From ba87264833e2aa71ee46f3df4aaf1a7d5b7cee33 Mon Sep 17 00:00:00 2001 From: potassco-bot Date: Mon, 4 Dec 2017 02:33:03 +0100 Subject: [PATCH] Add benchmark result [gc-ta1-tt1 | ipc-2011 | visit-all-sequential-satisficing | 4] --- ...011_visit-all-sequential-satisficing_4.env | 53 ++ ...011_visit-all-sequential-satisficing_4.err | 32 + ...011_visit-all-sequential-satisficing_4.out | 835 ++++++++++++++++++ 3 files changed, 920 insertions(+) create mode 100644 gc-ta1-tt1/ipc-2011_visit-all-sequential-satisficing_4.env create mode 100644 gc-ta1-tt1/ipc-2011_visit-all-sequential-satisficing_4.err create mode 100644 gc-ta1-tt1/ipc-2011_visit-all-sequential-satisficing_4.out diff --git a/gc-ta1-tt1/ipc-2011_visit-all-sequential-satisficing_4.env b/gc-ta1-tt1/ipc-2011_visit-all-sequential-satisficing_4.env new file mode 100644 index 000000000..42095b6cd --- /dev/null +++ b/gc-ta1-tt1/ipc-2011_visit-all-sequential-satisficing_4.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-2011/domains/visit-all-sequential-satisficing/domain.pddl +- /home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/visit-all-sequential-satisficing/instances/instance-4.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: visit-all-sequential-satisficing + instance: 4 + ipc: ipc-2011 +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-2011_visit-all-sequential-satisficing_4.err b/gc-ta1-tt1/ipc-2011_visit-all-sequential-satisficing_4.err new file mode 100644 index 000000000..c87a896f1 --- /dev/null +++ b/gc-ta1-tt1/ipc-2011_visit-all-sequential-satisficing_4.err @@ -0,0 +1,32 @@ +# 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-2011', 'domain': 'visit-all-sequential-satisficing', 'instance': 4} +# 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-2011/domains/visit-all-sequential-satisficing/domain.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/visit-all-sequential-satisficing/instances/instance-4.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)) + +/home/pluehne/Documents/ASP/plasp-javier/encodings/strips/strips-incremental.lp:66:15-28: info: atom does not occur in any rule head: + mutexGroup(G) + +/home/pluehne/Documents/ASP/plasp-javier/encodings/strips/strips-incremental.lp:66:30-45: info: atom does not occur in any rule head: + contains(G,X,V) + +/home/pluehne/Documents/ASP/plasp-javier/encodings/strips/strips-incremental.lp:67:15-28: info: atom does not occur in any rule head: + mutexGroup(G) + +/home/pluehne/Documents/ASP/plasp-javier/encodings/strips/strips-incremental.lp:74:41-56: info: atom does not occur in any rule head: + contains(G,X,V) + +/home/pluehne/Documents/ASP/plasp-javier/encodings/strips/strips-incremental.lp:84:41-56: info: atom does not occur in any rule head: + contains(G,X,V) + +TIMEOUT CPU 900.07 MEM 654864 MAXMEM 702368 STALE 1 MAXMEM_RSS 639648 + + diff --git a/gc-ta1-tt1/ipc-2011_visit-all-sequential-satisficing_4.out b/gc-ta1-tt1/ipc-2011_visit-all-sequential-satisficing_4.out new file mode 100644 index 000000000..48c19b259 --- /dev/null +++ b/gc-ta1-tt1/ipc-2011_visit-all-sequential-satisficing_4.out @@ -0,0 +1,835 @@ +INFO Running translator. +INFO translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/visit-all-sequential-satisficing/domain.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/visit-all-sequential-satisficing/instances/instance-4.pddl'] +INFO translator arguments: [] +INFO translator time limit: None +INFO translator memory limit: None +INFO callstring: /home/pluehne/.usr/bin/python /home/wv/bin/linux/64/fast-downward-10997/builds/release64/bin/translate/translate.py /home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/visit-all-sequential-satisficing/domain.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2011/domains/visit-all-sequential-satisficing/instances/instance-4.pddl +Parsing... +Parsing: [0.100s CPU, 0.104s wall-clock] +Normalizing task... [0.010s CPU, 0.004s wall-clock] +Instantiating... +Generating Datalog program... [0.040s CPU, 0.045s wall-clock] +Normalizing Datalog program... +Normalizing Datalog program: [0.010s CPU, 0.010s wall-clock] +Preparing model... [0.140s CPU, 0.140s wall-clock] +Generated 6 rules. +Computing model... [0.300s CPU, 0.301s wall-clock] +4069 relevant atoms +1548 auxiliary atoms +5617 final queue length +7419 total queue pushes +Completing instantiation... [0.270s CPU, 0.273s wall-clock] +Instantiating: [0.770s CPU, 0.776s wall-clock] +Computing fact groups... +Finding invariants... +4 initial candidates +Finding invariants: [0.000s CPU, 0.003s wall-clock] +Checking invariant weight... [0.010s CPU, 0.005s wall-clock] +Instantiating groups... [0.000s CPU, 0.005s wall-clock] +Collecting mutex groups... [0.010s CPU, 0.003s wall-clock] +Choosing groups... +324 uncovered facts +Choosing groups: [0.000s CPU, 0.007s wall-clock] +Building translation key... [0.020s CPU, 0.014s wall-clock] +Computing fact groups: [0.090s CPU, 0.085s wall-clock] +Building STRIPS to SAS dictionary... [0.000s CPU, 0.005s wall-clock] +Building dictionary for full mutex groups... [0.000s CPU, 0.004s wall-clock] +Building mutex information... +Building mutex information: [0.010s CPU, 0.005s wall-clock] +Translating task... +Processing axioms... +Simplifying axioms... [0.000s CPU, 0.000s wall-clock] +Processing axioms: [0.010s CPU, 0.014s wall-clock] +Translating task: [0.270s CPU, 0.275s wall-clock] +0 effect conditions simplified +0 implied preconditions added +Detecting unreachable propositions... +0 operators removed +0 axioms removed +3 propositions removed +Detecting unreachable propositions: [0.220s CPU, 0.214s wall-clock] +Reordering and filtering variables... +324 of 324 variables necessary. +0 of 1 mutex groups necessary. +1224 of 1224 operators necessary. +0 of 0 axiom rules necessary. +Reordering and filtering variables: [0.060s CPU, 0.064s wall-clock] +Translator variables: 324 +Translator derived variables: 0 +Translator facts: 970 +Translator goal facts: 323 +Translator mutex groups: 0 +Translator total mutex groups size: 0 +Translator operators: 1224 +Translator axioms: 0 +Translator task size: 6509 +Translator peak memory: 41164 KB +Writing output... [0.160s CPU, 0.182s wall-clock] +Done! [1.710s CPU, 1.733s wall-clock] +planner.py version 0.0.1 + +Time: 0.23s +Memory: 62MB + +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: 63MB (+1MB) +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: 63MB +Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])] +Grounding Time: 0.11s +Memory: 70MB (+7MB) +Unblocking actions... +Solving... +Solving Time: 0.01s +Memory: 74MB (+4MB) +UNSAT +Iteration Time: 0.16s + +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: 85.0MB +Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])] +Grounding Time: 0.12s +Memory: 80MB (+6MB) +Unblocking actions... +Solving... +Solving Time: 0.01s +Memory: 83MB (+3MB) +UNSAT +Iteration Time: 0.18s + +Iteration 4 +Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)] +Grounded Until: 10 +Expected Memory: 94.0MB +Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])] +Grounding Time: 0.13s +Memory: 90MB (+7MB) +Unblocking actions... +Solving... +Solving Time: 0.01s +Memory: 95MB (+5MB) +UNSAT +Iteration Time: 0.21s + +Iteration 5 +Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)] +Grounded Until: 15 +Expected Memory: 107.0MB +Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])] +Grounding Time: 0.13s +Memory: 101MB (+6MB) +Unblocking actions... +Solving... +Solving Time: 0.58s +Memory: 107MB (+6MB) +UNSAT +Iteration Time: 0.79s + +Iteration 6 +Queue: [(5,25,0,True), (6,30,0,True)] +Grounded Until: 20 +Expected Memory: 119.0MB +Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])] +Grounding Time: 0.13s +Memory: 112MB (+5MB) +Unblocking actions... +Solving... +Solving Time: 1.73s +Memory: 120MB (+8MB) +UNSAT +Iteration Time: 1.93s + +Iteration 7 +Queue: [(6,30,0,True)] +Grounded Until: 25 +Expected Memory: 133.0MB +Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])] +Grounding Time: 0.16s +Memory: 129MB (+9MB) +Unblocking actions... +Solving... +Solving Time: 1.79s +Memory: 133MB (+4MB) +UNSAT +Iteration Time: 2.02s + +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: 146.0MB +Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])] +Grounding Time: 0.13s +Memory: 140MB (+7MB) +Unblocking actions... +Solving... +Solving Time: 3.40s +Memory: 150MB (+10MB) +UNSAT +Iteration Time: 3.61s + +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: 167.0MB +Grounding... [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])] +Grounding Time: 0.13s +Memory: 153MB (+3MB) +Unblocking actions... +Solving... +Solving Time: 7.83s +Memory: 160MB (+7MB) +UNKNOWN +Iteration Time: 8.04s + +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: 177.0MB +Grounding... [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])] +Grounding Time: 0.13s +Memory: 166MB (+6MB) +Unblocking actions... +Solving... +Solving Time: 9.32s +Memory: 170MB (+4MB) +UNSAT +Iteration Time: 9.54s + +Iteration 11 +Queue: [(10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)] +Grounded Until: 45 +Expected Memory: 187.0MB +Grounding... [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])] +Grounding Time: 0.13s +Memory: 174MB (+4MB) +Unblocking actions... +Solving... +Solving Time: 7.38s +Memory: 179MB (+5MB) +UNKNOWN +Iteration Time: 7.61s + +Iteration 12 +Queue: [(11,55,0,True), (12,60,0,True), (13,65,0,True)] +Grounded Until: 50 +Expected Memory: 196.0MB +Grounding... [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])] +Grounding Time: 0.13s +Memory: 185MB (+6MB) +Unblocking actions... +Solving... +Solving Time: 6.20s +Memory: 202MB (+17MB) +UNKNOWN +Iteration Time: 6.44s + +Iteration 13 +Queue: [(12,60,0,True), (13,65,0,True)] +Grounded Until: 55 +Expected Memory: 225.0MB +Grounding... [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])] +Grounding Time: 0.21s +Memory: 214MB (+12MB) +Unblocking actions... +Solving... +Solving Time: 12.24s +Memory: 221MB (+7MB) +UNKNOWN +Iteration Time: 12.56s + +Iteration 14 +Queue: [(13,65,0,True)] +Grounded Until: 60 +Expected Memory: 244.0MB +Grounding... [('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('check', [65])] +Grounding Time: 0.13s +Memory: 232MB (+11MB) +Unblocking actions... +Solving... +Solving Time: 6.70s +Memory: 238MB (+6MB) +UNKNOWN +Iteration Time: 6.95s + +Iteration 15 +Queue: [(10,50,1,True), (11,55,1,True), (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)] +Grounded Until: 65 +Blocking actions... +Solving... +Solving Time: 9.22s +Memory: 238MB (+0MB) +UNSAT +Iteration Time: 9.23s + +Iteration 16 +Queue: [(11,55,1,True), (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)] +Grounded Until: 65 +Unblocking actions... +Solving... +Solving Time: 7.01s +Memory: 238MB (+0MB) +UNKNOWN +Iteration Time: 7.02s + +Iteration 17 +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)] +Grounded Until: 65 +Unblocking actions... +Solving... +Solving Time: 14.69s +Memory: 247MB (+9MB) +UNKNOWN +Iteration Time: 14.71s + +Iteration 18 +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)] +Grounded Until: 65 +Unblocking actions... +Solving... +Solving Time: 11.84s +Memory: 262MB (+15MB) +UNKNOWN +Iteration Time: 11.86s + +Iteration 19 +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)] +Grounded Until: 65 +Expected Memory: 285.0MB +Grounding... [('step', [66]), ('step', [67]), ('step', [68]), ('step', [69]), ('step', [70]), ('check', [70])] +Grounding Time: 0.13s +Memory: 271MB (+9MB) +Unblocking actions... +Solving... +Solving Time: 13.88s +Memory: 274MB (+3MB) +UNKNOWN +Iteration Time: 14.15s + +Iteration 20 +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), (21,105,0,True), (22,110,0,True), (23,115,0,True)] +Grounded Until: 70 +Expected Memory: 297.0MB +Grounding... [('step', [71]), ('step', [72]), ('step', [73]), ('step', [74]), ('step', [75]), ('check', [75])] +Grounding Time: 0.13s +Memory: 274MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 12.16s +Memory: 276MB (+2MB) +UNKNOWN +Iteration Time: 12.42s + +Iteration 21 +Queue: [(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)] +Grounded Until: 75 +Expected Memory: 299.0MB +Grounding... [('step', [76]), ('step', [77]), ('step', [78]), ('step', [79]), ('step', [80]), ('check', [80])] +Grounding Time: 0.13s +Memory: 276MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 11.80s +Memory: 291MB (+15MB) +UNKNOWN +Iteration Time: 12.08s + +Iteration 22 +Queue: [(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)] +Grounded Until: 80 +Expected Memory: 314.0MB +Grounding... [('step', [81]), ('step', [82]), ('step', [83]), ('step', [84]), ('step', [85]), ('check', [85])] +Grounding Time: 0.13s +Memory: 291MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 14.64s +Memory: 293MB (+2MB) +UNKNOWN +Iteration Time: 14.91s + +Iteration 23 +Queue: [(18,90,0,True), (19,95,0,True), (20,100,0,True), (21,105,0,True), (22,110,0,True), (23,115,0,True)] +Grounded Until: 85 +Expected Memory: 316.0MB +Grounding... [('step', [86]), ('step', [87]), ('step', [88]), ('step', [89]), ('step', [90]), ('check', [90])] +Grounding Time: 0.13s +Memory: 293MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 13.08s +Memory: 294MB (+1MB) +UNKNOWN +Iteration Time: 13.36s + +Iteration 24 +Queue: [(19,95,0,True), (20,100,0,True), (21,105,0,True), (22,110,0,True), (23,115,0,True)] +Grounded Until: 90 +Expected Memory: 317.0MB +Grounding... [('step', [91]), ('step', [92]), ('step', [93]), ('step', [94]), ('step', [95]), ('check', [95])] +Grounding Time: 0.13s +Memory: 298MB (+4MB) +Unblocking actions... +Solving... +Solving Time: 13.66s +Memory: 305MB (+7MB) +UNKNOWN +Iteration Time: 13.95s + +Iteration 25 +Queue: [(20,100,0,True), (21,105,0,True), (22,110,0,True), (23,115,0,True)] +Grounded Until: 95 +Expected Memory: 328.0MB +Grounding... [('step', [96]), ('step', [97]), ('step', [98]), ('step', [99]), ('step', [100]), ('check', [100])] +Grounding Time: 0.13s +Memory: 306MB (+1MB) +Unblocking actions... +Solving... +Solving Time: 14.06s +Memory: 315MB (+9MB) +UNKNOWN +Iteration Time: 14.35s + +Iteration 26 +Queue: [(21,105,0,True), (22,110,0,True), (23,115,0,True)] +Grounded Until: 100 +Expected Memory: 338.0MB +Grounding... [('step', [101]), ('step', [102]), ('step', [103]), ('step', [104]), ('step', [105]), ('check', [105])] +Grounding Time: 0.14s +Memory: 315MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 15.63s +Memory: 322MB (+7MB) +UNKNOWN +Iteration Time: 15.94s + +Iteration 27 +Queue: [(22,110,0,True), (23,115,0,True)] +Grounded Until: 105 +Expected Memory: 345.0MB +Grounding... [('step', [106]), ('step', [107]), ('step', [108]), ('step', [109]), ('step', [110]), ('check', [110])] +Grounding Time: 0.14s +Memory: 330MB (+8MB) +Unblocking actions... +Solving... +Solving Time: 17.73s +Memory: 339MB (+9MB) +UNKNOWN +Iteration Time: 18.05s + +Iteration 28 +Queue: [(23,115,0,True)] +Grounded Until: 110 +Expected Memory: 362.0MB +Grounding... [('step', [111]), ('step', [112]), ('step', [113]), ('step', [114]), ('step', [115]), ('check', [115])] +Grounding Time: 0.14s +Memory: 347MB (+8MB) +Unblocking actions... +Solving... +Solving Time: 15.37s +Memory: 376MB (+29MB) +UNKNOWN +Iteration Time: 15.71s + +Iteration 29 +Queue: [(11,55,2,True), (12,60,2,True), (13,65,2,True), (14,70,1,True), (15,75,1,True), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,1,True), (21,105,1,True), (22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Blocking actions... +Solving... +Solving Time: 14.00s +Memory: 384MB (+8MB) +UNKNOWN +Iteration Time: 14.03s + +Iteration 30 +Queue: [(12,60,2,True), (13,65,2,True), (14,70,1,True), (15,75,1,True), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,1,True), (21,105,1,True), (22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 11.79s +Memory: 392MB (+8MB) +UNKNOWN +Iteration Time: 11.82s + +Iteration 31 +Queue: [(13,65,2,True), (14,70,1,True), (15,75,1,True), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,1,True), (21,105,1,True), (22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 12.28s +Memory: 407MB (+15MB) +UNKNOWN +Iteration Time: 12.31s + +Iteration 32 +Queue: [(14,70,1,True), (15,75,1,True), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,1,True), (21,105,1,True), (22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 15.57s +Memory: 445MB (+38MB) +UNKNOWN +Iteration Time: 15.60s + +Iteration 33 +Queue: [(15,75,1,True), (16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,1,True), (21,105,1,True), (22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 15.92s +Memory: 445MB (+0MB) +UNKNOWN +Iteration Time: 15.95s + +Iteration 34 +Queue: [(16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,1,True), (21,105,1,True), (22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 15.21s +Memory: 445MB (+0MB) +UNKNOWN +Iteration Time: 15.25s + +Iteration 35 +Queue: [(17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,1,True), (21,105,1,True), (22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 18.59s +Memory: 445MB (+0MB) +UNKNOWN +Iteration Time: 18.62s + +Iteration 36 +Queue: [(18,90,1,True), (19,95,1,True), (20,100,1,True), (21,105,1,True), (22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 18.01s +Memory: 445MB (+0MB) +UNKNOWN +Iteration Time: 18.04s + +Iteration 37 +Queue: [(19,95,1,True), (20,100,1,True), (21,105,1,True), (22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 18.37s +Memory: 445MB (+0MB) +UNKNOWN +Iteration Time: 18.41s + +Iteration 38 +Queue: [(20,100,1,True), (21,105,1,True), (22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 17.06s +Memory: 445MB (+0MB) +UNKNOWN +Iteration Time: 17.09s + +Iteration 39 +Queue: [(21,105,1,True), (22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 16.62s +Memory: 445MB (+0MB) +UNKNOWN +Iteration Time: 16.65s + +Iteration 40 +Queue: [(22,110,1,True), (23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 17.17s +Memory: 445MB (+0MB) +UNKNOWN +Iteration Time: 17.20s + +Iteration 41 +Queue: [(23,115,1,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Unblocking actions... +Solving... +Solving Time: 17.09s +Memory: 445MB (+0MB) +UNKNOWN +Iteration Time: 17.12s + +Iteration 42 +Queue: [(24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 115 +Expected Memory: 482.0MB +Grounding... [('step', [116]), ('step', [117]), ('step', [118]), ('step', [119]), ('step', [120]), ('check', [120])] +Grounding Time: 0.31s +Memory: 460MB (+15MB) +Unblocking actions... +Solving... +Solving Time: 17.82s +Memory: 461MB (+1MB) +UNKNOWN +Iteration Time: 18.33s + +Iteration 43 +Queue: [(25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 120 +Expected Memory: 498.0MB +Grounding... [('step', [121]), ('step', [122]), ('step', [123]), ('step', [124]), ('step', [125]), ('check', [125])] +Grounding Time: 0.13s +Memory: 461MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 16.55s +Memory: 463MB (+2MB) +UNKNOWN +Iteration Time: 16.88s + +Iteration 44 +Queue: [(26,130,0,True), (27,135,0,True), (28,140,0,True)] +Grounded Until: 125 +Expected Memory: 500.0MB +Grounding... [('step', [126]), ('step', [127]), ('step', [128]), ('step', [129]), ('step', [130]), ('check', [130])] +Grounding Time: 0.13s +Memory: 463MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 18.50s +Memory: 465MB (+2MB) +UNKNOWN +Iteration Time: 18.83s + +Iteration 45 +Queue: [(27,135,0,True), (28,140,0,True)] +Grounded Until: 130 +Expected Memory: 502.0MB +Grounding... [('step', [131]), ('step', [132]), ('step', [133]), ('step', [134]), ('step', [135]), ('check', [135])] +Grounding Time: 0.13s +Memory: 465MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 16.71s +Memory: 467MB (+2MB) +UNKNOWN +Iteration Time: 17.06s + +Iteration 46 +Queue: [(28,140,0,True)] +Grounded Until: 135 +Expected Memory: 504.0MB +Grounding... [('step', [136]), ('step', [137]), ('step', [138]), ('step', [139]), ('step', [140]), ('check', [140])] +Grounding Time: 0.13s +Memory: 467MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 17.43s +Memory: 468MB (+1MB) +UNKNOWN +Iteration Time: 17.78s + +Iteration 47 +Queue: [(11,55,3,True), (12,60,3,True), (13,65,3,True), (14,70,2,True), (15,75,2,True), (16,80,2,True), (17,85,2,True), (18,90,2,True), (19,95,2,True), (20,100,2,True), (21,105,2,False), (22,110,2,False), (23,115,2,False), (24,120,1,True), (25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Blocking actions... +Solving... +Solving Time: 10.91s +Memory: 468MB (+0MB) +UNKNOWN +Iteration Time: 10.95s + +Iteration 48 +Queue: [(12,60,3,True), (13,65,3,True), (14,70,2,True), (15,75,2,True), (16,80,2,True), (17,85,2,True), (18,90,2,True), (19,95,2,True), (20,100,2,True), (21,105,2,False), (22,110,2,False), (23,115,2,False), (24,120,1,True), (25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 11.76s +Memory: 493MB (+25MB) +UNKNOWN +Iteration Time: 11.80s + +Iteration 49 +Queue: [(13,65,3,True), (14,70,2,True), (15,75,2,True), (16,80,2,True), (17,85,2,True), (18,90,2,True), (19,95,2,True), (20,100,2,True), (21,105,2,False), (22,110,2,False), (23,115,2,False), (24,120,1,True), (25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 13.77s +Memory: 503MB (+10MB) +UNKNOWN +Iteration Time: 13.81s + +Iteration 50 +Queue: [(14,70,2,True), (15,75,2,True), (16,80,2,True), (17,85,2,True), (18,90,2,True), (19,95,2,True), (20,100,2,True), (21,105,2,False), (22,110,2,False), (23,115,2,False), (24,120,1,True), (25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 17.00s +Memory: 510MB (+7MB) +UNKNOWN +Iteration Time: 17.05s + +Iteration 51 +Queue: [(15,75,2,True), (16,80,2,True), (17,85,2,True), (18,90,2,True), (19,95,2,True), (20,100,2,True), (21,105,2,False), (22,110,2,False), (23,115,2,False), (24,120,1,True), (25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 16.36s +Memory: 511MB (+1MB) +UNKNOWN +Iteration Time: 16.40s + +Iteration 52 +Queue: [(16,80,2,True), (17,85,2,True), (18,90,2,True), (19,95,2,True), (20,100,2,True), (21,105,2,False), (22,110,2,False), (23,115,2,False), (24,120,1,True), (25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 16.35s +Memory: 528MB (+17MB) +UNKNOWN +Iteration Time: 16.39s + +Iteration 53 +Queue: [(17,85,2,True), (18,90,2,True), (19,95,2,True), (20,100,2,True), (21,105,2,False), (22,110,2,False), (23,115,2,False), (24,120,1,True), (25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 15.91s +Memory: 541MB (+13MB) +UNKNOWN +Iteration Time: 15.96s + +Iteration 54 +Queue: [(18,90,2,True), (19,95,2,True), (20,100,2,True), (21,105,2,False), (22,110,2,False), (23,115,2,False), (24,120,1,True), (25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 16.52s +Memory: 548MB (+7MB) +UNKNOWN +Iteration Time: 16.57s + +Iteration 55 +Queue: [(19,95,2,True), (20,100,2,True), (21,105,2,False), (22,110,2,False), (23,115,2,False), (24,120,1,True), (25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 18.40s +Memory: 560MB (+12MB) +UNKNOWN +Iteration Time: 18.44s + +Iteration 56 +Queue: [(20,100,2,True), (21,105,2,False), (22,110,2,False), (23,115,2,False), (24,120,1,True), (25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 14.20s +Memory: 573MB (+13MB) +UNKNOWN +Iteration Time: 14.26s + +Iteration 57 +Queue: [(24,120,1,True), (25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 20.06s +Memory: 582MB (+9MB) +UNKNOWN +Iteration Time: 20.12s + +Iteration 58 +Queue: [(25,125,1,True), (26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 18.92s +Memory: 582MB (+0MB) +UNKNOWN +Iteration Time: 18.97s + +Iteration 59 +Queue: [(26,130,1,True), (27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 16.85s +Memory: 587MB (+5MB) +UNKNOWN +Iteration Time: 16.89s + +Iteration 60 +Queue: [(27,135,1,True), (28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 20.00s +Memory: 598MB (+11MB) +UNKNOWN +Iteration Time: 20.06s + +Iteration 61 +Queue: [(28,140,1,True), (29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Unblocking actions... +Solving... +Solving Time: 18.43s +Memory: 598MB (+0MB) +UNKNOWN +Iteration Time: 18.47s + +Iteration 62 +Queue: [(29,145,0,True), (30,150,0,True)] +Grounded Until: 140 +Expected Memory: 635.0MB +Grounding... [('step', [141]), ('step', [142]), ('step', [143]), ('step', [144]), ('step', [145]), ('check', [145])] +Grounding Time: 0.14s +Memory: 598MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 17.70s +Memory: 600MB (+2MB) +UNKNOWN +Iteration Time: 18.07s + +Iteration 63 +Queue: [(30,150,0,True)] +Grounded Until: 145 +Expected Memory: 637.0MB +Grounding... [('step', [146]), ('step', [147]), ('step', [148]), ('step', [149]), ('step', [150]), ('check', [150])] +Grounding Time: 0.14s +Memory: 600MB (+0MB) +Unblocking actions... +Solving... +Solving Time: 18.02s +Memory: 602MB (+2MB) +UNKNOWN +Iteration Time: 18.40s + +Iteration 64 +Queue: [(11,55,4,True), (12,60,4,True), (13,65,4,True), (14,70,3,True), (15,75,3,True), (16,80,3,True), (17,85,3,True), (18,90,3,False), (19,95,3,False), (20,100,3,False), (21,105,2,True), (22,110,2,True), (23,115,2,False), (24,120,2,False), (25,125,2,False), (26,130,2,False), (27,135,2,False), (28,140,2,False), (29,145,1,True), (30,150,1,True)] +Grounded Until: 150 +Blocking actions... +Solving... +Solving Time: 16.75s +Memory: 602MB (+0MB) +UNKNOWN +Iteration Time: 16.79s + +Iteration 65 +Queue: [(12,60,4,True), (13,65,4,True), (14,70,3,True), (15,75,3,True), (16,80,3,True), (17,85,3,True), (18,90,3,False), (19,95,3,False), (20,100,3,False), (21,105,2,True), (22,110,2,True), (23,115,2,False), (24,120,2,False), (25,125,2,False), (26,130,2,False), (27,135,2,False), (28,140,2,False), (29,145,1,True), (30,150,1,True)] +