tplp-planning-benchmark/gc-ta1-tt1-jumpy/ipc-2011_tidybot-sequential-satisficing_2.out

493 lines
17 KiB
Plaintext
Raw Permalink Normal View History

INFO Running translator.
INFO translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/tidybot-sequential-satisficing/domain.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/tidybot-sequential-satisficing/instances/instance-2.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/tidybot-sequential-satisficing/domain.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/tidybot-sequential-satisficing/instances/instance-2.pddl
Parsing...
Parsing: [0.080s CPU, 0.079s wall-clock]
Normalizing task... [0.010s CPU, 0.006s wall-clock]
Instantiating...
Generating Datalog program... [0.010s CPU, 0.014s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.210s CPU, 0.209s wall-clock]
Preparing model... [0.070s CPU, 0.068s wall-clock]
Generated 400 rules.
Computing model... [6.630s CPU, 6.628s wall-clock]
31226 relevant atoms
32263 auxiliary atoms
63489 final queue length
163321 total queue pushes
Completing instantiation... [17.810s CPU, 17.801s wall-clock]
Instantiating: [24.810s CPU, 24.797s wall-clock]
Computing fact groups...
Finding invariants...
41 initial candidates
Finding invariants: [0.620s CPU, 0.619s wall-clock]
Checking invariant weight... [0.000s CPU, 0.001s wall-clock]
Instantiating groups... [0.000s CPU, 0.001s wall-clock]
Collecting mutex groups... [0.000s CPU, 0.000s wall-clock]
Choosing groups...
383 uncovered facts
Choosing groups: [0.000s CPU, 0.001s wall-clock]
Building translation key... [0.010s CPU, 0.014s wall-clock]
Computing fact groups: [0.660s CPU, 0.665s wall-clock]
Building STRIPS to SAS dictionary... [0.000s CPU, 0.003s wall-clock]
Building dictionary for full mutex groups... [0.010s CPU, 0.003s wall-clock]
Building mutex information...
Building mutex information: [0.000s CPU, 0.003s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [1.120s CPU, 1.116s wall-clock]
Translating task: [21.230s CPU, 21.225s wall-clock]
81643 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
2 propositions removed
Detecting unreachable propositions: [10.480s CPU, 10.475s wall-clock]
Reordering and filtering variables...
385 of 385 variables necessary.
1 of 3 mutex groups necessary.
30657 of 30657 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [6.890s CPU, 6.889s wall-clock]
Translator variables: 385
Translator derived variables: 0
Translator facts: 773
Translator goal facts: 4
Translator mutex groups: 1
Translator total mutex groups size: 2
Translator operators: 30657
Translator axioms: 0
Translator task size: 367826
Translator peak memory: 232356 KB
Writing output... [6.020s CPU, 6.420s wall-clock]
Done! [70.850s CPU, 71.224s wall-clock]
planner.py version 0.0.1
Time: 17.20s
Memory: 1148MB
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 : 20.587s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 17.284s
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 : 1009302
Atoms : 1009302
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 : 1284MB
Max. Length : 0 steps
Models : 0
[endof: stats after solve call]
Solving Time: 0.09s
Memory: 1220MB (+72MB)
UNSAT
Iteration Time: 0.09s
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: 1220MB
Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])]
Grounding Time: 2.98s
Memory: 1220MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0
Calls : 2
Time : 29.430s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 26.132s
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 : 1009302
Atoms : 1009302
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 66390 (Eliminated: 0 Frozen: 66390)
Constraints : 7069 (Binary: 94.1% Ternary: 3.3% Other: 2.6%)
Memory Peak : 1284MB
Max. Length : 0 steps
Models : 0
[endof: stats after solve call]
Solving Time: 4.69s
Memory: 1225MB (+5MB)
UNSAT
Iteration Time: 8.85s
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: 1230.0MB
Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])]
Grounding Time: 2.73s
Memory: 1225MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0
Calls : 3
Time : 42.478s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 39.192s
Choices : 0
Conflicts : 0 (Analyzed: 0)
Restarts : 0
Problems : 3 (Average Length: 7.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 : 1009302
Atoms : 1009302
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 133561 (Eliminated: 0 Frozen: 133561)
Constraints : 155609 (Binary: 98.1% Ternary: 0.9% Other: 0.9%)
Memory Peak : 1284MB
Max. Length : 5 steps
Models : 0
[endof: stats after solve call]
Solving Time: 9.02s
Memory: 1243MB (+18MB)
UNSAT
Iteration Time: 13.06s
Iteration 4
Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 10
Expected Memory: 1261.0MB
Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])]
Grounding Time: 3.59s
Memory: 1243MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0
Calls : 4
Time : 58.385s (Solving: 0.01s 1st Model: 0.00s Unsat: 0.01s)
CPU Time : 55.108s
Choices : 200 (Domain: 165)
Conflicts : 31 (Analyzed: 30)
Restarts : 0
Problems : 4 (Average Length: 9.50 Splits: 0)
Lemmas : 30 (Deleted: 0)
Binary : 15 (Ratio: 50.00%)
Ternary : 3 (Ratio: 10.00%)
Conflict : 30 (Average Length: 13.3 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 30 (Average: 6.73 Max: 39 Sum: 202)
Executed : 28 (Average: 6.67 Max: 39 Sum: 200 Ratio: 99.01%)
Bounded : 2 (Average: 1.00 Max: 1 Sum: 2 Ratio: 0.99%)
Rules : 1009302
Atoms : 1009302
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 205269 (Eliminated: 0 Frozen: 205269)
Constraints : 831622 (Binary: 99.0% Ternary: 0.5% Other: 0.5%)
Memory Peak : 1284MB
Max. Length : 10 steps
Models : 0
[endof: stats after solve call]
Solving Time: 10.88s
Memory: 1261MB (+18MB)
UNSAT
Iteration Time: 15.92s
Iteration 5
Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 15
Expected Memory: 1279.0MB
Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])]
Grounding Time: 2.83s
Memory: 1261MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 1+
Calls : 5
Time : 78.265s (Solving: 0.29s 1st Model: 0.25s Unsat: 0.01s)
CPU Time : 74.996s
Choices : 26363 (Domain: 5407)
Conflicts : 786 (Analyzed: 785)
Restarts : 5 (Average: 157.00 Last: 155)
Model-Level : 2256.0
Problems : 5 (Average Length: 12.00 Splits: 0)
Lemmas : 785 (Deleted: 0)
Binary : 32 (Ratio: 4.08%)
Ternary : 18 (Ratio: 2.29%)
Conflict : 785 (Average Length: 74.4 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 785 (Average: 23.86 Max: 1155 Sum: 18729)
Executed : 782 (Average: 23.83 Max: 1155 Sum: 18705 Ratio: 99.87%)
Bounded : 3 (Average: 8.00 Max: 22 Sum: 24 Ratio: 0.13%)
Rules : 1009302
Atoms : 1009302
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 286075 (Eliminated: 0 Frozen: 286075)
Constraints : 2125881 (Binary: 99.3% Ternary: 0.3% Other: 0.3%)
Memory Peak : 1284MB
Max. Length : 15 steps
Models : 1
[endof: stats after solve call]
Solving Time: 15.60s
Memory: 1282MB (+21MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time: 21.35s
Memory: 1942MB (+660MB)
Solving...
[start: stats after solve call]
Models : 0
Calls : 6
Time : 95.811s (Solving: 10.14s 1st Model: 0.25s Unsat: 9.86s)
CPU Time : 92.548s
Choices : 39125 (Domain: 10504)
Conflicts : 2912 (Analyzed: 2910)
Restarts : 18 (Average: 161.67 Last: 155)
Model-Level : 2256.0
Problems : 6 (Average Length: 13.67 Splits: 0)
Lemmas : 2910 (Deleted: 0)
Binary : 129 (Ratio: 4.43%)
Ternary : 78 (Ratio: 2.68%)
Conflict : 2910 (Average Length: 1027.6 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 2910 (Average: 10.89 Max: 1155 Sum: 31681)
Executed : 2883 (Average: 10.70 Max: 1155 Sum: 31131 Ratio: 98.26%)
Bounded : 27 (Average: 20.37 Max: 22 Sum: 550 Ratio: 1.74%)
Rules : 1670359 (Original: 1669574)
Atoms : 1067291
Bodies : 383203 (Original: 382503)
Count : 3675 (Original: 3778)
Equivalences : 124277 (Atom=Atom: 113 Body=Body: 0 Other: 124164)
Tight : Yes
Variables : 294421 (Eliminated: 721 Frozen: 293620)
Constraints : 2743767 (Binary: 99.2% Ternary: 0.3% Other: 0.5%)
Memory Peak : 2000MB
Max. Length : 15 steps
Models : 1
[endof: stats after solve call]
Solving Time: 11.59s
Memory: 1942MB (+0MB)
UNSAT
Iteration Time: 52.84s
Iteration 6
Queue: [(5,25,0,True), (6,30,0,True)]
Grounded Until: 20
Expected Memory: 1963.0MB
Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])]
Grounding Time: 5.64s
Memory: 1942MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 7
Time : 387.347s (Solving: 271.96s 1st Model: 0.25s Unsat: 9.86s)
CPU Time : 384.208s
Choices : 113745 (Domain: 55156)
Conflicts : 31120 (Analyzed: 31118)
Restarts : 118 (Average: 263.71 Last: 203)
Model-Level : 2256.0
Problems : 7 (Average Length: 15.57 Splits: 0)
Lemmas : 31118 (Deleted: 20075)
Binary : 212 (Ratio: 0.68%)
Ternary : 111 (Ratio: 0.36%)
Conflict : 31118 (Average Length: 7462.9 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 31118 (Average: 3.31 Max: 7366 Sum: 103020)
Executed : 31082 (Average: 3.29 Max: 7366 Sum: 102227 Ratio: 99.23%)
Bounded : 36 (Average: 22.03 Max: 27 Sum: 793 Ratio: 0.77%)
Rules : 1670359 (Original: 1669574)
Atoms : 1067291
Bodies : 383203 (Original: 382503)
Count : 3675 (Original: 3778)
Equivalences : 124277 (Atom=Atom: 113 Body=Body: 0 Other: 124164)
Tight : Yes
Variables : 379892 (Eliminated: 721 Frozen: 379171)
Constraints : 4383837 (Binary: 99.3% Ternary: 0.3% Other: 0.5%)
Memory Peak : 2356MB
Max. Length : 20 steps
Models : 1
[endof: stats after solve call]
Solving Time: 284.52s
Memory: 2356MB (+414MB)
UNKNOWN
Iteration Time: 291.67s
Iteration 7
Queue: [(6,30,0,True)]
Grounded Until: 25
Expected Memory: 2770.0MB
Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])]
Grounding Time: 5.74s
Memory: 2356MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 8
Time : 630.261s (Solving: 484.99s 1st Model: 0.25s Unsat: 9.86s)
CPU Time : 627.228s
Choices : 194696 (Domain: 122410)
Conflicts : 59280 (Analyzed: 59278)
Restarts : 218 (Average: 271.92 Last: 203)
Model-Level : 2256.0
Problems : 8 (Average Length: 17.62 Splits: 0)
Lemmas : 59278 (Deleted: 47681)
Binary : 246 (Ratio: 0.41%)
Ternary : 119 (Ratio: 0.20%)
Conflict : 59278 (Average Length: 6074.8 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 59278 (Average: 3.03 Max: 7366 Sum: 179881)
Executed : 59226 (Average: 3.01 Max: 7366 Sum: 178576 Ratio: 99.27%)
Bounded : 52 (Average: 25.10 Max: 32 Sum: 1305 Ratio: 0.73%)
Rules : 1670359 (Original: 1669574)
Atoms : 1067291
Bodies : 383203 (Original: 382503)
Count : 3675 (Original: 3778)
Equivalences : 124277 (Atom=Atom: 113 Body=Body: 0 Other: 124164)
Tight : Yes
Variables : 465363 (Eliminated: 721 Frozen: 464642)
Constraints : 6073663 (Binary: 99.3% Ternary: 0.2% Other: 0.5%)
Memory Peak : 2501MB
Max. Length : 25 steps
Models : 1
[endof: stats after solve call]
Solving Time: 235.68s
Memory: 2501MB (+145MB)
UNKNOWN
Iteration Time: 243.03s
Iteration 8
Queue: [(5,25,1,True), (6,30,1,True), (7,35,0,True), (8,40,0,True), (9,45,0,True), (10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True), (14,70,0,True), (15,75,0,True), (16,80,0,True), (17,85,0,True), (18,90,0,True)]
Grounded Until: 30
Blocking actions...
Solving...
*** Info : (planner): INTERRUPTED by signal!
UNKNOWN
INTERRUPTED : 1
Models : 0+
Calls : 9
Time : 810.715s (Solving: 665.22s 1st Model: 0.25s Unsat: 9.86s)
CPU Time : 807.740s
Choices : 220176 (Domain: 147792)
Conflicts : 76740 (Analyzed: 76738)
Restarts : 280 (Average: 274.06 Last: 1339)
Model-Level : 2256.0
Problems : 9 (Average Length: 19.22 Splits: 0)
Lemmas : 76738 (Deleted: 63521)
Binary : 257 (Ratio: 0.33%)
Ternary : 123 (Ratio: 0.16%)
Conflict : 76738 (Average Length: 6985.1 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 76738 (Average: 2.65 Max: 7366 Sum: 203531)
Executed : 76686 (Average: 2.64 Max: 7366 Sum: 202226 Ratio: 99.36%)
Bounded : 52 (Average: 25.10 Max: 32 Sum: 1305 Ratio: 0.64%)
Rules : 1670359 (Original: 1669574)
Atoms : 1067291
Bodies : 383203 (Original: 382503)
Count : 3675 (Original: 3778)
Equivalences : 124277 (Atom=Atom: 113 Body=Body: 0 Other: 124164)
Tight : Yes
Variables : 465363 (Eliminated: 721 Frozen: 464642)
Constraints : 6072889 (Binary: 99.3% Ternary: 0.2% Other: 0.5%)
Memory Peak : 2629MB
Max. Length : 30 steps
Models : 1