execution time is 265 milliseconds
colors(red,blue,black,blue,black,blue,black,blue,black,blue,yellow,red,yellow,red,yellow,red,yellow,red,yellow,black,blue,black,blue,black,blue,black,blue,red,red,yellow,red,yellow,red,yellow,black,blue,black,blue,black,blue,red,red,yellow,red,yellow,black,black,blue,black,red,yellow,red,blue,blue,black,red,black,yellow,black,yellow,black,blue,red,black,yellow,blue,yellow,black,blue,yellow,blue,yellow,blue,red,yellow,blue,black,red,yellow,yellow,blue,black,red,blue,red,yellow,blue,black,red,yellow,black,red,yellow,red,blue,black,blue,yellow,black,blue,black,red,yellow,red,black,red,yellow,red,yellow,black)
BMARK_cube: = [sols = 48,time = 516]
31

BMARK_fibo: = [time = 62,heap = 51132,trail = 0,fibo(16,1597)]
time = 266
runtime=[312,0]
global_stack=[27692,2036632]
local_stack=[104,261004]
trail=[944,260172]
code=[248776,799784]
strings=[372,1048204]
symbols=[12468,249676]
htable=[109944,676488]
bboard=[9752,512484]
gctime=[0,0]
realtime=[1,335311313]
The Board

 25 20 11 16  5
 12 17  6 21 10
  7 24 19  4 15
 18 13  2  9 22
  1  8 23 14  3
Input:

0.03 0.03 
0.97 0.03 
0.03 0.97 
0.97 0.97 

Desired Output:

0.03 0.03 
0.03 0.97 
0.03 0.97 
0.97 0.03 

SquaredError  Output

1-[0.418431] 0.483835 0.490939
2-[0.441269] 0.444539 0.450937
3-[0.369235] 0.410153 0.495954
4-[0.605213] 0.379595 0.536592

401-[0.215081] 0.157271 0.475963
402-[0.323313] 0.295263 0.46706
403-[0.28349] 0.278799 0.499267
404-[0.59993] 0.391938 0.545534

801-[0.166106] 0.0168542 0.437349
802-[0.272359] 0.206578 0.4789
803-[0.234993] 0.197593 0.515132
804-[0.418582] 0.666873 0.601574

1201-[0.110399] 0.00480234 0.361306
1202-[0.154809] 0.134314 0.590623
1203-[0.137894] 0.132499 0.613085
1204-[0.25282] 0.785593 0.497776

1601-[0.0266178] 0.00206653 0.19074
1602-[0.0335582] 0.0817178 0.794263
1603-[0.0335499] 0.0821118 0.794403
1604-[0.0586868] 0.87348 0.252195

2001-[0.0100807] 0.00143968 0.126255
2002-[0.0118587] 0.0644859 0.866707
2003-[0.0120152] 0.064318 0.865897
2004-[0.0216145] 0.903731 0.161236

2401-[0.00558961] 0.00118611 0.0989882
2402-[0.00610477] 0.056348 0.896444
2403-[0.00618628] 0.0560922 0.895801
2404-[0.01153] 0.918043 0.12397

2801-[0.00375651] 0.00104447 0.0840193
2802-[0.00375632] 0.0514119 0.912573
2803-[0.00380317] 0.0511543 0.912072
2804-[0.00731471] 0.926788 0.103807

3201-[0.00282112] 0.000952368 0.0744675
3202-[0.00255322] 0.0480279 0.922796
3203-[0.00258308] 0.0477853 0.922389
3204-[0.00510603] 0.932854 0.0910428

Final weights

6.92184 -4.66448 -4.6694 
2.2046 -5.10575 -5.07395 
3.34668 -6.82327 -3.93899 
-2.97394 6.4652 -7.07452 
time = 562
[[rob-king,leon-prince,mark-queen],[mark-24,leon-25,rob-26],[mark-classic,leon-jazz,rob-pop]]
time = 0
time = 797
runtime=[859,0]
global_stack=[31904,2032420]
local_stack=[120,260988]
trail=[1024,260092]
code=[251168,797392]
strings=[642,1047934]
symbols=[12596,249548]
htable=[110640,675792]
bboard=[67448,454788]
gctime=[0,0]
realtime=[1,335311314]
[4]-[body,constant,deep]
[12]-[body,constant,top]
[4,12]-[body,constant]
[5]-[body,deep,structure]
[6]-[body,deep,value]
[7]-[body,deep,variable]
[4,5,6,7]-[body,deep]
[13]-[body,structure,top]
[5,13]-[body,structure]
[14]-[body,top,value]
[15]-[body,top,variable]
[12,13,14,15]-[body,top]
[6,14]-[body,value]
[7,15]-[body,variable]
[4,5,6,7,12,13,14,15]-[body]
[0]-[constant,deep,head]
[0,4]-[constant,deep]
[8]-[constant,head,top]
[0,8]-[constant,head]
[8,12]-[constant,top]
[0,4,8,12]-[constant]
[1]-[deep,head,structure]
[2]-[deep,head,value]
[3]-[deep,head,variable]
[0,1,2,3]-[deep,head]
[1,5]-[deep,structure]
[2,6]-[deep,value]
[3,7]-[deep,variable]
[0,1,2,3,4,5,6,7]-[deep]
[9]-[head,structure,top]
[1,9]-[head,structure]
[10]-[head,top,value]
[11]-[head,top,variable]
[8,9,10,11]-[head,top]
[2,10]-[head,value]
[3,11]-[head,variable]
[0,1,2,3,8,9,10,11]-[head]
[9,13]-[structure,top]
[1,5,9,13]-[structure]
[10,14]-[top,value]
[11,15]-[top,variable]
[8,9,10,11,12,13,14,15]-[top]
[2,6,10,14]-[value]
[3,7,11,15]-[variable]
use bp -h40000 -t20000 -s4000 -b0 -d19 for BinProlog
tail_call_atom_atom took 
 user cpu (5235-625)/1.42857e+006 = 0.003227 ms/iteration
binary_call_atom_atom took 
 user cpu (4657-93)/242483 = 0.0188219 ms/iteration
cons_list took 
 user cpu (5312-391)/853242 = 0.00576741 ms/iteration
walk_list took 
 user cpu (5187-438)/972573 = 0.00488292 ms/iteration
walk_list_rec took 
 user cpu (5500-609)/1.37931e+006 = 0.00354598 ms/iteration
args(1) took 
 user cpu (5218-657)/1.46113e+006 = 0.00312155 ms/iteration
args(2) took 
 user cpu (5094-406)/909091 = 0.0051568 ms/iteration
args(4) took 
 user cpu (4906-141)/347705 = 0.0137041 ms/iteration
args(8) took 
 user cpu (5187-94)/226963 = 0.0224398 ms/iteration
args(16) took 
 user cpu (4719-63)/121684 = 0.038263 ms/iteration
cons_term took 
 user cpu (4984-375)/831117 = 0.00554555 ms/iteration
walk_term took 
 user cpu (5110-422)/935804 = 0.0050096 ms/iteration
walk_term_rec took 
 user cpu (4797-656)/1.39743e+006 = 0.0029633 ms/iteration
shallow_backtracking took 
 user cpu (5235-437)/1.00644e+006 = 0.00476729 ms/iteration
deep_backtracking took 
 user cpu (5062-141)/313676 = 0.0156881 ms/iteration
choice_point took 
 user cpu (6328-3922)/8.83861e+006 = 0.000272215 ms/iteration
trail_variables took 
 user cpu (6234-2829)/6.40041e+006 = 0.000531997 ms/iteration
medium_unify took 
 user cpu (5453-2234)/5e+006 = 0.0006438 ms/iteration
deep_unify took 
 user cpu (5359-1547)/3.44116e+006 = 0.00110777 ms/iteration
integer_add took 
 user cpu (5047-406)/955110 = 0.00485913 ms/iteration
floating_add took 
 user cpu (4985-93)/223814 = 0.0218575 ms/iteration
arg(1) took 
 user cpu (5000-375)/914244 = 0.00505882 ms/iteration
arg(2) took 
 user cpu (5000-391)/916926 = 0.00502658 ms/iteration
arg(4) took 
 user cpu (5093-391)/916758 = 0.00512894 ms/iteration
arg(8) took 
 user cpu (5125-391)/922169 = 0.00513355 ms/iteration
arg(16) took 
 user cpu (5015-375)/898796 = 0.00516246 ms/iteration
index took 
 user cpu (5078-250)/569346 = 0.0084799 ms/iteration
assert_unit took 
 user cpu (5969-0)/666.667 = 8.9535 ms/iteration
access_unit took 
 user cpu (5016-46)/92747.2 = 0.0535865 ms/iteration
slow_access_unit took 
 user cpu (5016-0)/6095.33 = 0.822925 ms/iteration
setof took 
 user cpu (5016-15)/12597.6 = 0.396979 ms/iteration
pair_setof took 
 user cpu (1266-0)/2809.46 = 0.45062 ms/iteration
double_setof took 
 user cpu (4891-0)/4325.26 = 1.1308 ms/iteration
bagof took 
 user cpu (5078-16)/36791.8 = 0.137585 ms/iteration
functor_in(0) took 
 user cpu (5969-531)/1.10351e+006 = 0.00492792 ms/iteration
functor_in(4) took 
 user cpu (5672-469)/1.03242e+006 = 0.00503963 ms/iteration
functor_out(0) took 
 user cpu (4797-531)/1.18963e+006 = 0.003586 ms/iteration
functor_out(4) took 
 user cpu (4953-531)/1.19847e+006 = 0.00368972 ms/iteration
functor_unify(0) took 
 user cpu (6469-750)/1.24533e+006 = 0.00459236 ms/iteration
functor_unify(4) took 
 user cpu (3594-359)/831255 = 0.00389171 ms/iteration
call_test(number(1)) took 
 user cpu (5594-4828)/1.08108e+006 = 0.00070855 ms/iteration
call_test(a == a) took 
 user cpu (5328-3297)/835561 = 0.0024307 ms/iteration
call_test(dummy) took 
 user cpu (5000-2015)/1.25471e+006 = 0.00237904 ms/iteration
call_test(dummy(_x2145,_x2146,_x2147)) took 
 user cpu (5407-4046)/1.77809e+006 = 0.000765426 ms/iteration