tplp-planning-benchmark/gc-ta1-tt1/ipc-2006_pathways-propositional-strips_27.out

261 lines
25 KiB
Plaintext
Raw Permalink Normal View History

INFO Running translator.
INFO translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/pathways-propositional-strips/domains/domain-27.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/pathways-propositional-strips/instances/instance-27.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/pathways-propositional-strips/domains/domain-27.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/pathways-propositional-strips/instances/instance-27.pddl
Parsing...
Parsing: [2.770s CPU, 2.781s wall-clock]
Normalizing task... [0.520s CPU, 0.520s wall-clock]
Instantiating...
Generating Datalog program... [0.320s CPU, 0.310s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.820s CPU, 0.831s wall-clock]
Preparing model... [0.620s CPU, 0.616s wall-clock]
Generated 7923 rules.
Computing model... [0.260s CPU, 0.266s wall-clock]
3552 relevant atoms
0 auxiliary atoms
3552 final queue length
7996 total queue pushes
Completing instantiation... [0.750s CPU, 0.747s wall-clock]
Instantiating: [2.810s CPU, 2.807s wall-clock]
Computing fact groups...
Finding invariants...
654 initial candidates
Time limit reached, aborting invariant generation
Finding invariants: [300.560s CPU, 300.427s wall-clock]
Checking invariant weight... [0.040s CPU, 0.043s wall-clock]
Instantiating groups... [0.010s CPU, 0.002s wall-clock]
Collecting mutex groups... [0.000s CPU, 0.002s wall-clock]
Choosing groups...
502 uncovered facts
Choosing groups: [0.000s CPU, 0.007s wall-clock]
Building translation key... [0.020s CPU, 0.017s wall-clock]
Computing fact groups: [300.680s CPU, 300.552s wall-clock]
Building STRIPS to SAS dictionary... [0.000s CPU, 0.005s wall-clock]
Building dictionary for full mutex groups... [0.010s CPU, 0.006s wall-clock]
Building mutex information...
Building mutex information: [0.010s CPU, 0.007s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [0.040s CPU, 0.039s wall-clock]
Translating task: [0.850s CPU, 0.852s wall-clock]
2138 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
71 propositions removed
Detecting unreachable propositions: [0.480s CPU, 0.475s wall-clock]
Reordering and filtering variables...
378 of 574 variables necessary.
0 of 80 mutex groups necessary.
2812 of 2896 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [0.290s CPU, 0.296s wall-clock]
Translator variables: 378
Translator derived variables: 0
Translator facts: 765
Translator goal facts: 35
Translator mutex groups: 0
Translator total mutex groups size: 0
Translator operators: 2812
Translator axioms: 0
Translator task size: 16183
Translator peak memory: 293828 KB
Writing output... [0.310s CPU, 0.337s wall-clock]
Done! [308.770s CPU, 308.671s wall-clock]
planner.py version 0.0.1
Time: 0.40s
Memory: 67MB
Iteration 1
Queue: [(0,0,0,True), (1,5,0,True), (2,10,0,True), (3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 0
Solving...
Solving Time: 0.00s
Memory: 67MB (+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: 67MB
Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])]
Grounding Time: 0.21s
Memory: 88MB (+21MB)
Unblocking actions...
Solving...
Solving Time: 0.01s
Memory: 94MB (+6MB)
UNSAT
Iteration Time: 0.31s
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: 121.0MB
Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])]
Grounding Time: 0.21s
Memory: 103MB (+9MB)
Unblocking actions...
Solving...
Solving Time: 0.02s
Memory: 109MB (+6MB)
UNSAT
Iteration Time: 0.34s
Iteration 4
Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 10
Expected Memory: 136.0MB
Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])]
Grounding Time: 0.25s
Memory: 119MB (+10MB)
Unblocking actions...
Solving...
Solving Time: 0.04s
Memory: 128MB (+9MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time: 0.52s
Memory: 129MB (+1MB)
Solving...
Solving Time: 0.18s
Memory: 132MB (+3MB)
UNSAT
Iteration Time: 1.12s
Iteration 5
Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 15
Expected Memory: 159.0MB
Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])]
Grounding Time: 0.36s
Memory: 149MB (+17MB)
Unblocking actions...
Solving...
Solving Time: 2.98s
Memory: 157MB (+8MB)
UNKNOWN
Iteration Time: 3.50s
Iteration 6
Queue: [(5,25,0,True), (6,30,0,True)]
Grounded Until: 20
Expected Memory: 184.0MB
Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])]
Grounding Time: 0.44s
Memory: 174MB (+17MB)
Unblocking actions...
Solving...
Solving Time: 3.49s
Memory: 187MB (+13MB)
UNKNOWN
Iteration Time: 4.11s
Iteration 7
Queue: [(6,30,0,True)]
Grounded Until: 25
Expected Memory: 217.0MB
Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])]
Grounding Time: 0.37s
Memory: 197MB (+10MB)
Unblocking actions...
Solving...
Solving Time: 4.63s
Memory: 218MB (+21MB)
UNKNOWN
Iteration Time: 5.20s
Iteration 8
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), (16,80,0,True), (17,85,0,True)]
Grounded Until: 30
Blocking actions...
Solving...
Solving Time: 2.83s
Memory: 218MB (+0MB)
UNKNOWN
Iteration Time: 2.84s
Iteration 9
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), (16,80,0,True), (17,85,0,True)]
Grounded Until: 30
Unblocking actions...
Solving...
Solving Time: 3.47s
Memory: 218MB (+0MB)
UNKNOWN
Iteration Time: 3.48s
Iteration 10
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), (16,80,0,True), (17,85,0,True)]
Grounded Until: 30
Unblocking actions...
Solving...
Solving Time: 4.57s
Memory: 218MB (+0MB)
UNKNOWN
Iteration Time: 4.58s
Iteration 11
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), (16,80,0,True), (17,85,0,True)]
Grounded Until: 30
Expected Memory: 249.0MB
Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])]
Grounding Time: 0.37s
Memory: 224MB (+6MB)
Unblocking actions...
Solving...
Solving Time: 0.37s
Memory: 233MB (+9MB)
SAT
Testing...
SERIALIZABLE?
Testing Time: 0.00s
Memory: 233MB (+0MB)
Answer: 2
occurs(action("choose_gp_l1_l0"),1) occurs(action("initialize_gp"),2) occurs(action("choose_sp1_l2_l1"),2) occurs(action("initialize_sp1"),3) occurs(action("choose_max_l3_l2"),3) occurs(action("associate_sp1_gp_sp1-gp"),4) occurs(action("choose_gcdc25a_l4_l3"),4) occurs(action("initialize_max"),4) occurs(action("synthesize_sp1-gp_cyca"),5) occurs(action("synthesize_sp1-gp_cycdp1"),5) occurs(action("synthesize_sp1-gp_p107"),5) occurs(action("synthesize_sp1-gp_cyce"),5) occurs(action("initialize_gp"),5) occurs(action("initialize_gcdc25a"),5) occurs(action("choose_raf1_l5_l4"),5) occurs(action("synthesize_sp1-gp_cycep1"),5) occurs(action("synthesize_sp1-gp_cycd"),5) occurs(action("initialize_sp1"),5) occurs(action("synthesize_sp1-gp_c-myc"),5) occurs(action("dummy-action-24-2"),6) occurs(action("initialize_raf1"),6) occurs(action("associate_c-myc_max_c-myc-max"),6) occurs(action("choose_cdk46p1_l6_l5"),6) occurs(action("synthesize_sp1-gp_cycdp1"),7) occurs(action("synthesize_sp1-gp_p107"),7) occurs(action("associate_c-myc-max_gcdc25a_c-myc-max-gcdc25a"),7) occurs(action("initialize_raf1"),7) occurs(action("initialize_gp"),7) occurs(action("synthesize_sp1-gp_cycep1"),7) occurs(action("synthesize_sp1-gp_cycd"),7) occurs(action("choose_p27_l7_l6"),7) occurs(action("initialize_cdk46p1"),7) occurs(action("initialize_sp1"),7) occurs(action("initialize_max"),7) occurs(action("synthesize_sp1-gp_c-myc"),7) occurs(action("synthesize_c-myc-max-gcdc25a_cdc25a"),8) occurs(action("synthesize_sp1-gp_cyca"),8) occurs(action("initialize_p27"),8) occurs(action("initialize_gcdc25a"),8) occurs(action("associate_c-myc_max_c-myc-max"),8) occurs(action("choose_cych_l8_l7"),8) occurs(action("associate-with-catalyze_cdc25a_raf1_cdc25ap1"),9) occurs(action("synthesize_sp1-gp_p107"),9) occurs(action("synthesize_sp1-gp_cyce"),9) occurs(action("associate_c-myc-max_gcdc25a_c-myc-max-gcdc25a"),9) occurs(action("initialize_raf1"),9) occurs(action("initialize_cych"),9) occurs(action("initialize_max"),9) occurs(action("synthesize_sp1-gp_c-myc"),9) occurs(action("choose_cdk2p1_l9_l8"),9) occurs(action("dummy-action-13-2"),10) occurs(action("synthesize_c-myc-max-gcdc25a_cdc25a"),10) occurs(action("synthesize_sp1-gp_cyca"),10) occurs(action("synthesize_sp1-gp_cyce"),10) occurs(action("initialize_raf1"),10) occurs(action("associate-with-catalyze_cdk46p1_cdc25ap1_cdk46"),10) occurs(action("initialize_gcdc25a"),10) occurs(action("associate_c-myc_max_c-myc-max"),10) occurs(action("initialize_cdk2p1"),10) occurs(action("choose_cdk7_l10_l9"),10) occurs(action("associate_raf1_cdc25a_raf1-cdc25a"),11) occurs(action("synthesize_sp1-gp_cyce"),11) occurs(action("associate_c-myc-max_gcdc25a_c-myc-max-gcdc25a"),11) occurs(action("associate_cdk46_cycd_cdk46-cycd"),11) occurs(action("initialize_p27"),11) occurs(action("associate_cdk2p1_cyca_cdk2p1-cyca"),11) occurs(action("initialize_cych"),11) occurs(action("initialize_cdk7"),11) occurs(action("synthesize_sp1-gp_cycep1"),11) occurs(action("initialize_cdk46p1"),11) occurs(action("choose_skp1_l11_l10"),11) occurs(action("dummy-action-4-2"),12) occurs(action("synthesize_c-myc-max-gcdc25a_cdc25a"),12) occurs(action("associate_p27_cdk46-cycd_p27-cdk46-cycd"),12) occurs(action("synthesize_sp1-gp_cyca"),12) occurs(action("associate_cdk7_cych_cdk7-cych"),12) occurs(action("associate-with-catalyze_cdk46p1_cdc25ap1_cdk46"),12) occurs(action("initialize_skp1"),12) occurs(action("associate-with-catalyze_cdk2p1-cyca_cdc25ap1_cdk2-cyca"),12) occurs(action("synthesize_sp1-gp_cycd"),12) occurs(action("choose_skp2_l12_l11"),12) occurs(action("initialize_cdk2p1"),12) occurs(action("dummy-action-32-2"),13) occurs(action("dummy-action-4-2"),13) occurs(action("dummy-action-1-1"),13) occurs(action("associate_cdk46_cycd_cdk46-cycd"),13) occurs(action("initialize_p27"),13) occurs(action("associate_cdk2p1_cyce_cdk2p1-cyce"),13) occurs(action("initialize_skp1"),13) occurs(action("initialize_skp2"),13) occurs(action("associate-with-catalyze_cdk2-cyca_cdk7-cych_cdk2p2-cyca"),13) occurs(action("choose_p53_l13_l12"),13) occurs(action("initialize_cdk46p
SATISFIABLE
Models : 1+
Calls : 12
Time : 26.498s (Solving: 22.33s 1st Model: 0.34s Unsat: 0.14s)
CPU Time : 26.500s
Choices : 597295 (Domain: 593261)
Conflicts : 58400 (Analyzed: 58399)
Restarts : 615 (Average: 94.96 Last: 128)
Model-Level : 2058.0
Problems : 12 (Average Length: 22.42 Splits: 0)
Lemmas : 58399 (Deleted: 52132)
Binary : 220 (Ratio: 0.38%)
Ternary : 213 (Ratio: 0.36%)
Conflict : 58399 (Average Length: 78.8 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 58399 (Average: 9.66 Max: 478 Sum: 564217)
Executed : 58372 (Average: 9.65 Max: 478 Sum: 563657 Ratio: 99.90%)
Bounded : 27 (Average: 20.74 Max: 32 Sum: 560 Ratio: 0.10%)
Rules : 88728 (Original: 84620)
Atoms : 62955
Bodies : 22322 (Original: 18228)
Count : 857 (Original: 1484)
Equivalences : 13198 (Atom=Atom: 780 Body=Body: 0 Other: 12418)
Tight : Yes
Variables : 145964 (Eliminated: 0 Frozen: 60575)
Constraints : 666219 (Binary: 93.8% Ternary: 4.2% Other: 2.0%)
Memory Peak : 245MB
Max. Length : 35 steps
Sol. Length : 35 steps
Models : 2