tplp-planning-benchmark/gc-ta1-tt1-single-shot/ipc-2011_elevator-sequential-satisficing_7.out

479 lines
17 KiB
Plaintext
Raw Permalink Normal View History

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-7.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-7.pddl
Parsing...
Parsing: [0.060s CPU, 0.061s wall-clock]
Normalizing task... [0.010s CPU, 0.003s wall-clock]
Instantiating...
Generating Datalog program... [0.010s CPU, 0.015s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.030s CPU, 0.026s wall-clock]
Preparing model... [0.040s CPU, 0.047s wall-clock]
Generated 46 rules.
Computing model... [1.270s CPU, 1.267s wall-clock]
10863 relevant atoms
5844 auxiliary atoms
16707 final queue length
34683 total queue pushes
Completing instantiation... [3.500s CPU, 3.497s wall-clock]
Instantiating: [4.870s CPU, 4.868s wall-clock]
Computing fact groups...
Finding invariants...
12 initial candidates
Finding invariants: [0.060s CPU, 0.064s wall-clock]
Checking invariant weight... [0.000s CPU, 0.003s wall-clock]
Instantiating groups... [0.050s CPU, 0.043s wall-clock]
Collecting mutex groups... [0.010s CPU, 0.005s wall-clock]
Choosing groups...
0 uncovered facts
Choosing groups: [0.010s CPU, 0.017s wall-clock]
Building translation key... [0.010s CPU, 0.009s wall-clock]
Computing fact groups: [0.180s CPU, 0.180s wall-clock]
Building STRIPS to SAS dictionary... [0.000s CPU, 0.005s wall-clock]
Building dictionary for full mutex groups... [0.000s CPU, 0.004s wall-clock]
Building mutex information...
Building mutex information: [0.010s CPU, 0.005s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [0.150s CPU, 0.155s wall-clock]
Translating task: [2.910s CPU, 2.916s wall-clock]
0 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
34 propositions removed
Detecting unreachable propositions: [1.530s CPU, 1.523s wall-clock]
Reordering and filtering variables...
34 of 34 variables necessary.
0 of 34 mutex groups necessary.
9516 of 9516 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [0.440s CPU, 0.444s wall-clock]
Translator variables: 34
Translator derived variables: 0
Translator facts: 790
Translator goal facts: 24
Translator mutex groups: 0
Translator total mutex groups size: 0
Translator operators: 9516
Translator axioms: 0
Translator task size: 57044
Translator peak memory: 73420 KB
Writing output... [0.960s CPU, 1.029s wall-clock]
Done! [11.100s CPU, 11.166s wall-clock]
planner.py version 0.0.1
Time: 2.38s
Memory: 207MB
Iteration 1
Queue: [(0,40,0,True)]
Grounded Until: 0
Expected Memory: 207MB
Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])]
Grounding Time: 6.94s
Memory: 740MB (+533MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 1+
Calls : 1
Time : 16.060s (Solving: 1.82s 1st Model: 1.79s Unsat: 0.00s)
CPU Time : 15.684s
Choices : 77432 (Domain: 77396)
Conflicts : 1723 (Analyzed: 1723)
Restarts : 12 (Average: 143.58 Last: 15)
Model-Level : 2261.0
Problems : 1 (Average Length: 42.00 Splits: 0)
Lemmas : 1723 (Deleted: 0)
Binary : 83 (Ratio: 4.82%)
Ternary : 32 (Ratio: 1.86%)
Conflict : 1723 (Average Length: 650.9 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 1723 (Average: 39.30 Max: 1823 Sum: 67712)
Executed : 1723 (Average: 39.30 Max: 1823 Sum: 67712 Ratio: 100.00%)
Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%)
Rules : 0
Atoms : 0
Bodies : 0
Tight : Yes
Variables : 434996 (Eliminated: 0 Frozen: 30266)
Constraints : 3086313 (Binary: 98.1% Ternary: 0.9% Other: 1.0%)
Memory Peak : 1029MB
Max. Length : 0 steps
Models : 1
[endof: stats after solve call]
Solving Time: 2.16s
Memory: 965MB (+225MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time: 4.83s
Memory: 979MB (+14MB)
Solving...
[start: stats after solve call]
Models : 0+
Calls : 2
Time : 110.899s (Solving: 93.31s 1st Model: 1.79s Unsat: 0.00s)
CPU Time : 110.564s
Choices : 2275614 (Domain: 2275578)
Conflicts : 27012 (Analyzed: 27012)
Restarts : 112 (Average: 241.18 Last: 169)
Model-Level : 2261.0
Problems : 2 (Average Length: 42.00 Splits: 0)
Lemmas : 27012 (Deleted: 22338)
Binary : 460 (Ratio: 1.70%)
Ternary : 233 (Ratio: 0.86%)
Conflict : 27012 (Average Length: 1233.1 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 27012 (Average: 82.85 Max: 5926 Sum: 2237826)
Executed : 26883 (Average: 82.65 Max: 5926 Sum: 2232408 Ratio: 99.76%)
Bounded : 129 (Average: 42.00 Max: 42 Sum: 5418 Ratio: 0.24%)
Rules : 1021812 (Original: 1021763)
Atoms : 21549
Bodies : 673519 (Original: 673470)
Count : 1309 (Original: 1314)
Equivalences : 342707 (Atom=Atom: 53 Body=Body: 0 Other: 342654)
Tight : Yes
Variables : 437702 (Eliminated: 0 Frozen: 372797)
Constraints : 4090766 (Binary: 98.5% Ternary: 0.7% Other: 0.8%)
Memory Peak : 1032MB
Max. Length : 0 steps
Models : 1
[endof: stats after solve call]
Solving Time: 92.21s
Memory: 1009MB (+30MB)
UNKNOWN
Iteration Time: 110.36s
Iteration 2
Queue: [(0,40,1,True)]
Grounded Until: 40
Solving...
[start: stats after solve call]
Models : 0+
Calls : 3
Time : 227.470s (Solving: 209.74s 1st Model: 1.79s Unsat: 0.00s)
CPU Time : 227.184s
Choices : 5171986 (Domain: 5171950)
Conflicts : 54822 (Analyzed: 54822)
Restarts : 212 (Average: 258.59 Last: 169)
Model-Level : 2261.0
Problems : 3 (Average Length: 42.00 Splits: 0)
Lemmas : 54822 (Deleted: 49220)
Binary : 766 (Ratio: 1.40%)
Ternary : 418 (Ratio: 0.76%)
Conflict : 54822 (Average Length: 951.0 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 54822 (Average: 92.86 Max: 5926 Sum: 5090975)
Executed : 54661 (Average: 92.74 Max: 5926 Sum: 5084213 Ratio: 99.87%)
Bounded : 161 (Average: 42.00 Max: 42 Sum: 6762 Ratio: 0.13%)
Rules : 1021812 (Original: 1021763)
Atoms : 21549
Bodies : 673519 (Original: 673470)
Count : 1309 (Original: 1314)
Equivalences : 342707 (Atom=Atom: 53 Body=Body: 0 Other: 342654)
Tight : Yes
Variables : 437702 (Eliminated: 0 Frozen: 372797)
Constraints : 4027413 (Binary: 98.5% Ternary: 0.7% Other: 0.8%)
Memory Peak : 1032MB
Max. Length : 40 steps
Models : 1
[endof: stats after solve call]
Solving Time: 116.63s
Memory: 1009MB (+0MB)
UNKNOWN
Iteration Time: 116.63s
Iteration 3
Queue: [(0,40,2,True)]
Grounded Until: 40
Solving...
[start: stats after solve call]
Models : 0+
Calls : 4
Time : 343.359s (Solving: 325.54s 1st Model: 1.79s Unsat: 0.00s)
CPU Time : 343.120s
Choices : 7782651 (Domain: 7782615)
Conflicts : 82933 (Analyzed: 82933)
Restarts : 312 (Average: 265.81 Last: 227)
Model-Level : 2261.0
Problems : 4 (Average Length: 42.00 Splits: 0)
Lemmas : 82933 (Deleted: 75237)
Binary : 1056 (Ratio: 1.27%)
Ternary : 621 (Ratio: 0.75%)
Conflict : 82933 (Average Length: 927.8 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 82933 (Average: 92.54 Max: 5926 Sum: 7674431)
Executed : 82746 (Average: 92.44 Max: 5926 Sum: 7666577 Ratio: 99.90%)
Bounded : 187 (Average: 42.00 Max: 42 Sum: 7854 Ratio: 0.10%)
Rules : 1021812 (Original: 1021763)
Atoms : 21549
Bodies : 673519 (Original: 673470)
Count : 1309 (Original: 1314)
Equivalences : 342707 (Atom=Atom: 53 Body=Body: 0 Other: 342654)
Tight : Yes
Variables : 437702 (Eliminated: 0 Frozen: 372797)
Constraints : 4025018 (Binary: 98.5% Ternary: 0.7% Other: 0.8%)
Memory Peak : 1032MB
Max. Length : 40 steps
Models : 1
[endof: stats after solve call]
Solving Time: 115.94s
Memory: 1009MB (+0MB)
UNKNOWN
Iteration Time: 115.94s
Iteration 4
Queue: [(0,40,3,True)]
Grounded Until: 40
Solving...
[start: stats after solve call]
Models : 0+
Calls : 5
Time : 471.109s (Solving: 453.22s 1st Model: 1.79s Unsat: 0.00s)
CPU Time : 470.928s
Choices : 10963592 (Domain: 10963556)
Conflicts : 113184 (Analyzed: 113184)
Restarts : 412 (Average: 274.72 Last: 274)
Model-Level : 2261.0
Problems : 5 (Average Length: 42.00 Splits: 0)
Lemmas : 113184 (Deleted: 101756)
Binary : 1177 (Ratio: 1.04%)
Ternary : 736 (Ratio: 0.65%)
Conflict : 113184 (Average Length: 1042.7 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 113184 (Average: 95.64 Max: 5926 Sum: 10824540)
Executed : 112979 (Average: 95.56 Max: 5926 Sum: 10815930 Ratio: 99.92%)
Bounded : 205 (Average: 42.00 Max: 42 Sum: 8610 Ratio: 0.08%)
Rules : 1021812 (Original: 1021763)
Atoms : 21549
Bodies : 673519 (Original: 673470)
Count : 1309 (Original: 1314)
Equivalences : 342707 (Atom=Atom: 53 Body=Body: 0 Other: 342654)
Tight : Yes
Variables : 437702 (Eliminated: 0 Frozen: 372797)
Constraints : 4019791 (Binary: 98.5% Ternary: 0.7% Other: 0.8%)
Memory Peak : 1032MB
Max. Length : 40 steps
Models : 1
[endof: stats after solve call]
Solving Time: 127.81s
Memory: 1009MB (+0MB)
UNKNOWN
Iteration Time: 127.81s
Iteration 5
Queue: [(0,40,4,True)]
Grounded Until: 40
Solving...
[start: stats after solve call]
Models : 0+
Calls : 6
Time : 559.152s (Solving: 541.14s 1st Model: 1.79s Unsat: 0.00s)
CPU Time : 559.008s
Choices : 13351038 (Domain: 13351002)
Conflicts : 140647 (Analyzed: 140647)
Restarts : 512 (Average: 274.70 Last: 274)
Model-Level : 2261.0
Problems : 6 (Average Length: 42.00 Splits: 0)
Lemmas : 140647 (Deleted: 126659)
Binary : 1281 (Ratio: 0.91%)
Ternary : 809 (Ratio: 0.58%)
Conflict : 140647 (Average Length: 1242.7 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 140647 (Average: 93.70 Max: 5926 Sum: 13179280)
Executed : 140427 (Average: 93.64 Max: 5926 Sum: 13170040 Ratio: 99.93%)
Bounded : 220 (Average: 42.00 Max: 42 Sum: 9240 Ratio: 0.07%)
Rules : 1021812 (Original: 1021763)
Atoms : 21549
Bodies : 673519 (Original: 673470)
Count : 1309 (Original: 1314)
Equivalences : 342707 (Atom=Atom: 53 Body=Body: 0 Other: 342654)
Tight : Yes
Variables : 437702 (Eliminated: 0 Frozen: 372797)
Constraints : 4018630 (Binary: 98.5% Ternary: 0.7% Other: 0.8%)
Memory Peak : 1137MB
Max. Length : 40 steps
Models : 1
[endof: stats after solve call]
Solving Time: 88.08s
Memory: 1073MB (+64MB)
UNKNOWN
Iteration Time: 88.08s
Iteration 6
Queue: [(0,40,5,True)]
Grounded Until: 40
Solving...
[start: stats after solve call]
Models : 0+
Calls : 7
Time : 679.346s (Solving: 661.22s 1st Model: 1.79s Unsat: 0.00s)
CPU Time : 679.252s
Choices : 17034655 (Domain: 17034619)
Conflicts : 172900 (Analyzed: 172900)
Restarts : 612 (Average: 282.52 Last: 274)
Model-Level : 2261.0
Problems : 7 (Average Length: 42.00 Splits: 0)
Lemmas : 172900 (Deleted: 159169)
Binary : 1367 (Ratio: 0.79%)
Ternary : 897 (Ratio: 0.52%)
Conflict : 172900 (Average Length: 1248.0 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 172900 (Average: 97.23 Max: 5926 Sum: 16810566)
Executed : 172673 (Average: 97.17 Max: 5926 Sum: 16801032 Ratio: 99.94%)
Bounded : 227 (Average: 42.00 Max: 42 Sum: 9534 Ratio: 0.06%)
Rules : 1021812 (Original: 1021763)
Atoms : 21549
Bodies : 673519 (Original: 673470)
Count : 1309 (Original: 1314)
Equivalences : 342707 (Atom=Atom: 53 Body=Body: 0 Other: 342654)
Tight : Yes
Variables : 437702 (Eliminated: 0 Frozen: 372797)
Constraints : 4013174 (Binary: 98.5% Ternary: 0.7% Other: 0.8%)
Memory Peak : 1137MB
Max. Length : 40 steps
Models : 1
[endof: stats after solve call]
Solving Time: 120.25s
Memory: 1073MB (+0MB)
UNKNOWN
Iteration Time: 120.25s
Iteration 7
Queue: [(0,40,6,True)]
Grounded Until: 40
Solving...
[start: stats after solve call]
Models : 0+
Calls : 8
Time : 764.581s (Solving: 746.38s 1st Model: 1.79s Unsat: 0.00s)
CPU Time : 764.524s
Choices : 19533987 (Domain: 19533951)
Conflicts : 198764 (Analyzed: 198764)
Restarts : 712 (Average: 279.16 Last: 274)
Model-Level : 2261.0
Problems : 8 (Average Length: 42.00 Splits: 0)
Lemmas : 198764 (Deleted: 181764)
Binary : 1403 (Ratio: 0.71%)
Ternary : 992 (Ratio: 0.50%)
Conflict : 198764 (Average Length: 1326.0 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 198764 (Average: 96.90 Max: 5926 Sum: 19260702)
Executed : 198534 (Average: 96.85 Max: 5926 Sum: 19251042 Ratio: 99.95%)
Bounded : 230 (Average: 42.00 Max: 42 Sum: 9660 Ratio: 0.05%)
Rules : 1021812 (Original: 1021763)
Atoms : 21549
Bodies : 673519 (Original: 673470)
Count : 1309 (Original: 1314)
Equivalences : 342707 (Atom=Atom: 53 Body=Body: 0 Other: 342654)
Tight : Yes
Variables : 437702 (Eliminated: 0 Frozen: 372797)
Constraints : 4013075 (Binary: 98.5% Ternary: 0.7% Other: 0.8%)
Memory Peak : 1137MB
Max. Length : 40 steps
Models : 1
[endof: stats after solve call]
Solving Time: 85.27s
Memory: 1073MB (+0MB)
UNKNOWN
Iteration Time: 85.27s
Iteration 8
Queue: [(0,40,7,True)]
Grounded Until: 40
Solving...
*** Info : (planner): INTERRUPTED by signal!
UNKNOWN
INTERRUPTED : 1
Models : 0+
Calls : 9
Time : 884.754s (Solving: 866.45s 1st Model: 1.79s Unsat: 0.00s)
CPU Time : 884.732s
Choices : 23707480 (Domain: 23707444)
Conflicts : 228045 (Analyzed: 228045)
Restarts : 809 (Average: 281.89 Last: 274)
Model-Level : 2261.0
Problems : 9 (Average Length: 42.00 Splits: 0)
Lemmas : 228045 (Deleted: 208926)
Binary : 1456 (Ratio: 0.64%)
Ternary : 1096 (Ratio: 0.48%)
Conflict : 228045 (Average Length: 1305.5 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 228045 (Average: 102.52 Max: 5926 Sum: 23378267)
Executed : 227802 (Average: 102.47 Max: 5926 Sum: 23368061 Ratio: 99.96%)
Bounded : 243 (Average: 42.00 Max: 42 Sum: 10206 Ratio: 0.04%)
Rules : 1021812 (Original: 1021763)
Atoms : 21549
Bodies : 673519 (Original: 673470)
Count : 1309 (Original: 1314)
Equivalences : 342707 (Atom=Atom: 53 Body=Body: 0 Other: 342654)
Tight : Yes
Variables : 437702 (Eliminated: 0 Frozen: 372797)
Constraints : 4012977 (Binary: 98.5% Ternary: 0.7% Other: 0.8%)
Memory Peak : 1137MB
Max. Length : 40 steps
Models : 1