xpra icon
Bug tracker and wiki

This bug tracker and wiki are being discontinued
please use https://github.com/Xpra-org/xpra instead.


Changes between Initial Version and Version 1 of Ticket #329


Ignore:
Timestamp:
05/08/13 04:34:44 (8 years ago)
Author:
Antoine Martin
Comment:

Which codec was this? What sort of internet connection is this? What was the bandwidth usage at the time?

average server latency=1752.4

A latency of over a second is going to be problematic! (maybe sound data is overloading the connection?)

PS: please use shell redirection to capture log files so I don't have to edit the log to remove the idiotic carriage returns added by the obnoxious windows dos window.

Legend:

Unmodified
Added
Removed
Modified
  • Ticket #329

    • Property Status changed from new to assigned
    • Property Milestone changed from to 0.10
  • Ticket #329 – Description

    initial v1  
    44
    55{{{
    6 2013-05-07 20:00:13,361 mask_to_names(<flags 0 of type GdkModifierType>)=['mod2'
    7 ]
    8 2013-05-07 20:00:13,377 mask_to_names(<flags 0 of type GdkModifierType>) GetKeyS
    9 tate(VK_NUMLOCK)=1
    10 2013-05-07 20:00:13,378 mask_to_names(<flags 0 of type GdkModifierType>)=['mod2'
    11 ]
    12 2013-05-07 20:00:13,392 mask_to_names(<flags 0 of type GdkModifierType>) GetKeyS
    13 tate(VK_NUMLOCK)=1
    14 2013-05-07 20:00:13,394 mask_to_names(<flags 0 of type GdkModifierType>)=['mod2'
    15 ]
    16 2013-05-07 20:00:13,552 check_echo_timeout(1367981953553) last_ping_echoed_time=
    17 1367981953553
     62013-05-07 20:00:13,361 mask_to_names(<flags 0 of type GdkModifierType>)=['mod2']
     72013-05-07 20:00:13,377 mask_to_names(<flags 0 of type GdkModifierType>) GetKeyState(VK_NUMLOCK)=1
     82013-05-07 20:00:13,378 mask_to_names(<flags 0 of type GdkModifierType>)=['mod2']
     92013-05-07 20:00:13,392 mask_to_names(<flags 0 of type GdkModifierType>) GetKeyState(VK_NUMLOCK)=1
     102013-05-07 20:00:13,394 mask_to_names(<flags 0 of type GdkModifierType>)=['mod2']
     112013-05-07 20:00:13,552 check_echo_timeout(1367981953553) last_ping_echoed_time=1367981953553
    18122013-05-07 20:00:13,563 average server latency=1752.4, using max wait 4.50s
    19 2013-05-07 20:00:18,071 check_server_echo: server is not responding, redrawing s
    20 pinners over the windows
    21 2013-05-07 20:00:18,076 paint_spinner(<gtk.gdk.CairoContext object at 0x02B00360
    22 >, gtk.gdk.Rectangle(0, 0, 834, 716))
    23 2013-05-07 20:00:18,177 paint_spinner(<gtk.gdk.CairoContext object at 0x02B00360
    24 >, gtk.gdk.Rectangle(0, 0, 834, 716))
    25 2013-05-07 20:00:18,276 paint_spinner(<gtk.gdk.CairoContext object at 0x02B00360
    26 >, gtk.gdk.Rectangle(0, 0, 834, 716))
    27 2013-05-07 20:00:18,377 paint_spinner(<gtk.gdk.CairoContext object at 0x02B00360
    28 >, gtk.gdk.Rectangle(0, 0, 834, 716))
     132013-05-07 20:00:18,071 check_server_echo: server is not responding, redrawing spinners over the windows
     142013-05-07 20:00:18,076 paint_spinner(<gtk.gdk.CairoContext object at 0x02B00360>, gtk.gdk.Rectangle(0, 0, 834, 716))
     152013-05-07 20:00:18,177 paint_spinner(<gtk.gdk.CairoContext object at 0x02B00360>, gtk.gdk.Rectangle(0, 0, 834, 716))
     162013-05-07 20:00:18,276 paint_spinner(<gtk.gdk.CairoContext object at 0x02B00360>, gtk.gdk.Rectangle(0, 0, 834, 716))
     172013-05-07 20:00:18,377 paint_spinner(<gtk.gdk.CairoContext object at 0x02B00360>, gtk.gdk.Rectangle(0, 0, 834, 716))
    29182013-05-07 20:00:18,480 sound sink: adding 104 bytes, {}
    30 2013-05-07 20:00:18,483 need_data: 4096 bytes in /GstPipeline:pipeline0/GstAppSr
    31 c:src (__main__.GstAppSrc)
     192013-05-07 20:00:18,483 need_data: 4096 bytes in /GstPipeline:pipeline0/GstAppSrc:src (__main__.GstAppSrc)
    32202013-05-07 20:00:18,483 sound sink queue underrun
    33 2013-05-07 20:00:18,572 check_server_echo: server is OK again, stopping redraw
    34 2013-05-07 20:00:23,553 check_echo_timeout(1367981963553) last_ping_echoed_time=
    35 1367981953553
    36 2013-05-07 20:00:23,555 server ping timeout - waited 60 seconds without a respon
    37 se
     212013-05-07 20:00:18,572 check_server_echo: server is OK again, stopping redraw2013-05-07 20:00:23,553 check_echo_timeout(1367981963553) last_ping_echoed_time=1367981953553
     222013-05-07 20:00:23,555 server ping timeout - waited 60 seconds without a response
    38232013-05-07 20:00:23,555 XpraClient.quit(2) current exit_code=None
    39 2013-05-07 20:00:23,555 XpraClient.cleanup() client_extras=<xpra.win32.gui.Clien
    40 tExtras object at 0x02B637D0>
    41 2013-05-07 20:00:23,556 ClientExtras.cleanup() tray=<xpra.win32.win32_tray.Win32
    42 Tray instance at 0x04B4A8F0>
    43 2013-05-07 20:00:23,558 ClientExtrasBase.cleanup() session_info_window=None, gtk
    44 .main_level()=1
     242013-05-07 20:00:23,555 XpraClient.cleanup() client_extras=<xpra.win32.gui.ClientExtras object at 0x02B637D0>
     252013-05-07 20:00:23,556 ClientExtras.cleanup() tray=<xpra.win32.win32_tray.Win32Tray instance at 0x04B4A8F0>
     262013-05-07 20:00:23,558 ClientExtrasBase.cleanup() session_info_window=None, gtk.main_level()=1
    45272013-05-07 20:00:23,558 ClientExtrasBase.cleanup() done
    46 2013-05-07 20:00:23,559 ClientExtras.cleanup() calling tray.close=<bound method
    47 Win32Tray.close of <xpra.win32.win32_tray.Win32Tray instance at 0x04B4A8F0>>
    48 2013-05-07 20:00:23,559 Win32Tray.close() tray_widget=<xpra.win32.win32_NotifyIc
    49 on.win32NotifyIcon instance at 0x04B558A0>
    50 2013-05-07 20:00:23,561 win32NotifyIcon.close() exit_callback=<function tray_exi
    51 t at 0x04B4B730>
    52 2013-05-07 20:00:23,563 OnDestroy(0,None,None,None) closed=False, exit_callback=
    53 None
    54 2013-05-07 20:00:23,565 OnDestroy(..) calling Shell_NotifyIcon(NIM_DELETE, (5258
    55 84, 0))
     282013-05-07 20:00:23,559 ClientExtras.cleanup() calling tray.close=<bound methodWin32Tray.close of <xpra.win32.win32_tray.Win32Tray instance at 0x04B4A8F0>>
     292013-05-07 20:00:23,559 Win32Tray.close() tray_widget=<xpra.win32.win32_NotifyIcon.win32NotifyIcon instance at 0x04B558A0>
     302013-05-07 20:00:23,561 win32NotifyIcon.close() exit_callback=<function tray_exit at 0x04B4B730>
     312013-05-07 20:00:23,563 OnDestroy(0,None,None,None) closed=False, exit_callback=None
     322013-05-07 20:00:23,565 OnDestroy(..) calling Shell_NotifyIcon(NIM_DELETE, (525884, 0))
    56332013-05-07 20:00:23,595 OnDestroy(..) calling exit_callback=None
    57342013-05-07 20:00:23,596 detect_win32_session_events(None) missing handle!
     
    61382013-05-07 20:00:23,601 SoundPipeline.cleanup()
    62392013-05-07 20:00:23,601 SoundPipeline.stop()
    63 2013-05-07 20:00:23,628 need_data: 4096 bytes in /GstPipeline:pipeline0/GstAppSr
    64 c:src (__main__.GstAppSrc)
     402013-05-07 20:00:23,628 need_data: 4096 bytes in /GstPipeline:pipeline0/GstAppSrc:src (__main__.GstAppSrc)
    65412013-05-07 20:00:23,653 SoundPipeline.stop() done
    66422013-05-07 20:00:23,654 SoundPipeline.cleanup() done
    67 2013-05-07 20:00:23,655 sound: client_signalled_change(<XpraClient object at 0x2
    68 90e6c0 (xpra+client+XpraClient at 0x238db30)>) is_on=False
     432013-05-07 20:00:23,655 sound: client_signalled_change(<XpraClient object at 0x290e6c0 (xpra+client+XpraClient at 0x238db30)>) is_on=False
    69442013-05-07 20:00:23,657 spk_off(())
    70452013-05-07 20:00:23,657 XpraClient.stop_receiving_sound()
    71462013-05-07 20:00:23,658 stop_receiving_sound: sound not started!
    72472013-05-07 20:00:23,660 XpraClient.stop_receiving_sound() done
    73 2013-05-07 20:00:23,661 XpraClientBase.cleanup() protocol=Protocol(SocketConnect
    74 ion(('10.0.11.67', 52994) - ('107.6.90.194', 1201)))
    75 2013-05-07 20:00:23,661 connection closed after 140854 packets received (1647302
    76 58 bytes) and 19349 packets sent (638945 bytes)
     482013-05-07 20:00:23,661 XpraClientBase.cleanup() protocol=Protocol(SocketConnection(('10.0.11.67', 52994) - ('107.6.90.194', 1201)))
     492013-05-07 20:00:23,661 connection closed after 140854 packets received (164730258 bytes) and 19349 packets sent (638945 bytes)
    77502013-05-07 20:00:23,663 XpraClient.clean_mmap() mmap_file=None
    78512013-05-07 20:00:23,664 write thread: empty marker, exiting
    79522013-05-07 20:00:23,664 read thread: empty marker, exiting
    80532013-05-07 20:00:23,665 update_focus(2,False) _focused=2
    81 2013-05-07 20:00:23,667 mask_to_names(<flags 0 of type GdkModifierType>) GetKeyS
    82 tate(VK_NUMLOCK)=1
    83 2013-05-07 20:00:23,668 mask_to_names(<flags 0 of type GdkModifierType>)=['mod2'
    84 ]
    85 2013-05-07 20:00:23,670 <class 'xpra.window_backing.PixmapBacking'>.close() vide
    86 o_decoder=<xpra.x264.codec.Decoder object at 0x02BD4D70>
     542013-05-07 20:00:23,667 mask_to_names(<flags 0 of type GdkModifierType>) GetKeyState(VK_NUMLOCK)=1
     552013-05-07 20:00:23,668 mask_to_names(<flags 0 of type GdkModifierType>)=['mod2']
     562013-05-07 20:00:23,670 <class 'xpra.window_backing.PixmapBacking'>.close() video_decoder=<xpra.x264.codec.Decoder object at 0x02BD4D70>
    87572013-05-07 20:00:23,677 unknown win32 message: 28 / 0 / 2452
    88582013-05-07 20:00:23,688 XpraClient.cleanup() done
    89 2013-05-07 20:00:23,690 XpraClient.quit(2) main loop at level 1, calling gtk qui
    90 t via timeout
     592013-05-07 20:00:23,690 XpraClient.quit(2) main loop at level 1, calling gtk quit via timeout
    91602013-05-07 20:00:23,690 average server latency=1752.4, using max wait 4.50s
    92612013-05-07 20:00:23,693 Connection lost
    93622013-05-07 20:00:23,694 XpraClient.quit(1) current exit_code=2
    94 2013-05-07 20:00:23,694 XpraClient.cleanup() client_extras=<xpra.win32.gui.Clien
    95 tExtras object at 0x02B637D0>
     632013-05-07 20:00:23,694 XpraClient.cleanup() client_extras=<xpra.win32.gui.ClientExtras object at 0x02B637D0>
    96642013-05-07 20:00:23,696 ClientExtras.cleanup() tray=None
    97 2013-05-07 20:00:23,698 ClientExtrasBase.cleanup() session_info_window=None, gtk
    98 .main_level()=1
     652013-05-07 20:00:23,698 ClientExtrasBase.cleanup() session_info_window=None, gtk.main_level()=1
    99662013-05-07 20:00:23,700 ClientExtrasBase.cleanup() done
    100672013-05-07 20:00:23,701 ClientExtras.cleanup() ended
     
    102692013-05-07 20:00:23,704 XpraClient.clean_mmap() mmap_file=None
    103702013-05-07 20:00:23,706 XpraClient.cleanup() done
    104 2013-05-07 20:00:23,707 XpraClient.quit(1) main loop at level 1, calling gtk qui
    105 t via timeout
     712013-05-07 20:00:23,707 XpraClient.quit(1) main loop at level 1, calling gtk quit via timeout
    106722013-05-07 20:00:24,190 XpraClient.run() main loop ended, returning exit_code=2
    107 2013-05-07 20:00:24,191 XpraClient.cleanup() client_extras=<xpra.win32.gui.Clien
    108 tExtras object at 0x02B637D0>
     732013-05-07 20:00:24,191 XpraClient.cleanup() client_extras=<xpra.win32.gui.ClientExtras object at 0x02B637D0>
    109742013-05-07 20:00:24,193 ClientExtras.cleanup() tray=None
    110 2013-05-07 20:00:24,193 ClientExtrasBase.cleanup() session_info_window=None, gtk
    111 .main_level()=0
     752013-05-07 20:00:24,193 ClientExtrasBase.cleanup() session_info_window=None, gtk.main_level()=0
    112762013-05-07 20:00:24,194 ClientExtrasBase.cleanup() done
    113772013-05-07 20:00:24,194 ClientExtras.cleanup() ended