INFO     Running translator.
INFO     translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/rovers-propositional/domain.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/rovers-propositional/instances/instance-22.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-2006/domains/rovers-propositional/domain.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/rovers-propositional/instances/instance-22.pddl
Parsing...
Parsing: [0.100s CPU, 0.104s wall-clock]
Normalizing task... [0.000s CPU, 0.003s wall-clock]
Instantiating...
Generating Datalog program... [0.030s CPU, 0.023s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.040s CPU, 0.041s wall-clock]
Preparing model... [0.100s CPU, 0.101s wall-clock]
Generated 90 rules.
Computing model... [5.100s CPU, 5.103s wall-clock]
7899 relevant atoms
64249 auxiliary atoms
72148 final queue length
82078 total queue pushes
Completing instantiation... [1.920s CPU, 1.918s wall-clock]
Instantiating: [7.270s CPU, 7.267s wall-clock]
Computing fact groups...
Finding invariants...
35 initial candidates
Finding invariants: [0.070s CPU, 0.066s wall-clock]
Checking invariant weight... [0.010s CPU, 0.008s wall-clock]
Instantiating groups... [0.040s CPU, 0.039s wall-clock]
Collecting mutex groups... [0.000s CPU, 0.003s wall-clock]
Choosing groups...
218 uncovered facts
Choosing groups: [0.010s CPU, 0.010s wall-clock]
Building translation key... [0.010s CPU, 0.013s wall-clock]
Computing fact groups: [0.180s CPU, 0.175s wall-clock]
Building STRIPS to SAS dictionary... [0.000s CPU, 0.004s wall-clock]
Building dictionary for full mutex groups... [0.010s CPU, 0.004s wall-clock]
Building mutex information...
Building mutex information: [0.000s CPU, 0.005s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [0.090s CPU, 0.083s wall-clock]
Translating task: [1.670s CPU, 1.668s wall-clock]
2947 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
59 propositions removed
Detecting unreachable propositions: [0.900s CPU, 0.896s wall-clock]
Reordering and filtering variables...
90 of 256 variables necessary.
0 of 45 mutex groups necessary.
4077 of 5964 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [0.200s CPU, 0.206s wall-clock]
Translator variables: 90
Translator derived variables: 0
Translator facts: 514
Translator goal facts: 16
Translator mutex groups: 0
Translator total mutex groups size: 0
Translator operators: 4077
Translator axioms: 0
Translator task size: 17117
Translator peak memory: 62816 KB
Writing output... [0.350s CPU, 0.392s wall-clock]
Done! [10.740s CPU, 10.780s wall-clock]
planner.py version 0.0.1

Time:	 0.72s
Memory: 97MB

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...
Solving Time:	 0.00s
Memory:		 98MB (+1MB)
UNSAT
Iteration Time:	 0.00s

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: 98MB
Grounding...	 [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])]
Grounding Time:	 0.12s
Memory:		 98MB (+0MB)
Unblocking actions...
Solving...
Solving Time:	 0.04s
Memory:		 99MB (+1MB)
UNSAT
Iteration Time:	 0.22s

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: 100.0MB
Grounding...	 [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])]
Grounding Time:	 0.11s
Memory:		 99MB (+0MB)
Unblocking actions...
Solving...
Solving Time:	 0.03s
Memory:		 99MB (+0MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time:	 0.67s
Memory:		 132MB (+33MB)
Solving...
Solving Time:	 0.32s
Memory:		 132MB (+0MB)
SAT
Testing...
SERIALIZABLE?
Testing Time:	 0.00s
Memory:		 132MB (+0MB)
Answer: 2
occurs(action(("navigate","rover2","waypoint3","waypoint7")),1) occurs(action(("navigate","rover4","waypoint0","waypoint14")),1) occurs(action(("navigate","rover0","waypoint4","waypoint13")),1) occurs(action(("navigate","rover3","waypoint4","waypoint5")),1) occurs(action(("navigate","rover1","waypoint16","waypoint13")),1) occurs(action(("navigate","rover5","waypoint10","waypoint0")),1) occurs(action(("sample_rock","rover2","rover2store","waypoint7")),2) occurs(action(("navigate","rover0","waypoint13","waypoint17")),2) occurs(action(("navigate","rover1","waypoint13","waypoint25")),2) occurs(action(("calibrate","rover2","camera6","objective5","waypoint7")),2) occurs(action(("navigate","rover3","waypoint5","waypoint3")),2) occurs(action(("calibrate","rover2","camera7","objective9","waypoint7")),2) occurs(action(("navigate","rover4","waypoint14","waypoint1")),2) occurs(action(("navigate","rover5","waypoint0","waypoint6")),2) occurs(action(("communicate_rock_data","rover2","general","waypoint7","waypoint7","waypoint2")),3) occurs(action(("sample_rock","rover1","rover1store","waypoint25")),3) occurs(action(("sample_soil","rover4","rover4store","waypoint1")),3) occurs(action(("sample_soil","rover0","rover0store","waypoint17")),3) occurs(action(("sample_soil","rover3","rover3store","waypoint3")),3) occurs(action(("take_image","rover2","waypoint7","objective6","camera6","low_res")),3) occurs(action(("take_image","rover2","waypoint7","objective9","camera7","high_res")),3) occurs(action(("calibrate","rover3","camera1","objective2","waypoint3")),3) occurs(action(("calibrate","rover4","camera2","objective3","waypoint1")),3) occurs(action(("navigate","rover5","waypoint6","waypoint21")),3) occurs(action(("drop","rover2","rover2store")),3) occurs(action(("communicate_rock_data","rover1","general","waypoint25","waypoint25","waypoint2")),4) occurs(action(("communicate_soil_data","rover0","general","waypoint17","waypoint17","waypoint2")),4) occurs(action(("communicate_image_data","rover2","general","objective6","low_res","waypoint7","waypoint2")),4) occurs(action(("communicate_image_data","rover2","general","objective9","high_res","waypoint7","waypoint2")),4) occurs(action(("sample_rock","rover5","rover5store","waypoint21")),4) occurs(action(("navigate","rover3","waypoint3","waypoint7")),4) occurs(action(("navigate","rover4","waypoint1","waypoint14")),4) occurs(action(("calibrate","rover5","camera4","objective1","waypoint21")),4) occurs(action(("drop","rover4","rover4store")),4) occurs(action(("drop","rover3","rover3store")),4) occurs(action(("drop","rover1","rover1store")),4) occurs(action(("drop","rover0","rover0store")),4) occurs(action(("communicate_soil_data","rover4","general","waypoint1","waypoint14","waypoint2")),5) occurs(action(("communicate_soil_data","rover3","general","waypoint3","waypoint7","waypoint2")),5) occurs(action(("take_image","rover3","waypoint7","objective1","camera1","low_res")),5) occurs(action(("take_image","rover4","waypoint14","objective3","camera2","high_res")),5) occurs(action(("navigate","rover0","waypoint17","waypoint13")),5) occurs(action(("navigate","rover1","waypoint25","waypoint13")),5) occurs(action(("navigate","rover5","waypoint21","waypoint6")),5) occurs(action(("navigate","rover2","waypoint7","waypoint3")),5) occurs(action(("communicate_image_data","rover3","general","objective1","low_res","waypoint7","waypoint2")),6) occurs(action(("navigate","rover2","waypoint3","waypoint14")),6) occurs(action(("navigate","rover5","waypoint6","waypoint18")),6) occurs(action(("navigate","rover0","waypoint13","waypoint31")),6) occurs(action(("navigate","rover4","waypoint14","waypoint38")),6) occurs(action(("navigate","rover1","waypoint13","waypoint16")),6) occurs(action(("communicate_rock_data","rover5","general","waypoint21","waypoint18","waypoint2")),7) occurs(action(("sample_rock","rover0","rover0store","waypoint31")),7) occurs(action(("sample_soil","rover4","rover4store","waypoint38")),7) occurs(action(("take_image","rover5","waypoint18","objective8","camera4","high_res")),7) occurs(action(("navigate","rover1","waypoint16","waypoint18")),7) occurs(action(("navigate","rover2","waypoint14","waypoint24")),7) occurs(action(("communicate_image_data","rover5","general","objective8","high_res","waypoint18","waypoint2")),8) occurs(action(("sample_rock","rover2","rover2store","waypoint24")),8) occurs(action(("sample_soil","rover1","rover1store","waypoint18")),8) occurs(action(("navigate","rover4","waypoint38","waypoint14")),8) occurs(action(("navigate","rover0","waypoint31","waypoint13")),8) occurs(action(("drop","rover4","rover4store")),8) occurs(action(("communicate_soil_data","rover1","general","waypoint18","waypoint18","waypoint2")),9) occurs(action(("communicate_soil_data","rover3","general","waypoint3","waypoint7","waypoint2")),9) occurs(action(("communicate_soil_data","rover4","general","waypoint38","waypoint14","waypoint2")),9) occurs(action(("communicate_image_data","rover4","general","objective3","high_res","waypoint14","waypoint2")),9) occurs(action(("sample_rock","rover4","rover4store","waypoint14")),9) occurs(action(("navigate","rover0","waypoint13","waypoint34")),9) occurs(action(("navigate","rover2","waypoint24","waypoint14")),9) occurs(action(("navigate","rover5","waypoint18","waypoint6")),9) occurs(action(("communicate_rock_data","rover4","general","waypoint14","waypoint14","waypoint2")),10) occurs(action(("communicate_rock_data","rover2","general","waypoint24","waypoint14","waypoint2")),10) occurs(action(("communicate_rock_data","rover0","general","waypoint31","waypoint34","waypoint2")),10) occurs(action(("calibrate","rover2","camera6","objective5","waypoint14")),10) occurs(action(("calibrate","rover3","camera1","objective2","waypoint7")),10) occurs(action(("calibrate","rover1","camera3","objective8","waypoint18")),10) occurs(action(("calibrate","rover2","camera7","objective9","waypoint14")),10) occurs(action(("calibrate","rover4","camera2","objective3","waypoint14")),10) occurs(action(("calibrate","rover5","camera4","objective1","waypoint6")),10)
SATISFIABLE

Models       : 1+
Calls        : 4
Time         : 1.587s (Solving: 0.37s 1st Model: 0.32s Unsat: 0.04s)
CPU Time     : 1.560s

Choices      : 28706    (Domain: 27092)
Conflicts    : 2009     (Analyzed: 2008)
Restarts     : 21       (Average: 95.62 Last: 67)
Model-Level  : 225.5   
Problems     : 4        (Average Length: 8.25 Splits: 0)
Lemmas       : 2008     (Deleted: 0)
  Binary     : 160      (Ratio:   7.97%)
  Ternary    : 64       (Ratio:   3.19%)
  Conflict   : 2008     (Average Length:   30.4 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 2008     (Average: 14.58 Max: 145 Sum:  29283)
  Executed   : 1890     (Average: 13.98 Max: 145 Sum:  28079 Ratio:  95.89%)
  Bounded    : 118      (Average: 10.20 Max:  12 Sum:   1204 Ratio:   4.11%)

Rules        : 82948    (Original: 81316)
Atoms        : 56557   
Bodies       : 26321    (Original: 24688)
  Count      : 166      (Original: 427)
Equivalences : 9565     (Atom=Atom: 27 Body=Body: 0 Other: 9538)
Tight        : Yes
Variables    : 26899    (Eliminated:    0 Frozen: 13004)
Constraints  : 134614   (Binary:  94.3% Ternary:   4.1% Other:   1.5%)

Memory Peak  : 132MB
Max. Length  : 10 steps
Sol. Length  : 10 steps
Models       : 2