xpra icon
Bug tracker and wiki

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


Ticket #806: ticket806_-d_encoding_log-excerpt-cleaned.txt

File ticket806_-d_encoding_log-excerpt-cleaned.txt, 104.0 KB (added by alas, 7 years ago)

ticket 806 server logs -d encoding

Line 
1Feb 20 14:57:52 2015-02-20 14:57:52,785 damage(WindowModel(0xe0000a - "Pandora Radio - Listen to Free Internet Radio, Find New Music | AirGap"), 743, 539, 260, 70, {})
2Feb 20 14:57:52 2015-02-20 14:57:52,786 damage(743, 539, 260, 70, {}) wid=3, sending now with sequence 5608
3Feb 20 14:57:52 2015-02-20 14:57:52,786 get_best_encoding_video(..) temporarily switching to lossless mode for 18200 pixels: low pixel count
4Feb 20 14:57:52 2015-02-20 14:57:52,790 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 5.7 ms, request rgb time: 2.5 ms
5Feb 20 14:57:52 2015-02-20 14:57:52,792 make_data_packet: image=XShmImageWrapper(BGRX: 743, 539, 260, 70), damage data: (3, 743, 539, 260, 70, 'rgb24')
6Feb 20 14:57:52 2015-02-20 14:57:52,793 rgb_encode: BGRX pixels re-stride saving 77% from 4384 (306880 bytes) to 1040 (72800 bytes)
7Feb 20 14:57:52 2015-02-20 14:57:52,794 rgb_encode using level=1, lz4 compressed 260x70 in rgb24/BGRX: 72800 bytes down to 4057
8Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
9Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
10Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
11Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
12Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
13Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
14Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
15Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
16Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
17Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
18Feb 20 14:57:52 2015-02-20 14:57:52,801 packet decoding sequence 5608 for window 3 260x70 took 0.0ms
19Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
20Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
21Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
22Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
23Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
24Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
25Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
26Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
27Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
28Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
29Feb 20 14:57:52 2015-02-20 14:57:52,839 damage(WindowModel(0xe0000a - "Pandora Radio - Listen to Free Internet Radio, Find New Music | AirGap"), 744, 538, 261, 86, {})
30Feb 20 14:57:52 2015-02-20 14:57:52,842 damage(744, 538, 261, 86, {}) wid=3, sending now with sequence 5609
31Feb 20 14:57:52 2015-02-20 14:57:52,842 get_best_encoding_video(..) temporarily switching to lossless mode for 22446 pixels: low pixel count
32Feb 20 14:57:52 2015-02-20 14:57:52,850 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 11.6 ms, request rgb time: 2.4 ms
33Feb 20 14:57:52 2015-02-20 14:57:52,851 make_data_packet: image=XShmImageWrapper(BGRX: 744, 538, 261, 86), damage data: (3, 744, 538, 261, 86, 'rgb24')
34Feb 20 14:57:52 2015-02-20 14:57:52,852 rgb_encode: BGRX pixels re-stride saving 77% from 4384 (377024 bytes) to 1044 (89784 bytes)
35Feb 20 14:57:52 2015-02-20 14:57:52,852 rgb_encode using level=1, lz4 compressed 261x86 in rgb24/BGRX: 89784 bytes down to 5636
36Feb 20 14:57:52 2015-02-20 14:57:52,859 packet decoding sequence 5609 for window 3 261x86 took 0.0ms
37Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
38Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
39Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
40Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
41Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
42Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
43Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
44Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
45Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
46Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
47Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
48Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
49Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
50Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
51Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
52Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
53Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
54Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
55Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
56Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
57Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
58Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
59Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
60Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
61Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
62Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
63Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
64Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
65Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
66Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
67Feb 20 14:57:52 2015-02-20 14:57:52,926 damage(WindowModel(0xe0000a - "Pandora Radio - Listen to Free Internet Radio, Find New Music | AirGap"), 746, 538, 261, 86, {})
68Feb 20 14:57:52 2015-02-20 14:57:52,927 damage(746, 538, 261, 86, {}) wid=3, sending now with sequence 5610
69Feb 20 14:57:52 2015-02-20 14:57:52,927 get_best_encoding_video(..) temporarily switching to lossless mode for 22446 pixels: low pixel count
70Feb 20 14:57:52 2015-02-20 14:57:52,930 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 3.9 ms, request rgb time: 2.2 ms
71Feb 20 14:57:52 2015-02-20 14:57:52,930 make_data_packet: image=XShmImageWrapper(BGRX: 746, 538, 261, 86), damage data: (3, 746, 538, 261, 86, 'rgb24')
72Feb 20 14:57:52 2015-02-20 14:57:52,931 rgb_encode: BGRX pixels re-stride saving 77% from 4384 (377024 bytes) to 1044 (89784 bytes)
73Feb 20 14:57:52 2015-02-20 14:57:52,932 rgb_encode using level=1, lz4 compressed 261x86 in rgb24/BGRX: 89784 bytes down to 5520
74Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
75Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
76Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
77Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
78Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
79Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
80Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
81Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
82Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
83Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
84Feb 20 14:57:52 2015-02-20 14:57:52,939 packet decoding sequence 5610 for window 3 261x86 took 0.0ms
85Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
86Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
87Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
88Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
89Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
90Feb 20 14:57:52 2015-02-20 14:57:52,959 damage(WindowModel(0xe0000a - "Pandora Radio - Listen to Free Internet Radio, Find New Music | AirGap"), 748, 537, 261, 72, {})
91Feb 20 14:57:52 2015-02-20 14:57:52,960 damage(748, 537, 261, 72, {}) wid=3, sending now with sequence 5611
92Feb 20 14:57:52 2015-02-20 14:57:52,961 get_best_encoding_video(..) temporarily switching to lossless mode for    18792 pixels: low pixel count
93Feb 20 14:57:52 2015-02-20 14:57:52,964 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 4.9 ms, request rgb time: 1.7 ms
94Feb 20 14:57:52 2015-02-20 14:57:52,964 make_data_packet: image=XShmImageWrapper(BGRX: 748, 537, 261, 72), damage data: (3, 748, 537, 261, 72, 'rgb24')
95Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
96Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
97Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
98Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
99Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
100Feb 20 14:57:52 2015-02-20 14:57:52,965 rgb_encode: BGRX pixels re-stride saving 77% from 4384 (315648 bytes) to 1044 (75168 bytes)
101Feb 20 14:57:52 2015-02-20 14:57:52,965 rgb_encode using level=1, lz4 compressed 261x72 in rgb24/BGRX: 75168 bytes down to 3955
102Feb 20 14:57:52 2015-02-20 14:57:52,974 packet decoding sequence 5611 for window 3 261x72 took 16.0ms
103Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
104Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
105Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
106Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
107Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
108Feb 20 14:57:52 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
109Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
110Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
111Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
112Feb 20 14:57:52 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
113Feb 20 14:57:53 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
114Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
115Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
116Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
117Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
118Feb 20 14:57:53 2015-02-20 14:57:53,014 damage(WindowModel(0xe0000a - "Pandora Radio - Listen to Free Internet Radio, Find New Music | AirGap"), 750, 537, 260, 72, {})
119Feb 20 14:57:53 2015-02-20 14:57:53,015 damage(750, 537, 260, 72, {}) wid=3, sending now with sequence 5612
120Feb 20 14:57:53 2015-02-20 14:57:53,015 get_best_encoding_video(..) temporarily switching to lossless mode for    18720 pixels: low pixel count
121Feb 20 14:57:53 2015-02-20 14:57:53,019 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 4.7 ms, request rgb time: 2.6 ms
122Feb 20 14:57:53 2015-02-20 14:57:53,019 make_data_packet: image=XShmImageWrapper(BGRX: 750, 537, 260, 72), damage data: (3, 750, 537, 260, 72, 'rgb24')
123Feb 20 14:57:53 2015-02-20 14:57:53,019 rgb_encode: BGRX pixels re-stride saving 77% from 4384 (315648 bytes) to 1040 (74880 bytes)
124Feb 20 14:57:53 2015-02-20 14:57:53,020 rgb_encode using level=1, lz4 compressed 260x72 in rgb24/BGRX: 74880 bytes down to 3995
125Feb 20 14:57:53 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
126Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
127Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
128Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
129Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
130Feb 20 14:57:53 2015-02-20 14:57:53,025 packet decoding sequence 5612 for window 3 260x72 took 0.0ms
131Feb 20 14:57:53 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
132Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
133Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
134Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
135Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
136Feb 20 14:57:53 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
137Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
138Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
139Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
140Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
141Feb 20 14:57:53 2015-02-20 14:57:53,060 damage(WindowModel(0xe0000a - "Pandora Radio - Listen to Free Internet Radio, Find New Music | AirGap"), 751, 537, 261, 72, {})
142Feb 20 14:57:53 2015-02-20 14:57:53,061 damage(751, 537, 261, 72, {}) wid=3, sending now with sequence 5613
143Feb 20 14:57:53 2015-02-20 14:57:53,061 get_best_encoding_video(..) temporarily switching to lossless mode for 18792 pixels: low pixel count
144Feb 20 14:57:53 2015-02-20 14:57:53,064 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 3.8 ms, request rgb time: 2.4 ms
145Feb 20 14:57:53 2015-02-20 14:57:53,064 make_data_packet: image=XShmImageWrapper(BGRX: 751, 537, 261, 72), damage data: (3, 751, 537, 261, 72, 'rgb24')
146Feb 20 14:57:53 2015-02-20 14:57:53,065 rgb_encode: BGRX pixels re-stride saving 77% from 4384 (315648 bytes) to 1044 (75168 bytes)
147Feb 20 14:57:53 2015-02-20 14:57:53,065 rgb_encode using level=1, lz4 compressed 261x72 in rgb24/BGRX: 75168 bytes down to 4217
148Feb 20 14:57:53 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
149Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
150Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
151Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
152Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
153Feb 20 14:57:53 2015-02-20 14:57:53,072 packet decoding sequence 5613 for window 3 261x72 took 0.0ms
154Feb 20 14:57:53 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
155Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_get_visual: assertion 'GTK_IS_WIDGET (widget)' failed
156Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_new: assertion 'GDK_IS_VISUAL (visual)' failed
157Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gdk-CRITICAL **: IA__gdk_colormap_alloc_colors: assertion 'GDK_IS_COLORMAP (colormap)' failed
158Feb 20 14:57:53 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_modify_bg: assertion 'GTK_IS_WIDGET (widget)' failed
159Feb 20 14:57:53 (WebKitPluginProcess2:3461): GLib-GObject-WARNING **: invalid cast from 'GdkWindowImplX11' to 'GtkWidget'
160Feb 20 14:58:20 2015-02-20 14:58:20,226 update_quality() info={'backlog_factor': 100, 'latency_factor': 3552, 'min_quality': 30, 'batch_factor': 102}, quality=99
161Feb 20 14:58:20 2015-02-20 14:58:20,328 update_speed() info={'damage_latency.abs_factor': 0, 'damage_latency.avg': 38, 'decoding_latency.target': 8000000, 'damage_latency.target': 36, 'min_speed': 0, 'frame_delay': 0, 'decoding_latency.factor': 14, 'damage_latency.ref': 36, 'damage_latency.rel_factor': 73, 'low_limit': 1135456}, speed=71
162Feb 20 14:58:20 2015-02-20 14:58:20,379 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27,{})
163Feb 20 14:58:20 2015-02-20 14:58:20,389 update_encoding_options(False) want_alpha=False, lossless threshold: 89 / 20, small_as_rgb=85155, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1096, 1036))>
164Feb 20 14:58:20 2015-02-20 14:58:20,394 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5809
165Feb 20 14:58:20 2015-02-20 14:58:20,394 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV444P - 1096x1036)
166Feb 20 14:58:20 2015-02-20 14:58:20,395 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
167Feb 20 14:58:20 2015-02-20 14:58:20,420 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 41.2 ms, request rgb time: 10.5 ms
168Feb 20 14:58:20 2015-02-20 14:58:20,440 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
169Feb 20 14:58:20 2015-02-20 14:58:20,444 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
170Feb 20 14:58:20 2015-02-20 14:58:20,453 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2390
171Feb 20 14:58:20 2015-02-20 14:58:20,485 packet decoding sequence 5809 for window 3 924x27 took 0.0ms
172Feb 20 14:58:20 2015-02-20 14:58:20,736 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27,{})
173Feb 20 14:58:20 2015-02-20 14:58:20,742 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5810
174Feb 20 14:58:20 2015-02-20 14:58:20,742 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
175Feb 20 14:58:20 2015-02-20 14:58:20,751 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 14.8 ms, request rgb time: 2.8 ms
176Feb 20 14:58:20 2015-02-20 14:58:20,752 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
177Feb 20 14:58:20 2015-02-20 14:58:20,754 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
178Feb 20 14:58:20 2015-02-20 14:58:20,756 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2415
179Feb 20 14:58:20 2015-02-20 14:58:20,763 check_pipeline_score(False) best=(55, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1096, 1036, codec_spec(x264))
180Feb 20 14:58:20 2015-02-20 14:58:20,768 packet decoding sequence 5810 for window 3 924x27 took 0.0ms
181Feb 20 14:58:21 GLib-GIO-Message: Using the 'memory' GSettings backend.  Your settings will not be saved or shared with other applications.
182Feb 20 14:58:21 2015-02-20 14:58:21,200 update_quality() info={'backlog_factor': 100, 'latency_factor': 2820, 'min_quality': 30, 'batch_factor': 102}, quality=99
183Feb 20 14:58:21 2015-02-20 14:58:21,202 update_speed() info={'damage_latency.abs_factor': 0, 'damage_latency.avg': 37, 'decoding_latency.target': 8000000, 'damage_latency.target': 36, 'min_speed': 0, 'frame_delay': 0, 'decoding_latency.factor': 14, 'damage_latency.ref': 36, 'damage_latency.rel_factor': 71, 'low_limit': 1135456}, speed=70
184Feb 20 14:58:21 2015-02-20 14:58:21,202 update_encoding_options(False) want_alpha=False, lossless threshold: 89 / 20, small_as_rgb=81100, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1096, 1036))>
185Feb 20 14:58:21 2015-02-20 14:58:21,205 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV444P - 1096x1036)
186Feb 20 14:58:21 2015-02-20 14:58:21,490 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27,{})
187Feb 20 14:58:21 2015-02-20 14:58:21,495 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5811
188Feb 20 14:58:21 2015-02-20 14:58:21,495 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
189Feb 20 14:58:21 2015-02-20 14:58:21,508 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 18.1 ms, request rgb time: 3.7 ms
190Feb 20 14:58:21 2015-02-20 14:58:21,518 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
191Feb 20 14:58:21 2015-02-20 14:58:21,519 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
192Feb 20 14:58:21 2015-02-20 14:58:21,520 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2390
193Feb 20 14:58:21 2015-02-20 14:58:21,533 packet decoding sequence 5811 for window 3 924x27 took 0.0ms
194Feb 20 14:58:21 2015-02-20 14:58:21,886 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27,{})
195Feb 20 14:58:21 2015-02-20 14:58:21,888 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5812
196Feb 20 14:58:21 2015-02-20 14:58:21,888 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
197Feb 20 14:58:21 2015-02-20 14:58:21,892 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 6.3 ms, request rgb time: 1.7 ms
198Feb 20 14:58:21 2015-02-20 14:58:21,893 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
199Feb 20 14:58:21 2015-02-20 14:58:21,893 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
200Feb 20 14:58:21 2015-02-20 14:58:21,894 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2415
201Feb 20 14:58:21 2015-02-20 14:58:21,900 packet decoding sequence 5812 for window 3 924x27 took 0.0ms
202Feb 20 14:58:22 2015-02-20 14:58:22,205 update_quality() info={'backlog_factor': 100, 'latency_factor': 2508, 'min_quality': 30, 'batch_factor': 102}, quality=99
203Feb 20 14:58:22 2015-02-20 14:58:22,211 update_speed() info={'damage_latency.abs_factor': 0, 'damage_latency.avg': 34, 'decoding_latency.target': 8000000, 'damage_latency.target': 36, 'min_speed': 0, 'frame_delay': 0, 'decoding_latency.factor': 14, 'damage_latency.ref': 36, 'damage_latency.rel_factor': 66, 'low_limit': 1135456}, speed=69
204Feb 20 14:58:22 2015-02-20 14:58:22,213 update_encoding_options(False) want_alpha=False, lossless threshold: 88 / 20, small_as_rgb=77045, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1096, 1036))>
205Feb 20 14:58:22 2015-02-20 14:58:22,221 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV444P - 1096x1036)
206Feb 20 14:58:22 2015-02-20 14:58:22,256 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 1, 64, 1094, 971, {})
207Feb 20 14:58:22 2015-02-20 14:58:22,260 damage(1, 64, 1094, 971, {}) wid=3, sending now with sequence 5813
208Feb 20 14:58:22 2015-02-20 14:58:22,264 process_damage_regions: wid=3, adding h264 pixel data to queue, elapsed time: 7.9 ms, request rgb time: 3.1 ms
209Feb 20 14:58:22 2015-02-20 14:58:22,266 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1096, 1036), damage data: (3, 0, 0, 1096, 1036, 'h264')
210Feb 20 14:58:22 2015-02-20 14:58:22,266 video_encode('h264', XShmImageWrapper(BGRX: 0, 0, 1096, 1036), {})
211Feb 20 14:58:22 2015-02-20 14:58:22,267 video_encode('h264', XShmImageWrapper(BGRX: 0, 0, 1096, 1036), {}) image size: 1096x1036, encoder/csc size: 1096x1036
212Feb 20 14:58:22 2015-02-20 14:58:22,314 csc_image(XShmImageWrapper(BGRX: 0, 0, 1096, 1036), 1096, 1036) converted to <class 'xpra.codecs.csc_swscale.colorspace_converter.CSCImageWrapper'>(YUV444P:(0, 0, 1096, 1036, 24):3_PLANES) in 47.0ms (23.0 MPixels/s)
213Feb 20 14:58:22 2015-02-20 14:58:22,405 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 81, 35, 40, 27, {})
214Feb 20 14:58:22 2015-02-20 14:58:22,426 damage(81, 35, 40, 27, {}) wid=3, sending now with sequence 5814
215Feb 20 14:58:22 2015-02-20 14:58:22,428 get_best_encoding_video(..) temporarily switching to lossless mode for     1080 pixels: low pixel count
216Feb 20 14:58:22 2015-02-20 14:58:22,432 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 28.3 ms, request rgb time: 2.2 ms
217Feb 20 14:58:22 2015-02-20 14:58:22,477 video_encode encoder: h264 1096x1036 result is 95197 bytes (6.8 MPixels/s), client options={'quality': 97, 'frame': 845L, 'pts': 515252, 'csc': 'YUV444P', 'speed': 74}
218Feb 20 14:58:22 2015-02-20 14:58:22,499 make_data_packet: image=XShmImageWrapper(BGRX: 81, 35, 40, 27), damage data: (3, 81, 35, 40, 27, 'rgb24')
219Feb 20 14:58:22 2015-02-20 14:58:22,514 rgb_encode: BGRX pixels re-stride saving 97% from 4384 (118368 bytes) to 160 (4320 bytes)
220Feb 20 14:58:22 2015-02-20 14:58:22,515 rgb_encode using level=1, lz4 compressed 40x27 in rgb24/BGRX: 4320 bytes down to 31
221Feb 20 14:58:22 2015-02-20 14:58:22,519 check_pipeline_score(False) best=(55, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1096, 1036, codec_spec(x264))
222Feb 20 14:58:22 2015-02-20 14:58:22,551 packet decoding sequence 5813 for window 3 1096x1036 took 31.0ms
223Feb 20 14:58:22 2015-02-20 14:58:22,554 packet decoding sequence 5814 for window 3 40x27 took 16.0ms
224Feb 20 14:58:22 2015-02-20 14:58:22,691 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
225Feb 20 14:58:22 2015-02-20 14:58:22,696 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5815
226Feb 20 14:58:22 2015-02-20 14:58:22,696 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
227Feb 20 14:58:22 2015-02-20 14:58:22,702 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 11.3 ms, request rgb time: 2.6 ms
228Feb 20 14:58:22 2015-02-20 14:58:22,704 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
229Feb 20 14:58:22 2015-02-20 14:58:22,705 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
230Feb 20 14:58:22 2015-02-20 14:58:22,706 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2390
231Feb 20 14:58:22 2015-02-20 14:58:22,722 packet decoding sequence 5815 for window 3 924x27 took 0.0ms
232Feb 20 14:58:23 2015-02-20 14:58:23,002 send_delayed_regions: bytes_cost=1114548, bytes_threshold=681273, pixel_count=1109428
233Feb 20 14:58:23 2015-02-20 14:58:23,004 send_delayed_regions: using full window update 1096x1036 with png
234Feb 20 14:58:23 2015-02-20 14:58:23,007 process_damage_regions: wid=3, adding png pixel data to queue, elapsed time: 5.2 ms, request rgb time: 2.2 ms
235Feb 20 14:58:23 2015-02-20 14:58:23,007 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1096, 1036), damage data: (3, 0, 0, 1096, 1036, 'png')
236Feb 20 14:58:23 2015-02-20 14:58:23,100 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
237Feb 20 14:58:23 2015-02-20 14:58:23,106 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5817
238Feb 20 14:58:23 2015-02-20 14:58:23,107 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
239Feb 20 14:58:23 2015-02-20 14:58:23,185 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 84.8 ms, request rgb time: 30.0 ms
240Feb 20 14:58:23 2015-02-20 14:58:23,206 update_quality() info={'backlog_factor': 100, 'latency_factor': 888, 'min_quality': 30, 'batch_factor': 102}, quality=99
241Feb 20 14:58:23 2015-02-20 14:58:23,207 update_speed() info={'damage_latency.abs_factor': 8, 'damage_latency.avg': 49, 'decoding_latency.target': 8000000, 'damage_latency.target': 36, 'min_speed': 0, 'frame_delay': 0, 'decoding_latency.factor': 15, 'damage_latency.ref': 36, 'damage_latency.rel_factor': 93, 'low_limit': 1135456}, speed=75
242Feb 20 14:58:23 2015-02-20 14:58:23,210 update_encoding_options(False) want_alpha=False, lossless threshold: 90 / 20, small_as_rgb=101376, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1096, 1036))>
243Feb 20 14:58:23 2015-02-20 14:58:23,210 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV444P - 1096x1036)
244Feb 20 14:58:23 2015-02-20 14:58:23,291 sending 1096x1036 BGRX as png, mode=RGB, options={'compress_level': 3}
245Feb 20 14:58:23 2015-02-20 14:58:23,333 check_pipeline_score(False) best=(54, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1096, 1036, codec_spec(x264))
246Feb 20 14:58:23 2015-02-20 14:58:23,351 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
247Feb 20 14:58:23 2015-02-20 14:58:23,353 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
248Feb 20 14:58:23 2015-02-20 14:58:23,355 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2415
249Feb 20 14:58:23 2015-02-20 14:58:23,479 packet decoding sequence 5816 for window 3 1096x1036 took 78.0ms
250Feb 20 14:58:23 2015-02-20 14:58:23,483 packet decoding sequence 5817 for window 3 924x27 took 16.0ms
251Feb 20 14:58:23 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_hide: assertion 'GTK_IS_WIDGET (widget)' failed
252Feb 20 14:58:23 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
253Feb 20 14:58:23 2015-02-20 14:58:23,865 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 9, 64, 1086, 971, {})
254Feb 20 14:58:23 2015-02-20 14:58:23,868 damage(9, 64, 1086, 971, {}) wid=3, sending now with sequence 5818
255Feb 20 14:58:23 2015-02-20 14:58:23,871 cancel_damage() wid=30, dropping delayed region None and all sequences up to 2
256Feb 20 14:58:23 2015-02-20 14:58:23,872 encoding_totals for wid=30 with primary encoding=h264 : {}
257Feb 20 14:58:23 2015-02-20 14:58:23,880 process_damage_regions: wid=3, adding h264 pixel data to queue, elapsed time: 14.2 ms, request rgb time: 1.8 ms
258Feb 20 14:58:23 2015-02-20 14:58:23,880 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1096, 1036), damage data: (3, 0, 0, 1096, 1036, 'h264')
259Feb 20 14:58:23 2015-02-20 14:58:23,880 video_encode('h264', XShmImageWrapper(BGRX: 0, 0, 1096, 1036), {})
260Feb 20 14:58:23 2015-02-20 14:58:23,881 video_encode('h264', XShmImageWrapper(BGRX: 0, 0, 1096, 1036), {}) image size: 1096x1036, encoder/csc size: 1096x1036
261Feb 20 14:58:23 2015-02-20 14:58:23,893 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
262Feb 20 14:58:23 2015-02-20 14:58:23,894 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5819
263Feb 20 14:58:23 2015-02-20 14:58:23,895 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
264Feb 20 14:58:23 2015-02-20 14:58:23,896 csc_image(XShmImageWrapper(BGRX: 0, 0, 1096, 1036), 1096, 1036) converted to <class 'xpra.codecs.csc_swscale.colorspace_converter.CSCImageWrapper'>(YUV444P:(0, 0, 1096, 1036, 24):3_PLANES) in 14.6ms (74.3 MPixels/s)
265Feb 20 14:58:23 2015-02-20 14:58:23,899 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 5.5 ms, request rgb time: 2.8 ms
266Feb 20 14:58:23 2015-02-20 14:58:23,930 video_encode encoder: h264 1096x1036 result is 8836 bytes (35.5 MPixels/s), client options={'quality': 97, 'frame': 846L, 'pts': 516834, 'csc': 'YUV444P', 'speed': 75}
267Feb 20 14:58:23 2015-02-20 14:58:23,931 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
268Feb 20 14:58:23 2015-02-20 14:58:23,933 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
269Feb 20 14:58:23 2015-02-20 14:58:23,934 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2390
270Feb 20 14:58:23 2015-02-20 14:58:23,959 packet decoding sequence 5818 for window 3 1096x1036 took 16.0ms
271Feb 20 14:58:23 2015-02-20 14:58:23,963 packet decoding sequence 5819 for window 3 924x27 took 15.0ms
272Feb 20 14:58:23 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
273Feb 20 14:58:23 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_hide: assertion 'GTK_IS_WIDGET (widget)' failed
274Feb 20 14:58:23 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
275Feb 20 14:58:23 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
276Feb 20 14:58:23 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_hide: assertion 'GTK_IS_WIDGET (widget)' failed
277Feb 20 14:58:23 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
278Feb 20 14:58:23 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
279Feb 20 14:58:23 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_hide: assertion 'GTK_IS_WIDGET (widget)' failed
280Feb 20 14:58:23 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
281Feb 20 14:58:24 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
282Feb 20 14:58:24 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_hide: assertion 'GTK_IS_WIDGET (widget)' failed
283Feb 20 14:58:24 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
284Feb 20 14:58:24 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
285Feb 20 14:58:24 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_hide: assertion 'GTK_IS_WIDGET (widget)' failed
286Feb 20 14:58:24 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
287Feb 20 14:58:24 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
288Feb 20 14:58:24 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_hide: assertion 'GTK_IS_WIDGET (widget)' failed
289Feb 20 14:58:24 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
290Feb 20 14:58:24 (WebKitPluginProcess2:3461): Gtk-CRITICAL **: IA__gtk_widget_destroy: assertion 'GTK_IS_WIDGET (widget)' failed
291Feb 20 14:58:24 2015-02-20 14:58:24,208 update_quality() info={'backlog_factor': 100, 'latency_factor': 987, 'min_quality': 30, 'batch_factor': 102}, quality=99
292Feb 20 14:58:24 2015-02-20 14:58:24,209 update_speed() info={'damage_latency.abs_factor': 20, 'damage_latency.avg': 66, 'decoding_latency.target': 8000000, 'damage_latency.target': 36, 'min_speed': 0, 'frame_delay': 0, 'decoding_latency.factor': 16, 'damage_latency.ref': 36, 'damage_latency.rel_factor': 132, 'low_limit': 1135456}, speed=77
293Feb 20 14:58:24 2015-02-20 14:58:24,209 update_encoding_options(False) want_alpha=False, lossless threshold: 90 / 20, small_as_rgb=109486, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1096, 1036))>
294Feb 20 14:58:24 2015-02-20 14:58:24,209 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV444P - 1096x1036)
295Feb 20 14:58:24 2015-02-20 14:58:24,231 check_pipeline_score(False) best=(54, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1096, 1036, codec_spec(x264))
296Feb 20 14:58:24 2015-02-20 14:58:24,286 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
297Feb 20 14:58:24 2015-02-20 14:58:24,286 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5820
298Feb 20 14:58:24 2015-02-20 14:58:24,286 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
299Feb 20 14:58:24 2015-02-20 14:58:24,288 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 2.4 ms, request rgb time: 1.4 ms
300Feb 20 14:58:24 2015-02-20 14:58:24,289 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
301Feb 20 14:58:24 2015-02-20 14:58:24,290 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
302Feb 20 14:58:24 2015-02-20 14:58:24,290 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2415
303Feb 20 14:58:24 2015-02-20 14:58:24,296 packet decoding sequence 5820 for window 3 924x27 took 0.0ms
304Feb 20 14:58:24 2015-02-20 14:58:24,433 send_delayed_regions: bytes_cost=1114604, bytes_threshold=681273, pixel_count=1110508
305Feb 20 14:58:24 2015-02-20 14:58:24,435 send_delayed_regions: using full window update 1096x1036 with png
306Feb 20 14:58:24 2015-02-20 14:58:24,437 process_damage_regions: wid=3, adding png pixel data to queue, elapsed time: 4.6 ms, request rgb time: 0.8 ms
307Feb 20 14:58:24 2015-02-20 14:58:24,438 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1096, 1036), damage data: (3, 0, 0, 1096, 1036, 'png')
308Feb 20 14:58:24 2015-02-20 14:58:24,503 sending 1096x1036 BGRX as png, mode=RGB, options={'compress_level': 3}
309Feb 20 14:58:24 2015-02-20 14:58:24,581 packet decoding sequence 5821 for window 3 1096x1036 took 63.0ms
310Feb 20 14:58:25 2015-02-20 14:58:25,088 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27,        {})
311Feb 20 14:58:25 2015-02-20 14:58:25,089 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5822
312Feb 20 14:58:25 2015-02-20 14:58:25,089 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
313Feb 20 14:58:25 2015-02-20 14:58:25,092 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 3.3 ms, request rgb time: 1.9 ms
314Feb 20 14:58:25 2015-02-20 14:58:25,092 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
315Feb 20 14:58:25 2015-02-20 14:58:25,092 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
316Feb 20 14:58:25 2015-02-20 14:58:25,092 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2390
317Feb 20 14:58:25 2015-02-20 14:58:25,102 packet decoding sequence 5822 for window 3 924x27 took 16.0ms
318Feb 20 14:58:25 2015-02-20 14:58:25,206 update_quality() info={'backlog_factor': 100, 'latency_factor': 2754, 'min_quality': 30, 'batch_factor': 102}, quality=99
319Feb 20 14:58:25 2015-02-20 14:58:25,207 update_speed() info={'damage_latency.abs_factor': 11, 'damage_latency.avg': 53, 'decoding_latency.target': 8000000, 'damage_latency.target': 36, 'min_speed': 0, 'frame_delay': 0, 'decoding_latency.factor': 18, 'damage_latency.ref': 36, 'damage_latency.rel_factor': 109, 'low_limit': 1135456}, speed=78
320Feb 20 14:58:25 2015-02-20 14:58:25,207 update_encoding_options(False) want_alpha=False, lossless threshold: 90 / 20, small_as_rgb=113541, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1096, 1036))>
321Feb 20 14:58:25 2015-02-20 14:58:25,208 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV444P - 1096x1036)
322Feb 20 14:58:25 2015-02-20 14:58:25,228 check_pipeline_score(False) best=(54, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1096, 1036, codec_spec(x264))
323Feb 20 14:58:25 2015-02-20 14:58:25,489 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
324Feb 20 14:58:25 2015-02-20 14:58:25,492 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5823
325Feb 20 14:58:25 2015-02-20 14:58:25,492 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
326Feb 20 14:58:25 2015-02-20 14:58:25,495 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 5.4 ms, request rgb time: 1.6 ms
327Feb 20 14:58:25 2015-02-20 14:58:25,496 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
328Feb 20 14:58:25 2015-02-20 14:58:25,496 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
329Feb 20 14:58:25 2015-02-20 14:58:25,496 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2415
330Feb 20 14:58:25 2015-02-20 14:58:25,506 packet decoding sequence 5823 for window 3 924x27 took 0.0ms
331Feb 20 14:58:26 2015-02-20 14:58:26,207 update_quality() info={'backlog_factor': 100, 'latency_factor': 1360, 'min_quality': 30, 'batch_factor': 102}, quality=99
332Feb 20 14:58:26 2015-02-20 14:58:26,208 update_speed() info={'damage_latency.abs_factor': 8, 'damage_latency.avg': 50, 'decoding_latency.target': 8000000, 'damage_latency.target': 36, 'min_speed': 0, 'frame_delay': 0, 'decoding_latency.factor': 17, 'damage_latency.ref': 36, 'damage_latency.rel_factor': 103, 'low_limit': 1135456}, speed=78
333Feb 20 14:58:26 2015-02-20 14:58:26,209 update_encoding_options(False) want_alpha=False, lossless threshold: 90 / 20, small_as_rgb=113541, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1096, 1036))>
334Feb 20 14:58:26 2015-02-20 14:58:26,209 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV444P - 1096x1036)
335Feb 20 14:58:26 2015-02-20 14:58:26,231 check_pipeline_score(False) best=(54, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1096, 1036, codec_spec(x264))
336Feb 20 14:58:26 2015-02-20 14:58:26,293 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
337Feb 20 14:58:26 2015-02-20 14:58:26,295 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5824
338Feb 20 14:58:26 2015-02-20 14:58:26,299 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
339Feb 20 14:58:26 2015-02-20 14:58:26,301 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 8.0 ms, request rgb time: 1.5 ms
340Feb 20 14:58:26 2015-02-20 14:58:26,302 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
341Feb 20 14:58:26 2015-02-20 14:58:26,302 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
342Feb 20 14:58:26 2015-02-20 14:58:26,302 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2390
343Feb 20 14:58:26 2015-02-20 14:58:26,308 packet decoding sequence 5824 for window 3 924x27 took 0.0ms
344Feb 20 14:58:26 2015-02-20 14:58:26,694 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
345Feb 20 14:58:26 2015-02-20 14:58:26,697 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5825
346Feb 20 14:58:26 2015-02-20 14:58:26,697 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
347Feb 20 14:58:26 2015-02-20 14:58:26,701 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 7.0 ms, request rgb time: 2.1 ms
348Feb 20 14:58:26 2015-02-20 14:58:26,703 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
349Feb 20 14:58:26 2015-02-20 14:58:26,703 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
350Feb 20 14:58:26 2015-02-20 14:58:26,703 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2415
351Feb 20 14:58:26 2015-02-20 14:58:26,709 packet decoding sequence 5825 for window 3 924x27 took 16.0ms
352Feb 20 14:58:27 2015-02-20 14:58:27,208 update_quality() info={'backlog_factor': 100, 'latency_factor': 4499, 'min_quality': 30, 'batch_factor': 102}, quality=99
353Feb 20 14:58:27 2015-02-20 14:58:27,211 update_speed() info={'damage_latency.abs_factor': 3, 'damage_latency.avg': 42, 'decoding_latency.target': 8000000, 'damage_latency.target': 36, 'min_speed': 0, 'frame_delay': 0, 'decoding_latency.factor': 17, 'damage_latency.ref': 36, 'damage_latency.rel_factor': 88, 'low_limit': 1135456}, speed=76
354Feb 20 14:58:27 2015-02-20 14:58:27,211 update_encoding_options(False) want_alpha=False, lossless threshold: 90 / 20, small_as_rgb=105431, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1096, 1036))>
355Feb 20 14:58:27 2015-02-20 14:58:27,211 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV444P - 1096x1036)
356Feb 20 14:58:27 2015-02-20 14:58:27,233 check_pipeline_score(False) best=(54, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1096, 1036, codec_spec(x264))
357Feb 20 14:58:27 2015-02-20 14:58:27,496 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
358Feb 20 14:58:27 2015-02-20 14:58:27,497 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5826
359Feb 20 14:58:27 2015-02-20 14:58:27,497 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
360Feb 20 14:58:27 2015-02-20 14:58:27,500 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 3.7 ms, request rgb time: 2.1 ms
361Feb 20 14:58:27 2015-02-20 14:58:27,500 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
362Feb 20 14:58:27 2015-02-20 14:58:27,501 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
363Feb 20 14:58:27 2015-02-20 14:58:27,501 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2390
364Feb 20 14:58:27 2015-02-20 14:58:27,510 packet decoding sequence 5826 for window 3 924x27 took 0.0ms
365Feb 20 14:58:27 2015-02-20 14:58:27,898 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
366Feb 20 14:58:27 2015-02-20 14:58:27,899 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5827
367Feb 20 14:58:27 2015-02-20 14:58:27,899 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
368Feb 20 14:58:27 2015-02-20 14:58:27,903 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 4.9 ms, request rgb time: 3.8 ms
369Feb 20 14:58:27 2015-02-20 14:58:27,904 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
370Feb 20 14:58:27 2015-02-20 14:58:27,904 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
371Feb 20 14:58:27 2015-02-20 14:58:27,904 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2415
372Feb 20 14:58:27 2015-02-20 14:58:27,911 packet decoding sequence 5827 for window 3 924x27 took 16.0ms
373Feb 20 14:58:28 2015-02-20 14:58:28,207 update_quality() info={'backlog_factor': 100, 'latency_factor': 11337, 'min_quality': 30, 'batch_factor': 102}, quality=99
374Feb 20 14:58:28 2015-02-20 14:58:28,208 update_speed() info={'damage_latency.abs_factor': 0, 'damage_latency.avg': 36, 'decoding_latency.target': 8000000, 'damage_latency.target': 36, 'min_speed': 0, 'frame_delay': 0, 'decoding_latency.factor': 17, 'damage_latency.ref': 36, 'damage_latency.rel_factor': 74, 'low_limit': 1135456}, speed=73
375Feb 20 14:58:28 2015-02-20 14:58:28,208 update_encoding_options(False) want_alpha=False, lossless threshold: 89 / 20, small_as_rgb=93265, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1096, 1036))>
376Feb 20 14:58:28 2015-02-20 14:58:28,208 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV444P - 1096x1036)
377Feb 20 14:58:28 2015-02-20 14:58:28,229 check_pipeline_score(False) best=(54, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1096, 1036, codec_spec(x264))
378Feb 20 14:58:53 2015-02-20 14:58:53,801 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 1, 35, 1094, 1000, {})
379Feb 20 14:58:53 2015-02-20 14:58:53,836 damage(1, 35, 1094, 1000, {}) wid=3, sending now with sequence 5828
380Feb 20 14:58:53 2015-02-20 14:58:53,849 process_damage_regions: wid=3, adding h264 pixel data to queue, elapsed time: 48.2 ms, request rgb time: 9.7 ms
381Feb 20 14:58:53 2015-02-20 14:58:53,849 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1096, 1036), damage data: (3, 0, 0, 1096, 1036, 'h264')
382Feb 20 14:58:53 2015-02-20 14:58:53,849 video_encode('h264', XShmImageWrapper(BGRX: 0, 0, 1096, 1036), {})
383Feb 20 14:58:53 2015-02-20 14:58:53,850 video_encode('h264', XShmImageWrapper(BGRX: 0, 0, 1096, 1036), {}) image size: 1096x1036, encoder/csc size: 1096x1036
384Feb 20 14:58:53 2015-02-20 14:58:53,851 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
385Feb 20 14:58:53 2015-02-20 14:58:53,851 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5829
386Feb 20 14:58:53 2015-02-20 14:58:53,851 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
387Feb 20 14:58:53 2015-02-20 14:58:53,856 update_quality() info={'backlog_factor': 100, 'latency_factor': 1588, 'min_quality': 30, 'batch_factor': 102}, quality=99
388Feb 20 14:58:53 2015-02-20 14:58:53,856 update_speed() info={'damage_latency.abs_factor': 2, 'damage_latency.avg': 41, 'decoding_latency.target': 8000000, 'damage_latency.target': 36, 'min_speed': 0, 'frame_delay': 0, 'decoding_latency.factor': 15, 'damage_latency.ref': 36, 'damage_latency.rel_factor': 78, 'low_limit': 1135456}, speed=74
389Feb 20 14:58:53 2015-02-20 14:58:53,856 update_encoding_options(False) want_alpha=False, lossless threshold: 89 / 20, small_as_rgb=97320, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1096, 1036))>
390Feb 20 14:58:53 2015-02-20 14:58:53,856 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV       444P - 1096x1036)
391Feb 20 14:58:53 2015-02-20 14:58:53,859 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 8.3 ms, request rgb time: 4.6 ms
392Feb 20 14:58:53 2015-02-20 14:58:53,862 csc_image(XShmImageWrapper(BGRX: 0, 0, 1096, 1036), 1096, 1036) converted to <class 'xpra.codecs.csc_swscale.colorspace_converter.CSCImageWrapper'>(YUV444P:(0, 0, 1096, 1036, 24):3_PLANES) in 11.9ms (90.8 MPixels/s)
393Feb 20 14:58:53 2015-02-20 14:58:53,885 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
394Feb 20 14:58:53 2015-02-20 14:58:53,886 damage(123, 35, 924, 27, {}) wid=3, scheduling batching expiry for sequence 5830 in 0.0 ms
395Feb 20 14:58:53 2015-02-20 14:58:53,887 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1135456
396Feb 20 14:58:53 2015-02-20 14:58:53,888 send_delayed_regions: bytes_cost=25972, bytes_threshold=681273, pixel_count=24948
397Feb 20 14:58:53 2015-02-20 14:58:53,888 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
398Feb 20 14:58:53 2015-02-20 14:58:53,890 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 4.8 ms, request rgb time: 1.3 ms
399Feb 20 14:58:53 2015-02-20 14:58:53,896 video_encode encoder: h264 1096x1036 result is 6359 bytes (32.3 MPixels/s), client options={'quality': 97, 'frame': 847L, 'pts': 546800, 'csc': 'YUV444P', 'speed': 73}
400Feb 20 14:58:53 2015-02-20 14:58:53,896 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
401Feb 20 14:58:53 2015-02-20 14:58:53,897 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
402Feb 20 14:58:53 2015-02-20 14:58:53,900 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2393
403Feb 20 14:58:53 2015-02-20 14:58:53,900 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
404Feb 20 14:58:53 2015-02-20 14:58:53,900 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
405Feb 20 14:58:53 2015-02-20 14:58:53,901 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2393
406Feb 20 14:58:53 2015-02-20 14:58:53,901 window 3 delayed region already sent
407Feb 20 14:58:53 2015-02-20 14:58:53,905 check_pipeline_score(False) best=(54, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1096, 1036, codec_spec(x264))
408Feb 20 14:58:53 2015-02-20 14:58:53,903 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
409Feb 20 14:58:53 2015-02-20 14:58:53,905 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5831
410Feb 20 14:58:53 2015-02-20 14:58:53,906 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
411Feb 20 14:58:53 2015-02-20 14:58:53,909 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 5.4 ms, request rgb time: 1.3 ms
412Feb 20 14:58:53 2015-02-20 14:58:53,909 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
413Feb 20 14:58:53 2015-02-20 14:58:53,909 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
414Feb 20 14:58:53 2015-02-20 14:58:53,909 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2392
415Feb 20 14:58:53 2015-02-20 14:58:53,917 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
416Feb 20 14:58:53 2015-02-20 14:58:53,917 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5832
417Feb 20 14:58:53 2015-02-20 14:58:53,917 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
418Feb 20 14:58:53 2015-02-20 14:58:53,920 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 2.9 ms, request rgb time: 2.0 ms
419Feb 20 14:58:53 2015-02-20 14:58:53,920 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
420Feb 20 14:58:53 2015-02-20 14:58:53,920 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
421Feb 20 14:58:53 2015-02-20 14:58:53,920 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2394
422Feb 20 14:58:53 2015-02-20 14:58:53,934 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
423Feb 20 14:58:53 2015-02-20 14:58:53,934 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5833
424Feb 20 14:58:53 2015-02-20 14:58:53,934 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
425Feb 20 14:58:53 2015-02-20 14:58:53,936 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 2.6 ms, request rgb time: 1.0 ms
426Feb 20 14:58:53 2015-02-20 14:58:53,937 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
427Feb 20 14:58:53 2015-02-20 14:58:53,937 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
428Feb 20 14:58:53 2015-02-20 14:58:53,937 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2393
429Feb 20 14:58:53 2015-02-20 14:58:53,940 packet decoding sequence 5828 for window 3 1096x1036 took 15.0ms
430Feb 20 14:58:53 2015-02-20 14:58:53,943 packet decoding sequence 5829 for window 3 924x27 took 15.0ms
431Feb 20 14:58:53 2015-02-20 14:58:53,948 packet decoding sequence 5830 for window 3 924x27 took 15.0ms
432Feb 20 14:58:53 2015-02-20 14:58:53,948 packet decoding sequence 5831 for window 3 924x27 took 15.0ms
433Feb 20 14:58:53 2015-02-20 14:58:53,950 packet decoding sequence 5832 for window 3 924x27 took 15.0ms
434Feb 20 14:58:53 2015-02-20 14:58:53,951 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
435Feb 20 14:58:53 2015-02-20 14:58:53,952 packet decoding sequence 5833 for window 3 924x27 took 0.0ms
436Feb 20 14:58:53 2015-02-20 14:58:53,954 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5834
437Feb 20 14:58:53 2015-02-20 14:58:53,955 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
438Feb 20 14:58:53 2015-02-20 14:58:53,960 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 8.6 ms, request rgb time: 1.8 ms
439Feb 20 14:58:53 2015-02-20 14:58:53,962 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
440Feb 20 14:58:53 2015-02-20 14:58:53,963 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
441Feb 20 14:58:53 2015-02-20 14:58:53,964 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2394
442Feb 20 14:58:53 2015-02-20 14:58:53,968 packet decoding sequence 5834 for window 3 924x27 took 0.0ms
443Feb 20 14:58:53 2015-02-20 14:58:53,970 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 123, 35, 924, 27, {})
444Feb 20 14:58:53 2015-02-20 14:58:53,972 damage(123, 35, 924, 27, {}) wid=3, sending now with sequence 5835
445Feb 20 14:58:53 2015-02-20 14:58:53,972 get_best_encoding_video(..) temporarily switching to lossless mode for    24948 pixels: low pixel count
446Feb 20 14:58:53 2015-02-20 14:58:53,975 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 5.7 ms, request rgb time: 1.3 ms
447Feb 20 14:58:53 2015-02-20 14:58:53,975 make_data_packet: image=XShmImageWrapper(BGRX: 123, 35, 924, 27), damage data: (3, 123, 35, 924, 27, 'rgb24')
448Feb 20 14:58:53 2015-02-20 14:58:53,976 rgb_encode: BGRX pixels re-stride saving 16% from 4384 (118368 bytes) to 3696 (99792 bytes)
449Feb 20 14:58:53 2015-02-20 14:58:53,976 rgb_encode using level=1, lz4 compressed 924x27 in rgb24/BGRX: 99792 bytes down to 2395
450Feb 20 14:58:53 2015-02-20 14:58:53,980 packet decoding sequence 5835 for window 3 924x27 took 0.0ms
451Feb 20 14:58:53 2015-02-20 14:58:53,994 update_encoding_selection(h264) encoding=h264, common encodings=['h264', 'vp8', 'png', 'png/P', 'png/L', 'webp', 'rgb', 'rgb24', 'rgb32', 'jpeg'], auto_refresh_encodings=['webp', 'jpeg', 'rgb24', 'png', 'rgb32']
452Feb 20 14:58:53 2015-02-20 14:58:53,995 update_quality() info={'backlog_factor': 100, 'min_quality': 30, 'latency_factor': 2535}, quality=99
453Feb 20 14:58:53 2015-02-20 14:58:53,996 update_speed() info={'damage_latency.abs_factor': 46, 'damage_latency.avg': 100, 'decoding_latency.target': 8000000, 'damage_latency.target': 35, 'min_speed': 0, 'frame_delay': 0, 'decoding_latency.factor': 0, 'damage_latency.ref': 35, 'damage_latency.rel_factor': 0, 'low_limit': 1048576}, speed=46
454Feb 20 14:58:53 2015-02-20 14:58:53,996 update_encoding_options(False) want_alpha=False, lossless threshold: 84 / 20, small_as_rgb=15206, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(32 : (0, 0))>
455Feb 20 14:58:53 2015-02-20 14:58:53,997 update_encoding_options(False) csc_encoder=None, video_encoder=None
456Feb 20 14:58:53 2015-02-20 14:58:53,997 initial encoding for 32: h264
457Feb 20 14:58:53 2015-02-20 14:58:53,998 damage(OverrideRedirectWindowModel(0xe06cc5), 0, 0, 1, 1, {})
458Feb 20 14:58:53 2015-02-20 14:58:53,999 damage(0, 0, 1, 1, {}) wid=32, scheduling batching expiry for sequence 1 in 25.0 ms
459Feb 20 14:58:54 2015-02-20 14:58:54,000 damage(OverrideRedirectWindowModel(0xe06cc5), 0, 0, 1, 1, {})
460Feb 20 14:58:54 2015-02-20 14:58:54,001 damage(0, 0, 1, 1, {}) wid=32, using existing delayed h264 regions created 0.0ms ago
461Feb 20 14:58:54 2015-02-20 14:58:54,028 send_delayed for wid 32, batch delay is 0.0, elapsed time is 29.0 ms
462Feb 20 14:58:54 2015-02-20 14:58:54,029 send_delayed_regions: bytes_cost=1025, bytes_threshold=0, pixel_count=1
463Feb 20 14:58:54 2015-02-20 14:58:54,029 get_best_encoding_video(..) temporarily switching to lossless mode for        1 pixels: low pixel count
464Feb 20 14:58:54 2015-02-20 14:58:54,030 send_delayed_regions: using full window update 1x1 with rgb24
465Feb 20 14:58:54 2015-02-20 14:58:54,031 process_damage_regions: wid=32, adding rgb24 pixel data to queue, elapsed time: 32.9 ms, request rgb time: 1.2 ms
466Feb 20 14:58:54 2015-02-20 14:58:54,033 make_data_packet: image=XImageWrapper(BGRX: 0, 0, 1, 1), damage data: (32, 0, 0, 1, 1, 'rgb24')
467Feb 20 14:58:54 2015-02-20 14:58:54,034 rgb_reformat(XImageWrapper(RGB: 0, 0, 1, 1), ['RGB', 'RGBX'], False) converted from BGRX (4 bytes) to RGB (3 bytes) in 0.6ms, rowstride=3
468Feb 20 14:58:54 2015-02-20 14:58:54,034 rgb_encode using level=0, lz4 compressed 1x1 in rgb24/RGB: 3 bytes down to 3
469Feb 20 14:58:54 2015-02-20 14:58:54,077 packet decoding sequence 1 for window 32 1x1 took 0.0ms
470Feb 20 14:58:54 GLib-GIO-Message: Using the 'memory' GSettings backend.  Your settings will not be saved or shared with other applications.
471Feb 20 14:58:54 2015-02-20 14:58:54,399 send_delayed_regions: bytes_cost=1114604, bytes_threshold=681273, pixel_count=1110508
472Feb 20 14:58:54 2015-02-20 14:58:54,401 send_delayed_regions: using full window update 1096x1036 with png
473Feb 20 14:58:54 2015-02-20 14:58:54,402 process_damage_regions: wid=3, adding png pixel data to queue, elapsed time: 3.4 ms, request rgb time: 0.9 ms
474Feb 20 14:58:54 2015-02-20 14:58:54,402 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1096, 1036), damage data: (3, 0, 0, 1096, 1036, 'png')
475Feb 20 14:58:54 2015-02-20 14:58:54,489 sending 1096x1036 BGRX as png, mode=RGB, options={'compress_level': 3}
476Feb 20 14:58:54 2015-02-20 14:58:54,566 packet decoding sequence 5836 for window 3 1096x1036 took 62.0ms
477Feb 20 14:58:54 2015-02-20 14:58:54,783 Uh-oh, our size doesn't fit window sizing constraints: 1096x1036 vs 1201x1036
478Feb 20 14:58:54 2015-02-20 14:58:54,785 damage(WindowModel(0xe0000a - "AirGap by Spikes Security"), 0, 0, 1096, 1036, {})
479Feb 20 14:58:54 2015-02-20 14:58:54,785 damage(0, 0, 1096, 1036, {}) wid=3, scheduling batching expiry for sequence 5837 in 25.0 ms
480Feb 20 14:58:54 2015-02-20 14:58:54,786 damage(WindowModel(0xe0000a - "AirGap by Spikes Security"), 1096, 0, 105, 1036, {})
481Feb 20 14:58:54 2015-02-20 14:58:54,787 damage(1096, 0, 105, 1036, {}) wid=3, using existing delayed h264 regions created 0.0ms ago
482Feb 20 14:58:54 2015-02-20 14:58:54,797 damage(WindowModel(0xe0000a - "AirGap by Spikes Security"), 0, 0, 1201, 1036, {})
483Feb 20 14:58:54 2015-02-20 14:58:54,798 damage(0, 0, 1201, 1036, {}) wid=3, using existing delayed h264 regions created 0.0ms ago
484Feb 20 14:58:54 2015-02-20 14:58:54,814 update_quality() info={'backlog_factor': 100, 'latency_factor': 466, 'min_quality': 30, 'batch_factor': 861}, quality=99
485Feb 20 14:58:54 2015-02-20 14:58:54,815 send_delayed for wid 3, batch delay is 0.0, elapsed time is 30.0 ms
486Feb 20 14:58:54 2015-02-20 14:58:54,816 send_delayed_regions: bytes_cost=1245260, bytes_threshold=746541, pixel_count=1244236
487Feb 20 14:58:54 2015-02-20 14:58:54,816 send_delayed_regions: using full window update 1201x1036 with jpeg
488Feb 20 14:58:54 2015-02-20 14:58:54,831 process_damage_regions: wid=3, adding jpeg pixel data to queue, elapsed time: 45.7 ms, request rgb time: 13.9 ms
489Feb 20 14:58:54 2015-02-20 14:58:54,815 update_speed() info={'damage_latency.abs_factor': 0, 'damage_latency.avg': 3, 'decoding_latency.target': 8000000, 'damage_latency.target': 35, 'min_speed': 0, 'frame_delay': 19, 'decoding_latency.factor': 0, 'damage_latency.ref': 35, 'damage_latency.rel_factor': 4, 'low_limit': 64}, speed=18
490Feb 20 14:58:54 2015-02-20 14:58:54,834 update_encoding_options(False) want_alpha=False, lossless threshold: 78 / 20, small_as_rgb=15206, get_best_encoding=<bound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(32 : (1, 1))>
491Feb 20 14:58:54 2015-02-20 14:58:54,834 update_encoding_options(False) csc_encoder=None, video_encoder=None
492Feb 20 14:58:54 2015-02-20 14:58:54,836 update_quality() info={'backlog_factor': 100, 'latency_factor': 1144, 'min_quality': 30, 'batch_factor': 102}, quality=99
493Feb 20 14:58:54 2015-02-20 14:58:54,836 update_speed() info={'damage_latency.abs_factor': 0, 'damage_latency.avg': 29, 'decoding_latency.target': 8000000, 'da       mage_latency.target': 39, 'min_speed': 0, 'frame_delay': 9, 'decoding_latency.factor': 18, 'damage_latency.ref': 39, 'damage_latency.rel_factor': 56, 'low_limit': 1244236}, speed=65
494Feb 20 14:58:54 2015-02-20 14:58:54,836 update_encoding_options(False) want_alpha=False, lossless threshold: 88 / 20, small_as_rgb=60825, get_best_encoding=<b       ound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1201, 1036))>
495Feb 20 14:58:54 2015-02-20 14:58:54,836 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV       444P - 1096x1036)
496Feb 20 14:58:54 2015-02-20 14:58:54,842 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1201, 1036), damage data: (3, 0, 0, 1201, 1036, 'jpeg')
497Feb 20 14:58:54 2015-02-20 14:58:54,897 damage(WindowModel(0xe0000a - "AirGap by Spikes Security"), 0, 0, 1201, 1036, {})
498Feb 20 14:58:54 2015-02-20 14:58:54,900 sending 1201x1036 BGRX as jpeg, mode=RGB, options={'quality': 99, 'optimize': True}
499Feb 20 14:58:54 2015-02-20 14:58:54,901 damage(0, 0, 1201, 1036, {}) wid=3, scheduling batching expiry for sequence 5838 in 27.0 ms
500Feb 20 14:58:54 2015-02-20 14:58:54,934 send_delayed for wid 3, batch delay is 2.8, elapsed time is 36.0 ms
501Feb 20 14:58:54 2015-02-20 14:58:54,935 send_delayed_regions: bytes_cost=1245260, bytes_threshold=746541, pixel_count=1244236
502Feb 20 14:58:54 2015-02-20 14:58:54,935 send_delayed_regions: using full window update 1201x1036 with jpeg
503Feb 20 14:58:54 2015-02-20 14:58:54,937 process_damage_regions: wid=3, adding jpeg pixel data to queue, elapsed time: 40.4 ms, request rgb time: 2.2 ms
504Feb 20 14:58:54 2015-02-20 14:58:54,947 damage(WindowModel(0xe0000a - "AirGap by Spikes Security"), 123, 35, 1029, 27, {})
505Feb 20 14:58:54 2015-02-20 14:58:54,948 damage(123, 35, 1029, 27, {}) wid=3, scheduling batching expiry for sequence 5839 in 27.0 ms
506Feb 20 14:58:54 2015-02-20 14:58:54,948 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1201, 1036), damage data: (3, 0, 0, 1201, 1036, 'jpeg')
507Feb 20 14:58:54 2015-02-20 14:58:54,987 sending 1201x1036 BGRX as jpeg, mode=RGB, options={'quality': 99, 'optimize': True}
508Feb 20 14:58:54 2015-02-20 14:58:54,991 damage(WindowModel(0xe0000a - "AirGap by Spikes Security"), 81, 35, 42, 27, {})
509Feb 20 14:58:54 2015-02-20 14:58:54,991 damage(81, 35, 42, 27, {}) wid=3, using existing delayed h264 regions created 0.0ms ago
510Feb 20 14:58:54 2015-02-20 14:58:54,992 damage(WindowModel(0xe0000a - "AirGap by Spikes Security"), 1, 35, 80, 27, {})
511Feb 20 14:58:54 2015-02-20 14:58:54,992 damage(1, 35, 80, 27, {}) wid=3, using existing delayed h264 regions created 0.0ms ago
512Feb 20 14:58:54 2015-02-20 14:58:54,992 damage(WindowModel(0xe0000a - "AirGap by Spikes Security"), 1152, 35, 48, 27, {})
513Feb 20 14:58:54 2015-02-20 14:58:54,993 damage(1152, 35, 48, 27, {}) wid=3, using existing delayed h264 regions created 0.0ms ago
514Feb 20 14:58:54 2015-02-20 14:58:54,994 packet decoding sequence 5837 for window 3 1201x1036 took 78.0ms
515Feb 20 14:58:54 2015-02-20 14:58:54,995 damage(WindowModel(0xe0000a - "AirGap by Spikes Security"), 1, 62, 1199, 973, {})
516Feb 20 14:58:54 2015-02-20 14:58:54,995 damage(1, 62, 1199, 973, {}) wid=3, using existing delayed h264 regions created 0.0ms ago
517Feb 20 14:58:54 2015-02-20 14:58:54,995 send_delayed for wid 3, batch delay is 2.8, elapsed time is 48.0 ms
518Feb 20 14:58:54 2015-02-20 14:58:54,996 send_delayed_regions: bytes_cost=1204120, bytes_threshold=746541, pixel_count=1199000
519Feb 20 14:58:54 2015-02-20 14:58:54,996 send_delayed_regions: using full window update 1201x1036 with jpeg
520Feb 20 14:58:54 2015-02-20 14:58:54,998 process_damage_regions: wid=3, adding jpeg pixel data to queue, elapsed time: 50.9 ms, request rgb time: 1.9 ms
521Feb 20 14:58:55 2015-02-20 14:58:55,011 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1201, 1036), damage data: (3, 0, 0, 1201, 1036, 'jpeg')
522Feb 20 14:58:55 2015-02-20 14:58:55,046 sending 1201x1036 BGRX as jpeg, mode=RGB, options={'quality': 99, 'optimize': True}
523Feb 20 14:58:55 2015-02-20 14:58:55,053 packet decoding sequence 5838 for window 3 1201x1036 took 63.0ms
524Feb 20 14:58:55 2015-02-20 14:58:55,106 packet decoding sequence 5839 for window 3 1201x1036 took 47.0ms
525Feb 20 14:58:55 2015-02-20 14:58:55,275 Uh-oh, our size doesn't fit window sizing constraints: 1201x1036 vs 1287x1036
526Feb 20 14:58:55 2015-02-20 14:58:55,278 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 0, 0, 1201, 1036, {})
527Feb 20 14:58:55 2015-02-20 14:58:55,278 damage(0, 0, 1201, 1036, {}) wid=3, scheduling batching expiry for sequence 5840 in 27.0 ms
528Feb 20 14:58:55 2015-02-20 14:58:55,279 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 1201, 0, 86, 1036, {})
529Feb 20 14:58:55 2015-02-20 14:58:55,279 damage(1201, 0, 86, 1036, {}) wid=3, using existing delayed h264 regions created 0.0ms ago
530Feb 20 14:58:55 2015-02-20 14:58:55,284 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 0, 0, 1287, 1036, {})
531Feb 20 14:58:55 2015-02-20 14:58:55,284 damage(0, 0, 1287, 1036, {}) wid=3, using existing delayed h264 regions created 0.0ms ago
532Feb 20 14:58:55 2015-02-20 14:58:55,306 send_delayed for wid 3, batch delay is 2.8, elapsed time is 28.0 ms
533Feb 20 14:58:55 2015-02-20 14:58:55,308 send_delayed_regions: bytes_cost=1334356, bytes_threshold=799999, pixel_count=1333332
534Feb 20 14:58:55 2015-02-20 14:58:55,308 send_delayed_regions: using full window update 1287x1036 with jpeg
535Feb 20 14:58:55 2015-02-20 14:58:55,333 process_damage_regions: wid=3, adding jpeg pixel data to queue, elapsed time: 54.8 ms, request rgb time: 24.8 ms
536Feb 20 14:58:55 2015-02-20 14:58:55,336 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1287, 1036), damage data: (3, 0, 0, 1287, 1036, 'jpeg')
537Feb 20 14:58:55 2015-02-20 14:58:55,336 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 0, 0, 1287, 1036, {})
538Feb 20 14:58:55 2015-02-20 14:58:55,344 damage(0, 0, 1287, 1036, {}) wid=3, scheduling batching expiry for sequence 5841 in 27.0 ms
539Feb 20 14:58:55 2015-02-20 14:58:55,360 sending 1287x1036 BGRX as jpeg, mode=RGB, options={'quality': 99, 'optimize': True}
540Feb 20 14:58:55 2015-02-20 14:58:55,372 send_delayed for wid 3, batch delay is 2.8, elapsed time is 36.0 ms
541Feb 20 14:58:55 2015-02-20 14:58:55,373 send_delayed_regions: bytes_cost=1334356, bytes_threshold=799999, pixel_count=1333332
542Feb 20 14:58:55 2015-02-20 14:58:55,374 send_delayed_regions: using full window update 1287x1036 with jpeg
543Feb 20 14:58:55 2015-02-20 14:58:55,376 process_damage_regions: wid=3, adding jpeg pixel data to queue, elapsed time: 40.8 ms, request rgb time: 2.2 ms
544Feb 20 14:58:55 2015-02-20 14:58:55,378 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1287, 1036), damage data: (3, 0, 0, 1287, 1036, 'jpeg')
545Feb 20 14:58:55 2015-02-20 14:58:55,397 sending 1287x1036 BGRX as jpeg, mode=RGB, options={'quality': 99, 'optimize': True}
546Feb 20 14:58:55 2015-02-20 14:58:55,421 packet decoding sequence 5840 for window 3 1287x1036 took 56.0ms
547Feb 20 14:58:55 2015-02-20 14:58:55,474 packet decoding sequence 5841 for window 3 1287x1036 took 47.0ms
548Feb 20 14:58:55 2015-02-20 14:58:55,813 update_quality() info={'backlog_factor': 100, 'latency_factor': 1033, 'min_quality': 30, 'batch_factor': 91}, quality=       94
549Feb 20 14:58:55 2015-02-20 14:58:55,816 update_speed() info={'damage_latency.abs_factor': 0, 'damage_latency.avg': 35, 'decoding_latency.target': 8000000, 'da       mage_latency.target': 41, 'min_speed': 0, 'frame_delay': 19, 'decoding_latency.factor': 26, 'damage_latency.ref': 41, 'damage_latency.rel_factor': 57, 'low_limit': 1333332}, speed=64
550Feb 20 14:58:55 2015-02-20 14:58:55,816 update_encoding_options(False) want_alpha=False, lossless threshold: 87 / 20, small_as_rgb=53903, get_best_encoding=<b       ound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1287, 1036))>
551Feb 20 14:58:55 2015-02-20 14:58:55,816 update_encoding_options(False) csc_encoder=None, video_encoder=None
552Feb 20 14:58:55 2015-02-20 14:58:55,900 send_delayed_regions: bytes_cost=1334356, bytes_threshold=799999, pixel_count=1333332
553Feb 20 14:58:55 2015-02-20 14:58:55,904 process_damage_regions: wid=3, adding webp pixel data to queue, elapsed time: 4.6 ms, request rgb time: 2.6 ms
554Feb 20 14:58:55 2015-02-20 14:58:55,904 make_data_packet: image=XShmImageWrapper(BGRX: 1096, 0, 191, 1036), damage data: (3, 1096, 0, 191, 1036, 'webp')
555Feb 20 14:58:55 2015-02-20 14:58:55,951 packet decoding sequence 5842 for window 3 191x1036 took 16.0ms
556Feb 20 14:58:56 2015-02-20 14:58:56,339 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 1, 64, 1285, 971, {})
557Feb 20 14:58:56 2015-02-20 14:58:56,343 damage(1, 64, 1285, 971, {}) wid=3, scheduling batching expiry for sequence 5843 in 11.0 ms
558Feb 20 14:58:56 2015-02-20 14:58:56,364 send_delayed for wid 3, batch delay is 11.2, elapsed time is 24.0 ms
559Feb 20 14:58:56 2015-02-20 14:58:56,372 process_damage_regions: wid=3, adding h264 pixel data to queue, elapsed time: 33.2 ms, request rgb time: 3.1 ms
560Feb 20 14:58:56 2015-02-20 14:58:56,373 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1096, 1036), damage data: (3, 0, 0, 1096, 1036, 'h264')
561Feb 20 14:58:56 2015-02-20 14:58:56,374 video_encode('h264', XShmImageWrapper(BGRX: 0, 0, 1096, 1036), {})
562Feb 20 14:58:56 2015-02-20 14:58:56,375 setup_pipeline([(44, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1096, 1036, codec_spec(x264))       , (43, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV422P', (1, 1), 1096, 1036, codec_spec(x264)), (42, (1, 1), None, 0, 0, None, 'BGRX', (1, 1), 1096, 1036, codec_spec(x264)), (42, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV420P', (1, 1), 1096, 1036, codec_spec(x264)), (38, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'RGB', (1, 1), 1096, 1036, codec_s       pec(x264)), (26, (1, 1), (1, 1), 1096, 1036, codec_spec(cython), 'YUV420P', (1, 1), 1096, 1036, codec_spec(x264))], 1096, 1036, 'BGRX')
563Feb 20 14:58:56 2015-02-20 14:58:56,378 setup_pipeline: trying (44, (1, 1), (1, 1), 1096, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1096, 1036, codec_spec       (x264))
564Feb 20 14:58:56 2015-02-20 14:58:56,380 setup_pipeline: csc=swscale(BGRX 1096x1036 - YUV444P 1096x1036), info={'src_height': 1036, 'src_width': 1096, 'dst_hei       ght': 1036, 'dst_width': 1096, 'version': (3, 0, 100), 'flags': ['SWS_FAST_BILINEAR'], 'src_format': 'BGRX', 'formats': ['RGB', 'BGR', 'XRGB', 'BGRX', 'YUV420P', 'YUV422P', 'YUV444P', 'GBR       P'], 'frames': 0L, 'dst_format': 'YUV444P'}, setup took 1.24ms
565Feb 20 14:58:56 2015-02-20 14:58:56,389 setup_pipeline: video encoder=x264_encoder(YUV444P - 1096x1036), info: {'profile': 'high444', 'speed': 64, 'height': 1       036, 'width': 1096, 'version': 142, 'src_format': 'YUV444P', 'formats': ['YUV422P', 'RGB', 'BGRX', 'BGR', 'YUV420P', 'BGRA', 'YUV444P'], 'frames': 0L, 'quality': 94, 'preset': 'faster'}, s       etup took 8.11ms
566Feb 20 14:58:56 2015-02-20 14:58:56,392 video_encode('h264', XShmImageWrapper(BGRX: 0, 0, 1096, 1036), {}) image size: 1096x1036, encoder/csc size: 1096x1036
567Feb 20 14:58:56 2015-02-20 14:58:56,391 send_delayed_regions: bytes_cost=185514, bytes_threshold=799999, pixel_count=184490
568Feb 20 14:58:56 2015-02-20 14:58:56,394 process_damage_regions: wid=3, adding webp pixel data to queue, elapsed time: 55.7 ms, request rgb time: 0.7 ms
569Feb 20 14:58:56 2015-02-20 14:58:56,430 csc_image(XShmImageWrapper(BGRX: 0, 0, 1096, 1036), 1096, 1036) converted to <class 'xpra.codecs.csc_swscale.colorspac       e_converter.CSCImageWrapper'>(YUV444P:(0, 0, 1096, 1036, 24):3_PLANES) in 36.3ms (29.9 MPixels/s)
570Feb 20 14:58:56 2015-02-20 14:58:56,501 video_encode encoder: h264 1096x1036 result is 16632 bytes (15.8 MPixels/s), client options={'quality': 94, 'frame': 0       L, 'pts': 0, 'csc': 'YUV444P', 'speed': 64}
571Feb 20 14:58:56 2015-02-20 14:58:56,503 make_data_packet: image=XShmImageWrapper(BGRX: 1096, 64, 190, 971), damage data: (3, 1096, 64, 190, 971, 'webp')
572Feb 20 14:58:56 2015-02-20 14:58:56,583 packet decoding sequence 5843 for window 3 1096x1036 took 32.0ms
573Feb 20 14:58:56 2015-02-20 14:58:56,599 packet decoding sequence 5844 for window 3 190x971 took 15.0ms
574Feb 20 14:58:56 2015-02-20 14:58:56,660 send_delayed_regions: bytes_cost=1136480, bytes_threshold=799999, pixel_count=1135456
575Feb 20 14:58:56 2015-02-20 14:58:56,665 send_delayed_regions: using full window update 1287x1036 with png
576Feb 20 14:58:56 2015-02-20 14:58:56,668 process_damage_regions: wid=3, adding png pixel data to queue, elapsed time: 8.3 ms, request rgb time: 2.8 ms
577Feb 20 14:58:56 2015-02-20 14:58:56,669 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1287, 1036), damage data: (3, 0, 0, 1287, 1036, 'png')
578Feb 20 14:58:56 2015-02-20 14:58:56,781 send_delayed_regions: bytes_cost=185514, bytes_threshold=799999, pixel_count=184490
579Feb 20 14:58:56 2015-02-20 14:58:56,787 process_damage_regions: wid=3, adding webp pixel data to queue, elapsed time: 5.8 ms, request rgb time: 3.7 ms
580Feb 20 14:58:56 2015-02-20 14:58:56,817 update_quality() info={'backlog_factor': 100, 'latency_factor': 435, 'min_quality': 30, 'batch_factor': 87}, quality=9       1
581Feb 20 14:58:56 2015-02-20 14:58:56,821 update_speed() info={'damage_latency.abs_factor': 7, 'damage_latency.avg': 52, 'decoding_latency.target': 8000000, 'da       mage_latency.target': 41, 'min_speed': 0, 'frame_delay': 17, 'decoding_latency.factor': 25, 'damage_latency.ref': 41, 'damage_latency.rel_factor': 83, 'low_limit': 1333332}, speed=73
582Feb 20 14:58:56 2015-02-20 14:58:56,822 update_encoding_options(False) want_alpha=False, lossless threshold: 89 / 20, small_as_rgb=85729, get_best_encoding=<b       ound method WindowVideoSource.get_best_encoding_video of WindowVideoSource(3 : (1287, 1036))>
583Feb 20 14:58:56 2015-02-20 14:58:56,822 update_encoding_options(False) csc_encoder=swscale(BGRX 1096x1036 - YUV444P 1096x1036), video_encoder=x264_encoder(YUV       444P - 1096x1036)
584Feb 20 14:58:56 2015-02-20 14:58:56,828 check_pipeline_score(False) best=(45, (1, 1), (1, 1), 1286, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1286, 1036, codec_spec(x264))
585Feb 20 14:58:56 2015-02-20 14:58:56,829 check_pipeline_score(False) found better csc encoder: (45, (1, 1), (1, 1), 1286, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1286, 1036, codec_spec(x264))
586Feb 20 14:58:56 2015-02-20 14:58:56,868 check_pipeline_score(False) found better video encoder: (45, (1, 1), (1, 1), 1286, 1036, codec_spec(swscale), 'YUV444P       ', (1, 1), 1286, 1036, codec_spec(x264))
587Feb 20 14:58:56 2015-02-20 14:58:56,873 setup_pipeline([(45, (1, 1), (1, 1), 1286, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1286, 1036, codec_spec(x264))       , (43, (1, 1), None, 0, 0, None, 'BGRX', (1, 1), 1286, 1036, codec_spec(x264)), (43, (1, 1), (1, 1), 1286, 1036, codec_spec(swscale), 'YUV422P', (1, 1), 1286, 1036, codec_spec(x264)), (42, (1, 1), (1, 1), 1286, 1036, codec_spec(swscale), 'YUV420P', (1, 1), 1286, 1036, codec_spec(x264)), (38, (1, 1), (1, 1), 1286, 1036, codec_spec(swscale), 'RGB', (1, 1), 1286, 1036, codec_s       pec(x264)), (26, (1, 1), (1, 1), 1286, 1036, codec_spec(cython), 'YUV420P', (1, 1), 1286, 1036, codec_spec(x264))], 1287, 1036, 'BGRX')
588Feb 20 14:58:56 2015-02-20 14:58:56,874 setup_pipeline: trying (45, (1, 1), (1, 1), 1286, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1286, 1036, codec_spec       (x264))
589Feb 20 14:58:56 2015-02-20 14:58:56,891 setup_pipeline: csc=swscale(BGRX 1286x1036 - YUV444P 1286x1036), info={'src_height': 1036, 'src_width': 1286, 'dst_hei       ght': 1036, 'dst_width': 1286, 'version': (3, 0, 100), 'flags': ['SWS_FAST_BILINEAR'], 'src_format': 'BGRX', 'formats': ['RGB', 'BGR', 'XRGB', 'BGRX', 'YUV420P', 'YUV422P', 'YUV444P', 'GBR       P'], 'frames': 0L, 'dst_format': 'YUV444P'}, setup took 15.34ms
590Feb 20 14:58:56 2015-02-20 14:58:56,949 setup_pipeline failed for (45, (1, 1), (1, 1), 1286, 1036, codec_spec(swscale), 'YUV444P', (1, 1), 1286, 1036, codec_s       pec(x264))
591Feb 20 14:58:56 Traceback (most recent call last):
592Feb 20 14:58:57 File "/usr/lib64/python2.7/site-packages/xpra/server/window_video_source.py", line 1100, in setup_pipeline
593Feb 20 14:58:57 self._video_encoder.init_context(enc_width, enc_height, enc_in_format, dst_formats, encoder_spec.encoding, quality, speed, encoder_scaling, se       lf.encoding_options)
594Feb 20 14:58:57 File "xpra/codecs/enc_x264/encoder.pyx", line 304, in xpra.codecs.enc_x264.encoder.Encoder.init_context (xpra/codecs/enc_x264/encoder.c:2717)
595Feb 20 14:58:57 File "xpra/codecs/enc_x264/encoder.pyx", line 327, in xpra.codecs.enc_x264.encoder.Encoder.init_encoder (xpra/codecs/enc_x264/encoder.c:2947)
596Feb 20 14:58:57 AssertionError: context initialization failed for format YUV444P
597Feb 20 14:58:57 2015-02-20 14:58:56,976 sending 1287x1036 BGRX as png, mode=RGB, options={'compress_level': 3}
598Feb 20 14:58:57 2015-02-20 14:58:56,993 make_data_packet: image=XShmImageWrapper(BGRX: 1096, 64, 190, 971), damage data: (3, 1096, 64, 190, 971, 'webp')
599Feb 20 14:58:57 2015-02-20 14:58:57,062 packet decoding sequence 5845 for window 3 1287x1036 took 62.0ms
600Feb 20 14:58:57 2015-02-20 14:58:57,067 packet decoding sequence 5846 for window 3 190x971 took 0.0ms
601Feb 20 14:58:57 2015-02-20 14:58:57,221 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 1, 64, 1285, 971, {})
602Feb 20 14:58:57 2015-02-20 14:58:57,225 damage(1, 64, 1285, 971, {}) wid=3, scheduling batching expiry for sequence 5847 in 11.0 ms
603Feb 20 14:58:57 2015-02-20 14:58:57,238 send_delayed for wid 3, batch delay is 11.7, elapsed time is 16.0 ms
604Feb 20 14:58:57 2015-02-20 14:58:57,252 process_damage_regions: wid=3, adding h264 pixel data to queue, elapsed time: 31.1 ms, request rgb time: 2.6 ms
605Feb 20 14:58:57 2015-02-20 14:58:57,254 send_delayed_regions: bytes_cost=185514, bytes_threshold=799999, pixel_count=184490
606Feb 20 14:58:57 2015-02-20 14:58:57,254 make_data_packet: image=XShmImageWrapper(BGRX: 0, 0, 1096, 1036), damage data: (3, 0, 0, 1096, 1036, 'h264')
607Feb 20 14:58:57 2015-02-20 14:58:57,255 video_encode('h264', XShmImageWrapper(BGRX: 0, 0, 1096, 1036), {})
608Feb 20 14:58:57 2015-02-20 14:58:57,255 process_damage_regions: wid=3, adding webp pixel data to queue, elapsed time: 34.3 ms, request rgb time: 0.1 ms
609Feb 20 14:58:58 2015-02-20 14:58:58,263 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 1, 64, 1285, 971, {})
610Feb 20 14:58:58 2015-02-20 14:58:58,267 damage(1, 64, 1285, 971, {}) wid=3, scheduling batching expiry for sequence 5849 in 11.0 ms
611Feb 20 14:58:58 2015-02-20 14:58:58,280 send_delayed for wid 3, batch delay is 11.7, elapsed time is 15.0 ms
612Feb 20 14:58:58 2015-02-20 14:58:58,288 process_damage_regions: wid=3, adding h264 pixel data to queue, elapsed time: 24.3 ms, request rgb time: 2.7 ms
613Feb 20 14:58:58 2015-02-20 14:58:58,290 send_delayed_regions: bytes_cost=185514, bytes_threshold=799999, pixel_count=184490
614Feb 20 14:58:58 2015-02-20 14:58:58,292 process_damage_regions: wid=3, adding webp pixel data to queue, elapsed time: 28.5 ms, request rgb time: 1.6 ms
615Feb 20 14:59:00 2015-02-20 14:59:00,100 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 1, 35, 1285, 1000, {})
616Feb 20 14:59:00 2015-02-20 14:59:00,123 damage(1, 35, 1285, 1000, {}) wid=3, scheduling batching expiry for sequence 5851 in 11.0 ms
617Feb 20 14:59:00 2015-02-20 14:59:00,152 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
618Feb 20 14:59:00 2015-02-20 14:59:00,164 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
619Feb 20 14:59:00 2015-02-20 14:59:00,173 process_damage_regions: wid=3, adding h264 pixel data to queue, elapsed time: 73.2 ms, request rgb time: 3.6 ms
620Feb 20 14:59:00 2015-02-20 14:59:00,177 send_delayed_regions: bytes_cost=191024, bytes_threshold=799999, pixel_count=190000
621Feb 20 14:59:00 2015-02-20 14:59:00,189 process_damage_regions: wid=3, adding webp pixel data to queue, elapsed time: 89.2 ms, request rgb time: 8.6 ms
622Feb 20 14:59:00 2015-02-20 14:59:00,198 window 3 delayed region already sent
623Feb 20 14:59:00 2015-02-20 14:59:00,565 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 1, 64, 1285, 971, {})
624Feb 20 14:59:00 2015-02-20 14:59:00,576 damage(1, 64, 1285, 971, {}) wid=3, scheduling batching expiry for sequence 5853 in 12.0 ms
625Feb 20 14:59:00 2015-02-20 14:59:00,593 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
626Feb 20 14:59:00 2015-02-20 14:59:00,605 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
627Feb 20 14:59:00 2015-02-20 14:59:00,619 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
628Feb 20 14:59:00 2015-02-20 14:59:00,656 process_damage_regions: wid=3, adding h264 pixel data to queue, elapsed time: 90.8 ms, request rgb time: 13.4 ms
629Feb 20 14:59:00 2015-02-20 14:59:00,659 send_delayed_regions: bytes_cost=185514, bytes_threshold=799999, pixel_count=184490
630Feb 20 14:59:00 2015-02-20 14:59:00,662 process_damage_regions: wid=3, adding webp pixel data to queue, elapsed time: 96.8 ms, request rgb time: 1.5 ms
631Feb 20 14:59:00 2015-02-20 14:59:00,673 window 3 delayed region already sent
632Feb 20 14:59:01 2015-02-20 14:59:01,290 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 183, 206, 317, 130, {})
633Feb 20 14:59:01 2015-02-20 14:59:01,293 damage(183, 206, 317, 130, {}) wid=3, scheduling batching expiry for sequence 5855 in 17.0 ms
634Feb 20 14:59:01 2015-02-20 14:59:01,361 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
635Feb 20 14:59:01 2015-02-20 14:59:01,435 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
636Feb 20 14:59:01 2015-02-20 14:59:01,486 send_delayed_regions: bytes_cost=42234, bytes_threshold=799999, pixel_count=41210
637Feb 20 14:59:01 2015-02-20 14:59:01,533 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 242.7 ms, request rgb time: 13.3 ms
638Feb 20 14:59:01 2015-02-20 14:59:01,561 window 3 delayed region already sent
639Feb 20 14:59:01 2015-02-20 14:59:01,726 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 1080, 8, 16, 18, {})
640Feb 20 14:59:01 2015-02-20 14:59:01,775 damage(1080, 8, 16, 18, {}) wid=3, scheduling batching expiry for sequence 5856 in 20.0 ms
641Feb 20 14:59:01 2015-02-20 14:59:01,845 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
642Feb 20 14:59:01 2015-02-20 14:59:01,906 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
643Feb 20 14:59:01 2015-02-20 14:59:01,941 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
644Feb 20 14:59:01 2015-02-20 14:59:01,969 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 183, 206, 317, 130, {})
645Feb 20 14:59:01 2015-02-20 14:59:01,972 damage(183, 206, 317, 130, {}) wid=3, using existing delayed h264 regions created 0.2ms ago
646Feb 20 14:59:02 2015-02-20 14:59:01,981 send_delayed_regions: bytes_cost=43546, bytes_threshold=799999, pixel_count=41498
647Feb 20 14:59:02 2015-02-20 14:59:01,982 send_delayed_regions: 2 regions with 41498 pixels (coding=None)
648Feb 20 14:59:02 2015-02-20 14:59:01,995 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 265.9 ms, request rgb time: 9.4 ms
649Feb 20 14:59:02 2015-02-20 14:59:02,011 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 285.2 ms, request rgb time: 5.2 ms
650Feb 20 14:59:02 2015-02-20 14:59:02,013 window 3 delayed region already sent
651Feb 20 14:59:11 2015-02-20 14:59:11,310 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 0, 0, 1287, 35, {})
652Feb 20 14:59:11 2015-02-20 14:59:11,314 damage(0, 0, 1287, 35, {}) wid=3, scheduling batching expiry for sequence 5858 in 25.0 ms
653Feb 20 14:59:11 2015-02-20 14:59:11,864 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 1, 35, 336, 27, {})
654Feb 20 14:59:11 2015-02-20 14:59:11,869 damage(1, 35, 336, 27, {}) wid=3, using existing delayed h264 regions created 0.6ms ago
655Feb 20 14:59:11 2015-02-20 14:59:11,875 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
656Feb 20 14:59:11 2015-02-20 14:59:11,936 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 0, 35, 1, 27, {})
657Feb 20 14:59:11 2015-02-20 14:59:11,942 damage(0, 35, 1, 27, {}) wid=3, using existing delayed h264 regions created 0.6ms ago
658Feb 20 14:59:11 2015-02-20 14:59:11,948 damage(WindowModel(0xe0000a - "Adobe Flash Player Download | AirGap"), 337, 35, 950, 27, {})
659Feb 20 14:59:11 2015-02-20 14:59:11,949 damage(337, 35, 950, 27, {}) wid=3, using existing delayed h264 regions created 0.6ms ago
660Feb 20 14:59:11 2015-02-20 14:59:11,958 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
661Feb 20 14:59:12 2015-02-20 14:59:12,012 send_delayed_regions: bytes_cost=83890, bytes_threshold=799999, pixel_count=79794
662Feb 20 14:59:12 2015-02-20 14:59:12,019 process_damage_regions: wid=3, adding rgb24 pixel data to queue, elapsed time: 709.8 ms, request rgb time: 5.6 ms
663Feb 20 14:59:12 2015-02-20 14:59:12,024 window 3 delayed region already sent
664Feb 20 14:59:13 2015-02-20 14:59:13,097 damage(WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), 0, 0, 1287, 1036, {})
665Feb 20 14:59:13 2015-02-20 14:59:13,100 damage(0, 0, 1287, 1036, {}) wid=3, scheduling batching expiry for sequence 5859 in 27.0 ms
666Feb 20 14:59:13 2015-02-20 14:59:13,130 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
667Feb 20 14:59:13 2015-02-20 14:59:13,141 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
668Feb 20 14:59:13 2015-02-20 14:59:13,152 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
669Feb 20 14:59:13 2015-02-20 14:59:13,166 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
670Feb 20 14:59:13 2015-02-20 14:59:13,180 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
671Feb 20 14:59:13 2015-02-20 14:59:13,191 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
672Feb 20 14:59:13 2015-02-20 14:59:13,201 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
673Feb 20 14:59:13 2015-02-20 14:59:13,212 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
674Feb 20 14:59:13 2015-02-20 14:59:13,224 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
675Feb 20 14:59:13 2015-02-20 14:59:13,248 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
676Feb 20 14:59:13 2015-02-20 14:59:13,267 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
677Feb 20 14:59:13 2015-02-20 14:59:13,285 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
678Feb 20 14:59:13 2015-02-20 14:59:13,304 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
679Feb 20 14:59:13 2015-02-20 14:59:13,327 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
680Feb 20 14:59:13 2015-02-20 14:59:13,354 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
681Feb 20 14:59:13 2015-02-20 14:59:13,382 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
682Feb 20 14:59:13 2015-02-20 14:59:13,416 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
683Feb 20 14:59:13 2015-02-20 14:59:13,451 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
684Feb 20 14:59:13 2015-02-20 14:59:13,491 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
685Feb 20 14:59:13 2015-02-20 14:59:13,533 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
686Feb 20 14:59:13 2015-02-20 14:59:13,580 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
687Feb 20 14:59:13 2015-02-20 14:59:13,631 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
688Feb 20 14:59:13 2015-02-20 14:59:13,691 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
689Feb 20 14:59:13 2015-02-20 14:59:13,756 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
690Feb 20 14:59:13 2015-02-20 14:59:13,827 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
691Feb 20 14:59:13 2015-02-20 14:59:13,905 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
692Feb 20 14:59:13 2015-02-20 14:59:13,989 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
693Feb 20 14:59:14 2015-02-20 14:59:14,084 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
694Feb 20 14:59:14 2015-02-20 14:59:14,188 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
695Feb 20 14:59:14 2015-02-20 14:59:14,302 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
696Feb 20 14:59:14 2015-02-20 14:59:14,435 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
697Feb 20 14:59:14 2015-02-20 14:59:14,591 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
698Feb 20 14:59:14 2015-02-20 14:59:14,752 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
699Feb 20 14:59:14 2015-02-20 14:59:14,924 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
700Feb 20 14:59:15 2015-02-20 14:59:15,120 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
701Feb 20 14:59:15 2015-02-20 14:59:15,338 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
702Feb 20 14:59:15 2015-02-20 14:59:15,577 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
703Feb 20 14:59:15 2015-02-20 14:59:15,830 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
704Feb 20 14:59:16 2015-02-20 14:59:16,112 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
705Feb 20 14:59:16 2015-02-20 14:59:16,420 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
706Feb 20 14:59:16 2015-02-20 14:59:16,779 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
707Feb 20 14:59:17 2015-02-20 14:59:17,159 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
708Feb 20 14:59:17 2015-02-20 14:59:17,575 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
709Feb 20 14:59:18 2015-02-20 14:59:18,035 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
710Feb 20 14:59:18 2015-02-20 14:59:18,534 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
711Feb 20 14:59:19 2015-02-20 14:59:19,044 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
712Feb 20 14:59:19 2015-02-20 14:59:19,568 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
713Feb 20 14:59:20 2015-02-20 14:59:20,087 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
714Feb 20 14:59:20 2015-02-20 14:59:20,603 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
715Feb 20 14:59:21 2015-02-20 14:59:21,120 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
716Feb 20 14:59:21 2015-02-20 14:59:21,630 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
717Feb 20 14:59:22 2015-02-20 14:59:22,153 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
718Feb 20 14:59:22 2015-02-20 14:59:22,661 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
719Feb 20 14:59:23 2015-02-20 14:59:23,192 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
720Feb 20 14:59:23 2015-02-20 14:59:23,705 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
721Feb 20 14:59:24 2015-02-20 14:59:24,237 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
722Feb 20 14:59:24 2015-02-20 14:59:24,750 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
723Feb 20 14:59:25 2015-02-20 14:59:25,259 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
724Feb 20 14:59:25 2015-02-20 14:59:25,768 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
725Feb 20 14:59:26 2015-02-20 14:59:26,294 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
726Feb 20 14:59:26 2015-02-20 14:59:26,809 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
727Feb 20 14:59:27 2015-02-20 14:59:27,322 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
728Feb 20 14:59:27 2015-02-20 14:59:27,867 send_delayed for wid 3, delaying again because too many pixels are waiting to be encoded: 1333332
729Feb 20 14:59:28 2015-02-20 14:59:28,137 delayed_region_timeout: region is 15038ms old, bad connection?
730Feb 20 14:59:28 2015-02-20 14:59:28,138 cancel_damage() wid=3, dropping delayed region (1424473153.097817, WindowModel(0xe0000a - "Pandora Internet Radio - Listen to Free Music You'll Love | AirGap"), [R(0, 0, 1287, 1036)], 'h264', {}) and all sequences up to 5859
731Feb 20 15:00:42 (WebKitPluginProcess2:3461): Gdk-WARNING **: XID collision, trouble ahead
732