INFO     Running translator.
INFO     translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-1998/domains/mystery-round-1-strips/domain.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-1998/domains/mystery-round-1-strips/instances/instance-20.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-1998/domains/mystery-round-1-strips/domain.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-1998/domains/mystery-round-1-strips/instances/instance-20.pddl
Parsing...
Parsing: [0.020s CPU, 0.026s wall-clock]
Normalizing task... [0.000s CPU, 0.001s wall-clock]
Instantiating...
Generating Datalog program... [0.010s CPU, 0.007s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.030s CPU, 0.031s wall-clock]
Preparing model... [0.020s CPU, 0.022s wall-clock]
Generated 42 rules.
Computing model... [0.950s CPU, 0.940s wall-clock]
7768 relevant atoms
4174 auxiliary atoms
11942 final queue length
25710 total queue pushes
Completing instantiation... [2.840s CPU, 2.847s wall-clock]
Instantiating: [3.860s CPU, 3.859s wall-clock]
Computing fact groups...
Finding invariants...
12 initial candidates
Finding invariants: [0.060s CPU, 0.063s wall-clock]
Checking invariant weight... [0.010s CPU, 0.003s wall-clock]
Instantiating groups... [0.030s CPU, 0.037s wall-clock]
Collecting mutex groups... [0.010s CPU, 0.003s wall-clock]
Choosing groups...
2 uncovered facts
Choosing groups: [0.010s CPU, 0.009s wall-clock]
Building translation key... [0.010s CPU, 0.006s wall-clock]
Computing fact groups: [0.150s CPU, 0.144s wall-clock]
Building STRIPS to SAS dictionary... [0.000s CPU, 0.002s wall-clock]
Building dictionary for full mutex groups... [0.000s CPU, 0.005s 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: [0.120s CPU, 0.111s wall-clock]
Translating task: [2.110s CPU, 2.102s wall-clock]
0 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
46 propositions removed
Detecting unreachable propositions: [1.120s CPU, 1.125s wall-clock]
Reordering and filtering variables...
42 of 42 variables necessary.
0 of 42 mutex groups necessary.
7094 of 7094 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [0.320s CPU, 0.322s wall-clock]
Translator variables: 42
Translator derived variables: 0
Translator facts: 462
Translator goal facts: 1
Translator mutex groups: 0
Translator total mutex groups size: 0
Translator operators: 7094
Translator axioms: 0
Translator task size: 40295
Translator peak memory: 63180 KB
Writing output... [0.710s CPU, 0.813s wall-clock]
Done! [8.380s CPU, 8.497s wall-clock]
planner.py version 0.0.1

Time:	 1.71s
Memory: 164MB

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.01s
Memory:		 165MB (+1MB)
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
Grounding...	 [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])]
Grounding Time:	 0.51s
Memory:		 165MB (+0MB)
Unblocking actions...
Solving...
Solving Time:	 0.06s
Memory:		 167MB (+2MB)
UNSAT
Iteration Time:	 0.88s

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
Grounding...	 [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])]
Grounding Time:	 0.59s
Memory:		 178MB (+11MB)
Unblocking actions...
Solving...
Solving Time:	 0.05s
Memory:		 201MB (+23MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time:	 48.76s
Memory:		 2397MB (+2196MB)
Solving...
Solving Time:	 0.51s
Memory:		 2409MB (+12MB)
SAT
Testing...
SERIALIZABLE?
Testing Time:	 0.00s
Memory:		 2409MB (+0MB)
Answer: 2
occurs(action(("feast","achievement","cherry","turkey","bosnia","goias")),1) occurs(action(("feast","aesthetics","muffin","yogurt","goias","arizona")),1) occurs(action(("feast","curiosity","cod","pork","bosnia","goias")),1) occurs(action(("feast","empathy","pork","cod","guanabara","quebec")),1) occurs(action(("feast","expectation","orange","scallion","guanabara","quebec")),1) occurs(action(("feast","intoxication","wonderbread","yogurt","moravia","bosnia")),1) occurs(action(("feast","love","mutton","pork","guanabara","quebec")),1) occurs(action(("feast","satisfaction","sweetroll","pork","bosnia","goias")),1) occurs(action(("feast","triumph","yogurt","tuna","goias","arizona")),1) occurs(action(("feast","understanding","marzipan","cherry","kentucky","moravia")),1) occurs(action(("overcome","grief","achievement","turkey","neptune","venus")),2) occurs(action(("overcome","dread","aesthetics","yogurt","saturn","neptune")),2) occurs(action(("overcome","laceration","understanding","cherry","saturn","neptune")),2) occurs(action(("feast","understanding","cherry","pepper","moravia","bosnia")),2) occurs(action(("feast","achievement","turkey","guava","quebec","alsace")),2) occurs(action(("feast","expectation","scallion","potato","oregon","surrey")),2) occurs(action(("feast","satisfaction","pork","mutton","manitoba","guanabara")),2) occurs(action(("feast","triumph","tuna","turkey","goias","arizona")),2) occurs(action(("feast","empathy","cod","pork","moravia","bosnia")),2) occurs(action(("succumb","grief","achievement","guava","neptune","venus")),3) occurs(action(("feast","achievement","guava","turkey","bosnia","goias")),3) occurs(action(("feast","expectation","potato","rice","oregon","surrey")),3) occurs(action(("feast","satisfaction","mutton","wonderbread","manitoba","guanabara")),3) occurs(action(("feast","understanding","pepper","guava","surrey","bavaria")),3) occurs(action(("overcome","abrasion","satisfaction","wonderbread","neptune","venus")),4) occurs(action(("feast","understanding","guava","pepper","moravia","bosnia")),4) occurs(action(("succumb","laceration","understanding","guava","saturn","neptune")),4) occurs(action(("feast","satisfaction","wonderbread","yogurt","kentucky","moravia")),4) occurs(action(("feast","satisfaction","yogurt","tuna","bosnia","goias")),5) occurs(action(("feast","understanding","pepper","cherry","oregon","surrey")),5) occurs(action(("succumb","dread","aesthetics","yogurt","saturn","neptune")),6) occurs(action(("feast","satisfaction","tuna","turkey","bosnia","goias")),6) occurs(action(("feast","understanding","cherry","marzipan","kentucky","moravia")),6) occurs(action(("feast","satisfaction","turkey","guava","guanabara","quebec")),7) occurs(action(("feast","satisfaction","guava","pepper","kentucky","moravia")),8) occurs(action(("feast","achievement","turkey","guava","manitoba","guanabara")),8) occurs(action(("feast","understanding","marzipan","cod","alsace","kentucky")),8) occurs(action(("succumb","abrasion","satisfaction","pepper","neptune","venus")),9) occurs(action(("overcome","laceration","achievement","guava","neptune","venus")),9) occurs(action(("overcome","dread","intoxication","yogurt","neptune","venus")),9) occurs(action(("feast","intoxication","yogurt","muffin","moravia","bosnia")),9) occurs(action(("feast","satisfaction","pepper","guava","arizona","oregon")),9) occurs(action(("feast","understanding","cod","marzipan","kentucky","moravia")),9) occurs(action(("overcome","grief","satisfaction","guava","neptune","venus")),10) occurs(action(("succumb","dread","intoxication","muffin","neptune","venus")),10) occurs(action(("succumb","laceration","achievement","guava","neptune","venus")),10) occurs(action(("feast","understanding","marzipan","cod","quebec","alsace")),10)
SATISFIABLE

Models       : 1+
Calls        : 4
Time         : 51.529s (Solving: 0.09s 1st Model: 0.07s Unsat: 0.01s)
CPU Time     : 51.480s

Choices      : 4390     (Domain: 3220)
Conflicts    : 686      (Analyzed: 685)
Restarts     : 4        (Average: 171.25 Last: 87)
Model-Level  : 285.0   
Problems     : 4        (Average Length: 8.25 Splits: 0)
Lemmas       : 1897     (Deleted: 0)
  Binary     : 1260     (Ratio:  66.42%)
  Ternary    : 17       (Ratio:   0.90%)
  Conflict   : 685      (Average Length:  134.3 Ratio:  36.11%) 
  Loop       : 1212     (Average Length:    2.0 Ratio:  63.89%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 685      (Average:  4.88 Max: 243 Sum:   3345)
  Executed   : 682      (Average:  4.85 Max: 243 Sum:   3324 Ratio:  99.37%)
  Bounded    : 3        (Average:  7.00 Max:   7 Sum:     21 Ratio:   0.63%)

Rules        : 25053892
  Acyc       : 1480620 
Atoms        : 23573272
Bodies       : 11       (Original: 10)
Equivalences : 30       (Atom=Atom: 10 Body=Body: 0 Other: 20)
Tight        : Yes
Variables    : 71904    (Eliminated:    0 Frozen: 45657)
Constraints  : 371439   (Binary:  98.2% Ternary:   0.8% Other:   1.0%)

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