PCCE Outbound Dialer - Transferring customer call to agents are failing

[wahyukurnia]

Hi all,

I have PCCE 10.5.

Inbound call already worked properly.

Now I am trying enabling SIP Dialer using Preview Dialer method.

The import procedure worked properly.

The dialer can reserve an agent while the agent was in ready state.

When the agent press "Accept" button, the dialed number was ringing. When the dialed number answered the call, it suddenly disconnected.

I got following trace result:

--- from Dialer ---

SIP/2.0 200 OK

Via: SIP/2.0/UDP 172.18.19.253:5060;branch=z9hG4bK4563A0140E

Contact: <sip:40002@172.18.19.30:58800>

To: <sip:40002@172.18.19.30>;tag=f0680445

From: <sip:9120818183468@172.18.19.253>;tag=423B02F0-CFE

Call-ID: 6b619217-3b1a9d14-ee270414-bc4e4f1c

CSeq: 102 NOTIFY

User-Agent: Cisco-SIPDialer/UCCE10.0

Content-Length: 0

.
14:45:01:648 dialer-baDialer Trace: (RESIP) Adding message to tx buffer to: [ V4 172.18.19.253:5060 UDP target domain=unspecified mFlowKey=864 ].
14:45:01:663 dialer-baDialer Trace: (SGM) Skill group stats received, SG: 5504904, agents - logged in: 1, available: 0.
14:45:01:663 dialer-baDialer Trace: (DD) Softphone connection event, phone: 9120818183468, result: ERROR, port: 002, state: TRANSFER,.
14:45:01:663 dialer-baDialer Trace: (CLMGR) CTI SetCallData request, invoke: 97826, port: 002, call: 1701804067
  type: 32, disposition: 26, ani: [0818183468]
  campaign: 0 [], query rule: 0, acc#: []
  status: [], response: [CPA_Voice], list id: [], time zone: []
  CallerEnteredDigits: [NULL], customer name: [,], skill target id: , CallOriginated: [NULL].
14:45:01:663 dialer-baDialer Trace: (CUST) SetCallResult, id: 28 in DL_5000_5000, skill: 5240, result: 2 [DIAL_ERROR], now: [Mon Apr 27 14:45:01 2015], callback: [Mon Apr 27 14:44:12 2015].
14:45:01:663 dialer-baDialer Trace: (PVD) Received Telephony Event port: 002, connection state: 150.
14:45:01:663 dialer-baDialer Trace: (PVD) Received Telephony event port: 002, state: TRANSFER, Transfer Failed, ConnState: 150.
14:45:01:663 dialer-baDialer Trace: (PVD) ***End call event port: 002, state: TRANSFER***.
14:45:01:663 dialer-baDialer Trace: (PVR) Release agent request, port: 001, state: AGENT_RESERVE.
14:45:01:663 dialer-baDialer Trace: (PVR) End port: 001.
14:45:01:663 dialer-baDialer Trace: (CLMGR) CTI ClearConnection request, invoke: 97827, port: 001, call: 2130706442, instrument: [20251].
14:45:01:663 dialer-baDialer Trace: CCallManager::RemoveCall -> call: 2130706442.
14:45:01:663 dialer-baDialer Trace: (SIP) Hangup, port: 001.
14:45:01:663 dialer-baDialer Trace: (PM)
------------------------------
Release port: 001, state: [AGENT_RESERVE]
------------------------------.
14:45:01:663 dialer-baDialer Trace: (CPORT) SetState, port: 001, m_ReservationCallTime: 46644, state: IDLE.
14:45:01:663 dialer-baDialer Trace: (SIP) Hangup, port: 002.
14:45:01:663 dialer-baDialer Trace: (PM)
------------------------------
Release port: 002, state: [TRANSFER]
------------------------------.
14:45:01:663 dialer-baDialer Trace: (CPORT) SetState, port: 002, m_CustomerCallTime: 8907, state: IDLE.
14:45:01:663 dialer-baDialer Trace: (CM) Close record request, customer: 0818183468, Dial Id: 28 in DL_5000_5000, result: 2 [DIAL_ERROR].
14:45:01:663 dialer-baDialer Trace: (CUST) Record sent to campaign manager, id: 28 in DL_5000_5000, skill: 5240, result: 2 [DIAL_ERROR].
14:45:01:663 dialer-baDialer Trace: Info:: HandleByeMsg - SIP port: 001, station: 40001, state: SIP_LINESTATE_IDLE.
14:45:01:663 dialer-baDialer Trace: Info:: HandleByeMsg - SIP port: 002, station: 40002, state: SIP_LINESTATE_REFER_SENT.
14:45:01:663 dialer-baDialer Trace: Info:: HandleByeMsg -SIP port: 002, Resetting appDialogSet so Port would not be reachable for further SIP Msg.
14:45:01:663 dialer-baDialer Trace: (RESIP) InviteSession::Connected: end.
14:45:01:663 dialer-baDialer Trace: (RESIP) Dialog::makeRequest:

BYE sip:9120818183468@172.18.19.253:5060 SIP/2.0

Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-a552354ed93f0e77-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:40002>

To: <sip:9120818183468@172.18.19.253>;tag=423B02F0-CFE

From: <sip:40002@172.18.19.30>;tag=f0680445

Call-ID: 6b619217-3b1a9d14-ee270414-bc4e4f1c

CSeq: 5 BYE

Content-Length: 0

.
14:45:01:663 dialer-baDialer Trace: (RESIP) <sip:40002@172.18.19.30>;tag=f0680445 Sending BYE .
14:45:01:663 dialer-baDialer Trace: (RESIP) Looking for dialogSet: 6b619217-3b1a9d14-ee270414-bc4e4f1c-f0680445 in map:.
14:45:01:663 dialer-baDialer Trace: (CLMGR) Failure event, port: 002, id: 1701804067, reason: [E_CTI_INVALID_CALLID].
14:45:01:663 dialer-baDialer Trace: (RESIP) [6b619217-3b1a9d14-ee270414-bc4e4f1c-f0680445 -> 05E12C40].
14:45:01:663 dialer-baDialer Trace: (RESIP) SEND:

BYE sip:9120818183468@172.18.19.253:5060 SIP/2.0

Via: SIP/2.0/ ;branch=z9hG4bK-d8754z-636bd9214f5e1212-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:40002>

To: <sip:9120818183468@172.18.19.253>;tag=423B02F0-CFE

From: <sip:40002@172.18.19.30>;tag=f0680445

Call-ID: 6b619217-3b1a9d14-ee270414-bc4e4f1c

CSeq: 5 BYE

User-Agent: Cisco-SIPDialer/UCCE10.0

Content-Length: 0

.
14:45:01:663 dialer-baDialer Trace: (RESIP) Looking for dialogSet: 6b619217-3b1a9d14-ee270414-bc4e4f1c-f0680445 in map:.
14:45:01:663 dialer-baDialer Trace: (RESIP) [6b619217-3b1a9d14-ee270414-bc4e4f1c-f0680445 -> 05E12C40].
14:45:01:663 dialer-baDialer Trace: (RESIP) DialogId::DialogId: 6b619217-3b1a9d14-ee270414-bc4e4f1c-f0680445-423B02F0-CFE.
14:45:01:663 dialer-baDialer Trace: (RESIP) Send: SipReq:  BYE 9120818183468@172.18.19.253:5060 cid=6b619217-3b1a9d14-ee270414-bc4e4f1c tid=636bd9214f5e1212 cseq=BYE contact=40002 / 5 from(tu).
14:45:01:663 dialer-baDialer Trace: (RESIP) SEND: SipReq:  BYE 9120818183468@172.18.19.253:5060 cid=6b619217-3b1a9d14-ee270414-bc4e4f1c tid=636bd9214f5e1212 cseq=BYE contact=40002 / 5 from(tu).
14:45:01:663 dialer-baDialer Trace: (RESIP) Transition InviteSession::Connected -> InviteSession::Terminated.
14:45:01:663 dialer-baDialer Trace: SipISH-onTerminated:1
.
14:45:01:663 dialer-baDialer Trace: unable to find SIP port .
14:45:01:710 dialer-baDialer Trace: (RESIP) No matching transaction for SipReq:  BYE 9120818183468@172.18.19.253:5060 cid=6b619217-3b1a9d14-ee270414-bc4e4f1c tid=636bd9214f5e1212 cseq=BYE contact=40002 / 5 from(tu).
14:45:01:710 dialer-baDialer Trace: (RESIP) Creating new TransactionState: tid=636bd9214f5e1212 [ ClientNonInviteTrying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]].
14:45:01:710 dialer-baDialer Trace: (RESIP) TransactionState::processClientNonInvite: SipReq:  BYE 9120818183468@172.18.19.253:5060 cid=6b619217-3b1a9d14-ee270414-bc4e4f1c tid=636bd9214f5e1212 cseq=BYE contact=40002 / 5 from(tu).
14:45:01:710 dialer-baDialer Trace: (RESIP) Adding timer: Timer F tid=636bd9214f5e1212 ms=32000.
14:45:01:710 dialer-baDialer Trace: (RESIP) sendToWire with no dns result: tid=636bd9214f5e1212 [ ClientNonInviteTrying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]].
14:45:01:710 dialer-baDialer Trace: (RESIP) Looking up dns entries for sip:9120818183468@172.18.19.253:5060.
14:45:01:710 dialer-baDialer Trace: (RESIP) DnsResult::lookup sip:9120818183468@172.18.19.253:5060.
14:45:01:710 dialer-baDialer Trace: (RESIP) Numeric result so return immediately: [ V4 172.18.19.253:5060 UDP target domain=172.18.19.253 mFlowKey=0 ].
14:45:01:710 dialer-baDialer Trace: (RESIP) tid=636bd9214f5e1212 [ ClientNonInviteTrying reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]] got DNS result: 172.18.19.253 --> [[ V4 172.18.19.253:5060 UDP target domain=172.18.19.253 mFlowKey=0 ]].
14:45:01:710 dialer-baDialer Trace: (RESIP) Returning next dns entry: [ V4 172.18.19.253:5060 UDP target domain=172.18.19.253 mFlowKey=0 ].
14:45:01:710 dialer-baDialer Trace: (RESIP) Unreliable transport: tid=636bd9214f5e1212 [ ClientNonInviteTrying unreliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT target domain=unspecified mFlowKey=0 ]].
14:45:01:710 dialer-baDialer Trace: (RESIP) Adding timer: Timer E1 tid=636bd9214f5e1212 ms=500.
14:45:01:710 dialer-baDialer Trace: (RESIP) Best Route - subnet=172.18.19.0 net-mask=255.255.255.0 next-hop=0.0.0.0 if-index=16.
14:45:01:710 dialer-baDialer Trace: (RESIP) IP Table entry 1/3 if-index=16 NIC IP=172.18.19.30 NIC Mask=255.255.255.0.
14:45:01:710 dialer-baDialer Trace: (RESIP) IP Table entry 2/3 if-index=17 NIC IP=172.18.18.30 NIC Mask=255.255.255.0.
14:45:01:710 dialer-baDialer Trace: (RESIP) IP Table entry 3/3 if-index=1 NIC IP=127.0.0.1 NIC Mask=255.0.0.0.
14:45:01:710 dialer-baDialer Trace: (RESIP) Looked up source for destination: [ V4 172.18.19.253:5060 UDP target domain=172.18.19.253 mFlowKey=0 ] -> [ V4 172.18.19.30:0 UDP target domain=172.18.19.253 mFlowKey=0 ] sent-by= sent-port=0.
14:45:01:710 dialer-baDialer Trace: (RESIP) findTransportBySource([ V4 172.18.19.30:0 UDP target domain=172.18.19.253 mFlowKey=0 ]).
14:45:01:710 dialer-baDialer Trace: (RESIP) findTransport (any port, any interface) => Transport: [ V4 0.0.0.0:58800 UDP target domain=unspecified mFlowKey=864 ].
14:45:01:710 dialer-baDialer Trace: (RESIP) Transmitting to [ V4 172.18.19.253:5060 UDP target domain=172.18.19.253 mFlowKey=0 ] tlsDomain= via [ V4 172.18.19.30:58800 UDP target domain=172.18.19.253 mFlowKey=0 ]

BYE sip:9120818183468@172.18.19.253:5060 SIP/2.0

Via: SIP/2.0/UDP 172.18.19.30:58800;branch=z9hG4bK-d8754z-636bd9214f5e1212-1---d8754z-;rport

Max-Forwards: 70

Contact: <sip:40002@172.18.19.30:58800>

To: <sip:9120818183468@172.18.19.253>;tag=423B02F0-CFE

From: <sip:40002@172.18.19.30>;tag=f0680445

Call-ID: 6b619217-3b1a9d14-ee270414-bc4e4f1c

CSeq: 5 BYE

User-Agent: Cisco-SIPDialer/UCCE10.0

Content-Length: 0

--- from CTISERVER ---

14:45:01:663 cg1B-ctisvr Session 2: MsgType:SET_CALL_DATA_REQ (InvokeID:0x17e22 PeripheralID:5000 
14:45:01:663 cg1B-ctisvr Session 2:         ConnectionDeviceIDType:CONNECTION_ID_NONE ConnectionCallID:1701804067 NumNamedVariables:7 
14:45:01:663 cg1B-ctisvr Session 2:         NumNamedArrays:0 CallType:CALLTYPE_OO_CUSTOMER_PREVIEW CalledPartyDisposition:CD_UABORT 
14:45:01:663 cg1B-ctisvr Session 2:         CampaignID:0 QueryRuleID:0 ConnectionDeviceID:"" ANI:"0818183468" 
14:45:01:663 cg1B-ctisvr Session 2:         ExpandedCallContxt:<TotalBytes=116> BACampaign="" BAAccountNumber="" BABuddyName="," 
14:45:01:663 cg1B-ctisvr Session 2:         BAResponse="CPA_Voice" BAStatus="" BADialedListID="" BATimeZone="" CustomerPhoneNumber:"" 
14:45:01:663 cg1B-ctisvr Session 2:         CustomerAccountNumber:"" )
14:45:01:663 cg1B-ctisvr Trace:
.
14:45:01:663 cg1B-ctisvr Session 2: MsgType:CLEAR_CONNECTION_REQ (InvokeID:0x17e23 PeripheralID:5000 ConnectionCallID:2130706442 
14:45:01:663 cg1B-ctisvr Session 2:         ConnectionDeviceIDType:CONNECTION_ID_STATIC ConnectionDeviceID:"20251" 
14:45:01:663 cg1B-ctisvr Session 2:         AgentInstrument:"20251" )
14:45:01:663 cg1B-ctisvr Trace: CTIApplication::ProcessSetCallDataRequest - sessionID 2.
14:45:01:663 cg1B-ctisvr Trace: SET_CALL_DATA_REQ: InvokeID=0x345f7920 Periph=5000 CID=1701804067. Dest= AGTID= Srch=0 CallType=32, CPDisposition=26.
14:45:01:663 cg1B-ctisvr Trace: CampaignID=0 QueryRuleID=0 CallOriginatedFrom=0.
14:45:01:663 cg1B-ctisvr Trace:                    CustPhone#= CustAccount#= ANI=0818183468.
14:45:01:663 cg1B-ctisvr Trace: Name                           Type        Index    Value.
14:45:01:663 cg1B-ctisvr Trace: BACampaign                     Scalar               .
14:45:01:663 cg1B-ctisvr Trace: BAAccountNumber                Scalar               .
14:45:01:663 cg1B-ctisvr Trace: BABuddyName                    Scalar               ,.
14:45:01:663 cg1B-ctisvr Trace: BAResponse                     Scalar               CPA_Voice.
14:45:01:663 cg1B-ctisvr Trace: BAStatus                       Scalar               .
14:45:01:663 cg1B-ctisvr Trace: BADialedListID                 Scalar               .
14:45:01:663 cg1B-ctisvr Trace: BATimeZone                     Scalar               .
14:45:01:663 cg1B-ctisvr Trace: ProcessClearConnectionRequest - sessionID 2.
14:45:01:663 cg1B-ctisvr Trace: CSTAClearConnection:  InvokeID=0x345f7921 Call(CID=2130706442,Dev=20251,Type=Static).
14:45:01:663 cg1B-ctisvr Trace: PRIVATE_DATA: CompoundRequestType=Unknown CSTA Event Type SubjectDevice=20251.
14:45:01:663 cg1B-ctisvr Trace:
.
14:45:01:663 cg1B-ctisvr Trace: SET_CALL_DATA_RESP: InvokeID=0x345f7920 ResultCode=-4 (INVALID_CALL) Flags=0x0.
14:45:01:663 cg1B-ctisvr Session 2: MsgType:FAILURE_CONF (InvokeID:0x17e22 Status:E_CTI_INVALID_CALLID )
14:45:01:663 cg1B-ctisvr Trace:
.
14:45:01:663 cg1B-ctisvr Trace: CSTA_CONNECTION_CLEARED - callID=2130706442.20251(s) releasingDev=20251  localConnectionInfo(-1)=CS_NONE cause=-1.
14:45:01:663 cg1B-ctisvr Trace:  callAction=must clear.
14:45:01:663 cg1B-ctisvr Trace: TailorMessageForClient - reEncode message for version 8.
14:45:01:663 cg1B-ctisvr Session 6: MsgType:CALL_CONNECTION_CLEARED_EVENT (MonitorID:0 PeripheralID:5000 
14:45:01:663 cg1B-ctisvr Session 6:         PeripheralType:EnterpriseAgent ConnectionDeviceIDType:CONNECTION_ID_STATIC 
14:45:01:663 cg1B-ctisvr Session 6:         ConnectionCallID:2130706442 ReleasingDeviceType:DEVID_DEVICE_IDENTIFIER 
14:45:01:663 cg1B-ctisvr Session 6:         LocalConnectionState:LCS_NONE EventCause:CEC_NONE ConnectionDeviceID:"20251" 
14:45:01:663 cg1B-ctisvr Session 6:         ReleasingDeviceID:"20251" )
14:45:01:663 cg1B-ctisvr Trace: TailorMessageForClient - reEncode message for version 16.
14:45:01:663 cg1B-ctisvr Session 7: MsgType:CALL_CONNECTION_CLEARED_EVENT (MonitorID:0 PeripheralID:5000 
14:45:01:663 cg1B-ctisvr Session 7:         PeripheralType:EnterpriseAgent ConnectionDeviceIDType:CONNECTION_ID_STATIC 
14:45:01:663 cg1B-ctisvr Session 7:         ConnectionCallID:2130706442 ReleasingDeviceType:DEVID_DEVICE_IDENTIFIER 
14:45:01:663 cg1B-ctisvr Session 7:         LocalConnectionState:LCS_NONE EventCause:CEC_NONE ConnectionDeviceID:"20251" 
14:45:01:663 cg1B-ctisvr Session 7:         ReleasingDeviceID:"20251" RemaskNumMasks:1 RemaskInstrument:"20251" 
14:45:01:663 cg1B-ctisvr Session 7:         RemaskExtension:"20251" RemaskCallId:2130706442 RemaskFunctionFlag:<0x00> <> 
14:45:01:663 cg1B-ctisvr Session 7:         RemaskCallMask:<0x00040000> <SetData> RemaskAgentMask:<0x3c000000> 
14:45:01:663 cg1B-ctisvr Session 7:         <NotReady,Avail,WrkRdy,WrkNotRdy> )
14:45:01:663 cg1B-ctisvr Trace: TailorMessageForClient - reEncode message for version 16.
14:45:01:663 cg1B-ctisvr Session 8: MsgType:CALL_CONNECTION_CLEARED_EVENT (MonitorID:0 PeripheralID:5000 
14:45:01:663 cg1B-ctisvr Session 8:         PeripheralType:EnterpriseAgent ConnectionDeviceIDType:CONNECTION_ID_STATIC 
14:45:01:663 cg1B-ctisvr Session 8:         ConnectionCallID:2130706442 ReleasingDeviceType:DEVID_DEVICE_IDENTIFIER 
14:45:01:663 cg1B-ctisvr Session 8:         LocalConnectionState:LCS_NONE EventCause:CEC_NONE ConnectionDeviceID:"20251" 
14:45:01:663 cg1B-ctisvr Session 8:         ReleasingDeviceID:"20251" RemaskNumMasks:1 RemaskInstrument:"20251" 
14:45:01:663 cg1B-ctisvr Session 8:         RemaskExtension:"20251" RemaskCallId:2130706442 RemaskFunctionFlag:<0x00> <> 
14:45:01:663 cg1B-ctisvr Session 8:         RemaskCallMask:<0x00040000> <SetData> RemaskAgentMask:<0x3c000000> 
14:45:01:663 cg1B-ctisvr Session 8:         <NotReady,Avail,WrkRdy,WrkNotRdy> )
14:45:01:663 cg1B-ctisvr Trace: TailorMessageForClient - reEncode message for version 8.
14:45:01:663 cg1B-ctisvr Session 6: MsgType:CALL_CONNECTION_CLEARED_EVENT (MonitorID:0 PeripheralID:5000 
14:45:01:663 cg1B-ctisvr Session 6:         PeripheralType:EnterpriseAgent ConnectionDeviceIDType:CONNECTION_ID_STATIC 
14:45:01:663 cg1B-ctisvr Session 6:         ConnectionCallID:2130706442 ReleasingDeviceType:DEVID_DEVICE_IDENTIFIER 
14:45:01:663 cg1B-ctisvr Session 6:         LocalConnectionState:LCS_NULL EventCause:CEC_NONE ConnectionDeviceID:"40001" 
14:45:01:663 cg1B-ctisvr Session 6:         ReleasingDeviceID:"40001" )
14:45:01:663 cg1B-ctisvr Trace: TailorMessageForClient - reEncode message for version 16.
14:45:01:663 cg1B-ctisvr Session 7: MsgType:CALL_CONNECTION_CLEARED_EVENT (MonitorID:0 PeripheralID:5000 
14:45:01:663 cg1B-ctisvr Session 7:         PeripheralType:EnterpriseAgent ConnectionDeviceIDType:CONNECTION_ID_STATIC 
14:45:01:663 cg1B-ctisvr Session 7:         ConnectionCallID:2130706442 ReleasingDeviceType:DEVID_DEVICE_IDENTIFIER 
14:45:01:663 cg1B-ctisvr Session 7:         LocalConnectionState:LCS_NULL EventCause:CEC_NONE ConnectionDeviceID:"40001" 
14:45:01:663 cg1B-ctisvr Session 7:         ReleasingDeviceID:"40001" RemaskNumMasks:1 RemaskInstrument:"20251" 
14:45:01:663 cg1B-ctisvr Session 7:         RemaskExtension:"20251" RemaskCallId:2130706442 RemaskFunctionFlag:<0x00> <> 
14:45:01:663 cg1B-ctisvr Session 7:         RemaskCallMask:<0x00040000> <SetData> RemaskAgentMask:<0x3c000000> 
14:45:01:663 cg1B-ctisvr Session 7:         <NotReady,Avail,WrkRdy,WrkNotRdy> )
14:45:01:663 cg1B-ctisvr Trace: TailorMessageForClient - reEncode message for version 16.
14:45:01:663 cg1B-ctisvr Session 8: MsgType:CALL_CONNECTION_CLEARED_EVENT (MonitorID:0 PeripheralID:5000 
14:45:01:663 cg1B-ctisvr Session 8:         PeripheralType:EnterpriseAgent ConnectionDeviceIDType:CONNECTION_ID_STATIC 
14:45:01:663 cg1B-ctisvr Session 8:         ConnectionCallID:2130706442 ReleasingDeviceType:DEVID_DEVICE_IDENTIFIER 
14:45:01:663 cg1B-ctisvr Session 8:         LocalConnectionState:LCS_NULL EventCause:CEC_NONE ConnectionDeviceID:"40001" 
14:45:01:663 cg1B-ctisvr Session 8:         ReleasingDeviceID:"40001" RemaskNumMasks:1 RemaskInstrument:"20251" 
14:45:01:663 cg1B-ctisvr Session 8:         RemaskExtension:"20251" RemaskCallId:2130706442 RemaskFunctionFlag:<0x00> <> 
14:45:01:663 cg1B-ctisvr Session 8:         RemaskCallMask:<0x00040000> <SetData> RemaskAgentMask:<0x3c000000> 
14:45:01:663 cg1B-ctisvr Session 8:         <NotReady,Avail,WrkRdy,WrkNotRdy> )
14:45:01:663 cg1B-ctisvr Trace: Removing device: 40001.
14:45:01:663 cg1B-ctisvr Trace: TailorMessageForClient - reEncode message for version 8.
14:45:01:663 cg1B-ctisvr Session 6: MsgType:CALL_CLEARED_EVENT (MonitorID:0 PeripheralID:5000 PeripheralType:EnterpriseAgent 
14:45:01:663 cg1B-ctisvr Session 6:         ConnectionDeviceIDType:CONNECTION_ID_STATIC ConnectionCallID:2130706442 
14:45:01:663 cg1B-ctisvr Session 6:         LocalConnectionState:LCS_NULL EventCause:CEC_NONE ConnectionDeviceID:"40001" )
14:45:01:663 cg1B-ctisvr Trace: TailorMessageForClient - reEncode message for version 16.
14:45:01:663 cg1B-ctisvr Session 7: MsgType:CALL_CLEARED_EVENT (MonitorID:0 PeripheralID:5000 PeripheralType:EnterpriseAgent 
14:45:01:663 cg1B-ctisvr Session 7:         ConnectionDeviceIDType:CONNECTION_ID_STATIC ConnectionCallID:2130706442 
14:45:01:663 cg1B-ctisvr Session 7:         LocalConnectionState:LCS_NULL EventCause:CEC_NONE ConnectionDeviceID:"40001" 
14:45:01:663 cg1B-ctisvr Session 7:         RemaskNumMasks:1 RemaskInstrument:"20251" RemaskExtension:"20251" RemaskCallId:2130706442 
14:45:01:663 cg1B-ctisvr Session 7:         RemaskFunctionFlag:<0x00> <> RemaskCallMask:<0x00040000> <SetData> 
14:45:01:663 cg1B-ctisvr Session 7:         RemaskAgentMask:<0x3c000000> <NotReady,Avail,WrkRdy,WrkNotRdy> )
14:45:01:663 cg1B-ctisvr Trace: TailorMessageForClient - reEncode message for version 16.
14:45:01:663 cg1B-ctisvr Session 8: MsgType:CALL_CLEARED_EVENT (MonitorID:0 PeripheralID:5000 PeripheralType:EnterpriseAgent 
14:45:01:663 cg1B-ctisvr Session 8:         ConnectionDeviceIDType:CONNECTION_ID_STATIC ConnectionCallID:2130706442 
14:45:01:663 cg1B-ctisvr Session 8:         LocalConnectionState:LCS_NULL EventCause:CEC_NONE ConnectionDeviceID:"40001" 
14:45:01:663 cg1B-ctisvr Session 8:         RemaskNumMasks:1 RemaskInstrument:"20251" RemaskExtension:"20251" RemaskCallId:2130706442 
14:45:01:663 cg1B-ctisvr Session 8:         RemaskFunctionFlag:<0x00> <> RemaskCallMask:<0x00040000> <SetData> 
14:45:01:663 cg1B-ctisvr Session 8:         RemaskAgentMask:<0x3c000000> <NotReady,Avail,WrkRdy,WrkNotRdy> )

 --- from PG ---

14:44:14:878 PG2B-pim2 Trace:
Message = HEARTBEAT_RESP; Length = 14 bytes
   Invoke ID = (2673262398) Hex 9f56bf3e
   Time Stamp = Date=04-27-2015, Time=14:44:14, bias=-420
.
14:44:14:878 PG2B-pim2 Trace: PIM Active Heartbeat..
14:44:15:019 PG2B-pim2 Trace: Application->PG:
Message = NEW_TASK; Length = 42 bytes
   DialogueID = (7) Hex 00000007
   SendSeqNo = (1) Hex 00000001
   MRDomainID = (1) Hex 00000001
   PreviousTask = -1:-1:-1
   PreferredAgent = Undefined
   Service = Undefined
   CiscoReserved = (0) Hex 00000000
   ScriptSelector: 1308
.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Peripheral::On_App_NewTask.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Dialogue::MR_Dialogue.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Peripheral::Send_ToOpc_CSTADeliveredInitiated.
14:44:15:019 PG2B-pim2 Trace: MR_Peripheral::Send_ToOpc_CSTADeliveredInitiated:.
14:44:15:019 PG2B-pim2 Trace: Call ID=7, MRDomainID=1, PreviousTask: TaskGroupHigh=-1, TaskGroupLow=-1, SequenceNumber=-1, Service=-1, CallOriginated=.
14:44:15:019 PG2B-pim2 Trace: ScriptSelector=1308.
14:44:15:019 PG2B-pim2 Trace: Send INRCMSGNewCall to Router : :
NEW_CALL  RCID=5006 PID=5001 DID=7 DIDRelSeq#=1 GrpDelKey=5006 CRS(RtrDate=-1,RtrCID=-1) RCKSeq#=-1 NICCallID={N/A} PGCallID={N/A} OperationCode=CLASSIC OperationFlags=COOP_NONE CalledParty#=1308 CallingParty#= CED= MsgOrigin=1 RouteDevType=6 Originator=172.18.19.30 NICCalledParty#= NetDelay=0 Priority=0 OrigType=0 atVRU=T CLIDRestrict=F PrefAGSTID=-1 MRDomainID=1 LegacyPreCallMsgEnabled=F CID=0, ServiceReq=0 PV1= PV2= PV3= PV4= PV5= PV6= PV7= PV8= PV9= PV10=.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Peripheral::ProcessConnect.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Peripheral::On_Router_Connect.
14:44:15:019 PG2B-pim2 Trace: MR_Peripheral::On_Router_Connect:
CONNECT  RCID=5006 PID=5001 DID=7 DIDRelSeq#=0 CRS(RtrDate=151326,RtrCID=8221) RCKSeq#=0 ErrorCode=0 TRTargetID=-1 CorrID= EventSel=0 SvcType=0 NICCallID={N/A} PGCallID={N/A} OperationCode=CLASSIC OperationFlags=COOP_NONE NetworkTransferEnabled=F Label(Type=0)=20251 NICCalledParty#=1308 SGSTID=5240 SvcSTID=-1 AGSTID=5149 AGInfo= PV1= PV2= PV3= PV4= PV5= PV6= PV7= PV8= PV9= PV10=.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Dialogue::AScriptIsRunning = 0.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Peripheral::On_Router_PendingConnect.
14:44:15:019 PG2B-pim2 Trace: MR_Peripheral::On_PendingConnect:
CONNECT  RCID=5006 PID=5001 DID=7 DIDRelSeq#=0 CRS(RtrDate=151326,RtrCID=8221) RCKSeq#=0 ErrorCode=0 TRTargetID=-1 CorrID= EventSel=0 SvcType=0 NICCallID={N/A} PGCallID={N/A} OperationCode=CLASSIC OperationFlags=COOP_NONE NetworkTransferEnabled=F Label(Type=0)=20251 NICCalledParty#=1308 SGSTID=5240 SvcSTID=-1 AGSTID=5149 AGInfo= PV1= PV2= PV3= PV4= PV5= PV6= PV7= PV8= PV9= PV10=.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Peripheral::GetECCValueList.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Peripheral::FreeECCValueList.
14:44:15:019 PG2B-pim2 Trace: PG->Application:
Message = DO_THIS_WITH_TASK; Length = 63 bytes
   DialogueID = (7) Hex 00000007
   SendSeqNo = (1) Hex 00000001
   IcmTaskID = 151326:8221: 1
   SkillGroup = (5240) Hex 00001478
   Service = Undefined
   Agent = (5149) Hex 0000141d
   AgentInfo:
   Label: 20251
   ApplicationString2:
   Call Variable 1:
   Call Variable 2:
   Call Variable 3:
   Call Variable 4:
   Call Variable 5:
   Call Variable 6:
   Call Variable 7:
   Call Variable 8:
   Call Variable 9:
   Call Variable 10:
.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Peripheral::Send_ToOpc_CSTAEstablished.
14:44:15:019 PG2B-pim2 Trace: MR_Peripheral::Send_ToOpc_CSTAEstablished:.
14:44:15:019 PG2B-pim2 Trace: Call ID=7, PreviousTask: TaskGroupHigh=151326, TaskGroupLow=8221, SequenceNumber=1, SkillGroup=5240, Service=-1, Agent=5149.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Peripheral::Send_ToOpc_CSTACallCleared.
14:44:15:019 PG2B-pim2 Trace: MR_Peripheral::Send_ToOpc_CSTACallCleared:  CallID=7  Cause=-1.
14:44:15:019 PG2B-pim2 Trace:     ExpandedCallContextSize=0.
14:44:15:019 PG2B-pim2 Trace: Function==>MR_Dialogue::~MR_Dialogue.
14:44:15:019 PG2B-pim2 Trace: MR_Dialogue::DialogHashOut m_DialogHashIndex -1.
14:44:19:777 PG2B-pim2 Trace: Sent Implicit Heartbeat to OPC..
14:44:19:777 PG2B-pim2 Trace:
Message = HEARTBEAT_REQ; Length = 14 bytes
   Invoke ID = (2673262399) Hex 9f56bf3f
   Time Stamp = Date=04-27-2015, Time=14:44:19, bias=-420
.
 

Has anyone faced the same issue? Please advise how to solve this problem.

Thanks in advance,

Wahyu

[Chintan Gajjar]

looks like the call is failing while nagotiating the media at gateway.

could you please attach Dialer logs  (i see only few snippets are posted) and Gateway sip traces completely?

[wahyukurnia]

Hi Chintan,

I have double checked to my configuration.

I have missed in "CUCM - SIP Trunk Security Profile Configuration".

Thanks and best regards,

wahyu

[Ritesh Desai]

Hi Wayu,

Am also having the same error. Just wanted to confirm, your Outbound scenario was Agent-based campaign... right?

regards,

Ritesh Desai

[wahyukurnia]

Hi Ritesh,

Yes, it was about agent-based campaign. If you have experienced the same problem, please double check "CUCM - SIP Trunk Security Profile Configuration".

Thanks and best regards,

Wahyu

[Ritesh Desai]

Wahyu,

Thanks for fast response. Am having this problem on Transfer to IVR based campaign.

regards,

Ritesh Desai

[pingaunis]

What was the resolution?

[khan.rehan11]

Hi Chintan,

I am facinig the same issue that is calls are failing to agent transfer, can you explain what you have missed in sip trunk security profile configuration ?

Regards,

Rehan Khan

[Muhammed Ashiq]

Anyone has found the solution ?