tplp-planning-benchmark/gc-ta1-tt1/ipc-2004_airport-nontemporal-strips_32.out

422 lines
50 KiB
Plaintext
Raw Normal View History

INFO Running translator.
INFO translator input: ['/home/pluehne/Documents/ASP/pddl-instances/ipc-2004/domains/airport-nontemporal-strips/domains/domain-32.pddl', '/home/pluehne/Documents/ASP/pddl-instances/ipc-2004/domains/airport-nontemporal-strips/instances/instance-32.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-2004/domains/airport-nontemporal-strips/domains/domain-32.pddl /home/pluehne/Documents/ASP/pddl-instances/ipc-2004/domains/airport-nontemporal-strips/instances/instance-32.pddl
Parsing...
Parsing: [2.590s CPU, 2.592s wall-clock]
Normalizing task... [0.320s CPU, 0.318s wall-clock]
Instantiating...
Generating Datalog program... [0.340s CPU, 0.344s wall-clock]
Normalizing Datalog program...
Normalizing Datalog program: [1.400s CPU, 1.399s wall-clock]
Preparing model... [1.480s CPU, 1.482s wall-clock]
Generated 8891 rules.
Computing model... [4.470s CPU, 4.468s wall-clock]
15344 relevant atoms
34282 auxiliary atoms
49626 final queue length
73644 total queue pushes
Completing instantiation... [5.240s CPU, 5.239s wall-clock]
Instantiating: [13.060s CPU, 13.061s wall-clock]
Computing fact groups...
Finding invariants...
26 initial candidates
Finding invariants: [2.890s CPU, 2.883s wall-clock]
Checking invariant weight... [0.030s CPU, 0.038s wall-clock]
Instantiating groups... [1.430s CPU, 1.430s wall-clock]
Collecting mutex groups... [0.030s CPU, 0.035s wall-clock]
Choosing groups...
5644 uncovered facts
Choosing groups: [0.120s CPU, 0.122s wall-clock]
Building translation key... [0.240s CPU, 0.235s wall-clock]
Computing fact groups: [5.690s CPU, 5.685s wall-clock]
Building STRIPS to SAS dictionary... [0.280s CPU, 0.281s wall-clock]
Building dictionary for full mutex groups... [0.090s CPU, 0.088s wall-clock]
Building mutex information...
Building mutex information: [0.120s CPU, 0.123s wall-clock]
Translating task...
Processing axioms...
Simplifying axioms... [0.000s CPU, 0.000s wall-clock]
Processing axioms: [0.260s CPU, 0.257s wall-clock]
Translating task: [5.880s CPU, 5.868s wall-clock]
19896 effect conditions simplified
0 implied preconditions added
Detecting unreachable propositions...
0 operators removed
0 axioms removed
2023 propositions removed
Detecting unreachable propositions: [3.290s CPU, 3.292s wall-clock]
Reordering and filtering variables...
2164 of 4674 variables necessary.
204 of 251 mutex groups necessary.
6441 of 6441 operators necessary.
0 of 0 axiom rules necessary.
Reordering and filtering variables: [62.560s CPU, 62.536s wall-clock]
Translator variables: 2164
Translator derived variables: 0
Translator facts: 6575
Translator goal facts: 10
Translator mutex groups: 204
Translator total mutex groups size: 2171
Translator operators: 6441
Translator axioms: 0
Translator task size: 103236
Translator peak memory: 148944 KB
Writing output... [1.550s CPU, 1.692s wall-clock]
Done! [95.620s CPU, 95.728s wall-clock]
planner.py version 0.0.1
Time: 3.39s
Memory: 274MB
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.02s
Memory: 274MB (+0MB)
UNSAT
Iteration Time: 0.03s
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: 1.50s
Memory: 307MB (+33MB)
Unblocking actions...
Solving...
Solving Time: 0.13s
Memory: 323MB (+16MB)
UNSAT
Iteration Time: 2.32s
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: 1.60s
Memory: 358MB (+35MB)
Unblocking actions...
Solving...
Solving Time: 0.17s
Memory: 393MB (+35MB)
UNSAT
Iteration Time: 2.62s
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: 1.53s
Memory: 419MB (+26MB)
Unblocking actions...
Solving...
Solving Time: 0.19s
Memory: 458MB (+39MB)
UNSAT
Iteration Time: 2.74s
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: 1.62s
Memory: 493MB (+35MB)
Unblocking actions...
Solving...
Solving Time: 0.20s
Memory: 546MB (+53MB)
UNSAT
Iteration Time: 2.98s
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: 1.89s
Memory: 594MB (+48MB)
Unblocking actions...
Solving...
Solving Time: 0.22s
Memory: 657MB (+63MB)
UNSAT
Iteration Time: 3.39s
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: 1.57s
Memory: 670MB (+13MB)
Unblocking actions...
Solving...
Solving Time: 0.24s
Memory: 700MB (+30MB)
UNSAT
Iteration Time: 3.20s
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: 1.62s
Memory: 739MB (+39MB)
Unblocking actions...
Solving...
Solving Time: 0.25s
Memory: 770MB (+31MB)
UNSAT
Iteration Time: 3.36s
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: 1.68s
Memory: 810MB (+40MB)
Unblocking actions...
Solving...
Solving Time: 0.27s
Memory: 911MB (+101MB)
UNSAT
Iteration Time: 3.55s
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: 1.73s
Memory: 912MB (+1MB)
Unblocking actions...
Solving...
Solving Time: 0.28s
Memory: 943MB (+31MB)
UNSAT
Iteration Time: 3.68s
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: 2.38s
Memory: 1026MB (+83MB)
Unblocking actions...
Solving...
Solving Time: 0.30s
Memory: 1063MB (+37MB)
UNSAT
Iteration Time: 4.41s
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: 1.61s
Memory: 1100MB (+37MB)
Unblocking actions...
Solving...
Solving Time: 0.32s
Memory: 1180MB (+80MB)
UNSAT
Iteration Time: 3.74s
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: 1.64s
Memory: 1206MB (+26MB)
Unblocking actions...
Solving...
Solving Time: 0.33s
Memory: 1249MB (+43MB)
UNSAT
Iteration Time: 3.83s
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: 1.66s
Memory: 1281MB (+32MB)
Unblocking actions...
Solving...
Solving Time: 0.35s
Memory: 1319MB (+38MB)
UNSAT
Iteration Time: 3.91s
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: 1.68s
Memory: 1348MB (+29MB)
Unblocking actions...
Solving...
Solving Time: 13.60s
Memory: 1389MB (+41MB)
UNKNOWN
Iteration Time: 17.24s
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: 1.67s
Memory: 1433MB (+44MB)
Unblocking actions...
Solving...
Solving Time: 12.21s
Memory: 1478MB (+45MB)
UNKNOWN
Iteration Time: 15.87s
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: 1.72s
Memory: 1531MB (+53MB)
Unblocking actions...
Solving...
Solving Time: 14.01s
Memory: 1657MB (+126MB)
UNKNOWN
Iteration Time: 17.79s
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: 1.74s
Memory: 1664MB (+7MB)
Unblocking actions...
Solving...
Solving Time: 13.35s
Memory: 1722MB (+58MB)
UNKNOWN
Iteration Time: 17.18s
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: 1.84s
Memory: 1753MB (+31MB)
Unblocking actions...
Solving...
Solving Time: 1.59s
Memory: 1820MB (+67MB)
SAT
Testing...
NOT SERIALIZABLE
Testing Time: 16.16s
Memory: 2190MB (+370MB)
Solving...
Solving Time: 47.89s
Memory: 2368MB (+178MB)
UNKNOWN
Iteration Time: 69.61s
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: 3.11s
Memory: 2368MB (+0MB)
Unblocking actions...
Solving...
Solving Time: 76.58s
Memory: 2557MB (+189MB)
UNKNOWN
Iteration Time: 82.71s
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: 4.32s
Memory: 2657MB (+100MB)
Unblocking actions...
Solving...
Solving Time: 49.15s
Memory: 2714MB (+57MB)
UNKNOWN
Iteration Time: 56.48s
Iteration 22
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,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)]
Grounded Until: 100
Blocking actions...
Solving...
Solving Time: 25.67s
Memory: 2714MB (+0MB)
UNKNOWN
Iteration Time: 25.93s
Iteration 23
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)]
Grounded Until: 100
Unblocking actions...
Solving...
Solving Time: 23.45s
Memory: 2714MB (+0MB)
UNKNOWN
Iteration Time: 23.70s
Iteration 24
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)]
Grounded Until: 100
Unblocking actions...
Solving...
Solving Time: 34.43s
Memory: 2714MB (+0MB)
SAT
Testing...
SERIALIZABLE?
Testing Time: 0.00s
Memory: 2714MB (+0MB)
Answer: 2
occurs(action(("move_seg_08l_a3a4_0_450_seg_08l_a4d_0_80_south_north_medium","airplane_4xekd")),1) occurs(action(("pushback_seg_p101_0_76_seg_o1_c1a_0_60_south_south_medium","airplane_daewh")),1) occurs(action(("pushback_seg_p118_0_76_seg_o1_118b_0_60_south_south_medium","airplane_daew7")),1) occurs(action(("pushback_seg_p154_0_75_seg_w1_154b_0_45_south_south_medium","airplane_daew5")),1) occurs(action(("pushback_seg_p131_0_75_seg_o1_108d_0_45_south_south_medium","airplane_daew3")),1) occurs(action(("pushback_seg_p112_0_76_seg_o1_c3b_0_60_south_south_medium","airplane_daew2")),1) occurs(action(("move_seg_n_a6a8d_0_75_seg_n_a6a8c_0_75_north_north_medium","airplane_cfbe1")),1) occurs(action(("move_seg_n_a7a6a_0_85_seg_n_a7b_0_60_north_north_medium","airplane_cfbeg")),1) occurs(action(("pushback_seg_o1_c1a_0_60_seg_o1_c1b_0_34_south_north_medium","airplane_daewh")),2) occurs(action(("pushback_seg_o1_118b_0_60_seg_o1_118c_0_34_south_north_medium","airplane_daew7")),2) occurs(action(("pushback_seg_w1_154b_0_45_seg_w1_154c_0_34_south_north_medium","airplane_daew5")),2) occurs(action(("pushback_seg_o1_108d_0_45_seg_o1_108c_0_34_south_north_medium","airplane_daew3")),2) occurs(action(("pushback_seg_o1_c3b_0_60_seg_o1_c3d_0_60_south_north_medium","airplane_daew2")),2) occurs(action(("move_seg_n_a7b_0_60_seg_n_a7c_0_60_north_south_medium","airplane_cfbeg")),2) occurs(action(("move_seg_08l_a4d_0_80_seg_08l_a4a_0_80_north_south_medium","airplane_4xekd")),2) occurs(action(("move_seg_n_a6a8c_0_75_seg_n_a6a8b_0_75_north_north_medium","airplane_cfbe1")),2) occurs(action(("startup_seg_o1_c1b_0_34_north_medium","airplane_daewh")),3) occurs(action(("startup_seg_o1_118c_0_34_north_medium","airplane_daew7")),3) occurs(action(("startup_seg_w1_154c_0_34_north_medium","airplane_daew5")),3) occurs(action(("startup_seg_o1_108c_0_34_north_medium","airplane_daew3")),3) occurs(action(("startup_seg_o1_c3d_0_60_north_medium","airplane_daew2")),3) occurs(action(("move_seg_08l_a4a_0_80_seg_08l_a6a7_0_450_south_south_medium","airplane_4xekd")),3) occurs(action(("move_seg_n_a7c_0_60_seg_n_a4a7f_0_75_south_north_medium","airplane_cfbeg")),3) occurs(action(("move_seg_n_a6a8b_0_75_seg_n_a6a8a_0_115_north_north_medium","airplane_cfbe1")),3) occurs(action(("move_seg_08l_a6a7_0_450_seg_08l_a7d_0_80_south_north_medium","airplane_4xekd")),4) occurs(action(("move_seg_o1_c1b_0_34_seg_o1_c1c_0_80_north_south_medium","airplane_daewh")),4) occurs(action(("move_seg_o1_118c_0_34_seg_o1_118a_0_34_north_south_medium","airplane_daew7")),4) occurs(action(("move_seg_w1_154c_0_34_seg_w1_154a_0_34_north_south_medium","airplane_daew5")),4) occurs(action(("move_seg_o1_108c_0_34_seg_o1_108a_0_34_north_south_medium","airplane_daew3")),4) occurs(action(("move_seg_o1_c3d_0_60_seg_o1_c3a_0_34_north_south_medium","airplane_daew2")),4) occurs(action(("move_seg_n_a6a8a_0_115_seg_n_a6b_0_60_north_north_medium","airplane_cfbe1")),4) occurs(action(("move_seg_n_a4a7f_0_75_seg_n_a4a7e_0_75_north_north_medium","airplane_cfbeg")),4) occurs(action(("move_seg_o1_c1c_0_80_seg_c1_n2b_0_80_south_north_medium","airplane_daewh")),5) occurs(action(("move_seg_o1_118a_0_34_seg_o1_117c_0_34_south_north_medium","airplane_daew7")),5) occurs(action(("move_seg_w1_154a_0_34_seg_w1_153c_0_34_south_north_medium","airplane_daew5")),5) occurs(action(("move_seg_o1_108a_0_34_seg_o1_c2c_0_34_south_north_medium","airplane_daew3")),5) occurs(action(("move_seg_o1_c3a_0_34_seg_o1_111c_0_34_south_north_medium","airplane_daew2")),5) occurs(action(("move_seg_n_a6b_0_60_seg_n_a6c_0_60_north_south_medium","airplane_cfbe1")),5) occurs(action(("move_seg_08l_a7d_0_80_seg_08l_a7b_0_161_245_north_south_medium","airplane_4xekd")),5) occurs(action(("move_seg_n_a4a7e_0_75_seg_n_a4a7d_0_75_north_north_medium","airplane_cfbeg")),5) occurs(action(("move_seg_c1_n2b_0_80_seg_c1_n2c_0_60_north_south_medium","airplane_daewh")),6) occurs(action(("move_seg_o1_117c_0_34_seg_o1_117a_0_34_north_south_medium","airplane_daew7")),6) occurs(action(("move_seg_w1_153c_0_34_seg_w1_153a_0_34_north_south_medium","airplane_daew5")),6) occurs(action(("mo
SATISFIABLE
Models : 1+
Calls : 25
Time : 405.475s (Solving: 304.09s 1st Model: 34.96s Unsat: 0.00s)
CPU Time : 405.488s
Choices : 1721261 (Domain: 1721258)
Conflicts : 83046 (Analyzed: 83046)
Restarts : 971 (Average: 85.53 Last: 114)
Model-Level : 1997.0
Problems : 25 (Average Length: 59.60 Splits: 0)
Lemmas : 83046 (Deleted: 78064)
Binary : 599 (Ratio: 0.72%)
Ternary : 803 (Ratio: 0.97%)
Conflict : 83046 (Average Length: 1653.0 Ratio: 100.00%)
Loop : 0 (Average Length: 0.0 Ratio: 0.00%)
Other : 0 (Average Length: 0.0 Ratio: 0.00%)
Backjumps : 83046 (Average: 7.46 Max: 3394 Sum: 619272)
Executed : 82977 (Average: 7.38 Max: 3394 Sum: 612970 Ratio: 98.98%)
Bounded : 69 (Average: 91.33 Max: 102 Sum: 6302 Ratio: 1.02%)
Rules : 3467540 (Original: 3221406)
Atoms : 681223
Bodies : 2673770 (Original: 2457342)
Count : 62015 (Original: 104106)
Equivalences : 507085 (Atom=Atom: 52886 Body=Body: 0 Other: 454199)
Tight : Yes
Variables : 2329602 (Eliminated: 0 Frozen: 699469)
Constraints : 12833532 (Binary: 90.5% Ternary: 6.5% Other: 3.0%)
Memory Peak : 2942MB
Max. Length : 100 steps
Sol. Length : 80 steps
Models : 2