Add benchmark result [gc-ta1-tt1 | ipc-2000 | blocks-strips-typed | 73]

2017-11-28 07:12:53 +01:00
parent e1fb5ec9b0
commit 7fd9d220ff
3 changed files with 588 additions and 0 deletions
--- a/gc-ta1-tt1/ipc-2000_blocks-strips-typed_73.env
+++ b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_73.env
@@ -0,0 +1,51 @@
+command:
+- timeout
+- -m=8000000
+- -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-73.pddl
+- --stats
+- --verbose
+- --print-call
+- --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
+  - --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: 73
+  ipc: ipc-2000
+versions:
+  clingo: 5.2.2
+  fastDownward: 10997:847cdf0069cab0c8841a9958e783d1a7340fe2e9 (2017-11-02 15:10 +0100)
+  planner: 61750c0521c6104870e5b881c8b0c237e2af4a96 (2017-11-27 07:44:27 +0100)
+  plasp: 3.1.1
+  python: 3.6.3
+workingDirectory: /home/pluehne/Documents/ASP/plasp-javier/encodings/planner
+
--- a/gc-ta1-tt1/ipc-2000_blocks-strips-typed_73.err
+++ b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_73.err
@@ -0,0 +1,18 @@
+# configuration: {'id': 'gc-ta1-tt1', 'options': ['--stats', '--verbose', '--print-call', '--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-2000', 'domain': 'blocks-strips-typed', 'instance': 73}
+# command: ['timeout', '-m=8000000', '-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-73.pddl', '--stats', '--verbose', '--print-call', '--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-2000/domains/blocks-strips-typed/domain.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2000/domains/blocks-strips-typed/instances/instance-73.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 -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 526.69 MEM 33728 MAXMEM 1518200 STALE 1 MAXMEM_RSS 1457808
+<time name="ALL">526520</time>
+
--- a/gc-ta1-tt1/ipc-2000_blocks-strips-typed_73.out
+++ b/gc-ta1-tt1/ipc-2000_blocks-strips-typed_73.out
@@ -0,0 +1,519 @@
+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-73.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-73.pddl
+Parsing...
+Parsing: [0.010s CPU, 0.019s wall-clock]
+Normalizing task... [0.000s CPU, 0.002s wall-clock]
+Instantiating...
+Generating Datalog program... [0.010s CPU, 0.006s wall-clock]
+Normalizing Datalog program...
+Normalizing Datalog program: [0.010s CPU, 0.011s wall-clock]
+Preparing model... [0.010s CPU, 0.014s wall-clock]
+Generated 21 rules.
+Computing model... [0.490s CPU, 0.494s wall-clock]
+4178 relevant atoms
+2772 auxiliary atoms
+6950 final queue length
+12209 total queue pushes
+Completing instantiation... [0.880s CPU, 0.889s wall-clock]
+Instantiating: [1.420s CPU, 1.420s wall-clock]
+Computing fact groups...
+Finding invariants...
+10 initial candidates
+Finding invariants: [0.020s CPU, 0.025s wall-clock]
+Checking invariant weight... [0.010s CPU, 0.005s wall-clock]
+Instantiating groups... [0.050s CPU, 0.054s wall-clock]
+Collecting mutex groups... [0.010s CPU, 0.012s wall-clock]
+Choosing groups...
+37 uncovered facts
+Choosing groups: [0.050s CPU, 0.054s wall-clock]
+Building translation key... [0.020s CPU, 0.017s wall-clock]
+Computing fact groups: [0.290s CPU, 0.293s wall-clock]
+Building STRIPS to SAS dictionary... [0.000s CPU, 0.008s wall-clock]
+Building dictionary for full mutex groups... [0.030s CPU, 0.019s wall-clock]
+Building mutex information...
+Building mutex information: [0.030s CPU, 0.031s wall-clock]
+Translating task...
+Processing axioms...
+Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
+Processing axioms: [0.050s CPU, 0.043s wall-clock]
+Translating task: [1.020s CPU, 1.023s wall-clock]
+3852 effect conditions simplified
+0 implied preconditions added
+Detecting unreachable propositions...
+0 operators removed
+0 axioms removed
+72 propositions removed
+Detecting unreachable propositions: [0.620s CPU, 0.621s wall-clock]
+Reordering and filtering variables...
+73 of 73 variables necessary.
+37 of 73 mutex groups necessary.
+2592 of 2592 operators necessary.
+0 of 0 axiom rules necessary.
+Reordering and filtering variables: [0.320s CPU, 0.318s wall-clock]
+Translator variables: 73
+Translator derived variables: 0
+Translator facts: 1406
+Translator goal facts: 35
+Translator mutex groups: 37
+Translator total mutex groups size: 1369
+Translator operators: 2592
+Translator axioms: 0
+Translator task size: 22215
+Translator peak memory: 49612 KB
+Writing output... [0.380s CPU, 0.400s wall-clock]
+Done! [4.170s CPU, 4.202s wall-clock]
+planner.py version 0.0.1
+
+Time:	 0.74s
+Memory: 96MB
+
+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:		 96MB (+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
+Grounding...	 [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])]
+Grounding Time:	 0.31s
+Memory:		 101MB (+5MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.02s
+Memory:		 107MB (+6MB)
+UNSAT
+Iteration Time:	 0.45s
+
+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
+Grounding...	 [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])]
+Grounding Time:	 0.36s
+Memory:		 123MB (+16MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.02s
+Memory:		 130MB (+7MB)
+UNSAT
+Iteration Time:	 0.52s
+
+Iteration 4
+Queue:		 [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
+Grounded Until:	 10
+Grounding...	 [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])]
+Grounding Time:	 0.35s
+Memory:		 141MB (+11MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.02s
+Memory:		 149MB (+8MB)
+UNSAT
+Iteration Time:	 0.54s
+
+Iteration 5
+Queue:		 [(4,20,0,True), (5,25,0,True), (6,30,0,True)]
+Grounded Until:	 15
+Grounding...	 [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])]
+Grounding Time:	 0.43s
+Memory:		 166MB (+17MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.02s
+Memory:		 177MB (+11MB)
+UNSAT
+Iteration Time:	 0.63s
+
+Iteration 6
+Queue:		 [(5,25,0,True), (6,30,0,True)]
+Grounded Until:	 20
+Grounding...	 [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])]
+Grounding Time:	 0.36s
+Memory:		 187MB (+10MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.03s
+Memory:		 201MB (+14MB)
+UNSAT
+Iteration Time:	 0.55s
+
+Iteration 7
+Queue:		 [(6,30,0,True)]
+Grounded Until:	 25
+Grounding...	 [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])]
+Grounding Time:	 0.36s
+Memory:		 210MB (+9MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.04s
+Memory:		 218MB (+8MB)
+UNSAT
+Iteration Time:	 0.57s
+
+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
+Grounding...	 [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])]
+Grounding Time:	 0.38s
+Memory:		 230MB (+12MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.05s
+Memory:		 248MB (+18MB)
+UNSAT
+Iteration Time:	 0.60s
+
+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
+Grounding...	 [('step', [36]), ('step', [37]), ('step', [38]), ('step', [39]), ('step', [40]), ('check', [40])]
+Grounding Time:	 0.53s
+Memory:		 265MB (+17MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.06s
+Memory:		 273MB (+8MB)
+UNSAT
+Iteration Time:	 0.77s
+
+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
+Grounding...	 [('step', [41]), ('step', [42]), ('step', [43]), ('step', [44]), ('step', [45]), ('check', [45])]
+Grounding Time:	 0.35s
+Memory:		 283MB (+10MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.06s
+Memory:		 291MB (+8MB)
+UNSAT
+Iteration Time:	 0.61s
+
+Iteration 11
+Queue:		 [(10,50,0,True), (11,55,0,True), (12,60,0,True), (13,65,0,True)]
+Grounded Until:	 45
+Grounding...	 [('step', [46]), ('step', [47]), ('step', [48]), ('step', [49]), ('step', [50]), ('check', [50])]
+Grounding Time:	 0.36s
+Memory:		 304MB (+13MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.07s
+Memory:		 313MB (+9MB)
+UNSAT
+Iteration Time:	 0.63s
+
+Iteration 12
+Queue:		 [(11,55,0,True), (12,60,0,True), (13,65,0,True)]
+Grounded Until:	 50
+Grounding...	 [('step', [51]), ('step', [52]), ('step', [53]), ('step', [54]), ('step', [55]), ('check', [55])]
+Grounding Time:	 0.37s
+Memory:		 325MB (+12MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.08s
+Memory:		 351MB (+26MB)
+UNSAT
+Iteration Time:	 0.67s
+
+Iteration 13
+Queue:		 [(12,60,0,True), (13,65,0,True)]
+Grounded Until:	 55
+Grounding...	 [('step', [56]), ('step', [57]), ('step', [58]), ('step', [59]), ('step', [60]), ('check', [60])]
+Grounding Time:	 0.38s
+Memory:		 351MB (+0MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.15s
+Memory:		 363MB (+12MB)
+UNSAT
+Iteration Time:	 0.77s
+
+Iteration 14
+Queue:		 [(13,65,0,True)]
+Grounded Until:	 60
+Grounding...	 [('step', [61]), ('step', [62]), ('step', [63]), ('step', [64]), ('step', [65]), ('check', [65])]
+Grounding Time:	 0.38s
+Memory:		 371MB (+8MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.38s
+Memory:		 380MB (+9MB)
+UNSAT
+Iteration Time:	 0.99s
+
+Iteration 15
+Queue:		 [(14,70,0,True), (15,75,0,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)]
+Grounded Until:	 65
+Grounding...	 [('step', [66]), ('step', [67]), ('step', [68]), ('step', [69]), ('step', [70]), ('check', [70])]
+Grounding Time:	 0.39s
+Memory:		 390MB (+10MB)
+Unblocking actions...
+Solving...
+Solving Time:	 7.94s
+Memory:		 429MB (+39MB)
+UNSAT
+Iteration Time:	 8.59s
+
+Iteration 16
+Queue:		 [(15,75,0,True), (16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)]
+Grounded Until:	 70
+Grounding...	 [('step', [71]), ('step', [72]), ('step', [73]), ('step', [74]), ('step', [75]), ('check', [75])]
+Grounding Time:	 0.39s
+Memory:		 441MB (+12MB)
+Unblocking actions...
+Solving...
+Solving Time:	 18.48s
+Memory:		 487MB (+46MB)
+UNKNOWN
+Iteration Time:	 19.13s
+
+Iteration 17
+Queue:		 [(16,80,0,True), (17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)]
+Grounded Until:	 75
+Grounding...	 [('step', [76]), ('step', [77]), ('step', [78]), ('step', [79]), ('step', [80]), ('check', [80])]
+Grounding Time:	 0.72s
+Memory:		 512MB (+25MB)
+Unblocking actions...
+Solving...
+Solving Time:	 20.53s
+Memory:		 562MB (+50MB)
+UNKNOWN
+Iteration Time:	 21.53s
+
+Iteration 18
+Queue:		 [(17,85,0,True), (18,90,0,True), (19,95,0,True), (20,100,0,True)]
+Grounded Until:	 80
+Grounding...	 [('step', [81]), ('step', [82]), ('step', [83]), ('step', [84]), ('step', [85]), ('check', [85])]
+Grounding Time:	 0.40s
+Memory:		 562MB (+0MB)
+Unblocking actions...
+Solving...
+Solving Time:	 24.73s
+Memory:		 623MB (+61MB)
+UNKNOWN
+Iteration Time:	 25.43s
+
+Iteration 19
+Queue:		 [(18,90,0,True), (19,95,0,True), (20,100,0,True)]
+Grounded Until:	 85
+Grounding...	 [('step', [86]), ('step', [87]), ('step', [88]), ('step', [89]), ('step', [90]), ('check', [90])]
+Grounding Time:	 0.37s
+Memory:		 634MB (+11MB)
+Unblocking actions...
+Solving...
+Solving Time:	 31.75s
+Memory:		 690MB (+56MB)
+UNKNOWN
+Iteration Time:	 32.42s
+
+Iteration 20
+Queue:		 [(19,95,0,True), (20,100,0,True)]
+Grounded Until:	 90
+Grounding...	 [('step', [91]), ('step', [92]), ('step', [93]), ('step', [94]), ('step', [95]), ('check', [95])]
+Grounding Time:	 0.37s
+Memory:		 690MB (+0MB)
+Unblocking actions...
+Solving...
+Solving Time:	 29.16s
+Memory:		 738MB (+48MB)
+UNKNOWN
+Iteration Time:	 29.84s
+
+Iteration 21
+Queue:		 [(20,100,0,True)]
+Grounded Until:	 95
+Grounding...	 [('step', [96]), ('step', [97]), ('step', [98]), ('step', [99]), ('step', [100]), ('check', [100])]
+Grounding Time:	 0.37s
+Memory:		 738MB (+0MB)
+Unblocking actions...
+Solving...
+Solving Time:	 32.59s
+Memory:		 769MB (+31MB)
+UNKNOWN
+Iteration Time:	 33.27s
+
+Iteration 22
+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,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 100
+Blocking actions...
+Solving...
+Solving Time:	 25.94s
+Memory:		 769MB (+0MB)
+UNKNOWN
+Iteration Time:	 25.99s
+
+Iteration 23
+Queue:		 [(16,80,1,True), (17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,1,True), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 100
+Unblocking actions...
+Solving...
+Solving Time:	 26.26s
+Memory:		 769MB (+0MB)
+UNKNOWN
+Iteration Time:	 26.31s
+
+Iteration 24
+Queue:		 [(17,85,1,True), (18,90,1,True), (19,95,1,True), (20,100,1,True), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 100
+Unblocking actions...
+Solving...
+Solving Time:	 26.92s
+Memory:		 769MB (+0MB)
+UNKNOWN
+Iteration Time:	 26.97s
+
+Iteration 25
+Queue:		 [(18,90,1,True), (19,95,1,True), (20,100,1,True), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 100
+Unblocking actions...
+Solving...
+Solving Time:	 23.03s
+Memory:		 769MB (+0MB)
+UNKNOWN
+Iteration Time:	 23.08s
+
+Iteration 26
+Queue:		 [(19,95,1,True), (20,100,1,True), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 100
+Unblocking actions...
+Solving...
+Solving Time:	 23.53s
+Memory:		 769MB (+0MB)
+UNKNOWN
+Iteration Time:	 23.57s
+
+Iteration 27
+Queue:		 [(20,100,1,True), (21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 100
+Unblocking actions...
+Solving...
+Solving Time:	 27.49s
+Memory:		 769MB (+0MB)
+UNKNOWN
+Iteration Time:	 27.53s
+
+Iteration 28
+Queue:		 [(21,105,0,True), (22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 100
+Grounding...	 [('step', [101]), ('step', [102]), ('step', [103]), ('step', [104]), ('step', [105]), ('check', [105])]
+Grounding Time:	 0.39s
+Memory:		 769MB (+0MB)
+Unblocking actions...
+Solving...
+Solving Time:	 30.84s
+Memory:		 763MB (+-6MB)
+UNKNOWN
+Iteration Time:	 31.54s
+
+Iteration 29
+Queue:		 [(22,110,0,True), (23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 105
+Grounding...	 [('step', [106]), ('step', [107]), ('step', [108]), ('step', [109]), ('step', [110]), ('check', [110])]
+Grounding Time:	 0.37s
+Memory:		 763MB (+0MB)
+Unblocking actions...
+Solving...
+Solving Time:	 36.15s
+Memory:		 825MB (+62MB)
+UNKNOWN
+Iteration Time:	 36.86s
+
+Iteration 30
+Queue:		 [(23,115,0,True), (24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 110
+Grounding...	 [('step', [111]), ('step', [112]), ('step', [113]), ('step', [114]), ('step', [115]), ('check', [115])]
+Grounding Time:	 0.39s
+Memory:		 825MB (+0MB)
+Unblocking actions...
+Solving...
+Solving Time:	 30.25s
+Memory:		 839MB (+14MB)
+UNKNOWN
+Iteration Time:	 30.99s
+
+Iteration 31
+Queue:		 [(24,120,0,True), (25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 115
+Grounding...	 [('step', [116]), ('step', [117]), ('step', [118]), ('step', [119]), ('step', [120]), ('check', [120])]
+Grounding Time:	 0.37s
+Memory:		 839MB (+0MB)
+Unblocking actions...
+Solving...
+Solving Time:	 31.46s
+Memory:		 868MB (+29MB)
+UNKNOWN
+Iteration Time:	 32.19s
+
+Iteration 32
+Queue:		 [(25,125,0,True), (26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 120
+Grounding...	 [('step', [121]), ('step', [122]), ('step', [123]), ('step', [124]), ('step', [125]), ('check', [125])]
+Grounding Time:	 0.38s
+Memory:		 868MB (+0MB)
+Unblocking actions...
+Solving...
+Solving Time:	 53.21s
+Memory:		 1359MB (+491MB)
+UNKNOWN
+Iteration Time:	 53.95s
+
+Iteration 33
+Queue:		 [(26,130,0,True), (27,135,0,True), (28,140,0,True)]
+Grounded Until:	 125
+Grounding...	 [('step', [126]), ('step', [127]), ('step', [128]), ('step', [129]), ('step', [130]), ('check', [130])]
+Grounding Time:	 0.38s
+Memory:		 1371MB (+12MB)
+Unblocking actions...
+Solving...
+Solving Time:	 0.41s
+Memory:		 1388MB (+17MB)
+SAT
+Testing...
+SERIALIZABLE
+Testing Time:	 0.61s
+Memory:		 1403MB (+15MB)
+Answer: 1
+occurs(action(("unstack","p","e1")),1) occurs(action(("put-down","p")),2) occurs(action(("unstack","e1","j1")),3) occurs(action(("put-down","e1")),4) occurs(action(("unstack","j1","q")),5) occurs(action(("put-down","j1")),6) occurs(action(("unstack","q","l")),7) occurs(action(("stack","q","p")),8) occurs(action(("unstack","i","u")),9) occurs(action(("put-down","i")),10) occurs(action(("unstack","l","c")),11) occurs(action(("put-down","l")),12) occurs(action(("unstack","c","n")),13) occurs(action(("stack","c","l")),14) occurs(action(("unstack","n","d")),15) occurs(action(("put-down","n")),16) occurs(action(("unstack","d","m")),17) occurs(action(("put-down","d")),18) occurs(action(("unstack","m","f")),19) occurs(action(("put-down","m")),20) occurs(action(("unstack","f","f1")),21) occurs(action(("stack","f","j1")),22) occurs(action(("unstack","f1","o")),23) occurs(action(("stack","f1","n")),24) occurs(action(("unstack","o","a")),25) occurs(action(("put-down","o")),26) occurs(action(("unstack","a","t")),27) occurs(action(("stack","a","c")),28) occurs(action(("unstack","h","c1")),29) occurs(action(("put-down","h")),30) occurs(action(("unstack","c1","k")),31) occurs(action(("stack","c1","i")),32) occurs(action(("unstack","k","z")),33) occurs(action(("put-down","k")),34) occurs(action(("unstack","z","r")),35) occurs(action(("put-down","z")),36) occurs(action(("unstack","r","g1")),37) occurs(action(("stack","r","a")),38) occurs(action(("pick-up","k")),39) occurs(action(("stack","k","r")),40) occurs(action(("unstack","u","b")),41) occurs(action(("put-down","u")),42) occurs(action(("unstack","b","s")),43) occurs(action(("put-down","b")),44) occurs(action(("unstack","q","p")),45) occurs(action(("stack","q","k")),46) occurs(action(("unstack","g1","h1")),47) occurs(action(("stack","g1","h1")),48) occurs(action(("unstack","g1","h1")),49) occurs(action(("stack","g1","o")),50) occurs(action(("pick-up","e1")),51) occurs(action(("stack","e1","g1")),52) occurs(action(("unstack","t","a1")),53) occurs(action(("put-down","t")),54) occurs(action(("unstack","a1","v")),55) occurs(action(("stack","a1","d")),56) occurs(action(("unstack","v","d1")),57) occurs(action(("put-down","v")),58) occurs(action(("unstack","d1","j")),59) occurs(action(("stack","d1","u")),60) occurs(action(("unstack","j","y")),61) occurs(action(("put-down","j")),62) occurs(action(("unstack","y","w")),63) occurs(action(("stack","y","q")),64) occurs(action(("unstack","c1","i")),65) occurs(action(("stack","c1","y")),66) occurs(action(("unstack","d1","u")),67) occurs(action(("stack","d1","c1")),68) occurs(action(("unstack","s","b1")),69) occurs(action(("put-down","s")),70) occurs(action(("unstack","b1","e")),71) occurs(action(("stack","b1","t")),72) occurs(action(("unstack","e","g")),73) occurs(action(("stack","e","d1")),74) occurs(action(("unstack","f1","n")),75) occurs(action(("stack","f1","e")),76) occurs(action(("pick-up","v")),77) occurs(action(("stack","v","f1")),78) occurs(action(("pick-up","s")),79) occurs(action(("stack","s","v")),80) occurs(action(("pick-up","h1")),81) occurs(action(("stack","h1","s")),82) occurs(action(("pick-up","p")),83) occurs(action(("stack","p","h1")),84) occurs(action(("unstack","f","j1")),85) occurs(action(("stack","f","p")),86) occurs(action(("unstack","g","i1")),87) occurs(action(("put-down","g")),88) occurs(action(("pick-up","i1")),89) occurs(action(("stack","i1","f")),90) occurs(action(("pick-up","u")),91) occurs(action(("stack","u","i1")),92) occurs(action(("pick-up","g")),93) occurs(action(("stack","g","u")),94) occurs(action(("pick-up","z")),95) occurs(action(("stack","z","g")),96) occurs(action(("pick-up","b")),97) occurs(action(("stack","b","z")),98) occurs(action(("pick-up","h")),99) occurs(action(("stack","h","b")),100) occurs(action(("unstack","w","x")),101) occurs(action(("stack","w","h")),102) occurs(action(("unstack","a1","d")),103) occurs(action(("stack","a1","w")),104) occurs(action(("pick-up","m")),105) occurs(action(("stack","m","a1")),106) occurs(action(("pick-up","n")),107) occurs(action(("stack","n","m")),108) occurs(action(("pick-up","x")),109) occurs(action(("stack","x","n")),110) occurs(action(("pick-up","d")),111) occurs(action(("stack","d","x")),112) occurs(action(("unstack","e1","g1")),113) occurs(action(("stack","e1","d")),114) occurs(action(("unstack","b1","t")),115) occurs(action(("stack","b1","e1")),116) occurs(action(("pick-up","t")),117) occurs(action(("stack","t","b1")),118) occurs(action(("pick-up","i")),119) occurs(action(("stack","i","t")),120) occurs(action(("unstack","g1","o")),121) occurs(action(("stack","g1","i")),122) occurs(action(("pick-up","j1")),123) occurs(action(("stack","j1","g1")),124) occurs(action(("pick-up","o")),125) occurs(action(("stack","o","j1")),126) occurs(action(("pick-up","j")),127) occurs(action(("put-down","j")),128) occurs(action(("pick-up","j")),129) occurs(action(("stack","j","o")),130)
+SATISFIABLE
+
+Models       : 1+
+Calls        : 33
+Time         : 519.269s (Solving: 499.28s 1st Model: 0.14s Unsat: 8.42s)
+CPU Time     : 519.456s
+
+Choices      : 10310176 (Domain: 10310176)
+Conflicts    : 161573   (Analyzed: 161563)
+Restarts     : 1766     (Average: 91.49 Last: 158)
+Model-Level  : 26498.0 
+Problems     : 33       (Average Length: 73.36 Splits: 0)
+Lemmas       : 161563   (Deleted: 153759)
+  Binary     : 1816     (Ratio:   1.12%)
+  Ternary    : 60       (Ratio:   0.04%)
+  Conflict   : 161563   (Average Length: 10605.0 Ratio: 100.00%) 
+  Loop       : 0        (Average Length:    0.0 Ratio:   0.00%) 
+  Other      : 0        (Average Length:    0.0 Ratio:   0.00%) 
+Backjumps    : 161563   (Average: 39.12 Max: 24745 Sum: 6320467)
+  Executed   : 161383   (Average: 39.10 Max: 24745 Sum: 6316345 Ratio:  99.93%)
+  Bounded    : 180      (Average: 22.90 Max:  77 Sum:   4122 Ratio:   0.07%)
+
+Rules        : 68095   
+Atoms        : 68095   
+Bodies       : 1        (Original: 0)
+Tight        : Yes
+Variables    : 536471   (Eliminated:    0 Frozen: 175804)
+Constraints  : 3680793  (Binary:  95.0% Ternary:   4.3% Other:   0.7%)
+
+Memory Peak  : 1445MB
+Max. Length  : 130 steps
+Sol. Length  : 130 steps
+Models       : 1
+
+