INFO Running translator. INFO translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-2000/domains/blocks-strips-typed/domain.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2000/domains/blocks-strips-typed/instances/instance-51.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-2000/domains/blocks-strips-typed/domain.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2000/domains/blocks-strips-typed/instances/instance-51.pddl Parsing... Parsing: [0.020s CPU, 0.271s wall-clock] Normalizing task... [0.000s CPU, 0.002s wall-clock] Instantiating... Generating Datalog program... [0.010s CPU, 0.007s wall-clock] Normalizing Datalog program... Normalizing Datalog program: [0.010s CPU, 0.016s wall-clock] Preparing model... [0.020s CPU, 0.014s wall-clock] Generated 21 rules. Computing model... [0.280s CPU, 0.282s wall-clock] 2077 relevant atoms 1375 auxiliary atoms 3452 final queue length 6006 total queue pushes Completing instantiation... [0.420s CPU, 0.419s wall-clock] Instantiating: [0.740s CPU, 0.743s wall-clock] Computing fact groups... Finding invariants... 10 initial candidates Finding invariants: [0.020s CPU, 0.024s wall-clock] Checking invariant weight... [0.000s CPU, 0.004s wall-clock] Instantiating groups... [0.030s CPU, 0.028s wall-clock] Collecting mutex groups... [0.010s CPU, 0.005s wall-clock] Choosing groups... 26 uncovered facts Choosing groups: [0.020s CPU, 0.027s wall-clock] Building translation key... [0.010s CPU, 0.009s wall-clock] Computing fact groups: [0.150s CPU, 0.154s wall-clock] Building STRIPS to SAS dictionary... [0.010s CPU, 0.004s wall-clock] Building dictionary for full mutex groups... [0.000s CPU, 0.010s wall-clock] Building mutex information... Building mutex information: [0.020s CPU, 0.016s wall-clock] Translating task... Processing axioms... Simplifying axioms... [0.000s CPU, 0.000s wall-clock] Processing axioms: [0.020s CPU, 0.022s wall-clock] Translating task: [0.500s CPU, 0.494s wall-clock] 1850 effect conditions simplified 0 implied preconditions added Detecting unreachable propositions... 0 operators removed 0 axioms removed 50 propositions removed Detecting unreachable propositions: [0.300s CPU, 0.300s wall-clock] Reordering and filtering variables... 51 of 51 variables necessary. 26 of 51 mutex groups necessary. 1250 of 1250 operators necessary. 0 of 0 axiom rules necessary. Reordering and filtering variables: [0.150s CPU, 0.151s wall-clock] Translator variables: 51 Translator derived variables: 0 Translator facts: 702 Translator goal facts: 24 Translator mutex groups: 26 Translator total mutex groups size: 676 Translator operators: 1250 Translator axioms: 0 Translator task size: 10753 Translator peak memory: 42700 KB Writing output... [0.190s CPU, 0.197s wall-clock] Done! [2.100s CPU, 2.366s wall-clock] planner.py version 0.0.1 Time: 0.40s Memory: 72MB 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 : 0.824s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 0.400s 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 : 32995 Atoms : 32995 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 : 208MB Max. Length : 0 steps Models : 0 [endof: stats after solve call] Solving Time: 0.00s Memory: 144MB (+72MB) 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: 144MB Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])] Grounding Time: 0.14s Memory: 147MB (+3MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 2 Time : 1.064s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 0.640s 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 : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 9050 (Eliminated: 0 Frozen: 9050) Constraints : 8839 (Binary: 92.8% Ternary: 4.2% Other: 2.9%) Memory Peak : 208MB Max. Length : 0 steps Models : 0 [endof: stats after solve call] Solving Time: 0.06s Memory: 150MB (+3MB) UNSAT Iteration Time: 0.24s 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: 156.0MB Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])] Grounding Time: 0.17s Memory: 157MB (+7MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 3 Time : 1.372s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 0.948s 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 : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 18601 (Eliminated: 0 Frozen: 18601) Constraints : 45707 (Binary: 93.8% Ternary: 4.4% Other: 1.8%) Memory Peak : 208MB Max. Length : 5 steps Models : 0 [endof: stats after solve call] Solving Time: 0.09s Memory: 161MB (+4MB) UNSAT Iteration Time: 0.31s Iteration 4 Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] Grounded Until: 10 Expected Memory: 172.0MB Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])] Grounding Time: 0.16s Memory: 166MB (+5MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 4 Time : 1.720s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 1.296s Choices : 0 Conflicts : 0 (Analyzed: 0) Restarts : 0 Problems : 4 (Average Length: 9.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 : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 28542 (Eliminated: 0 Frozen: 28542) Constraints : 107252 (Binary: 94.2% Ternary: 4.4% Other: 1.4%) Memory Peak : 208MB Max. Length : 10 steps Models : 0 [endof: stats after solve call] Solving Time: 0.12s Memory: 171MB (+5MB) UNSAT Iteration Time: 0.35s Iteration 5 Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)] Grounded Until: 15 Expected Memory: 182.0MB Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])] Grounding Time: 0.20s Memory: 179MB (+8MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 5 Time : 2.138s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 1.712s Choices : 0 Conflicts : 1 (Analyzed: 0) Restarts : 0 Problems : 5 (Average Length: 12.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 : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 38928 (Eliminated: 0 Frozen: 38928) Constraints : 185882 (Binary: 94.4% Ternary: 4.4% Other: 1.2%) Memory Peak : 208MB Max. Length : 15 steps Models : 0 [endof: stats after solve call] Solving Time: 0.15s Memory: 184MB (+5MB) UNSAT Iteration Time: 0.42s Iteration 6 Queue: [(5,25,0,True), (6,30,0,True)] Grounded Until: 20 Expected Memory: 197.0MB Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])] Grounding Time: 0.17s Memory: 189MB (+5MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 6 Time : 2.529s (Solving: 0.01s 1st Model: 0.00s Unsat: 0.01s) CPU Time : 2.104s Choices : 0 Conflicts : 2 (Analyzed: 0) Restarts : 0 Problems : 6 (Average Length: 14.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 : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 49339 (Eliminated: 0 Frozen: 49339) Constraints : 264802 (Binary: 94.4% Ternary: 4.4% Other: 1.1%) Memory Peak : 208MB Max. Length : 20 steps Models : 0 [endof: stats after solve call] Solving Time: 0.16s Memory: 197MB (+8MB) UNSAT Iteration Time: 0.40s Iteration 7 Queue: [(6,30,0,True)] Grounded Until: 25 Expected Memory: 210.0MB Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])] Grounding Time: 0.17s Memory: 201MB (+4MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 7 Time : 2.930s (Solving: 0.01s 1st Model: 0.00s Unsat: 0.01s) CPU Time : 2.508s Choices : 0 Conflicts : 3 (Analyzed: 0) Restarts : 0 Problems : 7 (Average Length: 17.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 : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 59750 (Eliminated: 0 Frozen: 59750) Constraints : 343722 (Binary: 94.5% Ternary: 4.4% Other: 1.1%) Memory Peak : 210MB Max. Length : 25 steps Models : 0 [endof: stats after solve call] Solving Time: 0.16s Memory: 206MB (+5MB) UNSAT Iteration Time: 0.41s Iteration 8 Queue: [(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)] Grounded Until: 30 Expected Memory: 219.0MB Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])] Grounding Time: 0.17s Memory: 210MB (+4MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 8 Time : 3.347s (Solving: 0.02s 1st Model: 0.00s Unsat: 0.02s) CPU Time : 2.924s Choices : 0 Conflicts : 4 (Analyzed: 0) Restarts : 0 Problems : 8 (Average Length: 19.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 : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 70161 (Eliminated: 0 Frozen: 70161) Constraints : 422642 (Binary: 94.5% Ternary: 4.4% Other: 1.1%) Memory Peak : 221MB Max. Length : 30 steps Models : 0 [endof: stats after solve call] Solving Time: 0.16s Memory: 221MB (+11MB) UNSAT Iteration Time: 0.42s Iteration 9 Queue: [(8,40,0,True), (9,45,0,True), (10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)] Grounded Until: 35 Expected Memory: 236.0MB Grounding... [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])] Grounding Time: 0.25s Memory: 228MB (+7MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 9 Time : 3.857s (Solving: 0.03s 1st Model: 0.00s Unsat: 0.03s) CPU Time : 3.432s Choices : 126 (Domain: 126) Conflicts : 23 (Analyzed: 18) Restarts : 0 Problems : 9 (Average Length: 22.00 Splits: 0) Lemmas : 18 (Deleted: 0) Binary : 3 (Ratio: 16.67%) Ternary : 1 (Ratio: 5.56%) Conflict : 18 (Average Length: 17.4 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 18 (Average: 9.33 Max: 68 Sum: 168) Executed : 16 (Average: 7.00 Max: 68 Sum: 126 Ratio: 75.00%) Bounded : 2 (Average: 21.00 Max: 41 Sum: 42 Ratio: 25.00%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 80572 (Eliminated: 0 Frozen: 80572) Constraints : 501562 (Binary: 94.5% Ternary: 4.4% Other: 1.1%) Memory Peak : 240MB Max. Length : 35 steps Models : 0 [endof: stats after solve call] Solving Time: 0.18s Memory: 234MB (+6MB) UNSAT Iteration Time: 0.52s Iteration 10 Queue: [(9,45,0,True), (10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)] Grounded Until: 40 Expected Memory: 249.0MB Grounding... [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])] Grounding Time: 0.17s Memory: 237MB (+3MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 10 Time : 4.319s (Solving: 0.08s 1st Model: 0.00s Unsat: 0.08s) CPU Time : 3.892s Choices : 449 (Domain: 449) Conflicts : 86 (Analyzed: 80) Restarts : 0 Problems : 10 (Average Length: 24.50 Splits: 0) Lemmas : 80 (Deleted: 0) Binary : 5 (Ratio: 6.25%) Ternary : 1 (Ratio: 1.25%) Conflict : 80 (Average Length: 88.2 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 80 (Average: 8.50 Max: 68 Sum: 680) Executed : 73 (Average: 5.61 Max: 68 Sum: 449 Ratio: 66.03%) Bounded : 7 (Average: 33.00 Max: 47 Sum: 231 Ratio: 33.97%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 90983 (Eliminated: 0 Frozen: 90983) Constraints : 580482 (Binary: 94.5% Ternary: 4.4% Other: 1.1%) Memory Peak : 250MB Max. Length : 40 steps Models : 0 [endof: stats after solve call] Solving Time: 0.21s Memory: 242MB (+5MB) UNSAT Iteration Time: 0.47s Iteration 11 Queue: [(10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)] Grounded Until: 45 Expected Memory: 257.0MB Grounding... [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])] Grounding Time: 0.19s Memory: 246MB (+4MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 11 Time : 4.830s (Solving: 0.12s 1st Model: 0.00s Unsat: 0.12s) CPU Time : 4.404s Choices : 1064 (Domain: 1064) Conflicts : 141 (Analyzed: 134) Restarts : 0 Problems : 11 (Average Length: 27.00 Splits: 0) Lemmas : 134 (Deleted: 0) Binary : 20 (Ratio: 14.93%) Ternary : 1 (Ratio: 0.75%) Conflict : 134 (Average Length: 100.9 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 134 (Average: 9.69 Max: 68 Sum: 1299) Executed : 123 (Average: 7.94 Max: 68 Sum: 1064 Ratio: 81.91%) Bounded : 11 (Average: 21.36 Max: 47 Sum: 235 Ratio: 18.09%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 101394 (Eliminated: 0 Frozen: 101394) Constraints : 613973 (Binary: 94.5% Ternary: 4.4% Other: 1.1%) Memory Peak : 261MB Max. Length : 45 steps Models : 0 [endof: stats after solve call] Solving Time: 0.22s Memory: 254MB (+8MB) UNSAT Iteration Time: 0.52s Iteration 12 Queue: [(11,55,0,True), (12,60,0,True), (13,65,0,True)] Grounded Until: 50 Expected Memory: 269.0MB Grounding... [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])] Grounding Time: 0.19s Memory: 257MB (+3MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 12 Time : 5.452s (Solving: 0.28s 1st Model: 0.00s Unsat: 0.28s) CPU Time : 5.024s Choices : 4953 (Domain: 4953) Conflicts : 218 (Analyzed: 210) Restarts : 0 Problems : 12 (Average Length: 29.50 Splits: 0) Lemmas : 210 (Deleted: 0) Binary : 58 (Ratio: 27.62%) Ternary : 1 (Ratio: 0.48%) Conflict : 210 (Average Length: 257.6 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 210 (Average: 24.74 Max: 178 Sum: 5196) Executed : 191 (Average: 23.59 Max: 178 Sum: 4953 Ratio: 95.32%) Bounded : 19 (Average: 12.79 Max: 47 Sum: 243 Ratio: 4.68%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 111805 (Eliminated: 0 Frozen: 111805) Constraints : 692893 (Binary: 94.5% Ternary: 4.4% Other: 1.1%) Memory Peak : 273MB Max. Length : 50 steps Models : 0 [endof: stats after solve call] Solving Time: 0.33s Memory: 270MB (+13MB) UNSAT Iteration Time: 0.63s Iteration 13 Queue: [(12,60,0,True), (13,65,0,True)] Grounded Until: 55 Expected Memory: 286.0MB Grounding... [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])] Grounding Time: 0.18s Memory: 270MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 13 Time : 6.239s (Solving: 0.61s 1st Model: 0.00s Unsat: 0.61s) CPU Time : 5.812s Choices : 17271 (Domain: 17271) Conflicts : 376 (Analyzed: 367) Restarts : 0 Problems : 13 (Average Length: 32.00 Splits: 0) Lemmas : 367 (Deleted: 0) Binary : 114 (Ratio: 31.06%) Ternary : 3 (Ratio: 0.82%) Conflict : 367 (Average Length: 832.3 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 367 (Average: 47.75 Max: 348 Sum: 17525) Executed : 337 (Average: 47.06 Max: 348 Sum: 17271 Ratio: 98.55%) Bounded : 30 (Average: 8.47 Max: 47 Sum: 254 Ratio: 1.45%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 122216 (Eliminated: 0 Frozen: 122216) Constraints : 771813 (Binary: 94.5% Ternary: 4.4% Other: 1.1%) Memory Peak : 288MB Max. Length : 55 steps Models : 0 [endof: stats after solve call] Solving Time: 0.51s Memory: 277MB (+7MB) UNSAT Iteration Time: 0.79s Iteration 14 Queue: [(13,65,0,True)] Grounded Until: 60 Expected Memory: 293.0MB Grounding... [('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('check', [65])] Grounding Time: 0.22s Memory: 280MB (+3MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 14 Time : 7.515s (Solving: 1.37s 1st Model: 0.00s Unsat: 1.37s) CPU Time : 7.088s Choices : 46802 (Domain: 46802) Conflicts : 826 (Analyzed: 816) Restarts : 0 Problems : 14 (Average Length: 34.50 Splits: 0) Lemmas : 816 (Deleted: 0) Binary : 194 (Ratio: 23.77%) Ternary : 3 (Ratio: 0.37%) Conflict : 816 (Average Length: 1425.9 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 816 (Average: 57.69 Max: 556 Sum: 47071) Executed : 771 (Average: 57.36 Max: 556 Sum: 46802 Ratio: 99.43%) Bounded : 45 (Average: 5.98 Max: 47 Sum: 269 Ratio: 0.57%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 132627 (Eliminated: 0 Frozen: 132627) Constraints : 850733 (Binary: 94.5% Ternary: 4.4% Other: 1.0%) Memory Peak : 299MB Max. Length : 60 steps Models : 0 [endof: stats after solve call] Solving Time: 0.94s Memory: 287MB (+7MB) UNSAT Iteration Time: 1.28s Iteration 15 Queue: [(14,70,0,True), (15,75,0,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)] Grounded Until: 65 Expected Memory: 303.0MB Grounding... [('step', [66]), ('step', [67]), ('step', [68]), ('step', [69]), ('step', [70]), ('check', [70])] Grounding Time: 0.21s Memory: 288MB (+1MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 15 Time : 9.088s (Solving: 2.44s 1st Model: 0.00s Unsat: 2.44s) CPU Time : 8.664s Choices : 88757 (Domain: 88757) Conflicts : 1328 (Analyzed: 1317) Restarts : 1 (Average: 1317.00 Last: 449) Problems : 15 (Average Length: 37.00 Splits: 0) Lemmas : 1317 (Deleted: 0) Binary : 285 (Ratio: 21.64%) Ternary : 3 (Ratio: 0.23%) Conflict : 1317 (Average Length: 1385.0 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 1317 (Average: 67.63 Max: 751 Sum: 89068) Executed : 1251 (Average: 67.03 Max: 751 Sum: 88281 Ratio: 99.12%) Bounded : 66 (Average: 11.92 Max: 72 Sum: 787 Ratio: 0.88%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 143038 (Eliminated: 0 Frozen: 143038) Constraints : 929653 (Binary: 94.5% Ternary: 4.4% Other: 1.0%) Memory Peak : 308MB Max. Length : 65 steps Models : 0 [endof: stats after solve call] Solving Time: 1.25s Memory: 296MB (+8MB) UNSAT Iteration Time: 1.58s Iteration 16 Queue: [(15,75,0,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)] Grounded Until: 70 Expected Memory: 312.0MB Grounding... [('step', [71]), ('step', [72]), ('step', [73]), ('step', [74]), ('step', [75]), ('check', [75])] Grounding Time: 0.19s Memory: 296MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 16 Time : 13.089s (Solving: 5.94s 1st Model: 0.00s Unsat: 5.94s) CPU Time : 12.668s Choices : 130370 (Domain: 130370) Conflicts : 4479 (Analyzed: 4467) Restarts : 1 (Average: 4467.00 Last: 3150) Problems : 16 (Average Length: 39.50 Splits: 0) Lemmas : 4467 (Deleted: 0) Binary : 365 (Ratio: 8.17%) Ternary : 4 (Ratio: 0.09%) Conflict : 4467 (Average Length: 1784.0 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 4467 (Average: 29.33 Max: 1155 Sum: 130995) Executed : 4388 (Average: 29.08 Max: 1155 Sum: 129894 Ratio: 99.16%) Bounded : 79 (Average: 13.94 Max: 77 Sum: 1101 Ratio: 0.84%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 153449 (Eliminated: 0 Frozen: 153449) Constraints : 981435 (Binary: 94.5% Ternary: 4.4% Other: 1.0%) Memory Peak : 318MB Max. Length : 70 steps Models : 0 [endof: stats after solve call] Solving Time: 3.68s Memory: 304MB (+8MB) UNSAT Iteration Time: 4.01s Iteration 17 Queue: [(16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)] Grounded Until: 75 Expected Memory: 320.0MB Grounding... [('step', [76]), ('step', [77]), ('step', [78]), ('step', [79]), ('step', [80]), ('check', [80])] Grounding Time: 0.19s Memory: 305MB (+1MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 17 Time : 59.258s (Solving: 51.59s 1st Model: 0.00s Unsat: 5.94s) CPU Time : 58.804s Choices : 407427 (Domain: 407427) Conflicts : 28571 (Analyzed: 28559) Restarts : 101 (Average: 282.76 Last: 3150) Problems : 17 (Average Length: 42.00 Splits: 0) Lemmas : 28559 (Deleted: 16205) Binary : 644 (Ratio: 2.25%) Ternary : 9 (Ratio: 0.03%) Conflict : 28559 (Average Length: 2795.5 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 28559 (Average: 12.66 Max: 1208 Sum: 361675) Executed : 28472 (Average: 12.63 Max: 1208 Sum: 360566 Ratio: 99.69%) Bounded : 87 (Average: 12.75 Max: 77 Sum: 1109 Ratio: 0.31%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 163860 (Eliminated: 0 Frozen: 163860) Constraints : 1060305 (Binary: 94.5% Ternary: 4.4% Other: 1.0%) Memory Peak : 519MB Max. Length : 75 steps Models : 0 [endof: stats after solve call] Solving Time: 45.81s Memory: 519MB (+214MB) UNKNOWN Iteration Time: 46.14s Iteration 18 Queue: [(17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)] Grounded Until: 80 Expected Memory: 734.0MB Grounding... [('step', [81]), ('step', [82]), ('step', [83]), ('step', [84]), ('step', [85]), ('check', [85])] Grounding Time: 0.35s Memory: 531MB (+12MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 18 Time : 379.933s (Solving: 371.53s 1st Model: 0.00s Unsat: 5.94s) CPU Time : 378.968s Choices : 2223058 (Domain: 2223058) Conflicts : 117598 (Analyzed: 117586) Restarts : 201 (Average: 585.00 Last: 3150) Problems : 18 (Average Length: 44.50 Splits: 0) Lemmas : 117586 (Deleted: 97122) Binary : 850 (Ratio: 0.72%) Ternary : 33 (Ratio: 0.03%) Conflict : 117586 (Average Length: 16389.2 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 117586 (Average: 17.96 Max: 6837 Sum: 2111767) Executed : 117493 (Average: 17.95 Max: 6837 Sum: 2110652 Ratio: 99.95%) Bounded : 93 (Average: 11.99 Max: 77 Sum: 1115 Ratio: 0.05%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 174271 (Eliminated: 0 Frozen: 174271) Constraints : 1139225 (Binary: 94.5% Ternary: 4.4% Other: 1.0%) Memory Peak : 3866MB Max. Length : 80 steps Models : 0 [endof: stats after solve call] Solving Time: 319.64s Memory: 3802MB (+3271MB) UNKNOWN Iteration Time: 320.17s Iteration 19 Queue: [(18,90,0,True), (19,95,0,True), (20,100,0,True)] Grounded Until: 85 Expected Memory: 7085.0MB Grounding... [('step', [86]), ('step', [87]), ('step', [88]), ('step', [89]), ('step', [90]), ('check', [90])] Grounding Time: 0.17s Memory: 3802MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 1+ Calls : 19 Time : 382.435s (Solving: 372.70s 1st Model: 1.15s Unsat: 5.94s) CPU Time : 381.468s Choices : 2417039 (Domain: 2417039) Conflicts : 117868 (Analyzed: 117856) Restarts : 201 (Average: 586.35 Last: 3150) Model-Level : 3414.0 Problems : 19 (Average Length: 47.00 Splits: 0) Lemmas : 117856 (Deleted: 97122) Binary : 895 (Ratio: 0.76%) Ternary : 33 (Ratio: 0.03%) Conflict : 117856 (Average Length: 16352.5 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 117856 (Average: 19.54 Max: 6837 Sum: 2302432) Executed : 117757 (Average: 19.53 Max: 6837 Sum: 2301311 Ratio: 99.95%) Bounded : 99 (Average: 11.32 Max: 77 Sum: 1121 Ratio: 0.05%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 184682 (Eliminated: 0 Frozen: 184682) Constraints : 1218145 (Binary: 94.5% Ternary: 4.4% Other: 1.0%) Memory Peak : 3866MB Max. Length : 85 steps Models : 1 [endof: stats after solve call] Solving Time: 1.74s Memory: 3806MB (+4MB) SAT Testing... SERIALIZABLE Testing Time: 0.44s Memory: 3812MB (+6MB) Answer: 1 occurs(action(("unstack","x","n")),1) occurs(action(("put-down","x")),2) occurs(action(("pick-up","p")),3) occurs(action(("put-down","p")),4) occurs(action(("unstack","u","i")),5) occurs(action(("put-down","u")),6) occurs(action(("unstack","n","l")),7) occurs(action(("put-down","n")),8) occurs(action(("unstack","l","e")),9) occurs(action(("put-down","l")),10) occurs(action(("pick-up","e")),11) occurs(action(("stack","e","n")),12) occurs(action(("unstack","a","v")),13) occurs(action(("put-down","a")),14) occurs(action(("pick-up","p")),15) occurs(action(("put-down","p")),16) occurs(action(("unstack","i","k")),17) occurs(action(("put-down","i")),18) occurs(action(("unstack","v","c")),19) occurs(action(("stack","v","x")),20) occurs(action(("unstack","k","t")),21) occurs(action(("stack","k","l")),22) occurs(action(("unstack","c","r")),23) occurs(action(("put-down","c")),24) occurs(action(("unstack","r","s")),25) occurs(action(("put-down","r")),26) occurs(action(("unstack","s","h")),27) occurs(action(("put-down","s")),28) occurs(action(("unstack","t","f")),29) occurs(action(("put-down","t")),30) occurs(action(("unstack","h","o")),31) occurs(action(("stack","h","u")),32) occurs(action(("unstack","o","d")),33) occurs(action(("put-down","o")),34) occurs(action(("unstack","d","w")),35) occurs(action(("stack","d","a")),36) occurs(action(("unstack","w","y")),37) occurs(action(("put-down","w")),38) occurs(action(("unstack","y","g")),39) occurs(action(("stack","y","s")),40) occurs(action(("unstack","g","j")),41) occurs(action(("stack","g","t")),42) occurs(action(("unstack","j","q")),43) occurs(action(("stack","j","r")),44) occurs(action(("unstack","q","m")),45) occurs(action(("stack","q","h")),46) occurs(action(("pick-up","i")),47) occurs(action(("stack","i","q")),48) occurs(action(("pick-up","f")),49) occurs(action(("stack","f","i")),50) occurs(action(("unstack","v","x")),51) occurs(action(("stack","v","f")),52) occurs(action(("unstack","e","n")),53) occurs(action(("stack","e","v")),54) occurs(action(("pick-up","x")),55) occurs(action(("stack","x","e")),56) occurs(action(("unstack","m","b")),57) occurs(action(("stack","m","x")),58) occurs(action(("pick-up","p")),59) occurs(action(("stack","p","m")),60) occurs(action(("unstack","k","l")),61) occurs(action(("stack","k","p")),62) occurs(action(("pick-up","b")),63) occurs(action(("stack","b","k")),64) occurs(action(("unstack","d","a")),65) occurs(action(("stack","d","b")),66) occurs(action(("unstack","j","r")),67) occurs(action(("stack","j","d")),68) occurs(action(("unstack","g","t")),69) occurs(action(("stack","g","j")),70) occurs(action(("pick-up","c")),71) occurs(action(("stack","c","g")),72) occurs(action(("pick-up","r")),73) occurs(action(("stack","r","c")),74) occurs(action(("pick-up","a")),75) occurs(action(("stack","a","r")),76) occurs(action(("unstack","y","s")),77) occurs(action(("stack","y","a")),78) occurs(action(("pick-up","s")),79) occurs(action(("stack","s","y")),80) occurs(action(("pick-up","o")),81) occurs(action(("stack","o","s")),82) occurs(action(("pick-up","n")),83) occurs(action(("stack","n","o")),84) occurs(action(("pick-up","w")),85) occurs(action(("stack","w","n")),86) occurs(action(("pick-up","t")),87) occurs(action(("stack","t","w")),88) occurs(action(("pick-up","l")),89) occurs(action(("stack","l","t")),90) SATISFIABLE Models : 1+ Calls : 19 Time : 382.435s (Solving: 372.70s 1st Model: 1.15s Unsat: 5.94s) CPU Time : 381.468s Choices : 2417039 (Domain: 2417039) Conflicts : 117868 (Analyzed: 117856) Restarts : 201 (Average: 586.35 Last: 3150) Model-Level : 3414.0 Problems : 19 (Average Length: 47.00 Splits: 0) Lemmas : 117856 (Deleted: 97122) Binary : 895 (Ratio: 0.76%) Ternary : 33 (Ratio: 0.03%) Conflict : 117856 (Average Length: 16352.5 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 117856 (Average: 19.54 Max: 6837 Sum: 2302432) Executed : 117757 (Average: 19.53 Max: 6837 Sum: 2301311 Ratio: 99.95%) Bounded : 99 (Average: 11.32 Max: 77 Sum: 1121 Ratio: 0.05%) Rules : 32995 Atoms : 32995 Bodies : 1 (Original: 0) Tight : Yes Variables : 184682 (Eliminated: 0 Frozen: 184682) Constraints : 1218145 (Binary: 94.5% Ternary: 4.4% Other: 1.0%) Memory Peak : 3866MB Max. Length : 90 steps Sol. Length : 90 steps Models : 1