Changeset 21258

Timestamp:

Feb 1, 2009, 11:57:23 AM (17 years ago)

Author:

eugene

Message:

added a few coarse-grained timer marks

Location:

trunk/ppStack/src

Files:

• ppStack.c (modified) (1 diff)
• ppStackLoop.c (modified) (11 diffs)

trunk/ppStack/src/ppStack.c

@@ -16 +16 @@
     psExit exitValue = PS_EXIT_SUCCESS; // Exit value
     psTimerStart(TIMER_NAME);
+    psTimerStart("PPSTACK_STEPS");
     psLibInit(NULL);
 

trunk/ppStack/src/ppStackLoop.c

@@ -249 +249 @@
 
     memDump("start");
+
+    psLogMsg("ppStack", PS_LOG_INFO, "Stage 0 : Initialization and Configuration : %f sec", psTimerClear("PPSTACK_STEPS"));
 
     // Preparation iteration: Load the sources, and get a target PSF model
@@ -380 +382 @@
     }
 
+    psLogMsg("ppStack", PS_LOG_INFO, "Stage 1 : Load Sources and Generate Target PSF : %f sec", psTimerClear("PPSTACK_STEPS"));
     memDump("psf");
 
@@ -509 +512 @@
     psFree(rng);
 
+    psLogMsg("ppStack", PS_LOG_INFO, "Stage 2 : Generate Convolutions and Save : %f sec", psTimerClear("PPSTACK_STEPS"));
+
     if (numGood == 0) {
         psError(PS_ERR_UNKNOWN, false, "No good images to combine.");
@@ -613 +618 @@
 #endif
 
+    psLogMsg("ppStack", PS_LOG_INFO, "Stage 3 : Basic Image Rejection  : %f sec", psTimerClear("PPSTACK_STEPS"));
 
     // Start threading
@@ -762 +768 @@
                          "Time to make initial stack", psTimerMark("PPSTACK_INITIAL"));
     }
+    psLogMsg("ppStack", PS_LOG_INFO, "Stage 4 : Make Initial Stack : %f sec", psTimerClear("PPSTACK_STEPS"));
     psLogMsg("ppStack", PS_LOG_INFO, "Time to make initial stack: %f sec", psTimerClear("PPSTACK_INITIAL"));
 
@@ -912 +919 @@
                              "Number of images rejected completely", numRejected);
         }
-   }
-
+    }
+
+    psLogMsg("ppStack", PS_LOG_INFO, "Stage 5 : Pixel Rejection : %f sec", psTimerClear("PPSTACK_STEPS"));
     psTimerStart("PPSTACK_FINAL");
 
@@ -976 +984 @@
                          "Time to make final stack", psTimerMark("PPSTACK_FINAL"));
     }
+
+    psLogMsg("ppStack", PS_LOG_INFO, "Stage 6 : Final Stack : %f sec", psTimerClear("PPSTACK_STEPS"));
     psLogMsg("ppStack", PS_LOG_INFO, "Time to make final stack: %f sec", psTimerClear("PPSTACK_FINAL"));
 
@@ -1071 +1081 @@
     }
 
+    psLogMsg("ppStack", PS_LOG_INFO, "Stage 7 : WCS & JPEGS : %f sec", psTimerClear("PPSTACK_STEPS"));
+
     if (psMetadataLookupBool(&mdok, recipe, "RENORM")) {
         // Statistics for renormalisation
@@ -1088 +1100 @@
     }
 
+    psLogMsg("ppStack", PS_LOG_INFO, "Stage 8 : Photometry Renormalization : %f sec", psTimerClear("PPSTACK_STEPS"));
+
     if (psMetadataLookupBool(&mdok, recipe, "PHOTOMETRY")) {
         psTrace("ppStack", 1, "Photometering stacked image....\n");
@@ -1117 +1131 @@
     }
 
+    psLogMsg("ppStack", PS_LOG_INFO, "Stage 9 : Photometry Analysis : %f sec", psTimerClear("PPSTACK_STEPS"));
+
     psThreadPoolFinalize();
 
@@ -1170 +1186 @@
     }
 
+    psLogMsg("ppStack", PS_LOG_INFO, "Stage 10 : Final Output : %f sec", psTimerClear("PPSTACK_STEPS"));
+
     memDump("finish");