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-96.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-96.pddl Parsing... Parsing: [0.020s CPU, 0.021s wall-clock] Normalizing task... [0.000s CPU, 0.002s wall-clock] Instantiating... Generating Datalog program... [0.010s CPU, 0.008s wall-clock] Normalizing Datalog program... Normalizing Datalog program: [0.010s CPU, 0.011s wall-clock] Preparing model... [0.020s CPU, 0.017s wall-clock] Generated 21 rules. Computing model... [0.820s CPU, 0.818s wall-clock] 7005 relevant atoms 4653 auxiliary atoms 11658 final queue length 20596 total queue pushes Completing instantiation... [1.480s CPU, 1.474s wall-clock] Instantiating: [2.340s CPU, 2.338s wall-clock] Computing fact groups... Finding invariants... 10 initial candidates Finding invariants: [0.030s CPU, 0.029s wall-clock] Checking invariant weight... [0.010s CPU, 0.007s wall-clock] Instantiating groups... [0.140s CPU, 0.147s wall-clock] Collecting mutex groups... [0.020s CPU, 0.018s wall-clock] Choosing groups... 48 uncovered facts Choosing groups: [0.080s CPU, 0.090s wall-clock] Building translation key... [0.030s CPU, 0.028s wall-clock] Computing fact groups: [0.550s CPU, 0.548s wall-clock] Building STRIPS to SAS dictionary... [0.010s CPU, 0.017s wall-clock] Building dictionary for full mutex groups... [0.040s CPU, 0.032s wall-clock] Building mutex information... Building mutex information: [0.050s CPU, 0.049s wall-clock] Translating task... Processing axioms... Simplifying axioms... [0.000s CPU, 0.000s wall-clock] Processing axioms: [0.070s CPU, 0.074s wall-clock] Translating task: [1.730s CPU, 1.738s wall-clock] 6580 effect conditions simplified 0 implied preconditions added Detecting unreachable propositions... 0 operators removed 0 axioms removed 94 propositions removed Detecting unreachable propositions: [1.040s CPU, 1.035s wall-clock] Reordering and filtering variables... 95 of 95 variables necessary. 48 of 95 mutex groups necessary. 4418 of 4418 operators necessary. 0 of 0 axiom rules necessary. Reordering and filtering variables: [0.550s CPU, 0.550s wall-clock] Translator variables: 95 Translator derived variables: 0 Translator facts: 2352 Translator goal facts: 46 Translator mutex groups: 48 Translator total mutex groups size: 2304 Translator operators: 4418 Translator axioms: 0 Translator task size: 37791 Translator peak memory: 59416 KB Writing output... [0.650s CPU, 0.686s wall-clock] Done! [7.060s CPU, 7.096s wall-clock] planner.py version 0.0.1 Time: 1.28s Memory: 129MB Iteration 1 Queue: [(0,150,0,True)] Grounded Until: 0 Expected Memory: 129MB Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('step', [66]), ('step', [67]), ('step', [68]), ('step', [69]), ('step', [70]), ('step', [71]), ('step', [72]), ('step', [73]), ('step', [74]), ('step', [75]), ('step', [76]), ('step', [77]), ('step', [78]), ('step', [79]), ('step', [80]), ('step', [81]), ('step', [82]), ('step', [83]), ('step', [84]), ('step', [85]), ('step', [86]), ('step', [87]), ('step', [88]), ('step', [89]), ('step', [90]), ('step', [91]), ('step', [92]), ('step', [93]), ('step', [94]), ('step', [95]), ('step', [96]), ('step', [97]), ('step', [98]), ('step', [99]), ('step', [100]), ('step', [101]), ('step', [102]), ('step', [103]), ('step', [104]), ('step', [105]), ('step', [106]), ('step', [107]), ('step', [108]), ('step', [109]), ('step', [110]), ('step', [111]), ('step', [112]), ('step', [113]), ('step', [114]), ('step', [115]), ('step', [116]), ('step', [117]), ('step', [118]), ('step', [119]), ('step', [120]), ('step', [121]), ('step', [122]), ('step', [123]), ('step', [124]), ('step', [125]), ('step', [126]), ('step', [127]), ('step', [128]), ('step', [129]), ('step', [130]), ('step', [131]), ('step', [132]), ('step', [133]), ('step', [134]), ('step', [135]), ('step', [136]), ('step', [137]), ('step', [138]), ('step', [139]), ('step', [140]), ('step', [141]), ('step', [142]), ('step', [143]), ('step', [144]), ('step', [145]), ('step', [146]), ('step', [147]), ('step', [148]), ('step', [149]), ('step', [150]), ('check', [150])] Grounding Time: 22.40s Memory: 1953MB (+1824MB) Unblocking actions... Solving... [start: stats after solve call] Models : 0+ Calls : 1 Time : 183.505s (Solving: 148.23s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 183.416s Choices : 703963 (Domain: 703963) Conflicts : 26715 (Analyzed: 26715) Restarts : 100 (Average: 267.15 Last: 136) Problems : 1 (Average Length: 152.00 Splits: 0) Lemmas : 26715 (Deleted: 21700) Binary : 6 (Ratio: 0.02%) Ternary : 0 (Ratio: 0.00%) Conflict : 26715 (Average Length: 15738.1 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 26715 (Average: 24.52 Max: 7807 Sum: 654922) Executed : 26710 (Average: 24.49 Max: 7807 Sum: 654314 Ratio: 99.91%) Bounded : 5 (Average: 121.60 Max: 152 Sum: 608 Ratio: 0.09%) Rules : 0 Atoms : 0 Bodies : 0 Tight : Yes Variables : 1046877 (Eliminated: 0 Frozen: 343969) Constraints : 7936909 (Binary: 95.2% Ternary: 4.2% Other: 0.5%) Memory Peak : 2797MB Max. Length : 0 steps Models : 0 [endof: stats after solve call] Solving Time: 149.05s Memory: 2733MB (+780MB) UNKNOWN Iteration Time: 182.15s Iteration 2 Queue: [(0,150,1,True)] Grounded Until: 150 Solving... [start: stats after solve call] Models : 0+ Calls : 2 Time : 324.186s (Solving: 288.61s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 324.160s Choices : 930133 (Domain: 930133) Conflicts : 51023 (Analyzed: 51023) Restarts : 200 (Average: 255.12 Last: 137) Problems : 2 (Average Length: 152.00 Splits: 0) Lemmas : 51023 (Deleted: 45566) Binary : 12 (Ratio: 0.02%) Ternary : 0 (Ratio: 0.00%) Conflict : 51023 (Average Length: 16972.7 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 51023 (Average: 16.45 Max: 7807 Sum: 839115) Executed : 51014 (Average: 16.43 Max: 7807 Sum: 838503 Ratio: 99.93%) Bounded : 9 (Average: 68.00 Max: 152 Sum: 612 Ratio: 0.07%) Rules : 0 Atoms : 0 Bodies : 0 Tight : Yes Variables : 1046877 (Eliminated: 0 Frozen: 343969) Constraints : 7921807 (Binary: 95.2% Ternary: 4.2% Other: 0.5%) Memory Peak : 2945MB Max. Length : 150 steps Models : 0 [endof: stats after solve call] Solving Time: 140.74s Memory: 2817MB (+84MB) UNKNOWN Iteration Time: 140.75s Iteration 3 Queue: [(0,150,2,True)] Grounded Until: 150 Solving... [start: stats after solve call] Models : 0+ Calls : 3 Time : 474.376s (Solving: 438.53s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 474.412s Choices : 1149190 (Domain: 1149190) Conflicts : 77105 (Analyzed: 77105) Restarts : 300 (Average: 257.02 Last: 155) Problems : 3 (Average Length: 152.00 Splits: 0) Lemmas : 77105 (Deleted: 72655) Binary : 15 (Ratio: 0.02%) Ternary : 0 (Ratio: 0.00%) Conflict : 77105 (Average Length: 17543.1 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 77105 (Average: 13.18 Max: 7807 Sum: 1016092) Executed : 77094 (Average: 13.17 Max: 7807 Sum: 1015478 Ratio: 99.94%) Bounded : 11 (Average: 55.82 Max: 152 Sum: 614 Ratio: 0.06%) Rules : 0 Atoms : 0 Bodies : 0 Tight : Yes Variables : 1046877 (Eliminated: 0 Frozen: 343969) Constraints : 7921807 (Binary: 95.2% Ternary: 4.2% Other: 0.5%) Memory Peak : 2945MB Max. Length : 150 steps Models : 0 [endof: stats after solve call] Solving Time: 150.26s Memory: 2830MB (+13MB) UNKNOWN Iteration Time: 150.26s Iteration 4 Queue: [(0,150,3,True)] Grounded Until: 150 Solving... [start: stats after solve call] Models : 0+ Calls : 4 Time : 613.555s (Solving: 577.40s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 613.648s Choices : 1387512 (Domain: 1387512) Conflicts : 101894 (Analyzed: 101894) Restarts : 400 (Average: 254.74 Last: 157) Problems : 4 (Average Length: 152.00 Splits: 0) Lemmas : 101894 (Deleted: 98719) Binary : 21 (Ratio: 0.02%) Ternary : 0 (Ratio: 0.00%) Conflict : 101894 (Average Length: 17444.6 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 101894 (Average: 11.91 Max: 7807 Sum: 1213288) Executed : 101881 (Average: 11.90 Max: 7807 Sum: 1212672 Ratio: 99.95%) Bounded : 13 (Average: 47.38 Max: 152 Sum: 616 Ratio: 0.05%) Rules : 0 Atoms : 0 Bodies : 0 Tight : Yes Variables : 1046877 (Eliminated: 0 Frozen: 343969) Constraints : 7921807 (Binary: 95.2% Ternary: 4.2% Other: 0.5%) Memory Peak : 2945MB Max. Length : 150 steps Models : 0 [endof: stats after solve call] Solving Time: 139.24s Memory: 2832MB (+2MB) UNKNOWN Iteration Time: 139.24s Iteration 5 Queue: [(0,150,4,True)] Grounded Until: 150 Solving... [start: stats after solve call] Models : 0+ Calls : 5 Time : 749.577s (Solving: 713.15s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 749.728s Choices : 1624525 (Domain: 1624525) Conflicts : 126822 (Analyzed: 126822) Restarts : 500 (Average: 253.64 Last: 213) Problems : 5 (Average Length: 152.00 Splits: 0) Lemmas : 126822 (Deleted: 123491) Binary : 21 (Ratio: 0.02%) Ternary : 0 (Ratio: 0.00%) Conflict : 126822 (Average Length: 17395.0 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 126822 (Average: 11.10 Max: 7807 Sum: 1407671) Executed : 126809 (Average: 11.09 Max: 7807 Sum: 1407055 Ratio: 99.96%) Bounded : 13 (Average: 47.38 Max: 152 Sum: 616 Ratio: 0.04%) Rules : 0 Atoms : 0 Bodies : 0 Tight : Yes Variables : 1046877 (Eliminated: 0 Frozen: 343969) Constraints : 7921807 (Binary: 95.2% Ternary: 4.2% Other: 0.5%) Memory Peak : 2945MB Max. Length : 150 steps Models : 0 [endof: stats after solve call] Solving Time: 136.08s Memory: 2832MB (+0MB) UNKNOWN Iteration Time: 136.08s Iteration 6 Queue: [(0,150,5,True)] Grounded Until: 150 Solving... *** Info : (planner): INTERRUPTED by signal! UNKNOWN INTERRUPTED : 1 Models : 0+ Calls : 6 Time : 905.629s (Solving: 868.93s 1st Model: 0.00s Unsat: 0.00s) CPU Time : 905.832s Choices : 1864505 (Domain: 1864505) Conflicts : 153808 (Analyzed: 153808) Restarts : 600 (Average: 256.35 Last: 253) Problems : 6 (Average Length: 152.00 Splits: 0) Lemmas : 153808 (Deleted: 148410) Binary : 30 (Ratio: 0.02%) Ternary : 0 (Ratio: 0.00%) Conflict : 153808 (Average Length: 17389.4 Ratio: 100.00%) Loop : 0 (Average Length: 0.0 Ratio: 0.00%) Other : 0 (Average Length: 0.0 Ratio: 0.00%) Backjumps : 153808 (Average: 10.45 Max: 7807 Sum: 1607156) Executed : 153791 (Average: 10.45 Max: 7807 Sum: 1606536 Ratio: 99.96%) Bounded : 17 (Average: 36.47 Max: 152 Sum: 620 Ratio: 0.04%) Rules : 0 Atoms : 0 Bodies : 0 Tight : Yes Variables : 1046877 (Eliminated: 0 Frozen: 343969) Constraints : 7921807 (Binary: 95.2% Ternary: 4.2% Other: 0.5%) Memory Peak : 2945MB Max. Length : 150 steps Models : 0