[Tue Jan 13 22:21:26 2009].355048 msFreeMap(): freeing map at 0x6005200.
[Tue Jan 13 22:21:37 2009].732681 msDrawRasterLayerLow(Dem): entering.
[Tue Jan 13 22:21:38 2009].376280 msDrawMap(): Layer 0 (Dem), 0.644s
[Tue Jan 13 22:21:39 2009].274366 msDrawMap(): Layer 22 (Ownership), 0.898s
[Tue Jan 13 22:21:39 2009].274782 msDrawMap(): Layer 32 (mtrq), 0.000s
[Tue Jan 13 22:21:39 2009].274838 msDrawMap(): Layer 33 (elfeet), 0.000s
[Tue Jan 13 22:21:39 2009].275043 msDrawMap(): Layer 34 (copyright), 0.000s
[Tue Jan 13 22:21:39 2009].276255 msOGRFileOpen(/Applications/MAMP/d/DATA/NonGrassFiles/GPX/gpsbabel_output.gpx)...
[Tue Jan 13 22:21:39 2009].276449 OGROPen(/Applications/MAMP/d/DATA/NonGrassFiles/GPX/gpsbabel_output.gpx)
[Tue Jan 13 22:21:39 2009].283682 msConnPoolRegister(GPS,/Applications/MAMP/d/DATA/NonGrassFiles/GPX/gpsbabel_output.gpx,0x5b37480)
[Tue Jan 13 22:21:39 2009].284096 msOGRFileWhichShapes: Setting spatial filter to -112.654563 33.855236 -112.530269 33.956196
[Tue Jan 13 22:21:39 2009].285403 msOGRFileNextShape: Returning shape=3, tile=0
[Tue Jan 13 22:21:39 2009].285455 msOGRFileNextShape: Returning shape=4, tile=0
[Tue Jan 13 22:21:39 2009].285498 msOGRFileNextShape: Returning shape=5, tile=0
[Tue Jan 13 22:21:39 2009].285537 msOGRFileNextShape: Returning shape=6, tile=0
[Tue Jan 13 22:21:39 2009].288274 msOGRFileNextShape: Returning shape=35, tile=0
[Tue Jan 13 22:21:39 2009].288328 msOGRFileNextShape: Returning shape=36, tile=0
[Tue Jan 13 22:21:39 2009].288366 msOGRFileNextShape: Returning shape=37, tile=0
[Tue Jan 13 22:21:39 2009].289771 msOGRFileNextShape: Returning shape=55, tile=0
[Tue Jan 13 22:21:39 2009].295244 msOGRFileNextShape: Returning shape=58, tile=0
[Tue Jan 13 22:21:39 2009].295329 msOGRFileNextShape: Returning shape=60, tile=0
[Tue Jan 13 22:21:39 2009].295368 msOGRFileNextShape: Returning shape=63, tile=0
[Tue Jan 13 22:21:39 2009].295975 msOGRFileNextShape: Returning shape=66, tile=0
[Tue Jan 13 22:21:39 2009].297324 msOGRFileNextShape: Returning shape=84, tile=0
[Tue Jan 13 22:21:39 2009].298300 msOGRFileNextShape: Returning shape=91, tile=0
[Tue Jan 13 22:21:39 2009].298351 msOGRFileNextShape: Returning shape=93, tile=0
[Tue Jan 13 22:21:39 2009].299421 msOGRFileNextShape: Returning shape=107, tile=0
[Tue Jan 13 22:21:39 2009].299998 msOGRFileNextShape: Returning shape=111, tile=0
[Tue Jan 13 22:21:39 2009].300531 msOGRFileNextShape: Returning shape=118, tile=0
[Tue Jan 13 22:21:39 2009].300584 msOGRFileNextShape: Returning shape=119, tile=0
[Tue Jan 13 22:21:39 2009].301060 msOGRFileNextShape: Returning shape=120, tile=0
[Tue Jan 13 22:21:39 2009].301106 msOGRFileNextShape: Returning shape=121, tile=0
[Tue Jan 13 22:21:39 2009].301144 msOGRFileNextShape: Returning shape=122, tile=0
[Tue Jan 13 22:21:39 2009].301182 msOGRFileNextShape: Returning shape=123, tile=0
[Tue Jan 13 22:21:39 2009].301734 msOGRFileNextShape: Returning shape=127, tile=0
[Tue Jan 13 22:21:39 2009].301785 msOGRFileNextShape: Returning shape=130, tile=0
[Tue Jan 13 22:21:39 2009].302324 msOGRFileNextShape: Returning shape=131, tile=0
[Tue Jan 13 22:21:39 2009].302376 msOGRFileNextShape: Returning shape=132, tile=0
[Tue Jan 13 22:21:39 2009].302415 msOGRFileNextShape: Returning shape=136, tile=0
[Tue Jan 13 22:21:39 2009].302931 msOGRFileNextShape: Returning shape=138, tile=0
[Tue Jan 13 22:21:39 2009].303321 msOGRFileNextShape: Returning shape=145, tile=0
[Tue Jan 13 22:21:39 2009].303390 msOGRFileNextShape: Returning MS_DONE (no more shapes)
[Tue Jan 13 22:21:39 2009].303415 msOGRLayerClose(/Applications/MAMP/d/DATA/NonGrassFiles/GPX/gpsbabel_output.gpx).
[Tue Jan 13 22:21:39 2009].303437 msOGRFileClose(/Applications/MAMP/d/DATA/NonGrassFiles/GPX/gpsbabel_output.gpx,0).
[Tue Jan 13 22:21:39 2009].303471 msConnPoolRelease(GPS,/Applications/MAMP/d/DATA/NonGrassFiles/GPX/gpsbabel_output.gpx,0x5b37480)
[Tue Jan 13 22:21:39 2009].303505 msConnPoolClose(/Applications/MAMP/d/DATA/NonGrassFiles/GPX/gpsbabel_output.gpx,0x5b37480)
[Tue Jan 13 22:21:39 2009].305298 msDrawMap(): Layer 35 (GPS), 0.030s
[Tue Jan 13 22:21:39 2009].372199 msDrawMap(): Drawing Label Cache, 0.067s
[Tue Jan 13 22:21:39 2009].372304 msDrawMap() total time: 1.684s
[Tue Jan 13 22:21:39 2009].986715 msSaveImage() total time: 0.599s
[Tue Jan 13 22:21:40 2009].68141 msSaveImage() total time: 0.080s
[Tue Jan 13 22:21:40 2009].134197 mapserv request processing time (loadmap not incl.): 2.446s