Thank you. APP_ID worked fine but still something is not working as it should (log section below).
My Voice over IP Service DN is DTMF_StreamManager3 , and I try to send 555 via DTMF to caller 499.
It seems StreamManager is sending a "not found" message:
10:30:48.396 Received [38,UDP] 437 bytes from 172.19.192.219:1103 <<<<<
SIP/2.0 404 Not Found
From: <sip:499@172.19.192.200:5060>;tag=006C2F50-F2CB-1FFF-B694-0100007FAA77-3346968
To: <sip:DTMF_StreamManager3@172.19.192.200:5060>;tag=C517EFF9-FFDA-4567-8A14-E95A6D38E57F-893476
Call-ID: 006C2F14-F2CB-1FFF-B694-0100007FAA77-2746698@172.19.192.200
Entire log section:
message RequestApplyTreatment
AttributeThisDN '17903'
AttributeConnID 006c020f99243762
AttributeTreatmentType 13 (TreatmentPlayApplication)
AttributeTreatmentParms [43] 00 02 01 00..
'APP_ID' 1
'GSIP_DTMF_TO_DIAL' 555
AttributeReferenceID 2788
10:30:48.395 Int 04543 Interaction message "RequestApplyTreatment" received from 16 ("URS_PRI")
10:30:48.395 -- created: CRequest@0xb707d2c0 RequestApplyTreatment-URS_PRI[16]/2788
10:30:48.395 SIPS:LOGBLOCK:BEGIN:REQUEST:[
10:30:48.395 +++ CIFace::Request +++
-- new invoke
-- thisCall by party
Parsed: RequestApplyTreatment
From: URS_PRI[16]/2788
Numbers: +<17903> -<none>
Calls: 0xb7601728:1 none
Parties: 17903.0xb67f50e8-0xb7601728:1
none
Status: parsed:1 queued:0 sent:0 acked:0 preevent:0 event:0 context:0 transferred:0
-----
-- validate
-- state check: ok
CIFace: Sent CRequest@0xb707d2c0 RequestApplyTreatment-URS_PRI[16]/2788
FinishRequest CRequest@0xb707d2c0 RequestApplyTreatment-URS_PRI[16]/2788
IFace stats: q=0 s=0
-- complete
10:30:48.395 Selected for Dn (): Service DTMF_StreamManager3 (geo-loc , priority 0, capacity 0 (0% of -2))
10:30:48.395 SIPCONN(DTMF_StreamManager3): set monitor b656f290, b6905614
10:30:48.395 SIPTR(14799422): Begin step 0 - SipTransactionConnectMediaService(14799423)
10:30:48.395 SIPCONN(499): re-invite-connected
10:30:48.395 SIPCONN(DTMF_StreamManager3): re-invite-null
10:30:48.395 SIPCONN(DTMF_StreamManager3): GetOffer
10:30:48.395 SIPCONN(DTMF_StreamManager3): GetOffer::SendInvite
10:30:48.395 SipDialog: set monitor b656f304
10:30:48.395 SIPCONN(DTMF_StreamManager3): main dialog 0 created
10:30:48.395 SIPCONN(DTMF_StreamManager3): Local contact: '<sip:499@172.19.192.200:5060>'
@10:30:48.3960 [BSYNC] Trace: Send to backup (SIP_Server_BCK) [39]:
message EventUserEvent
attr_#1005 0
attr_#1004 396
attr_#1003 1345793448
attr_#1002 23493552
attr_#1001 1
attr_#1000 131072
attr_#16000 1
attr_#16500 [86] 31 3D 31 0D..
AttributeUserEvent [16099]
@10:30:48.3960 [BSYNC] Trace: Sent
10:30:48.396 HA:MESSAGE:TYPE[2]: SYNCED
10:30:48.396 SIPDLG[11488924]: register TRN[14491195]
10:30:48.396 SIPDLG[11488924]: TRN[14491195] flags set to 0x6
10:30:48.396 Sending [38,UDP] 649 bytes to 172.19.192.219:9104 >>>>>
INVITE sip:1@172.19.192.219:9104 SIP/2.0
From: <sip:499@172.19.192.200:5060>;tag=006C2F50-F2CB-1FFF-B694-0100007FAA77-3346968
To: <sip:DTMF_StreamManager3@172.19.192.200:5060>
Call-ID: 006C2F14-F2CB-1FFF-B694-0100007FAA77-2746698@172.19.192.200
CSeq: 1 INVITE
Content-Length: 0
Via: SIP/2.0/UDP 172.19.192.200:5060;branch=z9hG4bK006C2F64-F2CB-1FFF-B694-0100007FAA77-16877260
Contact: <sip:499@172.19.192.200:5060>
Allow: ACK, BYE, CANCEL, INFO, INVITE, MESSAGE, NOTIFY, OPTIONS, PRACK, REFER
X-Genesys-CallUUID: 00JHUP7IPGFVVDKK04000VTAES0AKAA4
Max-Forwards: 69
Session-Expires: 1800;refresher=uac
Min-SE: 90
Supported: 100rel,timer
10:30:48.396 SipDialog: event SEND_INVITE, t=14491195, s=2, r=5, m=b656f304
10:30:48.396 SIPCONN(DTMF_StreamManager3): HandleSipDialogEvent(SEND_INVITE) - filtered
10:30:48.396 SIPCONN(DTMF_StreamManager3): sdp state SDP_STATE_NULL, event SDP_OFFER_REQUESTED
10:30:48.396 SIPCONN(DTMF_StreamManager3): new sdp state SDP_OFFER_REQUESTED, event SDP_OFFER_REQUESTED
10:30:48.396 --- CIFace::Request ---
10:30:48.396 10:30:48.396 SIPS:LOGBLOCK:END:REQUEST:]
@10:30:48.3962 [BSYNC] Trace: Received [39]:
message EventUserEvent
AttributeUserEvent [16002]
attr_#16100 [21] 31 3A 31 7C..
attr_#16000 1
attr_#1000 131072
attr_#1001 1
attr_#1002 1398240
attr_#1003 1345793445
attr_#1004 561
attr_#1005 0
10:30:48.396 SIPTS:<< SYNC(16002) <<
10:30:48.396 HA:MESSAGE:TYPE[1]:RECEIVED
10:30:48.396 HA:MESSAGE:TYPE[1]:PROCESSED
10:30:48.396 SIPS:LOGBLOCK:BEGIN:SIPDATA:[
10:30:48.396 Received [38,UDP] 437 bytes from 172.19.192.219:1103 <<<<<
SIP/2.0 404 Not Found
From: <sip:499@172.19.192.200:5060>;tag=006C2F50-F2CB-1FFF-B694-0100007FAA77-3346968
To: <sip:DTMF_StreamManager3@172.19.192.200:5060>;tag=C517EFF9-FFDA-4567-8A14-E95A6D38E57F-893476
Call-ID: 006C2F14-F2CB-1FFF-B694-0100007FAA77-2746698@172.19.192.200
CSeq: 1 INVITE
Via: SIP/2.0/UDP 172.19.192.200:5060;branch=z9hG4bK006C2F64-F2CB-1FFF-B694-0100007FAA77-16877260;received=172.19.192.200
Content-Length: 0
10:30:48.396 Sending [38,UDP] 426 bytes to 172.19.192.219:9104 >>>>>
ACK sip:1@172.19.192.219:9104 SIP/2.0
Via: SIP/2.0/UDP 172.19.192.200:5060;branch=z9hG4bK006C2F64-F2CB-1FFF-B694-0100007FAA77-16877260
From: <sip:499@172.19.192.200:5060>;tag=006C2F50-F2CB-1FFF-B694-0100007FAA77-3346968
To: <sip:DTMF_StreamManager3@172.19.192.200:5060>;tag=C517EFF9-FFDA-4567-8A14-E95A6D38E57F-893476
Call-ID: 006C2F14-F2CB-1FFF-B694-0100007FAA77-2746698@172.19.192.200
CSeq: 1 ACK
Content-Length: 0
10:30:48.396 SipDialog: event CALLING_RESREJECT, t=14491195, s=9, r=5, m=b656f304
10:30:48.396 SIPCONN(DTMF_StreamManager3): HandleSipDialogEvent(CALLING_RESREJECT)
10:30:48.396 SIPCONN(DTMF_StreamManager3): Connect(1,2)
10:30:48.396 SIPDM: locate new destination for failed device 'DTMF_StreamManager3'
10:30:48.396 GetTheBestService: no eligible service found for
10:30:48.396 REGISTRAR: Replacement cannot be found for service [DTMF_StreamManager3], Dn
10:30:48.396 SIPDM: no alternative destination is found for 'DTMF_StreamManager3'
10:30:48.396 SIPCONN(DTMF_StreamManager3): state e:4,p:0,s:6,c:23,rc:404,m:1
10:30:48.396 SIPTS: HandleMediaServiceFailed
@10:30:48.3968 [0] 7.6.001.27 distribute_event: message EventTreatmentNotApplied
AttributeEventSequenceNumber 00000000032179c6
AttributeTimeinuSecs 396817
AttributeTimeinSecs 1345793448 (10:30:48)
AttributeExtensions [23] 00 01 01 00..
'BusinessCall' 1
AttributeReferenceID 2788
AttributeErrorCode 50
AttributeTreatmentParms [43] 00 02 01 00..
'APP_ID' 1
'GSIP_DTMF_TO_DIAL' 555
AttributeTreatmentType 13 (TreatmentPlayApplication)
AttributeCustomerID 'Resources'
AttributeDNIS '17903'
AttributeCallUUID '00JHUP7IPGFVVDKK04000VTAES0AKAA4'
AttributeConnID 006c020f99243762
AttributeCallID 1000152
AttributeCallType 1
AttributeCallState 0
AttributeThisQueue '17903'
AttributeCollectedDigits ''
AttributeThisDNRole 2
AttributeThisDN '17903'
@10:30:48.3968 [ISCC] Translate: '' -> ''; result 1 ()
10:30:48.396 Int 04544 Interaction message "EventTreatmentNotApplied" generated
10:30:48.396 Trc 04542 EventTreatmentNotApplied sent to [37] (0000001a GAD2_SServer 172.19.192.94:2160)
10:30:48.396 Trc 04542 EventTreatmentNotApplied sent to [34] (00000017 OCS_SServer_BKP 172.19.192.208:2206)
10:30:48.396 Trc 04542 EventTreatmentNotApplied sent to [19] (00000008 CCA_SServer_BKP 172.19.192.214:4255)
10:30:48.396 Trc 04542 EventTreatmentNotApplied sent to [18] (00000007 CCP_StatServer_PRI 172.19.192.214:4254)
10:30:48.396 Trc 04542 EventTreatmentNotApplied sent to [35] (00000018 GAD1_SServer 172.19.192.93:3693)
10:30:48.396 Trc 04542 EventTreatmentNotApplied sent to [17] (00000006 URS_StatServer_BCK 172.19.192.203:14445)
10:30:48.396 Trc 04542 EventTreatmentNotApplied sent to [14] (00000003 URS_StatServer_PRI 172.19.192.204:44430)
10:30:48.396 Trc 04542 EventTreatmentNotApplied sent to [31] (00000014 CCA_SServer_PRI 172.19.192.213:4171)
10:30:48.396 Trc 04542 EventTreatmentNotApplied sent to [32] (00000015 CCP_StatServer_BCK 172.19.192.213:4172)
10:30:48.397 Trc 04542 EventTreatmentNotApplied sent to [29] (00000012 OCS_SServer_PRI 172.19.192.207:4210)
10:30:48.397 Trc 04542 EventTreatmentNotApplied sent to [16] (00000005 URS_PRI 172.19.192.204:44431)
10:30:48.397 Trc 04542 EventTreatmentNotApplied sent to [15] (00000004 URS_BCK 172.19.192.203:14444)
10:30:48.397 Trc 04542 EventTreatmentNotApplied sent to [27] (00000010 SIP_ICON2 172.19.192.216:2653)
10:30:48.397 Trc 04542 EventTreatmentNotApplied sent to [22] (0000000b SIP_ICON1 172.19.192.215:4124)
10:30:48.397 SIPCONN(DTMF_StreamManager3): NotifyOnError
10:30:48.397 SIPCONN(DTMF_StreamManager3): TRCLR(14491195)
10:30:48.397 ConnectAbort
10:30:48.397 SIPCONN(499): ClrMediaPeer
10:30:48.397 SIPCONN(DTMF_StreamManager3): ClrMediaPeer
10:30:48.397 music service failed
10:30:48.397 SIPCONN(DTMF_StreamManager3): ClrMediaPeer
10:30:48.397 SIPCONN(DTMF_StreamManager3): state e:1,p:6,s:0,c:0,rc:0,m:1
10:30:48.397 SipDialog: ClearCall(phone=0,state=9)
10:30:48.397 SipDialog::Terminate(state=9)
10:30:48.397 SipDialog: set monitor 0
10:30:48.397 SIPCONN(DTMF_StreamManager3): DetachMediaPeer
10:30:48.397 SIPTR(14799423): failed
10:30:48.397 SIPTR(14799422): Step 0 - SipTransactionConnectMediaService(14799423) failed
10:30:48.397 SIPTR(14799422): failed
10:30:48.397 SIPCM: transaction SipScenario failed
10:30:48.397 PI: 00 S[IN]D[499]C[*D[499]]P[-]
10:30:48.397 PI: 00 S[QN]D[17903]E[-]
10:30:48.397 CALLSTATE(a:1,d:1,i:0,e:0,r:0,o:0)
10:30:48.397 -----------------------------------------------------------
10:30:48.397 C[1000152]:CF[D[[0]]:SC[14799422]
10:30:48.397 P[5352066]

[499[8791452]]:LID[0]:D2[17903[8791453]]
10:30:48.397 SIPCONN(499): endPoint :CON[6459730]:PEER[0]

[499[8791452]]:DLG[11488911 STATE[7]]:D2[17903[8791453]:TD[0[IM[no]]]:LCRC
10:30:48.397 P[5352067]

[17903[8791453]]:LID[0]:D2[499[8791452]]
10:30:48.397 HA: BEGIN SYNC: CALL[1000152] SYNCTYPE[2]: SECOND CALL[0] SYNCTYPE[-1]
10:30:48.397 HA: END SYNC: CALL[1000152] SYNCTYPE[2]: SECOND CALL[0] SYNCTYPE[-1]
@10:30:48.3973 [BSYNC] Trace: Send to backup (SIP_Server_BCK) [39]:
message EventUserEvent
attr_#1005 0
attr_#1004 397
attr_#1003 1345793448
attr_#1002 23493553
attr_#1001 1
attr_#1000 131072
attr_#16000 1
attr_#16102 [240] 32 3A 31 7C..
attr_#16101 [349] 32 3A 31 7C..
attr_#16100 [33] 31 3A 31 7C..
AttributeUserEvent [16001]
@10:30:48.3973 [BSYNC] Trace: Sent
10:30:48.397 HA:MESSAGE:TYPE[0]: SYNCED
10:30:48.397 OnRequestFailed
10:30:48.397 -- thisCall by party
10:30:48.397 Trc 36002 Request rejected: error code 100(Unknown cause)
@10:30:48.3973 [0] 7.6.001.27 send_to_client: message EventError
(Unknown cause)
AttributeEventSequenceNumber 00000000032179c7
AttributeCustomerID 'Resources'
AttributeTimeinuSecs 397369
AttributeTimeinSecs 1345793448 (10:30:48)
AttributeErrorCode 100
AttributeErrorMessage 'Unknown cause'
AttributeReferenceID 2788
AttributeTreatmentType 13 (TreatmentPlayApplication)
AttributeConnID 006c020f99243762
AttributeThisDN '17903'
AttributeClientID 5