0131091714|sip |1|03|TimeOut500ms Call (0x95d14b90) finished
0131091725|efk |1|03|Macro [groupcallpickup] is valid.
0131091725|efk |1|03|Action [groupcallpickup] looks good.
0131091725|efk |1|03|No more input...
0131091725|efk |1|03|Efk exec engine: adding token [groupcallpickup]
0131091725|efk |1|03|User buffer contains [groupcallpickup].
0131091725|efk |1|03|EFK buffer not empty but no action assigned.
0131091725|efk |1|03|EFK Exec engine will invoke default dialing behavior.
0131091725|app1 |1|03|AppPhoneC::isCallSupportedOn( pRegLine 0x956ae310 ), returning true
0131091725|app1 |1|03|AppPhoneC::isCallSupportedOn( pKeyLine 0x956a1fe0 ), returning true
0131091725|app1 |1|03|AppPhoneC::isCallSupportedOn( index 0 ), returning true
0131091725|app1 |1|03|[AppPhoneC::GetNewCallKeyLine()], free calls available on line pLine 0x956a1fe0
0131091725|app1 |1|03|AppPhoneC::isCallSupportedOn( pRegLine 0x956ae310 ), returning true
0131091725|app1 |1|03|AppPhoneC::isCallSupportedOn( pKeyLine 0x956a1fe0 ), returning true
0131091725|app1 |1|03|AppPhoneC::isCallSupportedOn( index 0 ), returning true
0131091725|app1 |1|03|[AppPhoneC::GetNewCallKeyLine()], free calls available on line pLine 0x956a1fe0
0131091725|app1 |1|03|[AppCallC::NewCall] Line -1
0131091725|app1 |1|03|AppPhoneC::isCallSupportedOn( pRegLine 0x956ae310 ), returning true
0131091725|app1 |1|03|AppPhoneC::isCallSupportedOn( pKeyLine 0x956a1fe0 ), returning true
0131091725|app1 |1|03|AppPhoneC::isCallSupportedOn( index 0 ), returning true
0131091725|app1 |1|03|[AppPhoneC::GetNewCallKeyLine()], free calls available on line pLine 0x956a1fe0
0131091725|app1 |1|03|[AppAudioC::SetAudioTerm] to SO = 2
0131091725|app1 |2|03|[AppHybridC::soMediaSessCbFunc] processing event 2
0131091725|app1 |2|03|[AppHybridC::soMediaSessCbFunc] processing event 1
0131091725|app1 |1|03|[AppCallC::NewCall] call created(0x9576d730) CallState(8192) this=(-1790558688)
0131091725|efk |1|03|Dialing [groupcallpickup].
0131091725|app1 |2|03|[AppCallC::Call], szDest=[groupcallpickup], szDisplay=[EFK Dial], dialSource=[4]
0131091725|efk |1|03|EFK Exec engine said we are done and will stop.
0131091725|app1 |1|03|Event: AppEvLclSoMediaSessState
0131091725|app1 |2|03|fsmCall() - AppEvLclSoMediaSessState: From So 9576d730
0131091725|app1 |2|03|OnEvCallNewState Usr(0x9576d730) St(1) Srv(0) Line 0
0131091725|app1 |2|03|[AppCallC::Call], szDest=[groupcallpickup], szDisplay=[EFK Dial], dialSource=[4]
0131091725|sip |2|03|SipCallNew 0 local port 10028 call appearance -1 IsRtrv 0 dialog 0
0131091725|sip |2|03|CStkDialog::CStkDialogSetAddressLocalConfig '4708' <:0>
0131091725|sip |2|03|CStkDialog::CStkDialogAddressLocal set to Config
0131091725|sip |3|03|CStkDialog::SetAddressLocallocalTag set to ''
0131091725|sip |3|03|CStkDialog::SetAddressLocal new address added of 1
0131091725|sip |2|03|CStkDialog::CStkDialog TAG '281B5295-DBCAFA41' generated
0131091725|sip |2|03|CStkDialog::CStkDialog local addr '4708' <:0> Tag '281B5295-DBCAFA41'
0131091725|sip |2|03|CStkDialog::CStkDialog exit 0x95cca6e8 local list size 1
0131091725|sip |2|03|CStkDialogList::CreateDialogObjectlocalTargusr '4708'
0131091725|sip |2|03|CUser::CallNew 0x9576d730 0x95d14b90 CallAppr 0 IsRetrieve 0 ThrdParty '' Dialog 0x0 isCentConf 0
0131091725|sip |3|03|CStkCall::NewCallState reason 15 'Unknown'->'Dialtone' (0x95d14b90)
0131091725|sip |2|03|SipOnEvCallNewState 95d14b90,9576d730 0,Dialtone
0131091725|app1 |2|03|[AppHybridC::soMediaSessCbFunc] processing event 1
0131091725|sip |2|03|SipCallMake groupcallpickup
0131091725|sip |2|03|new UA Client INVITE trans state 'callingTrying', timeout=0 (0x95d48bb0)
0131091725|sip |1|03|CreateFailOverProxyList : Reg to Domain '192.168.2.50' nPort 5060
0131091725|sip |1|03|CreateFailOverProxyList : For INVITE Request nPort 5060
0131091725|sip |1|03|doDnsListLookup(udp): doDnsSrvLookupForARecordList for '192.168.2.50' port 5060 returned 1 results
0131091725|sip |1|03|doDnsListLookup(udp): result 0 '192.168.2.50' port 5060 isInBound 0
0131091725|sip |1|03|CreateFailOverProxyList : 'UDP Only' for '192.168.2.50' port 5060 IP 0 is '192.168.2.50' on udp port 5060
0131091725|sip |1|03|CreateFailOverProxyList : 'UDP Only' Add rest Total to Try 3
0131091725|sip |1|03|doDnsListLookup(udp): doDnsSrvLookupForARecordList for '192.168.2.49' port 5060 returned 1 results
0131091725|sip |1|03|doDnsListLookup(udp): result 0 '192.168.2.49' port 5060 isInBound 0
0131091725|sip |1|03|CreateFailOverProxyList : 'UDP Only' Add rest '192.168.2.49' IP 1 is '192.168.2.49' on udp
0131091725|sip |1|03|doDnsListLookup(udp): doDnsSrvLookupForARecordList for '67.222.137.179' port 5060 returned 1 results
0131091725|sip |1|03|doDnsListLookup(udp): result 0 '67.222.137.179' port 5060 isInBound 0
0131091725|sip |1|03|CreateFailOverProxyList : 'UDP Only' Add rest '67.222.137.179' IP 2 is '67.222.137.179' on udp
0131091725|sip |2|03|CreateFailOverProxyList : Exit 'UDP Only' lookup with 3 IP Addresses
0131091725|sip |2|03|CreateFailOverProxyList : IP 1 is '192.168.2.50' on udp port 5060
0131091725|sip |2|03|CreateFailOverProxyList : IP 2 is '192.168.2.49' on udp port 5060
0131091725|sip |2|03|CreateFailOverProxyList : IP 3 is '67.222.137.179' on udp port 5060
0131091725|sip |3|03|CStkCall::NewCallState reason 15 'Dialtone'->'Proceeding' (0x95d14b90)
0131091725|sip |2|03|SipOnEvCallNewState 95d14b90,9576d730 2,Proceeding
0131091725|app1 |2|03|[AppHybridC::soMediaSessCbFunc] processing event 1
0131091725|app1 |2|03|[AppCallC::Call] desType[1] Des=[groupcallpickup] Display=[EFK Dial], DialPlan=1, dialSource=4
0131091725|app1 |2|03|AppUiC::CallStateChange Line[0].State[4]
0131091725|app1 |1|03|AppUiC::CallStateChangenOldOrder 0 nNewOrder 0
0131091725|sip |1|03|SipOnCommand: response 401,INVITE
0131091725|sip |1|03|SipOnCommand: response 401,INVITE matches user 1 of 3 '4708'
0131091725|sip |3|03|UA Client INVITE INVITE trans state 'callingTrying'->'completed' by 401 resp 65 timeout(0x95d48bb0)
0131091725|sip |2|03|CTrans:: INVITE InvTranreTrans ALREADY stopped in 'completed' state at retryCount 1 code 401, timeout=65 (0x95d48bb0)
0131091725|sip |3|03|401 challenge received
0131091725|sip |2|03|new UA Client INVITE trans state 'callingTrying', timeout=0 (0x95d4a7b0)
0131091725|sip |1|03|Digest authentication
0131091725|sip |1|03|CreateFailOverProxyList : Reg to Domain '192.168.2.50' nPort 5060
0131091725|sip |1|03|CreateFailOverProxyList : For INVITE Request nPort 5060
0131091725|sip |1|03|doDnsListLookup(udp): doDnsSrvLookupForARecordList for '192.168.2.50' port 5060 returned 1 results
0131091725|sip |1|03|doDnsListLookup(udp): result 0 '192.168.2.50' port 5060 isInBound 0
0131091725|sip |1|03|CreateFailOverProxyList : 'UDP Only' for '192.168.2.50' port 5060 IP 0 is '192.168.2.50' on udp port 5060
0131091725|sip |1|03|CreateFailOverProxyList : 'UDP Only' Add rest Total to Try 3
0131091725|sip |1|03|doDnsListLookup(udp): doDnsSrvLookupForARecordList for '192.168.2.49' port 5060 returned 1 results
0131091725|sip |1|03|doDnsListLookup(udp): result 0 '192.168.2.49' port 5060 isInBound 0
0131091725|sip |1|03|CreateFailOverProxyList : 'UDP Only' Add rest '192.168.2.49' IP 1 is '192.168.2.49' on udp
0131091725|sip |1|03|doDnsListLookup(udp): doDnsSrvLookupForARecordList for '67.222.137.179' port 5060 returned 1 results
0131091725|sip |1|03|doDnsListLookup(udp): result 0 '67.222.137.179' port 5060 isInBound 0
0131091725|sip |1|03|CreateFailOverProxyList : 'UDP Only' Add rest '67.222.137.179' IP 2 is '67.222.137.179' on udp
0131091725|sip |2|03|CreateFailOverProxyList : Exit 'UDP Only' lookup with 3 IP Addresses
0131091725|sip |2|03|CreateFailOverProxyList : IP 1 is '192.168.2.50' on udp port 5060
0131091725|sip |2|03|CreateFailOverProxyList : IP 2 is '192.168.2.49' on udp port 5060
0131091725|sip |2|03|CreateFailOverProxyList : IP 3 is '67.222.137.179' on udp port 5060
0131091725|sip |1|03|SipOnCommand: response 100,INVITE
0131091725|sip |1|03|SipOnCommand: response 100,INVITE matches user 1 of 3 '4708'
0131091725|sip |3|03|CStateInviteServer::CStateInviteServer central conf user user '' found in contact user 'groupcallpickup' for cent conf URI ''. Set is focus
0131091725|sip |3|03|CCallBase::OnEvResponseisFocus set for call 0x95d14b90
0131091725|sip |3|03|UA Client INVITE INVITE trans state 'callingTrying'->'proceeding' by 100 resp 65 timeout(0x95d4a7b0)
0131091725|sip |2|03|CTrans:: INVITE InvTranreTrans ALREADY stopped in 'proceeding' state at retryCount 0 code 100, timeout=65 (0x95d4a7b0)
0131091725|sip |3|03|GetRemotePartyAddress from 'To'
0131091725|sip |3|03|CStkCall::OnEvNewDest (0x95d14b90) new display '' user 'groupcallpickup' old 'From' new 'To' source
0131091725|sip |2|03|SipOnEvNewDest 95d14b90,9576d730,groupcallpickup,
0131091725|app1 |2|03|[AppHybridC] soNcasLookupCbFunc (0x9576d730) Type 2 - Addr 'groupcallpickup' Name 'groupcallpickup'
0131091725|app1 |2|03|[AppHybridC] hanldeCallService - Event: 0x9
0131091725|sip |3|03|CStkCall::NewCallState reason 15 'Proceeding'->'Proceeding' (0x95d14b90)
0131091725|sip |2|03|SipOnEvCallNewState 95d14b90,9576d730 2,Proceeding
0131091725|app1 |1|03|[AppUiC]: notifyText - in Call stated
0131091725|app1 |1|03|AppCallDisplayC::DisplaypCall = 95463e20, nState = 4
0131091725|app1 |1|03|[AppUiC]: notifyText - in Call stated
0131091725|sip |1|03|SipOnCommand: response 200,INVITE
0131091725|sip |1|03|SipOnCommand: response 200,INVITE matches user 1 of 3 '4708'
0131091725|sip |3|03|UA Client INVITE INVITE trans state 'proceeding'->'terminated' by 200 resp 0 timeout(0x95d4a7b0)
0131091725|sip |1|03|CreateFailOverProxyList : Reg to Domain '192.168.2.50' nPort 5060
0131091725|sip |1|03|CreateFailOverProxyList : For ACK Request nPort 5060
0131091725|sip |1|03|doDnsListLookup(udp): doDnsSrvLookupForARecordList for '192.168.2.50' port 5060 returned 1 results
0131091725|sip |1|03|doDnsListLookup(udp): result 0 '192.168.2.50' port 5060 isInBound 0
0131091725|sip |1|03|CreateFailOverProxyList : 'UDP Only' for '192.168.2.50' port 5060 IP 0 is '192.168.2.50' on udp port 5060
0131091725|sip |2|03|CreateFailOverProxyList : Exit 'UDP Only' lookup with 1 IP Addresses
0131091725|sip |2|03|CreateFailOverProxyList : IP 1 is '192.168.2.50' on udp port 5060
0131091725|sip |3|03|GetRemotePartyAddress from 'To'
0131091725|sip |3|03|CStkCall::OnEvNewDest Unchanged display '' user 'groupcallpickup'
0131091725|sip |3|03|CStkCall::OnEvNewDest (0x95d14b90) refreshing '' user 'groupcallpickup' source 'To'
0131091725|sip |2|03|SipOnEvNewDest 95d14b90,9576d730,groupcallpickup,
0131091725|app1 |2|03|[AppHybridC] soNcasLookupCbFunc (0x9576d730) Type 2 - Addr 'groupcallpickup' Name 'groupcallpickup'
0131091725|app1 |2|03|[AppHybridC] hanldeCallService - Event: 0x9
0131091725|sip |2|03|CStateInviteClient::OnEvResponse Normal case
0131091725|sip |3|03|CStkCall::RemoteSdpAnswer(1) -> ReportCodec( 1)
0131091725|sip |2|03|CStkCall::ReportCodec: held set to false
0131091725|sip |2|03|SipOnEvNewCodec c0a80232,18 18 G729/8000 10972,10028 ptime=20,dir 2 index 0 lastCodec 1 callWithVideo 0 bandwidth -1
0131091725|sip |2|03|SipOnEvNewCodec c0a80232,127 127 telephone-event/8000 10972,10028 ptime=0,dir 2 index 0 lastCodec 1 callWithVideo 0 bandwidth -1
0131091725|efk |1|03|Got call state change: [4]
0131091725|app1 |1|03|Event: AppEvLclSoMediaSessState
0131091725|app1 |2|03|fsmCall() - AppEvLclSoMediaSessState: From So 9576d730
0131091725|app1 |2|03|OnEvCallNewState Usr(0x9576d730) St(2) Srv(0) Line 0
0131091725|app1 |2|03|AppUiC::CallStateChange Line[0].State[2]
0131091725|app1 |1|03|AppUiC::CallStateChangenOldOrder 0 nNewOrder 0
0131091725|app1 |1|03|AppCallDisplayC::DisplaypCall = 95463e20, nState = 2
0131091725|efk |1|03|Got call state change: [2]
0131091725|app1 |1|03|Event: AppEvLclSoMediaSessState
0131091725|app1 |2|03|fsmCall() - AppEvLclSoMediaSessState: From So 9576d730
0131091725|app1 |2|03|OnEvCallNewState Usr(0x9576d730) St(4) Srv(0) Line 0
0131091725|app1 |2|03|AppUiC::CallStateChange Line[0].State[4]
0131091725|app1 |1|03|AppUiC::CallStateChangenOldOrder 0 nNewOrder 0
0131091725|app1 |1|03|[AppUiC]: notifyText - in Call stated
0131091725|app1 |1|03|AppCallDisplayC::DisplaypCall = 95463e20, nState = 4
0131091725|sip |3|03|CStkCall::ReportCodec: call state 'Proceeding' exit with held 0 (0x95d14b90)
0131091725|sip |1|03|Dialog 'id539d2e51' State 'Trying'->'Confirmed'
0131091725|sip |3|03|CStkCall::NewCallState reason 15 'Proceeding'->'Connected' (0x95d14b90)
0131091725|sip |2|03|SipOnEvCallNewState 95d14b90,9576d730 4,Connected
0131091725|sip |2|03|SipOnEvRtcpFBNegotiated 0
0131091725|sip |3|03|SipOnEvCallNewState pStkCall->m_bIsRTCFBReceived= 0
0131091725|app1 |1|03|[AppUiC]: notifyText - in Call stated
0131091725|efk |1|03|Got call state change: [4]
0131091725|app1 |1|03|Event: AppEvLclNewMessage
0131091725|app1 |2|03|[AppHybridC::soMediaSessCbFunc] processing event 1
0131091725|app1 |2|03|[AppHybridC::soMediaSessCbFunc] processing event 2
0131091725|app1 |2|03|AppPhoneC::OnEvNewDestgroupcallpickupgroupcallpickup
0131091725|app1 |1|03|[AppUiC]: notifyText - in Call stated
0131091725|app1 |1|03|AppCallDisplayC::DisplaypCall = 95463e20, nState = 4
0131091725|app1 |1|03|Event: AppEvLclNewMessage
0131091725|app1 |2|03|AppPhoneC::OnEvNewDestgroupcallpickupgroupcallpickup
0131091725|app1 |1|03|[AppUiC]: notifyText - in Call stated
0131091725|app1 |1|03|AppCallDisplayC::DisplaypCall = 95463e20, nState = 4
0131091725|app1 |1|03|Event: AppEvLclKeyRel
0131091725|app1 |1|03|Event: AppEvLclSoMediaSessState
0131091725|app1 |2|03|fsmCall() - AppEvLclSoMediaSessState: From So 9576d730
0131091725|app1 |2|03|OnEvCallNewState Usr(0x9576d730) St(6) Srv(0) Line 0
0131091725|app1 |2|03|AppUiC::CallStateChange Line[0].State[6]
0131091725|app1 |1|03|AppUiC::CallStateChangenOldOrder 0 nNewOrder 0
0131091725|app1 |1|03|[AppUiC]: notifyText - in Call stated
0131091725|app1 |1|03|AppCallDisplayC::DisplaypCall = 95463e20, nState = 6
0131091725|efk |1|03|Got call state change: [6]
0131091725|efk |1|03|EFK is in connected state.
0131091727|sip |2|03|CCallBase::IsChallenged 'BYE' Dialog Tag '281B5295-DBCAFA41' pRequest Tag '281B5295-DBCAFA41' state 'Confirmed'
0131091727|sip |2|03|new UA Server Non-INVITE trans state 'callingTrying', timeout=0 (0x95d4c9f0)
0131091727|sip |3|03|UA Server Non-INVITE BYE trans state 'callingTrying'->'completed' by 200 resp 65 timeout(0x95d4c9f0)
0131091727|sip |1|03|Dialog 'id539d2e51' State 'Confirmed'->'Terminated'
0131091727|sip |1|03|doDnsListLookup(udp): doDnsSrvLookupForARecordList for '192.168.2.50' port 5060 returned 1 results
0131091727|sip |1|03|doDnsListLookup(udp): result 0 '192.168.2.50' port 5060 isInBound 0
0131091728|sip |2|03|CTrans::InitRetrans for UA Server Non-INVITE BYE state 'completed' Server 1 of 1 (0x95d4c9f0)
0131091728|sip |3|03|CStkCall::NewCallState reason 15 'Connected'->'Idle' (0x95d14b90)
0131091728|sip |2|03|SipOnEvCallNewState 95d14b90,9576d730 10,Idle
0131091728|app1 |2|03|[AppHybridC::soMediaSessCbFunc] processing event 2
0131091728|app1 |2|03|[AppHybridC::soMediaSessCbFunc] processing event 1
0131091728|app1 |2|03|[AppHybridC::soMediaSessCbFunc] processing event 1
0131091728|sip |2|03|SipCallDrop 95d14b90,9576d730 reason 6
0131091728|sip |3|03|CStkCall::Drop(reason = 6) (0x95d14b90)
0131091728|sip |3|03|CStkCall::NewCallState reason 15 'Idle'->'Idle' (0x95d14b90)
0131091728|sip |1|03|CStkCall::NewCallState Already Idle returning (0x95d14b90)
0131091728|app1 |1|03|Event: AppEvLclSoMediaSessState
0131091728|app1 |2|03|fsmCall() - AppEvLclSoMediaSessState: From So 9576d730
0131091728|app1 |2|03|[AppPhoneC::OnEvCallNewState] SoMediaSessStateDisconnected, call dropped because of : 3, m_hsCall(Ox9576d730):usrCall(Ox9576d730)
0131091728|app1 |2|03|OnEvCallNewState Usr(0x9576d730) St(7) Srv(0) Line 0
0131091728|app1 |2|03|AppUiC::CallStateChange Line[0].State[7]
0131091728|app1 |1|03|AppUiC::CallStateChangenOldOrder 0 nNewOrder 0
0131091728|app1 |1|03|AppCallDisplayC::DisplaypCall = 95463e20, nState = 7
0131091728|efk |1|03|Got call state change: [7]
0131091728|app1 |1|03|Event: AppEvLclSoMediaSessState
0131091728|app1 |2|03|fsmCall() - AppEvLclSoMediaSessState: From So 9576d730
0131091728|app1 |2|03|OnEvCallNewState Usr(0x9576d730) St(0) Srv(0) Line 0
0131091728|app1 |2|03|AppUiC::CallStateChange Line[0].State[0]
0131091728|app1 |1|03|AppUiC::CallStateChangenOldOrder 0 nNewOrder 0
0131091728|app1 |1|03|[AppUiC]: notifyText - in Call stated
0131091728|app1 |1|03|[AppAudioC::SetAudioTerm] to SO = 10
0131091728|efk |1|03|Got call state change: [0]
0131091728|copy |*|03|Server '192.168.2.8' said '0004f2477ae9-app.log' is not present
0131091728|log |4|03|UtilLogC::uploadFifoLog: upload error. protocol 0 result = -1