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-87.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-87.pddl Parsing... Parsing: [0.010s CPU, 0.020s wall-clock] Normalizing task... [0.010s CPU, 0.002s wall-clock] Instantiating... Generating Datalog program... [0.000s CPU, 0.007s wall-clock] Normalizing Datalog program... Normalizing Datalog program: [0.010s CPU, 0.012s wall-clock] Preparing model... [0.020s CPU, 0.016s wall-clock] Generated 21 rules. Computing model... [0.690s CPU, 0.693s wall-clock] 5893 relevant atoms 3913 auxiliary atoms 9806 final queue length 17293 total queue pushes Completing instantiation... [1.250s CPU, 1.246s wall-clock] Instantiating: [1.980s CPU, 1.983s wall-clock] Computing fact groups... Finding invariants... 10 initial candidates Finding invariants: [0.020s CPU, 0.022s wall-clock] Checking invariant weight... [0.010s CPU, 0.006s wall-clock] Instantiating groups... [0.070s CPU, 0.072s wall-clock] Collecting mutex groups... [0.010s CPU, 0.015s wall-clock] Choosing groups... 44 uncovered facts Choosing groups: [0.080s CPU, 0.077s wall-clock] Building translation key... [0.020s CPU, 0.025s wall-clock] Computing fact groups: [0.400s CPU, 0.404s wall-clock] Building STRIPS to SAS dictionary... [0.020s CPU, 0.012s wall-clock] Building dictionary for full mutex groups... [0.020s CPU, 0.028s wall-clock] Building mutex information... Building mutex information: [0.050s CPU, 0.042s wall-clock] Translating task... Processing axioms... Simplifying axioms... [0.000s CPU, 0.000s wall-clock] Processing axioms: [0.060s CPU, 0.063s wall-clock] Translating task: [1.510s CPU, 1.508s wall-clock] 5504 effect conditions simplified 0 implied preconditions added Detecting unreachable propositions... 0 operators removed 0 axioms removed 86 propositions removed Detecting unreachable propositions: [0.780s CPU, 0.788s wall-clock] Reordering and filtering variables... 87 of 87 variables necessary. 44 of 87 mutex groups necessary. 3698 of 3698 operators necessary. 0 of 0 axiom rules necessary. Reordering and filtering variables: [0.540s CPU, 0.534s wall-clock] Translator variables: 87 Translator derived variables: 0 Translator facts: 1980 Translator goal facts: 42 Translator mutex groups: 44 Translator total mutex groups size: 1936 Translator operators: 3698 Translator axioms: 0 Translator task size: 31651 Translator peak memory: 55244 KB Writing output... [0.540s CPU, 0.578s wall-clock] Done! [5.920s CPU, 5.968s wall-clock] planner.py version 0.0.1 Time: 1.13s Memory: 116MB 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 : 1.317s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 1.140s 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 : 96986 Atoms : 96986 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 : 252MB Max. Length : 0 steps Models : 0 [endof: stats after solve call] Solving Time: 0.01s Memory: 188MB (+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: 188MB Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])] Grounding Time: 0.48s Memory: 197MB (+9MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 2 Time : 2.311s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 2.136s 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 : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 25596 (Eliminated: 0 Frozen: 25596) Constraints : 13898 (Binary: 93.7% Ternary: 4.0% Other: 2.3%) Memory Peak : 252MB Max. Length : 0 steps Models : 0 [endof: stats after solve call] Solving Time: 0.34s Memory: 206MB (+9MB) UNSAT Iteration Time: 1.00s 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: 224.0MB Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])] Grounding Time: 0.50s Memory: 223MB (+17MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 3 Time : 3.433s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 3.260s Choices : 0 Conflicts : 0 (Analyzed: 0) Restarts : 0 Problems : 3 (Average Length: 7.00 Splits: 0) Lemmas : 0 (Deleted: 0) Binary : 0 (Ratio: 0.00%) Ternary : 0 (Ratio: 0.00%) Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 51982 (Eliminated: 0 Frozen: 51982) Constraints : 81706 (Binary: 94.6% Ternary: 4.1% Other: 1.3%) Memory Peak : 252MB Max. Length : 5 steps Models : 0 [endof: stats after solve call] Solving Time: 0.41s Memory: 232MB (+9MB) UNSAT Iteration Time: 1.13s Iteration 4 Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] Grounded Until: 10 Expected Memory: 258.0MB Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])] Grounding Time: 0.58s Memory: 251MB (+19MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 4 Time : 4.848s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 4.676s Choices : 0 Conflicts : 0 (Analyzed: 0) Restarts : 0 Problems : 4 (Average Length: 9.50 Splits: 0) Lemmas : 0 (Deleted: 0) Binary : 0 (Ratio: 0.00%) Ternary : 0 (Ratio: 0.00%) Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 79397 (Eliminated: 0 Frozen: 79397) Constraints : 219943 (Binary: 94.9% Ternary: 4.1% Other: 1.0%) Memory Peak : 264MB Max. Length : 10 steps Models : 0 [endof: stats after solve call] Solving Time: 0.59s Memory: 264MB (+13MB) UNSAT Iteration Time: 1.42s Iteration 5 Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)] Grounded Until: 15 Expected Memory: 296.0MB Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])] Grounding Time: 0.53s Memory: 281MB (+17MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 5 Time : 6.506s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 6.332s Choices : 0 Conflicts : 1 (Analyzed: 0) Restarts : 0 Problems : 5 (Average Length: 12.00 Splits: 0) Lemmas : 0 (Deleted: 0) Binary : 0 (Ratio: 0.00%) Ternary : 0 (Ratio: 0.00%) Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 108178 (Eliminated: 0 Frozen: 108178) Constraints : 430588 (Binary: 95.1% Ternary: 4.2% Other: 0.8%) Memory Peak : 298MB Max. Length : 15 steps Models : 0 [endof: stats after solve call] Solving Time: 0.86s Memory: 297MB (+16MB) UNSAT Iteration Time: 1.66s Iteration 6 Queue: [(5,25,0,True), (6,30,0,True)] Grounded Until: 20 Expected Memory: 330.0MB Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])] Grounding Time: 0.70s Memory: 321MB (+24MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 6 Time : 8.413s (Solving: 0.01s 1st Model: 0.00s Unsat: 0.01s) CPU Time : 8.240s Choices : 0 Conflicts : 2 (Analyzed: 0) Restarts : 0 Problems : 6 (Average Length: 14.50 Splits: 0) Lemmas : 0 (Deleted: 0) Binary : 0 (Ratio: 0.00%) Ternary : 0 (Ratio: 0.00%) Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 137669 (Eliminated: 0 Frozen: 137669) Constraints : 663048 (Binary: 95.1% Ternary: 4.2% Other: 0.7%) Memory Peak : 345MB Max. Length : 20 steps Models : 0 [endof: stats after solve call] Solving Time: 0.98s Memory: 345MB (+24MB) UNSAT Iteration Time: 1.92s Iteration 7 Queue: [(6,30,0,True)] Grounded Until: 25 Expected Memory: 393.0MB Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])] Grounding Time: 0.52s Memory: 351MB (+6MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 7 Time : 10.153s (Solving: 0.02s 1st Model: 0.00s Unsat: 0.02s) CPU Time : 9.980s Choices : 0 Conflicts : 3 (Analyzed: 0) Restarts : 0 Problems : 7 (Average Length: 17.00 Splits: 0) Lemmas : 0 (Deleted: 0) Binary : 0 (Ratio: 0.00%) Ternary : 0 (Ratio: 0.00%) Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 167160 (Eliminated: 0 Frozen: 167160) Constraints : 895508 (Binary: 95.1% Ternary: 4.2% Other: 0.7%) Memory Peak : 376MB Max. Length : 25 steps Models : 0 [endof: stats after solve call] Solving Time: 0.98s Memory: 367MB (+16MB) UNSAT Iteration Time: 1.75s 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: 415.0MB Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])] Grounding Time: 0.53s Memory: 381MB (+14MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 8 Time : 11.934s (Solving: 0.04s 1st Model: 0.00s Unsat: 0.04s) CPU Time : 11.760s Choices : 0 Conflicts : 4 (Analyzed: 0) Restarts : 0 Problems : 8 (Average Length: 19.50 Splits: 0) Lemmas : 0 (Deleted: 0) Binary : 0 (Ratio: 0.00%) Ternary : 0 (Ratio: 0.00%) Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 196651 (Eliminated: 0 Frozen: 196651) Constraints : 1127968 (Binary: 95.1% Ternary: 4.2% Other: 0.6%) Memory Peak : 408MB Max. Length : 30 steps Models : 0 [endof: stats after solve call] Solving Time: 0.99s Memory: 407MB (+26MB) UNSAT Iteration Time: 1.79s 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: 455.0MB Grounding... [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])] Grounding Time: 0.54s Memory: 416MB (+9MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 9 Time : 13.746s (Solving: 0.06s 1st Model: 0.00s Unsat: 0.06s) CPU Time : 13.576s Choices : 0 Conflicts : 5 (Analyzed: 0) Restarts : 0 Problems : 9 (Average Length: 22.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 : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 226142 (Eliminated: 0 Frozen: 226142) Constraints : 1360428 (Binary: 95.1% Ternary: 4.2% Other: 0.6%) Memory Peak : 453MB Max. Length : 35 steps Models : 0 [endof: stats after solve call] Solving Time: 1.01s Memory: 438MB (+22MB) UNSAT Iteration Time: 1.82s 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: 486.0MB Grounding... [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])] Grounding Time: 0.55s Memory: 444MB (+6MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 10 Time : 15.604s (Solving: 0.10s 1st Model: 0.00s Unsat: 0.10s) CPU Time : 15.436s Choices : 0 Conflicts : 6 (Analyzed: 0) Restarts : 0 Problems : 10 (Average Length: 24.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 : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 255633 (Eliminated: 0 Frozen: 255633) Constraints : 1592888 (Binary: 95.1% Ternary: 4.2% Other: 0.6%) Memory Peak : 481MB Max. Length : 40 steps Models : 0 [endof: stats after solve call] Solving Time: 1.03s Memory: 461MB (+17MB) UNSAT Iteration Time: 1.87s Iteration 11 Queue: [(10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)] Grounded Until: 45 Expected Memory: 509.0MB Grounding... [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])] Grounding Time: 0.57s Memory: 468MB (+7MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 11 Time : 17.501s (Solving: 0.13s 1st Model: 0.00s Unsat: 0.13s) CPU Time : 17.332s Choices : 0 Conflicts : 7 (Analyzed: 0) Restarts : 0 Problems : 11 (Average Length: 27.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 : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 285124 (Eliminated: 0 Frozen: 285124) Constraints : 1825348 (Binary: 95.2% Ternary: 4.2% Other: 0.6%) Memory Peak : 506MB Max. Length : 45 steps Models : 0 [endof: stats after solve call] Solving Time: 1.03s Memory: 485MB (+17MB) UNSAT Iteration Time: 1.91s Iteration 12 Queue: [(11,55,0,True), (12,60,0,True), (13,65,0,True)] Grounded Until: 50 Expected Memory: 533.0MB Grounding... [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])] Grounding Time: 1.02s Memory: 517MB (+32MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 12 Time : 19.896s (Solving: 0.17s 1st Model: 0.00s Unsat: 0.17s) CPU Time : 19.732s Choices : 0 Conflicts : 8 (Analyzed: 0) Restarts : 0 Problems : 12 (Average Length: 29.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 : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 314615 (Eliminated: 0 Frozen: 314615) Constraints : 2057808 (Binary: 95.2% Ternary: 4.2% Other: 0.6%) Memory Peak : 559MB Max. Length : 50 steps Models : 0 [endof: stats after solve call] Solving Time: 1.04s Memory: 554MB (+37MB) UNSAT Iteration Time: 2.41s Iteration 13 Queue: [(12,60,0,True), (13,65,0,True)] Grounded Until: 55 Expected Memory: 623.0MB Grounding... [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])] Grounding Time: 0.54s Memory: 556MB (+2MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 13 Time : 21.813s (Solving: 0.22s 1st Model: 0.00s Unsat: 0.22s) CPU Time : 21.648s Choices : 0 Conflicts : 9 (Analyzed: 0) Restarts : 0 Problems : 13 (Average Length: 32.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 : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 344106 (Eliminated: 0 Frozen: 344106) Constraints : 2290268 (Binary: 95.2% Ternary: 4.2% Other: 0.6%) Memory Peak : 612MB Max. Length : 55 steps Models : 0 [endof: stats after solve call] Solving Time: 1.06s Memory: 584MB (+28MB) UNSAT Iteration Time: 1.93s Iteration 14 Queue: [(13,65,0,True)] Grounded Until: 60 Expected Memory: 653.0MB Grounding... [('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('check', [65])] Grounding Time: 0.55s Memory: 585MB (+1MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 14 Time : 23.767s (Solving: 0.27s 1st Model: 0.00s Unsat: 0.27s) CPU Time : 23.604s Choices : 445 (Domain: 445) Conflicts : 17 (Analyzed: 7) Restarts : 0 Problems : 14 (Average Length: 34.50 Splits: 0) Lemmas : 7 (Deleted: 0) Binary : 1 (Ratio: 14.29%) Ternary : 0 (Ratio: 0.00%) Conflict : 7 (Average Length: 1.1 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 7 (Average: 121.14 Max: 134 Sum: 848) Executed : 0 (Average: 63.57 Max: 67 Sum: 445 Ratio: 52.48%) Bounded : 7 (Average: 57.57 Max: 67 Sum: 403 Ratio: 47.52%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 373597 (Eliminated: 0 Frozen: 373597) Constraints : 2522728 (Binary: 95.2% Ternary: 4.2% Other: 0.6%) Memory Peak : 640MB Max. Length : 60 steps Models : 0 [endof: stats after solve call] Solving Time: 1.07s Memory: 605MB (+20MB) UNSAT Iteration Time: 1.97s Iteration 15 Queue: [(14,70,0,True), (15,75,0,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)] Grounded Until: 65 Expected Memory: 674.0MB Grounding... [('step', [66]), ('step', [67]), ('step', [68]), ('step', [69]), ('step', [70]), ('check', [70])] Grounding Time: 0.55s Memory: 614MB (+9MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 15 Time : 25.822s (Solving: 0.40s 1st Model: 0.00s Unsat: 0.40s) CPU Time : 25.660s Choices : 2471 (Domain: 2471) Conflicts : 49 (Analyzed: 38) Restarts : 0 Problems : 15 (Average Length: 37.00 Splits: 0) Lemmas : 38 (Deleted: 0) Binary : 2 (Ratio: 5.26%) Ternary : 0 (Ratio: 0.00%) Conflict : 38 (Average Length: 1.1 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 38 (Average: 132.50 Max: 143 Sum: 5035) Executed : 0 (Average: 65.03 Max: 71 Sum: 2471 Ratio: 49.08%) Bounded : 38 (Average: 67.47 Max: 72 Sum: 2564 Ratio: 50.92%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 403088 (Eliminated: 0 Frozen: 403088) Constraints : 2742689 (Binary: 95.2% Ternary: 4.2% Other: 0.6%) Memory Peak : 673MB Max. Length : 65 steps Models : 0 [endof: stats after solve call] Solving Time: 1.15s Memory: 635MB (+21MB) UNSAT Iteration Time: 2.07s Iteration 16 Queue: [(15,75,0,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)] Grounded Until: 70 Expected Memory: 704.0MB Grounding... [('step', [71]), ('step', [72]), ('step', [73]), ('step', [74]), ('step', [75]), ('check', [75])] Grounding Time: 0.57s Memory: 645MB (+10MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 16 Time : 28.129s (Solving: 0.71s 1st Model: 0.00s Unsat: 0.71s) CPU Time : 27.968s Choices : 6147 (Domain: 6147) Conflicts : 106 (Analyzed: 94) Restarts : 0 Problems : 16 (Average Length: 39.50 Splits: 0) Lemmas : 94 (Deleted: 0) Binary : 3 (Ratio: 3.19%) Ternary : 0 (Ratio: 0.00%) Conflict : 94 (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 : 94 (Average: 137.73 Max: 148 Sum: 12947) Executed : 0 (Average: 65.39 Max: 71 Sum: 6147 Ratio: 47.48%) Bounded : 94 (Average: 72.34 Max: 77 Sum: 6800 Ratio: 52.52%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 432579 (Eliminated: 0 Frozen: 432579) Constraints : 2911107 (Binary: 95.2% Ternary: 4.2% Other: 0.6%) Memory Peak : 707MB Max. Length : 70 steps Models : 0 [endof: stats after solve call] Solving Time: 1.34s Memory: 667MB (+22MB) UNSAT Iteration Time: 2.32s Iteration 17 Queue: [(16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)] Grounded Until: 75 Expected Memory: 736.0MB Grounding... [('step', [76]), ('step', [77]), ('step', [78]), ('step', [79]), ('step', [80]), ('check', [80])] Grounding Time: 0.57s Memory: 669MB (+2MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 17 Time : 30.597s (Solving: 1.13s 1st Model: 0.00s Unsat: 1.13s) CPU Time : 30.440s Choices : 10419 (Domain: 10419) Conflicts : 171 (Analyzed: 158) Restarts : 0 Problems : 17 (Average Length: 42.00 Splits: 0) Lemmas : 158 (Deleted: 0) Binary : 5 (Ratio: 3.16%) Ternary : 0 (Ratio: 0.00%) Conflict : 158 (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 : 158 (Average: 141.16 Max: 153 Sum: 22304) Executed : 1 (Average: 65.94 Max: 153 Sum: 10419 Ratio: 46.71%) Bounded : 157 (Average: 75.70 Max: 82 Sum: 11885 Ratio: 53.29%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 462070 (Eliminated: 0 Frozen: 462070) Constraints : 3040000 (Binary: 95.1% Ternary: 4.3% Other: 0.6%) Memory Peak : 735MB Max. Length : 75 steps Models : 0 [endof: stats after solve call] Solving Time: 1.46s Memory: 722MB (+53MB) UNSAT Iteration Time: 2.48s Iteration 18 Queue: [(17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)] Grounded Until: 80 Expected Memory: 791.0MB Grounding... [('step', [81]), ('step', [82]), ('step', [83]), ('step', [84]), ('step', [85]), ('check', [85])] Grounding Time: 0.56s Memory: 722MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 18 Time : 37.697s (Solving: 6.19s 1st Model: 0.00s Unsat: 6.19s) CPU Time : 37.544s Choices : 40360 (Domain: 40360) Conflicts : 1902 (Analyzed: 1888) Restarts : 2 (Average: 944.00 Last: 397) Problems : 18 (Average Length: 44.50 Splits: 0) Lemmas : 1888 (Deleted: 0) Binary : 33 (Ratio: 1.75%) Ternary : 5 (Ratio: 0.26%) Conflict : 1888 (Average Length: 3186.8 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 1888 (Average: 29.08 Max: 596 Sum: 54904) Executed : 1690 (Average: 20.99 Max: 596 Sum: 39625 Ratio: 72.17%) Bounded : 198 (Average: 77.17 Max: 87 Sum: 15279 Ratio: 27.83%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 491561 (Eliminated: 0 Frozen: 491561) Constraints : 3167721 (Binary: 95.1% Ternary: 4.3% Other: 0.6%) Memory Peak : 782MB Max. Length : 80 steps Models : 0 [endof: stats after solve call] Solving Time: 6.12s Memory: 741MB (+19MB) UNSAT Iteration Time: 7.12s Iteration 19 Queue: [(18,90,0,True), (19,95,0,True), (20,100,0,True)] Grounded Until: 85 Expected Memory: 810.0MB Grounding... [('step', [86]), ('step', [87]), ('step', [88]), ('step', [89]), ('step', [90]), ('check', [90])] Grounding Time: 0.56s Memory: 741MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 19 Time : 42.339s (Solving: 8.76s 1st Model: 0.00s Unsat: 8.76s) CPU Time : 42.188s Choices : 119407 (Domain: 119407) Conflicts : 2613 (Analyzed: 2598) Restarts : 5 (Average: 519.60 Last: 397) Problems : 19 (Average Length: 47.00 Splits: 0) Lemmas : 2598 (Deleted: 0) Binary : 89 (Ratio: 3.43%) Ternary : 7 (Ratio: 0.27%) Conflict : 2598 (Average Length: 2864.2 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 2598 (Average: 51.10 Max: 1235 Sum: 132750) Executed : 2393 (Average: 45.21 Max: 1235 Sum: 117464 Ratio: 88.49%) Bounded : 205 (Average: 74.57 Max: 87 Sum: 15286 Ratio: 11.51%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 521052 (Eliminated: 0 Frozen: 521052) Constraints : 3338898 (Binary: 95.1% Ternary: 4.3% Other: 0.6%) Memory Peak : 810MB Max. Length : 85 steps Models : 0 [endof: stats after solve call] Solving Time: 3.65s Memory: 761MB (+20MB) UNSAT Iteration Time: 4.66s Iteration 20 Queue: [(19,95,0,True), (20,100,0,True)] Grounded Until: 90 Expected Memory: 830.0MB Grounding... [('step', [91]), ('step', [92]), ('step', [93]), ('step', [94]), ('step', [95]), ('check', [95])] Grounding Time: 0.57s Memory: 761MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 20 Time : 54.596s (Solving: 18.96s 1st Model: 0.00s Unsat: 18.96s) CPU Time : 54.448s Choices : 191442 (Domain: 191442) Conflicts : 4609 (Analyzed: 4593) Restarts : 5 (Average: 918.60 Last: 1995) Problems : 20 (Average Length: 49.50 Splits: 0) Lemmas : 4593 (Deleted: 0) Binary : 158 (Ratio: 3.44%) Ternary : 8 (Ratio: 0.17%) Conflict : 4593 (Average Length: 5583.2 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 4593 (Average: 44.59 Max: 3304 Sum: 204797) Executed : 4376 (Average: 41.26 Max: 3304 Sum: 189499 Ratio: 92.53%) Bounded : 217 (Average: 70.50 Max: 87 Sum: 15298 Ratio: 7.47%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 550543 (Eliminated: 0 Frozen: 550543) Constraints : 3571358 (Binary: 95.1% Ternary: 4.3% Other: 0.6%) Memory Peak : 913MB Max. Length : 90 steps Models : 0 [endof: stats after solve call] Solving Time: 11.27s Memory: 849MB (+88MB) UNSAT Iteration Time: 12.28s Iteration 21 Queue: [(20,100,0,True)] Grounded Until: 95 Expected Memory: 937.0MB Grounding... [('step', [96]), ('step', [97]), ('step', [98]), ('step', [99]), ('step', [100]), ('check', [100])] Grounding Time: 0.58s Memory: 850MB (+1MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 21 Time : 533.379s (Solving: 495.59s 1st Model: 0.00s Unsat: 495.59s) CPU Time : 533.436s Choices : 810446 (Domain: 810446) Conflicts : 61151 (Analyzed: 61134) Restarts : 9 (Average: 6792.67 Last: 1995) Problems : 21 (Average Length: 52.00 Splits: 0) Lemmas : 61134 (Deleted: 41586) Binary : 389 (Ratio: 0.64%) Ternary : 18 (Ratio: 0.03%) Conflict : 61134 (Average Length: 11336.7 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 61134 (Average: 13.36 Max: 4052 Sum: 817007) Executed : 60900 (Average: 13.11 Max: 4052 Sum: 801692 Ratio: 98.13%) Bounded : 234 (Average: 65.45 Max: 87 Sum: 15315 Ratio: 1.87%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 580034 (Eliminated: 0 Frozen: 580034) Constraints : 3803818 (Binary: 95.1% Ternary: 4.3% Other: 0.6%) Memory Peak : 2091MB Max. Length : 95 steps Models : 0 [endof: stats after solve call] Solving Time: 477.93s Memory: 2027MB (+1177MB) UNSAT Iteration Time: 479.01s Iteration 22 Queue: [(21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True)] Grounded Until: 100 Expected Memory: 3205.0MB Grounding... [('step', [101]), ('step', [102]), ('step', [103]), ('step', [104]), ('step', [105]), ('check', [105])] Grounding Time: 0.59s Memory: 2029MB (+2MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 22 Time : 558.789s (Solving: 518.44s 1st Model: 0.00s Unsat: 518.44s) CPU Time : 558.860s Choices : 1065070 (Domain: 1065070) Conflicts : 64233 (Analyzed: 64215) Restarts : 9 (Average: 7135.00 Last: 3081) Problems : 22 (Average Length: 54.50 Splits: 0) Lemmas : 64215 (Deleted: 41586) Binary : 522 (Ratio: 0.81%) Ternary : 20 (Ratio: 0.03%) Conflict : 64215 (Average Length: 11191.4 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 64215 (Average: 16.69 Max: 7194 Sum: 1071652) Executed : 63960 (Average: 16.45 Max: 7194 Sum: 1056316 Ratio: 98.57%) Bounded : 255 (Average: 60.14 Max: 87 Sum: 15336 Ratio: 1.43%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 609525 (Eliminated: 0 Frozen: 609525) Constraints : 4036278 (Binary: 95.1% Ternary: 4.3% Other: 0.6%) Memory Peak : 2116MB Max. Length : 100 steps Models : 0 [endof: stats after solve call] Solving Time: 24.14s Memory: 2056MB (+27MB) UNSAT Iteration Time: 25.44s Iteration 23 Queue: [(22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True)] Grounded Until: 105 Expected Memory: 3234.0MB Grounding... [('step', [106]), ('step', [107]), ('step', [108]), ('step', [109]), ('step', [110]), ('check', [110])] Grounding Time: 0.59s Memory: 2056MB (+0MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0 Calls : 23 Time : 679.956s (Solving: 637.00s 1st Model: 0.00s Unsat: 637.00s) CPU Time : 680.076s Choices : 1489867 (Domain: 1489867) Conflicts : 81066 (Analyzed: 81047) Restarts : 10 (Average: 8104.70 Last: 3081) Problems : 23 (Average Length: 57.00 Splits: 0) Lemmas : 81047 (Deleted: 57328) Binary : 718 (Ratio: 0.89%) Ternary : 24 (Ratio: 0.03%) Conflict : 81047 (Average Length: 11803.2 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 81047 (Average: 18.45 Max: 7768 Sum: 1495378) Executed : 80766 (Average: 18.26 Max: 7768 Sum: 1480016 Ratio: 98.97%) Bounded : 281 (Average: 54.67 Max: 87 Sum: 15362 Ratio: 1.03%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 639016 (Eliminated: 0 Frozen: 639016) Constraints : 4268738 (Binary: 95.1% Ternary: 4.3% Other: 0.6%) Memory Peak : 2273MB Max. Length : 105 steps Models : 0 [endof: stats after solve call] Solving Time: 119.93s Memory: 2273MB (+217MB) UNSAT Iteration Time: 121.24s Iteration 24 Queue: [(23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True)] Grounded Until: 110 Expected Memory: 3451.0MB Grounding... [('step', [111]), ('step', [112]), ('step', [113]), ('step', [114]), ('step', [115]), ('check', [115])] Grounding Time: 1.28s Memory: 2323MB (+50MB) Unblocking actions... Solving... *** Info : (planner): INTERRUPTED by signal! UNKNOWN INTERRUPTED : 1 Models : 0+ Calls : 24 Time : 892.035s (Solving: 845.24s 1st Model: 0.00s Unsat: 637.00s) CPU Time : 892.232s Choices : 2214425 (Domain: 2214425) Conflicts : 108626 (Analyzed: 108607) Restarts : 11 (Average: 9873.36 Last: 11526) Problems : 24 (Average Length: 59.50 Splits: 0) Lemmas : 108607 (Deleted: 87379) Binary : 963 (Ratio: 0.89%) Ternary : 26 (Ratio: 0.02%) Conflict : 108607 (Average Length: 13294.1 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 108607 (Average: 20.39 Max: 8165 Sum: 2214443) Executed : 108320 (Average: 20.25 Max: 8165 Sum: 2199075 Ratio: 99.31%) Bounded : 287 (Average: 53.55 Max: 87 Sum: 15368 Ratio: 0.69%) Rules : 96986 Atoms : 96986 Bodies : 1 (Original: 0) Tight : Yes Variables : 668507 (Eliminated: 0 Frozen: 668507) Constraints : 4501198 (Binary: 95.1% Ternary: 4.3% Other: 0.6%) Memory Peak : 2717MB Max. Length : 110 steps Models : 0