New EX60 Call dropping

[julienf28]

Trying to  conect an EX 60 to an EX90 for a video call but it drops after just one ring if you pickup.

We are going through a VCS

Some log files attached:

Dec 19 12:22:53 (none) main: 830.10 MC I: MediaServerAction(): InputGate(ig=54) creation took 313 miliseconds Dec 19 12:22:53 (none) main: 830.11 RTP I: TrafficCtrl: Added new entry (duo): id: 28, tcid: 65568 Dec 19 12:22:53 (none) main: 830.13 MC I: CallParticipantImpl: calledUri: h323:89202 Dec 19 12:22:53 (none) main: 830.13 H323Call I: h323_call::makeOutgoingCall(p=5): Sending call request to stack (rate=768000 srcName='', src uri='h323:OTTPVD1' src e164='89201' dest='89202') Dec 19 12:22:53 (none) main: 830.14 MC I: RemoteParticipant::proposeMode(p=5, ch=1): Did not find mixer ((nil)) or channel (0x49e53c9c) Dec 19 12:22:53 (none) main: 830.14 MC I: RemoteParticipant::propose60fpsThreshold(p=5, ch=1): Did not find mixer ((nil)) or channel (0x49e53c9c) Dec 19 12:22:53 (none) main: 830.14 MC I: RemoteParticipant::reevalRefMode(p=5,ch=1) set ref [Audio (1): G.711a  64k ] q= auto, t60=6000 Dec 19 12:22:53 (none) main: 830.15 MC I: RemoteParticipant::reevalRefMode(p=5,ch=2) set ref [Video (2): vid-off 0x0@0.0  0k ] q= auto, t60=6000 Dec 19 12:22:53 (none) main: 830.15 MC I: RemoteParticipant::reevalRefMode(p=5,ch=3) set ref [Video (3): vid-off 0x0@0.0  0k ] q= auto, t60=6000 Dec 19 12:22:53 (none) main: 830.15 MC I: RemoteParticipant::proposeMode(p=5, ch=4): Did not find mixer ((nil)) or channel (0x49e75b2c) Dec 19 12:22:53 (none) main: 830.15 MC I: RemoteParticipant::propose60fpsThreshold(p=5, ch=4): Did not find mixer ((nil)) or channel (0x49e75b2c) Dec 19 12:22:53 (none) main: 830.15 MC I: RemoteParticipant::reevalRefMode(p=5,ch=4) set ref [Data (4): H.224-HDLC  64k ] q= auto, t60=6000 Dec 19 12:22:53 (none) main: 830.15 MC I: MediaServerAction(): InputGate(ig=57) creation took 361 miliseconds Dec 19 12:22:53 (none) main: 830.42 H323Call I: h323_call_handler::handleH323AlertInd(p=5, s=1): Incoming call alert indication Dec 19 12:22:53 (none) main: 830.47 MediaStreamController I: SC::PlayReq(og=11) path='/sounds/', tone=2 Dec 19 12:22:53 (none) main: 830.65 H323Call I: h323_call_handler::handleH323CapsetInd(p=5, s=1) Received new capset Dec 19 12:22:53 (none) main: 830.65 MC I: RemoteParticipant::setRRRate(p=5): Received new remote rate from protocol: 0 (old: -1) Dec 19 12:22:53 (none) main: 830.66 MC I: RemoteParticipant::modeChanged(p=5, ch=1): ModesController wants to run mode: Audio (1): aud-off  0k  Dec 19 12:22:53 (none) main: 830.66 MC I: RemoteParticipant::modeChanged(p=5, ch=2): ModesController wants to run mode: Video (2): vid-off 0x0@0.0  0k  Dec 19 12:22:53 (none) main: 830.67 MC I: RemoteParticipant::modeChanged(p=5, ch=3): ModesController wants to run mode: Video (3): vid-off 0x0@0.0  0k  Dec 19 12:22:53 (none) main: 830.67 MC I: Conference::calcCommonRate(c=4,ch=3) rate=0 Dec 19 12:22:53 (none) main: 830.67 MC I: RemoteParticipant::modeChanged(p=5, ch=4): ModesController wants to run mode: Data (4): data-off  0k  Dec 19 12:22:53 (none) main: 830.67 MC I: RemoteParticipant::setRRCap(p=5): Received new remote capset from protocol: Capability table: Dec 19 12:22:53 (none) main: 830.68 MC I: Conference::updateCommonCapSet(c=4)  Dec 19 12:22:53 (none) main: 830.69 MC I: RemoteParticipant::modeChanged(p=5, ch=1): ModesController wants to run mode: Audio (1): G.722  64k  Dec 19 12:22:53 (none) main: 830.69 MC I: RemoteParticipant::modeChanged(p=5, ch=4): ModesController wants to run mode: Data (4): H.224-HDLC  64k  Dec 19 12:22:53 (none) main: 830.70 H323Call I: h323_call::sendOutgoingModesToStack(p=5): Modes sent to stack: audio: G.722, video: vid-off, duo: vid-off, data: H.224-HDLC Dec 19 12:22:53 (none) main: 830.73 H323Call I: h323_call_handler::handleH323CallCnf(p=5, s=1) Incoming call confirm rate=7680 lang='en' dest=[h323Id='MeetMeAuto2' e164='89202' ] Dec 19 12:22:53 (none) main: 830.73 MC I: RemoteParticipant::setRRRate(p=5): Received new remote rate from protocol: 768000 (old: 0) Dec 19 12:22:53 (none) main: 830.73 H323Call I: h323_call::sendOutgoingModesToStack(p=5): Modes sent to stack: audio: G.722, video: vid-off, duo: vid-off, data: H.224-HDLC Dec 19 12:22:53 (none) main: 830.73 MC I: setCallState(p=5) InCall Dec 19 12:22:53 (none) main: 830.74 H323Call I: h323_call_handler::handleH323TpeStringAvailableInd(p=5, s=1) Tpe string available indication Dec 19 12:22:53 (none) main: 830.90 MC I: RemoteInputGateImpl::setIncomingModeReport(ig=51,p=5) [Audio (1): aud-off stereo  0k ] Dec 19 12:22:53 (none) main: 830.94 RTP I: readBYE(): received bye for session w/SSRC 3957634190 Dec 19 12:22:53 (none) main: 830.94 RTP !ER readBYE(): invalid SSRC found 0/3100380213 received 3957634190 Dec 19 12:22:53 (none) main: 830.94 RTP !ER decodeRtcpPacket::readBYE(sid=0) error validating RTCP packet Dec 19 12:22:53 (none) main: 830.97 H323Call I: h323_call_handler::handleH323RtpOpenSessionReq(p=5, s=1) Open outgoing media session (OLC/OLC-ACK, h233.chanid: 1: MC channel: 1) Dec 19 12:22:53 (none) main: 830.97 H323Call I: h323_call_handler::handleH323RtpEncryptionKeyInd(p=5, s=1) Received encryption key (channel: 1, h323.type: 1) Dec 19 12:22:53 (none) main: 830.98 MC I: configureOutgoingChannel(p=5, ch=1): Configuring mode : Audio (1): G.722  0k PT(103)  (modescontroller says real is: Audio (1): G.722  64k ) Dec 19 12:22:53 (none) main: 830.99 RTP I: Flux Start FEC Decoder sess: 0 Dec 19 12:22:53 (none) main: 831.00 MC I: RemoteParticipant::reevalRefMode(p=5,ch=2) set ref [Video (2): vid-raw 1920x1080@30.0  0k ] q= motion, t60=921600 Dec 19 12:22:53 (none) main: 831.01 MC I: RemoteParticipant::modeChanged(p=5, ch=2): ModesController wants to run mode: Video (2): H.264 512x288@30.0 17500mbps 17500smbps  704k  Dec 19 12:22:53 (none) main: 831.01 H323Call I: h323_call::sendOutgoingModesToStack(p=5): Modes sent to stack: audio: G.722, video: H.264, duo: vid-off, data: H.224-HDLC Dec 19 12:22:53 (none) main: 831.04 RTP I: Rtp_Ready_doRTPSourceMuteReq(app=0,strm=18) source unmuted Dec 19 12:22:53 (none) main: 831.04 H323Call I: h323_call::configureOutgoingChannelCnf(p=5) Outgoing media is set up for channel 1, sending confirm on open back to stack Dec 19 12:22:53 (none) main: 831.05 H323Call I: h323_call::configureOutgoingChannelCnf(p=5) Sending mic mute indication on startup (channel: 1, type: 1) Dec 19 12:22:53 (none) main: 831.05 H323Call I: h323_call_handler::handleH323RtpCloseSessionReq(p=5, s=1) Close outgoing media session (CLC/CLC-ACK, channel: 1) Dec 19 12:22:53 (none) main: 831.05 MC I: configureOutgoingChannel(p=5, ch=1): Configuring mode : iX (1): undefined  0k  (modescontroller says real is: Audio (1): aud-off  0k ) Dec 19 12:22:53 (none) main: 831.06 RTP I: Rtp_Ready_doRTPSourceMuteReq(app=0,strm=18) source unmuted Dec 19 12:22:53 (none) main: 831.06 RTP I: Rtp_Ready_doRTPSourceMuteReq(app=0,strm=18) source unmuted Dec 19 12:22:54 (none) main: 831.13 H323Call I: h323_call_handler::handleDiscInd(p=5, s=1) Received disconnect indication (Cause: 2:16, h323 cause: 16:0)- RemoteDisconnect Q850 Dec 19 12:22:54 (none) main: 831.13 MC I: RemoteParticipant::reevalRefMode(p=5,ch=2) set ref [Video (2): vid-off 0x0@0.0  0k ] q= auto, t60=6000 Dec 19 12:22:54 (none) main: 831.14 ModesController I: ModesController::resetRateLimit(ch=2) Dec 19 12:22:54 (none) main: 831.14 MC I: RemoteParticipant::modeChanged(p=5, ch=2): ModesController wants to run mode: Video (2): vid-off 0x0@0.0  0k  Dec 19 12:22:54 (none) main: 831.14 H323Call I: h323_call::sendOutgoingModesToStack(p=5): Modes sent to stack: audio: G.722, video: vid-off, duo: vid-off, data: H.224-HDLC Dec 19 12:22:54 (none) main: 831.19 H323Call I: h323_call::affirmIncomingDisconnect(p=5): Incoming disconnect affirmed Dec 19 12:22:54 (none) main: 831.24 MC W: RemoteParticipant::disconnectTokenParticipant(p=5) No call Dec 19 12:22:54 (none) main: 831.25 MC I: Conference::updateCommonCapSet(c=4)  Dec 19 12:22:54 (none) main: 831.25 IXUser I: iXController teardownIxChannel: Not connected Dec 19 12:22:54 (none) main: 831.26 MC I: CapabilityControllerImpl::setCapset() reduced = 0, waitForDuoGate = 1, hasLegacyVideo = 0 Dec 19 12:22:54 (none) main: 831.28 RTP I: TrafficCtrl: Deleting entry (main): id: 26, tcid: 65568 Dec 19 12:22:54 (none) main: 831.29 RTP I: TrafficCtrl: Deleting entry (duo): id: 28, tcid: 65568 Dec 19 12:22:54 (none) main: 831.29 CAMERA I: CamVisca::Ready_doCAMActionReq cameraId=1 actionId=20 Dec 19 12:22:54 (none) main: 831.30 MediaStreamController I: MV::getVCSetting getOutputPortStatus initialized 1 Dec 19 12:22:54 (none) main: 831.30 MediaStreamController I: MV::getVCSetting localHwCookieHint_ 24 w 1920 h 1080 Dec 19 12:22:54 (none) main: 831.30 MediaStreamController I: MV::getVCSetting getOutputPortStatus initialized 0 Dec 19 12:22:54 (none) main: 831.30 MediaStreamController I: MV::getVCSetting localHwCookieHint_ 32 w 704 h 576 Dec 19 12:22:54 (none) main: 831.30 MediaStreamController I: doAUDIOMIXERREMGATECNF(ms-ig=6) not found Dec 19 12:22:54 (none) main: 831.31 DATACTRL I: DataGateRemReq(ig=4) Dec 19 12:22:54 (none) main: 831.39 MediaStreamController I: MV::getVCSetting getOutputPortStatus initialized 0 Dec 19 12:22:54 (none) main: 831.39 MediaStreamController I: MV::getVCSetting localHwCookieHint_ 32 w 704 h 576 Dec 19 12:22:54 (none) main: 831.41 VIDEOCTRL-0 I: (proxy,161) maximum number of framestorage slices 2 Dec 19 12:22:54 (none) main: 831.45 VIDEOCTRL-0 I: VIDEOCTRL_doReadyMixerConfigureReq: redundant signal for mixer (rawvideo,1) from (MSCtrl,0) Dec 19 12:22:54 (none) main: 831.45 VIDEOCTRL-0 I: VIDEOCTRL_doReadyMixerConfigureReq: redundant signal for mixer (rawvideo,2) from (MSCtrl,0) Dec 19 12:22:54 (none) main: 831.47 MC I: MediaServerAction(): InputGate(ig=61) creation took 198 miliseconds Dec 19 12:23:05 (none) main: 842.54 IXUser I: iXController(0x49e4e098) registerProtocolUser: proto=1, user=0x49e52b78 Dec 19 12:23:05 (none) main: 842.54 IXUser I: iXController(0x49e4e098) registerProtocolUser: proto=2, user=0x49e7efe8 Dec 19 12:23:05 (none) main: 842.62 MC I: Conference::addRemoteParticipant(p=6,ch=3) adding modecontrol shared channel Dec 19 12:23:05 (none) main: 842.63 MC I: Conference::modeChanged(c=5) holder=-1  Video (3): vid-off 0x0@0.0  0k  Dec 19 12:23:05 (none) main: 842.63 MC I: RemoteParticipant::outgoingDuoModeChanged(p=6, ch=3): ModesController wants to run mode: Video (3): vid-off 0x0@0.0  0k  Dec 19 12:23:05 (none) main: 842.64 CAMERA I: CamVisca::sendCAMPositionInd cameraId=1 pos=0/0/0/183 Dec 19 12:23:05 (none) main: 842.65 RTP I: SockPair::dynamic(sock=0) retrying next pair (rtp port=2358) Dec 19 12:23:05 (none) main: 842.65 RTP I: SockPair::dynamic(sock=1) retrying next pair (rtp port=2360) Dec 19 12:23:05 (none) main: 842.66 RTP I: SockPair::dynamic(sock=2) retrying next pair (rtp port=2362) Dec 19 12:23:05 (none) main: 842.66 RTP I: SockPair::dynamic(sock=3) retrying next pair (rtp port=2364) Dec 19 12:23:05 (none) main: 842.66 CAMERA I: CamVisca::Ready_doCAMActionReq cameraId=1 actionId=19 Dec 19 12:23:05 (none) main: 842.68 DATACTRL I: DataGateAddReq(ig=5) assoc gate -1 hdlc=yes Dec 19 12:23:05 (none) main: 842.90 MediaStreamController I: MV::getVCSetting getOutputPortStatus initialized 0 Dec 19 12:23:05 (none) main: 842.91 MediaStreamController I: MV::getVCSetting localHwCookieHint_ 32 w 704 h 576 Dec 19 12:23:05 (none) main: 842.93 MC I: MediaServerAction(): InputGate(ig=63) creation took 312 miliseconds Dec 19 12:23:05 (none) main: 842.95 MC I: MediaServerAction(): InputGate(ig=71) creation took 328 miliseconds Dec 19 12:23:06 (none) main: 843.12 RTP I: TrafficCtrl: Added new entry (main): id: 34, tcid: 65568 Dec 19 12:23:06 (none) main: 843.15 MC I: MediaServerAction(): InputGate(ig=66) creation took 536 miliseconds Dec 19 12:23:06 (none) main: 843.17 RTP I: TrafficCtrl: Added new entry (duo): id: 36, tcid: 65568 Dec 19 12:23:06 (none) main: 843.22 MC I: CallParticipantImpl: calledUri: h323:84002 Dec 19 12:23:06 (none) main: 843.23 H323Call I: h323_call::makeOutgoingCall(p=6): Sending call request to stack (rate=768000 srcName='', src uri='h323:OTTPVD1' src e164='89201' dest='84002') Dec 19 12:23:06 (none) main: 843.25 MC I: RemoteParticipant::proposeMode(p=6, ch=1): Did not find mixer ((nil)) or channel (0x49e76eec) Dec 19 12:23:06 (none) main: 843.25 MC I: RemoteParticipant::propose60fpsThreshold(p=6, ch=1): Did not find mixer ((nil)) or channel (0x49e76eec) Dec 19 12:23:06 (none) main: 843.25 MC I: RemoteParticipant::reevalRefMode(p=6,ch=1) set ref [Audio (1): G.711a  64k ] q= auto, t60=6000 Dec 19 12:23:06 (none) main: 843.25 MC I: RemoteParticipant::reevalRefMode(p=6,ch=2) set ref [Video (2): vid-off 0x0@0.0  0k ] q= auto, t60=6000 Dec 19 12:23:06 (none) main: 843.25 MC I: RemoteParticipant::reevalRefMode(p=6,ch=3) set ref [Video (3): vid-off 0x0@0.0  0k ] q= auto, t60=6000 Dec 19 12:23:06 (none) main: 843.25 MC I: RemoteParticipant::proposeMode(p=6, ch=4): Did not find mixer ((nil)) or channel (0x49e75b7c) Dec 19 12:23:06 (none) main: 843.25 MC I: RemoteParticipant::propose60fpsThreshold(p=6, ch=4): Did not find mixer ((nil)) or channel (0x49e75b7c) Dec 19 12:23:06 (none) main: 843.25 MC I: RemoteParticipant::reevalRefMode(p=6,ch=4) set ref [Data (4): H.224-HDLC  64k ] q= auto, t60=6000 Dec 19 12:23:06 (none) main: 843.25 MC I: MediaServerAction(): InputGate(ig=69) creation took 629 miliseconds Dec 19 12:23:06 (none) main: 843.59 H323Call I: h323_call_handler::handleH323AlertInd(p=6, s=1): Incoming call alert indication Dec 19 12:23:06 (none) main: 843.65 MediaStreamController I: SC::PlayReq(og=11) path='/sounds/', tone=2 Dec 19 12:23:06 (none) main: 843.86 MC I: RemoteInputGateImpl::setIncomingModeReport(ig=63,p=6) [Audio (1): aud-off stereo  0k ] Dec 19 12:23:12 (none) main: 849.48 H323Call I: h323_call::outgoingDisconnect(p=6): Sending outgoing disconnect (cause 16:71) Dec 19 12:23:12 (none) main: 849.49 H323Call I: h323_call_handler::handleDiscCnf(p=6, s=1) Received confirm on outgoing disconnect Dec 19 12:23:12 (none) main: 849.49 MC I: signalLocalReceiveCapsetChange, RemoteParticipant::signalLRCap Dec 19 12:23:12 (none) main: 849.49 H323Call I: h323_call::signalLocalReceiveCapsetChange(p=6): Sending new capset to stack (size=0) Dec 19 12:23:12 (none) main: 849.50 MC I: RemoteParticipant::setRRRate(p=6): Received new remote rate from protocol: 0 (old: -1) Dec 19 12:23:12 (none) main: 849.50 MC I: RemoteParticipant::modeChanged(p=6, ch=1): ModesController wants to run mode: Audio (1): aud-off  0k  Dec 19 12:23:12 (none) main: 849.50 MC I: RemoteParticipant::modeChanged(p=6, ch=2): ModesController wants to run mode: Video (2): vid-off 0x0@0.0  0k  Dec 19 12:23:12 (none) main: 849.51 MC I: RemoteParticipant::modeChanged(p=6, ch=3): ModesController wants to run mode: Video (3): vid-off 0x0@0.0  0k  Dec 19 12:23:12 (none) main: 849.51 MC I: Conference::calcCommonRate(c=5,ch=3) rate=0 Dec 19 12:23:12 (none) main: 849.51 MC I: RemoteParticipant::modeChanged(p=6, ch=4): ModesController wants to run mode: Data (4): data-off  0k  Dec 19 12:23:12 (none) main: 849.54 MC I: MediaController::remoteAffirmOutgoingDisconnect Dec 19 12:23:12 (none) main: 849.60 IXUser I: iXController teardownIxChannel: Not connected Dec 19 12:23:12 (none) main: 849.61 MC I: CapabilityControllerImpl::setCapset() reduced = 0, waitForDuoGate = 1, hasLegacyVideo = 0 Dec 19 12:23:12 (none) main: 849.63 MC !ER TransactionActionStorage::removeAction no match for Modify  InGate  id(66)  Dec 19 12:23:12 (none) main: 849.63 DATACTRL I: DataGateCfgReq(ig=5) hdlc=yes Dec 19 12:23:12 (none) main: 849.63 RTP I: TrafficCtrl: Deleting entry (main): id: 34, tcid: 65568 Dec 19 12:23:12 (none) main: 849.64 RTP I: TrafficCtrl: Deleting entry (duo): id: 36, tcid: 65568 Dec 19 12:23:12 (none) main: 849.65 CAMERA I: CamVisca::Ready_doCAMActionReq cameraId=1 actionId=20 Dec 19 12:23:12 (none) main: 849.65 MediaStreamController I: MV::getVCSetting getOutputPortStatus initialized 1 Dec 19 12:23:12 (none) main: 849.65 MediaStreamController I: MV::getVCSetting localHwCookieHint_ 24 w 1920 h 1080 Dec 19 12:23:12 (none) main: 849.66 MediaStreamController I: MV::getVCSetting getOutputPortStatus initialized 0 Dec 19 12:23:12 (none) main: 849.66 MediaStreamController I: MV::getVCSetting localHwCookieHint_ 32 w 704 h 576 Dec 19 12:23:12 (none) main: 849.66 MediaStreamController W: doAUDIOCFGGATECNF(ms-ig=7) not found Dec 19 12:23:12 (none) main: 849.66 MediaStreamController !ER doDATACFGGATECNF(ms-ig=5) not found Dec 19 12:23:12 (none) main: 849.66 DATACTRL I: DataGateRemReq(ig=5) Dec 19 12:23:12 (none) main: 849.77 MediaStreamController I: MV::getVCSetting getOutputPortStatus initialized 0 Dec 19 12:23:12 (none) main: 849.77 MediaStreamController I: MV::getVCSetting localHwCookieHint_ 32 w 704 h 576 Dec 19 12:23:12 (none) main: 849.81 VIDEOCTRL-0 I: (proxy,161) maximum number of framestorage slices 2 Dec 19 12:23:12 (none) main: 849.85 VIDEOCTRL-0 I: VIDEOCTRL_doReadyMixerConfigureReq: redundant signal for mixer (rawvideo,1) from (MSCtrl,0) Dec 19 12:23:12 (none) main: 849.85 VIDEOCTRL-0 I: VIDEOCTRL_doReadyMixerConfigureReq: redundant signal for mixer (rawvideo,2) from (MSCtrl,0) Dec 19 12:23:12 (none) main: 849.86 MC I: MediaServerAction(): InputGate(ig=73) creation took 248 miliseconds Dec 19 12:23:17 (none) main: 854.21 IXUser I: iXController(0x49e39bb8) registerProtocolUser: proto=1, user=0x49e76f38 Dec 19 12:23:17 (none) main: 854.21 IXUser I: iXController(0x49e39bb8) registerProtocolUser: proto=2, user=0x49e4bf70 Dec 19 12:23:17 (none) main: 854.26 MC I: Conference::addRemoteParticipant(p=7,ch=3) adding modecontrol shared channel Dec 19 12:23:17 (none) main: 854.26 MC I: Conference::modeChanged(c=6) holder=-1  Video (3): vid-off 0x0@0.0  0k  Dec 19 12:23:17 (none) main: 854.26 MC I: RemoteParticipant::outgoingDuoModeChanged(p=7, ch=3): ModesController wants to run mode: Video (3): vid-off 0x0@0.0  0k  Dec 19 12:23:17 (none) main: 854.27 RTP I: SockPair::dynamic(sock=0) retrying next pair (rtp port=2366) Dec 19 12:23:17 (none) main: 854.27 RTP I: SockPair::dynamic(sock=1) retrying next pair (rtp port=2368) Dec 19 12:23:17 (none) main: 854.27 RTP I: SockPair::dynamic(sock=2) retrying next pair (rtp port=2370) Dec 19 12:23:17 (none) main: 854.27 RTP I: SockPair::dynamic(sock=3) retrying next pair (rtp port=2372) Dec 19 12:23:17 (none) main: 854.28 CAMERA I: CamVisca::Ready_doCAMActionReq cameraId=1 actionId=19 Dec 19 12:23:17 (none) main: 854.28 DATACTRL I: DataGateAddReq(ig=6) assoc gate -1 hdlc=yes Dec 19 12:23:17 (none) main: 854.39 MC I: MediaServerAction(): InputGate(ig=75) creation took 138 miliseconds Dec 19 12:23:17 (none) main: 854.39 MC I: MediaServerAction(): InputGate(ig=83) creation took 139 miliseconds Dec 19 12:23:17 (none) main: 854.41 MediaStreamController I: MV::getVCSetting getOutputPortStatus initialized 0 Dec 19 12:23:17 (none) main: 854.41 MediaStreamController I: MV::getVCSetting localHwCookieHint_ 32 w 704 h 576 Dec 19 12:23:17 (none) main: 854.55 RTP I: TrafficCtrl: Added new entry (main): id: 42, tcid: 65568 Dec 19 12:23:17 (none) main: 854.56 MC I: MediaServerAction(): InputGate(ig=78) creation took 311 miliseconds Dec 19 12:23:17 (none) main: 854.58 RTP I: TrafficCtrl: Added new entry (duo): id: 44, tcid: 65568 Dec 19 12:23:17 (none) main: 854.60 MC I: CallParticipantImpl: calledUri: h323:89202 Dec 19 12:23:17 (none) main: 854.60 H323Call I: h323_call::makeOutgoingCall(p=7): Sending call request to stack (rate=768000 srcName='', src uri='h323:OTTPVD1' src e164='89201' dest='89202') Dec 19 12:23:17 (none) main: 854.61 MC I: RemoteParticipant::proposeMode(p=7, ch=1): Did not find mixer ((nil)) or channel (0x49e36384) Dec 19 12:23:17 (none) main: 854.61 MC I: RemoteParticipant::propose60fpsThreshold(p=7, ch=1): Did not find mixer ((nil)) or channel (0x49e36384) Dec 19 12:23:17 (none) main: 854.61 MC I: RemoteParticipant::reevalRefMode(p=7,ch=1) set ref [Audio (1): G.711a  64k ] q= auto, t60=6000 Dec 19 12:23:17 (none) main: 854.61 MC I: RemoteParticipant::reevalRefMode(p=7,ch=2) set ref [Video (2): vid-off 0x0@0.0  0k ] q= auto, t60=6000 Dec 19 12:23:17 (none) main: 854.61 MC I: RemoteParticipant::reevalRefMode(p=7,ch=3) set ref [Video (3): vid-off 0x0@0.0  0k ] q= auto, t60=6000 Dec 19 12:23:17 (none) main: 854.61 MC I: RemoteParticipant::proposeMode(p=7, ch=4): Did not find mixer ((nil)) or channel (0x49e588d4) Dec 19 12:23:17 (none) main: 854.61 MC I: RemoteParticipant::propose60fpsThreshold(p=7, ch=4): Did not find mixer ((nil)) or channel (0x49e588d4) Dec 19 12:23:17 (none) main: 854.61 MC I: RemoteParticipant::reevalRefMode(p=7,ch=4) set ref [Data (4): H.224-HDLC  64k ] q= auto, t60=6000 Dec 19 12:23:17 (none) main: 854.61 MC I: MediaServerAction(): InputGate(ig=81) creation took 358 miliseconds Dec 19 12:23:17 (none) main: 854.89 H323Call I: h323_call_handler::handleH323AlertInd(p=7, s=1): Incoming call alert indication Dec 19 12:23:17 (none) main: 854.94 MediaStreamController I: SC::PlayReq(og=11) path='/sounds/', tone=2 Dec 19 12:23:18 (none) main: 855.09 H323Call I: h323_call_handler::handleH323CapsetInd(p=7, s=1) Received new capset Dec 19 12:23:18 (none) main: 855.09 MC I: RemoteParticipant::setRRRate(p=7): Received new remote rate from protocol: 0 (old: -1) Dec 19 12:23:18 (none) main: 855.10 MC I: RemoteParticipant::modeChanged(p=7, ch=1): ModesController wants to run mode: Audio (1): aud-off  0k  Dec 19 12:23:18 (none) main: 855.10 MC I: RemoteParticipant::modeChanged(p=7, ch=2): ModesController wants to run mode: Video (2): vid-off 0x0@0.0  0k  Dec 19 12:23:18 (none) main: 855.11 MC I: RemoteParticipant::modeChanged(p=7, ch=3): ModesController wants to run mode: Video (3): vid-off 0x0@0.0  0k  Dec 19 12:23:18 (none) main: 855.11 MC I: Conference::calcCommonRate(c=6,ch=3) rate=0 Dec 19 12:23:18 (none) main: 855.11 MC I: RemoteParticipant::modeChanged(p=7, ch=4): ModesController wants to run mode: Data (4): data-off  0k  Dec 19 12:23:18 (none) main: 855.12 MC I: RemoteParticipant::setRRCap(p=7): Received new remote capset from protocol: Capability table: Dec 19 12:23:18 (none) main: 855.12 MC I: Conference::updateCommonCapSet(c=6)  Dec 19 12:23:18 (none) main: 855.13 MC I: RemoteParticipant::modeChanged(p=7, ch=1): ModesController wants to run mode: Audio (1): G.722  64k  Dec 19 12:23:18 (none) main: 855.13 MC I: RemoteParticipant::modeChanged(p=7, ch=4): ModesController wants to run mode: Data (4): H.224-HDLC  64k  Dec 19 12:23:18 (none) main: 855.14 H323Call I: h323_call::sendOutgoingModesToStack(p=7): Modes sent to stack: audio: G.722, video: vid-off, duo: vid-off, data: H.224-HDLC Dec 19 12:23:18 (none) main: 855.17 H323Call I: h323_call_handler::handleH323CallCnf(p=7, s=1) Incoming call confirm rate=7680 lang='en' dest=[h323Id='MeetMeAuto2' e164='89202' ] Dec 19 12:23:18 (none) main: 855.17 MC I: RemoteParticipant::setRRRate(p=7): Received new remote rate from protocol: 768000 (old: 0) Dec 19 12:23:18 (none) main: 855.17 H323Call I: h323_call::sendOutgoingModesToStack(p=7): Modes sent to stack: audio: G.722, video: vid-off, duo: vid-off, data: H.224-HDLC Dec 19 12:23:18 (none) main: 855.17 MC I: setCallState(p=7) InCall Dec 19 12:23:18 (none) main: 855.18 H323Call I: h323_call_handler::handleH323TpeStringAvailableInd(p=7, s=1) Tpe string available indication Dec 19 12:23:18 (none) main: 855.39 RTP I: readBYE(): received bye for session w/SSRC 3741286469 Dec 19 12:23:18 (none) main: 855.39 RTP !ER readBYE(): invalid SSRC found 0/567354606 received 3741286469 Dec 19 12:23:18 (none) main: 855.39 RTP !ER decodeRtcpPacket::readBYE(sid=0) error validating RTCP packet Dec 19 12:23:18 (none) main: 855.40 MC I: RemoteInputGateImpl::setIncomingModeReport(ig=75,p=7) [Audio (1): aud-off stereo  0k ] Dec 19 12:23:18 (none) main: 855.41 H323Call I: h323_call_handler::handleH323RtpOpenSessionReq(p=7, s=1) Open outgoing media session (OLC/OLC-ACK, h233.chanid: 1: MC channel: 1) Dec 19 12:23:18 (none) main: 855.41 H323Call I: h323_call_handler::handleH323RtpEncryptionKeyInd(p=7, s=1) Received encryption key (channel: 1, h323.type: 1) Dec 19 12:23:18 (none) main: 855.42 MC I: configureOutgoingChannel(p=7, ch=1): Configuring mode : Audio (1): G.722  0k PT(103)  (modescontroller says real is: Audio (1): G.722  64k ) Dec 19 12:23:18 (none) main: 855.43 RTP I: Flux Start FEC Decoder sess: 0 Dec 19 12:23:18 (none) main: 855.44 MC I: RemoteParticipant::reevalRefMode(p=7,ch=2) set ref [Video (2): vid-raw 1920x1080@30.0  0k ] q= motion, t60=921600 Dec 19 12:23:18 (none) main: 855.44 MC I: RemoteParticipant::modeChanged(p=7, ch=2): ModesController wants to run mode: Video (2): H.264 512x288@30.0 17500mbps 17500smbps  704k  Dec 19 12:23:18 (none) main: 855.45 H323Call I: h323_call::sendOutgoingModesToStack(p=7): Modes sent to stack: audio: G.722, video: H.264, duo: vid-off, data: H.224-HDLC Dec 19 12:23:18 (none) main: 855.48 RTP I: Rtp_Ready_doRTPSourceMuteReq(app=0,strm=27) source unmuted Dec 19 12:23:18 (none) main: 855.49 H323Call I: h323_call::configureOutgoingChannelCnf(p=7) Outgoing media is set up for channel 1, sending confirm on open back to stack Dec 19 12:23:18 (none) main: 855.49 H323Call I: h323_call::configureOutgoingChannelCnf(p=7) Sending mic mute indication on startup (channel: 1, type: 1) Dec 19 12:23:18 (none) main: 855.49 H323Call I: h323_call_handler::handleH323RtpCloseSessionReq(p=7, s=1) Close outgoing media session (CLC/CLC-ACK, channel: 1) Dec 19 12:23:18 (none) main: 855.49 MC I: configureOutgoingChannel(p=7, ch=1): Configuring mode : iX (1): undefined  0k  (modescontroller says real is: Audio (1): aud-off  0k ) Dec 19 12:23:18 (none) main: 855.50 RTP I: Rtp_Ready_doRTPSourceMuteReq(app=0,strm=27) source unmuted Dec 19 12:23:18 (none) main: 855.50 RTP I: Rtp_Ready_doRTPSourceMuteReq(app=0,strm=27) source unmuted Dec 19 12:23:18 (none) main: 855.57 H323Call I: h323_call_handler::handleDiscInd(p=7, s=1) Received disconnect indication (Cause: 2:16, h323 cause: 16:0)- RemoteDisconnect Q850 Dec 19 12:23:18 (none) main: 855.57 MC I: RemoteParticipant::reevalRefMode(p=7,ch=2) set ref [Video (2): vid-off 0x0@0.0  0k ] q= auto, t60=6000 Dec 19 12:23:18 (none) main: 855.58 ModesController I: ModesController::resetRateLimit(ch=2) Dec 19 12:23:18 (none) main: 855.58 MC I: RemoteParticipant::modeChanged(p=7, ch=2): ModesController wants to run mode: Video (2): vid-off 0x0@0.0  0k  Dec 19 12:23:18 (none) main: 855.58 H323Call I: h323_call::sendOutgoingModesToStack(p=7): Modes sent to stack: audio: G.722, video: vid-off, duo: vid-off, data: H.224-HDLC Dec 19 12:23:18 (none) main: 855.63 H323Call I: h323_call::affirmIncomingDisconnect(p=7): Incoming disconnect affirmed Dec 19 12:23:18 (none) main: 855.67 MC W: RemoteParticipant::disconnectTokenParticipant(p=7) No call Dec 19 12:23:18 (none) main: 855.68 MC I: Conference::updateCommonCapSet(c=6)  Dec 19 12:23:18 (none) main: 855.68 IXUser I: iXController teardownIxChannel: Not connected Dec 19 12:23:18 (none) main: 855.70 MC I: CapabilityControllerImpl::setCapset() reduced = 0, waitForDuoGate = 1, hasLegacyVideo = 0 Dec 19 12:23:18 (none) main: 855.72 RTP I: TrafficCtrl: Deleting entry (main): id: 42, tcid: 65568 Dec 19 12:23:18 (none) main: 855.72 RTP I: TrafficCtrl: Deleting entry (duo): id: 44, tcid: 65568 Dec 19 12:23:18 (none) main: 855.73 CAMERA I: CamVisca::Ready_doCAMActionReq cameraId=1 actionId=20