INFO Running translator. INFO translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/elevator-sequential-satisficing/domain.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/elevator-sequential-satisficing/instances/instance-2.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/elevator-sequential-satisficing/domain.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/elevator-sequential-satisficing/instances/instance-2.pddl Parsing... Parsing: [0.050s CPU, 0.051s wall-clock] Normalizing task... [0.000s CPU, 0.002s wall-clock] Instantiating... Generating Datalog program... [0.020s CPU, 0.013s wall-clock] Normalizing Datalog program... Normalizing Datalog program: [0.020s CPU, 0.023s wall-clock] Preparing model... [0.040s CPU, 0.042s wall-clock] Generated 46 rules. Computing model... [1.130s CPU, 1.130s wall-clock] 9612 relevant atoms 5472 auxiliary atoms 15084 final queue length 30843 total queue pushes Completing instantiation... [3.090s CPU, 3.078s wall-clock] Instantiating: [4.310s CPU, 4.301s wall-clock] Computing fact groups... Finding invariants... 12 initial candidates Finding invariants: [0.060s CPU, 0.058s wall-clock] Checking invariant weight... [0.000s CPU, 0.003s wall-clock] Instantiating groups... [0.040s CPU, 0.036s wall-clock] Collecting mutex groups... [0.010s CPU, 0.005s wall-clock] Choosing groups... 0 uncovered facts Choosing groups: [0.010s CPU, 0.013s wall-clock] Building translation key... [0.010s CPU, 0.008s wall-clock] Computing fact groups: [0.160s CPU, 0.158s wall-clock] Building STRIPS to SAS dictionary... [0.000s CPU, 0.003s wall-clock] Building dictionary for full mutex groups... [0.000s CPU, 0.004s wall-clock] Building mutex information... Building mutex information: [0.010s CPU, 0.004s wall-clock] Translating task... Processing axioms... Simplifying axioms... [0.000s CPU, 0.000s wall-clock] Processing axioms: [0.130s CPU, 0.136s wall-clock] Translating task: [2.570s CPU, 2.569s wall-clock] 0 effect conditions simplified 0 implied preconditions added Detecting unreachable propositions... 0 operators removed 0 axioms removed 31 propositions removed Detecting unreachable propositions: [1.190s CPU, 1.199s wall-clock] Reordering and filtering variables... 31 of 31 variables necessary. 0 of 31 mutex groups necessary. 8364 of 8364 operators necessary. 0 of 0 axiom rules necessary. Reordering and filtering variables: [0.390s CPU, 0.391s wall-clock] Translator variables: 31 Translator derived variables: 0 Translator facts: 700 Translator goal facts: 21 Translator mutex groups: 0 Translator total mutex groups size: 0 Translator operators: 8364 Translator axioms: 0 Translator task size: 50036 Translator peak memory: 69068 KB Writing output... [0.860s CPU, 0.930s wall-clock] Done! [9.660s CPU, 9.725s wall-clock] planner.py version 0.0.1 Time: 2.60s Memory: 187MB 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 : 2.928s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 2.608s 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 : 151430 Atoms : 151430 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 : 323MB Max. Length : 0 steps Models : 0 [endof: stats after solve call] Solving Time: 0.01s Memory: 259MB (+72MB) 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: 259MB Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])] Grounding Time: 0.64s Memory: 259MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 2 Time : 5.182s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 4.864s 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 : 151430 Atoms : 151430 Bodies : 1 (Original: 0) Tight : Yes Variables : 39943 (Eliminated: 0 Frozen: 39943) Constraints : 69078 (Binary: 96.6% Ternary: 1.6% Other: 1.8%) Memory Peak : 323MB Max. Length : 0 steps Models : 0 [endof: stats after solve call] Solving Time: 1.24s Memory: 263MB (+4MB) UNSAT Iteration Time: 2.26s 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: 267.0MB Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])] Grounding Time: 0.70s Memory: 275MB (+12MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 3 Time : 10.404s (Solving: 2.09s 1st Model: 0.00s Unsat: 2.09s) CPU Time : 10.088s Choices : 47636 (Domain: 47636) Conflicts : 10222 (Analyzed: 10221) Restarts : 44 (Average: 232.30 Last: 181) Problems : 3 (Average Length: 7.00 Splits: 0) Lemmas : 10221 (Deleted: 7263) Binary : 145 (Ratio: 1.42%) Ternary : 49 (Ratio: 0.48%) Conflict : 10221 (Average Length: 334.6 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 10221 (Average: 4.45 Max: 236 Sum: 45458) Executed : 10210 (Average: 4.44 Max: 236 Sum: 45425 Ratio: 99.93%) Bounded : 11 (Average: 3.00 Max: 12 Sum: 33 Ratio: 0.07%) Rules : 151430 Atoms : 151430 Bodies : 1 (Original: 0) Tight : Yes Variables : 87049 (Eliminated: 0 Frozen: 87049) Constraints : 424946 (Binary: 97.8% Ternary: 1.0% Other: 1.2%) Memory Peak : 323MB Max. Length : 5 steps Models : 0 [endof: stats after solve call] Solving Time: 4.14s Memory: 303MB (+28MB) UNSAT Iteration Time: 5.23s Iteration 4 Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] Grounded Until: 10 Expected Memory: 343.0MB Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])] Grounding Time: 0.67s Memory: 312MB (+9MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 4 Time : 25.769s (Solving: 14.20s 1st Model: 0.00s Unsat: 2.09s) CPU Time : 25.460s Choices : 272658 (Domain: 272658) Conflicts : 38342 (Analyzed: 38341) Restarts : 144 (Average: 266.26 Last: 200) Problems : 4 (Average Length: 9.50 Splits: 0) Lemmas : 38341 (Deleted: 26915) Binary : 274 (Ratio: 0.71%) Ternary : 180 (Ratio: 0.47%) Conflict : 38341 (Average Length: 1297.7 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 38341 (Average: 6.68 Max: 538 Sum: 256283) Executed : 38298 (Average: 6.68 Max: 538 Sum: 256218 Ratio: 99.97%) Bounded : 43 (Average: 1.51 Max: 12 Sum: 65 Ratio: 0.03%) Rules : 151430 Atoms : 151430 Bodies : 1 (Original: 0) Tight : Yes Variables : 136035 (Eliminated: 0 Frozen: 136035) Constraints : 802763 (Binary: 97.9% Ternary: 1.0% Other: 1.1%) Memory Peak : 475MB Max. Length : 10 steps Models : 0 [endof: stats after solve call] Solving Time: 14.33s Memory: 411MB (+99MB) UNKNOWN Iteration Time: 15.38s Iteration 5 Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)] Grounded Until: 15 Expected Memory: 519.0MB Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])] Grounding Time: 0.85s Memory: 438MB (+27MB) Unblocking actions... Solving... [start: stats after solve call] Models : 1+ Calls : 5 Time : 32.680s (Solving: 17.62s 1st Model: 3.40s Unsat: 2.09s) CPU Time : 32.372s Choices : 385886 (Domain: 385850) Conflicts : 44574 (Analyzed: 44573) Restarts : 173 (Average: 257.65 Last: 610) Model-Level : 1000.0 Problems : 5 (Average Length: 12.00 Splits: 0) Lemmas : 44573 (Deleted: 26915) Binary : 335 (Ratio: 0.75%) Ternary : 210 (Ratio: 0.47%) Conflict : 44573 (Average Length: 1352.8 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 44573 (Average: 7.81 Max: 811 Sum: 348116) Executed : 44528 (Average: 7.81 Max: 811 Sum: 348028 Ratio: 99.97%) Bounded : 45 (Average: 1.96 Max: 22 Sum: 88 Ratio: 0.03%) Rules : 151430 Atoms : 151430 Bodies : 1 (Original: 0) Tight : Yes Variables : 185021 (Eliminated: 0 Frozen: 185021) Constraints : 1180598 (Binary: 98.0% Ternary: 1.0% Other: 1.1%) Memory Peak : 475MB Max. Length : 15 steps Models : 1 [endof: stats after solve call] Solving Time: 5.66s Memory: 466MB (+28MB) SAT Testing... NOT SERIALIZABLE Testing Time: 2.93s Memory: 545MB (+79MB) Solving... [start: stats after solve call] Models : 0+ Calls : 6 Time : 73.114s (Solving: 56.07s 1st Model: 3.40s Unsat: 2.09s) CPU Time : 72.820s Choices : 1271574 (Domain: 1271538) Conflicts : 72666 (Analyzed: 72665) Restarts : 273 (Average: 266.17 Last: 610) Model-Level : 1000.0 Problems : 6 (Average Length: 13.67 Splits: 0) Lemmas : 72665 (Deleted: 59111) Binary : 738 (Ratio: 1.02%) Ternary : 524 (Ratio: 0.72%) Conflict : 72665 (Average Length: 1255.7 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 72665 (Average: 16.51 Max: 1704 Sum: 1199522) Executed : 72546 (Average: 16.48 Max: 1704 Sum: 1197806 Ratio: 99.86%) Bounded : 119 (Average: 14.42 Max: 22 Sum: 1716 Ratio: 0.14%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 186226 (Eliminated: 39 Frozen: 186187) Constraints : 1563690 (Binary: 98.4% Ternary: 0.7% Other: 0.9%) Memory Peak : 590MB Max. Length : 15 steps Models : 1 [endof: stats after solve call] Solving Time: 39.28s Memory: 590MB (+45MB) UNKNOWN Iteration Time: 49.13s Iteration 6 Queue: [(5,25,0,True), (6,30,0,True)] Grounded Until: 20 Expected Memory: 698.0MB Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])] Grounding Time: 1.19s Memory: 590MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 7 Time : 110.197s (Solving: 87.72s 1st Model: 3.40s Unsat: 2.09s) CPU Time : 109.916s Choices : 2049390 (Domain: 2049354) Conflicts : 100753 (Analyzed: 100752) Restarts : 373 (Average: 270.11 Last: 610) Model-Level : 1000.0 Problems : 7 (Average Length: 15.57 Splits: 0) Lemmas : 100752 (Deleted: 86768) Binary : 831 (Ratio: 0.82%) Ternary : 582 (Ratio: 0.58%) Conflict : 100752 (Average Length: 1528.9 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 100752 (Average: 19.14 Max: 1704 Sum: 1927958) Executed : 100616 (Average: 19.11 Max: 1704 Sum: 1925783 Ratio: 99.89%) Bounded : 136 (Average: 15.99 Max: 27 Sum: 2175 Ratio: 0.11%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 235522 (Eliminated: 39 Frozen: 235483) Constraints : 2006710 (Binary: 98.4% Ternary: 0.7% Other: 0.9%) Memory Peak : 651MB Max. Length : 20 steps Models : 1 [endof: stats after solve call] Solving Time: 35.36s Memory: 651MB (+61MB) UNKNOWN Iteration Time: 37.11s Iteration 7 Queue: [(6,30,0,True)] Grounded Until: 25 Expected Memory: 759.0MB Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])] Grounding Time: 1.23s Memory: 651MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 8 Time : 166.174s (Solving: 138.17s 1st Model: 3.40s Unsat: 2.09s) CPU Time : 165.916s Choices : 3323038 (Domain: 3323002) Conflicts : 128878 (Analyzed: 128877) Restarts : 473 (Average: 272.47 Last: 610) Model-Level : 1000.0 Problems : 8 (Average Length: 17.62 Splits: 0) Lemmas : 128877 (Deleted: 113994) Binary : 938 (Ratio: 0.73%) Ternary : 674 (Ratio: 0.52%) Conflict : 128877 (Average Length: 1771.6 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 128877 (Average: 24.31 Max: 2237 Sum: 3133303) Executed : 128735 (Average: 24.29 Max: 2237 Sum: 3130936 Ratio: 99.92%) Bounded : 142 (Average: 16.67 Max: 32 Sum: 2367 Ratio: 0.08%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 284818 (Eliminated: 39 Frozen: 284779) Constraints : 2502557 (Binary: 98.4% Ternary: 0.7% Other: 0.9%) Memory Peak : 692MB Max. Length : 25 steps Models : 1 [endof: stats after solve call] Solving Time: 54.21s Memory: 682MB (+31MB) UNKNOWN Iteration Time: 56.01s Iteration 8 Queue: [(3,15,1,True), (4,20,1,True), (5,25,1,True), (6,30,1,True), (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), (14,70,0,True), (15,75,0,True), (16,80,0,True)] Grounded Until: 30 Blocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 9 Time : 171.055s (Solving: 142.97s 1st Model: 3.40s Unsat: 6.89s) CPU Time : 170.800s Choices : 3337557 (Domain: 3337521) Conflicts : 133786 (Analyzed: 133784) Restarts : 498 (Average: 268.64 Last: 610) Model-Level : 1000.0 Problems : 9 (Average Length: 19.22 Splits: 0) Lemmas : 133784 (Deleted: 113994) Binary : 997 (Ratio: 0.75%) Ternary : 708 (Ratio: 0.53%) Conflict : 133784 (Average Length: 1732.4 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 133784 (Average: 23.53 Max: 2237 Sum: 3147859) Executed : 133620 (Average: 23.51 Max: 2237 Sum: 3144943 Ratio: 99.91%) Bounded : 164 (Average: 17.78 Max: 32 Sum: 2916 Ratio: 0.09%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 284818 (Eliminated: 39 Frozen: 284779) Constraints : 2500691 (Binary: 98.4% Ternary: 0.7% Other: 0.9%) Memory Peak : 692MB Max. Length : 30 steps Models : 1 [endof: stats after solve call] Solving Time: 4.85s Memory: 682MB (+0MB) UNSAT Iteration Time: 4.89s Iteration 9 Queue: [(4,20,1,True), (5,25,1,True), (6,30,1,True), (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), (14,70,0,True), (15,75,0,True), (16,80,0,True)] Grounded Until: 30 Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 10 Time : 213.312s (Solving: 185.09s 1st Model: 3.40s Unsat: 6.89s) CPU Time : 213.076s Choices : 3618139 (Domain: 3618103) Conflicts : 161913 (Analyzed: 161911) Restarts : 598 (Average: 270.75 Last: 610) Model-Level : 1000.0 Problems : 10 (Average Length: 20.50 Splits: 0) Lemmas : 161911 (Deleted: 141338) Binary : 1136 (Ratio: 0.70%) Ternary : 815 (Ratio: 0.50%) Conflict : 161911 (Average Length: 1838.5 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 161911 (Average: 21.01 Max: 2237 Sum: 3401970) Executed : 161739 (Average: 20.99 Max: 2237 Sum: 3398798 Ratio: 99.91%) Bounded : 172 (Average: 18.44 Max: 32 Sum: 3172 Ratio: 0.09%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 284818 (Eliminated: 39 Frozen: 284779) Constraints : 2493843 (Binary: 98.4% Ternary: 0.7% Other: 0.9%) Memory Peak : 692MB Max. Length : 30 steps Models : 1 [endof: stats after solve call] Solving Time: 42.21s Memory: 682MB (+0MB) UNKNOWN Iteration Time: 42.28s Iteration 10 Queue: [(5,25,1,True), (6,30,1,True), (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), (14,70,0,True), (15,75,0,True), (16,80,0,True)] Grounded Until: 30 Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 11 Time : 254.404s (Solving: 226.09s 1st Model: 3.40s Unsat: 6.89s) CPU Time : 254.188s Choices : 4647168 (Domain: 4647132) Conflicts : 189982 (Analyzed: 189980) Restarts : 698 (Average: 272.18 Last: 610) Model-Level : 1000.0 Problems : 11 (Average Length: 21.55 Splits: 0) Lemmas : 189980 (Deleted: 167260) Binary : 1202 (Ratio: 0.63%) Ternary : 881 (Ratio: 0.46%) Conflict : 189980 (Average Length: 1848.7 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 189980 (Average: 23.05 Max: 2237 Sum: 4378651) Executed : 189806 (Average: 23.03 Max: 2237 Sum: 4375415 Ratio: 99.93%) Bounded : 174 (Average: 18.60 Max: 32 Sum: 3236 Ratio: 0.07%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 284818 (Eliminated: 39 Frozen: 284779) Constraints : 2491457 (Binary: 98.4% Ternary: 0.7% Other: 0.9%) Memory Peak : 692MB Max. Length : 30 steps Models : 1 [endof: stats after solve call] Solving Time: 41.07s Memory: 682MB (+0MB) UNKNOWN Iteration Time: 41.11s Iteration 11 Queue: [(6,30,1,True), (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), (14,70,0,True), (15,75,0,True), (16,80,0,True)] Grounded Until: 30 Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 12 Time : 312.951s (Solving: 284.52s 1st Model: 3.40s Unsat: 6.89s) CPU Time : 312.760s Choices : 6328104 (Domain: 6328068) Conflicts : 218066 (Analyzed: 218064) Restarts : 798 (Average: 273.26 Last: 610) Model-Level : 1000.0 Problems : 12 (Average Length: 22.42 Splits: 0) Lemmas : 218064 (Deleted: 198071) Binary : 1302 (Ratio: 0.60%) Ternary : 975 (Ratio: 0.45%) Conflict : 218064 (Average Length: 1968.2 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 218064 (Average: 27.39 Max: 2237 Sum: 5973495) Executed : 217881 (Average: 27.38 Max: 2237 Sum: 5970002 Ratio: 99.94%) Bounded : 183 (Average: 19.09 Max: 32 Sum: 3493 Ratio: 0.06%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 284818 (Eliminated: 39 Frozen: 284779) Constraints : 2491165 (Binary: 98.4% Ternary: 0.7% Other: 0.9%) Memory Peak : 810MB Max. Length : 30 steps Models : 1 [endof: stats after solve call] Solving Time: 58.51s Memory: 746MB (+64MB) UNKNOWN Iteration Time: 58.58s Iteration 12 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), (14,70,0,True), (15,75,0,True), (16,80,0,True)] Grounded Until: 30 Expected Memory: 854.0MB Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])] Grounding Time: 1.22s Memory: 755MB (+9MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 13 Time : 376.041s (Solving: 342.13s 1st Model: 3.40s Unsat: 6.89s) CPU Time : 375.880s Choices : 7483537 (Domain: 7483501) Conflicts : 246225 (Analyzed: 246223) Restarts : 898 (Average: 274.19 Last: 610) Model-Level : 1000.0 Problems : 13 (Average Length: 23.54 Splits: 0) Lemmas : 246223 (Deleted: 224792) Binary : 1386 (Ratio: 0.56%) Ternary : 1046 (Ratio: 0.42%) Conflict : 246223 (Average Length: 1972.6 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 246223 (Average: 28.73 Max: 2591 Sum: 7073646) Executed : 246020 (Average: 28.71 Max: 2591 Sum: 7069413 Ratio: 99.94%) Bounded : 203 (Average: 20.85 Max: 37 Sum: 4233 Ratio: 0.06%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 334114 (Eliminated: 39 Frozen: 334075) Constraints : 2988814 (Binary: 98.4% Ternary: 0.7% Other: 0.9%) Memory Peak : 810MB Max. Length : 30 steps Models : 1 [endof: stats after solve call] Solving Time: 61.33s Memory: 808MB (+53MB) UNKNOWN Iteration Time: 63.13s Iteration 13 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), (14,70,0,True), (15,75,0,True), (16,80,0,True)] Grounded Until: 35 Expected Memory: 916.0MB Grounding... [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])] Grounding Time: 1.22s Memory: 810MB (+2MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 14 Time : 442.815s (Solving: 403.38s 1st Model: 3.40s Unsat: 6.89s) CPU Time : 442.680s Choices : 8698020 (Domain: 8697984) Conflicts : 274311 (Analyzed: 274309) Restarts : 998 (Average: 274.86 Last: 610) Model-Level : 1000.0 Problems : 14 (Average Length: 24.86 Splits: 0) Lemmas : 274309 (Deleted: 252075) Binary : 1409 (Ratio: 0.51%) Ternary : 1072 (Ratio: 0.39%) Conflict : 274309 (Average Length: 2002.7 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 274309 (Average: 29.82 Max: 2591 Sum: 8179295) Executed : 274104 (Average: 29.80 Max: 2591 Sum: 8174978 Ratio: 99.95%) Bounded : 205 (Average: 21.06 Max: 42 Sum: 4317 Ratio: 0.05%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 383410 (Eliminated: 39 Frozen: 383371) Constraints : 3481880 (Binary: 98.4% Ternary: 0.7% Other: 0.9%) Memory Peak : 871MB Max. Length : 35 steps Models : 1 [endof: stats after solve call] Solving Time: 64.99s Memory: 852MB (+42MB) UNKNOWN Iteration Time: 66.81s Iteration 14 Queue: [(9,45,0,True), (10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True), (14,70,0,True), (15,75,0,True), (16,80,0,True)] Grounded Until: 40 Expected Memory: 960.0MB Grounding... [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])] Grounding Time: 1.56s Memory: 882MB (+30MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 15 Time : 526.200s (Solving: 480.86s 1st Model: 3.40s Unsat: 6.89s) CPU Time : 526.100s Choices : 10458027 (Domain: 10457991) Conflicts : 302397 (Analyzed: 302395) Restarts : 1098 (Average: 275.41 Last: 610) Model-Level : 1000.0 Problems : 15 (Average Length: 26.33 Splits: 0) Lemmas : 302395 (Deleted: 278399) Binary : 1433 (Ratio: 0.47%) Ternary : 1112 (Ratio: 0.37%) Conflict : 302395 (Average Length: 2168.3 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 302395 (Average: 32.47 Max: 5410 Sum: 9820124) Executed : 302190 (Average: 32.46 Max: 5410 Sum: 9815807 Ratio: 99.96%) Bounded : 205 (Average: 21.06 Max: 42 Sum: 4317 Ratio: 0.04%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 432706 (Eliminated: 39 Frozen: 432667) Constraints : 3982540 (Binary: 98.4% Ternary: 0.7% Other: 0.8%) Memory Peak : 987MB Max. Length : 40 steps Models : 1 [endof: stats after solve call] Solving Time: 81.24s Memory: 987MB (+105MB) UNKNOWN Iteration Time: 83.43s Iteration 15 Queue: [(10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True), (14,70,0,True), (15,75,0,True), (16,80,0,True)] Grounded Until: 45 Expected Memory: 1122.0MB Grounding... [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])] Grounding Time: 1.18s Memory: 989MB (+2MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 16 Time : 624.093s (Solving: 573.22s 1st Model: 3.40s Unsat: 6.89s) CPU Time : 624.032s Choices : 12603385 (Domain: 12603349) Conflicts : 330477 (Analyzed: 330475) Restarts : 1198 (Average: 275.86 Last: 610) Model-Level : 1000.0 Problems : 16 (Average Length: 27.94 Splits: 0) Lemmas : 330475 (Deleted: 306659) Binary : 1470 (Ratio: 0.44%) Ternary : 1149 (Ratio: 0.35%) Conflict : 330475 (Average Length: 2160.5 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 330475 (Average: 35.82 Max: 5410 Sum: 11838507) Executed : 330264 (Average: 35.81 Max: 5410 Sum: 11833878 Ratio: 99.96%) Bounded : 211 (Average: 21.94 Max: 52 Sum: 4629 Ratio: 0.04%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 482002 (Eliminated: 39 Frozen: 481963) Constraints : 4483300 (Binary: 98.4% Ternary: 0.7% Other: 0.8%) Memory Peak : 1062MB Max. Length : 45 steps Models : 1 [endof: stats after solve call] Solving Time: 96.12s Memory: 1057MB (+68MB) UNKNOWN Iteration Time: 97.95s Iteration 16 Queue: [(11,55,0,True), (12,60,0,True), (13,65,0,True), (14,70,0,True), (15,75,0,True), (16,80,0,True)] Grounded Until: 50 Expected Memory: 1192.0MB Grounding... [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])] Grounding Time: 1.20s Memory: 1057MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 17 Time : 723.795s (Solving: 667.31s 1st Model: 3.40s Unsat: 6.89s) CPU Time : 723.776s Choices : 14826034 (Domain: 14825998) Conflicts : 358557 (Analyzed: 358555) Restarts : 1298 (Average: 276.24 Last: 610) Model-Level : 1000.0 Problems : 17 (Average Length: 29.65 Splits: 0) Lemmas : 358555 (Deleted: 333893) Binary : 1491 (Ratio: 0.42%) Ternary : 1175 (Ratio: 0.33%) Conflict : 358555 (Average Length: 2206.6 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 358555 (Average: 38.84 Max: 5410 Sum: 13924632) Executed : 358339 (Average: 38.82 Max: 5410 Sum: 13919718 Ratio: 99.96%) Bounded : 216 (Average: 22.75 Max: 57 Sum: 4914 Ratio: 0.04%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 531298 (Eliminated: 39 Frozen: 531259) Constraints : 4983798 (Binary: 98.4% Ternary: 0.7% Other: 0.8%) Memory Peak : 1130MB Max. Length : 50 steps Models : 1 [endof: stats after solve call] Solving Time: 97.87s Memory: 1097MB (+40MB) UNKNOWN Iteration Time: 99.75s Iteration 17 Queue: [(12,60,0,True), (13,65,0,True), (14,70,0,True), (15,75,0,True), (16,80,0,True)] Grounded Until: 55 Expected Memory: 1232.0MB Grounding... [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])] Grounding Time: 1.20s Memory: 1097MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 18 Time : 809.389s (Solving: 747.26s 1st Model: 3.40s Unsat: 6.89s) CPU Time : 809.408s Choices : 16383343 (Domain: 16383307) Conflicts : 386666 (Analyzed: 386664) Restarts : 1398 (Average: 276.58 Last: 610) Model-Level : 1000.0 Problems : 18 (Average Length: 31.44 Splits: 0) Lemmas : 386664 (Deleted: 361340) Binary : 1535 (Ratio: 0.40%) Ternary : 1225 (Ratio: 0.32%) Conflict : 386664 (Average Length: 2307.8 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 386664 (Average: 39.63 Max: 5410 Sum: 15323544) Executed : 386447 (Average: 39.62 Max: 5410 Sum: 15318568 Ratio: 99.97%) Bounded : 217 (Average: 22.93 Max: 62 Sum: 4976 Ratio: 0.03%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 580594 (Eliminated: 39 Frozen: 580555) Constraints : 5480972 (Binary: 98.5% Ternary: 0.7% Other: 0.8%) Memory Peak : 1284MB Max. Length : 55 steps Models : 1 [endof: stats after solve call] Solving Time: 83.74s Memory: 1220MB (+123MB) UNKNOWN Iteration Time: 85.64s Iteration 18 Queue: [(13,65,0,True), (14,70,0,True), (15,75,0,True), (16,80,0,True)] Grounded Until: 60 Expected Memory: 1355.0MB Grounding... [('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('check', [65])] Grounding Time: 1.22s Memory: 1220MB (+0MB) Unblocking actions... Solving... *** Info : (planner): INTERRUPTED by signal! UNKNOWN INTERRUPTED : 1 Models : 0+ Calls : 19 Time : 886.557s (Solving: 818.74s 1st Model: 3.40s Unsat: 6.89s) CPU Time : 886.592s Choices : 18378383 (Domain: 18378347) Conflicts : 409919 (Analyzed: 409917) Restarts : 1481 (Average: 276.78 Last: 610) Model-Level : 1000.0 Problems : 19 (Average Length: 33.32 Splits: 0) Lemmas : 409917 (Deleted: 388743) Binary : 1544 (Ratio: 0.38%) Ternary : 1236 (Ratio: 0.30%) Conflict : 409917 (Average Length: 2342.7 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 409917 (Average: 41.87 Max: 5410 Sum: 17163291) Executed : 409695 (Average: 41.86 Max: 5410 Sum: 17157980 Ratio: 99.97%) Bounded : 222 (Average: 23.92 Max: 67 Sum: 5311 Ratio: 0.03%) Rules : 550485 (Original: 550450) Atoms : 169184 Bodies : 257373 (Original: 257337) Count : 573 (Original: 577) Equivalences : 131598 (Atom=Atom: 37 Body=Body: 0 Other: 131561) Tight : Yes Variables : 629890 (Eliminated: 39 Frozen: 629851) Constraints : 5981720 (Binary: 98.5% Ternary: 0.7% Other: 0.8%) Memory Peak : 1313MB Max. Length : 60 steps Models : 1