[Problem] OpenStage 40 - keine Kurzwahl mehr möglich

Toggle sidebar Toggle sidebar
Upgrade 3CX to v18 and get it hosted free!
I

IT-Alexander

Neuer User
Mitglied seit
12 Jan 2014
Beiträge
166
Punkte für Reaktionen
0
Punkte
0
Hallo,

heute erreichte mich ein Problem mit einem OpenStage 40 Gerät. Auf diesem sind die Funktionstasten am Display als Kurzwahltasten konfiguriert. Bisher lief das auch einwandfrei. Nur jetzt scheint es da ein Problem zu geben:

Bei Abnehmen des Hörers und Nutzung einer Taste ertönt sofort das Besetzt Zeichen und es erscheint eine Art Verbotszeichen im Display. Wird die jeweilige Rufnummer jedoch normal per Hand eingetippt, gibt es keine Probleme.

Es scheint, als wären die Tasten bzw. die Wahlvorgänge darüber irgendwie gesperrt. Das Gerät läuft jetzt seit knapp 2 Jahren ohne Probleme, es wurde auch nichts an der Konfiguration geändert.

Genutzt wird das Telefon an einer AVM Fritz!Box 7320 (aktuelle Firmware 6.30), wie gesagt, bisher ohne Probleme.

Hat jemand eine Idee, wo ich den Fehler suchen könnte ?
 
Im Phone selbst ... :)

Also mittels interner Phone-Traces.

Versuchs mal mit SIP Signalling u SIP Messages auf DEBUG zu Beginn.
Gehen KEINE SIP Meldungen raus, dann müsste man "weiter oben" suchen, d.h. CallContorl u CSTA dazunehmen.
Sieht man dann immer nocht keinen Grund für das Fehlverhalten, dann evtl. noch CallView usw...

Aber die Traces zu lesen sind nicht jedermans Sache ... ;)
 
Nun habe ich mir die Sache mal vor Ort angesehen, aufgefallen ist mir sofort im Log der Box bereits:

Code: 
Internettelefonie mit [email protected]:5060 war nicht erfolgreich Ursache: Decline (603)

Jedoch wenn die Rufnummer manuell eingetippt wird, klappt der Anruf.
 
Schon die Phone-Traces gezogen ?
 
Ja, aber bei soviel Text blicke ich irgendwie nicht durch. Und leider steht das Gerät nicht bei mir, sondern bei meinen Eltern. Werde aber heute nachmittag noch mal vorbei fahren und dann mal den Text hier posten, vielleicht kann da einer genauer analysieren.

Auf jedenfall ist der Anrufaufbau auch in den Traces erkennbar, die gewählten Rufnummern sind dort zu finden. Dazu noch jede Menge andere Meldungen.
 
OK - wenn das Phone das INVITE rausschickt, dieses bei der fritz.bix ankommt, dann muss man nur noch klären, warum angeblich ein 603 Decline zurückkommt ...

Komisch ist halt nur, dass das normale Wählen lt deiner Aussage ja problemlos funktioniert ... bin schon auf die Traces gespannt :)
 
mini01 schrieb:
Komisch ist halt nur, dass das normale Wählen lt deiner Aussage ja problemlos funktioniert ... bin schon auf die Traces gespannt :)
Zum Vergrößern anklicken....

Richtig, wenn die gleiche Rufnummer manuell eingetippt wird, geht ja alles.

Hier mal ein Auszug (ist jetzt von einem Versuch, per Kurzwahltaste einen Anruf zu tätigen)
Code: 
___TRACE:___   Fri Sep 18 20:12:31 2015.310
SIP Call Control(2968): ./src/cc_tracing.c:657 Failed to find callref for calltype: ccPreConsultationCall : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.311
SIP Call Control(2968): ./src/cc_tracing.c:650 CALLREC ALLOC = 129 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.311
SIP Call Control(2968): ./src/cc_tracing.c:657 Failed to find callref for calltype: ccPrimaryCall : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.311
SIP Call Control(2968): ./src/cc_tracing.c:657 Failed to find callref for calltype: ccConsultationCall : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.311
SIP Call Control(2968): ./src/cc_tracing.c:685 Set calltype = ccPrimaryCall for callref 129 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.311
SIP Call Control(2968): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.311
SIP Call Control(2968): ./src/cc_tracing.c:473 Line 0: E_FM_new_outgoing_call:   S_FM_idle ---> S_FM_new_call_outgoing :  : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.311
SIP Call Control(2968): ./src/cc_features.c:2729 Feature state change call leg 1 calltype 0 current_state 0 callref 129
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.311
SIP Call Control(2968): ./src/cc_features.c:2729 Feature state change call leg 2 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.311
SIP Call Control(2968): ./src/cc_features.c:2729 Feature state change call leg 3 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.312
SIP Call Control(2968): ./src/cc_features.c:2729 Feature state change call leg 4 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.312
SIP Call Control(2968): ./src/cc_features.c:2729 Feature state change call leg 5 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.312
SIP Call Control(2968): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.312
SIP Call Control(2968): ./src/cc_events.c:807 Exit action not defined for state : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.312
SIP Call Control(2968): ./src/cc_tracing.c:473 Line 0: E_CC_call_make:   S_CC_idle ---> S_CC_call_setup : 129 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.312
SIP Call Control(2968): ./src/cc_notify.c:795 **** ccCallStateChange - reached start **** (thisCall = 129, newState = ccCallSettingUp, traceId = '')

___TRACE:___   Fri Sep 18 20:12:31 2015.313
SIP Call Control(2968): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.313
SIP Call Control(2968): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.313
SIP Call Control(2968): ./src/cc_notify.c:62 # calls(incremented): 1

___TRACE:___   Fri Sep 18 20:12:31 2015.313
SIP Call Control(2968): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.313
SIP Call Control(2968): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.313
SIP Call Control(2968): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.313
SIP Call Control(2968): ./src/cc_notify.c:823 Call ref=129: Old state=ccNull: New state=ccCallSettingUp:

___TRACE:___   Fri Sep 18 20:12:31 2015.313
SIP Call Control(2968): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.313
SIP Call Control(2968): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.314
SIP Call Control(2968): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.315
SIP Call Control(2968): ./src/cc_tracing.c:657 Failed to find callref for calltype: ccWaitingCall : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.315
SIP Call Control(2968): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.315
SIP Call Control(2968): ./src/cc_tracing.c:473 Line 0: E_FM_wait:   S_FM_new_call_outgoing ---> S_FM_primary_call_wait_state :  : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.315
SIP Call Control(2968): ./src/cc_features.c:2729 Feature state change call leg 1 calltype 0 current_state 1 callref 129
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.315
SIP Call Control(2968): ./src/cc_features.c:2729 Feature state change call leg 2 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.315
SIP Call Control(2968): ./src/cc_features.c:2729 Feature state change call leg 3 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.315
SIP Call Control(2968): ./src/cc_features.c:2729 Feature state change call leg 4 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.315
SIP Call Control(2968): ./src/cc_features.c:2729 Feature state change call leg 5 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.315
SIP Call Control(2968): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.321
SIP Signalling(590): ./src/sgCDispatcher.cpp:128 sgCDispatcher::sgParseIncomingMessage - event = 5; state = 2

___TRACE:___   Fri Sep 18 20:12:31 2015.321
SIP Signalling(590): ./src/sgCDispatcher.cpp:608 CC->SIG:  sgCallMake:

___TRACE:___   Fri Sep 18 20:12:31 2015.322
SIP Signalling(590): ./src/sg_init_service.cpp:109 SetStackTime

---INFO:---    Fri Sep 18 20:12:31 2015.322
SIP Signalling(590): ./src/sg_init_service.cpp:121 GMT: 2015 Sep 18 18:12:31 Fri

---INFO:---    Fri Sep 18 20:12:31 2015.322
SIP Signalling(590): ./src/sg_init_service.cpp:129 UTC: y(115) m(8) d(18) h(18) m(12) s(31)

___TRACE:___   Fri Sep 18 20:12:31 2015.322
SIP Signalling(590): ./src/sg_call_service_int.cpp:135 sgCallSetup() BRIDGE DATA: CallId() CallToUri() CallTo() CallFrom() Enabled(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.322
SIP Signalling(590): ./src/sgCallRecordMgmt.cpp:76 CreateCallRecord() - new CallRecord(129,0) created, 1 CallRecord(s) in total

___TRACE:___   Fri Sep 18 20:12:31 2015.338
SIP Signalling(3625): ./src/sg_engine.cpp:3963 EvMessageServiceMgrAwaken(1, 5, 0xa7a6a0)

___TRACE:___   Fri Sep 18 20:12:31 2015.342
SIP Signalling(590): ./src/sg_sip_url_service.cpp:53 sgSetSipURL() - pInRemURL(020000000) unLineId(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.342
SIP Signalling(590): ./src/sg_sip_url_service.cpp:217 sgSetSipURL() - URI<sip:(020000000)@(192.168.178.2):(5060)>

___TRACE:___   Fri Sep 18 20:12:31 2015.342
SIP Signalling(590): ./src/sgCDatabaseIf.cpp:802 GetVideoCapability() - eVideoCapability(1)

___TRACE:___   Fri Sep 18 20:12:31 2015.343
SIP Signalling(590): ./src/MediaSessionMgr.cpp:756 KW: eRtpMediaType(0) bHasRtp(0) bHasSrtpMikey(0) bHasSrtpSdes(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.356
SIP Signalling(590): ./src/MediaSessionMgr.cpp:168 sgCreateSession() - getLocalSessionDescription: <media-sessiondescription><ip-addr>192.168.178.50</ip-addr><port>5004</port><local-socket><ip-addr-v4>192.168.178.50</ip-addr-v4><port>5004</port><rtcp-port>5005</rtcp-port></local-socket><dtmf-payload>101</dtmf-payload><ptime>0</ptime><max-ptime>60</max-ptime><audio><codec>PCMA</codec><codec>PCMU</codec><codec>G729</codec></audio><ssrc>695466777</ssrc></media-sessiondescription>

___TRACE:___   Fri Sep 18 20:12:31 2015.357
SIP Signalling(590): ./src/sgCRtpSession.cpp:669 AddSocket RtpSession(0x9f5af8) ip(192.168.178.50) port(5004) rtcpport(5005) eIPV4

___TRACE:___   Fri Sep 18 20:12:31 2015.359
SIP Signalling(590): ./src/MediaSessionMgr.cpp:186 sgCreateSession() - pRtpSession(9f5af8) SessionHandle(25) eMediaType(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.360
SIP Signalling(590): ./src/MediaSessionMgr.cpp:782 GenerateRtpSessionsHelper() - New RtpSession created, pRtpSession(0x9f5af8)

___TRACE:___   Fri Sep 18 20:12:31 2015.360
SIP Signalling(590): ./src/MediaSessionMgr.cpp:831 GenerateRtpSessionsHelper() - created a vector(0xa5be48) with 1 RtpSession(s) eRtpMediaType(0) total(1)

___TRACE:___   Fri Sep 18 20:12:31 2015.361
SIP Signalling(590): ./src/MediaSessionMgr.cpp:720 GenerateRtpSessions() - created a vector(0xa5be48) with 1 RtpSession(s)

___TRACE:___   Fri Sep 18 20:12:31 2015.361
SIP Signalling(590): ./src/sgCallRecordNew.cpp:224 SetRtpSessions() - replacing m_pvRtpSessions((nil)) with pRtpSession(0xa5be48)

___TRACE:___   Fri Sep 18 20:12:31 2015.361
SIP Signalling(590): ./src/sgSdpService.cpp:583 SdpStateEventMachine() - CallRefId(129) CalLRefIdForCC(129) SdpState(0,SDP_NULL) eTypeOfMessage(0) bIncludeSdp(1) bResetCaps(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.362
SIP Signalling(590): ./src/sgSdpService.cpp:1814 GenerateLocalCapsMgr() - CallRefId(129) CalLRefIdForCC(129) bSdpOffer(1)

___TRACE:___   Fri Sep 18 20:12:31 2015.362
SIP Signalling(590): ./src/sgSdpService.cpp:1840 GenerateLocalCapsMgr() - bAnatEnabled(0) bSDESenabled(0) bDualstack(0) bPayloadSecurityEnabled(0) eMediaIPMode(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.362
SIP Signalling(590): ./src/sgSdpService.cpp:1849 GenerateLocalCapsMgr() - based on 1 RTPSession(s)

___TRACE:___   Fri Sep 18 20:12:31 2015.362
SIP Signalling(590): ./src/sgSdpService.cpp:1890 GenerateLocalCapsMgr() - uNumSockets(1)

___TRACE:___   Fri Sep 18 20:12:31 2015.362
SIP Signalling(590): ./src/sgSdpService.cpp:1900 GenerateLocalCapsMgr() - IPV4 socket found

___TRACE:___   Fri Sep 18 20:12:31 2015.363
SIP Signalling(590): ./src/sgSdpService.cpp:1936 GenerateLocalCapsMgr() - m-line(0) set to RtpMediaType(0) eRTPAVP

___TRACE:___   Fri Sep 18 20:12:31 2015.364
SIP Signalling(590): ./src/sgSdpService.cpp:2083 GenerateLocalCapsMgr() - remove m-line(0) local connections data

___TRACE:___   Fri Sep 18 20:12:31 2015.364
SIP Signalling(590): ./src/sgSdpService.cpp:2171 GenerateLocalCapsMgr() - GetCapsLocal((nil)) GetCapsRemote((nil)) GetCapsNegotiated((nil)) GetCapsNegotiatedLast((nil)) HasRemoteSdpOriginChanged(0) bSdpOffer(1)

___TRACE:___   Fri Sep 18 20:12:31 2015.364
SIP Signalling(590): ./src/sgSdpService.cpp:2266 GenerateLocalCapsMgr() - setting streams to bInactive(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.364
SIP Signalling(590): ./src/sgSdpService.cpp:2296 GenerateLocalCapsMgr() - CallState(0,eCALL_NULL) CallSubState(0,eCALL_SS_NULL) bInactive(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.364
SIP Signalling(590): ./src/sgSdpService.cpp:646 SdpStateEventMachine() - INVITE_REQ_OUTGOING: LOCAL

___TRACE:___   Fri Sep 18 20:12:31 2015.365
SIP Signalling(590): ./src/sgCallRecordNew.cpp:339 SetCapsToUseForSdp() - using eCAPS_MGR_LOCAL for SDP

___TRACE:___   Fri Sep 18 20:12:31 2015.365
SIP Signalling(590): ./src/sgCallRecordNew.cpp:401 SdpState - Call(129) transition from (0,SDP_NULL) to (1,SDP_OFFER_SENT)

___TRACE:___   Fri Sep 18 20:12:31 2015.365
SIP Signalling(590): ./src/sgCallRecordNew.cpp:507 CallPhase - Call(129) transition from (0,eCALL_P_NULL) to (1,eCALL_P_INITIAL)

___TRACE:___   Fri Sep 18 20:12:31 2015.365
SIP Signalling(590): ./src/sgSdpService.cpp:1436 SdpStateEventMachine() END - rCallRecord(129) rCallRecord.GetSdpStateStr(1,SDP_OFFER_SENT) eCallEvent(0) bIncludeSdp(1)

___TRACE:___   Fri Sep 18 20:12:31 2015.365
SIP Signalling(590): ./src/sgSdpService.cpp:194 GetSdp() - CallRefId(129) CallRefIdForCC(129) bIncludeSdp(1)

___TRACE:___   Fri Sep 18 20:12:31 2015.365
SIP Signalling(590): ./src/sgSdpService.cpp:221 GetSdp() - generating SDP based on LOCAL_CAPS

___TRACE:___   Fri Sep 18 20:12:31 2015.365
SIP Signalling(590): ./src/sgSdpService.cpp:416 GetSdp() - szSessionAddr(192.168.178.50) strLocalAddr.CStr(192.168.178.50)

___TRACE:___   Fri Sep 18 20:12:31 2015.366
SIP Signalling(590): ./src/sgSdpService.cpp:458 GetSdp() - sdpPacket.IsValid(1) GetSessionTimeEnable(0) GetServerType(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.367
SIP Signalling(590): ./src/sg_call_service_int.cpp:377 sgCallSetup()/InviteA - CallRefId(129) CallRefIdForCC(129)

___TRACE:___   Fri Sep 18 20:12:31 2015.368
SIP Signalling(3625): ./src/sg_engine.cpp:3963 EvMessageServiceMgrAwaken(0, 13, 0xa7a6a0)

___TRACE:___   Fri Sep 18 20:12:31 2015.368
SIP Signalling(3625): ./src/sgCallInfoMgmt.cpp:58 CreateCallInfo() - new CallInfo(129) created, 1 CallInfo(s) in total

___TRACE:___   Fri Sep 18 20:12:31 2015.368
SIP Signalling(3625): ./src/sg_engine.cpp:1657 InternalInviteA() - rRemoteUri: user(020000000) host(192.168.178.2) port(5060)

___TRACE:___   Fri Sep 18 20:12:31 2015.368
SIP Signalling(3625): ./src/sg_engine.cpp:11800 CreateSipContext() - CallInfo created, lineId(0), callRefId(129)

___TRACE:___   Fri Sep 18 20:12:31 2015.369
SIP Signalling(3625): ./src/sg_engine.cpp:10248 AddUserAgentSvc() - IPv4(192.168.178.50)(1) IPv6(NULL)(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.370
SIP Signalling(3625): ./src/sg_engine.cpp:11855 CreateSipContext() - LineId(0) TLS(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.370
SIP Signalling(3625): ./src/sg_engine_auth.cpp:40 AddDigestClientAuthSvc()  SetLoopThreshold(3)

___TRACE:___   Fri Sep 18 20:12:31 2015.371
SIP Signalling(3625): ./src/sg_engine_rel.cpp:26 AddReliableProvisionalResponseSvc()

~~~DEBUG:~~~   Fri Sep 18 20:12:31 2015.376
SIP Signalling(3625): ./src/SIP_Service.cpp:194 SIP_Service::dispatchMsgToSignalling: entering

___TRACE:___   Fri Sep 18 20:12:31 2015.381
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet Out--->192.168.178.2
INVITE sip:[email protected]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bK8a966a7029240f1ab
Max-Forwards: 70
From: "620" <sip:[email protected]:5060>;tag=0b1c859569;epid=SC0ab96e
To: <sip:[email protected]:5060>
Call-ID: cb3dedfd40502fad
CSeq: 1944759308 INVITE
Allow: INVITE, ACK, CANCEL, BYE, REFER, NOTIFY, UPDATE
Allow-Events: hold
Contact: "620" <sip:[email protected]:5060;transport=udp>
Supported: replaces, 100rel
User-Agent: OpenStage_40_V3 R1.50.0      SIP  131206
X-Siemens-Call-Type: ST-insecure
Content-Type: application/sdp
Content-Length: 324

v=0
o=OpenStage-Line_0 1354921367 153643502 IN IP4 192.168.178.50
s=SIP Call
c=IN IP4 192.168.178.50
t=0 0
m=audio 5004 RTP/AVP 8 0 18 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
a=silenceSupp:off - - - -
a=fmtp:18 annexb=no
a=fmtp:101 0-15
a=sendrecv


___TRACE:___   Fri Sep 18 20:12:31 2015.382
SIP Signalling(590): ./src/sgCDispatcher.cpp:128 sgCDispatcher::sgParseIncomingMessage - event = 144; state = 2

___TRACE:___   Fri Sep 18 20:12:31 2015.382
SIP Signalling(590): ./src/sgCDispatcher.cpp:338 Engine->CallService: sipCallProceeding

___TRACE:___   Fri Sep 18 20:12:31 2015.382
SIP Signalling(590): ./src/sg_call_service_ext.cpp:5126 SIG->CC: sgEvtCallProceeding()/sgCallStateProceeding - CallRefId(129)

~~~DEBUG:~~~   Fri Sep 18 20:12:31 2015.382
SIP Signalling(590): ./src/SIP_Service.cpp:185 createSIPService: call HandleSignallingEvent

___TRACE:___   Fri Sep 18 20:12:31 2015.382
SIP Call Control(590): ./src/cc_sig_events.c:52 HandleSignallingEvent - received event. Event: : 12

___TRACE:___   Fri Sep 18 20:12:31 2015.382
SIP Call Control(590): ./src/cc_sig_events.c:34 NotifyStateMachine - CallRef:  : 129

___TRACE:___   Fri Sep 18 20:12:31 2015.382
SIP Call Control(590): ./src/cc_events.c:807 Exit action not defined for state : 1

___TRACE:___   Fri Sep 18 20:12:31 2015.382
SIP Call Control(590): ./src/cc_tracing.c:473 Line 0: E_CC_call_proceeding:   S_CC_call_setup ---> S_CC_call_proceeding : 129 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.382
SIP Call Control(590): ./src/cc_notify.c:795 **** ccCallStateChange - reached start **** (thisCall = 129, newState = ccCallProceeding, traceId = '')

___TRACE:___   Fri Sep 18 20:12:31 2015.383
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.383
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.383
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.383
SIP Call Control(590): ./src/cc_notify.c:823 Call ref=129: Old state=ccCallSettingUp: New state=ccCallProceeding:

___TRACE:___   Fri Sep 18 20:12:31 2015.383
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.383
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.383
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.404
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet In <---192.168.178.2
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bK8a966a7029240f1ab
From: "620" <sip:[email protected]:5060>;tag=0b1c859569;epid=SC0ab96e
To: <sip:[email protected]:5060>;tag=DB833B50AB0BF541
Call-ID: cb3dedfd40502fad
CSeq: 1944759308 INVITE
WWW-Authenticate: Digest realm="fritz.box", nonce="DA68297E3DB9C976"
User-Agent: FRITZ!OS
Content-Length: 0



___TRACE:___   Fri Sep 18 20:12:31 2015.404
SIP Signalling(3626): ./src/sg_engine.cpp:9192 EvPacketReceived(ISipTransportObserver) - RES Code(401) Method(INVITE)

___TRACE:___   Fri Sep 18 20:12:31 2015.406
SIP Signalling(3625): ./src/sg_engine_auth.cpp:72 EvCredentialsRequired()

___TRACE:___   Fri Sep 18 20:12:31 2015.407
SIP Signalling(3625): ./src/sg_engine_auth.cpp:127 EvCredentialsRequired() - LineId(0) CallRefId(129)

___TRACE:___   Fri Sep 18 20:12:31 2015.412
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet Out--->192.168.178.2
ACK sip:[email protected]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bK8a966a7029240f1ab
Max-Forwards: 70
From: "620" <sip:[email protected]:5060>;tag=0b1c859569;epid=SC0ab96e
To: <sip:[email protected]:5060>;tag=DB833B50AB0BF541
Call-ID: cb3dedfd40502fad
CSeq: 1944759308 ACK
User-Agent: OpenStage_40_V3 R1.50.0      SIP  131206
Content-Length: 0



___TRACE:___   Fri Sep 18 20:12:31 2015.415
SIP Signalling(3625): ./src/sg_engine_auth.cpp:240 EvCredentialsRequired() - request reissued

___TRACE:___   Fri Sep 18 20:12:31 2015.421
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet Out--->192.168.178.2
INVITE sip:[email protected]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bK0e7b8dedcfdff7ae5
Max-Forwards: 70
From: "620" <sip:[email protected]:5060>;tag=0b1c859569;epid=SC0ab96e
To: <sip:[email protected]:5060>
Call-ID: cb3dedfd40502fad
CSeq: 1944759309 INVITE
Allow: INVITE, ACK, CANCEL, BYE, REFER, NOTIFY, UPDATE
Allow-Events: hold
Authorization: Digest username="620",realm="fritz.box",nonce="DA68297E3DB9C976",uri="sip:[email protected]:5060;transport=udp",response="0570700e32bcda8df182da1fda10adb6"
Contact: "620" <sip:[email protected]:5060;transport=udp>
Supported: replaces, 100rel
User-Agent: OpenStage_40_V3 R1.50.0      SIP  131206
X-Siemens-Call-Type: ST-insecure
Content-Type: application/sdp
Content-Length: 324

v=0
o=OpenStage-Line_0 1354921367 153643502 IN IP4 192.168.178.50
s=SIP Call
c=IN IP4 192.168.178.50
t=0 0
m=audio 5004 RTP/AVP 8 0 18 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
a=silenceSupp:off - - - -
a=fmtp:18 annexb=no
a=fmtp:101 0-15
a=sendrecv


___TRACE:___   Fri Sep 18 20:12:31 2015.437
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet In <---192.168.178.2
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bK0e7b8dedcfdff7ae5
From: "620" <sip:[email protected]:5060>;tag=0b1c859569;epid=SC0ab96e
To: <sip:[email protected]:5060>
Call-ID: cb3dedfd40502fad
CSeq: 1944759309 INVITE
User-Agent: AVM FRITZ!Box Fon WLAN 7390 (UI) 84.06.30 (Jul 10 2015)
Content-Length: 0



___TRACE:___   Fri Sep 18 20:12:31 2015.437
SIP Signalling(3626): ./src/sg_engine.cpp:9192 EvPacketReceived(ISipTransportObserver) - RES Code(100) Method(INVITE)

___TRACE:___   Fri Sep 18 20:12:31 2015.439
SIP Signalling(3625): ./src/sg_engine.cpp:5602 EvProgress(ISipSessionSvc)

~~~DEBUG:~~~   Fri Sep 18 20:12:31 2015.439
SIP Signalling(3625): ./src/SIP_Service.cpp:194 SIP_Service::dispatchMsgToSignalling: entering

___TRACE:___   Fri Sep 18 20:12:31 2015.441
SIP Signalling(590): ./src/sgCDispatcher.cpp:128 sgCDispatcher::sgParseIncomingMessage - event = 122; state = 2

___TRACE:___   Fri Sep 18 20:12:31 2015.441
SIP Signalling(590): ./src/sgCDispatcher.cpp:197 Engine->CallService: sipCallProgress

___TRACE:___   Fri Sep 18 20:12:31 2015.441
SIP Signalling(590): ./src/sg_call_service_ext.cpp:1920 sgEvtCallProgress() - START: CallRefId(129) CallState(0,eCALL_NULL) CallSubState(0,eCALL_SS_NULL)

___TRACE:___   Fri Sep 18 20:12:31 2015.441
SIP Signalling(590): ./src/sg_call_service_ext.cpp:1977 sgEvtCallProgress() - END 100Trying (100)

___TRACE:___   Fri Sep 18 20:12:31 2015.453
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet In <---192.168.178.2
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bK0e7b8dedcfdff7ae5
From: "620" <sip:[email protected]:5060>;tag=0b1c859569;epid=SC0ab96e
To: <sip:[email protected]:5060>;tag=A228ECF5E10182D6
Call-ID: cb3dedfd40502fad
CSeq: 1944759309 INVITE
Contact: <sip:[email protected]>
User-Agent: AVM FRITZ!Box Fon WLAN 7390 (UI) 84.06.30 (Jul 10 2015)
Content-Type: application/sdp
Content-Length: 244

v=0
o=user 5399744 5399744 IN IP4 192.168.178.2
s=SIP Call
c=IN IP4 192.168.178.2
t=0 0
m=audio 7078 RTP/AVP 8 0 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=rtcp:7079


___TRACE:___   Fri Sep 18 20:12:31 2015.454
SIP Signalling(3626): ./src/sg_engine.cpp:9192 EvPacketReceived(ISipTransportObserver) - RES Code(183) Method(INVITE)

___TRACE:___   Fri Sep 18 20:12:31 2015.459
SIP Signalling(3625): ./src/sg_engine.cpp:5602 EvProgress(ISipSessionSvc)

~~~DEBUG:~~~   Fri Sep 18 20:12:31 2015.459
SIP Signalling(3625): ./src/SIP_Service.cpp:194 SIP_Service::dispatchMsgToSignalling: entering

___TRACE:___   Fri Sep 18 20:12:31 2015.461
SIP Signalling(590): ./src/sgCDispatcher.cpp:197 Engine->CallService: sipCallProgress

___TRACE:___   Fri Sep 18 20:12:31 2015.461
SIP Signalling(590): ./src/sg_call_service_ext.cpp:1920 sgEvtCallProgress() - START: CallRefId(129) CallState(0,eCALL_NULL) CallSubState(0,eCALL_SS_NULL)

___TRACE:___   Fri Sep 18 20:12:31 2015.461
SIP Signalling(590): ./src/sgSdpService.cpp:583 SdpStateEventMachine() - CallRefId(129) CalLRefIdForCC(129) SdpState(1,SDP_OFFER_SENT) eTypeOfMessage(3) bIncludeSdp(1) bResetCaps(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.462
SIP Signalling(590): ./src/sgCSipPacket.cpp:999 HasContentTypeHeader() - Content(application/sdp) available

___TRACE:___   Fri Sep 18 20:12:31 2015.462
SIP Signalling(590): ./src/sgCSipPacket.cpp:918 GetFirstPayload() - application/sdp found

___TRACE:___   Fri Sep 18 20:12:31 2015.462
SIP Signalling(590): ./src/sgSdpService.cpp:2389 GenerateRemoteCapsMgr() - CallRefId(129) CallRefIdForCC(129)

___TRACE:___   Fri Sep 18 20:12:31 2015.463
SIP Signalling(590): ./src/sgCallRecordNew.cpp:372 SetRemoteSdpOrigin() - m_bRemoteSdpOriginChanged set

___TRACE:___   Fri Sep 18 20:12:31 2015.464
SIP Signalling(590): ./src/sgSdpService.cpp:3044 VerifySdpAnswer() - CallRefId(129) CalLRefIdForCC(129)

___TRACE:___   Fri Sep 18 20:12:31 2015.465
SIP Signalling(590): ./src/sgSdpService.cpp:3071 VerifySdpAnswer() - OKAY, res(0,S:OK)

___TRACE:___   Fri Sep 18 20:12:31 2015.466
SIP Signalling(590): ./src/sgSdpService.cpp:3091 VerifySdpAnswer() - Media Supported res(0,S:OK)

___TRACE:___   Fri Sep 18 20:12:31 2015.466
SIP Signalling(590): ./src/sgSdpService.cpp:3132 VerifySdpAnswer() - really OKAY, res(0,S:OK)

___TRACE:___   Fri Sep 18 20:12:31 2015.466
SIP Signalling(590): ./src/sgCSdpCapabilitiesMgr.cpp:90 GetSupportedStream() - eMediaType(0) ruStreamIndex(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.466
SIP Signalling(590): ./src/sgSdpService.cpp:3170 VerifySdpAnswer() - CallRefId(129) CallState(0,eCALL_NULL) CallSubState(0,eCALL_SS_NULL) CurrentCallAction(0,eCALL_A_NULL) bHoldIndication(0) bHoldUsingSendOnly(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.466
SIP Signalling(590): ./src/sgCallRecordNew.cpp:431 CallState - Call(129) transition from (0,eCALL_NULL) to (1,eCALL_CONNECTED)

___TRACE:___   Fri Sep 18 20:12:31 2015.466
SIP Signalling(590): ./src/sgSdpService.cpp:3604 GetRtpSession() - iPort(5004) eMediaType(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.466
SIP Signalling(590): ./src/sgSdpService.cpp:3617 GetRtpSession() - pReturnSession[0](0x9f5af8)

___TRACE:___   Fri Sep 18 20:12:31 2015.466
SIP Signalling(590): ./src/sgSdpService.cpp:3630 GetRtpSession() - pReturnSession[0](0x9f5af8) - port(5004) iPort(5004) eMediaType(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.467
SIP Signalling(590): ./src/sgSdpService.cpp:3684 SetSessionDirection() - CallRefId(129) CallState(1,eCALL_CONNECTED) RtpMediaType(0) eSessionDirection(5) bFromVerifyAnswer(1)

___TRACE:___   Fri Sep 18 20:12:31 2015.467
SIP Signalling(590): ./src/sgCSdpCapabilitiesMgr.cpp:90 GetSupportedStream() - eMediaType(1) ruStreamIndex(-1)

___TRACE:___   Fri Sep 18 20:12:31 2015.467
SIP Signalling(590): ./src/sgSdpService.cpp:3448 VerifySdpAnswer() - no video supported, res(0,S:OK)

___TRACE:___   Fri Sep 18 20:12:31 2015.467
SIP Signalling(590): ./src/sgSdpService.cpp:3649 RemoveRemoteSessionInformation() - pRtpSessionNotToBeTouched(0x9f5af8) eRtpMediaType(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.467
SIP Signalling(590): ./src/sgSdpService.cpp:3649 RemoveRemoteSessionInformation() - pRtpSessionNotToBeTouched((nil)) eRtpMediaType(1)

___TRACE:___   Fri Sep 18 20:12:31 2015.468
SIP Signalling(590): ./src/sgCallRecordNew.cpp:401 SdpState - Call(129) transition from (1,SDP_OFFER_SENT) to (4,SDP_ANSWER_RECEIVED)

___TRACE:___   Fri Sep 18 20:12:31 2015.468
SIP Signalling(590): ./src/sgCallRecordNew.cpp:507 CallPhase - Call(129) transition from (1,eCALL_P_INITIAL) to (2,eCALL_P_EARLY)

___TRACE:___   Fri Sep 18 20:12:31 2015.468
SIP Signalling(590): ./src/sgSdpService.cpp:1436 SdpStateEventMachine() END - rCallRecord(129) rCallRecord.GetSdpStateStr(4,SDP_ANSWER_RECEIVED) eCallEvent(0) bIncludeSdp(1)

___TRACE:___   Fri Sep 18 20:12:31 2015.468
SIP Signalling(590): ./src/sgCSipPacket.cpp:747 GetRequestUri() - SipPacket is not a request

___TRACE:___   Fri Sep 18 20:12:31 2015.469
SIP Signalling(590): ./src/sgCallRecordNew.cpp:678 SetRemoteUriDefault() - Call(129) Display() User(020000000)

___TRACE:___   Fri Sep 18 20:12:31 2015.469
SIP Signalling(590): ./src/sgCallRecordNew.cpp:838 RemoteCallSecurityIndication - Call(129) transition from (-2147483643,FE:Null pointer) to (2,SI:False)

___TRACE:___   Fri Sep 18 20:12:31 2015.469
SIP Signalling(590): ./src/sg_call_service_ext.cpp:5231 SIG->CC: SendDisplayUpdate()/sgCallUpdateDisplayID - CallRefId(129) CallRefIdForCC(129) exitConf(0)

~~~DEBUG:~~~   Fri Sep 18 20:12:31 2015.469
SIP Signalling(590): ./src/SIP_Service.cpp:185 createSIPService: call HandleSignallingEvent

___TRACE:___   Fri Sep 18 20:12:31 2015.470
SIP Call Control(590): ./src/cc_sig_events.c:52 HandleSignallingEvent - received event. Event: : 25

___TRACE:___   Fri Sep 18 20:12:31 2015.470
SIP Signalling(590): ./src/sgCallServiceHelper.cpp:618 PopulateResourcePriority() - no ResourcePriority header in SipPacket at call(129)

___TRACE:___   Fri Sep 18 20:12:31 2015.470
SIP Signalling(590): ./src/sgCallServiceHelper.cpp:798 ExtractReasonData() - no Reason header in SipPacket

___TRACE:___   Fri Sep 18 20:12:31 2015.481
SIP Signalling(590): ./src/MediaSessionMgr.cpp:500 sgSetSessionTone() - eToneRequest(4) ignored

___TRACE:___   Fri Sep 18 20:12:31 2015.481
SIP Signalling(590): ./src/sgCallServiceHelper.cpp:59 GetRtpSessionToBeUsed() - returns pRtpSession(0x9f5af8) SessionHandle(25) eRtpMediaType(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.483
SIP Signalling(590): ./src/MediaSessionMgr.cpp:324 sgSetRemoteSessionDescription: pRtpSession(0x9f5af8) SessionHandle(25) - <media-sessiondescription><remote-socket><ip-addr-v4>192.168.178.2</ip-addr-v4><port>7078</port><rtcp-port>0</rtcp-port></remote-socket><ptime>0</ptime><resource-priority>0</resource-priority><audio-silence-suppression>false</audio-silence-suppression><audio><audio-mode><codec>PCMA</codec><order>1</order></audio-mode></audio><dtmf-payload>101</dtmf-payload><qdc><subscriber-no>620</subscriber-no><subscriber-type>2</subscriber-type><call-id>cb3dedfd40502fad</call-id><hipath-switch-id>Unknown</hipath-switch-id></qdc></media-sessiondescription>

___TRACE:___   Fri Sep 18 20:12:31 2015.497
SIP Signalling(590): ./src/MediaSessionMgr.cpp:329 setRemoteSessionDescription - success:

___TRACE:___   Fri Sep 18 20:12:31 2015.497
SIP Signalling(590): ./src/MediaSessionMgr.cpp:398 sgSetSessionDirection() - eSessionDirection(0,eFromRtpSession)

___TRACE:___   Fri Sep 18 20:12:31 2015.497
SIP Signalling(590): ./src/MediaSessionMgr.cpp:410 sgSetSessionDirection() - pRtpSession(0x9f5af8): SessionHandle(25) SessionDirection(0,eSENDRECV)

___TRACE:___   Fri Sep 18 20:12:31 2015.534
SIP Signalling(590): ./src/MediaSessionMgr.cpp:443 setDirection - success

___TRACE:___   Fri Sep 18 20:12:31 2015.534
SIP Signalling(590): ./src/sg_call_service_ext.cpp:2292 SIG->CC: sgEvtCallProgress()/58 - CallRefId(129) CallRefIdForCC(129) ResourcePriority(99) ResourcePriorityToCC(0)

~~~DEBUG:~~~   Fri Sep 18 20:12:31 2015.534
SIP Signalling(590): ./src/SIP_Service.cpp:185 createSIPService: call HandleSignallingEvent

___TRACE:___   Fri Sep 18 20:12:31 2015.534
SIP Call Control(590): ./src/cc_sig_events.c:52 HandleSignallingEvent - received event. Event: : 58

___TRACE:___   Fri Sep 18 20:12:31 2015.534
SIP Call Control(590): ./src/cc_notify.c:795 **** ccCallStateChange - reached start **** (thisCall = 129, newState = ccCallProgress, traceId = '')

___TRACE:___   Fri Sep 18 20:12:31 2015.534
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.534
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.534
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.535
SIP Call Control(590): ./src/cc_notify.c:823 Call ref=129: Old state=ccCallProceeding: New state=ccCallProgress:

___TRACE:___   Fri Sep 18 20:12:31 2015.535
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.535
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.535
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.536
SIP Signalling(590): ./src/sg_call_service_ext.cpp:2300 sgEvtCallProgress() - END: CallRefId(129) CallState(1,eCALL_CONNECTED) CallSubState(0,eCALL_SS_NULL)

___TRACE:___   Fri Sep 18 20:12:31 2015.543
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet In <---192.168.178.2
SIP/2.0 603 Decline
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bK0e7b8dedcfdff7ae5
From: "620" <sip:[email protected]:5060>;tag=0b1c859569;epid=SC0ab96e
To: <sip:[email protected]:5060>;tag=A228ECF5E10182D6
Call-ID: cb3dedfd40502fad
CSeq: 1944759309 INVITE
User-Agent: FRITZ!OS
Content-Length: 0



___TRACE:___   Fri Sep 18 20:12:31 2015.543
SIP Signalling(3626): ./src/sg_engine.cpp:9192 EvPacketReceived(ISipTransportObserver) - RES Code(603) Method(INVITE)

___TRACE:___   Fri Sep 18 20:12:31 2015.549
SIP Signalling(3625): ./src/sg_engine.cpp:5059 EvFailure() - CallRefId(129) bHidden(0) DialogSize(1)

~~~DEBUG:~~~   Fri Sep 18 20:12:31 2015.549
SIP Signalling(3625): ./src/SIP_Service.cpp:194 SIP_Service::dispatchMsgToSignalling: entering

___TRACE:___   Fri Sep 18 20:12:31 2015.554
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet Out--->192.168.178.2
ACK sip:[email protected]:5060;transport=udp SIP/2.0
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bK0e7b8dedcfdff7ae5
Max-Forwards: 70
From: "620" <sip:[email protected]:5060>;tag=0b1c859569;epid=SC0ab96e
To: <sip:[email protected]:5060>;tag=A228ECF5E10182D6
Call-ID: cb3dedfd40502fad
CSeq: 1944759309 ACK
User-Agent: OpenStage_40_V3 R1.50.0      SIP  131206
Content-Length: 0



___TRACE:___   Fri Sep 18 20:12:31 2015.555
SIP Signalling(590): ./src/sgCDispatcher.cpp:128 sgCDispatcher::sgParseIncomingMessage - event = 124; state = 2

___TRACE:___   Fri Sep 18 20:12:31 2015.555
SIP Signalling(590): ./src/sgCDispatcher.cpp:209 Engine->CallService: sipCallFailed

___TRACE:___   Fri Sep 18 20:12:31 2015.556
SIP Signalling(590): ./src/sgCallRecordNew.cpp:670 SetRemoteUriDefault() - exit Call(129) Display() User(020000000)

___TRACE:___   Fri Sep 18 20:12:31 2015.556
SIP Signalling(590): ./src/sg_call_service_ext.cpp:2984 sgEvtCallFailed() - CallRefId(129) CallRefIdForCC(129) CallState(1,eCALL_CONNECTED) CallSubState(0,eCALL_SS_NULL) CallPhase(2,eCALL_P_EARLY) OriginalCallRefId(0) TransferToCallRefId(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.556
SIP Signalling(590): ./src/sg_call_service_ext.cpp:3017 sgEvtCallFailed() - CallRefId(129) CallRefIdForCC(129) will be cleared

___TRACE:___   Fri Sep 18 20:12:31 2015.556
SIP Signalling(590): ./src/MediaSessionMgr.cpp:500 sgSetSessionTone() - eToneRequest(4) ignored

___TRACE:___   Fri Sep 18 20:12:31 2015.556
SIP Signalling(590): ./src/sgCSipPacket.cpp:637 GetRawHeader(12) - header not available

___TRACE:___   Fri Sep 18 20:12:31 2015.556
SIP Signalling(590): ./src/sgCallServiceHelper.cpp:892 ExtractCallInfoRawHeader() - no RawHeader for Call-Info header available

***ERROR:***   Fri Sep 18 20:12:31 2015.556
SIP Signalling(590): ./src/sgCallRecordMgmt.cpp:113 GetCallRecord() - cannot search for zero CallRefId

___TRACE:___   Fri Sep 18 20:12:31 2015.556
SIP Signalling(590): ./src/sgCallServiceHelper.cpp:866 ExtractWarningCode() - no Warning header in SipPacket

___TRACE:___   Fri Sep 18 20:12:31 2015.556
SIP Signalling(590): ./src/sg_call_service_ext.cpp:3084 sgEvtCallFailed() - calling SendCallDisconnected()

___TRACE:___   Fri Sep 18 20:12:31 2015.557
SIP Signalling(590): ./src/sg_call_service_ext.cpp:5881 SIG->CC: SendCallDisconnected()/sgCallStateDisconnected - CallRefId(129) CallRefIdForCC(129) clearingCause(2)

~~~DEBUG:~~~   Fri Sep 18 20:12:31 2015.557
SIP Signalling(590): ./src/SIP_Service.cpp:185 createSIPService: call HandleSignallingEvent

___TRACE:___   Fri Sep 18 20:12:31 2015.557
SIP Call Control(590): ./src/cc_sig_events.c:52 HandleSignallingEvent - received event. Event: : 17

___TRACE:___   Fri Sep 18 20:12:31 2015.557
SIP Call Control(590): ./src/cc_sig_events.c:34 NotifyStateMachine - CallRef:  : 129

___TRACE:___   Fri Sep 18 20:12:31 2015.557
SIP Call Control(590): ./src/cc_events.c:807 Exit action not defined for state : 2

___TRACE:___   Fri Sep 18 20:12:31 2015.558
SIP Call Control(590): ./src/cc_tracing.c:473 Line 0: E_CC_call_clear_remote:   S_CC_call_proceeding ---> S_CC_call_cleared : 129 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.558
SIP Call Control(590): ./src/cc_notify.c:795 **** ccCallStateChange - reached start **** (thisCall = 129, newState = ccCallCleared, traceId = '')

___TRACE:___   Fri Sep 18 20:12:31 2015.558
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.558
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.558
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.558
SIP Call Control(590): ./src/cc_notify.c:823 Call ref=129: Old state=ccCallProceeding: New state=ccCallCleared:

___TRACE:___   Fri Sep 18 20:12:31 2015.558
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.558
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.558
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.559
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.560
SIP Call Control(590): ./src/cc_notify.c:90 Number of calls (decremented): 0

___TRACE:___   Fri Sep 18 20:12:31 2015.560
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.560
SIP Call Control(590): ./src/cc_events.c:1951 ACT_call_cleared - : 129

___TRACE:___   Fri Sep 18 20:12:31 2015.560
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.560
SIP Call Control(590): ./src/cc_tracing.c:473 Line 0: E_FM_call_cleared:   S_FM_primary_call_wait_state ---> S_FM_primary_call_cleared :  : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.560
SIP Call Control(590): ./src/cc_features.c:2729 Feature state change call leg 1 calltype 0 current_state 11 callref 129
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.560
SIP Call Control(590): ./src/cc_features.c:2729 Feature state change call leg 2 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.560
SIP Call Control(590): ./src/cc_features.c:2729 Feature state change call leg 3 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.578
SIP Call Control(590): ./src/cc_features.c:2729 Feature state change call leg 4 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.578
SIP Call Control(590): ./src/cc_features.c:2729 Feature state change call leg 5 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.578
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.578
SIP Call Control(590): ./src/cc_tracing.c:650 CALLREC FREE = 129 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.578
SIP Call Control(590): ./src/cc_tracing.c:657 Failed to find callref for calltype: ccIsolatedCall : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.579
SIP Call Control(590): ./src/cc_features.c:10673 lockSIPLine(0xa60280, -1) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.579
SIP Call Control(590): ./src/cc_tracing.c:473 Line 0: E_FM_wait:   S_FM_primary_call_cleared ---> S_FM_idle :  : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.579
SIP Call Control(590): ./src/cc_features.c:2729 Feature state change call leg 1 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.579
SIP Call Control(590): ./src/cc_features.c:2729 Feature state change call leg 2 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.579
SIP Call Control(590): ./src/cc_features.c:2729 Feature state change call leg 3 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.579
SIP Call Control(590): ./src/cc_features.c:2729 Feature state change call leg 4 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.579
SIP Call Control(590): ./src/cc_features.c:2729 Feature state change call leg 5 calltype 14 current_state 0 callref 0
 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.579
SIP Call Control(590): ./src/cc_features.c:10696 unlockSIPLine(0xa60280) - retval 1 : 0

___TRACE:___   Fri Sep 18 20:12:31 2015.579
SIP Signalling(590): ./src/sg_engine.cpp:12008 RemoveCallA() - unCallRefId(129)

___TRACE:___   Fri Sep 18 20:12:31 2015.579
SIP Signalling(590): ./src/sgCallRecordNew.cpp:1322 StopRetryTimer() - stopping RetryTimer((nil)) at call(129)

___TRACE:___   Fri Sep 18 20:12:31 2015.580
SIP Signalling(590): ./src/MediaSessionMgr.cpp:207 sgCloseSession() - closing pRtpSession(0x9f5af8) with handle(25)

___TRACE:___   Fri Sep 18 20:12:31 2015.592
SIP Signalling(3625): ./src/sg_engine.cpp:3963 EvMessageServiceMgrAwaken(0, 20, 0xa6d330)

___TRACE:___   Fri Sep 18 20:12:31 2015.592
SIP Signalling(3625): ./src/sg_engine.cpp:12029 InternalRemoveCallA() - unCallRefId(129) bCalledFromExt(1)

___TRACE:___   Fri Sep 18 20:12:31 2015.592
SIP Signalling(3625): ./src/sg_engine.cpp:4232 CSipEngine(0xa817c0)::StartTimer(129, 0xa5b4c0)

___TRACE:___   Fri Sep 18 20:12:31 2015.592
SIP Signalling(3625): ./src/sg_engine.cpp:4274 CSipEngine(0xa817c0)::StartTimerExit(0)

___TRACE:___   Fri Sep 18 20:12:31 2015.614
SIP Signalling(590): ./src/sgCallRecordMgmt.cpp:94 RemoveCallRecord() - CallRecord(129,129) removed, 0 CallRecord(s) left

___TRACE:___   Fri Sep 18 20:12:31 2015.615
SIP Signalling(590): ./src/sgCDispatcher.cpp:128 sgCDispatcher::sgParseIncomingMessage - event = 18; state = 2

___TRACE:___   Fri Sep 18 20:12:31 2015.615
SIP Signalling(590): ./src/sgCDispatcher.cpp:633 CC->SIG:  sgCallDisconnectedConfirm:

***ERROR:***   Fri Sep 18 20:12:31 2015.615
SIP Signalling(590): ./src/sgCallRecordMgmt.cpp:131 GetCallRecord() - CallRecord with CallRefId(129) not found

***ERROR:***   Fri Sep 18 20:12:31 2015.616
SIP Signalling(590): ./src/sg_call_service_ext.cpp:78 sgFarCallClearConfirm() - no CallRecord for callRefId(129) available

___TRACE:___   Fri Sep 18 20:13:05 2015.611
SIP Signalling(3625): ./src/sg_engine.cpp:4112 EvTimerServiceMgrAwaken(0, 129, 0xa5b4c0)

___TRACE:___   Fri Sep 18 20:13:05 2015.611
SIP Signalling(3625): ./src/sg_engine.cpp:4202 EvTimerServiceMgrAwaken() - default

___TRACE:___   Fri Sep 18 20:13:05 2015.611
SIP Signalling(3625): ./src/sg_engine.cpp:12029 InternalRemoveCallA() - unCallRefId(129) bCalledFromExt(0)

___TRACE:___   Fri Sep 18 20:13:05 2015.611
SIP Signalling(3625): ./src/sg_engine.cpp:12059 InternalRemoveCallA() - rejecting pActiveDialog(0xa74158) at CallInfo CallRefId(129)

___TRACE:___   Fri Sep 18 20:13:05 2015.611
SIP Signalling(3625): ./src/sg_engine.cpp:2389 InternalRejectA_Helper() - pDialog(0xa74158) SipContext(0xa5dc88) CallRefId(129)

***ERROR:***   Fri Sep 18 20:13:05 2015.611
SIP Signalling(3625): ./src/sg_engine.cpp:2466 InternalRejectA_Helper() - no ISipServerEventControl found for CallRefId(129) LineID(0)

***ERROR:***   Fri Sep 18 20:13:05 2015.611
SIP Signalling(3625): ./src/sg_engine.cpp:2574 InternalRejectA_Helper() - BYE ERROR, rres(80000002)(FE:Invalid state)

***ERROR:***   Fri Sep 18 20:13:05 2015.611
SIP Signalling(3625): ./src/sg_engine.cpp:12081 InternalRemoveCallA() - InternalRejectA_Helper() did not succeed, result(-2147483646,FE:Invalid state) pActiveDialog(0xa74158) CallRefId(129)

___TRACE:___   Fri Sep 18 20:13:05 2015.612
SIP Signalling(3625): ./src/sgCallInfoMgmt.cpp:74 RemoveCallInfo() - CallInfo(129) removed, 0 CallInfo(s) left

___TRACE:___   Fri Sep 18 20:13:17 2015.301
SIP Signalling(3625): ./src/sg_engine_reg.cpp:1145 EvExpiring(ISipRegistrationSvc)

___TRACE:___   Fri Sep 18 20:13:17 2015.302
SIP Signalling(3625): ./src/sg_engine_reg.cpp:1213 EvExpiring() - ReRegister line(0)

___TRACE:___   Fri Sep 18 20:13:17 2015.307
SIP Signalling(3625): ./src/sg_engine_reg.cpp:1234 EvExpiring() - AddLocalRegistration line(0)

___TRACE:___   Fri Sep 18 20:13:17 2015.309
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet Out--->192.168.178.2
REGISTER sip:192.168.178.2:5060;transport=udp SIP/2.0
Accept: application/dls-contact-me
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bK802ce05d71037e704
Max-Forwards: 70
From: "620" <sip:[email protected]:5060>;tag=6cd5dd4993;epid=SC0ab96e
To: <sip:[email protected]:5060>
Call-ID: 19014a7d52c3b634
CSeq: 367203758 REGISTER
Authorization: Digest username="620",realm="fritz.box",nonce="CA672A446FE6B847",uri="sip:192.168.178.2:5060;transport=udp",response="0b9eb3d953f54826a4736cb3e66fc263"
Contact: "620" <sip:[email protected]:5060;transport=udp>;expires=3600
Supported: X-Siemens-Proxy-State
User-Agent: OpenStage_40_V3 R1.50.0      SIP  131206 simple-uaCSTA
X-Siemens-IID: 802MAC=001ae80ab96e
Content-Length: 0



___TRACE:___   Fri Sep 18 20:13:17 2015.316
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet In <---192.168.178.2
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bK802ce05d71037e704
From: "620" <sip:[email protected]:5060>;tag=6cd5dd4993;epid=SC0ab96e
To: <sip:[email protected]:5060>;tag=248882F3DC75DB4F
Call-ID: 19014a7d52c3b634
CSeq: 367203758 REGISTER
WWW-Authenticate: Digest realm="fritz.box", nonce="4F7C84971B0DDDBE"
User-Agent: FRITZ!OS
Content-Length: 0



___TRACE:___   Fri Sep 18 20:13:17 2015.316
SIP Signalling(3626): ./src/sg_engine.cpp:9192 EvPacketReceived(ISipTransportObserver) - RES Code(401) Method(REGISTER)

___TRACE:___   Fri Sep 18 20:13:17 2015.317
SIP Signalling(3625): ./src/sg_engine_auth.cpp:269 EvCredentialsExist()

___TRACE:___   Fri Sep 18 20:13:17 2015.323
SIP Signalling(3625): ./src/sg_engine_auth.cpp:316 EvCredentialsExist() - request was reissued

___TRACE:___   Fri Sep 18 20:13:17 2015.325
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet Out--->192.168.178.2
REGISTER sip:192.168.178.2:5060;transport=udp SIP/2.0
Accept: application/dls-contact-me
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bKdbe26ebc89db6f8e3
Max-Forwards: 70
From: "620" <sip:[email protected]:5060>;tag=6cd5dd4993;epid=SC0ab96e
To: <sip:[email protected]:5060>
Call-ID: 19014a7d52c3b634
CSeq: 367203759 REGISTER
Authorization: Digest username="620",realm="fritz.box",nonce="4F7C84971B0DDDBE",uri="sip:192.168.178.2:5060;transport=udp",response="1f628175bc9d19f8b42b35c2459f97c8"
Contact: "620" <sip:[email protected]:5060;transport=udp>;expires=3600
Supported: X-Siemens-Proxy-State
User-Agent: OpenStage_40_V3 R1.50.0      SIP  131206 simple-uaCSTA
X-Siemens-IID: 802MAC=001ae80ab96e
Content-Length: 0



___TRACE:___   Fri Sep 18 20:13:17 2015.333
SIP Messages(3626): ./src/sgCSipPacketLog.cpp:112 :

	Packet In <---192.168.178.2
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.178.50;branch=z9hG4bKdbe26ebc89db6f8e3
From: "620" <sip:[email protected]:5060>;tag=6cd5dd4993;epid=SC0ab96e
To: <sip:[email protected]:5060>;tag=F6C71DB66AE57665
Call-ID: 19014a7d52c3b634
CSeq: 367203759 REGISTER
Contact: "620" <sip:[email protected]:5060;transport=udp>;expires=300
User-Agent: AVM FRITZ!Box Fon WLAN 7390 (UI) 84.06.30 (Jul 10 2015)
Supported: 100rel,replaces,timer
Allow-Events: telephone-event,refer,reg
Allow: INVITE,ACK,OPTIONS,CANCEL,BYE,UPDATE,PRACK,INFO,SUBSCRIBE,NOTIFY,REFER,MESSAGE,PUBLISH
Accept: application/sdp, multipart/mixed
Accept-Encoding: identity
Content-Length: 0



___TRACE:___   Fri Sep 18 20:13:17 2015.333
SIP Signalling(3626): ./src/sg_engine.cpp:9192 EvPacketReceived(ISipTransportObserver) - RES Code(200) Method(REGISTER)

___TRACE:___   Fri Sep 18 20:13:17 2015.334
SIP Signalling(3625): ./src/sg_engine_reg.cpp:667 EvSuccess(ISipRegistrationSvc)

___TRACE:___   Fri Sep 18 20:13:17 2015.335
SIP Signalling(3625): ./src/sg_engine_reg.cpp:683 ManageRegStatus() - received 200 response (EvSuccess)

~~~DEBUG:~~~   Fri Sep 18 20:13:17 2015.335
SIP Signalling(3625): ./src/SIP_Service.cpp:194 SIP_Service::dispatchMsgToSignalling: entering

___TRACE:___   Fri Sep 18 20:13:17 2015.336
SIP Signalling(3625): ./src/sg_engine_events.cpp:3960 SetServerStatus: (1), current server status: (1)

___TRACE:___   Fri Sep 18 20:13:17 2015.336
SIP Signalling(3625): ./src/sg_events.cpp:143 STK->SG: Registration State Change, State=Register OK, Line ID=0:

~~~DEBUG:~~~   Fri Sep 18 20:13:17 2015.336
SIP Signalling(3625): ./src/SIP_Service.cpp:194 SIP_Service::dispatchMsgToSignalling: entering

___TRACE:___   Fri Sep 18 20:13:17 2015.337
SIP Signalling(590): ./src/sgCDispatcher.cpp:128 sgCDispatcher::sgParseIncomingMessage - event = 112; state = 2

___TRACE:___   Fri Sep 18 20:13:17 2015.338
SIP Signalling(590): ./src/sg_reg_service.cpp:1147 SIG->CC: sgPrimaryRouteStatus()/sgEvPrimaryRouteStatus - unLineID(0,0) unState(1)

~~~DEBUG:~~~   Fri Sep 18 20:13:17 2015.338
SIP Signalling(590): ./src/SIP_Service.cpp:185 createSIPService: call HandleSignallingEvent

___TRACE:___   Fri Sep 18 20:13:17 2015.338
SIP Call Control(590): ./src/cc_sig_events.c:52 HandleSignallingEvent - received event. Event: : 88

___TRACE:___   Fri Sep 18 20:13:17 2015.338
SIP Signalling(590): ./src/sgCDispatcher.cpp:128 sgCDispatcher::sgParseIncomingMessage - event = 105; state = 2

___TRACE:___   Fri Sep 18 20:13:17 2015.338
SIP Signalling(590): ./src/sgCDispatcher.cpp:454 SIG->SIG:  sipRegistrationStateChanged: state=1  code=200

___TRACE:___   Fri Sep 18 20:13:17 2015.338
SIP Signalling(590): ./src/sg_reg_service.cpp:387 sgRegRegistered() - unLineID(0) eRegistrationState(2) bUnRegisterA(0)

___TRACE:___   Fri Sep 18 20:13:17 2015.338
SIP Signalling(590): ./src/sg_reg_service.cpp:450 sgRegRegistered() - register of line(0) will not be forwarded to CC (refresh)

Hilft das schon weiter ? Oder braucht es noch mehr Infos ?

Hinweis:
  • bei den Stellen sip:020000000@ steht natürlich die komplette gewählte Rufnummer, diese habe ich aber erstmal durch 0 ersetzt.
  • 192.168.178.2 ist die IP der Fritz!Box
  • 192.168.178.50 ist die IP des OpenStage
 
Ja, aus irgendeinem Grund bekommt das Phone nach einer Ansage/Ringtone von der fritz.box ein 603 Decline.
Keine Ahnung, ob man herausfinden kann, wer das Decline generiert (ob fritz.box oder doch das angerufene Phone ...).

Kannst du zum Vergleich auch einen "normal gewählten" Anruf zur selben Nummer anhängen, der gut geht ?

Vielleicht sieht man ja am INVITE dann, obs einen Unterschied gibt (müsste einen geben) - wenns keinen gibt, dann liegts nicht am Phone (behaupt ich mal).
 
Um antworten zu können musst du eingeloggt sein.
Kostenlos!
Jetzt holen

Neueste Beiträge

Kategorien

Wissenswertes

Statistik des Forums

Themen
248,890
Beiträge
2,304,039
Mitglieder
378,570
Neuestes Mitglied
domitrader

3CX jetzt einen Monat kostenlos testen

Die Verbindung, Zusammenarbeit und Kommunikation mit Ihrem Team und Ihren Kunden war noch nie so einfach. Nutzen Sie unsere kostenlose 30-Tage-Testversion und entdecken Sie die richtige Lösung für Ihr Unternehmen.

3CX start your free trial guy
Für diese E-Mail-Adresse besteht bereits ein 3CX-Konto. Sie werden zum Kundenportal weitergeleitet, wo Sie sich anmelden oder Ihr Passwort zurücksetzen können, falls Sie dieses vergessen haben.
| Style by ThemeHouse
XenPorta 2 PRO © Jason Axelrod of 8WAYRUN
Oben Unten