2:43 a.m.
Hi,
I'm still (or again) stuck on an easy test case.
A few days ago I first mentioned I had I very easy unit test that easily could be solved
on sight but which was not solved optimal by planner.
Geoffrey pointed out that I needed to adjust the value of entityTabuSize in my localSearch
acceptor configuration.
I did so (reducing from 7 to 3) and it worked, but now, having fiddled a bit on one of my
rules I'm stuck again on the same issue.
I created a custom solver phase to force a specific solution and when adding this phase
into my configuration I get a zero-score solution, namely the solution I forced.
So it does not seem to be an issue in my rules.
As suggested before by Geoffrey, I have put the logging level to debug and I get a lot of
output like this (see beneath), but I don't really know how this can help me in
solving the issue:
(I left out a lot of lines, I hope I left in the important ones)
INFO : [2013-01-16 09:34:29,847] Solving started: time spend (90), score (null), new best
score (null), random seed (0).
DEBUG: [2013-01-16 09:34:30,113] Step index (0), time spend (357), score
(-80hard/0soft), initialized planning entity (Inspection of PG_Leuven.I#0 2137587059).
DEBUG: [2013-01-16 09:34:30,248] Step index (1), time spend (492), score
(-81hard/0soft), initialized planning entity (Inspection of PG_Haacht.I#0 1475783831).
DEBUG: [2013-01-16 09:34:30,268] Step index (2), time spend (512), score
(-81hard/0soft), initialized planning entity (Inspection of PG_Leuven.I#2 2137587061).
DEBUG: [2013-01-16 09:34:30,295] Step index (3), time spend (539), score
(-81hard/0soft), initialized planning entity (Inspection of Rotselaar.I#0 -105164233).
DEBUG: [2013-01-16 09:34:30,405] Step index (4), time spend (649), score
(-161hard/0soft), initialized planning entity (Inspection of Rotselaar.I#1 -105164232).
DEBUG: [2013-01-16 09:34:30,490] Step index (5), time spend (734), score
(-242hard/0soft), initialized planning entity (Inspection of PG_Haacht.I#1 1475783832).
DEBUG: [2013-01-16 09:34:30,572] Step index (6), time spend (816), score
(-392hard/0soft), initialized planning entity (Inspection of PG_Leuven.I#1 2137587060).
INFO : [2013-01-16 09:34:30,572] Phase constructionHeuristic ended: step total (7), time
spend (816), best score (-392hard/0soft).
DEBUG: [2013-01-16 09:34:31,499] Step index (0), time spend (1743), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count
(1000/1000) for picked step (Inspection of PG_Leuven.I#1 2137587060 => (P8) ).
DEBUG: [2013-01-16 09:34:32,037] Step index (1), time spend (2281), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count
(1000/1215) for picked step (Inspection of PG_Haacht.I#0 1475783831 => TL).
DEBUG: [2013-01-16 09:34:32,635] Step index (2), time spend (2879), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count
(1000/1587) for picked step (Inspection of Rotselaar.I#1 -105164232 => TL).
DEBUG: [2013-01-16 09:34:32,914] Step index (3), time spend (3158), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count
(1000/2118) for picked step (Inspection of PG_Haacht.I#1 1475783832 => TL).
DEBUG: [2013-01-16 09:34:33,128] Step index (4), time spend (3372), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count
(1000/2039) for picked step (Inspection of PG_Leuven.I#1 2137587060 => (P2) ).
...
DEBUG: [2013-01-16 09:34:41,219] Step index (68), time spend (11463), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count
(1000/1995) for picked step (Inspection of PG_Haacht.I#0 1475783831 => TL).
DEBUG: [2013-01-16 09:34:41,340] Step index (69), time spend (11584), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count
(1000/2070) for picked step (Inspection of PG_Leuven.I#1 2137587060 => IV).
DEBUG: [2013-01-16 09:34:41,460] Step index (70), time spend (11704), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count
(1000/2034) for picked step (Inspection of PG_Leuven.I#0 2137587059 => TL).
DEBUG: [2013-01-16 09:34:41,575] Step index (71), time spend (11819), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count
(1000/1978) for picked step (Inspection of PG_Haacht.I#1 1475783832 => (P4) ).
DEBUG: [2013-01-16 09:34:41,693] Step index (72), time spend (11937), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count
(1000/2045) for picked step (Inspection of Rotselaar.I#0 -105164233 => TL).
DEBUG: [2013-01-16 09:34:41,813] Step index (73), time spend (12057), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count
(1000/2052) for picked step (Inspection of Rotselaar.I#1 -105164232 <=> Inspection
of PG_Leuven.I#1 2137587060).
DEBUG: [2013-01-16 09:34:41,970] Step index (74), time spend (12214), score
(-312hard/0soft), new best score (-312hard/0soft), accepted/selected move count
(1000/2673) for picked step (Inspection of Rotselaar.I#1 -105164232 => Jesse).
DEBUG: [2013-01-16 09:34:42,089] Step index (75), time spend (12333), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count
(1000/2039) for picked step (Inspection of PG_Haacht.I#1 1475783832 => IV).
DEBUG: [2013-01-16 09:34:42,223] Step index (76), time spend (12467), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count
(1000/1997) for picked step (Inspection of PG_Leuven.I#2 2137587061 => TL).
DEBUG: [2013-01-16 09:34:42,346] Step index (77), time spend (12590), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count
(1000/2073) for picked step (Inspection of PG_Haacht.I#0 1475783831 => IV).
DEBUG: [2013-01-16 09:34:42,484] Step index (78), time spend (12728), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count
(1000/2093) for picked step (Inspection of PG_Leuven.I#1 2137587060 => IV).
DEBUG: [2013-01-16 09:34:42,607] Step index (79), time spend (12851), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count
(1000/2049) for picked step (Inspection of PG_Haacht.I#1 1475783832 => TL).
DEBUG: [2013-01-16 09:34:42,720] Step index (80), time spend (12964), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count
(1000/1977) for picked step (Inspection of PG_Leuven.I#0 2137587059 => IV).
DEBUG: [2013-01-16 09:34:42,836] Step index (81), time spend (13080), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count
(1000/1991) for picked step (Inspection of PG_Haacht.I#0 1475783831 => TL).
DEBUG: [2013-01-16 09:34:42,959] Step index (82), time spend (13203), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count
(1000/2012) for picked step (Inspection of Rotselaar.I#0 -105164233 => (P3) ).
DEBUG: [2013-01-16 09:34:43,078] Step index (83), time spend (13322), score
(-162hard/0soft), new best score (-162hard/0soft), accepted/selected move count
(1000/2028) for picked step (Inspection of Rotselaar.I#1 -105164232 => (P3) ).
DEBUG: [2013-01-16 09:34:43,195] Step index (84), time spend (13439), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2013) for picked step (Inspection of PG_Leuven.I#1 2137587060 => TL).
DEBUG: [2013-01-16 09:34:43,313] Step index (85), time spend (13557), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2086) for picked step (Inspection of PG_Leuven.I#0 2137587059 => TL).
DEBUG: [2013-01-16 09:34:43,424] Step index (86), time spend (13668), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2011) for picked step (Inspection of PG_Haacht.I#1 1475783832 => IV).
DEBUG: [2013-01-16 09:34:43,540] Step index (87), time spend (13784), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2017) for picked step (Inspection of PG_Haacht.I#0 1475783831 => IV).
DEBUG: [2013-01-16 09:34:43,663] Step index (88), time spend (13907), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2090) for picked step (Inspection of Rotselaar.I#1 -105164232 => TL).
...
DEBUG: [2013-01-16 09:36:04,828] Step index (468), time spend (58711), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2071) for picked step (Inspection of PG_Leuven.I#1 2137587060 => IV).
DEBUG: [2013-01-16 09:36:04,949] Step index (469), time spend (58832), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2134) for picked step (Inspection of PG_Leuven.I#0 2137587059 => TL).
DEBUG: [2013-01-16 09:36:05,066] Step index (470), time spend (58949), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2073) for picked step (Inspection of Rotselaar.I#0 -105164233 => TL).
DEBUG: [2013-01-16 09:36:05,183] Step index (471), time spend (59066), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2067) for picked step (Inspection of Rotselaar.I#1 -105164232 => TL).
DEBUG: [2013-01-16 09:36:05,296] Step index (472), time spend (59179), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2034) for picked step (Inspection of PG_Haacht.I#0 1475783831 => IV).
DEBUG: [2013-01-16 09:36:05,409] Step index (473), time spend (59292), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2025) for picked step (Inspection of PG_Leuven.I#2 2137587061 => IV).
DEBUG: [2013-01-16 09:36:05,519] Step index (474), time spend (59402), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/1972) for picked step (Inspection of PG_Haacht.I#1 1475783832 => IV).
DEBUG: [2013-01-16 09:36:05,634] Step index (475), time spend (59517), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2028) for picked step (Inspection of PG_Leuven.I#1 2137587060 => TL).
DEBUG: [2013-01-16 09:36:05,749] Step index (476), time spend (59632), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2078) for picked step (Inspection of Rotselaar.I#0 -105164233 => IV).
DEBUG: [2013-01-16 09:36:05,863] Step index (477), time spend (59746), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2042) for picked step (Inspection of Rotselaar.I#1 -105164232 => IV).
DEBUG: [2013-01-16 09:36:05,980] Step index (478), time spend (59863), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2072) for picked step (Inspection of PG_Haacht.I#1 1475783832 => TL).
DEBUG: [2013-01-16 09:36:06,095] Step index (479), time spend (59978), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count
(1000/2037) for picked step (Inspection of PG_Leuven.I#1 2137587060 => IV).
DEBUG: [2013-01-16 09:36:06,118] Step index (480), time spend (60001), score
(-162hard/0soft), best score (-162hard/0soft), accepted/selected move count (171/360)
for picked step (Inspection of PG_Leuven.I#0 2137587059 => IV).
INFO : [2013-01-16 09:36:06,118] Phase localSearch ended: step total (481), time spend
(60001), best score (-162hard/0soft).
INFO : [2013-01-16 09:36:06,118] Solving ended: time spend (60001), best score
(-162hard/0soft), average calculate count per second (32639).
isEveryProblemFactChangeProcessed: true
isTerminateEarly: false
My configuration:
<localSearch>
<termination>
<terminationCompositionStyle>OR</terminationCompositionStyle>
<maximumSecondsSpend>3600</maximumSecondsSpend>
<scoreAttained>0hard/0soft</scoreAttained>
</termination>
<unionMoveSelector>
<changeMoveSelector>
<valueSelector>
<planningVariableName>period</planningVariableName>
</valueSelector>
</changeMoveSelector>
<changeMoveSelector>
<valueSelector>
<planningVariableName>inspector</planningVariableName>
</valueSelector>
</changeMoveSelector>
<changeMoveSelector>
<valueSelector>
<planningVariableName>type</planningVariableName>
</valueSelector>
</changeMoveSelector>
<swapMoveSelector>
</swapMoveSelector>
</unionMoveSelector>
<acceptor>
<planningEntityTabuSize>3</planningEntityTabuSize>
</acceptor>
<forager>
<minimalAcceptedSelection>1000</minimalAcceptedSelection>
</forager>
</localSearch>
I also tried with a different localSearch configuration:
<localSearch>
<termination>
<terminationCompositionStyle>OR</terminationCompositionStyle>
<maximumSecondsSpend>3600</maximumSecondsSpend>
<scoreAttained>0hard/0soft</scoreAttained>
</termination>
<unionMoveSelector>
<changeMoveSelector>
<valueSelector>
<planningVariableName>period</planningVariableName>
</valueSelector>
</changeMoveSelector>
<changeMoveSelector>
<valueSelector>
<planningVariableName>inspector</planningVariableName>
</valueSelector>
</changeMoveSelector>
<changeMoveSelector>
<valueSelector>
<planningVariableName>type</planningVariableName>
</valueSelector>
</changeMoveSelector>
<swapMoveSelector>
</swapMoveSelector>
</unionMoveSelector>
<acceptor>
<simulatedAnnealingStartingTemperature>2hard/100soft</simulatedAnnealingStartingTemperature>
<planningEntityTabuSize>3</planningEntityTabuSize>
</acceptor>
<forager>
<minimalAcceptedSelection>4</minimalAcceptedSelection>
</forager>
</localSearch>
Result:
INFO : [2013-01-16 09:12:43,653] Solving started: time spend (87), score (null), new best
score (null), random seed (0).
DEBUG: [2013-01-16 09:12:43,917] Step index (0), time spend (352), score
(-80hard/0soft), initialized planning entity (Inspection of B747-AX1.I#0 2137587059).
DEBUG: [2013-01-16 09:12:44,039] Step index (1), time spend (474), score
(-81hard/0soft), initialized planning entity (Inspection of B737-DX7.I#0 1475783831).
DEBUG: [2013-01-16 09:12:44,060] Step index (2), time spend (495), score
(-81hard/0soft), initialized planning entity (Inspection of B747-AX1.I#2 2137587061).
DEBUG: [2013-01-16 09:12:44,088] Step index (3), time spend (523), score
(-81hard/0soft), initialized planning entity (Inspection of B737-DC3.I#0 -105164233).
DEBUG: [2013-01-16 09:12:44,176] Step index (4), time spend (611), score
(-161hard/0soft), initialized planning entity (Inspection of B737-DC3.I#1 -105164232).
DEBUG: [2013-01-16 09:12:44,270] Step index (5), time spend (705), score
(-242hard/0soft), initialized planning entity (Inspection of B737-DX7.I#1 1475783832).
DEBUG: [2013-01-16 09:12:44,380] Step index (6), time spend (815), score
(-392hard/0soft), initialized planning entity (Inspection of B747-AX1.I#1 2137587060).
INFO : [2013-01-16 09:12:44,380] Phase constructionHeuristic ended: step total (7), time
spend (815), best score (-392hard/0soft).
DEBUG: [2013-01-16 09:12:44,420] Step index (0), time spend (855), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/19) for
picked step (Inspection of B747-AX1.I#2 2137587061 => TL).
DEBUG: [2013-01-16 09:12:44,444] Step index (1), time spend (879), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/27) for
picked step (Inspection of B737-DC3.I#0 -105164233 => TL).
DEBUG: [2013-01-16 09:12:44,465] Step index (2), time spend (900), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/23) for
picked step (Inspection of B747-AX1.I#0 2137587059 => TL).
DEBUG: [2013-01-16 09:12:44,488] Step index (3), time spend (923), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/23) for
picked step (Inspection of B737-DC3.I#1 -105164232 => TL).
DEBUG: [2013-01-16 09:12:44,529] Step index (4), time spend (964), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/21) for
picked step (Inspection of B747-AX1.I#1 2137587060 => TL).
...
DEBUG: [2013-01-16 09:12:44,776] Step index (12), time spend (1211), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/13) for
picked step (Inspection of B737-DX7.I#0 1475783831 => IV).
DEBUG: [2013-01-16 09:12:44,814] Step index (13), time spend (1249), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/45) for
picked step (Inspection of B737-DX7.I#1 1475783832 => (P4) ).
DEBUG: [2013-01-16 09:12:44,849] Step index (14), time spend (1284), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/46) for
picked step (Inspection of B747-AX1.I#2 2137587061 => IV).
DEBUG: [2013-01-16 09:12:44,880] Step index (15), time spend (1315), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/39) for
picked step (Inspection of B747-AX1.I#0 2137587059 => TL).
...
DEBUG: [2013-01-16 09:12:47,043] Step index (122), time spend (3478), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/40) for
picked step (Inspection of B737-DX7.I#0 1475783831 => IV).
DEBUG: [2013-01-16 09:12:47,046] Step index (123), time spend (3481), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/20) for
picked step (Inspection of B747-AX1.I#0 2137587059 => TL).
DEBUG: [2013-01-16 09:12:47,049] Step index (124), time spend (3484), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/16) for
picked step (Inspection of B737-DC3.I#0 -105164233 => TL).
DEBUG: [2013-01-16 09:12:47,056] Step index (125), time spend (3491), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/46) for
picked step (Inspection of B737-DC3.I#1 -105164232 <=> Inspection of B747-AX1.I#1
2137587060).
DEBUG: [2013-01-16 09:12:47,062] Step index (126), time spend (3497), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/44) for
picked step (Inspection of B737-DX7.I#0 1475783831 => TL).
DEBUG: [2013-01-16 09:12:47,067] Step index (127), time spend (3502), score
(-392hard/0soft), best score (-392hard/0soft), accepted/selected move count (4/26) for
picked step (Inspection of B747-AX1.I#2 2137587061 => TL).
DEBUG: [2013-01-16 09:12:47,072] Step index (128), time spend (3507), score
(-312hard/0soft), new best score (-312hard/0soft), accepted/selected move count (4/27) for
picked step (Inspection of B737-DC3.I#1 -105164232 => Jesse).
DEBUG: [2013-01-16 09:12:47,078] Step index (129), time spend (3513), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/37) for
picked step (Inspection of B747-AX1.I#0 2137587059 => IV).
DEBUG: [2013-01-16 09:12:47,080] Step index (130), time spend (3515), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/16) for
picked step (Inspection of B737-DX7.I#0 1475783831 => IV).
...
DEBUG: [2013-01-16 09:12:47,131] Step index (137), time spend (3566), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/28) for
picked step (Inspection of B747-AX1.I#1 2137587060 => IV).
DEBUG: [2013-01-16 09:12:47,135] Step index (138), time spend (3570), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/16) for
picked step (Inspection of B747-AX1.I#2 2137587061 <=> Inspection of B737-DC3.I#1
-105164232).
DEBUG: [2013-01-16 09:12:47,142] Step index (139), time spend (3577), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/69) for
picked step (Inspection of B737-DX7.I#0 1475783831 => IV).
DEBUG: [2013-01-16 09:12:47,148] Step index (140), time spend (3583), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/39) for
picked step (Inspection of B737-DC3.I#0 -105164233 => TL).
DEBUG: [2013-01-16 09:12:47,151] Step index (141), time spend (3586), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/22) for
picked step (Inspection of B747-AX1.I#0 2137587059 => IV).
DEBUG: [2013-01-16 09:12:47,153] Step index (142), time spend (3588), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/9) for
picked step (Inspection of B747-AX1.I#2 2137587061 <=> Inspection of B737-DC3.I#1
-105164232).
DEBUG: [2013-01-16 09:12:47,160] Step index (143), time spend (3595), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/51) for
picked step (Inspection of B737-DX7.I#1 1475783832 => IV).
DEBUG: [2013-01-16 09:12:47,167] Step index (144), time spend (3602), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/50) for
picked step (Inspection of B747-AX1.I#1 2137587060 => TL).
DEBUG: [2013-01-16 09:12:47,172] Step index (145), time spend (3607), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/37) for
picked step (Inspection of B737-DC3.I#0 -105164233 => IV).
...
DEBUG: [2013-01-16 09:12:47,824] Step index (259), time spend (4259), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/27) for
picked step (Inspection of B737-DC3.I#0 -105164233 => IV).
DEBUG: [2013-01-16 09:12:47,827] Step index (260), time spend (4262), score
(-312hard/0soft), best score (-312hard/0soft), accepted/selected move count (4/30) for
picked step (Inspection of B737-DC3.I#1 -105164232 <=> Inspection of B747-AX1.I#2
2137587061).
DEBUG: [2013-01-16 09:12:47,835] Step index (261), time spend (4270), score
(-242hard/0soft), new best score (-242hard/0soft), accepted/selected move count (4/50) for
picked step (Inspection of B737-DC3.I#0 -105164233 => (P8) ).
DEBUG: [2013-01-16 09:12:47,838] Step index (262), time spend (4273), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/27) for
picked step (Inspection of B737-DX7.I#1 1475783832 => TL).
DEBUG: [2013-01-16 09:12:47,842] Step index (263), time spend (4277), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/32) for
picked step (Inspection of B737-DX7.I#0 1475783831 => TL).
DEBUG: [2013-01-16 09:12:47,846] Step index (264), time spend (4281), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/26) for
picked step (Inspection of B747-AX1.I#1 2137587060 => TL).
...
DEBUG: [2013-01-16 09:27:17,903] Step index (16715), time spend (59977), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/49) for
picked step (Inspection of B737-DX7.I#0 -105164233 => TL).
DEBUG: [2013-01-16 09:27:17,905] Step index (16716), time spend (59979), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/19) for
picked step (Inspection of B737-DC3.I#1 2137587060 => TL).
DEBUG: [2013-01-16 09:27:17,908] Step index (16717), time spend (59982), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/43) for
picked step (Inspection of B737-DX7.I#1 -105164232 => TL).
DEBUG: [2013-01-16 09:27:17,912] Step index (16718), time spend (59986), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/55) for
picked step (Inspection of B747-AX1.I#1 1475783832 => TL).
DEBUG: [2013-01-16 09:27:17,915] Step index (16719), time spend (59989), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/41) for
picked step (Inspection of B737-DC3.I#0 2137587059 => IV).
DEBUG: [2013-01-16 09:27:17,918] Step index (16720), time spend (59992), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/47) for
picked step (Inspection of B737-DC3.I#1 2137587060 => IV).
DEBUG: [2013-01-16 09:27:17,922] Step index (16721), time spend (59996), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/62) for
picked step (Inspection of B747-AX1.I#0 1475783831 => IV).
DEBUG: [2013-01-16 09:27:17,924] Step index (16722), time spend (59998), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/24) for
picked step (Inspection of B737-DX7.I#1 -105164232 => IV).
DEBUG: [2013-01-16 09:27:17,926] Step index (16723), time spend (60000), score
(-242hard/0soft), best score (-242hard/0soft), accepted/selected move count (4/25) for
picked step (Inspection of B747-AX1.I#1 1475783832 => IV).
INFO : [2013-01-16 09:27:17,926] Phase localSearch ended: step total (16724), time spend
(60000), best score (-242hard/0soft).
INFO : [2013-01-16 09:27:17,926] Solving ended: time spend (60000), best score
(-242hard/0soft), average calculate count per second (22637).
isEveryProblemFactChangeProcessed: true
isTerminateEarly: false
Any ideas on how to move forward from here?
Thanks,
Michiel Vermandel
-----------------
http://www.codessentials.com - Your essential software, for free!
Follow us at http://twitter.com/#!/Codessentials