This is the mail archive of the
cygwin-xfree@cygwin.com
mailing list for the Cygwin XFree86 project.
XWin 6.7.0.0-7 with -clipboard hangs with cygwin1-20040422 in Win98SE
- From: "Carl Holmberg" <holmberg at tiac dot net>
- To: cygwin-xfree at cygwin dot com
- Date: Wed, 28 Apr 2004 14:46:18 -500
- Subject: XWin 6.7.0.0-7 with -clipboard hangs with cygwin1-20040422 in Win98SE
- Reply-to: cygwin-xfree at cygwin dot com
- Reply-to: holmberg at tiac dot net
Hi,
I am seeing the same XWin hang problem with the latest code,
with -clipboard, as I've reported before. In this case I also
used the default startxwin.sh with a --logverbose 255 to try to
pick up whatever logging I could. This is a -multiwindow
config, but identical hangs occurred before when running without
this option, using twm instead. Am running bash.
My cygwin installation is up-to-date as of 4/28/04 12:28 EDT. A
cygcheck -csvr is available - I'll post it upon request. In
this case I also used the latest cygwin1.dll snapshot, but the
hang occurs with the latest release cygwin1.dll also.
I attached to XWin with strace using after the XTerm came up,
stabilized and the XWin.log stopped producing initial output. I
then placed the cursor in the window, typed the "date" command,
then copied (left click/hold/drag) and the pasted the command
successfully. I then left clicked to the left of the date
command, right-clicked to the right, and XWin froze up. As is
typical, in my experience, only a few mouse clicks -
particularly anything using the right-click, causes XWin to hang
up completely with -clipboard.
The last 132 lines of the strace are reproduced below. After
that, I've included the XWin.log. I've marked the place where
the system froze (just before the kill -9 was issued). Note the
readv errno 11 returned 14 lines before the freeze point.
I hope this helps.
###Last 132 lines of strace. Whole trace from time XTerm came
###up is available.
399 93751361 [select_socket] XWin 1034021 thread_socket: stuff_start 0x101A2FCC
86 93751447 [main] XWin 1034021 select_stuff::wait: m 2, ms 117051
1270 93752717 [select_socket] XWin 1034021 thread_socket: Win32 select returned 1
540 93753257 [select_socket] XWin 1034021 thread_socket: s 0x1019D720, testing fd 13 ()
420 93753677 [select_socket] XWin 1034021 thread_socket: s 0x1016D048, testing fd 11 ()
405 93754082 [select_socket] XWin 1034021 thread_socket: s 0x101741A8, testing fd 10 ()
411 93754493 [select_socket] XWin 1034021 thread_socket: s 0x10173CD0, testing fd 9 ()
471 93754964 [select_socket] XWin 1034021 thread_socket: read_ready
400 93755364 [select_socket] XWin 1034021 thread_socket: s 0x1019DD90, testing fd 5 ()
416 93755780 [select_socket] XWin 1034021 thread_socket: s 0x1016D290, testing fd 4 ()
468 93756248 [main] XWin 1034021 select_stuff::wait: woke up. wait_ret 1. verifying
419 93756667 [main] XWin 1034021 select_stuff::wait: gotone 1
423 93757090 [main] XWin 1034021 select_stuff::wait: returning 0
401 93757491 [main] XWin 1034021 select_stuff::cleanup: calling cleanup routines
403 93757894 [main] XWin 1034021 socket_cleanup: si 0x1019FFA8 si->thread 0x610F7860
400 93758294 [main] XWin 1034021 socket_cleanup: connection to si->exitsock 0x2E4
4827 93763121 [main] XWin 1034021 cygthread::detach: WFSO returns 0, id 0xFFCE4D87
1650 93764771 [main] XWin 1034021 free: (0x1019FFA8), called by 0x6108AAA4
887 93765658 [main] XWin 1034021 socket_cleanup: returning
783 93766441 [main] XWin 1034021 socket_cleanup: si 0x0 si->thread 0x0
843 93767284 [main] XWin 1034021 socket_cleanup: returning
475 93767759 [main] XWin 1034021 socket_cleanup: si 0x0 si->thread 0x0
400 93768159 [main] XWin 1034021 socket_cleanup: returning
405 93768564 [main] XWin 1034021 socket_cleanup: si 0x0 si->thread 0x0
398 93768962 [main] XWin 1034021 socket_cleanup: returning
394 93769356 [main] XWin 1034021 socket_cleanup: si 0x0 si->thread 0x0
475 93769831 [main] XWin 1034021 socket_cleanup: returning
395 93770226 [main] XWin 1034021 socket_cleanup: si 0x0 si->thread 0x0
407 93770633 [main] XWin 1034021 socket_cleanup: returning
407 93771040 [main] XWin 1034021 peek_socket: considering handle 0x28C
401 93771441 [main] XWin 1034021 peek_socket: adding read fd_set , fd 13
859 93772300 [main] XWin 1034021 peek_socket: WINSOCK_SELECT returned 0
432 93772732 [main] XWin 1034021 peek_socket: considering handle 0x284
398 93773130 [main] XWin 1034021 peek_socket: adding read fd_set , fd 11
520 93773650 [main] XWin 1034021 peek_socket: WINSOCK_SELECT returned 0
416 93774066 [main] XWin 1034021 peek_socket: considering handle 0x20C
397 93774463 [main] XWin 1034021 peek_socket: adding read fd_set , fd 10
565 93775028 [main] XWin 1034021 peek_socket: WINSOCK_SELECT returned 0
414 93775442 [main] XWin 1034021 peek_socket: considering handle 0x178
410 93775852 [main] XWin 1034021 set_bits: me 0x10173CD0, testing fd 9 ()
398 93776250 [main] XWin 1034021 set_bits: ready 1
434 93776684 [main] XWin 1034021 peek_windows: window 6(0x0) not ready
404 93777088 [main] XWin 1034021 peek_socket: considering handle 0x12C
404 93777492 [main] XWin 1034021 peek_socket: adding read fd_set , fd 5
488 93777980 [main] XWin 1034021 peek_socket: WINSOCK_SELECT returned 0
413 93778393 [main] XWin 1034021 peek_socket: considering handle 0x128
410 93778803 [main] XWin 1034021 peek_socket: adding read fd_set , fd 4
480 93779283 [main] XWin 1034021 peek_socket: WINSOCK_SELECT returned 0
487 93779770 [main] XWin 1034021 select_stuff::poll: returning 1
406 93780176 [main] XWin 1034021 select_stuff::cleanup: calling cleanup routines
408 93780584 [main] XWin 1034021 select_stuff::~select_stuff: deleting select records
402 93780986 [main] XWin 1034021 free: (0x1019D720), called by 0x61086EEB
405 93781391 [main] XWin 1034021 free: (0x1016D048), called by 0x61086EEB
651 93782042 [main] XWin 1034021 free: (0x101741A8), called by 0x61086EEB
409 93782451 [main] XWin 1034021 free: (0x10173CD0), called by 0x61086EEB
414 93782865 [main] XWin 1034021 free: (0x1016F908), called by 0x61086EEB
404 93783269 [main] XWin 1034021 free: (0x1019DD90), called by 0x61086EEB
413 93783682 [main] XWin 1034021 free: (0x1016D290), called by 0x61086EEB
472 93784154 [main] XWin 1034021 readv: readv (9, 0xADEA10, 1) nonblocking, sigcatchers 3
430 93784584 [main] XWin 1034021 peek_socket: considering handle 0x178
1517 93786101 [main] XWin 1034021 peek_socket: adding read fd_set , fd 9
1368 93787469 [main] XWin 1034021 peek_socket: WINSOCK_SELECT returned 1
434 93787903 [main] XWin 1034021 fhandler_base::ready_for_read: read_ready 1, avail 1
501 93788404 [main] XWin 1034021 readv: 36 = readv (9, 0xADEA10, 1), errno 0
595 93788999 [unknown (0xFFF1A7EB)] XWin 1034021 select_stuff::wait: woke up. wait_ret 2. verifying
541 93789540 [unknown (0xFFF1A7EB)] XWin 1034021 peek_windows: window 14(0x0) not ready
494 93790034 [unknown (0xFFF1A7EB)] XWin 1034021 select_stuff::wait: gotone 0
434 93790468 [unknown (0xFFF1A7EB)] XWin 1034021 select_stuff::wait: looping
618 93791086 [unknown (0xFFF1A7EB)] XWin 1034021 select_stuff::wait: woke up. wait_ret 2. verifying
506 93791592 [unknown (0xFFF1A7EB)] XWin 1034021 writev: writev (12, 0x30FE7F8, 1)
3873 93795465 [unknown (0xFFF1A7EB)] XWin 1034021 writev: 4 = write (12, 0x30FE7F8, 1), errno 0
920 93796385 [unknown (0xFFF1A7EB)] XWin 1034021 readv: readv (12, 0x30FE7F8, 1) nonblocking, sigcatchers 3
823 93797208 [unknown (0xFFF1A7EB)] XWin 1034021 peek_socket: considering handle 0x298
890 93798098 [unknown (0xFFF1A7EB)] XWin 1034021 peek_socket: adding read fd_set , fd 12
1801 93799899 [unknown (0xFFF1A7EB)] XWin 1034021 peek_socket: WINSOCK_SELECT returned 0
890 93800789 [unknown (0xFFF1A7EB)] XWin 1034021 fhandler_base::ready_for_read: read_ready 0, avail 0
1715 93802504 [unknown (0xFFF1A7EB)] XWin 1034021 readv: -1 = readv (12, 0x30FE7F8, 1), errno 11
#### Is the errno 11 above relevant?####
620 93803124 [unknown (0xFFF1A7EB)] XWin 1034021 cygwin_select: 13, 0x30FE7E8, 0x0, 0x0, 0x0
814 93803938 [unknown (0xFFF1A7EB)] XWin 1034021 calloc: (1, 44) = 1016D290, called by 61001C99
420 93804358 [unknown (0xFFF1A7EB)] XWin 1034021 dtable::select_read: fd 12
556 93804914 [unknown (0xFFF1A7EB)] XWin 1034021 cygwin_select: to NULL, ms FFFFFFFF
407 93805321 [unknown (0xFFF1A7EB)] XWin 1034021 cygwin_select: sel.always_ready 0
481 93805802 [unknown (0xFFF1A7EB)] XWin 1034021 calloc: (1, 12328) = 1019FFA8, called by 61001C99
432 93806234 [unknown (0xFFF1A7EB)] XWin 1034021 start_thread_socket: Handle 0x298
414 93806648 [unknown (0xFFF1A7EB)] XWin 1034021 start_thread_socket: Added to readfds
4047 93810695 [unknown (0xFFF1A7EB)] XWin 1034021 start_thread_socket: exitsock 0x2E4
456 93811151 [unknown (0xFFF1A7EB)] XWin 1034021 start_thread_socket: stuff_start 0x30FE74C
419 93811570 [unknown (0xFFF1A7EB)] XWin 1034021 cygthread::cygthread: name select_socket, id 0xFFCE4D87
502 93812072 [unknown (0xFFF1A7EB)] XWin 1034021 cygthread::cygthread: activated thread_sync 0x258
415 93812487 [select_socket] XWin 1034021 thread_socket: stuff_start 0x101A2FCC
90 93812577 [unknown (0xFFF1A7EB)] XWin 1034021 select_stuff::wait: m 2, ms 4294967295
####FROZE AT ABOVE LINE####
259815524 353628101 [sig] XWin 1034021 sigpacket::process: signal 9 processing
698 353628799 [sig] XWin 1034021 sigpacket::process: signal 9, about to call do_exit
560 353629359 [sig] XWin 1034021 ResourceLocks::Delete: Close Resource Locks 0x610F7D04
657 353630016 [sig] XWin 1034021 ResourceLocks::Init: lock 0x610F7D04 inited by 0x610F3020 , 1034021
489 353630505 [sig] XWin 1034021 signal_exit: about to call do_exit (10900)
545 353631050 [sig] XWin 1034021 do_exit: do_exit (67840), exit_state 0
441 353631491 [sig] XWin 1034021 void: 0x0 = signal (20, 0x1)
444 353631935 [sig] XWin 1034021 void: 0x42C730 = signal (1, 0x1)
451 353632386 [sig] XWin 1034021 void: 0x42C760 = signal (2, 0x1)
443 353632829 [sig] XWin 1034021 void: 0x1 = signal (3, 0x1)
454 353633283 [sig] XWin 1034021 fhandler_base::close: closing '/dev/null' handle 0x90
791 353634074 [sig] XWin 1034021 fhandler_tty_slave::close: /dev/tty0 closed, decremented open_fhs 2, usecount 2
524 353634598 [sig] XWin 1034021 fhandler_tty_slave::close: just returning because archetype usecount is != 0
464 353635062 [sig] XWin 1034021 fhandler_tty_slave::close: /dev/tty0 closed, decremented open_fhs 1, usecount 1
474 353635536 [sig] XWin 1034021 fhandler_tty_slave::close: just returning because archetype usecount is != 0
458 353635994 [sig] XWin 1034021 fhandler_base::close: closing '/tmp/XWin.log' handle 0x108
28939 353664933 [sig] XWin 1034021 fhandler_socket::close: 0 = fhandler_socket::close()
1986 353666919 [sig] XWin 1034021 fhandler_socket::close: 0 = fhandler_socket::close()
1061 353667980 [sig] XWin 1034021 fhandler_socket::close: 0 = fhandler_socket::close()
759 353668739 [sig] XWin 1034021 fhandler_socket::close: 0 = fhandler_socket::close()
756 353669495 [sig] XWin 1034021 fhandler_socket::close: 0 = fhandler_socket::close()
748 353670243 [sig] XWin 1034021 fhandler_socket::close: 0 = fhandler_socket::close()
763 353671006 [sig] XWin 1034021 fhandler_socket::close: 0 = fhandler_socket::close()
755 353671761 [sig] XWin 1034021 fhandler_socket::close: 0 = fhandler_socket::close()
809 353672570 [sig] XWin 1034021 fhandler_socket::close: 0 = fhandler_socket::close()
527 353673097 [sig] XWin 1034021 init_cygheap::close_ctty: closing cygheap->ctty 0x616D1564
467 353673564 [sig] XWin 1034021 fhandler_tty_slave::close: /dev/tty0 closed, decremented open_fhs 0, usecount 0
452 353674016 [sig] XWin 1034021 fhandler_tty_slave::close: closing last open /dev/tty0 handle
457 353674473 [sig] XWin 1034021 fhandler_tty_common::close: tty0 <0xF8,0xFC> closing
586 353675059 [sig] XWin 1034021 sigproc_terminate: entering
715 353675774 [sig] XWin 1034021 proc_terminate: nchildren 0, nzombies 0
916 353676690 [sig] XWin 1034021 proc_subproc: args: 3, 1
427 353677117 [sig] XWin 1034021 proc_subproc: clear waiting threads
520 353677637 [sig] XWin 1034021 proc_subproc: finished clearing
445 353678082 [sig] XWin 1034021 proc_subproc: returning 1
456 353678538 [sig] XWin 1034021 proc_terminate: leaving
889 353679427 [sig] XWin 1034021 __to_clock_t: dwHighDateTime 0, dwLowDateTime 0
448 353679875 [sig] XWin 1034021 __to_clock_t: total 00000000 00000000
458 353680333 [sig] XWin 1034021 __to_clock_t: dwHighDateTime 0, dwLowDateTime 0
448 353680781 [sig] XWin 1034021 __to_clock_t: total 00000000 00000000
22108 353702889 [sig] XWin 1034021 _pinfo::exit: Calling ExitProcess 67840
###XWin.Log. Note there are 3 nul characters in the log,
###after "winMultiWindowXMsgProc - Hello". I replaced these
###with '[nul]'
Welcome to the XWin X Server
Vendor: The Cygwin/X Project
Release: 6.7.0.0-7
Contact: cygwin-xfree@cygwin.com
XWin was started with the following command line:
XWin -multiwindow -logverbose 255 -clipboard
ddxProcessArgument - Initializing default screens
winInitializeDefaultScreens - w 1280 h 1024
winInitializeDefaultScreens - Returning
OsVendorInit - Creating bogus screen 0
winValidateArgs - g_iNumScreens: 1 iMaxConsecutiveScreen: 1
winValidateArgs - Returning.
(II) XF86Config is not supported
(II) See http://x.cygwin.com/docs/faq/cygwin-x-faq.html for more information
winDetectSupportedEngines - Windows 95/98/Me
winDetectSupportedEngines - DirectDraw installed
winDetectSupportedEngines - DirectDraw4 installed
winDetectSupportedEngines - Returning, supported engines 00000007
winScreenInit - dwWidth: 1280 dwHeight: 1024
winSetEngine - Multi Window or Rootless => ShadowGDI
winAdjustVideoModeShadowGDI - Using Windows display depth of 16 bits per pixel
winCreateBoundingWindowWindowed - User w: 1280 h: 1024
winCreateBoundingWindowWindowed - Current w: 1280 h: 1024
winAdjustForAutoHide - Original WorkArea: 0 0 1024 1280
winAdjustForAutoHide - Taskbar is auto hide
winAdjustForAutoHide - Found BOTTOM auto-hide taskbar
winAdjustForAutoHide - Adjusted WorkArea: 0 0 1023 1280
winCreateBoundingWindowWindowed - WindowClient w 1280 h 1023 r 1280 l 0 b 1023 t 0
winCreateBoundingWindowWindowed - Returning
winAllocateFBShadowGDI - Creating DIB with width: 1280 height: 1023 depth: 16
winAllocateFBShadowGDI - Dibsection width: 1280 height: -1023 depth: 16 size image: 2618880
winAllocateFBShadowGDI - WEIRDNESS - biHeight still negative: -1023
winAllocateFBShadowGDI - WEIRDNESS - Flipping biHeight sign
winAllocateFBShadowGDI - Created shadow stride: 1280
winFinishScreenInitFB - Masks: 00007c00 000003e0 0000001f
winInitVisualsShadowGDI - Masks 00007c00 000003e0 0000001f BPRGB 5 d 15 bpp 16
winRandRInit ()
winCreateDefColormap - Deferring to fbCreateDefColormap ()
null screen fn ReparentWindow
null screen fn RestackWindow
winFinishScreenInitFB - Calling winInitWM.
InitQueue - Calling pthread_mutex_init
InitQueue - pthread_mutex_init returned
InitQueue - Calling pthread_cond_init
InitQueue - pthread_cond_init returned
winInitMultiWindowWM - Hello
winInitWM - Returning.
winMultiWindowXMsgProc - Hello
[nul]g
winScreenInit - returning
[nul]llo
winInitMultiWindowWM - CalwinInitMultiWindowWM - Calling pthread_mutex_lock ()
InitOutput - Returning.
[nul]Calling pthread_mutex_lock ()
InitOutput - Returning.
MIT-SHM extension disabled due to lack of kernel support
XFree86-Bigfont extension local-client optimization disabled due to lack of shared memory support in the kernel
(--) Setting autorepeat to delay=250, rate=15
(--) winConfigKeyboard - Layout: "00000409" (00000409)
(EE) Keyboardlayout "United States 101" (00000409) is unknown
Rules = "xorg" Model = "pc101" Layout = "us" Variant = "(null)" Options = "(null)"
Could not init font path element /usr/X11R6/lib/X11/fonts/CID/, removing from list!
winRealizeCursor: cursor=0x10203008
winPointerWarpCursor - Discarding first warp: 640 511
winSetCursor: cursor=0x10203008
winLoadCursor: Win32: 32x32 X11: 16x16 hotspot: 7,7
winLoadCursor: Trying two color cursor
winLoadCursor: Creating bitmap cursor: hotspot 7,7
winLoadCursor: CreateIconIndirect returned no cursor. Trying again.
winSetCursor: handle=0x6b86
winBlockHandler - Releasing pmServerStarted
winInitMultiWindowWM - pthread_mutex_lock () returnwinInitMultiWindowWM - pthread_mutex_lock () returned.
winInitMultiWindowWM - pthread_mutex_unlock () returned.
winMultiWindowXMsgProc - pthread_mutex_lock () returned.
winInitMultiWindowWM - DISPLAY=127.0.0.1:0.0
winMultiWindowXMsgProc - pthread_mutex_unlock () returned.
winMultiWindowXMsgProc - DISPLAY=127.0.0.1:0.0
winProcEstablishConnection - Hello
winInitClipboard ()
winProcEstablishConnection - winInitClipboard returned.
winClipboardProc - Hello
DetectUnicodeSupport - Windows 95/98/Me
winClipboardProc - DISPLAY=127.0.0.1:0.0
winMultiWindowXMsgProc - XOpenDisplay () returned and successfully opened the display.
winInitMultiWindowWM - XOpenDisplay () returned and successfully opened the display.
winClipboardProc - XOpenDisplay () returned and successfully opened the display.
winRealizeCursor: cursor=0x101740a8
winRealizeCursor: cursor=0x10174488
winRealizeCursor: cursor=0x1016e3a8
winRealizeCursor: cursor=0x1016e508
winRealizeCursor: cursor=0x1016e680
winRealizeCursor: cursor=0x1016b780
winRealizeCursor: cursor=0x1016b8b8
winRealizeCursor: cursor=0x1016bb60
winUnrealizeCursor: cursor=0x1016bb60
winRealizeCursor: cursor=0x1016bb60
winUnrealizeCursor: cursor=0x101740a8
winRealizeCursor: cursor=0x101740a8
winSetCursor: cursor=0x101740a8
winLoadCursor: Win32: 32x32 X11: 9x16 hotspot: 4,8
winLoadCursor: Trying two color cursor
winLoadCursor: Creating bitmap cursor: hotspot 4,8
winLoadCursor: CreateIconIndirect returned no cursor. Trying again.
winSetCursor: handle=0x75ee
winSetCursor: cursor=0x10203008
winLoadCursor: Win32: 32x32 X11: 16x16 hotspot: 7,7
winLoadCursor: Trying two color cursor
winLoadCursor: Creating bitmap cursor: hotspot 7,7
winLoadCursor: CreateIconIndirect returned no cursor. Trying again.
winSetCursor: handle=0x6ab6
winSetCursor: cursor=0x101740a8
winLoadCursor: Win32: 32x32 X11: 9x16 hotspot: 4,8
winLoadCursor: Trying two color cursor
winLoadCursor: Creating bitmap cursor: hotspot 4,8
winLoadCursor: CreateIconIndirect returned no cursor. Trying again.
winSetCursor: handle=0x75b6
### Above was last line recorded in the log, unchanged from time
### of freezeup.