Ticket #135: profile_nautilus_v4669.txt

File profile_nautilus_v4669.txt, 12.3 KB (added by ole, 17 years ago)
Line 
1Caching: looking for cached files /home/ole/.python_cache/_pmesh_to_domain[-993177944]_{Result,Args,Admin}.z
2Caching: Dependencies are ['Benchmark_2.msh']
3+----------------------------------------------------------
4| Wed Sep 12 13:37:47 2007. Caching statistics (retrieving)
5+----------------------------------------------------------
6| Function:     _pmesh_to_domain
7| Arguments:    ('Benchmark_2.msh', None)
8| CPU time:     0.79 seconds
9| Loading time: 0.02 seconds
10| Time saved:   0.77 seconds
11|
12| Caching dir:  /home/ole/.python_cache/
13| Result file:  _pmesh_to_domain[-993177944]_Result.z (603086 bytes, compressed)
14| Args file:    _pmesh_to_domain[-993177944]_Args.z (40 bytes, compressed)
15| Admin file:   _pmesh_to_domain[-993177944]_Admin.z (428 bytes, compressed)
16|
17| Dependencies: 
18|  Benchmark_2.msh: Wed Sep 12 13:09:18 2007   1341952 bytes
19+----------------------------------------------------------
20
21General_mesh: Building basic mesh structure
22General_mesh: Computing areas, normals and edgelenghts
23(0/41457)
24(4146/41457)
25(8292/41457)
26(12438/41457)
27(16584/41457)
28(20730/41457)
29(24876/41457)
30(29022/41457)
31(33168/41457)
32(37314/41457)
33Building inverted triangle structure
34Initialising mesh
35Mesh: Computing centroids and radii
36(0/41457)
37(4146/41457)
38(8292/41457)
39(12438/41457)
40(16584/41457)
41(20730/41457)
42(24876/41457)
43(29022/41457)
44(33168/41457)
45(37314/41457)
46Mesh: Building neigbour structure
47Mesh: Building surrogate neigbour structure
48Mesh: Building boundary dictionary
49Mesh: Building tagged elements dictionary
50Mesh: Done
51Initialising Domain
52Domain: Set up communication buffers (parallel)
53Domain: Initialising quantity values
54Domain: Done
55------------------------------------------------
56Mesh statistics:
57  Number of triangles = 41457
58  Extent [m]:
59    x in [0.000000, 5.448000]
60    y in [0.000000, 3.402000]
61  Areas [m^2]:
62    A in [0.000009, 0.099963]
63    number of distinct areas: 41457
64    Histogram:
65      [0.000009, 0.010004[: 41225
66      [0.010004, 0.020000[: 46
67      [0.020000, 0.029995[: 25
68      [0.029995, 0.039991[: 16
69      [0.039991, 0.049986[: 34
70      [0.049986, 0.059981[: 31
71      [0.059981, 0.069977[: 34
72      [0.069977, 0.079972[: 22
73      [0.079972, 0.089968[: 18
74      [0.089968, 0.099963]: 6
75    Percentiles (10%):
76      4145 triangles in [0.000009, 0.000016]
77      4145 triangles in [0.000016, 0.000018]
78      4145 triangles in [0.000018, 0.000021]
79      4145 triangles in [0.000021, 0.000026]
80      4145 triangles in [0.000026, 0.000147]
81      4145 triangles in [0.000147, 0.000188]
82      4145 triangles in [0.000188, 0.000233]
83      4145 triangles in [0.000233, 0.000278]
84      4145 triangles in [0.000278, 0.000362]
85      4145 triangles in [0.000362, 0.089004]
86      7 triangles in [0.089004, 0.099963]
87  Boundary:
88    Number of boundary segments == 97
89    Boundary tags == ['wall', 'wave']
90------------------------------------------------
91
92Caching: looking for cached files /home/ole/.python_cache/_fit_to_mesh[491029454]_{Result,Args,Admin}.z
93Caching: Dependencies are ['Benchmark_2_Bathymetry.pts']
94+----------------------------------------------------------
95| Wed Sep 12 13:38:16 2007. Caching statistics (retrieving)
96+----------------------------------------------------------
97| Function:     _fit_to_mesh
98| Arguments:    (Array: (20778, 2), Array: (41457, 3), 'Benchmark_2_Bathymetry.pts')
99| Keyword Args: {'point_attributes': None, 'use_cache': True, 'attribute_name': None, 'verbose': True, 'max_read_lines': 500, 'acceptable_overshoot': 1.01, 'mesh_origin': None, 'alpha': 0.02, 'data_origin': None}
100| CPU time:     216.13 seconds
101| Loading time: 0.0 seconds
102| Time saved:   216.13 seconds
103|
104| Caching dir:  /home/ole/.python_cache/
105| Result file:  _fit_to_mesh[491029454]_Result (166276 bytes)
106| Args file:    _fit_to_mesh[491029454]_Args (830231 bytes)
107| Admin file:   _fit_to_mesh[491029454]_Admin (1648 bytes)
108|
109| Dependencies: 
110|  Benchmark_2_Bathymetry.pts: Wed Sep 12 13:09:18 2007   2301948 bytes
111+----------------------------------------------------------
112
113Reading Benchmark_2_input.tms
114File_function data obtained from: Benchmark_2_input.tms
115  References:
116    Start time:   0.000000
117Time = 0.0000, steps=0 (0)
118Time = 0.0500, delta t in [0.00503234, 0.00503236], steps=10 (0)
119Time = 0.1000, delta t in [0.00503233, 0.00503236], steps=10 (0)
120Time = 0.1500, delta t in [0.00503233, 0.00503234], steps=10 (0)
121Time = 0.2000, delta t in [0.00503234, 0.00503234], steps=10 (0)
122Time = 0.2500, delta t in [0.00503233, 0.00503234], steps=10 (0)
123Time = 0.3000, delta t in [0.00503232, 0.00503233], steps=10 (0)
124Time = 0.3500, delta t in [0.00503231, 0.00503232], steps=10 (0)
125Time = 0.4000, delta t in [0.00503229, 0.00503231], steps=10 (0)
126Time = 0.4500, delta t in [0.00503226, 0.00503229], steps=10 (0)
127Time = 0.5000, delta t in [0.00503223, 0.00503226], steps=10 (0)
128Time = 0.5500, delta t in [0.00503219, 0.00503222], steps=10 (0)
129Time = 0.6000, delta t in [0.00503215, 0.00503219], steps=10 (0)
130Time = 0.6500, delta t in [0.00503209, 0.00503214], steps=10 (0)
131Time = 0.7000, delta t in [0.00503202, 0.00503209], steps=10 (0)
132Time = 0.7500, delta t in [0.00503196, 0.00503201], steps=10 (0)
133Time = 0.8000, delta t in [0.00503191, 0.00503195], steps=10 (0)
134Time = 0.8500, delta t in [0.00503187, 0.00503190], steps=10 (0)
135Time = 0.9000, delta t in [0.00503184, 0.00503186], steps=10 (0)
136Time = 0.9500, delta t in [0.00503183, 0.00503184], steps=10 (0)
137Time = 1.0000, delta t in [0.00503183, 0.00503184], steps=10 (0)
138Time = 1.0500, delta t in [0.00503184, 0.00503187], steps=10 (0)
139Time = 1.1000, delta t in [0.00503187, 0.00503194], steps=10 (0)
140Time = 1.1500, delta t in [0.00503194, 0.00503205], steps=10 (0)
141Time = 1.2000, delta t in [0.00503207, 0.00503233], steps=10 (0)
142Time = 1.2500, delta t in [0.00503237, 0.00503286], steps=10 (0)
143Time = 1.3000, delta t in [0.00503292, 0.00503352], steps=10 (0)
144Time = 1.3500, delta t in [0.00503358, 0.00503408], steps=10 (0)
145Time = 1.4000, delta t in [0.00503412, 0.00503433], steps=10 (0)
146Time = 1.4500, delta t in [0.00503433, 0.00503435], steps=10 (0)
147Time = 1.5000, delta t in [0.00503410, 0.00503432], steps=10 (0)
148Time = 1.5500, delta t in [0.00503369, 0.00503407], steps=10 (0)
149Time = 1.6000, delta t in [0.00503328, 0.00503365], steps=10 (0)
150Time = 1.6500, delta t in [0.00503288, 0.00503324], steps=10 (0)
151Time = 1.7000, delta t in [0.00503254, 0.00503284], steps=10 (0)
152Time = 1.7500, delta t in [0.00503228, 0.00503251], steps=10 (0)
153Time = 1.8000, delta t in [0.00503212, 0.00503226], steps=10 (0)
154Time = 1.8500, delta t in [0.00503203, 0.00503210], steps=10 (0)
155Time = 1.9000, delta t in [0.00503202, 0.00503203], steps=10 (0)
156Time = 1.9500, delta t in [0.00503203, 0.00503206], steps=10 (0)
157Time = 2.0000, delta t in [0.00503206, 0.00503211], steps=10 (0)
158That took 44.18 seconds
159Wed Sep 12 13:39:05 2007    profile.dat
160
161         36789 function calls in 43.320 CPU seconds
162
163   Ordered by: internal time
164   List reduced from 95 to 50 due to restriction <50>
165
166   ncalls  tottime  percall  cumtime  percall filename:lineno(function)
167      402   18.480    0.046   18.490    0.046 /home/ole/inundation/anuga_core/source/anuga/shallow_water/shallow_water_domain.py:381(distribute_to_vertices_and_edges)
168      400   14.020    0.035   14.020    0.035 /home/ole/inundation/anuga_core/source/anuga/shallow_water/shallow_water_domain.py:376(compute_fluxes)
169      400    4.340    0.011    4.350    0.011 /home/ole/inundation/anuga_core/source/anuga/abstract_2d_finite_volumes/domain.py:1027(update_conserved_quantities)
170      524    1.950    0.004    1.950    0.004 :0(max)
171      924    1.930    0.002    1.930    0.002 :0(min)
172      124    0.580    0.005    0.580    0.005 :0(take)
173      401    0.530    0.001    1.170    0.003 /home/ole/inundation/anuga_core/source/anuga/abstract_2d_finite_volumes/domain.py:933(update_boundary)
174     3208    0.280    0.000    0.460    0.000 fit_interpolate/interpolate.py:584(__call__)
175      124    0.210    0.002    0.210    0.002 :0(average_vertex_values)
176    16167    0.160    0.000    0.160    0.000 :0(len)
177      124    0.160    0.001    1.110    0.009 abstract_2d_finite_volumes/quantity.py:1076(get_vertex_values)
178     3208    0.140    0.000    0.180    0.000 /home/ole/inundation/anuga_core/source/anuga/abstract_2d_finite_volumes/domain.py:246(get_conserved_quantities)
179      124    0.110    0.001    0.110    0.001 :0(range)
180       41    0.100    0.002    3.950    0.096 /home/ole/inundation/anuga_core/source/anuga/shallow_water/data_manager.py:4988(quantities)
181     6540    0.080    0.000    0.080    0.000 :0(zeros)
182       41    0.060    0.001    5.140    0.125 /home/ole/inundation/anuga_core/source/anuga/shallow_water/data_manager.py:461(store_timestep)
183       41    0.040    0.001    0.040    0.001 :0(choose)
184      251    0.040    0.000    0.040    0.000 :0(astype)
185      400    0.030    0.000    0.030    0.000 /home/ole/inundation/anuga_core/source/anuga/abstract_2d_finite_volumes/domain.py:960(update_timestep)
186     1602    0.020    0.000    0.020    0.000 /home/ole/inundation/anuga_core/source/anuga/abstract_2d_finite_volumes/general_mesh.py:218(__len__)
187        1    0.020    0.020    0.060    0.060 /home/ole/inundation/anuga_core/source/anuga/shallow_water/data_manager.py:4894(triangulation)
188      401    0.010    0.000    0.010    0.000 /home/ole/inundation/anuga_core/source/anuga/abstract_2d_finite_volumes/domain.py:1058(update_ghosts)
189       42    0.010    0.000   38.040    0.906 /home/ole/inundation/anuga_core/source/anuga/abstract_2d_finite_volumes/domain.py:773(evolve)
190        1    0.010    0.010    0.010    0.010 /home/ole/inundation/anuga_core/source/anuga/shallow_water/data_manager.py:4784(header)
191        1    0.010    0.010    0.090    0.090 /home/ole/inundation/anuga_core/source/anuga/shallow_water/data_manager.py:409(store_connectivity)
192        1    0.000    0.000    0.000    0.000 /home/ole/inundation/anuga_core/source/anuga/shallow_water/data_manager.py:293(Data_format_sww)
193        1    0.000    0.000    0.000    0.000 /home/ole/inundation/anuga_core/source/anuga/shallow_water/data_manager.py:56(DataDomainError)
194       43    0.000    0.000    0.000    0.000 /usr/lib/python2.4/site-packages/Scientific/IO/NetCDF.py:136(NetCDFFile)
195        1    0.000    0.000    0.100    0.100 /home/ole/inundation/anuga_core/source/anuga/shallow_water/shallow_water_domain.py:474(initialise_storage)
196        1    0.000    0.000    0.000    0.000 /home/ole/inundation/anuga_core/source/anuga/shallow_water/data_manager.py:3994(Write_nc)
197        1    0.000    0.000    0.000    0.000 :0(setprofile)
198       44    0.000    0.000    0.000    0.000 posixpath.py:310(expanduser)
199        1    0.000    0.000    0.000    0.000 :0(read)
200        3    0.000    0.000    0.000    0.000 /usr/lib/python2.4/site-packages/Numeric/Numeric.py:211(swapaxes)
201        1    0.000    0.000    0.000    0.000 /home/ole/inundation/anuga_core/source/anuga/shallow_water/data_manager.py:53(DataMissingValuesError)
202       41    0.000    0.000    5.140    0.125 /home/ole/inundation/anuga_core/source/anuga/shallow_water/shallow_water_domain.py:488(store_timestep)
203       41    0.000    0.000    0.000    0.000 :0(sync)
204       41    0.000    0.000    0.000    0.000 /home/ole/inundation/anuga_core/source/anuga/abstract_2d_finite_volumes/domain.py:556(timestepping_statistics)
205       43    0.000    0.000    0.000    0.000 :0(apply)
206        1    0.000    0.000    0.000    0.000 /home/ole/inundation/anuga_core/source/anuga/coordinate_transforms/geo_reference.py:81(write_NetCDF)
207       41    0.000    0.000    0.000    0.000 :0(stat)
208        1    0.000    0.000    0.000    0.000 :0(values)
209        1    0.000    0.000    0.000    0.000 /home/ole/inundation/anuga_core/source/anuga/load_mesh/__init__.py:0(?)
210       13    0.000    0.000    0.000    0.000 :0(createVariable)
211        1    0.000    0.000    0.000    0.000 /home/ole/inundation/anuga_core/source/anuga/shallow_water/data_manager.py:5246(Screen_Catcher)
212        1    0.000    0.000    0.000    0.000 /home/ole/inundation/anuga_core/source/anuga/shallow_water/data_manager.py:120(check_dir)
213       41    0.000    0.000    0.000    0.000 /home/ole/inundation/anuga_core/source/anuga/abstract_2d_finite_volumes/domain.py:552(write_time)
214        1    0.000    0.000    0.000    0.000 /home/ole/inundation/anuga_core/source/anuga/abstract_2d_finite_volumes/domain.py:740(get_name)
215        2    0.000    0.000    0.000    0.000 :0(split)
216        1    0.000    0.000    0.000    0.000 :0(keys)
217
218
219<pstats.Stats instance at 0xb48549ac>