RE: [aspectj-users] Overall problem with AJDT performance

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index] [List Home]
RE: [aspectj-users] Overall problem with AJDT performance
From: Thomas Hofmann <email@xxxxxxxxxxxxxxxxx>
Date: Sat, 10 Oct 2009 21:57:16 +0200
Accept-language: en-US, de-DE
Acceptlanguage: en-US, de-DE
Delivered-to: aspectj-users@xxxxxxxxxxx
List-archive: <https://dev.eclipse.org/mailman/private/aspectj-users>
List-help: <mailto:aspectj-users-request@eclipse.org?subject=help>
List-subscribe: <https://dev.eclipse.org/mailman/listinfo/aspectj-users>, <mailto:aspectj-users-request@eclipse.org?subject=subscribe>
List-unsubscribe: <https://dev.eclipse.org/mailman/listinfo/aspectj-users>, <mailto:aspectj-users-request@eclipse.org?subject=unsubscribe>
Thread-index: AcpJw2HQdKBxC5tCRIe6lcopMK4T/gAEP2vwAAPBkUA=
Thread-topic: [aspectj-users] Overall problem with AJDT performance
Hi again,

with Xlint tunred off on all projects and zip3 I'm now down to 6:18 minutes! What a change...


Heres the AJDT trace:

21:44:34 Startup information:
   AJDT version: 2.0.1.e35x-20091001-1600 for Eclipse 3.5
   AspectJ Compiler version: 1.6.6
   usingVisualiser=true
   usingXref=true
   usingCUprovider=true
   promptForAutoOpenCrossReference = false
   org.eclipse.ajdt.internal.ui.tracing.checked.filters = set: Compiler,Builder
   ajde.version.at.previous.startup = @AJDEVERSION@
21:46:59 Compiler configuration for project com.dcx.ivkmds.fwk.common.spec.trace.aspectj doesn't know previous state, so assuming EVERYTHING has changed.
21:47:0 ===========================================================================================
21:47:0 Build kind = FULLBUILD
21:47:0 Project=com.dcx.ivkmds.fwk.common.spec.trace.aspectj, kind of build requested=Full AspectJ compilation
21:47:0 Timer event: 25ms: Flush included source file cache
21:47:0 Timer event: 0ms: Check delta
21:47:0 Builder: Tidied output folder(s), removed class files and derived resources
21:47:0 Timer event: 426ms: Pre compile
21:47:0 Compiler configuration for project com.dcx.ivkmds.fwk.common.spec.trace.aspectj has been read by compiler.  Resetting.
21:47:0      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]

21:47:0 Resetting list of modified source files.  Was null
21:47:0 Preparing for build: not going to be incremental because no successful previous full build
21:47:1 Timer event: 836ms: Time to first compiled message
21:47:1 Timer event: 847ms: Time to first woven message
21:47:1 AspectJ reports build successful, build was: FULL
21:47:1 AJDE Callback: finish. Was full build: true
21:47:1 Timer event: 822ms: Total time spent in AJDE
21:47:1 Timer event: 0ms: Refresh after build
21:47:1 Types affected during build = 2
21:47:1 Timer event: 1583ms: Total time spent in AJBuilder.build()
21:47:1 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.fwk.common.spec.trace.aspectj
21:47:13 Compiler configuration for project com.dcx.ivkmds.fwk.common.ass.persist doesn't know previous state, so assuming EVERYTHING has changed.
21:47:13 ===========================================================================================
21:47:13 Build kind = FULLBUILD
21:47:13 Project=com.dcx.ivkmds.fwk.common.ass.persist, kind of build requested=Full AspectJ compilation
21:47:13 Timer event: 0ms: Flush included source file cache
21:47:13 Timer event: 0ms: Check delta
21:47:13 Builder: Tidied output folder(s), removed class files and derived resources
21:47:14 Timer event: 52ms: Pre compile
21:47:14 Compiler configuration for project com.dcx.ivkmds.fwk.common.ass.persist has been read by compiler.  Resetting.
21:47:14      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:47:14 Resetting list of modified source files.  Was null
21:47:14 Preparing for build: not going to be incremental because no successful previous full build
21:47:14 Timer event: 700ms: Time to first compiled message
21:47:14 Timer event: 815ms: Time to first woven message
21:47:15 AspectJ reports build successful, build was: FULL
21:47:15 AJDE Callback: finish. Was full build: true
21:47:15 Timer event: 1761ms: Total time spent in AJDE
21:47:15 Timer event: 0ms: Refresh after build
21:47:15 Types affected during build = 47
21:47:15 Timer event: 1823ms: Total time spent in AJBuilder.build()
21:47:15 Compiler configuration for project com.dcx.ivkmds.fwk.common.businessobjects.persistent doesn't know previous state, so assuming EVERYTHING has changed.
21:47:15 ===========================================================================================
21:47:15 Build kind = FULLBUILD
21:47:15 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.fwk.common.ass.persist
21:47:15 Project=com.dcx.ivkmds.fwk.common.businessobjects.persistent, kind of build requested=Full AspectJ compilation
21:47:15 Timer event: 0ms: Flush included source file cache
21:47:15 Timer event: 0ms: Check delta
21:47:15 Builder: Tidied output folder(s), removed class files and derived resources
21:47:15 Timer event: 110ms: Pre compile
21:47:16 Compiler configuration for project com.dcx.ivkmds.fwk.common.businessobjects.persistent has been read by compiler.  Resetting.
21:47:16      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:47:16 Resetting list of modified source files.  Was null
21:47:16 Preparing for build: not going to be incremental because no successful previous full build
21:47:16 Timer event: 176ms: Time to first compiled message
21:47:16 Timer event: 180ms: Time to first woven message
21:47:16 AspectJ reports build successful, build was: FULL
21:47:16 AJDE Callback: finish. Was full build: true
21:47:16 Timer event: 261ms: Total time spent in AJDE
21:47:16 Timer event: 0ms: Refresh after build
21:47:16 Types affected during build = 6
21:47:16 Timer event: 374ms: Total time spent in AJBuilder.build()
21:47:16 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.fwk.common.businessobjects.persistent
21:47:17 Compiler configuration for project com.dcx.ivkmds.fwk.rcs doesn't know previous state, so assuming EVERYTHING has changed.
21:47:17 ===========================================================================================
21:47:17 Build kind = FULLBUILD
21:47:17 Project=com.dcx.ivkmds.fwk.rcs, kind of build requested=Full AspectJ compilation
21:47:17 Timer event: 0ms: Flush included source file cache
21:47:17 Timer event: 0ms: Check delta
21:47:17 Builder: Tidied output folder(s), removed class files and derived resources
21:47:17 Timer event: 101ms: Pre compile
21:47:17 Compiler configuration for project com.dcx.ivkmds.fwk.rcs has been read by compiler.  Resetting.
21:47:17      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:47:17 Resetting list of modified source files.  Was null
21:47:17 Preparing for build: not going to be incremental because no successful previous full build
21:47:18 Timer event: 871ms: Time to first compiled message
21:47:18 Timer event: 904ms: Time to first woven message
21:47:22 AspectJ reports build successful, build was: FULL
21:47:22 AJDE Callback: finish. Was full build: true
21:47:22 Timer event: 4711ms: Total time spent in AJDE
21:47:22 Timer event: 0ms: Refresh after build
21:47:22 Types affected during build = 87
21:47:22 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.fwk.rcs
21:47:22 Timer event: 4857ms: Total time spent in AJBuilder.build()
21:47:22 Compiler configuration for project com.dcx.ivkmds.csolver.cts doesn't know previous state, so assuming EVERYTHING has changed.
21:47:22 ===========================================================================================
21:47:22 Build kind = FULLBUILD
21:47:22 Project=com.dcx.ivkmds.csolver.cts, kind of build requested=Full AspectJ compilation
21:47:22 Timer event: 0ms: Flush included source file cache
21:47:22 Timer event: 0ms: Check delta
21:47:22 Builder: Tidied output folder(s), removed class files and derived resources
21:47:22 Timer event: 259ms: Pre compile
21:47:22 Compiler configuration for project com.dcx.ivkmds.csolver.cts has been read by compiler.  Resetting.
21:47:22      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:47:22 Resetting list of modified source files.  Was null
21:47:22 Preparing for build: not going to be incremental because no successful previous full build
21:47:25 Timer event: 2710ms: Time to first compiled message
21:47:25 Timer event: 2813ms: Time to first woven message
21:47:49 AspectJ reports build successful, build was: FULL
21:47:49 AJDE Callback: finish. Was full build: true
21:47:49 Timer event: 27166ms: Total time spent in AJDE
21:47:49 Timer event: 0ms: Refresh after build
21:47:49 Types affected during build = 343
21:47:49 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.csolver.cts
21:47:49 Timer event: 27547ms: Total time spent in AJBuilder.build()
21:47:52 Compiler configuration for project com.dcx.ivkmds.common.businessobjects.persistent doesn't know previous state, so assuming EVERYTHING has changed.
21:47:52 ===========================================================================================
21:47:52 Build kind = FULLBUILD
21:47:52 Project=com.dcx.ivkmds.common.businessobjects.persistent, kind of build requested=Full AspectJ compilation
21:47:52 Timer event: 0ms: Flush included source file cache
21:47:52 Timer event: 0ms: Check delta
21:47:52 Builder: Tidied output folder(s), removed class files and derived resources
21:47:54 Timer event: 2069ms: Pre compile
21:47:54 Compiler configuration for project com.dcx.ivkmds.common.businessobjects.persistent has been read by compiler.  Resetting.
21:47:54      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:47:54 Resetting list of modified source files.  Was null
21:47:54 Preparing for build: not going to be incremental because no successful previous full build
21:47:55 Timer event: 1625ms: Time to first compiled message
21:47:55 Timer event: 1629ms: Time to first woven message
21:48:3 AspectJ reports build successful, build was: FULL
21:48:5 AJDE Callback: finish. Was full build: true
21:48:5 Timer event: 11514ms: Total time spent in AJDE
21:48:5 Timer event: 0ms: Refresh after build
21:48:5 Types affected during build = 326
21:48:5 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.common.businessobjects.persistent
21:48:5 Timer event: 13795ms: Total time spent in AJBuilder.build()
21:48:7 Compiler configuration for project com.dcx.ivkmds.common.businessobjects.fwktest doesn't know previous state, so assuming EVERYTHING has changed.
21:48:7 ===========================================================================================
21:48:7 Build kind = FULLBUILD
21:48:7 Project=com.dcx.ivkmds.common.businessobjects.fwktest, kind of build requested=Full AspectJ compilation
21:48:7 Timer event: 0ms: Flush included source file cache
21:48:7 Timer event: 0ms: Check delta
21:48:7 Builder: Tidied output folder(s), removed class files and derived resources
21:48:7 Timer event: 267ms: Pre compile
21:48:7 Compiler configuration for project com.dcx.ivkmds.common.businessobjects.fwktest has been read by compiler.  Resetting.
21:48:7      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]

21:48:7 Resetting list of modified source files.  Was null
21:48:7 Preparing for build: not going to be incremental because no successful previous full build
21:48:8 Timer event: 456ms: Time to first compiled message
21:48:8 Timer event: 474ms: Time to first woven message
21:48:11 AspectJ reports build successful, build was: FULL
21:48:11 AJDE Callback: finish. Was full build: true
21:48:11 Timer event: 3639ms: Total time spent in AJDE
21:48:11 Timer event: 0ms: Refresh after build
21:48:11 Types affected during build = 32
21:48:11 Timer event: 3930ms: Total time spent in AJBuilder.build()
21:48:11 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.common.businessobjects.fwktest
21:49:9 Compiler configuration for project com.dcx.ivkmds.fwk.ass doesn't know previous state, so assuming EVERYTHING has changed.
21:49:9 ===========================================================================================
21:49:9 Build kind = FULLBUILD
21:49:9 Project=com.dcx.ivkmds.fwk.ass, kind of build requested=Full AspectJ compilation
21:49:9 Timer event: 0ms: Flush included source file cache
21:49:9 Timer event: 0ms: Check delta
21:49:9 Builder: Tidied output folder(s), removed class files and derived resources
21:49:10 Timer event: 193ms: Pre compile
21:49:10 Compiler configuration for project com.dcx.ivkmds.fwk.ass has been read by compiler.  Resetting.
21:49:10      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:49:10 Resetting list of modified source files.  Was null
21:49:10 Preparing for build: not going to be incremental because no successful previous full build
21:49:12 Timer event: 2459ms: Time to first compiled message
21:49:12 Timer event: 2647ms: Time to first woven message
21:49:18 AspectJ reports build successful, build was: FULL
21:49:18 AJDE Callback: finish. Was full build: true
21:49:18 Timer event: 8588ms: Total time spent in AJDE
21:49:18 Timer event: 0ms: Refresh after build
21:49:18 Types affected during build = 117
21:49:18 Timer event: 8796ms: Total time spent in AJBuilder.build()
21:49:18 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.fwk.ass
21:49:19 Compiler configuration for project com.dcx.ivkmds.application.ass doesn't know previous state, so assuming EVERYTHING has changed.
21:49:19 ===========================================================================================
21:49:19 Build kind = FULLBUILD
21:49:19 Project=com.dcx.ivkmds.application.ass, kind of build requested=Full AspectJ compilation
21:49:19 Timer event: 0ms: Flush included source file cache
21:49:19 Timer event: 0ms: Check delta
21:49:19 Builder: Tidied output folder(s), removed class files and derived resources
21:49:20 Timer event: 1191ms: Pre compile
21:49:21 Compiler configuration for project com.dcx.ivkmds.application.ass has been read by compiler.  Resetting.
21:49:21      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:49:21 Resetting list of modified source files.  Was null
21:49:21 Preparing for build: not going to be incremental because no successful previous full build
21:49:24 Timer event: 3997ms: Time to first compiled message
21:49:25 Timer event: 4035ms: Time to first woven message
21:49:51 AspectJ reports build successful, build was: FULL
21:49:52 AJDE Callback: finish. Was full build: true
21:49:52 Timer event: 31460ms: Total time spent in AJDE
21:49:52 Timer event: 0ms: Refresh after build
21:49:52 Types affected during build = 292
21:49:52 Timer event: 32697ms: Total time spent in AJBuilder.build()
21:49:52 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.application.ass
21:49:52 Compiler configuration for project com.dcx.ivkmds.csolver.ass doesn't know previous state, so assuming EVERYTHING has changed.
21:49:52 ===========================================================================================
21:49:52 Build kind = FULLBUILD
21:49:52 Project=com.dcx.ivkmds.csolver.ass, kind of build requested=Full AspectJ compilation
21:49:52 Timer event: 0ms: Flush included source file cache
21:49:52 Timer event: 0ms: Check delta
21:49:52 Builder: Tidied output folder(s), removed class files and derived resources
21:49:53 Timer event: 520ms: Pre compile
21:49:53 Compiler configuration for project com.dcx.ivkmds.csolver.ass has been read by compiler.  Resetting.
21:49:53      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:49:53 Resetting list of modified source files.  Was null
21:49:53 Preparing for build: not going to be incremental because no successful previous full build
21:49:56 Timer event: 3001ms: Time to first compiled message
21:49:56 Timer event: 3146ms: Time to first woven message
21:50:15 AspectJ reports build successful, build was: FULL
21:50:16 AJDE Callback: finish. Was full build: true
21:50:16 Timer event: 22950ms: Total time spent in AJDE
21:50:16 Timer event: 0ms: Refresh after build
21:50:16 Types affected during build = 83
21:50:16 Timer event: 23483ms: Total time spent in AJBuilder.build()
21:50:16 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.csolver.ass
21:50:27 Compiler configuration for project com.dcx.ivkmds._45_export_import.ass doesn't know previous state, so assuming EVERYTHING has changed.
21:50:27 ===========================================================================================
21:50:27 Build kind = FULLBUILD
21:50:27 Project=com.dcx.ivkmds._45_export_import.ass, kind of build requested=Full AspectJ compilation
21:50:27 Timer event: 0ms: Flush included source file cache
21:50:27 Timer event: 0ms: Check delta
21:50:27 Builder: Tidied output folder(s), removed class files and derived resources
21:50:28 Timer event: 324ms: Pre compile
21:50:28 Compiler configuration for project com.dcx.ivkmds._45_export_import.ass has been read by compiler.  Resetting.
21:50:28      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:50:28 Resetting list of modified source files.  Was null
21:50:28 Preparing for build: not going to be incremental because no successful previous full build
21:50:35 Timer event: 7859ms: Time to first compiled message
21:50:35 Timer event: 7883ms: Time to first woven message
21:51:3 AspectJ reports build successful, build was: FULL
21:51:3 AJDE Callback: finish. Was full build: true
21:51:3 Timer event: 35654ms: Total time spent in AJDE
21:51:3 Timer event: 0ms: Refresh after build
21:51:3 Types affected during build = 425
21:51:3 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds._45_export_import.ass
21:51:3 Timer event: 36069ms: Total time spent in AJBuilder.build()
21:51:13 Compiler configuration for project com.dcx.ivkmds._00_fwktest.ass doesn't know previous state, so assuming EVERYTHING has changed.
21:51:13 ===========================================================================================
21:51:13 Build kind = FULLBUILD
21:51:13 Project=com.dcx.ivkmds._00_fwktest.ass, kind of build requested=Full AspectJ compilation
21:51:13 Timer event: 0ms: Flush included source file cache
21:51:13 Timer event: 0ms: Check delta
21:51:13 Builder: Tidied output folder(s), removed class files and derived resources
21:51:13 Timer event: 170ms: Pre compile
21:51:13 Compiler configuration for project com.dcx.ivkmds._00_fwktest.ass has been read by compiler.  Resetting.
21:51:13      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:51:13 Resetting list of modified source files.  Was null
21:51:13 Preparing for build: not going to be incremental because no successful previous full build
21:51:14 Timer event: 444ms: Time to first compiled message
21:51:14 Timer event: 554ms: Time to first woven message
21:51:14 AspectJ reports build successful, build was: FULL
21:51:14 AJDE Callback: finish. Was full build: true
21:51:14 Timer event: 1208ms: Total time spent in AJDE
21:51:14 Timer event: 0ms: Refresh after build
21:51:14 Types affected during build = 4
21:51:14 Timer event: 1382ms: Total time spent in AJBuilder.build()
21:51:14 Compiler configuration for project com.dcx.ivkmds.csolver.cts.standalone doesn't know previous state, so assuming EVERYTHING has changed.
21:51:14 ===========================================================================================
21:51:14 Build kind = FULLBUILD
21:51:14 Project=com.dcx.ivkmds.csolver.cts.standalone, kind of build requested=Full AspectJ compilation
21:51:14 Timer event: 0ms: Flush included source file cache
21:51:14 Timer event: 0ms: Check delta
21:51:14 Builder: Tidied output folder(s), removed class files and derived resources
21:51:15 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds._00_fwktest.ass
21:51:15 Timer event: 275ms: Pre compile
21:51:15 Compiler configuration for project com.dcx.ivkmds.csolver.cts.standalone has been read by compiler.  Resetting.
21:51:15      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:51:15 Resetting list of modified source files.  Was null
21:51:15 Preparing for build: not going to be incremental because no successful previous full build
21:51:15 Timer event: 693ms: Time to first compiled message
21:51:15 Timer event: 709ms: Time to first woven message
21:51:16 AspectJ reports build successful, build was: FULL
21:51:16 AJDE Callback: finish. Was full build: true
21:51:16 Timer event: 1672ms: Total time spent in AJDE
21:51:16 Timer event: 0ms: Refresh after build
21:51:16 Types affected during build = 17
21:51:16 Timer event: 1954ms: Total time spent in AJBuilder.build()
21:51:16 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.csolver.cts.standalone
21:51:17 Compiler configuration for project com.dcx.ivkmds.application.rcs.standalone doesn't know previous state, so assuming EVERYTHING has changed.
21:51:17 ===========================================================================================
21:51:17 Build kind = FULLBUILD
21:51:17 Project=com.dcx.ivkmds.application.rcs.standalone, kind of build requested=Full AspectJ compilation
21:51:17 Timer event: 0ms: Flush included source file cache
21:51:17 Timer event: 0ms: Check delta
21:51:17 Builder: Tidied output folder(s), removed class files and derived resources
21:51:17 Timer event: 193ms: Pre compile
21:51:17 Compiler configuration for project com.dcx.ivkmds.application.rcs.standalone has been read by compiler.  Resetting.
21:51:17      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:51:17 Resetting list of modified source files.  Was null
21:51:17 Preparing for build: not going to be incremental because no successful previous full build
21:51:18 Timer event: 692ms: Time to first compiled message
21:51:18 Timer event: 694ms: Time to first woven message
21:51:18 AspectJ reports build successful, build was: FULL
21:51:18 AJDE Callback: finish. Was full build: true
21:51:18 Timer event: 1115ms: Total time spent in AJDE
21:51:18 Timer event: 0ms: Refresh after build
21:51:18 Types affected during build = 9
21:51:18 Timer event: 1320ms: Total time spent in AJBuilder.build()
21:51:18 Compiler configuration for project com.dcx.ivkmds.testfwk doesn't know previous state, so assuming EVERYTHING has changed.
21:51:18 ===========================================================================================
21:51:18 Build kind = FULLBUILD
21:51:18 Project=com.dcx.ivkmds.testfwk, kind of build requested=Full AspectJ compilation
21:51:18 Timer event: 0ms: Flush included source file cache
21:51:18 Timer event: 0ms: Check delta
21:51:18 Builder: Tidied output folder(s), removed class files and derived resources
21:51:18 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.application.rcs.standalone
21:51:19 Timer event: 958ms: Pre compile
21:51:19 Compiler configuration for project com.dcx.ivkmds.testfwk has been read by compiler.  Resetting.
21:51:19      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:51:19 Resetting list of modified source files.  Was null
21:51:19 Preparing for build: not going to be incremental because no successful previous full build
21:51:23 Timer event: 3992ms: Time to first compiled message
21:51:23 Timer event: 4140ms: Time to first woven message
21:51:25 AspectJ reports build successful, build was: FULL
21:51:25 AJDE Callback: finish. Was full build: true
21:51:25 Timer event: 6233ms: Total time spent in AJDE
21:51:25 Timer event: 0ms: Refresh after build
21:51:25 Types affected during build = 45
21:51:25 Timer event: 7220ms: Total time spent in AJBuilder.build()
21:51:25 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.testfwk
21:51:25 Compiler configuration for project com.dcx.ivkmds.fwk.test.ass doesn't know previous state, so assuming EVERYTHING has changed.
21:51:25 ===========================================================================================
21:51:25 Build kind = FULLBUILD
21:51:25 Project=com.dcx.ivkmds.fwk.test.ass, kind of build requested=Full AspectJ compilation
21:51:25 Timer event: 0ms: Flush included source file cache
21:51:25 Timer event: 0ms: Check delta
21:51:25 Builder: Tidied output folder(s), removed class files and derived resources
21:51:26 Timer event: 171ms: Pre compile
21:51:26 Compiler configuration for project com.dcx.ivkmds.fwk.test.ass has been read by compiler.  Resetting.
21:51:26      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:51:26 Resetting list of modified source files.  Was null
21:51:26 Preparing for build: not going to be incremental because no successful previous full build
21:51:26 Timer event: 778ms: Time to first compiled message
21:51:27 Timer event: 997ms: Time to first woven message
21:51:37 AspectJ reports build successful, build was: FULL
21:51:37 AJDE Callback: finish. Was full build: true
21:51:37 Timer event: 11048ms: Total time spent in AJDE
21:51:37 Timer event: 0ms: Refresh after build
21:51:37 Types affected during build = 24
21:51:37 Timer event: 11242ms: Total time spent in AJBuilder.build()
21:51:37 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.fwk.test.ass
21:51:37 Compiler configuration for project com.dcx.ivkmds.fwk.test.rcs doesn't know previous state, so assuming EVERYTHING has changed.
21:51:37 ===========================================================================================
21:51:37 Build kind = FULLBUILD
21:51:37 Project=com.dcx.ivkmds.fwk.test.rcs, kind of build requested=Full AspectJ compilation
21:51:37 Timer event: 0ms: Flush included source file cache
21:51:37 Timer event: 1ms: Check delta
21:51:37 Builder: Tidied output folder(s), removed class files and derived resources
21:51:37 Timer event: 150ms: Pre compile
21:51:37 Compiler configuration for project com.dcx.ivkmds.fwk.test.rcs has been read by compiler.  Resetting.
21:51:37      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:51:37 Resetting list of modified source files.  Was null
21:51:37 Preparing for build: not going to be incremental because no successful previous full build
21:51:37 Timer event: 462ms: Time to first compiled message
21:51:37 Timer event: 494ms: Time to first woven message
21:51:38 AspectJ reports build successful, build was: FULL
21:51:38 AJDE Callback: finish. Was full build: true
21:51:38 Timer event: 1352ms: Total time spent in AJDE
21:51:38 Timer event: 0ms: Refresh after build
21:51:38 Types affected during build = 4
21:51:38 Timer event: 1510ms: Total time spent in AJBuilder.build()
21:51:38 Compiler configuration for project com.dcx.ivkmds.fwk.test.common doesn't know previous state, so assuming EVERYTHING has changed.
21:51:38 ===========================================================================================
21:51:38 Build kind = FULLBUILD
21:51:38 Project=com.dcx.ivkmds.fwk.test.common, kind of build requested=Full AspectJ compilation
21:51:38 Timer event: 0ms: Flush included source file cache
21:51:38 Timer event: 0ms: Check delta
21:51:38 Builder: Tidied output folder(s), removed class files and derived resources
21:51:38 Timer event: 107ms: Pre compile
21:51:38 Compiler configuration for project com.dcx.ivkmds.fwk.test.common has been read by compiler.  Resetting.
21:51:38      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:51:38 Resetting list of modified source files.  Was null
21:51:38 Preparing for build: not going to be incremental because no successful previous full build
21:51:38 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.fwk.test.rcs
21:51:39 Timer event: 315ms: Time to first compiled message
21:51:39 Timer event: 316ms: Time to first woven message
21:51:39 AspectJ reports build successful, build was: FULL
21:51:39 AJDE Callback: finish. Was full build: true
21:51:39 Timer event: 404ms: Total time spent in AJDE
21:51:39 Timer event: 0ms: Refresh after build
21:51:39 Types affected during build = 2
21:51:39 Timer event: 517ms: Total time spent in AJBuilder.build()
21:51:39 Compiler configuration for project com.dcx.ivkmds.csolver.test.cts doesn't know previous state, so assuming EVERYTHING has changed.
21:51:39 ===========================================================================================
21:51:39 Build kind = FULLBUILD
21:51:39 Project=com.dcx.ivkmds.csolver.test.cts, kind of build requested=Full AspectJ compilation
21:51:39 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.fwk.test.common
21:51:39 Timer event: 0ms: Flush included source file cache
21:51:39 Timer event: 0ms: Check delta
21:51:39 Builder: Tidied output folder(s), removed class files and derived resources
21:51:39 Timer event: 246ms: Pre compile
21:51:39 Compiler configuration for project com.dcx.ivkmds.csolver.test.cts has been read by compiler.  Resetting.
21:51:39      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:51:39 Resetting list of modified source files.  Was null
21:51:39 Preparing for build: not going to be incremental because no successful previous full build
21:51:40 Timer event: 709ms: Time to first compiled message
21:51:40 Timer event: 737ms: Time to first woven message
21:51:40 AspectJ reports build successful, build was: FULL
21:51:41 AJDE Callback: finish. Was full build: true
21:51:41 Timer event: 1563ms: Total time spent in AJDE
21:51:41 Timer event: 0ms: Refresh after build
21:51:41 Types affected during build = 12
21:51:41 Timer event: 1817ms: Total time spent in AJBuilder.build()
21:51:41 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.csolver.test.cts
21:51:41 Compiler configuration for project com.dcx.ivkmds.application.test.ass doesn't know previous state, so assuming EVERYTHING has changed.
21:51:41 ===========================================================================================
21:51:41 Build kind = FULLBUILD
21:51:41 Project=com.dcx.ivkmds.application.test.ass, kind of build requested=Full AspectJ compilation
21:51:41 Timer event: 0ms: Flush included source file cache
21:51:41 Timer event: 0ms: Check delta
21:51:41 Builder: Tidied output folder(s), removed class files and derived resources
21:51:42 Timer event: 986ms: Pre compile
21:51:42 Compiler configuration for project com.dcx.ivkmds.application.test.ass has been read by compiler.  Resetting.
21:51:42      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:51:42 Resetting list of modified source files.  Was null
21:51:42 Preparing for build: not going to be incremental because no successful previous full build
21:51:45 Timer event: 3285ms: Time to first compiled message
21:51:45 Timer event: 3348ms: Time to first woven message
21:51:56 AspectJ reports build successful, build was: FULL
21:51:57 AJDE Callback: finish. Was full build: true
21:51:57 Timer event: 14977ms: Total time spent in AJDE
21:51:57 Timer event: 1ms: Refresh after build
21:51:57 Types affected during build = 152
21:51:57 Timer event: 16369ms: Total time spent in AJBuilder.build()
21:51:57 Compiler configuration for project com.dcx.ivkmds.csolver.test.ass doesn't know previous state, so assuming EVERYTHING has changed.
21:51:57 ===========================================================================================
21:51:57 Build kind = FULLBUILD
21:51:57 Project=com.dcx.ivkmds.csolver.test.ass, kind of build requested=Full AspectJ compilation
21:51:57 Timer event: 0ms: Flush included source file cache
21:51:57 Timer event: 0ms: Check delta
21:51:57 Builder: Tidied output folder(s), removed class files and derived resources
21:51:57 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.application.test.ass
21:51:57 Timer event: 197ms: Pre compile
21:51:57 Compiler configuration for project com.dcx.ivkmds.csolver.test.ass has been read by compiler.  Resetting.
21:51:57      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]
21:51:57 Resetting list of modified source files.  Was null
21:51:57 Preparing for build: not going to be incremental because no successful previous full build
21:51:59 Timer event: 1397ms: Time to first compiled message
21:51:59 Timer event: 1587ms: Time to first woven message
21:52:4 AspectJ reports build successful, build was: FULL
21:52:4 AJDE Callback: finish. Was full build: true
21:52:4 Timer event: 7233ms: Total time spent in AJDE
21:52:4 Timer event: 0ms: Refresh after build
21:52:4 Types affected during build = 31
21:52:4 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.csolver.test.ass
21:52:4 Timer event: 7508ms: Total time spent in AJBuilder.build()
21:52:5 Compiler configuration for project com.dcx.ivkmds.application.test.rcs.standalone doesn't know previous state, so assuming EVERYTHING has changed.
21:52:5 ===========================================================================================
21:52:5 Build kind = FULLBUILD
21:52:5 Project=com.dcx.ivkmds.application.test.rcs.standalone, kind of build requested=Full AspectJ compilation
21:52:5 Timer event: 0ms: Flush included source file cache
21:52:5 Timer event: 0ms: Check delta
21:52:5 Builder: Tidied output folder(s), removed class files and derived resources
21:52:5 Timer event: 93ms: Pre compile
21:52:5 Compiler configuration for project com.dcx.ivkmds.application.test.rcs.standalone has been read by compiler.  Resetting.
21:52:5      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]

21:52:5 Resetting list of modified source files.  Was null
21:52:5 Preparing for build: not going to be incremental because no successful previous full build
21:52:5 Timer event: 352ms: Time to first compiled message
21:52:5 AspectJ reports build successful, build was: FULL
21:52:5 AJDE Callback: finish. Was full build: true
21:52:5 Timer event: 379ms: Total time spent in AJDE
21:52:5 Timer event: 0ms: Refresh after build
21:52:5 Types affected during build = 1
21:52:5 Timer event: 485ms: Total time spent in AJBuilder.build()
21:52:5 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.application.test.rcs.standalone
21:52:5 Compiler configuration for project com.dcx.ivkmds.application.test.common doesn't know previous state, so assuming EVERYTHING has changed.
21:52:5 ===========================================================================================
21:52:5 Build kind = FULLBUILD
21:52:5 Project=com.dcx.ivkmds.application.test.common, kind of build requested=Full AspectJ compilation
21:52:5 Timer event: 0ms: Flush included source file cache
21:52:5 Timer event: 0ms: Check delta
21:52:5 Builder: Tidied output folder(s), removed class files and derived resources
21:52:5 Timer event: 97ms: Pre compile
21:52:5 Compiler configuration for project com.dcx.ivkmds.application.test.common has been read by compiler.  Resetting.
21:52:5      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]

21:52:5 Resetting list of modified source files.  Was null
21:52:5 Preparing for build: not going to be incremental because no successful previous full build
21:52:6 Timer event: 406ms: Time to first compiled message
21:52:6 Timer event: 415ms: Time to first woven message
21:52:6 AspectJ reports build successful, build was: FULL
21:52:6 AJDE Callback: finish. Was full build: true
21:52:6 Timer event: 444ms: Total time spent in AJDE
21:52:6 Timer event: 0ms: Refresh after build
21:52:6 Types affected during build = 1
21:52:6 Timer event: 552ms: Total time spent in AJBuilder.build()
21:52:6 Compiler configuration for project com.dcx.ivkmds._55_archive.test.ass doesn't know previous state, so assuming EVERYTHING has changed.
21:52:6 ===========================================================================================
21:52:6 Build kind = FULLBUILD
21:52:6 Project=com.dcx.ivkmds._55_archive.test.ass, kind of build requested=Full AspectJ compilation
21:52:6 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds.application.test.common
21:52:6 Timer event: 0ms: Flush included source file cache
21:52:6 Timer event: 0ms: Check delta
21:52:6 Builder: Tidied output folder(s), removed class files and derived resources
21:52:6 Timer event: 108ms: Pre compile
21:52:6 Compiler configuration for project com.dcx.ivkmds._55_archive.test.ass has been read by compiler.  Resetting.
21:52:6      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]

21:52:6 Resetting list of modified source files.  Was null
21:52:6 Preparing for build: not going to be incremental because no successful previous full build
21:52:6 Timer event: 460ms: Time to first compiled message
21:52:6 Timer event: 483ms: Time to first woven message
21:52:6 AspectJ reports build successful, build was: FULL
21:52:6 AJDE Callback: finish. Was full build: true
21:52:6 Timer event: 619ms: Total time spent in AJDE
21:52:6 Timer event: 0ms: Refresh after build
21:52:6 Types affected during build = 2
21:52:6 Timer event: 740ms: Total time spent in AJBuilder.build()
21:52:6 Compiler configuration for project com.dcx.ivkmds._50_reports.test.ass doesn't know previous state, so assuming EVERYTHING has changed.
21:52:6 ===========================================================================================
21:52:6 Build kind = FULLBUILD
21:52:6 Project=com.dcx.ivkmds._50_reports.test.ass, kind of build requested=Full AspectJ compilation
21:52:6 Timer event: 0ms: Flush included source file cache
21:52:6 Timer event: 0ms: Check delta
21:52:6 Builder: Tidied output folder(s), removed class files and derived resources
21:52:7 Timer event: 251ms: Pre compile
21:52:7 Compiler configuration for project com.dcx.ivkmds._50_reports.test.ass has been read by compiler.  Resetting.
21:52:7      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]

21:52:7 Resetting list of modified source files.  Was null
21:52:7 Preparing for build: not going to be incremental because no successful previous full build
21:52:7 Timer event: 1ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds._55_archive.test.ass
21:52:7 Timer event: 499ms: Time to first compiled message
21:52:7 Timer event: 589ms: Time to first woven message
21:52:7 AspectJ reports build successful, build was: FULL
21:52:7 AJDE Callback: finish. Was full build: true
21:52:7 Timer event: 684ms: Total time spent in AJDE
21:52:7 Timer event: 0ms: Refresh after build
21:52:7 Types affected during build = 1
21:52:7 Timer event: 953ms: Total time spent in AJBuilder.build()
21:52:7 Compiler configuration for project com.dcx.ivkmds._45_export_import.test.ass doesn't know previous state, so assuming EVERYTHING has changed.
21:52:7 ===========================================================================================
21:52:7 Build kind = FULLBUILD
21:52:7 Project=com.dcx.ivkmds._45_export_import.test.ass, kind of build requested=Full AspectJ compilation
21:52:7 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds._50_reports.test.ass
21:52:7 Timer event: 0ms: Flush included source file cache
21:52:7 Timer event: 0ms: Check delta
21:52:7 Builder: Tidied output folder(s), removed class files and derived resources
21:52:9 Timer event: 1679ms: Pre compile
21:52:9 Compiler configuration for project com.dcx.ivkmds._45_export_import.test.ass has been read by compiler.  Resetting.
21:52:9      Configuration was [PROJECTSOURCEFILES_CHANGED, JAVAOPTIONS_CHANGED, ASPECTPATH_CHANGED, CLASSPATH_CHANGED, INPATH_CHANGED, NONSTANDARDOPTIONS_CHANGED, OUTJAR_CHANGED, PROJECTSOURCERESOURCES_CHANGED, OUTPUTDESTINATIONS_CHANGED, INJARS_CHANGED]

21:52:9 Resetting list of modified source files.  Was null
21:52:9 Preparing for build: not going to be incremental because no successful previous full build
21:52:10 Timer event: 1020ms: Time to first compiled message
21:52:10 Timer event: 1040ms: Time to first woven message
21:52:11 AspectJ reports build successful, build was: FULL
21:52:11 AJDE Callback: finish. Was full build: true
21:52:11 Timer event: 2172ms: Total time spent in AJDE
21:52:11 Timer event: 0ms: Refresh after build
21:52:11 Types affected during build = 25
21:52:11 Timer event: 3873ms: Total time spent in AJBuilder.build()
21:52:11 Timer event: 0ms: Update visualizer, xref, advice listeners for (separate thread): com.dcx.ivkmds._45_export_import.test.ass
21:52:15 Timer event: 44ms: Delete markers: com.dcx.ivkmds.fwk.common.businessobjects.persistent (Finished deleting markers for com.dcx.ivkmds.fwk.common.businessobjects.persistent)
21:52:15 Timer event: 43ms: Create markers: com.dcx.ivkmds.fwk.common.businessobjects.persistent (Finished creating markers for com.dcx.ivkmds.fwk.common.businessobjects.persistent)
21:52:15 Created 0 markers in 6 files
21:52:15 Timer event: 88ms: Delete markers: com.dcx.ivkmds.csolver.test.ass (Finished deleting markers for com.dcx.ivkmds.csolver.test.ass)
21:52:15 Timer event: 92ms: Delete markers: com.dcx.ivkmds.csolver.ass (Finished deleting markers for com.dcx.ivkmds.csolver.ass)
21:52:15 Timer event: 108ms: Delete markers: com.dcx.ivkmds.fwk.common.spec.trace.aspectj (Finished deleting markers for com.dcx.ivkmds.fwk.common.spec.trace.aspectj)
21:52:15 Timer event: 0ms: Create markers: com.dcx.ivkmds.fwk.common.spec.trace.aspectj (Finished creating markers for com.dcx.ivkmds.fwk.common.spec.trace.aspectj)
21:52:15 Created 0 markers in 2 files
21:52:15 Timer event: 116ms: Delete markers: com.dcx.ivkmds.fwk.ass (Finished deleting markers for com.dcx.ivkmds.fwk.ass)
21:52:15 Timer event: 117ms: Delete markers: com.dcx.ivkmds.fwk.common.ass.persist (Finished deleting markers for com.dcx.ivkmds.fwk.common.ass.persist)
21:52:15 Timer event: 119ms: Delete markers: com.dcx.ivkmds.fwk.rcs (Finished deleting markers for com.dcx.ivkmds.fwk.rcs)
21:52:15 Timer event: 119ms: Delete markers: com.dcx.ivkmds._00_fwktest.ass (Finished deleting markers for com.dcx.ivkmds._00_fwktest.ass)
21:52:15 Timer event: 106ms: Delete markers: com.dcx.ivkmds.application.test.ass (Finished deleting markers for com.dcx.ivkmds.application.test.ass)
21:52:15 Timer event: 109ms: Delete markers: com.dcx.ivkmds.fwk.test.rcs (Finished deleting markers for com.dcx.ivkmds.fwk.test.rcs)
21:52:15 Timer event: 116ms: Delete markers: com.dcx.ivkmds.common.businessobjects.fwktest (Finished deleting markers for com.dcx.ivkmds.common.businessobjects.fwktest)
21:52:23 Timer event: 8410ms: Create markers: com.dcx.ivkmds.fwk.test.rcs (Finished creating markers for com.dcx.ivkmds.fwk.test.rcs)
21:52:23 Created 44 markers in 4 files
21:52:25 Timer event: 9931ms: Create markers: com.dcx.ivkmds.fwk.common.ass.persist (Finished creating markers for com.dcx.ivkmds.fwk.common.ass.persist)
21:52:25 Created 55 markers in 47 files
21:52:25 Timer event: 10246ms: Create markers: com.dcx.ivkmds.fwk.rcs (Finished creating markers for com.dcx.ivkmds.fwk.rcs)
21:52:25 Created 57 markers in 87 files
21:52:29 Timer event: 14487ms: Create markers: com.dcx.ivkmds.csolver.ass (Finished creating markers for com.dcx.ivkmds.csolver.ass)
21:52:29 Created 98 markers in 83 files
21:52:30 Timer event: 15601ms: Create markers: com.dcx.ivkmds.common.businessobjects.fwktest (Finished creating markers for com.dcx.ivkmds.common.businessobjects.fwktest)
21:52:30 Created 111 markers in 32 files
21:52:34 Timer event: 18858ms: Create markers: com.dcx.ivkmds.fwk.ass (Finished creating markers for com.dcx.ivkmds.fwk.ass)
21:52:34 Created 160 markers in 117 files
21:52:34 Timer event: 19542ms: Create markers: com.dcx.ivkmds.csolver.test.ass (Finished creating markers for com.dcx.ivkmds.csolver.test.ass)
21:52:34 Created 174 markers in 31 files
21:52:34 Timer event: 19685ms: Create markers: com.dcx.ivkmds._00_fwktest.ass (Finished creating markers for com.dcx.ivkmds._00_fwktest.ass)
21:52:34 Created 179 markers in 4 files
21:52:44 Timer event: 29540ms: Create markers: com.dcx.ivkmds.application.test.ass (Finished creating markers for com.dcx.ivkmds.application.test.ass)
21:52:44 Created 818 markers in 152 files
21:52:44 Timer event: 1ms: Delete markers: com.dcx.ivkmds._45_export_import.test.ass (Finished deleting markers for com.dcx.ivkmds._45_export_import.test.ass)
21:52:44 Timer event: 0ms: Delete markers: com.dcx.ivkmds.fwk.test.common (Finished deleting markers for com.dcx.ivkmds.fwk.test.common)
21:52:44 Timer event: 1ms: Create markers: com.dcx.ivkmds.fwk.test.common (Finished creating markers for com.dcx.ivkmds.fwk.test.common)
21:52:44 Created 0 markers in 2 files
21:52:44 Timer event: 1ms: Delete markers: com.dcx.ivkmds._45_export_import.ass (Finished deleting markers for com.dcx.ivkmds._45_export_import.ass)
21:52:44 Timer event: 42ms: Delete markers: com.dcx.ivkmds._50_reports.test.ass (Finished deleting markers for com.dcx.ivkmds._50_reports.test.ass)
21:52:44 Timer event: 181ms: Create markers: com.dcx.ivkmds._50_reports.test.ass (Finished creating markers for com.dcx.ivkmds._50_reports.test.ass)
21:52:44 Created 4 markers in 1 files
21:52:45 Timer event: 451ms: Create markers: com.dcx.ivkmds._45_export_import.ass (Finished creating markers for com.dcx.ivkmds._45_export_import.ass)
21:52:45 Created 14 markers in 425 files
21:52:45 Timer event: 925ms: Create markers: com.dcx.ivkmds._45_export_import.test.ass (Finished creating markers for com.dcx.ivkmds._45_export_import.test.ass)
21:52:45 Created 53 markers in 25 files
21:52:49 Timer event: 24ms: Delete markers: com.dcx.ivkmds.csolver.test.cts (Finished deleting markers for com.dcx.ivkmds.csolver.test.cts)
21:52:49 Timer event: 34ms: Delete markers: com.dcx.ivkmds.application.test.rcs.standalone (Finished deleting markers for com.dcx.ivkmds.application.test.rcs.standalone)
21:52:49 Timer event: 0ms: Create markers: com.dcx.ivkmds.application.test.rcs.standalone (Finished creating markers for com.dcx.ivkmds.application.test.rcs.standalone)
21:52:49 Created 0 markers in 1 files
21:52:49 Timer event: 35ms: Delete markers: com.dcx.ivkmds.application.rcs.standalone (Finished deleting markers for com.dcx.ivkmds.application.rcs.standalone)
21:52:49 Timer event: 37ms: Delete markers: com.dcx.ivkmds._55_archive.test.ass (Finished deleting markers for com.dcx.ivkmds._55_archive.test.ass)
21:52:49 Timer event: 45ms: Delete markers: com.dcx.ivkmds.application.test.common (Finished deleting markers for com.dcx.ivkmds.application.test.common)
21:52:49 Timer event: 0ms: Create markers: com.dcx.ivkmds.application.test.common (Finished creating markers for com.dcx.ivkmds.application.test.common)
21:52:49 Created 0 markers in 1 files
21:52:49 Timer event: 46ms: Delete markers: com.dcx.ivkmds.csolver.cts (Finished deleting markers for com.dcx.ivkmds.csolver.cts)
21:52:49 Timer event: 47ms: Delete markers: com.dcx.ivkmds.csolver.cts.standalone (Finished deleting markers for com.dcx.ivkmds.csolver.cts.standalone)
21:52:49 Timer event: 56ms: Delete markers: com.dcx.ivkmds.testfwk (Finished deleting markers for com.dcx.ivkmds.testfwk)
21:52:49 Timer event: 61ms: Delete markers: com.dcx.ivkmds.common.businessobjects.persistent (Finished deleting markers for com.dcx.ivkmds.common.businessobjects.persistent)
21:52:49 Timer event: 65ms: Delete markers: com.dcx.ivkmds.fwk.test.ass (Finished deleting markers for com.dcx.ivkmds.fwk.test.ass)
21:52:49 Timer event: 72ms: Delete markers: com.dcx.ivkmds.application.ass (Finished deleting markers for com.dcx.ivkmds.application.ass)
21:52:49 Timer event: 455ms: Create markers: com.dcx.ivkmds.application.rcs.standalone (Finished creating markers for com.dcx.ivkmds.application.rcs.standalone)
21:52:49 Created 2 markers in 9 files
21:52:50 Timer event: 1365ms: Create markers: com.dcx.ivkmds.csolver.cts.standalone (Finished creating markers for com.dcx.ivkmds.csolver.cts.standalone)
21:52:50 Created 7 markers in 17 files
21:52:51 Timer event: 1813ms: Create markers: com.dcx.ivkmds._55_archive.test.ass (Finished creating markers for com.dcx.ivkmds._55_archive.test.ass)
21:52:51 Created 12 markers in 2 files
21:52:52 Timer event: 3142ms: Create markers: com.dcx.ivkmds.csolver.test.cts (Finished creating markers for com.dcx.ivkmds.csolver.test.cts)
21:52:52 Created 30 markers in 12 files
21:52:55 Timer event: 6623ms: Create markers: com.dcx.ivkmds.testfwk (Finished creating markers for com.dcx.ivkmds.testfwk)
21:52:55 Created 93 markers in 45 files
21:52:57 Timer event: 8536ms: Create markers: com.dcx.ivkmds.csolver.cts (Finished creating markers for com.dcx.ivkmds.csolver.cts)
21:52:57 Created 134 markers in 343 files
21:53:2 Timer event: 12652ms: Create markers: com.dcx.ivkmds.fwk.test.ass (Finished creating markers for com.dcx.ivkmds.fwk.test.ass)
21:53:2 Created 572 markers in 24 files
21:53:12 Timer event: 23494ms: Create markers: com.dcx.ivkmds.common.businessobjects.persistent (Finished creating markers for com.dcx.ivkmds.common.businessobjects.persistent)
21:53:12 Created 996 markers in 326 files
21:53:18 Timer event: 28932ms: Create markers: com.dcx.ivkmds.application.ass (Finished creating markers for com.dcx.ivkmds.application.ass)
21:53:18 Created 2615 markers in 292 files


And the timings along with some errors in AJDT:

Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=3ms
> weaving classes=1ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 1ms
> weaving normal itds=0ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 0ms
shadowWeaving = 0ms
postWeave = 0ms
Total =0ms

Kinded pointcut matchInternal(): 0ms
Kinded pointcut match calls: 0
Kinded pointcut xlinttime: 0ms
ThisTarget pointcut matchInternal: 0ms

Timing: time spent in pipeline weaving: 18ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=20ms
> weaving classes=146ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 6ms
> weaving normal itds=8ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 1ms
typeWeaving = 11ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 46ms
shadowWeaving = 14ms
postWeave = 4ms
Total =79ms

Kinded pointcut matchInternal(): 17ms
Kinded pointcut match calls: 2786
Kinded pointcut xlinttime: 0ms
ThisTarget pointcut matchInternal: 0ms

Timing: time spent in pipeline weaving: 495ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=12ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 0ms
> weaving normal itds=0ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 6ms
shadowWeaving = 0ms
postWeave = 0ms
Total =6ms

Kinded pointcut matchInternal(): 2ms
Kinded pointcut match calls: 462
Kinded pointcut xlinttime: 0ms
ThisTarget pointcut matchInternal: 0ms

Timing: time spent in pipeline weaving: 36ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=36ms
> weaving classes=560ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 30ms
> weaving normal itds=27ms
> weaving structural itds=3ms

Breakdown of time spent in type weaver instances:
class prep = 2ms
typeWeaving = 47ms
decaWeaving = 0ms
fastShadowMatching = 2ms
shadowMatching = 327ms
shadowWeaving = 26ms
postWeave = 7ms
Total =414ms

Kinded pointcut matchInternal(): 120ms
Kinded pointcut match calls: 3098
Kinded pointcut xlinttime: 2ms
ThisTarget pointcut matchInternal: 16ms

Timing: time spent in pipeline weaving: 1655ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=2ms
> verifying consistency=4ms
> weaving aspects=63ms
> weaving classes=15164ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 76ms
> weaving normal itds=55ms
> weaving structural itds=6ms

Breakdown of time spent in type weaver instances:
class prep = 12ms
typeWeaving = 30ms
decaWeaving = 3ms
fastShadowMatching = 7ms
shadowMatching = 14463ms
shadowWeaving = 111ms
postWeave = 90ms
Total =14719ms

Kinded pointcut matchInternal(): 2014ms
Kinded pointcut match calls: 148930
Kinded pointcut xlinttime: 494ms
ThisTarget pointcut matchInternal: 9440ms

Timing: time spent in pipeline weaving: 19141ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=2ms
> verifying consistency=1ms
> weaving aspects=1ms
> weaving classes=3054ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 41ms
> weaving normal itds=177ms
> weaving structural itds=23ms

Breakdown of time spent in type weaver instances:
class prep = 6ms
typeWeaving = 915ms
decaWeaving = 2ms
fastShadowMatching = 7ms
shadowMatching = 781ms
shadowWeaving = 670ms
postWeave = 27ms
Total =2412ms

Kinded pointcut matchInternal(): 435ms
Kinded pointcut match calls: 47699
Kinded pointcut xlinttime: 0ms
ThisTarget pointcut matchInternal: 14ms

Timing: time spent in pipeline weaving: 5954ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=1ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=579ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 5ms
> weaving normal itds=81ms
> weaving structural itds=1ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 188ms
decaWeaving = 0ms
fastShadowMatching = 1ms
shadowMatching = 64ms
shadowWeaving = 156ms
postWeave = 12ms
Total =423ms

Kinded pointcut matchInternal(): 47ms
Kinded pointcut match calls: 5242
Kinded pointcut xlinttime: 0ms
ThisTarget pointcut matchInternal: 2ms

Timing: time spent in pipeline weaving: 2828ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=1ms
> verifying consistency=0ms
> weaving aspects=191ms
> weaving classes=3367ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 391ms
> weaving normal itds=21ms
> weaving structural itds=1ms

Breakdown of time spent in type weaver instances:
class prep = 4ms
typeWeaving = 33ms
decaWeaving = 0ms
fastShadowMatching = 2ms
shadowMatching = 2702ms
shadowWeaving = 107ms
postWeave = 10ms
Total =2861ms

Kinded pointcut matchInternal(): 344ms
Kinded pointcut match calls: 23867
Kinded pointcut xlinttime: 47ms
ThisTarget pointcut matchInternal: 1115ms

Timing: time spent in pipeline weaving: 4587ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=12ms
> weaving classes=19848ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 379ms
> weaving normal itds=62ms
> weaving structural itds=8ms

Breakdown of time spent in type weaver instances:
class prep = 15ms
typeWeaving = 0ms
decaWeaving = 1ms
fastShadowMatching = 7ms
shadowMatching = 16149ms
shadowWeaving = 2272ms
postWeave = 45ms
Total =18493ms

Kinded pointcut matchInternal(): 3132ms
Kinded pointcut match calls: 182507
Kinded pointcut xlinttime: 444ms
ThisTarget pointcut matchInternal: 9281ms

Timing: time spent in pipeline weaving: 22614ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=130ms
> weaving classes=17780ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 19ms
> weaving normal itds=19ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 4ms
typeWeaving = 14ms
decaWeaving = 0ms
fastShadowMatching = 1ms
shadowMatching = 17580ms
shadowWeaving = 156ms
postWeave = 11ms
Total =17770ms

Kinded pointcut matchInternal(): 15634ms
Kinded pointcut match calls: 33642
Kinded pointcut xlinttime: 15088ms
ThisTarget pointcut matchInternal: 1344ms

Timing: time spent in pipeline weaving: 18593ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=2ms
> reweavable processing=7ms
> verifying consistency=0ms
> weaving aspects=13ms
> weaving classes=15564ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 118ms
> weaving normal itds=82ms
> weaving structural itds=7ms

Breakdown of time spent in type weaver instances:
class prep = 6ms
typeWeaving = 1ms
decaWeaving = 3ms
fastShadowMatching = 7ms
shadowMatching = 14649ms
shadowWeaving = 25ms
postWeave = 135ms
Total =14830ms

Kinded pointcut matchInternal(): 2990ms
Kinded pointcut match calls: 161602
Kinded pointcut xlinttime: 378ms
ThisTarget pointcut matchInternal: 8615ms

Timing: time spent in pipeline weaving: 20691ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=670ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 25ms
> weaving normal itds=6ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 459ms
shadowWeaving = 135ms
postWeave = 0ms
Total =596ms

Kinded pointcut matchInternal(): 143ms
Kinded pointcut match calls: 4960
Kinded pointcut xlinttime: 9ms
ThisTarget pointcut matchInternal: 271ms

Timing: time spent in pipeline weaving: 706ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=1ms
> weaving classes=282ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 6ms
> weaving normal itds=6ms
> weaving structural itds=1ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 3ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 227ms
shadowWeaving = 7ms
postWeave = 0ms
Total =239ms

Kinded pointcut matchInternal(): 34ms
Kinded pointcut match calls: 2128
Kinded pointcut xlinttime: 8ms
ThisTarget pointcut matchInternal: 137ms

Timing: time spent in pipeline weaving: 691ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=1ms
> weaving classes=8ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 1ms
> weaving normal itds=0ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 1ms
shadowWeaving = 0ms
postWeave = 0ms
Total =3ms

Kinded pointcut matchInternal(): 0ms
Kinded pointcut match calls: 65
Kinded pointcut xlinttime: 0ms
ThisTarget pointcut matchInternal: 0ms

Timing: time spent in pipeline weaving: 104ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=2ms
> weaving aspects=139ms
> weaving classes=917ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 51ms
> weaving normal itds=20ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 7ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 816ms
shadowWeaving = 100ms
postWeave = 3ms
Total =929ms

Kinded pointcut matchInternal(): 381ms
Kinded pointcut match calls: 24214
Kinded pointcut xlinttime: 50ms
ThisTarget pointcut matchInternal: 219ms

Timing: time spent in pipeline weaving: 1505ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=207ms
> weaving classes=8468ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 31ms
> weaving normal itds=11ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 6965ms
shadowWeaving = 1489ms
postWeave = 3ms
Total =8460ms

Kinded pointcut matchInternal(): 3157ms
Kinded pointcut match calls: 206596
Kinded pointcut xlinttime: 513ms
ThisTarget pointcut matchInternal: 2274ms

Timing: time spent in pipeline weaving: 9285ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=541ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 4ms
> weaving normal itds=0ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 460ms
shadowWeaving = 53ms
postWeave = 0ms
Total =515ms

Kinded pointcut matchInternal(): 185ms
Kinded pointcut match calls: 12951
Kinded pointcut xlinttime: 36ms
ThisTarget pointcut matchInternal: 80ms

Timing: time spent in pipeline weaving: 577ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=1ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 0ms
> weaving normal itds=0ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 0ms
shadowWeaving = 0ms
postWeave = 0ms
Total =0ms

Kinded pointcut matchInternal(): 0ms
Kinded pointcut match calls: 0
Kinded pointcut xlinttime: 0ms
ThisTarget pointcut matchInternal: 0ms

Timing: time spent in pipeline weaving: 15ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=280ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 13ms
> weaving normal itds=1ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 228ms
shadowWeaving = 22ms
postWeave = 1ms
Total =253ms

Kinded pointcut matchInternal(): 136ms
Kinded pointcut match calls: 11484
Kinded pointcut xlinttime: 38ms
ThisTarget pointcut matchInternal: 26ms

Timing: time spent in pipeline weaving: 368ms
Timing ------------

!ENTRY org.tigris.subversion.subclipse.core 4 0 2009-10-10 21:51:41.772
!MESSAGE org.tigris.subversion.javahl.ClientException: Working copy not locked;
this is probably a bug, please report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

!STACK 1
org.tigris.subversion.subclipse.core.SVNException: org.tigris.subversion.javahl.
ClientException: Working copy not locked; this is probably a bug, please report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

        at org.tigris.subversion.subclipse.core.SVNException.wrapException(SVNEx
ception.java:85)
        at org.tigris.subversion.subclipse.core.status.StatusCacheManager.refres
hStatus(StatusCacheManager.java:289)
        at org.tigris.subversion.subclipse.core.resourcesListeners.FileModificat
ionManager.refreshStatusInfitite(FileModificationManager.java:149)
        at org.tigris.subversion.subclipse.core.resourcesListeners.FileModificat
ionManager.resourceChanged(FileModificationManager.java:133)
        at org.eclipse.core.internal.events.NotificationManager$2.run(Notificati
onManager.java:291)
        at org.eclipse.core.runtime.SafeRunner.run(SafeRunner.java:42)
        at org.eclipse.core.internal.events.NotificationManager.notify(Notificat
ionManager.java:285)
        at org.eclipse.core.internal.events.NotificationManager.broadcastChanges
(NotificationManager.java:149)
        at org.eclipse.core.internal.resources.Workspace.broadcastPostChange(Wor
kspace.java:313)
        at org.eclipse.core.internal.resources.Workspace.endOperation(Workspace.
java:1022)
        at org.eclipse.core.internal.resources.Workspace.run(Workspace.java:1809
)
        at org.eclipse.core.internal.events.NotificationManager$NotifyJob.run(No
tificationManager.java:40)
        at org.eclipse.core.internal.jobs.Worker.run(Worker.java:55)
Caused by: org.tigris.subversion.subclipse.core.SVNException: org.tigris.subvers
ion.javahl.ClientException: Working copy not locked; this is probably a bug, ple
ase report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

        at org.tigris.subversion.subclipse.core.SVNException.wrapException(SVNEx
ception.java:75)
        at org.tigris.subversion.subclipse.core.status.RecursiveStatusUpdateStra
tegy.statusesToUpdate(RecursiveStatusUpdateStrategy.java:64)
        at org.tigris.subversion.subclipse.core.status.StatusCacheManager.refres
hStatus(StatusCacheManager.java:264)
        ... 11 more
Caused by: org.tigris.subversion.svnclientadapter.SVNClientException: org.tigris
.subversion.javahl.ClientException: Working copy not locked; this is probably a
bug, please report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:495)
        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:467)
        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:460)
        at org.tigris.subversion.subclipse.core.status.RecursiveStatusUpdateStra
tegy.statusesToUpdate(RecursiveStatusUpdateStrategy.java:62)
        ... 12 more
Caused by: org.tigris.subversion.javahl.ClientException: Working copy not locked
; this is probably a bug, please report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

        at org.tigris.subversion.javahl.SVNClient.status(Native Method)
        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:481)
        ... 15 more
!SUBENTRY 1 org.tigris.subversion.subclipse.core 4 -6 2009-10-10 21:51:41.786
!MESSAGE org.tigris.subversion.javahl.ClientException: Working copy not locked;
this is probably a bug, please report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

!STACK 1
org.tigris.subversion.subclipse.core.SVNException: org.tigris.subversion.javahl.
ClientException: Working copy not locked; this is probably a bug, please report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

        at org.tigris.subversion.subclipse.core.SVNException.wrapException(SVNEx
ception.java:75)
        at org.tigris.subversion.subclipse.core.status.RecursiveStatusUpdateStra
tegy.statusesToUpdate(RecursiveStatusUpdateStrategy.java:64)
        at org.tigris.subversion.subclipse.core.status.StatusCacheManager.refres
hStatus(StatusCacheManager.java:264)
        at org.tigris.subversion.subclipse.core.resourcesListeners.FileModificat
ionManager.refreshStatusInfitite(FileModificationManager.java:149)
        at org.tigris.subversion.subclipse.core.resourcesListeners.FileModificat
ionManager.resourceChanged(FileModificationManager.java:133)
        at org.eclipse.core.internal.events.NotificationManager$2.run(Notificati
onManager.java:291)
        at org.eclipse.core.runtime.SafeRunner.run(SafeRunner.java:42)
        at org.eclipse.core.internal.events.NotificationManager.notify(Notificat
ionManager.java:285)
        at org.eclipse.core.internal.events.NotificationManager.broadcastChanges
(NotificationManager.java:149)
        at org.eclipse.core.internal.resources.Workspace.broadcastPostChange(Wor
kspace.java:313)
        at org.eclipse.core.internal.resources.Workspace.endOperation(Workspace.
java:1022)
        at org.eclipse.core.internal.resources.Workspace.run(Workspace.java:1809
)
        at org.eclipse.core.internal.events.NotificationManager$NotifyJob.run(No
tificationManager.java:40)
        at org.eclipse.core.internal.jobs.Worker.run(Worker.java:55)
Caused by: org.tigris.subversion.svnclientadapter.SVNClientException: org.tigris
.subversion.javahl.ClientException: Working copy not locked; this is probably a
bug, please report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:495)
        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:467)
        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:460)
        at org.tigris.subversion.subclipse.core.status.RecursiveStatusUpdateStra
tegy.statusesToUpdate(RecursiveStatusUpdateStrategy.java:62)
        ... 12 more
Caused by: org.tigris.subversion.javahl.ClientException: Working copy not locked
; this is probably a bug, please report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

        at org.tigris.subversion.javahl.SVNClient.status(Native Method)
        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:481)
        ... 15 more
!SUBENTRY 2 org.tigris.subversion.subclipse.core 4 -6 2009-10-10 21:51:41.796
!MESSAGE org.tigris.subversion.javahl.ClientException: Working copy not locked;
this is probably a bug, please report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

!STACK 0
org.tigris.subversion.svnclientadapter.SVNClientException: org.tigris.subversion
.javahl.ClientException: Working copy not locked; this is probably a bug, please
 report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:495)
        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:467)
        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:460)
        at org.tigris.subversion.subclipse.core.status.RecursiveStatusUpdateStra
tegy.statusesToUpdate(RecursiveStatusUpdateStrategy.java:62)
        at org.tigris.subversion.subclipse.core.status.StatusCacheManager.refres
hStatus(StatusCacheManager.java:264)
        at org.tigris.subversion.subclipse.core.resourcesListeners.FileModificat
ionManager.refreshStatusInfitite(FileModificationManager.java:149)
        at org.tigris.subversion.subclipse.core.resourcesListeners.FileModificat
ionManager.resourceChanged(FileModificationManager.java:133)
        at org.eclipse.core.internal.events.NotificationManager$2.run(Notificati
onManager.java:291)
        at org.eclipse.core.runtime.SafeRunner.run(SafeRunner.java:42)
        at org.eclipse.core.internal.events.NotificationManager.notify(Notificat
ionManager.java:285)
        at org.eclipse.core.internal.events.NotificationManager.broadcastChanges
(NotificationManager.java:149)
        at org.eclipse.core.internal.resources.Workspace.broadcastPostChange(Wor
kspace.java:313)
        at org.eclipse.core.internal.resources.Workspace.endOperation(Workspace.
java:1022)
        at org.eclipse.core.internal.resources.Workspace.run(Workspace.java:1809
)
        at org.eclipse.core.internal.events.NotificationManager$NotifyJob.run(No
tificationManager.java:40)
        at org.eclipse.core.internal.jobs.Worker.run(Worker.java:55)
Caused by: org.tigris.subversion.javahl.ClientException: Working copy not locked
; this is probably a bug, please report
svn: Directory 'C:\ws\ivk- eclipse 3.5\com.dcx.ivkmds.application.test.ass\bin\c
om\.svn' containing working copy admin area is missing

        at org.tigris.subversion.javahl.SVNClient.status(Native Method)
        at org.tigris.subversion.svnclientadapter.javahl.AbstractJhlClientAdapte
r.getStatus(AbstractJhlClientAdapter.java:481)
        ... 15 more
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=3ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=7061ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 144ms
> weaving normal itds=35ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 1ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 1ms
shadowMatching = 5240ms
shadowWeaving = 1281ms
postWeave = 75ms
Total =6601ms

Kinded pointcut matchInternal(): 3424ms
Kinded pointcut match calls: 248587
Kinded pointcut xlinttime: 654ms
ThisTarget pointcut matchInternal: 664ms

Timing: time spent in pipeline weaving: 8426ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=2897ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 20ms
> weaving normal itds=2ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 1ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 2509ms
shadowWeaving = 307ms
postWeave = 3ms
Total =2823ms

Kinded pointcut matchInternal(): 1808ms
Kinded pointcut match calls: 73238
Kinded pointcut xlinttime: 205ms
ThisTarget pointcut matchInternal: 209ms

Timing: time spent in pipeline weaving: 5215ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=0ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 0ms
> weaving normal itds=0ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 0ms
shadowWeaving = 0ms
postWeave = 0ms
Total =0ms

Kinded pointcut matchInternal(): 0ms
Kinded pointcut match calls: 0
Kinded pointcut xlinttime: 0ms
ThisTarget pointcut matchInternal: 0ms

Timing: time spent in pipeline weaving: 0ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=3ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 1ms
> weaving normal itds=2ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 1ms
shadowWeaving = 0ms
postWeave = 0ms
Total =1ms

Kinded pointcut matchInternal(): 1ms
Kinded pointcut match calls: 30
Kinded pointcut xlinttime: 0ms
ThisTarget pointcut matchInternal: 0ms

Timing: time spent in pipeline weaving: 15ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=52ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 1ms
> weaving normal itds=1ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 35ms
shadowWeaving = 10ms
postWeave = 0ms
Total =47ms

Kinded pointcut matchInternal(): 24ms
Kinded pointcut match calls: 1204
Kinded pointcut xlinttime: 3ms
ThisTarget pointcut matchInternal: 4ms

Timing: time spent in pipeline weaving: 78ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=69ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 0ms
> weaving normal itds=23ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 50ms
shadowWeaving = 8ms
postWeave = 0ms
Total =59ms

Kinded pointcut matchInternal(): 29ms
Kinded pointcut match calls: 2013
Kinded pointcut xlinttime: 4ms
ThisTarget pointcut matchInternal: 9ms

Timing: time spent in pipeline weaving: 102ms
Timing ------------
Timing ------------
Entire time spent in the weaver instance created for this build:
> performing model repairs=0ms
> reweavable processing=0ms
> verifying consistency=0ms
> weaving aspects=0ms
> weaving classes=154ms
  for those two weave steps, time spent pre-post calling the individual type wea
ver instance: 12ms
> weaving normal itds=4ms
> weaving structural itds=0ms

Breakdown of time spent in type weaver instances:
class prep = 0ms
typeWeaving = 0ms
decaWeaving = 0ms
fastShadowMatching = 0ms
shadowMatching = 102ms
shadowWeaving = 17ms
postWeave = 1ms
Total =122ms

Kinded pointcut matchInternal(): 63ms
Kinded pointcut match calls: 4631
Kinded pointcut xlinttime: 13ms
ThisTarget pointcut matchInternal: 14ms

Timing: time spent in pipeline weaving: 318ms
Timing ------------

!ENTRY org.eclipse.ajdt.core 4 0 2009-10-10 21:52:16.179
!MESSAGE Class org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo can not
access a member of class org.eclipse.jdt.internal.core.ASTHolderCUInfo with modi
fiers ""
!STACK 0
java.lang.IllegalAccessException: Class org.eclipse.ajdt.core.javaelements.AJCom
pilationUnitInfo can not access a member of class org.eclipse.jdt.internal.core.
ASTHolderCUInfo with modifiers ""
        at sun.reflect.Reflection.ensureMemberAccess(Unknown Source)
        at java.lang.reflect.Field.doSecurityCheck(Unknown Source)
        at java.lang.reflect.Field.getFieldAccessor(Unknown Source)
        at java.lang.reflect.Field.getInt(Unknown Source)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo.getASTLevel(
AJCompilationUnitInfo.java:37)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.buildStructure(A
JCompilationUnit.java:296)
        at org.eclipse.jdt.internal.core.Openable.generateInfos(Openable.java:25
8)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.generateInfos(AJ
CompilationUnit.java:217)
        at org.eclipse.jdt.internal.core.JavaElement.openWhenClosed(JavaElement.
java:515)
        at org.eclipse.jdt.internal.core.JavaElement.getElementInfo(JavaElement.
java:252)
        at org.eclipse.jdt.internal.core.JavaElement.getElementInfo(JavaElement.
java:238)
        at org.eclipse.jdt.internal.core.JavaElement.getChildren(JavaElement.jav
a:193)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.findAspectType(A
JCompilationUnit.java:239)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.getType(AJCompil
ationUnit.java:226)
        at org.eclipse.jdt.internal.core.NameLookup.seekTypesInSourcePackage(Nam
eLookup.java:1083)
        at org.eclipse.jdt.internal.core.NameLookup.seekTypes(NameLookup.java:98
9)
        at org.eclipse.jdt.internal.core.NameLookup.findType(NameLookup.java:778
)
        at org.eclipse.jdt.internal.core.NameLookup.findType(NameLookup.java:662
)
        at org.eclipse.jdt.internal.core.NameLookup.findType(NameLookup.java:816
)
        at org.eclipse.jdt.internal.core.JavaProject.findType(JavaProject.java:1
199)
        at org.eclipse.jdt.internal.core.JavaProject.findType(JavaProject.java:1
280)
        at org.eclipse.jdt.internal.core.JavaProject.findType(JavaProject.java:1
186)
        at org.eclipse.ajdt.core.model.AJProjectModelFacade.getCUFromQualifiedNa
me(AJProjectModelFacade.java:685)
        at org.eclipse.ajdt.core.model.AJProjectModelFacade.getElementFromClassF
ile(AJProjectModelFacade.java:498)
        at org.eclipse.ajdt.core.model.AJProjectModelFacade.programElementToJava
Element(AJProjectModelFacade.java:370)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.getCustomMarker(
UpdateAJMarkers.java:440)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.createMarker(Upd
ateAJMarkers.java:200)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.addMarkersForFil
e(UpdateAJMarkers.java:189)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.addMarkersForPro
ject(UpdateAJMarkers.java:146)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.run(UpdateAJMark
ers.java:113)
        at org.eclipse.ajdt.internal.ui.markers.DeleteAndUpdateAJMarkersJob.run(
DeleteAndUpdateAJMarkersJob.java:59)
        at org.eclipse.core.internal.jobs.Worker.run(Worker.java:55)
!SUBENTRY 1 org.eclipse.ajdt.core 4 0 2009-10-10 21:52:16.235
!MESSAGE org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo.getASTLevel(AJ
CompilationUnitInfo.java:41)
!SUBENTRY 1 org.eclipse.ajdt.core 1 1 2009-10-10 21:52:16.237
!MESSAGE org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo@23ae49
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.238
!MESSAGE astLevelField=class java.lang.reflect.Field@1222314985
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.238
!MESSAGE resolveBindingsField=null
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.239
!MESSAGE reconcileFlagsField=null
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.240
!MESSAGE problemsField=null
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.241
!MESSAGE astField=null

!ENTRY org.eclipse.ajdt.core 4 0 2009-10-10 21:52:16.331
!MESSAGE Class org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo can not
access a member of class org.eclipse.jdt.internal.core.ASTHolderCUInfo with modi
fiers ""
!STACK 0
java.lang.IllegalAccessException: Class org.eclipse.ajdt.core.javaelements.AJCom
pilationUnitInfo can not access a member of class org.eclipse.jdt.internal.core.
ASTHolderCUInfo with modifiers ""
        at sun.reflect.Reflection.ensureMemberAccess(Unknown Source)
        at java.lang.reflect.Field.doSecurityCheck(Unknown Source)
        at java.lang.reflect.Field.getFieldAccessor(Unknown Source)
        at java.lang.reflect.Field.getInt(Unknown Source)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo.getASTLevel(
AJCompilationUnitInfo.java:37)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.buildStructure(A
JCompilationUnit.java:296)
        at org.eclipse.jdt.internal.core.Openable.generateInfos(Openable.java:25
8)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.generateInfos(AJ
CompilationUnit.java:217)
        at org.eclipse.jdt.internal.core.JavaElement.openWhenClosed(JavaElement.
java:515)
        at org.eclipse.jdt.internal.core.JavaElement.getElementInfo(JavaElement.
java:252)
        at org.eclipse.jdt.internal.core.JavaElement.getElementInfo(JavaElement.
java:238)
        at org.eclipse.jdt.internal.core.JavaElement.getChildren(JavaElement.jav
a:193)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.findAspectType(A
JCompilationUnit.java:239)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.getType(AJCompil
ationUnit.java:226)
        at org.eclipse.jdt.internal.core.NameLookup.seekTypesInSourcePackage(Nam
eLookup.java:1083)
        at org.eclipse.jdt.internal.core.NameLookup.seekTypes(NameLookup.java:98
9)
        at org.eclipse.jdt.internal.core.NameLookup.findType(NameLookup.java:778
)
        at org.eclipse.jdt.internal.core.NameLookup.findType(NameLookup.java:662
)
        at org.eclipse.jdt.internal.core.NameLookup.findType(NameLookup.java:816
)
        at org.eclipse.jdt.internal.core.JavaProject.findType(JavaProject.java:1
199)
        at org.eclipse.jdt.internal.core.JavaProject.findType(JavaProject.java:1
280)
        at org.eclipse.jdt.internal.core.JavaProject.findType(JavaProject.java:1
186)
        at org.eclipse.ajdt.core.model.AJProjectModelFacade.getCUFromQualifiedNa
me(AJProjectModelFacade.java:685)
        at org.eclipse.ajdt.core.model.AJProjectModelFacade.getElementFromClassF
ile(AJProjectModelFacade.java:498)
        at org.eclipse.ajdt.core.model.AJProjectModelFacade.programElementToJava
Element(AJProjectModelFacade.java:370)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.getCustomMarker(
UpdateAJMarkers.java:440)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.createMarker(Upd
ateAJMarkers.java:200)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.addMarkersForFil
e(UpdateAJMarkers.java:189)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.addMarkersForPro
ject(UpdateAJMarkers.java:146)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.run(UpdateAJMark
ers.java:113)
        at org.eclipse.ajdt.internal.ui.markers.DeleteAndUpdateAJMarkersJob.run(
DeleteAndUpdateAJMarkersJob.java:59)
        at org.eclipse.core.internal.jobs.Worker.run(Worker.java:55)
!SUBENTRY 1 org.eclipse.ajdt.core 4 0 2009-10-10 21:52:16.342
!MESSAGE org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo.getASTLevel(AJ
CompilationUnitInfo.java:41)
!SUBENTRY 1 org.eclipse.ajdt.core 1 1 2009-10-10 21:52:16.343
!MESSAGE org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo@6f3ab6
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.345
!MESSAGE astLevelField=class java.lang.reflect.Field@1222314985
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.346
!MESSAGE resolveBindingsField=class java.lang.reflect.Field@1652893009
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.347
!MESSAGE reconcileFlagsField=class java.lang.reflect.Field@-2131867118
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.347
!MESSAGE problemsField=null
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.348
!MESSAGE astField=null

!ENTRY org.eclipse.ajdt.core 4 0 2009-10-10 21:52:16.375
!MESSAGE Class org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo can not
access a member of class org.eclipse.jdt.internal.core.ASTHolderCUInfo with modi
fiers ""
!STACK 0
java.lang.IllegalAccessException: Class org.eclipse.ajdt.core.javaelements.AJCom
pilationUnitInfo can not access a member of class org.eclipse.jdt.internal.core.
ASTHolderCUInfo with modifiers ""
        at sun.reflect.Reflection.ensureMemberAccess(Unknown Source)
        at java.lang.reflect.Field.doSecurityCheck(Unknown Source)
        at java.lang.reflect.Field.getFieldAccessor(Unknown Source)
        at java.lang.reflect.Field.getInt(Unknown Source)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo.getASTLevel(
AJCompilationUnitInfo.java:37)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.buildStructure(A
JCompilationUnit.java:296)
        at org.eclipse.jdt.internal.core.Openable.generateInfos(Openable.java:25
8)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.generateInfos(AJ
CompilationUnit.java:217)
        at org.eclipse.jdt.internal.core.JavaElement.openWhenClosed(JavaElement.
java:515)
        at org.eclipse.jdt.internal.core.JavaElement.getElementInfo(JavaElement.
java:252)
        at org.eclipse.jdt.internal.core.JavaElement.getElementInfo(JavaElement.
java:238)
        at org.eclipse.jdt.internal.core.JavaElement.getChildren(JavaElement.jav
a:193)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.findAspectType(A
JCompilationUnit.java:239)
        at org.eclipse.ajdt.core.javaelements.AJCompilationUnit.getType(AJCompil
ationUnit.java:226)
        at org.eclipse.jdt.internal.core.NameLookup.seekTypesInSourcePackage(Nam
eLookup.java:1083)
        at org.eclipse.jdt.internal.core.NameLookup.seekTypes(NameLookup.java:98
9)
        at org.eclipse.jdt.internal.core.NameLookup.findType(NameLookup.java:778
)
        at org.eclipse.jdt.internal.core.NameLookup.findType(NameLookup.java:662
)
        at org.eclipse.jdt.internal.core.NameLookup.findType(NameLookup.java:816
)
        at org.eclipse.jdt.internal.core.JavaProject.findType(JavaProject.java:1
199)
        at org.eclipse.jdt.internal.core.JavaProject.findType(JavaProject.java:1
280)
        at org.eclipse.jdt.internal.core.JavaProject.findType(JavaProject.java:1
186)
        at org.eclipse.ajdt.core.model.AJProjectModelFacade.getCUFromQualifiedNa
me(AJProjectModelFacade.java:685)
        at org.eclipse.ajdt.core.model.AJProjectModelFacade.getElementFromClassF
ile(AJProjectModelFacade.java:498)
        at org.eclipse.ajdt.core.model.AJProjectModelFacade.programElementToJava
Element(AJProjectModelFacade.java:370)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.getCustomMarker(
UpdateAJMarkers.java:440)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.createMarker(Upd
ateAJMarkers.java:200)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.addMarkersForFil
e(UpdateAJMarkers.java:189)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.addMarkersForPro
ject(UpdateAJMarkers.java:146)
        at org.eclipse.ajdt.internal.ui.markers.UpdateAJMarkers.run(UpdateAJMark
ers.java:113)
        at org.eclipse.ajdt.internal.ui.markers.DeleteAndUpdateAJMarkersJob.run(
DeleteAndUpdateAJMarkersJob.java:59)
        at org.eclipse.core.internal.jobs.Worker.run(Worker.java:55)
!SUBENTRY 1 org.eclipse.ajdt.core 4 0 2009-10-10 21:52:16.385
!MESSAGE org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo.getASTLevel(AJ
CompilationUnitInfo.java:41)
!SUBENTRY 1 org.eclipse.ajdt.core 1 1 2009-10-10 21:52:16.387
!MESSAGE org.eclipse.ajdt.core.javaelements.AJCompilationUnitInfo@6cff9c
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.387
!MESSAGE astLevelField=class java.lang.reflect.Field@1222314985
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.388
!MESSAGE resolveBindingsField=class java.lang.reflect.Field@1652893009
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.389
!MESSAGE reconcileFlagsField=class java.lang.reflect.Field@-2131867118
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.390
!MESSAGE problemsField=null
!SUBENTRY 2 org.eclipse.ajdt.core 1 0 2009-10-10 21:52:16.391
!MESSAGE astField=null
Follow-Ups:
- Re: [aspectj-users] Overall problem with AJDT performance
  - From: Andrew Eisenberg
- Re: [aspectj-users] Overall problem with AJDT performance
  - From: Andy Clement
References:
- AW: [aspectj-users] Overall problem with AJDT performance
  - From: Thomas Hofmann
Prev by Date: AW: [aspectj-users] Overall problem with AJDT performance
Next by Date: Re: [aspectj-users] Overall problem with AJDT performance
Previous by thread: AW: [aspectj-users] Overall problem with AJDT performance
Next by thread: Re: [aspectj-users] Overall problem with AJDT performance
Index(es):
- Date
- Thread
Breadcrumbs
