From c73e3d7305dabd80e7d5ce079a225f91c9e04d12 Mon Sep 17 00:00:00 2001 From: potassco-bot Date: Thu, 1 Feb 2018 21:28:51 +0100 Subject: [PATCH] Add benchmark result [gc-ta1-tt1 | ipc-2000 | blocks-strips-typed | 46] --- .../ipc-2000_blocks-strips-typed_46.env | 54 ++ .../ipc-2000_blocks-strips-typed_46.err | 9 + .../ipc-2000_blocks-strips-typed_46.out | 899 ++++++++++++++++++ 3 files changed, 962 insertions(+) create mode 100644 gc-ta1-tt1/ipc-2000_blocks-strips-typed_46.env create mode 100644 gc-ta1-tt1/ipc-2000_blocks-strips-typed_46.err create mode 100644 gc-ta1-tt1/ipc-2000_blocks-strips-typed_46.out diff --git a/gc-ta1-tt1/ipc-2000_blocks-strips-typed_46.env b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_46.env new file mode 100644 index 000000000..06a4324a3 --- /dev/null +++ b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_46.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-46.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: 46 + 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_46.err b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_46.err new file mode 100644 index 000000000..dd810e91e --- /dev/null +++ b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_46.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': 46} +# 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-46.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-46.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 56.53 MEM 33472 MAXMEM 444364 STALE 0 MAXMEM_RSS 324504 + + diff --git a/gc-ta1-tt1/ipc-2000_blocks-strips-typed_46.out b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_46.out new file mode 100644 index 000000000..b4d3caf2f --- /dev/null +++ b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_46.out @@ -0,0 +1,899 @@ +INFO Running translator. +INFO translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-2000/domains/blocks-strips-typed/domain.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2000/domains/blocks-strips-typed/instances/instance-46.pddl'] +INFO translator arguments: [] +INFO translator time limit: None +INFO translator memory limit: None +INFO callstring: /home/pluehne/.usr/bin/python /home/wv/bin/linux/64/fast-downward-10997/builds/release64/bin/translate/translate.py /home/pluehne/Documents/ASP/pddl-instances/ipc-2000/domains/blocks-strips-typed/domain.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2000/domains/blocks-strips-typed/instances/instance-46.pddl +Parsing... +Parsing: [0.010s CPU, 0.018s wall-clock] +Normalizing task... [0.010s CPU, 0.002s wall-clock] +Instantiating... +Generating Datalog program... [0.000s CPU, 0.005s wall-clock] +Normalizing Datalog program... +Normalizing Datalog program: [0.020s CPU, 0.012s wall-clock] +Preparing model... [0.010s CPU, 0.011s wall-clock] +Generated 21 rules. +Computing model... [0.210s CPU, 0.216s wall-clock] +1630 relevant atoms +1078 auxiliary atoms +2708 final queue length +4693 total queue pushes +Completing instantiation... [0.320s CPU, 0.324s wall-clock] +Instantiating: [0.570s CPU, 0.571s wall-clock] +Computing fact groups... +Finding invariants... +10 initial candidates +Finding invariants: [0.020s CPU, 0.021s wall-clock] +Checking invariant weight... [0.000s CPU, 0.003s wall-clock] +Instantiating groups... [0.020s CPU, 0.020s wall-clock] +Collecting mutex groups... [0.010s CPU, 0.004s wall-clock] +Choosing groups... +23 uncovered facts +Choosing groups: [0.020s CPU, 0.021s wall-clock] +Building translation key... [0.010s CPU, 0.007s wall-clock] +Computing fact groups: [0.120s CPU, 0.120s wall-clock] +Building STRIPS to SAS dictionary... [0.000s CPU, 0.003s wall-clock] +Building dictionary for full mutex groups... [0.010s CPU, 0.007s wall-clock] +Building mutex information... +Building mutex information: [0.010s CPU, 0.015s wall-clock] +Translating task... +Processing axioms... +Simplifying axioms... [0.000s CPU, 0.000s wall-clock] +Processing axioms: [0.020s CPU, 0.016s wall-clock] +Translating task: [0.390s CPU, 0.381s wall-clock] +1430 effect conditions simplified +0 implied preconditions added +Detecting unreachable propositions... +0 operators removed +0 axioms removed +44 propositions removed +Detecting unreachable propositions: [0.210s CPU, 0.212s wall-clock] +Reordering and filtering variables... +45 of 45 variables necessary. +23 of 45 mutex groups necessary. +968 of 968 operators necessary. +0 of 0 axiom rules necessary. +Reordering and filtering variables: [0.120s CPU, 0.116s wall-clock] +Translator variables: 45 +Translator derived variables: 0 +Translator facts: 552 +Translator goal facts: 21 +Translator mutex groups: 23 +Translator total mutex groups size: 529 +Translator operators: 968 +Translator axioms: 0 +Translator task size: 8341 +Translator peak memory: 41164 KB +Writing output... [0.150s CPU, 0.152s wall-clock] +Done! [1.610s CPU, 1.616s wall-clock] +planner.py version 0.0.1 + +Time: 0.28s +Memory: 67MB + +Iteration 1 +Queue: [(0,0,0,True), (1,5,0,True), (2,10,0,True), (3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] +Grounded Until: 0 +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 1 +Time : 0.321s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 0.280s + +Choices : 0 +Conflicts : 0 (Analyzed: 0) +Restarts : 0 +Problems : 1 (Average Length: 2.00 Splits: 0) +Lemmas : 0 (Deleted: 0) + Binary : 0 (Ratio: 0.00%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) + Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) + Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 0 (Eliminated: 0 Frozen: 0) +Constraints : 0 (Binary: 0.0% Ternary: 0.0% Other: 0.0%) + +Memory Peak : 203MB +Max. Length : 0 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.00s +Memory: 139MB (+72MB) +UNSAT +Iteration Time: 0.00s + +Iteration 2 +Queue: [(1,5,0,True), (2,10,0,True), (3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] +Grounded Until: 0 +Expected Memory: 139MB +Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])] +Grounding Time: 0.11s +Memory: 142MB (+3MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 2 +Time : 0.471s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 0.432s + +Choices : 0 +Conflicts : 0 (Analyzed: 0) +Restarts : 0 +Problems : 2 (Average Length: 4.50 Splits: 0) +Lemmas : 0 (Deleted: 0) + Binary : 0 (Ratio: 0.00%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) + Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) + Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 7115 (Eliminated: 0 Frozen: 2315) +Constraints : 9093 (Binary: 92.7% Ternary: 4.4% Other: 2.9%) + +Memory Peak : 203MB +Max. Length : 0 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.01s +Memory: 144MB (+2MB) +UNSAT +Iteration Time: 0.15s + +Iteration 3 +Queue: [(2,10,0,True), (3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] +Grounded Until: 5 +Expected Memory: 149.0MB +Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])] +Grounding Time: 0.13s +Memory: 151MB (+7MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 3 +Time : 0.654s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 0.612s + +Choices : 0 +Conflicts : 0 (Analyzed: 0) +Restarts : 0 +Problems : 3 (Average Length: 7.00 Splits: 0) +Lemmas : 0 (Deleted: 0) + Binary : 0 (Ratio: 0.00%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) + Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) + Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 14621 (Eliminated: 0 Frozen: 4797) +Constraints : 38095 (Binary: 93.5% Ternary: 4.5% Other: 2.0%) + +Memory Peak : 203MB +Max. Length : 5 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.01s +Memory: 153MB (+2MB) +UNSAT +Iteration Time: 0.19s + +Iteration 4 +Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] +Grounded Until: 10 +Expected Memory: 162.0MB +Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])] +Grounding Time: 0.12s +Memory: 157MB (+4MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 4 +Time : 0.838s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 0.796s + +Choices : 0 +Conflicts : 1 (Analyzed: 0) +Restarts : 0 +Problems : 4 (Average Length: 9.50 Splits: 0) +Lemmas : 0 (Deleted: 0) + Binary : 0 (Ratio: 0.00%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) + Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) + Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 22462 (Eliminated: 0 Frozen: 7394) +Constraints : 88817 (Binary: 94.0% Ternary: 4.4% Other: 1.5%) + +Memory Peak : 203MB +Max. Length : 10 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.01s +Memory: 161MB (+4MB) +UNSAT +Iteration Time: 0.19s + +Iteration 5 +Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)] +Grounded Until: 15 +Expected Memory: 170.0MB +Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])] +Grounding Time: 0.13s +Memory: 166MB (+5MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 5 +Time : 1.024s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 0.980s + +Choices : 0 +Conflicts : 2 (Analyzed: 0) +Restarts : 0 +Problems : 5 (Average Length: 12.00 Splits: 0) +Lemmas : 0 (Deleted: 0) + Binary : 0 (Ratio: 0.00%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) + Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) + Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 30638 (Eliminated: 0 Frozen: 10039) +Constraints : 150022 (Binary: 94.2% Ternary: 4.5% Other: 1.4%) + +Memory Peak : 203MB +Max. Length : 15 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.01s +Memory: 169MB (+3MB) +UNSAT +Iteration Time: 0.19s + +Iteration 6 +Queue: [(5,25,0,True), (6,30,0,True)] +Grounded Until: 20 +Expected Memory: 178.0MB +Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])] +Grounding Time: 0.16s +Memory: 176MB (+7MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 6 +Time : 1.256s (Solving: 0.00s 1st Model: 0.00s Unsat: 0.00s) +CPU Time : 1.212s + +Choices : 0 +Conflicts : 3 (Analyzed: 0) +Restarts : 0 +Problems : 6 (Average Length: 14.50 Splits: 0) +Lemmas : 0 (Deleted: 0) + Binary : 0 (Ratio: 0.00%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 0 (Average Length: 0.0 Ratio: 0.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 0 (Average: 0.00 Max: 0 Sum: 0) + Executed : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 0.00%) + Bounded : 0 (Average: 0.00 Max: 0 Sum: 0 Ratio: 100.00%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 38814 (Eliminated: 0 Frozen: 12684) +Constraints : 211227 (Binary: 94.2% Ternary: 4.5% Other: 1.3%) + +Memory Peak : 203MB +Max. Length : 20 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.02s +Memory: 182MB (+6MB) +UNSAT +Iteration Time: 0.24s + +Iteration 7 +Queue: [(6,30,0,True)] +Grounded Until: 25 +Expected Memory: 195.0MB +Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])] +Grounding Time: 0.13s +Memory: 186MB (+4MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 7 +Time : 1.458s (Solving: 0.01s 1st Model: 0.00s Unsat: 0.01s) +CPU Time : 1.416s + +Choices : 27 (Domain: 27) +Conflicts : 14 (Analyzed: 10) +Restarts : 0 +Problems : 7 (Average Length: 17.00 Splits: 0) +Lemmas : 10 (Deleted: 0) + Binary : 5 (Ratio: 50.00%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 10 (Average Length: 138.1 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 10 (Average: 6.10 Max: 38 Sum: 61) + Executed : 7 (Average: 2.70 Max: 38 Sum: 27 Ratio: 44.26%) + Bounded : 3 (Average: 11.33 Max: 32 Sum: 34 Ratio: 55.74%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 46990 (Eliminated: 0 Frozen: 15329) +Constraints : 272432 (Binary: 94.3% Ternary: 4.5% Other: 1.3%) + +Memory Peak : 203MB +Max. Length : 25 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.02s +Memory: 188MB (+2MB) +UNSAT +Iteration Time: 0.21s + +Iteration 8 +Queue: [(7,35,0,True), (8,40,0,True), (9,45,0,True), (10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)] +Grounded Until: 30 +Expected Memory: 201.0MB +Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])] +Grounding Time: 0.13s +Memory: 193MB (+5MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 8 +Time : 1.708s (Solving: 0.05s 1st Model: 0.00s Unsat: 0.05s) +CPU Time : 1.664s + +Choices : 221 (Domain: 221) +Conflicts : 50 (Analyzed: 45) +Restarts : 0 +Problems : 8 (Average Length: 19.50 Splits: 0) +Lemmas : 45 (Deleted: 0) + Binary : 21 (Ratio: 46.67%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 45 (Average Length: 358.7 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 45 (Average: 5.69 Max: 38 Sum: 256) + Executed : 41 (Average: 4.91 Max: 38 Sum: 221 Ratio: 86.33%) + Bounded : 4 (Average: 8.75 Max: 32 Sum: 35 Ratio: 13.67%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 55166 (Eliminated: 0 Frozen: 17974) +Constraints : 332882 (Binary: 94.3% Ternary: 4.5% Other: 1.2%) + +Memory Peak : 203MB +Max. Length : 30 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.06s +Memory: 200MB (+7MB) +UNSAT +Iteration Time: 0.25s + +Iteration 9 +Queue: [(8,40,0,True), (9,45,0,True), (10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)] +Grounded Until: 35 +Expected Memory: 213.0MB +Grounding... [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])] +Grounding Time: 0.13s +Memory: 203MB (+3MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 9 +Time : 2.011s (Solving: 0.14s 1st Model: 0.00s Unsat: 0.14s) +CPU Time : 1.968s + +Choices : 1965 (Domain: 1965) +Conflicts : 212 (Analyzed: 206) +Restarts : 2 (Average: 103.00 Last: 35) +Problems : 9 (Average Length: 22.00 Splits: 0) +Lemmas : 206 (Deleted: 0) + Binary : 36 (Ratio: 17.48%) + Ternary : 0 (Ratio: 0.00%) + Conflict : 206 (Average Length: 1045.9 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 206 (Average: 10.11 Max: 161 Sum: 2082) + Executed : 198 (Average: 9.54 Max: 161 Sum: 1965 Ratio: 94.38%) + Bounded : 8 (Average: 14.62 Max: 41 Sum: 117 Ratio: 5.62%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 63342 (Eliminated: 0 Frozen: 20619) +Constraints : 394087 (Binary: 94.3% Ternary: 4.5% Other: 1.2%) + +Memory Peak : 211MB +Max. Length : 35 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.11s +Memory: 206MB (+3MB) +UNSAT +Iteration Time: 0.31s + +Iteration 10 +Queue: [(9,45,0,True), (10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)] +Grounded Until: 40 +Expected Memory: 219.0MB +Grounding... [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])] +Grounding Time: 0.13s +Memory: 210MB (+4MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 10 +Time : 3.408s (Solving: 1.32s 1st Model: 0.00s Unsat: 1.32s) +CPU Time : 3.368s + +Choices : 9644 (Domain: 9644) +Conflicts : 1840 (Analyzed: 1833) +Restarts : 20 (Average: 91.65 Last: 83) +Problems : 10 (Average Length: 24.50 Splits: 0) +Lemmas : 1833 (Deleted: 0) + Binary : 65 (Ratio: 3.55%) + Ternary : 1 (Ratio: 0.05%) + Conflict : 1833 (Average Length: 2096.6 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 1833 (Average: 5.20 Max: 233 Sum: 9531) + Executed : 1824 (Average: 5.14 Max: 233 Sum: 9413 Ratio: 98.76%) + Bounded : 9 (Average: 13.11 Max: 41 Sum: 118 Ratio: 1.24%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 71518 (Eliminated: 0 Frozen: 23264) +Constraints : 455292 (Binary: 94.3% Ternary: 4.5% Other: 1.2%) + +Memory Peak : 220MB +Max. Length : 40 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 1.20s +Memory: 213MB (+3MB) +UNSAT +Iteration Time: 1.40s + +Iteration 11 +Queue: [(10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)] +Grounded Until: 45 +Expected Memory: 226.0MB +Grounding... [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])] +Grounding Time: 0.15s +Memory: 217MB (+4MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 11 +Time : 8.371s (Solving: 6.03s 1st Model: 0.00s Unsat: 6.03s) +CPU Time : 8.332s + +Choices : 33406 (Domain: 33406) +Conflicts : 6116 (Analyzed: 6108) +Restarts : 70 (Average: 87.26 Last: 83) +Problems : 11 (Average Length: 27.00 Splits: 0) +Lemmas : 6108 (Deleted: 3790) + Binary : 147 (Ratio: 2.41%) + Ternary : 1 (Ratio: 0.02%) + Conflict : 6108 (Average Length: 2657.4 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 6108 (Average: 5.33 Max: 404 Sum: 32527) + Executed : 6094 (Average: 5.31 Max: 404 Sum: 32404 Ratio: 99.62%) + Bounded : 14 (Average: 8.79 Max: 41 Sum: 123 Ratio: 0.38%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 79694 (Eliminated: 0 Frozen: 25909) +Constraints : 516497 (Binary: 94.3% Ternary: 4.5% Other: 1.2%) + +Memory Peak : 227MB +Max. Length : 45 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 4.74s +Memory: 219MB (+2MB) +UNSAT +Iteration Time: 4.97s + +Iteration 12 +Queue: [(11,55,0,True), (12,60,0,True), (13,65,0,True)] +Grounded Until: 50 +Expected Memory: 232.0MB +Grounding... [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])] +Grounding Time: 0.21s +Memory: 230MB (+11MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 12 +Time : 15.279s (Solving: 12.62s 1st Model: 0.00s Unsat: 12.62s) +CPU Time : 15.244s + +Choices : 68533 (Domain: 68533) +Conflicts : 11841 (Analyzed: 11832) +Restarts : 134 (Average: 88.30 Last: 87) +Problems : 12 (Average Length: 29.50 Splits: 0) +Lemmas : 11832 (Deleted: 7847) + Binary : 248 (Ratio: 2.10%) + Ternary : 2 (Ratio: 0.02%) + Conflict : 11832 (Average Length: 3268.0 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 11832 (Average: 5.54 Max: 649 Sum: 65591) + Executed : 11814 (Average: 5.53 Max: 649 Sum: 65464 Ratio: 99.81%) + Bounded : 18 (Average: 7.06 Max: 41 Sum: 127 Ratio: 0.19%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 87870 (Eliminated: 0 Frozen: 28554) +Constraints : 577702 (Binary: 94.3% Ternary: 4.5% Other: 1.2%) + +Memory Peak : 365MB +Max. Length : 50 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 6.62s +Memory: 301MB (+71MB) +UNSAT +Iteration Time: 6.92s + +Iteration 13 +Queue: [(12,60,0,True), (13,65,0,True)] +Grounded Until: 55 +Expected Memory: 383.0MB +Grounding... [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])] +Grounding Time: 0.15s +Memory: 305MB (+4MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0+ +Calls : 13 +Time : 29.625s (Solving: 26.69s 1st Model: 0.00s Unsat: 12.62s) +CPU Time : 29.596s + +Choices : 148434 (Domain: 148434) +Conflicts : 20569 (Analyzed: 20560) +Restarts : 234 (Average: 87.86 Last: 95) +Problems : 13 (Average Length: 32.00 Splits: 0) +Lemmas : 20560 (Deleted: 17622) + Binary : 368 (Ratio: 1.79%) + Ternary : 4 (Ratio: 0.02%) + Conflict : 20560 (Average Length: 4275.4 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 20560 (Average: 6.59 Max: 999 Sum: 135584) + Executed : 20536 (Average: 6.59 Max: 999 Sum: 135451 Ratio: 99.90%) + Bounded : 24 (Average: 5.54 Max: 41 Sum: 133 Ratio: 0.10%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 96046 (Eliminated: 0 Frozen: 31199) +Constraints : 638907 (Binary: 94.3% Ternary: 4.5% Other: 1.2%) + +Memory Peak : 365MB +Max. Length : 55 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 14.12s +Memory: 309MB (+4MB) +UNKNOWN +Iteration Time: 14.36s + +Iteration 14 +Queue: [(13,65,0,True)] +Grounded Until: 60 +Expected Memory: 391.0MB +Grounding... [('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('check', [65])] +Grounding Time: 0.14s +Memory: 313MB (+4MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0+ +Calls : 14 +Time : 45.235s (Solving: 42.03s 1st Model: 0.00s Unsat: 12.62s) +CPU Time : 45.212s + +Choices : 270174 (Domain: 270174) +Conflicts : 29633 (Analyzed: 29624) +Restarts : 334 (Average: 88.69 Last: 117) +Problems : 14 (Average Length: 34.50 Splits: 0) +Lemmas : 29624 (Deleted: 26244) + Binary : 482 (Ratio: 1.63%) + Ternary : 13 (Ratio: 0.04%) + Conflict : 29624 (Average Length: 4691.2 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 29624 (Average: 8.28 Max: 3309 Sum: 245321) + Executed : 29595 (Average: 8.28 Max: 3309 Sum: 245183 Ratio: 99.94%) + Bounded : 29 (Average: 4.76 Max: 41 Sum: 138 Ratio: 0.06%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 104222 (Eliminated: 0 Frozen: 33844) +Constraints : 700112 (Binary: 94.3% Ternary: 4.5% Other: 1.2%) + +Memory Peak : 365MB +Max. Length : 60 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 15.39s +Memory: 316MB (+3MB) +UNKNOWN +Iteration Time: 15.62s + +Iteration 15 +Queue: [(12,60,1,True), (13,65,1,True), (14,70,0,True), (15,75,0,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True)] +Grounded Until: 65 +Blocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 15 +Time : 48.531s (Solving: 45.30s 1st Model: 0.00s Unsat: 15.88s) +CPU Time : 48.508s + +Choices : 282584 (Domain: 282584) +Conflicts : 31400 (Analyzed: 31390) +Restarts : 354 (Average: 88.67 Last: 117) +Problems : 15 (Average Length: 36.67 Splits: 0) +Lemmas : 31390 (Deleted: 26244) + Binary : 494 (Ratio: 1.57%) + Ternary : 13 (Ratio: 0.04%) + Conflict : 31390 (Average Length: 4702.0 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 31390 (Average: 8.06 Max: 3309 Sum: 253065) + Executed : 31360 (Average: 8.06 Max: 3309 Sum: 252926 Ratio: 99.95%) + Bounded : 30 (Average: 4.63 Max: 41 Sum: 139 Ratio: 0.05%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 104222 (Eliminated: 0 Frozen: 33844) +Constraints : 700112 (Binary: 94.3% Ternary: 4.5% Other: 1.2%) + +Memory Peak : 365MB +Max. Length : 65 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 3.28s +Memory: 316MB (+0MB) +UNSAT +Iteration Time: 3.30s + +Iteration 16 +Queue: [(13,65,1,True), (14,70,0,True), (15,75,0,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True)] +Grounded Until: 65 +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 0 +Calls : 16 +Time : 48.594s (Solving: 45.31s 1st Model: 0.00s Unsat: 15.90s) +CPU Time : 48.572s + +Choices : 282584 (Domain: 282584) +Conflicts : 31401 (Analyzed: 31390) +Restarts : 354 (Average: 88.67 Last: 117) +Problems : 16 (Average Length: 38.56 Splits: 0) +Lemmas : 31390 (Deleted: 26244) + Binary : 494 (Ratio: 1.57%) + Ternary : 13 (Ratio: 0.04%) + Conflict : 31390 (Average Length: 4702.0 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 31390 (Average: 8.06 Max: 3309 Sum: 253065) + Executed : 31360 (Average: 8.06 Max: 3309 Sum: 252926 Ratio: 99.95%) + Bounded : 30 (Average: 4.63 Max: 41 Sum: 139 Ratio: 0.05%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 104222 (Eliminated: 0 Frozen: 33844) +Constraints : 700112 (Binary: 94.3% Ternary: 4.5% Other: 1.2%) + +Memory Peak : 365MB +Max. Length : 65 steps +Models : 0 + +[endof: stats after solve call] +Solving Time: 0.03s +Memory: 316MB (+0MB) +UNSAT +Iteration Time: 0.07s + +Iteration 17 +Queue: [(14,70,0,True), (15,75,0,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True)] +Grounded Until: 65 +Expected Memory: 398.0MB +Grounding... [('step', [66]), ('step', [67]), ('step', [68]), ('step', [69]), ('step', [70]), ('check', [70])] +Grounding Time: 0.13s +Memory: 320MB (+4MB) +Unblocking actions... +Solving... +[start: stats after solve call] + +Models : 1+ +Calls : 17 +Time : 52.709s (Solving: 49.14s 1st Model: 3.83s Unsat: 15.90s) +CPU Time : 52.692s + +Choices : 375302 (Domain: 375302) +Conflicts : 34035 (Analyzed: 34024) +Restarts : 384 (Average: 88.60 Last: 117) +Model-Level : 438.0 +Problems : 17 (Average Length: 40.53 Splits: 0) +Lemmas : 34024 (Deleted: 29401) + Binary : 568 (Ratio: 1.67%) + Ternary : 14 (Ratio: 0.04%) + Conflict : 34024 (Average Length: 4953.9 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 34024 (Average: 9.96 Max: 5132 Sum: 338841) + Executed : 33991 (Average: 9.95 Max: 5132 Sum: 338699 Ratio: 99.96%) + Bounded : 33 (Average: 4.30 Max: 41 Sum: 142 Ratio: 0.04%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 112398 (Eliminated: 0 Frozen: 36489) +Constraints : 761317 (Binary: 94.3% Ternary: 4.5% Other: 1.2%) + +Memory Peak : 391MB +Max. Length : 65 steps +Models : 1 + +[endof: stats after solve call] +Solving Time: 3.89s +Memory: 391MB (+71MB) +SAT +Testing... +SERIALIZABLE +Testing Time: 0.30s +Memory: 396MB (+5MB) +Answer: 1 +occurs(action(("unstack","p","u")),1) occurs(action(("put-down","p")),2) occurs(action(("unstack","u","q")),3) occurs(action(("put-down","u")),4) occurs(action(("pick-up","q")),5) occurs(action(("put-down","q")),6) occurs(action(("pick-up","n")),7) occurs(action(("stack","n","u")),8) occurs(action(("pick-up","a")),9) occurs(action(("put-down","a")),10) occurs(action(("unstack","g","r")),11) occurs(action(("put-down","g")),12) occurs(action(("unstack","o","f")),13) occurs(action(("put-down","o")),14) occurs(action(("unstack","f","i")),15) occurs(action(("stack","f","n")),16) occurs(action(("pick-up","p")),17) occurs(action(("stack","p","f")),18) occurs(action(("pick-up","o")),19) occurs(action(("stack","o","p")),20) occurs(action(("pick-up","q")),21) occurs(action(("stack","q","o")),22) occurs(action(("unstack","r","l")),23) occurs(action(("stack","r","q")),24) occurs(action(("unstack","l","m")),25) occurs(action(("put-down","l")),26) occurs(action(("unstack","m","v")),27) occurs(action(("stack","m","r")),28) occurs(action(("unstack","v","b")),29) occurs(action(("stack","v","l")),30) occurs(action(("unstack","b","s")),31) occurs(action(("put-down","b")),32) occurs(action(("unstack","s","j")),33) occurs(action(("stack","s","a")),34) occurs(action(("unstack","j","t")),35) occurs(action(("stack","j","i")),36) occurs(action(("unstack","t","d")),37) occurs(action(("put-down","t")),38) occurs(action(("unstack","d","h")),39) occurs(action(("stack","d","m")),40) occurs(action(("unstack","s","a")),41) occurs(action(("stack","s","d")),42) occurs(action(("pick-up","a")),43) occurs(action(("stack","a","s")),44) occurs(action(("unstack","h","c")),45) occurs(action(("stack","h","a")),46) occurs(action(("unstack","c","e")),47) occurs(action(("put-down","c")),48) occurs(action(("unstack","e","k")),49) occurs(action(("put-down","e")),50) occurs(action(("pick-up","k")),51) occurs(action(("stack","k","h")),52) occurs(action(("unstack","v","l")),53) occurs(action(("stack","v","k")),54) occurs(action(("unstack","j","i")),55) occurs(action(("stack","j","v")),56) occurs(action(("pick-up","b")),57) occurs(action(("stack","b","j")),58) occurs(action(("pick-up","g")),59) occurs(action(("stack","g","b")),60) occurs(action(("pick-up","e")),61) occurs(action(("stack","e","g")),62) occurs(action(("pick-up","i")),63) occurs(action(("stack","i","e")),64) occurs(action(("pick-up","l")),65) occurs(action(("stack","l","i")),66) occurs(action(("pick-up","t")),67) occurs(action(("stack","t","l")),68) occurs(action(("pick-up","c")),69) occurs(action(("stack","c","t")),70) +SATISFIABLE + +Models : 1+ +Calls : 17 +Time : 52.709s (Solving: 49.14s 1st Model: 3.83s Unsat: 15.90s) +CPU Time : 52.692s + +Choices : 375302 (Domain: 375302) +Conflicts : 34035 (Analyzed: 34024) +Restarts : 384 (Average: 88.60 Last: 117) +Model-Level : 438.0 +Problems : 17 (Average Length: 40.53 Splits: 0) +Lemmas : 34024 (Deleted: 29401) + Binary : 568 (Ratio: 1.67%) + Ternary : 14 (Ratio: 0.04%) + Conflict : 34024 (Average Length: 4953.9 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 34024 (Average: 9.96 Max: 5132 Sum: 338841) + Executed : 33991 (Average: 9.95 Max: 5132 Sum: 338699 Ratio: 99.96%) + Bounded : 33 (Average: 4.30 Max: 41 Sum: 142 Ratio: 0.04%) + +Rules : 25607 +Atoms : 25607 +Bodies : 1 (Original: 0) +Tight : Yes +Variables : 112398 (Eliminated: 0 Frozen: 36489) +Constraints : 761317 (Binary: 94.3% Ternary: 4.5% Other: 1.2%) + +Memory Peak : 396MB +Max. Length : 70 steps +Sol. Length : 70 steps +Models : 1 + +