private boolean logReturnResult(
boolean result, List<Job> realJobs, List<Job> jobsInUI, Q7WaitInfoRoot info) {
try {
long curTime = System.currentTimeMillis();
if (result) {
lastSuccessTime = curTime;
return result;
}
for (Job job : jobsInUI) {
Q7WaitUtils.updateInfo("job.ui", job.getClass().getName(), info);
}
for (Job job : realJobs) {
Q7WaitUtils.updateInfo("job", job.getClass().getName(), info);
}
if (lastSuccessTime == 0) {
lastSuccessTime = curTime;
return result;
}
if (curTime - lastSuccessTime > TeslaLimits.getJobLoggingTimeout()) {
lastSuccessTime = curTime;
logJobInformation(realJobs, jobsInUI);
}
} catch (Exception e) {
SWTTeslaActivator.log(e);
}
return result;
}
synchronized void printJobTimeoutLogEntry() {
if (!infoPrinted) {
infoPrinted = true;
SWTTeslaActivator.logToReport(
"---->>> Waiting timeout exceed then execute: "
+ getCurrentReportNodeName()
+ " <<---\n(skipping)"
+ getJobMessage(this));
}
}
public void activate() {
try {
Class.forName("org.eclipse.core.resources.ResourcesPlugin");
} catch (ClassNotFoundException e) {
SWTTeslaActivator.log("Unable to create q7-swt-event.log writter", e);
return;
}
File workspaceRoot =
org.eclipse.core.resources.ResourcesPlugin.getWorkspace().getRoot().getLocation().toFile();
File logFile = new File(workspaceRoot, ".metadata/q7-swt-event.log");
try {
writer = new FileWriter(logFile, true);
} catch (IOException e) {
SWTTeslaActivator.log("Unable to create q7-swt-event.log writter", e);
return;
}
active = true;
}
private void write(String line, Object... args) {
try {
writer.append(String.format(line, args));
writer.append('\n');
writer.flush();
} catch (IOException e) {
SWTTeslaActivator.log("Unable to write to q7-swt-event.log", e);
}
// SWTTeslaActivator.info(String.format(line, args));
// System.out.println(String.format(line, args));
}
/**
* Wait untill will not be empty for timeout
*
* @param timeout
* @throws InterruptedException
*/
public void join(long timeout) throws InterruptedException {
SWTTeslaActivator.debugLog("UIJobCollector is going to join");
long startTime = System.currentTimeMillis();
// Context ctx = ContextManagement.currentContext();
while (true) {
removeCanceledJobs();
long delta = System.currentTimeMillis() - startTime;
if (delta > timeout) {
break;
}
if (isJoinEmpty()) {
break;
}
List<Job> jobs2 = getJobs();
for (Job job : jobs2) {
SWTTeslaActivator.debugLog("Waiting for job:" + job.getName() + " " + job.getState());
}
SWTTeslaActivator.debugLog("UIJobCollector is going to join");
Thread.sleep(50);
}
}
public static Event clone(Event other) {
Event result = new Event();
for (Field field : Event.class.getDeclaredFields()) {
if ((field.getModifiers() & Modifier.PUBLIC) != 0) {
try {
field.set(result, field.get(other));
} catch (Exception e) {
SWTTeslaActivator.log(e);
}
}
}
return result;
}
private void logJobInformation(List<Job> realJobs, List<Job> jobsInUI) {
List<Job> otherJobs = new ArrayList<Job>(jobs.keySet());
Set<Job> jobInStepMode = new HashSet<Job>();
for (Job job : otherJobs) {
if (getOrCreateJobInfo(job).jobInStepMode) jobInStepMode.add(job);
}
otherJobs.removeAll(realJobs);
otherJobs.removeAll(jobsInUI);
otherJobs.removeAll(jobInStepMode);
StringBuilder reportMessage = new StringBuilder();
reportMessage
.append("----->>> Waiting for Jobs during execution: ")
.append(getCurrentReportNodeName())
.append(" -----<<<< \n");
if (realJobs.size() > 0) {
reportMessage.append("---> Standalone Jobs:\n");
for (Job job : realJobs) {
reportMessage.append(getJobMessage(job)).append("\n");
}
}
if (jobInStepMode.size() > 0) {
reportMessage.append("---> Jobs in Stepping mode:\n");
for (Job job : jobInStepMode) {
reportMessage.append(getJobMessage(job)).append("\n");
}
}
if (jobsInUI.size() > 0) {
reportMessage.append("---> Jobs doing UI:\n");
for (Job job : jobsInUI) {
reportMessage.append(getJobMessage(job)).append("\n");
}
}
if (otherJobs.size() > 0) {
reportMessage.append("---> Other jobs:\n");
for (Job job : otherJobs) {
reportMessage.append(getJobMessage(job)).append("\n");
}
}
SWTTeslaActivator.logToReport(reportMessage.toString());
}
public boolean isEmpty(Context context, Q7WaitInfoRoot info) {
// Filter already executed UI jobs with async finish status.
List<Job> realJobs = new ArrayList<Job>();
long current = System.currentTimeMillis();
boolean wasInStepMode = false;
List<Job> jobsInUI = new ArrayList<Job>();
synchronized (jobs) {
// Remove all canceled jobs
removeCanceledJobs();
if (jobs.isEmpty()) {
return logReturnResult(true, realJobs, jobsInUI, info);
}
for (JobInfo jobInfo : jobs.values()) {
if (!jobInfo.isActive()) continue;
Job job = jobInfo.job;
IJobCollector[] collectors = JobCollectorExtensions.getDefault().getCollectors();
boolean allowSkip = true;
for (IJobCollector ext : collectors) {
if (ext.noSkipMode(job)) {
allowSkip = false;
break;
}
}
if (allowSkip) {
continue;
}
// SWTTeslaActivator.debugLog("Waiting job:" + job.getName() +
// ": "
// + job.getClass().getName());
long jobStartTime = jobInfo.startingTime;
if (job.getClass().getName().contains("org.eclipse.debug.internal.ui.DebugUIPlugin$")) {
// It looks like background launching job.
Thread thread = job.getThread();
if (thread == null) {
SWTTeslaActivator.logToReport("Active job " + job.getName() + " has no thread");
jobInfo.done(false);
}
Context ctx = ContextManagement.makeContext(thread.getStackTrace());
// If Autobuild job is active and on lock and there is Modal
// Dialog in main thread,
// lets' skip job from important for us.
if (ctx.contains("java.util.concurrent.locks.LockSupport", "park")
|| ctx.contains("java.lang.Object", "wait")) {
// We are waiting some stuff, let's check if main thread
// have a MessageDialog and if so skip this job right
// now.
if (context.contains("org.eclipse.jface.dialogs.MessageDialogWithToggle", "open")
|| context.contains("org.eclipse.jface.dialogs.MessageDialog", "open")) {
// Skip job from processing since it in lock and
// waits for a dialog.
SWTTeslaActivator.logToReport(
"Active job "
+ job.getName()
+ " has skipped since it in lock state and Message dialog are active");
continue;
}
}
}
if (jobInfo.checkForTimeout) {
if (jobStartTime + TeslaLimits.getStepModeEnableTimeout() < current
&& job.getState() == Job.RUNNING
&& stepModeNext < current) {
// Job is sleepping to long time already.
// Check for job are slepping
// String name = job.getClass().getName();
// Locate thread
Thread thread = job.getThread();
if (thread == null) {
SWTTeslaActivator.logToReport("Active job " + job.getName() + " has no thread");
jobInfo.done(false);
}
Context ctx = ContextManagement.makeContext(thread.getStackTrace());
// if (ctx.contains(
// "org.eclipse.jface.operation.ModalContext$ModalContextThread",
// "block")) {
// // Skip model context, since it could
// continue;
// }
if (ctx.contains("java.lang.Thread", "sleep")
|| ctx.contains("java.lang.Object", "wait")
|| ctx.contains("java.util.concurrent.locks.LockSupport", "park")) {
/*
* Job are in Thread.sleep(), lets allow one
* operation.
*/
if (!jobInfo.jobInStepMode) {
// Print step information
SWTTeslaActivator.logToReport(
"---->>> Begin step mode for Job: "
+ getCurrentReportNodeName()
+ " <<---\n(skipping)"
+ getJobMessage(jobInfo));
}
jobInfo.jobInStepMode = true;
wasInStepMode = true;
continue;
}
}
long timeout = TeslaLimits.getJobTimeout();
if (job.belongsTo(getFamilyAutoBuild())) {
timeout = TeslaLimits.getAutoBuildJobTimeout();
}
if (jobInfo.jobInStepMode) {
timeout = TeslaLimits.getStepModeTimeout();
}
if (job.getClass().getName().contains("org.eclipse.debug.internal.ui.DebugUIPlugin")) {
timeout = TeslaLimits.getDebugJobTimeout();
}
if (jobStartTime + timeout < current) {
if (context != null && TeslaEventManager.getManager().isJobInSyncExec(job, context)) {
// Remove from stop waited jobs if called sync
// exec
jobInfo.checkForTimeout = false;
} else {
printJobTimeoutLogEntry(job);
continue;
}
}
}
if (context != null) {
if (isAsyncSupported()) {
// If we are executed from async finished job lets
// filter it
if (JobsManager.getInstance().isFinishedAsyncJob(job)) {
if (context.containsClass(job.getClass().getName())) {
jobsInUI.add(job);
continue;
}
}
}
if (isSyncSupported()) {
// Check for any other job running Display.sleep()
if (context.contains(Display.class.getName(), "sleep")) {
if (TeslaEventManager.getManager().isJobInSyncExec(job, context)) {
// If and only if job is already in synchronizer
Map<Thread, StackTraceElement[]> traces = Thread.getAllStackTraces();
Set<String> names = getSuperClassNames(job);
Thread jobThread = null;
Context jobContext = null;
for (Map.Entry<Thread, StackTraceElement[]> thread : traces.entrySet()) {
Context ctx = ContextManagement.makeContext(thread.getValue());
for (String name : names) {
if (ctx.contains("org.eclipse.core.internal.jobs.Worker", "run")
&& ctx.contains(name, "run")) {
jobThread = thread.getKey();
jobContext = ctx;
}
}
}
if (jobThread != null && jobContext != null) {
if (jobContext.contains("org.eclipse.ui.internal.UISynchronizer", "syncExec")
&& jobContext.contains("org.eclipse.ui.internal.Semaphore", "acquire")) {
if (!SWTUIPlayer.hasRunnables(RWTUtils.findDisplay())) {
// also check what sync exec are on
// current stack trace
List<Context> execs = TeslaEventManager.getManager().getSyncExecs();
boolean toContinue = true;
for (Context context2 : execs) {
StackTraceElement[] stackTrace = context2.getStackTrace();
String className = null;
for (int i = 0; i < stackTrace.length; i++) {
if (stackTrace[i].getClassName().equals("org.eclipse.swt.widgets.Display")
&& stackTrace[i].getMethodName().equals("syncExec")) {
className = stackTrace[i + 1].getClassName();
break;
}
}
if (!context.containsClass(className)) {
toContinue = false;
}
}
if (toContinue) {
jobsInUI.add(job);
continue;
}
}
}
}
}
}
}
}
if (jobInfo.isActive()) realJobs.add(job);
}
}
if (!jobsInUI.isEmpty()) {
if (realJobs.size() == 1 && realJobs.get(0).belongsTo(getFamilyAutoBuild())) {
realJobs.clear();
}
}
if (realJobs.size() == 1) {
Job job = realJobs.iterator().next();
if (job.belongsTo(getFamilyAutoBuild())) {
// Check for modal dialogs are visible
int flags = TeslaSWTAccess.getJobFlags(job);
// Job is alone and blocked
if ((flags & 0xFF) == 0x08) {
return logReturnResult(true, realJobs, jobsInUI, info);
}
final Display display = RWTUtils.findDisplay();
final boolean value[] = {false};
display.syncExec(
new Runnable() {
public void run() {
Shell[] shells = display.getShells();
for (Shell shell : shells) {
if (isModal(shell)) {
value[0] = true;
}
}
}
});
if (value[0]) {
return logReturnResult(true, realJobs, jobsInUI, info);
}
if (job.getState() != Job.NONE) {
return logReturnResult(false, realJobs, jobsInUI, info);
}
return logReturnResult(true, realJobs, jobsInUI, info);
}
}
if (wasInStepMode && realJobs.isEmpty()) {
stepModeNext = current + TeslaLimits.getStepModeStepTime();
}
return logReturnResult(realJobs.isEmpty(), realJobs, jobsInUI, info);
}