/**
* DOC amaumont Comment method "timeSinceStart".
*
* @param idTimer
* @return total elapsed time since start in ms
*/
public static long timeSinceBegin(String idTimer) {
if (!measureActive) {
return 0;
}
init();
if (!timers.containsKey(idTimer)) {
if (display) {
System.out.println(
indent(indent)
+ "Warning (end): timer "
+ idTimer
+ " does'nt exist"); //$NON-NLS-1$ //$NON-NLS-2$
}
return -1;
} else {
long time = timers.get(idTimer).getTotalElapsedTime();
if (display) {
if (printMemoryUsed) {
// GC must be forced when check memory, or we can't mesure the difference
Runtime.getRuntime().gc();
long usedMemory = Runtime.getRuntime().totalMemory() - Runtime.getRuntime().freeMemory();
System.out.println(
indent(indent)
+ "-> '"
+ idTimer
+ "', elapsed time since start: "
+ time
+ " ms," //$NON-NLS-1$ //$NON-NLS-2$ //$NON-NLS-3$
+ " current memory ["
+ usedMemory
+ "] bytes"); //$NON-NLS-1$ //$NON-NLS-2$
} else {
System.out.println(
indent(indent)
+ "-> '"
+ idTimer
+ "', elapsed time since start: "
+ time
+ " ms "); //$NON-NLS-1$ //$NON-NLS-2$ //$NON-NLS-3$
}
}
return time;
}
}
public static void resume(String idTimer) {
if (!measureActive) {
return;
}
init();
if (!timers.containsKey(idTimer)) {
begin(idTimer);
// if (display) {
// System.out.println(indent(indent) + "Warning (end): timer " + idTimer + "
// does'nt exist"); //$NON-NLS-1$ //$NON-NLS-2$
// }
return;
} else {
TimeStack times = timers.get(idTimer);
// long time = times.getLastStepElapsedTime();
times.resume();
if (display) {
// do nothing... yet
}
}
}
/**
* DOC amaumont Comment method "start".
*
* @param idTimer
*/
public static void begin(String idTimer) {
if (!measureActive) {
return;
}
init();
if (timers.containsKey(idTimer)) {
if (display) {
System.out.println(
indent(indent)
+ "Warning (start): timer "
+ idTimer
+ " already exists"); //$NON-NLS-1$ //$NON-NLS-2$
}
} else {
indent++;
TimeStack times = new TimeStack();
timers.put(idTimer, times);
if (display) {
System.out.println(
indent(indent) + "Start '" + idTimer + "' ..."); // $NON-NLS-1$ //$NON-NLS-2$
}
}
}
public static void pause(String idTimer) {
if (!measureActive) {
return;
}
init();
if (!timers.containsKey(idTimer)) {
if (display) {
System.out.println(
indent(indent)
+ "Warning (end): timer "
+ idTimer
+ " does'nt exist"); //$NON-NLS-1$ //$NON-NLS-2$
}
return;
} else {
TimeStack time = timers.get(idTimer);
// long time = times.getElapsedTimeSinceLastRequest();
time.pause();
if (display) {
// do nothing... yet
}
}
}
/**
* DOC amaumont Comment method "end".
*
* @param idTimer
* @return total elapsed time since start in ms
*/
public static long end(String idTimer) {
if (!measureActive) {
return 0;
}
init();
if (!timers.containsKey(idTimer)) {
if (display) {
System.out.println(
indent(indent)
+ "Warning (end): timer "
+ idTimer
+ " doesn't exist"); //$NON-NLS-1$ //$NON-NLS-2$
}
return -1;
} else {
TimeStack timeStack = timers.get(idTimer);
timers.remove(idTimer);
long elapsedTimeSinceLastRequest = timeStack.getLastStepElapsedTime();
if (display && displaySteps) {
System.out.println(
indent(indent)
+ "End '"
+ idTimer
+ "', elapsed time since last request: " //$NON-NLS-1$ //$NON-NLS-2$
+ elapsedTimeSinceLastRequest
+ " ms "); //$NON-NLS-1$
}
long totalElapsedTime = timeStack.getTotalElapsedTime();
if (display) {
if (printMemoryUsed) {
// GC must be forced when check memory, or we can't mesure the difference
Runtime.getRuntime().gc();
long usedMemory = Runtime.getRuntime().totalMemory() - Runtime.getRuntime().freeMemory();
System.out.println(
indent(indent)
+ "End '"
+ idTimer
+ "', total elapsed time: "
+ totalElapsedTime
+ " ms, " //$NON-NLS-1$ //$NON-NLS-2$ //$NON-NLS-3$
+ " current memory ["
+ usedMemory
+ "] bytes"); //$NON-NLS-1$ //$NON-NLS-2$
} else {
System.out.println(
indent(indent)
+ "End '"
+ idTimer
+ "', total elapsed time: "
+ totalElapsedTime
+ " ms "); //$NON-NLS-1$ //$NON-NLS-2$ //$NON-NLS-3$
}
}
indent--;
if (isLogToFile && logger != null) {
logger.logToFile(logValue, logFilePath);
logValue.clear();
}
return totalElapsedTime;
}
}
/**
* DOC amaumont Comment method "timeStep".
*
* @param idTimer
* @return elapsed time since previous step in ms
*/
public static long step(String idTimer, String stepName) {
if (!measureActive) {
return 0;
}
init();
if (!timers.containsKey(idTimer)) {
if (display) {
System.out.println(
indent(indent)
+ "Warning (end): timer "
+ idTimer
+ " does'nt exist"); //$NON-NLS-1$ //$NON-NLS-2$
}
return -1;
} else {
TimeStack timeStack = timers.get(idTimer);
timeStack.addStep();
/*
* trace the timeline of every step,problem is that the code below " Calendar ca = Calendar.getInstance();
* Date now = ca.getTime();" will cost almost 13ms~15ms
*/
Calendar ca = Calendar.getInstance();
Date now = ca.getTime();
long time = timeStack.getLastStepElapsedTime();
if (display && displaySteps) {
long usedMemory = 0;
if (printMemoryUsed) {
// GC must be forced when check memory, or we can't mesure the difference
Runtime.getRuntime().gc();
usedMemory = Runtime.getRuntime().totalMemory() - Runtime.getRuntime().freeMemory();
}
String timerStepName = idTimer + "', step name '" + stepName; // $NON-NLS-1$
if (printMemoryUsed) {
System.out.println(
indent(indent)
+ "-> '"
+ timerStepName
+ "', elapsed time since previous step: "
+ time
+ " ms,"
+ //$NON-NLS-1$ //$NON-NLS-2$ //$NON-NLS-3$
" current memory ["
+ usedMemory
+ "] bytes"); //$NON-NLS-1$ //$NON-NLS-2$
} else {
System.out.println(
indent(indent)
+ "-> '"
+ timerStepName
+ "', elapsed time since previous step: "
+ time
+ " ms"); //$NON-NLS-1$ //$NON-NLS-2$ //$NON-NLS-3$
}
if (isLogToFile) {
boolean foundTimerKey = false;
for (String keyTimer : logValue.keySet()) {
if (keyTimer.equals(idTimer)) {
/* rows */
List<Map<Integer, Object>> values = logValue.get(keyTimer);
if (values != null) {
Map<Integer, Object> newRowValue = new HashMap<Integer, Object>();
// step
newRowValue.put(ELogFileColumnConstant.STEP.locationY, timerStepName);
// timeused
newRowValue.put(ELogFileColumnConstant.TIME_USED.locationY, time);
// memory used
if (printMemoryUsed) {
newRowValue.put(ELogFileColumnConstant.MEMO_USED.locationY, usedMemory);
}
// current time
newRowValue.put(ELogFileColumnConstant.TIMETRACE.locationY, now);
values.add(newRowValue);
}
foundTimerKey = true;
break;
}
}
if (!foundTimerKey) {
List<Map<Integer, Object>> newvalues = new ArrayList<Map<Integer, Object>>();
Map<Integer, Object> newRowValue = new HashMap<Integer, Object>();
// step
newRowValue.put(ELogFileColumnConstant.STEP.locationY, timerStepName);
// timeused
newRowValue.put(ELogFileColumnConstant.TIME_USED.locationY, time);
// memory used
if (printMemoryUsed) {
newRowValue.put(ELogFileColumnConstant.MEMO_USED.locationY, usedMemory);
}
// current time
newRowValue.put(ELogFileColumnConstant.TIMETRACE.locationY, now);
newvalues.add(newRowValue);
logValue.put(idTimer, newvalues);
}
}
}
return time;
}
}