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-17.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-17.pddl
Parsing...
Parsing: [0.080s CPU, 0.083s wall-clock]
Normalizing task... [0.000s CPU, 0.003s wall-clock]
Instantiating...
Generating Datalog program... [0.030s CPU, 0.025s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.020s CPU, 0.021s wall-clock]
Preparing model... [0.090s CPU, 0.091s wall-clock]
Generated 46 rules.
Computing model... [4.540s CPU, 4.535s wall-clock]
39612 relevant atoms
17509 auxiliary atoms
57121 final queue length
126137 total queue pushes
Completing instantiation... [14.310s CPU, 14.312s wall-clock]
Instantiating: [19.050s CPU, 19.038s wall-clock]
Computing fact groups...
Finding invariants...
12 initial candidates
Finding invariants: [0.190s CPU, 0.194s wall-clock]
Checking invariant weight... [0.010s CPU, 0.007s wall-clock]
Instantiating groups... [0.130s CPU, 0.136s wall-clock]
Collecting mutex groups... [0.020s CPU, 0.014s wall-clock]
Choosing groups...
0 uncovered facts
Choosing groups: [0.040s CPU, 0.043s wall-clock]
Building translation key... [0.020s CPU, 0.027s wall-clock]
Computing fact groups: [0.550s CPU, 0.557s wall-clock]
Building STRIPS to SAS dictionary... [0.020s CPU, 0.016s wall-clock]
Building dictionary for full mutex groups... [0.010s CPU, 0.011s wall-clock]
Building mutex information...
Building mutex information: [0.020s CPU, 0.016s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [0.590s CPU, 0.596s wall-clock]
Translating task: [11.590s CPU, 11.586s wall-clock]
0 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
61 propositions removed
Detecting unreachable propositions: [5.820s CPU, 5.813s wall-clock]
Reordering and filtering variables...
61 of 61 variables necessary.
0 of 61 mutex groups necessary.
36008 of 36008 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [1.690s CPU, 1.687s wall-clock]
Translator variables: 61
Translator derived variables: 0
Translator facts: 2333
Translator goal facts: 45
Translator mutex groups: 0
Translator total mutex groups size: 0
Translator operators: 36008
Translator axioms: 0
Translator task size: 216303
Translator peak memory: 178236 KB
Writing output... [3.720s CPU, 3.983s wall-clock]
Done! [43.020s CPU, 43.273s wall-clock]
planner.py version 0.0.1

Time:	 9.31s
Memory: 649MB

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         : 10.921s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 9.360s

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        : 652732  
Atoms        : 652732  
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  : 785MB
Max. Length  : 0 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 0.05s
Memory:		 721MB (+72MB)
UNSAT
Iteration Time:	 0.05s

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: 721MB
Grounding...	 [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])]
Grounding Time:	 3.43s
Memory:		 721MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0
Calls        : 2
Time         : 17.659s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 16.096s

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        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 165379   (Eliminated:    0 Frozen: 9332)
Constraints  : 235450   (Binary:  97.5% Ternary:   1.2% Other:   1.4%)

Memory Peak  : 785MB
Max. Length  : 0 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 1.01s
Memory:		 736MB (+15MB)
UNSAT
Iteration Time:	 6.75s

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: 751.0MB
Grounding...	 [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])]
Grounding Time:	 2.99s
Memory:		 770MB (+34MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 3
Time         : 26.421s (Solving: 3.69s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 24.860s

Choices      : 61887    (Domain: 61887)
Conflicts    : 9129     (Analyzed: 9129)
Restarts     : 100      (Average: 91.29 Last: 62)
Problems     : 3        (Average Length: 7.00 Splits: 0)
Lemmas       : 9129     (Deleted: 6175)
  Binary     : 227      (Ratio:   2.49%)
  Ternary    : 35       (Ratio:   0.38%)
  Conflict   : 9129     (Average Length:  397.8 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 9129     (Average:  6.03 Max: 732 Sum:  55053)
  Executed   : 9123     (Average:  6.03 Max: 732 Sum:  55047 Ratio:  99.99%)
  Bounded    : 6        (Average:  1.00 Max:   1 Sum:      6 Ratio:   0.01%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 359824   (Eliminated:    0 Frozen: 20406)
Constraints  : 1757190  (Binary:  98.4% Ternary:   0.8% Other:   0.9%)

Memory Peak  : 886MB
Max. Length  : 5 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 3.89s
Memory:		 886MB (+116MB)
UNKNOWN
Iteration Time:	 8.78s

Iteration 4
Queue:		 [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until:	 10
Expected Memory: 1036.0MB
Grounding...	 [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])]
Grounding Time:	 3.17s
Memory:		 931MB (+45MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 4
Time         : 42.040s (Solving: 14.28s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 40.480s

Choices      : 190089   (Domain: 190089)
Conflicts    : 20773    (Analyzed: 20773)
Restarts     : 200      (Average: 103.86 Last: 75)
Problems     : 4        (Average Length: 9.50 Splits: 0)
Lemmas       : 20773    (Deleted: 16846)
  Binary     : 345      (Ratio:   1.66%)
  Ternary    : 90       (Ratio:   0.43%)
  Conflict   : 20773    (Average Length:  984.3 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 20773    (Average:  7.20 Max: 732 Sum: 149557)
  Executed   : 20767    (Average:  7.20 Max: 732 Sum: 149551 Ratio: 100.00%)
  Bounded    : 6        (Average:  1.00 Max:   1 Sum:      6 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 563510   (Eliminated:    0 Frozen: 31971)
Constraints  : 3387120  (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 1082MB
Max. Length  : 10 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 10.80s
Memory:		 1082MB (+151MB)
UNKNOWN
Iteration Time:	 15.63s

Iteration 5
Queue:		 [(4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until:	 15
Expected Memory: 1278.0MB
Grounding...	 [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])]
Grounding Time:	 3.91s
Memory:		 1183MB (+101MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 5
Time         : 59.521s (Solving: 25.93s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 57.972s

Choices      : 456983   (Domain: 456983)
Conflicts    : 31798    (Analyzed: 31798)
Restarts     : 300      (Average: 105.99 Last: 194)
Problems     : 5        (Average Length: 12.00 Splits: 0)
Lemmas       : 31798    (Deleted: 24681)
  Binary     : 576      (Ratio:   1.81%)
  Ternary    : 184      (Ratio:   0.58%)
  Conflict   : 31798    (Average Length:  962.9 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 31798    (Average: 10.50 Max: 1347 Sum: 333773)
  Executed   : 31791    (Average: 10.50 Max: 1347 Sum: 333766 Ratio: 100.00%)
  Bounded    : 7        (Average:  1.00 Max:   1 Sum:      7 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 767196   (Eliminated:    0 Frozen: 43536)
Constraints  : 5017050  (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 1302MB
Max. Length  : 15 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 11.87s
Memory:		 1233MB (+50MB)
UNKNOWN
Iteration Time:	 17.50s

Iteration 6
Queue:		 [(5,25,0,True), (6,30,0,True)]
Grounded Until:	 20
Expected Memory: 1429.0MB
Grounding...	 [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])]
Grounding Time:	 3.20s
Memory:		 1326MB (+93MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 6
Time         : 86.354s (Solving: 47.44s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 84.816s

Choices      : 1338818  (Domain: 1338818)
Conflicts    : 44366    (Analyzed: 44366)
Restarts     : 400      (Average: 110.92 Last: 194)
Problems     : 6        (Average Length: 14.50 Splits: 0)
Lemmas       : 44366    (Deleted: 34198)
  Binary     : 793      (Ratio:   1.79%)
  Ternary    : 313      (Ratio:   0.71%)
  Conflict   : 44366    (Average Length: 1017.5 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 44366    (Average: 24.15 Max: 4198 Sum: 1071350)
  Executed   : 44350    (Average: 24.15 Max: 4198 Sum: 1071334 Ratio: 100.00%)
  Bounded    : 16       (Average:  1.00 Max:   1 Sum:     16 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 970882   (Eliminated:    0 Frozen: 55101)
Constraints  : 6646980  (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 1595MB
Max. Length  : 20 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 21.77s
Memory:		 1531MB (+205MB)
UNKNOWN
Iteration Time:	 26.86s

Iteration 7
Queue:		 [(6,30,0,True)]
Grounded Until:	 25
Expected Memory: 1829.0MB
Grounding...	 [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])]
Grounding Time:	 3.23s
Memory:		 1598MB (+67MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 7
Time         : 118.095s (Solving: 73.78s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 116.572s

Choices      : 2249494  (Domain: 2249494)
Conflicts    : 54750    (Analyzed: 54750)
Restarts     : 500      (Average: 109.50 Last: 194)
Problems     : 7        (Average Length: 17.00 Splits: 0)
Lemmas       : 54750    (Deleted: 43723)
  Binary     : 891      (Ratio:   1.63%)
  Ternary    : 388      (Ratio:   0.71%)
  Conflict   : 54750    (Average Length: 1081.6 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 54750    (Average: 33.38 Max: 4198 Sum: 1827558)
  Executed   : 54733    (Average: 33.38 Max: 4198 Sum: 1827510 Ratio: 100.00%)
  Bounded    : 17       (Average:  2.82 Max:  32 Sum:     48 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 1174568  (Eliminated:    0 Frozen: 66666)
Constraints  : 8276910  (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 1780MB
Max. Length  : 25 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 26.62s
Memory:		 1668MB (+70MB)
UNKNOWN
Iteration Time:	 31.76s

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        : 8
Time         : 125.497s (Solving: 80.91s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 123.976s

Choices      : 2330679  (Domain: 2330679)
Conflicts    : 65638    (Analyzed: 65638)
Restarts     : 600      (Average: 109.40 Last: 194)
Problems     : 8        (Average Length: 18.88 Splits: 0)
Lemmas       : 65638    (Deleted: 53129)
  Binary     : 997      (Ratio:   1.52%)
  Ternary    : 461      (Ratio:   0.70%)
  Conflict   : 65638    (Average Length: 1020.6 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 65638    (Average: 28.97 Max: 4198 Sum: 1901687)
  Executed   : 65618    (Average: 28.97 Max: 4198 Sum: 1901636 Ratio: 100.00%)
  Bounded    : 20       (Average:  2.55 Max:  32 Sum:     51 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 1174568  (Eliminated:    0 Frozen: 66666)
Constraints  : 8276901  (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 1780MB
Max. Length  : 30 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 7.32s
Memory:		 1684MB (+16MB)
UNKNOWN
Iteration Time:	 7.41s

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        : 9
Time         : 136.846s (Solving: 92.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 135.332s

Choices      : 2474357  (Domain: 2474357)
Conflicts    : 76408    (Analyzed: 76408)
Restarts     : 700      (Average: 109.15 Last: 194)
Problems     : 9        (Average Length: 20.33 Splits: 0)
Lemmas       : 76408    (Deleted: 63155)
  Binary     : 1051     (Ratio:   1.38%)
  Ternary    : 509      (Ratio:   0.67%)
  Conflict   : 76408    (Average Length: 1124.5 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 76408    (Average: 26.46 Max: 4198 Sum: 2021639)
  Executed   : 76387    (Average: 26.46 Max: 4198 Sum: 2021587 Ratio: 100.00%)
  Bounded    : 21       (Average:  2.48 Max:  32 Sum:     52 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 1174568  (Eliminated:    0 Frozen: 66666)
Constraints  : 8276901  (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 1780MB
Max. Length  : 30 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 11.27s
Memory:		 1684MB (+0MB)
UNKNOWN
Iteration Time:	 11.36s

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        : 10
Time         : 150.554s (Solving: 105.40s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 149.044s

Choices      : 2831768  (Domain: 2831768)
Conflicts    : 87949    (Analyzed: 87949)
Restarts     : 800      (Average: 109.94 Last: 194)
Problems     : 10       (Average Length: 21.50 Splits: 0)
Lemmas       : 87949    (Deleted: 74646)
  Binary     : 1103     (Ratio:   1.25%)
  Ternary    : 538      (Ratio:   0.61%)
  Conflict   : 87949    (Average Length: 1125.4 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 87949    (Average: 25.82 Max: 4198 Sum: 2270485)
  Executed   : 87926    (Average: 25.82 Max: 4198 Sum: 2270431 Ratio: 100.00%)
  Bounded    : 23       (Average:  2.35 Max:  32 Sum:     54 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 1174568  (Eliminated:    0 Frozen: 66666)
Constraints  : 8276901  (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 1780MB
Max. Length  : 30 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 13.58s
Memory:		 1684MB (+0MB)
UNKNOWN
Iteration Time:	 13.72s

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        : 11
Time         : 172.237s (Solving: 126.78s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 170.736s

Choices      : 3636314  (Domain: 3636314)
Conflicts    : 100294   (Analyzed: 100294)
Restarts     : 900      (Average: 111.44 Last: 194)
Problems     : 11       (Average Length: 22.45 Splits: 0)
Lemmas       : 100294   (Deleted: 85089)
  Binary     : 1159     (Ratio:   1.16%)
  Ternary    : 584      (Ratio:   0.58%)
  Conflict   : 100294   (Average Length: 1106.5 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 100294   (Average: 28.99 Max: 4198 Sum: 2907989)
  Executed   : 100268   (Average: 28.99 Max: 4198 Sum: 2907932 Ratio: 100.00%)
  Bounded    : 26       (Average:  2.19 Max:  32 Sum:     57 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 1174568  (Eliminated:    0 Frozen: 66666)
Constraints  : 8276901  (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 1780MB
Max. Length  : 30 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 21.57s
Memory:		 1684MB (+0MB)
UNKNOWN
Iteration Time:	 21.69s

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        : 12
Time         : 208.608s (Solving: 162.88s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 207.120s

Choices      : 5005504  (Domain: 5005504)
Conflicts    : 111712   (Analyzed: 111712)
Restarts     : 1000     (Average: 111.71 Last: 194)
Problems     : 12       (Average Length: 23.25 Splits: 0)
Lemmas       : 111712   (Deleted: 96610)
  Binary     : 1250     (Ratio:   1.12%)
  Ternary    : 630      (Ratio:   0.56%)
  Conflict   : 111712   (Average Length: 1091.0 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 111712   (Average: 36.88 Max: 5166 Sum: 4119683)
  Executed   : 111682   (Average: 36.88 Max: 5166 Sum: 4119622 Ratio: 100.00%)
  Bounded    : 30       (Average:  2.03 Max:  32 Sum:     61 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 1174568  (Eliminated:    0 Frozen: 66666)
Constraints  : 8276901  (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 1780MB
Max. Length  : 30 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 36.30s
Memory:		 1684MB (+0MB)
UNKNOWN
Iteration Time:	 36.39s

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: 1982.0MB
Grounding...	 [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])]
Grounding Time:	 3.46s
Memory:		 1751MB (+67MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 13
Time         : 249.486s (Solving: 197.94s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 248.016s

Choices      : 6417573  (Domain: 6417573)
Conflicts    : 122174   (Analyzed: 122174)
Restarts     : 1100     (Average: 111.07 Last: 194)
Problems     : 13       (Average Length: 24.31 Splits: 0)
Lemmas       : 122174   (Deleted: 105338)
  Binary     : 1293     (Ratio:   1.06%)
  Ternary    : 668      (Ratio:   0.55%)
  Conflict   : 122174   (Average Length: 1118.4 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 122174   (Average: 43.87 Max: 5166 Sum: 5360096)
  Executed   : 122143   (Average: 43.87 Max: 5166 Sum: 5359998 Ratio: 100.00%)
  Bounded    : 31       (Average:  3.16 Max:  37 Sum:     98 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 1378254  (Eliminated:    0 Frozen: 78231)
Constraints  : 9906831  (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 1986MB
Max. Length  : 30 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 35.38s
Memory:		 1930MB (+179MB)
UNKNOWN
Iteration Time:	 40.91s

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: 2228.0MB
Grounding...	 [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])]
Grounding Time:	 3.32s
Memory:		 1954MB (+24MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 14
Time         : 297.510s (Solving: 240.27s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 296.060s

Choices      : 7415963  (Domain: 7415963)
Conflicts    : 132574   (Analyzed: 132574)
Restarts     : 1200     (Average: 110.48 Last: 194)
Problems     : 14       (Average Length: 25.57 Splits: 0)
Lemmas       : 132574   (Deleted: 115400)
  Binary     : 1312     (Ratio:   0.99%)
  Ternary    : 682      (Ratio:   0.51%)
  Conflict   : 132574   (Average Length: 1273.3 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 132574   (Average: 46.49 Max: 5166 Sum: 6162880)
  Executed   : 132543   (Average: 46.49 Max: 5166 Sum: 6162782 Ratio: 100.00%)
  Bounded    : 31       (Average:  3.16 Max:  37 Sum:     98 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 1581940  (Eliminated:    0 Frozen: 89796)
Constraints  : 11536752 (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 2185MB
Max. Length  : 35 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 42.68s
Memory:		 2110MB (+156MB)
UNKNOWN
Iteration Time:	 48.05s

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: 2408.0MB
Grounding...	 [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])]
Grounding Time:	 4.74s
Memory:		 2281MB (+171MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 15
Time         : 362.372s (Solving: 297.87s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 360.940s

Choices      : 9148158  (Domain: 9148158)
Conflicts    : 143295   (Analyzed: 143295)
Restarts     : 1300     (Average: 110.23 Last: 194)
Problems     : 15       (Average Length: 27.00 Splits: 0)
Lemmas       : 143295   (Deleted: 125378)
  Binary     : 1324     (Ratio:   0.92%)
  Ternary    : 690      (Ratio:   0.48%)
  Conflict   : 143295   (Average Length: 1332.0 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 143295   (Average: 53.70 Max: 5166 Sum: 7694819)
  Executed   : 143262   (Average: 53.70 Max: 5166 Sum: 7694627 Ratio: 100.00%)
  Bounded    : 33       (Average:  5.82 Max:  47 Sum:    192 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 1785626  (Eliminated:    0 Frozen: 101361)
Constraints  : 13166682 (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 2574MB
Max. Length  : 40 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 57.99s
Memory:		 2401MB (+120MB)
UNKNOWN
Iteration Time:	 64.89s

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: 2699.0MB
Grounding...	 [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])]
Grounding Time:	 3.19s
Memory:		 2441MB (+40MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 1+
Calls        : 16
Time         : 436.756s (Solving: 366.38s 1st Model: 68.34s Unsat: 0.00s)
CPU Time     : 435.348s

Choices      : 11525719 (Domain: 11525647)
Conflicts    : 152140   (Analyzed: 152140)
Restarts     : 1384     (Average: 109.93 Last: 194)
Model-Level  : 8304.0  
Problems     : 16       (Average Length: 28.56 Splits: 0)
Lemmas       : 152140   (Deleted: 135582)
  Binary     : 1369     (Ratio:   0.90%)
  Ternary    : 719      (Ratio:   0.47%)
  Conflict   : 152140   (Average Length: 1311.5 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 152140   (Average: 65.37 Max: 5166 Sum: 9945108)
  Executed   : 152107   (Average: 65.37 Max: 5166 Sum: 9944916 Ratio: 100.00%)
  Bounded    : 33       (Average:  5.82 Max:  47 Sum:    192 Ratio:   0.00%)

Rules        : 652732  
Atoms        : 652732  
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 1989312  (Eliminated:    0 Frozen: 112926)
Constraints  : 14796594 (Binary:  98.5% Ternary:   0.7% Other:   0.8%)

Memory Peak  : 2735MB
Max. Length  : 45 steps
Models       : 1

[endof: stats after solve call]
Solving Time:	 68.94s
Memory:		 2634MB (+193MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time:	 23.15s
Memory:		 2970MB (+336MB)
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 17
Time         : 662.016s (Solving: 572.76s 1st Model: 68.34s Unsat: 0.00s)
CPU Time     : 660.704s

Choices      : 14001164 (Domain: 14001092)
Conflicts    : 162041   (Analyzed: 162041)
Restarts     : 1484     (Average: 109.19 Last: 194)
Model-Level  : 8304.0  
Problems     : 17       (Average Length: 29.94 Splits: 0)
Lemmas       : 162041   (Deleted: 143757)
  Binary     : 1493     (Ratio:   0.92%)
  Ternary    : 813      (Ratio:   0.50%)
  Conflict   : 162041   (Average Length: 1265.8 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 162041   (Average: 76.23 Max: 10139 Sum: 12352110)
  Executed   : 161886   (Average: 76.19 Max: 10139 Sum: 12345574 Ratio:  99.95%)
  Bounded    : 155      (Average: 42.17 Max:  52 Sum:   6536 Ratio:   0.05%)

Rules        : 5563920  (Original: 5563865)
Atoms        : 730283  
Bodies       : 3240484  (Original: 3240428)
  Count      : 2954     (Original: 2959)
Equivalences : 1638227  (Atom=Atom: 79 Body=Body: 0 Other: 1638148)
Tight        : Yes
Variables    : 1995324  (Eliminated:    0 Frozen: 1750917)
Constraints  : 19639423 (Binary:  98.9% Ternary:   0.5% Other:   0.6%)

Memory Peak  : 3249MB
Max. Length  : 45 steps
Models       : 1

[endof: stats after solve call]
Solving Time:	 209.88s
Memory:		 3179MB (+209MB)
UNKNOWN
Iteration Time:	 307.45s

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: 3477.0MB
Grounding...	 [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])]
Grounding Time:	 5.76s
Memory:		 3179MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 18
Time         : 775.643s (Solving: 677.47s 1st Model: 68.34s Unsat: 0.00s)
CPU Time     : 774.376s

Choices      : 17894152 (Domain: 17894080)
Conflicts    : 171226   (Analyzed: 171226)
Restarts     : 1584     (Average: 108.10 Last: 194)
Model-Level  : 8304.0  
Problems     : 18       (Average Length: 31.44 Splits: 0)
Lemmas       : 171226   (Deleted: 152801)
  Binary     : 1605     (Ratio:   0.94%)
  Ternary    : 874      (Ratio:   0.51%)
  Conflict   : 171226   (Average Length: 1253.2 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 171226   (Average: 94.59 Max: 10139 Sum: 16195725)
  Executed   : 170955   (Average: 94.51 Max: 10139 Sum: 16182577 Ratio:  99.92%)
  Bounded    : 271      (Average: 48.52 Max:  57 Sum:  13148 Ratio:   0.08%)

Rules        : 5563920  (Original: 5563865)
Atoms        : 730283  
Bodies       : 3240484  (Original: 3240428)
  Count      : 2954     (Original: 2959)
Equivalences : 1638227  (Atom=Atom: 79 Body=Body: 0 Other: 1638148)
Tight        : Yes
Variables    : 2199620  (Eliminated:    0 Frozen: 1942827)
Constraints  : 21734004 (Binary:  98.9% Ternary:   0.5% Other:   0.6%)

Memory Peak  : 3448MB
Max. Length  : 50 steps
Models       : 1

[endof: stats after solve call]
Solving Time:	 105.21s
Memory:		 3225MB (+46MB)
UNKNOWN
Iteration Time:	 113.69s

Iteration 18
Queue:		 [(12,60,0,True), (13,65,0,True), (14,70,0,True), (15,75,0,True)]
Grounded Until:	 55
Expected Memory: 3523.0MB
Grounding...	 [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])]
Grounding Time:	 5.86s
Memory:		 3285MB (+60MB)
Unblocking actions...
Solving...
*** Info : (planner): INTERRUPTED by signal!
UNKNOWN

INTERRUPTED  : 1

Models       : 0+
Calls        : 19
Time         : 893.586s (Solving: 786.25s 1st Model: 68.34s Unsat: 0.00s)
CPU Time     : 892.352s

Choices      : 20583752 (Domain: 20583680)
Conflicts    : 180758   (Analyzed: 180758)
Restarts     : 1684     (Average: 107.34 Last: 194)
Model-Level  : 8304.0  
Problems     : 19       (Average Length: 33.05 Splits: 0)
Lemmas       : 180758   (Deleted: 161579)
  Binary     : 1662     (Ratio:   0.92%)
  Ternary    : 922      (Ratio:   0.51%)
  Conflict   : 180758   (Average Length: 1264.2 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 180758   (Average: 103.56 Max: 10226 Sum: 18719888)
  Executed   : 180448   (Average: 103.48 Max: 10226 Sum: 18704322 Ratio:  99.92%)
  Bounded    : 310      (Average: 50.21 Max:  62 Sum:  15566 Ratio:   0.08%)

Rules        : 5563920  (Original: 5563865)
Atoms        : 730283  
Bodies       : 3240484  (Original: 3240428)
  Count      : 2954     (Original: 2959)
Equivalences : 1638227  (Atom=Atom: 79 Body=Body: 0 Other: 1638148)
Tight        : Yes
Variables    : 2403916  (Eliminated:    0 Frozen: 2134737)
Constraints  : 23781703 (Binary:  98.9% Ternary:   0.5% Other:   0.6%)

Memory Peak  : 3631MB
Max. Length  : 55 steps
Models       : 1