[Spice-devel] vdagent-win32 update

[Mike Hinz]

On Thu, 2011-11-24 at 14:56 +0200, Arnon Gilboa wrote:
> Hi there,
> No updates for some time. Have you tried using the debug vdagent I 
> posted a while ago?
> A newer version with several fixes can be found at spice-space.org 
> download page, or directly at:
> http://www.spice-space.org/download/binaries/vdagent-win32_20111124.zip
> Please update with your results.
> Regards,
> Arnon
> 

(resent.  sent from wrong email account the first time).

Arnon,

I've gotten back on this problem and have done some more testing.  

First, there was a new version of qemu that I installed from the F15
virt-preview repos, 0.15.1.  Then within my WinXP VM, I installed the
new vdagent dated 11/24/2011.  

I can say that things have changed, but the problem is still present.
Let me try to describe.  First though are the contents of the log files:

vdservice.log

2976::INFO::2011-11-27 11:45:53,453::VDService::main::***Service
started***
2976::INFO::2011-11-27 11:45:53,453::log_version::1.1.0.1009
2976::INFO::2011-11-27 11:45:53,453::VDService::launch_agent::Wait for
vdagent to connect
2976::INFO::2011-11-27 11:45:53,531::VDService::launch_agent::Pipe
connected by vdagent
2976::INFO::2011-11-27 11:45:53,531::VDService::execute::created
VirtioVDIPort
2976::INFO::2011-11-27 11:45:53,531::VDService::execute::Connected to
server
3932::INFO::2011-11-27
11:45:55,453::VDService::control_handler::Interrogate service

vdagent.log

3632::INFO::2011-11-27 11:45:53,515::VDAgent::run::***Agent started in
session 0***
3632::INFO::2011-11-27 11:45:53,515::log_version::1.1.0.1009
3632::INFO::2011-11-27
11:45:53,515::DesktopLayout::consistent_displays::#qxls 1 #others 0
3632::INFO::2011-11-27 11:45:53,515::VDAgent::connect_pipe::Connected to
service pipe
3632::INFO::2011-11-27
11:45:53,515::VDAgent::send_announce_capabilities::Sending capabilities:
3632::INFO::2011-11-27
11:45:53,515::VDAgent::send_announce_capabilities::37
3632::INFO::2011-11-27
11:45:53,515::VDAgent::input_desktop_message_loop::Desktop: Default
3632::INFO::2011-11-27
11:45:53,515::VDAgent::input_desktop_message_loop::First display setting
3632::INFO::2011-11-27 11:45:53,531::DisplaySetting::load::loading
display setting
3632::INFO::2011-11-27
11:45:53,531::DisplaySetting::reload_from_registry::explorer pid 144
3632::INFO::2011-11-27 11:45:53,531::DisplaySetting::reload_wallpaper::
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_wallpaper::wallpaper wasn't
disabled
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_font_smoothing::
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_font_smoothing::font smoothing
value didn't change
3632::INFO::2011-11-27 11:45:53,546::DisplaySetting::reload_animation::
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_win_animation::
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_win_animation::reload window
animation: success
3632::INFO::2011-11-27 11:45:53,546::DisplaySetting::reload_ui_effects::
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_ui_effects::UserPreferencesMask =
80073e9e 6c
3632::INFO::2011-11-27
11:45:53,656::VDAgent::handle_announce_capabilities::Got capabilities
(1)
3632::INFO::2011-11-27
11:45:53,656::VDAgent::handle_announce_capabilities::77
3632::INFO::2011-11-27
11:45:53,656::VDAgent::send_announce_capabilities::Sending capabilities:
3632::INFO::2011-11-27
11:45:53,656::VDAgent::send_announce_capabilities::37
3632::INFO::2011-11-27
11:45:53,656::VDAgent::handle_announce_capabilities::Got
capabilitiesArnon,

I've gotten back on this problem and have done some more testing.  

First, there was a new version of qemu that I installed from the F15
virt-preview repos, 0.15.1.  Then within my WinXP VM, I installed the
new vdagent dated 11/24/2011.  

I can say that things have changed, but the problem is still present.
Let me try to describe.  First though are the contents of the log files:

vdservice.log

2976::INFO::2011-11-27 11:45:53,453::VDService::main::***Service
started***
2976::INFO::2011-11-27 11:45:53,453::log_version::1.1.0.1009
2976::INFO::2011-11-27 11:45:53,453::VDService::launch_agent::Wait for
vdagent to connect
2976::INFO::2011-11-27 11:45:53,531::VDService::launch_agent::Pipe
connected by vdagent
2976::INFO::2011-11-27 11:45:53,531::VDService::execute::created
VirtioVDIPort
2976::INFO::2011-11-27 11:45:53,531::VDService::execute::Connected to
server
3932::INFO::2011-11-27
11:45:55,453::VDService::control_handler::Interrogate service

vdagent.log

3632::INFO::2011-11-27 11:45:53,515::VDAgent::run::***Agent started in
session 0***
3632::INFO::2011-11-27 11:45:53,515::log_version::1.1.0.1009
3632::INFO::2011-11-27
11:45:53,515::DesktopLayout::consistent_displays::#qxls 1 #others 0
3632::INFO::2011-11-27 11:45:53,515::VDAgent::connect_pipe::Connected to
service pipe
3632::INFO::2011-11-27
11:45:53,515::VDAgent::send_announce_capabilities::Sending capabilities:
3632::INFO::2011-11-27
11:45:53,515::VDAgent::send_announce_capabilities::37
3632::INFO::2011-11-27
11:45:53,515::VDAgent::input_desktop_message_loop::Desktop: Default
3632::INFO::2011-11-27
11:45:53,515::VDAgent::input_desktop_message_loop::First display setting
3632::INFO::2011-11-27 11:45:53,531::DisplaySetting::load::loading
display setting
3632::INFO::2011-11-27
11:45:53,531::DisplaySetting::reload_from_registry::explorer pid 144
3632::INFO::2011-11-27 11:45:53,531::DisplaySetting::reload_wallpaper::
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_wallpaper::wallpaper wasn't
disabled
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_font_smoothing::
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_font_smoothing::font smoothing
value didn't change
3632::INFO::2011-11-27 11:45:53,546::DisplaySetting::reload_animation::
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_win_animation::
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_win_animation::reload window
animation: success
3632::INFO::2011-11-27 11:45:53,546::DisplaySetting::reload_ui_effects::
3632::INFO::2011-11-27
11:45:53,546::DisplaySetting::reload_ui_effects::UserPreferencesMask =
80073e9e 6c
3632::INFO::2011-11-27
11:45:53,656::VDAgent::handle_announce_capabilities::Got capabilities
(1)
3632::INFO::2011-11-27
11:45:53,656::VDAgent::handle_announce_capabilities::77
3632::INFO::2011-11-27
11:45:53,656::VDAgent::send_announce_capabilities::Sending capabilities:
3632::INFO::2011-11-27
11:45:53,656::VDAgent::send_announce_capabilities::37
3632::INFO::2011-11-27
11:45:53,656::VDAgent::handle_announce_capabilities::Got capabilities
(1)
3632::INFO::2011-11-27
11:45:53,656::VDAgent::handle_announce_capabilities::77
3632::INFO::2011-11-27 11:45:53,656::DisplaySetting::set::setting
display options
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_from_registry::explorer pid 144
3632::INFO::2011-11-27 11:45:53,656::DisplaySetting::reload_wallpaper::
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_wallpaper::wallpaper wasn't
disabled
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_font_smoothing::
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_font_smoothing::font smoothing
value didn't change
3632::INFO::2011-11-27 11:45:53,656::DisplaySetting::reload_animation::
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_win_animation::
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_win_animation::reload window
animation: success
3632::INFO::2011-11-27 11:45:53,656::DisplaySetting::reload_ui_effects::
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_ui_effects::UserPreferencesMask =
80073e9e 7c
3632::INFO::2011-11-27
11:56:13,828::VDAgent::on_clipboard_grab::Unsupported clipboard format
  (1)
3632::INFO::2011-11-27
11:45:53,656::VDAgent::handle_announce_capabilities::77
3632::INFO::2011-11-27 11:45:53,656::DisplaySetting::set::setting
display options
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_from_registry::explorer pid 144
3632::INFO::2011-11-27 11:45:53,656::DisplaySetting::reload_wallpaper::
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_wallpaper::wallpaper wasn't
disabled
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_font_smoothing::
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_font_smoothing::font smoothing
value didn't change
3632::INFO::2011-11-27 11:45:53,656::DisplaySetting::reload_animation::
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_win_animation::
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_win_animation::reload window
animation: success
3632::INFO::2011-11-27 11:45:53,656::DisplaySetting::reload_ui_effects::
3632::INFO::2011-11-27
11:45:53,656::DisplaySetting::reload_ui_effects::UserPreferencesMask =
80073e9e 7c
3632::INFO::2011-11-27
11:56:13,828::VDAgent::on_clipboard_grab::Unsupported clipboard format

Now, if whenever I first attempt to copy/paste, I can always do 1 and
sometimes up to 4 successful copy/paste operations.  However, copy/paste
will then abruptly fail to operate after that initial success.
Interestingly, there's one additional thing that I always note.  I've
disabled the USB Graphics Tablet function on the VM and with now I note
that initially, the cursor is NOT captured within the VM AND the
copy/paste operation works!  However, after a few copy/paste operations,
the cursor becomes trapped (the VM window header bar has "Press
Control_L+ALT_L to release the cursor) AND the copy/paste operation then
fails! 

When the above occurs, I can stop and start the vdservice and copy/paste
will again work for a very brief time, until the cursor again becomes
trapped.  

I've also tried enabling the USB Graphics Tablet and essentially the
same thing occurs;  that is copy/paste works for a very short time and
then fails.  However, with the Tablet enabled, the cursor never becomes
trapped.

I hope the above is helpful.  Please let me know if you need more info
or want me to try something else.

Thanks!