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/rand598.cudf.s-e-l.log.runsolver ./gj-trendy-solver-1.0 /home/misc2010/data/2011/incremental/s-e-l/rand598.cudf /home/misc2010/tmp/201108241238/gj-trendy-solver-1.0/rand598.cudf.s-e-l.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.07 1.03 1.01 4/36 17607 /proc/meminfo: memFree=682340/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=11048 CPUtime=0 /proc/17607/stat : 17607 (java) R 17606 17606 1511 34817 1511 4202496 676 0 0 0 0 0 0 0 25 0 1 0 4060950 11313152 412 1283457024 134512640 134550932 4289303520 18446744073709551615 4160022242 0 0 0 0 0 0 0 17 0 0 0 0 /proc/17607/statm: 2762 412 179 10 0 1104 0 [startup+0.125374 s] /proc/loadavg: 1.07 1.03 1.01 4/36 17607 /proc/meminfo: memFree=682340/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=409800 CPUtime=0.12 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 3878 0 1 0 8 4 0 0 25 0 9 0 4060950 419635200 3309 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102450 3309 1906 10 0 96598 0 Current children cumulated CPU time (s) 0.12 Current children cumulated vsize (KiB) 412364 [startup+0.205381 s] /proc/loadavg: 1.07 1.03 1.01 4/36 17607 /proc/meminfo: memFree=682340/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=409800 CPUtime=0.2 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 4071 0 1 0 16 4 0 0 25 0 9 0 4060950 419635200 3502 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102450 3502 1906 10 0 96598 0 Current children cumulated CPU time (s) 0.2 Current children cumulated vsize (KiB) 412364 [startup+0.305421 s] /proc/loadavg: 1.07 1.03 1.01 4/36 17607 /proc/meminfo: memFree=682340/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=410244 CPUtime=0.3 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 4421 0 1 0 26 4 0 0 25 0 9 0 4060950 420089856 3852 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102561 3852 1927 10 0 96709 0 Current children cumulated CPU time (s) 0.3 Current children cumulated vsize (KiB) 412808 [startup+0.705575 s] /proc/loadavg: 1.07 1.03 1.01 4/36 17607 /proc/meminfo: memFree=682340/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=410684 CPUtime=0.7 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 12716 0 1 0 64 6 0 0 25 0 9 0 4060950 420540416 11962 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102671 11962 2895 10 0 96819 0 Current children cumulated CPU time (s) 0.7 Current children cumulated vsize (KiB) 413248 [startup+1.50588 s] /proc/loadavg: 1.07 1.03 1.01 2/45 17616 /proc/meminfo: memFree=623544/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=410816 CPUtime=1.5 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 26347 0 1 0 139 11 0 0 25 0 9 0 4060950 420675584 25593 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102704 25593 2896 10 0 96852 0 [pid=17607/tid=17609] ppid=17606 vsize=410816 CPUtime=0.8 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 6808 0 1 0 72 8 0 0 25 0 9 0 4060951 420675584 25593 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=410816 CPUtime=0.65 /proc/17607/task/17610/stat : 17610 (java) R 17606 17606 1511 34817 1511 4202560 18161 0 0 0 63 2 0 0 19 0 9 0 4060951 420675584 25593 1283457024 134512640 134550932 4289303520 18446744073709551615 4150900664 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=410816 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 20 0 9 0 4060952 420675584 25593 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=410816 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 20 0 9 0 4060952 420675584 25593 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=410816 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 4060953 420675584 25593 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=410816 CPUtime=0.03 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 438 0 0 0 3 0 0 0 16 0 9 0 4060953 420675584 25593 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=410816 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 4060953 420675584 25593 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=410816 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) S 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 9 0 4060953 420675584 25593 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.5 Current children cumulated vsize (KiB) 413380 [startup+3.1264 s] /proc/loadavg: 1.07 1.03 1.01 2/45 17617 /proc/meminfo: memFree=549020/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=410816 CPUtime=3.12 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 49225 0 1 0 293 19 0 0 25 0 9 0 4060950 420675584 48468 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102704 48468 2897 10 0 96852 0 [pid=17607/tid=17609] ppid=17606 vsize=410816 CPUtime=1.39 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 14258 0 1 0 128 11 0 0 25 0 9 0 4060951 420675584 48468 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=410816 CPUtime=1.66 /proc/17607/task/17610/stat : 17610 (java) R 17606 17606 1511 34817 1511 4202560 33568 0 0 0 159 7 0 0 15 0 9 0 4060951 420675584 48468 1283457024 134512640 134550932 4289303520 18446744073709551615 4153008093 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=410816 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 20 0 9 0 4060952 420675584 48468 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=410816 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 20 0 9 0 4060952 420675584 48468 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=410816 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 4060953 420675584 48468 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=410816 CPUtime=0.06 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 459 0 0 0 6 0 0 0 15 0 9 0 4060953 420675584 48468 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=410816 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 4060953 420675584 48468 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=410816 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) R 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 9 0 4060953 420675584 48468 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.12 Current children cumulated vsize (KiB) 413380 [startup+6.3075 s] /proc/loadavg: 1.07 1.03 1.00 2/46 17618 /proc/meminfo: memFree=446968/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=411152 CPUtime=6.31 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 62602 0 1 0 609 22 0 0 25 0 10 0 4060950 421019648 61766 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102788 61766 2921 10 0 96933 0 [pid=17607/tid=17609] ppid=17606 vsize=411152 CPUtime=4.17 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 14514 0 1 0 406 11 0 0 25 0 10 0 4060951 421019648 61766 1283457024 134512640 134550932 4289303520 18446744073709551615 4115489604 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=411152 CPUtime=2 /proc/17607/task/17610/stat : 17610 (java) S 17606 17606 1511 34817 1511 4202560 46599 0 0 0 190 10 0 0 16 0 10 0 4060951 421019648 61766 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 61766 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 61766 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 61766 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=411152 CPUtime=0.12 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 544 0 0 0 12 0 0 0 15 0 10 0 4060953 421019648 61766 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 61766 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) S 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 10 0 4060953 421019648 61766 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17618] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17618/stat : 17618 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 4061354 421019648 61766 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.31 Current children cumulated vsize (KiB) 413716 [startup+12.7088 s] /proc/loadavg: 1.06 1.03 1.00 2/46 17619 /proc/meminfo: memFree=433824/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=411152 CPUtime=12.71 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 65862 0 1 0 1248 23 0 0 25 0 10 0 4060950 421019648 65026 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102788 65026 2921 10 0 96933 0 [pid=17607/tid=17609] ppid=17606 vsize=411152 CPUtime=10.48 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 14514 0 1 0 1036 12 0 0 25 0 10 0 4060951 421019648 65026 1283457024 134512640 134550932 4289303520 18446744073709551615 4115030935 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=411152 CPUtime=2.08 /proc/17607/task/17610/stat : 17610 (java) S 17606 17606 1511 34817 1511 4202560 49857 0 0 0 198 10 0 0 15 0 10 0 4060951 421019648 65026 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65026 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65026 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65026 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=411152 CPUtime=0.12 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 546 0 0 0 12 0 0 0 15 0 10 0 4060953 421019648 65026 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65026 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) S 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 10 0 4060953 421019648 65026 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17618] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17618/stat : 17618 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 4061354 421019648 65026 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 12.71 Current children cumulated vsize (KiB) 413716 [startup+25.5123 s] /proc/loadavg: 1.05 1.03 1.00 3/46 17620 /proc/meminfo: memFree=433700/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=411152 CPUtime=25.5 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 65879 0 1 0 2527 23 0 0 25 0 10 0 4060950 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102788 65034 2915 10 0 96933 0 [pid=17607/tid=17609] ppid=17606 vsize=411152 CPUtime=22.7 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 14515 0 1 0 2258 12 0 0 25 0 10 0 4060951 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4115417744 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=411152 CPUtime=2.66 /proc/17607/task/17610/stat : 17610 (java) S 17606 17606 1511 34817 1511 4202560 49869 0 0 0 256 10 0 0 15 0 10 0 4060951 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=411152 CPUtime=0.12 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 550 0 0 0 12 0 0 0 15 0 10 0 4060953 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) S 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 10 0 4060953 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17618] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17618/stat : 17618 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 4061354 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 25.5 Current children cumulated vsize (KiB) 413716 Solver just ended. Dumping a history of the last processes samples [startup+25.6123 s] /proc/loadavg: 1.05 1.03 1.00 3/46 17620 /proc/meminfo: memFree=433700/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=411152 CPUtime=25.6 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 65879 0 1 0 2537 23 0 0 25 0 10 0 4060950 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102788 65034 2915 10 0 96933 0 [pid=17607/tid=17609] ppid=17606 vsize=411152 CPUtime=22.8 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 14515 0 1 0 2268 12 0 0 25 0 10 0 4060951 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4115591352 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=411152 CPUtime=2.66 /proc/17607/task/17610/stat : 17610 (java) S 17606 17606 1511 34817 1511 4202560 49869 0 0 0 256 10 0 0 15 0 10 0 4060951 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=411152 CPUtime=0.12 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 550 0 0 0 12 0 0 0 15 0 10 0 4060953 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) R 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 10 0 4060953 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17618] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17618/stat : 17618 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 4061354 421019648 65034 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 25.6 Current children cumulated vsize (KiB) 413716 [startup+32.005 s] /proc/loadavg: 1.04 1.03 1.00 2/46 17621 /proc/meminfo: memFree=433700/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=411152 CPUtime=31.98 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 65880 0 1 0 3174 24 0 0 25 0 10 0 4060950 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102788 65035 2915 10 0 96933 0 [pid=17607/tid=17609] ppid=17606 vsize=411152 CPUtime=28.9 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 14515 0 1 0 2877 13 0 0 25 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4115456609 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=411152 CPUtime=2.94 /proc/17607/task/17610/stat : 17610 (java) S 17606 17606 1511 34817 1511 4202560 49869 0 0 0 284 10 0 0 15 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=411152 CPUtime=0.12 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 551 0 0 0 12 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) S 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17618] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17618/stat : 17618 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 4061354 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 31.98 Current children cumulated vsize (KiB) 413716 [startup+38.4068 s] /proc/loadavg: 1.04 1.03 1.00 2/46 17621 /proc/meminfo: memFree=433700/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=411152 CPUtime=38.38 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 65880 0 1 0 3814 24 0 0 25 0 10 0 4060950 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102788 65035 2915 10 0 96933 0 [pid=17607/tid=17609] ppid=17606 vsize=411152 CPUtime=35.28 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 14515 0 1 0 3515 13 0 0 25 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4115577148 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=411152 CPUtime=2.96 /proc/17607/task/17610/stat : 17610 (java) S 17606 17606 1511 34817 1511 4202560 49869 0 0 0 286 10 0 0 15 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=411152 CPUtime=0.12 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 551 0 0 0 12 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) S 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17618] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17618/stat : 17618 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 4061354 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 38.38 Current children cumulated vsize (KiB) 413716 [startup+40.0074 s] /proc/loadavg: 1.04 1.03 1.00 2/46 17621 /proc/meminfo: memFree=433700/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=411152 CPUtime=39.98 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 65880 0 1 0 3974 24 0 0 25 0 10 0 4060950 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102788 65035 2915 10 0 96933 0 [pid=17607/tid=17609] ppid=17606 vsize=411152 CPUtime=36.88 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 14515 0 1 0 3675 13 0 0 25 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4115577161 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=411152 CPUtime=2.96 /proc/17607/task/17610/stat : 17610 (java) S 17606 17606 1511 34817 1511 4202560 49869 0 0 0 286 10 0 0 15 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=411152 CPUtime=0.12 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 551 0 0 0 12 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) S 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17618] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17618/stat : 17618 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 4061354 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 39.98 Current children cumulated vsize (KiB) 413716 [startup+40.8075 s] /proc/loadavg: 1.04 1.03 1.00 2/46 17621 /proc/meminfo: memFree=433700/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=411152 CPUtime=40.78 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 65880 0 1 0 4054 24 0 0 25 0 10 0 4060950 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102788 65035 2915 10 0 96933 0 [pid=17607/tid=17609] ppid=17606 vsize=411152 CPUtime=37.68 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 14515 0 1 0 3755 13 0 0 25 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4115497892 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=411152 CPUtime=2.96 /proc/17607/task/17610/stat : 17610 (java) S 17606 17606 1511 34817 1511 4202560 49869 0 0 0 286 10 0 0 15 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=411152 CPUtime=0.12 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 551 0 0 0 12 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) S 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17618] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17618/stat : 17618 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 4061354 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 40.78 Current children cumulated vsize (KiB) 413716 [startup+41.2076 s] /proc/loadavg: 1.04 1.03 1.00 2/46 17621 /proc/meminfo: memFree=433700/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=411152 CPUtime=41.18 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 65880 0 1 0 4094 24 0 0 25 0 10 0 4060950 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102788 65035 2915 10 0 96933 0 [pid=17607/tid=17609] ppid=17606 vsize=411152 CPUtime=38.08 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 14515 0 1 0 3795 13 0 0 25 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4115630805 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=411152 CPUtime=2.96 /proc/17607/task/17610/stat : 17610 (java) S 17606 17606 1511 34817 1511 4202560 49869 0 0 0 286 10 0 0 15 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=411152 CPUtime=0.12 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 551 0 0 0 12 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) S 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17618] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17618/stat : 17618 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 4061354 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 41.18 Current children cumulated vsize (KiB) 413716 [startup+41.6077 s] /proc/loadavg: 1.04 1.03 1.00 2/46 17621 /proc/meminfo: memFree=433700/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=411152 CPUtime=41.58 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 65880 0 1 0 4134 24 0 0 25 0 10 0 4060950 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102788 65035 2915 10 0 96933 0 [pid=17607/tid=17609] ppid=17606 vsize=411152 CPUtime=38.48 /proc/17607/task/17609/stat : 17609 (java) R 17606 17606 1511 34817 1511 4202560 14515 0 1 0 3835 13 0 0 25 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4115465380 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=411152 CPUtime=2.96 /proc/17607/task/17610/stat : 17610 (java) S 17606 17606 1511 34817 1511 4202560 49869 0 0 0 286 10 0 0 15 0 10 0 4060951 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 10 0 4060952 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=411152 CPUtime=0.12 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 551 0 0 0 12 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) S 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 10 0 4060953 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17618] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17618/stat : 17618 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 25 0 10 0 4061354 421019648 65035 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 41.58 Current children cumulated vsize (KiB) 413716 [startup+41.704 s] /proc/loadavg: 1.04 1.03 1.00 2/46 17621 /proc/meminfo: memFree=433700/1048576 swapFree=0/0 [pid=17606] ppid=17605 vsize=2564 CPUtime=0 /proc/17606/stat : 17606 (gj-trendy-solve) S 17605 17606 1511 34817 1511 4202496 371 0 0 0 0 0 0 0 18 0 1 0 4060950 2625536 269 1283457024 134512640 135304128 4289440976 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/17606/statm: 641 269 229 194 0 28 0 [pid=17607] ppid=17606 vsize=411152 CPUtime=41.65 /proc/17607/stat : 17607 (java) S 17606 17606 1511 34817 1511 4202496 65882 0 1 0 4141 24 0 0 25 0 9 0 4060950 421019648 65037 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/17607/statm: 102788 65037 2916 10 0 96933 0 [pid=17607/tid=17609] ppid=17606 vsize=411152 CPUtime=38.54 /proc/17607/task/17609/stat : 17609 (java) S 17606 17606 1511 34817 1511 4202560 14515 0 1 0 3841 13 0 0 25 0 9 0 4060951 421019648 65037 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17610] ppid=17606 vsize=411152 CPUtime=2.97 /proc/17607/task/17610/stat : 17610 (java) S 17606 17606 1511 34817 1511 4202560 49869 0 0 0 287 10 0 0 15 0 9 0 4060951 421019648 65037 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 0 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17611] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17611/stat : 17611 (java) S 17606 17606 1511 34817 1511 4202560 15 0 0 0 0 0 0 0 18 0 9 0 4060952 421019648 65037 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17612] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17612/stat : 17612 (java) S 17606 17606 1511 34817 1511 4202560 5 0 0 0 0 0 0 0 18 0 9 0 4060952 421019648 65037 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17613] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17613/stat : 17613 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 4060953 421019648 65037 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17614] ppid=17606 vsize=411152 CPUtime=0.12 /proc/17607/task/17614/stat : 17614 (java) S 17606 17606 1511 34817 1511 4202560 552 0 0 0 12 0 0 0 15 0 9 0 4060953 421019648 65037 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17615] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17615/stat : 17615 (java) S 17606 17606 1511 34817 1511 4202560 1 0 0 0 0 0 0 0 25 0 9 0 4060953 421019648 65037 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 [pid=17607/tid=17616] ppid=17606 vsize=411152 CPUtime=0 /proc/17607/task/17616/stat : 17616 (java) S 17606 17606 1511 34817 1511 4202560 0 0 0 0 0 0 0 0 15 0 9 0 4060953 421019648 65037 1283457024 134512640 134550932 4289303520 18446744073709551615 4294960130 0 4 0 16800975 18446612133393238784 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 41.65 Current children cumulated vsize (KiB) 413716 Child status: 0 Real time (s): 41.7553 CPU time (s): 41.6746 CPU user time (s): 41.4146 CPU system time (s): 0.260016 CPU usage (%): 99.8068 Max. virtual memory (cumulated for all children) (KiB): 413716 getrusage(RUSAGE_CHILDREN,...) data: user time used= 41.4146 system time used= 0.260016 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 66268 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= 1562 involuntary context switches= 1999 runsolver used 0 second user time and 0 second system time The end