tplp-planning-benchmark/gc-ta1-tt1-trendy/ipc-2011_elevator-sequential-satisficing_11.out

400 lines
14 KiB
Plaintext

INFO Running translator.
INFO translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/elevator-sequential-satisficing/domain.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/elevator-sequential-satisficing/instances/instance-11.pddl']
INFO translator arguments: []
INFO translator time limit: None
INFO translator memory limit: None
INFO callstring: /home/pluehne/.usr/bin/python /home/wv/bin/linux/64/fast-downward-10997/builds/release64/bin/translate/translate.py /home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/elevator-sequential-satisficing/domain.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/elevator-sequential-satisficing/instances/instance-11.pddl
Parsing...
Parsing: [0.070s CPU, 0.171s wall-clock]
Normalizing task... [0.000s CPU, 0.003s wall-clock]
Instantiating...
Generating Datalog program... [0.020s CPU, 0.020s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.030s CPU, 0.028s wall-clock]
Preparing model... [0.060s CPU, 0.060s wall-clock]
Generated 46 rules.
Computing model... [3.110s CPU, 3.097s wall-clock]
28784 relevant atoms
11208 auxiliary atoms
39992 final queue length
91552 total queue pushes
Completing instantiation... [10.190s CPU, 10.192s wall-clock]
Instantiating: [13.450s CPU, 13.436s wall-clock]
Computing fact groups...
Finding invariants...
12 initial candidates
Finding invariants: [0.150s CPU, 0.147s wall-clock]
Checking invariant weight... [0.000s CPU, 0.005s wall-clock]
Instantiating groups... [0.100s CPU, 0.097s wall-clock]
Collecting mutex groups... [0.010s CPU, 0.009s wall-clock]
Choosing groups...
0 uncovered facts
Choosing groups: [0.020s CPU, 0.026s wall-clock]
Building translation key... [0.020s CPU, 0.018s wall-clock]
Computing fact groups: [0.370s CPU, 0.369s wall-clock]
Building STRIPS to SAS dictionary... [0.010s CPU, 0.008s wall-clock]
Building dictionary for full mutex groups... [0.000s CPU, 0.006s wall-clock]
Building mutex information...
Building mutex information: [0.010s CPU, 0.011s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [0.440s CPU, 0.437s wall-clock]
Translating task: [8.220s CPU, 8.215s wall-clock]
0 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
56 propositions removed
Detecting unreachable propositions: [4.270s CPU, 4.261s wall-clock]
Reordering and filtering variables...
56 of 56 variables necessary.
0 of 56 mutex groups necessary.
26696 of 26696 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [1.260s CPU, 1.257s wall-clock]
Translator variables: 56
Translator derived variables: 0
Translator facts: 1432
Translator goal facts: 40
Translator mutex groups: 0
Translator total mutex groups size: 0
Translator operators: 26696
Translator axioms: 0
Translator task size: 160336
Translator peak memory: 140708 KB
Writing output... [2.740s CPU, 2.939s wall-clock]
Done! [30.750s CPU, 31.034s wall-clock]
planner.py version 0.0.1
Time: 6.79s
Memory: 494MB
Iteration 1
Queue: [(0,0,0,True), (1,5,0,True), (2,10,0,True), (3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 0
Solving...
[start: stats after solve call]
Models : 0
Calls : 1
Time : 7.936s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 6.824s
Choices : 0
Conflicts : 0 (Analyzed: 0)
Restarts : 0
Problems : 1 (Average Length: 2.00 Splits: 0)
Lemmas : 0 (Deleted: 0)
Binary : 0 (Ratio: 0.00%)
Ternary : 0 (Ratio: 0.00%)
Conflict : 0 (Average Length: 0.0 Ratio: 0.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0)
Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%)
Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%)
Rules : 483386
Atoms : 483386
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 0 (Eliminated: 0 Frozen: 0)
Constraints : 0 (Binary: 0.0% Ternary: 0.0% Other: 0.0%)
Memory Peak : 630MB
Max. Length : 0 steps
Models : 0
[endof: stats after solve call]
Solving Time: 0.04s
Memory: 566MB (+72MB)
UNSAT
Iteration Time: 0.04s
Iteration 2
Queue: [(1,5,0,True), (2,10,0,True), (3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 0
Expected Memory: 566MB
Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])]
Grounding Time: 2.28s
Memory: 566MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0
Calls : 2
Time : 23.630s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 22.524s
Choices : 0
Conflicts : 0 (Analyzed: 0)
Restarts : 0
Problems : 2 (Average Length: 4.50 Splits: 0)
Lemmas : 0 (Deleted: 0)
Binary : 0 (Ratio: 0.00%)
Ternary : 0 (Ratio: 0.00%)
Conflict : 0 (Average Length: 0.0 Ratio: 0.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0)
Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%)
Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%)
Rules : 483386
Atoms : 483386
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 120011 (Eliminated: 0 Frozen: 120011)
Constraints : 286727 (Binary: 98.1% Ternary: 0.8% Other: 1.1%)
Memory Peak : 630MB
Max. Length : 0 steps
Models : 0
[endof: stats after solve call]
Solving Time: 11.90s
Memory: 602MB (+36MB)
UNSAT
Iteration Time: 15.71s
Iteration 3
Queue: [(2,10,0,True), (3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 5
Expected Memory: 638.0MB
Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])]
Grounding Time: 2.56s
Memory: 607MB (+5MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0
Calls : 3
Time : 54.565s (Solving: 6.83s 1st Model: 0.00s Unsat: 6.83s)
CPU Time : 53.472s
Choices : 291133 (Domain: 291133)
Conflicts : 14685 (Analyzed: 14684)
Restarts : 24 (Average: 611.83 Last: 155)
Problems : 3 (Average Length: 7.00 Splits: 0)
Lemmas : 14684 (Deleted: 4686)
Binary : 385 (Ratio: 2.62%)
Ternary : 185 (Ratio: 1.26%)
Conflict : 14684 (Average Length: 451.9 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 14684 (Average: 19.24 Max: 969 Sum: 282514)
Executed : 14670 (Average: 19.24 Max: 969 Sum: 282500 Ratio: 100.00%)
Bounded : 14 (Average: 1.00 Max: 1 Sum: 14 Ratio: 0.00%)
Rules : 483386
Atoms : 483386
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 265286 (Eliminated: 0 Frozen: 265286)
Constraints : 1465677 (Binary: 98.6% Ternary: 0.6% Other: 0.7%)
Memory Peak : 704MB
Max. Length : 5 steps
Models : 0
[endof: stats after solve call]
Solving Time: 27.08s
Memory: 704MB (+97MB)
UNSAT
Iteration Time: 30.96s
Iteration 4
Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 10
Expected Memory: 806.0MB
Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])]
Grounding Time: 2.27s
Memory: 723MB (+19MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 1+
Calls : 4
Time : 95.060s (Solving: 22.74s 1st Model: 15.87s Unsat: 6.83s)
CPU Time : 93.984s
Choices : 960793 (Domain: 960598)
Conflicts : 33873 (Analyzed: 33872)
Restarts : 82 (Average: 413.07 Last: 155)
Model-Level : 2625.0
Problems : 4 (Average Length: 9.50 Splits: 0)
Lemmas : 33872 (Deleted: 13988)
Binary : 703 (Ratio: 2.08%)
Ternary : 398 (Ratio: 1.18%)
Conflict : 33872 (Average Length: 533.9 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 33872 (Average: 26.39 Max: 1970 Sum: 893824)
Executed : 33844 (Average: 26.39 Max: 1970 Sum: 893764 Ratio: 99.99%)
Bounded : 28 (Average: 2.14 Max: 17 Sum: 60 Ratio: 0.01%)
Rules : 483386
Atoms : 483386
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 413377 (Eliminated: 0 Frozen: 413377)
Constraints : 2672947 (Binary: 98.7% Ternary: 0.6% Other: 0.7%)
Memory Peak : 860MB
Max. Length : 10 steps
Models : 1
[endof: stats after solve call]
Solving Time: 36.99s
Memory: 860MB (+137MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time: 8.97s
Memory: 1097MB (+237MB)
Solving...
[start: stats after solve call]
Models : 0+
Calls : 5
Time : 191.080s (Solving: 112.65s 1st Model: 15.87s Unsat: 6.83s)
CPU Time : 190.044s
Choices : 3083818 (Domain: 3083623)
Conflicts : 67863 (Analyzed: 67862)
Restarts : 182 (Average: 372.87 Last: 155)
Model-Level : 2625.0
Problems : 5 (Average Length: 11.00 Splits: 0)
Lemmas : 67862 (Deleted: 40371)
Binary : 1205 (Ratio: 1.78%)
Ternary : 772 (Ratio: 1.14%)
Conflict : 67862 (Average Length: 951.1 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 67862 (Average: 43.80 Max: 3791 Sum: 2972093)
Executed : 67705 (Average: 43.77 Max: 3791 Sum: 2970192 Ratio: 99.94%)
Bounded : 157 (Average: 12.11 Max: 17 Sum: 1901 Ratio: 0.06%)
Rules : 1412651 (Original: 1412586)
Atoms : 538194
Bodies : 586821 (Original: 586755)
Count : 769 (Original: 776)
Equivalences : 296642 (Atom=Atom: 33 Body=Body: 0 Other: 296609)
Tight : Yes
Variables : 415041 (Eliminated: 72 Frozen: 414969)
Constraints : 3549874 (Binary: 99.0% Ternary: 0.5% Other: 0.6%)
Memory Peak : 1245MB
Max. Length : 10 steps
Models : 1
[endof: stats after solve call]
Solving Time: 92.75s
Memory: 1181MB (+84MB)
UNKNOWN
Iteration Time: 142.25s
Iteration 5
Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 15
Expected Memory: 1337.0MB
Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])]
Grounding Time: 4.28s
Memory: 1181MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 6
Time : 403.738s (Solving: 286.55s 1st Model: 15.87s Unsat: 6.83s)
CPU Time : 402.788s
Choices : 10045770 (Domain: 10045575)
Conflicts : 112797 (Analyzed: 112796)
Restarts : 282 (Average: 399.99 Last: 1117)
Model-Level : 2625.0
Problems : 6 (Average Length: 12.83 Splits: 0)
Lemmas : 112796 (Deleted: 85139)
Binary : 1882 (Ratio: 1.67%)
Ternary : 1217 (Ratio: 1.08%)
Conflict : 112796 (Average Length: 945.3 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 112796 (Average: 86.17 Max: 3976 Sum: 9719116)
Executed : 112469 (Average: 86.12 Max: 3976 Sum: 9713475 Ratio: 99.94%)
Bounded : 327 (Average: 17.25 Max: 22 Sum: 5641 Ratio: 0.06%)
Rules : 1412651 (Original: 1412586)
Atoms : 538194
Bodies : 586821 (Original: 586755)
Count : 769 (Original: 776)
Equivalences : 296642 (Atom=Atom: 33 Body=Body: 0 Other: 296609)
Tight : Yes
Variables : 563692 (Eliminated: 72 Frozen: 563620)
Constraints : 5072741 (Binary: 99.0% Ternary: 0.5% Other: 0.5%)
Memory Peak : 1345MB
Max. Length : 15 steps
Models : 1
[endof: stats after solve call]
Solving Time: 206.82s
Memory: 1345MB (+164MB)
UNKNOWN
Iteration Time: 212.76s
Iteration 6
Queue: [(5,25,0,True), (6,30,0,True)]
Grounded Until: 20
Expected Memory: 1509.0MB
Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])]
Grounding Time: 4.90s
Memory: 1445MB (+100MB)
Unblocking actions...
Solving...
*** Info : (planner): INTERRUPTED by signal!
UNKNOWN
INTERRUPTED : 1
Models : 0+
Calls : 7
Time : 861.302s (Solving: 704.78s 1st Model: 15.87s Unsat: 6.83s)
CPU Time : 860.524s
Choices : 28437189 (Domain: 28436994)
Conflicts : 182701 (Analyzed: 182700)
Restarts : 350 (Average: 522.00 Last: 1124)
Model-Level : 2625.0
Problems : 7 (Average Length: 14.86 Splits: 0)
Lemmas : 182700 (Deleted: 142978)
Binary : 2393 (Ratio: 1.31%)
Ternary : 1706 (Ratio: 0.93%)
Conflict : 182700 (Average Length: 934.3 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 182700 (Average: 152.67 Max: 7180 Sum: 27893540)
Executed : 182223 (Average: 152.62 Max: 7180 Sum: 27883849 Ratio: 99.97%)
Bounded : 477 (Average: 20.32 Max: 27 Sum: 9691 Ratio: 0.03%)
Rules : 1412651 (Original: 1412586)
Atoms : 538194
Bodies : 586821 (Original: 586755)
Count : 769 (Original: 776)
Equivalences : 296642 (Atom=Atom: 33 Body=Body: 0 Other: 296609)
Tight : Yes
Variables : 712343 (Eliminated: 72 Frozen: 712271)
Constraints : 6572291 (Binary: 99.0% Ternary: 0.5% Other: 0.5%)
Memory Peak : 1535MB
Max. Length : 20 steps
Models : 1