<--- Received SIP request (617 bytes) from TCP:27.61.183.38:9457 ---> REGISTER sip:XXXX.dyndns.org SIP/2.0 Via: SIP/2.0/TCP 100.70.180.158:XXXX;branch=z9hG4bK-524287-1---ea67d47771e3c669;rport Max-Forwards: 70 Contact: ;+sip.instance="590@XXXX.dyndns.org";methods="INVITE,ACK,CANCEL,OPTIONS,BYE,NOTIFY,SUBSCRIBE,INFO,MESSAGE,PRACK" To: From: ;tag=aefac76b Call-ID: bkHb6m71upYDDvubMzdFzQ.. CSeq: 1 REGISTER Expires: 3600 Accept-Language: en Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, NOTIFY, SUBSCRIBE, INFO, MESSAGE, PRACK Supported: timer Content-Length: 0 <--- Transmitting SIP response (522 bytes) to TCP:27.61.183.38:9457 ---> SIP/2.0 401 Unauthorized Via: SIP/2.0/TCP 100.70.180.158:XXXX;rport=9457;received=27.61.183.38;branch=z9hG4bK-524287-1---ea67d47771e3c669 Call-ID: bkHb6m71upYDDvubMzdFzQ.. From: ;tag=aefac76b To: ;tag=z9hG4bK-524287-1---ea67d47771e3c669 CSeq: 1 REGISTER WWW-Authenticate: Digest realm="asterisk",nonce="1625496132/ad890197c265676daa7561de7cf30eb1",opaque="5456b54912f38f65",algorithm=md5,qop="auth" Server: FPBX-15.0.16.75(16.10.0) Content-Length: 0 <--- Received SIP request (902 bytes) from TCP:27.61.183.38:9457 ---> REGISTER sip:XXXX.dyndns.org SIP/2.0 Via: SIP/2.0/TCP 100.70.180.158:XXXX;branch=z9hG4bK-524287-1---d95b692958261c5a;rport Max-Forwards: 70 Contact: ;+sip.instance="590@XXXX.dyndns.org";methods="INVITE,ACK,CANCEL,OPTIONS,BYE,NOTIFY,SUBSCRIBE,INFO,MESSAGE,PRACK" To: From: ;tag=aefac76b Call-ID: bkHb6m71upYDDvubMzdFzQ.. CSeq: 2 REGISTER Expires: 3600 Accept-Language: en Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, NOTIFY, SUBSCRIBE, INFO, MESSAGE, PRACK Supported: timer Authorization: Digest username="590",realm="asterisk",nonce="1625496132/ad890197c265676daa7561de7cf30eb1",uri="sip:XXXX.dyndns.org",response="53325f2c29853f872a0d18baa0c32c07",cnonce="dde13f2b9cc4df15e381b675b27ac33a",nc=00000001,qop=auth,algorithm=md5,opaque="5456b54912f38f65" Content-Length: 0 -- Added contact 'sip:590@27.61.183.38:9457;transport=TCP;x-ast-orig-host=100.70.180.158:XXXX' to AOR '590' with expiration of 3600 seconds <--- Transmitting SIP response (485 bytes) to TCP:27.61.183.38:9457 ---> SIP/2.0 200 OK Via: SIP/2.0/TCP 100.70.180.158:XXXX;rport=9457;received=27.61.183.38;branch=z9hG4bK-524287-1---d95b692958261c5a Call-ID: bkHb6m71upYDDvubMzdFzQ.. From: ;tag=aefac76b To: ;tag=z9hG4bK-524287-1---d95b692958261c5a CSeq: 2 REGISTER Date: Mon, 05 Jul 2021 14:42:12 GMT Contact: ;expires=3599 Expires: 3600 Server: FPBX-15.0.16.75(16.10.0) Content-Length: 0 <--- Transmitting SIP request (527 bytes) to TCP:27.61.183.38:9457 ---> OPTIONS sip:590@27.61.183.38:9457;transport=TCP;x-ast-orig-host=100.70.180.158:XXXX SIP/2.0 Via: SIP/2.0/TCP 97.79.59.226:XXXX;rport;branch=z9hG4bKPj84bcd70b-1f1b-4661-ad1b-da7bc0b4b499;alias From: ;tag=1048adb6-bda7-4899-bcfa-4c409de0b3ed To: Contact: Call-ID: 4106b353-095d-4b32-8cf0-6e4c82cd8fcf CSeq: 62137 OPTIONS Max-Forwards: 70 User-Agent: FPBX-15.0.16.75(16.10.0) Content-Length: 0 <--- Transmitting SIP request (737 bytes) to TCP:27.61.183.38:9457 ---> NOTIFY sip:590@27.61.183.38:9457;transport=TCP;x-ast-orig-host=100.70.180.158:XXXX SIP/2.0 Via: SIP/2.0/TCP 97.79.59.226:XXXX;rport;branch=z9hG4bKPjcd8da9c9-cd9a-4bf4-8759-ffa307b5a14f;alias From: ;tag=195e2e37-537a-4502-bd54-c85e75d0ce1b To: Contact: Call-ID: 5e532b89-d519-419d-bb10-cdac12f26050 CSeq: 4732 NOTIFY Subscription-State: terminated Event: message-summary Allow-Events: message-summary, presence, dialog, refer Max-Forwards: 70 User-Agent: FPBX-15.0.16.75(16.10.0) Content-Type: application/simple-message-summary Content-Length: 48 Messages-Waiting: no Voice-Message: 0/0 (0/0) <--- Received SIP response (638 bytes) from TCP:27.61.183.38:9457 ---> SIP/2.0 200 OK Via: SIP/2.0/TCP 97.79.59.226:XXXX;rport=XXXX;branch=z9hG4bKPj84bcd70b-1f1b-4661-ad1b-da7bc0b4b499;received=71.212.129.101;alias Contact: To: ;tag=1f8da07b From: ;tag=1048adb6-bda7-4899-bcfa-4c409de0b3ed Call-ID: 4106b353-095d-4b32-8cf0-6e4c82cd8fcf CSeq: 62137 OPTIONS Accept: application/sdp, multipart/mixed, multipart/signed, multipart/alternative Accept-Language: en Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, NOTIFY, SUBSCRIBE, INFO, MESSAGE, PRACK Supported: timer Content-Length: 0 == Endpoint 590 is now Reachable -- Contact 590/sip:590@27.61.183.38:9457;transport=TCP;x-ast-orig-host=100.70.180.158:XXXX is now Reachable. RTT: 543.503 msec <--- Received SIP response (397 bytes) from TCP:27.61.183.38:9457 ---> SIP/2.0 405 Method Not Allowed Via: SIP/2.0/TCP 97.79.59.226:XXXX;rport=XXXX;branch=z9hG4bKPjcd8da9c9-cd9a-4bf4-8759-ffa307b5a14f;received=71.212.129.101;alias To: ;tag=116e473a From: ;tag=195e2e37-537a-4502-bd54-c85e75d0ce1b Call-ID: 5e532b89-d519-419d-bb10-cdac12f26050 CSeq: 4732 NOTIFY Content-Length: 0 [2021-07-05 14:42:19] ERROR[1641]: netsock2.c:303 ast_sockaddr_resolve: getaddrinfo("#$sncs54325432", "(null)", ...): Temporary failure in name resolution -- Called XXXXXXX@from-internal -- Executing [XXXXXXX@from-internal:1] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "1?ext-local,XXXXXXX,1:followme-check,XXXXXXX,1") in new stack -- Goto (ext-local,XXXXXXX,1) -- Executing [XXXXXXX@ext-local:1] Set("Local/XXXXXXX@from-internal-000004ca;2", "__RINGTIMER=15") in new stack -- Executing [XXXXXXX@ext-local:2] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(__CWIGNORE=)") in new stack -- Executing [XXXXXXX@ext-local:3] Macro("Local/XXXXXXX@from-internal-000004ca;2", "exten-vm,novm,XXXXXXX,0,0,0") in new stack -- Executing [s@macro-exten-vm:1] Macro("Local/XXXXXXX@from-internal-000004ca;2", "user-callerid,") in new stack -- Executing [s@macro-user-callerid:1] Set("Local/XXXXXXX@from-internal-000004ca;2", "TOUCH_MONITOR=1625496144.28878") in new stack -- Executing [s@macro-user-callerid:2] Set("Local/XXXXXXX@from-internal-000004ca;2", "AMPUSER=") in new stack -- Executing [s@macro-user-callerid:3] Set("Local/XXXXXXX@from-internal-000004ca;2", "HOTDESCKCHAN=XXXXXXX@from-internal-000004ca;2") in new stack -- Executing [s@macro-user-callerid:4] Set("Local/XXXXXXX@from-internal-000004ca;2", "HOTDESKEXTEN=XXXXXXX@from") in new stack -- Executing [s@macro-user-callerid:5] Set("Local/XXXXXXX@from-internal-000004ca;2", "HOTDESKCALL=0") in new stack -- Executing [s@macro-user-callerid:6] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(HOTDESKCALL=1)") in new stack -- Executing [s@macro-user-callerid:7] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(CALLERID(name)=)") in new stack -- Executing [s@macro-user-callerid:8] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?report") in new stack -- Executing [s@macro-user-callerid:9] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "1?Set(REALCALLERIDNUM=)") in new stack -- Executing [s@macro-user-callerid:10] Set("Local/XXXXXXX@from-internal-000004ca;2", "AMPUSER=") in new stack -- Executing [s@macro-user-callerid:11] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?limit") in new stack -- Executing [s@macro-user-callerid:12] Set("Local/XXXXXXX@from-internal-000004ca;2", "AMPUSERCIDNAME=") in new stack -- Executing [s@macro-user-callerid:13] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(__CIDMASQUERADING=TRUE)") in new stack -- Executing [s@macro-user-callerid:14] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "1?report") in new stack -- Goto (macro-user-callerid,s,22) -- Executing [s@macro-user-callerid:22] NoOp("Local/XXXXXXX@from-internal-000004ca;2", "Macro Depth is 2") in new stack -- Executing [s@macro-user-callerid:23] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "1?report2:macroerror") in new stack -- Goto (macro-user-callerid,s,24) -- Executing [s@macro-user-callerid:24] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?continue") in new stack -- Executing [s@macro-user-callerid:25] Set("Local/XXXXXXX@from-internal-000004ca;2", "__TTL=64") in new stack -- Executing [s@macro-user-callerid:26] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "1?continue") in new stack -- Goto (macro-user-callerid,s,42) -- Executing [s@macro-user-callerid:42] Set("Local/XXXXXXX@from-internal-000004ca;2", "CALLERID(number)=") in new stack -- Executing [s@macro-user-callerid:43] Set("Local/XXXXXXX@from-internal-000004ca;2", "CALLERID(name)=GD Entry") in new stack -- Executing [s@macro-user-callerid:44] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?cnum") in new stack -- Executing [s@macro-user-callerid:45] Set("Local/XXXXXXX@from-internal-000004ca;2", "CDR(cnam)=GD Entry") in new stack -- Executing [s@macro-user-callerid:46] Set("Local/XXXXXXX@from-internal-000004ca;2", "CDR(cnum)=") in new stack -- Executing [s@macro-user-callerid:47] Set("Local/XXXXXXX@from-internal-000004ca;2", "CHANNEL(language)=en") in new stack -- Executing [s@macro-exten-vm:2] Set("Local/XXXXXXX@from-internal-000004ca;2", "RingGroupMethod=none") in new stack -- Executing [s@macro-exten-vm:3] Set("Local/XXXXXXX@from-internal-000004ca;2", "__EXTTOCALL=XXXXXXX") in new stack -- Executing [s@macro-exten-vm:4] Set("Local/XXXXXXX@from-internal-000004ca;2", "__PICKUPMARK=XXXXXXX") in new stack -- Executing [s@macro-exten-vm:5] Set("Local/XXXXXXX@from-internal-000004ca;2", "RT=") in new stack -- Executing [s@macro-exten-vm:6] Gosub("Local/XXXXXXX@from-internal-000004ca;2", "sub-record-check,s,1(exten,XXXXXXX,dontcare)") in new stack -- Executing [s@sub-record-check:1] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?initialized") in new stack -- Executing [s@sub-record-check:2] Set("Local/XXXXXXX@from-internal-000004ca;2", "__REC_STATUS=INITIALIZED") in new stack -- Executing [s@sub-record-check:3] Set("Local/XXXXXXX@from-internal-000004ca;2", "NOW=1625496144") in new stack -- Executing [s@sub-record-check:4] Set("Local/XXXXXXX@from-internal-000004ca;2", "__DAY=05") in new stack -- Executing [s@sub-record-check:5] Set("Local/XXXXXXX@from-internal-000004ca;2", "__MONTH=07") in new stack -- Executing [s@sub-record-check:6] Set("Local/XXXXXXX@from-internal-000004ca;2", "__YEAR=2021") in new stack -- Executing [s@sub-record-check:7] Set("Local/XXXXXXX@from-internal-000004ca;2", "__TIMESTR=20210705-144224") in new stack -- Executing [s@sub-record-check:8] Set("Local/XXXXXXX@from-internal-000004ca;2", "__FROMEXTEN=unknown") in new stack -- Executing [s@sub-record-check:9] Set("Local/XXXXXXX@from-internal-000004ca;2", "__MON_FMT=wav") in new stack -- Executing [s@sub-record-check:10] NoOp("Local/XXXXXXX@from-internal-000004ca;2", "Recordings initialized") in new stack -- Executing [s@sub-record-check:11] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(ARG3=dontcare)") in new stack -- Executing [s@sub-record-check:12] Set("Local/XXXXXXX@from-internal-000004ca;2", "REC_POLICY_MODE_SAVE=") in new stack -- Executing [s@sub-record-check:13] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(REC_STATUS=NO)") in new stack -- Executing [s@sub-record-check:14] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "5?checkaction") in new stack -- Goto (sub-record-check,s,17) -- Executing [s@sub-record-check:17] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "1?sub-record-check,exten,1") in new stack -- Goto (sub-record-check,exten,1) -- Executing [exten@sub-record-check:1] NoOp("Local/XXXXXXX@from-internal-000004ca;2", "Exten Recording Check between unknown and XXXXXXX") in new stack -- Executing [exten@sub-record-check:2] Set("Local/XXXXXXX@from-internal-000004ca;2", "CALLTYPE=internal") in new stack -- Executing [exten@sub-record-check:3] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(CALLTYPE=)") in new stack -- Executing [exten@sub-record-check:4] Set("Local/XXXXXXX@from-internal-000004ca;2", "CALLEE=dontcare") in new stack -- Executing [exten@sub-record-check:5] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(CALLEE=dontcare)") in new stack -- Executing [exten@sub-record-check:6] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?callee") in new stack -- Executing [exten@sub-record-check:7] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "1?caller") in new stack -- Goto (sub-record-check,exten,13) -- Executing [exten@sub-record-check:13] Set("Local/XXXXXXX@from-internal-000004ca;2", "RECMODE=") in new stack -- Executing [exten@sub-record-check:14] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "1?Set(RECMODE=dontcare)") in new stack -- Executing [exten@sub-record-check:15] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "1?Set(RECMODE=dontcare)") in new stack -- Executing [exten@sub-record-check:16] Gosub("Local/XXXXXXX@from-internal-000004ca;2", "recordcheck,1(dontcare,internal,XXXXXXX)") in new stack -- Executing [recordcheck@sub-record-check:1] NoOp("Local/XXXXXXX@from-internal-000004ca;2", "Starting recording check against dontcare") in new stack -- Executing [recordcheck@sub-record-check:2] Goto("Local/XXXXXXX@from-internal-000004ca;2", "dontcare") in new stack -- Goto (sub-record-check,recordcheck,3) -- Executing [recordcheck@sub-record-check:3] Return("Local/XXXXXXX@from-internal-000004ca;2", "") in new stack -- Executing [exten@sub-record-check:17] Return("Local/XXXXXXX@from-internal-000004ca;2", "") in new stack -- Executing [s@macro-exten-vm:7] Macro("Local/XXXXXXX@from-internal-000004ca;2", "dial-one,,HhTtr,XXXXXXX") in new stack -- Executing [s@macro-dial-one:1] Set("Local/XXXXXXX@from-internal-000004ca;2", "DEXTEN=XXXXXXX") in new stack -- Executing [s@macro-dial-one:2] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(__EXTTOCALL=XXXXXXX)") in new stack -- Executing [s@macro-dial-one:3] Set("Local/XXXXXXX@from-internal-000004ca;2", "DIALSTATUS_CW=") in new stack -- Executing [s@macro-dial-one:4] GosubIf("Local/XXXXXXX@from-internal-000004ca;2", "0?screen,1()") in new stack -- Executing [s@macro-dial-one:5] GosubIf("Local/XXXXXXX@from-internal-000004ca;2", "0?cf,1()") in new stack -- Executing [s@macro-dial-one:6] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "1?skip1") in new stack -- Goto (macro-dial-one,s,9) -- Executing [s@macro-dial-one:9] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?nodial") in new stack -- Executing [s@macro-dial-one:10] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?continue") in new stack -- Executing [s@macro-dial-one:11] Set("Local/XXXXXXX@from-internal-000004ca;2", "EXTHASCW=ENABLED") in new stack -- Executing [s@macro-dial-one:12] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?next1:cwinusebusy") in new stack -- Goto (macro-dial-one,s,24) -- Executing [s@macro-dial-one:24] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?next3:continue") in new stack -- Goto (macro-dial-one,s,26) -- Executing [s@macro-dial-one:26] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?nodial") in new stack -- Executing [s@macro-dial-one:27] GosubIf("Local/XXXXXXX@from-internal-000004ca;2", "1?dstring,1():dlocal,1()") in new stack -- Executing [dstring@macro-dial-one:1] Set("Local/XXXXXXX@from-internal-000004ca;2", "DSTRING=") in new stack -- Executing [dstring@macro-dial-one:2] Set("Local/XXXXXXX@from-internal-000004ca;2", "DEVICES=XXXXXXX") in new stack -- Executing [dstring@macro-dial-one:3] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Return()") in new stack -- Executing [dstring@macro-dial-one:4] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(DEVICES=675310)") in new stack -- Executing [dstring@macro-dial-one:5] Set("Local/XXXXXXX@from-internal-000004ca;2", "LOOPCNT=1") in new stack -- Executing [dstring@macro-dial-one:6] Set("Local/XXXXXXX@from-internal-000004ca;2", "ITER=1") in new stack -- Executing [dstring@macro-dial-one:7] Set("Local/XXXXXXX@from-internal-000004ca;2", "THISDIAL=SIP/XXXXXXX") in new stack -- Executing [dstring@macro-dial-one:8] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "1?docheck") in new stack -- Goto (macro-dial-one,dstring,14) -- Executing [dstring@macro-dial-one:14] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?skipset") in new stack -- Executing [dstring@macro-dial-one:15] Set("Local/XXXXXXX@from-internal-000004ca;2", "DSTRING=SIP/XXXXXXX&") in new stack -- Executing [dstring@macro-dial-one:16] Set("Local/XXXXXXX@from-internal-000004ca;2", "ITER=2") in new stack -- Executing [dstring@macro-dial-one:17] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?begin") in new stack -- Executing [dstring@macro-dial-one:18] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Return()") in new stack -- Executing [dstring@macro-dial-one:19] Set("Local/XXXXXXX@from-internal-000004ca;2", "DSTRING=SIP/XXXXXXX") in new stack -- Executing [dstring@macro-dial-one:20] Return("Local/XXXXXXX@from-internal-000004ca;2", "") in new stack -- Executing [s@macro-dial-one:28] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?nodial") in new stack -- Executing [s@macro-dial-one:29] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?skiptrace") in new stack -- Executing [s@macro-dial-one:30] GosubIf("Local/XXXXXXX@from-internal-000004ca;2", "0?ctset,1():ctclear,1()") in new stack -- Executing [ctclear@macro-dial-one:1] NoOp("Local/XXXXXXX@from-internal-000004ca;2", "Deleting: CALLTRACE/XXXXXXX ") in new stack -- Executing [ctclear@macro-dial-one:2] Return("Local/XXXXXXX@from-internal-000004ca;2", "") in new stack -- Executing [s@macro-dial-one:31] Set("Local/XXXXXXX@from-internal-000004ca;2", "D_OPTIONS=HhTtr") in new stack -- Executing [s@macro-dial-one:32] GosubIf("Local/XXXXXXX@from-internal-000004ca;2", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack -- Executing [s@macro-dial-one:33] NoOp("Local/XXXXXXX@from-internal-000004ca;2", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack -- Executing [s@macro-dial-one:34] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(ALERT_INFO=)") in new stack -- Executing [s@macro-dial-one:35] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(ALERT_INFO=)") in new stack -- Executing [s@macro-dial-one:36] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(ALERT_INFO=)") in new stack -- Executing [s@macro-dial-one:37] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(ALERT_INFO=Normal;volume=)") in new stack -- Executing [s@macro-dial-one:38] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(ALERT_INFO=Normal;volume=)") in new stack -- Executing [s@macro-dial-one:39] GosubIf("Local/XXXXXXX@from-internal-000004ca;2", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack -- Executing [s@macro-dial-one:40] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(CHANNEL(musicclass)=)") in new stack -- Executing [s@macro-dial-one:41] GosubIf("Local/XXXXXXX@from-internal-000004ca;2", "0?qwait,1()") in new stack -- Executing [s@macro-dial-one:42] Set("Local/XXXXXXX@from-internal-000004ca;2", "__CWIGNORE=") in new stack -- Executing [s@macro-dial-one:43] Set("Local/XXXXXXX@from-internal-000004ca;2", "__KEEPCID=TRUE") in new stack -- Executing [s@macro-dial-one:44] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "0?usegoto,1") in new stack -- Executing [s@macro-dial-one:45] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "1?godial") in new stack -- Goto (macro-dial-one,s,50) -- Executing [s@macro-dial-one:50] Macro("Local/XXXXXXX@from-internal-000004ca;2", "dialout-one-predial-hook,") in new stack -- Executing [s@macro-dialout-one-predial-hook:1] MacroExit("Local/XXXXXXX@from-internal-000004ca;2", "") in new stack -- Executing [s@macro-dial-one:51] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(D_OPTIONS=HhtrI)") in new stack -- Executing [s@macro-dial-one:52] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack -- Executing [s@macro-dial-one:53] NoOp("Local/XXXXXXX@from-internal-000004ca;2", "") in new stack -- Executing [s@macro-dial-one:54] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(D_OPTIONS=HhTtrg)") in new stack -- Executing [s@macro-dial-one:55] Dial("Local/XXXXXXX@from-internal-000004ca;2", "SIP/XXXXXXX,,HhTtrb(func-apply-sipheaders^s^1)") in new stack == Using SIP VIDEO TOS bits 136 == Using SIP VIDEO CoS mark 6 == Using SIP RTP TOS bits 184 == Using SIP RTP CoS mark 5 -- SIP/XXXXXXX-00000466 Internal Gosub(func-apply-sipheaders,s,1) start -- Executing [s@func-apply-sipheaders:1] NoOp("SIP/XXXXXXX-00000466", "Applying SIP Headers to channel SIP/XXXXXXX-00000466") in new stack -- Executing [s@func-apply-sipheaders:2] Set("SIP/XXXXXXX-00000466", "TECH=SIP") in new stack -- Executing [s@func-apply-sipheaders:3] Set("SIP/XXXXXXX-00000466", "SIPHEADERKEYS=") in new stack -- Executing [s@func-apply-sipheaders:4] While("SIP/XXXXXXX-00000466", "0") in new stack -- Jumping to priority 12 -- Executing [s@func-apply-sipheaders:13] Return("SIP/XXXXXXX-00000466", "") in new stack == Spawn extension (from-internal, XXXXXXX, 1) exited non-zero on 'SIP/XXXXXXX-00000466' -- SIP/XXXXXXX-00000466 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL= -- Called SIP/XXXXXXX -- Local/XXXXXXX@from-internal-000004ca;1 is ringing -- SIP/XXXXXXX-00000466 is ringing -- Local/XXXXXXX@from-internal-000004ca;1 is ringing > 0xffff88068cf0 -- Strict RTP learning after remote address set to: 10.35.62.16:5004 -- SIP/XXXXXXX-00000466 answered Local/XXXXXXX@from-internal-000004ca;2 -- Local/XXXXXXX@from-internal-000004ca;1 answered -- Channel SIP/XXXXXXX-00000466 joined 'simple_bridge' basic-bridge <3f370e12-b775-4a65-848d-7b53c88e30ee> -- Channel Local/XXXXXXX@from-internal-000004ca;2 joined 'simple_bridge' basic-bridge <3f370e12-b775-4a65-848d-7b53c88e30ee> -- Executing [590@from-internal:1] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?ext-local,590,1:followme-check,590,1") in new stack -- Goto (followme-check,590,1) -- Executing [590@followme-check:1] Gosub("Local/XXXXXXX@from-internal-000004ca;1", "followme-sub,590,1()") in new stack -- Executing [590@followme-sub:1] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?skipclid") in new stack -- Executing [590@followme-sub:2] Macro("Local/XXXXXXX@from-internal-000004ca;1", "user-callerid,") in new stack -- Executing [s@macro-user-callerid:1] Set("Local/XXXXXXX@from-internal-000004ca;1", "TOUCH_MONITOR=1625496144.28877") in new stack -- Executing [s@macro-user-callerid:2] Set("Local/XXXXXXX@from-internal-000004ca;1", "AMPUSER=XXXXXXX") in new stack -- Executing [s@macro-user-callerid:3] Set("Local/XXXXXXX@from-internal-000004ca;1", "HOTDESCKCHAN=XXXXXXX@from-internal-000004ca;1") in new stack -- Executing [s@macro-user-callerid:4] Set("Local/XXXXXXX@from-internal-000004ca;1", "HOTDESKEXTEN=XXXXXXX@from") in new stack -- Executing [s@macro-user-callerid:5] Set("Local/XXXXXXX@from-internal-000004ca;1", "HOTDESKCALL=0") in new stack -- Executing [s@macro-user-callerid:6] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(HOTDESKCALL=1)") in new stack -- Executing [s@macro-user-callerid:7] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(CALLERID(name)=)") in new stack -- Executing [s@macro-user-callerid:8] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?report") in new stack -- Executing [s@macro-user-callerid:9] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "1?Set(REALCALLERIDNUM=XXXXXXX)") in new stack -- Executing [s@macro-user-callerid:10] Set("Local/XXXXXXX@from-internal-000004ca;1", "AMPUSER=XXXXXXX") in new stack -- Executing [s@macro-user-callerid:11] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?limit") in new stack -- Executing [s@macro-user-callerid:12] Set("Local/XXXXXXX@from-internal-000004ca;1", "AMPUSERCIDNAME=XXXXXXX") in new stack -- Executing [s@macro-user-callerid:13] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(__CIDMASQUERADING=TRUE)") in new stack -- Executing [s@macro-user-callerid:14] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?report") in new stack -- Executing [s@macro-user-callerid:15] Set("Local/XXXXXXX@from-internal-000004ca;1", "AMPUSERCID=XXXXXXX") in new stack -- Executing [s@macro-user-callerid:16] Set("Local/XXXXXXX@from-internal-000004ca;1", "__DIAL_OPTIONS=HhTtr") in new stack -- Executing [s@macro-user-callerid:17] Set("Local/XXXXXXX@from-internal-000004ca;1", "CALLERID(all)="XXXXXXX" ") in new stack -- Executing [s@macro-user-callerid:18] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(CUSDIAL=)") in new stack -- Executing [s@macro-user-callerid:19] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(CALLERID(all)="XXXXXXX" )") in new stack -- Executing [s@macro-user-callerid:20] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?limit") in new stack -- Executing [s@macro-user-callerid:21] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(GROUP(concurrency_limit)=XXXXXXX)") in new stack -- Executing [s@macro-user-callerid:22] NoOp("Local/XXXXXXX@from-internal-000004ca;1", "Macro Depth is 1") in new stack -- Executing [s@macro-user-callerid:23] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?report2:macroerror") in new stack -- Goto (macro-user-callerid,s,24) -- Executing [s@macro-user-callerid:24] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?continue") in new stack -- Executing [s@macro-user-callerid:25] Set("Local/XXXXXXX@from-internal-000004ca;1", "__TTL=64") in new stack -- Executing [s@macro-user-callerid:26] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?continue") in new stack -- Goto (macro-user-callerid,s,42) -- Executing [s@macro-user-callerid:42] Set("Local/XXXXXXX@from-internal-000004ca;1", "CALLERID(number)=XXXXXXX") in new stack -- Executing [s@macro-user-callerid:43] Set("Local/XXXXXXX@from-internal-000004ca;1", "CALLERID(name)=XXXXXXX") in new stack -- Executing [s@macro-user-callerid:44] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?cnum") in new stack -- Executing [s@macro-user-callerid:45] Set("Local/XXXXXXX@from-internal-000004ca;1", "CDR(cnam)=XXXXXXX") in new stack -- Executing [s@macro-user-callerid:46] Set("Local/XXXXXXX@from-internal-000004ca;1", "CDR(cnum)=XXXXXXX") in new stack -- Executing [s@macro-user-callerid:47] Set("Local/XXXXXXX@from-internal-000004ca;1", "CHANNEL(language)=en") in new stack -- Executing [590@followme-sub:3] Set("Local/XXXXXXX@from-internal-000004ca;1", "DIAL_OPTIONS=HhTtrI") in new stack -- Executing [590@followme-sub:4] Set("Local/XXXXXXX@from-internal-000004ca;1", "CONNECTEDLINE(num,i)=590") in new stack -- Executing [590@followme-sub:5] Gosub("Local/XXXXXXX@from-internal-000004ca;1", "sub-presencestate-display,s,1(590)") in new stack -- Executing [s@sub-presencestate-display:1] Goto("Local/XXXXXXX@from-internal-000004ca;1", "state-not_set,1") in new stack -- Goto (sub-presencestate-display,state-not_set,1) -- Executing [state-not_set@sub-presencestate-display:1] Set("Local/XXXXXXX@from-internal-000004ca;1", "PRESENCESTATE_DISPLAY=") in new stack -- Executing [state-not_set@sub-presencestate-display:2] Return("Local/XXXXXXX@from-internal-000004ca;1", "") in new stack -- Executing [590@followme-sub:6] Set("Local/XXXXXXX@from-internal-000004ca;1", "CONNECTEDLINE(name)=GD Test Anroiid") in new stack -- Executing [590@followme-sub:7] Set("Local/XXXXXXX@from-internal-000004ca;1", "FM_DIALSTATUS=NOT_INUSE") in new stack -- Executing [590@followme-sub:8] Set("Local/XXXXXXX@from-internal-000004ca;1", "__EXTTOCALL=590") in new stack -- Executing [590@followme-sub:9] Set("Local/XXXXXXX@from-internal-000004ca;1", "__PICKUPMARK=590") in new stack -- Executing [590@followme-sub:10] Macro("Local/XXXXXXX@from-internal-000004ca;1", "blkvm-setifempty,") in new stack -- Executing [s@macro-blkvm-setifempty:1] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?init") in new stack -- Goto (macro-blkvm-setifempty,s,4) -- Executing [s@macro-blkvm-setifempty:4] Set("Local/XXXXXXX@from-internal-000004ca;1", "__BLKVM_CHANNEL=Local/XXXXXXX@from-internal-000004ca;1") in new stack -- Executing [s@macro-blkvm-setifempty:5] Set("Local/XXXXXXX@from-internal-000004ca;1", "SHARED(BLKVM,Local/XXXXXXX@from-internal-000004ca;1)=TRUE") in new stack -- Executing [s@macro-blkvm-setifempty:6] Set("Local/XXXXXXX@from-internal-000004ca;1", "GOSUB_RETVAL=TRUE") in new stack -- Executing [s@macro-blkvm-setifempty:7] MacroExit("Local/XXXXXXX@from-internal-000004ca;1", "") in new stack -- Executing [590@followme-sub:11] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?skipov") in new stack -- Goto (followme-sub,590,14) -- Executing [590@followme-sub:14] Set("Local/XXXXXXX@from-internal-000004ca;1", "RRNODEST=") in new stack -- Executing [590@followme-sub:15] Set("Local/XXXXXXX@from-internal-000004ca;1", "__NODEST=590") in new stack -- Executing [590@followme-sub:16] GosubIf("Local/XXXXXXX@from-internal-000004ca;1", "0?sub-fmsetcid,s,1()") in new stack -- Executing [590@followme-sub:17] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?skipprepend") in new stack -- Goto (followme-sub,590,19) -- Executing [590@followme-sub:19] Set("Local/XXXXXXX@from-internal-000004ca;1", "RecordMethod=Group") in new stack -- Executing [590@followme-sub:20] Gosub("Local/XXXXXXX@from-internal-000004ca;1", "sub-record-check,s,1(exten,590,)") in new stack -- Executing [s@sub-record-check:1] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?initialized") in new stack -- Executing [s@sub-record-check:2] Set("Local/XXXXXXX@from-internal-000004ca;1", "__REC_STATUS=INITIALIZED") in new stack -- Executing [s@sub-record-check:3] Set("Local/XXXXXXX@from-internal-000004ca;1", "NOW=1625496144") in new stack -- Executing [s@sub-record-check:4] Set("Local/XXXXXXX@from-internal-000004ca;1", "__DAY=05") in new stack -- Executing [s@sub-record-check:5] Set("Local/XXXXXXX@from-internal-000004ca;1", "__MONTH=07") in new stack -- Executing [s@sub-record-check:6] Set("Local/XXXXXXX@from-internal-000004ca;1", "__YEAR=2021") in new stack -- Executing [s@sub-record-check:7] Set("Local/XXXXXXX@from-internal-000004ca;1", "__TIMESTR=20210705-144224") in new stack -- Executing [s@sub-record-check:8] Set("Local/XXXXXXX@from-internal-000004ca;1", "__FROMEXTEN=XXXXXXX") in new stack -- Executing [s@sub-record-check:9] Set("Local/XXXXXXX@from-internal-000004ca;1", "__MON_FMT=wav") in new stack -- Executing [s@sub-record-check:10] NoOp("Local/XXXXXXX@from-internal-000004ca;1", "Recordings initialized") in new stack -- Executing [s@sub-record-check:11] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "1?Set(ARG3=dontcare)") in new stack -- Executing [s@sub-record-check:12] Set("Local/XXXXXXX@from-internal-000004ca;1", "REC_POLICY_MODE_SAVE=") in new stack -- Executing [s@sub-record-check:13] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(REC_STATUS=NO)") in new stack -- Executing [s@sub-record-check:14] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "5?checkaction") in new stack -- Goto (sub-record-check,s,17) -- Executing [s@sub-record-check:17] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?sub-record-check,exten,1") in new stack -- Goto (sub-record-check,exten,1) -- Executing [exten@sub-record-check:1] NoOp("Local/XXXXXXX@from-internal-000004ca;1", "Exten Recording Check between XXXXXXX and 590") in new stack -- Executing [exten@sub-record-check:2] Set("Local/XXXXXXX@from-internal-000004ca;1", "CALLTYPE=internal") in new stack -- Executing [exten@sub-record-check:3] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(CALLTYPE=)") in new stack -- Executing [exten@sub-record-check:4] Set("Local/XXXXXXX@from-internal-000004ca;1", "CALLEE=dontcare") in new stack -- Executing [exten@sub-record-check:5] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(CALLEE=dontcare)") in new stack -- Executing [exten@sub-record-check:6] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?callee") in new stack -- Executing [exten@sub-record-check:7] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?caller") in new stack -- Goto (sub-record-check,exten,13) -- Executing [exten@sub-record-check:13] Set("Local/XXXXXXX@from-internal-000004ca;1", "RECMODE=dontcare") in new stack -- Executing [exten@sub-record-check:14] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(RECMODE=dontcare)") in new stack -- Executing [exten@sub-record-check:15] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "1?Set(RECMODE=dontcare)") in new stack -- Executing [exten@sub-record-check:16] Gosub("Local/XXXXXXX@from-internal-000004ca;1", "recordcheck,1(dontcare,internal,590)") in new stack -- Executing [recordcheck@sub-record-check:1] NoOp("Local/XXXXXXX@from-internal-000004ca;1", "Starting recording check against dontcare") in new stack -- Executing [recordcheck@sub-record-check:2] Goto("Local/XXXXXXX@from-internal-000004ca;1", "dontcare") in new stack -- Goto (sub-record-check,recordcheck,3) -- Executing [recordcheck@sub-record-check:3] Return("Local/XXXXXXX@from-internal-000004ca;1", "") in new stack -- Executing [exten@sub-record-check:17] Return("Local/XXXXXXX@from-internal-000004ca;1", "") in new stack -- Executing [590@followme-sub:21] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?skipdring") in new stack -- Executing [590@followme-sub:22] Set("Local/XXXXXXX@from-internal-000004ca;1", "DRING=Follow_Me") in new stack -- Executing [590@followme-sub:23] Set("Local/XXXXXXX@from-internal-000004ca;1", "__ALERT_INFO=Follow_Me") in new stack -- Executing [590@followme-sub:24] Set("Local/XXXXXXX@from-internal-000004ca;1", "STRATEGY=ringall") in new stack -- Executing [590@followme-sub:25] Set("Local/XXXXXXX@from-internal-000004ca;1", "__RVOL=") in new stack -- Executing [590@followme-sub:26] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?skipsimple") in new stack -- Executing [590@followme-sub:27] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1 ?skipsimple") in new stack -- Goto (followme-sub,590,29) -- Executing [590@followme-sub:29] Set("Local/XXXXXXX@from-internal-000004ca;1", "RingGroupMethod=ringall") in new stack -- Executing [590@followme-sub:30] Set("Local/XXXXXXX@from-internal-000004ca;1", "_FMGRP=590") in new stack -- Executing [590@followme-sub:31] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?DIALGRP") in new stack -- Goto (followme-sub,590,35) -- Executing [590@followme-sub:35] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "1?Set(DOPTS=HhTtrI):Set(DOPTS=m(Ring)HhTtI)") in new stack -- Executing [590@followme-sub:36] Set("Local/XXXXXXX@from-internal-000004ca;1", "__ALT_CONFIRM_MSG=") in new stack -- Executing [590@followme-sub:37] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?doconfirm") in new stack -- Goto (followme-sub,590,43) -- Executing [590@followme-sub:43] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?ringallv22") in new stack -- Executing [590@followme-sub:44] Macro("Local/XXXXXXX@from-internal-000004ca;1", "dial-confirm,60,HhTtrI,590,590") in new stack -- Executing [s@macro-dial-confirm:1] Set("Local/XXXXXXX@from-internal-000004ca;1", "DB(RG/590/Local/XXXXXXX@from-internal-000004ca;1)=RINGING") in new stack -- Executing [s@macro-dial-confirm:2] Set("Local/XXXXXXX@from-internal-000004ca;1", "__UNIQCHAN=Local/XXXXXXX@from-internal-000004ca;1") in new stack -- Executing [s@macro-dial-confirm:3] Set("Local/XXXXXXX@from-internal-000004ca;1", "USE_CONFIRMATION=TRUE") in new stack -- Executing [s@macro-dial-confirm:4] Set("Local/XXXXXXX@from-internal-000004ca;1", "RINGGROUP_INDEX=590") in new stack -- Executing [s@macro-dial-confirm:5] Set("Local/XXXXXXX@from-internal-000004ca;1", "FORCE_CONFIRM=") in new stack -- Executing [s@macro-dial-confirm:6] Set("Local/XXXXXXX@from-internal-000004ca;1", "ARG4=") in new stack -- Executing [s@macro-dial-confirm:7] Macro("Local/XXXXXXX@from-internal-000004ca;1", "dial,60,HhTtrI,590") in new stack -- Executing [s@macro-dial:1] NoOp("Local/XXXXXXX@from-internal-000004ca;1", "Blind Transfer: , Attended Transfer: , User: XXXXXXX, Alert Info: Follow_Me") in new stack -- Executing [s@macro-dial:2] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(ALERT_INFO=)") in new stack -- Executing [s@macro-dial:3] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(ALERT_INFO=)") in new stack -- Executing [s@macro-dial:4] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(ALERT_INFO=)") in new stack -- Executing [s@macro-dial:5] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(CHANNEL(musicclass)=)") in new stack -- Executing [s@macro-dial:6] AGI("Local/XXXXXXX@from-internal-000004ca;1", "agi://127.0.0.1/dialparties.agi") in new stack AGI Tx >> agi_network: yes AGI Tx >> agi_network_script: dialparties.agi AGI Tx >> agi_request: agi://127.0.0.1/dialparties.agi AGI Tx >> agi_channel: Local/XXXXXXX@from-internal-000004ca;1 AGI Tx >> agi_language: en AGI Tx >> agi_type: Local AGI Tx >> agi_uniqueid: 1625496144.28877 AGI Tx >> agi_version: 16.10.0 AGI Tx >> agi_callerid: XXXXXXX AGI Tx >> agi_calleridname: XXXXXXX AGI Tx >> agi_callingpres: 0 AGI Tx >> agi_callingani2: 0 AGI Tx >> agi_callington: 0 AGI Tx >> agi_callingtns: 0 AGI Tx >> agi_dnid: unknown AGI Tx >> agi_rdnis: unknown AGI Tx >> agi_context: macro-dial AGI Tx >> agi_extension: s AGI Tx >> agi_priority: 6 AGI Tx >> agi_enhanced: 0.0 AGI Tx >> agi_accountcode: AGI Tx >> agi_threadid: 281470883066240 AGI Tx >> > 0xffff88068cf0 -- Strict RTP switching to RTP target address 10.35.62.16:5004 as source AGI Rx << VERBOSE "Starting New Dialparties.agi" 1 agi://127.0.0.1/dialparties.agi: Starting New Dialparties.agi AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE CWINUSEBUSY AGI Tx >> 200 result=1 (1) AGI Rx << GET VARIABLE CWIGNORE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE CFIGNORE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE SIGNORE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE AMPUSER AGI Tx >> 200 result=1 (XXXXXXX) AGI Rx << VERBOSE "Caller ID name is 'XXXXXXX' number is 'XXXXXXX'" 1 agi://127.0.0.1/dialparties.agi: Caller ID name is 'XXXXXXX' number is 'XXXXXXX' AGI Tx >> 200 result=1 AGI Rx << VERBOSE "CW Ignore is: " 1 agi://127.0.0.1/dialparties.agi: CW Ignore is: AGI Tx >> 200 result=1 AGI Rx << VERBOSE "CF Ignore is: " 1 agi://127.0.0.1/dialparties.agi: CF Ignore is: AGI Tx >> 200 result=1 AGI Rx << VERBOSE "CW IN_USE/BUSY is: 1" 1 agi://127.0.0.1/dialparties.agi: CW IN_USE/BUSY is: 1 AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE QUEUEWAIT AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE __KEEPCID "TRUE" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE DIALSTATUS_CW "" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ARG1 AGI Tx >> 200 result=1 (60) AGI Rx << GET VARIABLE ARG2 AGI Tx >> 200 result=1 (HhTtrI) AGI Rx << GET VARIABLE RingGroupMethod AGI Tx >> 200 result=1 (ringall) AGI Rx << GET VARIABLE RVOL AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE ALERT_INFO AGI Tx >> 200 result=1 (Follow_Me) AGI Rx << GET VARIABLE SIPADDHEADER AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Setting sipheader Alert-Info: Follow_Me" 4 > agi://127.0.0.1/dialparties.agi: Setting sipheader Alert-Info: Follow_Me AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE HASH(__SIPHEADERS,Alert-Info) "Follow_Me" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE FMGRP AGI Tx >> 200 result=1 (590) AGI Rx << GET VARIABLE PR_DIALSTATUS AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE NODEST AGI Tx >> 200 result=1 (590) AGI Rx << GET VARIABLE RINGGROUP_INDEX AGI Tx >> 200 result=1 (590) AGI Rx << GET VARIABLE USE_CONFIRMATION AGI Tx >> 200 result=1 (TRUE) AGI Rx << VERBOSE "USE_CONFIRMATION: 'TRUE'" 5 > agi://127.0.0.1/dialparties.agi: USE_CONFIRMATION: 'TRUE' AGI Tx >> 200 result=1 AGI Rx << VERBOSE "RINGGROUP_INDEX: '590'" 5 > agi://127.0.0.1/dialparties.agi: RINGGROUP_INDEX: '590' AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Methodology of ring is 'ringall'" 1 agi://127.0.0.1/dialparties.agi: Methodology of ring is 'ringall' AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ARG3 AGI Tx >> 200 result=1 (590) AGI Rx << VERBOSE "Added extension 590 to extension map" 3 -- agi://127.0.0.1/dialparties.agi: Added extension 590 to extension map AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE ARG4 AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE SCREEN AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE FROM_DID AGI Tx >> 200 result=0 AGI Rx << DATABASE GET "CF" "590" AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Extension 590 cf is disabled" 3 -- agi://127.0.0.1/dialparties.agi: Extension 590 cf is disabled AGI Tx >> 200 result=1 AGI Rx << DATABASE GET "DND" "590" AGI Tx >> 200 result=0 AGI Rx << VERBOSE "Extension 590 do not disturb is disabled" 3 -- agi://127.0.0.1/dialparties.agi: Extension 590 do not disturb is disabled AGI Tx >> 200 result=1 AGI Rx << DATABASE GET "CW" "590" AGI Tx >> 200 result=1 (ENABLED) AGI Rx << DATABASE GET "CFB" "590" AGI Tx >> 200 result=0 AGI Rx << DATABASE GET "CFU" "590" AGI Tx >> 200 result=0 AGI Rx << VERBOSE "extnum 590 has: cw: 1; hascfb: 0 [] hascfu: 0 []" 4 > agi://127.0.0.1/dialparties.agi: extnum 590 has: cw: 1; hascfb: 0 [] hascfu: 0 [] AGI Tx >> 200 result=1 AGI Rx << DATABASE GET "AMPUSER" "590/device" AGI Tx >> 200 result=1 (590) AGI Rx << DATABASE PUT "CALLTRACE" "590" "XXXXXXX" AGI Tx >> 200 result=1 AGI Rx << VERBOSE "dbset CALLTRACE/590 to XXXXXXX" 3 -- agi://127.0.0.1/dialparties.agi: dbset CALLTRACE/590 to XXXXXXX AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE FILTERED_DIAL "590" AGI Tx >> 200 result=1 AGI Rx << VERBOSE "Filtered ARG3: 590" 3 -- agi://127.0.0.1/dialparties.agi: Filtered ARG3: 590 AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE DIRECTION AGI Tx >> 200 result=0 AGI Rx << SET VARIABLE __RT "60" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __RG_IDX "590" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE __CALLCONFIRMCID "XXXXXXX" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE ds "Local/LC-590@from-internal,60,HhTtrI" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE MACRODIALGOTO_PRI "normdial" AGI Tx >> 200 result=1 AGI Rx << GET VARIABLE RVOL_MODE AGI Tx >> 200 result=0 AGI Rx << GET VARIABLE RVOL AGI Tx >> 200 result=1 () AGI Rx << GET VARIABLE RVOLPARENT AGI Tx >> 200 result=0 AGI Rx << VERBOSE "RVOL_MODE '' " 1 agi://127.0.0.1/dialparties.agi: RVOL_MODE '' AGI Tx >> 200 result=1 AGI Rx << VERBOSE "RVOL is: " 1 agi://127.0.0.1/dialparties.agi: RVOL is: AGI Tx >> 200 result=1 AGI Rx << VERBOSE "RVOLPARENT is: " 1 agi://127.0.0.1/dialparties.agi: RVOLPARENT is: AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE TIMEOUT "60" AGI Tx >> 200 result=1 AGI Rx << SET VARIABLE DIALOPTS "HhTtrI" AGI Tx >> 200 result=1 -- AGI Script agi://127.0.0.1/dialparties.agi completed, returning 0 AGI Tx >> HANGUP -- Executing [s@macro-dial:7] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?normdial") in new stack -- Goto (macro-dial,s,10) -- Executing [s@macro-dial:10] NoOp("Local/XXXXXXX@from-internal-000004ca;1", "Returned from dialparties with groups to dial") in new stack -- Executing [s@macro-dial:11] NoOp("Local/XXXXXXX@from-internal-000004ca;1", "ringall array ") in new stack -- Executing [s@macro-dial:12] Set("Local/XXXXXXX@from-internal-000004ca;1", "__FMGL_DIAL=") in new stack -- Executing [s@macro-dial:13] Set("Local/XXXXXXX@from-internal-000004ca;1", "LOOPCNT=1") in new stack -- Executing [s@macro-dial:14] Set("Local/XXXXXXX@from-internal-000004ca;1", "ITER=1") in new stack -- Executing [s@macro-dial:15] Set("Local/XXXXXXX@from-internal-000004ca;1", "__EXTTOCALL=590") in new stack -- Executing [s@macro-dial:16] NoOp("Local/XXXXXXX@from-internal-000004ca;1", "Working with 590") in new stack -- Executing [s@macro-dial:17] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Follow_Me;volume=)") in new stack -- Executing [s@macro-dial:18] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Follow_Me;volume=)") in new stack -- Executing [s@macro-dial:19] Set("Local/XXXXXXX@from-internal-000004ca;1", "ITER=2") in new stack -- Executing [s@macro-dial:20] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?ndloopbegin") in new stack -- Executing [s@macro-dial:21] Macro("Local/XXXXXXX@from-internal-000004ca;1", "dial-ringall-predial-hook,") in new stack -- Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("Local/XXXXXXX@from-internal-000004ca;1", "") in new stack -- Executing [s@macro-dial:22] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack -- Executing [s@macro-dial:23] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(ds=Local/LC-590@from-internal,60,HhTtrIg)") in new stack -- Executing [s@macro-dial:24] Dial("Local/XXXXXXX@from-internal-000004ca;1", "Local/LC-590@from-internal,60,HhTtrIb(func-apply-sipheaders^s^1),") in new stack -- Local/LC-590@from-internal-000004cb;1 Internal Gosub(func-apply-sipheaders,s,1) start -- Executing [s@func-apply-sipheaders:1] NoOp("Local/LC-590@from-internal-000004cb;1", "Applying SIP Headers to channel Local/LC-590@from-internal-000004cb;1") in new stack -- Executing [s@func-apply-sipheaders:2] Set("Local/LC-590@from-internal-000004cb;1", "TECH=Local") in new stack -- Executing [s@func-apply-sipheaders:3] Set("Local/LC-590@from-internal-000004cb;1", "SIPHEADERKEYS=Alert-Info") in new stack -- Executing [s@func-apply-sipheaders:4] While("Local/LC-590@from-internal-000004cb;1", "1") in new stack -- Executing [s@func-apply-sipheaders:5] Set("Local/LC-590@from-internal-000004cb;1", "sipheader=Follow_Me") in new stack -- Executing [s@func-apply-sipheaders:6] ExecIf("Local/LC-590@from-internal-000004cb;1", "0?SIPRemoveHeader(Alert-Info:)") in new stack -- Executing [s@func-apply-sipheaders:7] ExecIf("Local/LC-590@from-internal-000004cb;1", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack -- Executing [s@func-apply-sipheaders:8] ExecIf("Local/LC-590@from-internal-000004cb;1", "1?Set(sipheader=;info=Follow_Me)") in new stack -- Executing [s@func-apply-sipheaders:9] ExecIf("Local/LC-590@from-internal-000004cb;1", "0?Set(sipheader=;info=Follow_Me)") in new stack -- Executing [s@func-apply-sipheaders:10] ExecIf("Local/LC-590@from-internal-000004cb;1", "0?SIPAddHeader(Alert-Info:;info=Follow_Me)") in new stack -- Executing [s@func-apply-sipheaders:11] ExecIf("Local/LC-590@from-internal-000004cb;1", "0?Set(PJSIP_HEADER(add,Alert-Info)=;info=Follow_Me)") in new stack -- Executing [s@func-apply-sipheaders:12] EndWhile("Local/LC-590@from-internal-000004cb;1", "") in new stack -- Executing [s@func-apply-sipheaders:4] While("Local/LC-590@from-internal-000004cb;1", "0") in new stack -- Executing [s@func-apply-sipheaders:13] Return("Local/LC-590@from-internal-000004cb;1", "") in new stack == Spawn extension (from-internal, 590, 1) exited non-zero on 'Local/LC-590@from-internal-000004cb;1' -- Local/LC-590@from-internal-000004cb;1 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL= -- Called Local/LC-590@from-internal -- Executing [LC-590@from-internal:1] ExecIf("Local/LC-590@from-internal-000004cb;2", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack -- Executing [LC-590@from-internal:2] Set("Local/LC-590@from-internal-000004cb;2", "THISDIAL=PJSIP/590") in new stack -- Executing [LC-590@from-internal:3] GotoIf("Local/LC-590@from-internal-000004cb;2", "0?dial") in new stack -- Executing [LC-590@from-internal:4] NoOp("Local/LC-590@from-internal-000004cb;2", "Debug: Found PJSIP Destination PJSIP/590, updating with PJSIP_DIAL_CONTACTS") in new stack -- Executing [LC-590@from-internal:5] Set("Local/LC-590@from-internal-000004cb;2", "THISDIAL=PJSIP/590/sip:590@27.61.183.38:9457;transport=TCP;x-ast-orig-host=100.70.180.158:XXXX") in new stack -- Executing [LC-590@from-internal:6] Dial("Local/LC-590@from-internal-000004cb;2", "PJSIP/590/sip:590@27.61.183.38:9457;transport=TCP;x-ast-orig-host=100.70.180.158:XXXX,60,HhTtrM(auto-confirm^590)b(func-apply-sipheaders^s^1)") in new stack -- PJSIP/590-00000066 Internal Gosub(func-apply-sipheaders,s,1) start -- Executing [s@func-apply-sipheaders:1] NoOp("PJSIP/590-00000066", "Applying SIP Headers to channel PJSIP/590-00000066") in new stack -- Executing [s@func-apply-sipheaders:2] Set("PJSIP/590-00000066", "TECH=PJSIP") in new stack -- Executing [s@func-apply-sipheaders:3] Set("PJSIP/590-00000066", "SIPHEADERKEYS=Alert-Info") in new stack -- Executing [s@func-apply-sipheaders:4] While("PJSIP/590-00000066", "1") in new stack -- Executing [s@func-apply-sipheaders:5] Set("PJSIP/590-00000066", "sipheader=Follow_Me") in new stack -- Executing [s@func-apply-sipheaders:6] ExecIf("PJSIP/590-00000066", "0?SIPRemoveHeader(Alert-Info:)") in new stack -- Executing [s@func-apply-sipheaders:7] ExecIf("PJSIP/590-00000066", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack -- Executing [s@func-apply-sipheaders:8] ExecIf("PJSIP/590-00000066", "1?Set(sipheader=;info=Follow_Me)") in new stack -- Executing [s@func-apply-sipheaders:9] ExecIf("PJSIP/590-00000066", "0?Set(sipheader=;info=Follow_Me)") in new stack -- Executing [s@func-apply-sipheaders:10] ExecIf("PJSIP/590-00000066", "0?SIPAddHeader(Alert-Info:;info=Follow_Me)") in new stack -- Executing [s@func-apply-sipheaders:11] ExecIf("PJSIP/590-00000066", "1?Set(PJSIP_HEADER(add,Alert-Info)=;info=Follow_Me)") in new stack -- Executing [s@func-apply-sipheaders:12] EndWhile("PJSIP/590-00000066", "") in new stack -- Executing [s@func-apply-sipheaders:4] While("PJSIP/590-00000066", "0") in new stack -- Executing [s@func-apply-sipheaders:13] Return("PJSIP/590-00000066", "") in new stack == Spawn extension (internal, LC-590, 1) exited non-zero on 'PJSIP/590-00000066' -- PJSIP/590-00000066 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL= -- Called PJSIP/590/sip:590@27.61.183.38:9457;transport=TCP;x-ast-orig-host=100.70.180.158:XXXX -- Local/LC-590@from-internal-000004cb;1 is ringing -- Connected line update to Local/XXXXXXX@from-internal-000004ca;1 prevented. == Using SIP RTP Audio TOS bits 184 == Using SIP RTP Audio TOS bits 184 in TCLASS field. == Using SIP RTP Audio CoS mark 5 <--- Transmitting SIP request (1923 bytes) to TCP:27.61.183.38:9457 ---> INVITE sip:590@27.61.183.38:9457;transport=TCP;x-ast-orig-host=100.70.180.158:XXXX SIP/2.0 Via: SIP/2.0/TCP 97.79.59.226:XXXX;rport;branch=z9hG4bKPjf17076b2-9936-43bd-87a3-74e69f4c82a6;alias From: "XXXXXXX" ;tag=14110580-18bf-433a-8227-30915711bf69 To: Contact: Call-ID: 8c2dafd3-61c7-4517-a828-4838c97696ce CSeq: 13820 INVITE Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, REFER, MESSAGE Supported: 100rel, timer, replaces, norefersub Session-Expires: 1800 Min-SE: 90 P-Asserted-Identity: "XXXXXXX" Alert-Info: ;info=Follow_Me Max-Forwards: 70 User-Agent: FPBX-15.0.16.75(16.10.0) Content-Type: application/sdp Content-Length: 1046 v=0 o=- 382563404 382563404 IN IP4 97.79.59.226 s=Asterisk c=IN IP4 97.79.59.226 t=0 0 a=msid-semantic:WMS * a=group:BUNDLE audio-0 m=audio 14140 UDP/TLS/RTP/SAVPF 0 101 a=connection:new a=setup:actpass a=fingerprint:SHA-256 9E:D0:C2:22:73:EB:F8:08:8A:21:3F:1F:9B:B9:55:91:10:2C:2D:5E:37:29:74:1D:31:91:2A:4D:D7:1F:84:2B a=ice-ufrag:7f03fbb936cbe9a95fc13af1601f5fca a=ice-pwd:0539eecd2144e23a2bc1b4e1243c47c7 a=candidate:Ha233e96 1 UDP 2130706431 10.35.62.150 14140 typ host a=candidate:H2b007c07 1 UDP 2130706431 fec0::ba27:ebff:fe25:7447 14140 typ host a=candidate:H59250bc7 1 UDP 2130706431 fe80::ba27:ebff:fe25:7447 14140 typ host a=candidate:S0 1 UDP 1694498815 0.0.0.0 0 typ srflx raddr 10.35.62.150 rport 14140 a=rtpmap:0 PCMU/XXXX a=rtpmap:101 telephone-event/XXXX a=fmtp:101 0-16 a=ptime:20 a=maxptime:150 a=sendrecv a=rtcp-mux a=ssrc:1284516925 cname:1ac79ad9-5831-46ee-8298-8d30b4b3f35a a=msid:98b3662c-dd4a-4a97-9058-78fb2a827bd0 c3f8b63d-de5d-484d-95b5-1be9b4b8ad30 a=rtcp-fb:* transport-cc a=mid:audio-0 <--- Received SIP response (387 bytes) from TCP:27.61.183.38:9457 ---> SIP/2.0 100 Trying Via: SIP/2.0/TCP 97.79.59.226:XXXX;rport=XXXX;branch=z9hG4bKPjf17076b2-9936-43bd-87a3-74e69f4c82a6;received=71.212.129.101;alias To: From: "XXXXXXX" ;tag=14110580-18bf-433a-8227-30915711bf69 Call-ID: 8c2dafd3-61c7-4517-a828-4838c97696ce CSeq: 13820 INVITE Content-Length: 0 > 0xffff88068cf0 -- Strict RTP learning complete - Locking on source address 10.35.62.16:5004 [2021-07-05 14:42:39] ERROR[1641]: netsock2.c:303 ast_sockaddr_resolve: getaddrinfo("#$sncs54325432", "(null)", ...): Temporary failure in name resolution <--- Received SIP response (417 bytes) from TCP:27.61.183.38:9457 ---> SIP/2.0 480 Temporarily Unavailable Via: SIP/2.0/TCP 97.79.59.226:XXXX;rport=XXXX;branch=z9hG4bKPjf17076b2-9936-43bd-87a3-74e69f4c82a6;received=71.212.129.101;alias To: ;tag=0ac81567 From: "XXXXXXX" ;tag=14110580-18bf-433a-8227-30915711bf69 Call-ID: 8c2dafd3-61c7-4517-a828-4838c97696ce CSeq: 13820 INVITE Content-Length: 0 <--- Transmitting SIP request (494 bytes) to TCP:27.61.183.38:9457 ---> ACK sip:590@27.61.183.38:9457;transport=TCP;x-ast-orig-host=100.70.180.158:XXXX SIP/2.0 Via: SIP/2.0/TCP 97.79.59.226:XXXX;rport;branch=z9hG4bKPjf17076b2-9936-43bd-87a3-74e69f4c82a6;alias From: "XXXXXXX" ;tag=14110580-18bf-433a-8227-30915711bf69 To: ;tag=0ac81567 Call-ID: 8c2dafd3-61c7-4517-a828-4838c97696ce CSeq: 13820 ACK Max-Forwards: 70 User-Agent: FPBX-15.0.16.75(16.10.0) Content-Length: 0 -- No one is available to answer at this time (1:0/0/0) -- Auto fallthrough, channel 'Local/LC-590@from-internal-000004cb;2' status is 'NOANSWER' -- Executing [h@from-internal:1] Macro("Local/LC-590@from-internal-000004cb;2", "hangupcall") in new stack -- Executing [s@macro-hangupcall:1] GotoIf("Local/LC-590@from-internal-000004cb;2", "1?theend") in new stack -- Goto (macro-hangupcall,s,3) -- Executing [s@macro-hangupcall:3] ExecIf("Local/LC-590@from-internal-000004cb;2", "0?Set(CDR(recordingfile)=)") in new stack -- Executing [s@macro-hangupcall:4] NoOp("Local/LC-590@from-internal-000004cb;2", "PJSIP/590-00000066 montior file= ") in new stack -- Executing [s@macro-hangupcall:5] GotoIf("Local/LC-590@from-internal-000004cb;2", "1?skipagi") in new stack -- Goto (macro-hangupcall,s,7) -- Executing [s@macro-hangupcall:7] Hangup("Local/LC-590@from-internal-000004cb;2", "") in new stack == Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/LC-590@from-internal-000004cb;2' in macro 'hangupcall' == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/LC-590@from-internal-000004cb;2' -- No one is available to answer at this time (1:0/0/0) -- Executing [s@macro-dial:25] Set("Local/XXXXXXX@from-internal-000004ca;1", "DIALSTATUS=NOANSWER") in new stack -- Executing [s@macro-dial:26] GosubIf("Local/XXXXXXX@from-internal-000004ca;1", "0?NOANSWER,1()") in new stack -- Executing [s@macro-dial:27] NoOp("Local/XXXXXXX@from-internal-000004ca;1", "Returning since nobody answered") in new stack -- Executing [s@macro-dial:28] MacroExit("Local/XXXXXXX@from-internal-000004ca;1", "") in new stack -- Executing [s@macro-dial-confirm:8] NoOp("Local/XXXXXXX@from-internal-000004ca;1", "Deleting: RG/590/Local/XXXXXXX@from-internal-000004ca;1 RINGING") in new stack -- Executing [s@macro-dial-confirm:9] Set("Local/XXXXXXX@from-internal-000004ca;1", "USE_CONFIRMATION=") in new stack -- Executing [s@macro-dial-confirm:10] Set("Local/XXXXXXX@from-internal-000004ca;1", "RINGGROUP_INDEX=") in new stack -- Executing [590@followme-sub:45] Goto("Local/XXXXXXX@from-internal-000004ca;1", "nextstep") in new stack -- Goto (followme-sub,590,47) -- Executing [590@followme-sub:47] Set("Local/XXXXXXX@from-internal-000004ca;1", "RingGroupMethod=") in new stack -- Executing [590@followme-sub:48] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?nodest") in new stack -- Executing [590@followme-sub:49] Set("Local/XXXXXXX@from-internal-000004ca;1", "__NODEST=") in new stack -- Executing [590@followme-sub:50] Set("Local/XXXXXXX@from-internal-000004ca;1", "__PICKUPMARK=") in new stack -- Executing [590@followme-sub:51] Macro("Local/XXXXXXX@from-internal-000004ca;1", "blkvm-clr,") in new stack -- Executing [s@macro-blkvm-clr:1] Set("Local/XXXXXXX@from-internal-000004ca;1", "SHARED(BLKVM,Local/XXXXXXX@from-internal-000004ca;1)=") in new stack -- Executing [s@macro-blkvm-clr:2] Set("Local/XXXXXXX@from-internal-000004ca;1", "GOSUB_RETVAL=") in new stack -- Executing [s@macro-blkvm-clr:3] MacroExit("Local/XXXXXXX@from-internal-000004ca;1", "") in new stack -- Executing [590@followme-sub:52] Set("Local/XXXXXXX@from-internal-000004ca;1", "DIALSTATUS=NOANSWER") in new stack [2021-07-05 14:42:46] ERROR[1574]: cdr_odbc.c:174 odbc_log: Unable to retrieve database handle. CDR failed. -- Executing [590@followme-sub:53] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?dohangup") in new stack -- Executing [590@followme-sub:54] Goto("Local/XXXXXXX@from-internal-000004ca;1", "ext-local,590,dest") in new stack -- Goto (ext-local,590,4) -- Executing [590@ext-local:4] Set("Local/XXXXXXX@from-internal-000004ca;1", "__PICKUPMARK=") in new stack -- Executing [590@ext-local:5] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "0?,return,1") in new stack -- Auto fallthrough, channel 'Local/XXXXXXX@from-internal-000004ca;1' status is 'NOANSWER' -- Executing [h@ext-local:1] Macro("Local/XXXXXXX@from-internal-000004ca;1", "hangupcall,") in new stack -- Executing [s@macro-hangupcall:1] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?theend") in new stack -- Goto (macro-hangupcall,s,3) -- Executing [s@macro-hangupcall:3] ExecIf("Local/XXXXXXX@from-internal-000004ca;1", "0?Set(CDR(recordingfile)=)") in new stack -- Executing [s@macro-hangupcall:4] NoOp("Local/XXXXXXX@from-internal-000004ca;1", " montior file= ") in new stack -- Executing [s@macro-hangupcall:5] GotoIf("Local/XXXXXXX@from-internal-000004ca;1", "1?skipagi") in new stack -- Goto (macro-hangupcall,s,7) -- Executing [s@macro-hangupcall:7] Hangup("Local/XXXXXXX@from-internal-000004ca;1", "") in new stack == Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/XXXXXXX@from-internal-000004ca;1' in macro 'hangupcall' == Spawn extension (ext-local, h, 1) exited non-zero on 'Local/XXXXXXX@from-internal-000004ca;1' -- Channel Local/XXXXXXX@from-internal-000004ca;2 left 'simple_bridge' basic-bridge <3f370e12-b775-4a65-848d-7b53c88e30ee> -- Channel SIP/XXXXXXX-00000466 left 'simple_bridge' basic-bridge <3f370e12-b775-4a65-848d-7b53c88e30ee> == Spawn extension (macro-dial-one, s, 55) exited non-zero on 'Local/XXXXXXX@from-internal-000004ca;2' in macro 'dial-one' == Spawn extension (macro-exten-vm, s, 7) exited non-zero on 'Local/XXXXXXX@from-internal-000004ca;2' in macro 'exten-vm' == Spawn extension (ext-local, XXXXXXX, 3) exited non-zero on 'Local/XXXXXXX@from-internal-000004ca;2' -- Executing [h@ext-local:1] Macro("Local/XXXXXXX@from-internal-000004ca;2", "hangupcall,") in new stack -- Executing [s@macro-hangupcall:1] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "1?theend") in new stack -- Goto (macro-hangupcall,s,3) [2021-07-05 14:42:46] ERROR[1574]: cdr_odbc.c:174 odbc_log: Unable to retrieve database handle. CDR failed. [2021-07-05 14:42:46] ERROR[1574]: cdr_odbc.c:174 odbc_log: Unable to retrieve database handle. CDR failed. -- Executing [s@macro-hangupcall:3] ExecIf("Local/XXXXXXX@from-internal-000004ca;2", "0?Set(CDR(recordingfile)=)") in new stack -- Executing [s@macro-hangupcall:4] NoOp("Local/XXXXXXX@from-internal-000004ca;2", "SIP/XXXXXXX-00000466 montior file= ") in new stack -- Executing [s@macro-hangupcall:5] GotoIf("Local/XXXXXXX@from-internal-000004ca;2", "1?skipagi") in new stack -- Goto (macro-hangupcall,s,7) -- Executing [s@macro-hangupcall:7] Hangup("Local/XXXXXXX@from-internal-000004ca;2", "") in new stack == Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'Local/XXXXXXX@from-internal-000004ca;2' in macro 'hangupcall' == Spawn extension (ext-local, h, 1) exited non-zero on 'Local/XXXXXXX@from-internal-000004ca;2' [2021-07-05 14:42:46] ERROR[1574]: cdr_odbc.c:174 odbc_log: Unable to retrieve database handle. CDR failed. [2021-07-05 14:42:59] ERROR[1641]: netsock2.c:303 ast_sockaddr_resolve: getaddrinfo("#$sncs54325432", "(null)", ...): Temporary failure in name resolution