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-7.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-7.pddl Parsing... Parsing: [0.060s CPU, 0.055s wall-clock] Normalizing task... [0.000s CPU, 0.002s wall-clock] Instantiating... Generating Datalog program... [0.010s CPU, 0.014s wall-clock] Normalizing Datalog program... Normalizing Datalog program: [0.040s CPU, 0.038s wall-clock] Preparing model... [0.060s CPU, 0.065s wall-clock] Generated 46 rules. Computing model... [1.290s CPU, 1.286s wall-clock] 10863 relevant atoms 5844 auxiliary atoms 16707 final queue length 34683 total queue pushes Completing instantiation... [3.510s CPU, 3.491s wall-clock] Instantiating: [4.920s CPU, 4.910s wall-clock] Computing fact groups... Finding invariants... 12 initial candidates Finding invariants: [0.060s CPU, 0.064s wall-clock] Checking invariant weight... [0.000s CPU, 0.003s wall-clock] Instantiating groups... [0.050s CPU, 0.042s wall-clock] Collecting mutex groups... [0.010s CPU, 0.005s wall-clock] Choosing groups... 0 uncovered facts Choosing groups: [0.020s CPU, 0.017s wall-clock] Building translation key... [0.000s CPU, 0.010s wall-clock] Computing fact groups: [0.170s CPU, 0.179s wall-clock] Building STRIPS to SAS dictionary... [0.010s CPU, 0.005s wall-clock] Building dictionary for full mutex groups... [0.010s CPU, 0.004s wall-clock] Building mutex information... Building mutex information: [0.000s CPU, 0.005s wall-clock] Translating task... Processing axioms... Simplifying axioms... [0.000s CPU, 0.000s wall-clock] Processing axioms: [0.150s CPU, 0.154s wall-clock] Translating task: [2.900s CPU, 2.901s wall-clock] 0 effect conditions simplified 0 implied preconditions added Detecting unreachable propositions... 0 operators removed 0 axioms removed 34 propositions removed Detecting unreachable propositions: [1.520s CPU, 1.523s wall-clock] Reordering and filtering variables... 34 of 34 variables necessary. 0 of 34 mutex groups necessary. 9516 of 9516 operators necessary. 0 of 0 axiom rules necessary. Reordering and filtering variables: [0.440s CPU, 0.444s wall-clock] Translator variables: 34 Translator derived variables: 0 Translator facts: 790 Translator goal facts: 24 Translator mutex groups: 0 Translator total mutex groups size: 0 Translator operators: 9516 Translator axioms: 0 Translator task size: 57044 Translator peak memory: 73420 KB Writing output... [1.040s CPU, 1.114s wall-clock] Done! [11.200s CPU, 11.270s wall-clock] planner.py version 0.0.1 Time: 2.39s Memory: 207MB 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.781s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 2.408s 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 : 172544 Atoms : 172544 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 : 343MB Max. Length : 0 steps Models : 0 [endof: stats after solve call] Solving Time: 0.02s Memory: 279MB (+72MB) UNSAT Iteration Time: 0.02s 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: 279MB Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])] Grounding Time: 0.80s Memory: 279MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 2 Time : 5.609s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 5.236s 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 : 172544 Atoms : 172544 Bodies : 1 (Original: 0) Tight : Yes Variables : 45376 (Eliminated: 0 Frozen: 45376) Constraints : 89600 (Binary: 96.9% Ternary: 1.4% Other: 1.7%) Memory Peak : 343MB Max. Length : 0 steps Models : 0 [endof: stats after solve call] Solving Time: 1.59s Memory: 289MB (+10MB) UNSAT Iteration Time: 2.83s 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: 299.0MB Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])] Grounding Time: 0.73s Memory: 294MB (+5MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 3 Time : 18.096s (Solving: 8.66s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 17.728s Choices : 135829 (Domain: 135829) Conflicts : 28099 (Analyzed: 28099) Restarts : 100 (Average: 280.99 Last: 200) Problems : 3 (Average Length: 7.00 Splits: 0) Lemmas : 28099 (Deleted: 17045) Binary : 346 (Ratio: 1.23%) Ternary : 175 (Ratio: 0.62%) Conflict : 28099 (Average Length: 796.9 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 28099 (Average: 4.58 Max: 312 Sum: 128648) Executed : 28073 (Average: 4.58 Max: 312 Sum: 128600 Ratio: 99.96%) Bounded : 26 (Average: 1.85 Max: 12 Sum: 48 Ratio: 0.04%) Rules : 172544 Atoms : 172544 Bodies : 1 (Original: 0) Tight : Yes Variables : 99506 (Eliminated: 0 Frozen: 99506) Constraints : 502683 (Binary: 97.9% Ternary: 1.0% Other: 1.1%) Memory Peak : 343MB Max. Length : 5 steps Models : 0 [endof: stats after solve call] Solving Time: 11.32s Memory: 323MB (+29MB) UNKNOWN Iteration Time: 12.50s Iteration 4 Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] Grounded Until: 10 Expected Memory: 357.0MB Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])] Grounding Time: 0.81s Memory: 339MB (+16MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 4 Time : 32.619s (Solving: 19.10s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 32.256s Choices : 409380 (Domain: 409380) Conflicts : 56173 (Analyzed: 56173) Restarts : 200 (Average: 280.87 Last: 200) Problems : 4 (Average Length: 9.50 Splits: 0) Lemmas : 56173 (Deleted: 43600) Binary : 564 (Ratio: 1.00%) Ternary : 394 (Ratio: 0.70%) Conflict : 56173 (Average Length: 873.5 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 56173 (Average: 6.61 Max: 616 Sum: 371145) Executed : 56142 (Average: 6.61 Max: 616 Sum: 371092 Ratio: 99.99%) Bounded : 31 (Average: 1.71 Max: 12 Sum: 53 Ratio: 0.01%) Rules : 172544 Atoms : 172544 Bodies : 1 (Original: 0) Tight : Yes Variables : 155167 (Eliminated: 0 Frozen: 155167) Constraints : 933270 (Binary: 98.0% Ternary: 1.0% Other: 1.1%) Memory Peak : 508MB Max. Length : 10 steps Models : 0 [endof: stats after solve call] Solving Time: 13.27s Memory: 444MB (+105MB) UNKNOWN Iteration Time: 14.54s Iteration 5 Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)] Grounded Until: 15 Expected Memory: 565.0MB Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])] Grounding Time: 0.92s Memory: 469MB (+25MB) Unblocking actions... Solving... [start: stats after solve call] Models : 1+ Calls : 5 Time : 37.761s (Solving: 20.03s 1st Model: 0.91s Unsat: 0.00s) CPU Time : 37.400s Choices : 453372 (Domain: 453336) Conflicts : 57440 (Analyzed: 57440) Restarts : 207 (Average: 277.49 Last: 200) Model-Level : 1078.0 Problems : 5 (Average Length: 12.00 Splits: 0) Lemmas : 57440 (Deleted: 43600) Binary : 602 (Ratio: 1.05%) Ternary : 413 (Ratio: 0.72%) Conflict : 57440 (Average Length: 860.7 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 57440 (Average: 7.12 Max: 848 Sum: 408847) Executed : 57405 (Average: 7.12 Max: 848 Sum: 408790 Ratio: 99.99%) Bounded : 35 (Average: 1.63 Max: 12 Sum: 57 Ratio: 0.01%) Rules : 172544 Atoms : 172544 Bodies : 1 (Original: 0) Tight : Yes Variables : 210828 (Eliminated: 0 Frozen: 210828) Constraints : 1363875 (Binary: 98.0% Ternary: 0.9% Other: 1.0%) Memory Peak : 508MB Max. Length : 15 steps Models : 1 [endof: stats after solve call] Solving Time: 3.76s Memory: 497MB (+28MB) SAT Testing... NOT SERIALIZABLE Testing Time: 3.42s Memory: 590MB (+93MB) Solving... [start: stats after solve call] Models : 0+ Calls : 6 Time : 86.669s (Solving: 66.60s 1st Model: 0.91s Unsat: 0.00s) CPU Time : 86.328s Choices : 1610324 (Domain: 1610288) Conflicts : 85521 (Analyzed: 85521) Restarts : 307 (Average: 278.57 Last: 201) Model-Level : 1078.0 Problems : 6 (Average Length: 13.67 Splits: 0) Lemmas : 85521 (Deleted: 71712) Binary : 921 (Ratio: 1.08%) Ternary : 709 (Ratio: 0.83%) Conflict : 85521 (Average Length: 787.7 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 85521 (Average: 17.77 Max: 1103 Sum: 1519485) Executed : 85382 (Average: 17.74 Max: 1103 Sum: 1517140 Ratio: 99.85%) Bounded : 139 (Average: 16.87 Max: 22 Sum: 2345 Ratio: 0.15%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 212174 (Eliminated: 54 Frozen: 212120) Constraints : 1807180 (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: 47.58s Memory: 569MB (+-21MB) UNKNOWN Iteration Time: 56.15s Iteration 6 Queue: [(5,25,0,True), (6,30,0,True)] Grounded Until: 20 Expected Memory: 690.0MB Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])] Grounding Time: 1.36s Memory: 569MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 7 Time : 136.677s (Solving: 109.99s 1st Model: 0.91s Unsat: 0.00s) CPU Time : 136.356s Choices : 2781864 (Domain: 2781828) Conflicts : 113627 (Analyzed: 113627) Restarts : 407 (Average: 279.18 Last: 201) Model-Level : 1078.0 Problems : 7 (Average Length: 15.57 Splits: 0) Lemmas : 113627 (Deleted: 98447) Binary : 1054 (Ratio: 0.93%) Ternary : 814 (Ratio: 0.72%) Conflict : 113627 (Average Length: 903.5 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 113627 (Average: 23.27 Max: 2553 Sum: 2644482) Executed : 113451 (Average: 23.24 Max: 2553 Sum: 2641138 Ratio: 99.87%) Bounded : 176 (Average: 19.00 Max: 27 Sum: 3344 Ratio: 0.13%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 268175 (Eliminated: 54 Frozen: 268121) Constraints : 2324721 (Binary: 98.4% Ternary: 0.7% Other: 0.9%) Memory Peak : 646MB Max. Length : 20 steps Models : 1 [endof: stats after solve call] Solving Time: 48.08s Memory: 646MB (+77MB) UNKNOWN Iteration Time: 50.04s Iteration 7 Queue: [(6,30,0,True)] Grounded Until: 25 Expected Memory: 767.0MB Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])] Grounding Time: 1.39s Memory: 646MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 8 Time : 200.553s (Solving: 167.20s 1st Model: 0.91s Unsat: 0.00s) CPU Time : 200.260s Choices : 4159970 (Domain: 4159934) Conflicts : 141703 (Analyzed: 141703) Restarts : 507 (Average: 279.49 Last: 201) Model-Level : 1078.0 Problems : 8 (Average Length: 17.62 Splits: 0) Lemmas : 141703 (Deleted: 125421) Binary : 1179 (Ratio: 0.83%) Ternary : 924 (Ratio: 0.65%) Conflict : 141703 (Average Length: 1071.8 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 141703 (Average: 27.92 Max: 2568 Sum: 3956357) Executed : 141514 (Average: 27.89 Max: 2568 Sum: 3952597 Ratio: 99.90%) Bounded : 189 (Average: 19.89 Max: 32 Sum: 3760 Ratio: 0.10%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 324176 (Eliminated: 54 Frozen: 324122) Constraints : 2881942 (Binary: 98.4% Ternary: 0.7% Other: 0.8%) Memory Peak : 686MB Max. Length : 25 steps Models : 1 [endof: stats after solve call] Solving Time: 61.91s Memory: 672MB (+26MB) UNKNOWN Iteration Time: 63.91s Iteration 8 Queue: [(2,10,1,True), (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)] Grounded Until: 30 Blocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 9 Time : 200.719s (Solving: 167.27s 1st Model: 0.91s Unsat: 0.07s) CPU Time : 200.424s Choices : 4160007 (Domain: 4159971) Conflicts : 141720 (Analyzed: 141719) Restarts : 507 (Average: 279.52 Last: 201) Model-Level : 1078.0 Problems : 9 (Average Length: 19.22 Splits: 0) Lemmas : 141719 (Deleted: 125421) Binary : 1180 (Ratio: 0.83%) Ternary : 924 (Ratio: 0.65%) Conflict : 141719 (Average Length: 1071.7 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 141719 (Average: 27.92 Max: 2568 Sum: 3956522) Executed : 141526 (Average: 27.89 Max: 2568 Sum: 3952634 Ratio: 99.90%) Bounded : 193 (Average: 20.15 Max: 32 Sum: 3888 Ratio: 0.10%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 324176 (Eliminated: 54 Frozen: 324122) Constraints : 2874467 (Binary: 98.4% Ternary: 0.7% Other: 0.8%) Memory Peak : 686MB Max. Length : 30 steps Models : 1 [endof: stats after solve call] Solving Time: 0.13s Memory: 672MB (+0MB) UNSAT Iteration Time: 0.17s Iteration 9 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)] Grounded Until: 30 Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 10 Time : 217.514s (Solving: 183.96s 1st Model: 0.91s Unsat: 16.76s) CPU Time : 217.228s Choices : 4218024 (Domain: 4217988) Conflicts : 156757 (Analyzed: 156755) Restarts : 568 (Average: 275.98 Last: 584) Model-Level : 1078.0 Problems : 10 (Average Length: 20.50 Splits: 0) Lemmas : 156755 (Deleted: 141080) Binary : 1298 (Ratio: 0.83%) Ternary : 1002 (Ratio: 0.64%) Conflict : 156755 (Average Length: 1071.0 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 156755 (Average: 25.59 Max: 2568 Sum: 4012140) Executed : 156537 (Average: 25.57 Max: 2568 Sum: 4007700 Ratio: 99.89%) Bounded : 218 (Average: 20.37 Max: 32 Sum: 4440 Ratio: 0.11%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 324176 (Eliminated: 54 Frozen: 324122) Constraints : 2874267 (Binary: 98.4% Ternary: 0.7% Other: 0.8%) Memory Peak : 686MB Max. Length : 30 steps Models : 1 [endof: stats after solve call] Solving Time: 16.76s Memory: 672MB (+0MB) UNSAT Iteration Time: 16.81s Iteration 10 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)] Grounded Until: 30 Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 11 Time : 257.458s (Solving: 223.78s 1st Model: 0.91s Unsat: 16.76s) CPU Time : 257.188s Choices : 5205129 (Domain: 5205093) Conflicts : 184826 (Analyzed: 184824) Restarts : 668 (Average: 276.68 Last: 584) Model-Level : 1078.0 Problems : 11 (Average Length: 21.55 Splits: 0) Lemmas : 184824 (Deleted: 165394) Binary : 1428 (Ratio: 0.77%) Ternary : 1187 (Ratio: 0.64%) Conflict : 184824 (Average Length: 1065.9 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 184824 (Average: 26.78 Max: 2568 Sum: 4950466) Executed : 184590 (Average: 26.76 Max: 2568 Sum: 4945514 Ratio: 99.90%) Bounded : 234 (Average: 21.16 Max: 32 Sum: 4952 Ratio: 0.10%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 324176 (Eliminated: 54 Frozen: 324122) Constraints : 2870392 (Binary: 98.4% Ternary: 0.7% Other: 0.8%) Memory Peak : 686MB Max. Length : 30 steps Models : 1 [endof: stats after solve call] Solving Time: 39.91s Memory: 672MB (+0MB) UNKNOWN Iteration Time: 39.97s Iteration 11 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)] Grounded Until: 30 Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 12 Time : 315.128s (Solving: 281.35s 1st Model: 0.91s Unsat: 16.76s) CPU Time : 314.880s Choices : 6958275 (Domain: 6958239) Conflicts : 212973 (Analyzed: 212971) Restarts : 768 (Average: 277.31 Last: 584) Model-Level : 1078.0 Problems : 12 (Average Length: 22.42 Splits: 0) Lemmas : 212971 (Deleted: 190328) Binary : 1587 (Ratio: 0.75%) Ternary : 1424 (Ratio: 0.67%) Conflict : 212971 (Average Length: 1046.3 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 212971 (Average: 31.11 Max: 2568 Sum: 6625864) Executed : 212725 (Average: 31.09 Max: 2568 Sum: 6620528 Ratio: 99.92%) Bounded : 246 (Average: 21.69 Max: 32 Sum: 5336 Ratio: 0.08%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 324176 (Eliminated: 54 Frozen: 324122) Constraints : 2868994 (Binary: 98.4% Ternary: 0.7% Other: 0.8%) Memory Peak : 686MB Max. Length : 30 steps Models : 1 [endof: stats after solve call] Solving Time: 57.65s Memory: 672MB (+0MB) UNKNOWN Iteration Time: 57.70s Iteration 12 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)] Grounded Until: 30 Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 13 Time : 387.097s (Solving: 353.21s 1st Model: 0.91s Unsat: 16.76s) CPU Time : 386.880s Choices : 9124263 (Domain: 9124227) Conflicts : 241053 (Analyzed: 241051) Restarts : 868 (Average: 277.71 Last: 584) Model-Level : 1078.0 Problems : 13 (Average Length: 23.15 Splits: 0) Lemmas : 241051 (Deleted: 213965) Binary : 1753 (Ratio: 0.73%) Ternary : 1581 (Ratio: 0.66%) Conflict : 241051 (Average Length: 1045.2 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 241051 (Average: 36.05 Max: 2568 Sum: 8688897) Executed : 240794 (Average: 36.02 Max: 2568 Sum: 8683209 Ratio: 99.93%) Bounded : 257 (Average: 22.13 Max: 32 Sum: 5688 Ratio: 0.07%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 324176 (Eliminated: 54 Frozen: 324122) Constraints : 2865302 (Binary: 98.4% Ternary: 0.7% Other: 0.8%) Memory Peak : 686MB Max. Length : 30 steps Models : 1 [endof: stats after solve call] Solving Time: 71.95s Memory: 672MB (+0MB) UNKNOWN Iteration Time: 72.00s Iteration 13 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)] Grounded Until: 30 Expected Memory: 793.0MB Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])] Grounding Time: 1.45s Memory: 679MB (+7MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 14 Time : 435.676s (Solving: 394.98s 1st Model: 0.91s Unsat: 16.76s) CPU Time : 435.480s Choices : 10076703 (Domain: 10076667) Conflicts : 269176 (Analyzed: 269174) Restarts : 968 (Average: 278.07 Last: 584) Model-Level : 1078.0 Problems : 14 (Average Length: 24.14 Splits: 0) Lemmas : 269174 (Deleted: 245223) Binary : 1791 (Ratio: 0.67%) Ternary : 1600 (Ratio: 0.59%) Conflict : 269174 (Average Length: 1199.6 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 269174 (Average: 35.36 Max: 2568 Sum: 9518987) Executed : 268912 (Average: 35.34 Max: 2568 Sum: 9513114 Ratio: 99.94%) Bounded : 262 (Average: 22.42 Max: 37 Sum: 5873 Ratio: 0.06%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 380177 (Eliminated: 54 Frozen: 380123) Constraints : 3432627 (Binary: 98.5% Ternary: 0.7% Other: 0.8%) Memory Peak : 942MB Max. Length : 30 steps Models : 1 [endof: stats after solve call] Solving Time: 46.48s Memory: 878MB (+199MB) UNKNOWN Iteration Time: 48.61s Iteration 14 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)] Grounded Until: 35 Expected Memory: 1084.0MB Grounding... [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])] Grounding Time: 1.78s Memory: 904MB (+26MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 15 Time : 522.041s (Solving: 474.16s 1st Model: 0.91s Unsat: 16.76s) CPU Time : 521.884s Choices : 12427705 (Domain: 12427669) Conflicts : 297317 (Analyzed: 297315) Restarts : 1068 (Average: 278.38 Last: 584) Model-Level : 1078.0 Problems : 15 (Average Length: 25.33 Splits: 0) Lemmas : 297315 (Deleted: 268870) Binary : 1925 (Ratio: 0.65%) Ternary : 1720 (Ratio: 0.58%) Conflict : 297315 (Average Length: 1256.2 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 297315 (Average: 39.44 Max: 2782 Sum: 11726629) Executed : 297047 (Average: 39.42 Max: 2782 Sum: 11720545 Ratio: 99.95%) Bounded : 268 (Average: 22.70 Max: 42 Sum: 6084 Ratio: 0.05%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 436178 (Eliminated: 54 Frozen: 436124) Constraints : 4003386 (Binary: 98.5% Ternary: 0.7% Other: 0.8%) Memory Peak : 963MB Max. Length : 35 steps Models : 1 [endof: stats after solve call] Solving Time: 83.94s Memory: 942MB (+38MB) UNKNOWN Iteration Time: 86.42s Iteration 15 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)] Grounded Until: 40 Expected Memory: 1148.0MB Grounding... [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])] Grounding Time: 1.40s Memory: 952MB (+10MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 16 Time : 602.091s (Solving: 547.39s 1st Model: 0.91s Unsat: 16.76s) CPU Time : 601.968s Choices : 14589704 (Domain: 14589668) Conflicts : 325420 (Analyzed: 325418) Restarts : 1168 (Average: 278.61 Last: 584) Model-Level : 1078.0 Problems : 16 (Average Length: 26.69 Splits: 0) Lemmas : 325418 (Deleted: 299533) Binary : 2018 (Ratio: 0.62%) Ternary : 1818 (Ratio: 0.56%) Conflict : 325418 (Average Length: 1354.6 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 325418 (Average: 42.20 Max: 5251 Sum: 13734240) Executed : 325134 (Average: 42.18 Max: 5251 Sum: 13727404 Ratio: 99.95%) Bounded : 284 (Average: 24.07 Max: 47 Sum: 6836 Ratio: 0.05%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 492179 (Eliminated: 54 Frozen: 492125) Constraints : 4574143 (Binary: 98.5% Ternary: 0.7% Other: 0.8%) Memory Peak : 1026MB Max. Length : 40 steps Models : 1 [endof: stats after solve call] Solving Time: 77.98s Memory: 998MB (+46MB) UNKNOWN Iteration Time: 80.10s Iteration 16 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)] Grounded Until: 45 Expected Memory: 1204.0MB Grounding... [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])] Grounding Time: 1.40s Memory: 999MB (+1MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 17 Time : 704.600s (Solving: 643.02s 1st Model: 0.91s Unsat: 16.76s) CPU Time : 704.520s Choices : 17156877 (Domain: 17156841) Conflicts : 353527 (Analyzed: 353525) Restarts : 1268 (Average: 278.81 Last: 584) Model-Level : 1078.0 Problems : 17 (Average Length: 28.18 Splits: 0) Lemmas : 353525 (Deleted: 326672) Binary : 2071 (Ratio: 0.59%) Ternary : 1891 (Ratio: 0.53%) Conflict : 353525 (Average Length: 1431.1 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 353525 (Average: 45.68 Max: 5251 Sum: 16148325) Executed : 353237 (Average: 45.66 Max: 5251 Sum: 16141281 Ratio: 99.96%) Bounded : 288 (Average: 24.46 Max: 52 Sum: 7044 Ratio: 0.04%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 548180 (Eliminated: 54 Frozen: 548126) Constraints : 5143534 (Binary: 98.5% Ternary: 0.7% Other: 0.8%) Memory Peak : 1085MB Max. Length : 45 steps Models : 1 [endof: stats after solve call] Solving Time: 100.39s Memory: 1085MB (+86MB) UNKNOWN Iteration Time: 102.56s Iteration 17 Queue: [(11,55,0,True), (12,60,0,True), (13,65,0,True), (14,70,0,True), (15,75,0,True)] Grounded Until: 50 Expected Memory: 1291.0MB Grounding... [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])] Grounding Time: 1.40s Memory: 1085MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 18 Time : 827.283s (Solving: 758.80s 1st Model: 0.91s Unsat: 16.76s) CPU Time : 827.256s Choices : 20036800 (Domain: 20036764) Conflicts : 381618 (Analyzed: 381616) Restarts : 1368 (Average: 278.96 Last: 584) Model-Level : 1078.0 Problems : 18 (Average Length: 29.78 Splits: 0) Lemmas : 381616 (Deleted: 353803) Binary : 2120 (Ratio: 0.56%) Ternary : 1944 (Ratio: 0.51%) Conflict : 381616 (Average Length: 1572.3 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 381616 (Average: 49.33 Max: 5251 Sum: 18823361) Executed : 381321 (Average: 49.31 Max: 5251 Sum: 18815918 Ratio: 99.96%) Bounded : 295 (Average: 25.23 Max: 57 Sum: 7443 Ratio: 0.04%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 604181 (Eliminated: 54 Frozen: 604127) Constraints : 5714083 (Binary: 98.5% Ternary: 0.7% Other: 0.8%) Memory Peak : 1188MB Max. Length : 50 steps Models : 1 [endof: stats after solve call] Solving Time: 120.58s Memory: 1188MB (+103MB) UNKNOWN Iteration Time: 122.75s Iteration 18 Queue: [(12,60,0,True), (13,65,0,True), (14,70,0,True), (15,75,0,True)] Grounded Until: 55 Expected Memory: 1394.0MB Grounding... [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])] Grounding Time: 1.42s Memory: 1191MB (+3MB) Unblocking actions... Solving... *** Info : (planner): INTERRUPTED by signal! UNKNOWN INTERRUPTED : 1 Models : 0+ Calls : 19 Time : 884.614s (Solving: 809.16s 1st Model: 0.91s Unsat: 16.76s) CPU Time : 884.588s Choices : 21451154 (Domain: 21451118) Conflicts : 402790 (Analyzed: 402788) Restarts : 1443 (Average: 279.13 Last: 584) Model-Level : 1078.0 Problems : 19 (Average Length: 31.47 Splits: 0) Lemmas : 402788 (Deleted: 381447) Binary : 2139 (Ratio: 0.53%) Ternary : 1966 (Ratio: 0.49%) Conflict : 402788 (Average Length: 1690.5 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 402788 (Average: 49.86 Max: 5251 Sum: 20083059) Executed : 402492 (Average: 49.84 Max: 5251 Sum: 20075554 Ratio: 99.96%) Bounded : 296 (Average: 25.35 Max: 62 Sum: 7505 Ratio: 0.04%) Rules : 634015 (Original: 633966) Atoms : 192718 Bodies : 297496 (Original: 297446) Count : 629 (Original: 634) Equivalences : 151645 (Atom=Atom: 33 Body=Body: 0 Other: 151612) Tight : Yes Variables : 660182 (Eliminated: 54 Frozen: 660128) Constraints : 6284298 (Binary: 98.5% Ternary: 0.7% Other: 0.8%) Memory Peak : 1287MB Max. Length : 55 steps Models : 1