search

acidanthera / bugtracker

Acidanthera Bugtracker
385 stars 45 forks source link

Sidecar not working with iMacPro1,1 on machines without iGPU #589

Closed hehongbo closed 4 years ago

hehongbo commented 4 years ago

Dear team,

I'm using OpenCore 0.5.2 on an i7-9700F machine (without iGPU) with SMBios set to iMacPro1,1. Continuity functions like AirDrop and Handoff work immediately after I plugged in a BCM94360CS2 AirPort card, except Sidecar. It doesn't work on both Wi-Fi and USB.

When I start Sidecar on Preference pane or status bar,

  1. Screen flashes and a screen is added in display preferences
  2. iPad shows a "Connecting" and then keeps showing black screen forever. The "Connecting" prompt stays a little longer than connects from a real Mac, however.
  3. Screen widgets like Sidebar and virtual TouchBar also not appear as expected.
  4. When I tap my iPad screen with Apple Pencil, the cursor on my main screen disappears. It seems even video streaming is broken, stylus function is still working and moved my cursor to Sidecar screen.
  5. Both USB and Wi-Fi not working. Also, the "Switching to USB" prompt is gone. That should appear when I connect to USB while using Sidecar on Wi-Fi.

Here's information about my environments:

And here're some logs I think related to Sidecar (a connect and a disconnect operation over last 5 minutes):

% log show --predicate '(logType="error"||logType="fault")&&process="SidecarDisplayAgent"' --last 5m
Filtering the log data using "(logType == 16 OR logType == 17) AND process == "SidecarDisplayAgent""
Skipping info and debug messages, pass --info and/or --debug to include.
Timestamp                       Thread     Type        Activity             PID    TTL
2019-11-30 18:39:50.157714+0800 0x7b5c     Error       0x0                  951    0    SidecarDisplayAgent: [com.apple.sidecar:display] AVC[1cb9f9b4] RTCP Timeout
2019-11-30 18:39:50.159112+0800 0x4ef7     Error       0x0                  951    0    SidecarDisplayAgent: [com.apple.sidecar:display] === Sidecar Error SidecarErrorDomain (-401) === <private>
2019-11-30 18:39:50.206425+0800 0x5aa5     Error       0x0                  951    0    SidecarDisplayAgent: (IOKit) [com.apple.iohid:default] HIDVS (id:7ffd2360c3500006) does not exist
2019-11-30 18:39:50.206462+0800 0x5aa5     Error       0x0                  951    0    SidecarDisplayAgent: (IOKit) [com.apple.iohid:default] HIDVS (id:7ffd2360c3500006) does not exist
2019-11-30 18:39:58.516864+0800 0x5aa5     Error       0x0                  951    0    SidecarDisplayAgent: [com.apple.sidecar:display] AVC[1cb9f9b5] RTCP Timeout
2019-11-30 18:39:58.517156+0800 0x4ef7     Error       0x0                  951    0    SidecarDisplayAgent: [com.apple.sidecar:display] === Sidecar Error SidecarErrorDomain (-401) === <private>
2019-11-30 18:39:58.550143+0800 0x7b5c     Error       0x0                  951    0    SidecarDisplayAgent: (IOKit) [com.apple.iohid:default] HIDVS (id:7ffd2360c3500007) does not exist
2019-11-30 18:39:58.550170+0800 0x7b5c     Error       0x0                  951    0    SidecarDisplayAgent: (IOKit) [com.apple.iohid:default] HIDVS (id:7ffd2360c3500007) does not exist
2019-11-30 18:40:04.029548+0800 0x7d15     Error       0xe5b0               951    0    SidecarDisplayAgent: (IOKit) [com.apple.iohid:default] HIDVS (id:7ffd2360c3500008) does not exist
2019-11-30 18:40:04.030014+0800 0x7d15     Error       0xe5b0               951    0    SidecarDisplayAgent: (IOKit) [com.apple.iohid:default] HIDVS (id:7ffd2360c3500008) does not exist
--------------------------------------------------------------------------------------------------------------------
Log      - Default:          0, Info:                0, Debug:             0, Error:         10, Fault:          0
Activity - Create:           0, Transition:          0, Actions:           0
% log show --predicate '(logType="error"||logType="fault")&&process="SidecarRelay"' --last 5m
Filtering the log data using "(logType == 16 OR logType == 17) AND process == "SidecarRelay""
Skipping info and debug messages, pass --info and/or --debug to include.
Timestamp                       Thread     Type        Activity             PID    TTL
2019-11-30 18:39:42.030067+0800 0x7b65     Error       0x0                  556    0    SidecarRelay: (CoreUtils) [com.apple.rapport:RPStreamSession] ### nw_listener no endpoint
2019-11-30 18:39:50.471051+0800 0x7c52     Error       0x0                  556    0    SidecarRelay: (CoreUtils) [com.apple.rapport:RPStreamSession] ### nw_listener no endpoint
2019-11-30 18:39:58.868840+0800 0x7cb7     Error       0x0                  556    0    SidecarRelay: (CoreUtils) [com.apple.rapport:RPStreamSession] ### nw_listener no endpoint
--------------------------------------------------------------------------------------------------------------------
Log      - Default:          0, Info:                0, Debug:             0, Error:          3, Fault:          0
Activity - Create:           0, Transition:          0, Actions:           0
% log show --predicate '(logType="error"||logType="fault")&&process="avconferenced"' --last 5m
Filtering the log data using "(logType == 16 OR logType == 17) AND process == "avconferenced""
Skipping info and debug messages, pass --info and/or --debug to include.
Timestamp                       Thread     Type        Activity             PID    TTL
2019-11-30 18:39:42.143931+0800 0x7b63     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] nw_channel_set_path_flow_registration Node not found for flow id A2881860-C961-4003-8481-47DEB3F64242
2019-11-30 18:39:42.144004+0800 0x7b63     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] nw_protocol_udp_connected [C7:1] udp->udp_stats is NULL setting to global 0x7fff98bc59a0
2019-11-30 18:39:42.147399+0800 0x7b64     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] +[VideoUtil getBestCaptureSizeForEncodingSize:]:1239 Cannot find capture size for 2032x1620
2019-11-30 18:39:42.147543+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) flushMessagesWithCompletion: Failed to get remote object proxy: <private>
2019-11-30 18:39:42.147614+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) fetchReportingStatesWithUserInfo: Failed to get remote object proxy: <private>
2019-11-30 18:39:42.147634+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace] VCVideoStream [ERROR] -[VCVideoStream setupReportingAgent]_block_invoke:1150 (0x7fdecba18660) RTCReporting: can't configure the reporting agent.
2019-11-30 18:39:42.147744+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) fetchReportingStatesWithUserInfo: Failed to get remote object proxy: <private>
2019-11-30 18:39:42.147804+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace] VCVideoStream [ERROR] -[VCVideoStream setupReportingAgent]_block_invoke:1150 (0x7fdecba18660) RTCReporting: can't configure the reporting agent.
2019-11-30 18:39:42.147866+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) startConfigurationWithCompletionHandler: Failed to get remote object proxy: <private>
2019-11-30 18:39:42.147903+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) startConfigurationWithCompletionHandler: Failed to get remote object proxy: <private>
2019-11-30 18:39:42.147965+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:39:42.149619+0800 0x7b64     Error       0x0                  820    0    avconferenced: (VideoProcessing) No bridgeOS device available
2019-11-30 18:39:42.149818+0800 0x7b64     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] EncCreateHandle:573 /BuildRoot/Library/Caches/com.apple.xbs/Sources/AVConference/AVConference-1624.20.4.1/AVConference.subproj/Sources/Others/VCVideoEncoder_VCP.c:573: VCPCompressionSessionCreate -18
2019-11-30 18:39:42.149838+0800 0x7b64     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VideoTransmitter_CreateHandle:1107 VideoTransmitter_CreateHandle: EncCreateHandle FAILED 2032x1620 result: -1610088430
2019-11-30 18:39:42.157967+0800 0x7bc8     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:39:46.193823+0800 0x7b63     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:39:50.157304+0800 0x4db2     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace] VCMediaStream [ERROR] -[VCMediaStream checkRTCPPacketTimeoutAgainstTime:lastReceivedPacketTime:]:1263 Last RTCP packet receive time:nan now:2188.622458
2019-11-30 18:39:50.158509+0800 0x7c4e     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VCNWConnectionMonitor_SetNotificationHandler_block_invoke:49 NWConnection notification returns error 89
2019-11-30 18:39:50.158830+0800 0x7c4e     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VCNWConnectionMonitor_SetPacketEventHandler_block_invoke:73 NWConnection packet event returns error 89
2019-11-30 18:39:50.159090+0800 0x7c4c     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:39:50.159584+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] _VTP_ScheduleReceiveForNWConnection_block_invoke:4765 NWConnection failed to receive data with error 89
2019-11-30 18:39:50.160312+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:50.160314+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C7 IPv6#ab1a5800.56455 udp, pid: 556, interface: llw0, local: IPv6#da601571.58495, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:50.160349+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C7 IPv6#ab1a5800.56455 udp, pid: 556, interface: llw0, local: IPv6#da601571.58495, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:50.160383+0800 0x7c4c     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:39:50.160421+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C7 IPv6#ab1a5800.56455 udp, pid: 556, interface: llw0, local: IPv6#da601571.58495, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:50.160508+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C7 IPv6#ab1a5800.56455 udp, pid: 556, interface: llw0, local: IPv6#da601571.58495, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:50.160604+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C7 IPv6#ab1a5800.56455 udp, pid: 556, interface: llw0, local: IPv6#da601571.58495, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:50.160684+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C7 IPv6#ab1a5800.56455 udp, pid: 556, interface: llw0, local: IPv6#da601571.58495, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:50.160722+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:50.160738+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C7 IPv6#ab1a5800.56455 udp, pid: 556, interface: llw0, local: IPv6#da601571.58495, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:50.160800+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C7 IPv6#ab1a5800.56455 udp, pid: 556, interface: llw0, local: IPv6#da601571.58495, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:50.161113+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:50.161155+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:50.161214+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:50.161271+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:50.161327+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:50.161474+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:50.201783+0800 0x4db2     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] +[LogDumpUtility filesSortedByTimestamp:]:327 failed to read directory /Users/hehongbo/Library/Caches/com.apple.VideoConference/logs/ (The folder “logs” doesn’t exist.)
2019-11-30 18:39:50.503393+0800 0x4db2     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] nw_channel_set_path_flow_registration Node not found for flow id 506A3779-081E-4B03-9787-6670E8D19167
2019-11-30 18:39:50.503467+0800 0x4db2     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] nw_protocol_udp_connected [C8:1] udp->udp_stats is NULL setting to global 0x7fff98bc59a0
2019-11-30 18:39:50.508864+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] +[VideoUtil getBestCaptureSizeForEncodingSize:]:1239 Cannot find capture size for 2032x1620
2019-11-30 18:39:50.509421+0800 0x7c4c     Error       0x0                  820    0    avconferenced: (RTCReporting) startConfigurationWithCompletionHandler: Failed to get remote object proxy: <private>
2019-11-30 18:39:50.509518+0800 0x7c4c     Error       0x0                  820    0    avconferenced: (RTCReporting) startConfigurationWithCompletionHandler: Failed to get remote object proxy: <private>
2019-11-30 18:39:50.509794+0800 0x7c4c     Error       0x0                  820    0    avconferenced: (RTCReporting) flushMessagesWithCompletion: Failed to get remote object proxy: <private>
2019-11-30 18:39:50.509844+0800 0x7c4c     Error       0x0                  820    0    avconferenced: (RTCReporting) fetchReportingStatesWithUserInfo: Failed to get remote object proxy: <private>
2019-11-30 18:39:50.509867+0800 0x7c4c     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace] VCVideoStream [ERROR] -[VCVideoStream setupReportingAgent]_block_invoke:1150 (0x7fdec9417580) RTCReporting: can't configure the reporting agent.
2019-11-30 18:39:50.509904+0800 0x7c4c     Error       0x0                  820    0    avconferenced: (RTCReporting) fetchReportingStatesWithUserInfo: Failed to get remote object proxy: <private>
2019-11-30 18:39:50.509924+0800 0x7c4c     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace] VCVideoStream [ERROR] -[VCVideoStream setupReportingAgent]_block_invoke:1150 (0x7fdec9417580) RTCReporting: can't configure the reporting agent.
2019-11-30 18:39:50.510206+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:39:50.511957+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (VideoProcessing) No bridgeOS device available
2019-11-30 18:39:50.512349+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] EncCreateHandle:573 /BuildRoot/Library/Caches/com.apple.xbs/Sources/AVConference/AVConference-1624.20.4.1/AVConference.subproj/Sources/Others/VCVideoEncoder_VCP.c:573: VCPCompressionSessionCreate -18
2019-11-30 18:39:50.512372+0800 0x7c4d     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VideoTransmitter_CreateHandle:1107 VideoTransmitter_CreateHandle: EncCreateHandle FAILED 2032x1620 result: -1610088430
2019-11-30 18:39:50.516711+0800 0x7c4c     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:39:54.526026+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:39:58.516718+0800 0x7c4c     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace] VCMediaStream [ERROR] -[VCMediaStream checkRTCPPacketTimeoutAgainstTime:lastReceivedPacketTime:]:1263 Last RTCP packet receive time:nan now:2196.981967
2019-11-30 18:39:58.517321+0800 0x7b63     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VCNWConnectionMonitor_SetNotificationHandler_block_invoke:49 NWConnection notification returns error 89
2019-11-30 18:39:58.518385+0800 0x7b63     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VCNWConnectionMonitor_SetPacketEventHandler_block_invoke:73 NWConnection packet event returns error 89
2019-11-30 18:39:58.518420+0800 0x7cb1     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] _VTP_ScheduleReceiveForNWConnection_block_invoke:4765 NWConnection failed to receive data with error 89
2019-11-30 18:39:58.518789+0800 0x7cb2     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:39:58.519131+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:58.519132+0800 0x7cb2     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C8 IPv6#1826659d.62127 udp, pid: 556, interface: llw0, local: IPv6#e419d525.62317, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:58.519189+0800 0x7cb2     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C8 IPv6#1826659d.62127 udp, pid: 556, interface: llw0, local: IPv6#e419d525.62317, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:58.519211+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:58.519258+0800 0x7cb2     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C8 IPv6#1826659d.62127 udp, pid: 556, interface: llw0, local: IPv6#e419d525.62317, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:58.519353+0800 0x7cb2     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C8 IPv6#1826659d.62127 udp, pid: 556, interface: llw0, local: IPv6#e419d525.62317, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:58.519458+0800 0x7cb2     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C8 IPv6#1826659d.62127 udp, pid: 556, interface: llw0, local: IPv6#e419d525.62317, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:58.519493+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:58.519555+0800 0x7cb2     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C8 IPv6#1826659d.62127 udp, pid: 556, interface: llw0, local: IPv6#e419d525.62317, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:58.519616+0800 0x7cb2     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C8 IPv6#1826659d.62127 udp, pid: 556, interface: llw0, local: IPv6#e419d525.62317, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:58.519685+0800 0x7cb2     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C8 IPv6#1826659d.62127 udp, pid: 556, interface: llw0, local: IPv6#e419d525.62317, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:39:58.519728+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:58.519918+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:58.520022+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:58.520154+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:58.520269+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:39:58.524001+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:39:58.524474+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] +[LogDumpUtility filesSortedByTimestamp:]:327 failed to read directory /Users/hehongbo/Library/Caches/com.apple.VideoConference/logs/ (The folder “logs” doesn’t exist.)
2019-11-30 18:39:58.951051+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] nw_channel_set_path_flow_registration Node not found for flow id 5D7C3808-7C27-4482-8355-68420865827E
2019-11-30 18:39:58.951137+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] nw_protocol_udp_connected [C9:1] udp->udp_stats is NULL setting to global 0x7fff98bc59a0
2019-11-30 18:39:58.955707+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] +[VideoUtil getBestCaptureSizeForEncodingSize:]:1239 Cannot find capture size for 2032x1620
2019-11-30 18:39:58.956395+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:39:58.956481+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) flushMessagesWithCompletion: Failed to get remote object proxy: <private>
2019-11-30 18:39:58.956535+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) fetchReportingStatesWithUserInfo: Failed to get remote object proxy: <private>
2019-11-30 18:39:58.956561+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace] VCVideoStream [ERROR] -[VCVideoStream setupReportingAgent]_block_invoke:1150 (0x7fdec9626e70) RTCReporting: can't configure the reporting agent.
2019-11-30 18:39:58.956597+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) fetchReportingStatesWithUserInfo: Failed to get remote object proxy: <private>
2019-11-30 18:39:58.956614+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace] VCVideoStream [ERROR] -[VCVideoStream setupReportingAgent]_block_invoke:1150 (0x7fdec9626e70) RTCReporting: can't configure the reporting agent.
2019-11-30 18:39:58.956673+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) startConfigurationWithCompletionHandler: Failed to get remote object proxy: <private>
2019-11-30 18:39:58.956713+0800 0x7bbf     Error       0x0                  820    0    avconferenced: (RTCReporting) startConfigurationWithCompletionHandler: Failed to get remote object proxy: <private>
2019-11-30 18:39:58.958229+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (VideoProcessing) No bridgeOS device available
2019-11-30 18:39:58.958455+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] EncCreateHandle:573 /BuildRoot/Library/Caches/com.apple.xbs/Sources/AVConference/AVConference-1624.20.4.1/AVConference.subproj/Sources/Others/VCVideoEncoder_VCP.c:573: VCPCompressionSessionCreate -18
2019-11-30 18:39:58.958477+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VideoTransmitter_CreateHandle:1107 VideoTransmitter_CreateHandle: EncCreateHandle FAILED 2032x1620 result: -1610088430
2019-11-30 18:39:58.962584+0800 0x7cb2     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:40:03.009727+0800 0x7cb1     Error       0x0                  820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:40:04.027724+0800 0x7d13     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VCNWConnectionMonitor_SetNotificationHandler_block_invoke:49 NWConnection notification returns error 89
2019-11-30 18:40:04.027930+0800 0x7d13     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VCNWConnectionMonitor_SetPacketEventHandler_block_invoke:73 NWConnection packet event returns error 89
2019-11-30 18:40:04.028623+0800 0x7d12     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] _VTP_ScheduleReceiveForNWConnection_block_invoke:4765 NWConnection failed to receive data with error 89
2019-11-30 18:40:04.028920+0800 0x7b63     Error       0xe5b0               820    0    avconferenced: (RTCReporting) sendMessageWithDictionary: Failed to get remote object proxy: <private>
2019-11-30 18:40:04.029170+0800 0x7d13     Error       0xe5b0               820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C9 IPv6#1db58279.54290 udp, pid: 556, interface: llw0, local: IPv6#58493e59.49765, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:40:04.029188+0800 0x7d12     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:40:04.029230+0800 0x7d13     Error       0xe5b0               820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C9 IPv6#1db58279.54290 udp, pid: 556, interface: llw0, local: IPv6#58493e59.49765, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:40:04.029290+0800 0x7d13     Error       0xe5b0               820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C9 IPv6#1db58279.54290 udp, pid: 556, interface: llw0, local: IPv6#58493e59.49765, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:40:04.029300+0800 0x7d12     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:40:04.029363+0800 0x7d13     Error       0xe5b0               820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C9 IPv6#1db58279.54290 udp, pid: 556, interface: llw0, local: IPv6#58493e59.49765, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:40:04.029433+0800 0x7d13     Error       0xe5b0               820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C9 IPv6#1db58279.54290 udp, pid: 556, interface: llw0, local: IPv6#58493e59.49765, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:40:04.029489+0800 0x7d13     Error       0xe5b0               820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C9 IPv6#1db58279.54290 udp, pid: 556, interface: llw0, local: IPv6#58493e59.49765, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:40:04.029526+0800 0x7d12     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:40:04.029550+0800 0x7d13     Error       0xe5b0               820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C9 IPv6#1db58279.54290 udp, pid: 556, interface: llw0, local: IPv6#58493e59.49765, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:40:04.029627+0800 0x7d13     Error       0xe5b0               820    0    avconferenced: (libnetwork.dylib) [com.apple.network:] [C9 IPv6#1db58279.54290 udp, pid: 556, interface: llw0, local: IPv6#58493e59.49765, indefinite] is already cancelled, ignoring cancel
2019-11-30 18:40:04.030075+0800 0x7d12     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:40:04.030223+0800 0x7d12     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:40:04.030244+0800 0x7d12     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:40:04.030393+0800 0x7d12     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:40:04.030413+0800 0x7d12     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] VTP_Close:1657 VTP_Close failed due to invalid handle.
2019-11-30 18:40:04.058446+0800 0x7c4f     Error       0xe5b0               820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace]  [ERROR] +[LogDumpUtility filesSortedByTimestamp:]:327 failed to read directory /Users/hehongbo/Library/Caches/com.apple.VideoConference/logs/ (The folder “logs” doesn’t exist.)
2019-11-30 18:40:05.029625+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace] AVConferenceXPCServer [ERROR] -[AVConferenceXPCServer(XPCManagement) _xpc_handle_incoming_request:]_block_invoke:861 VCXPCServer: XPC Error, Connection invalid
2019-11-30 18:40:05.029929+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace] AVConferenceXPCServer [ERROR] -[AVConferenceXPCServer(XPCManagement) _xpc_handle_incoming_request:]_block_invoke:861 VCXPCServer: XPC Error, Connection invalid
2019-11-30 18:40:05.030156+0800 0x7c4f     Error       0x0                  820    0    avconferenced: (AVConference) [com.apple.AVConference:ViceroyTrace] AVConferenceXPCServer [ERROR] -[AVConferenceXPCServer(XPCManagement) _xpc_handle_incoming_request:]_block_invoke:861 VCXPCServer: XPC Error, Connection invalid
--------------------------------------------------------------------------------------------------------------------
Log      - Default:          0, Info:                0, Debug:             0, Error:        118, Fault:          0
Activity - Create:           0, Transition:          0, Actions:           0

Full output:

avconferenced_full.log

SidecarDisplayAgent_full.log

SidecarRelay_full.log

On the iPad side, it spits the following through the USB debug console:

error    19:02:00.033472+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:00.033494+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:00.033668+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:00.043045+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:00.043737+0800    ContinuityDisplay     => Retrying... (0/5) retries
error    19:02:00.062745+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:00.062891+0800    ContinuityDisplay     => Retrying... (1/5) retries
error    19:02:02.107721+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:02.108467+0800    ContinuityDisplay     => Retrying... (2/5) retries
error    19:02:06.533370+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:06.543350+0800    ContinuityDisplay     => Retrying... (3/5) retries
error    19:02:08.162720+0800    ContinuityDisplay    === Session Interrupted (Presenting Alert) === SidecarErrorDomain (-401) <private>
error    19:02:08.206243+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:08.206293+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:08.206387+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:13.004172+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:13.005354+0800    ContinuityDisplay     => Retrying... (4/5) retries
error    19:02:16.419686+0800    ContinuityDisplay    === Session Interrupted (Updating Alert) === SidecarErrorDomain (-401) <private>
error    19:02:16.508725+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:16.508848+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:16.508984+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:21.792318+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:21.798865+0800    ContinuityDisplay    Bag loading failed! Error (__kIMRemoteURLConnectionErrorDomain:-1): <private> (null)
error    19:02:24.730671+0800    ContinuityDisplay    === Session Interrupted (Updating Alert) === SidecarErrorDomain (-401) <private>
error    19:02:24.824640+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:24.824726+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:24.824805+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:24.826272+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:24.826442+0800    ContinuityDisplay     => Retrying... (0/5) retries
error    19:02:24.828830+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:24.828948+0800    ContinuityDisplay     => Retrying... (1/5) retries
error    19:02:26.996872+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:26.997337+0800    ContinuityDisplay     => Retrying... (2/5) retries
error    19:02:31.377646+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:31.379003+0800    ContinuityDisplay     => Retrying... (3/5) retries
error    19:02:33.026556+0800    ContinuityDisplay    === Session Interrupted (Updating Alert) === SidecarErrorDomain (-401) <private>
error    19:02:33.261079+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:33.261352+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:33.261403+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:37.436332+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:37.436892+0800    ContinuityDisplay     => Retrying... (4/5) retries
error    19:02:41.365202+0800    ContinuityDisplay    === Session Interrupted (Updating Alert) === SidecarErrorDomain (-401) <private>
error    19:02:41.634201+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:41.634303+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:41.634399+0800    ContinuityDisplay     [ERROR] rangeCheck:149 VCBitrateArbiter: value 0 failed bitrate range check, ignored
error    19:02:45.757359+0800    ContinuityDisplay    Remote loader crashed for request: <private>
error    19:02:45.760198+0800    ContinuityDisplay    Bag loading failed! Error (__kIMRemoteURLConnectionErrorDomain:-1): <private> (null)
error    19:02:49.705965+0800    ContinuityDisplay    === Session Interrupted (Updating Alert) === SidecarErrorDomain (-401) <private>

Besides, while Sidecar was not working, AirPlay does work (I tested with AirReceiver) and streams the video pretty smoothly with no output from avconferenced.

I think maybe AVC hardware encoding is broken on my system. But given the fact that a real iMac Pro also has no iGPU, I have no idea what's the cause of this problem.

Any help is appreciated.

vit9696 commented 4 years ago

Hi, your problem is likely in RX 460. For some reason it may not be supported or may have been broken driver-wise. You are best to report that to Apple, as this is out of our scope. Thanks for being extra detailed though.