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-10.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-10.pddl Parsing... Parsing: [0.060s CPU, 0.067s wall-clock] Normalizing task... [0.010s CPU, 0.006s wall-clock] Instantiating... Generating Datalog program... [0.010s CPU, 0.013s wall-clock] Normalizing Datalog program... Normalizing Datalog program: [0.210s CPU, 0.209s wall-clock] Preparing model... [0.070s CPU, 0.067s wall-clock] Generated 400 rules. Computing model... [9.290s CPU, 9.292s wall-clock] 45717 relevant atoms 39821 auxiliary atoms 85538 final queue length 236723 total queue pushes Completing instantiation... [27.460s CPU, 27.443s wall-clock] Instantiating: [37.140s CPU, 37.124s wall-clock] Computing fact groups... Finding invariants... 41 initial candidates Finding invariants: [0.840s CPU, 0.844s 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... 471 uncovered facts Choosing groups: [0.000s CPU, 0.001s wall-clock] Building translation key... [0.020s CPU, 0.019s wall-clock] Computing fact groups: [0.900s CPU, 0.901s 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.006s wall-clock] Translating task... Processing axioms... Simplifying axioms... [0.000s CPU, 0.000s wall-clock] Processing axioms: [1.680s CPU, 1.674s wall-clock] Translating task: [32.250s CPU, 32.226s wall-clock] 124973 effect conditions simplified 0 implied preconditions added Detecting unreachable propositions... 0 operators removed 0 axioms removed 2 propositions removed Detecting unreachable propositions: [14.620s CPU, 14.621s wall-clock] Reordering and filtering variables... 473 of 473 variables necessary. 1 of 3 mutex groups necessary. 45042 of 45042 operators necessary. 0 of 0 axiom rules necessary. Reordering and filtering variables: [10.810s CPU, 10.805s wall-clock] Translator variables: 473 Translator derived variables: 0 Translator facts: 949 Translator goal facts: 4 Translator mutex groups: 1 Translator total mutex groups size: 2 Translator operators: 45042 Translator axioms: 0 Translator task size: 549492 Translator peak memory: 328868 KB Writing output... [9.010s CPU, 9.245s wall-clock] Done! [105.790s CPU, 105.987s wall-clock] planner.py version 0.0.1 Time: 27.14s Memory: 1694MB Iteration 1 Queue: [(0,60,0,True)] Grounded Until: 0 Expected Memory: 1694MB 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]), ('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])] Grounding Time: 55.68s Memory: 4909MB (+3215MB) Unblocking actions... Solving... [start: stats after solve call] Models : 1+ Calls : 1 Time : 119.121s (Solving: 0.80s 1st Model: 0.71s Unsat: 0.00s) CPU Time : 114.292s Choices : 14619 (Domain: 12003) Conflicts : 191 (Analyzed: 191) Restarts : 0 Model-Level : 3387.0 Problems : 1 (Average Length: 62.00 Splits: 0) Lemmas : 191 (Deleted: 0) Binary : 15 (Ratio: 7.85%) Ternary : 10 (Ratio: 5.24%) Conflict : 191 (Average Length: 84.9 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 191 (Average: 59.78 Max: 1325 Sum: 11418) Executed : 189 (Average: 59.13 Max: 1325 Sum: 11294 Ratio: 98.91%) Bounded : 2 (Average: 62.00 Max: 62 Sum: 124 Ratio: 1.09%) Rules : 0 Atoms : 0 Bodies : 0 Tight : Yes Variables : 1431063 (Eliminated: 0 Frozen: 0) Constraints : 18916708 (Binary: 99.6% Ternary: 0.2% Other: 0.2%) Memory Peak : 5733MB Max. Length : 0 steps Models : 1 [endof: stats after solve call] Solving Time: 4.04s Memory: 5669MB (+760MB) SAT Testing... NOT SERIALIZABLE Testing Time: 53.02s Memory: 5739MB (+70MB) Solving... [start: stats after solve call] Models : 0+ Calls : 2 Time : 433.391s (Solving: 282.28s 1st Model: 0.71s Unsat: 0.00s) CPU Time : 428.696s Choices : 232801 (Domain: 211231) Conflicts : 27305 (Analyzed: 27305) Restarts : 100 (Average: 273.05 Last: 197) Model-Level : 3387.0 Problems : 2 (Average Length: 62.00 Splits: 0) Lemmas : 27305 (Deleted: 21621) Binary : 159 (Ratio: 0.58%) Ternary : 70 (Ratio: 0.26%) Conflict : 27305 (Average Length: 4476.5 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 27305 (Average: 8.08 Max: 1464 Sum: 220713) Executed : 27267 (Average: 8.00 Max: 1464 Sum: 218437 Ratio: 98.97%) Bounded : 38 (Average: 59.89 Max: 62 Sum: 2276 Ratio: 1.03%) Rules : 5295962 (Original: 5294900) Atoms : 119623 Bodies : 3043678 (Original: 3042806) Count : 20125 (Original: 20275) Equivalences : 1047014 (Atom=Atom: 334 Body=Body: 0 Other: 1046680) Tight : Yes Variables : 1473056 (Eliminated: 0 Frozen: 1045552) Constraints : 24160368 (Binary: 99.5% Ternary: 0.2% Other: 0.3%) Memory Peak : 6079MB Max. Length : 0 steps Models : 1 [endof: stats after solve call] Solving Time: 285.37s Memory: 6015MB (+276MB) UNKNOWN Iteration Time: 425.56s Iteration 2 Queue: [(0,60,1,True)] Grounded Until: 60 Solving... [start: stats after solve call] Models : 0+ Calls : 3 Time : 716.235s (Solving: 564.57s 1st Model: 0.71s Unsat: 0.00s) CPU Time : 711.656s Choices : 445767 (Domain: 411771) Conflicts : 52612 (Analyzed: 52612) Restarts : 200 (Average: 263.06 Last: 197) Model-Level : 3387.0 Problems : 3 (Average Length: 62.00 Splits: 0) Lemmas : 52612 (Deleted: 48677) Binary : 173 (Ratio: 0.33%) Ternary : 75 (Ratio: 0.14%) Conflict : 52612 (Average Length: 7406.9 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 52612 (Average: 8.09 Max: 1464 Sum: 425393) Executed : 52572 (Average: 8.04 Max: 1464 Sum: 422999 Ratio: 99.44%) Bounded : 40 (Average: 59.85 Max: 62 Sum: 2394 Ratio: 0.56%) Rules : 5295962 (Original: 5294900) Atoms : 119623 Bodies : 3043678 (Original: 3042806) Count : 20125 (Original: 20275) Equivalences : 1047014 (Atom=Atom: 334 Body=Body: 0 Other: 1046680) Tight : Yes Variables : 1473056 (Eliminated: 0 Frozen: 1045552) Constraints : 23855250 (Binary: 99.5% Ternary: 0.2% Other: 0.3%) Memory Peak : 6365MB Max. Length : 60 steps Models : 1 [endof: stats after solve call] Solving Time: 282.98s Memory: 6301MB (+286MB) UNKNOWN Iteration Time: 282.98s Iteration 3 Queue: [(0,60,2,True)] Grounded Until: 60 Solving... *** Info : (planner): INTERRUPTED by signal! UNKNOWN INTERRUPTED : 1 Models : 0+ Calls : 4 Time : 1049.271s (Solving: 897.25s 1st Model: 0.71s Unsat: 0.00s) CPU Time : 1044.816s Choices : 768849 (Domain: 720251) Conflicts : 81018 (Analyzed: 81018) Restarts : 300 (Average: 270.06 Last: 197) Model-Level : 3387.0 Problems : 4 (Average Length: 62.00 Splits: 0) Lemmas : 81018 (Deleted: 76841) Binary : 195 (Ratio: 0.24%) Ternary : 81 (Ratio: 0.10%) Conflict : 81018 (Average Length: 8571.1 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 81018 (Average: 9.14 Max: 1464 Sum: 740375) Executed : 80978 (Average: 9.11 Max: 1464 Sum: 737981 Ratio: 99.68%) Bounded : 40 (Average: 59.85 Max: 62 Sum: 2394 Ratio: 0.32%) Rules : 5295962 (Original: 5294900) Atoms : 119623 Bodies : 3043678 (Original: 3042806) Count : 20125 (Original: 20275) Equivalences : 1047014 (Atom=Atom: 334 Body=Body: 0 Other: 1046680) Tight : Yes Variables : 1473056 (Eliminated: 0 Frozen: 1045552) Constraints : 23855116 (Binary: 99.5% Ternary: 0.2% Other: 0.3%) Memory Peak : 6510MB Max. Length : 60 steps Models : 1