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-29.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-29.pddl
Parsing...
Parsing: [0.130s CPU, 0.128s wall-clock]
Normalizing task... [0.000s CPU, 0.004s wall-clock]
Instantiating...
Generating Datalog program... [0.040s CPU, 0.031s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.060s CPU, 0.064s wall-clock]
Preparing model... [0.180s CPU, 0.178s wall-clock]
Generated 90 rules.
Computing model... [9.650s CPU, 9.649s wall-clock]
12491 relevant atoms
122333 auxiliary atoms
134824 final queue length
149914 total queue pushes
Completing instantiation... [3.360s CPU, 3.360s wall-clock]
Instantiating: [13.440s CPU, 13.435s wall-clock]
Computing fact groups...
Finding invariants...
35 initial candidates
Finding invariants: [0.080s CPU, 0.084s wall-clock]
Checking invariant weight... [0.020s CPU, 0.012s wall-clock]
Instantiating groups... [0.060s CPU, 0.067s wall-clock]
Collecting mutex groups... [0.010s CPU, 0.005s wall-clock]
Choosing groups...
232 uncovered facts
Choosing groups: [0.020s CPU, 0.017s wall-clock]
Building translation key... [0.020s CPU, 0.017s wall-clock]
Computing fact groups: [0.260s CPU, 0.260s wall-clock]
Building STRIPS to SAS dictionary... [0.010s CPU, 0.006s 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.007s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [0.130s CPU, 0.129s wall-clock]
Translating task: [2.670s CPU, 2.674s wall-clock]
5111 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
90 propositions removed
Detecting unreachable propositions: [1.430s CPU, 1.425s wall-clock]
Reordering and filtering variables...
132 of 286 variables necessary.
0 of 65 mutex groups necessary.
7360 of 9668 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [0.340s CPU, 0.341s wall-clock]
Translator variables: 132
Translator derived variables: 0
Translator facts: 892
Translator goal facts: 16
Translator mutex groups: 0
Translator total mutex groups size: 0
Translator operators: 7360
Translator axioms: 0
Translator task size: 31508
Translator peak memory: 83508 KB
Writing output... [0.650s CPU, 0.720s wall-clock]
Done! [19.030s CPU, 19.100s wall-clock]
planner.py version 0.0.1

Time:	 1.30s
Memory: 139MB

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:		 139MB (+0MB)
UNSAT
Iteration Time:	 0.01s

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: 139MB
Grounding...	 [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])]
Grounding Time:	 0.28s
Memory:		 139MB (+0MB)
Unblocking actions...
Solving...
Solving Time:	 0.05s
Memory:		 144MB (+5MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time:	 1.11s
Memory:		 186MB (+42MB)
Solving...
Solving Time:	 0.04s
Memory:		 186MB (+0MB)
UNSAT
Iteration Time:	 1.62s

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: 191.0MB
Grounding...	 [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])]
Grounding Time:	 0.40s
Memory:		 186MB (+0MB)
Unblocking actions...
Solving...
Solving Time:	 0.56s
Memory:		 190MB (+4MB)
SAT
Testing...
SERIALIZABLE?
Testing Time:	 0.00s
Memory:		 190MB (+0MB)
Answer: 2
occurs(action(("sample_soil","rover2","rover2store","waypoint2")),1) occurs(action(("sample_soil","rover9","rover9store","waypoint23")),1) occurs(action(("sample_soil","rover1","rover1store","waypoint9")),1) occurs(action(("navigate","rover5","waypoint18","waypoint36")),1) occurs(action(("navigate","rover3","waypoint8","waypoint14")),1) occurs(action(("navigate","rover0","waypoint7","waypoint15")),1) occurs(action(("calibrate","rover1","camera1","objective5","waypoint9")),1) occurs(action(("calibrate","rover1","camera10","objective5","waypoint9")),1) occurs(action(("calibrate","rover1","camera3","objective3","waypoint9")),1) occurs(action(("calibrate","rover4","camera9","objective0","waypoint28")),1) occurs(action(("calibrate","rover6","camera5","objective4","waypoint13")),1) occurs(action(("calibrate","rover6","camera7","objective4","waypoint13")),1) occurs(action(("navigate","rover7","waypoint19","waypoint23")),1) occurs(action(("navigate","rover8","waypoint20","waypoint26")),1) occurs(action(("sample_rock","rover4","rover4store","waypoint28")),1) occurs(action(("communicate_soil_data","rover1","general","waypoint9","waypoint9","waypoint3")),2) occurs(action(("sample_rock","rover7","rover7store","waypoint23")),2) occurs(action(("sample_rock","rover5","rover5store","waypoint36")),2) occurs(action(("sample_soil","rover3","rover3store","waypoint14")),2) occurs(action(("sample_soil","rover8","rover8store","waypoint26")),2) occurs(action(("navigate","rover2","waypoint2","waypoint33")),2) occurs(action(("take_image","rover4","waypoint28","objective3","camera9","colour")),2) occurs(action(("take_image","rover1","waypoint9","objective7","camera1","colour")),2) occurs(action(("take_image","rover6","waypoint13","objective5","camera5","low_res")),2) occurs(action(("take_image","rover1","waypoint9","objective1","camera3","high_res")),2) occurs(action(("take_image","rover1","waypoint9","objective3","camera10","high_res")),2) occurs(action(("take_image","rover6","waypoint13","objective5","camera7","high_res")),2) occurs(action(("navigate","rover9","waypoint23","waypoint31")),2) occurs(action(("navigate","rover0","waypoint15","waypoint20")),2) occurs(action(("drop","rover1","rover1store")),2) occurs(action(("communicate_soil_data","rover2","general","waypoint2","waypoint33","waypoint3")),3) occurs(action(("communicate_soil_data","rover9","general","waypoint23","waypoint31","waypoint3")),3) occurs(action(("communicate_image_data","rover4","general","objective3","colour","waypoint28","waypoint3")),3) occurs(action(("communicate_image_data","rover1","general","objective7","colour","waypoint9","waypoint3")),3) occurs(action(("communicate_image_data","rover1","general","objective1","high_res","waypoint9","waypoint3")),3) occurs(action(("communicate_image_data","rover1","general","objective3","high_res","waypoint9","waypoint3")),3) occurs(action(("navigate","rover0","waypoint20","waypoint28")),3) occurs(action(("navigate","rover6","waypoint13","waypoint22")),3) occurs(action(("navigate","rover7","waypoint23","waypoint28")),3) occurs(action(("navigate","rover8","waypoint26","waypoint20")),3) occurs(action(("navigate","rover3","waypoint14","waypoint8")),3) occurs(action(("drop","rover5","rover5store")),3) occurs(action(("navigate","rover5","waypoint36","waypoint18")),3) occurs(action(("drop","rover7","rover7store")),3) occurs(action(("communicate_rock_data","rover7","general","waypoint23","waypoint28","waypoint3")),4) occurs(action(("communicate_soil_data","rover9","general","waypoint23","waypoint31","waypoint3")),4) occurs(action(("communicate_image_data","rover6","general","objective5","low_res","waypoint22","waypoint3")),4) occurs(action(("communicate_image_data","rover6","general","objective5","high_res","waypoint22","waypoint3")),4) occurs(action(("sample_soil","rover0","rover0store","waypoint28")),4) occurs(action(("navigate","rover5","waypoint18","waypoint43")),4) occurs(action(("navigate","rover3","waypoint8","waypoint22")),4) occurs(action(("navigate","rover2","waypoint33","waypoint1")),4) occurs(action(("navigate","rover1","waypoint9","waypoint30")),4) occurs(action(("navigate","rover8","waypoint20","waypoint4")),4) occurs(action(("communicate_rock_data","rover5","general","waypoint36","waypoint43","waypoint3")),5) occurs(action(("communicate_soil_data","rover3","general","waypoint14","waypoint22","waypoint3")),5) occurs(action(("communicate_soil_data","rover9","general","waypoint23","waypoint31","waypoint3")),5) occurs(action(("communicate_soil_data","rover0","general","waypoint28","waypoint28","waypoint3")),5) occurs(action(("navigate","rover8","waypoint4","waypoint9")),5) occurs(action(("navigate","rover1","waypoint30","waypoint11")),5) occurs(action(("navigate","rover7","waypoint28","waypoint23")),5) occurs(action(("navigate","rover6","waypoint22","waypoint13")),5) occurs(action(("communicate_soil_data","rover8","general","waypoint26","waypoint9","waypoint3")),6) occurs(action(("sample_rock","rover1","rover1store","waypoint11")),6) occurs(action(("navigate","rover6","waypoint13","waypoint4")),6) occurs(action(("drop","rover8","rover8store")),6) occurs(action(("navigate","rover5","waypoint43","waypoint18")),6) occurs(action(("drop","rover3","rover3store")),6) occurs(action(("drop","rover2","rover2store")),6) occurs(action(("drop","rover0","rover0store")),6) occurs(action(("drop","rover9","rover9store")),6) occurs(action(("sample_rock","rover5","rover5store","waypoint18")),7) occurs(action(("navigate","rover1","waypoint11","waypoint30")),7) occurs(action(("navigate","rover6","waypoint4","waypoint19")),7) occurs(action(("navigate","rover5","waypoint18","waypoint43")),8) occurs(action(("navigate","rover4","waypoint28","waypoint0")),8) occurs(action(("navigate","rover6","waypoint19","waypoint0")),8) occurs(action(("navigate","rover1","waypoint30","waypoint9")),8) occurs(action(("drop","rover5","rover5store")),8) occurs(action(("drop","rover4","rover4store")),8) occurs(action(("communicate_rock_data","rover1","general","waypoint11","waypoint9","waypoint3")),9) occurs(action(("communicate_rock_data","rover5","general","waypoint18","waypoint43","waypoint3")),9) occurs(action(("communicate_rock_data","rover5","general","waypoint36","waypoint43","waypoint3")),9) occurs(action(("navigate","rover6","waypoint0","waypoint19")),9) occurs(action(("navigate","rover7","waypoint23","waypoint10")),9) occurs(action(("drop","rover1","rover1store")),9) occurs(action(("calibrate","rover1","camera1","objective5","waypoint9")),10) occurs(action(("calibrate","rover8","camera8","objective4","waypoint9")),10) occurs(action(("calibrate","rover1","camera10","objective5","waypoint9")),10) occurs(action(("calibrate","rover1","camera3","objective3","waypoint9")),10) occurs(action(("calibrate","rover4","camera0","objective5","waypoint0")),10) occurs(action(("calibrate","rover4","camera9","objective0","waypoint0")),10) occurs(action(("calibrate","rover7","camera4","objective1","waypoint10")),10) occurs(action(("calibrate","rover8","camera11","objective3","waypoint9")),10) occurs(action(("calibrate","rover8","camera2","objective1","waypoint9")),10) occurs(action(("calibrate","rover9","camera14","objective3","waypoint31")),10)
SATISFIABLE

Models       : 1+
Calls        : 4
Time         : 3.111s (Solving: 0.60s 1st Model: 0.57s Unsat: 0.02s)
CPU Time     : 3.052s

Choices      : 43013    (Domain: 38125)
Conflicts    : 2007     (Analyzed: 2006)
Restarts     : 27       (Average: 74.30 Last: 70)
Model-Level  : 310.0   
Problems     : 4        (Average Length: 7.00 Splits: 0)
Lemmas       : 2006     (Deleted: 0)
  Binary     : 205      (Ratio:  10.22%)
  Ternary    : 49       (Ratio:   2.44%)
  Conflict   : 2006     (Average Length:   27.3 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 2006     (Average: 22.49 Max: 209 Sum:  45118)
  Executed   : 1740     (Average: 21.12 Max: 209 Sum:  42371 Ratio:  93.91%)
  Bounded    : 266      (Average: 10.33 Max:  12 Sum:   2747 Ratio:   6.09%)

Rules        : 124292   (Original: 123700)
Atoms        : 104378  
Bodies       : 19977    (Original: 19384)
  Count      : 175      (Original: 274)
Equivalences : 8946     (Atom=Atom: 42 Body=Body: 0 Other: 8904)
Tight        : Yes
Variables    : 51985    (Eliminated:    0 Frozen: 32393)
Constraints  : 285453   (Binary:  95.8% Ternary:   2.9% Other:   1.3%)

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