VMware Horizon Community
Jubish-Jose
Hot Shot
Hot Shot
‎05-28-2020 04:24 PM

PCoIP Black Screen

We have a Horizon 7.9 environment running on ESXi, 6.7.0, 16075168. We are using NVIDIA GPU cards. We recently did the ESX upgrade and recompose of the VMs. Some of the users running on Windows 7 desktops are complaining about black screen issues, mostly when they are disconnected for a long time and then reconnects. Once they hit the black screen, they are unable to resolve it without rebooting the machine.

The logs show the below:

=====================

2020-05-28T21:45:50.873+10:00> LVL:2 RC:   0        MGMT_SYS :SESSION ACTIVE

2020-05-28T21:45:50.873+10:00> LVL:2 RC:   0      MGMT_VCHAN :Connect callback 0 accepted opening chan name=RDP__CARANOC

2020-05-28T21:45:50.873+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling connect callback 1: event=OPEN cap=0x2 reject=0 flags=0x0 (RDP__CARANOC)

2020-05-28T21:45:50.873+10:00> LVL:2 RC:   0      MGMT_VCHAN :Connect callback 1 accepted opening chan name=RDP__CARANOC

2020-05-28T21:45:50.873+10:00> LVL:2 RC:   0      MGMT_VCHAN :Received OPEN_REQ request to open channel RDP__NLR3hv (peer_chan=1)

2020-05-28T21:45:50.873+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change NOT_FOUND ==> PEER_OPEN  (name=RDP__NLR3hv)

2020-05-28T21:45:50.873+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling connect callback 0: event=OPEN cap=0x3 reject=15876192 flags=0x0 (RDP__NLR3hv)

2020-05-28T21:45:50.874+10:00> LVL:2 RC:   0      MGMT_VCHAN :Connect callback 0 accepted opening chan name=RDP__NLR3hv

2020-05-28T21:45:50.874+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling connect callback 1: event=OPEN cap=0x3 reject=0 flags=0x0 (RDP__NLR3hv)

2020-05-28T21:45:50.874+10:00> LVL:2 RC:   0      MGMT_VCHAN :Connect callback 1 accepted opening chan name=RDP__NLR3hv

2020-05-28T21:45:50.874+10:00> LVL:2 RC:   0      MGMT_VCHAN :Received OPEN_REQ request to open channel RDP__NLW3hv (peer_chan=2)

2020-05-28T21:45:50.874+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change NOT_FOUND ==> PEER_OPEN  (name=RDP__NLW3hv)

2020-05-28T21:45:50.874+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling connect callback 0: event=OPEN cap=0x4 reject=15876192 flags=0x0 (RDP__NLW3hv)

2020-05-28T21:45:50.874+10:00> LVL:2 RC:   0      MGMT_VCHAN :Connect callback 0 accepted opening chan name=RDP__NLW3hv

2020-05-28T21:45:50.874+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling connect callback 1: event=OPEN cap=0x4 reject=0 flags=0x0 (RDP__NLW3hv)

2020-05-28T21:45:50.874+10:00> LVL:2 RC:   0      MGMT_VCHAN :Connect callback 1 accepted opening chan name=RDP__NLW3hv

2020-05-28T21:45:50.879+10:00> LVL:2 RC:   0        MGMT_HDA :mgmt_hda_apdu_fcc_encode_and_send: Encoding MGMT_HDA_AUDIO_INPUT_CTRL_BOOST_ON message...

2020-05-28T21:45:50.879+10:00> LVL:2 RC:   0        MGMT_HDA :mgmt_hda_apdu_fcc_encode_and_send: Encoding MGMT_HDA_AUDIO_INPUT_CTRL_CHANGE_MIC_VOLUME message...

2020-05-28T21:45:50.879+10:00> LVL:1 RC:   0        MGMT_HDA :soft_hda_host_send_mic_volume_apdu: mic_volume(786432)

2020-05-28T21:45:50.880+10:00> LVL:2 RC:   0        MGMT_IMG :CODEC: Processing MGMT_IMG_APDU_TYPE_QUAD_CFG_ACK. [pri = 0]

2020-05-28T21:45:50.880+10:00> LVL:2 RC:   0        MGMT_IMG :cfg_ack_process: processing [1]: MGMT_IMG_APDU_TYPE_QUAD_CFG_ACK - extended

2020-05-28T21:45:50.880+10:00> LVL:2 RC:   0        MGMT_IMG :Soft client sent no preferred display topology. Using default values for 4 display(s). Forcing topology: 0

2020-05-28T21:45:50.880+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change LOCAL_OPEN ==> OPENED  (name=MultimediaRedirChannel)

2020-05-28T21:45:50.881+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=OPENED chan=0 data=0x7:0x1 (MultimediaRedirChannel)

2020-05-28T21:45:50.886+10:00> LVL:2 RC:   0      MGMT_VCHAN :Sending OPEN_REQ APDU: name=RPC#VMwareRde#17628_-001 data=0x00000000

2020-05-28T21:45:50.886+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change NOT_FOUND ==> LOCAL_OPEN  (name=RPC#VMwareRde#17628_-001)

2020-05-28T21:45:50.886+10:00> LVL:2 RC:   0      MGMT_VCHAN :Sending OPEN_REQ APDU: name=RPC#RPCME#5272_-001 data=0x00000000

2020-05-28T21:45:50.886+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change NOT_FOUND ==> LOCAL_OPEN  (name=RPC#RPCME#5272_-001)

2020-05-28T21:45:50.888+10:00> LVL:2 RC:   0      MGMT_VCHAN :Sending OPEN_REQ APDU: name=RPC#MKSVchan#6076_-001 data=0x00000000

2020-05-28T21:45:50.888+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change NOT_FOUND ==> LOCAL_OPEN  (name=RPC#MKSVchan#6076_-001)

2020-05-28T21:45:50.889+10:00> LVL:2 RC:   0        MGMT_HDA :Speaker audio is being enabled: encoding=STEREO-48K-ADPCM (active-bw=9.00 Mbps)

2020-05-28T21:45:50.889+10:00> LVL:2 RC:   0        MGMT_HDA :AUDIO enable changed state from 0 to 1

2020-05-28T21:45:50.891+10:00> LVL:2 RC:   0        MGMT_IMG :Native resolution of the client display 0 is 2560x1440

2020-05-28T21:45:50.891+10:00> LVL:2 RC:   0        MGMT_IMG :   Display 0 added using native dmt: resolution=2560x1440, origin=(0, 0), rotation=0

2020-05-28T21:45:50.891+10:00> LVL:2 RC:   0        MGMT_IMG :Native resolution of the client display 1 is 2560x1440

2020-05-28T21:45:50.892+10:00> LVL:2 RC:   0        MGMT_IMG :   Display 1 added using native dmt: resolution=2560x1440, origin=(2560, 0), rotation=0

2020-05-28T21:45:50.892+10:00> LVL:2 RC:   0        MGMT_IMG :Native resolution of the client display 2 is 2560x1440

2020-05-28T21:45:50.892+10:00> LVL:2 RC:   0        MGMT_IMG :   Display 2 added using native dmt: resolution=2560x1440, origin=(5120, 0), rotation=0

2020-05-28T21:45:50.892+10:00> LVL:2 RC:   0        MGMT_IMG :Native resolution of the client display 3 is 2560x1440

2020-05-28T21:45:50.892+10:00> LVL:2 RC:   0        MGMT_IMG :   Display 3 added using native dmt: resolution=2560x1440, origin=(7680, 0), rotation=0

2020-05-28T21:45:50.892+10:00> LVL:2 RC:   0        MGMT_IMG :Topology: valid:1 (res supported:1, no overlap:1, num active displays:4)

2020-05-28T21:45:50.892+10:00> LVL:2 RC:   0        MGMT_IMG :process_min_max_quality_params: minimum quality is set to 40 [host setting]

2020-05-28T21:45:50.892+10:00> LVL:2 RC:   0        MGMT_IMG :process_min_max_quality_params: maximum initial quality is set to 80 [host setting]

2020-05-28T21:45:50.892+10:00> LVL:2 RC:   0        MGMT_IMG :extended img_settings: use_client_settings: 0, build_to_lossless:1, max_frame_rate: 30, smoothness_vs_sharpness: 50

2020-05-28T21:45:50.893+10:00> LVL:0 RC:   0          SERVER :Resolution Set does not support VMwareResolutionSet_SetLogLevel, skipping ...

2020-05-28T21:45:50.893+10:00> LVL:0 RC:   0    IMG_FRONTEND :Calling open display in Tera2 mode.

2020-05-28T21:45:50.893+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTap_Attach2: inRdsSession 0 sessionId 1

2020-05-28T21:45:50.893+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device VMware SVGA 3D, name \\.\DISPLAY1, deviceID PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00 flags 0x0

2020-05-28T21:45:50.893+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY2, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80005

2020-05-28T21:45:50.893+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY3, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80001

2020-05-28T21:45:50.893+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY4, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80000

2020-05-28T21:45:50.893+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY5, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80000

2020-05-28T21:45:50.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDPDD Chained DD, name \\.\DISPLAYV1, deviceID  flags 0x200008

2020-05-28T21:45:50.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDP Encoder Mirror Driver, name \\.\DISPLAYV2, deviceID  flags 0x200008

2020-05-28T21:45:50.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDP Reflector Display Driver, name \\.\DISPLAYV3, deviceID  flags 0x200008

2020-05-28T21:45:50.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> vmwDisplays 1, nvDisplays 4, amdDisplays 0, intel 0

2020-05-28T21:45:50.899+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change LOCAL_OPEN ==> OPENED  (name=RPC#VMwareRde#17628_-001)

2020-05-28T21:45:50.899+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=OPENED chan=4 data=0x0:0x0 (RPC#VMwareRde#17628_-001)

2020-05-28T21:45:50.900+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change LOCAL_OPEN ==> OPENED  (name=RPC#MKSVchan#6076_-001)

2020-05-28T21:45:50.900+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=OPENED chan=6 data=0x0:0x0 (RPC#MKSVchan#6076_-001)

2020-05-28T21:45:50.904+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change LOCAL_OPEN ==> OPENED  (name=RPC#RPCME#5272_-001)

2020-05-28T21:45:50.904+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=OPENED chan=5 data=0x0:0x0 (RPC#RPCME#5272_-001)

2020-05-28T21:45:50.917+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> Unable to get API interface version 1: 0

2020-05-28T21:45:50.917+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: connecting to driver: Try VMW 0 force win32 0  forceXPDMForRDS 0

2020-05-28T21:45:50.917+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: connecting to driver: NV displays available 4 NVFBC disabled 0

2020-05-28T21:45:50.917+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: profiling disabled.

2020-05-28T21:45:50.917+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device VMware SVGA 3D, name \\.\DISPLAY1, deviceID PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00 flags 0x0

2020-05-28T21:45:50.917+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY2, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80005

2020-05-28T21:45:50.918+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY3, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80001

2020-05-28T21:45:50.918+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY4, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80000

2020-05-28T21:45:50.918+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY5, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80000

2020-05-28T21:45:50.919+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDPDD Chained DD, name \\.\DISPLAYV1, deviceID  flags 0x200008

2020-05-28T21:45:50.919+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDP Encoder Mirror Driver, name \\.\DISPLAYV2, deviceID  flags 0x200008

2020-05-28T21:45:50.919+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDP Reflector Display Driver, name \\.\DISPLAYV3, deviceID  flags 0x200008

2020-05-28T21:45:50.919+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> vmwDisplays 1, nvDisplays 4, amdDisplays 0, intel 0

2020-05-28T21:45:50.919+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: Allocating server, size=10472 bytes

2020-05-28T21:45:50.927+10:00> LVL:2 RC:   0      MGMT_VCHAN :Sending OPEN_REQ APDU: name=UNITY_UPDATE_CHA#44dc_1#PSC data=0x00000000

2020-05-28T21:45:50.927+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change NOT_FOUND ==> LOCAL_OPEN  (name=UNITY_UPDATE_CHA#44dc_1#PSC)

2020-05-28T21:45:50.931+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ResolutionSetReadRegistryInt error 2.

2020-05-28T21:45:50.931+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ResolutionSetReadRegistryInt error 2.

2020-05-28T21:45:50.931+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ressetlib: Enabling 3D RDSH registry key not present

2020-05-28T21:45:50.931+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ressetlib: configure conventional VDGA

2020-05-28T21:45:50.931+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> VMwareResolutionSet_ConfigureVDGADisplays: enter

2020-05-28T21:45:50.931+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ResolutionVDGADevicesPresent - VDGA Devices present called

2020-05-28T21:45:50.932+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ressetlib: displays requested 1, VDGA devices present 4, attached VDGA displays 2

2020-05-28T21:45:50.933+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: Display update strategy: modify

2020-05-28T21:45:50.934+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> The default path is C:\Windows\Syswow64\NvFBC.dll  Adapter 0, Display \\.\DISPLAY2

2020-05-28T21:45:50.937+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change LOCAL_OPEN ==> OPENED  (name=UNITY_UPDATE_CHA#44dc_1#PSC)

2020-05-28T21:45:50.937+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=OPENED chan=7 data=0x0:0x0 (UNITY_UPDATE_CHA#44dc_1#PSC)

2020-05-28T21:45:51.132+10:00> LVL:1 RC:   0          SERVER :InputDevTap_GetKeyboardState @ timer: LEDs = 0xFFFFFFFF ==> 0x02

2020-05-28T21:45:51.132+10:00> LVL:1 RC:   0          SERVER :InputDevTap_GetKeyboardState @ timer: typematic [delay 0 ==> 500] [rate 0 ==> 33]

2020-05-28T21:45:51.245+10:00> LVL:2 RC:   0      MGMT_VCHAN :Sending OPEN_REQ APDU: name=VMWARE__1.25148@1 data=0xFFFFFFFF

2020-05-28T21:45:51.245+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change NOT_FOUND ==> LOCAL_OPEN  (name=VMWARE__1.25148@1)

2020-05-28T21:45:51.253+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change LOCAL_OPEN ==> OPENED  (name=VMWARE__1.25148@1)

2020-05-28T21:45:51.253+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=OPENED chan=8 data=0xFFFFFFFF:0x0 (VMWARE__1.25148@1)

2020-05-28T21:45:51.386+10:00> LVL:2 RC:   0      MGMT_VCHAN :closing chan 8 (type=CLOSE_GRACEFUL) ...

2020-05-28T21:45:51.386+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change OPENED ==> CLOSE_PEND  (name=VMWARE__1.25148@1)

2020-05-28T21:45:51.396+10:00> LVL:2 RC:   0      MGMT_VCHAN :Sending CLOSE_REQ APDU: name=VMWARE__1.25148@1 data=0xFFFFFFFF

2020-05-28T21:45:51.414+10:00> LVL:2 RC:   0      MGMT_VCHAN :Received CLOSE_ACK APDU: chan=8 name=VMWARE__1.25148@1 reason=0xFFFFFFFF

2020-05-28T21:45:51.416+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=CLOSED chan=8 data=0x0:0xFFFFFFFF ()

2020-05-28T21:45:51.503+10:00> LVL:2 RC:   0        MGMT_KMP :>>> Rxed SET_MULTIPLE_LOCALE: num_locales=2 lang[0]=0xC09 layout[0]=0x1

2020-05-28T21:45:51.503+10:00> LVL:2 RC:   0        MGMT_KMP :>>> Rxed SET_MULTIPLE_LOCALE:               lang[1]=0x409 layout[1]=0x1

2020-05-28T21:45:51.510+10:00> LVL:2 RC:   0          SERVER :Desktop switched: EVENT_SYSTEM_DESKTOPSWITCH

2020-05-28T21:45:51.511+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> VMwareResolutionSet_SyncDisplayTopology: enter

2020-05-28T21:45:51.513+10:00> LVL:2 RC:   0      MGMT_VCHAN :Sending OPEN_REQ APDU: name=VMWARE__1.25148@2 data=0xFFFFFFFE

2020-05-28T21:45:51.513+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change NOT_FOUND ==> LOCAL_OPEN  (name=VMWARE__1.25148@2)

2020-05-28T21:45:51.521+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change LOCAL_OPEN ==> OPENED  (name=VMWARE__1.25148@2)

2020-05-28T21:45:51.521+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=OPENED chan=9 data=0xFFFFFFFE:0x0 (VMWARE__1.25148@2)

2020-05-28T21:45:51.968+10:00> LVL:2 RC:   0      MGMT_VCHAN :closing chan 9 (type=CLOSE_GRACEFUL) ...

2020-05-28T21:45:51.968+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change OPENED ==> CLOSE_PEND  (name=VMWARE__1.25148@2)

2020-05-28T21:45:51.979+10:00> LVL:2 RC:   0      MGMT_VCHAN :Sending CLOSE_REQ APDU: name=VMWARE__1.25148@2 data=0xFFFFFFFE

2020-05-28T21:45:52.101+10:00> LVL:2 RC:   0      MGMT_VCHAN :Received CLOSE_ACK APDU: chan=9 name=VMWARE__1.25148@2 reason=0xFFFFFFFE

2020-05-28T21:45:52.109+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=CLOSED chan=9 data=0x0:0xFFFFFFFE ()

2020-05-28T21:45:52.373+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ResolutionVMWDevicesActive: inRdsSession 0 sessionId 1

2020-05-28T21:45:52.374+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ressetlib: Could not find VMware devices.

2020-05-28T21:45:52.374+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ressetlib: noop sync topology

2020-05-28T21:45:52.386+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change PEER_OPEN ==> OPENED  (name=RDP__CARANOC)

2020-05-28T21:45:52.386+10:00> LVL:2 RC:   0      MGMT_VCHAN :Sending OPEN_ACK APDU: name=RDP__CARANOC data=0x00000001

2020-05-28T21:45:52.386+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=OPENED chan=1 data=0x2:0x0 (RDP__CARANOC, indirect)

2020-05-28T21:45:52.410+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: NvFBC reports capture is possible.  Adapter 0, Display \\.\DISPLAY2

2020-05-28T21:45:52.410+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: using NvFBC version 0, status returns 0  Adapter 0, Display \\.\DISPLAY2

2020-05-28T21:45:52.898+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: created the sys object - adapter 0, sys object 0C22ECCC  Adapter 0, Display \\.\DISPLAY2

2020-05-28T21:45:53.217+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> The default path is C:\Windows\Syswow64\NvFBC.dll  Adapter 0, Display \\.\DISPLAY3

2020-05-28T21:45:53.434+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: NvFBC reports capture is possible.  Adapter 0, Display \\.\DISPLAY3

2020-05-28T21:45:53.434+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: using NvFBC version 0, status returns 0  Adapter 0, Display \\.\DISPLAY3

2020-05-28T21:45:53.621+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: NvFBC_Create() failed -5, adapter 1  Adapter 0, Display \\.\DISPLAY3

2020-05-28T21:45:53.622+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: UpdateDisplayWatcher ERROR

2020-05-28T21:45:53.805+10:00> LVL:2 RC:   0      MGMT_VCHAN :closing chan 1 (type=CLOSE_GRACEFUL) ...

2020-05-28T21:45:53.805+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change OPENED ==> CLOSE_PEND  (name=RDP__CARANOC)

2020-05-28T21:45:53.815+10:00> LVL:2 RC:   0      MGMT_VCHAN :Sending CLOSE_REQ APDU: name=RDP__CARANOC data=0x00000001

2020-05-28T21:45:53.834+10:00> LVL:2 RC:   0      MGMT_VCHAN :Received CLOSE_ACK APDU: chan=1 name=RDP__CARANOC reason=0x00000001

2020-05-28T21:45:53.835+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=CLOSED chan=1 data=0x0:0x1 ()

2020-05-28T21:45:53.888+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: BlankHostScreen m_Displays empty

2020-05-28T21:45:53.888+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: usermode backend init failed

2020-05-28T21:45:53.888+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTap_Attach2 failed, retrying

2020-05-28T21:45:53.888+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTap_Attach2: inRdsSession 0 sessionId 1

2020-05-28T21:45:53.888+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device VMware SVGA 3D, name \\.\DISPLAY1, deviceID PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00 flags 0x0

2020-05-28T21:45:53.888+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY2, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80005

2020-05-28T21:45:53.888+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY3, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80001

2020-05-28T21:45:53.888+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY4, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80000

2020-05-28T21:45:53.888+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY5, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80000

2020-05-28T21:45:53.889+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDPDD Chained DD, name \\.\DISPLAYV1, deviceID  flags 0x200008

2020-05-28T21:45:53.889+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDP Encoder Mirror Driver, name \\.\DISPLAYV2, deviceID  flags 0x200008

2020-05-28T21:45:53.889+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDP Reflector Display Driver, name \\.\DISPLAYV3, deviceID  flags 0x200008

2020-05-28T21:45:53.889+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> vmwDisplays 1, nvDisplays 4, amdDisplays 0, intel 0

2020-05-28T21:45:53.893+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> Unable to get API interface version 1: 0

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: connecting to driver: Try VMW 0 force win32 0  forceXPDMForRDS 0

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: connecting to driver: NV displays available 4 NVFBC disabled 0

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: profiling disabled.

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device VMware SVGA 3D, name \\.\DISPLAY1, deviceID PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00 flags 0x0

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY2, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80005

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY3, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80001

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY4, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80000

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY5, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80000

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDPDD Chained DD, name \\.\DISPLAYV1, deviceID  flags 0x200008

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDP Encoder Mirror Driver, name \\.\DISPLAYV2, deviceID  flags 0x200008

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device RDP Reflector Display Driver, name \\.\DISPLAYV3, deviceID  flags 0x200008

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> vmwDisplays 1, nvDisplays 4, amdDisplays 0, intel 0

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: Allocating server, size=10472 bytes

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ResolutionSetReadRegistryInt error 2.

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ResolutionSetReadRegistryInt error 2.

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ressetlib: Enabling 3D RDSH registry key not present

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ressetlib: configure conventional VDGA

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> VMwareResolutionSet_ConfigureVDGADisplays: enter

2020-05-28T21:45:53.894+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ResolutionVDGADevicesPresent - VDGA Devices present called

2020-05-28T21:45:53.895+10:00> LVL:0 RC:   0          EXTERN :set_resolution ==> ressetlib: displays requested 1, VDGA devices present 4, attached VDGA displays 2

2020-05-28T21:45:53.896+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: Display update strategy: modify

2020-05-28T21:45:53.896+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> The default path is C:\Windows\Syswow64\NvFBC.dll  Adapter 0, Display \\.\DISPLAY2

2020-05-28T21:45:53.913+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: NvFBC reports capture is possible.  Adapter 0, Display \\.\DISPLAY2

2020-05-28T21:45:53.913+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: using NvFBC version 0, status returns 0  Adapter 0, Display \\.\DISPLAY2

2020-05-28T21:45:53.982+10:00> LVL:2 RC:   0      MGMT_VCHAN :Sending OPEN_REQ APDU: name=RDP__CARANOC data=0x00000002

2020-05-28T21:45:53.982+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change NOT_FOUND ==> LOCAL_OPEN  (name=RDP__CARANOC)

2020-05-28T21:45:54.077+10:00> LVL:2 RC:   0      MGMT_VCHAN :State Change LOCAL_OPEN ==> OPENED  (name=RDP__CARANOC)

2020-05-28T21:45:54.077+10:00> LVL:2 RC:   0      MGMT_VCHAN :Calling chan callback: event=OPENED chan=10 data=0x2:0x0 (RDP__CARANOC)

2020-05-28T21:45:54.211+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: created the sys object - adapter 0, sys object 0DB948E4  Adapter 0, Display \\.\DISPLAY2

2020-05-28T21:45:54.309+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> The default path is C:\Windows\Syswow64\NvFBC.dll  Adapter 0, Display \\.\DISPLAY3

2020-05-28T21:45:54.318+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: NvFBC reports capture is possible.  Adapter 0, Display \\.\DISPLAY3

2020-05-28T21:45:54.318+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: using NvFBC version 0, status returns 0  Adapter 0, Display \\.\DISPLAY3

2020-05-28T21:45:54.391+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: NvFBC_Create() failed -1, adapter 1  Adapter 0, Display \\.\DISPLAY3

2020-05-28T21:45:54.391+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: UpdateDisplayWatcher ERROR

2020-05-28T21:45:54.668+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: BlankHostScreen m_Displays empty

2020-05-28T21:45:54.668+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: usermode backend init failed

2020-05-28T21:45:54.668+10:00> LVL:0 RC:-500    IMG_FRONTEND :cSW_HOST_FRONTEND::open_display - Error attaching to SVGADevTap, error 1: Failed

2020-05-28T21:45:54.668+10:00> LVL:0 RC:-500        MGMT_IMG :cSW_HOST_IPC::enable_frontend failed. 10 retries remaining. Trying again...

==============

Attaching full logs.

I haven't tried with BLAST yet. We installed the VMware Tools and Horizon agent in the correct order during the maintenance/recompose.

Any help is appreciated.


-- If you find this reply helpful, please consider accepting it as a solution.
pcoip_server_2020_05_28_00005008.txt.zip
Reply
0 Kudos
7 Replies
Shreyskar
VMware Employee
VMware Employee
‎05-28-2020 08:37 PM

Hi popvm

As per logs I suspect it a display driver issue:

2020-05-28T21:46:10.658+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: BlankHostScreen m_Displays empty

2020-05-28T21:46:10.658+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: usermode backend init failed

2020-05-28T21:46:10.658+10:00> LVL:0 RC:-500    IMG_FRONTEND :cSW_HOST_FRONTEND::open_display - Error attaching to SVGADevTap, error 1: Failed

2020-05-28T21:46:11.665+10:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> SVGADevTapCountDisplays: new device NVIDIA GRID T4-4Q, name \\.\DISPLAY5, deviceID PCI\VEN_10DE&DEV_1EB8&SUBSYS_130E10DE&REV_A1 flags 0x80000

> Displays overlap issue occurred and could not be enabled within the 10 retries.

2020-05-28T21:46:26.241+10:00> LVL:0 RC:-500        MGMT_IMG :cSW_HOST_IPC::enable_frontend failed. All 10 retries failed.

2020-05-28T21:46:26.241+10:00> LVL:0 RC:-520        MGMT_IMG :Fatal error: cannot open svga frontend. Notifying session manager to close the session.

> Since PCoIP unable to connect to svgatap, session failed with disconnect cause 202:

2020-05-28T21:46:28.254+10:00> LVL:2 RC:   0          SERVER :server main: cb_notify_session_status called (mask 0x10) with tera_disconnect_cause (0x202)

2020-05-28T21:46:28.254+10:00> LVL:2 RC:   0          SERVER :server main: TERA_MGMT_SYS_SESS_EVENT_RESET with disconnect cause (0x202).

2020-05-28T21:46:28.254+10:00> LVL:1 RC:   0          SERVER :map_tera_to_agent_close_code: TERA_DISCONNECT_CAUSE_HOST_SVGA_FRONTEND_FAILURE -> PCOIP_AGENT_CLOSE_CODE_BROKER_INITIATED

> Disconnect cause 202 means (VMware Knowledge Base ) :

The PCoIP server front end failed to open displays on session startup. This could be a security problem, a bad driver, an application running in full-screen mode, or other problem that needs to be investigated. Without a source of pixels the PCoIP session will be terminated. Two other scenarios that can cause this error:

1)When 32 bpp is not supported by the video driver on Graphics Agent

2)When 32 bpp is not supported by Standard Agent because the tera svga video driver is disabled for some reason).

> Test with SVGA driver opposed to vGPU driver to isolate NVIDIA driver from being cause of the issue (VMware Knowledge Base ). You can update the driver and test.

> If running multi monitor setup, test with single monitor and see.

> Make sure video memory on the machine is set to 128MB. If not increase it and test again.

> Make sure you install NVIDIA driver after horizon agent installation.

Reply
0 Kudos
zdawson
Contributor
Contributor
‎07-07-2020 07:17 AM

PopVM,

Did they ever come up with a fix for this. This bug is hitting our CEO so any help would be much obliged.

Reply
0 Kudos
Jubish-Jose
Hot Shot
Hot Shot
‎07-08-2020 07:38 PM

Sorry, not yet. This happens once in a while for us, but not very frequently. I guess its time to move to Windows 10 leaving Windows 7.


-- If you find this reply helpful, please consider accepting it as a solution.
Reply
0 Kudos
zdawson
Contributor
Contributor
‎07-13-2020 05:51 AM

Ya we have now noticed this on our Windows 10 machines as well. Seems like a bug and it cant find the primary display. Very frustrating.

2020-06-29T20:44:20.281-04:00> LVL:0 RC:   0          EXTERN :svga_devtap ==> svgadevtap: win32 Flip error
2020-06-29T20:44:20.281-04:00> LVL:0 RC:   0 EXTERN :svga_devtap ==> SVGADevTap_Flip-1362: resultIn=0x1, *majorResultOut=0x1
2020-06-29T20:44:20.281-04:00> LVL:0 RC:   0    IMG_FRONTEND :flip_frame_buffer: General flip error [0 results for 2 displays]: [1, 0]
2020-06-29T20:44:21.520-04:00> LVL:0 RC:   0    IMG_FRONTEND :flip_frame_buffer: Resolution change for display 0 [0, 1004]
2020-06-29T20:44:21.520-04:00> LVL:1 RC:   0    IMG_FRONTEND :sw_host_get_display_modes:  - warning - primary display not found
2020-06-29T20:44:21.520-04:00> LVL:1 RC:   0    IMG_FRONTEND :reconfigure_displays: No displays reported, re-trying to get display modes, retries left: 3
2020-06-29T20:44:22.621-04:00> LVL:0 RC:   0    IMG_FRONTEND :flip_frame_buffer: Resolution change for display 0 [0, 1004]
2020-06-29T20:44:22.621-04:00> LVL:1 RC:   0    IMG_FRONTEND :sw_host_get_display_modes:  - warning - primary display not found
2020-06-29T20:44:22.621-04:00> LVL:1 RC:   0    IMG_FRONTEND :reconfigure_displays: No displays reported, re-trying to get display modes, retries left: 2
2020-06-29T20:44:23.721-04:00> LVL:0 RC:   0    IMG_FRONTEND :flip_frame_buffer: Resolution change for display 0 [0, 1004]
2020-06-29T20:44:23.721-04:00> LVL:1 RC:   0    IMG_FRONTEND :sw_host_get_display_modes:  - warning - primary display not found
2020-06-29T20:44:23.721-04:00> LVL:1 RC:   0    IMG_FRONTEND :reconfigure_displays: No displays reported, re-trying to get display modes, retries left: 1 2020-06-29T20:44:24.821-04:00> LVL:0 RC:   0    IMG_FRONTEND :flip_frame_buffer: Resolution change for display 0 [0, 1004]

Seems to not be able to find the display.

Reply
0 Kudos
jmd8888
Contributor
Contributor
‎11-16-2020 05:24 PM

We are seeing the same issues any update or Suggestions.  If we make the Portrait Primary it appears to help ? 

20-11-16T15:59:28.048-07:00> LVL:0 RC: 0 IMG_FRONTEND :flip_frame_buffer: General flip error [0 results for 0 displays]: [1, 0]
2020-11-16T15:59:28.057-07:00> LVL:1 RC: 0 IMG_FRONTEND :sw_host_get_display_modes: - warning - primary display not found
2020-11-16T15:59:28.057-07:00> LVL:0 RC: 0 IMG_FRONTEND :configure_displays: No displays reported, re-trying to get display modes, retries left: 3
18
2020-11-16T15:59:30.246-07:00> LVL:0 RC: 0 EXTERN :svga_devtap ==> SVGADevTap_Flip-1454: resultIn=0x1, *majorResultOut=0x1
2020-11-16T15:59:30.246-07:00> LVL:0 RC: 0 IMG_FRONTEND :flip_frame_buffer: General flip error [0 results for 0 displays]: [1, 0]
2020-11-16T15:59:30.255-07:00> LVL:1 RC: 0 IMG_FRONTEND :sw_host_get_display_modes: - warning - primary display not found
2020-11-16T15:59:30.255-07:00> LVL:0 RC: 0 IMG_FRONTEND :configure_displays: No displays reported, re-trying to get display modes, retries left: 2
2020-11-16T15:59:31.365-07:00> LVL:0 RC: 0 EXTERN :svga_devtap ==> svgadevtap: OnDisplayAdded for \\.\DISPLAY13

Reply
0 Kudos
jallis83
Contributor
Contributor
‎04-21-2021 06:10 AM

Did anyone solve this problem?

 

Reply
0 Kudos
SurajRoy
Enthusiast
Enthusiast
‎10-11-2021 07:11 AM

I come across this issue and below are my findings.

Refer to KB: https://kb.vmware.com/s/article/82276 

It is caused by windows 10 compatibility issue with WDDM driver provided by VMware tools 11.2.5

Resolution:

Upgrade VMware tools to 11.2.6 or higher

OR

Run Optional update as per KB and make sure the SVGA driver is 8.17.2.13 or higher

Reply
0 Kudos