From: "Dmitry Miloserdov" Received: from one.bis.ru ([82.138.63.1] verified) by mail.bestvoip.ru (CommuniGate Pro SMTP 6.2c3) with ESMTPS id 2870385 for CGatePro@ru.stalker.com; Mon, 22 May 2017 22:46:06 +0300 Received: from x-mail.bis.corp ([192.168.1.5]:41167 helo=bis.ru) by one.bis.ru with esmtp (Exim 4.69) (envelope-from ) id 1dCtGz-0007IM-2H for CGatePro@ru.stalker.com; Mon, 22 May 2017 22:45:45 +0300 Received: from [82.138.63.30] (account dmiloserdov@bis.ru HELO [127.0.0.1]) by bis.ru (CommuniGate Pro SMTP 6.1.15) with ESMTPSA id 6560012 for CGatePro@ru.stalker.com; Mon, 22 May 2017 22:45:43 +0300 Subject: =?UTF-8?B?UmU6IFtDR1BdIGF1dG8tYXR0ZW5kYW50INC00LvRjyDQvdC10YHQvtCy?= =?UTF-8?B?0YHQtdC8INC70L7QutCw0LvRjNC90YvRhSDQvdC+0LzQtdGA0L7Qsg==?= To: CommuniGate Pro Russian Discussions References: Message-ID: <7e92442a-3a50-b4d0-cbd2-b1a53ad17867@bis.ru> Date: Mon, 22 May 2017 22:45:44 +0300 User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64; rv:45.0) Gecko/20100101 Thunderbird/45.8.0 MIME-Version: 1.0 In-Reply-To: Content-Type: text/plain; charset=utf-8; format=flowed Content-Transfer-Encoding: 8bit X-Drweb-SpamState: no X-Drweb-SpamScore: 0 X-DrWeb-SpamReason: gggruggvucftvghtrhhoucdtuddrfeeljedrvdejucetufdoteggodetrfcurfhrohhfihhlvgemuceonhhonhgvqeenuceurghilhhouhhtmecupfdsteenuc X-Antivirus: Dr.Web (R) for Unix mail servers drweb plugin ver.6.0.2.0 X-Antivirus-Code: 0x100000 22.05.2017 12:10, Sergey Muravyev пишет: [] > В текущей версии Контакт-центра в наборе добавочного номера можно > набрать любой номер от 3 до 5 цифр и на него будет сделан вызов. > Планируется добавить настройки для задания первых цифр и длины > добавочного номера в будущих версиях Контакт-центра. > > При настроенном контакт-центре в домене использовать стандартный IVR из > приложения "Автосекретарь" возможно, но не рекомендуется, поскольку > нецелесообразно усложняется сценарий звонка в этом случае. С > контакт-центром рекомендуется использовать и IVR из контакт-центра > (более гибкий, с бОльшим количеством настроек, чем стандартный IVR). > > В Вашем сценарии возник неправильный порядок применения сигнальных правил. > > Покажите, пожалуйста, какие условия, действия, а также Priority и Stage > установлены для правил: "PBX Center starter" аккаунта pbx@my.domain и > "ccIn_domain"? > > У Вас получается, что сначала применяется правило PBX Center starter, а > потом сразу ccIn_domain с перенаправлением на #ccincoming. > > Попробуйте, пожалуйста, для правила ccIn_domain установить Stage - > пустой (immediately), а приоритет - Highest, как описано в инструкции по > установке Контакт-центра. Если после этого проблема останется, то > пришлите, пожалуйста, новый лог неудачного звонка. Ниже прикрепил лог проблемного звонка. В прошлый раз вместе с неотносящимся к делу пользовательским трафиком случайно удалил две строчки с ошибками HTTPO, может как-то поможет сейчас ничего не вырезано. Также попытался настроить IVR в CC результат тот же. Тогда я изменил stage в правиле PBX Center starter на 1 секунду и все похоже заработало как нужно. Странно но возврат к предыдущим значениям приводит теперь к другим результатам. Теперь оба приветствия звучат одновременно, а после переадресации через несколько секунд отваливается один поток. Пока оставил с 1 секундой. 20:38:34.053 5 SIP [0.0.0.0]:5060 <- [GWhost]:5060 inp(752): INVITE sip:4444@CGPhost:5060 SIP/2.0\r\nVia: SIP/2.0/UDP GWhost:5060;rpo 20:38:34.053 5 SIP UDP: SIPDATA-002441 preprocessing 20:38:34.053 2 SIPDATA-002441 inp: req [0.0.0.0]:5060 <- udp[GWhost]:5060 INVITE(752 bytes) sip:4444@CGPhost:5060 20:38:34.053 5 SIPDATA-002441 inp: INVITE sip:4444@CGPhost:5060 SIP/2.0 20:38:34.053 5 SIPDATA-002441 inp: Via: SIP/2.0/UDP GWhost:5060;rport;branch=z9hG4bKPj1KjqJ8zIvDP4TX6APSoH2RgqUnseYS8e 20:38:34.053 5 SIPDATA-002441 inp: Max-Forwards: 70 20:38:34.053 5 SIPDATA-002441 inp: From: "2043" ;tag=RJCwWGJ6xZxezuQ5fPqlZhezAoRmBjRj 20:38:34.053 5 SIPDATA-002441 inp: To: 20:38:34.053 5 SIPDATA-002441 inp: Contact: 20:38:34.053 5 SIPDATA-002441 inp: Call-ID: dD8.b7qYDlraBToDhbeZenCdYT992S7v 20:38:34.053 5 SIPDATA-002441 inp: CSeq: 25374 INVITE 20:38:34.053 5 SIPDATA-002441 inp: Category: 227 20:38:34.053 5 SIPDATA-002441 inp: Content-Type: application/sdp 20:38:34.053 5 SIPDATA-002441 inp: Content-Length: 241 20:38:34.053 5 SIPDATA-002441 inp: 20:38:34.053 5 SIPDATA-002441 inp: v=0 20:38:34.053 5 SIPDATA-002441 inp: o=mgapp 1267078180 934608776 IN IP4 GWhost 20:38:34.053 5 SIPDATA-002441 inp: s=- 20:38:34.053 5 SIPDATA-002441 inp: c=IN IP4 GWhost 20:38:34.053 5 SIPDATA-002441 inp: t=0 0 20:38:34.053 5 SIPDATA-002441 inp: m=audio 22668 RTP/AVP 8 0 101 20:38:34.053 5 SIPDATA-002441 inp: a=rtpmap:8 PCMA/8000 20:38:34.053 5 SIPDATA-002441 inp: a=rtpmap:0 PCMU/8000 20:38:34.053 5 SIPDATA-002441 inp: a=rtpmap:101 telephone-event/8000 20:38:34.053 5 SIPDATA-002441 inp: a=fmtp:101 0-16 20:38:34.053 5 SIPDATA-002441 inp: a=ptime:30 20:38:34.053 5 SIPDATA-002441 inp: a=sendrecv 20:38:34.053 4 SIPDATA-002441 Hash=1153861878 20:38:34.053 4 SIPS-001486 enqueued 20:38:34.054 5 SIPS-001486 INITIAL posted 20:38:34.054 2 SIPDATA-002441 created SIPS-001486 20:38:34.054 5 SIP UDP: SIPDATA-002441 preprocessed 20:38:34.054 5 SIPS(3) 001486: processing INITIAL 20:38:34.054 2 SIPS-001486 SIPDATA-002441 INVITE sip:4444@CGPhost:5060 from udp[GWhost]:5060 20:38:34.054 4 SIPS-001486 workarounds: BadCRYPTO 20:38:34.054 2 SIPDATA-002442 out: rsp [0.0.0.0]:5060 -> udp[GWhost]:5060 100-INVITE(345 bytes) 20:38:34.054 5 SIPDATA-002442 out: SIP/2.0 100 Trying 20:38:34.054 5 SIPDATA-002442 out: Via: SIP/2.0/UDP GWhost:5060;rport=5060;branch=z9hG4bKPj1KjqJ8zIvDP4TX6APSoH2RgqUnseYS8e 20:38:34.054 5 SIPDATA-002442 out: From: "2043" ;tag=RJCwWGJ6xZxezuQ5fPqlZhezAoRmBjRj 20:38:34.054 5 SIPDATA-002442 out: To: 20:38:34.054 5 SIPDATA-002442 out: Call-ID: dD8.b7qYDlraBToDhbeZenCdYT992S7v 20:38:34.054 5 SIPDATA-002442 out: CSeq: 25374 INVITE 20:38:34.054 5 SIPDATA-002442 out: Server: CommuniGatePro/6.1.15 20:38:34.054 5 SIPDATA-002442 out: Content-Length: 0 20:38:34.054 5 SIPDATA-002442 out: 20:38:34.054 5 SIP [0.0.0.0]:5060 -> [GWhost]:5060 out(345): SIP/2.0 100 Trying\r\nVia: SIP/2.0/UDP GWhost:5060;rport=5060;branch=z9hG4bK 20:38:34.054 2 SIPS-001486 SIPDATA-002442 100-INVITE(trying) sent [0.0.0.0]:5060 -> udp[GWhost]:5060 20:38:34.054 4 SIGNAL-002098 enqueued 20:38:34.054 5 SIGNAL-002098 INITIAL posted 20:38:34.054 2 SIPS-001486 SIGNAL-002098 created 20:38:34.054 5 SIPS(3) 001486: idling 20:38:34.054 5 SIGNAL(2) 002098: processing INITIAL 20:38:34.054 2 SIGNAL-002098 SIPS-001486: INVITE(25374) sip:4444@CGPhost:5060 20:38:34.054 2 DIALOG-000121 created for SIGNAL-002098:[GWhost] 20:38:34.054 4 DIALOG-000121 enqueued 20:38:34.054 2 SIGNAL-002098 DIALOG-000121 created 20:38:34.054 4 SIGNAL-002098 AOR added: sip:4444@CGPhost:5060 20:38:34.054 4 SIGNAL-002098 applying server rules 20:38:34.054 5 SIGNAL-002098 processing 1 rules. stage=0 20:38:34.054 5 SIGNALRULE-002098 rule(ccOut_domain) condition #3(Authenticated) is false 20:38:34.054 5 SIGNAL-002098 1 of 1 rules processed 20:38:34.054 5 SIGNAL-002098 timeout set for 900s 20:38:34.054 2 SIGNAL-002098 INVITE sip:4444@CGPhost:5060 via sip:4444@CGPhost:5060 20:38:34.055 4 DIALOG-000121 callee set: pbx@my.domain 20:38:34.055 4 SIGNAL-002098 applying Account rules 20:38:34.055 5 SIGNAL-002098 processing 2 rules. stage=-1 20:38:34.055 4 SIGNALRULE-002098 rule(PBX Center starter) conditions met 20:38:34.055 4 SIGNALRULE-002098 rule(PBX Center starter): -> sip:pbx#pbx@my.domain 20:38:34.055 2 SIGNALRULE-002098 rule(PBX Center starter): redirected 20:38:34.055 5 SIGNAL-002098 1 of 2 rules processed 20:38:34.055 4 SIGNAL-002098 AOR added: sip:pbx#pbx@my.domain 20:38:34.055 2 SIGNAL-002098 redirected by Rules 20:38:34.055 5 SIGNAL-002098 timeout immediate set 20:38:34.055 2 SIGNAL-002098 INVITE sip:pbx#pbx@my.domain 20:38:34.055 2 PBXLEG-000528 'pbx' created for ACCOUNT(pbx@my.domain) 20:38:34.055 2 SIGNAL-002098 SIPS-001486: {1/2} sent to NODE-000528: INVITE sip:pbx#pbx@my.domain 20:38:34.055 5 SIGNAL(2) 002098: enqueued (0 secs) 20:38:34.055 5 SIGNAL(2) 002098: timeout 20:38:34.055 4 SIGNAL-002098 stage timeout (0 sec) 20:38:34.055 5 SIGNAL-002098 processing 1 rules. stage=0 20:38:34.055 4 SIGNALRULE-002098 rule(ccIn_domain) conditions met 20:38:34.055 4 SIGNALRULE-002098 rule(ccIn_domain): -> sip:ccincoming%23pbx@my.domain 20:38:34.055 2 SIGNALRULE-002098 rule(ccIn_domain): redirected 20:38:34.055 2 PBXLEG-000528 started <- DIALOG-000121: 2043@GWhost(sip:2043@GWhost:5060;user=phone)(noUPDATE)(noREFER) 20:38:34.055 2 PBXLEG-000528 session refresh=7200(active) 20:38:34.055 2 PBXLEG-000528 pbx.sppr(Main) started 20:38:34.055 5 SIGNAL-002098 1 of 1 rules processed 20:38:34.055 4 SIGNAL-002098 cancelling all 20:38:34.055 4 SIGNAL-002098 {1/2} NODE-000528 cancelled 20:38:34.055 2 PBXLEG-000528 ProgramLog: "calledUser = 4444" 20:38:34.055 4 SIGNAL-002098 AOR added: sip:ccincoming%23pbx@my.domain 20:38:34.055 5 SIGNAL-002098 timeout set for 900s 20:38:34.055 2 SIGNAL-002098 INVITE sip:ccincoming%23pbx@my.domain 20:38:34.056 2 PBXLEG-000530 'ccincoming' created for ACCOUNT(pbx@my.domain) 20:38:34.056 2 SIGNAL-002098 SIPS-001486: {2/3} sent to NODE-000530: INVITE sip:ccincoming%23pbx@my.domain 20:38:34.056 5 SIGNAL(2) 002098: enqueued (900 secs) 20:38:34.056 2 MEDIA-000040 created for PBXLEG-000528: audio([0.0.0.0]:60000 8000Hz ssrc=4444447A) 20:38:34.056 2 MEDIA-000040 processor started 20:38:34.056 2 MEDIA-000040 audio offer SDP set:{101=DTMF 8=PCMA/8000} <-> [GWhost]:22668:22669 {101=DTMF 8=PCMA/8000,0=PCMU/8000,101=telephone-event/8000} 20:38:34.056 2 PBXLEG-000528 session refresh=7200(active) 20:38:34.056 2 PBXLEG-000530 started <- DIALOG-000121: 2043@GWhost(sip:2043@GWhost:5060;user=phone)(noUPDATE)(noREFER) 20:38:34.056 2 PBXLEG-000530 session refresh=7200(active) 20:38:34.056 2 PBXLEG-000530 ccincoming.sppr(Main) started 20:38:34.056 2 MEDIA-000040 local answer SDP composed 20:38:34.056 4 DIALOG-000121 CALLEE(296EA03A-528-97F3012E) created 20:38:34.056 2 MEDIA-000040 remote SDP retrieved 20:38:34.056 2 PBXLEG-000528 SIGNAL-002098 200-INVITE response sent 20:38:34.056 5 SIGNAL-002098 FINAL posted 20:38:34.056 2 PBXLEG-000528 accepting started 20:38:34.057 2 PBXLEG-000530 CLI command: GetNamedTask contactcenter@my.domain 20:38:34.057 5 SIGNAL(1) 002098: processing FINAL 20:38:34.057 4 SIGNAL-002098 {1/2} NODE-000528 reported final(200) 20:38:34.057 4 SIGNAL-002098 DIALOG-000121 updating on <- 200-INVITE 20:38:34.057 4 DIALOG-000121 expiration timer set to 7200 sec 20:38:34.057 4 SIGNAL-002098 200-INVITE call Record-Route[0] is reverted 20:38:34.057 3 SIGNAL-002098 supplementary 200-INVITE: upstreaming 20:38:34.057 2 PBXLEG-000530 ProgramLog: "2 Main(2043@GWhost): general settings read: {agentInitialStatus=last;agentPty=7;agentSkill=4;alertTimeout=30;groupPty=5;logLevel=5;ringStrategy=random;waitingMusicList=(holdmusic);}" 20:38:34.057 2 SIGNAL-002098 SIPS-001486(resending): 200-INVITE upstreaming 20:38:34.057 5 SIPS-001486 SUPPLUPSTREAM posted 20:38:34.057 2 PBXLEG-000528 incoming request CANCEL-ed after our 2xx-response 20:38:34.057 2 SIPDATA-000000 submitted to SIPS-001486 to suppl-upstream 20:38:34.057 4 SIGNAL-002100 enqueued 20:38:34.057 5 SIGNAL-002100 INITIAL posted 20:38:34.057 2 PBXLEG-000528 disconnected 20:38:34.057 5 SIPS(2) 001486: processing SUPPLUPSTREAM 20:38:34.057 2 PBXLEG-000528 program stopped 20:38:34.057 1 SIPS-001486 suppl Upstream 200-INVITE response ignored, wrong state(0) 20:38:34.057 5 SIGNAL(3) 002100: processing INITIAL 20:38:34.057 5 SIPS(2) 001486: idling 20:38:34.057 2 PBXLEG-000530 ProgramLog: "4 Main(2043@GWhost): Remote SDP active media types (audio): {host=pbx@my.domain;module=LOCAL;object=\"\";}" 20:38:34.059 5 SIPC-000140 INITIAL posted 20:38:34.059 2 SIGNAL-002100 NULL-000000: {1/1} sent to SIPC-000140: BYE sip:2043@GWhost:5060;maddr=GWhost;user=phone via 20:38:34.059 5 SIPC(2) 000140: processing INITIAL 20:38:34.059 2 SIPC-000140 SIGNAL-002100 BYE sip:2043@GWhost:5060;maddr=GWhost;user=phone 20:38:34.059 5 SIGNAL(3) 002100: enqueued (900 secs) 20:38:34.059 4 SIPC-000140 resolving sip:GWhost:5060;maddr=GWhost 20:38:34.059 2 PBXLEG-000530 ProgramLog: "2 Main(2043@GWhost): CG-Card CRM request: {op=getTel;param=2043;}" 20:38:34.059 4 SIPC-000140 trying: sip:GWhost:5060 20:38:34.059 5 SIPC-000140 timeout set for 2s 20:38:34.059 2 PBXLEG-000530 CLI command: ListAccountSessions pbx@my.domain PROTOCOL WebUser 20:38:34.059 2 SIPDATA-002443 out: req [CGPhost]:5060 -> udp[GWhost]:5060 BYE(532 bytes) sip:2043@GWhost:5060;maddr=GWhost;user=phone 20:38:34.059 5 SIPDATA-002443 out: BYE sip:2043@GWhost:5060;maddr=GWhost;user=phone SIP/2.0 20:38:34.059 5 SIPDATA-002443 out: Via: SIP/2.0/UDP CGPhost:5060;branch=z9hG4bK140;rport 20:38:34.059 5 SIPDATA-002443 out: P-CGP-Identity: pbx@my.domain 20:38:34.059 5 SIPDATA-002443 out: Max-Forwards: 15 20:38:34.059 5 SIPDATA-002443 out: From: ;tag=296EA03A-528-97F3012E 20:38:34.059 5 SIPDATA-002443 out: To: "2043" ;tag=RJCwWGJ6xZxezuQ5fPqlZhezAoRmBjRj 20:38:34.059 5 SIPDATA-002443 out: Call-ID: dD8.b7qYDlraBToDhbeZenCdYT992S7v 20:38:34.059 5 SIPDATA-002443 out: Contact: 20:38:34.059 5 SIPDATA-002443 out: CSeq: 1 BYE 20:38:34.059 5 SIPDATA-002443 out: Reason: SIP;cause=400;text="Request cancelled" 20:38:34.059 5 SIPDATA-002443 out: User-Agent: CommuniGatePro-callLeg/6.1.15 20:38:34.059 5 SIPDATA-002443 out: Content-Length: 0 20:38:34.059 5 SIPDATA-002443 out: 20:38:34.059 5 SIP [0.0.0.0]:5060 -> [GWhost]:5060 out(532): BYE sip:2043@GWhost:5060;maddr=GWhost;user=phone SIP/2.0\r\nVia: SIP/2 20:38:34.059 2 PBXLEG-000530 CLI command: GetSession 114-JWpkMcB1svXhDRO89niX Domain my.domain 20:38:34.059 2 SIPC-000140 SIPDATA-002443 BYE sip:2043@GWhost:5060;maddr=GWhost;user=phone sent [CGPhost]:5060 -> udp[GWhost]:5060 20:38:34.059 5 SIPC(2) 000140: enqueued (2 secs) 20:38:34.060 3 HTTPO-000026 write failed. Error Code=broken connection 20:38:34.060 1 HTTPO-000026 failed. Error Code=broken connection 20:38:34.060 2 PBXLEG-000530 ProgramLog: "2 Main(2043@GWhost): CG-Card CRM result: #NULL#" 20:38:34.060 2 PBXLEG-000530 ProgramLog: "3 Main(2043@GWhost): original: 2043@GWhost -> 4444@CGPhost" 20:38:34.061 2 PBXLEG-000530 ProgramLog: "3 Main(2043@GWhost): routed: #NULL# -> pbx@my.domain" 20:38:34.061 2 PBXLEG-000530 ProgramLog: "3 Main(2043@GWhost): failed to read 'pbx@my.domain' CC settings: failed to read CC settings file: \"/private/contactcenter/ccobjects/pbx.settings\"" 20:38:34.061 2 PBXLEG-000530 ProgramLog: "2 Main(2043@GWhost): bypassing CC: 2043@GWhost -> 4444@CGPhost" 20:38:34.061 3 PBXLEG-000530 failed to open '2043@GWhost'. Error Code=account is not available on this system 20:38:34.062 2 PBXLEG-000530 ProgramLog: "3 Main(2043@GWhost): record in bypass Disabled: From(NO), Impersonate(NO), To(NO)" 20:38:34.062 2 PBXLEG-000530 ProgramLog: "callerLeg:{\"\"=\"sip:4444@CGPhost:5060;fromCC=true\";Call-ID=dD8.b7qYDlraBToDhbeZenCdYT992S7v.bypassCC;From=\"sip:2043@GWhost\";Max-Forwards=#69;P-CGP-Local=cc;callBridged=YES;fromName=2043;impersonate=pbx@my.domain;noBeeps=YES;referMode=peer;}" 20:38:34.062 2 PBXLEG-000530 spawning PBXLEG-000532 20:38:34.062 2 PBXLEG-000532 spawned by PBXLEG-000530 20:38:34.063 2 PBXLEG-000532 callerleg.sppi(bridgeCaller) started 20:38:34.063 2 PBXLEG-000530 event([bridgeStart]) to NODE-000532 sent 20:38:34.063 2 PBXLEG-000532 impersonated as itself(pbx@my.domain) 20:38:34.063 2 PBXLEG-000530 bridge(NODE-000532) bridge starting started 20:38:34.063 2 PBXLEG-000532 event([bridgeStart]) from NODE-000530 retrieved 20:38:34.063 2 PBXLEG-000532 bridge(NODE-000530) bridged call(SDP) 20:38:34.063 2 PBXLEG-000532 calling sip:4444@CGPhost:5060;fromCC=true(SDP) 20:38:34.063 4 SIGNAL-002102 enqueued 20:38:34.063 5 SIGNAL-002102 INITIAL posted 20:38:34.063 2 PBXLEG-000532 media is bridged 20:38:34.063 5 SIGNAL(2) 002102: processing INITIAL 20:38:34.063 2 SIGNAL-002102 NODE-000532: INVITE(1) sip:4444@CGPhost:5060;fromCC=true 20:38:34.063 2 DIALOG-000122 created for SIGNAL-002102:[*] 20:38:34.063 4 DIALOG-000122 enqueued 20:38:34.063 2 SIGNAL-002102 DIALOG-000122 created 20:38:34.063 4 DIALOG-000122 caller set: pbx@my.domain 20:38:34.063 4 SIGNAL-002102 AOR added: sip:4444@CGPhost:5060;fromCC=true 20:38:34.063 4 SIGNAL-002102 applying server rules 20:38:34.063 5 SIGNAL-002102 processing 1 rules. stage=0 20:38:34.063 5 SIGNALRULE-002102 rule(ccOut_domain) condition #2(Submit Address) is false 20:38:34.063 5 SIGNAL-002102 1 of 1 rules processed 20:38:34.063 5 SIGNAL-002102 timeout set for 900s 20:38:34.063 2 SIGNAL-002102 INVITE sip:4444@CGPhost:5060;fromCC=true via sip:4444@CGPhost:5060;fromCC=true 20:38:34.064 4 DIALOG-000122 callee set: pbx@my.domain 20:38:34.064 4 SIGNAL-002102 applying Account rules 20:38:34.064 5 SIGNAL-002102 processing 2 rules. stage=-1 20:38:34.064 4 SIGNALRULE-002102 rule(PBX Center starter) conditions met 20:38:34.064 4 SIGNALRULE-002102 rule(PBX Center starter): -> sip:pbx#pbx@my.domain 20:38:34.064 2 SIGNALRULE-002102 rule(PBX Center starter): redirected 20:38:34.064 5 SIGNAL-002102 1 of 2 rules processed 20:38:34.064 4 SIGNAL-002102 AOR added: sip:pbx#pbx@my.domain 20:38:34.064 2 SIGNAL-002102 redirected by Rules 20:38:34.064 5 SIGNAL-002102 timeout immediate set 20:38:34.064 2 SIGNAL-002102 INVITE sip:pbx#pbx@my.domain 20:38:34.064 2 PBXLEG-000534 'pbx' created for ACCOUNT(pbx@my.domain) 20:38:34.064 2 SIGNAL-002102 NODE-000532: {1/2} sent to NODE-000534: INVITE sip:pbx#pbx@my.domain 20:38:34.064 5 SIGNAL(2) 002102: enqueued (0 secs) 20:38:34.064 5 SIGNAL(2) 002102: timeout 20:38:34.064 4 SIGNAL-002102 stage timeout (0 sec) 20:38:34.064 5 SIGNAL-002102 processing 1 rules. stage=0 20:38:34.064 5 SIGNALRULE-002102 rule(ccIn_domain) condition #2(RequestURI) is false 20:38:34.064 5 SIGNAL-002102 1 of 1 rules processed 20:38:34.064 5 SIGNAL-002102 timeout set for 900s 20:38:34.064 5 SIGNAL(2) 002102: enqueued (900 secs) 20:38:34.064 2 PBXLEG-000534 started <- DIALOG-000122: 2043@GWhost(sip:signode-532-97F3012E@my.domain) 20:38:34.064 2 PBXLEG-000534 session refresh=7200(passive) 20:38:34.064 2 PBXLEG-000534 peer authenticated as 'pbx@my.domain' 20:38:34.064 2 PBXLEG-000534 pbx.sppr(Main) started 20:38:34.064 2 PBXLEG-000534 ProgramLog: "calledUser = 4444" 20:38:34.065 2 MEDIA-000041 created for PBXLEG-000534: audio([0.0.0.0]:60004 8000Hz ssrc=4444447B) 20:38:34.065 2 MEDIA-000041 processor started 20:38:34.065 2 MEDIA-000041 audio offer SDP set:{101=DTMF 8=PCMA/8000} <-> [GWhost]:22668:22669 {101=DTMF 8=PCMA/8000,0=PCMU/8000,101=telephone-event/8000} 20:38:34.065 2 PBXLEG-000534 session refresh=7200(passive) 20:38:34.065 2 MEDIA-000041 local answer SDP composed 20:38:34.065 4 DIALOG-000122 CALLEE(BACD7B13-534-97F3012E) created 20:38:34.065 2 MEDIA-000041 remote SDP retrieved 20:38:34.065 2 PBXLEG-000534 SIGNAL-002102 200-INVITE response sent 20:38:34.065 5 SIGNAL-002102 FINAL posted 20:38:34.065 2 PBXLEG-000534 accepting started 20:38:34.065 5 SIGNAL(3) 002102: processing FINAL 20:38:34.065 4 SIGNAL-002102 {1/2} NODE-000534 reported final(200) 20:38:34.065 4 SIGNAL-002102 DIALOG-000122 updating on <- 200-INVITE 20:38:34.065 4 DIALOG-000122 expiration timer set to 7200 sec 20:38:34.066 4 SIGNAL-002102 200-INVITE call Record-Route[0] is reverted 20:38:34.066 4 SIGNAL-002102 collected code=200(OK) 20:38:34.066 2 DIALOG-000122 CALLEE(BACD7B13-534-97F3012E) connected 20:38:34.066 4 DIALOG-000122 updating caller info 20:38:34.066 2 ACCOUNT(pbx) out call connected. alerting=0 sec 20:38:34.066 4 DIALOG-000122 updating callee info 20:38:34.066 2 ACCOUNT(pbx) inp call connected. alerting=0 sec 20:38:34.066 2 SIGNAL-002102 200-INVITE reporting 20:38:34.066 5 SIGNAL(3) 002102: killing 20:38:34.066 4 SIGNAL-002102 dequeued 20:38:34.066 2 SIGNAL-002102 releasing 20:38:34.066 2 PBXLEG-000532 event([bridgeBridged]) to NODE-000530 sent 20:38:34.066 2 PBXLEG-000530 event([bridgeBridged]) from NODE-000532 20:38:34.066 2 PBXLEG-000532 started -> DIALOG-000122: 4444@CGPhost(sip:signode-534-97F3012E@my.domain) 20:38:34.066 2 PBXLEG-000532 session refresh=7200(active) 20:38:34.066 2 PBXLEG-000530 media is bridged 20:38:34.066 4 SIGNAL-002104 enqueued 20:38:34.066 2 PBXLEG-000530 session refresh=7200(active) 20:38:34.066 5 SIGNAL-002104 DOWNSTREAM posted 20:38:34.066 4 DIALOG-000121 CALLEE(05511E68-530-97F3012E) created 20:38:34.066 5 SIGNAL(2) 002104: processing DOWNSTREAM 20:38:34.066 2 PBXLEG-000532 event([asyncCallFinal]) retrieved 20:38:34.066 2 SIGNAL-002104 NODE-000532:downstreaming ACK(1) sip:signode-534-97F3012E@my.domain 20:38:34.066 2 PBXLEG-000530 SIGNAL-002098 200-INVITE response sent 20:38:34.066 5 SIGNAL-002098 FINAL posted 20:38:34.066 4 SIGNAL-002104 DIALOG-000122 updating on -> ACK 20:38:34.066 2 SIGNAL-002104 NODE-000532 downstreamed to NODE-000534: ACK sip:signode-534-97F3012E@my.domain 20:38:34.067 5 SIGNAL(2) 002104: killing 20:38:34.067 4 SIGNAL-002104 dequeued 20:38:34.067 2 SIGNAL-002104 releasing 20:38:34.067 5 SIGNAL(1) 002098: processing FINAL 20:38:34.067 4 SIGNAL-002098 {2/3} NODE-000530 reported final(200) 20:38:34.067 4 SIGNAL-002098 DIALOG-000121 updating on <- 200-INVITE 20:38:34.067 4 SIGNAL-002098 200-INVITE call Record-Route[0] is reverted 20:38:34.067 4 SIGNAL-002098 collected code=200(OK) 20:38:34.067 2 DIALOG-000121 CALLEE(05511E68-530-97F3012E) connected 20:38:34.067 4 DIALOG-000121 workarounds: BadCRYPTO <-> 20:38:34.067 2 DIALOG-000121 removing 1 CALLEE element(s) 20:38:34.067 4 DIALOG-000121 updating callee info 20:38:34.067 2 ACCOUNT(pbx) inp call connected. alerting=0 sec 20:38:34.067 2 SIGNAL-002098 200-INVITE reporting 20:38:34.067 5 SIPS-001486 FINAL posted 20:38:34.067 5 SIGNAL(1) 002098: killing 20:38:34.067 4 SIGNAL-002098 dequeued 20:38:34.067 2 SIGNAL-002098 releasing 20:38:34.067 5 SIPS(1) 001486: processing FINAL 20:38:34.067 5 SIPS-001486 RRs: response=1,orig=0,nOrig=0,inserted=0 20:38:34.067 2 SIPDATA-002444 out: rsp [0.0.0.0]:5060 -> udp[GWhost]:5060 200-INVITE(1009 bytes) 20:38:34.067 5 SIPDATA-002444 out: SIP/2.0 200 OK 20:38:34.067 5 SIPDATA-002444 out: Via: SIP/2.0/UDP GWhost:5060;rport=5060;branch=z9hG4bKPj1KjqJ8zIvDP4TX6APSoH2RgqUnseYS8e 20:38:34.067 5 SIPDATA-002444 out: Record-Route: 20:38:34.067 5 SIPDATA-002444 out: Record-Route: 20:38:34.067 5 SIPDATA-002444 out: From: "2043" ;tag=RJCwWGJ6xZxezuQ5fPqlZhezAoRmBjRj 20:38:34.067 5 SIPDATA-002444 out: To: ;tag=05511E68-530-97F3012E 20:38:34.067 5 SIPDATA-002444 out: Call-ID: dD8.b7qYDlraBToDhbeZenCdYT992S7v 20:38:34.067 5 SIPDATA-002444 out: CSeq: 25374 INVITE 20:38:34.067 5 SIPDATA-002444 out: Contact: 20:38:34.067 5 SIPDATA-002444 out: Supported: 100rel,timer,replaces,histinfo,precondition 20:38:34.067 5 SIPDATA-002444 out: Allow: INVITE,OPTIONS,INFO,MESSAGE,PRACK,UPDATE,REFER 20:38:34.067 5 SIPDATA-002444 out: Session-Expires: 7200;refresher=uas 20:38:34.067 5 SIPDATA-002444 out: User-Agent: CommuniGatePro-callLeg/6.1.15 20:38:34.067 5 SIPDATA-002444 out: Content-Type: application/sdp 20:38:34.067 5 SIPDATA-002444 out: Content-Length: 317 20:38:34.067 5 SIPDATA-002444 out: 20:38:34.067 5 SIPDATA-002444 out: v=0 20:38:34.067 5 SIPDATA-002444 out: o=CGPLeg000530 344651531 172325766 IN IP4 WANIP 20:38:34.067 5 SIPDATA-002444 out: s=- 20:38:34.067 5 SIPDATA-002444 out: c=IN IP4 CGPhost 20:38:34.067 5 SIPDATA-002444 out: t=0 0 20:38:34.067 5 SIPDATA-002444 out: m=audio 60004 RTP/AVP 8 0 101 20:38:34.067 5 SIPDATA-002444 out: a=rtpmap:8 PCMA/8000 20:38:34.067 5 SIPDATA-002444 out: a=rtpmap:0 PCMU/8000 20:38:34.067 5 SIPDATA-002444 out: a=rtpmap:101 telephone-event/8000 20:38:34.067 5 SIPDATA-002444 out: a=fmtp:101 0-15 20:38:34.067 5 SIPDATA-002444 out: a=sendrecv 20:38:34.067 5 SIPDATA-002444 out: a=ice-pwd:B101DDFA8FCF943645D0E0E 20:38:34.067 5 SIPDATA-002444 out: a=ice-ufrag:cgp41+0 20:38:34.067 5 SIPDATA-002444 out: a=rtcpping:M:41:1659566323 20:38:34.067 5 SIP [0.0.0.0]:5060 -> [GWhost]:5060 out(1009): SIP/2.0 200 OK\r\nVia: SIP/2.0/UDP GWhost:5060;rport=5060;branch=z9hG4bKPj1K 20:38:34.067 2 SIPS-001486 SIPDATA-002444 200-INVITE(final) sent [0.0.0.0]:5060 -> udp[GWhost]:5060 20:38:34.067 5 SIPS-001486 timeout set for 32s 20:38:34.067 5 SIPS(1) 001486: enqueued (32 secs) 20:38:34.069 5 SIP [0.0.0.0]:5060 <- [GWhost]:5060 inp(450): ACK sip:signode-530-97F3012E@CGPhost SIP/2.0\r\nVia: SIP/2.0/UDP GWhost: 20:38:34.069 5 SIP UDP: SIPDATA-002445 preprocessing 20:38:34.069 2 SIPDATA-002445 inp: req [0.0.0.0]:5060 <- udp[GWhost]:5060 ACK(450 bytes) sip:signode-530-97F3012E@CGPhost 20:38:34.069 5 SIPDATA-002445 inp: ACK sip:signode-530-97F3012E@CGPhost SIP/2.0 20:38:34.069 5 SIPDATA-002445 inp: Via: SIP/2.0/UDP GWhost:5060;rport;branch=z9hG4bKPj8CXQjIgaR9EExNRfYjmYlSzYN3zauvz2 20:38:34.069 5 SIPDATA-002445 inp: Max-Forwards: 70 20:38:34.069 5 SIPDATA-002445 inp: From: "2043" ;tag=RJCwWGJ6xZxezuQ5fPqlZhezAoRmBjRj 20:38:34.069 5 SIPDATA-002445 inp: To: ;tag=05511E68-530-97F3012E 20:38:34.069 5 SIPDATA-002445 inp: Call-ID: dD8.b7qYDlraBToDhbeZenCdYT992S7v 20:38:34.069 5 SIPDATA-002445 inp: CSeq: 25374 ACK 20:38:34.069 5 SIPDATA-002445 inp: Route: 20:38:34.069 5 SIPDATA-002445 inp: Route: 20:38:34.069 5 SIPDATA-002445 inp: Content-Length: 0 20:38:34.069 5 SIPDATA-002445 inp: 20:38:34.069 4 SIPDATA-002445 Hash=234319913 20:38:34.069 4 SIPDATA-002445 self-Route removed: 20:38:34.069 4 SIPDATA-002445 special route detected: sip:121.call.cgatepro;lr 20:38:34.069 4 SIPDATA-002445 CLUSTER[LOCAL] object URI: sip:121.call.cgatepro;lr 20:38:34.069 4 SIPS-001488 enqueued 20:38:34.069 5 SIPS-001488 DOWNSTREAM posted 20:38:34.069 2 SIPDATA-002445 created SIPS-001488 20:38:34.069 5 SIP UDP: SIPDATA-002445 preprocessed 20:38:34.069 5 SIPS(3) 001488: processing DOWNSTREAM 20:38:34.069 2 SIPS-001488 SIPDATA-002445 ACK sip:signode-530-97F3012E@CGPhost from udp[GWhost]:5060 20:38:34.069 4 SIPS-001488 workarounds: BadCRYPTO 20:38:34.069 4 SIGNAL-002106 enqueued 20:38:34.069 5 SIGNAL-002106 DOWNSTREAM posted 20:38:34.069 2 SIPS-001488 SIGNAL-002106 created 20:38:34.069 5 SIPS(3) 001488: killing 20:38:34.069 4 SIPS-001488 dequeued 20:38:34.069 5 SIGNAL-002106 DETACH posted queued 20:38:34.069 5 SIGNAL(3) 002106: processing DOWNSTREAM 20:38:34.069 2 SIGNAL-002106 SIPS-001488:downstreaming ACK(25374) sip:signode-530-97F3012E@CGPhost 20:38:34.069 4 SIGNAL-002106 DIALOG-000121 updating on -> ACK 20:38:34.069 2 SIGNAL-002106 SIPS-001488 downstreamed to NODE-000530: ACK sip:signode-530-97F3012E@CGPhost 20:38:34.069 5 SIGNAL(3) 002106: killing 20:38:34.069 4 SIGNAL-002106 dequeued 20:38:34.069 2 SIGNAL-002106 releasing 20:38:34.069 2 PBXLEG-000530 bridge(NODE-000532) [bridgeBridged] completed(no SDP)