From 2bd4556d1b70d1ba22a250afca4e6c42f4d0edd6 Mon Sep 17 00:00:00 2001 From: potassco-bot Date: Sat, 2 Dec 2017 05:44:17 +0100 Subject: [PATCH] Add benchmark result [gc-ta1-tt1 | ipc-2006 | storage-propositional | 15] --- .../ipc-2006_storage-propositional_15.env | 53 ++ .../ipc-2006_storage-propositional_15.err | 18 + .../ipc-2006_storage-propositional_15.out | 775 ++++++++++++++++++ 3 files changed, 846 insertions(+) create mode 100644 gc-ta1-tt1/ipc-2006_storage-propositional_15.env create mode 100644 gc-ta1-tt1/ipc-2006_storage-propositional_15.err create mode 100644 gc-ta1-tt1/ipc-2006_storage-propositional_15.out diff --git a/gc-ta1-tt1/ipc-2006_storage-propositional_15.env b/gc-ta1-tt1/ipc-2006_storage-propositional_15.env new file mode 100644 index 000000000..01a084f73 --- /dev/null +++ b/gc-ta1-tt1/ipc-2006_storage-propositional_15.env @@ -0,0 +1,53 @@ +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-2006/domains/storage-propositional/domain.pddl +- /home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/storage-propositional/instances/instance-15.pddl +- --stats +- --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: + - lpnmr-first-plan-not-serializable + - rintanen-aij-2012 + options: + - --stats + - --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: storage-propositional + instance: 15 + ipc: ipc-2006 +versions: + clingo: 5.2.2 + fastDownward: 10997:847cdf0069cab0c8841a9958e783d1a7340fe2e9 (2017-11-02 15:10 +0100) + planner: 398fcb36ad9c5a23a8c35820fb4b021802dbc349 (2017-11-30 17:03:27 +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-2006_storage-propositional_15.err b/gc-ta1-tt1/ipc-2006_storage-propositional_15.err new file mode 100644 index 000000000..2e01ce871 --- /dev/null +++ b/gc-ta1-tt1/ipc-2006_storage-propositional_15.err @@ -0,0 +1,18 @@ +# configuration: {'id': 'gc-ta1-tt1', 'options': ['--stats', '--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': ['lpnmr-first-plan-not-serializable', 'rintanen-aij-2012']} +# instance: {'ipc': 'ipc-2006', 'domain': 'storage-propositional', 'instance': 15} +# 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-2006/domains/storage-propositional/domain.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/storage-propositional/instances/instance-15.pddl', '--stats', '--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 +/home/pluehne/Documents/ASP/plasp-javier/encodings/strips/preprocess.lp:13:4-34: info: atom does not occur in any rule head: + requires(feature(actionCosts)) + +/home/pluehne/Documents/ASP/plasp-javier/encodings/strips/preprocess.lp:14:4-33: info: atom does not occur in any rule head: + requires(feature(axiomRules)) + +/home/pluehne/Documents/ASP/plasp-javier/encodings/strips/preprocess.lp:15:4-41: info: atom does not occur in any rule head: + requires(feature(conditionalEffects)) + +# planner call: /home/wv/bin/linux/64/fast-downward/fast-downward.py --translate --build=release64 /home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/storage-propositional/domain.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/storage-propositional/instances/instance-15.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 --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 298.95 MEM 33472 MAXMEM 333412 STALE 0 MAXMEM_RSS 277428 + + diff --git a/gc-ta1-tt1/ipc-2006_storage-propositional_15.out b/gc-ta1-tt1/ipc-2006_storage-propositional_15.out new file mode 100644 index 000000000..8d8430023 --- /dev/null +++ b/gc-ta1-tt1/ipc-2006_storage-propositional_15.out @@ -0,0 +1,775 @@ +INFO Running translator. +INFO translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/storage-propositional/domain.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/storage-propositional/instances/instance-15.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-2006/domains/storage-propositional/domain.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/storage-propositional/instances/instance-15.pddl +Parsing... +Parsing: [0.020s CPU, 0.021s wall-clock] +Normalizing task... [0.000s CPU, 0.001s wall-clock] +Instantiating... +Generating Datalog program... [0.000s CPU, 0.008s wall-clock] +Normalizing Datalog program... +Normalizing Datalog program: [0.020s CPU, 0.023s wall-clock] +Preparing model... [0.020s CPU, 0.016s wall-clock] +Generated 43 rules. +Computing model... [0.180s CPU, 0.186s wall-clock] +1202 relevant atoms +1188 auxiliary atoms +2390 final queue length +4283 total queue pushes +Completing instantiation... [0.320s CPU, 0.315s wall-clock] +Instantiating: [0.540s CPU, 0.552s wall-clock] +Computing fact groups... +Finding invariants... +16 initial candidates +Finding invariants: [0.040s CPU, 0.036s wall-clock] +Checking invariant weight... [0.000s CPU, 0.001s wall-clock] +Instantiating groups... [0.010s CPU, 0.007s wall-clock] +Collecting mutex groups... [0.000s CPU, 0.001s wall-clock] +Choosing groups... +53 uncovered facts +Choosing groups: [0.000s CPU, 0.003s wall-clock] +Building translation key... [0.000s CPU, 0.003s wall-clock] +Computing fact groups: [0.060s CPU, 0.059s wall-clock] +Building STRIPS to SAS dictionary... [0.000s CPU, 0.001s wall-clock] +Building dictionary for full mutex groups... [0.000s CPU, 0.002s wall-clock] +Building mutex information... +Building mutex information: [0.010s CPU, 0.001s wall-clock] +Translating task... +Processing axioms... +Simplifying axioms... [0.000s CPU, 0.000s wall-clock] +Processing axioms: [0.010s CPU, 0.017s wall-clock] +Translating task: [0.350s CPU, 0.356s wall-clock] +1200 effect conditions simplified +0 implied preconditions added +Detecting unreachable propositions... +0 operators removed +0 axioms removed +38 propositions removed +Detecting unreachable propositions: [0.190s CPU, 0.184s wall-clock] +Reordering and filtering variables... +31 of 46 variables necessary. +3 of 11 mutex groups necessary. +846 of 846 operators necessary. +0 of 0 axiom rules necessary. +Reordering and filtering variables: [0.080s CPU, 0.080s wall-clock] +Translator variables: 31 +Translator derived variables: 0 +Translator facts: 184 +Translator goal facts: 5 +Translator mutex groups: 3 +Translator total mutex groups size: 18 +Translator operators: 846 +Translator axioms: 0 +Translator task size: 6295 +Translator peak memory: 40652 KB +Writing output... [0.120s CPU, 0.124s wall-clock] +Done! [1.390s CPU, 1.397s wall-clock] +planner.py version 0.0.1 + +Time: 0.27s +Memory: 66MB + +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... +Solving Time: 0.00s +Memory: 66MB (+0MB) +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: 66MB +Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])] +Grounding Time: 0.07s +Memory: 66MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 0.01s +Memory: 67MB (+1MB) +UNSAT +Iteration Time: 0.11s + +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: 68.0MB +Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])] +Grounding Time: 0.08s +Memory: 70MB (+3MB) +Unblocking actions... +Solving... +Solving Time: 0.01s +Memory: 72MB (+2MB) +SAT +Testing... +NOT SERIALIZABLE +Testing Time: 0.28s +Memory: 83MB (+11MB) +Solving... +Solving Time: 1.56s +Memory: 82MB (+-1MB) +UNKNOWN +Iteration Time: 1.96s + +Iteration 4 +Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] +Grounded Until: 10 +Expected Memory: 87.0MB +Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])] +Grounding Time: 0.14s +Memory: 84MB (+2MB) +Unblocking actions... +Solving... +Solving Time: 1.66s +Memory: 88MB (+4MB) +UNKNOWN +Iteration Time: 1.84s + +Iteration 5 +Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)] +Grounded Until: 15 +Expected Memory: 94.0MB +Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])] +Grounding Time: 0.13s +Memory: 93MB (+5MB) +Unblocking actions... +Solving... +Solving Time: 2.04s +Memory: 97MB (+4MB) +UNKNOWN +Iteration Time: 2.22s + +Iteration 6 +Queue: [(5,25,0,True), (6,30,0,True)] +Grounded Until: 20 +Expected Memory: 106.0MB +Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])] +Grounding Time: 0.13s +Memory: 100MB (+3MB) +Unblocking actions... +Solving... +Solving Time: 2.34s +Memory: 110MB (+10MB) +UNKNOWN +Iteration Time: 2.53s + +Iteration 7 +Queue: [(6,30,0,True)] +Grounded Until: 25 +Expected Memory: 123.0MB +Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])] +Grounding Time: 0.14s +Memory: 117MB (+7MB) +Unblocking actions... +Solving... +Solving Time: 2.79s +Memory: 123MB (+6MB) +UNKNOWN +Iteration Time: 2.99s + +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... +Solving Time: 2.02s +Memory: 124MB (+1MB) +UNKNOWN +Iteration Time: 2.03s + +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... +Solving Time: 1.73s +Memory: 124MB (+0MB) +UNKNOWN +Iteration Time: 1.73s + +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... +Solving Time: 2.33s +Memory: 124MB (+0MB) +UNKNOWN +Iteration Time: 2.34s + +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... +Solving Time: 2.58s +Memory: 124MB (+0MB) +UNKNOWN +Iteration Time: 2.59s + +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... +Solving Time: 2.33s +Memory: 124MB (+0MB) +UNKNOWN +Iteration Time: 2.33s + +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: 137.0MB +Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])] +Grounding Time: 0.17s +Memory: 130MB (+6MB) +Unblocking actions... +Solving... +Solving Time: 3.55s +Memory: 137MB (+7MB) +UNKNOWN +Iteration Time: 3.78s + +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: 150.0MB +Grounding... [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])] +Grounding Time: 0.13s +Memory: 137MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 3.90s +Memory: 144MB (+7MB) +UNKNOWN +Iteration Time: 4.10s + +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: 157.0MB +Grounding... [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])] +Grounding Time: 0.13s +Memory: 144MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 4.66s +Memory: 150MB (+6MB) +UNKNOWN +Iteration Time: 4.87s + +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: 163.0MB +Grounding... [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])] +Grounding Time: 0.14s +Memory: 156MB (+6MB) +Unblocking actions... +Solving... +Solving Time: 4.97s +Memory: 172MB (+16MB) +UNKNOWN +Iteration Time: 5.18s + +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: 194.0MB +Grounding... [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])] +Grounding Time: 0.14s +Memory: 172MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 5.77s +Memory: 175MB (+3MB) +UNKNOWN +Iteration Time: 5.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: 197.0MB +Grounding... [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])] +Grounding Time: 0.14s +Memory: 175MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 6.72s +Memory: 179MB (+4MB) +UNKNOWN +Iteration Time: 6.94s + +Iteration 19 +Queue: [(13,65,0,True), (14,70,0,True), (15,75,0,True)] +Grounded Until: 60 +Expected Memory: 201.0MB +Grounding... [('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('check', [65])] +Grounding Time: 0.14s +Memory: 179MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 6.71s +Memory: 206MB (+27MB) +UNKNOWN +Iteration Time: 6.94s + +Iteration 20 +Queue: [(14,70,0,True), (15,75,0,True)] +Grounded Until: 65 +Expected Memory: 233.0MB +Grounding... [('step', [66]), ('step', [67]), ('step', [68]), ('step', [69]), ('step', [70]), ('check', [70])] +Grounding Time: 0.14s +Memory: 206MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 7.03s +Memory: 216MB (+10MB) +UNKNOWN +Iteration Time: 7.26s + +Iteration 21 +Queue: [(15,75,0,True)] +Grounded Until: 70 +Expected Memory: 243.0MB +Grounding... [('step', [71]), ('step', [72]), ('step', [73]), ('step', [74]), ('step', [75]), ('check', [75])] +Grounding Time: 0.22s +Memory: 222MB (+6MB) +Unblocking actions... +Solving... +Solving Time: 9.28s +Memory: 239MB (+17MB) +UNKNOWN +Iteration Time: 9.60s + +Iteration 22 +Queue: [(2,10,2,True), (3,15,2,True), (4,20,2,True), (5,25,2,True), (6,30,2,True), (7,35,1,True), (8,40,1,True), (9,45,1,True), (10,50,1,True), (11,55,1,True), (12,60,1,True), (13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Blocking actions... +Solving... +Solving Time: 2.24s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 2.25s + +Iteration 23 +Queue: [(3,15,2,True), (4,20,2,True), (5,25,2,True), (6,30,2,True), (7,35,1,True), (8,40,1,True), (9,45,1,True), (10,50,1,True), (11,55,1,True), (12,60,1,True), (13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 2.09s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 2.10s + +Iteration 24 +Queue: [(4,20,2,True), (5,25,2,True), (6,30,2,True), (7,35,1,True), (8,40,1,True), (9,45,1,True), (10,50,1,True), (11,55,1,True), (12,60,1,True), (13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 2.45s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 2.46s + +Iteration 25 +Queue: [(5,25,2,True), (6,30,2,True), (7,35,1,True), (8,40,1,True), (9,45,1,True), (10,50,1,True), (11,55,1,True), (12,60,1,True), (13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 2.93s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 2.94s + +Iteration 26 +Queue: [(6,30,2,True), (7,35,1,True), (8,40,1,True), (9,45,1,True), (10,50,1,True), (11,55,1,True), (12,60,1,True), (13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 3.47s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 3.48s + +Iteration 27 +Queue: [(7,35,1,True), (8,40,1,True), (9,45,1,True), (10,50,1,True), (11,55,1,True), (12,60,1,True), (13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 3.68s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 3.69s + +Iteration 28 +Queue: [(8,40,1,True), (9,45,1,True), (10,50,1,True), (11,55,1,True), (12,60,1,True), (13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 4.82s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 4.83s + +Iteration 29 +Queue: [(9,45,1,True), (10,50,1,True), (11,55,1,True), (12,60,1,True), (13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 4.90s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 4.91s + +Iteration 30 +Queue: [(10,50,1,True), (11,55,1,True), (12,60,1,True), (13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 5.01s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 5.02s + +Iteration 31 +Queue: [(11,55,1,True), (12,60,1,True), (13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 6.64s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 6.65s + +Iteration 32 +Queue: [(12,60,1,True), (13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 6.60s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 6.61s + +Iteration 33 +Queue: [(13,65,1,True), (14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 7.50s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 7.51s + +Iteration 34 +Queue: [(14,70,1,True), (15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 7.83s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 7.84s + +Iteration 35 +Queue: [(15,75,1,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Unblocking actions... +Solving... +Solving Time: 9.58s +Memory: 239MB (+0MB) +UNKNOWN +Iteration Time: 9.59s + +Iteration 36 +Queue: [(16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 75 +Expected Memory: 266.0MB +Grounding... [('step', [76]), ('step', [77]), ('step', [78]), ('step', [79]), ('step', [80]), ('check', [80])] +Grounding Time: 0.14s +Memory: 239MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 9.13s +Memory: 252MB (+13MB) +UNKNOWN +Iteration Time: 9.36s + +Iteration 37 +Queue: [(17,85,0,True), (18,90,0,True), (19,95,0,True)] +Grounded Until: 80 +Expected Memory: 279.0MB +Grounding... [('step', [81]), ('step', [82]), ('step', [83]), ('step', [84]), ('step', [85]), ('check', [85])] +Grounding Time: 0.14s +Memory: 252MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 9.56s +Memory: 253MB (+1MB) +UNKNOWN +Iteration Time: 9.80s + +Iteration 38 +Queue: [(18,90,0,True), (19,95,0,True)] +Grounded Until: 85 +Expected Memory: 280.0MB +Grounding... [('step', [86]), ('step', [87]), ('step', [88]), ('step', [89]), ('step', [90]), ('check', [90])] +Grounding Time: 0.14s +Memory: 253MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 10.06s +Memory: 254MB (+1MB) +UNKNOWN +Iteration Time: 10.30s + +Iteration 39 +Queue: [(19,95,0,True)] +Grounded Until: 90 +Expected Memory: 281.0MB +Grounding... [('step', [91]), ('step', [92]), ('step', [93]), ('step', [94]), ('step', [95]), ('check', [95])] +Grounding Time: 0.14s +Memory: 254MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 11.54s +Memory: 260MB (+6MB) +UNKNOWN +Iteration Time: 11.79s + +Iteration 40 +Queue: [(2,10,3,True), (3,15,3,True), (4,20,3,True), (5,25,3,True), (6,30,3,True), (7,35,2,True), (8,40,2,True), (9,45,2,True), (10,50,2,True), (11,55,2,True), (12,60,2,False), (13,65,2,False), (14,70,2,False), (15,75,2,False), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Blocking actions... +Solving... +Solving Time: 2.67s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 2.69s + +Iteration 41 +Queue: [(3,15,3,True), (4,20,3,True), (5,25,3,True), (6,30,3,True), (7,35,2,True), (8,40,2,True), (9,45,2,True), (10,50,2,True), (11,55,2,True), (12,60,2,False), (13,65,2,False), (14,70,2,False), (15,75,2,False), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 3.42s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 3.43s + +Iteration 42 +Queue: [(4,20,3,True), (5,25,3,True), (6,30,3,True), (7,35,2,True), (8,40,2,True), (9,45,2,True), (10,50,2,True), (11,55,2,True), (12,60,2,False), (13,65,2,False), (14,70,2,False), (15,75,2,False), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 2.69s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 2.70s + +Iteration 43 +Queue: [(5,25,3,True), (6,30,3,True), (7,35,2,True), (8,40,2,True), (9,45,2,True), (10,50,2,True), (11,55,2,True), (12,60,2,False), (13,65,2,False), (14,70,2,False), (15,75,2,False), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 3.02s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 3.04s + +Iteration 44 +Queue: [(6,30,3,True), (7,35,2,True), (8,40,2,True), (9,45,2,True), (10,50,2,True), (11,55,2,True), (12,60,2,False), (13,65,2,False), (14,70,2,False), (15,75,2,False), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 3.60s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 3.62s + +Iteration 45 +Queue: [(7,35,2,True), (8,40,2,True), (9,45,2,True), (10,50,2,True), (11,55,2,True), (12,60,2,False), (13,65,2,False), (14,70,2,False), (15,75,2,False), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 4.23s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 4.24s + +Iteration 46 +Queue: [(8,40,2,True), (9,45,2,True), (10,50,2,True), (11,55,2,True), (12,60,2,False), (13,65,2,False), (14,70,2,False), (15,75,2,False), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 5.04s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 5.06s + +Iteration 47 +Queue: [(9,45,2,True), (10,50,2,True), (11,55,2,True), (12,60,2,False), (13,65,2,False), (14,70,2,False), (15,75,2,False), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 5.43s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 5.45s + +Iteration 48 +Queue: [(10,50,2,True), (11,55,2,True), (12,60,2,False), (13,65,2,False), (14,70,2,False), (15,75,2,False), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 5.65s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 5.67s + +Iteration 49 +Queue: [(11,55,2,True), (12,60,2,False), (13,65,2,False), (14,70,2,False), (15,75,2,False), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 6.17s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 6.19s + +Iteration 50 +Queue: [(16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 8.77s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 8.78s + +Iteration 51 +Queue: [(17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 8.94s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 8.95s + +Iteration 52 +Queue: [(18,90,1,True), (19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 8.76s +Memory: 260MB (+0MB) +UNKNOWN +Iteration Time: 8.78s + +Iteration 53 +Queue: [(19,95,1,True), (20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Unblocking actions... +Solving... +Solving Time: 10.25s +Memory: 286MB (+26MB) +UNKNOWN +Iteration Time: 10.27s + +Iteration 54 +Queue: [(20,100,0,True), (21,105,0,True)] +Grounded Until: 95 +Expected Memory: 313.0MB +Grounding... [('step', [96]), ('step', [97]), ('step', [98]), ('step', [99]), ('step', [100]), ('check', [100])] +Grounding Time: 0.14s +Memory: 286MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 10.42s +Memory: 272MB (+-14MB) +UNKNOWN +Iteration Time: 10.66s + +Iteration 55 +Queue: [(21,105,0,True)] +Grounded Until: 100 +Expected Memory: 299.0MB +Grounding... [('step', [101]), ('step', [102]), ('step', [103]), ('step', [104]), ('step', [105]), ('check', [105])] +Grounding Time: 0.14s +Memory: 272MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 11.21s +Memory: 288MB (+16MB) +UNKNOWN +Iteration Time: 11.46s + +Iteration 56 +Queue: [(2,10,4,True), (3,15,4,True), (4,20,4,True), (5,25,4,True), (6,30,4,False), (7,35,3,True), (8,40,3,True), (9,45,3,False), (10,50,3,False), (11,55,3,False), (12,60,2,True), (13,65,2,True), (14,70,2,False), (15,75,2,False), (16,80,2,False), (17,85,2,False), (18,90,2,False), (19,95,2,False), (20,100,1,True), (21,105,1,True)] +Grounded Until: 105 +Blocking actions... +Solving... +Solving Time: 2.72s +Memory: 288MB (+0MB) +UNKNOWN +Iteration Time: 2.74s + +Iteration 57 +Queue: [(3,15,4,True), (4,20,4,True), (5,25,4,True), (6,30,4,False), (7,35,3,True), (8,40,3,True), (9,45,3,False), (10,50,3,False), (11,55,3,False), (12,60,2,True), (13,65,2,True), (14,70,2,False), (15,75,2,False), (16,80,2,False), (17,85,2,False), (18,90,2,False), (19,95,2,False), (20,100,1,True), (21,105,1,True)] +Grounded Until: 105 +Unblocking actions... +Solving... +Solving Time: 3.35s +Memory: 288MB (+0MB) +SAT +Testing... +SERIALIZABLE? +Testing Time: 0.00s +Memory: 288MB (+0MB) +Answer: 2 +occurs(action(("move","hoist0","depot0-1-1","depot0-1-2")),1) occurs(action(("move","hoist1","depot1-1-3","depot1-1-2")),1) occurs(action(("go-out","hoist2","depot1-2-3","loadarea")),1) occurs(action(("move","hoist0","depot0-1-2","depot0-2-2")),2) occurs(action(("lift","hoist2","crate3","container-0-3","loadarea","container0")),2) occurs(action(("move","hoist1","depot1-1-2","depot1-1-1")),2) occurs(action(("go-out","hoist0","depot0-2-2","loadarea")),3) occurs(action(("move","hoist1","depot1-1-1","depot1-2-1")),3) occurs(action(("go-in","hoist2","loadarea","depot1-2-3")),3) occurs(action(("lift","hoist0","crate4","container-1-0","loadarea","container1")),4) occurs(action(("move","hoist2","depot1-2-3","depot1-1-3")),4) occurs(action(("drop","hoist2","crate3","depot1-1-2","depot1-1-3","depot1")),5) occurs(action(("drop","hoist0","crate4","depot1-2-3","loadarea","depot1")),5) occurs(action(("move","hoist1","depot1-2-1","depot1-1-1")),5) occurs(action(("lift","hoist0","crate0","container-0-0","loadarea","container0")),6) occurs(action(("move","hoist1","depot1-1-1","depot1-2-1")),6) occurs(action(("lift","hoist2","crate4","depot1-2-3","depot1-1-3","depot1")),6) occurs(action(("go-in","hoist0","loadarea","depot0-2-2")),7) occurs(action(("move","hoist2","depot1-1-3","depot1-2-3")),7) occurs(action(("drop","hoist0","crate0","depot0-1-2","depot0-2-2","depot0")),8) occurs(action(("drop","hoist2","crate4","depot1-1-3","depot1-2-3","depot1")),8) occurs(action(("go-out","hoist0","depot0-2-2","loadarea")),9) occurs(action(("go-out","hoist2","depot1-2-3","loadarea")),9) occurs(action(("lift","hoist0","crate1","container-0-1","loadarea","container0")),10) occurs(action(("lift","hoist2","crate2","container-0-2","loadarea","container0")),10) occurs(action(("drop","hoist0","crate1","depot0-2-2","loadarea","depot0")),11) occurs(action(("drop","hoist2","crate2","depot1-2-3","loadarea","depot1")),11) occurs(action(("move","hoist1","depot1-2-1","depot1-1-1")),12) occurs(action(("go-in","hoist0","loadarea","container-0-0")),12) occurs(action(("go-out","hoist0","container-0-0","loadarea")),13) occurs(action(("go-in","hoist0","loadarea","container-1-0")),14) occurs(action(("move","hoist1","depot1-1-1","depot1-2-1")),15) +SATISFIABLE + +Models : 1+ +Calls : 58 +Time : 295.410s (Solving: 289.17s 1st Model: 3.31s Unsat: 0.01s) +CPU Time : 295.528s + +Choices : 6457680 (Domain: 6156092) +Conflicts : 484261 (Analyzed: 484260) +Restarts : 5489 (Average: 88.22 Last: 166) +Model-Level : 214.5 +Problems : 58 (Average Length: 69.33 Splits: 0) +Lemmas : 484260 (Deleted: 476936) + Binary : 197 (Ratio: 0.04%) + Ternary : 77 (Ratio: 0.02%) + Conflict : 484260 (Average Length: 1790.3 Ratio: 100.00%) + Loop : 0 (Average Length: 0.0 Ratio: 0.00%) + Other : 0 (Average Length: 0.0 Ratio: 0.00%) +Backjumps : 484260 (Average: 12.09 Max: 3571 Sum: 5855904) + Executed : 484215 (Average: 12.09 Max: 3571 Sum: 5854717 Ratio: 99.98%) + Bounded : 45 (Average: 26.38 Max: 97 Sum: 1187 Ratio: 0.02%) + +Rules : 36328 (Original: 36276) +Atoms : 21399 +Bodies : 10348 (Original: 10307) + Count : 202 (Original: 214) +Equivalences : 5515 (Atom=Atom: 30 Body=Body: 0 Other: 5485) +Tight : Yes +Variables : 133052 (Eliminated: 0 Frozen: 102618) +Constraints : 1276250 (Binary: 96.7% Ternary: 1.6% Other: 1.7%) + +Memory Peak : 288MB +Max. Length : 105 steps +Sol. Length : 15 steps +Models : 2 + +