voip log

🧩 Syntax:
[2024-02-14 07:22:12] VERBOSE[330] res_pjsip_logger.c: <--- Received SIP request (888 bytes) from UDP:10.0.100.75:5060 --->
INVITE sip:202@voip.mydomain.com:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.100.75:5060;branch=z9hG4bK3596301497
From: "Jay-202" <sip:202@voip.mydomain.com:5060>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com:5060>
Call-ID: 18403fee2e3af96@10.0.100.75
CSeq: 20 INVITE
Contact: <sip:202@10.0.100.75:5060;transport=UDP>
Max-Forwards: 70
User-Agent: Sangoma S705 V3.0.4.88
Supported: replaces
Subject: SIP Call
Expires: 120
Allow: INVITE, ACK, UPDATE, INFO, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY, MESSAGE, PRACK
Content-Type: application/sdp
Content-Length: 307

v=0
o=- 6666 377 IN IP4 10.0.100.75
s=SIP Call
c=IN IP4 10.0.100.75
t=0 0
m=audio 12138 RTP/AVP 0 8 3 2 9 101
a=sendrecv
a=rtpmap:0 PCMU/8000
a=ptime:20
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-11,16

[2024-02-14 07:22:12] VERBOSE[23380] res_pjsip_logger.c: <--- Transmitting SIP response (496 bytes) to UDP:10.0.100.75:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.0.100.75:5060;rport=5060;received=10.0.100.75;branch=z9hG4bK3596301497
Call-ID: 18403fee2e3af96@10.0.100.75
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com>;tag=z9hG4bK3596301497
CSeq: 20 INVITE
WWW-Authenticate: Digest realm="asterisk",nonce="1707916932/527efcb4d132327f15465f99d9d5c5c5",opaque="3b12f79431ea365e",algorithm=MD5,qop="auth"
Server: PBXact-15.0.37.4(16.30.0)
Content-Length:  0


[2024-02-14 07:22:12] VERBOSE[330] res_pjsip_logger.c: <--- Received SIP request (297 bytes) from UDP:10.0.100.75:5060 --->
ACK sip:202@voip.mydomain.com:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.100.75:5060;branch=z9hG4bK3596301497
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com>;tag=z9hG4bK3596301497
Call-ID: 18403fee2e3af96@10.0.100.75
CSeq: 20 ACK
Content-Length: 0


[2024-02-14 07:22:12] VERBOSE[330] res_pjsip_logger.c: <--- Received SIP request (1162 bytes) from UDP:10.0.100.75:5060 --->
INVITE sip:202@voip.mydomain.com:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.100.75:5060;branch=z9hG4bK4eb868fb
From: "Jay-202" <sip:202@voip.mydomain.com:5060>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com:5060>
Call-ID: 18403fee2e3af96@10.0.100.75
CSeq: 21 INVITE
Contact: <sip:202@10.0.100.75:5060;transport=UDP>
Authorization: Digest username="202", realm="asterisk", nonce="1707916932/527efcb4d132327f15465f99d9d5c5c5", uri="sip:202@voip.mydomain.com:5060", response="1c15916bf499e0900e66d6ece4d4ccfe", algorithm=MD5, cnonce="0a4f113b", opaque="3b12f79431ea365e", qop=auth, nc=00000001
Max-Forwards: 70
User-Agent: Sangoma S705 V3.0.4.88
Supported: replaces
Subject: SIP Call
Expires: 120
Allow: INVITE, ACK, UPDATE, INFO, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY, MESSAGE, PRACK
Content-Type: application/sdp
Content-Length: 307

v=0
o=- 6666 377 IN IP4 10.0.100.75
s=SIP Call
c=IN IP4 10.0.100.75
t=0 0
m=audio 12138 RTP/AVP 0 8 3 2 9 101
a=sendrecv
a=rtpmap:0 PCMU/8000
a=ptime:20
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-11,16

[2024-02-14 07:22:12] VERBOSE[1805] res_pjsip_logger.c: <--- Transmitting SIP response (320 bytes) to UDP:10.0.100.75:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 10.0.100.75:5060;rport=5060;received=10.0.100.75;branch=z9hG4bK4eb868fb
Call-ID: 18403fee2e3af96@10.0.100.75
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com>
CSeq: 21 INVITE
Server: PBXact-15.0.37.4(16.30.0)
Content-Length:  0


[2024-02-14 07:22:12] VERBOSE[1805] netsock2.c: Using SIP RTP Audio TOS bits 184
[2024-02-14 07:22:12] VERBOSE[1805] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2024-02-14 07:22:12] VERBOSE[1805] netsock2.c: Using SIP RTP Audio CoS mark 5
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [202@from-internal:1] GotoIf("PJSIP/202-000168fd", "0?ext-local,*202,1") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [202@from-internal:2] GotoIf("PJSIP/202-000168fd", "1?ext-local,202,1:followme-check,202,1") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (ext-local,202,1)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [202@ext-local:1] Set("PJSIP/202-000168fd", "__RINGTIMER=15") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [202@ext-local:2] ExecIf("PJSIP/202-000168fd", "0?Set(__CWIGNORE=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [202@ext-local:3] Macro("PJSIP/202-000168fd", "exten-vm,202,202,0,0,0") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:1] Macro("PJSIP/202-000168fd", "user-callerid,") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/202-000168fd", "TOUCH_MONITOR=1707916932.459604") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/202-000168fd", "CHANCONTEXT=") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:3] Progress("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/202-000168fd", "CHANCONTEXT=") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/202-000168fd", "CHANEXTENCONTEXT=202-000168fd") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:6] Set("PJSIP/202-000168fd", "CHANEXTEN=202-000168fd") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/202-000168fd", "CALLERID(number)=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:8] Set("PJSIP/202-000168fd", "AMPUSER=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:9] Set("PJSIP/202-000168fd", "HOTDESCKCHAN=202-000168fd") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/202-000168fd", "HOTDESKEXTEN=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:11] Set("PJSIP/202-000168fd", "HOTDESKCALL=0") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:12] ExecIf("PJSIP/202-000168fd", "0?Set(HOTDESKCALL=1)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("PJSIP/202-000168fd", "0?Set(CALLERID(name)=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("PJSIP/202-000168fd", "0?report") in new stack
[2024-02-14 07:22:12] VERBOSE[2925] res_pjsip_logger.c: <--- Transmitting SIP request (833 bytes) to UDP:10.0.100.84:5060 --->
NOTIFY sip:201@10.0.100.84:5060 SIP/2.0
Via: SIP/2.0/UDP 10.40.0.1:5060;rport;branch=z9hG4bKPje02aecf9-34b8-4848-b50f-c2686a4392fd
From: <sip:202@voip.mydomain.com>;tag=79af8a85-9d5f-4e2e-af3f-ba934918fea5
To: "Matt-201" <sip:201@voip.mydomain.com>;tag=d7b564ed7f85cfa
Contact: <sip:10.40.0.1:5060>
Call-ID: 6040dbf77e03ccf@10.0.100.84
CSeq: 30497 NOTIFY
Event: dialog
Subscription-State: active;expires=138
Allow-Events: presence, dialog, message-summary, refer
Max-Forwards: 70
User-Agent: PBXact-15.0.37.4(16.30.0)
Content-Type: application/dialog-info+xml
Content-Length:   235

<?xml version="1.0" encoding="UTF-8"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="733" state="full" entity="sip:202@voip.mydomain.com:5060">
 <dialog id="202">
  <state>confirmed</state>
 </dialog>
</dialog-info>

[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:15] ExecIf("PJSIP/202-000168fd", "1?Set(REALCALLERIDNUM=202)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:16] Set("PJSIP/202-000168fd", "AMPUSER=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:17] GotoIf("PJSIP/202-000168fd", "0?limit") in new stack
[2024-02-14 07:22:12] VERBOSE[19795] res_pjsip_logger.c: <--- Transmitting SIP request (836 bytes) to UDP:10.0.100.82:5060 --->
NOTIFY sip:209@10.0.100.82:5060 SIP/2.0
Via: SIP/2.0/UDP 10.40.0.1:5060;rport;branch=z9hG4bKPj78baaa03-4656-4f6b-af14-51e7c1df7045
From: <sip:202@voip.mydomain.com>;tag=b6c97d93-0a43-4d9d-9f25-48cf5e180096
To: "IT Matt-209" <sip:209@voip.mydomain.com>;tag=9cb6cb1bb2e77c7
Contact: <sip:10.40.0.1:5060>
Call-ID: a564e28b5775f91@10.0.100.82
CSeq: 25459 NOTIFY
Event: dialog
Subscription-State: active;expires=146
Allow-Events: presence, dialog, message-summary, refer
Max-Forwards: 70
User-Agent: PBXact-15.0.37.4(16.30.0)
Content-Type: application/dialog-info+xml
Content-Length:   235

<?xml version="1.0" encoding="UTF-8"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="733" state="full" entity="sip:202@voip.mydomain.com:5060">
 <dialog id="202">
  <state>confirmed</state>
 </dialog>
</dialog-info>

[2024-02-14 07:22:12] VERBOSE[1805] res_rtp_asterisk.c: 0x7f22b4085e10 -- Strict RTP learning after remote address set to: 10.0.100.75:12138
[2024-02-14 07:22:12] VERBOSE[29611] res_pjsip_logger.c: <--- Transmitting SIP request (828 bytes) to UDP:10.0.100.68:5060 --->
NOTIFY sip:106@10.0.100.68:5060 SIP/2.0
Via: SIP/2.0/UDP 10.40.0.1:5060;rport;branch=z9hG4bKPj3d513bb2-1938-4713-b235-4d67b42d4f4d
From: <sip:202@voip.mydomain.com>;tag=0aab9561-c386-42dd-a89e-65d3c74faec3
To: "106" <sip:106@voip.mydomain.com>;tag=474e1b4b24e3010
Contact: <sip:10.40.0.1:5060>
Call-ID: 94bacda4745815b@10.0.100.68
CSeq: 24470 NOTIFY
Event: dialog
Subscription-State: active;expires=178
Allow-Events: presence, dialog, message-summary, refer
Max-Forwards: 70
User-Agent: PBXact-15.0.37.4(16.30.0)
Content-Type: application/dialog-info+xml
Content-Length:   235

<?xml version="1.0" encoding="UTF-8"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="733" state="full" entity="sip:202@voip.mydomain.com:5060">
 <dialog id="202">
  <state>confirmed</state>
 </dialog>
</dialog-info>

[2024-02-14 07:22:12] VERBOSE[1805] res_pjsip_logger.c: <--- Transmitting SIP response (863 bytes) to UDP:10.0.100.75:5060 --->
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 10.0.100.75:5060;rport=5060;received=10.0.100.75;branch=z9hG4bK4eb868fb
Call-ID: 18403fee2e3af96@10.0.100.75
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com>;tag=57bd2a67-2da7-4e9f-89bb-79c74a738946
CSeq: 21 INVITE
Server: PBXact-15.0.37.4(16.30.0)
Contact: <sip:10.40.0.1:5060>
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Content-Type: application/sdp
Content-Length:   316

v=0
o=- 6666 379 IN IP4 10.40.0.1
s=Asterisk
c=IN IP4 10.40.0.1
t=0 0
m=audio 12740 RTP/AVP 0 8 3 2 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv

[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:18] Set("PJSIP/202-000168fd", "AMPUSERCIDNAME=Jay") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:19] ExecIf("PJSIP/202-000168fd", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:20] GotoIf("PJSIP/202-000168fd", "0?report") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:21] Set("PJSIP/202-000168fd", "AMPUSERCID=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:22] Set("PJSIP/202-000168fd", "__DIAL_OPTIONS=HhTtr") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:23] Set("PJSIP/202-000168fd", "CALLERID(all)="Jay" <202>") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:24] ExecIf("PJSIP/202-000168fd", "0?Set(CUSDIAL=202)") in new stack



[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:25] ExecIf("PJSIP/202-000168fd", "0?Set(CALLERID(all)="Jay" <202>)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:26] GotoIf("PJSIP/202-000168fd", "0?limit") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:27] ExecIf("PJSIP/202-000168fd", "0?Set(GROUP(concurrency_limit)=202)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:28] ExecIf("PJSIP/202-000168fd", "0?Set(CHANNEL(language)=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:29] NoOp("PJSIP/202-000168fd", "Macro Depth is 2") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/202-000168fd", "1?report2:macroerror") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-user-callerid,s,31)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("PJSIP/202-000168fd", "0?continue") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:32] ExecIf("PJSIP/202-000168fd", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:33] Set("PJSIP/202-000168fd", "__TTL=64") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:34] GotoIf("PJSIP/202-000168fd", "1?continue") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-user-callerid,s,50)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/202-000168fd", "CALLERID(number)=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:51] Set("PJSIP/202-000168fd", "CALLERID(name)=Jay") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:52] GotoIf("PJSIP/202-000168fd", "0?cnum") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/202-000168fd", "CDR(cnam)=Jay") in new stack


[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/202-000168fd", "CDR(cnum)=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/202-000168fd", "CHANNEL(language)=en") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:56] GosubIf("PJSIP/202-000168fd", "0?app-check-classofservce,s,1()") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:2] Set("PJSIP/202-000168fd", "RingGroupMethod=none") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:3] Set("PJSIP/202-000168fd", "__EXTTOCALL=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:4] Set("PJSIP/202-000168fd", "__PICKUPMARK=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:5] Set("PJSIP/202-000168fd", "RT=15") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:6] GotoIf("PJSIP/202-000168fd", "1?startcheck:exitcheck") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-exten-vm,s,7)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:7] GotoIf("PJSIP/202-000168fd", "0?featureSIP:featurePJSIP") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-exten-vm,s,11)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:11] ExecIf("PJSIP/202-000168fd", "0?Macro(vm,202,DIRECTDIAL,)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:12] ExecIf("PJSIP/202-000168fd", "0?MacroExit()") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:13] GotoIf("PJSIP/202-000168fd", "1?featuremoniPJSIP:featuremoniSIP") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-exten-vm,s,14)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:14] ExecIf("PJSIP/202-000168fd", "0?ChanSpy(PJSIP/202,q)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:15] ExecIf("PJSIP/202-000168fd", "0?MacroExit()") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:16] GotoIf("PJSIP/202-000168fd", "1?check-ext-intercom:featuremoniSIP") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-exten-vm,s,19)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:19] GotoIf("PJSIP/202-000168fd", "0?ext-intercomSIP:ext-intercomPJSIP") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-exten-vm,s,20)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:20] ExecIf("PJSIP/202-000168fd", "0?Gosub(ext-intercom,nointercom202,1())") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:21] ExecIf("PJSIP/202-000168fd", "0?MacroExit()") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:22] GotoIf("PJSIP/202-000168fd", "1?exitcheck:ext-intercomSIP") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-exten-vm,s,25)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:25] NoOp("PJSIP/202-000168fd", "Exiting Checks") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:26] Gosub("PJSIP/202-000168fd", "sub-record-check,s,1(exten,202,dontcare)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/202-000168fd", "0?initialized") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/202-000168fd", "__REC_STATUS=INITIALIZED") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/202-000168fd", "NOW=1707916932") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/202-000168fd", "__DAY=14") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/202-000168fd", "__MONTH=02") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/202-000168fd", "__YEAR=2024") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/202-000168fd", "__TIMESTR=20240214-072212") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/202-000168fd", "__FROMEXTEN=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/202-000168fd", "__MON_FMT=WAV") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/202-000168fd", "Recordings initialized") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/202-000168fd", "0?Set(ARG3=dontcare)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/202-000168fd", "REC_POLICY_MODE_SAVE=") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/202-000168fd", "0?Set(REC_STATUS=NO)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/202-000168fd", "5?checkaction") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (sub-record-check,s,17)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/202-000168fd", "1?sub-record-check,exten,1") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (sub-record-check,exten,1)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:1] NoOp("PJSIP/202-000168fd", "Exten Recording Check between 202 and 202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:2] Set("PJSIP/202-000168fd", "CALLTYPE=internal") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:3] ExecIf("PJSIP/202-000168fd", "0?Set(CALLTYPE=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:4] Set("PJSIP/202-000168fd", "CALLEE=force") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:5] ExecIf("PJSIP/202-000168fd", "0?Set(CALLEE=dontcare)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:6] GotoIf("PJSIP/202-000168fd", "0?callee") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:7] GotoIf("PJSIP/202-000168fd", "0?caller") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:8] ExecIf("PJSIP/202-000168fd", "1?Set(CALLER_PRI=0):Set(CALLER_PRI=0)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:9] ExecIf("PJSIP/202-000168fd", "1?Set(CALLEE_PRI=0):Set(CALLEE_PRI=0)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:10] GotoIf("PJSIP/202-000168fd", "1?caller:callee") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (sub-record-check,exten,13)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:13] Set("PJSIP/202-000168fd", "RECMODE=force") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:14] Set("PJSIP/202-000168fd", "CALLERRECMODE=force") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:15] Set("PJSIP/202-000168fd", "CALEERECMODE=force") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:16] GotoIf("PJSIP/202-000168fd", "0?processnormal") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:17] ExecIf("PJSIP/202-000168fd", "0?Set(RECMODE=force)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:18] ExecIf("PJSIP/202-000168fd", "0?Set(RECMODE=force)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:19] ExecIf("PJSIP/202-000168fd", "0?Set(RECMODE=force)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:20] ExecIf("PJSIP/202-000168fd", "0?Set(RECMODE=force)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:21] ExecIf("PJSIP/202-000168fd", "0?Set(RECMODE=dontcare)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:22] ExecIf("PJSIP/202-000168fd", "0?Set(RECMODE=force)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:23] Gosub("PJSIP/202-000168fd", "recordcheck,1(force,internal,202)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/202-000168fd", "Starting recording check against force") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/202-000168fd", "force") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (sub-record-check,recordcheck,5)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:5] Set("PJSIP/202-000168fd", "__REC_POLICY_MODE=FORCE") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:6] GotoIf("PJSIP/202-000168fd", "1?startrec") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (sub-record-check,recordcheck,16)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:16] NoOp("PJSIP/202-000168fd", "Starting recording: internal, 202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:17] ExecIf("PJSIP/202-000168fd", "0?Set(RECFROMEXTEN=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:18] ExecIf("PJSIP/202-000168fd", "1?Set(RECFROMEXTEN=202)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:19] Set("PJSIP/202-000168fd", "__CALLFILENAME=internal-202-202-20240214-072212-1707916932.459604") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:20] MixMonitor("PJSIP/202-000168fd", "2024/02/14/internal-202-202-20240214-072212-1707916932.459604.WAV,abi(),") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:21] Set("PJSIP/202-000168fd", "__MIXMON_ID=") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:22] Set("PJSIP/202-000168fd", "__RECORD_ID=PJSIP/202-000168fd") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:23] Set("PJSIP/202-000168fd", "__REC_STATUS=RECORDING") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:24] Set("PJSIP/202-000168fd", "CDR(recordingfile)=internal-202-202-20240214-072212-1707916932.459604.WAV") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [recordcheck@sub-record-check:25] Return("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [exten@sub-record-check:24] Return("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:27] Macro("PJSIP/202-000168fd", "dial-one,15,HhTtr,202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:1] Set("PJSIP/202-000168fd", "DEXTEN=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:2] Set("PJSIP/202-000168fd", "__CRM_SOURCE=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:3] Gosub("PJSIP/202-000168fd", "zulu-user-settings-map,s,1(202)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@zulu-user-settings-map:1] GotoIf("PJSIP/202-000168fd", "0?202,1") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@zulu-user-settings-map:2] Return("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:4] Gosub("PJSIP/202-000168fd", "zulu-send-event,s,1(202,202)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@zulu-send-event:1] GotoIf("PJSIP/202-000168fd", "1?skippopup") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (zulu-send-event,s,4)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@zulu-send-event:4] NoOp("PJSIP/202-000168fd", "No Call Pop") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@zulu-send-event:5] UserEvent("PJSIP/202-000168fd", "zulu-call,eventtype:calling,extension:202,type:,url:,cnam:SmF5,cnum:202,lid:1707916932.459604,from:202,to:202}") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@zulu-send-event:6] Return("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:5] UserEvent("PJSIP/202-000168fd", "zulu-inbound-call,type:macro-dial-one,from:202,to:202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:6] ExecIf("PJSIP/202-000168fd", "0?Set(__EXTTOCALL=202)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:7] Set("PJSIP/202-000168fd", "DIALSTATUS_CW=") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:8] GosubIf("PJSIP/202-000168fd", "0?screen,1()") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:9] GosubIf("PJSIP/202-000168fd", "0?cf,1()") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:10] GotoIf("PJSIP/202-000168fd", "1?skip1") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-dial-one,s,13)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:13] GotoIf("PJSIP/202-000168fd", "0?nodial") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:14] GotoIf("PJSIP/202-000168fd", "0?continue") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:15] Set("PJSIP/202-000168fd", "EXTHASCW=ENABLED") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:16] GotoIf("PJSIP/202-000168fd", "0?next1:cwinusebusy") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-dial-one,s,28)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:28] GotoIf("PJSIP/202-000168fd", "0?next3:continue") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-dial-one,s,30)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:30] GotoIf("PJSIP/202-000168fd", "0?nodial") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:31] GosubIf("PJSIP/202-000168fd", "1?dstring,1():dlocal,1()") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:1] Set("PJSIP/202-000168fd", "DSTRING=") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:2] Set("PJSIP/202-000168fd", "DEVICES=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("PJSIP/202-000168fd", "0?Return()") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("PJSIP/202-000168fd", "0?Set(DEVICES=02)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:5] Set("PJSIP/202-000168fd", "LOOPCNT=1") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:6] Set("PJSIP/202-000168fd", "ITER=1") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:7] Set("PJSIP/202-000168fd", "THISDIAL=PJSIP/202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:8] GotoIf("PJSIP/202-000168fd", "0?docheck") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:9] NoOp("PJSIP/202-000168fd", "Debug: Found PJSIP Destination PJSIP/202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:10] GotoIf("PJSIP/202-000168fd", "0?doset") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:11] NoOp("PJSIP/202-000168fd", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:12] Set("PJSIP/202-000168fd", "THISDIAL=PJSIP/202/sip:202@10.0.100.75:5060;x-ast-orig-host=0.0.0.0:5060") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:13] ExecIf("PJSIP/202-000168fd", "0?Set(DIALSTATUS=CHANUNAVAIL)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("PJSIP/202-000168fd", "0?skipset") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:15] Set("PJSIP/202-000168fd", "DSTRING=PJSIP/202/sip:202@10.0.100.75:5060;x-ast-orig-host=0.0.0.0:5060&") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:16] Set("PJSIP/202-000168fd", "ITER=2") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("PJSIP/202-000168fd", "0?begin") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("PJSIP/202-000168fd", "0?Return()") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:19] Set("PJSIP/202-000168fd", "DSTRING=PJSIP/202/sip:202@10.0.100.75:5060;x-ast-orig-host=0.0.0.0:5060") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [dstring@macro-dial-one:20] Return("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:32] GotoIf("PJSIP/202-000168fd", "0?nodial") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:33] GotoIf("PJSIP/202-000168fd", "0?skiptrace") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:34] GosubIf("PJSIP/202-000168fd", "1?ctset,1():ctclear,1()") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [ctset@macro-dial-one:1] Set("PJSIP/202-000168fd", "DB(CALLTRACE/202)=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [ctset@macro-dial-one:2] Return("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:35] Set("PJSIP/202-000168fd", "D_OPTIONS=HhTtr") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:36] GosubIf("PJSIP/202-000168fd", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:37] NoOp("PJSIP/202-000168fd", "Blind Transfer: , Attended Transfer: , User: 202, Alert Info: ") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:38] ExecIf("PJSIP/202-000168fd", "1?Set(ALERT_INFO=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:39] ExecIf("PJSIP/202-000168fd", "0?Set(ALERT_INFO=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:40] ExecIf("PJSIP/202-000168fd", "0?Set(ALERT_INFO=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:41] ExecIf("PJSIP/202-000168fd", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1690][C-0000a552] app_mixmonitor.c: Begin MixMonitor Recording PJSIP/202-000168fd
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:42] ExecIf("PJSIP/202-000168fd", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:43] GosubIf("PJSIP/202-000168fd", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:44] ExecIf("PJSIP/202-000168fd", "0?Set(CHANNEL(musicclass)=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:45] GosubIf("PJSIP/202-000168fd", "0?qwait,1()") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:46] Set("PJSIP/202-000168fd", "__CWIGNORE=") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:47] Set("PJSIP/202-000168fd", "__KEEPCID=TRUE") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:48] GotoIf("PJSIP/202-000168fd", "0?usegoto,1") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:49] GotoIf("PJSIP/202-000168fd", "0?godial") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:50] Gosub("PJSIP/202-000168fd", "sub-presencestate-display,s,1(202)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@sub-presencestate-display:1] Goto("PJSIP/202-000168fd", "state-available,1") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (sub-presencestate-display,state-available,1)
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [state-available@sub-presencestate-display:1] Set("PJSIP/202-000168fd", "PRESENCESTATE_DISPLAY=(Available)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [state-available@sub-presencestate-display:2] Return("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:51] Set("PJSIP/202-000168fd", "CONNECTEDLINE(name,i)=Jay (Available)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:52] Set("PJSIP/202-000168fd", "CONNECTEDLINE(num)=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:53] Set("PJSIP/202-000168fd", "D_OPTIONS=HhTtr") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:54] Macro("PJSIP/202-000168fd", "dialout-one-predial-hook,") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] MacroExit("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:55] ExecIf("PJSIP/202-000168fd", "0?Set(D_OPTIONS=HhtrI)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:56] ExecIf("PJSIP/202-000168fd", "0?Set(CWRING=r(callwaiting)):Set(CWRING=)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:57] Set("PJSIP/202-000168fd", "__ZULU_TIMEOUT=15") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:58] Set("PJSIP/202-000168fd", "__ZULU_FROMEXTEN=202") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:59] Set("PJSIP/202-000168fd", "__ZULU_DIALOPTS=HhTtr") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:60] NoOp("PJSIP/202-000168fd", "Finished") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:61] NoOp("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:62] ExecIf("PJSIP/202-000168fd", "0?Set(D_OPTIONS=HhTtrg)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:63] Dial("PJSIP/202-000168fd", "PJSIP/202/sip:202@10.0.100.75:5060;x-ast-orig-host=0.0.0.0:5060,15,HhTtrb(func-apply-sipheaders^s^1)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] app_stack.c: PJSIP/202-000168fe Internal Gosub(func-apply-sipheaders,s,1) start
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/202-000168fe", "0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/202-000168fe", "Applying SIP Headers to channel PJSIP/202-000168fe") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/202-000168fe", "TECH=PJSIP") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/202-000168fe", "SIPHEADERKEYS=") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/202-000168fe", "0") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] app_while.c: Jumping to priority 13
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@func-apply-sipheaders:14] Return("PJSIP/202-000168fe", "") in new stack
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] app_stack.c: Spawn extension (from-internal, 202, 1) exited non-zero on 'PJSIP/202-000168fe'
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] app_stack.c: PJSIP/202-000168fe Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] app_dial.c: Called PJSIP/202/sip:202@10.0.100.75:5060;x-ast-orig-host=0.0.0.0:5060
[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] res_rtp_asterisk.c: 0x7f22b4085e10 -- Strict RTP switching to RTP target address 10.0.100.75:12138 as source
[2024-02-14 07:22:12] VERBOSE[16359] netsock2.c: Using SIP RTP Audio TOS bits 184
[2024-02-14 07:22:12] VERBOSE[16359] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2024-02-14 07:22:12] VERBOSE[16359] netsock2.c: Using SIP RTP Audio CoS mark 5
[2024-02-14 07:22:12] VERBOSE[28638] res_pjsip_logger.c: <--- Transmitting SIP response (919 bytes) to UDP:10.0.100.75:5060 --->
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 10.0.100.75:5060;rport=5060;received=10.0.100.75;branch=z9hG4bK4eb868fb
Call-ID: 18403fee2e3af96@10.0.100.75
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com>;tag=57bd2a67-2da7-4e9f-89bb-79c74a738946
CSeq: 21 INVITE
Server: PBXact-15.0.37.4(16.30.0)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip:10.40.0.1:5060>
P-Asserted-Identity: "Jay" <sip:202@voip.mydomain.com>
Content-Type: application/sdp
Content-Length:   316

v=0
o=- 6666 379 IN IP4 10.40.0.1
s=Asterisk
c=IN IP4 10.40.0.1
t=0 0
m=audio 12740 RTP/AVP 0 8 3 2 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv

[2024-02-14 07:22:12] VERBOSE[16359] res_pjsip_logger.c: <--- Transmitting SIP request (1036 bytes) to UDP:10.0.100.75:5060 --->
INVITE sip:202@10.0.100.75:5060 SIP/2.0
Via: SIP/2.0/UDP 10.40.0.1:5060;rport;branch=z9hG4bKPja192c9db-03bb-4b79-9abb-cb6499091843
From: "Jay" <sip:202@10.40.0.1>;tag=d8213b6e-2be7-4a7d-820d-7476fa8cef7b
To: <sip:202@10.0.100.75>
Contact: <sip:asterisk@10.40.0.1:5060>
Call-ID: 6b89e65f-2911-4042-8bf6-3d0054d8a23e
CSeq: 1853 INVITE
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Supported: 100rel, timer, replaces, norefersub, histinfo
Session-Expires: 1800
Min-SE: 90
P-Asserted-Identity: "Jay" <sip:202@10.40.0.1>
Max-Forwards: 70
User-Agent: PBXact-15.0.37.4(16.30.0)
Content-Type: application/sdp
Content-Length:   331

v=0
o=- 529330788 529330788 IN IP4 10.40.0.1
s=Asterisk
c=IN IP4 10.40.0.1
t=0 0
m=audio 11228 RTP/AVP 0 8 3 111 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:111 G726-32/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv

[2024-02-14 07:22:12] VERBOSE[330] res_pjsip_logger.c: <--- Received SIP response (439 bytes) from UDP:10.0.100.75:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 10.40.0.1:5060;rport=5060;branch=z9hG4bKPja192c9db-03bb-4b79-9abb-cb6499091843
From: "Jay" <sip:202@10.40.0.1>;tag=d8213b6e-2be7-4a7d-820d-7476fa8cef7b
To: <sip:202@10.0.100.75>
Call-ID: 6b89e65f-2911-4042-8bf6-3d0054d8a23e
CSeq: 1853 INVITE
User-Agent: Sangoma S705 V3.0.4.88
Allow: INVITE, ACK, UPDATE, INFO, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY, MESSAGE, PRACK
Content-Length: 0


[2024-02-14 07:22:12] VERBOSE[330] res_pjsip_logger.c: <--- Received SIP response (511 bytes) from UDP:10.0.100.75:5060 --->
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 10.40.0.1:5060;rport=5060;branch=z9hG4bKPja192c9db-03bb-4b79-9abb-cb6499091843
From: "Jay" <sip:202@10.40.0.1>;tag=d8213b6e-2be7-4a7d-820d-7476fa8cef7b
To: <sip:202@10.0.100.75>;tag=25485212eb3349e
Call-ID: 6b89e65f-2911-4042-8bf6-3d0054d8a23e
CSeq: 1853 INVITE
Contact: <sip:202@10.0.100.75:5060;transport=UDP>
User-Agent: Sangoma S705 V3.0.4.88
Allow: INVITE, ACK, UPDATE, INFO, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY, MESSAGE, PRACK
Content-Length: 0


[2024-02-14 07:22:12] VERBOSE[1673][C-0000a552] app_dial.c: PJSIP/202-000168fe is ringing
[2024-02-14 07:22:12] VERBOSE[26102] res_pjsip_logger.c: <--- Transmitting SIP response (919 bytes) to UDP:10.0.100.75:5060 --->
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 10.0.100.75:5060;rport=5060;received=10.0.100.75;branch=z9hG4bK4eb868fb
Call-ID: 18403fee2e3af96@10.0.100.75
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com>;tag=57bd2a67-2da7-4e9f-89bb-79c74a738946
CSeq: 21 INVITE
Server: PBXact-15.0.37.4(16.30.0)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip:10.40.0.1:5060>
P-Asserted-Identity: "Jay" <sip:202@voip.mydomain.com>
Content-Type: application/sdp
Content-Length:   316

v=0
o=- 6666 379 IN IP4 10.40.0.1
s=Asterisk
c=IN IP4 10.40.0.1
t=0 0
m=audio 12740 RTP/AVP 0 8 3 2 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv



[2024-02-14 07:22:17] VERBOSE[1673][C-0000a552] res_rtp_asterisk.c: 0x7f22b4085e10 -- Strict RTP learning complete - Locking on source address 10.0.100.75:12138
[2024-02-14 07:22:18] VERBOSE[330] res_pjsip_logger.c: <--- Received SIP request (586 bytes) from UDP:10.0.100.75:5060 --->
SUBSCRIBE sip:10.40.0.1:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.100.75:5060;branch=z9hG4bK82192072
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=fff84acdabdd583
To: <sip:209@voip.mydomain.com>;tag=3a589c37-5ddc-4de9-ba59-02f439a4c9bf
Call-ID: e447498bd90f849@10.0.100.75
CSeq: 22624 SUBSCRIBE
Contact: <sip:202@10.0.100.75:5060;transport=UDP>
Max-Forwards: 70
User-Agent: Sangoma S705 V3.0.4.88
Expires: 300
Event: dialog
Allow: INVITE, ACK, UPDATE, INFO, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY, MESSAGE, PRACK
Accept: application/dialog-info+xml
Content-Length: 0


[2024-02-14 07:22:18] VERBOSE[23380] res_pjsip_logger.c: <--- Transmitting SIP response (567 bytes) to UDP:10.0.100.75:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.100.75:5060;rport=5060;received=10.0.100.75;branch=z9hG4bK82192072
Call-ID: e447498bd90f849@10.0.100.75
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=fff84acdabdd583
To: <sip:209@voip.mydomain.com>;tag=3a589c37-5ddc-4de9-ba59-02f439a4c9bf
CSeq: 22624 SUBSCRIBE
Expires: 300
Contact: <sip:10.40.0.1:5060>
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Supported: 100rel, timer, replaces, norefersub
Server: PBXact-15.0.37.4(16.30.0)
Content-Length:  0



[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] app_dial.c: Nobody picked up in 15000 ms
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:64] ExecIf("PJSIP/202-000168fd", "0?MacroExit()") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:65] ExecIf("PJSIP/202-000168fd", "0?Set(DIALSTATUS=)") in new stack
[2024-02-14 07:22:27] VERBOSE[18482] res_pjsip_logger.c: <--- Transmitting SIP request (402 bytes) to UDP:10.0.100.75:5060 --->
CANCEL sip:202@10.0.100.75:5060 SIP/2.0
Via: SIP/2.0/UDP 10.40.0.1:5060;rport;branch=z9hG4bKPja192c9db-03bb-4b79-9abb-cb6499091843
From: "Jay" <sip:202@10.40.0.1>;tag=d8213b6e-2be7-4a7d-820d-7476fa8cef7b
To: <sip:202@10.0.100.75>
Call-ID: 6b89e65f-2911-4042-8bf6-3d0054d8a23e
CSeq: 1853 CANCEL
Reason: Q.850;cause=0
Max-Forwards: 70
User-Agent: PBXact-15.0.37.4(16.30.0)
Content-Length:  0


[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:66] GosubIf("PJSIP/202-000168fd", "0?s-NOANSWER,1()") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-dial-one:67] MacroExit("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:28] Set("PJSIP/202-000168fd", "SV_DIALSTATUS=NOANSWER") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:29] GosubIf("PJSIP/202-000168fd", "0?docfu,1()") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:30] GosubIf("PJSIP/202-000168fd", "0?docfb,1()") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:31] Set("PJSIP/202-000168fd", "DIALSTATUS=NOANSWER") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:32] ExecIf("PJSIP/202-000168fd", "0?MacroExit()") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:33] GotoIf("PJSIP/202-000168fd", "0?s-NOANSWER,1") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-exten-vm:34] Macro("PJSIP/202-000168fd", "vm,202,NOANSWER,") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-vm:1] Macro("PJSIP/202-000168fd", "user-callerid,SKIPTTL") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/202-000168fd", "TOUCH_MONITOR=1707916932.459604") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/202-000168fd", "CHANCONTEXT=") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:3] Progress("PJSIP/202-000168fd", "") in new stack


[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/202-000168fd", "CHANCONTEXT=") in new stack


[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/202-000168fd", "CHANEXTENCONTEXT=202-000168fd") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:6] Set("PJSIP/202-000168fd", "CHANEXTEN=202-000168fd") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/202-000168fd", "CALLERID(number)=202") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:8] Set("PJSIP/202-000168fd", "AMPUSER=202") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:9] Set("PJSIP/202-000168fd", "HOTDESCKCHAN=202-000168fd") in new stack


[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/202-000168fd", "HOTDESKEXTEN=202") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:11] Set("PJSIP/202-000168fd", "HOTDESKCALL=0") in new stack


[2024-02-14 07:22:27] VERBOSE[26102] res_pjsip_logger.c: <--- Transmitting SIP response (919 bytes) to UDP:10.0.100.75:5060 --->
SIP/2.0 183 Session Progress
Via: SIP/2.0/UDP 10.0.100.75:5060;rport=5060;received=10.0.100.75;branch=z9hG4bK4eb868fb
Call-ID: 18403fee2e3af96@10.0.100.75
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com>;tag=57bd2a67-2da7-4e9f-89bb-79c74a738946
CSeq: 21 INVITE
Server: PBXact-15.0.37.4(16.30.0)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip:10.40.0.1:5060>
P-Asserted-Identity: "Jay" <sip:202@voip.mydomain.com>
Content-Type: application/sdp
Content-Length:   316

v=0
o=- 6666 379 IN IP4 10.40.0.1
s=Asterisk
c=IN IP4 10.40.0.1
t=0 0
m=audio 12740 RTP/AVP 0 8 3 2 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv




[2024-02-14 07:22:27] VERBOSE[330] res_pjsip_logger.c: <--- Received SIP response (470 bytes) from UDP:10.0.100.75:5060 --->
SIP/2.0 487 Request Cancelled
Via: SIP/2.0/UDP 10.40.0.1:5060;rport=5060;branch=z9hG4bKPja192c9db-03bb-4b79-9abb-cb6499091843
From: "Jay" <sip:202@10.40.0.1>;tag=d8213b6e-2be7-4a7d-820d-7476fa8cef7b
To: <sip:202@10.0.100.75>;tag=25485212eb3349e
Call-ID: 6b89e65f-2911-4042-8bf6-3d0054d8a23e
CSeq: 1853 INVITE
User-Agent: Sangoma S705 V3.0.4.88
Allow: INVITE, ACK, UPDATE, INFO, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY, MESSAGE, PRACK
Content-Length: 0


[2024-02-14 07:22:27] VERBOSE[330] res_pjsip_logger.c: <--- Received SIP response (455 bytes) from UDP:10.0.100.75:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.40.0.1:5060;rport=5060;branch=z9hG4bKPja192c9db-03bb-4b79-9abb-cb6499091843
From: "Jay" <sip:202@10.40.0.1>;tag=d8213b6e-2be7-4a7d-820d-7476fa8cef7b
To: <sip:202@10.0.100.75>;tag=25485212eb3349e
Call-ID: 6b89e65f-2911-4042-8bf6-3d0054d8a23e
CSeq: 1853 CANCEL
User-Agent: Sangoma S705 V3.0.4.88
Allow: INVITE, ACK, UPDATE, INFO, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY, MESSAGE, PRACK
Content-Length: 0





[2024-02-14 07:22:27] VERBOSE[1805] res_pjsip_logger.c: <--- Transmitting SIP request (393 bytes) to UDP:10.0.100.75:5060 --->
ACK sip:202@10.0.100.75:5060 SIP/2.0
Via: SIP/2.0/UDP 10.40.0.1:5060;rport;branch=z9hG4bKPja192c9db-03bb-4b79-9abb-cb6499091843
From: "Jay" <sip:202@10.40.0.1>;tag=d8213b6e-2be7-4a7d-820d-7476fa8cef7b
To: <sip:202@10.0.100.75>;tag=25485212eb3349e
Call-ID: 6b89e65f-2911-4042-8bf6-3d0054d8a23e
CSeq: 1853 ACK
Max-Forwards: 70
User-Agent: PBXact-15.0.37.4(16.30.0)
Content-Length:  0




[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:12] ExecIf("PJSIP/202-000168fd", "0?Set(HOTDESKCALL=1)") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("PJSIP/202-000168fd", "0?Set(CALLERID(name)=)") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("PJSIP/202-000168fd", "3?report") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-user-callerid,s,29)
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:29] NoOp("PJSIP/202-000168fd", "Macro Depth is 3") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/202-000168fd", "1?report2:macroerror") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-user-callerid,s,31)
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("PJSIP/202-000168fd", "1?continue") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-user-callerid,s,50)
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/202-000168fd", "CALLERID(number)=202") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:51] Set("PJSIP/202-000168fd", "CALLERID(name)=Jay") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:52] GotoIf("PJSIP/202-000168fd", "0?cnum") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/202-000168fd", "CDR(cnam)=Jay") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/202-000168fd", "CDR(cnum)=202") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/202-000168fd", "CHANNEL(language)=en") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-user-callerid:56] GosubIf("PJSIP/202-000168fd", "0?app-check-classofservce,s,1()") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-vm:2] Set("PJSIP/202-000168fd", "VMGAIN=") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-vm:3] Macro("PJSIP/202-000168fd", "blkvm-check,") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-blkvm-check:1] Set("PJSIP/202-000168fd", "GOSUB_RETVAL=") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-blkvm-check:2] ExecIf("PJSIP/202-000168fd", "0?Set(GOSUB_RETVAL=TRUE)") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-blkvm-check:3] MacroExit("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-vm:4] GotoIf("PJSIP/202-000168fd", "1?vmx,1") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-vm,vmx,1)
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:1] Set("PJSIP/202-000168fd", "__EXTTOCALL=202") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:2] Set("PJSIP/202-000168fd", "__CRM_VOICEMAIL=202") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:3] Set("PJSIP/202-000168fd", "MEXTEN=202") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:4] Set("PJSIP/202-000168fd", "MMODE=NOANSWER") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:5] Set("PJSIP/202-000168fd", "RETVM=") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:6] Set("PJSIP/202-000168fd", "MODE=unavail") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:7] Macro("PJSIP/202-000168fd", "get-vmcontext,202") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-get-vmcontext:1] Set("PJSIP/202-000168fd", "VMCONTEXT=default") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf("PJSIP/202-000168fd", "0?200:300") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:8] Set("PJSIP/202-000168fd", "MODE=unavail") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:9] NoOp("PJSIP/202-000168fd", "MODE IS: unavail") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:10] GotoIf("PJSIP/202-000168fd", "1?chknomsg") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-vm,vmx,12)
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:12] GotoIf("PJSIP/202-000168fd", "0?s-NOANSWER,1") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:13] GotoIf("PJSIP/202-000168fd", "1?notdirect") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-vm,vmx,15)
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:15] NoOp("PJSIP/202-000168fd", "Checking if ext 202 is enabled: ") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [vmx@macro-vm:16] GotoIf("PJSIP/202-000168fd", "1?s-NOANSWER,1") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-vm,s-NOANSWER,1)
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s-NOANSWER@macro-vm:1] Macro("PJSIP/202-000168fd", "get-vmcontext,202") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-get-vmcontext:1] Set("PJSIP/202-000168fd", "VMCONTEXT=default") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-get-vmcontext:2] GotoIf("PJSIP/202-000168fd", "0?200:300") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-get-vmcontext,s,300)
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-get-vmcontext:300] NoOp("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] pbx.c: Executing [s-NOANSWER@macro-vm:2] VoiceMail("PJSIP/202-000168fd", "202@default,u") in new stack
[2024-02-14 07:22:27] VERBOSE[28638] res_pjsip_logger.c: <--- Transmitting SIP response (953 bytes) to UDP:10.0.100.75:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.100.75:5060;rport=5060;received=10.0.100.75;branch=z9hG4bK4eb868fb
Call-ID: 18403fee2e3af96@10.0.100.75
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com>;tag=57bd2a67-2da7-4e9f-89bb-79c74a738946
CSeq: 21 INVITE
Server: PBXact-15.0.37.4(16.30.0)
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, MESSAGE, REFER
Contact: <sip:10.40.0.1:5060>
Supported: 100rel, timer, replaces, norefersub
P-Asserted-Identity: "Jay" <sip:202@voip.mydomain.com>
Content-Type: application/sdp
Content-Length:   316

v=0
o=- 6666 379 IN IP4 10.40.0.1
s=Asterisk
c=IN IP4 10.40.0.1
t=0 0
m=audio 12740 RTP/AVP 0 8 3 2 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv

[2024-02-14 07:22:27] VERBOSE[1673][C-0000a552] file.c: <PJSIP/202-000168fd> Playing '/var/spool/asterisk/voicemail/default/202/unavail.slin' (language 'en')
[2024-02-14 07:22:27] VERBOSE[330] res_pjsip_logger.c: <--- Received SIP request (409 bytes) from UDP:10.0.100.75:5060 --->
ACK sip:10.40.0.1:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.100.75:5060;branch=z9hG4bK2702075583
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com>;tag=57bd2a67-2da7-4e9f-89bb-79c74a738946
Call-ID: 18403fee2e3af96@10.0.100.75
CSeq: 21 ACK
Contact: <sip:202@10.0.100.75:5060;transport=UDP>
Max-Forwards: 70
User-Agent: Sangoma S705 V3.0.4.88
Content-Length: 0



[2024-02-14 07:22:29] VERBOSE[18417] res_pjsip_logger.c: <--- Transmitting SIP request (411 bytes) to UDP:10.0.100.75:5060 --->
OPTIONS sip:202@10.0.100.75:5060 SIP/2.0
Via: SIP/2.0/UDP 10.40.0.1:5060;rport;branch=z9hG4bKPjcf1f3522-7a0b-4717-a952-a2a7180dcae3
From: <sip:202@10.40.0.1>;tag=86264c4a-bc76-4665-b482-66e1b0c2c208
To: <sip:202@10.0.100.75>
Contact: <sip:202@10.40.0.1:5060>
Call-ID: d93cae40-8aa7-4d0c-bb12-5a9fbb010d6c
CSeq: 40659 OPTIONS
Max-Forwards: 70
User-Agent: PBXact-15.0.37.4(16.30.0)
Content-Length:  0


[2024-02-14 07:22:29] VERBOSE[330] res_pjsip_logger.c: <--- Received SIP response (451 bytes) from UDP:10.0.100.75:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.40.0.1:5060;rport=5060;branch=z9hG4bKPjcf1f3522-7a0b-4717-a952-a2a7180dcae3
From: <sip:202@10.40.0.1>;tag=86264c4a-bc76-4665-b482-66e1b0c2c208
To: <sip:202@10.0.100.75>;tag=47bb045790ccc97
Call-ID: d93cae40-8aa7-4d0c-bb12-5a9fbb010d6c
CSeq: 40659 OPTIONS
User-Agent: Sangoma S705 V3.0.4.88
Allow: INVITE, ACK, UPDATE, INFO, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY, MESSAGE, PRACK
Content-Length: 0



[2024-02-14 07:22:33] VERBOSE[1673][C-0000a552] file.c: <PJSIP/202-000168fd> Playing 'vm-intro.ulaw' (language 'en')

[2024-02-14 07:22:39] VERBOSE[1673][C-0000a552] file.c: <PJSIP/202-000168fd> Playing 'beep.ulaw' (language 'en')
[2024-02-14 07:22:39] VERBOSE[1673][C-0000a552] app_voicemail.c: Recording the message
[2024-02-14 07:22:39] VERBOSE[1673][C-0000a552] app.c: x=0, open writing:  /var/spool/asterisk/voicemail/default/202/tmp/n7a2P0 format: wav, 0x7f2324016c00
[2024-02-14 07:22:42] VERBOSE[1805] res_pjsip_logger.c: <--- Transmitting SIP request (411 bytes) to UDP:10.0.100.82:5060 --->
OPTIONS sip:209@10.0.100.82:5060 SIP/2.0
Via: SIP/2.0/UDP 10.40.0.1:5060;rport;branch=z9hG4bKPj8aab10f2-b384-415d-b514-8c7954d86001
From: <sip:209@10.40.0.1>;tag=117a72ea-6060-4720-9c22-7a5d6a0abfb9
To: <sip:209@10.0.100.82>
Contact: <sip:209@10.40.0.1:5060>
Call-ID: 4692122f-8118-4a7b-bc42-cd5b5126b977
CSeq: 19663 OPTIONS
Max-Forwards: 70
User-Agent: PBXact-15.0.37.4(16.30.0)
Content-Length:  0





[2024-02-14 07:22:47] VERBOSE[330] res_pjsip_logger.c: <--- Received SIP request (673 bytes) from UDP:10.0.100.75:5060 --->
BYE sip:10.40.0.1:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.100.75:5060;branch=z9hG4bK2989890733
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com>;tag=57bd2a67-2da7-4e9f-89bb-79c74a738946
Call-ID: 18403fee2e3af96@10.0.100.75
CSeq: 22 BYE
Contact: <sip:202@10.0.100.75:5060;transport=UDP>
Authorization: Digest username="202", realm="asterisk", nonce="1707916932/527efcb4d132327f15465f99d9d5c5c5", uri="sip:10.40.0.1:5060", response="f642e68793fd10c6c335ae4fefa74424", algorithm=MD5, cnonce="0a4f113b", opaque="3b12f79431ea365e", qop=auth, nc=00000001
Max-Forwards: 70
User-Agent: Sangoma S705 V3.0.4.88
Content-Length: 0


[2024-02-14 07:22:47] VERBOSE[16359] res_pjsip_logger.c: <--- Transmitting SIP response (356 bytes) to UDP:10.0.100.75:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.0.100.75:5060;rport=5060;received=10.0.100.75;branch=z9hG4bK2989890733
Call-ID: 18403fee2e3af96@10.0.100.75
From: "Jay-202" <sip:202@voip.mydomain.com>;tag=8077eff6aca6f5c
To: <sip:202@voip.mydomain.com>;tag=57bd2a67-2da7-4e9f-89bb-79c74a738946
CSeq: 22 BYE
Server: PBXact-15.0.37.4(16.30.0)
Content-Length:  0


[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] app.c: User hung up
[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] app_voicemail.c: Recording was 1 seconds long but needs to be at least 3 - abandoning
[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] app_macro.c: Spawn extension (macro-vm, s-NOANSWER, 2) exited non-zero on 'PJSIP/202-000168fd' in macro 'vm'
[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] app_macro.c: Spawn extension (macro-exten-vm, s, 34) exited non-zero on 'PJSIP/202-000168fd' in macro 'exten-vm'
[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] pbx.c: Spawn extension (ext-local, 202, 3) exited non-zero on 'PJSIP/202-000168fd'
[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] pbx.c: Executing [h@ext-local:1] Macro("PJSIP/202-000168fd", "hangupcall,") in new stack
[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/202-000168fd", "1?theend") in new stack
[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/202-000168fd", "0?Set(CDR(recordingfile)=)") in new stack
[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] pbx.c: Executing [s@macro-hangupcall:4] Hangup("PJSIP/202-000168fd", "") in new stack
[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'PJSIP/202-000168fd' in macro 'hangupcall'
[2024-02-14 07:22:47] VERBOSE[1673][C-0000a552] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'PJSIP/202-000168fd'
[2024-02-14 07:22:47] VERBOSE[1690][C-0000a552] app_mixmonitor.c: MixMonitor close filestream (mixed)


[2024-02-14 07:23:30] VERBOSE[13917] asterisk.c: Remote UNIX connection disconnected