Bug 75153 - [assist] complete: takes forever, reads all jars MANY times
Summary: [assist] complete: takes forever, reads all jars MANY times
Status: RESOLVED DUPLICATE of bug 86579
Alias: None
Product: JDT
Classification: Eclipse Project
Component: Core (show other bugs)
Version: 3.1   Edit
Hardware: PC Windows XP
: P3 normal with 2 votes (vote)
Target Milestone: 3.1 M7   Edit
Assignee: David Audel CLA
QA Contact:
URL:
Whiteboard:
Keywords: performance
: 76747 (view as bug list)
Depends on:
Blocks:
 
Reported: 2004-09-28 06:52 EDT by Aksel Schmidt CLA
Modified: 2005-11-15 01:58 EST (History)
4 users (show)

See Also:


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Aksel Schmidt CLA 2004-09-28 06:52:36 EDT
using 3.1M2 on centrino 1.6Ghz notebook
when completing (in-type), what seems to be all jar files in classpath is read 
20-2000(!) times -> cpu goes 100% for 1 minute (using sysinternals filemon, 
javaw is the guilty, not virusscanners)ยจ

i dont expect plugins (ia use some) to be the problem, this is core 
functionality?

went back to 3.0.1, no problems...

i'll be happy to help w. debug info

/aksel
Comment 1 Aksel Schmidt CLA 2004-09-28 06:55:47 EDT
i'll take 'using 3.0.1 wo. problems' very much back... same problem :(

/Aksel
Comment 2 Philipe Mulet CLA 2004-09-28 09:15:11 EDT
Pls provide steps to reproduce. Also thread dumps are most likely a good 
indication as well (launch Eclipse with console open, and press ctrl-pause to 
get VM to dump activity).
Comment 3 Aksel Schmidt CLA 2004-09-28 16:26:35 EDT
reproduce: 
- open eclipse
- open type with an attribute
- try to 'complete' any methods on that attribute (almost always works for me, 
but it has turned into this behaviour, not always been so...)

evidence of filereading:
try to install (worlds best freeware) filemon from sysinternals.com and see 
how all jar files are pounded - (I could include this log although it only 
states that javaw reads some jar files up to 2000 times in a row within 
seconds)

maybe if this is expected behaviour, it is only my hdd which is about to fail 
(again)?

starting eclipse with 
'eclipse -vm h:\tools\j2sdk-se\1.4.2_03\jre\bin\java.exe -vmargs -Xmx256m'
I have auto build off, plugins:
- xmlbuddy
- jigloo (ui editor)
- enerjy profilers (auto start turned off, never uses)
- findbugs
- vancauwenberge.tostring
- jadclipse
- net.empanda.copyfqn_1_0_0
- net.lehnert.eclipse.genequalshashcode_0.0.5
- net.sf.jfacedbc_2.2.1
- net.sf.lunar_eclipse.editing_3.0.1
- net.trajano.eclipse.platform_3.0.0.1
- org.eclipse.ve_1.0.1 (w. required emf)

all plugins have been used in a long time, except ve (but trouble started 
before that)

trace:
Full thread dump Java HotSpot(TM) Client VM (1.4.2_03-b02 mixed mode):

"Worker-2" prio=5 tid=0x0336e340 nid=0x964 in Object.wait() [4b5f000..4b5fd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x11a48d30> (a org.eclipse.core.internal.jobs.WorkerPool)
        at org.eclipse.core.internal.jobs.WorkerPool.sleep(WorkerPool.java:166)
        - locked <0x11a48d30> (a org.eclipse.core.internal.jobs.WorkerPool)
        at org.eclipse.core.internal.jobs.WorkerPool.startJob
(WorkerPool.java:19
3)
        at org.eclipse.core.internal.jobs.Worker.run(Worker.java:59)

"Worker-1" prio=5 tid=0x03317d18 nid=0x808 in Object.wait() [4adf000..4adfd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x11a48d30> (a org.eclipse.core.internal.jobs.WorkerPool)
        at org.eclipse.core.internal.jobs.WorkerPool.sleep(WorkerPool.java:166)
        - locked <0x11a48d30> (a org.eclipse.core.internal.jobs.WorkerPool)
        at org.eclipse.core.internal.jobs.WorkerPool.startJob
(WorkerPool.java:19
3)
        at org.eclipse.core.internal.jobs.Worker.run(Worker.java:59)

"Reference Cleaner - 6" prio=7 tid=0x03fbd448 nid=0x40c in Object.wait() 
[484f00
0..484fd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x11e41de8> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
        - locked <0x11e41de8> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:127)
        at org.eclipse.jface.resource.ImageCache$ReferenceCleanerThread.run
(Imag
eCache.java:161)

"Reference Cleaner - 5" prio=7 tid=0x03fbb8c0 nid=0x9f8 in Object.wait() 
[480f00
0..480fd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x11e41ec8> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
        - locked <0x11e41ec8> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:127)
        at org.eclipse.jface.resource.ImageCache$ReferenceCleanerThread.run
(Imag
eCache.java:161)

"Reference Cleaner - 4" prio=7 tid=0x033ebdc0 nid=0x200 in Object.wait() 
[47bf00
0..47bfd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x11e41e80> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
        - locked <0x11e41e80> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:127)
        at org.eclipse.jface.resource.ImageCache$ReferenceCleanerThread.run
(Imag
eCache.java:161)

"org.eclipse.jdt.internal.ui.text.JavaReconciler" daemon prio=2 tid=0x0324fcc8 
n
id=0xad8 runnable [476f000..476fd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x11dbd170> (a 
org.eclipse.jface.text.reconciler.DirtyRegi
onQueue)
        at 
org.eclipse.jface.text.reconciler.AbstractReconciler$BackgroundThread
.run(AbstractReconciler.java:176)
        - locked <0x11dbd170> (a 
org.eclipse.jface.text.reconciler.DirtyRegionQu
eue)

"Worker-0" prio=5 tid=0x032c9258 nid=0xff0 in Object.wait() [3f1f000..3f1fd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x11a48d30> (a org.eclipse.core.internal.jobs.WorkerPool)
        at org.eclipse.core.internal.jobs.WorkerPool.sleep(WorkerPool.java:166)
        - locked <0x11a48d30> (a org.eclipse.core.internal.jobs.WorkerPool)
        at org.eclipse.core.internal.jobs.WorkerPool.startJob
(WorkerPool.java:19
3)
        at org.eclipse.core.internal.jobs.Worker.run(Worker.java:59)

"Java indexing" daemon prio=4 tid=0x031cc168 nid=0xfe4 in Object.wait() 
[3edf000
..3edfd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x11bb0278> (a 
org.eclipse.jdt.internal.core.search.indexi
ng.IndexManager)
        at java.lang.Object.wait(Object.java:429)
        at org.eclipse.jdt.internal.core.search.processing.JobManager.run
(JobMan
ager.java:345)
        - locked <0x11bb0278> (a 
org.eclipse.jdt.internal.core.search.indexing.I
ndexManager)
        at java.lang.Thread.run(Thread.java:534)

"Reference Cleaner - 3" prio=7 tid=0x0312d9c0 nid=0xfa4 in Object.wait() 
[3dcf00
0..3dcfd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x11b67ed0> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
        - locked <0x11b67ed0> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:127)
        at org.eclipse.jface.resource.ImageCache$ReferenceCleanerThread.run
(Imag
eCache.java:161)

"Reference Cleaner - 2" prio=7 tid=0x0312f398 nid=0xfc0 in Object.wait() 
[3c6f00
0..3c6fd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x11b67f40> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
        - locked <0x11b67f40> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:127)
        at org.eclipse.jface.resource.ImageCache$ReferenceCleanerThread.run
(Imag
eCache.java:161)

"Reference Cleaner - 1" prio=7 tid=0x030ec008 nid=0xf9c in Object.wait() 
[3c2f00
0..3c2fd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x11b67fb0> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
        - locked <0x11b67fb0> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:127)
        at org.eclipse.jface.resource.ImageCache$ReferenceCleanerThread.run
(Imag
eCache.java:161)

"Start Level Event Dispatcher" daemon prio=5 tid=0x02eee8e8 nid=0xd50 in 
Object.
wait() [300f000..300fd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x114df308> (a 
org.eclipse.osgi.framework.eventmgr.EventTh
read)
        at java.lang.Object.wait(Object.java:429)
        at org.eclipse.osgi.framework.eventmgr.EventThread.getNextEvent
(EventThr
ead.java:162)
        - locked <0x114df308> (a 
org.eclipse.osgi.framework.eventmgr.EventThread
)
        at org.eclipse.osgi.framework.eventmgr.EventThread.run
(EventThread.java:
100)

"Framework Event Dispatcher" daemon prio=5 tid=0x02de8ba8 nid=0xe70 in 
Object.wa
it() [2fcf000..2fcfd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x114d83f8> (a 
org.eclipse.osgi.framework.eventmgr.EventTh
read)
        at java.lang.Object.wait(Object.java:429)
        at org.eclipse.osgi.framework.eventmgr.EventThread.getNextEvent
(EventThr
ead.java:162)
        - locked <0x114d83f8> (a 
org.eclipse.osgi.framework.eventmgr.EventThread
)
        at org.eclipse.osgi.framework.eventmgr.EventThread.run
(EventThread.java:
100)

"Signal Dispatcher" daemon prio=10 tid=0x0003dc68 nid=0xd28 waiting on 
condition
 [0..0]

"Finalizer" daemon prio=9 tid=0x009e0990 nid=0xd20 in Object.wait() 
[2c7f000..2c
7fd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x113ce850> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:111)
        - locked <0x113ce850> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:127)
        at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:159)

"Reference Handler" daemon prio=10 tid=0x009df560 nid=0xd1c in Object.wait() 
[2c
3f000..2c3fd8c]
        at java.lang.Object.wait(Native Method)
        - waiting on <0x113ce8b8> (a java.lang.ref.Reference$Lock)
        at java.lang.Object.wait(Object.java:429)
        at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:115)
        - locked <0x113ce8b8> (a java.lang.ref.Reference$Lock)

"main" prio=7 tid=0x00035878 nid=0xecc waiting on condition [7e000..7fc3c]
        at java.lang.String.substring(String.java:1446)
        at org.eclipse.jdt.internal.core.util.Util.splitOn(Util.java:1679)
        at 
org.eclipse.jdt.internal.core.JarPackageFragmentRoot.initPackageFragT
oTypes(JarPackageFragmentRoot.java:237)
        at org.eclipse.jdt.internal.core.JarPackageFragmentRoot.computeChildren
(
JarPackageFragmentRoot.java:97)
        at org.eclipse.jdt.internal.core.PackageFragmentRoot.buildStructure
(Pack
ageFragmentRoot.java:173)
        at org.eclipse.jdt.internal.core.Openable.generateInfos
(Openable.java:20
2)
        at org.eclipse.jdt.internal.core.JarPackageFragment.generateInfos
(JarPac
kageFragment.java:113)
        at org.eclipse.jdt.internal.core.JavaElement.openWhenClosed
(JavaElement.
java:544)
        at org.eclipse.jdt.internal.core.JavaElement.getElementInfo
(JavaElement.
java:291)
        at org.eclipse.jdt.internal.core.JavaElement.getElementInfo
(JavaElement.
java:277)
        at org.eclipse.jdt.internal.core.JavaElement.getChildren
(JavaElement.jav
a:232)
        at org.eclipse.jdt.internal.core.JavaElement.getChildrenOfType
(JavaEleme
nt.java:246)
        at org.eclipse.jdt.internal.core.JarPackageFragment.getClassFiles
(JarPac
kageFragment.java:120)
        at org.eclipse.jdt.internal.core.NameLookup.seekTypesInBinaryPackage
(Nam
eLookup.java:575)
        at org.eclipse.jdt.internal.core.NameLookup.seekTypes
(NameLookup.java:55
6)
        at org.eclipse.jdt.internal.core.NameLookup.findType
(NameLookup.java:381
)
        at org.eclipse.jdt.internal.core.NameLookup.findType
(NameLookup.java:352
)
        at org.eclipse.jdt.internal.core.NameLookup.findType
(NameLookup.java:460
)
        at org.eclipse.jdt.internal.core.JavaProject.findType
(JavaProject.java:1
067)
        at org.eclipse.jdt.internal.core.JavaProject.findType
(JavaProject.java:1
058)
        at org.eclipse.jdt.internal.core.JavaProject.findType
(JavaProject.java:1
075)
        at org.eclipse.jdt.internal.core.JavaProject.findType
(JavaProject.java:1
058)
        at org.eclipse.jdt.internal.core.JavaProject.findType
(JavaProject.java:1
075)
        at org.eclipse.jdt.internal.core.JavaProject.findType
(JavaProject.java:1
058)
        at org.eclipse.jdt.internal.ui.text.java.ParameterGuesser.isAssignable
(P
arameterGuesser.java:662)
        at org.eclipse.jdt.internal.ui.text.java.ParameterGuesser.isTypeMatch
(Pa
rameterGuesser.java:638)
        at 
org.eclipse.jdt.internal.ui.text.java.ParameterGuesser.findFieldsMatc
hingType(ParameterGuesser.java:589)
        at 
org.eclipse.jdt.internal.ui.text.java.ParameterGuesser.parameterPropo
sals(ParameterGuesser.java:390)
        at 
org.eclipse.jdt.internal.ui.text.java.ParameterGuessingProposal.guess
Parameters(ParameterGuessingProposal.java:254)
        at 
org.eclipse.jdt.internal.ui.text.java.ParameterGuessingProposal.compu
teGuessingCompletion(ParameterGuessingProposal.java:284)
        at 
org.eclipse.jdt.internal.ui.text.java.ParameterGuessingProposal.apply
(ParameterGuessingProposal.java:144)
        at org.eclipse.jdt.internal.ui.text.java.JavaCompletionProposal.apply
(Ja
vaCompletionProposal.java:557)
        at 
org.eclipse.jface.text.contentassist.CompletionProposalPopup.insertPr
oposal(CompletionProposalPopup.java:415)
        at 
org.eclipse.jface.text.contentassist.CompletionProposalPopup.selectPr
oposalWithMask(CompletionProposalPopup.java:362)
        at 
org.eclipse.jface.text.contentassist.CompletionProposalPopup.verifyKe
y(CompletionProposalPopup.java:720)
        at 
org.eclipse.jface.text.contentassist.ContentAssistant$InternalListene
r.verifyKey(ContentAssistant.java:622)
        at 
org.eclipse.jface.text.TextViewer$VerifyKeyListenersManager.verifyKey
(TextViewer.java:404)
        at org.eclipse.swt.custom.StyledTextListener.handleEvent
(StyledTextListe
ner.java:55)
        at org.eclipse.swt.widgets.EventTable.sendEvent(EventTable.java:82)
        at org.eclipse.swt.widgets.Widget.sendEvent(Widget.java:796)
        at org.eclipse.swt.widgets.Widget.sendEvent(Widget.java:820)
        at org.eclipse.swt.widgets.Widget.sendEvent(Widget.java:805)
        at org.eclipse.swt.widgets.Widget.notifyListeners(Widget.java:613)
        at org.eclipse.swt.custom.StyledText.handleKeyDown
(StyledText.java:5000)

        at org.eclipse.swt.custom.StyledText$7.handleEvent
(StyledText.java:4747)

        at org.eclipse.swt.widgets.EventTable.sendEvent(EventTable.java:82)
        at org.eclipse.swt.widgets.Widget.sendEvent(Widget.java:796)
        at org.eclipse.swt.widgets.Widget.sendEvent(Widget.java:820)
        at org.eclipse.swt.widgets.Widget.sendEvent(Widget.java:805)
        at org.eclipse.swt.widgets.Control.sendKeyEvent(Control.java:1736)
        at org.eclipse.swt.widgets.Control.sendKeyEvent(Control.java:1732)
        at org.eclipse.swt.widgets.Control.WM_CHAR(Control.java:3073)
        at org.eclipse.swt.widgets.Control.windowProc(Control.java:2975)
        at org.eclipse.swt.widgets.Display.windowProc(Display.java:3349)
        at org.eclipse.swt.internal.win32.OS.DispatchMessageW(Native Method)
        at org.eclipse.swt.internal.win32.OS.DispatchMessage(OS.java:1479)
        at org.eclipse.swt.widgets.Display.readAndDispatch(Display.java:2440)
        at org.eclipse.ui.internal.Workbench.runEventLoop(Workbench.java:1443)
        at org.eclipse.ui.internal.Workbench.runUI(Workbench.java:1414)
        at org.eclipse.ui.internal.Workbench.createAndRunWorkbench
(Workbench.jav
a:271)
        at org.eclipse.ui.PlatformUI.createAndRunWorkbench(PlatformUI.java:144)
        at org.eclipse.ui.internal.ide.IDEApplication.run
(IDEApplication.java:10
2)
        at org.eclipse.core.internal.runtime.PlatformActivator$1.run
(PlatformAct
ivator.java:335)
        at org.eclipse.core.runtime.adaptor.EclipseStarter.run
(EclipseStarter.ja
va:273)
        at org.eclipse.core.runtime.adaptor.EclipseStarter.run
(EclipseStarter.ja
va:129)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke
(NativeMethodAccessorImpl.
java:39)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke
(DelegatingMethodAcces
sorImpl.java:25)
        at java.lang.reflect.Method.invoke(Method.java:324)
        at org.eclipse.core.launcher.Main.basicRun(Main.java:185)
        at org.eclipse.core.launcher.Main.run(Main.java:704)
        at org.eclipse.core.launcher.Main.main(Main.java:688)

"VM Thread" prio=5 tid=0x00a1b6d0 nid=0xd18 runnable

"VM Periodic Task Thread" prio=10 tid=0x00a1c488 nid=0xd2c waiting on condition

"Suspend Checker Thread" prio=10 tid=0x0003d320 nid=0xd24 runnable

Comment 4 Frederic Fusier CLA 2004-10-27 13:44:05 EDT
*** Bug 76747 has been marked as a duplicate of this bug. ***
Comment 5 Jerome Lanneluc CLA 2004-12-16 10:01:18 EST
Aksel, do you still have the problem using 3.1 M4 (to be out at the en dof the
week) ?
Comment 6 Aksel Schmidt CLA 2005-01-04 03:22:23 EST
hi

for a long time, the 'forever' symptome seemed gone, but yesterday, i worked 
on a 500+ file project and nearly every operation (not just completion, but 
maybe ast related tasks such as follow link to (f3), find ancestors (ctrl-t) 
took forever. starting filemon from sysinternals produced a near similar 
result as previously, but i am not sure that this is the same problem.
every jar file is read thousands and thousands of times - maybe this is 
because of low mem? (i have 1 gb, but it could still be exhausted - i didnt 
check))
the javaw process made over 50 millions (!) read accesses, mostly to jar 
files. the process explorer (sysinternals) showed which handles were held by 
eclipse and this revealed about 55 jar files (all plugins etc. included), 
the 'core' build classpath of the project was 12 jar files and two source 
folders.
common to the file accesses was very small reads (20-100 bytes) but many, here 
is an example from filemon:
1	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3047460 Length: 30	
2	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3047490 Length: 71	
3	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3048668 Length: 30	
4	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3048698 Length: 69	
5	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3049564 Length: 30	
6	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3049594 Length: 69	
7	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3050451 Length: 30	
8	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3050481 Length: 75	
9	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3051352 Length: 30	
10	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3051382 Length: 75	
11	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3052371 Length: 30	
12	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3052401 Length: 65	
13	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3054401 Length: 30	
14	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3054431 Length: 66	
15	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3055324 Length: 30	
16	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3055354 Length: 58	
17	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3056936 Length: 30	
18	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3056966 Length: 77	
19	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3058204 Length: 30	
20	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3058234 Length: 60	
21	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3059389 Length: 30	
22	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3059419 Length: 67	
23	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3060030 Length: 30	
24	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3060060 Length: 79	
25	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3060508 Length: 30	
26	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3060538 Length: 76	
27	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3060911 Length: 30	
28	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3060941 Length: 68	
29	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3063726 Length: 30	
30	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3063756 Length: 79	
31	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3065716 Length: 30	
32	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3065746 Length: 77	
33	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3067584 Length: 30	
34	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3067614 Length: 78	
35	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3069131 Length: 30	
36	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3069161 Length: 74	
37	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3070539 Length: 30	
38	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3070569 Length: 60	
39	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3072005 Length: 30	
40	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3072035 Length: 82	
41	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3073193 Length: 30	
42	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3073223 Length: 83	
43	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3076015 Length: 30	
44	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3076045 Length: 85	
45	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3077086 Length: 30	
46	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3077116 Length: 76	
47	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3080568 Length: 30	
48	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3080598 Length: 87	
49	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3081335 Length: 30	
50	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3081365 Length: 65	
51	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3082228 Length: 30	
52	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3082258 Length: 65	
53	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3083481 Length: 30	
54	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3083511 Length: 65	
55	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3084376 Length: 30	
56	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3084406 Length: 65	
57	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3085684 Length: 30	
58	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3085714 Length: 63	
59	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3107996 Length: 30	
60	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3108026 Length: 71	
61	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3110105 Length: 30	
62	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3110135 Length: 62	
63	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3115003 Length: 30	
64	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3115033 Length: 67	
65	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3115493 Length: 30	
66	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3115523 Length: 69	
67	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3116027 Length: 30	
68	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3116057 Length: 70	
69	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3118650 Length: 30	
70	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3118680 Length: 78	
71	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3120063 Length: 30	
72	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3120093 Length: 69	
73	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3122535 Length: 30	
74	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3122565 Length: 70	
75	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3127699 Length: 30	
76	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3127729 Length: 65	
77	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3130852 Length: 30	
78	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3130882 Length: 65	
79	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3132804 Length: 30	
80	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3132834 Length: 75	
81	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3136009 Length: 30	
82	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3136039 Length: 76	
83	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3137664 Length: 30	
84	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3137694 Length: 85	
85	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3138933 Length: 30	
86	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3138963 Length: 90	
87	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3140369 Length: 30	
88	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3140399 Length: 91	
89	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3141996 Length: 30	
90	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3142026 Length: 75	
91	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3144020 Length: 30	
92	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3144050 Length: 71	
93	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3145200 Length: 30	
94	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3145230 Length: 65	
95	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3147959 Length: 30	
96	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3147989 Length: 71	
97	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3148828 Length: 30	
98	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3148858 Length: 68	
99	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3149115 Length: 30	
100	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3149145 Length: 70	
101	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3149560 Length: 30	
102	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3149590 Length: 73	
103	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3150024 Length: 30	
104	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3150054 Length: 79	
105	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3152011 Length: 30	
106	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3152041 Length: 60	
107	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3152501 Length: 30	
108	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3152531 Length: 82	
109	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3152974 Length: 30	
110	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3153004 Length: 90	
111	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3154638 Length: 30	
112	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3154668 Length: 93	
113	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3156065 Length: 30	
114	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3156095 Length: 96	
115	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3157560 Length: 30	
116	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3157590 Length: 104	
117	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3158004 Length: 30	
118	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3158034 Length: 93	
119	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3158426 Length: 30	
120	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3158456 Length: 89	
121	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3158816 Length: 30	
122	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3158846 Length: 93	
123	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3159197 Length: 30	
124	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3159227 Length: 92	
125	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3159752 Length: 30	
126	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3159782 Length: 84	
127	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3160266 Length: 30	
128	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3160296 Length: 92	
129	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3161883 Length: 30	
130	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3161913 Length: 85	
131	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3162341 Length: 30	
132	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3162371 Length: 93	
133	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3163867 Length: 30	
134	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3163897 Length: 93	
135	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3164713 Length: 30	
136	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3164743 Length: 106	
137	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3165358 Length: 30	
138	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3165388 Length: 100	
139	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3165851 Length: 30	
140	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3165881 Length: 99	
141	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3166339 Length: 30	
142	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3166369 Length: 108	
143	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3166850 Length: 30	
144	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3166880 Length: 120	
145	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3167396 Length: 30	
146	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3167426 Length: 106	
147	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3167901 Length: 30	
148	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3167931 Length: 109	
149	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3168418 Length: 30	
150	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3168448 Length: 106	
151	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3168931 Length: 30	
152	15:34:19	javaw.exe:2692	READ	H:\cws-flex-build\nightly\cws-
flex\dev\build\lib\cws-flex.jar	SUCCESS	Offset: 3168961 Length: 108
Comment 7 Aksel Schmidt CLA 2005-01-04 16:56:41 EST
no, it is not mem-exhaustion, still got 400 mb free
i can reproduce now with ease
it may be worth to mention that the classpath entries is located on a pgp-
drive, but i cant see why this should slow down this much - file operations 
could generally be slower but it still doesn't explain the millions af reads
/aksel
Comment 8 Richard Emerson CLA 2005-01-07 11:11:26 EST
Hi - I see what appears to be the same problem, or a related problem, but in a
different place.  Here's what I do:

Start Eclipse, go to Java Browsing perspective, click on my project in the
Projects view.

Eclipse then goes busy for a few minutes.  Once it completes whatever it's
doing, things work normally.

Selecting e.g. a source folder in my project, then selecting the project itself
again, causes the problem to happen again.

If I reproduce the problem in a Runtime Workbench, and pause it in the debugger
at intervals, I see that Eclipse is doing something to the jars in my project's
lib (there are 70+ jars in there).  From the stack trace, I would guess that it
is rebuilding the contents of the Packages view.  Perhaps some cache or index is
not being saved?

Here is one such stack trace (apologies for messy pasting):

Thread [main] (Suspended)
	ZipFile.getNextEntry(long, int) line: not available [native method]
	ZipFile.access$400(long, int) line: 26
	ZipFile$2.nextElement() line: 313 [local variables unavailable]
	JarPackageFragmentRoot.computeChildren(OpenableElementInfo, Map) line: 86
	JarPackageFragmentRoot(PackageFragmentRoot).buildStructure(OpenableElementInfo,
IProgressMonitor, Map, IResource) line: 173
	JarPackageFragmentRoot(Openable).generateInfos(Object, HashMap,
IProgressMonitor) line: 203
	JarPackageFragmentRoot(JavaElement).openWhenClosed(Object, IProgressMonitor)
line: 547
	JarPackageFragmentRoot(JavaElement).getElementInfo(IProgressMonitor) line: 291
	JarPackageFragmentRoot(JavaElement).getElementInfo() line: 277
	JarPackageFragmentRoot(JavaElement).getChildren() line: 232
	JarPackageFragment(PackageFragment).hasSubpackages() line: 355
	EmptyInnerPackageFilter.select(Viewer, Object, Object) line: 35
	PackagesViewTableViewer(StructuredViewer).filter(Object[]) line: 585
	PackagesViewTableViewer.selectLogicalPackage(LogicalPackage) line: 83
	PackagesViewTableViewer.getFilteredChildren(Object) line: 70
	PackagesViewTableViewer(StructuredViewer).getSortedChildren(Object) line: 823
	PackagesViewTableViewer(TableViewer).internalRefresh(Object, boolean) line: 725
	PackagesViewTableViewer(TableViewer).internalRefresh(Object) line: 706
	PackagesViewTableViewer.internalRefresh(Object) line: 105
	StructuredViewer$7.run() line: 1172
	PackagesViewTableViewer(StructuredViewer).preservingSelection(Runnable) line: 1109
	PackagesViewTableViewer(StructuredViewer).refresh(Object) line: 1170
	PackagesViewTableViewer(StructuredViewer).refresh() line: 1129
	PackagesViewTableViewer(TableViewer).inputChanged(Object, Object) line: 667
	PackagesViewTableViewer(ContentViewer).setInput(Object) line: 248
	PackagesViewTableViewer(StructuredViewer).setInput(Object) line: 1314
	PackageViewerWrapper.setViewerInput(Object) line: 307
	PackagesView.setViewerWrapperInput(Object) line: 340
	PackagesView.setInput(Object) line: 335
	PackagesView(JavaBrowsingPart).adjustInputAndSetSelection(Object) line: 1003
	PackagesView.adjustInputAndSetSelection(Object) line: 411
	PackagesView(JavaBrowsingPart).selectionChanged(IWorkbenchPart, ISelection)
line: 754
	AbstractSelectionService$4.run() line: 182
	InternalPlatform.run(ISafeRunnable) line: 1044
	Platform.run(ISafeRunnable) line: 747
	PageSelectionService(AbstractSelectionService).firePostSelection(IWorkbenchPart,
ISelection) line: 180
	AbstractSelectionService$2.selectionChanged(SelectionChangedEvent) line: 75
	StructuredViewer$3.run() line: 681
	InternalPlatform.run(ISafeRunnable) line: 1044
	Platform.run(ISafeRunnable) line: 747
	ProblemTreeViewer(StructuredViewer).firePostSelectionChanged(SelectionChangedEvent)
line: 679
	ProblemTreeViewer(StructuredViewer).handlePostSelect(SelectionEvent) line: 950
	StructuredViewer$5.widgetSelected(SelectionEvent) line: 970
	OpenStrategy.firePostSelectionEvent(SelectionEvent) line: 231
	OpenStrategy.access$4(OpenStrategy, SelectionEvent) line: 226
	OpenStrategy$3.run() line: 392
	RunnableLock.run() line: 35
	UISynchronizer(Synchronizer).runAsyncMessages(boolean) line: 118
	Display.runAsyncMessages(boolean) line: 2780
	Display.readAndDispatch() line: 2451
	Workbench.runEventLoop(Window$IExceptionHandler, Display) line: 1569
	Workbench.runUI() line: 1540
	Workbench.createAndRunWorkbench(Display, WorkbenchAdvisor) line: 285
	PlatformUI.createAndRunWorkbench(Display, WorkbenchAdvisor) line: 144
	IDEApplication.run(Object) line: 102
	PlatformActivator$1.run(Object) line: 220
	EclipseStarter.run(Object) line: 273
	EclipseStarter.run(String[], Runnable) line: 129
	NativeMethodAccessorImpl.invoke0(Method, Object, Object[]) line: not available
[native method]
	NativeMethodAccessorImpl.invoke(Object, Object[]) line: 39
	DelegatingMethodAccessorImpl.invoke(Object, Object[]) line: 25
	Method.invoke(Object, Object[]) line: 324
	Main.basicRun(String[]) line: 185
	Main.run(String[]) line: 710
	Main.main(String[]) line: 694

The ZipFile instance at the top refers to one of the jars in my project's lib
directory.  Pausing later on gives a similar trace with a different jar, and so on.

Hope this helps.  I'll try to investigate more but I confess this is my first
time in the PDE/runtime-workbench side of things.

Cheers

Richard
Comment 9 Richard Emerson CLA 2005-01-07 11:14:33 EST
Doh - sorry that was with 3.1M4, no extra plugins.  Previously with 3.0.1 I had
not seen the problem.
Comment 10 Richard Emerson CLA 2005-01-12 05:28:10 EST
After some investigation my suspicions lie in and around
JavaElement.openWhenClosed() : I think that ElementInfos for
JarPackageFragments/JarPackageFragmentRoots (built up during this method's use
of the JavaModelManager's thread-local 'temporary cache') are not always making
it into the 'main' cache.  But, this might just be my lack of understanding.

I'll try to figure out how to actually change the code locally instead of just
debugging it from a source attachment, so I can test my theory.  Jumping in at
the deep end like this is pretty mind-blowing but it's fun ;)
Comment 11 David Audel CLA 2005-04-06 04:49:11 EDT
Aksel - Inside comment 6 i can see that cws-flex.jar is on H drive. Is it a
network drive ? If it is a network drive, did you observe the same problem on a
local drive ?
If it is possible, could you try to reproduce the problem on a local (and not
pgp) drive ?

I aks this question to know if the problem is caused by the nature of this drive
or not.
Comment 12 David Audel CLA 2005-04-07 07:50:35 EDT
The first problem seems to be the same as bug 86579.

Tom, could you confirm that ?

The second problem (comment 8) seems to be a little bit different.
Comment 13 Richard Emerson CLA 2005-04-07 08:19:42 EDT
Hi there.  I wrote comment #8 and I can well believe that is, in fact, a
separate  problem.

FYI I've been unable to replicate my problem in M5a - so you should probably
ignore my comments on this bug.

Good luck ;)
Comment 14 Aksel Schmidt CLA 2005-04-07 09:13:08 EDT
(In reply to comment #11)
> Aksel - Inside comment 6 i can see that cws-flex.jar is on H drive. Is it a
> network drive ? If it is a network drive, did you observe the same problem 
on a
> local drive ?
> If it is possible, could you try to reproduce the problem on a local (and not
> pgp) drive ?
> I aks this question to know if the problem is caused by the nature of this 
drive
> or not.

hi

i can reproduce on non pgp or network drive
i have experienced that this only happens to me when having worked on large 
files (1000+ lines of code)
each time i return to the large file projekt, i get the 'experience', in small 
file projects i never get any problems like this.

of course, i could reduce the file sizes, but it still seems like a bug out of 
proportions (i could understand wait time linear to type sizes, but this 
should not be minutes)

/aksel

Comment 15 Aksel Schmidt CLA 2005-04-07 09:14:14 EDT
oh, i just reproduced on M5a

thanks!

/aksel

Comment 16 Tom Hofmann CLA 2005-04-07 09:35:06 EDT
(In reply to comment #12)
> The first problem seems to be the same as bug 86579.
> 
> Tom, could you confirm that ?

Looking at the thread dump this is almost certainly a dup of bug 86579.

> The second problem (comment 8) seems to be a little bit different.

Agree, this sounds more like an IO issue. Doesn't have anything to do with code
assist anyway.

Comment 17 David Audel CLA 2005-04-18 09:36:17 EDT

*** This bug has been marked as a duplicate of 86579 ***
Comment 18 alex CLA 2005-11-15 01:58:49 EST
I got this issue on eclipse 3.1 when I'm trying to open a java package view in 
our project, the eclipse seems freezed (except the project's java files are 
very few), I have to pause the running and I got a stack trace like this:

JarPackageFragmentRootInfo(PackageFragmentRootInfo).<init>() line: 50
JarPackageFragmentRootInfo.<init>() line: 16
JarPackageFragmentRoot.createElementInfo() line: 148
JarPackageFragment.generateInfos(Object, HashMap, IProgressMonitor) line: 113
JarPackageFragment(JavaElement).openWhenClosed(Object, IProgressMonitor) line: 
488
JarPackageFragment(JavaElement).getElementInfo(IProgressMonitor) line: 232
JarPackageFragment(JavaElement).getElementInfo() line: 218
JarPackageFragment(JavaElement).getChildren() line: 173
JarPackageFragment(JavaElement).getChildrenOfType(int) line: 187
JarPackageFragment.getClassFiles() line: 120
NameLookup.seekTypesInBinaryPackage(String, IPackageFragment, boolean, int, 
IJavaElementRequestor) line: 793
NameLookup.seekTypes(String, IPackageFragment, boolean, int, 
IJavaElementRequestor) line: 769
NameLookup.findType(String, IPackageFragment, boolean, int) line: 542
NameLookup.findType(String, String, boolean, int) line: 501
NameLookup.findType(String, boolean, int) line: 633
JavaProject.findType(String, WorkingCopyOwner) line: 1141
JavaProject.findType(String) line: 1113
JavaProject.findType(String, WorkingCopyOwner) line: 1149
JavaProject.findType(String) line: 1113
JavaClassUtils.getQualifiedTypeName(IType, String) line: 537
JavaClassUtils.getQualifiedTypeNameInTypeHierarchy(IType, String) line: 470
JavaBeanUtils.getMethodWithSameParamters(IMethod[], Map, IMethod, String, String
[]) line: 708
JavaBeanUtils.getBeanProperties(IType, IMethod[]) line: 795
ManagedBeanTreeItem.addPropertyItems(IType, IMethod[], TreeParent, List) line: 
539
ManagedBeanTreeItem.getClassInformation(TreeParent, String, 
ManagedBeanTypeImpl) line: 522
ManagedBeanTreeItem.getBeanInformation(TreeParent) line: 442
ManagedBeanTreeItem.hasChildren() line: 252
ScopeContentProvider(ManagedBeanContentProvider).hasChildren(Object) line: 133
DataBindingsContentProvider.hasChildren(Object) line: 208
DataBindingViewer(AbstractTreeViewer).isExpandable(Object) line: 1378
DataBindingViewer(AbstractTreeViewer).updatePlus(Item, Object) line: 1845
DataBindingViewer(AbstractTreeViewer).createTreeItem(Widget, Object, int) line: 
536
AbstractTreeViewer$1.run() line: 514
BusyIndicator.showWhile(Display, Runnable) line: 69
DataBindingViewer(AbstractTreeViewer).createChildren(Widget) line: 494
DataBindingViewer(AbstractTreeViewer).handleTreeExpand(TreeEvent) line: 948
AbstractTreeViewer$4.treeExpanded(TreeEvent) line: 959
TypedListener.handleEvent(Event) line: 180
EventTable.sendEvent(Event) line: 66
Tree(Widget).sendEvent(Event) line: 843
Tree(Widget).sendEvent(int, Event, boolean) line: 867
Tree(Widget).sendEvent(int, Event) line: 852
Tree.wmNotifyChild(int, int) line: 3708
Composite(Control).WM_NOTIFY(int, int) line: 3568
Composite.WM_NOTIFY(int, int) line: 1035
Composite(Control).windowProc(int, int, int, int) line: 3089
Display.windowProc(int, int, int, int) line: 3706
OS.CallWindowProcW(int, int, int, int, int) line: not available [native method]
OS.CallWindowProc(int, int, int, int, int) line: 1580
Tree.callWindowProc(int, int, int, int) line: 219
Tree.WM_LBUTTONDOWN(int, int) line: 2815
Tree(Control).windowProc(int, int, int, int) line: 3071
Tree.windowProc(int, int, int, int) line: 2391
Display.windowProc(int, int, int, int) line: 3706
OS.DispatchMessageW(MSG) line: not available [native method]
OS.DispatchMessage(MSG) line: 1656
Display.readAndDispatch() line: 2711
Workbench.runEventLoop(Window$IExceptionHandler, Display) line: 1699
Workbench.runUI() line: 1663
Workbench.createAndRunWorkbench(Display, WorkbenchAdvisor) line: 367
PlatformUI.createAndRunWorkbench(Display, WorkbenchAdvisor) line: 143
IDEApplication.run(Object) line: 103
PlatformActivator$1.run(Object) line: 226
EclipseStarter.run(Object) line: 376
EclipseStarter.run(String[], Runnable) line: 163
NativeMethodAccessorImpl.invoke0(Method, Object, Object[]) line: not available 
[native method]
NativeMethodAccessorImpl.invoke(Object, Object[]) line: 39
DelegatingMethodAccessorImpl.invoke(Object, Object[]) line: 25
Method.invoke(Object, Object[]) line: 324
Main.invokeFramework(String[], URL[]) line: 334
Main.basicRun(String[]) line: 278
Main.run(String[]) line: 973
Main.main(String[]) line: 948

The problem is on eclipse ver 3.0, I didn't encounter this problem. And the 
stange is my colleagues don't have this problem on 3.1. But on my machine each 
time I try to open the viewer I can reproduce this problem. I see a similiar 
bug report that is 75153. But this happens to 3.1 release, so what's the 
conclusion of this performance issue, machine, jdk, or eclipse itself, why 3.0 
has no problem, only 3.1 ?

Anyone can help?