Re: Long pauses in applications maybe due to gpbs : Timed out waiting for X...

[Wolfgang Lux]

Fred Kiefer wrote:

> The interesting line is:
> Owning program failed to convert data.
>
> Could it be that the content of the pasteboard was something that  
> wasn't
> a string, but our code always expects that it can be converted to a  
> string?
>
> Am 30.01.2011 22:10, schrieb Philippe Roussel:
> > Le samedi 29 janvier 2011 à 21:26 +0100, Philippe Roussel a écrit :
> > > Le samedi 29 janvier 2011 à 14:11 +0100, Fred Kiefer a écrit :
> > > > I remember this behaviour form way back, but cannot remember  
> > > > seeing it
> > > > in recent years. I may just have been lucky, though.
> > > > Could you please start gpbs manually and switch on debug output  
> > > > for "Pbs"?
> > > > This command should do the trick:
> > > > gpbs --GNU-Debug=Pbs --verbose --verbose
> > > >
> > > > Providing verbose twice should given even more output than using  
> > > > in once:-)
> > > >
> > > > The whole pasteboard interaction is a bit of a mess.
> > >
> > > And, how surprising, I can't reproduce the problem anymore. And I  
> > > have
> > > no idea what could have changed since yesterday...
> >
> > I managed to capture a 3 second hang but I'm not sure the log will  
> > help
> > much. The first panel I opened worked fine but at 22:05:44 I opened a
> > second one in the same application hit the timeout :
> >
> > 2011-01-30 22:05:24.002 gpbs[7030] <PasteboardObject: 0x9a0ce50>  
> > get data for type 'NSStringPboardType' version 1
> > 2011-01-30 22:05:24.002 gpbs[7030] PropertyNotify.
> > 2011-01-30 22:05:24.002 gpbs[7030] Selection (PRIMARY) notify -  
> > 'None'.
> > 2011-01-30 22:05:24.002 gpbs[7030] Owning program failed to convert  
> > data.
> > 2011-01-30 22:05:24.002 gpbs[7030] SelectionNotify.
> > 2011-01-30 22:05:24.003 gpbs[7030] PropertyNotify.
> > 2011-01-30 22:05:24.003 gpbs[7030] Selection (PRIMARY) notify -  
> > 'None'.
> > 2011-01-30 22:05:24.003 gpbs[7030] Owning program failed to convert  
> > data.
> > 2011-01-30 22:05:24.003 gpbs[7030] SelectionNotify.
> > 2011-01-30 22:05:24.003 gpbs[7030] <PasteboardObject: 0x9a0ce50>  
> > set data for type 'NSStringPboardType' version 1
> > 2011-01-30 22:05:24.003 gpbs[7030] set data for 0x9a0b9c8
> > 2011-01-30 22:05:24.003 gpbs[7030] get data for 0x9a0b9c8
> > 2011-01-30 22:05:44.903 gpbs[7030] <PasteboardObject: 0x9a0ce50>  
> > get data for type 'NSStringPboardType' version 1
> > 2011-01-30 22:05:47.906 gpbs[7030] Timed out waiting for X append  
> > for Selection
> > 2011-01-30 22:05:47.906 gpbs[7030] PropertyNotify.
> > 2011-01-30 22:05:47.906 gpbs[7030] PropertyNotify.
> > 2011-01-30 22:05:47.906 gpbs[7030] Selection (PRIMARY) notify -  
> > 'None'.
> > 2011-01-30 22:05:47.906 gpbs[7030] Owning program failed to convert  
> > data.
> > 2011-01-30 22:05:47.907 gpbs[7030] SelectionNotify.
> > 2011-01-30 22:05:47.907 gpbs[7030] <PasteboardObject: 0x9a0ce50>  
> > set data for type 'NSStringPboardType' version 1
> > 2011-01-30 22:05:47.907 gpbs[7030] set data for 0x9a0b9c8
> > 2011-01-30 22:05:47.907 gpbs[7030] get data for 0x9a0b9c8
> >
> > Hope this helps,
> > Philippe

After upgrading my local MacPorts tree, which meant switching from  
Apple's X libraries to the xorg X libraries, I have been noticing  
these timeouts too. Turns out that these were caused by a race  
condition in gpbs, where the expected property change notifications  
could already have been read into the X event queue by a call to  
XFlush and gpbs would timeout waiting for new data being received on  
the X connection file descriptor. This is now fixed in r32457.

Wolfgang