2371: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DATAI.2} Found an incoming CISCO-GUID hdr : 1586999424-0000065536-0000000078-2504894656, Generated a new CVP-ID hdr : FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA 2372: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DATAI.2} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND]: Display Name [] Is Using Survivability [false] CallServer build CVP_12_6_1_0_0_0_266 2373: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DATAI.2} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND]: Display Name [] Is Using Survivability [false] CallServer build CVP_12_6_1_0_0_0_266 2374: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DATAI.2} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND]: P-Asserted-Id hdr USER portion (calling-number ANI) is.3000 2375: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-PARAM: {Thrd=DATAI.2} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND]: ReqURI (DN) sip:2000@192.168.77.35:5060 FromURI sip:3000@192.168.77.149 Video:false m_needs_postcallsurvey:false 2376: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DATAI.2} NEW CALL with guid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA legid=5e97b080-1ed11e80-57-954da8c0 dn=2000 ani=3000 uui=null calldate=Thu Aug 19 07:38:05 CST 2021 video=false cachecallcontext = false is_postcallsurvey = false RouterCallKey = null RouterCallKeyDay = null RouterCallKeySequenceNumber = null 2377: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DATAI.2} Sending msg:>>HEADERS: (JMSType)=MsgBus:NEW_CALL (JMSDestination)=Topic(CVP.SIP.CC.REQ) (JMSTimestamp)=1629329885612 >>BODY: replyto=true callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA ani=3000 dnis=2000 timezone=Asia/Shanghai version=CVP_12_6 pstntrkgrpsrcip=192.168.77.149 calldate=Thu Aug 19 07:38:05 CST 2021 calltypeid=4 localOffset=480 calllegid=5e97b080-1ed11e80-57-954da8c0 >>STATE: isTabular=false isWriteable=true cursor=-1 4685: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Core-router-group-0} --NEW SESSION CREATED--CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA NUMBER OF ACTIVE SESSIONS= 1 2378: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DATAI.2} Sending msg:ICMEvent, sessionId=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA callId=5e97b080-1ed11e80-57-954da8c0 dialogId=0 sourceId=5e97b080-1ed11e80-57-954da8c0 systemType=SIP mediatype= dnis=2000 ani=3000 srcAddress=192.168.77.149 locationsiteid=sessionId=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA callType=4 cacheCallContext=false postcallsurveycall=false icmMessage=NEW_CALL 842: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA - New call 843: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=97 [SIP_SWITCH_LEG_DIALOGUE] - Processing from SIP_SS - [NEW_CALL] DialogID=0 SendSeqNo=0 DNIS=2000 ANI=3000 CED= rckey=0 rcday=0 rcseq=0 uui= callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA trunkGroupId=0 trunkNumber=0 serviceId=0 calledNumber= location= locationpkid= pstntrunkgroupid= sipheader= ECC variables= ECC arrays= Peripheral Variables= 844: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=97 [SIP_SWITCH_LEG_DIALOGUE] - Publishing to UCCE - [NEW_CALL] DialogID=97 SendSeqNo=1 DNIS=2000 ANI=3000 CED= rckey=0 rcday=0 rcseq=0 uui= callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA trunkGroupId=100 trunkNumber=0 serviceId=1 calledNumber= location= locationpkid= pstntrunkgroupid=192.168.77.149 sipheader= ECC variables=user.media.id: FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA,user.cvp_server_info: 192.168.77.35, ECC arrays= Peripheral Variables= 845: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=97 [SIP_SWITCH_LEG_DIALOGUE] - Processing from UCCE - [CONNECT] DialogID=97 SendSeqNo=1, Label=000000000011111, TxrHint=false, rckey=233, rcday=153632, rcseq=0, location=, locationpkid=, sipheader=, uui=, whisperAnnounce=, callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA, serviceparam=, ECC variables=user.media.id: FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA,user.microapp.input_type: D,user.microapp.app_media_lib: ..,user.microapp.UseVXMLParams: N,user.cvp_server_info: 192.168.77.35, ECC arrays=USER_MICROAPP_TOEXTVXML[1]:ani=3000,USER_MICROAPP_TOEXTVXML[0]:application=SGIN,, Peripheral Variables=, DNIS=2000, ANI=3000 846: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=97 [SIP_SWITCH_LEG_DIALOGUE] - Publishing to SIP_SS - [CONNECT] DialogID=97 SendSeqNo=1, Label=000000000011111, TxrHint=false, rckey=233, rcday=153632, rcseq=0, location=, locationpkid=, sipheader=, uui=, whisperAnnounce=, callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA, serviceparam=, ECC variables=user.media.id: FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA,user.microapp.input_type: D,user.microapp.app_media_lib: ..,user.microapp.UseVXMLParams: N,user.cvp_server_info: 192.168.77.35, ECC arrays=USER_MICROAPP_TOEXTVXML[1]:ani=3000,USER_MICROAPP_TOEXTVXML[0]:application=SGIN,, Peripheral Variables= 2379: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-340-SIP-1787} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND] Handling CONNECT :[CONNECT] DialogID=97 SendSeqNo=1, Label=000000000011111, TxrHint=false, rckey=233, rcday=153632, rcseq=0, location=, locationpkid=, sipheader=, uui=, whisperAnnounce=, callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA, serviceparam=, ECC variables=user.media.id: FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA,user.microapp.input_type: D,user.microapp.app_media_lib: ..,user.microapp.UseVXMLParams: N,user.cvp_server_info: 192.168.77.35, ECC arrays=USER_MICROAPP_TOEXTVXML[1]:ani=3000,USER_MICROAPP_TOEXTVXML[0]:application=SGIN,, Peripheral Variables= 2380: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-340-SIP-1787} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND] Got a serviceParam : 2381: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-340-SIP-1787} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND] leg is not enabled for process the serviceParam : 2382: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-340-SIP-1787} Static route matched 000000000011111 to StaticRoute: patterns like 000000000011111> will route to 192.168.77.36 2383: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-340-SIP-1787} Using Local Static Route for sip:000000000011111@192.168.77.36 2384: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-340-SIP-1787} : to=sip:000000000011111@192.168.77.36route_hdr=null 2385: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-340-SIP-1787} parseAndUpdateUuidsForResponse(String): remoteUuid=8ac0e2154bb6e8fba1790469e5f7eba0, localUuid=00000000000000000000000000000000 2386: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-340-SIP-1787} Found an incoming CISCO-GUID hdr : 1586999424-0000065536-0000000078-2504894656, Found an existing CVP-ID hdr: FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA 2387: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-340-SIP-1787} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND]: INVITE TO FROM 3000 EXPIRES[60] 100REL[Unsupported] 2388: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-340-SIP-1787} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND]Trying to set headers in INVITE with these operations: 2389: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DIALOG_CALLBACK.5} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND]: Invitation proceeding 100 2390: 192.168.77.35: Aug 19 2021 07:38:05.612 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DIALOG_CALLBACK.5} parseAndUpdateUuidsForResponse(String): remoteUuid=00000000000000000000000000000000, localUuid=8ac0e2154bb6e8fba1790469e5f7eba0 2391: 192.168.77.35: Aug 19 2021 07:38:05.628 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DIALOG_CALLBACK.5} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND]: Invitation accepted - ack'ing 2392: 192.168.77.35: Aug 19 2021 07:38:05.628 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DIALOG_CALLBACK.5} parseAndUpdateUuidsForResponse(String): remoteUuid=5BA14D7D3F57B2DC0000AC4B1000017B, localUuid=8ac0e2154bb6e8fba1790469e5f7eba0 2393: 192.168.77.35: Aug 19 2021 07:38:05.628 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DIALOG_CALLBACK.5} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND]: NO P_Asserted_Identity. 2394: 192.168.77.35: Aug 19 2021 07:38:05.644 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DIALOG_CALLBACK.5} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND]: CountObserver() is >0 and sending Re-Invite to caller. 2395: 192.168.77.35: Aug 19 2021 07:38:05.644 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-341-SIP-1788} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND]: Updated by : CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND]: with event type INV_ACCEPTED 2396: 192.168.77.35: Aug 19 2021 07:38:05.644 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-341-SIP-1788} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND]: Send the 200 OK back to caller with SDP of this dialog. 2397: 192.168.77.35: Aug 19 2021 07:38:05.644 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-341-SIP-1788} Sending BUS MSG for Event Reportnew CSS:[EVENT_REPORT] DialogID=0 SendSeqNo=0 EventID=ANSWER CauseCode=CAUSE_NONE 2398: 192.168.77.35: Aug 19 2021 07:38:05.644 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-341-SIP-1788} Sending BUS MSG:>>HEADERS: (JMSType)=MsgBus:CALL_STATE_EVENT (JMSDestination)=Topic(CVP.SIP.CC.EVENT) (JMSTimestamp)=1629329885644 >>BODY: callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA RouterCallKey=233 RouterCallKeySent=false causecode=0 timezone=Asia/Shanghai RouterCallKeySequenceNumber=0 version=CVP_12_6 labeltype=1 RouterCallKeyDay=153632 calldate=Thu Aug 19 07:38:05 CST 2021 label=000000000011111 localOffset=480 eventid=4 calllegid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 >>STATE: isTabular=false isWriteable=true cursor=-1 847: 192.168.77.35: Aug 19 2021 07:38:05.644 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=97 [SIP_SWITCH_LEG_DIALOGUE] - Processing from SIP_SS - [EVENT_REPORT] DialogID=0 SendSeqNo=0 EventID=ANSWER CauseCode=CAUSE_NONE 848: 192.168.77.35: Aug 19 2021 07:38:05.644 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=97 [SIP_SWITCH_LEG_DIALOGUE] - Publishing to UCCE - [EVENT_REPORT] DialogID=97 SendSeqNo=2 EventID=ANSWER CauseCode=NONE 2399: 192.168.77.35: Aug 19 2021 07:38:05.659 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DIALOG_CALLBACK.5} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND]: DsSipInviteDialog ack'ed 2400: 192.168.77.35: Aug 19 2021 07:38:05.659 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DIALOG_CALLBACK.5} parseAndUpdateUuidsForResponse(String): remoteUuid=8ac0e2154bb6e8fba1790469e5f7eba0, localUuid=5BA14D7D3F57B2DC0000AC4B1000017B 2401: 192.168.77.35: Aug 19 2021 07:38:05.659 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-342-SIP-1789} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND]: Updated by : CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND]: with event type INV_ACKED 2402: 192.168.77.35: Aug 19 2021 07:38:05.659 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-342-SIP-1789} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND]: Acked the invite. 4686: 192.168.77.35: Aug 19 2021 07:38:05.690 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA CALLID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA [IVR] - processing from VXMLServer - [NEW_CALL] ClientNewCallEvent,sessionId=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA ani=3000 dnis=000000000011111 uui= callId=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249@192.168.77.35 seqNo=1 invokationId=0 message=null ccbServletUrl= ccbServletReqTimeout=0 switch_leg_ani= switch_leg_dnis= 4687: 192.168.77.35: Aug 19 2021 07:38:05.690 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA CALLID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249@192.168.77.35 [IVR] [Publishing to ICM_SS] [NEW_CALL] DialogID=0 SendSeqNo=0 DNIS=000000000011111 ANI=3000 CED= rckey=0 rcday=0 rcseq=0 uui= callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA trunkGroupId=0 trunkNumber=0 serviceId=0 calledNumber= location= locationpkid= pstntrunkgroupid= sipheader= ECC variables= ECC arrays= Peripheral Variables= 4688: 192.168.77.35: Aug 19 2021 07:38:05.690 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} CallServerReportingProvider:sendNewCall: CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DNIS=000000000011111 Publishing NewCall message: >>HEADERS: (JMSType)=MsgBus:NEW_CALL (AppName)=IVR >>BODY: replyto=true uui= callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA ani=3000 dnis=000000000011111 timezone=Asia/Shanghai mediatype=A version=CVP_12_6 calldate=Thu Aug 19 07:38:05 CST 2021 location= calltypeid=5 localOffset=480 calllegid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249@192.168.77.35 >>STATE: isTabular=false isWriteable=true cursor=-1 849: 192.168.77.35: Aug 19 2021 07:38:05.690 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA - New call 850: 192.168.77.35: Aug 19 2021 07:38:05.690 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=98 [IVR_VRU_LEG_DIALOGUE] - Processing from IVR_SS - [NEW_CALL] DialogID=0 SendSeqNo=0 DNIS=000000000011111 ANI=3000 CED= rckey=0 rcday=0 rcseq=0 uui= callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA trunkGroupId=0 trunkNumber=0 serviceId=0 calledNumber= location= locationpkid= pstntrunkgroupid= sipheader= ECC variables= ECC arrays= Peripheral Variables= 851: 192.168.77.35: Aug 19 2021 07:38:05.690 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=98 [IVR_VRU_LEG_DIALOGUE] - Publishing to UCCE - [NEW_CALL] DialogID=98 SendSeqNo=1 DNIS=000000000011111 ANI=3000 CED= rckey=0 rcday=0 rcseq=0 uui= callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA trunkGroupId=100 trunkNumber=1 serviceId=1 calledNumber= location= locationpkid= pstntrunkgroupid= sipheader= ECC variables=user.media.id: FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA,user.cvp_server_info: 192.168.77.35, ECC arrays= Peripheral Variables= 852: 192.168.77.35: Aug 19 2021 07:38:05.690 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=98 [IVR_VRU_LEG_DIALOGUE] - Processing from UCCE - [DIALOG_FAILURE_EVENT] DialogID=98 SendSeqNo=1 ErrorCode=E_UNSPECIFIED_FAILURE 853: 192.168.77.35: Aug 19 2021 07:38:05.690 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=98 [IVR_VRU_LEG_DIALOGUE] - Publishing to IVR_SS - [DIALOG_FAILURE_EVENT] DialogID=98 SendSeqNo=1 ErrorCode=E_UNSPECIFIED_FAILURE 4689: 192.168.77.35: Aug 19 2021 07:38:05.690 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA CALLID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249@192.168.77.35 [IVR] [processing from ICM_SS] [DIALOG_FAILURE_EVENT] DialogID=98 SendSeqNo=1 ErrorCode=E_UNSPECIFIED_FAILURE 4690: 192.168.77.35: Aug 19 2021 07:38:05.690 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} IvrConnection:registerDisonnectTimer: CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA CALLID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249@192.168.77.35 [IVR] Register Disonnect Timer 4691: 192.168.77.35: Aug 19 2021 07:38:05.690 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA CALLID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249@192.168.77.35 [IVR] - Publishing to VXMLServer - [DIALOG_FAILURE_EVENT] DialogID=98 SendSeqNo=1 ErrorCode=E_UNSPECIFIED_FAILURE 4692: 192.168.77.35: Aug 19 2021 07:38:06.815 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Global-task-executor-group-3} CallServerThreadDumpTask:Subsystem Name=SIPRunning Threads=0 4693: 192.168.77.35: Aug 19 2021 07:38:07.737 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA CALLID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249@192.168.77.35 [IVR] process Timer Event 4694: 192.168.77.35: Aug 19 2021 07:38:07.737 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA CALLID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249@192.168.77.35 [IVR] [Publishing to ICM_SS] [EVENT_REPORT] DialogID=0 SendSeqNo=0 EventID=DISCONNECT CauseCode=CAUSE_NORMAL_COMPLETION 4695: 192.168.77.35: Aug 19 2021 07:38:07.737 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} CallServerReportingProvider:sendIVRCallStateEvent: CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DNIS=000000000011111CallStateEvent message: >>HEADERS: (JMSType)=MsgBus:CALL_STATE_EVENT (AppName)=IVR >>BODY: callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA dnis=000000000011111 RouterCallKeySent=false causecode=1 timezone=Asia/Shanghai version=CVP_12_6 calldate=Thu Aug 19 07:38:07 CST 2021 localOffset=480 calllegid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249@192.168.77.35 eventid=6 >>STATE: isTabular=false isWriteable=true cursor=-1 4696: 192.168.77.35: Aug 19 2021 07:38:07.737 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} CallSession:removeConnectionByCallId: CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA--REMOVING CONNECTION-- callId=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA 854: 192.168.77.35: Aug 19 2021 07:38:07.737 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=98 [IVR_VRU_LEG_DIALOGUE] - Processing from IVR_SS - [EVENT_REPORT] DialogID=0 SendSeqNo=0 EventID=DISCONNECT CauseCode=CAUSE_NORMAL_COMPLETION 855: 192.168.77.35: Aug 19 2021 07:38:07.737 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=98 [IVR_VRU_LEG_DIALOGUE] - Publishing to UCCE - [EVENT_REPORT] DialogID=98 SendSeqNo=2 EventID=DISCONNECT CauseCode=CAUSE_NORMAL_COMPLETION 4697: 192.168.77.35: Aug 19 2021 07:38:07.737 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} CallSession:removeConnectionByDialogId: CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA--REMOVING CONNECTION-- dialogId=98 2403: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DIALOG_CALLBACK.5} parseAndUpdateUuidsForResponse(String): remoteUuid=8ac0e2154bb6e8fba1790469e5f7eba0, localUuid=5BA14D7D3F57B2DC0000AC4B1000017B 2404: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=DIALOG_CALLBACK.5} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND] DURATION (msecs) = 2422 - DIALOG TERMINATED. Reason: Q.850;cause=16 2405: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-343-SIP-1790} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND]: Going to clean after a BYE now. 2406: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-343-SIP-1790} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND]: Disconnecting Normally 2407: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-343-SIP-1790} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND] Sending event report with code = 2 2408: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-343-SIP-1790} Sending BUS MSG for Event Reportnew CSS:[EVENT_REPORT] DialogID=0 SendSeqNo=0 EventID=DISCONNECT CauseCode=CAUSE_NORMAL_COMPLETION 2409: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-343-SIP-1790} Sending BUS MSG:>>HEADERS: (JMSType)=MsgBus:CALL_STATE_EVENT (JMSDestination)=Topic(CVP.SIP.CC.EVENT) (JMSTimestamp)=1629329888034 >>BODY: callguid=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA RouterCallKey=233 RouterCallKeySent=true causecode=1 timezone=Asia/Shanghai RouterCallKeySequenceNumber=0 version=CVP_12_6 labeltype=1 RouterCallKeyDay=153632 calldate=Thu Aug 19 07:38:08 CST 2021 label=000000000011111 localOffset=480 eventid=6 calllegid=5e97b080-1ed11e80-57-954da8c0 >>STATE: isTabular=false isWriteable=true cursor=-1 856: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=97 [SIP_SWITCH_LEG_DIALOGUE] - Processing from SIP_SS - [EVENT_REPORT] DialogID=0 SendSeqNo=0 EventID=DISCONNECT CauseCode=CAUSE_NORMAL_COMPLETION 857: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_ICM-7-CALL: {Thrd=Event-router-group-0} CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA DialogId=97 [SIP_SWITCH_LEG_DIALOGUE] - Publishing to UCCE - [EVENT_REPORT] DialogID=97 SendSeqNo=3 EventID=DISCONNECT CauseCode=CAUSE_NORMAL_COMPLETION 4698: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} CallSession:removeConnectionByDialogId: CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA--REMOVING CONNECTION-- dialogId=97 2410: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-344-SIP-1791} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND]: Updated by : CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = 5e97b080-1ed11e80-57-954da8c0 - [INBOUND]: with event type TERMINATED 4699: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Event-router-group-0} -- SESSION DESTROYED--CALLGUID=FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA NUMBER OF ACTIVE SESSIONS= 0 2411: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-344-SIP-1792} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND] DURATION (msecs) = 2422 - HANGUP with Call History 2412: 192.168.77.35: Aug 19 2021 07:38:08.034 +0800: %CVP_12_6_SIP-7-CALL: {Thrd=pool-1-thread-344-SIP-1792} CALLGUID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA LEGID = FOJHLAIAAAABAAAAAAAAAAEOJFENKIMA-162932988561249 - [OUTBOUND]: Terminated with Q.850;cause=16 4700: 192.168.77.35: Aug 19 2021 07:38:09.112 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Global-task-executor-group-5} CallServerStatsManager:[[CallServer Stats][SessionManager Stats:[Total Number of Active Sessions=0][Total Number of Deleted Sessions=0][Total Number of Pcs Sessions=0][[CallServerPoolManager Stats][SessionPool Stats:[Total Number of Active Sessions=0][Total Number of Idle Sessions=1][IvrConnectionPool Stats:[Total Number of Active IvrConnections=0][Total Number of Idle IvrConnections=1][IvrConnectionPool Stats:[Total Number of Active IcmConnections=0][Total Number of Idle IcmConnections=2][NewDialogHandlerPool Stats:[Total Number of Active NewDialogHandlers=0][Total Number of Idle NewDialogHandlers=0] [[QueueManager Stats][Name=CALLSERVER_TRANSPORT_MANAGER_QUEUE,Max Size=32768,Current Size=0[Name=EVENT_ROUTER_QUEUE,Max Size=15360,Current Size=0[Name=CLOUDCHERRY_MESSAGING_QUEUE,Max Size=32768,Current Size=0[Name=CALLSERVER_REPORTING_PROVIDER_QUEUE,Max Size=32768,Current Size=0[Name=SIP_MESSAGE_QUEUE,Max Size=32768,Current Size=0[[CallServer Worker Stats messages/second][TransportManager Reader Worker=0][EventRouter Worker=2][[CallServer Worker TimerManager stats]Total Active TImer=0 4701: 192.168.77.35: Aug 19 2021 07:38:16.816 +0800: %CVP_12_6_IVR-7-CALL: {Thrd=Global-task-executor-group-9} CallServerThreadDumpTask:Subsystem Name=SIPRunning Threads=0