tplp-planning-benchmark/gc-ta1-tt1/ipc-2011_elevator-sequential-satisficing_17.out

944 lines
33 KiB
Plaintext

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