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-55.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-55.pddl Parsing... Parsing: [0.010s CPU, 0.016s wall-clock] Normalizing task... [0.000s CPU, 0.001s wall-clock] Instantiating... Generating Datalog program... [0.000s CPU, 0.005s wall-clock] Normalizing Datalog program... Normalizing Datalog program: [0.000s CPU, 0.009s wall-clock] Preparing model... [0.010s CPU, 0.011s wall-clock] Generated 21 rules. Computing model... [0.290s CPU, 0.286s wall-clock] 2405 relevant atoms 1593 auxiliary atoms 3998 final queue length 6974 total queue pushes Completing instantiation... [0.490s CPU, 0.484s wall-clock] Instantiating: [0.800s CPU, 0.799s wall-clock] Computing fact groups... Finding invariants... 10 initial candidates Finding invariants: [0.020s CPU, 0.021s 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.000s CPU, 0.006s wall-clock] Choosing groups... 28 uncovered facts Choosing groups: [0.030s CPU, 0.031s wall-clock] Building translation key... [0.000s CPU, 0.011s wall-clock] Computing fact groups: [0.170s CPU, 0.167s wall-clock] Building STRIPS to SAS dictionary... [0.010s CPU, 0.008s 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.017s wall-clock] Translating task... Processing axioms... Simplifying axioms... [0.000s CPU, 0.000s wall-clock] Processing axioms: [0.030s CPU, 0.024s wall-clock] Translating task: [0.600s CPU, 0.601s wall-clock] 2160 effect conditions simplified 0 implied preconditions added Detecting unreachable propositions... 0 operators removed 0 axioms removed 54 propositions removed Detecting unreachable propositions: [0.320s CPU, 0.315s wall-clock] Reordering and filtering variables... 55 of 55 variables necessary. 28 of 55 mutex groups necessary. 1458 of 1458 operators necessary. 0 of 0 axiom rules necessary. Reordering and filtering variables: [0.180s CPU, 0.177s wall-clock] Translator variables: 55 Translator derived variables: 0 Translator facts: 812 Translator goal facts: 26 Translator mutex groups: 28 Translator total mutex groups size: 784 Translator operators: 1458 Translator axioms: 0 Translator task size: 12531 Translator peak memory: 43724 KB Writing output... [0.220s CPU, 0.227s wall-clock] Done! [2.350s CPU, 2.366s wall-clock] planner.py version 0.0.1 Time: 0.42s Memory: 75MB 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.496s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 0.424s 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 : 38443 Atoms : 38443 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 : 211MB Max. Length : 0 steps Models : 0 [endof: stats after solve call] Solving Time: 0.00s Memory: 147MB (+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: 147MB Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])] Grounding Time: 0.18s Memory: 153MB (+6MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 2 Time : 0.806s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 0.732s 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 : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 10479 (Eliminated: 0 Frozen: 10479) Constraints : 16087 (Binary: 93.9% Ternary: 3.9% Other: 2.2%) Memory Peak : 211MB Max. Length : 0 steps Models : 0 [endof: stats after solve call] Solving Time: 0.07s Memory: 156MB (+3MB) UNSAT Iteration Time: 0.31s 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: 165.0MB Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])] Grounding Time: 0.18s Memory: 163MB (+7MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 3 Time : 1.210s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 1.136s Choices : 0 Conflicts : 1 (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 : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 21852 (Eliminated: 0 Frozen: 21852) Constraints : 92584 (Binary: 94.6% Ternary: 4.2% Other: 1.2%) Memory Peak : 211MB Max. Length : 5 steps Models : 0 [endof: stats after solve call] Solving Time: 0.16s Memory: 167MB (+4MB) UNSAT Iteration Time: 0.41s Iteration 4 Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] Grounded Until: 10 Expected Memory: 178.0MB Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])] Grounding Time: 0.23s Memory: 177MB (+10MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 4 Time : 1.697s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 1.620s Choices : 0 Conflicts : 2 (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 : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 33903 (Eliminated: 0 Frozen: 33903) Constraints : 184564 (Binary: 94.7% Ternary: 4.3% Other: 1.1%) Memory Peak : 211MB Max. Length : 10 steps Models : 0 [endof: stats after solve call] Solving Time: 0.19s Memory: 182MB (+5MB) UNSAT Iteration Time: 0.49s Iteration 5 Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)] Grounded Until: 15 Expected Memory: 197.0MB Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])] Grounding Time: 0.19s Memory: 188MB (+6MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 5 Time : 2.155s (Solving: 0.01s 1st Model: 0.00s Unsat: 0.01s) CPU Time : 2.080s Choices : 0 Conflicts : 3 (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 : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 45954 (Eliminated: 0 Frozen: 45954) Constraints : 276544 (Binary: 94.7% Ternary: 4.3% Other: 1.0%) Memory Peak : 211MB Max. Length : 15 steps Models : 0 [endof: stats after solve call] Solving Time: 0.20s Memory: 195MB (+7MB) UNSAT Iteration Time: 0.46s Iteration 6 Queue: [(5,25,0,True), (6,30,0,True)] Grounded Until: 20 Expected Memory: 210.0MB Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])] Grounding Time: 0.20s Memory: 201MB (+6MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 6 Time : 2.633s (Solving: 0.02s 1st Model: 0.00s Unsat: 0.02s) CPU Time : 2.560s Choices : 0 Conflicts : 4 (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 : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 58005 (Eliminated: 0 Frozen: 58005) Constraints : 368524 (Binary: 94.7% Ternary: 4.4% Other: 1.0%) Memory Peak : 211MB Max. Length : 20 steps Models : 0 [endof: stats after solve call] Solving Time: 0.21s Memory: 211MB (+10MB) UNSAT Iteration Time: 0.48s Iteration 7 Queue: [(6,30,0,True)] Grounded Until: 25 Expected Memory: 227.0MB Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])] Grounding Time: 0.20s Memory: 214MB (+3MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 7 Time : 3.125s (Solving: 0.02s 1st Model: 0.00s Unsat: 0.02s) CPU Time : 3.052s Choices : 0 Conflicts : 5 (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 : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 70056 (Eliminated: 0 Frozen: 70056) Constraints : 460504 (Binary: 94.7% Ternary: 4.4% Other: 1.0%) Memory Peak : 225MB Max. Length : 25 steps Models : 0 [endof: stats after solve call] Solving Time: 0.21s Memory: 221MB (+7MB) UNSAT Iteration Time: 0.50s 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: 237.0MB Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])] Grounding Time: 0.27s Memory: 230MB (+9MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 8 Time : 3.706s (Solving: 0.04s 1st Model: 0.00s Unsat: 0.04s) CPU Time : 3.632s Choices : 5 (Domain: 5) Conflicts : 7 (Analyzed: 1) Restarts : 0 Problems : 8 (Average Length: 19.50 Splits: 0) Lemmas : 1 (Deleted: 0) Binary : 0 (Ratio: 0.00%) Ternary : 0 (Ratio: 0.00%) Conflict : 1 (Average Length: 1.0 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 1 (Average: 42.00 Max: 42 Sum: 42) Executed : 0 (Average: 5.00 Max: 5 Sum: 5 Ratio: 11.90%) Bounded : 1 (Average: 37.00 Max: 37 Sum: 37 Ratio: 88.10%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 82107 (Eliminated: 0 Frozen: 82107) Constraints : 552484 (Binary: 94.7% Ternary: 4.4% Other: 1.0%) Memory Peak : 242MB Max. Length : 30 steps Models : 0 [endof: stats after solve call] Solving Time: 0.22s Memory: 241MB (+11MB) UNSAT Iteration Time: 0.59s 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: 261.0MB Grounding... [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])] Grounding Time: 0.19s Memory: 245MB (+4MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 9 Time : 4.229s (Solving: 0.06s 1st Model: 0.00s Unsat: 0.06s) CPU Time : 4.156s Choices : 58 (Domain: 58) Conflicts : 20 (Analyzed: 13) Restarts : 0 Problems : 9 (Average Length: 22.00 Splits: 0) Lemmas : 13 (Deleted: 0) Binary : 2 (Ratio: 15.38%) Ternary : 0 (Ratio: 0.00%) Conflict : 13 (Average Length: 3.1 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 13 (Average: 36.46 Max: 50 Sum: 474) Executed : 2 (Average: 4.46 Max: 50 Sum: 58 Ratio: 12.24%) Bounded : 11 (Average: 37.82 Max: 42 Sum: 416 Ratio: 87.76%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 94158 (Eliminated: 0 Frozen: 94158) Constraints : 640226 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 258MB Max. Length : 35 steps Models : 0 [endof: stats after solve call] Solving Time: 0.23s Memory: 251MB (+6MB) UNSAT Iteration Time: 0.53s 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: 271.0MB Grounding... [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])] Grounding Time: 0.20s Memory: 257MB (+6MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 10 Time : 4.805s (Solving: 0.11s 1st Model: 0.00s Unsat: 0.11s) CPU Time : 4.732s Choices : 193 (Domain: 193) Conflicts : 81 (Analyzed: 73) Restarts : 0 Problems : 10 (Average Length: 24.50 Splits: 0) Lemmas : 73 (Deleted: 0) Binary : 6 (Ratio: 8.22%) Ternary : 2 (Ratio: 2.74%) Conflict : 73 (Average Length: 815.4 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 73 (Average: 10.16 Max: 52 Sum: 742) Executed : 58 (Average: 2.64 Max: 52 Sum: 193 Ratio: 26.01%) Bounded : 15 (Average: 36.60 Max: 47 Sum: 549 Ratio: 73.99%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 106209 (Eliminated: 0 Frozen: 106209) Constraints : 713723 (Binary: 94.7% Ternary: 4.4% Other: 1.0%) Memory Peak : 274MB Max. Length : 40 steps Models : 0 [endof: stats after solve call] Solving Time: 0.27s Memory: 266MB (+9MB) UNSAT Iteration Time: 0.58s Iteration 11 Queue: [(10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)] Grounded Until: 45 Expected Memory: 286.0MB Grounding... [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])] Grounding Time: 0.22s Memory: 268MB (+2MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 11 Time : 5.794s (Solving: 0.56s 1st Model: 0.00s Unsat: 0.56s) CPU Time : 5.720s Choices : 3451 (Domain: 3451) Conflicts : 641 (Analyzed: 632) Restarts : 4 (Average: 158.00 Last: 60) Problems : 11 (Average Length: 27.00 Splits: 0) Lemmas : 632 (Deleted: 0) Binary : 30 (Ratio: 4.75%) Ternary : 7 (Ratio: 1.11%) Conflict : 632 (Average Length: 1188.0 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 632 (Average: 8.51 Max: 142 Sum: 5378) Executed : 584 (Average: 5.25 Max: 142 Sum: 3318 Ratio: 61.70%) Bounded : 48 (Average: 42.92 Max: 52 Sum: 2060 Ratio: 38.30%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 118260 (Eliminated: 0 Frozen: 118260) Constraints : 805653 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 285MB Max. Length : 45 steps Models : 0 [endof: stats after solve call] Solving Time: 0.66s Memory: 274MB (+6MB) UNSAT Iteration Time: 1.00s Iteration 12 Queue: [(11,55,0,True), (12,60,0,True), (13,65,0,True)] Grounded Until: 50 Expected Memory: 294.0MB Grounding... [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])] Grounding Time: 0.22s Memory: 278MB (+4MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 12 Time : 7.438s (Solving: 1.65s 1st Model: 0.00s Unsat: 1.65s) CPU Time : 7.364s Choices : 9883 (Domain: 9883) Conflicts : 1638 (Analyzed: 1628) Restarts : 10 (Average: 162.80 Last: 188) Problems : 12 (Average Length: 29.50 Splits: 0) Lemmas : 1628 (Deleted: 0) Binary : 92 (Ratio: 5.65%) Ternary : 9 (Ratio: 0.55%) Conflict : 1628 (Average Length: 1888.6 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 1628 (Average: 7.46 Max: 171 Sum: 12150) Executed : 1564 (Average: 5.89 Max: 171 Sum: 9583 Ratio: 78.87%) Bounded : 64 (Average: 40.11 Max: 57 Sum: 2567 Ratio: 21.13%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 130311 (Eliminated: 0 Frozen: 130311) Constraints : 896933 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 297MB Max. Length : 50 steps Models : 0 [endof: stats after solve call] Solving Time: 1.30s Memory: 293MB (+15MB) UNSAT Iteration Time: 1.65s Iteration 13 Queue: [(12,60,0,True), (13,65,0,True)] Grounded Until: 55 Expected Memory: 313.0MB Grounding... [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])] Grounding Time: 0.27s Memory: 293MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 13 Time : 22.915s (Solving: 16.50s 1st Model: 0.00s Unsat: 16.50s) CPU Time : 22.848s Choices : 70108 (Domain: 70108) Conflicts : 10825 (Analyzed: 10814) Restarts : 47 (Average: 230.09 Last: 301) Problems : 13 (Average Length: 32.00 Splits: 0) Lemmas : 10814 (Deleted: 0) Binary : 223 (Ratio: 2.06%) Ternary : 11 (Ratio: 0.10%) Conflict : 10814 (Average Length: 3890.4 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 10814 (Average: 6.40 Max: 568 Sum: 69201) Executed : 10744 (Average: 6.16 Max: 568 Sum: 66567 Ratio: 96.19%) Bounded : 70 (Average: 37.63 Max: 62 Sum: 2634 Ratio: 3.81%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 142362 (Eliminated: 0 Frozen: 142362) Constraints : 988813 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 494MB Max. Length : 55 steps Models : 0 [endof: stats after solve call] Solving Time: 15.09s Memory: 430MB (+137MB) UNSAT Iteration Time: 15.49s Iteration 14 Queue: [(13,65,0,True)] Grounded Until: 60 Expected Memory: 567.0MB Grounding... [('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('check', [65])] Grounding Time: 0.21s Memory: 433MB (+3MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 14 Time : 84.122s (Solving: 77.07s 1st Model: 0.00s Unsat: 16.50s) CPU Time : 84.080s Choices : 266863 (Domain: 266863) Conflicts : 39087 (Analyzed: 39076) Restarts : 147 (Average: 265.82 Last: 301) Problems : 14 (Average Length: 34.50 Splits: 0) Lemmas : 39076 (Deleted: 27324) Binary : 406 (Ratio: 1.04%) Ternary : 15 (Ratio: 0.04%) Conflict : 39076 (Average Length: 5267.2 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 39076 (Average: 6.50 Max: 793 Sum: 253803) Executed : 38997 (Average: 6.43 Max: 793 Sum: 251160 Ratio: 98.96%) Bounded : 79 (Average: 33.46 Max: 62 Sum: 2643 Ratio: 1.04%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 154413 (Eliminated: 0 Frozen: 154413) Constraints : 1080768 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 635MB Max. Length : 60 steps Models : 0 [endof: stats after solve call] Solving Time: 60.85s Memory: 635MB (+202MB) UNKNOWN Iteration Time: 61.24s Iteration 15 Queue: [(13,65,1,True), (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), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True)] Grounded Until: 65 Solving... [start: stats after solve call] Models : 0 Calls : 15 Time : 163.053s (Solving: 155.90s 1st Model: 0.00s Unsat: 95.34s) CPU Time : 163.044s Choices : 374574 (Domain: 374574) Conflicts : 64265 (Analyzed: 64253) Restarts : 239 (Average: 268.84 Last: 301) Problems : 15 (Average Length: 36.67 Splits: 0) Lemmas : 64253 (Deleted: 55352) Binary : 467 (Ratio: 0.73%) Ternary : 16 (Ratio: 0.02%) Conflict : 64253 (Average Length: 5792.3 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 64253 (Average: 5.56 Max: 793 Sum: 357366) Executed : 64173 (Average: 5.52 Max: 793 Sum: 354722 Ratio: 99.26%) Bounded : 80 (Average: 33.05 Max: 62 Sum: 2644 Ratio: 0.74%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 154413 (Eliminated: 0 Frozen: 154413) Constraints : 1080768 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 891MB Max. Length : 65 steps Models : 0 [endof: stats after solve call] Solving Time: 78.97s Memory: 827MB (+192MB) UNSAT Iteration Time: 78.97s Iteration 16 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), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True)] Grounded Until: 65 Expected Memory: 1032.0MB Grounding... [('step', [66]), ('step', [67]), ('step', [68]), ('step', [69]), ('step', [70]), ('check', [70])] Grounding Time: 0.38s Memory: 840MB (+13MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 16 Time : 230.026s (Solving: 222.07s 1st Model: 0.00s Unsat: 95.34s) CPU Time : 230.044s Choices : 704545 (Domain: 704545) Conflicts : 92469 (Analyzed: 92457) Restarts : 339 (Average: 272.73 Last: 301) Problems : 16 (Average Length: 38.88 Splits: 0) Lemmas : 92457 (Deleted: 80342) Binary : 666 (Ratio: 0.72%) Ternary : 20 (Ratio: 0.02%) Conflict : 92457 (Average Length: 6117.5 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 92457 (Average: 6.95 Max: 2383 Sum: 642947) Executed : 92368 (Average: 6.93 Max: 2383 Sum: 640294 Ratio: 99.59%) Bounded : 89 (Average: 29.81 Max: 62 Sum: 2653 Ratio: 0.41%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 166464 (Eliminated: 0 Frozen: 166464) Constraints : 1172748 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 891MB Max. Length : 65 steps Models : 0 [endof: stats after solve call] Solving Time: 66.46s Memory: 846MB (+6MB) UNKNOWN Iteration Time: 67.01s Iteration 17 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), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True)] Grounded Until: 70 Expected Memory: 1051.0MB Grounding... [('step', [71]), ('step', [72]), ('step', [73]), ('step', [74]), ('step', [75]), ('check', [75])] Grounding Time: 0.20s Memory: 849MB (+3MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 17 Time : 322.678s (Solving: 314.03s 1st Model: 0.00s Unsat: 95.34s) CPU Time : 322.736s Choices : 1046987 (Domain: 1046987) Conflicts : 120706 (Analyzed: 120694) Restarts : 439 (Average: 274.93 Last: 301) Problems : 17 (Average Length: 41.12 Splits: 0) Lemmas : 120694 (Deleted: 108155) Binary : 780 (Ratio: 0.65%) Ternary : 21 (Ratio: 0.02%) Conflict : 120694 (Average Length: 6579.1 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 120694 (Average: 7.91 Max: 5916 Sum: 954226) Executed : 120594 (Average: 7.88 Max: 5916 Sum: 951562 Ratio: 99.72%) Bounded : 100 (Average: 26.64 Max: 62 Sum: 2664 Ratio: 0.28%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 178515 (Eliminated: 0 Frozen: 178515) Constraints : 1264728 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 921MB Max. Length : 70 steps Models : 0 [endof: stats after solve call] Solving Time: 92.29s Memory: 921MB (+72MB) UNKNOWN Iteration Time: 92.70s Iteration 18 Queue: [(16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True)] Grounded Until: 75 Expected Memory: 1126.0MB Grounding... [('step', [76]), ('step', [77]), ('step', [78]), ('step', [79]), ('step', [80]), ('check', [80])] Grounding Time: 0.23s Memory: 923MB (+2MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 18 Time : 383.116s (Solving: 373.67s 1st Model: 0.00s Unsat: 95.34s) CPU Time : 383.200s Choices : 1594072 (Domain: 1594072) Conflicts : 148953 (Analyzed: 148941) Restarts : 539 (Average: 276.33 Last: 301) Problems : 18 (Average Length: 43.39 Splits: 0) Lemmas : 148941 (Deleted: 136033) Binary : 1018 (Ratio: 0.68%) Ternary : 28 (Ratio: 0.02%) Conflict : 148941 (Average Length: 6451.0 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 148941 (Average: 9.66 Max: 5916 Sum: 1439506) Executed : 148827 (Average: 9.65 Max: 5916 Sum: 1436828 Ratio: 99.81%) Bounded : 114 (Average: 23.49 Max: 62 Sum: 2678 Ratio: 0.19%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 190566 (Eliminated: 0 Frozen: 190566) Constraints : 1356708 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 951MB Max. Length : 75 steps Models : 0 [endof: stats after solve call] Solving Time: 59.97s Memory: 945MB (+22MB) UNKNOWN Iteration Time: 60.47s Iteration 19 Queue: [(17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True)] Grounded Until: 80 Expected Memory: 1150.0MB Grounding... [('step', [81]), ('step', [82]), ('step', [83]), ('step', [84]), ('step', [85]), ('check', [85])] Grounding Time: 0.20s Memory: 945MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 19 Time : 439.560s (Solving: 429.45s 1st Model: 0.00s Unsat: 95.34s) CPU Time : 439.668s Choices : 2426734 (Domain: 2426734) Conflicts : 177166 (Analyzed: 177154) Restarts : 639 (Average: 277.24 Last: 301) Problems : 19 (Average Length: 45.68 Splits: 0) Lemmas : 177154 (Deleted: 163784) Binary : 1254 (Ratio: 0.71%) Ternary : 37 (Ratio: 0.02%) Conflict : 177154 (Average Length: 6608.7 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 177154 (Average: 12.11 Max: 8314 Sum: 2146052) Executed : 177033 (Average: 12.10 Max: 8314 Sum: 2143367 Ratio: 99.87%) Bounded : 121 (Average: 22.19 Max: 62 Sum: 2685 Ratio: 0.13%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 202617 (Eliminated: 0 Frozen: 202617) Constraints : 1448688 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 970MB Max. Length : 80 steps Models : 0 [endof: stats after solve call] Solving Time: 56.08s Memory: 953MB (+8MB) UNKNOWN Iteration Time: 56.48s Iteration 20 Queue: [(18,90,0,True), (19,95,0,True), (20,100,0,True), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True)] Grounded Until: 85 Expected Memory: 1158.0MB Grounding... [('step', [86]), ('step', [87]), ('step', [88]), ('step', [89]), ('step', [90]), ('check', [90])] Grounding Time: 0.21s Memory: 953MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 1+ Calls : 20 Time : 440.583s (Solving: 429.72s 1st Model: 0.26s Unsat: 95.34s) CPU Time : 440.688s Choices : 2473104 (Domain: 2473104) Conflicts : 177250 (Analyzed: 177238) Restarts : 639 (Average: 277.37 Last: 301) Model-Level : 11261.0 Problems : 20 (Average Length: 48.00 Splits: 0) Lemmas : 177238 (Deleted: 163784) Binary : 1258 (Ratio: 0.71%) Ternary : 37 (Ratio: 0.02%) Conflict : 177238 (Average Length: 6605.8 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 177238 (Average: 12.31 Max: 9916 Sum: 2181255) Executed : 177115 (Average: 12.29 Max: 9916 Sum: 2178568 Ratio: 99.88%) Bounded : 123 (Average: 21.85 Max: 62 Sum: 2687 Ratio: 0.12%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 214668 (Eliminated: 0 Frozen: 214668) Constraints : 1540668 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 984MB Max. Length : 85 steps Models : 1 [endof: stats after solve call] Solving Time: 0.57s Memory: 966MB (+13MB) SAT Testing... SERIALIZABLE Testing Time: 0.41s Memory: 971MB (+5MB) Answer: 1 occurs(action(("unstack","u","d")),1) occurs(action(("put-down","u")),2) occurs(action(("unstack","d","q")),3) occurs(action(("stack","d","f")),4) occurs(action(("unstack","q","s")),5) occurs(action(("put-down","q")),6) occurs(action(("unstack","s","i")),7) occurs(action(("stack","s","q")),8) occurs(action(("unstack","w","j")),9) occurs(action(("put-down","w")),10) occurs(action(("unstack","i","k")),11) occurs(action(("put-down","i")),12) occurs(action(("unstack","k","n")),13) occurs(action(("put-down","k")),14) occurs(action(("unstack","n","c")),15) occurs(action(("stack","n","i")),16) occurs(action(("pick-up","u")),17) occurs(action(("stack","u","n")),18) occurs(action(("unstack","j","g")),19) occurs(action(("stack","j","w")),20) occurs(action(("unstack","g","o")),21) occurs(action(("put-down","g")),22) occurs(action(("pick-up","c")),23) occurs(action(("put-down","c")),24) occurs(action(("unstack","o","p")),25) occurs(action(("stack","o","u")),26) occurs(action(("unstack","p","r")),27) occurs(action(("stack","p","c")),28) occurs(action(("unstack","r","z")),29) occurs(action(("put-down","r")),30) occurs(action(("pick-up","a")),31) occurs(action(("stack","a","p")),32) occurs(action(("unstack","h","v")),33) occurs(action(("stack","h","g")),34) occurs(action(("unstack","b","y")),35) occurs(action(("stack","b","s")),36) occurs(action(("unstack","j","w")),37) occurs(action(("stack","j","o")),38) occurs(action(("unstack","d","f")),39) occurs(action(("stack","d","j")),40) occurs(action(("unstack","b","s")),41) occurs(action(("stack","b","d")),42) occurs(action(("unstack","v","a1")),43) occurs(action(("put-down","v")),44) occurs(action(("unstack","a1","e")),45) occurs(action(("stack","a1","b")),46) occurs(action(("unstack","a","p")),47) occurs(action(("stack","a","a1")),48) occurs(action(("pick-up","z")),49) occurs(action(("stack","z","a")),50) occurs(action(("unstack","p","c")),51) occurs(action(("stack","p","z")),52) occurs(action(("pick-up","c")),53) occurs(action(("stack","c","p")),54) occurs(action(("unstack","e","l")),55) occurs(action(("stack","e","v")),56) occurs(action(("unstack","l","x")),57) occurs(action(("put-down","l")),58) occurs(action(("unstack","x","m")),59) occurs(action(("stack","x","c")),60) occurs(action(("pick-up","r")),61) occurs(action(("stack","r","x")),62) occurs(action(("unstack","h","g")),63) occurs(action(("stack","h","r")),64) occurs(action(("unstack","y","t")),65) occurs(action(("put-down","y")),66) occurs(action(("pick-up","t")),67) occurs(action(("stack","t","h")),68) occurs(action(("unstack","s","q")),69) occurs(action(("stack","s","t")),70) occurs(action(("pick-up","k")),71) occurs(action(("stack","k","s")),72) occurs(action(("pick-up","g")),73) occurs(action(("stack","g","k")),74) occurs(action(("pick-up","q")),75) occurs(action(("stack","q","g")),76) occurs(action(("pick-up","m")),77) occurs(action(("stack","m","q")),78) occurs(action(("unstack","e","v")),79) occurs(action(("stack","e","m")),80) occurs(action(("pick-up","v")),81) occurs(action(("stack","v","e")),82) occurs(action(("pick-up","w")),83) occurs(action(("stack","w","v")),84) occurs(action(("pick-up","l")),85) occurs(action(("stack","l","w")),86) occurs(action(("pick-up","f")),87) occurs(action(("stack","f","l")),88) occurs(action(("pick-up","y")),89) occurs(action(("stack","y","f")),90) SATISFIABLE Models : 1+ Calls : 20 Time : 440.583s (Solving: 429.72s 1st Model: 0.26s Unsat: 95.34s) CPU Time : 440.688s Choices : 2473104 (Domain: 2473104) Conflicts : 177250 (Analyzed: 177238) Restarts : 639 (Average: 277.37 Last: 301) Model-Level : 11261.0 Problems : 20 (Average Length: 48.00 Splits: 0) Lemmas : 177238 (Deleted: 163784) Binary : 1258 (Ratio: 0.71%) Ternary : 37 (Ratio: 0.02%) Conflict : 177238 (Average Length: 6605.8 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 177238 (Average: 12.31 Max: 9916 Sum: 2181255) Executed : 177115 (Average: 12.29 Max: 9916 Sum: 2178568 Ratio: 99.88%) Bounded : 123 (Average: 21.85 Max: 62 Sum: 2687 Ratio: 0.12%) Rules : 38443 Atoms : 38443 Bodies : 1 (Original: 0) Tight : Yes Variables : 214668 (Eliminated: 0 Frozen: 214668) Constraints : 1540668 (Binary: 94.7% Ternary: 4.4% Other: 0.9%) Memory Peak : 984MB Max. Length : 90 steps Sol. Length : 90 steps Models : 1