2018-07-07 21:36:10,698 cannot access python uinput module: 2018-07-07 21:36:10,698 No module named uinput _XSERVTransSocketUNIXCreateListener: ...SocketCreateListener() failed _XSERVTransMakeAllCOTSServerListeners: server already running 2018-07-07 21:36:10,790 created unix domain socket: /run/user/1000/xpra/xubuntu-1 2018-07-07 21:36:10,790 created unix domain socket: /home/steved/.xpra/xubuntu-1 2018-07-07 21:36:10,790 cannot create group socket '/run/xpra/xubuntu-1' 2018-07-07 21:36:10,790 [Errno 13] Permission denied 2018-07-07 21:36:10,824 pointer device emulation using XTest 2018-07-07 21:36:11,598 serving html content from: /usr/share/xpra/www 2018-07-07 21:36:11,674 D-Bus notification forwarding is available 2018-07-07 21:36:11,755 Warning: webcam forwarding is disabled 2018-07-07 21:36:11,756 the virtual video directory '/sys/devices/virtual/video4linux' was not found 2018-07-07 21:36:11,756 make sure that the 'v4l2loopback' kernel module is installed and loaded 2018-07-07 21:36:11,756 found 0 virtual video devices for webcam forwarding 2018-07-07 21:36:11,763 pulseaudio server started with pid 12696 2018-07-07 21:36:11,763 private server socket path: 2018-07-07 21:36:11,763 '/run/user/1000/xpra/pulse-:1/pulse/native' 2018-07-07 21:36:12,472 GStreamer version 1.8.3 for Python 2.7.12 64-bit 2018-07-07 21:36:12,538 xpra X11 version 2.3.2-r19729 64-bit 2018-07-07 21:36:12,538 uid=1000 (steved), gid=1000 (steved) 2018-07-07 21:36:12,538 running with pid 12644 on Linux Ubuntu 16.04 xenial 2018-07-07 21:36:12,538 connected to X11 display :1 with 24 bit colors 2018-07-07 21:36:12,594 xpra is ready. 2018-07-07 21:36:12,643 printer forwarding enabled using postscript and pdf 2018-07-07 21:36:12,651 7.7GB of system memory Failed to connect to session manager: Failed to connect to the session manager: SESSION_MANAGER environment variable not defined 2018-07-07 21:37:39,469 New unix-domain connection received on /run/user/1000/xpra/xubuntu-1 2018-07-07 21:37:39,476 Handshake complete; enabling connection 2018-07-07 21:37:39,485 automatic picture encoding enabled, also available: 2018-07-07 21:37:39,485 h264, vp9, vp8, png, png/P, png/L, rgb24, rgb32, jpeg 2018-07-07 21:37:39,485 Python/Gtk2 Linux Ubuntu 18.04 bionic client version 2.3.2-r19729 64-bit 2018-07-07 21:37:39,485 connected from 'beelink' as 'steved' - 'Steve Dee' 2018-07-07 21:37:39,486 client root window size is 2880x900 with 1 display: 2018-07-07 21:37:39,486 :0.0 (761x237 mm - DPI: 96x96) 2018-07-07 21:37:39,486 monitor 1 1440x900 (408x255 mm - DPI: 89x89) 2018-07-07 21:37:39,486 monitor 2 1440x900 at 1440x0 (408x255 mm - DPI: 89x89) 2018-07-07 21:37:40,041 server virtual display now set to 2880x900 2018-07-07 21:37:40,045 setting key repeat rate from client: 500ms delay / 50ms interval 2018-07-07 21:37:40,048 setting keymap: rules=evdev, model=pc105, layout=gb 2018-07-07 21:37:40,063 setting keyboard layout to 'gb' 2018-07-07 21:37:40,096 DPI set to 96 x 96 2018-07-07 21:37:40,122 client @45.924 Xpra X11 server version 2.3.2-r19729 64-bit 2018-07-07 21:37:40,128 client @45.926 running on Linux Ubuntu 16.04 xenial 2018-07-07 21:37:40,174 client @45.934 Attached to xubuntu via ssh 2018-07-07 21:37:40,175 client @45.934 (press Control-C to detach) 2018-07-07 21:37:40,217 New unix-domain connection received on /home/steved/.xpra/xubuntu-1 2018-07-07 21:37:40,217 New unix-domain connection received on /run/user/1000/xpra/xubuntu-1 2018-07-07 21:37:40,247 client @46.051 server does not support xi input devices 2018-07-07 21:37:40,250 client @46.052 server uses: xtest 2018-07-07 21:37:40,346 total_time=0, total_pixels=0 2018-07-07 21:37:40,405 packet decoding sequence 1 for window 1: 735x457 took 21.0ms 2018-07-07 21:37:40,406 record_latency: took 55.2 ms round trip, 55.2 for echo, 20.0 for decoding of 335895 pixels, 15758 bytes sent over the network in 34.2 ms, 34.2 ms for echo 2018-07-07 21:37:40,406 may_recalculate(1, 335895) total 335895 pixels, scheduling recalculate work item 2018-07-07 21:37:40,407 calculate_batch_delay for wid=1 current batch delay=28, last update 80136 seconds ago 2018-07-07 21:37:40,407 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 40, 'recent': 40} 2018-07-07 21:37:40,408 update_batch_delay: client-decode-speed : 1.00,0.00 {'avg': 65, 'recent': 65} 2018-07-07 21:37:40,408 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 100, 'elapsed': 85} 2018-07-07 21:37:40,408 update_batch_delay: client-latency : 0.92,0.43 {'target': 39, 'weight_multiplier': 1566, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 852, 'div': 1000, 'avg': 34, 'recent': 34} 2018-07-07 21:37:40,408 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:40,408 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:40,408 update_batch_delay: compression-work-queue : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:40,408 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:40,409 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:37:40,409 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:37:40,409 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:37:40,409 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:37:40,409 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:37:40,409 update_batch_delay: delay=13 2018-07-07 21:37:40,413 packet decoding sequence 2 for window 1: 735x457 took 14.8ms 2018-07-07 21:37:40,413 record_latency: took 35.7 ms round trip, 35.7 for echo, 14.0 for decoding of 335895 pixels, 18555 bytes sent over the network in 20.9 ms, 20.9 ms for echo 2018-07-07 21:37:40,413 may_recalculate(1, 335895) total 335895 pixels, scheduling recalculate work item 2018-07-07 21:37:40,616 packet decoding sequence 3 for window 1: 735x457 took 13.6ms 2018-07-07 21:37:40,616 record_latency: took 18.3 ms round trip, 18.2 for echo, 13.0 for decoding of 335895 pixels, 18555 bytes sent over the network in 4.7 ms, 4.6 ms for echo 2018-07-07 21:37:41,144 the remote printer 'PDF' has been configured 2018-07-07 21:37:41,176 the remote printer 'MX470-series' has been configured 2018-07-07 21:37:41,408 calculate_batch_delay for wid=1 current batch delay=13, last update 1 seconds ago 2018-07-07 21:37:41,409 calculate_batch_delay for wid=1, skipping - only 1 events since the last update 2018-07-07 21:37:41,730 packet decoding sequence 4 for window 1: 13x434 took 3.4ms 2018-07-07 21:37:41,730 record_latency: took 8.6 ms round trip, 8.5 for echo, 3.0 for decoding of 5642 pixels, 22638 bytes sent over the network in 5.2 ms, 5.1 ms for echo 2018-07-07 21:37:41,730 may_recalculate(1, 5642) total 5642 pixels, scheduling recalculate work item 2018-07-07 21:37:42,050 using pulseaudio device: 2018-07-07 21:37:42,050 'Monitor of Xpra Speaker' 2018-07-07 21:37:42,407 calculate_batch_delay for wid=1 current batch delay=13, last update 2 seconds ago 2018-07-07 21:37:42,408 calculate_batch_delay for wid=1, skipping - only 2 events since the last update 2018-07-07 21:37:43,197 sound source using 'opus' audio codec 2018-07-07 21:37:46,152 packet decoding sequence 5 for window 1: 13x21 took 15.8ms 2018-07-07 21:37:46,152 record_latency: took 1362.0 ms round trip, 1361.9 for echo, 15.0 for decoding of 273 pixels, 1151 bytes sent over the network in 1346.1 ms, 1346.1 ms for echo 2018-07-07 21:37:46,156 packet decoding sequence 6 for window 1: 243x16 took 19.2ms 2018-07-07 21:37:46,156 record_latency: took 1364.8 ms round trip, 1364.8 for echo, 19.0 for decoding of 3888 pixels, 15621 bytes sent over the network in 1345.6 ms, 1345.6 ms for echo 2018-07-07 21:37:46,156 may_recalculate(1, 3888) total 4161 pixels, scheduling recalculate work item 2018-07-07 21:37:46,157 calculate_batch_delay for wid=1 current batch delay=13, last update 5 seconds ago 2018-07-07 21:37:46,157 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 40, 'recent': 40} 2018-07-07 21:37:46,157 update_batch_delay: client-decode-speed : 1.02,0.00 {'avg': 49, 'recent': 50} 2018-07-07 21:37:46,158 update_batch_delay: damage-rate : 0.91,0.30 {'max_latency': 111, 'elapsed': 312} 2018-07-07 21:37:46,158 update_batch_delay: client-latency : 4.39,1.05 {'target': 9, 'weight_multiplier': 568, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 19260, 'div': 1000, 'avg': 1025, 'recent': 1336} 2018-07-07 21:37:46,158 update_batch_delay: client-ping-latency : 0.74,0.12 {'target': 8, 'weight_multiplier': 226, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 544, 'div': 1000, 'avg': 4, 'recent': 5} 2018-07-07 21:37:46,158 update_batch_delay: server-ping-latency : 0.55,0.21 {'target': 12, 'weight_multiplier': 310, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 306, 'div': 1000, 'avg': 24, 'recent': 8} 2018-07-07 21:37:46,158 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:46,159 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:46,159 update_batch_delay: compression-work-queue : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:46,159 update_batch_delay: congestion : 2.75,17.48 {} 2018-07-07 21:37:46,159 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:46,160 update_batch_delay: focus : 1.00,0.00 {'has_focus': False} 2018-07-07 21:37:46,161 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:37:46,162 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:37:46,163 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:37:46,164 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:37:46,164 update_batch_delay: delay=36 2018-07-07 21:37:46,165 get_client_backlog missing acks: [] 2018-07-07 21:37:46,165 get_target_quality: target=0% (window 735x457) pctpixdamaged=402%, dpc={1: 1007685, 2: 340056, 3: 0, 4: 0, 5: 5642, 6: 1659775, 7: 0, 8: 0, 9: 0, 10: 0} 2018-07-07 21:37:46,166 update_quality() wid=1, info={'batch-delay-ratio': 241, 'backlog_factor': (4, 1343580, 335895, 4, 0), 'congestion-value': 1748, 'latency': 5, 'compression-ratio': (54, 54, 0), 'min_quality': 30, 'min_speed': 30}, quality=30 2018-07-07 21:37:46,166 update_speed() wid=1, info={}, speed=100 2018-07-07 21:37:47,088 packet decoding sequence 7 for window 1: 735x457 took 950.9ms 2018-07-07 21:37:47,089 record_latency: took 2014.9 ms round trip, 2014.8 for echo, 950.0 for decoding of 335895 pixels, 18706 bytes sent over the network in 1064.0 ms, 1063.9 ms for echo 2018-07-07 21:37:47,089 may_recalculate(1, 335895) total 335895 pixels, scheduling recalculate work item 2018-07-07 21:37:47,104 packet decoding sequence 8 for window 1: 735x457 took 949.1ms 2018-07-07 21:37:47,105 record_latency: took 1760.2 ms round trip, 1760.1 for echo, 949.0 for decoding of 335895 pixels, 18706 bytes sent over the network in 811.0 ms, 811.0 ms for echo 2018-07-07 21:37:47,121 packet decoding sequence 9 for window 1: 735x457 took 953.6ms 2018-07-07 21:37:47,121 record_latency: took 1366.1 ms round trip, 1366.0 for echo, 953.0 for decoding of 335895 pixels, 18706 bytes sent over the network in 412.5 ms, 412.4 ms for echo 2018-07-07 21:37:47,137 packet decoding sequence 10 for window 1: 735x457 took 957.5ms 2018-07-07 21:37:47,137 record_latency: took 1111.1 ms round trip, 1111.0 for echo, 957.0 for decoding of 335895 pixels, 18706 bytes sent over the network in 153.6 ms, 153.6 ms for echo 2018-07-07 21:37:47,154 packet decoding sequence 11 for window 1: 735x457 took 15.1ms 2018-07-07 21:37:47,154 record_latency: took 453.7 ms round trip, 453.6 for echo, 15.0 for decoding of 335895 pixels, 18706 bytes sent over the network in 438.6 ms, 438.6 ms for echo 2018-07-07 21:37:47,157 calculate_batch_delay for wid=1 current batch delay=36, last update 1 seconds ago 2018-07-07 21:37:47,158 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 40, 'recent': 40} 2018-07-07 21:37:47,158 update_batch_delay: client-decode-speed : 1.18,0.18 {'avg': 171, 'recent': 216} 2018-07-07 21:37:47,158 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 230, 'elapsed': 63} 2018-07-07 21:37:47,158 update_batch_delay: bandwidth-limit : 0.06,0.00 {'used': 298672, 'budget': 5242880} 2018-07-07 21:37:47,159 update_batch_delay: client-latency : 2.98,0.80 {'target': 9, 'weight_multiplier': 568, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 8881, 'div': 1000, 'avg': 643, 'recent': 597} 2018-07-07 21:37:47,159 update_batch_delay: client-ping-latency : 0.73,0.12 {'target': 8, 'weight_multiplier': 226, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 532, 'div': 1000, 'avg': 4, 'recent': 5} 2018-07-07 21:37:47,159 update_batch_delay: server-ping-latency : 0.66,0.18 {'target': 12, 'weight_multiplier': 310, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 437, 'div': 1000, 'avg': 28, 'recent': 14} 2018-07-07 21:37:47,159 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:47,159 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:47,159 update_batch_delay: compression-work-queue : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:47,159 update_batch_delay: congestion : 5.53,45.29 {} 2018-07-07 21:37:47,159 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:47,160 update_batch_delay: focus : 1.00,0.00 {'has_focus': False} 2018-07-07 21:37:47,160 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:37:47,160 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:37:47,160 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:37:47,160 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:37:47,160 update_batch_delay: delay=148 2018-07-07 21:37:47,161 get_client_backlog missing acks: [] 2018-07-07 21:37:47,161 get_target_quality: target=0% (window 735x457) pctpixdamaged=801%, dpc={1: 1343580, 2: 1007685, 3: 340056, 4: 0, 5: 0, 6: 5642, 7: 1659775, 8: 0, 9: 0, 10: 0} 2018-07-07 21:37:47,161 update_quality() wid=1, info={'batch-delay-ratio': 51, 'backlog_factor': (1, 335895, 335895, 1, 100), 'congestion-value': 4529, 'latency': 12, 'compression-ratio': (54, 54, 0), 'min_quality': 30, 'max-quality-range': 72, 'min_speed': 30}, quality=30 2018-07-07 21:37:47,161 update_speed() wid=1, info={}, speed=100 2018-07-07 21:37:47,170 packet decoding sequence 12 for window 1: 735x457 took 19.3ms 2018-07-07 21:37:47,171 record_latency: took 168.8 ms round trip, 168.7 for echo, 19.0 for decoding of 335895 pixels, 18706 bytes sent over the network in 149.5 ms, 149.3 ms for echo 2018-07-07 21:37:47,171 may_recalculate(1, 335895) total 335895 pixels, scheduling recalculate work item 2018-07-07 21:37:47,383 packet decoding sequence 13 for window 1: 735x457 took 17.6ms 2018-07-07 21:37:47,383 record_latency: took 23.2 ms round trip, 23.1 for echo, 17.0 for decoding of 335895 pixels, 18706 bytes sent over the network in 5.5 ms, 5.4 ms for echo 2018-07-07 21:37:47,433 packet decoding sequence 14 for window 1: 735x457 took 18.4ms 2018-07-07 21:37:47,433 record_latency: took 23.1 ms round trip, 23.1 for echo, 18.0 for decoding of 335895 pixels, 18706 bytes sent over the network in 4.7 ms, 4.7 ms for echo 2018-07-07 21:37:47,796 packet decoding sequence 15 for window 1: 13x21 took 2.1ms 2018-07-07 21:37:47,797 record_latency: took 6.8 ms round trip, 6.7 for echo, 2.0 for decoding of 273 pixels, 1144 bytes sent over the network in 4.7 ms, 4.6 ms for echo 2018-07-07 21:37:48,158 calculate_batch_delay for wid=1 current batch delay=148, last update 1 seconds ago 2018-07-07 21:37:48,159 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 40, 'recent': 40} 2018-07-07 21:37:48,159 update_batch_delay: client-decode-speed : 0.97,0.01 {'avg': 94, 'recent': 91} 2018-07-07 21:37:48,159 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 230, 'elapsed': 138} 2018-07-07 21:37:48,159 update_batch_delay: bandwidth-limit : 0.09,0.00 {'used': 307408, 'budget': 3589377} 2018-07-07 21:37:48,159 update_batch_delay: client-latency : 1.96,0.56 {'target': 9, 'weight_multiplier': 568, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 3853, 'div': 1000, 'avg': 400, 'recent': 246} 2018-07-07 21:37:48,160 update_batch_delay: client-ping-latency : 0.73,0.12 {'target': 8, 'weight_multiplier': 226, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 538, 'div': 1000, 'avg': 5, 'recent': 5} 2018-07-07 21:37:48,160 update_batch_delay: server-ping-latency : 0.59,0.20 {'target': 12, 'weight_multiplier': 310, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 346, 'div': 1000, 'avg': 18, 'recent': 7} 2018-07-07 21:37:48,160 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:48,160 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:48,160 update_batch_delay: compression-work-queue : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:48,160 update_batch_delay: congestion : 1.44,4.40 {} 2018-07-07 21:37:48,160 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:48,161 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:37:48,161 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:37:48,161 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:37:48,161 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:37:48,161 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:37:48,161 update_batch_delay: delay=160 2018-07-07 21:37:48,162 get_target_quality: target=6% (window 735x457) pctpixdamaged=801%, dpc={1: 1508, 2: 1343580, 3: 1007685, 4: 340056, 5: 0, 6: 0, 7: 5642, 8: 1659775, 9: 0, 10: 0} 2018-07-07 21:37:48,162 update_quality() wid=1, info={'batch-delay-ratio': 45, 'backlog_factor': (0, 0, 335895, 0, 100), 'congestion-value': 439, 'latency': 29, 'compression-ratio': (54, 54, 0), 'min_quality': 30, 'max-quality-range': 59, 'min_speed': 30}, quality=30 2018-07-07 21:37:48,162 update_speed() wid=1, info={}, speed=100 2018-07-07 21:37:48,298 packet decoding sequence 1 for window 2: 314x165 took 14.1ms 2018-07-07 21:37:48,298 record_latency: took 20.0 ms round trip, 19.9 for echo, 14.0 for decoding of 51810 pixels, 4537 bytes sent over the network in 5.9 ms, 5.8 ms for echo 2018-07-07 21:37:48,298 may_recalculate(2, 51810) total 51810 pixels, scheduling recalculate work item 2018-07-07 21:37:48,472 packet decoding sequence 16 for window 1: 65x19 took 53.9ms 2018-07-07 21:37:48,472 record_latency: took 62.1 ms round trip, 61.3 for echo, 53.0 for decoding of 1235 pixels, 5008 bytes sent over the network in 8.2 ms, 7.4 ms for echo 2018-07-07 21:37:48,641 packet decoding sequence 1 for window 3: 221x82 took 12.1ms 2018-07-07 21:37:48,641 record_latency: took 15.8 ms round trip, 15.7 for echo, 12.0 for decoding of 18122 pixels, 2928 bytes sent over the network in 3.7 ms, 3.6 ms for echo 2018-07-07 21:37:48,642 may_recalculate(3, 18122) total 18122 pixels, scheduling recalculate work item 2018-07-07 21:37:48,820 packet decoding sequence 17 for window 1: 106x19 took 1.1ms 2018-07-07 21:37:48,820 record_latency: took 44.6 ms round trip, 44.5 for echo, 1.0 for decoding of 2014 pixels, 8124 bytes sent over the network in 43.5 ms, 43.4 ms for echo 2018-07-07 21:37:48,820 may_recalculate(1, 2014) total 3249 pixels, scheduling recalculate work item 2018-07-07 21:37:48,892 packet decoding sequence 1 for window 4: 314x165 took 12.9ms 2018-07-07 21:37:48,892 record_latency: took 16.8 ms round trip, 16.7 for echo, 12.0 for decoding of 51810 pixels, 4537 bytes sent over the network in 3.9 ms, 3.8 ms for echo 2018-07-07 21:37:48,893 may_recalculate(4, 51810) total 51810 pixels, scheduling recalculate work item 2018-07-07 21:37:49,073 packet decoding sequence 18 for window 1: 106x19 took 2.6ms 2018-07-07 21:37:49,073 record_latency: took 10.3 ms round trip, 9.4 for echo, 2.0 for decoding of 2014 pixels, 8124 bytes sent over the network in 7.7 ms, 6.8 ms for echo 2018-07-07 21:37:49,158 calculate_batch_delay for wid=1 current batch delay=160, last update 0 seconds ago 2018-07-07 21:37:49,159 update_batch_delay: damage-network-delay : 1.01,0.51 {'avg': 40, 'recent': 41} 2018-07-07 21:37:49,159 update_batch_delay: client-decode-speed : 1.03,0.01 {'avg': 93, 'recent': 97} 2018-07-07 21:37:49,159 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 174, 'elapsed': 15} 2018-07-07 21:37:49,159 update_batch_delay: bandwidth-limit : 0.05,0.00 {'used': 168416, 'budget': 3992478} 2018-07-07 21:37:49,159 update_batch_delay: client-latency : 0.93,0.14 {'target': 8, 'weight_multiplier': 520, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 865, 'div': 1000, 'avg': 208, 'recent': 47} 2018-07-07 21:37:49,159 update_batch_delay: client-ping-latency : 0.73,0.12 {'target': 8, 'weight_multiplier': 226, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 533, 'div': 1000, 'avg': 4, 'recent': 5} 2018-07-07 21:37:49,160 update_batch_delay: server-ping-latency : 0.65,0.18 {'target': 12, 'weight_multiplier': 310, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 416, 'div': 1000, 'avg': 20, 'recent': 10} 2018-07-07 21:37:49,160 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:49,160 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:49,160 update_batch_delay: compression-work-queue : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:49,160 update_batch_delay: congestion : 1.13,1.26 {} 2018-07-07 21:37:49,160 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:49,160 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:37:49,160 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:37:49,161 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:37:49,161 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:37:49,161 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:37:49,161 update_batch_delay: delay=131 2018-07-07 21:37:49,161 get_target_quality: target=25% (window 735x457) pctpixdamaged=803%, dpc={1: 6023, 2: 1508, 3: 1343580, 4: 1007685, 5: 340056, 6: 0, 7: 0, 8: 5642, 9: 1659775, 10: 0} 2018-07-07 21:37:49,162 update_quality() wid=1, info={'batch-delay-ratio': 53, 'backlog_factor': (0, 0, 335895, 0, 100), 'congestion-value': 125, 'latency': 152, 'compression-ratio': (54, 54, 0), 'min_quality': 30, 'max-quality-range': 63, 'min_speed': 30}, quality=36 2018-07-07 21:37:49,162 update_speed() wid=1, info={}, speed=100 2018-07-07 21:37:49,284 packet decoding sequence 1 for window 6: 166x48 took 6.8ms 2018-07-07 21:37:49,284 record_latency: took 29.4 ms round trip, 29.4 for echo, 6.0 for decoding of 7968 pixels, 1728 bytes sent over the network in 22.6 ms, 22.5 ms for echo 2018-07-07 21:37:49,285 may_recalculate(6, 7968) total 7968 pixels, scheduling recalculate work item 2018-07-07 21:37:49,391 packet decoding sequence 19 for window 1: 146x19 took 2.9ms 2018-07-07 21:37:49,392 record_latency: took 9.4 ms round trip, 9.3 for echo, 2.0 for decoding of 2774 pixels, 11166 bytes sent over the network in 6.5 ms, 6.5 ms for echo 2018-07-07 21:37:49,392 may_recalculate(1, 2774) total 2774 pixels, scheduling recalculate work item 2018-07-07 21:37:49,437 packet decoding sequence 2 for window 6: 166x48 took 2.8ms 2018-07-07 21:37:49,437 record_latency: took 7.0 ms round trip, 6.9 for echo, 2.0 for decoding of 7968 pixels, 3337 bytes sent over the network in 4.2 ms, 4.1 ms for echo 2018-07-07 21:37:49,858 packet decoding sequence 1 for window 8: 314x165 took 12.0ms 2018-07-07 21:37:49,858 record_latency: took 15.8 ms round trip, 15.7 for echo, 12.0 for decoding of 51810 pixels, 4537 bytes sent over the network in 3.8 ms, 3.7 ms for echo 2018-07-07 21:37:49,858 may_recalculate(8, 51810) total 51810 pixels, scheduling recalculate work item 2018-07-07 21:37:49,891 packet decoding sequence 20 for window 1: 146x19 took 1.3ms 2018-07-07 21:37:49,891 record_latency: took 6.2 ms round trip, 6.1 for echo, 1.0 for decoding of 2774 pixels, 11166 bytes sent over the network in 4.9 ms, 4.8 ms for echo 2018-07-07 21:37:50,158 calculate_batch_delay for wid=1 current batch delay=131, last update 1 seconds ago 2018-07-07 21:37:50,159 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 40, 'recent': 40} 2018-07-07 21:37:50,159 update_batch_delay: client-decode-speed : 1.04,0.02 {'avg': 92, 'recent': 98} 2018-07-07 21:37:50,159 update_batch_delay: damage-rate : 0.88,0.34 {'max_latency': 146, 'elapsed': 407} 2018-07-07 21:37:50,159 update_batch_delay: bandwidth-limit : 0.05,0.00 {'used': 177536, 'budget': 3596209} 2018-07-07 21:37:50,160 update_batch_delay: client-latency : 0.79,0.24 {'target': 8, 'weight_multiplier': 520, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 625, 'div': 1000, 'avg': 153, 'recent': 31} 2018-07-07 21:37:50,160 update_batch_delay: client-ping-latency : 0.73,0.12 {'target': 8, 'weight_multiplier': 226, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 526, 'div': 1000, 'avg': 4, 'recent': 5} 2018-07-07 21:37:50,160 update_batch_delay: server-ping-latency : 0.70,0.17 {'target': 12, 'weight_multiplier': 310, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 491, 'div': 1000, 'avg': 22, 'recent': 13} 2018-07-07 21:37:50,160 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:50,160 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:50,160 update_batch_delay: compression-work-queue : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:50,160 update_batch_delay: congestion : 1.06,0.59 {} 2018-07-07 21:37:50,161 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:50,161 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:37:50,161 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:37:50,161 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:37:50,161 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:37:50,161 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:37:50,161 update_batch_delay: delay=111 2018-07-07 21:37:50,162 get_target_quality: target=32% (window 735x457) pctpixdamaged=703%, dpc={1: 3553, 2: 6023, 3: 1508, 4: 1343580, 5: 1007685, 6: 340056, 7: 0, 8: 0, 9: 5642, 10: 1659775} 2018-07-07 21:37:50,162 update_quality() wid=1, info={'batch-delay-ratio': 61, 'backlog_factor': (0, 0, 335895, 0, 100), 'congestion-value': 58, 'latency': 226, 'compression-ratio': (54, 54, 0), 'min_quality': 30, 'max-quality-range': 59, 'min_speed': 30}, quality=42 2018-07-07 21:37:50,162 update_speed() wid=1, info={}, speed=100 2018-07-07 21:37:50,163 calculate_batch_delay for wid=8 current batch delay=88, last update 80145 seconds ago 2018-07-07 21:37:50,163 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 40, 'recent': 40} 2018-07-07 21:37:50,163 update_batch_delay: client-decode-speed : 1.00,0.00 {'avg': 243, 'recent': 243} 2018-07-07 21:37:50,163 update_batch_delay: damage-rate : 0.79,0.46 {'max_latency': 100, 'elapsed': 411} 2018-07-07 21:37:50,163 update_batch_delay: bandwidth-limit : 0.02,0.00 {'used': 35904, 'budget': 1646670} 2018-07-07 21:37:50,163 update_batch_delay: client-latency : 0.79,0.24 {'target': 8, 'weight_multiplier': 520, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 625, 'div': 1000, 'avg': 153, 'recent': 31} 2018-07-07 21:37:50,164 update_batch_delay: client-ping-latency : 0.73,0.12 {'target': 8, 'weight_multiplier': 226, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 526, 'div': 1000, 'avg': 4, 'recent': 5} 2018-07-07 21:37:50,164 update_batch_delay: server-ping-latency : 0.70,0.17 {'target': 12, 'weight_multiplier': 310, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 491, 'div': 1000, 'avg': 22, 'recent': 13} 2018-07-07 21:37:50,164 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:50,164 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 51810000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:50,164 update_batch_delay: compression-work-queue : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:50,164 update_batch_delay: congestion : 1.06,0.59 {} 2018-07-07 21:37:50,164 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 51810000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:50,164 update_batch_delay: focus : 1.00,0.00 {'has_focus': False} 2018-07-07 21:37:50,164 update_batch_delay: override-redirect : 0.00,1.00 {'is_OR': True} 2018-07-07 21:37:50,164 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:37:50,164 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:37:50,164 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:37:50,164 update_batch_delay: delay=70 2018-07-07 21:37:50,235 packet decoding sequence 2 for window 8: 314x165 took 4.6ms 2018-07-07 21:37:50,235 record_latency: took 8.9 ms round trip, 8.9 for echo, 4.0 for decoding of 51810 pixels, 9327 bytes sent over the network in 4.3 ms, 4.2 ms for echo 2018-07-07 21:37:50,235 may_recalculate(8, 51810) total 51810 pixels, scheduling recalculate work item 2018-07-07 21:37:51,159 calculate_batch_delay for wid=8 current batch delay=70, last update 0 seconds ago 2018-07-07 21:37:51,159 calculate_batch_delay for wid=8, skipping - only 1 events since the last update 2018-07-07 21:37:53,466 packet decoding sequence 3 for window 8: 312x19 took 3.8ms 2018-07-07 21:37:53,466 record_latency: took 9.7 ms round trip, 9.7 for echo, 3.0 for decoding of 5928 pixels, 1078 bytes sent over the network in 5.9 ms, 5.9 ms for echo 2018-07-07 21:37:53,466 may_recalculate(8, 5928) total 5928 pixels, scheduling recalculate work item 2018-07-07 21:37:53,467 calculate_batch_delay for wid=8 current batch delay=70, last update 3 seconds ago 2018-07-07 21:37:53,467 calculate_batch_delay for wid=8, skipping - only 2 events since the last update 2018-07-07 21:37:53,506 packet decoding sequence 21 for window 1: 65x19 took 1.2ms 2018-07-07 21:37:53,507 record_latency: took 9.8 ms round trip, 9.8 for echo, 1.0 for decoding of 1235 pixels, 5008 bytes sent over the network in 8.6 ms, 8.6 ms for echo 2018-07-07 21:37:53,577 packet decoding sequence 4 for window 8: 312x21 took 5.7ms 2018-07-07 21:37:53,577 record_latency: took 11.5 ms round trip, 11.4 for echo, 5.0 for decoding of 6552 pixels, 1348 bytes sent over the network in 5.8 ms, 5.6 ms for echo 2018-07-07 21:37:53,577 may_recalculate(8, 6552) total 6552 pixels, scheduling recalculate work item 2018-07-07 21:37:53,672 packet decoding sequence 5 for window 8: 312x21 took 5.3ms 2018-07-07 21:37:53,672 record_latency: took 9.6 ms round trip, 9.5 for echo, 5.0 for decoding of 6552 pixels, 1263 bytes sent over the network in 4.3 ms, 4.2 ms for echo 2018-07-07 21:37:53,710 packet decoding sequence 22 for window 1: 65x19 took 2.8ms 2018-07-07 21:37:53,711 record_latency: took 8.5 ms round trip, 8.4 for echo, 2.0 for decoding of 1235 pixels, 5009 bytes sent over the network in 5.7 ms, 5.6 ms for echo 2018-07-07 21:37:53,711 may_recalculate(1, 1235) total 2470 pixels, scheduling recalculate work item 2018-07-07 21:37:53,834 packet decoding sequence 6 for window 8: 312x19 took 2.8ms 2018-07-07 21:37:53,834 record_latency: took 7.9 ms round trip, 7.8 for echo, 2.0 for decoding of 5928 pixels, 1298 bytes sent over the network in 5.1 ms, 5.1 ms for echo 2018-07-07 21:37:53,871 packet decoding sequence 23 for window 1: 65x19 took 1.2ms 2018-07-07 21:37:53,871 record_latency: took 5.0 ms round trip, 4.9 for echo, 1.0 for decoding of 1235 pixels, 5009 bytes sent over the network in 3.7 ms, 3.7 ms for echo 2018-07-07 21:37:53,931 packet decoding sequence 7 for window 8: 312x19 took 5.5ms 2018-07-07 21:37:53,931 record_latency: took 12.4 ms round trip, 12.3 for echo, 5.0 for decoding of 5928 pixels, 1487 bytes sent over the network in 6.9 ms, 6.8 ms for echo 2018-07-07 21:37:53,933 packet decoding sequence 8 for window 8: 312x19 took 9.1ms 2018-07-07 21:37:53,934 record_latency: took 13.1 ms round trip, 13.0 for echo, 9.0 for decoding of 5928 pixels, 998 bytes sent over the network in 4.0 ms, 3.9 ms for echo 2018-07-07 21:37:53,936 packet decoding sequence 9 for window 8: 312x19 took 2.0ms 2018-07-07 21:37:53,937 record_latency: took 14.9 ms round trip, 14.8 for echo, 2.0 for decoding of 5928 pixels, 1226 bytes sent over the network in 12.9 ms, 12.8 ms for echo 2018-07-07 21:37:54,015 packet decoding sequence 10 for window 8: 312x19 took 2.5ms 2018-07-07 21:37:54,015 record_latency: took 7.4 ms round trip, 7.3 for echo, 2.0 for decoding of 5928 pixels, 1479 bytes sent over the network in 4.9 ms, 4.8 ms for echo 2018-07-07 21:37:54,040 packet decoding sequence 24 for window 1: 65x19 took 1.2ms 2018-07-07 21:37:54,040 record_latency: took 9.8 ms round trip, 9.7 for echo, 1.0 for decoding of 1235 pixels, 5009 bytes sent over the network in 8.6 ms, 8.5 ms for echo 2018-07-07 21:37:54,468 calculate_batch_delay for wid=1 current batch delay=111, last update 4 seconds ago 2018-07-07 21:37:54,468 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 40, 'recent': 40} 2018-07-07 21:37:54,469 update_batch_delay: client-decode-speed : 1.05,0.03 {'avg': 88, 'recent': 95} 2018-07-07 21:37:54,469 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 110, 'elapsed': 98} 2018-07-07 21:37:54,469 update_batch_delay: bandwidth-limit : 0.03,0.00 {'used': 158080, 'budget': 5242880} 2018-07-07 21:37:54,469 update_batch_delay: client-latency : 0.51,0.36 {'target': 8, 'weight_multiplier': 520, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 264, 'div': 1000, 'avg': 67, 'recent': 10} 2018-07-07 21:37:54,469 update_batch_delay: client-ping-latency : 0.72,0.12 {'target': 8, 'weight_multiplier': 226, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 519, 'div': 1000, 'avg': 4, 'recent': 5} 2018-07-07 21:37:54,469 update_batch_delay: server-ping-latency : 0.61,0.16 {'target': 9, 'weight_multiplier': 263, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 368, 'div': 1000, 'avg': 13, 'recent': 6} 2018-07-07 21:37:54,469 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:54,470 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:54,470 update_batch_delay: compression-work-queue : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:54,470 update_batch_delay: congestion : 1.01,0.12 {} 2018-07-07 21:37:54,470 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:37:54,470 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:37:54,470 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:37:54,470 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:37:54,471 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:37:54,471 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:37:54,471 update_batch_delay: delay=81 2018-07-07 21:37:54,471 get_target_quality: target=49% (window 735x457) pctpixdamaged=2%, dpc={1: 4940, 2: 1235, 3: 0, 4: 0, 5: 2774, 6: 4788, 7: 3249, 8: 1007958, 9: 1007685, 10: 675951} 2018-07-07 21:37:54,472 update_quality() wid=1, info={'batch-delay-ratio': 82, 'backlog_factor': (0, 0, 335895, 0, 100), 'congestion-value': 11, 'latency': 698, 'compression-ratio': (54, 54, 0), 'min_quality': 30, 'max-quality-range': 72, 'min_speed': 30}, quality=89 2018-07-07 21:37:54,472 update_speed() wid=1, info={}, speed=100 2018-07-07 21:37:54,566 packet decoding sequence 25 for window 1: 65x19 took 1.7ms 2018-07-07 21:37:54,567 record_latency: took 7.2 ms round trip, 7.1 for echo, 1.0 for decoding of 1235 pixels, 5009 bytes sent over the network in 5.5 ms, 5.5 ms for echo 2018-07-07 21:37:59,856 packet decoding sequence 26 for window 1: 13x21 took 2.6ms 2018-07-07 21:37:59,856 record_latency: took 7.8 ms round trip, 7.7 for echo, 2.0 for decoding of 273 pixels, 1144 bytes sent over the network in 5.2 ms, 5.1 ms for echo 2018-07-07 21:38:05,148 total_time=4146070, total_pixels=4012150 2018-07-07 21:38:05,400 packet decoding sequence 27 for window 1: 13x21 took 3.3ms 2018-07-07 21:38:05,400 record_latency: took 8.3 ms round trip, 8.3 for echo, 3.0 for decoding of 273 pixels, 1144 bytes sent over the network in 5.0 ms, 5.0 ms for echo 2018-07-07 21:38:06,471 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:06,573 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:06,673 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:06,774 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:06,874 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:06,975 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:07,077 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:07,175 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:07,278 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:07,379 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:07,480 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:07,585 total_time=4149369, total_pixels=4012423 2018-07-07 21:38:07,606 packet decoding sequence 28 for window 1: 13x21 took 1.3ms 2018-07-07 21:38:07,606 record_latency: took 27.8 ms round trip, 27.7 for echo, 1.0 for decoding of 273 pixels, 1144 bytes sent over the network in 26.5 ms, 26.5 ms for echo 2018-07-07 21:38:07,606 may_recalculate(1, 273) total 2054 pixels, scheduling recalculate work item 2018-07-07 21:38:07,607 calculate_batch_delay for wid=1 current batch delay=81, last update 13 seconds ago 2018-07-07 21:38:07,607 calculate_batch_delay for wid=1, skipping - only 4 events since the last update 2018-07-07 21:38:07,608 get_target_quality: target=49% (window 735x457) pctpixdamaged=0%, dpc={1: 273, 2: 0, 3: 273, 4: 0, 5: 0, 6: 0, 7: 0, 8: 273, 9: 0, 10: 0} 2018-07-07 21:38:07,608 update_quality() wid=1, info={'batch-delay-ratio': 81, 'backlog_factor': (0, 0, 335895, 0, 100), 'congestion-value': 0, 'latency': 265, 'compression-ratio': (54, 54, 0), 'min_quality': 30, 'max-quality-range': 72, 'min_speed': 30}, quality=99 2018-07-07 21:38:07,608 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:07,684 total_time=4150623, total_pixels=4012696 2018-07-07 21:38:07,786 total_time=4150623, total_pixels=4012696 2018-07-07 21:38:07,887 total_time=4150623, total_pixels=4012696 2018-07-07 21:38:07,992 total_time=4150623, total_pixels=4012696 2018-07-07 21:38:08,107 total_time=4150623, total_pixels=4012696 2018-07-07 21:38:08,207 total_time=4150623, total_pixels=4012696 2018-07-07 21:38:08,235 packet decoding sequence 29 for window 1: 13x21 took 1.0ms 2018-07-07 21:38:08,235 record_latency: took 45.8 ms round trip, 45.7 for echo, 1.0 for decoding of 273 pixels, 1144 bytes sent over the network in 44.8 ms, 44.7 ms for echo 2018-07-07 21:38:08,293 total_time=4151626, total_pixels=4012969 2018-07-07 21:38:08,422 total_time=4151626, total_pixels=4012969 2018-07-07 21:38:08,527 total_time=4151626, total_pixels=4012969 2018-07-07 21:38:08,622 total_time=4151626, total_pixels=4012969 2018-07-07 21:38:08,739 total_time=4151626, total_pixels=4012969 2018-07-07 21:38:08,843 total_time=4151626, total_pixels=4012969 2018-07-07 21:38:08,941 total_time=4151626, total_pixels=4012969 2018-07-07 21:38:09,040 total_time=4151626, total_pixels=4012969 2018-07-07 21:38:09,142 total_time=4151626, total_pixels=4012969 2018-07-07 21:38:09,206 packet decoding sequence 30 for window 1: 735x457 took 8.3ms 2018-07-07 21:38:09,206 record_latency: took 776.1 ms round trip, 755.4 for echo, 8.0 for decoding of 335895 pixels, 1343639 bytes sent over the network in 767.9 ms, 747.1 ms for echo 2018-07-07 21:38:09,207 may_recalculate(1, 335895) total 336168 pixels, scheduling recalculate work item 2018-07-07 21:38:09,207 calculate_batch_delay for wid=1 current batch delay=81, last update 14 seconds ago 2018-07-07 21:38:09,208 update_batch_delay: damage-network-delay : 1.12,0.62 {'avg': 50, 'recent': 58} 2018-07-07 21:38:09,208 update_batch_delay: client-decode-speed : 0.84,0.02 {'avg': 32, 'recent': 25} 2018-07-07 21:38:09,208 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 100, 'elapsed': 22} 2018-07-07 21:38:09,208 update_batch_delay: bandwidth-limit : 6.77,45.88 {'used': 32245920, 'budget': 5242880} 2018-07-07 21:38:09,208 update_batch_delay: client-latency : 3.45,0.81 {'target': 8, 'weight_multiplier': 520, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 11895, 'div': 1000, 'avg': 253, 'recent': 671} 2018-07-07 21:38:09,209 update_batch_delay: client-ping-latency : 0.66,0.13 {'target': 8, 'weight_multiplier': 225, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 438, 'div': 1000, 'avg': 4, 'recent': 4} 2018-07-07 21:38:09,209 update_batch_delay: server-ping-latency : 0.62,0.13 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 381, 'div': 1000, 'avg': 6, 'recent': 4} 2018-07-07 21:38:09,209 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:09,209 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:09,209 update_batch_delay: compression-work-queue : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:09,209 update_batch_delay: congestion : 1.87,8.74 {} 2018-07-07 21:38:09,209 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:09,210 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:38:09,210 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:38:09,210 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:09,210 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:09,210 update_batch_delay: soft-expired : 2.00,1.00 {'count': 2} 2018-07-07 21:38:09,210 update_batch_delay: delay=277 2018-07-07 21:38:09,210 get_client_backlog missing acks: [] 2018-07-07 21:38:09,211 get_target_quality: target=0% (window 735x457) pctpixdamaged=300%, dpc={1: 1007958, 2: 546, 3: 0, 4: 273, 5: 0, 6: 0, 7: 0, 8: 0, 9: 0, 10: 273} 2018-07-07 21:38:09,211 update_quality() wid=1, info={'batch-delay-ratio': 23, 'backlog_factor': (1, 335895, 335895, 1, 100), 'congestion-value': 874, 'latency': 10, 'compression-ratio': (3359, 3995, -61), 'min_quality': 30, 'max-quality-range': 72, 'min_speed': 30}, quality=33 2018-07-07 21:38:09,211 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:09,212 packet decoding sequence 31 for window 1: 735x457 took 13.2ms 2018-07-07 21:38:09,212 record_latency: took 376.0 ms round trip, 356.9 for echo, 13.0 for decoding of 335895 pixels, 1343639 bytes sent over the network in 362.8 ms, 343.7 ms for echo 2018-07-07 21:38:09,213 may_recalculate(1, 335895) total 335895 pixels, scheduling recalculate work item 2018-07-07 21:38:09,225 total_time=4173071, total_pixels=4684759 2018-07-07 21:38:09,232 packet decoding sequence 32 for window 1: 735x457 took 17.0ms 2018-07-07 21:38:09,232 record_latency: took 58.9 ms round trip, 39.1 for echo, 17.0 for decoding of 335895 pixels, 1343639 bytes sent over the network in 41.9 ms, 22.1 ms for echo 2018-07-07 21:38:09,328 total_time=4190073, total_pixels=5020654 2018-07-07 21:38:09,427 total_time=4190073, total_pixels=5020654 2018-07-07 21:38:09,528 total_time=4190073, total_pixels=5020654 2018-07-07 21:38:09,592 packet decoding sequence 33 for window 1: 13x21 took 1.3ms 2018-07-07 21:38:09,592 record_latency: took 4.8 ms round trip, 4.7 for echo, 1.0 for decoding of 273 pixels, 1144 bytes sent over the network in 3.5 ms, 3.5 ms for echo 2018-07-07 21:38:09,630 total_time=4191347, total_pixels=5020927 2018-07-07 21:38:09,729 total_time=4191347, total_pixels=5020927 2018-07-07 21:38:09,830 total_time=4191347, total_pixels=5020927 2018-07-07 21:38:09,932 total_time=4191347, total_pixels=5020927 2018-07-07 21:38:10,033 total_time=4191347, total_pixels=5020927 2018-07-07 21:38:10,133 total_time=4191347, total_pixels=5020927 2018-07-07 21:38:10,208 calculate_batch_delay for wid=1 current batch delay=277, last update 1 seconds ago 2018-07-07 21:38:10,208 update_batch_delay: damage-network-delay : 1.02,0.52 {'avg': 47, 'recent': 48} 2018-07-07 21:38:10,209 update_batch_delay: client-decode-speed : 0.91,0.01 {'avg': 41, 'recent': 36} 2018-07-07 21:38:10,209 update_batch_delay: damage-rate : 0.18,0.91 {'max_latency': 100, 'elapsed': 1022} 2018-07-07 21:38:10,209 update_batch_delay: bandwidth-limit : 0.00,0.00 {'used': 8736, 'budget': 5242880} 2018-07-07 21:38:10,209 update_batch_delay: client-latency : 1.98,0.51 {'target': 8, 'weight_multiplier': 510, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 3918, 'div': 1000, 'avg': 175, 'recent': 203} 2018-07-07 21:38:10,209 update_batch_delay: client-ping-latency : 0.65,0.13 {'target': 8, 'weight_multiplier': 225, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 424, 'div': 1000, 'avg': 4, 'recent': 3} 2018-07-07 21:38:10,209 update_batch_delay: server-ping-latency : 0.66,0.13 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 430, 'div': 1000, 'avg': 6, 'recent': 4} 2018-07-07 21:38:10,209 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:10,211 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:10,211 update_batch_delay: compression-work-queue : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:10,212 update_batch_delay: congestion : 1.08,0.79 {} 2018-07-07 21:38:10,212 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:10,212 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:38:10,212 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:38:10,212 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:10,212 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:10,212 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:10,213 update_batch_delay: delay=182 2018-07-07 21:38:10,213 get_target_quality: target=0% (window 735x457) pctpixdamaged=300%, dpc={1: 0, 2: 1007958, 3: 546, 4: 0, 5: 273, 6: 0, 7: 0, 8: 0, 9: 0, 10: 0} 2018-07-07 21:38:10,213 update_quality() wid=1, info={'batch-delay-ratio': 35, 'backlog_factor': (0, 0, 335895, 0, 100), 'congestion-value': 79, 'latency': 35, 'compression-ratio': (3020, 3958, -95), 'min_quality': 30, 'max-quality-range': 72, 'min_speed': 30}, quality=32 2018-07-07 21:38:10,214 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:10,254 total_time=4191347, total_pixels=5020927 2018-07-07 21:38:10,345 total_time=4191347, total_pixels=5020927 2018-07-07 21:38:10,357 packet decoding sequence 1 for window 9: 221x82 took 7.0ms 2018-07-07 21:38:10,357 record_latency: took 41.0 ms round trip, 40.9 for echo, 7.0 for decoding of 18122 pixels, 2928 bytes sent over the network in 34.0 ms, 33.9 ms for echo 2018-07-07 21:38:10,357 may_recalculate(9, 18122) total 18122 pixels, scheduling recalculate work item 2018-07-07 21:38:10,447 total_time=4198387, total_pixels=5039049 2018-07-07 21:38:10,507 packet decoding sequence 34 for window 1: 41x19 took 1.6ms 2018-07-07 21:38:10,508 record_latency: took 5.7 ms round trip, 5.6 for echo, 1.0 for decoding of 779 pixels, 3168 bytes sent over the network in 4.1 ms, 4.0 ms for echo 2018-07-07 21:38:10,546 total_time=4199970, total_pixels=5039828 2018-07-07 21:38:10,631 packet decoding sequence 2 for window 9: 221x82 took 3.8ms 2018-07-07 21:38:10,631 record_latency: took 8.8 ms round trip, 8.8 for echo, 3.0 for decoding of 18122 pixels, 4194 bytes sent over the network in 5.0 ms, 4.9 ms for echo 2018-07-07 21:38:10,647 total_time=4203794, total_pixels=5057950 2018-07-07 21:38:10,748 total_time=4203794, total_pixels=5057950 2018-07-07 21:38:10,849 total_time=4203794, total_pixels=5057950 2018-07-07 21:38:10,952 total_time=4203794, total_pixels=5057950 2018-07-07 21:38:10,987 packet decoding sequence 3 for window 9: 219x19 took 5.3ms 2018-07-07 21:38:10,988 record_latency: took 15.4 ms round trip, 15.3 for echo, 5.0 for decoding of 4161 pixels, 12536 bytes sent over the network in 10.1 ms, 10.1 ms for echo 2018-07-07 21:38:11,051 total_time=4209076, total_pixels=5062111 2018-07-07 21:38:11,153 total_time=4209076, total_pixels=5062111 2018-07-07 21:38:11,191 packet decoding sequence 35 for window 1: 41x19 took 1.1ms 2018-07-07 21:38:11,191 record_latency: took 32.9 ms round trip, 32.8 for echo, 1.0 for decoding of 779 pixels, 3168 bytes sent over the network in 31.8 ms, 31.8 ms for echo 2018-07-07 21:38:11,208 calculate_batch_delay for wid=9 current batch delay=72, last update 80166 seconds ago 2018-07-07 21:38:11,208 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 40, 'recent': 40} 2018-07-07 21:38:11,208 update_batch_delay: client-decode-speed : 1.00,0.00 {'avg': 291, 'recent': 291} 2018-07-07 21:38:11,208 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 100, 'elapsed': 6} 2018-07-07 21:38:11,209 update_batch_delay: bandwidth-limit : 0.20,0.00 {'used': 156152, 'budget': 865212} 2018-07-07 21:38:11,209 update_batch_delay: client-latency : 0.86,0.19 {'target': 8, 'weight_multiplier': 510, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 731, 'div': 1000, 'avg': 95, 'recent': 32} 2018-07-07 21:38:11,209 update_batch_delay: client-ping-latency : 0.60,0.14 {'target': 7, 'weight_multiplier': 213, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 357, 'div': 1000, 'avg': 3, 'recent': 3} 2018-07-07 21:38:11,209 update_batch_delay: server-ping-latency : 0.57,0.14 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 319, 'div': 1000, 'avg': 5, 'recent': 3} 2018-07-07 21:38:11,209 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:11,209 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 18122000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:11,209 update_batch_delay: compression-work-queue : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:11,210 update_batch_delay: congestion : 1.02,0.21 {} 2018-07-07 21:38:11,210 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 18122000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:11,210 update_batch_delay: focus : 1.00,0.00 {'has_focus': False} 2018-07-07 21:38:11,210 update_batch_delay: override-redirect : 0.00,1.00 {'is_OR': True} 2018-07-07 21:38:11,210 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:11,210 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:11,210 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:11,211 update_batch_delay: delay=53 2018-07-07 21:38:11,254 total_time=4210162, total_pixels=5062890 2018-07-07 21:38:11,299 packet decoding sequence 4 for window 9: 219x38 took 2.3ms 2018-07-07 21:38:11,299 record_latency: took 32.7 ms round trip, 32.6 for echo, 2.0 for decoding of 8322 pixels, 1838 bytes sent over the network in 30.4 ms, 30.3 ms for echo 2018-07-07 21:38:11,299 may_recalculate(9, 8322) total 8322 pixels, scheduling recalculate work item 2018-07-07 21:38:11,354 total_time=4212462, total_pixels=5071212 2018-07-07 21:38:11,455 total_time=4212462, total_pixels=5071212 2018-07-07 21:38:11,491 packet decoding sequence 36 for window 1: 41x19 took 1.8ms 2018-07-07 21:38:11,491 record_latency: took 41.2 ms round trip, 41.1 for echo, 1.0 for decoding of 779 pixels, 3168 bytes sent over the network in 39.3 ms, 39.3 ms for echo 2018-07-07 21:38:11,492 may_recalculate(1, 779) total 2337 pixels, scheduling recalculate work item 2018-07-07 21:38:11,494 packet decoding sequence 5 for window 9: 219x38 took 4.6ms 2018-07-07 21:38:11,494 record_latency: took 29.7 ms round trip, 29.6 for echo, 4.0 for decoding of 8322 pixels, 1930 bytes sent over the network in 25.1 ms, 25.0 ms for echo 2018-07-07 21:38:11,557 total_time=4218892, total_pixels=5080313 2018-07-07 21:38:11,598 packet decoding sequence 6 for window 9: 219x38 took 1.5ms 2018-07-07 21:38:11,598 record_latency: took 34.8 ms round trip, 34.7 for echo, 1.0 for decoding of 8322 pixels, 2035 bytes sent over the network in 33.4 ms, 33.3 ms for echo 2018-07-07 21:38:11,657 total_time=4220347, total_pixels=5088635 2018-07-07 21:38:11,697 packet decoding sequence 37 for window 1: 41x19 took 1.4ms 2018-07-07 21:38:11,697 record_latency: took 29.5 ms round trip, 29.3 for echo, 1.0 for decoding of 779 pixels, 3168 bytes sent over the network in 28.1 ms, 27.9 ms for echo 2018-07-07 21:38:11,700 packet decoding sequence 7 for window 9: 219x19 took 4.0ms 2018-07-07 21:38:11,701 record_latency: took 32.3 ms round trip, 32.2 for echo, 3.0 for decoding of 4161 pixels, 1136 bytes sent over the network in 28.3 ms, 28.2 ms for echo 2018-07-07 21:38:11,758 total_time=4225696, total_pixels=5093575 2018-07-07 21:38:11,858 total_time=4225696, total_pixels=5093575 2018-07-07 21:38:11,899 packet decoding sequence 38 for window 1: 41x19 took 1.0ms 2018-07-07 21:38:11,899 record_latency: took 28.1 ms round trip, 28.0 for echo, 0.0 for decoding of 779 pixels, 3168 bytes sent over the network in 27.1 ms, 27.1 ms for echo 2018-07-07 21:38:11,959 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:12,059 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:12,161 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:12,208 calculate_batch_delay for wid=1 current batch delay=182, last update 2 seconds ago 2018-07-07 21:38:12,209 update_batch_delay: damage-network-delay : 0.97,0.53 {'avg': 43, 'recent': 41} 2018-07-07 21:38:12,209 update_batch_delay: client-decode-speed : 0.87,0.03 {'avg': 45, 'recent': 37} 2018-07-07 21:38:12,209 update_batch_delay: damage-rate : 0.60,0.63 {'max_latency': 100, 'elapsed': 597} 2018-07-07 21:38:12,210 update_batch_delay: bandwidth-limit : 0.02,0.00 {'used': 74784, 'budget': 4700636} 2018-07-07 21:38:12,210 update_batch_delay: client-latency : 0.93,0.14 {'target': 8, 'weight_multiplier': 510, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 860, 'div': 1000, 'avg': 71, 'recent': 34} 2018-07-07 21:38:12,210 update_batch_delay: client-ping-latency : 0.78,0.10 {'target': 7, 'weight_multiplier': 213, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 608, 'div': 1000, 'avg': 4, 'recent': 5} 2018-07-07 21:38:12,210 update_batch_delay: server-ping-latency : 0.55,0.14 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 306, 'div': 1000, 'avg': 5, 'recent': 3} 2018-07-07 21:38:12,210 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:12,210 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:12,210 update_batch_delay: compression-work-queue : 0.08,0.28 {'target': 1000, 'weight_multiplier': 301, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 55, 'div': 1000, 'avg': 40, 'recent': 90} 2018-07-07 21:38:12,211 update_batch_delay: congestion : 1.01,0.10 {} 2018-07-07 21:38:12,211 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:12,211 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:38:12,211 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:38:12,211 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:12,211 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:12,211 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:12,212 update_batch_delay: delay=130 2018-07-07 21:38:12,213 get_target_quality: target=0% (window 735x457) pctpixdamaged=301%, dpc={1: 1558, 2: 2337, 3: 0, 4: 1007958, 5: 546, 6: 0, 7: 273, 8: 0, 9: 0, 10: 0} 2018-07-07 21:38:12,213 update_quality() wid=1, info={'batch-delay-ratio': 50, 'backlog_factor': (0, 0, 335895, 0, 100), 'congestion-value': 9, 'latency': 211, 'compression-ratio': (2569, 3788, -131), 'min_quality': 30, 'max-quality-range': 68, 'min_speed': 30}, quality=31 2018-07-07 21:38:12,214 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:12,215 calculate_batch_delay for wid=9 current batch delay=53, last update 1 seconds ago 2018-07-07 21:38:12,215 calculate_batch_delay for wid=9, skipping - only 4 events since the last update 2018-07-07 21:38:12,215 get_target_quality: target=4% (window 221x82) pctpixdamaged=383%, dpc={1: 20805, 2: 48727, 3: 0, 4: 0, 5: 0, 6: 0, 7: 0, 8: 0, 9: 0, 10: 0} 2018-07-07 21:38:12,216 update_quality() wid=9, info={'batch-delay-ratio': 176, 'backlog_factor': (0, 0, 18122, 0, 100), 'congestion-value': 9, 'latency': 211, 'compression-ratio': (265, 268, 0), 'min_quality': 30, 'max-quality-range': 23, 'min_speed': 30}, quality=32 2018-07-07 21:38:12,216 update_speed() wid=9, info={}, speed=100 2018-07-07 21:38:12,259 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:12,362 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:12,463 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:12,564 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:12,664 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:12,764 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:12,866 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:12,967 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:13,069 total_time=4226650, total_pixels=5094354 2018-07-07 21:38:13,095 packet decoding sequence 39 for window 1: 41x19 took 1.1ms 2018-07-07 21:38:13,096 record_latency: took 4.5 ms round trip, 4.4 for echo, 1.0 for decoding of 779 pixels, 3168 bytes sent over the network in 3.4 ms, 3.3 ms for echo 2018-07-07 21:38:13,167 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:13,269 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:13,370 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:13,470 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:13,571 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:13,672 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:13,772 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:13,872 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:13,973 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:14,073 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:14,174 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:14,274 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:14,375 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:14,477 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:14,578 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:14,679 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:14,779 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:14,879 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:14,980 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:15,081 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:15,181 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:15,282 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:15,382 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:15,483 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:15,584 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:15,687 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:15,788 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:15,888 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:15,989 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:16,089 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:16,189 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:16,291 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:16,391 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:16,492 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:16,593 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:16,693 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:16,793 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:16,894 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:16,996 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:17,097 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:17,199 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:17,299 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:17,399 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:17,500 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:17,601 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:17,702 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:17,802 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:17,903 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:18,003 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:18,104 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:18,208 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:18,308 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:18,408 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:18,509 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:18,610 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:18,711 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:18,812 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:18,913 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:19,012 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:19,114 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:19,214 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:19,315 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:19,415 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:19,518 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:19,618 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:19,718 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:19,819 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:19,920 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:20,022 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:20,122 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:20,222 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:20,322 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:20,423 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:20,526 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:20,627 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:20,728 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:20,828 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:20,928 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:21,029 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:21,129 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:21,231 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:21,330 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:21,431 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:21,533 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:21,635 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:21,734 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:21,834 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:21,934 total_time=4227788, total_pixels=5095133 2018-07-07 21:38:21,979 packet decoding sequence 40 for window 1: 13x21 took 1.5ms 2018-07-07 21:38:21,980 record_latency: took 56.5 ms round trip, 54.7 for echo, 1.0 for decoding of 273 pixels, 1144 bytes sent over the network in 55.1 ms, 53.2 ms for echo 2018-07-07 21:38:22,034 total_time=4229244, total_pixels=5095406 2018-07-07 21:38:22,135 total_time=4229244, total_pixels=5095406 2018-07-07 21:38:22,245 total_time=4229244, total_pixels=5095406 2018-07-07 21:38:22,375 total_time=4229244, total_pixels=5095406 2018-07-07 21:38:22,465 total_time=4229244, total_pixels=5095406 2018-07-07 21:38:22,566 total_time=4229244, total_pixels=5095406 2018-07-07 21:38:22,665 total_time=4229244, total_pixels=5095406 2018-07-07 21:38:22,786 total_time=4229244, total_pixels=5095406 2018-07-07 21:38:22,900 total_time=4229244, total_pixels=5095406 2018-07-07 21:38:22,990 packet decoding sequence 41 for window 1: 13x21 took 3.2ms 2018-07-07 21:38:22,990 record_latency: took 725.4 ms round trip, 725.4 for echo, 3.0 for decoding of 273 pixels, 1144 bytes sent over the network in 722.3 ms, 722.2 ms for echo 2018-07-07 21:38:23,001 total_time=4232398, total_pixels=5095679 2018-07-07 21:38:23,076 packet decoding sequence 42 for window 1: 735x457 took 89.5ms 2018-07-07 21:38:23,076 record_latency: took 315.7 ms round trip, 315.7 for echo, 89.0 for decoding of 335895 pixels, 18701 bytes sent over the network in 226.2 ms, 226.1 ms for echo 2018-07-07 21:38:23,076 may_recalculate(1, 335895) total 337220 pixels, scheduling recalculate work item 2018-07-07 21:38:23,079 calculate_batch_delay for wid=1 current batch delay=130, last update 10 seconds ago 2018-07-07 21:38:23,079 update_batch_delay: damage-network-delay : 0.98,0.52 {'avg': 41, 'recent': 40} 2018-07-07 21:38:23,080 update_batch_delay: client-decode-speed : 1.73,2.93 {'avg': 118, 'recent': 276} 2018-07-07 21:38:23,080 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 229, 'elapsed': 100} 2018-07-07 21:38:23,080 update_batch_delay: bandwidth-limit : 0.02,0.00 {'used': 158032, 'budget': 7445198} 2018-07-07 21:38:23,080 update_batch_delay: client-latency : 2.86,0.69 {'target': 8, 'weight_multiplier': 503, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 8178, 'div': 1000, 'avg': 233, 'recent': 446} 2018-07-07 21:38:23,080 update_batch_delay: client-ping-latency : 0.79,0.10 {'target': 7, 'weight_multiplier': 209, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 616, 'div': 1000, 'avg': 5, 'recent': 6} 2018-07-07 21:38:23,080 update_batch_delay: server-ping-latency : 0.57,0.14 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 329, 'div': 1000, 'avg': 4, 'recent': 3} 2018-07-07 21:38:23,081 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:23,081 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:23,081 update_batch_delay: compression-work-queue : 0.00,0.08 {'target': 1000, 'weight_multiplier': 80, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 6, 'recent': 0} 2018-07-07 21:38:23,081 update_batch_delay: congestion : 2.75,17.48 {} 2018-07-07 21:38:23,081 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:23,081 update_batch_delay: focus : 1.00,0.00 {'has_focus': False} 2018-07-07 21:38:23,081 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:38:23,082 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:23,082 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:23,082 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:23,082 update_batch_delay: delay=265 2018-07-07 21:38:23,083 get_target_quality: target=1% (window 735x457) pctpixdamaged=200%, dpc={1: 672336, 2: 546, 3: 0, 4: 0, 5: 0, 6: 0, 7: 0, 8: 0, 9: 0, 10: 0} 2018-07-07 21:38:23,083 update_quality() wid=1, info={'batch-delay-ratio': 24, 'backlog_factor': (0, 0, 335895, 0, 100), 'congestion-value': 1748, 'latency': 16, 'compression-ratio': (683, 66, 127), 'min_quality': 30, 'max-quality-range': 86, 'min_speed': 30}, quality=30 2018-07-07 21:38:23,084 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:23,099 total_time=4321928, total_pixels=5431574 2018-07-07 21:38:23,200 total_time=4321928, total_pixels=5431574 2018-07-07 21:38:23,295 total_time=4321928, total_pixels=5431574 2018-07-07 21:38:23,369 packet decoding sequence 43 for window 1: 735x457 took 14.1ms 2018-07-07 21:38:23,369 record_latency: took 76.9 ms round trip, 76.8 for echo, 14.0 for decoding of 335895 pixels, 18701 bytes sent over the network in 62.7 ms, 62.7 ms for echo 2018-07-07 21:38:23,369 may_recalculate(1, 335895) total 335895 pixels, scheduling recalculate work item 2018-07-07 21:38:23,402 total_time=4336063, total_pixels=5767469 2018-07-07 21:38:23,504 total_time=4336063, total_pixels=5767469 2018-07-07 21:38:23,613 total_time=4336063, total_pixels=5767469 2018-07-07 21:38:23,706 total_time=4336063, total_pixels=5767469 2018-07-07 21:38:23,810 total_time=4336063, total_pixels=5767469 2018-07-07 21:38:23,910 total_time=4336063, total_pixels=5767469 2018-07-07 21:38:24,013 total_time=4336063, total_pixels=5767469 2018-07-07 21:38:24,080 calculate_batch_delay for wid=1 current batch delay=265, last update 1 seconds ago 2018-07-07 21:38:24,081 update_batch_delay: damage-network-delay : 0.98,0.52 {'avg': 41, 'recent': 40} 2018-07-07 21:38:24,081 update_batch_delay: client-decode-speed : 0.96,0.01 {'avg': 65, 'recent': 62} 2018-07-07 21:38:24,081 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 207, 'elapsed': 387} 2018-07-07 21:38:24,081 update_batch_delay: bandwidth-limit : 0.01,0.00 {'used': 149296, 'budget': 14847651} 2018-07-07 21:38:24,081 update_batch_delay: client-latency : 2.17,0.54 {'target': 8, 'weight_multiplier': 503, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 4692, 'div': 1000, 'avg': 174, 'recent': 241} 2018-07-07 21:38:24,081 update_batch_delay: client-ping-latency : 0.73,0.11 {'target': 7, 'weight_multiplier': 209, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 530, 'div': 1000, 'avg': 4, 'recent': 5} 2018-07-07 21:38:24,082 update_batch_delay: server-ping-latency : 0.57,0.14 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 328, 'div': 1000, 'avg': 4, 'recent': 3} 2018-07-07 21:38:24,083 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:24,085 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:24,085 update_batch_delay: compression-work-queue : 0.00,0.08 {'target': 1000, 'weight_multiplier': 83, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 7, 'recent': 0} 2018-07-07 21:38:24,086 update_batch_delay: congestion : 1.16,1.59 {} 2018-07-07 21:38:24,086 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 335895000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:24,086 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:38:24,086 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:38:24,087 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:24,088 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:24,088 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:24,089 update_batch_delay: delay=255 2018-07-07 21:38:24,090 get_target_quality: target=6% (window 735x457) pctpixdamaged=200%, dpc={1: 546, 2: 672336, 3: 546, 4: 0, 5: 0, 6: 0, 7: 0, 8: 0, 9: 0, 10: 0} 2018-07-07 21:38:24,090 update_quality() wid=1, info={'batch-delay-ratio': 25, 'backlog_factor': (0, 0, 335895, 0, 100), 'congestion-value': 158, 'latency': 29, 'compression-ratio': (558, 81, 102), 'min_quality': 30, 'max-quality-range': 121, 'min_speed': 30}, quality=32 2018-07-07 21:38:24,090 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:24,110 total_time=4336063, total_pixels=5767469 2018-07-07 21:38:24,159 packet decoding sequence 44 for window 1: 13x21 took 1.0ms 2018-07-07 21:38:24,159 record_latency: took 22.2 ms round trip, 22.1 for echo, 1.0 for decoding of 273 pixels, 1145 bytes sent over the network in 21.2 ms, 21.1 ms for echo 2018-07-07 21:38:24,211 total_time=4337063, total_pixels=5767742 2018-07-07 21:38:24,315 total_time=4337063, total_pixels=5767742 2018-07-07 21:38:24,414 total_time=4337063, total_pixels=5767742 2018-07-07 21:38:24,470 packet decoding sequence 45 for window 1: 13x21 took 1.0ms 2018-07-07 21:38:24,470 record_latency: took 40.2 ms round trip, 40.1 for echo, 1.0 for decoding of 273 pixels, 1145 bytes sent over the network in 39.2 ms, 39.1 ms for echo 2018-07-07 21:38:24,514 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:24,618 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:24,717 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:24,822 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:24,931 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:25,029 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:25,136 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:25,239 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:25,352 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:25,456 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:25,566 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:25,675 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:25,781 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:25,886 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:25,984 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:26,095 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:26,185 total_time=4338099, total_pixels=5768015 2018-07-07 21:38:26,280 packet decoding sequence 46 for window 1: 690x457 took 317.0ms 2018-07-07 21:38:26,280 record_latency: took 991.4 ms round trip, 991.4 for echo, 317.0 for decoding of 315330 pixels, 18153 bytes sent over the network in 674.4 ms, 674.4 ms for echo 2018-07-07 21:38:26,280 may_recalculate(1, 315330) total 315876 pixels, scheduling recalculate work item 2018-07-07 21:38:26,281 calculate_batch_delay for wid=1 current batch delay=255, last update 2 seconds ago 2018-07-07 21:38:26,283 update_batch_delay: damage-network-delay : 0.98,0.52 {'avg': 41, 'recent': 40} 2018-07-07 21:38:26,283 update_batch_delay: client-decode-speed : 2.90,7.60 {'avg': 120, 'recent': 778} 2018-07-07 21:38:26,283 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 119, 'elapsed': 166} 2018-07-07 21:38:26,283 update_batch_delay: bandwidth-limit : 0.06,0.00 {'used': 274680, 'budget': 5242880} 2018-07-07 21:38:26,283 update_batch_delay: client-latency : 3.37,0.78 {'target': 8, 'weight_multiplier': 503, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 11387, 'div': 1000, 'avg': 241, 'recent': 625} 2018-07-07 21:38:26,284 update_batch_delay: client-ping-latency : 1.33,0.12 {'target': 7, 'weight_multiplier': 209, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 1772, 'div': 1000, 'avg': 10, 'recent': 27} 2018-07-07 21:38:26,284 update_batch_delay: server-ping-latency : 0.67,0.12 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 449, 'div': 1000, 'avg': 4, 'recent': 4} 2018-07-07 21:38:26,284 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:26,285 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:26,285 update_batch_delay: compression-work-queue : 0.00,0.07 {'target': 1000, 'weight_multiplier': 72, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 5, 'recent': 0} 2018-07-07 21:38:26,286 packet decoding sequence 47 for window 1: 519x457 took 312.4ms 2018-07-07 21:38:26,286 update_batch_delay: congestion : 1.89,8.93 {} 2018-07-07 21:38:26,286 record_latency: took 381.6 ms round trip, 381.6 for echo, 312.0 for decoding of 237183 pixels, 16262 bytes sent over the network in 69.2 ms, 69.2 ms for echo 2018-07-07 21:38:26,286 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:26,287 may_recalculate(1, 237183) total 237183 pixels, scheduling recalculate work item 2018-07-07 21:38:26,287 update_batch_delay: focus : 1.00,0.00 {'has_focus': False} 2018-07-07 21:38:26,291 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:38:26,293 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:26,295 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:26,295 update_batch_delay: soft-expired : 2.00,1.00 {'count': 2} 2018-07-07 21:38:26,295 update_batch_delay: delay=405 2018-07-07 21:38:26,296 get_target_quality: target=0% (window 465x457) pctpixdamaged=1019%, dpc={1: 919941, 2: 573078, 3: 546, 4: 672063, 5: 819, 6: 0, 7: 0, 8: 0, 9: 0, 10: 0} 2018-07-07 21:38:26,297 update_quality() wid=1, info={'batch-delay-ratio': 15, 'backlog_factor': (0, 0, 212505, 0, 100), 'congestion-value': 893, 'latency': 11, 'compression-ratio': (428, 76, 83), 'min_quality': 30, 'max-quality-range': 72, 'min_speed': 30}, quality=30 2018-07-07 21:38:26,297 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:26,307 total_time=4967498, total_pixels=6320528 2018-07-07 21:38:26,426 total_time=4967498, total_pixels=6320528 2018-07-07 21:38:26,520 total_time=4967498, total_pixels=6320528 2018-07-07 21:38:26,590 packet decoding sequence 48 for window 1: 465x457 took 84.9ms 2018-07-07 21:38:26,590 record_latency: took 195.8 ms round trip, 195.8 for echo, 84.0 for decoding of 212505 pixels, 15638 bytes sent over the network in 110.9 ms, 110.9 ms for echo 2018-07-07 21:38:26,628 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:26,729 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:26,829 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:26,932 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:27,039 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:27,171 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:27,285 calculate_batch_delay for wid=1 current batch delay=405, last update 1 seconds ago 2018-07-07 21:38:27,286 update_batch_delay: damage-network-delay : 0.99,0.51 {'avg': 41, 'recent': 40} 2018-07-07 21:38:27,286 update_batch_delay: client-decode-speed : 2.15,4.59 {'avg': 131, 'recent': 449} 2018-07-07 21:38:27,287 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 110, 'elapsed': 6} 2018-07-07 21:38:27,287 update_batch_delay: bandwidth-limit : 0.01,0.00 {'used': 133520, 'budget': 10898184} 2018-07-07 21:38:27,287 update_batch_delay: client-latency : 2.11,0.53 {'target': 8, 'weight_multiplier': 503, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 4459, 'div': 1000, 'avg': 175, 'recent': 229} 2018-07-07 21:38:27,287 update_batch_delay: client-ping-latency : 0.68,0.12 {'target': 7, 'weight_multiplier': 209, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 457, 'div': 1000, 'avg': 8, 'recent': 5} 2018-07-07 21:38:27,287 update_batch_delay: server-ping-latency : 0.75,0.11 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 559, 'div': 1000, 'avg': 5, 'recent': 5} 2018-07-07 21:38:27,288 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:27,288 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:27,288 update_batch_delay: compression-work-queue : 0.00,0.07 {'target': 1000, 'weight_multiplier': 67, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 4, 'recent': 0} 2018-07-07 21:38:27,288 update_batch_delay: congestion : 1.96,9.64 {} 2018-07-07 21:38:27,289 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:27,289 update_batch_delay: focus : 1.00,0.00 {'has_focus': False} 2018-07-07 21:38:27,289 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:38:27,289 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:27,289 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:27,289 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:27,290 update_batch_delay: delay=449 2018-07-07 21:38:27,290 get_client_backlog missing acks: [] 2018-07-07 21:38:27,291 get_target_quality: target=1% (window 465x457) pctpixdamaged=1119%, dpc={1: 213051, 2: 919941, 3: 573078, 4: 546, 5: 672063, 6: 819, 7: 0, 8: 0, 9: 0, 10: 0} 2018-07-07 21:38:27,291 update_quality() wid=1, info={'batch-delay-ratio': 14, 'backlog_factor': (1, 273, 212505, 0, 100), 'congestion-value': 964, 'latency': 31, 'compression-ratio': (451, 97, 0), 'min_quality': 30, 'max-quality-range': 104, 'min_speed': 30}, quality=30 2018-07-07 21:38:27,292 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:27,298 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:27,393 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:27,494 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:27,610 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:27,707 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:27,809 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:27,911 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:28,011 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:28,112 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:28,207 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:28,315 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:28,417 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:28,518 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:28,654 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:28,732 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:28,834 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:28,933 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:29,053 total_time=5052401, total_pixels=6533033 2018-07-07 21:38:29,099 packet decoding sequence 49 for window 1: 13x21 took 285.1ms 2018-07-07 21:38:29,099 record_latency: took 2098.1 ms round trip, 2098.1 for echo, 285.0 for decoding of 273 pixels, 1145 bytes sent over the network in 1813.0 ms, 1813.0 ms for echo 2018-07-07 21:38:29,137 packet decoding sequence 50 for window 1: 465x457 took 323.1ms 2018-07-07 21:38:29,138 record_latency: took 957.6 ms round trip, 957.6 for echo, 323.0 for decoding of 212505 pixels, 15638 bytes sent over the network in 634.5 ms, 634.5 ms for echo 2018-07-07 21:38:29,138 may_recalculate(1, 212505) total 212778 pixels, scheduling recalculate work item 2018-07-07 21:38:29,139 calculate_batch_delay for wid=1 current batch delay=449, last update 1 seconds ago 2018-07-07 21:38:29,140 update_batch_delay: damage-network-delay : 0.99,0.51 {'avg': 41, 'recent': 40} 2018-07-07 21:38:29,142 update_batch_delay: client-decode-speed : 3.19,8.76 {'avg': 143, 'recent': 1167} 2018-07-07 21:38:29,142 update_batch_delay: damage-rate : 0.72,0.52 {'max_latency': 111, 'elapsed': 498} 2018-07-07 21:38:29,142 update_batch_delay: bandwidth-limit : 0.05,0.00 {'used': 124784, 'budget': 3037124} 2018-07-07 21:38:29,142 update_batch_delay: client-latency : 4.42,0.93 {'target': 8, 'weight_multiplier': 503, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 19562, 'div': 1000, 'avg': 522, 'recent': 1186} 2018-07-07 21:38:29,143 update_batch_delay: client-ping-latency : 0.93,0.05 {'target': 7, 'weight_multiplier': 209, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 868, 'div': 1000, 'avg': 7, 'recent': 11} 2018-07-07 21:38:29,143 update_batch_delay: server-ping-latency : 0.57,0.14 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 329, 'div': 1000, 'avg': 4, 'recent': 3} 2018-07-07 21:38:29,144 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:29,144 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:29,144 update_batch_delay: compression-work-queue : 0.00,0.07 {'target': 1000, 'weight_multiplier': 69, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 4, 'recent': 0} 2018-07-07 21:38:29,145 update_batch_delay: congestion : 2.80,17.96 {} 2018-07-07 21:38:29,145 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:29,145 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:38:29,145 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:38:29,145 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:29,145 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:29,146 update_batch_delay: soft-expired : 2.00,1.00 {'count': 2} 2018-07-07 21:38:29,146 update_batch_delay: delay=447 2018-07-07 21:38:29,146 get_target_quality: target=0% (window 465x457) pctpixdamaged=903%, dpc={1: 1508, 2: 425283, 3: 273, 4: 1177689, 5: 315330, 6: 546, 7: 672336, 8: 546, 9: 0, 10: 0} 2018-07-07 21:38:29,147 update_quality() wid=1, info={'batch-delay-ratio': 14, 'backlog_factor': (0, 0, 212505, 0, 100), 'congestion-value': 1795, 'latency': 6, 'compression-ratio': (478, 111, 76), 'min_quality': 30, 'max-quality-range': 55, 'min_speed': 30}, quality=30 2018-07-07 21:38:29,147 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:29,148 packet decoding sequence 1 for window 10: 314x165 took 8.4ms 2018-07-07 21:38:29,148 record_latency: took 23.3 ms round trip, 23.2 for echo, 8.0 for decoding of 51810 pixels, 4537 bytes sent over the network in 14.9 ms, 14.8 ms for echo 2018-07-07 21:38:29,148 may_recalculate(10, 51810) total 51810 pixels, scheduling recalculate work item 2018-07-07 21:38:29,164 total_time=5668990, total_pixels=6797621 2018-07-07 21:38:29,223 packet decoding sequence 51 for window 1: 65x19 took 1.6ms 2018-07-07 21:38:29,224 record_latency: took 5.8 ms round trip, 5.6 for echo, 1.0 for decoding of 1235 pixels, 5017 bytes sent over the network in 4.2 ms, 4.0 ms for echo 2018-07-07 21:38:29,225 packet decoding sequence 52 for window 1: 13x21 took 1.0ms 2018-07-07 21:38:29,225 record_latency: took 5.8 ms round trip, 5.8 for echo, 0.0 for decoding of 273 pixels, 1145 bytes sent over the network in 4.9 ms, 4.8 ms for echo 2018-07-07 21:38:29,265 total_time=5671590, total_pixels=6799129 2018-07-07 21:38:29,367 total_time=5671590, total_pixels=6799129 2018-07-07 21:38:29,466 total_time=5671590, total_pixels=6799129 2018-07-07 21:38:29,566 total_time=5671590, total_pixels=6799129 2018-07-07 21:38:29,667 total_time=5671590, total_pixels=6799129 2018-07-07 21:38:29,768 total_time=5671590, total_pixels=6799129 2018-07-07 21:38:29,869 total_time=5671590, total_pixels=6799129 2018-07-07 21:38:29,968 total_time=5671590, total_pixels=6799129 2018-07-07 21:38:30,073 total_time=5671590, total_pixels=6799129 2018-07-07 21:38:30,139 calculate_batch_delay for wid=10 current batch delay=480, last update 80185 seconds ago 2018-07-07 21:38:30,139 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 41, 'recent': 41} 2018-07-07 21:38:30,139 update_batch_delay: client-decode-speed : 1.00,0.00 {'avg': 169, 'recent': 169} 2018-07-07 21:38:30,140 update_batch_delay: damage-rate : 1.00,0.00 {'max_latency': 100, 'elapsed': 187} 2018-07-07 21:38:30,140 update_batch_delay: bandwidth-limit : 0.24,0.00 {'used': 294424, 'budget': 1322321} 2018-07-07 21:38:30,140 update_batch_delay: client-latency : 2.73,0.66 {'target': 8, 'weight_multiplier': 503, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 7478, 'div': 1000, 'avg': 294, 'recent': 424} 2018-07-07 21:38:30,140 update_batch_delay: client-ping-latency : 0.80,0.09 {'target': 7, 'weight_multiplier': 209, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 646, 'div': 1000, 'avg': 7, 'recent': 8} 2018-07-07 21:38:30,140 update_batch_delay: server-ping-latency : 0.64,0.13 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 409, 'div': 1000, 'avg': 4, 'recent': 3} 2018-07-07 21:38:30,140 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:30,140 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 51810000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:30,141 update_batch_delay: compression-work-queue : 0.00,0.06 {'target': 1000, 'weight_multiplier': 61, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 3, 'recent': 0} 2018-07-07 21:38:30,141 update_batch_delay: congestion : 1.18,1.82 {} 2018-07-07 21:38:30,141 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 51810000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:30,141 update_batch_delay: focus : 1.00,0.00 {'has_focus': False} 2018-07-07 21:38:30,141 update_batch_delay: override-redirect : 0.00,1.00 {'is_OR': True} 2018-07-07 21:38:30,141 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:30,141 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:30,142 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:30,142 update_batch_delay: delay=429 2018-07-07 21:38:30,176 total_time=5671590, total_pixels=6799129 2018-07-07 21:38:30,277 total_time=5671590, total_pixels=6799129 2018-07-07 21:38:30,365 packet decoding sequence 2 for window 10: 312x27 took 3.1ms 2018-07-07 21:38:30,366 record_latency: took 303.5 ms round trip, 303.5 for echo, 3.0 for decoding of 8424 pixels, 1290 bytes sent over the network in 300.4 ms, 300.4 ms for echo 2018-07-07 21:38:30,366 may_recalculate(10, 8424) total 8424 pixels, scheduling recalculate work item 2018-07-07 21:38:30,378 total_time=5674685, total_pixels=6807553 2018-07-07 21:38:30,463 packet decoding sequence 3 for window 10: 312x19 took 100.9ms 2018-07-07 21:38:30,464 record_latency: took 397.3 ms round trip, 397.3 for echo, 100.0 for decoding of 5928 pixels, 17845 bytes sent over the network in 296.4 ms, 296.4 ms for echo 2018-07-07 21:38:30,465 packet decoding sequence 4 for window 10: 312x19 took 102.5ms 2018-07-07 21:38:30,466 record_latency: took 398.1 ms round trip, 398.0 for echo, 102.0 for decoding of 5928 pixels, 17837 bytes sent over the network in 295.6 ms, 295.6 ms for echo 2018-07-07 21:38:30,469 packet decoding sequence 53 for window 1: 65x19 took 105.6ms 2018-07-07 21:38:30,469 record_latency: took 135.0 ms round trip, 134.9 for echo, 105.0 for decoding of 1235 pixels, 5010 bytes sent over the network in 29.4 ms, 29.3 ms for echo 2018-07-07 21:38:30,470 may_recalculate(1, 1235) total 2743 pixels, scheduling recalculate work item 2018-07-07 21:38:30,481 total_time=5983643, total_pixels=6820644 2018-07-07 21:38:30,581 total_time=5983643, total_pixels=6820644 2018-07-07 21:38:30,682 total_time=5983643, total_pixels=6820644 2018-07-07 21:38:30,783 total_time=5983643, total_pixels=6820644 2018-07-07 21:38:30,842 packet decoding sequence 54 for window 1: 65x19 took 1.1ms 2018-07-07 21:38:30,842 record_latency: took 46.4 ms round trip, 46.3 for echo, 1.0 for decoding of 1235 pixels, 5010 bytes sent over the network in 45.3 ms, 45.2 ms for echo 2018-07-07 21:38:30,884 total_time=5984759, total_pixels=6821879 2018-07-07 21:38:30,988 total_time=5984759, total_pixels=6821879 2018-07-07 21:38:31,042 packet decoding sequence 5 for window 10: 312x38 took 2.2ms 2018-07-07 21:38:31,043 record_latency: took 27.4 ms round trip, 27.3 for echo, 2.0 for decoding of 11856 pixels, 1736 bytes sent over the network in 25.2 ms, 25.1 ms for echo 2018-07-07 21:38:31,087 total_time=5986928, total_pixels=6833735 2018-07-07 21:38:31,139 calculate_batch_delay for wid=1 current batch delay=447, last update 2 seconds ago 2018-07-07 21:38:31,140 update_batch_delay: damage-network-delay : 0.99,0.51 {'avg': 41, 'recent': 40} 2018-07-07 21:38:31,140 update_batch_delay: client-decode-speed : 1.87,3.47 {'avg': 110, 'recent': 292} 2018-07-07 21:38:31,140 update_batch_delay: damage-rate : 0.33,0.82 {'max_latency': 100, 'elapsed': 868} 2018-07-07 21:38:31,140 update_batch_delay: bandwidth-limit : 0.02,0.00 {'used': 79040, 'budget': 4039614} 2018-07-07 21:38:31,140 update_batch_delay: client-latency : 1.47,0.35 {'target': 8, 'weight_multiplier': 503, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 2171, 'div': 1000, 'avg': 213, 'recent': 116} 2018-07-07 21:38:31,141 update_batch_delay: client-ping-latency : 0.59,0.13 {'target': 7, 'weight_multiplier': 206, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 349, 'div': 1000, 'avg': 6, 'recent': 4} 2018-07-07 21:38:31,141 update_batch_delay: server-ping-latency : 0.74,0.11 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 551, 'div': 1000, 'avg': 4, 'recent': 5} 2018-07-07 21:38:31,141 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:31,141 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:31,141 update_batch_delay: compression-work-queue : 0.00,0.06 {'target': 1000, 'weight_multiplier': 57, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 3, 'recent': 0} 2018-07-07 21:38:31,141 update_batch_delay: congestion : 3.68,26.78 {} 2018-07-07 21:38:31,141 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:31,142 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:38:31,142 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:38:31,142 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:31,142 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:31,142 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:31,142 update_batch_delay: delay=460 2018-07-07 21:38:31,145 get_target_quality: target=34% (window 465x457) pctpixdamaged=202%, dpc={1: 1235, 2: 1235, 3: 1508, 4: 425283, 5: 273, 6: 1177689, 7: 315330, 8: 546, 9: 672336, 10: 546} 2018-07-07 21:38:31,146 update_quality() wid=1, info={'batch-delay-ratio': 14, 'backlog_factor': (0, 0, 212505, 0, 100), 'congestion-value': 2678, 'latency': 61, 'compression-ratio': (571, 215, 57), 'min_quality': 30, 'max-quality-range': 63, 'min_speed': 30}, quality=31 2018-07-07 21:38:31,146 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:31,147 calculate_batch_delay for wid=10 current batch delay=429, last update 1 seconds ago 2018-07-07 21:38:31,147 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 40, 'recent': 40} 2018-07-07 21:38:31,147 update_batch_delay: client-decode-speed : 1.06,0.06 {'avg': 190, 'recent': 207} 2018-07-07 21:38:31,147 update_batch_delay: damage-rate : 0.21,0.89 {'max_latency': 100, 'elapsed': 993} 2018-07-07 21:38:31,148 update_batch_delay: bandwidth-limit : 0.01,0.00 {'used': 13504, 'budget': 1203265} 2018-07-07 21:38:31,148 update_batch_delay: client-latency : 1.47,0.35 {'target': 8, 'weight_multiplier': 503, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 2171, 'div': 1000, 'avg': 213, 'recent': 116} 2018-07-07 21:38:31,148 update_batch_delay: client-ping-latency : 0.59,0.13 {'target': 7, 'weight_multiplier': 206, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 349, 'div': 1000, 'avg': 6, 'recent': 4} 2018-07-07 21:38:31,148 update_batch_delay: server-ping-latency : 0.74,0.11 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 551, 'div': 1000, 'avg': 4, 'recent': 5} 2018-07-07 21:38:31,148 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:31,148 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 51810000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:31,148 update_batch_delay: compression-work-queue : 0.00,0.06 {'target': 1000, 'weight_multiplier': 57, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 3, 'recent': 0} 2018-07-07 21:38:31,149 update_batch_delay: congestion : 3.68,26.78 {} 2018-07-07 21:38:31,149 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 51810000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:31,149 update_batch_delay: focus : 1.00,0.00 {'has_focus': False} 2018-07-07 21:38:31,149 update_batch_delay: override-redirect : 0.00,1.00 {'is_OR': True} 2018-07-07 21:38:31,149 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:31,149 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:31,149 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:31,150 update_batch_delay: delay=479 2018-07-07 21:38:31,150 get_target_quality: target=6% (window 314x165) pctpixdamaged=262%, dpc={1: 11856, 2: 20280, 3: 103620, 4: 0, 5: 0, 6: 0, 7: 0, 8: 0, 9: 0, 10: 0} 2018-07-07 21:38:31,150 update_quality() wid=10, info={'batch-delay-ratio': 28, 'backlog_factor': (0, 0, 51810, 0, 100), 'congestion-value': 2678, 'latency': 61, 'compression-ratio': (211, 206, 1), 'min_quality': 30, 'max-quality-range': 34, 'min_speed': 30}, quality=30 2018-07-07 21:38:31,150 update_speed() wid=10, info={}, speed=100 2018-07-07 21:38:31,188 total_time=5986928, total_pixels=6833735 2018-07-07 21:38:31,289 total_time=5986928, total_pixels=6833735 2018-07-07 21:38:31,389 total_time=5986928, total_pixels=6833735 2018-07-07 21:38:31,490 total_time=5986928, total_pixels=6833735 2018-07-07 21:38:31,592 total_time=5986928, total_pixels=6833735 2018-07-07 21:38:31,693 total_time=5986928, total_pixels=6833735 2018-07-07 21:38:31,794 total_time=5986928, total_pixels=6833735 2018-07-07 21:38:31,889 total_time=5986928, total_pixels=6833735 2018-07-07 21:38:31,959 packet decoding sequence 55 for window 1: 65x19 took 1.2ms 2018-07-07 21:38:31,960 record_latency: took 4.7 ms round trip, 4.6 for echo, 1.0 for decoding of 1235 pixels, 5010 bytes sent over the network in 3.5 ms, 3.4 ms for echo 2018-07-07 21:38:31,994 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:32,096 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:32,195 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:32,298 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:32,397 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:32,498 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:32,599 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:32,702 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:32,802 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:32,904 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:33,005 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:33,107 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:33,206 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:33,307 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:33,407 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:33,509 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:33,609 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:33,711 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:33,812 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:33,912 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:34,012 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:34,113 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:34,213 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:34,314 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:34,414 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:34,515 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:34,617 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:34,717 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:34,835 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:34,922 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:35,021 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:35,145 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:35,246 total_time=5988133, total_pixels=6834970 2018-07-07 21:38:35,339 packet decoding sequence 1 for window 11: 314x165 took 7.1ms 2018-07-07 21:38:35,339 record_latency: took 10.2 ms round trip, 10.1 for echo, 7.0 for decoding of 51810 pixels, 4537 bytes sent over the network in 3.1 ms, 3.1 ms for echo 2018-07-07 21:38:35,339 may_recalculate(11, 51810) total 51810 pixels, scheduling recalculate work item 2018-07-07 21:38:35,340 calculate_batch_delay for wid=11 current batch delay=798, last update 80191 seconds ago 2018-07-07 21:38:35,341 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 41, 'recent': 41} 2018-07-07 21:38:35,341 update_batch_delay: client-decode-speed : 1.00,0.00 {'avg': 143, 'recent': 143} 2018-07-07 21:38:35,341 update_batch_delay: damage-rate : 0.68,0.56 {'max_latency': 100, 'elapsed': 516} 2018-07-07 21:38:35,341 update_batch_delay: bandwidth-limit : 0.01,0.00 {'used': 35904, 'budget': 2938306} 2018-07-07 21:38:35,341 update_batch_delay: client-latency : 0.55,0.33 {'target': 8, 'weight_multiplier': 491, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 301, 'div': 1000, 'avg': 160, 'recent': 15} 2018-07-07 21:38:35,342 update_batch_delay: client-ping-latency : 0.88,0.07 {'target': 7, 'weight_multiplier': 206, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 781, 'div': 1000, 'avg': 6, 'recent': 8} 2018-07-07 21:38:35,342 update_batch_delay: server-ping-latency : 0.70,0.12 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 490, 'div': 1000, 'avg': 4, 'recent': 4} 2018-07-07 21:38:35,342 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:35,342 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 51810000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:35,342 update_batch_delay: compression-work-queue : 0.00,0.06 {'target': 1000, 'weight_multiplier': 61, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 3, 'recent': 0} 2018-07-07 21:38:35,342 update_batch_delay: congestion : 1.02,0.23 {} 2018-07-07 21:38:35,343 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 51810000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:35,346 update_batch_delay: focus : 1.00,0.00 {'has_focus': False} 2018-07-07 21:38:35,347 update_batch_delay: override-redirect : 0.00,1.00 {'is_OR': True} 2018-07-07 21:38:35,348 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:35,348 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:35,349 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:35,349 update_batch_delay: delay=402 2018-07-07 21:38:35,357 total_time=5995213, total_pixels=6886780 2018-07-07 21:38:35,403 packet decoding sequence 56 for window 1: 65x19 took 1.0ms 2018-07-07 21:38:35,403 record_latency: took 39.7 ms round trip, 39.5 for echo, 1.0 for decoding of 1235 pixels, 5010 bytes sent over the network in 38.7 ms, 38.5 ms for echo 2018-07-07 21:38:35,404 may_recalculate(1, 1235) total 2470 pixels, scheduling recalculate work item 2018-07-07 21:38:35,454 total_time=5996215, total_pixels=6888015 2018-07-07 21:38:35,555 total_time=5996215, total_pixels=6888015 2018-07-07 21:38:35,678 total_time=5996215, total_pixels=6888015 2018-07-07 21:38:35,759 total_time=5996215, total_pixels=6888015 2018-07-07 21:38:35,870 total_time=5996215, total_pixels=6888015 2018-07-07 21:38:35,971 total_time=5996215, total_pixels=6888015 2018-07-07 21:38:36,072 total_time=5996215, total_pixels=6888015 2018-07-07 21:38:36,180 total_time=5996215, total_pixels=6888015 2018-07-07 21:38:36,301 total_time=5996215, total_pixels=6888015 2018-07-07 21:38:36,341 calculate_batch_delay for wid=1 current batch delay=460, last update 5 seconds ago 2018-07-07 21:38:36,341 update_batch_delay: damage-network-delay : 0.99,0.51 {'avg': 41, 'recent': 40} 2018-07-07 21:38:36,342 update_batch_delay: client-decode-speed : 1.34,0.34 {'avg': 92, 'recent': 141} 2018-07-07 21:38:36,342 update_batch_delay: damage-rate : 0.52,0.69 {'max_latency': 100, 'elapsed': 675} 2018-07-07 21:38:36,342 update_batch_delay: bandwidth-limit : 0.02,0.00 {'used': 103360, 'budget': 5611640} 2018-07-07 21:38:36,342 update_batch_delay: client-latency : 1.08,0.14 {'target': 8, 'weight_multiplier': 491, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 1167, 'div': 1000, 'avg': 159, 'recent': 58} 2018-07-07 21:38:36,342 update_batch_delay: client-ping-latency : 0.96,0.04 {'target': 7, 'weight_multiplier': 206, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 915, 'div': 1000, 'avg': 7, 'recent': 11} 2018-07-07 21:38:36,343 update_batch_delay: server-ping-latency : 0.60,0.13 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 365, 'div': 1000, 'avg': 4, 'recent': 3} 2018-07-07 21:38:36,343 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:36,343 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:36,344 update_batch_delay: compression-work-queue : 0.00,0.06 {'target': 1000, 'weight_multiplier': 55, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 3, 'recent': 0} 2018-07-07 21:38:36,344 update_batch_delay: congestion : 1.01,0.14 {} 2018-07-07 21:38:36,344 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:36,344 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:38:36,344 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:38:36,344 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:36,345 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:36,345 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:36,345 update_batch_delay: delay=349 2018-07-07 21:38:36,345 get_client_backlog missing acks: [] 2018-07-07 21:38:36,346 get_target_quality: target=2% (window 465x457) pctpixdamaged=2%, dpc={1: 1995, 2: 1235, 3: 0, 4: 0, 5: 1235, 6: 0, 7: 2470, 8: 1508, 9: 212505, 10: 213051} 2018-07-07 21:38:36,346 update_quality() wid=1, info={'batch-delay-ratio': 18, 'backlog_factor': (1, 1995, 212505, 0, 100), 'congestion-value': 14, 'latency': 124, 'compression-ratio': (680, 424, 0), 'min_quality': 30, 'max-quality-range': 74, 'min_speed': 30}, quality=87 2018-07-07 21:38:36,346 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:36,402 total_time=5996215, total_pixels=6888015 2018-07-07 21:38:36,489 packet decoding sequence 1 for window 12: 295x121 took 7.0ms 2018-07-07 21:38:36,489 record_latency: took 316.6 ms round trip, 316.4 for echo, 6.0 for decoding of 35695 pixels, 2953 bytes sent over the network in 309.6 ms, 309.4 ms for echo 2018-07-07 21:38:36,490 may_recalculate(12, 35695) total 35695 pixels, scheduling recalculate work item 2018-07-07 21:38:36,506 total_time=6003173, total_pixels=6923710 2018-07-07 21:38:36,552 packet decoding sequence 57 for window 1: 105x19 took 68.7ms 2018-07-07 21:38:36,552 record_latency: took 348.2 ms round trip, 348.0 for echo, 68.0 for decoding of 1995 pixels, 8050 bytes sent over the network in 279.4 ms, 279.3 ms for echo 2018-07-07 21:38:36,603 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:36,705 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:36,805 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:36,909 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:37,008 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:37,109 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:37,210 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:37,316 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:37,341 calculate_batch_delay for wid=12 current batch delay=651, last update 80193 seconds ago 2018-07-07 21:38:37,341 update_batch_delay: damage-network-delay : 1.00,0.50 {'avg': 40, 'recent': 40} 2018-07-07 21:38:37,341 update_batch_delay: client-decode-speed : 1.00,0.00 {'avg': 204, 'recent': 204} 2018-07-07 21:38:37,342 update_batch_delay: damage-rate : 0.00,1.21 {'max_latency': 100, 'elapsed': 1674} 2018-07-07 21:38:37,342 update_batch_delay: bandwidth-limit : 0.00,0.00 {'used': 0, 'budget': 754007} 2018-07-07 21:38:37,342 update_batch_delay: client-latency : 2.18,0.53 {'target': 8, 'weight_multiplier': 491, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 4752, 'div': 1000, 'avg': 191, 'recent': 246} 2018-07-07 21:38:37,342 update_batch_delay: client-ping-latency : 0.76,0.10 {'target': 7, 'weight_multiplier': 206, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 571, 'div': 1000, 'avg': 6, 'recent': 6} 2018-07-07 21:38:37,342 update_batch_delay: server-ping-latency : 0.84,0.09 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 708, 'div': 1000, 'avg': 5, 'recent': 7} 2018-07-07 21:38:37,342 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:37,343 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 35695000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:37,344 update_batch_delay: compression-work-queue : 0.00,0.06 {'target': 1000, 'weight_multiplier': 60, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 3, 'recent': 0} 2018-07-07 21:38:37,344 update_batch_delay: congestion : 1.88,8.84 {} 2018-07-07 21:38:37,345 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 35695000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:37,345 update_batch_delay: focus : 1.00,0.00 {'has_focus': False} 2018-07-07 21:38:37,345 update_batch_delay: override-redirect : 0.00,1.00 {'is_OR': True} 2018-07-07 21:38:37,345 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:37,345 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:37,345 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:37,345 update_batch_delay: delay=434 2018-07-07 21:38:37,410 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:37,512 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:37,612 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:37,713 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:37,813 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:37,913 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:38,014 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:38,116 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:38,215 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:38,316 total_time=6071899, total_pixels=6925705 2018-07-07 21:38:38,368 packet decoding sequence 58 for window 1: 40x19 took 1.3ms 2018-07-07 21:38:38,368 record_latency: took 56.0 ms round trip, 55.9 for echo, 1.0 for decoding of 760 pixels, 3094 bytes sent over the network in 54.7 ms, 54.6 ms for echo 2018-07-07 21:38:38,369 may_recalculate(1, 760) total 2755 pixels, scheduling recalculate work item 2018-07-07 21:38:38,370 calculate_batch_delay for wid=1 current batch delay=349, last update 2 seconds ago 2018-07-07 21:38:38,370 update_batch_delay: damage-network-delay : 0.99,0.51 {'avg': 41, 'recent': 40} 2018-07-07 21:38:38,370 update_batch_delay: client-decode-speed : 1.28,0.14 {'avg': 89, 'recent': 127} 2018-07-07 21:38:38,371 update_batch_delay: damage-rate : 0.78,0.47 {'max_latency': 191, 'elapsed': 606} 2018-07-07 21:38:38,371 update_batch_delay: bandwidth-limit : 0.01,0.00 {'used': 24320, 'budget': 5242880} 2018-07-07 21:38:38,371 update_batch_delay: client-latency : 1.19,0.21 {'target': 8, 'weight_multiplier': 491, 'smoothing': 'sqrt', 'aim': 800, 'aimed_avg': 1404, 'div': 1000, 'avg': 164, 'recent': 70} 2018-07-07 21:38:38,371 update_batch_delay: client-ping-latency : 0.62,0.13 {'target': 7, 'weight_multiplier': 206, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 378, 'div': 1000, 'avg': 5, 'recent': 4} 2018-07-07 21:38:38,371 update_batch_delay: server-ping-latency : 0.66,0.13 {'target': 8, 'weight_multiplier': 214, 'smoothing': 'sqrt', 'aim': 949, 'aimed_avg': 433, 'div': 1000, 'avg': 4, 'recent': 4} 2018-07-07 21:38:38,371 update_batch_delay: packet-queue-size : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:38,372 update_batch_delay: packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:38,372 update_batch_delay: compression-work-queue : 0.00,0.05 {'target': 1000, 'weight_multiplier': 50, 'smoothing': 'logp', 'aim': 250, 'aimed_avg': 0, 'div': 1000, 'avg': 2, 'recent': 0} 2018-07-07 21:38:38,372 update_batch_delay: congestion : 1.09,0.87 {} 2018-07-07 21:38:38,372 update_batch_delay: damage-packet-queue-pixels : 0.00,0.00 {'target': 1000, 'weight_multiplier': 0, 'smoothing': 'sqrt', 'aim': 250, 'aimed_avg': 0, 'div': 212505000, 'avg': 0, 'recent': 0} 2018-07-07 21:38:38,372 update_batch_delay: focus : 0.00,1.00 {'has_focus': True} 2018-07-07 21:38:38,372 update_batch_delay: override-redirect : 1.00,0.00 {'is_OR': False} 2018-07-07 21:38:38,372 update_batch_delay: fullscreen : 0.00,0.00 {'other_is_fullscreen': False} 2018-07-07 21:38:38,372 update_batch_delay: maximized : 0.00,0.00 {'other_is_maximized': False} 2018-07-07 21:38:38,373 update_batch_delay: soft-expired : 0.00,0.00 {'count': 0} 2018-07-07 21:38:38,373 update_batch_delay: delay=306 2018-07-07 21:38:38,373 get_target_quality: target=16% (window 465x457) pctpixdamaged=1%, dpc={1: 760, 2: 0, 3: 1995, 4: 1235, 5: 0, 6: 0, 7: 1235, 8: 0, 9: 2470, 10: 1508} 2018-07-07 21:38:38,374 update_quality() wid=1, info={'batch-delay-ratio': 21, 'backlog_factor': (0, 0, 212505, 0, 100), 'congestion-value': 86, 'latency': 102, 'compression-ratio': (701, 484, 22), 'min_quality': 30, 'max-quality-range': 72, 'min_speed': 30}, quality=66 2018-07-07 21:38:38,374 update_speed() wid=1, info={}, speed=100 2018-07-07 21:38:38,416 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:38,516 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:38,618 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:38,718 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:38,819 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:38,920 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:39,021 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:39,121 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:39,222 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:39,322 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:39,423 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:39,525 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:39,626 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:39,727 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:39,828 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:39,942 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:40,038 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:40,156 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:40,253 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:40,353 total_time=6073202, total_pixels=6926465 2018-07-07 21:38:40,456 total_time=6037390, total_pixels=6254675 2018-07-07 21:38:40,537 packet decoding sequence 59 for window 1: 13x21 took 1.2ms 2018-07-07 21:38:40,537 record_latency: took 5.0 ms round trip, 5.0 for echo, 1.0 for decoding of 273 pixels, 1145 bytes sent over the network in 3.8 ms, 3.8 ms for echo 2018-07-07 21:38:40,558 total_time=6038617, total_pixels=6254948 2018-07-07 21:38:40,657 total_time=6025004, total_pixels=5919053 2018-07-07 21:38:40,757 total_time=6025004, total_pixels=5919053 2018-07-07 21:38:40,858 total_time=6025004, total_pixels=5919053 2018-07-07 21:38:40,958 total_time=6025004, total_pixels=5919053 2018-07-07 21:38:41,059 total_time=6025004, total_pixels=5919053 2018-07-07 21:38:41,160 total_time=6025004, total_pixels=5919053 2018-07-07 21:38:41,261 total_time=6025004, total_pixels=5919053 2018-07-07 21:38:41,361 total_time=6025004, total_pixels=5919053 2018-07-07 21:38:41,462 total_time=6025004, total_pixels=5919053 2018-07-07 21:38:41,563 total_time=6025004, total_pixels=5919053 2018-07-07 21:38:41,666 total_time=6025004, total_pixels=5919053 2018-07-07 21:38:41,767 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:41,868 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:41,969 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:42,070 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:42,171 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:42,270 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:42,371 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:42,472 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:42,572 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:42,673 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:42,773 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:42,874 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:42,974 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:43,074 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:43,175 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:43,277 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:43,378 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:43,477 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:43,578 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:43,679 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:43,779 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:43,880 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:43,981 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:44,081 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:44,184 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:44,284 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:44,385 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:44,487 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:44,588 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:44,689 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:44,788 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:44,890 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:44,991 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:45,091 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:45,192 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:45,293 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:45,393 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:45,493 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:45,594 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:45,694 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:45,795 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:45,898 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:45,998 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:46,098 total_time=6021565, total_pixels=5913411 2018-07-07 21:38:46,198 total_time=5986554, total_pixels=5909250 2018-07-07 21:38:46,299 total_time=5986554, total_pixels=5909250 2018-07-07 21:38:46,400 total_time=5986554, total_pixels=5909250 2018-07-07 21:38:46,501 total_time=5986554, total_pixels=5909250 2018-07-07 21:38:46,602 total_time=5986554, total_pixels=5909250 2018-07-07 21:38:46,701 total_time=5986554, total_pixels=5909250 2018-07-07 21:38:46,801 total_time=5986554, total_pixels=5909250 2018-07-07 21:38:46,902 total_time=5986554, total_pixels=5909250 2018-07-07 21:38:47,004 total_time=5986554, total_pixels=5909250 2018-07-07 21:38:47,105 total_time=4086536, total_pixels=5237460 2018-07-07 21:38:47,207 total_time=2141036, total_pixels=3893880 2018-07-07 21:38:47,309 total_time=2141036, total_pixels=3893880 2018-07-07 21:38:47,408 total_time=2123402, total_pixels=3557985 2018-07-07 21:38:47,509 total_time=2105012, total_pixels=3222090 2018-07-07 21:38:47,609 total_time=2105012, total_pixels=3222090 2018-07-07 21:38:47,711 total_time=2105012, total_pixels=3222090 2018-07-07 21:38:47,811 total_time=2102911, total_pixels=3221817 2018-07-07 21:38:47,912 total_time=2102911, total_pixels=3221817 2018-07-07 21:38:48,012 total_time=2102911, total_pixels=3221817 2018-07-07 21:38:48,106 total_time=2102911, total_pixels=3221817 2018-07-07 21:38:48,214 total_time=2102911, total_pixels=3221817 2018-07-07 21:38:48,314 total_time=2088832, total_pixels=3170007 2018-07-07 21:38:48,416 total_time=2088832, total_pixels=3170007 2018-07-07 21:38:48,516 total_time=2034937, total_pixels=3168772 2018-07-07 21:38:48,616 total_time=2034937, total_pixels=3168772 2018-07-07 21:38:48,719 total_time=2022816, total_pixels=3150650 2018-07-07 21:38:48,819 total_time=2022816, total_pixels=3150650 2018-07-07 21:38:48,920 total_time=2008820, total_pixels=3096826 2018-07-07 21:38:49,020 total_time=2008820, total_pixels=3096826 2018-07-07 21:38:49,122 total_time=2006189, total_pixels=3094812 2018-07-07 21:38:49,222 total_time=2006189, total_pixels=3094812 2018-07-07 21:38:49,325 total_time=1999343, total_pixels=3086844 2018-07-07 21:38:49,424 total_time=1996451, total_pixels=3084070 2018-07-07 21:38:49,526 total_time=1993687, total_pixels=3076102 2018-07-07 21:38:49,628 total_time=1993687, total_pixels=3076102 2018-07-07 21:38:49,728 total_time=1993687, total_pixels=3076102 2018-07-07 21:38:49,829 total_time=1993687, total_pixels=3076102 2018-07-07 21:38:49,929 total_time=1980344, total_pixels=3021518 2018-07-07 21:38:50,025 total_time=1980344, total_pixels=3021518 2018-07-07 21:38:50,130 total_time=1980344, total_pixels=3021518 2018-07-07 21:38:50,232 total_time=1980344, total_pixels=3021518 2018-07-07 21:38:50,333 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:50,433 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:50,534 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:50,635 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:50,731 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:50,831 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:50,931 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:51,033 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:51,133 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:51,234 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:51,334 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:51,444 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:51,545 total_time=1975713, total_pixels=2969708 2018-07-07 21:38:51,625 New unix-domain connection received on /run/user/1000/xpra/xubuntu-1 2018-07-07 21:38:51,628 Handshake complete; enabling connection 2018-07-07 21:38:51,633 Python2/GObject client version 2.3.2-r19729 64-bit 2018-07-07 21:38:51,633 connected from 'xubuntu' as 'steved' - 'Steve Dee' 2018-07-07 21:38:51,648 Shutting down in response to client request 2018-07-07 21:38:51,649 Disconnecting client Protocol(unix-domain socket:/run/user/1000/xpra/xubuntu-1): 2018-07-07 21:38:51,649 server shutdown 2018-07-07 21:38:51,652 xpra client 2 disconnected. 2018-07-07 21:38:51,653 Disconnecting client Protocol(unix-domain socket:/run/user/1000/xpra/xubuntu-1): 2018-07-07 21:38:51,653 server shutdown 2018-07-07 21:38:51,669 sound source stopping 2018-07-07 21:38:51,671 Error during info collection using > Traceback (most recent call last): File "/usr/lib/python2.7/dist-packages/xpra/server/server_core.py", line 1703, in _get_info_in_thread info = self.get_info(proto, *args) File "/usr/lib/python2.7/dist-packages/xpra/server/server_base.py", line 546, in get_info dgi = self.do_get_info(proto, sources, wids) File "/usr/lib/python2.7/dist-packages/xpra/x11/server.py", line 325, in do_get_info info = X11ServerBase.do_get_info(self, proto, server_sources, window_ids) File "/usr/lib/python2.7/dist-packages/xpra/x11/x11_server_core.py", line 325, in do_get_info info = GTKServerBase.do_get_info(self, proto, server_sources, window_ids) File "/usr/lib/python2.7/dist-packages/xpra/server/gtk_server_base.py", line 120, in do_get_info info = ServerBase.do_get_info(self, proto, *args) File "/usr/lib/python2.7/dist-packages/xpra/server/server_base.py", line 613, in do_get_info sinfo = ss.get_info() File "/usr/lib/python2.7/dist-packages/xpra/server/source/client_connection.py", line 347, in get_info "connection" : self.protocol.get_info(), AttributeError: 'NoneType' object has no attribute 'get_info' 2018-07-07 21:38:51,684 xpra client 1 disconnected. 2018-07-07 21:38:52,187 stopping pulseaudio with pid 12696 2018-07-07 21:38:52,292 New unix-domain connection received on /run/user/1000/xpra/xubuntu-1 2018-07-07 21:38:52,293 New unix-domain connection received on /home/steved/.xpra/xubuntu-1 2018-07-07 21:38:52,704 killing xvfb with pid 12646 2018-07-07 21:38:52,704 removing socket /run/user/1000/xpra/xubuntu-1 2018-07-07 21:38:52,705 removing socket /home/steved/.xpra/xubuntu-1 xfce4-terminal: Fatal IO error 11 (Resource temporarily unavailable) on X server :1.