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-46.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-46.pddl
Parsing...
Parsing: [0.010s CPU, 0.018s wall-clock]
Normalizing task... [0.010s CPU, 0.002s wall-clock]
Instantiating...
Generating Datalog program... [0.000s CPU, 0.005s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.020s CPU, 0.012s wall-clock]
Preparing model... [0.010s CPU, 0.011s wall-clock]
Generated 21 rules.
Computing model... [0.210s CPU, 0.216s wall-clock]
1630 relevant atoms
1078 auxiliary atoms
2708 final queue length
4693 total queue pushes
Completing instantiation... [0.320s CPU, 0.324s wall-clock]
Instantiating: [0.570s CPU, 0.571s wall-clock]
Computing fact groups...
Finding invariants...
10 initial candidates
Finding invariants: [0.020s CPU, 0.021s wall-clock]
Checking invariant weight... [0.000s CPU, 0.003s wall-clock]
Instantiating groups... [0.020s CPU, 0.020s wall-clock]
Collecting mutex groups... [0.010s CPU, 0.004s wall-clock]
Choosing groups...
23 uncovered facts
Choosing groups: [0.020s CPU, 0.021s wall-clock]
Building translation key... [0.010s CPU, 0.007s wall-clock]
Computing fact groups: [0.120s CPU, 0.120s wall-clock]
Building STRIPS to SAS dictionary... [0.000s CPU, 0.003s wall-clock]
Building dictionary for full mutex groups... [0.010s CPU, 0.007s wall-clock]
Building mutex information...
Building mutex information: [0.010s CPU, 0.015s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [0.020s CPU, 0.016s wall-clock]
Translating task: [0.390s CPU, 0.381s wall-clock]
1430 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
44 propositions removed
Detecting unreachable propositions: [0.210s CPU, 0.212s wall-clock]
Reordering and filtering variables...
45 of 45 variables necessary.
23 of 45 mutex groups necessary.
968 of 968 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [0.120s CPU, 0.116s wall-clock]
Translator variables: 45
Translator derived variables: 0
Translator facts: 552
Translator goal facts: 21
Translator mutex groups: 23
Translator total mutex groups size: 529
Translator operators: 968
Translator axioms: 0
Translator task size: 8341
Translator peak memory: 41164 KB
Writing output... [0.150s CPU, 0.152s wall-clock]
Done! [1.610s CPU, 1.616s wall-clock]
planner.py version 0.0.1

Time:	 0.28s
Memory: 67MB

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

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

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

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

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

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        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 7115     (Eliminated:    0 Frozen: 2315)
Constraints  : 9093     (Binary:  92.7% Ternary:   4.4% Other:   2.9%)

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

[endof: stats after solve call]
Solving Time:	 0.01s
Memory:		 144MB (+2MB)
UNSAT
Iteration Time:	 0.15s

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

Models       : 0
Calls        : 3
Time         : 0.654s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 0.612s

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        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 14621    (Eliminated:    0 Frozen: 4797)
Constraints  : 38095    (Binary:  93.5% Ternary:   4.5% Other:   2.0%)

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

[endof: stats after solve call]
Solving Time:	 0.01s
Memory:		 153MB (+2MB)
UNSAT
Iteration Time:	 0.19s

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

Models       : 0
Calls        : 4
Time         : 0.838s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 0.796s

Choices      : 0       
Conflicts    : 1        (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        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 22462    (Eliminated:    0 Frozen: 7394)
Constraints  : 88817    (Binary:  94.0% Ternary:   4.4% Other:   1.5%)

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

[endof: stats after solve call]
Solving Time:	 0.01s
Memory:		 161MB (+4MB)
UNSAT
Iteration Time:	 0.19s

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

Models       : 0
Calls        : 5
Time         : 1.024s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 0.980s

Choices      : 0       
Conflicts    : 2        (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        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 30638    (Eliminated:    0 Frozen: 10039)
Constraints  : 150022   (Binary:  94.2% Ternary:   4.5% Other:   1.4%)

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

[endof: stats after solve call]
Solving Time:	 0.01s
Memory:		 169MB (+3MB)
UNSAT
Iteration Time:	 0.19s

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

Models       : 0
Calls        : 6
Time         : 1.256s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time     : 1.212s

Choices      : 0       
Conflicts    : 3        (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        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 38814    (Eliminated:    0 Frozen: 12684)
Constraints  : 211227   (Binary:  94.2% Ternary:   4.5% Other:   1.3%)

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

[endof: stats after solve call]
Solving Time:	 0.02s
Memory:		 182MB (+6MB)
UNSAT
Iteration Time:	 0.24s

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

Models       : 0
Calls        : 7
Time         : 1.458s (Solving: 0.01s 1st Model: 0.00s Unsat: 0.01s)
CPU Time     : 1.416s

Choices      : 27       (Domain: 27)
Conflicts    : 14       (Analyzed: 10)
Restarts     : 0       
Problems     : 7        (Average Length: 17.00 Splits: 0)
Lemmas       : 10       (Deleted: 0)
  Binary     : 5        (Ratio:  50.00%)
  Ternary    : 0        (Ratio:   0.00%)
  Conflict   : 10       (Average Length:  138.1 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 10       (Average:  6.10 Max:  38 Sum:     61)
  Executed   : 7        (Average:  2.70 Max:  38 Sum:     27 Ratio:  44.26%)
  Bounded    : 3        (Average: 11.33 Max:  32 Sum:     34 Ratio:  55.74%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 46990    (Eliminated:    0 Frozen: 15329)
Constraints  : 272432   (Binary:  94.3% Ternary:   4.5% Other:   1.3%)

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

[endof: stats after solve call]
Solving Time:	 0.02s
Memory:		 188MB (+2MB)
UNSAT
Iteration Time:	 0.21s

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

Models       : 0
Calls        : 8
Time         : 1.708s (Solving: 0.05s 1st Model: 0.00s Unsat: 0.05s)
CPU Time     : 1.664s

Choices      : 221      (Domain: 221)
Conflicts    : 50       (Analyzed: 45)
Restarts     : 0       
Problems     : 8        (Average Length: 19.50 Splits: 0)
Lemmas       : 45       (Deleted: 0)
  Binary     : 21       (Ratio:  46.67%)
  Ternary    : 0        (Ratio:   0.00%)
  Conflict   : 45       (Average Length:  358.7 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 45       (Average:  5.69 Max:  38 Sum:    256)
  Executed   : 41       (Average:  4.91 Max:  38 Sum:    221 Ratio:  86.33%)
  Bounded    : 4        (Average:  8.75 Max:  32 Sum:     35 Ratio:  13.67%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 55166    (Eliminated:    0 Frozen: 17974)
Constraints  : 332882   (Binary:  94.3% Ternary:   4.5% Other:   1.2%)

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

[endof: stats after solve call]
Solving Time:	 0.06s
Memory:		 200MB (+7MB)
UNSAT
Iteration Time:	 0.25s

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

Models       : 0
Calls        : 9
Time         : 2.011s (Solving: 0.14s 1st Model: 0.00s Unsat: 0.14s)
CPU Time     : 1.968s

Choices      : 1965     (Domain: 1965)
Conflicts    : 212      (Analyzed: 206)
Restarts     : 2        (Average: 103.00 Last: 35)
Problems     : 9        (Average Length: 22.00 Splits: 0)
Lemmas       : 206      (Deleted: 0)
  Binary     : 36       (Ratio:  17.48%)
  Ternary    : 0        (Ratio:   0.00%)
  Conflict   : 206      (Average Length: 1045.9 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 206      (Average: 10.11 Max: 161 Sum:   2082)
  Executed   : 198      (Average:  9.54 Max: 161 Sum:   1965 Ratio:  94.38%)
  Bounded    : 8        (Average: 14.62 Max:  41 Sum:    117 Ratio:   5.62%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 63342    (Eliminated:    0 Frozen: 20619)
Constraints  : 394087   (Binary:  94.3% Ternary:   4.5% Other:   1.2%)

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

[endof: stats after solve call]
Solving Time:	 0.11s
Memory:		 206MB (+3MB)
UNSAT
Iteration Time:	 0.31s

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

Models       : 0
Calls        : 10
Time         : 3.408s (Solving: 1.32s 1st Model: 0.00s Unsat: 1.32s)
CPU Time     : 3.368s

Choices      : 9644     (Domain: 9644)
Conflicts    : 1840     (Analyzed: 1833)
Restarts     : 20       (Average: 91.65 Last: 83)
Problems     : 10       (Average Length: 24.50 Splits: 0)
Lemmas       : 1833     (Deleted: 0)
  Binary     : 65       (Ratio:   3.55%)
  Ternary    : 1        (Ratio:   0.05%)
  Conflict   : 1833     (Average Length: 2096.6 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 1833     (Average:  5.20 Max: 233 Sum:   9531)
  Executed   : 1824     (Average:  5.14 Max: 233 Sum:   9413 Ratio:  98.76%)
  Bounded    : 9        (Average: 13.11 Max:  41 Sum:    118 Ratio:   1.24%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 71518    (Eliminated:    0 Frozen: 23264)
Constraints  : 455292   (Binary:  94.3% Ternary:   4.5% Other:   1.2%)

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

[endof: stats after solve call]
Solving Time:	 1.20s
Memory:		 213MB (+3MB)
UNSAT
Iteration Time:	 1.40s

Iteration 11
Queue:		 [(10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)]
Grounded Until:	 45
Expected Memory: 226.0MB
Grounding...	 [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])]
Grounding Time:	 0.15s
Memory:		 217MB (+4MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0
Calls        : 11
Time         : 8.371s (Solving: 6.03s 1st Model: 0.00s Unsat: 6.03s)
CPU Time     : 8.332s

Choices      : 33406    (Domain: 33406)
Conflicts    : 6116     (Analyzed: 6108)
Restarts     : 70       (Average: 87.26 Last: 83)
Problems     : 11       (Average Length: 27.00 Splits: 0)
Lemmas       : 6108     (Deleted: 3790)
  Binary     : 147      (Ratio:   2.41%)
  Ternary    : 1        (Ratio:   0.02%)
  Conflict   : 6108     (Average Length: 2657.4 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 6108     (Average:  5.33 Max: 404 Sum:  32527)
  Executed   : 6094     (Average:  5.31 Max: 404 Sum:  32404 Ratio:  99.62%)
  Bounded    : 14       (Average:  8.79 Max:  41 Sum:    123 Ratio:   0.38%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 79694    (Eliminated:    0 Frozen: 25909)
Constraints  : 516497   (Binary:  94.3% Ternary:   4.5% Other:   1.2%)

Memory Peak  : 227MB
Max. Length  : 45 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 4.74s
Memory:		 219MB (+2MB)
UNSAT
Iteration Time:	 4.97s

Iteration 12
Queue:		 [(11,55,0,True), (12,60,0,True), (13,65,0,True)]
Grounded Until:	 50
Expected Memory: 232.0MB
Grounding...	 [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])]
Grounding Time:	 0.21s
Memory:		 230MB (+11MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0
Calls        : 12
Time         : 15.279s (Solving: 12.62s 1st Model: 0.00s Unsat: 12.62s)
CPU Time     : 15.244s

Choices      : 68533    (Domain: 68533)
Conflicts    : 11841    (Analyzed: 11832)
Restarts     : 134      (Average: 88.30 Last: 87)
Problems     : 12       (Average Length: 29.50 Splits: 0)
Lemmas       : 11832    (Deleted: 7847)
  Binary     : 248      (Ratio:   2.10%)
  Ternary    : 2        (Ratio:   0.02%)
  Conflict   : 11832    (Average Length: 3268.0 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 11832    (Average:  5.54 Max: 649 Sum:  65591)
  Executed   : 11814    (Average:  5.53 Max: 649 Sum:  65464 Ratio:  99.81%)
  Bounded    : 18       (Average:  7.06 Max:  41 Sum:    127 Ratio:   0.19%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 87870    (Eliminated:    0 Frozen: 28554)
Constraints  : 577702   (Binary:  94.3% Ternary:   4.5% Other:   1.2%)

Memory Peak  : 365MB
Max. Length  : 50 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 6.62s
Memory:		 301MB (+71MB)
UNSAT
Iteration Time:	 6.92s

Iteration 13
Queue:		 [(12,60,0,True), (13,65,0,True)]
Grounded Until:	 55
Expected Memory: 383.0MB
Grounding...	 [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])]
Grounding Time:	 0.15s
Memory:		 305MB (+4MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 13
Time         : 29.625s (Solving: 26.69s 1st Model: 0.00s Unsat: 12.62s)
CPU Time     : 29.596s

Choices      : 148434   (Domain: 148434)
Conflicts    : 20569    (Analyzed: 20560)
Restarts     : 234      (Average: 87.86 Last: 95)
Problems     : 13       (Average Length: 32.00 Splits: 0)
Lemmas       : 20560    (Deleted: 17622)
  Binary     : 368      (Ratio:   1.79%)
  Ternary    : 4        (Ratio:   0.02%)
  Conflict   : 20560    (Average Length: 4275.4 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 20560    (Average:  6.59 Max: 999 Sum: 135584)
  Executed   : 20536    (Average:  6.59 Max: 999 Sum: 135451 Ratio:  99.90%)
  Bounded    : 24       (Average:  5.54 Max:  41 Sum:    133 Ratio:   0.10%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 96046    (Eliminated:    0 Frozen: 31199)
Constraints  : 638907   (Binary:  94.3% Ternary:   4.5% Other:   1.2%)

Memory Peak  : 365MB
Max. Length  : 55 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 14.12s
Memory:		 309MB (+4MB)
UNKNOWN
Iteration Time:	 14.36s

Iteration 14
Queue:		 [(13,65,0,True)]
Grounded Until:	 60
Expected Memory: 391.0MB
Grounding...	 [('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('check', [65])]
Grounding Time:	 0.14s
Memory:		 313MB (+4MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0+
Calls        : 14
Time         : 45.235s (Solving: 42.03s 1st Model: 0.00s Unsat: 12.62s)
CPU Time     : 45.212s

Choices      : 270174   (Domain: 270174)
Conflicts    : 29633    (Analyzed: 29624)
Restarts     : 334      (Average: 88.69 Last: 117)
Problems     : 14       (Average Length: 34.50 Splits: 0)
Lemmas       : 29624    (Deleted: 26244)
  Binary     : 482      (Ratio:   1.63%)
  Ternary    : 13       (Ratio:   0.04%)
  Conflict   : 29624    (Average Length: 4691.2 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 29624    (Average:  8.28 Max: 3309 Sum: 245321)
  Executed   : 29595    (Average:  8.28 Max: 3309 Sum: 245183 Ratio:  99.94%)
  Bounded    : 29       (Average:  4.76 Max:  41 Sum:    138 Ratio:   0.06%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 104222   (Eliminated:    0 Frozen: 33844)
Constraints  : 700112   (Binary:  94.3% Ternary:   4.5% Other:   1.2%)

Memory Peak  : 365MB
Max. Length  : 60 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 15.39s
Memory:		 316MB (+3MB)
UNKNOWN
Iteration Time:	 15.62s

Iteration 15
Queue:		 [(12,60,1,True), (13,65,1,True), (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), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True)]
Grounded Until:	 65
Blocking actions...
Solving...
[start: stats after solve call]

Models       : 0
Calls        : 15
Time         : 48.531s (Solving: 45.30s 1st Model: 0.00s Unsat: 15.88s)
CPU Time     : 48.508s

Choices      : 282584   (Domain: 282584)
Conflicts    : 31400    (Analyzed: 31390)
Restarts     : 354      (Average: 88.67 Last: 117)
Problems     : 15       (Average Length: 36.67 Splits: 0)
Lemmas       : 31390    (Deleted: 26244)
  Binary     : 494      (Ratio:   1.57%)
  Ternary    : 13       (Ratio:   0.04%)
  Conflict   : 31390    (Average Length: 4702.0 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 31390    (Average:  8.06 Max: 3309 Sum: 253065)
  Executed   : 31360    (Average:  8.06 Max: 3309 Sum: 252926 Ratio:  99.95%)
  Bounded    : 30       (Average:  4.63 Max:  41 Sum:    139 Ratio:   0.05%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 104222   (Eliminated:    0 Frozen: 33844)
Constraints  : 700112   (Binary:  94.3% Ternary:   4.5% Other:   1.2%)

Memory Peak  : 365MB
Max. Length  : 65 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 3.28s
Memory:		 316MB (+0MB)
UNSAT
Iteration Time:	 3.30s

Iteration 16
Queue:		 [(13,65,1,True), (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), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True)]
Grounded Until:	 65
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 0
Calls        : 16
Time         : 48.594s (Solving: 45.31s 1st Model: 0.00s Unsat: 15.90s)
CPU Time     : 48.572s

Choices      : 282584   (Domain: 282584)
Conflicts    : 31401    (Analyzed: 31390)
Restarts     : 354      (Average: 88.67 Last: 117)
Problems     : 16       (Average Length: 38.56 Splits: 0)
Lemmas       : 31390    (Deleted: 26244)
  Binary     : 494      (Ratio:   1.57%)
  Ternary    : 13       (Ratio:   0.04%)
  Conflict   : 31390    (Average Length: 4702.0 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 31390    (Average:  8.06 Max: 3309 Sum: 253065)
  Executed   : 31360    (Average:  8.06 Max: 3309 Sum: 252926 Ratio:  99.95%)
  Bounded    : 30       (Average:  4.63 Max:  41 Sum:    139 Ratio:   0.05%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 104222   (Eliminated:    0 Frozen: 33844)
Constraints  : 700112   (Binary:  94.3% Ternary:   4.5% Other:   1.2%)

Memory Peak  : 365MB
Max. Length  : 65 steps
Models       : 0

[endof: stats after solve call]
Solving Time:	 0.03s
Memory:		 316MB (+0MB)
UNSAT
Iteration Time:	 0.07s

Iteration 17
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), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True)]
Grounded Until:	 65
Expected Memory: 398.0MB
Grounding...	 [('step', [66]), ('step', [67]), ('step', [68]), ('step', [69]), ('step', [70]), ('check', [70])]
Grounding Time:	 0.13s
Memory:		 320MB (+4MB)
Unblocking actions...
Solving...
[start: stats after solve call]

Models       : 1+
Calls        : 17
Time         : 52.709s (Solving: 49.14s 1st Model: 3.83s Unsat: 15.90s)
CPU Time     : 52.692s

Choices      : 375302   (Domain: 375302)
Conflicts    : 34035    (Analyzed: 34024)
Restarts     : 384      (Average: 88.60 Last: 117)
Model-Level  : 438.0   
Problems     : 17       (Average Length: 40.53 Splits: 0)
Lemmas       : 34024    (Deleted: 29401)
  Binary     : 568      (Ratio:   1.67%)
  Ternary    : 14       (Ratio:   0.04%)
  Conflict   : 34024    (Average Length: 4953.9 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 34024    (Average:  9.96 Max: 5132 Sum: 338841)
  Executed   : 33991    (Average:  9.95 Max: 5132 Sum: 338699 Ratio:  99.96%)
  Bounded    : 33       (Average:  4.30 Max:  41 Sum:    142 Ratio:   0.04%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 112398   (Eliminated:    0 Frozen: 36489)
Constraints  : 761317   (Binary:  94.3% Ternary:   4.5% Other:   1.2%)

Memory Peak  : 391MB
Max. Length  : 65 steps
Models       : 1

[endof: stats after solve call]
Solving Time:	 3.89s
Memory:		 391MB (+71MB)
SAT
Testing...
SERIALIZABLE
Testing Time:	 0.30s
Memory:		 396MB (+5MB)
Answer: 1
occurs(action(("unstack","p","u")),1) occurs(action(("put-down","p")),2) occurs(action(("unstack","u","q")),3) occurs(action(("put-down","u")),4) occurs(action(("pick-up","q")),5) occurs(action(("put-down","q")),6) occurs(action(("pick-up","n")),7) occurs(action(("stack","n","u")),8) occurs(action(("pick-up","a")),9) occurs(action(("put-down","a")),10) occurs(action(("unstack","g","r")),11) occurs(action(("put-down","g")),12) occurs(action(("unstack","o","f")),13) occurs(action(("put-down","o")),14) occurs(action(("unstack","f","i")),15) occurs(action(("stack","f","n")),16) occurs(action(("pick-up","p")),17) occurs(action(("stack","p","f")),18) occurs(action(("pick-up","o")),19) occurs(action(("stack","o","p")),20) occurs(action(("pick-up","q")),21) occurs(action(("stack","q","o")),22) occurs(action(("unstack","r","l")),23) occurs(action(("stack","r","q")),24) occurs(action(("unstack","l","m")),25) occurs(action(("put-down","l")),26) occurs(action(("unstack","m","v")),27) occurs(action(("stack","m","r")),28) occurs(action(("unstack","v","b")),29) occurs(action(("stack","v","l")),30) occurs(action(("unstack","b","s")),31) occurs(action(("put-down","b")),32) occurs(action(("unstack","s","j")),33) occurs(action(("stack","s","a")),34) occurs(action(("unstack","j","t")),35) occurs(action(("stack","j","i")),36) occurs(action(("unstack","t","d")),37) occurs(action(("put-down","t")),38) occurs(action(("unstack","d","h")),39) occurs(action(("stack","d","m")),40) occurs(action(("unstack","s","a")),41) occurs(action(("stack","s","d")),42) occurs(action(("pick-up","a")),43) occurs(action(("stack","a","s")),44) occurs(action(("unstack","h","c")),45) occurs(action(("stack","h","a")),46) occurs(action(("unstack","c","e")),47) occurs(action(("put-down","c")),48) occurs(action(("unstack","e","k")),49) occurs(action(("put-down","e")),50) occurs(action(("pick-up","k")),51) occurs(action(("stack","k","h")),52) occurs(action(("unstack","v","l")),53) occurs(action(("stack","v","k")),54) occurs(action(("unstack","j","i")),55) occurs(action(("stack","j","v")),56) occurs(action(("pick-up","b")),57) occurs(action(("stack","b","j")),58) occurs(action(("pick-up","g")),59) occurs(action(("stack","g","b")),60) occurs(action(("pick-up","e")),61) occurs(action(("stack","e","g")),62) occurs(action(("pick-up","i")),63) occurs(action(("stack","i","e")),64) occurs(action(("pick-up","l")),65) occurs(action(("stack","l","i")),66) occurs(action(("pick-up","t")),67) occurs(action(("stack","t","l")),68) occurs(action(("pick-up","c")),69) occurs(action(("stack","c","t")),70)
SATISFIABLE

Models       : 1+
Calls        : 17
Time         : 52.709s (Solving: 49.14s 1st Model: 3.83s Unsat: 15.90s)
CPU Time     : 52.692s

Choices      : 375302   (Domain: 375302)
Conflicts    : 34035    (Analyzed: 34024)
Restarts     : 384      (Average: 88.60 Last: 117)
Model-Level  : 438.0   
Problems     : 17       (Average Length: 40.53 Splits: 0)
Lemmas       : 34024    (Deleted: 29401)
  Binary     : 568      (Ratio:   1.67%)
  Ternary    : 14       (Ratio:   0.04%)
  Conflict   : 34024    (Average Length: 4953.9 Ratio: 100.00%) 
  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
Backjumps    : 34024    (Average:  9.96 Max: 5132 Sum: 338841)
  Executed   : 33991    (Average:  9.95 Max: 5132 Sum: 338699 Ratio:  99.96%)
  Bounded    : 33       (Average:  4.30 Max:  41 Sum:    142 Ratio:   0.04%)

Rules        : 25607   
Atoms        : 25607   
Bodies       : 1        (Original: 0)
Tight        : Yes
Variables    : 112398   (Eliminated:    0 Frozen: 36489)
Constraints  : 761317   (Binary:  94.3% Ternary:   4.5% Other:   1.2%)

Memory Peak  : 396MB
Max. Length  : 70 steps
Sol. Length  : 70 steps
Models       : 1


