X-selection bug - "Timed out waiting for property-notify event"

[David Sitsky]

G'day,

I have noticed a selection X-related bug in emacs, which seems to
effect the current version 20.7.29, and the version supplied with
RedHat 6.2.  I am currently running Linux 2.4.2 on an x86 system,
under Redhat 7.1.

The problem is reproduced as follows.  Start up a new emacs in an X
window.  Do a M-x shell.  Type "du -a /".  Wait for the output to go
to roughtly ~30,000 lines to get enough output.  Then ^C the du
process.  Mark from the end of the output, go to the start of buffer,
and either wipe or copy the buffer (C-w or M-w).  Emacs will "hang"
for 20 seconds, and then report "Timed out waiting for property-notify
event".  Emacs usually behaves badly after that.

Sometimes its not easily reproduceable, but I downloaded the source
for 20.7.29, compiled, and found I could reproduce it each time.  I
decided to try and find out what is wrong, and sprinkled the code with
debugging statements.  Unfortunately, having never really programmed
with X, I couldn't really understand the problem.  Somehow, the X
server doesn't seem to be sending us a PropertyNotify with state
delete when we are expecting it, or somehow we have lost that event.

Naturally, this bug doesn't occur when I run emacs as "emacs -nw".  I
also tried compiling emacs with "configure --with-x-toolkit=no", and
the output is different, but essentially the same property notify
error occurs.  I know the following output contains my own debugging,
but I thought it might still be readable/useful to somebody.

Here is the trace I see when I have --with-x-toolkit=yes:

[sits@localhost src]$ ./emacs
PropertyNotify event
PropertyNotify event
PropertyNotify event
PropertyNotify event
PropertyNotify event
PropertyNotify event
PropertyNotify event
PropertyNotify event
PropertyNotify event
PropertyNotify event
PropertyNotify event
PropertyNotify event
PropertyNotify event
PropertyNotify event
Got ReparentNotify
Got ReparentNotify done
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
swallow_events(): Calling first x_handle_selection_request for event 0x81d7140 
kbd_fetch_ptr 0x81d7168 kbd_store_ptr 0x81d7168
In x_handle_selection_request()
x_handle_selection_request(size=18)
### x_reply_selection_request(size=18) called

Storing all 72 max_bytes 262040
x_handle_selection_request(size=18) done
swallow_events(): Done Calling first x_handle_selection_request for event 
0x81d7140 kbd_fetch_ptr 0x81d7168 kbd_store_ptr 0x81d7168
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
swallow_events(): Calling first x_handle_selection_request for event 0x81d7168 
kbd_fetch_ptr 0x81d7190 kbd_store_ptr 0x81d7190
In x_handle_selection_request()
x_handle_selection_request(size=18)
### x_reply_selection_request(size=18) called

Storing all 72 max_bytes 262040
x_handle_selection_request(size=18) done
swallow_events(): Done Calling first x_handle_selection_request for event 
0x81d7168 kbd_fetch_ptr 0x81d7190 kbd_store_ptr 0x81d7190
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
swallow_events(): Calling first x_handle_selection_request for event 0x81d7190 
kbd_fetch_ptr 0x81d71b8 kbd_store_ptr 0x81d71b8
In x_handle_selection_request()
x_handle_selection_request(size=1609161)
### x_reply_selection_request(size=1609161) called

INCR 1609161 max_bytes 262040
+++ Added in property change id 1 property 220 state 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
About to unblock input in X code, interrupt_input_blocked is 1
BLOCKED INIT wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling other for propertynotify
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done

At this point I killed emacs, as it will eventually report the
property-notify error message.

For running without the xlib toolkit, things progress further (for
some reason, we get the selection requests doubled, but the same error
seems to occur):

[sits@localhost src]$ ./emacs
Got ReparentNotify
Got ReparentNotify done
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
swallow_events(): Calling first x_handle_selection_request for event 0x81d5868 
kbd_fetch_ptr 0x81d5890 kbd_store_ptr 0x81d5890
In x_handle_selection_request()
x_handle_selection_request(size=18)
### x_reply_selection_request(size=18) called

Storing all 72 max_bytes 262040
x_handle_selection_request(size=18) done
swallow_events(): Done Calling first x_handle_selection_request for event 
0x81d5868 kbd_fetch_ptr 0x81d5890 kbd_store_ptr 0x81d5890
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
swallow_events(): Calling first x_handle_selection_request for event 0x81d5890 
kbd_fetch_ptr 0x81d58b8 kbd_store_ptr 0x81d58b8
In x_handle_selection_request()
x_handle_selection_request(size=18)
### x_reply_selection_request(size=18) called

Storing all 72 max_bytes 262040
x_handle_selection_request(size=18) done
swallow_events(): Done Calling first x_handle_selection_request for event 
0x81d5890 kbd_fetch_ptr 0x81d58b8 kbd_store_ptr 0x81d58b8
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
swallow_events(): Calling first x_handle_selection_request for event 0x81d58b8 
kbd_fetch_ptr 0x81d58e0 kbd_store_ptr 0x81d58e0
In x_handle_selection_request()
x_handle_selection_request(size=1819870)
### x_reply_selection_request(size=1819870) called

INCR 1819870 max_bytes 262040
+++ Added in property change id 1 property 220 state 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
About to unblock input in X code, interrupt_input_blocked is 1
BLOCKED INIT wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 1 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INIT wait_for_property_change
+++ Added in property change id 2 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 2 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 2 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 3 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 3 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 3 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 4 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 4 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 4 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 5 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 5 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 5 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 6 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 6 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 6 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 7 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 7 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 7 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 8 property 220 state 1
  INCR adding 247630
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 8 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 8 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
  INCR done
Calling XChangeProperty
Calling XChangeProperty done
XTread returns, says interrupt_input_blocked is set to 1
x_handle_selection_request(size=1819870) done
swallow_events(): Done Calling first x_handle_selection_request for event 
0x81d58b8 kbd_fetch_ptr 0x81d58e0 kbd_store_ptr 0x81d58e0
EXITING swallow_events()
Handling Xevent of type: 30
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
ENTERING swallow_events()
kbd_fetch_ptr 0x81d58e0 kbd_store_ptr 0x81d5908
swallow_events(): Calling first x_handle_selection_request for event 0x81d58e0 
kbd_fetch_ptr 0x81d5908 kbd_store_ptr 0x81d5908
In x_handle_selection_request()
x_handle_selection_request(size=18)
### x_reply_selection_request(size=18) called
XTread returns, says interrupt_input_blocked is set to 1

Storing all 72 max_bytes 262040
XTread returns, says interrupt_input_blocked is set to 1
x_handle_selection_request(size=18) done
swallow_events(): Done Calling first x_handle_selection_request for event 
0x81d58e0 kbd_fetch_ptr 0x81d5908 kbd_store_ptr 0x81d5908
EXITING swallow_events()
Handling Xevent of type: 30
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
ENTERING swallow_events()
kbd_fetch_ptr 0x81d5908 kbd_store_ptr 0x81d5930
swallow_events(): Calling first x_handle_selection_request for event 0x81d5908 
kbd_fetch_ptr 0x81d5930 kbd_store_ptr 0x81d5930
In x_handle_selection_request()
x_handle_selection_request(size=18)
### x_reply_selection_request(size=18) called
XTread returns, says interrupt_input_blocked is set to 1

Storing all 72 max_bytes 262040
XTread returns, says interrupt_input_blocked is set to 1
x_handle_selection_request(size=18) done
swallow_events(): Done Calling first x_handle_selection_request for event 
0x81d5908 kbd_fetch_ptr 0x81d5930 kbd_store_ptr 0x81d5930
EXITING swallow_events()
Handling Xevent of type: 30
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
ENTERING swallow_events()
kbd_fetch_ptr 0x81d5930 kbd_store_ptr 0x81d5958
swallow_events(): Calling first x_handle_selection_request for event 0x81d5930 
kbd_fetch_ptr 0x81d5958 kbd_store_ptr 0x81d5958
In x_handle_selection_request()
x_handle_selection_request(size=1819870)
### x_reply_selection_request(size=1819870) called
XTread returns, says interrupt_input_blocked is set to 1

INCR 1819870 max_bytes 262040
XTread returns, says interrupt_input_blocked is set to 1
+++ Added in property change id 9 property 220 state 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
About to unblock input in X code, interrupt_input_blocked is 1
BLOCKED INIT wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 9 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INIT wait_for_property_change
+++ Added in property change id 10 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 10 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 10 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 11 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 11 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 11 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 12 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 12 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 12 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 13 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 13 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 13 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 14 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 14 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 14 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 15 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 15 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 15 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
+++ Added in property change id 16 property 220 state 1
  INCR adding 247630
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 16 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 16 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INCR wait_for_property_change
  INCR done
Calling XChangeProperty
Calling XChangeProperty done
XTread returns, says interrupt_input_blocked is set to 1
x_handle_selection_request(size=1819870) done
swallow_events(): Done Calling first x_handle_selection_request for event 
0x81d5930 kbd_fetch_ptr 0x81d5958 kbd_store_ptr 0x81d5958
EXITING swallow_events()
Handling Xevent of type: 30
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
ENTERING swallow_events()
kbd_fetch_ptr 0x81d5958 kbd_store_ptr 0x81d5980
swallow_events(): Calling first x_handle_selection_request for event 0x81d5958 
kbd_fetch_ptr 0x81d5980 kbd_store_ptr 0x81d5980
In x_handle_selection_request()
x_handle_selection_request(size=18)
### x_reply_selection_request(size=18) called
XTread returns, says interrupt_input_blocked is set to 1

Storing all 72 max_bytes 262040
XTread returns, says interrupt_input_blocked is set to 1
x_handle_selection_request(size=18) done
swallow_events(): Done Calling first x_handle_selection_request for event 
0x81d5958 kbd_fetch_ptr 0x81d5980 kbd_store_ptr 0x81d5980
EXITING swallow_events()
Handling Xevent of type: 30
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
ENTERING swallow_events()
kbd_fetch_ptr 0x81d5980 kbd_store_ptr 0x81d59a8
swallow_events(): Calling first x_handle_selection_request for event 0x81d5980 
kbd_fetch_ptr 0x81d59a8 kbd_store_ptr 0x81d59a8
In x_handle_selection_request()
x_handle_selection_request(size=18)
### x_reply_selection_request(size=18) called
XTread returns, says interrupt_input_blocked is set to 1

Storing all 72 max_bytes 262040
XTread returns, says interrupt_input_blocked is set to 1
x_handle_selection_request(size=18) done
swallow_events(): Done Calling first x_handle_selection_request for event 
0x81d5980 kbd_fetch_ptr 0x81d59a8 kbd_store_ptr 0x81d59a8
EXITING swallow_events()
Handling Xevent of type: 30
Got SelectionRequest
Processing x_selection_event the hard way... property 220
Got SelectionRequest done
ENTERING swallow_events()
kbd_fetch_ptr 0x81d59a8 kbd_store_ptr 0x81d59d0
swallow_events(): Calling first x_handle_selection_request for event 0x81d59a8 
kbd_fetch_ptr 0x81d59d0 kbd_store_ptr 0x81d59d0
In x_handle_selection_request()
x_handle_selection_request(size=1819870)
### x_reply_selection_request(size=1819870) called
XTread returns, says interrupt_input_blocked is set to 1

INCR 1819870 max_bytes 262040
XTread returns, says interrupt_input_blocked is set to 1
+++ Added in property change id 17 property 220 state 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
About to unblock input in X code, interrupt_input_blocked is 1
BLOCKED INIT wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 17 
property 220 state 1
+++ Matched expected prop-delete
+++ SETTING property_change_reply cons cell to wake up!
Calling x_handle_property_notify done
** UNBLOCKING for wait_reading_process_input
UNBLOCKED INIT wait_for_property_change
+++ Added in property change id 18 property 220 state 1
  INCR adding 262040
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
XTread returns, says interrupt_input_blocked is set to 1
Added the next chunk, about to UNBLOCK
Handling Xevent of type: 28
PropertyNotify event
Calling x_handle_property_notify
+++ x_handle_property_notify called!!!+++ Checking expected property id 18 
property 220 state 1
+++ received unexpected/unprocessed event 0Calling x_handle_property_notify done
BLOCKED INCR wait_for_property_change
** BLOCKING for wait_reading_process_input
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done
Handling Xevent of type: 15
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done
Handling Xevent of type: 30
Got SelectionRequest
Calling x_queue_event for X event: 0x1e
Got SelectionRequest done


Does anyone have any ideas what the problem is?  I am happy to run
with more debugging information if required.  For what its worth, I am
using the following xfree packages shipped with redhat 7.1:

[sits@localhost sits]$ rpm -qa | grep -i xfree
XFree86-ISO8859-2-1.0-9
XFree86-ISO8859-9-75dpi-fonts-2.1.2-16
XFree86-ISO8859-2-Type1-fonts-4.0.3-5
XFree86-VGA16-3.3.6-35
XFree86-doc-4.0.3-5
XFree86-ISO8859-9-2.1.2-16
XFree86-libs-4.0.3-5
XFree86-4.0.3-5
XFree86-cyrillic-fonts-4.0.3-5
XFree86-twm-4.0.3-5
XFree86-devel-4.0.3-5
XFree86-FBDev-3.3.6-35
XFree86-ISO8859-7-100dpi-fonts-1.0-9
XFree86-ISO8859-9-100dpi-fonts-2.1.2-16
XFree86-Xnest-4.0.3-5
XFree86-xfs-4.0.3-5
XFree86-75dpi-fonts-4.0.3-5
XFree86-tools-4.0.3-5
XFree86-ISO8859-7-75dpi-fonts-1.0-9
XFree86-SVGA-3.3.6-35
XFree86-Xvfb-4.0.3-5
XFree86-ISO8859-2-100dpi-fonts-4.0.3-5
XFree86-100dpi-fonts-4.0.3-5
XFree86-3DLabs-3.3.6-35
XFree86-ISO8859-7-Type1-fonts-1.0-9
XFree86-ISO8859-2-75dpi-fonts-4.0.3-5
XFree86-ISO8859-7-1.0-9
XFree86-xf86cfg-4.0.3-5

--
Cheers,
David