From 0d87584e28f54b3a6cf079d62bcdf7fb3be6c5d0 Mon Sep 17 00:00:00 2001 From: potassco-bot Date: Thu, 1 Feb 2018 22:46:56 +0100 Subject: [PATCH] Add benchmark result [gc-ta1-tt1 | ipc-2000 | blocks-strips-typed | 75] --- .../ipc-2000_blocks-strips-typed_75.env | 54 + .../ipc-2000_blocks-strips-typed_75.err | 9 + .../ipc-2000_blocks-strips-typed_75.out | 1471 +++++++++++++++++ 3 files changed, 1534 insertions(+) create mode 100644 gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.env create mode 100644 gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.err create mode 100644 gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.out diff --git a/gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.env b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.env new file mode 100644 index 000000000..dc9996436 --- /dev/null +++ b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.env @@ -0,0 +1,54 @@ +command: +- timeout +- -m=9216000 +- -t=900 +- python3 +- /home/pluehne/Documents/ASP/plasp-javier/encodings/planner/runplanner.py +- --domain=/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-75.pddl +- --stats +- --stats-iter +- --verbose +- --print-call +- -m 8192 +- --translate +- -B 0.9 +- --parallel=0 +- --shallow +- --use-heuristic +- --test-until-not-sat +- --test=0 +- --test-add=1 +- --test-times=1 +configuration: + id: gc-ta1-tt1 + instanceSets: + - rintanen-aij-2012-interesting + options: + - --stats + - --stats-iter + - --verbose + - --print-call + - -m 8192 + - --translate + - -B 0.9 + - --parallel=0 + - --shallow + - --use-heuristic + - --test-until-not-sat + - --test=0 + - --test-add=1 + - --test-times=1 +exitCode: 0 +instance: + domain: blocks-strips-typed + instance: 75 + ipc: ipc-2000 +versions: + clingo: 5.2.2 + fastDownward: 10997:847cdf0069cab0c8841a9958e783d1a7340fe2e9 (2017-11-02 15:10 +0100) + planner: f090434475c02dbccc3811039498f2a63a357ddc (2018-02-01 18:15:39 +0100) + plasp: 3.1.1 + python: 3.6.3 +workingDirectory: /home/pluehne/Documents/ASP/plasp-javier/encodings/planner + diff --git a/gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.err b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.err new file mode 100644 index 000000000..9b746cd1d --- /dev/null +++ b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.err @@ -0,0 +1,9 @@ +# configuration: {'id': 'gc-ta1-tt1', 'options': ['--stats', '--stats-iter', '--verbose', '--print-call', '-m 8192', '--translate', '-B 0.9', '--parallel=0', '--shallow', '--use-heuristic', '--test-until-not-sat', '--test=0', '--test-add=1', '--test-times=1'], 'instanceSets': ['rintanen-aij-2012-interesting']} +# instance: {'ipc': 'ipc-2000', 'domain': 'blocks-strips-typed', 'instance': 75} +# command: ['timeout', '-m=9216000', '-t=900', 'python3', '/home/pluehne/Documents/ASP/plasp-javier/encodings/planner/runplanner.py', '--domain=/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-75.pddl', '--stats', '--stats-iter', '--verbose', '--print-call', '-m 8192', '--translate', '-B 0.9', '--parallel=0', '--shallow', '--use-heuristic', '--test-until-not-sat', '--test=0', '--test-add=1', '--test-times=1'] +# working directory: /home/pluehne/Documents/ASP/plasp-javier/encodings/planner +# exit code: 0 +# planner call: /home/wv/bin/linux/64/fast-downward/fast-downward.py --translate --build=release64 /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-75.pddl && plasp-3.1.1 translate --parsing-mode=compatibility output.sas | /home/pluehne/Documents/ASP/plasp-javier/encodings/planner/planner.py - /home/pluehne/Documents/ASP/plasp-javier/encodings/strips/preprocess.lp /home/pluehne/Documents/ASP/plasp-javier/encodings/strips/strips-incremental.lp --stats --stats-iter --verbose -m 8192 -B 0.9 --test-until-not-sat --query-at-last --check-at-last --forbid-actions --force-actions -c planner_on=1 --test=- --test=/home/pluehne/Documents/ASP/plasp-javier/encodings/planner/test_files/test.lp /home/pluehne/Documents/ASP/plasp-javier/encodings/planner/test_files/block_forall_t.lp --test-once --heuristic=Domain /home/pluehne/Documents/ASP/plasp-javier/encodings/planner/heuristic.lp -c _shallow=1 -c _closure=3 -c _parallel=0 +FINISHED CPU 36.07 MEM 33472 MAXMEM 940828 STALE 0 MAXMEM_RSS 804164 + + diff --git a/gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.out b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.out new file mode 100644 index 000000000..d10e0c291 --- /dev/null +++ b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_75.out @@ -0,0 +1,1471 @@ +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-75.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-75.pddl +Parsing... +Parsing: [0.030s CPU, 0.151s wall-clock] +Normalizing task... [0.000s CPU, 0.002s wall-clock] +Instantiating... +Generating Datalog program... [0.010s CPU, 0.010s wall-clock] +Normalizing Datalog program... +Normalizing Datalog program: [0.010s CPU, 0.014s wall-clock] +Preparing model... [0.020s CPU, 0.019s wall-clock] +Generated 21 rules. +Computing model... [0.550s CPU, 0.554s wall-clock] +4405 relevant atoms +2923 auxiliary atoms +7328 final queue length +12880 total queue pushes +Completing instantiation... [0.930s CPU, 0.942s wall-clock] +Instantiating: [1.540s CPU, 1.546s wall-clock] +Computing fact groups... +Finding invariants... +10 initial candidates +Finding invariants: [0.030s CPU, 0.030s wall-clock] +Checking invariant weight... [0.000s CPU, 0.005s wall-clock] +Instantiating groups... [0.060s CPU, 0.051s wall-clock] +Collecting mutex groups... [0.020s CPU, 0.012s wall-clock] +Choosing groups... +38 uncovered facts +Choosing groups: [0.050s CPU, 0.058s wall-clock] +Building translation key... [0.020s CPU, 0.019s wall-clock] +Computing fact groups: [0.310s CPU, 0.308s wall-clock] +Building STRIPS to SAS dictionary... [0.010s CPU, 0.013s wall-clock] +Building dictionary for full mutex groups... [0.020s CPU, 0.019s wall-clock] +Building mutex information... +Building mutex information: [0.030s CPU, 0.033s wall-clock] +Translating task... +Processing axioms... +Simplifying axioms... [0.000s CPU, 0.000s wall-clock] +Processing axioms: [0.050s CPU, 0.048s wall-clock] +Translating task: [1.090s CPU, 1.088s wall-clock] +4070 effect conditions simplified +0 implied preconditions added +Detecting unreachable propositions... +0 operators removed +0 axioms removed +74 propositions removed +Detecting unreachable propositions: [0.660s CPU, 0.658s wall-clock] +Reordering and filtering variables... +75 of 75 variables necessary. +38 of 75 mutex groups necessary. +2738 of 2738 operators necessary. +0 of 0 axiom rules necessary. +Reordering and filtering variables: [0.340s CPU, 0.337s wall-clock] +Translator variables: 75 +Translator derived variables: 0 +Translator facts: 1482 +Translator goal facts: 36 +Translator mutex groups: 38 +Translator total mutex groups size: 1444 +Translator operators: 2738 +Translator axioms: 0 +Translator task size: 23461 +Translator peak memory: 50124 KB +Writing output... [0.400s CPU, 0.421s wall-clock] +Done! [4.480s CPU, 4.627s wall-clock] +planner.py version 0.0.1 + +Time: 0.78s +Memory: 99MB + +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.890s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 0.788s + +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 : 71909 +Atoms : 71909 +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 : 235MB +Max. Length : 0 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.01s +Memory: 171MB (+72MB) +UNSAT +Iteration Time: 0.01s + +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: 171MB +Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])] +Grounding Time: 0.33s +Memory: 176MB (+5MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 2 +Time : 1.372s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 1.272s + +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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 19135 (Eliminated: 0 Frozen: 5961) +Constraints : 2356 (Binary: 88.5% Ternary: 5.8% Other: 5.7%) + +Memory Peak : 235MB +Max. Length : 0 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.03s +Memory: 182MB (+6MB) +UNSAT +Iteration Time: 0.49s + +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: 193.0MB +Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])] +Grounding Time: 0.38s +Memory: 198MB (+16MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 3 +Time : 1.930s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 1.832s + +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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 38401 (Eliminated: 0 Frozen: 12115) +Constraints : 13208 (Binary: 91.6% Ternary: 5.0% Other: 3.3%) + +Memory Peak : 235MB +Max. Length : 5 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.03s +Memory: 204MB (+6MB) +UNSAT +Iteration Time: 0.56s + +Iteration 4 +Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] +Grounded Until: 10 +Expected Memory: 226.0MB +Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])] +Grounding Time: 0.38s +Memory: 216MB (+12MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 4 +Time : 2.514s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 2.416s + +Choices : 0 +Conflicts : 0 (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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 57882 (Eliminated: 0 Frozen: 18459) +Constraints : 38560 (Binary: 93.0% Ternary: 4.7% Other: 2.3%) + +Memory Peak : 235MB +Max. Length : 10 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.04s +Memory: 224MB (+8MB) +UNSAT +Iteration Time: 0.59s + +Iteration 5 +Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)] +Grounded Until: 15 +Expected Memory: 246.0MB +Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])] +Grounding Time: 0.45s +Memory: 239MB (+15MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 5 +Time : 3.182s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 3.088s + +Choices : 0 +Conflicts : 0 (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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 77678 (Eliminated: 0 Frozen: 24993) +Constraints : 84662 (Binary: 93.7% Ternary: 4.5% Other: 1.8%) + +Memory Peak : 251MB +Max. Length : 15 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.04s +Memory: 250MB (+11MB) +UNSAT +Iteration Time: 0.68s + +Iteration 6 +Queue: [(5,25,0,True), (6,30,0,True)] +Grounded Until: 20 +Expected Memory: 276.0MB +Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])] +Grounding Time: 0.38s +Memory: 260MB (+10MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 6 +Time : 3.805s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 3.712s + +Choices : 0 +Conflicts : 0 (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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 97889 (Eliminated: 0 Frozen: 31717) +Constraints : 157764 (Binary: 94.1% Ternary: 4.4% Other: 1.4%) + +Memory Peak : 274MB +Max. Length : 20 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.04s +Memory: 274MB (+14MB) +UNSAT +Iteration Time: 0.63s + +Iteration 7 +Queue: [(6,30,0,True)] +Grounded Until: 25 +Expected Memory: 300.0MB +Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])] +Grounding Time: 0.41s +Memory: 283MB (+9MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 7 +Time : 4.469s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 4.376s + +Choices : 0 +Conflicts : 0 (Analyzed: 0) +Restarts : 0 +Problems : 7 (Average Length: 17.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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 118615 (Eliminated: 0 Frozen: 38631) +Constraints : 264116 (Binary: 94.4% Ternary: 4.4% Other: 1.2%) + +Memory Peak : 301MB +Max. Length : 25 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.04s +Memory: 289MB (+6MB) +UNSAT +Iteration Time: 0.67s + +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: 315.0MB +Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])] +Grounding Time: 0.41s +Memory: 300MB (+11MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 8 +Time : 5.141s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 5.048s + +Choices : 0 +Conflicts : 0 (Analyzed: 0) +Restarts : 0 +Problems : 8 (Average Length: 19.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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 139956 (Eliminated: 0 Frozen: 45735) +Constraints : 409961 (Binary: 94.7% Ternary: 4.3% Other: 1.0%) + +Memory Peak : 320MB +Max. Length : 30 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.04s +Memory: 307MB (+7MB) +UNSAT +Iteration Time: 0.68s + +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: 333.0MB +Grounding... [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])] +Grounding Time: 0.55s +Memory: 331MB (+24MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 9 +Time : 5.923s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 5.832s + +Choices : 0 +Conflicts : 1 (Analyzed: 0) +Restarts : 0 +Problems : 9 (Average Length: 22.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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 161970 (Eliminated: 0 Frozen: 52955) +Constraints : 581807 (Binary: 94.8% Ternary: 4.3% Other: 0.9%) + +Memory Peak : 357MB +Max. Length : 35 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.05s +Memory: 357MB (+26MB) +UNSAT +Iteration Time: 0.79s + +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: 407.0MB +Grounding... [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])] +Grounding Time: 0.38s +Memory: 358MB (+1MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 10 +Time : 6.558s (Solving: 0.01s 1st Model: 0.00s Unsat: 0.01s) +CPU Time : 6.468s + +Choices : 0 +Conflicts : 2 (Analyzed: 0) +Restarts : 0 +Problems : 10 (Average Length: 24.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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 184021 (Eliminated: 0 Frozen: 60175) +Constraints : 754087 (Binary: 94.8% Ternary: 4.3% Other: 0.9%) + +Memory Peak : 385MB +Max. Length : 40 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.06s +Memory: 367MB (+9MB) +UNSAT +Iteration Time: 0.64s + +Iteration 11 +Queue: [(10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)] +Grounded Until: 45 +Expected Memory: 417.0MB +Grounding... [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])] +Grounding Time: 0.39s +Memory: 380MB (+13MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 11 +Time : 7.220s (Solving: 0.02s 1st Model: 0.00s Unsat: 0.02s) +CPU Time : 7.132s + +Choices : 0 +Conflicts : 3 (Analyzed: 0) +Restarts : 0 +Problems : 11 (Average Length: 27.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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 206072 (Eliminated: 0 Frozen: 67395) +Constraints : 926367 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 410MB +Max. Length : 45 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.06s +Memory: 387MB (+7MB) +UNSAT +Iteration Time: 0.67s + +Iteration 12 +Queue: [(11,55,0,True), (12,60,0,True), (13,65,0,True)] +Grounded Until: 50 +Expected Memory: 437.0MB +Grounding... [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])] +Grounding Time: 0.40s +Memory: 400MB (+13MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 12 +Time : 7.910s (Solving: 0.04s 1st Model: 0.00s Unsat: 0.04s) +CPU Time : 7.824s + +Choices : 0 +Conflicts : 4 (Analyzed: 0) +Restarts : 0 +Problems : 12 (Average Length: 29.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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 228123 (Eliminated: 0 Frozen: 74615) +Constraints : 1098647 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 432MB +Max. Length : 50 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.07s +Memory: 427MB (+27MB) +UNSAT +Iteration Time: 0.70s + +Iteration 13 +Queue: [(12,60,0,True), (13,65,0,True)] +Grounded Until: 55 +Expected Memory: 477.0MB +Grounding... [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])] +Grounding Time: 0.39s +Memory: 427MB (+0MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 13 +Time : 8.612s (Solving: 0.06s 1st Model: 0.00s Unsat: 0.06s) +CPU Time : 8.524s + +Choices : 0 +Conflicts : 5 (Analyzed: 0) +Restarts : 0 +Problems : 13 (Average Length: 32.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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 250174 (Eliminated: 0 Frozen: 81835) +Constraints : 1270927 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 464MB +Max. Length : 55 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.08s +Memory: 440MB (+13MB) +UNSAT +Iteration Time: 0.71s + +Iteration 14 +Queue: [(13,65,0,True)] +Grounded Until: 60 +Expected Memory: 490.0MB +Grounding... [('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('check', [65])] +Grounding Time: 0.40s +Memory: 447MB (+7MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 14 +Time : 9.336s (Solving: 0.08s 1st Model: 0.00s Unsat: 0.08s) +CPU Time : 9.248s + +Choices : 0 +Conflicts : 6 (Analyzed: 0) +Restarts : 0 +Problems : 14 (Average Length: 34.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 : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 272225 (Eliminated: 0 Frozen: 89055) +Constraints : 1443207 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 485MB +Max. Length : 60 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.08s +Memory: 457MB (+10MB) +UNSAT +Iteration Time: 0.73s + +Iteration 15 +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)] +Grounded Until: 65 +Expected Memory: 507.0MB +Grounding... [('step', [66]), ('step', [67]), ('step', [68]), ('step', [69]), ('step', [70]), ('check', [70])] +Grounding Time: 0.41s +Memory: 467MB (+10MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 15 +Time : 10.086s (Solving: 0.10s 1st Model: 0.00s Unsat: 0.10s) +CPU Time : 9.996s + +Choices : 1 (Domain: 1) +Conflicts : 8 (Analyzed: 1) +Restarts : 0 +Problems : 15 (Average Length: 37.00 Splits: 0) +Lemmas : 1 (Deleted: 0) + Binary : 0 (Ratio: 0.00%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 1 (Average Length: 1.0 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 1 (Average: 73.00 Max: 73 Sum: 73) + Executed : 0 (Average: 1.00 Max: 1 Sum: 1 Ratio: 1.37%) + Bounded : 1 (Average: 72.00 Max: 72 Sum: 72 Ratio: 98.63%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 294276 (Eliminated: 0 Frozen: 96275) +Constraints : 1615487 (Binary: 94.9% Ternary: 4.3% Other: 0.7%) + +Memory Peak : 508MB +Max. Length : 65 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.09s +Memory: 477MB (+10MB) +UNSAT +Iteration Time: 0.76s + +Iteration 16 +Queue: [(15,75,0,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)] +Grounded Until: 70 +Expected Memory: 527.0MB +Grounding... [('step', [71]), ('step', [72]), ('step', [73]), ('step', [74]), ('step', [75]), ('check', [75])] +Grounding Time: 0.75s +Memory: 509MB (+32MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 16 +Time : 11.204s (Solving: 0.13s 1st Model: 0.00s Unsat: 0.13s) +CPU Time : 11.112s + +Choices : 46 (Domain: 46) +Conflicts : 24 (Analyzed: 16) +Restarts : 0 +Problems : 16 (Average Length: 39.50 Splits: 0) +Lemmas : 16 (Deleted: 0) + Binary : 1 (Ratio: 6.25%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 16 (Average Length: 1.1 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 16 (Average: 74.81 Max: 82 Sum: 1197) + Executed : 0 (Average: 2.88 Max: 5 Sum: 46 Ratio: 3.84%) + Bounded : 16 (Average: 71.94 Max: 77 Sum: 1151 Ratio: 96.16%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 316327 (Eliminated: 0 Frozen: 103495) +Constraints : 1779923 (Binary: 95.0% Ternary: 4.3% Other: 0.7%) + +Memory Peak : 553MB +Max. Length : 70 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.11s +Memory: 521MB (+12MB) +UNSAT +Iteration Time: 1.13s + +Iteration 17 +Queue: [(16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)] +Grounded Until: 75 +Expected Memory: 571.0MB +Grounding... [('step', [76]), ('step', [77]), ('step', [78]), ('step', [79]), ('step', [80]), ('check', [80])] +Grounding Time: 0.40s +Memory: 528MB (+7MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 17 +Time : 12.054s (Solving: 0.21s 1st Model: 0.00s Unsat: 0.21s) +CPU Time : 11.960s + +Choices : 197 (Domain: 197) +Conflicts : 66 (Analyzed: 57) +Restarts : 0 +Problems : 17 (Average Length: 42.00 Splits: 0) +Lemmas : 57 (Deleted: 0) + Binary : 2 (Ratio: 3.51%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 57 (Average Length: 1.0 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 57 (Average: 81.21 Max: 88 Sum: 4629) + Executed : 0 (Average: 3.46 Max: 6 Sum: 197 Ratio: 4.26%) + Bounded : 57 (Average: 77.75 Max: 82 Sum: 4432 Ratio: 95.74%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 338378 (Eliminated: 0 Frozen: 110715) +Constraints : 1905257 (Binary: 94.9% Ternary: 4.3% Other: 0.7%) + +Memory Peak : 574MB +Max. Length : 75 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.15s +Memory: 568MB (+40MB) +UNSAT +Iteration Time: 0.86s + +Iteration 18 +Queue: [(17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)] +Grounded Until: 80 +Expected Memory: 618.0MB +Grounding... [('step', [81]), ('step', [82]), ('step', [83]), ('step', [84]), ('step', [85]), ('check', [85])] +Grounding Time: 0.39s +Memory: 568MB (+0MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 18 +Time : 13.001s (Solving: 0.38s 1st Model: 0.00s Unsat: 0.38s) +CPU Time : 12.908s + +Choices : 448 (Domain: 448) +Conflicts : 133 (Analyzed: 123) +Restarts : 1 (Average: 123.00 Last: 41) +Problems : 18 (Average Length: 44.50 Splits: 0) +Lemmas : 123 (Deleted: 0) + Binary : 3 (Ratio: 2.44%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 123 (Average Length: 1.0 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 123 (Average: 85.66 Max: 93 Sum: 10536) + Executed : 0 (Average: 3.64 Max: 6 Sum: 448 Ratio: 4.25%) + Bounded : 123 (Average: 82.02 Max: 87 Sum: 10088 Ratio: 95.75%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 360429 (Eliminated: 0 Frozen: 117935) +Constraints : 1987595 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 617MB +Max. Length : 80 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.25s +Memory: 575MB (+7MB) +UNSAT +Iteration Time: 0.96s + +Iteration 19 +Queue: [(18,90,0,True), (19,95,0,True), (20,100,0,True)] +Grounded Until: 85 +Expected Memory: 625.0MB +Grounding... [('step', [86]), ('step', [87]), ('step', [88]), ('step', [89]), ('step', [90]), ('check', [90])] +Grounding Time: 0.52s +Memory: 581MB (+6MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 19 +Time : 14.334s (Solving: 0.67s 1st Model: 0.00s Unsat: 0.67s) +CPU Time : 14.244s + +Choices : 799 (Domain: 799) +Conflicts : 225 (Analyzed: 214) +Restarts : 2 (Average: 107.00 Last: 41) +Problems : 19 (Average Length: 47.00 Splits: 0) +Lemmas : 214 (Deleted: 0) + Binary : 4 (Ratio: 1.87%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 214 (Average Length: 1.0 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 214 (Average: 89.57 Max: 98 Sum: 19168) + Executed : 0 (Average: 3.73 Max: 6 Sum: 799 Ratio: 4.17%) + Bounded : 214 (Average: 85.84 Max: 92 Sum: 18369 Ratio: 95.83%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 382480 (Eliminated: 0 Frozen: 125155) +Constraints : 2041033 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 634MB +Max. Length : 85 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.40s +Memory: 596MB (+15MB) +UNSAT +Iteration Time: 1.35s + +Iteration 20 +Queue: [(19,95,0,True), (20,100,0,True)] +Grounded Until: 90 +Expected Memory: 646.0MB +Grounding... [('step', [91]), ('step', [92]), ('step', [93]), ('step', [94]), ('step', [95]), ('check', [95])] +Grounding Time: 0.41s +Memory: 600MB (+4MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 20 +Time : 15.615s (Solving: 1.10s 1st Model: 0.00s Unsat: 1.10s) +CPU Time : 15.524s + +Choices : 1250 (Domain: 1250) +Conflicts : 342 (Analyzed: 330) +Restarts : 3 (Average: 110.00 Last: 56) +Problems : 20 (Average Length: 49.50 Splits: 0) +Lemmas : 330 (Deleted: 0) + Binary : 5 (Ratio: 1.52%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 330 (Average Length: 1.0 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 330 (Average: 93.26 Max: 103 Sum: 30775) + Executed : 0 (Average: 3.79 Max: 6 Sum: 1250 Ratio: 4.06%) + Bounded : 330 (Average: 89.47 Max: 97 Sum: 29525 Ratio: 95.94%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 404531 (Eliminated: 0 Frozen: 132375) +Constraints : 2071821 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 656MB +Max. Length : 90 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.52s +Memory: 614MB (+14MB) +UNSAT +Iteration Time: 1.29s + +Iteration 21 +Queue: [(20,100,0,True)] +Grounded Until: 95 +Expected Memory: 664.0MB +Grounding... [('step', [96]), ('step', [97]), ('step', [98]), ('step', [99]), ('step', [100]), ('check', [100])] +Grounding Time: 0.42s +Memory: 620MB (+6MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 21 +Time : 17.113s (Solving: 1.73s 1st Model: 0.00s Unsat: 1.73s) +CPU Time : 17.024s + +Choices : 1801 (Domain: 1801) +Conflicts : 484 (Analyzed: 471) +Restarts : 5 (Average: 94.20 Last: 56) +Problems : 21 (Average Length: 52.00 Splits: 0) +Lemmas : 471 (Deleted: 0) + Binary : 6 (Ratio: 1.27%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 471 (Average Length: 1.0 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 471 (Average: 96.83 Max: 108 Sum: 45607) + Executed : 0 (Average: 3.82 Max: 6 Sum: 1801 Ratio: 3.95%) + Bounded : 471 (Average: 93.01 Max: 102 Sum: 43806 Ratio: 96.05%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 426582 (Eliminated: 0 Frozen: 139595) +Constraints : 2086209 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 679MB +Max. Length : 95 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.73s +Memory: 634MB (+14MB) +UNSAT +Iteration Time: 1.51s + +Iteration 22 +Queue: [(21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True)] +Grounded Until: 100 +Expected Memory: 684.0MB +Grounding... [('step', [101]), ('step', [102]), ('step', [103]), ('step', [104]), ('step', [105]), ('check', [105])] +Grounding Time: 0.41s +Memory: 635MB (+1MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 22 +Time : 18.116s (Solving: 1.84s 1st Model: 0.00s Unsat: 1.84s) +CPU Time : 18.028s + +Choices : 5999 (Domain: 5999) +Conflicts : 494 (Analyzed: 480) +Restarts : 5 (Average: 96.00 Last: 56) +Problems : 22 (Average Length: 54.50 Splits: 0) +Lemmas : 480 (Deleted: 0) + Binary : 11 (Ratio: 2.29%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 480 (Average Length: 17.2 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 480 (Average: 103.76 Max: 1528 Sum: 49806) + Executed : 8 (Average: 12.50 Max: 1528 Sum: 5999 Ratio: 12.04%) + Bounded : 472 (Average: 92.81 Max: 102 Sum: 43807 Ratio: 87.96%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 448633 (Eliminated: 0 Frozen: 146815) +Constraints : 2090447 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 700MB +Max. Length : 100 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.21s +Memory: 649MB (+14MB) +UNSAT +Iteration Time: 1.02s + +Iteration 23 +Queue: [(22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True)] +Grounded Until: 105 +Expected Memory: 699.0MB +Grounding... [('step', [106]), ('step', [107]), ('step', [108]), ('step', [109]), ('step', [110]), ('check', [110])] +Grounding Time: 0.43s +Memory: 656MB (+7MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 23 +Time : 19.150s (Solving: 2.00s 1st Model: 0.00s Unsat: 2.00s) +CPU Time : 19.060s + +Choices : 15731 (Domain: 15731) +Conflicts : 504 (Analyzed: 489) +Restarts : 5 (Average: 97.80 Last: 56) +Problems : 23 (Average Length: 57.00 Splits: 0) +Lemmas : 489 (Deleted: 0) + Binary : 16 (Ratio: 3.27%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 489 (Average Length: 33.7 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 489 (Average: 121.76 Max: 2590 Sum: 59539) + Executed : 16 (Average: 32.17 Max: 2590 Sum: 15731 Ratio: 26.42%) + Bounded : 473 (Average: 92.62 Max: 102 Sum: 43808 Ratio: 73.58%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 470684 (Eliminated: 0 Frozen: 154035) +Constraints : 2262727 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 723MB +Max. Length : 105 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.27s +Memory: 669MB (+13MB) +UNSAT +Iteration Time: 1.05s + +Iteration 24 +Queue: [(23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True)] +Grounded Until: 110 +Expected Memory: 719.0MB +Grounding... [('step', [111]), ('step', [112]), ('step', [113]), ('step', [114]), ('step', [115]), ('check', [115])] +Grounding Time: 0.43s +Memory: 672MB (+3MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 24 +Time : 20.460s (Solving: 2.41s 1st Model: 0.00s Unsat: 2.41s) +CPU Time : 20.368s + +Choices : 45357 (Domain: 45357) +Conflicts : 549 (Analyzed: 533) +Restarts : 5 (Average: 106.60 Last: 56) +Problems : 24 (Average Length: 59.50 Splits: 0) +Lemmas : 533 (Deleted: 0) + Binary : 31 (Ratio: 5.82%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 533 (Average Length: 78.1 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 533 (Average: 167.29 Max: 3246 Sum: 89167) + Executed : 58 (Average: 85.10 Max: 3246 Sum: 45357 Ratio: 50.87%) + Bounded : 475 (Average: 92.23 Max: 102 Sum: 43810 Ratio: 49.13%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 492735 (Eliminated: 0 Frozen: 161255) +Constraints : 2435007 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 739MB +Max. Length : 110 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.51s +Memory: 731MB (+59MB) +UNSAT +Iteration Time: 1.32s + +Iteration 25 +Queue: [(24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True)] +Grounded Until: 115 +Expected Memory: 793.0MB +Grounding... [('step', [116]), ('step', [117]), ('step', [118]), ('step', [119]), ('step', [120]), ('check', [120])] +Grounding Time: 0.42s +Memory: 731MB (+0MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 25 +Time : 21.981s (Solving: 3.03s 1st Model: 0.00s Unsat: 3.03s) +CPU Time : 21.888s + +Choices : 92078 (Domain: 92078) +Conflicts : 572 (Analyzed: 555) +Restarts : 5 (Average: 111.00 Last: 56) +Problems : 25 (Average Length: 62.00 Splits: 0) +Lemmas : 555 (Deleted: 0) + Binary : 47 (Ratio: 8.47%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 555 (Average Length: 84.0 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 555 (Average: 244.85 Max: 4582 Sum: 135891) + Executed : 77 (Average: 165.91 Max: 4582 Sum: 92078 Ratio: 67.76%) + Bounded : 478 (Average: 91.66 Max: 102 Sum: 43813 Ratio: 32.24%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 514786 (Eliminated: 0 Frozen: 168475) +Constraints : 2607287 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 794MB +Max. Length : 115 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.74s +Memory: 734MB (+3MB) +UNSAT +Iteration Time: 1.54s + +Iteration 26 +Queue: [(25,125,0,True), (26,130,0,True), (27,135,0,True)] +Grounded Until: 120 +Expected Memory: 796.0MB +Grounding... [('step', [121]), ('step', [122]), ('step', [123]), ('step', [124]), ('step', [125]), ('check', [125])] +Grounding Time: 0.42s +Memory: 734MB (+0MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 26 +Time : 23.520s (Solving: 3.65s 1st Model: 0.00s Unsat: 3.65s) +CPU Time : 23.428s + +Choices : 140367 (Domain: 140367) +Conflicts : 592 (Analyzed: 574) +Restarts : 5 (Average: 114.80 Last: 56) +Problems : 26 (Average Length: 64.50 Splits: 0) +Lemmas : 574 (Deleted: 0) + Binary : 62 (Ratio: 10.80%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 574 (Average Length: 95.6 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 574 (Average: 320.88 Max: 5169 Sum: 184183) + Executed : 93 (Average: 244.54 Max: 5169 Sum: 140367 Ratio: 76.21%) + Bounded : 481 (Average: 91.09 Max: 102 Sum: 43816 Ratio: 23.79%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 536837 (Eliminated: 0 Frozen: 175695) +Constraints : 2779567 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 812MB +Max. Length : 120 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.73s +Memory: 751MB (+17MB) +UNSAT +Iteration Time: 1.55s + +Iteration 27 +Queue: [(26,130,0,True), (27,135,0,True)] +Grounded Until: 125 +Expected Memory: 813.0MB +Grounding... [('step', [126]), ('step', [127]), ('step', [128]), ('step', [129]), ('step', [130]), ('check', [130])] +Grounding Time: 0.42s +Memory: 751MB (+0MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 27 +Time : 25.114s (Solving: 4.34s 1st Model: 0.00s Unsat: 4.34s) +CPU Time : 25.020s + +Choices : 192033 (Domain: 192033) +Conflicts : 616 (Analyzed: 597) +Restarts : 5 (Average: 119.40 Last: 56) +Problems : 27 (Average Length: 67.00 Splits: 0) +Lemmas : 597 (Deleted: 0) + Binary : 77 (Ratio: 12.90%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 597 (Average Length: 124.0 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 597 (Average: 395.06 Max: 6497 Sum: 235852) + Executed : 113 (Average: 321.66 Max: 6497 Sum: 192033 Ratio: 81.42%) + Bounded : 484 (Average: 90.54 Max: 102 Sum: 43819 Ratio: 18.58%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 558888 (Eliminated: 0 Frozen: 182915) +Constraints : 2951847 (Binary: 94.9% Ternary: 4.3% Other: 0.8%) + +Memory Peak : 832MB +Max. Length : 125 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.80s +Memory: 771MB (+20MB) +UNSAT +Iteration Time: 1.61s + +Iteration 28 +Queue: [(27,135,0,True)] +Grounded Until: 130 +Expected Memory: 833.0MB +Grounding... [('step', [131]), ('step', [132]), ('step', [133]), ('step', [134]), ('step', [135]), ('check', [135])] +Grounding Time: 0.43s +Memory: 775MB (+4MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 28 +Time : 26.837s (Solving: 5.11s 1st Model: 0.00s Unsat: 5.11s) +CPU Time : 26.744s + +Choices : 245904 (Domain: 245904) +Conflicts : 640 (Analyzed: 620) +Restarts : 5 (Average: 124.00 Last: 56) +Problems : 28 (Average Length: 69.50 Splits: 0) +Lemmas : 620 (Deleted: 0) + Binary : 92 (Ratio: 14.84%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 620 (Average Length: 154.8 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 620 (Average: 467.30 Max: 6958 Sum: 289726) + Executed : 133 (Average: 396.62 Max: 6958 Sum: 245904 Ratio: 84.87%) + Bounded : 487 (Average: 89.98 Max: 102 Sum: 43822 Ratio: 15.13%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 580939 (Eliminated: 0 Frozen: 190135) +Constraints : 3124127 (Binary: 94.9% Ternary: 4.3% Other: 0.7%) + +Memory Peak : 859MB +Max. Length : 130 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.90s +Memory: 797MB (+22MB) +UNSAT +Iteration Time: 1.73s + +Iteration 29 +Queue: [(28,140,0,True), (29,145,0,True), (30,150,0,True), (31,155,0,True), (32,160,0,True), (33,165,0,True), (34,170,0,True)] +Grounded Until: 135 +Expected Memory: 859.0MB +Grounding... [('step', [136]), ('step', [137]), ('step', [138]), ('step', [139]), ('step', [140]), ('check', [140])] +Grounding Time: 0.42s +Memory: 797MB (+0MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 1+ +Calls : 29 +Time : 27.960s (Solving: 5.29s 1st Model: 0.12s Unsat: 5.11s) +CPU Time : 27.868s + +Choices : 252861 (Domain: 252861) +Conflicts : 645 (Analyzed: 625) +Restarts : 5 (Average: 125.00 Last: 56) +Model-Level : 7094.0 +Problems : 29 (Average Length: 72.00 Splits: 0) +Lemmas : 625 (Deleted: 0) + Binary : 92 (Ratio: 14.72%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 625 (Average Length: 166.8 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 625 (Average: 463.57 Max: 6958 Sum: 289731) + Executed : 138 (Average: 393.45 Max: 6958 Sum: 245909 Ratio: 84.87%) + Bounded : 487 (Average: 89.98 Max: 102 Sum: 43822 Ratio: 15.13%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 602990 (Eliminated: 0 Frozen: 197355) +Constraints : 3296407 (Binary: 94.9% Ternary: 4.3% Other: 0.7%) + +Memory Peak : 881MB +Max. Length : 135 steps +Models : 1 + +[endof: stats after solve call] +Solving Time: 0.30s +Memory: 815MB (+18MB) +SAT +Testing... +SERIALIZABLE +Testing Time: 0.69s +Memory: 825MB (+10MB) +Answer: 1 +occurs(action(("unstack","n","x")),1) occurs(action(("put-down","n")),2) occurs(action(("unstack","x","s")),3) occurs(action(("put-down","x")),4) occurs(action(("unstack","s","a")),5) occurs(action(("put-down","s")),6) occurs(action(("unstack","a","h1")),7) occurs(action(("put-down","a")),8) occurs(action(("unstack","h1","l")),9) occurs(action(("stack","h1","x")),10) occurs(action(("unstack","l","f")),11) occurs(action(("put-down","l")),12) occurs(action(("unstack","f","g")),13) occurs(action(("put-down","f")),14) occurs(action(("unstack","g","b")),15) occurs(action(("put-down","g")),16) occurs(action(("unstack","b","v")),17) occurs(action(("stack","b","f")),18) occurs(action(("unstack","v","w")),19) occurs(action(("put-down","v")),20) occurs(action(("unstack","w","a1")),21) occurs(action(("put-down","w")),22) occurs(action(("unstack","a1","m")),23) occurs(action(("put-down","a1")),24) occurs(action(("unstack","m","k1")),25) occurs(action(("stack","m","n")),26) occurs(action(("unstack","k1","o")),27) occurs(action(("put-down","k1")),28) occurs(action(("unstack","o","e1")),29) occurs(action(("put-down","o")),30) occurs(action(("unstack","e1","p")),31) occurs(action(("stack","e1","s")),32) occurs(action(("unstack","p","i1")),33) occurs(action(("put-down","p")),34) occurs(action(("unstack","i1","e")),35) occurs(action(("put-down","i1")),36) occurs(action(("unstack","e","j1")),37) occurs(action(("stack","e","k1")),38) occurs(action(("unstack","j1","d")),39) occurs(action(("put-down","j1")),40) occurs(action(("unstack","d","c")),41) occurs(action(("put-down","d")),42) occurs(action(("unstack","c","t")),43) occurs(action(("put-down","c")),44) occurs(action(("unstack","t","q")),45) occurs(action(("put-down","t")),46) occurs(action(("unstack","q","f1")),47) occurs(action(("stack","q","t")),48) occurs(action(("unstack","f1","z")),49) occurs(action(("stack","f1","b")),50) occurs(action(("unstack","z","b1")),51) occurs(action(("stack","z","g")),52) occurs(action(("unstack","b1","u")),53) occurs(action(("stack","b1","j1")),54) occurs(action(("unstack","u","h")),55) occurs(action(("put-down","u")),56) occurs(action(("unstack","h","d1")),57) occurs(action(("put-down","h")),58) occurs(action(("unstack","d1","i")),59) occurs(action(("put-down","d1")),60) occurs(action(("unstack","i","j")),61) occurs(action(("put-down","i")),62) occurs(action(("pick-up","p")),63) occurs(action(("stack","p","i")),64) occurs(action(("pick-up","v")),65) occurs(action(("stack","v","p")),66) occurs(action(("pick-up","d")),67) occurs(action(("stack","d","v")),68) occurs(action(("pick-up","a")),69) occurs(action(("stack","a","d")),70) occurs(action(("unstack","m","n")),71) occurs(action(("stack","m","a")),72) occurs(action(("pick-up","n")),73) occurs(action(("stack","n","m")),74) occurs(action(("unstack","h1","x")),75) occurs(action(("stack","h1","n")),76) occurs(action(("unstack","f1","b")),77) occurs(action(("stack","f1","h1")),78) occurs(action(("pick-up","x")),79) occurs(action(("stack","x","f1")),80) occurs(action(("pick-up","o")),81) occurs(action(("stack","o","x")),82) occurs(action(("unstack","b","f")),83) occurs(action(("stack","b","o")),84) occurs(action(("unstack","c1","k")),85) occurs(action(("stack","c1","d1")),86) occurs(action(("pick-up","k")),87) occurs(action(("stack","k","b")),88) occurs(action(("unstack","j","r")),89) occurs(action(("put-down","j")),90) occurs(action(("unstack","r","y")),91) occurs(action(("stack","r","k")),92) occurs(action(("unstack","z","g")),93) occurs(action(("stack","z","r")),94) occurs(action(("unstack","e1","s")),95) occurs(action(("stack","e1","z")),96) occurs(action(("unstack","y","g1")),97) occurs(action(("stack","y","e1")),98) occurs(action(("pick-up","w")),99) occurs(action(("stack","w","y")),100) occurs(action(("unstack","c1","d1")),101) occurs(action(("stack","c1","w")),102) occurs(action(("pick-up","s")),103) occurs(action(("stack","s","c1")),104) occurs(action(("pick-up","l")),105) occurs(action(("stack","l","s")),106) occurs(action(("unstack","b1","j1")),107) occurs(action(("stack","b1","l")),108) occurs(action(("pick-up","j1")),109) occurs(action(("stack","j1","b1")),110) occurs(action(("pick-up","c")),111) occurs(action(("stack","c","j1")),112) occurs(action(("pick-up","i1")),113) occurs(action(("stack","i1","c")),114) occurs(action(("pick-up","a1")),115) occurs(action(("stack","a1","i1")),116) occurs(action(("pick-up","f")),117) occurs(action(("stack","f","a1")),118) occurs(action(("pick-up","h")),119) occurs(action(("stack","h","f")),120) occurs(action(("pick-up","d1")),121) occurs(action(("stack","d1","h")),122) occurs(action(("pick-up","g1")),123) occurs(action(("stack","g1","d1")),124) occurs(action(("pick-up","j")),125) occurs(action(("stack","j","g1")),126) occurs(action(("unstack","e","k1")),127) occurs(action(("stack","e","j")),128) occurs(action(("unstack","q","t")),129) occurs(action(("stack","q","e")),130) occurs(action(("pick-up","g")),131) occurs(action(("stack","g","q")),132) occurs(action(("pick-up","u")),133) occurs(action(("stack","u","g")),134) occurs(action(("pick-up","k1")),135) occurs(action(("stack","k1","u")),136) occurs(action(("pick-up","t")),137) occurs(action(("put-down","t")),138) occurs(action(("pick-up","t")),139) occurs(action(("stack","t","k1")),140) +SATISFIABLE + +Models : 1+ +Calls : 29 +Time : 27.960s (Solving: 5.29s 1st Model: 0.12s Unsat: 5.11s) +CPU Time : 27.868s + +Choices : 252861 (Domain: 252861) +Conflicts : 645 (Analyzed: 625) +Restarts : 5 (Average: 125.00 Last: 56) +Model-Level : 7094.0 +Problems : 29 (Average Length: 72.00 Splits: 0) +Lemmas : 625 (Deleted: 0) + Binary : 92 (Ratio: 14.72%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 625 (Average Length: 166.8 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 625 (Average: 463.57 Max: 6958 Sum: 289731) + Executed : 138 (Average: 393.45 Max: 6958 Sum: 245909 Ratio: 84.87%) + Bounded : 487 (Average: 89.98 Max: 102 Sum: 43822 Ratio: 15.13%) + +Rules : 71909 +Atoms : 71909 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 602990 (Eliminated: 0 Frozen: 197355) +Constraints : 3296407 (Binary: 94.9% Ternary: 4.3% Other: 0.7%) + +Memory Peak : 881MB +Max. Length : 140 steps +Sol. Length : 140 steps +Models : 1 + +