1
0
tplp-planning-benchmark/gc-ta1-tt1/ipc-2011_elevator-sequential-satisficing_13.out

1004 lines
36 KiB
Plaintext
Raw Normal View History

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-13.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-13.pddl
Parsing...
Parsing: [0.050s CPU, 0.053s wall-clock]
Normalizing task... [0.000s CPU, 0.003s wall-clock]
Instantiating...
Generating Datalog program... [0.020s CPU, 0.016s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.020s CPU, 0.023s wall-clock]
Preparing model... [0.050s CPU, 0.052s wall-clock]
Generated 46 rules.
Computing model... [3.580s CPU, 3.581s wall-clock]
32936 relevant atoms
12318 auxiliary atoms
45254 final queue length
104494 total queue pushes
Completing instantiation... [11.550s CPU, 11.541s wall-clock]
Instantiating: [15.270s CPU, 15.258s wall-clock]
Computing fact groups...
Finding invariants...
12 initial candidates
Finding invariants: [0.170s CPU, 0.170s wall-clock]
Checking invariant weight... [0.000s CPU, 0.005s wall-clock]
Instantiating groups... [0.120s CPU, 0.114s wall-clock]
Collecting mutex groups... [0.010s CPU, 0.010s wall-clock]
Choosing groups...
0 uncovered facts
Choosing groups: [0.030s CPU, 0.030s wall-clock]
Building translation key... [0.020s CPU, 0.020s wall-clock]
Computing fact groups: [0.430s CPU, 0.430s wall-clock]
Building STRIPS to SAS dictionary... [0.010s CPU, 0.012s 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.010s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [0.510s CPU, 0.511s wall-clock]
Translating task: [9.920s CPU, 9.924s wall-clock]
0 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
62 propositions removed
Detecting unreachable propositions: [4.970s CPU, 4.965s wall-clock]
Reordering and filtering variables...
62 of 62 variables necessary.
0 of 62 mutex groups necessary.
30632 of 30632 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [1.460s CPU, 1.456s wall-clock]
Translator variables: 62
Translator derived variables: 0
Translator facts: 1630
Translator goal facts: 46
Translator mutex groups: 0
Translator total mutex groups size: 0
Translator operators: 30632
Translator axioms: 0
Translator task size: 184162
Translator peak memory: 156688 KB
Writing output... [3.170s CPU, 3.403s wall-clock]
Done! [35.700s CPU, 35.927s wall-clock]
planner.py version 0.0.1
Time: 7.83s
Memory: 560MB
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 : 8.993s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 7.868s
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 : 555062
Atoms : 555062
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 : 696MB
Max. Length : 0 steps
Models : 0
[endof: stats after solve call]
Solving Time: 0.04s
Memory: 632MB (+72MB)
UNSAT
Iteration Time: 0.04s
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: 632MB
Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])]
Grounding Time: 2.67s
Memory: 632MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0
Calls : 2
Time : 14.271s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 13.144s
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 : 555062
Atoms : 555062
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 137565 (Eliminated: 0 Frozen: 6510)
Constraints : 291918 (Binary: 98.0% Ternary: 0.9% Other: 1.1%)
Memory Peak : 696MB
Max. Length : 0 steps
Models : 0
[endof: stats after solve call]
Solving Time: 0.79s
Memory: 673MB (+41MB)
UNSAT
Iteration Time: 5.29s
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: 714.0MB
Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])]
Grounding Time: 3.00s
Memory: 702MB (+29MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 3
Time : 22.838s (Solving: 3.92s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 21.712s
Choices : 110230 (Domain: 110230)
Conflicts : 10452 (Analyzed: 10452)
Restarts : 100 (Average: 104.52 Last: 130)
Problems : 3 (Average Length: 7.00 Splits: 0)
Lemmas : 10452 (Deleted: 5985)
Binary : 381 (Ratio: 3.65%)
Ternary : 175 (Ratio: 1.67%)
Conflict : 10452 (Average Length: 446.1 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 10452 (Average: 9.80 Max: 885 Sum: 102453)
Executed : 10448 (Average: 9.80 Max: 885 Sum: 102438 Ratio: 99.99%)
Bounded : 4 (Average: 3.75 Max: 12 Sum: 15 Ratio: 0.01%)
Rules : 555062
Atoms : 555062
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 303354 (Eliminated: 0 Frozen: 14380)
Constraints : 1637246 (Binary: 98.7% Ternary: 0.6% Other: 0.7%)
Memory Peak : 757MB
Max. Length : 5 steps
Models : 0
[endof: stats after solve call]
Solving Time: 4.06s
Memory: 757MB (+55MB)
UNKNOWN
Iteration Time: 8.58s
Iteration 4
Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 10
Expected Memory: 841.0MB
Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])]
Grounding Time: 2.63s
Memory: 815MB (+58MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 4
Time : 36.663s (Solving: 13.53s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 35.544s
Choices : 509637 (Domain: 509637)
Conflicts : 22205 (Analyzed: 22205)
Restarts : 200 (Average: 111.03 Last: 130)
Problems : 4 (Average Length: 9.50 Splits: 0)
Lemmas : 22205 (Deleted: 17570)
Binary : 623 (Ratio: 2.81%)
Ternary : 322 (Ratio: 1.45%)
Conflict : 22205 (Average Length: 551.6 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 22205 (Average: 21.26 Max: 1387 Sum: 471979)
Executed : 22197 (Average: 21.25 Max: 1387 Sum: 471912 Ratio: 99.99%)
Bounded : 8 (Average: 8.38 Max: 17 Sum: 67 Ratio: 0.01%)
Rules : 555062
Atoms : 555062
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 473135 (Eliminated: 0 Frozen: 22430)
Constraints : 3023667 (Binary: 98.7% Ternary: 0.6% Other: 0.7%)
Memory Peak : 929MB
Max. Length : 10 steps
Models : 0
[endof: stats after solve call]
Solving Time: 9.78s
Memory: 929MB (+114MB)
UNKNOWN
Iteration Time: 13.84s
Iteration 5
Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 15
Expected Memory: 1101.0MB
Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])]
Grounding Time: 2.77s
Memory: 985MB (+56MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 5
Time : 54.507s (Solving: 26.96s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 53.396s
Choices : 1006959 (Domain: 1006959)
Conflicts : 32785 (Analyzed: 32785)
Restarts : 300 (Average: 109.28 Last: 130)
Problems : 5 (Average Length: 12.00 Splits: 0)
Lemmas : 32785 (Deleted: 26424)
Binary : 720 (Ratio: 2.20%)
Ternary : 365 (Ratio: 1.11%)
Conflict : 32785 (Average Length: 628.0 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 32785 (Average: 26.82 Max: 1871 Sum: 879168)
Executed : 32775 (Average: 26.81 Max: 1871 Sum: 879057 Ratio: 99.99%)
Bounded : 10 (Average: 11.10 Max: 22 Sum: 111 Ratio: 0.01%)
Rules : 555062
Atoms : 555062
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 642916 (Eliminated: 0 Frozen: 30480)
Constraints : 4410070 (Binary: 98.7% Ternary: 0.6% Other: 0.7%)
Memory Peak : 1100MB
Max. Length : 15 steps
Models : 0
[endof: stats after solve call]
Solving Time: 13.63s
Memory: 1042MB (+57MB)
UNKNOWN
Iteration Time: 17.86s
Iteration 6
Queue: [(5,25,0,True), (6,30,0,True)]
Grounded Until: 20
Expected Memory: 1214.0MB
Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])]
Grounding Time: 3.32s
Memory: 1161MB (+119MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 6
Time : 79.155s (Solving: 46.54s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 78.028s
Choices : 1568625 (Domain: 1568625)
Conflicts : 43383 (Analyzed: 43383)
Restarts : 400 (Average: 108.46 Last: 185)
Problems : 6 (Average Length: 14.50 Splits: 0)
Lemmas : 43383 (Deleted: 36804)
Binary : 838 (Ratio: 1.93%)
Ternary : 442 (Ratio: 1.02%)
Conflict : 43383 (Average Length: 692.9 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 43383 (Average: 31.14 Max: 1871 Sum: 1350896)
Executed : 43362 (Average: 31.13 Max: 1871 Sum: 1350488 Ratio: 99.97%)
Bounded : 21 (Average: 19.43 Max: 27 Sum: 408 Ratio: 0.03%)
Rules : 555062
Atoms : 555062
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 812697 (Eliminated: 0 Frozen: 38530)
Constraints : 5796482 (Binary: 98.7% Ternary: 0.6% Other: 0.7%)
Memory Peak : 1306MB
Max. Length : 20 steps
Models : 0
[endof: stats after solve call]
Solving Time: 19.76s
Memory: 1271MB (+110MB)
UNKNOWN
Iteration Time: 24.64s
Iteration 7
Queue: [(6,30,0,True)]
Grounded Until: 25
Expected Memory: 1500.0MB
Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])]
Grounding Time: 2.64s
Memory: 1327MB (+56MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 7
Time : 109.871s (Solving: 72.78s 1st Model: 0.00s Unsat: 0.00s)
CPU Time : 108.756s
Choices : 2168004 (Domain: 2168004)
Conflicts : 53633 (Analyzed: 53633)
Restarts : 500 (Average: 107.27 Last: 185)
Problems : 7 (Average Length: 17.00 Splits: 0)
Lemmas : 53633 (Deleted: 47049)
Binary : 881 (Ratio: 1.64%)
Ternary : 467 (Ratio: 0.87%)
Conflict : 53633 (Average Length: 836.5 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 53633 (Average: 34.18 Max: 2856 Sum: 1832946)
Executed : 53612 (Average: 34.17 Max: 2856 Sum: 1832538 Ratio: 99.98%)
Bounded : 21 (Average: 19.43 Max: 27 Sum: 408 Ratio: 0.02%)
Rules : 555062
Atoms : 555062
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 982478 (Eliminated: 0 Frozen: 46580)
Constraints : 7182813 (Binary: 98.8% Ternary: 0.6% Other: 0.7%)
Memory Peak : 1474MB
Max. Length : 25 steps
Models : 0
[endof: stats after solve call]
Solving Time: 26.49s
Memory: 1381MB (+54MB)
UNKNOWN
Iteration Time: 30.74s
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 : 110.773s (Solving: 73.45s 1st Model: 0.00s Unsat: 0.67s)
CPU Time : 109.656s
Choices : 2172002 (Domain: 2172002)
Conflicts : 54714 (Analyzed: 54713)
Restarts : 513 (Average: 106.65 Last: 185)
Problems : 8 (Average Length: 18.88 Splits: 0)
Lemmas : 54713 (Deleted: 47049)
Binary : 904 (Ratio: 1.65%)
Ternary : 483 (Ratio: 0.88%)
Conflict : 54713 (Average Length: 829.4 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 54713 (Average: 33.57 Max: 2856 Sum: 1836749)
Executed : 54689 (Average: 33.56 Max: 2856 Sum: 1836338 Ratio: 99.98%)
Bounded : 24 (Average: 17.12 Max: 27 Sum: 411 Ratio: 0.02%)
Rules : 555062
Atoms : 555062
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 982478 (Eliminated: 0 Frozen: 46580)
Constraints : 7182813 (Binary: 98.8% Ternary: 0.6% Other: 0.7%)
Memory Peak : 1474MB
Max. Length : 30 steps
Models : 0
[endof: stats after solve call]
Solving Time: 0.83s
Memory: 1381MB (+0MB)
UNSAT
Iteration Time: 0.90s
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 : 119.597s (Solving: 82.03s 1st Model: 0.00s Unsat: 0.67s)
CPU Time : 118.468s
Choices : 2504466 (Domain: 2504466)
Conflicts : 65868 (Analyzed: 65867)
Restarts : 613 (Average: 107.45 Last: 185)
Problems : 9 (Average Length: 20.33 Splits: 0)
Lemmas : 65867 (Deleted: 57741)
Binary : 968 (Ratio: 1.47%)
Ternary : 530 (Ratio: 0.80%)
Conflict : 65867 (Average Length: 752.2 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 65867 (Average: 32.44 Max: 2856 Sum: 2136836)
Executed : 65841 (Average: 32.43 Max: 2856 Sum: 2136392 Ratio: 99.98%)
Bounded : 26 (Average: 17.08 Max: 32 Sum: 444 Ratio: 0.02%)
Rules : 555062
Atoms : 555062
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 982478 (Eliminated: 0 Frozen: 46580)
Constraints : 7182813 (Binary: 98.8% Ternary: 0.6% Other: 0.7%)
Memory Peak : 1474MB
Max. Length : 30 steps
Models : 0
[endof: stats after solve call]
Solving Time: 8.72s
Memory: 1381MB (+0MB)
UNKNOWN
Iteration Time: 8.82s
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 : 132.870s (Solving: 95.05s 1st Model: 0.00s Unsat: 0.67s)
CPU Time : 131.748s
Choices : 2993560 (Domain: 2993560)
Conflicts : 77203 (Analyzed: 77202)
Restarts : 713 (Average: 108.28 Last: 185)
Problems : 10 (Average Length: 21.50 Splits: 0)
Lemmas : 77202 (Deleted: 69154)
Binary : 1056 (Ratio: 1.37%)
Ternary : 590 (Ratio: 0.76%)
Conflict : 77202 (Average Length: 723.1 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 77202 (Average: 33.09 Max: 2968 Sum: 2554955)
Executed : 77173 (Average: 33.09 Max: 2968 Sum: 2554508 Ratio: 99.98%)
Bounded : 29 (Average: 15.41 Max: 32 Sum: 447 Ratio: 0.02%)
Rules : 555062
Atoms : 555062
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 982478 (Eliminated: 0 Frozen: 46580)
Constraints : 7182804 (Binary: 98.8% Ternary: 0.6% Other: 0.7%)
Memory Peak : 1474MB
Max. Length : 30 steps
Models : 0
[endof: stats after solve call]
Solving Time: 13.18s
Memory: 1381MB (+0MB)
UNKNOWN
Iteration Time: 13.28s
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 : 150.377s (Solving: 112.31s 1st Model: 0.00s Unsat: 0.67s)
CPU Time : 149.232s
Choices : 3613965 (Domain: 3613965)
Conflicts : 87689 (Analyzed: 87688)
Restarts : 813 (Average: 107.86 Last: 185)
Problems : 11 (Average Length: 22.45 Splits: 0)
Lemmas : 87688 (Deleted: 76702)
Binary : 1109 (Ratio: 1.26%)
Ternary : 619 (Ratio: 0.71%)
Conflict : 87688 (Average Length: 721.8 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 87688 (Average: 34.95 Max: 4867 Sum: 3064979)
Executed : 87655 (Average: 34.95 Max: 4867 Sum: 3064466 Ratio: 99.98%)
Bounded : 33 (Average: 15.55 Max: 32 Sum: 513 Ratio: 0.02%)
Rules : 555062
Atoms : 555062
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 982478 (Eliminated: 0 Frozen: 46580)
Constraints : 7182804 (Binary: 98.8% Ternary: 0.6% Other: 0.7%)
Memory Peak : 1474MB
Max. Length : 30 steps
Models : 0
[endof: stats after solve call]
Solving Time: 17.39s
Memory: 1381MB (+0MB)
UNKNOWN
Iteration Time: 17.49s
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 : 1+
Calls : 12
Time : 163.212s (Solving: 124.92s 1st Model: 12.51s Unsat: 0.67s)
CPU Time : 162.072s
Choices : 4152367 (Domain: 4151878)
Conflicts : 92506 (Analyzed: 92505)
Restarts : 856 (Average: 108.07 Last: 185)
Model-Level : 5008.0
Problems : 12 (Average Length: 23.25 Splits: 0)
Lemmas : 92505 (Deleted: 82956)
Binary : 1152 (Ratio: 1.25%)
Ternary : 638 (Ratio: 0.69%)
Conflict : 92505 (Average Length: 715.2 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 92505 (Average: 38.06 Max: 4867 Sum: 3520383)
Executed : 92472 (Average: 38.05 Max: 4867 Sum: 3519870 Ratio: 99.99%)
Bounded : 33 (Average: 15.55 Max: 32 Sum: 513 Ratio: 0.01%)
Rules : 555062
Atoms : 555062
Bodies : 1 (Original: 0)
Tight : Yes
Variables : 982478 (Eliminated: 0 Frozen: 46580)
Constraints : 7182786 (Binary: 98.8% Ternary: 0.6% Other: 0.7%)
Memory Peak : 1474MB
Max. Length : 30 steps
Models : 1
[endof: stats after solve call]
Solving Time: 12.77s
Memory: 1381MB (+0MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time: 14.19s
Memory: 1710MB (+329MB)
Solving...
[start: stats after solve call]
Models : 0+
Calls : 13
Time : 238.353s (Solving: 190.82s 1st Model: 12.51s Unsat: 0.67s)
CPU Time : 237.204s
Choices : 5255235 (Domain: 5254746)
Conflicts : 102348 (Analyzed: 102347)
Restarts : 956 (Average: 107.06 Last: 185)
Model-Level : 5008.0
Problems : 13 (Average Length: 23.92 Splits: 0)
Lemmas : 102347 (Deleted: 90986)
Binary : 1275 (Ratio: 1.25%)
Ternary : 717 (Ratio: 0.70%)
Conflict : 102347 (Average Length: 720.0 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 102347 (Average: 44.65 Max: 4867 Sum: 4569389)
Executed : 102277 (Average: 44.63 Max: 4867 Sum: 4567692 Ratio: 99.96%)
Bounded : 70 (Average: 24.24 Max: 32 Sum: 1697 Ratio: 0.04%)
Rules : 2974418 (Original: 2974357)
Atoms : 619779
Bodies : 1577942 (Original: 1577880)
Count : 1775 (Original: 1780)
Equivalences : 795655 (Atom=Atom: 44 Body=Body: 0 Other: 795611)
Tight : Yes
Variables : 986172 (Eliminated: 0 Frozen: 842043)
Constraints : 9543170 (Binary: 99.0% Ternary: 0.5% Other: 0.5%)
Memory Peak : 1710MB
Max. Length : 30 steps
Models : 1
[endof: stats after solve call]
Solving Time: 67.52s
Memory: 1606MB (+-104MB)
UNKNOWN
Iteration Time: 94.55s
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: 1835.0MB
Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])]
Grounding Time: 4.90s
Memory: 1686MB (+80MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 14
Time : 276.876s (Solving: 222.22s 1st Model: 12.51s Unsat: 0.67s)
CPU Time : 275.708s
Choices : 6423523 (Domain: 6423034)
Conflicts : 111572 (Analyzed: 111571)
Restarts : 1056 (Average: 105.65 Last: 185)
Model-Level : 5008.0
Problems : 14 (Average Length: 24.86 Splits: 0)
Lemmas : 111571 (Deleted: 100305)
Binary : 1410 (Ratio: 1.26%)
Ternary : 748 (Ratio: 0.67%)
Conflict : 111571 (Average Length: 739.2 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 111571 (Average: 50.14 Max: 5887 Sum: 5594438)
Executed : 111364 (Average: 50.08 Max: 5887 Sum: 5587672 Ratio: 99.88%)
Bounded : 207 (Average: 32.69 Max: 37 Sum: 6766 Ratio: 0.12%)
Rules : 2974418 (Original: 2974357)
Atoms : 619779
Bodies : 1577942 (Original: 1577880)
Count : 1775 (Original: 1780)
Equivalences : 795655 (Atom=Atom: 44 Body=Body: 0 Other: 795611)
Tight : Yes
Variables : 1156573 (Eliminated: 0 Frozen: 1003563)
Constraints : 11364174 (Binary: 99.0% Ternary: 0.4% Other: 0.5%)
Memory Peak : 2045MB
Max. Length : 30 steps
Models : 1
[endof: stats after solve call]
Solving Time: 31.65s
Memory: 1981MB (+295MB)
UNKNOWN
Iteration Time: 38.52s
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: 2356.0MB
Grounding... [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])]
Grounding Time: 5.04s
Memory: 1981MB (+0MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 15
Time : 348.186s (Solving: 286.06s 1st Model: 12.51s Unsat: 0.67s)
CPU Time : 347.048s
Choices : 8573723 (Domain: 8573234)
Conflicts : 120781 (Analyzed: 120780)
Restarts : 1156 (Average: 104.48 Last: 185)
Model-Level : 5008.0
Problems : 15 (Average Length: 26.00 Splits: 0)
Lemmas : 120780 (Deleted: 109200)
Binary : 1557 (Ratio: 1.29%)
Ternary : 850 (Ratio: 0.70%)
Conflict : 120780 (Average Length: 706.5 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 120780 (Average: 63.85 Max: 5887 Sum: 7712234)
Executed : 120444 (Average: 63.75 Max: 5887 Sum: 7700050 Ratio: 99.84%)
Bounded : 336 (Average: 36.26 Max: 42 Sum: 12184 Ratio: 0.16%)
Rules : 2974418 (Original: 2974357)
Atoms : 619779
Bodies : 1577942 (Original: 1577880)
Count : 1775 (Original: 1780)
Equivalences : 795655 (Atom=Atom: 44 Body=Body: 0 Other: 795611)
Tight : Yes
Variables : 1326974 (Eliminated: 0 Frozen: 1165083)
Constraints : 13056068 (Binary: 99.0% Ternary: 0.4% Other: 0.5%)
Memory Peak : 2178MB
Max. Length : 35 steps
Models : 1
[endof: stats after solve call]
Solving Time: 64.17s
Memory: 2051MB (+70MB)
UNKNOWN
Iteration Time: 71.35s
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: 2426.0MB
Grounding... [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])]
Grounding Time: 5.00s
Memory: 2115MB (+64MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 16
Time : 422.845s (Solving: 353.25s 1st Model: 12.51s Unsat: 0.67s)
CPU Time : 421.632s
Choices : 10831952 (Domain: 10831463)
Conflicts : 130639 (Analyzed: 130638)
Restarts : 1256 (Average: 104.01 Last: 185)
Model-Level : 5008.0
Problems : 16 (Average Length: 27.31 Splits: 0)
Lemmas : 130638 (Deleted: 118120)
Binary : 1626 (Ratio: 1.24%)
Ternary : 886 (Ratio: 0.68%)
Conflict : 130638 (Average Length: 704.5 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 130638 (Average: 74.56 Max: 6085 Sum: 9740428)
Executed : 130249 (Average: 74.45 Max: 6085 Sum: 9725753 Ratio: 99.85%)
Bounded : 389 (Average: 37.72 Max: 47 Sum: 14675 Ratio: 0.15%)
Rules : 2974418 (Original: 2974357)
Atoms : 619779
Bodies : 1577942 (Original: 1577880)
Count : 1775 (Original: 1780)
Equivalences : 795655 (Atom=Atom: 44 Body=Body: 0 Other: 795611)
Tight : Yes
Variables : 1497375 (Eliminated: 0 Frozen: 1326603)
Constraints : 14808262 (Binary: 99.0% Ternary: 0.4% Other: 0.5%)
Memory Peak : 2346MB
Max. Length : 40 steps
Models : 1
[endof: stats after solve call]
Solving Time: 67.44s
Memory: 2226MB (+111MB)
UNKNOWN
Iteration Time: 74.60s
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: 2601.0MB
Grounding... [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])]
Grounding Time: 6.47s
Memory: 2369MB (+143MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 17
Time : 569.110s (Solving: 490.45s 1st Model: 12.51s Unsat: 0.67s)
CPU Time : 567.956s
Choices : 13539427 (Domain: 13538938)
Conflicts : 140518 (Analyzed: 140517)
Restarts : 1356 (Average: 103.63 Last: 185)
Model-Level : 5008.0
Problems : 17 (Average Length: 28.76 Splits: 0)
Lemmas : 140517 (Deleted: 128707)
Binary : 1699 (Ratio: 1.21%)
Ternary : 963 (Ratio: 0.69%)
Conflict : 140517 (Average Length: 696.5 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 140517 (Average: 88.14 Max: 6085 Sum: 12385776)
Executed : 140106 (Average: 88.03 Max: 6085 Sum: 12369957 Ratio: 99.87%)
Bounded : 411 (Average: 38.49 Max: 52 Sum: 15819 Ratio: 0.13%)
Rules : 2974418 (Original: 2974357)
Atoms : 619779
Bodies : 1577942 (Original: 1577880)
Count : 1775 (Original: 1780)
Equivalences : 795655 (Atom=Atom: 44 Body=Body: 0 Other: 795611)
Tight : Yes
Variables : 1667776 (Eliminated: 0 Frozen: 1488123)
Constraints : 16649909 (Binary: 99.0% Ternary: 0.4% Other: 0.5%)
Memory Peak : 2620MB
Max. Length : 45 steps
Models : 1
[endof: stats after solve call]
Solving Time: 137.61s
Memory: 2520MB (+151MB)
UNKNOWN
Iteration Time: 146.33s
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: 2895.0MB
Grounding... [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])]
Grounding Time: 4.78s
Memory: 2593MB (+73MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 18
Time : 735.008s (Solving: 648.96s 1st Model: 12.51s Unsat: 0.67s)
CPU Time : 733.924s
Choices : 16447134 (Domain: 16446645)
Conflicts : 150184 (Analyzed: 150183)
Restarts : 1456 (Average: 103.15 Last: 185)
Model-Level : 5008.0
Problems : 18 (Average Length: 30.33 Splits: 0)
Lemmas : 150183 (Deleted: 137959)
Binary : 1739 (Ratio: 1.16%)
Ternary : 1019 (Ratio: 0.68%)
Conflict : 150183 (Average Length: 701.3 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 150183 (Average: 101.34 Max: 6151 Sum: 15218839)
Executed : 149757 (Average: 101.22 Max: 6151 Sum: 15202165 Ratio: 99.89%)
Bounded : 426 (Average: 39.14 Max: 57 Sum: 16674 Ratio: 0.11%)
Rules : 2974418 (Original: 2974357)
Atoms : 619779
Bodies : 1577942 (Original: 1577880)
Count : 1775 (Original: 1780)
Equivalences : 795655 (Atom=Atom: 44 Body=Body: 0 Other: 795611)
Tight : Yes
Variables : 1838177 (Eliminated: 0 Frozen: 1649643)
Constraints : 18487302 (Binary: 99.0% Ternary: 0.4% Other: 0.5%)
Memory Peak : 2877MB
Max. Length : 50 steps
Models : 1
[endof: stats after solve call]
Solving Time: 158.95s
Memory: 2696MB (+103MB)
UNKNOWN
Iteration Time: 165.98s
Iteration 18
Queue: [(12,60,0,True), (13,65,0,True), (14,70,0,True), (15,75,0,True)]
Grounded Until: 55
Expected Memory: 3071.0MB
Grounding... [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])]
Grounding Time: 4.83s
Memory: 2760MB (+64MB)
Unblocking actions...
Solving...
[start: stats after solve call]
Models : 0+
Calls : 19
Time : 849.807s (Solving: 756.21s 1st Model: 12.51s Unsat: 0.67s)
CPU Time : 848.768s
Choices : 17965691 (Domain: 17965202)
Conflicts : 159880 (Analyzed: 159879)
Restarts : 1556 (Average: 102.75 Last: 185)
Model-Level : 5008.0
Problems : 19 (Average Length: 32.00 Splits: 0)
Lemmas : 159879 (Deleted: 146152)
Binary : 1782 (Ratio: 1.11%)
Ternary : 1089 (Ratio: 0.68%)
Conflict : 159879 (Average Length: 707.0 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 159879 (Average: 104.11 Max: 6151 Sum: 16644501)
Executed : 159431 (Average: 103.99 Max: 6151 Sum: 16626463 Ratio: 99.89%)
Bounded : 448 (Average: 40.26 Max: 62 Sum: 18038 Ratio: 0.11%)
Rules : 2974418 (Original: 2974357)
Atoms : 619779
Bodies : 1577942 (Original: 1577880)
Count : 1775 (Original: 1780)
Equivalences : 795655 (Atom=Atom: 44 Body=Body: 0 Other: 795611)
Tight : Yes
Variables : 2008578 (Eliminated: 0 Frozen: 1811163)
Constraints : 20329365 (Binary: 99.0% Ternary: 0.4% Other: 0.5%)
Memory Peak : 3053MB
Max. Length : 55 steps
Models : 1
[endof: stats after solve call]
Solving Time: 107.68s
Memory: 2857MB (+97MB)
UNKNOWN
Iteration Time: 114.85s
Iteration 19
Queue: [(13,65,0,True), (14,70,0,True), (15,75,0,True)]
Grounded Until: 60
Expected Memory: 3232.0MB
Grounding... [('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('check', [65])]
Grounding Time: 4.88s
Memory: 2926MB (+69MB)
*** Info : (planner): INTERRUPTED by signal!
UNKNOWN
INTERRUPTED : 1
Models : 0+
Calls : 19
Time : 849.807s (Solving: 756.21s 1st Model: 12.51s Unsat: 0.67s)
CPU Time : 848.768s
Choices : 17965691 (Domain: 17965202)
Conflicts : 159880 (Analyzed: 159879)
Restarts : 1556 (Average: 102.75 Last: 185)
Model-Level : 5008.0
Problems : 19 (Average Length: 32.00 Splits: 0)
Lemmas : 159879 (Deleted: 146152)
Binary : 1782 (Ratio: 1.11%)
Ternary : 1089 (Ratio: 0.68%)
Conflict : 159879 (Average Length: 707.0 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 159879 (Average: 104.11 Max: 6151 Sum: 16644501)
Executed : 159431 (Average: 103.99 Max: 6151 Sum: 16626463 Ratio: 99.89%)
Bounded : 448 (Average: 40.26 Max: 62 Sum: 18038 Ratio: 0.11%)
Rules : 2974418 (Original: 2974357)
Atoms : 619779
Bodies : 1577942 (Original: 1577880)
Count : 1775 (Original: 1780)
Equivalences : 795655 (Atom=Atom: 44 Body=Body: 0 Other: 795611)
Tight : Yes
Variables : 2008578 (Eliminated: 0 Frozen: 1811163)
Constraints : 20329365 (Binary: 99.0% Ternary: 0.4% Other: 0.5%)
Memory Peak : 3240MB
Max. Length : 60 steps
Models : 1