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/201108251442/gj-paranoid-solver-1.0/rand149.cudf.s-e-l-s.log.runsolver ./gj-paranoid-solver-1.0 /home/misc2010/data/2011/incremental/s-e-l-s/rand149.cudf /home/misc2010/tmp/201108251442/gj-paranoid-solver-1.0/rand149.cudf.s-e-l-s.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.06 0.99 0.68 3/35 5465 /proc/meminfo: memFree=369660/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) R 5463 5464 4778 34817 4778 4202496 354 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 268 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/5464/statm: 642 268 228 194 0 29 0 [pid=5465] ppid=5464 vsize=2568 CPUtime=0 /proc/5465/stat : 5465 (gj-paranoid-sol) R 5464 5464 4778 34817 4778 4202560 0 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 40 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65538 4 65536 0 0 0 17 0 0 0 0 /proc/5465/statm: 642 40 0 194 0 29 0 [startup+0.165546 s] /proc/loadavg: 1.06 0.99 0.68 3/35 5465 /proc/meminfo: memFree=369660/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=409796 CPUtime=0.16 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 3961 0 1 0 14 2 0 0 25 0 9 0 10046247 419631104 3393 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 102449 3393 1906 10 0 96597 0 Current children cumulated CPU time (s) 0.16 Current children cumulated vsize (KiB) 412364 [startup+0.205533 s] /proc/loadavg: 1.06 0.99 0.68 3/35 5465 /proc/meminfo: memFree=369660/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=409796 CPUtime=0.2 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 4052 0 1 0 18 2 0 0 25 0 9 0 10046247 419631104 3484 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 102449 3484 1906 10 0 96597 0 Current children cumulated CPU time (s) 0.2 Current children cumulated vsize (KiB) 412364 [startup+0.305574 s] /proc/loadavg: 1.06 0.99 0.68 3/35 5465 /proc/meminfo: memFree=369660/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=410244 CPUtime=0.3 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 4399 0 1 0 28 2 0 0 25 0 9 0 10046247 420089856 3831 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 102561 3831 1926 10 0 96709 0 Current children cumulated CPU time (s) 0.3 Current children cumulated vsize (KiB) 412812 [startup+0.705711 s] /proc/loadavg: 1.06 0.99 0.68 3/35 5465 /proc/meminfo: memFree=369660/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=410684 CPUtime=0.7 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 12887 0 1 0 64 6 0 0 25 0 9 0 10046247 420540416 12134 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 102671 12134 2895 10 0 96819 0 Current children cumulated CPU time (s) 0.7 Current children cumulated vsize (KiB) 413252 [startup+1.50588 s] /proc/loadavg: 1.06 0.99 0.68 3/44 5474 /proc/meminfo: memFree=309996/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=410816 CPUtime=1.5 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 26539 0 1 0 141 9 0 0 25 0 9 0 10046247 420675584 25786 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 102704 25786 2896 10 0 96852 0 [pid=5465/tid=5467] ppid=5464 vsize=410816 CPUtime=0.78 /proc/5465/task/5467/stat : 5467 (java) R 5464 5464 4778 34817 4778 4202560 6823 0 1 0 75 3 0 0 25 0 9 0 10046248 420675584 25786 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5468] ppid=5464 vsize=410816 CPUtime=0.67 /proc/5465/task/5468/stat : 5468 (java) R 5464 5464 4778 34817 4778 4202560 18337 0 0 0 62 5 0 0 19 0 9 0 10046248 420675584 25786 1283457024 134512640 134550932 4291792464 18446744073709551615 4153321902 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5469] ppid=5464 vsize=410816 CPUtime=0 /proc/5465/task/5469/stat : 5469 (java) S 5464 5464 4778 34817 4778 4202560 15 0 0 0 0 0 0 0 20 0 9 0 10046248 420675584 25786 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5470] ppid=5464 vsize=410816 CPUtime=0 /proc/5465/task/5470/stat : 5470 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 20 0 9 0 10046248 420675584 25786 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5471] ppid=5464 vsize=410816 CPUtime=0 /proc/5465/task/5471/stat : 5471 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 9 0 10046250 420675584 25786 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5472] ppid=5464 vsize=410816 CPUtime=0.04 /proc/5465/task/5472/stat : 5472 (java) S 5464 5464 4778 34817 4778 4202560 439 0 0 0 4 0 0 0 16 0 9 0 10046250 420675584 25786 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5473] ppid=5464 vsize=410816 CPUtime=0 /proc/5465/task/5473/stat : 5473 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 9 0 10046250 420675584 25786 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5474] ppid=5464 vsize=410816 CPUtime=0 /proc/5465/task/5474/stat : 5474 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 9 0 10046250 420675584 25786 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 1.5 Current children cumulated vsize (KiB) 413384 [startup+3.10627 s] /proc/loadavg: 1.06 0.99 0.68 2/44 5474 /proc/meminfo: memFree=234728/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=410816 CPUtime=3.09 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 47923 0 1 0 290 19 0 0 25 0 9 0 10046247 420675584 47170 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 102704 47170 2896 10 0 96852 0 [pid=5465/tid=5467] ppid=5464 vsize=410816 CPUtime=1.39 /proc/5465/task/5467/stat : 5467 (java) R 5464 5464 4778 34817 4778 4202560 12978 0 1 0 133 6 0 0 25 0 9 0 10046248 420675584 47170 1283457024 134512640 134550932 4291792464 18446744073709551615 4115440634 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5468] ppid=5464 vsize=410816 CPUtime=1.65 /proc/5465/task/5468/stat : 5468 (java) S 5464 5464 4778 34817 4778 4202560 33563 0 0 0 153 12 0 0 17 0 9 0 10046248 420675584 47170 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5469] ppid=5464 vsize=410816 CPUtime=0 /proc/5465/task/5469/stat : 5469 (java) S 5464 5464 4778 34817 4778 4202560 15 0 0 0 0 0 0 0 20 0 9 0 10046248 420675584 47170 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5470] ppid=5464 vsize=410816 CPUtime=0 /proc/5465/task/5470/stat : 5470 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 20 0 9 0 10046248 420675584 47170 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5471] ppid=5464 vsize=410816 CPUtime=0 /proc/5465/task/5471/stat : 5471 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 9 0 10046250 420675584 47170 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5472] ppid=5464 vsize=410816 CPUtime=0.04 /proc/5465/task/5472/stat : 5472 (java) S 5464 5464 4778 34817 4778 4202560 442 0 0 0 4 0 0 0 16 0 9 0 10046250 420675584 47170 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5473] ppid=5464 vsize=410816 CPUtime=0 /proc/5465/task/5473/stat : 5473 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 9 0 10046250 420675584 47170 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5474] ppid=5464 vsize=410816 CPUtime=0 /proc/5465/task/5474/stat : 5474 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 9 0 10046250 420675584 47170 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 3.09 Current children cumulated vsize (KiB) 413384 [startup+6.30705 s] /proc/loadavg: 1.21 1.02 0.69 3/44 5474 /proc/meminfo: memFree=87912/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=413868 CPUtime=6.3 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 77106 0 1 0 600 30 0 0 25 0 9 0 10046247 423800832 71106 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 103467 71106 2911 10 0 97612 0 [pid=5465/tid=5467] ppid=5464 vsize=413868 CPUtime=2.38 /proc/5465/task/5467/stat : 5467 (java) R 5464 5464 4778 34817 4778 4202560 14556 0 1 0 232 6 0 0 25 0 9 0 10046248 423800832 71106 1283457024 134512640 134550932 4291792464 18446744073709551615 4115357160 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5468] ppid=5464 vsize=413868 CPUtime=3.84 /proc/5465/task/5468/stat : 5468 (java) S 5464 5464 4778 34817 4778 4202560 61133 0 0 0 362 22 0 0 17 0 9 0 10046248 423800832 71106 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5469] ppid=5464 vsize=413868 CPUtime=0 /proc/5465/task/5469/stat : 5469 (java) S 5464 5464 4778 34817 4778 4202560 15 0 0 0 0 0 0 0 18 0 9 0 10046248 423800832 71106 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5470] ppid=5464 vsize=413868 CPUtime=0 /proc/5465/task/5470/stat : 5470 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 18 0 9 0 10046248 423800832 71106 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5471] ppid=5464 vsize=413868 CPUtime=0 /proc/5465/task/5471/stat : 5471 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 9 0 10046250 423800832 71106 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5472] ppid=5464 vsize=413868 CPUtime=0.05 /proc/5465/task/5472/stat : 5472 (java) S 5464 5464 4778 34817 4778 4202560 477 0 0 0 5 0 0 0 15 0 9 0 10046250 423800832 71106 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5473] ppid=5464 vsize=413868 CPUtime=0 /proc/5465/task/5473/stat : 5473 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 9 0 10046250 423800832 71106 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5474] ppid=5464 vsize=413868 CPUtime=0 /proc/5465/task/5474/stat : 5474 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 9 0 10046250 423800832 71106 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 6.3 Current children cumulated vsize (KiB) 416436 [startup+12.7089 s] /proc/loadavg: 1.20 1.02 0.69 2/45 5475 /proc/meminfo: memFree=96096/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=413552 CPUtime=12.7 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 82202 0 1 0 1238 32 0 0 25 0 10 0 10046247 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 103388 71036 2912 10 0 97533 0 [pid=5465/tid=5467] ppid=5464 vsize=413552 CPUtime=7.06 /proc/5465/task/5467/stat : 5467 (java) R 5464 5464 4778 34817 4778 4202560 14586 0 1 0 698 8 0 0 25 0 10 0 10046248 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4115758097 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5468] ppid=5464 vsize=413552 CPUtime=5.5 /proc/5465/task/5468/stat : 5468 (java) R 5464 5464 4778 34817 4778 4202560 66135 0 0 0 527 23 0 0 15 0 10 0 10046248 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5469] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5469/stat : 5469 (java) S 5464 5464 4778 34817 4778 4202560 15 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5470] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5470/stat : 5470 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5471] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5471/stat : 5471 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5472] ppid=5464 vsize=413552 CPUtime=0.12 /proc/5465/task/5472/stat : 5472 (java) S 5464 5464 4778 34817 4778 4202560 536 0 0 0 12 0 0 0 15 0 10 0 10046250 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5473] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5473/stat : 5473 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5474] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5474/stat : 5474 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 10046250 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5475] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5475/stat : 5475 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 25 0 10 0 10047098 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 12.7 Current children cumulated vsize (KiB) 416120 Solver just ended. Dumping a history of the last processes samples [startup+12.8089 s] /proc/loadavg: 1.20 1.02 0.69 2/45 5475 /proc/meminfo: memFree=96096/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=413552 CPUtime=12.8 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 82202 0 1 0 1248 32 0 0 25 0 10 0 10046247 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 103388 71036 2912 10 0 97533 0 [pid=5465/tid=5467] ppid=5464 vsize=413552 CPUtime=7.16 /proc/5465/task/5467/stat : 5467 (java) R 5464 5464 4778 34817 4778 4202560 14586 0 1 0 708 8 0 0 25 0 10 0 10046248 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4115881609 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5468] ppid=5464 vsize=413552 CPUtime=5.5 /proc/5465/task/5468/stat : 5468 (java) S 5464 5464 4778 34817 4778 4202560 66135 0 0 0 527 23 0 0 16 0 10 0 10046248 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5469] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5469/stat : 5469 (java) S 5464 5464 4778 34817 4778 4202560 15 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5470] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5470/stat : 5470 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5471] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5471/stat : 5471 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5472] ppid=5464 vsize=413552 CPUtime=0.12 /proc/5465/task/5472/stat : 5472 (java) S 5464 5464 4778 34817 4778 4202560 536 0 0 0 12 0 0 0 15 0 10 0 10046250 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5473] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5473/stat : 5473 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5474] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5474/stat : 5474 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 10046250 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5475] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5475/stat : 5475 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 25 0 10 0 10047098 423477248 71036 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 12.8 Current children cumulated vsize (KiB) 416120 [startup+19.2106 s] /proc/loadavg: 1.18 1.02 0.69 3/45 5475 /proc/meminfo: memFree=96096/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=413552 CPUtime=19.2 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 82212 0 1 0 1888 32 0 0 25 0 10 0 10046247 423477248 71046 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 103388 71046 2914 10 0 97533 0 [pid=5465/tid=5467] ppid=5464 vsize=413552 CPUtime=13.49 /proc/5465/task/5467/stat : 5467 (java) R 5464 5464 4778 34817 4778 4202560 14587 0 1 0 1341 8 0 0 25 0 10 0 10046248 423477248 71046 1283457024 134512640 134550932 4291792464 18446744073709551615 4115338135 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5468] ppid=5464 vsize=413552 CPUtime=5.57 /proc/5465/task/5468/stat : 5468 (java) S 5464 5464 4778 34817 4778 4202560 66137 0 0 0 534 23 0 0 16 0 10 0 10046248 423477248 71046 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5469] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5469/stat : 5469 (java) S 5464 5464 4778 34817 4778 4202560 15 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71046 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5470] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5470/stat : 5470 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71046 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5471] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5471/stat : 5471 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71046 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5472] ppid=5464 vsize=413552 CPUtime=0.12 /proc/5465/task/5472/stat : 5472 (java) S 5464 5464 4778 34817 4778 4202560 543 0 0 0 12 0 0 0 15 0 10 0 10046250 423477248 71046 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5473] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5473/stat : 5473 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71046 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5474] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5474/stat : 5474 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 10046250 423477248 71046 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5475] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5475/stat : 5475 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 25 0 10 0 10047098 423477248 71046 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 19.2 Current children cumulated vsize (KiB) 416120 [startup+20.8111 s] /proc/loadavg: 1.16 1.02 0.69 2/45 5475 /proc/meminfo: memFree=96096/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=413552 CPUtime=20.8 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 82214 0 1 0 2048 32 0 0 25 0 10 0 10046247 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 103388 71048 2914 10 0 97533 0 [pid=5465/tid=5467] ppid=5464 vsize=413552 CPUtime=14.79 /proc/5465/task/5467/stat : 5467 (java) R 5464 5464 4778 34817 4778 4202560 14587 0 1 0 1471 8 0 0 25 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4115786208 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5468] ppid=5464 vsize=413552 CPUtime=5.87 /proc/5465/task/5468/stat : 5468 (java) S 5464 5464 4778 34817 4778 4202560 66137 0 0 0 564 23 0 0 16 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5469] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5469/stat : 5469 (java) S 5464 5464 4778 34817 4778 4202560 15 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5470] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5470/stat : 5470 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5471] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5471/stat : 5471 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5472] ppid=5464 vsize=413552 CPUtime=0.12 /proc/5465/task/5472/stat : 5472 (java) S 5464 5464 4778 34817 4778 4202560 545 0 0 0 12 0 0 0 15 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5473] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5473/stat : 5473 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5474] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5474/stat : 5474 (java) R 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5475] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5475/stat : 5475 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 25 0 10 0 10047098 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 20.8 Current children cumulated vsize (KiB) 416120 [startup+21.6113 s] /proc/loadavg: 1.16 1.02 0.69 2/45 5475 /proc/meminfo: memFree=96096/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=413552 CPUtime=21.6 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 82214 0 1 0 2128 32 0 0 25 0 10 0 10046247 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 103388 71048 2914 10 0 97533 0 [pid=5465/tid=5467] ppid=5464 vsize=413552 CPUtime=15.59 /proc/5465/task/5467/stat : 5467 (java) R 5464 5464 4778 34817 4778 4202560 14587 0 1 0 1551 8 0 0 25 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4115764742 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5468] ppid=5464 vsize=413552 CPUtime=5.87 /proc/5465/task/5468/stat : 5468 (java) S 5464 5464 4778 34817 4778 4202560 66137 0 0 0 564 23 0 0 15 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5469] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5469/stat : 5469 (java) S 5464 5464 4778 34817 4778 4202560 15 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5470] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5470/stat : 5470 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5471] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5471/stat : 5471 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5472] ppid=5464 vsize=413552 CPUtime=0.12 /proc/5465/task/5472/stat : 5472 (java) S 5464 5464 4778 34817 4778 4202560 545 0 0 0 12 0 0 0 15 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5473] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5473/stat : 5473 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5474] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5474/stat : 5474 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5475] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5475/stat : 5475 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 25 0 10 0 10047098 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 21.6 Current children cumulated vsize (KiB) 416120 [startup+22.0114 s] /proc/loadavg: 1.16 1.02 0.69 3/45 5475 /proc/meminfo: memFree=96096/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=413552 CPUtime=22 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 82214 0 1 0 2168 32 0 0 25 0 10 0 10046247 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 103388 71048 2914 10 0 97533 0 [pid=5465/tid=5467] ppid=5464 vsize=413552 CPUtime=15.99 /proc/5465/task/5467/stat : 5467 (java) R 5464 5464 4778 34817 4778 4202560 14587 0 1 0 1591 8 0 0 25 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4115338135 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5468] ppid=5464 vsize=413552 CPUtime=5.87 /proc/5465/task/5468/stat : 5468 (java) S 5464 5464 4778 34817 4778 4202560 66137 0 0 0 564 23 0 0 15 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5469] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5469/stat : 5469 (java) S 5464 5464 4778 34817 4778 4202560 15 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5470] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5470/stat : 5470 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5471] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5471/stat : 5471 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5472] ppid=5464 vsize=413552 CPUtime=0.12 /proc/5465/task/5472/stat : 5472 (java) S 5464 5464 4778 34817 4778 4202560 545 0 0 0 12 0 0 0 15 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5473] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5473/stat : 5473 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5474] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5474/stat : 5474 (java) R 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5475] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5475/stat : 5475 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 25 0 10 0 10047098 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 22 Current children cumulated vsize (KiB) 416120 [startup+22.2115 s] /proc/loadavg: 1.16 1.02 0.69 3/45 5475 /proc/meminfo: memFree=96096/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=413552 CPUtime=22.2 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 82214 0 1 0 2188 32 0 0 25 0 10 0 10046247 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 103388 71048 2914 10 0 97533 0 [pid=5465/tid=5467] ppid=5464 vsize=413552 CPUtime=16.19 /proc/5465/task/5467/stat : 5467 (java) R 5464 5464 4778 34817 4778 4202560 14587 0 1 0 1611 8 0 0 25 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4115338135 0 4 0 16800975 0 0 0 -1 0 0 0 0 [pid=5465/tid=5468] ppid=5464 vsize=413552 CPUtime=5.87 /proc/5465/task/5468/stat : 5468 (java) S 5464 5464 4778 34817 4778 4202560 66137 0 0 0 564 23 0 0 15 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5469] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5469/stat : 5469 (java) S 5464 5464 4778 34817 4778 4202560 15 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5470] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5470/stat : 5470 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 18 0 10 0 10046248 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5471] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5471/stat : 5471 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5472] ppid=5464 vsize=413552 CPUtime=0.12 /proc/5465/task/5472/stat : 5472 (java) S 5464 5464 4778 34817 4778 4202560 545 0 0 0 12 0 0 0 15 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5473] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5473/stat : 5473 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5474] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5474/stat : 5474 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 10 0 10046250 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5475] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5475/stat : 5475 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 25 0 10 0 10047098 423477248 71048 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 22.2 Current children cumulated vsize (KiB) 416120 [startup+22.3069 s] /proc/loadavg: 1.16 1.02 0.69 3/45 5475 /proc/meminfo: memFree=96096/1048576 swapFree=0/0 [pid=5464] ppid=5463 vsize=2568 CPUtime=0 /proc/5464/stat : 5464 (gj-paranoid-sol) S 5463 5464 4778 34817 4778 4202496 371 0 0 0 0 0 0 0 25 0 1 0 10046247 2629632 269 1283457024 134512640 135304128 4287105680 18446744073709551615 4294960130 0 65536 4 65538 18446744071564329979 0 0 17 0 0 0 0 /proc/5464/statm: 642 269 229 194 0 29 0 [pid=5465] ppid=5464 vsize=413552 CPUtime=22.28 /proc/5465/stat : 5465 (java) S 5464 5464 4778 34817 4778 4202496 82216 0 1 0 2196 32 0 0 25 0 9 0 10046247 423477248 71050 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446744073709551615 0 0 17 0 0 0 0 /proc/5465/statm: 103388 71050 2915 10 0 97533 0 [pid=5465/tid=5467] ppid=5464 vsize=413552 CPUtime=16.27 /proc/5465/task/5467/stat : 5467 (java) S 5464 5464 4778 34817 4778 4202560 14587 0 1 0 1619 8 0 0 25 0 9 0 10046248 423477248 71050 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5468] ppid=5464 vsize=413552 CPUtime=5.87 /proc/5465/task/5468/stat : 5468 (java) S 5464 5464 4778 34817 4778 4202560 66137 0 0 0 564 23 0 0 16 0 9 0 10046248 423477248 71050 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 0 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5469] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5469/stat : 5469 (java) S 5464 5464 4778 34817 4778 4202560 15 0 0 0 0 0 0 0 18 0 9 0 10046248 423477248 71050 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5470] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5470/stat : 5470 (java) S 5464 5464 4778 34817 4778 4202560 5 0 0 0 0 0 0 0 18 0 9 0 10046248 423477248 71050 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5471] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5471/stat : 5471 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 9 0 10046250 423477248 71050 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5472] ppid=5464 vsize=413552 CPUtime=0.12 /proc/5465/task/5472/stat : 5472 (java) S 5464 5464 4778 34817 4778 4202560 546 0 0 0 12 0 0 0 15 0 9 0 10046250 423477248 71050 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5473] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5473/stat : 5473 (java) S 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 25 0 9 0 10046250 423477248 71050 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 18446612133155121344 0 0 -1 0 0 0 0 [pid=5465/tid=5474] ppid=5464 vsize=413552 CPUtime=0 /proc/5465/task/5474/stat : 5474 (java) R 5464 5464 4778 34817 4778 4202560 1 0 0 0 0 0 0 0 15 0 9 0 10046250 423477248 71050 1283457024 134512640 134550932 4291792464 18446744073709551615 4294960130 0 4 0 16800975 0 0 0 -1 0 0 0 0 Current children cumulated CPU time (s) 22.28 Current children cumulated vsize (KiB) 416120 Child status: 0 Real time (s): 22.3319 CPU time (s): 22.2974 CPU user time (s): 21.9614 CPU system time (s): 0.336021 CPU usage (%): 99.8455 Max. virtual memory (cumulated for all children) (KiB): 437156 getrusage(RUSAGE_CHILDREN,...) data: user time used= 21.9614 system time used= 0.336021 maximum resident set size= 0 integral shared memory size= 0 integral unshared data size= 0 integral unshared stack size= 0 page reclaims= 82603 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= 1153 involuntary context switches= 1412 runsolver used 0 second user time and 0 second system time The end