On Wed, Dec 07, 2011 at 09:08:30AM +0100, Hammer Attila wrote:
Paul, this is very interesting. I maked a fresh debug.out file now my Precise system. I see interesting informations, but please if anybody not would like looking the detailed debug.out file content, please close this letter. Unfortunately, a normal Thunderbird launching operation generated my machine a six mbite sized debug.out file, so I unable to attaching this file the list or Bugzilla.
bugzilla rejects it even if its compressed? that's a little suprising I though the limit was a bit bigger.
After Orca mapped Thunderbird script, following lines present lot of time the debug.out file: "DEQUEUED OBJECT:PROPERTY-CHANGE:ACCESSIBLE-NAME <---------- vvvvv PROCESS OBJECT EVENT object:property-change:accessible-name vvvvv OBJECT EVENT: object:property-change:accessible-name detail=(0,0,- Mozilla Thunderbird) ----------> QUEUEING WINDOW:CREATE ----------> QUEUEING OBJECT:CHILDREN-CHANGED:ADD:SYSTEM ----------> QUEUEING OBJECT:CHILDREN-CHANGED:ADD:SYSTEM ----------> QUEUEING OBJECT:CHILDREN-CHANGED:ADD:SYSTEM ----------> QUEUEING OBJECT:CHILDREN-CHANGED:ADD:SYSTEM ----------> QUEUEING OBJECT:CHILDREN-CHANGED:ADD:SYSTEM ----------> QUEUEING OBJECT:CHILDREN-CHANGED:ADD:SYSTEM ----------> QUEUEING OBJECT:CHILDREN-CHANGED:ADD:SYSTEM" After more this type equals lines, presenting following information: "----------> QUEUEING OBJECT:STATE-CHANGED:SHOWING ----------> QUEUEING OBJECT:PROPERTY-CHANGE:ACCESSIBLE-NAME ----------> QUEUEING OBJECT:PROPERTY-CHANGE:ACCESSIBLE-NAME" The last line I see lot of time the debug.out file before new information presenting (more than 9 lines). After this following informations presenting: "----------> QUEUEING WINDOW:ACTIVATE ----------> QUEUEING OBJECT:STATE-CHANGED:ACTIVE ----------> QUEUEING FOCUS: ----------> QUEUEING OBJECT:STATE-CHANGED:FOCUSED IGNORING DEFUNCT OBJECT
that's a little weird, but I doubt its a major cause of delay here.
TOTAL PROCESSING TIME: 24.5515
what unit is this? if its seconds that's really suprising.
^^^^^ PROCESS OBJECT EVENT object:property-change:accessible-name ^^^^^
DEQUEUED WINDOW:CREATE <----------
vvvvv PROCESS OBJECT EVENT window:create vvvvv
OBJECT EVENT: window:create detail=(0,0,-
Mozilla Thunderbird)
----------> QUEUEING WINDOW:DEACTIVATE
----------> QUEUEING OBJECT:STATE-CHANGED:FOCUSED
----------> QUEUEING OBJECT:STATE-CHANGED:ACTIVE
KEYEVENT: type=1
id=65515
hw_code=133
modifiers=64
event_string=(Super_L)
is_text=True
timestamp=797651
time=1323240812.190665
KEYBOARDEVENT: type=1
id=65515
hw_code=133
modifiers=64
event_string=(Super_L)
keyval_name=(Super_L)
is_text=True
timestamp=797651
time=1323240812.191259
orca.isModifierKey: returning: False
orca.isModifierKey: returning: False
I'm guessing you were asking your window manager to do something here? its not a big deal, but trying to avoid doing this sort of thing is probably a good idea to keep the log as simple as possible.
After this, again presenting the "----------> QUEUEING OBJECT:PROPERTY-CHANGE:ACCESSIBLE-NAME " type line, more than 2268
that's about how many mails you have right? if so I think this is sort of to be expected, and not really unreasonable, but I suspect causes a bit of the perf issue you are seeing. (I'm really not sure what the solution here is though)
After this, again following more "----------> QUEUEING OBJECT:PROPERTY-CHANGE:ACCESSIBLE-NAME" type line, I counting 7450 equals line.
hmm, that's a little interesting, I wonder if there is two accessibles for each thunderbird message or something.
Now following the importanter information I think, but I not quote entire remaing part, because very long the text:
it'd be nice to have the full log, but I'd guess the issue or atleast a big issue is the 10000 or so name change events from thunderbird. I'm not really sure how many accessibles there are per message, but I think 1 name change and one child added per message is pretty obligatory. Which leaves us with the question of what to do about these cases where the app needs to fire a zilion events to keep at-spi's cache up to date. Trev
Attachment:
signature.asc
Description: Digital signature