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

261 lines
26 KiB
Plaintext
Raw Normal View History

INFO Running translator.
INFO translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/pathways-propositional-strips/domains/domain-24.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/pathways-propositional-strips/instances/instance-24.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-24.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/pathways-propositional-strips/instances/instance-24.pddl
Parsing...
Parsing: [2.060s CPU, 2.064s wall-clock]
Normalizing task... [0.340s CPU, 0.338s wall-clock]
Instantiating...
Generating Datalog program... [0.220s CPU, 0.222s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.580s CPU, 0.575s wall-clock]
Preparing model... [0.440s CPU, 0.446s wall-clock]
Generated 5705 rules.
Computing model... [0.200s CPU, 0.195s wall-clock]
2617 relevant atoms
0 auxiliary atoms
2617 final queue length
5763 total queue pushes
Completing instantiation... [0.480s CPU, 0.479s wall-clock]
Instantiating: [1.940s CPU, 1.946s wall-clock]
Computing fact groups...
Finding invariants...
547 initial candidates
Time limit reached, aborting invariant generation
Finding invariants: [300.560s CPU, 300.419s wall-clock]
Checking invariant weight... [0.080s CPU, 0.074s wall-clock]
Instantiating groups... [0.000s CPU, 0.002s wall-clock]
Collecting mutex groups... [0.000s CPU, 0.002s wall-clock]
Choosing groups...
425 uncovered facts
Choosing groups: [0.010s CPU, 0.006s wall-clock]
Building translation key... [0.010s CPU, 0.014s wall-clock]
Computing fact groups: [300.700s CPU, 300.562s wall-clock]
Building STRIPS to SAS dictionary... [0.010s CPU, 0.004s wall-clock]
Building dictionary for full mutex groups... [0.000s CPU, 0.005s wall-clock]
Building mutex information...
Building mutex information: [0.010s CPU, 0.006s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [0.030s CPU, 0.027s wall-clock]
Translating task: [0.620s CPU, 0.621s wall-clock]
1623 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
56 propositions removed
Detecting unreachable propositions: [0.350s CPU, 0.351s wall-clock]
Reordering and filtering variables...
310 of 482 variables necessary.
0 of 65 mutex groups necessary.
2049 of 2068 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [0.210s CPU, 0.212s wall-clock]
Translator variables: 310
Translator derived variables: 0
Translator facts: 629
Translator goal facts: 31
Translator mutex groups: 0
Translator total mutex groups size: 0
Translator operators: 2049
Translator axioms: 0
Translator task size: 12033
Translator peak memory: 294096 KB
Writing output... [0.230s CPU, 0.250s wall-clock]
Done! [306.500s CPU, 306.385s wall-clock]
planner.py version 0.0.1
Time: 0.30s
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: 62MB (+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: 62MB
Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])]
Grounding Time: 0.14s
Memory: 76MB (+14MB)
Unblocking actions...
Solving...
Solving Time: 0.01s
Memory: 80MB (+4MB)
UNSAT
Iteration Time: 0.21s
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: 98.0MB
Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])]
Grounding Time: 0.17s
Memory: 90MB (+10MB)
Unblocking actions...
Solving...
Solving Time: 0.01s
Memory: 93MB (+3MB)
UNSAT
Iteration Time: 0.25s
Iteration 4
Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 10
Expected Memory: 111.0MB
Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])]
Grounding Time: 0.16s
Memory: 99MB (+6MB)
Unblocking actions...
Solving...
Solving Time: 0.02s
Memory: 104MB (+5MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time: 0.41s
Memory: 109MB (+5MB)
Solving...
Solving Time: 0.54s
Memory: 111MB (+2MB)
UNSAT
Iteration Time: 1.22s
Iteration 5
Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 15
Expected Memory: 129.0MB
Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])]
Grounding Time: 0.25s
Memory: 124MB (+13MB)
Unblocking actions...
Solving...
Solving Time: 2.13s
Memory: 134MB (+10MB)
UNKNOWN
Iteration Time: 2.49s
Iteration 6
Queue: [(5,25,0,True), (6,30,0,True)]
Grounded Until: 20
Expected Memory: 157.0MB
Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])]
Grounding Time: 0.26s
Memory: 141MB (+7MB)
Unblocking actions...
Solving...
Solving Time: 2.83s
Memory: 145MB (+4MB)
UNKNOWN
Iteration Time: 3.21s
Iteration 7
Queue: [(6,30,0,True)]
Grounded Until: 25
Expected Memory: 168.0MB
Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])]
Grounding Time: 0.26s
Memory: 154MB (+9MB)
Unblocking actions...
Solving...
Solving Time: 2.76s
Memory: 168MB (+14MB)
UNKNOWN
Iteration Time: 3.16s
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: 1.67s
Memory: 168MB (+0MB)
UNKNOWN
Iteration Time: 1.67s
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: 2.62s
Memory: 168MB (+0MB)
UNKNOWN
Iteration Time: 2.63s
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: 3.64s
Memory: 168MB (+0MB)
UNKNOWN
Iteration Time: 3.65s
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: 191.0MB
Grounding... [('step', [31]), ('step', [32]), ('step', [33]), ('step', [34]), ('step', [35]), ('check', [35])]
Grounding Time: 0.27s
Memory: 175MB (+7MB)
Unblocking actions...
Solving...
Solving Time: 0.48s
Memory: 180MB (+5MB)
SAT
Testing...
SERIALIZABLE?
Testing Time: 0.00s
Memory: 180MB (+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_cycdp1"),5) occurs(action("initialize_gp"),5) occurs(action("synthesize_sp1-gp_cycd"),5) occurs(action("synthesize_sp1-gp_cycep1"),5) occurs(action("synthesize_sp1-gp_p107"),5) occurs(action("initialize_sp1"),5) occurs(action("synthesize_sp1-gp_cyce"),5) occurs(action("choose_raf1_l5_l4"),5) occurs(action("synthesize_sp1-gp_cyca"),5) occurs(action("initialize_gcdc25a"),5) occurs(action("synthesize_sp1-gp_c-myc"),5) occurs(action("associate_sp1_p107_sp1-p107"),6) occurs(action("initialize_gp"),6) occurs(action("initialize_raf1"),6) occurs(action("choose_cych_l6_l5"),6) occurs(action("associate_c-myc_max_c-myc-max"),6) occurs(action("associate_sp1-p107_gp_sp1-p107-gp"),7) occurs(action("synthesize_sp1-gp_cycdp1"),7) occurs(action("synthesize_sp1-gp_cycd"),7) occurs(action("synthesize_sp1-gp_p107"),7) occurs(action("initialize_cych"),7) occurs(action("initialize_sp1"),7) occurs(action("synthesize_sp1-gp_cyce"),7) occurs(action("associate_c-myc-max_gcdc25a_c-myc-max-gcdc25a"),7) occurs(action("synthesize_sp1-gp_cyca"),7) occurs(action("choose_cdk7_l7_l6"),7) occurs(action("synthesize_sp1-gp_c-myc"),7) occurs(action("dummy-action-17-2"),8) occurs(action("initialize_gp"),8) occurs(action("synthesize_c-myc-max-gcdc25a_cdc25a"),8) occurs(action("initialize_cdk7"),8) occurs(action("choose_cdk46p1_l8_l7"),8) occurs(action("associate-with-catalyze_cdc25a_raf1_cdc25ap1"),9) occurs(action("synthesize_sp1-gp_cycdp1"),9) occurs(action("associate_cdk7_cych_cdk7-cych"),9) occurs(action("initialize_gp"),9) occurs(action("synthesize_sp1-gp_cycd"),9) occurs(action("initialize_cdk46p1"),9) occurs(action("synthesize_sp1-gp_p107"),9) occurs(action("choose_p57p1_l9_l8"),9) occurs(action("initialize_sp1"),9) occurs(action("synthesize_sp1-gp_cyce"),9) occurs(action("synthesize_sp1-gp_cyca"),9) occurs(action("dummy-action-25-1"),10) occurs(action("associate-with-catalyze_cdk46p1_cdk7-cych_cdk46p1p2"),10) occurs(action("initialize_p57p1"),10) occurs(action("synthesize_sp1-gp_cycdp1"),10) occurs(action("synthesize_c-myc-max-gcdc25a_cdc25a"),10) occurs(action("initialize_cych"),10) occurs(action("initialize_cdk7"),10) occurs(action("synthesize_sp1-gp_cyce"),10) occurs(action("choose_cdk2_l10_l9"),10) occurs(action("initialize_max"),10) occurs(action("associate-with-catalyze_cdk46p1p2_cdc25ap1_cdk46p2"),11) occurs(action("associate_raf1_cdc25a_raf1-cdc25a"),11) occurs(action("initialize_cdk46p1"),11) occurs(action("choose_cdk2p1_l11_l10"),11) occurs(action("initialize_cych"),11) occurs(action("synthesize_sp1-gp_cyce"),11) occurs(action("initialize_cdk2"),11) occurs(action("synthesize_sp1-gp_cyca"),11) occurs(action("associate_c-myc_max_c-myc-max"),11) occurs(action("dummy-action-19-1"),12) occurs(action("dummy-action-25-1"),12) occurs(action("associate_cdk46p2_cycd_cdk46p2-cycd"),12) occurs(action("associate_cdk2_cyca_cdk2-cyca"),12) occurs(action("initialize_cdk2p1"),12) occurs(action("associate-with-catalyze_cdk46p1_cdk7-cych_cdk46p1p2"),12) occurs(action("synthesize_sp1-gp_cycdp1"),12) occurs(action("synthesize_c-myc-max-gcdc25a_cdc25a"),12) occurs(action("initialize_raf1"),12) occurs(action("choose_e2f13_l12_l11"),12) occurs(action("synthesize_sp1-gp_cycep1"),12) occurs(action("synthesize_sp1-gp_p107"),12) occurs(action("initialize_cdk7"),12) occurs(action("synthesize_sp1-gp_cyce"),12) occurs(action("associate-with-catalyze_cdk2p1_cdk7-cych_cdk2p1p2"),13) occurs(action("associate_p57p1_cdk46p2-cycd_p57p1-cdk46p2-cycd"),13) occurs(action("associate-with-catalyze_cdk46p1p2_cdc25ap1_cdk46p2"),13) occurs(action("initialize_e2f13"),13) occurs(action("synthesize_sp1-gp_cycd"),13) occurs(action("associate-with-catalyze_cdk2-cyca_cdk7-cych_cdk2p2-cyca"),13) occurs(action("initialize_cdk46p1"),13) occurs(action("initialize_cdk2")
SATISFIABLE
Models : 1+
Calls : 12
Time : 19.442s (Solving: 16.52s 1st Model: 0.45s Unsat: 0.51s)
CPU Time : 19.444s
Choices : 753496 (Domain: 750235)
Conflicts : 61347 (Analyzed: 61346)
Restarts : 647 (Average: 94.82 Last: 143)
Model-Level : 1626.0
Problems : 12 (Average Length: 22.42 Splits: 0)
Lemmas : 61346 (Deleted: 52429)
Binary : 210 (Ratio: 0.34%)
Ternary : 447 (Ratio: 0.73%)
Conflict : 61346 (Average Length: 43.8 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 61346 (Average: 11.75 Max: 904 Sum: 720594)
Executed : 61321 (Average: 11.74 Max: 904 Sum: 719970 Ratio: 99.91%)
Bounded : 25 (Average: 24.96 Max: 32 Sum: 624 Ratio: 0.09%)
Rules : 67054 (Original: 62773)
Atoms : 46509
Bodies : 17614 (Original: 13350)
Count : 633 (Original: 1280)
Equivalences : 9765 (Atom=Atom: 427 Body=Body: 0 Other: 9338)
Tight : Yes
Variables : 111146 (Eliminated: 0 Frozen: 41564)
Constraints : 510289 (Binary: 93.1% Ternary: 4.6% Other: 2.3%)
Memory Peak : 191MB
Max. Length : 35 steps
Sol. Length : 35 steps
Models : 2