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

247 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-28.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/pathways-propositional-strips/instances/instance-28.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-28.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2006/domains/pathways-propositional-strips/instances/instance-28.pddl
Parsing...
Parsing: [2.950s CPU, 2.959s wall-clock]
Normalizing task... [0.560s CPU, 0.555s wall-clock]
Instantiating...
Generating Datalog program... [0.320s CPU, 0.327s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [0.840s CPU, 0.838s wall-clock]
Preparing model... [0.640s CPU, 0.637s wall-clock]
Generated 8376 rules.
Computing model... [0.280s CPU, 0.280s wall-clock]
3596 relevant atoms
0 auxiliary atoms
3596 final queue length
8445 total queue pushes
Completing instantiation... [0.780s CPU, 0.781s wall-clock]
Instantiating: [2.900s CPU, 2.902s wall-clock]
Computing fact groups...
Finding invariants...
579 initial candidates
Time limit reached, aborting invariant generation
Finding invariants: [300.560s CPU, 300.431s wall-clock]
Checking invariant weight... [0.050s CPU, 0.043s wall-clock]
Instantiating groups... [0.000s CPU, 0.002s wall-clock]
Collecting mutex groups... [0.000s CPU, 0.002s wall-clock]
Choosing groups...
435 uncovered facts
Choosing groups: [0.010s CPU, 0.007s wall-clock]
Building translation key... [0.020s CPU, 0.015s wall-clock]
Computing fact groups: [300.680s CPU, 300.547s wall-clock]
Building STRIPS to SAS dictionary... [0.000s CPU, 0.005s wall-clock]
Building dictionary for full mutex groups... [0.010s CPU, 0.005s wall-clock]
Building mutex information...
Building mutex information: [0.000s CPU, 0.006s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [0.040s CPU, 0.040s wall-clock]
Translating task: [0.990s CPU, 0.985s wall-clock]
2261 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
67 propositions removed
Detecting unreachable propositions: [0.490s CPU, 0.495s wall-clock]
Reordering and filtering variables...
369 of 503 variables necessary.
0 of 76 mutex groups necessary.
2973 of 3015 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [0.310s CPU, 0.306s wall-clock]
Translator variables: 369
Translator derived variables: 0
Translator facts: 747
Translator goal facts: 37
Translator mutex groups: 0
Translator total mutex groups size: 0
Translator operators: 2973
Translator axioms: 0
Translator task size: 17209
Translator peak memory: 295196 KB
Writing output... [0.330s CPU, 0.356s wall-clock]
Done! [309.260s CPU, 309.161s wall-clock]
planner.py version 0.0.1
Time: 0.44s
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: 68MB (+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: 68MB
Grounding... [('step', [1]), ('step', [2]), ('step', [3]), ('step', [4]), ('step', [5]), ('check', [5])]
Grounding Time: 0.23s
Memory: 91MB (+23MB)
Unblocking actions...
Solving...
Solving Time: 0.02s
Memory: 96MB (+5MB)
UNSAT
Iteration Time: 0.34s
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: 124.0MB
Grounding... [('step', [6]), ('step', [7]), ('step', [8]), ('step', [9]), ('step', [10]), ('check', [10])]
Grounding Time: 0.27s
Memory: 110MB (+14MB)
Unblocking actions...
Solving...
Solving Time: 0.02s
Memory: 117MB (+7MB)
UNSAT
Iteration Time: 0.41s
Iteration 4
Queue: [(3,15,0,True), (4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 10
Expected Memory: 145.0MB
Grounding... [('step', [11]), ('step', [12]), ('step', [13]), ('step', [14]), ('step', [15]), ('check', [15])]
Grounding Time: 0.24s
Memory: 124MB (+7MB)
Unblocking actions...
Solving...
Solving Time: 0.04s
Memory: 134MB (+10MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time: 0.58s
Memory: 135MB (+1MB)
Solving...
Solving Time: 0.71s
Memory: 139MB (+4MB)
UNSAT
Iteration Time: 1.71s
Iteration 5
Queue: [(4,20,0,True), (5,25,0,True), (6,30,0,True)]
Grounded Until: 15
Expected Memory: 167.0MB
Grounding... [('step', [16]), ('step', [17]), ('step', [18]), ('step', [19]), ('step', [20]), ('check', [20])]
Grounding Time: 0.41s
Memory: 156MB (+17MB)
Unblocking actions...
Solving...
Solving Time: 2.72s
Memory: 171MB (+15MB)
UNKNOWN
Iteration Time: 3.31s
Iteration 6
Queue: [(5,25,0,True), (6,30,0,True)]
Grounded Until: 20
Expected Memory: 203.0MB
Grounding... [('step', [21]), ('step', [22]), ('step', [23]), ('step', [24]), ('step', [25]), ('check', [25])]
Grounding Time: 0.48s
Memory: 185MB (+14MB)
Unblocking actions...
Solving...
Solving Time: 3.55s
Memory: 193MB (+8MB)
UNKNOWN
Iteration Time: 4.22s
Iteration 7
Queue: [(6,30,0,True)]
Grounded Until: 25
Expected Memory: 225.0MB
Grounding... [('step', [26]), ('step', [27]), ('step', [28]), ('step', [29]), ('step', [30]), ('check', [30])]
Grounding Time: 0.40s
Memory: 205MB (+12MB)
Unblocking actions...
Solving...
Solving Time: 4.96s
Memory: 229MB (+24MB)
UNKNOWN
Iteration Time: 5.58s
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.76s
Memory: 229MB (+0MB)
UNKNOWN
Iteration Time: 2.77s
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: 4.49s
Memory: 229MB (+0MB)
UNKNOWN
Iteration Time: 4.50s
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: 0.47s
Memory: 229MB (+0MB)
SAT
Testing...
SERIALIZABLE?
Testing Time: 0.00s
Memory: 229MB (+0MB)
Answer: 2
occurs(action("choose_sp1_l1_l0"),1) occurs(action("initialize_sp1"),2) occurs(action("choose_gp_l2_l1"),2) occurs(action("initialize_gp"),3) occurs(action("choose_max_l3_l2"),3) occurs(action("initialize_max"),4) occurs(action("associate_sp1_gp_sp1-gp"),4) occurs(action("choose_gcdc25a_l4_l3"),4) occurs(action("synthesize_sp1-gp_p19arf"),5) occurs(action("synthesize_sp1-gp_cyca"),5) occurs(action("synthesize_sp1-gp_c-myc"),5) occurs(action("synthesize_sp1-gp_cycdp1"),5) occurs(action("synthesize_sp1-gp_cycd"),5) occurs(action("initialize_sp1"),5) occurs(action("synthesize_sp1-gp_p107"),5) occurs(action("initialize_gp"),5) occurs(action("synthesize_sp1-gp_cyce"),5) occurs(action("synthesize_sp1-gp_p107p1"),5) occurs(action("choose_raf1_l5_l4"),5) occurs(action("synthesize_sp1-gp_cycep1"),5) occurs(action("initialize_gcdc25a"),5) occurs(action("dummy-action-32-2"),6) occurs(action("dummy-action-13-2"),6) occurs(action("associate_c-myc_max_c-myc-max"),6) occurs(action("synthesize_sp1-gp_cyca"),6) occurs(action("associate_sp1_p107p1_sp1-p107p1"),6) occurs(action("initialize_raf1"),6) occurs(action("initialize_gcdc25a"),6) occurs(action("choose_cych_l6_l5"),6) occurs(action("dummy-action-13-2"),7) occurs(action("associate_sp1-p107p1_gp_sp1-p107p1-gp"),7) occurs(action("initialize_max"),7) occurs(action("synthesize_sp1-gp_c-myc"),7) occurs(action("initialize_sp1"),7) occurs(action("initialize_raf1"),7) occurs(action("associate_c-myc-max_gcdc25a_c-myc-max-gcdc25a"),7) occurs(action("synthesize_sp1-gp_cyce"),7) occurs(action("initialize_cych"),7) occurs(action("choose_cdk7_l7_l6"),7) occurs(action("dummy-action-31-2"),8) occurs(action("associate_c-myc_max_c-myc-max"),8) occurs(action("synthesize_c-myc-max-gcdc25a_cdc25a"),8) occurs(action("initialize_gp"),8) occurs(action("choose_cdk46p1_l8_l7"),8) occurs(action("initialize_cdk7"),8) occurs(action("dummy-action-20-2"),9) occurs(action("synthesize_sp1-gp_p19arf"),9) occurs(action("associate-with-catalyze_cdc25a_raf1_cdc25ap1"),9) occurs(action("synthesize_sp1-gp_cyca"),9) occurs(action("synthesize_sp1-gp_c-myc"),9) occurs(action("synthesize_sp1-gp_cycdp1"),9) occurs(action("synthesize_sp1-gp_cycd"),9) occurs(action("initialize_cdk46p1"),9) occurs(action("associate_cdk7_cych_cdk7-cych"),9) occurs(action("choose_p16_l9_l8"),9) occurs(action("dummy-action-32-2"),10) occurs(action("dummy-action-10-2"),10) occurs(action("synthesize_c-myc-max-gcdc25a_cdc25a"),10) occurs(action("initialize_p16"),10) occurs(action("associate-with-catalyze_cdk46p1_cdk7-cych_cdk46p1p2"),10) occurs(action("choose_p53p1_l10_l9"),10) occurs(action("initialize_cdk7"),10) occurs(action("dummy-action-19-2"),11) occurs(action("associate-with-catalyze_cdk46p1p2_cdc25ap1_cdk46p2"),11) occurs(action("synthesize_sp1-gp_cyca"),11) occurs(action("initialize_p53p1"),11) occurs(action("synthesize_sp1-gp_cycd"),11) occurs(action("associate-with-catalyze_cdk7_cdk7-cych_cdk7p1"),11) occurs(action("initialize_cdk46p1"),11) occurs(action("initialize_cych"),11) occurs(action("choose_pcna_l11_l10"),11) occurs(action("associate_p16_cdk46p2_p16-cdk46p2"),12) occurs(action("associate-with-catalyze_cdk46p1_cdc25ap1_cdk46"),12) occurs(action("synthesize_p53p1_mdm2"),12) occurs(action("synthesize_p53p1_p21"),12) occurs(action("synthesize_p53p1_c-fos"),12) occurs(action("initialize_pcna"),12) occurs(action("initialize_cdk7"),12) occurs(action("choose_cdk2p1_l12_l11"),12) occurs(action("dummy-action-4-2"),13) occurs(action("associate_cdk46_cycd_cdk46-cycd"),13) occurs(action("synthesize_sp1-gp_cyca"),13) occurs(action("synthesize_c-myc-max-gcdc25a_cdc25a"),13) occurs(action("associate_pcna_p21_pcna-p21"),13) occurs(action("synthesize_sp1-gp_cycdp1"),13) occurs(action("initialize_p16"),13) occurs(action("initialize_cdk46p1"),13) occurs(action("initialize_raf1"),13) occurs(action("associate_cdk7_cych_cdk7-cych"),13) occurs(action("initialize_cdk2p1"),13) occurs(action("choose_p57_l13_l12"),13) occurs(action("dummy-action-7-2"),14) occurs(action("associate_p16_cdk7p1_p16-cdk7p1"),14) occurs(action("associate-with-catalyze_cdk46p1_cdc25a
SATISFIABLE
Models : 1+
Calls : 11
Time : 23.438s (Solving: 19.47s 1st Model: 0.46s Unsat: 0.67s)
CPU Time : 23.432s
Choices : 528175 (Domain: 520902)
Conflicts : 52203 (Analyzed: 52202)
Restarts : 541 (Average: 96.49 Last: 155)
Model-Level : 1645.0
Problems : 11 (Average Length: 21.09 Splits: 0)
Lemmas : 52202 (Deleted: 46204)
Binary : 116 (Ratio: 0.22%)
Ternary : 355 (Ratio: 0.68%)
Conflict : 52202 (Average Length: 94.4 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 52202 (Average: 9.49 Max: 1166 Sum: 495390)
Executed : 52166 (Average: 9.47 Max: 1166 Sum: 494472 Ratio: 99.81%)
Bounded : 36 (Average: 25.50 Max: 32 Sum: 918 Ratio: 0.19%)
Rules : 93502 (Original: 88379)
Atoms : 66734
Bodies : 23754 (Original: 18681)
Count : 805 (Original: 1625)
Equivalences : 12744 (Atom=Atom: 758 Body=Body: 0 Other: 11986)
Tight : Yes
Variables : 132279 (Eliminated: 0 Frozen: 49310)
Constraints : 516842 (Binary: 92.8% Ternary: 5.0% Other: 2.2%)
Memory Peak : 229MB
Max. Length : 30 steps
Sol. Length : 30 steps
Models : 2