Call dropped, phone dropped and no more inbound calls


#1

I think this is a network issue but I wanted to see if there is anything obvious on the Asterisk/FreePBX side that I am missing. According to the user she answered a call and parked it ##70 but never got the announcement. In the log I see “Disconnecting Call for lack of RTP activity”. The call obviously never made it to the parking lot. You can see the users hunting a pecking for it. Then one of the extensions becomes “unreachable” and ultimately the system stops taking incoming calls. The client reboots the system and it comes back to life.

The system is Asterisk 1.6.2.18.1 with FreePBX 2.8x
The RTP timeout value on the SIP settings page is 30 seconds.
Phones are Grandstream GXP2XXX with latest firmware.

The problem occurs about once a week. Can anyone give me some insight on what’s going on based on this log clipping?

[Oct 19 09:36:22] VERBOSE[30070] app_dial.c: – SIP/6045-00000394 is ringing
[Oct 19 09:36:23] VERBOSE[30070] app_dial.c: – SIP/6030-00000392 answered DAHDI/2-1
[Oct 19 09:36:23] VERBOSE[22418] chan_sip.c: == Extension Changed 6030[ext-local] new state InUse for Notify User 6045
[Oct 19 09:36:23] VERBOSE[22418] chan_sip.c: == Extension Changed 6060[ext-local] new state Idle for Notify User 6045
[Oct 19 09:36:23] VERBOSE[30070] pbx.c: – Executing [s@macro-auto-blkvm:1] Set(“SIP/6030-00000392”, “__MACRO_RESULT=”) in new stack
[Oct 19 09:36:23] VERBOSE[30070] pbx.c: – Executing [s@macro-auto-blkvm:2] NoOp(“SIP/6030-00000392”, “Deleting: BLKVM/7005/DAHDI/2-1 TRUE”) in new stack
[Oct 19 09:36:23] VERBOSE[22418] chan_sip.c: == Extension Changed 6055[ext-local] new state Idle for Notify User 6045
[Oct 19 09:36:23] VERBOSE[22418] chan_sip.c: == Extension Changed 6035[ext-local] new state Idle for Notify User 6045
[Oct 19 09:36:23] VERBOSE[22418] chan_sip.c: == Extension Changed 6025[ext-local] new state Idle for Notify User 6045
[Oct 19 09:36:23] VERBOSE[22418] chan_sip.c: == Extension Changed 6020[ext-local] new state Idle for Notify User 6045
[Oct 19 09:36:23] VERBOSE[22418] chan_sip.c: == Extension Changed 6015[ext-local] new state Idle for Notify User 6045
[Oct 19 09:36:23] VERBOSE[22418] chan_sip.c: == Extension Changed 6010[ext-local] new state InUse for Notify User 6045
[Oct 19 09:36:23] VERBOSE[22418] chan_sip.c: == Extension Changed 6005[ext-local] new state Idle for Notify User 6045
[Oct 19 09:36:54] NOTICE[22424] chan_sip.c: Disconnecting call ‘SIP/6030-00000392’ for lack of RTP activity in 31 seconds
[Oct 19 09:37:00] VERBOSE[22424] netsock.c: == Using SIP RTP TOS bits 184
[Oct 19 09:37:00] VERBOSE[22424] netsock.c: == Using SIP RTP CoS mark 5
[Oct 19 09:37:00] VERBOSE[30075] pbx.c: – Executing [71@from-internal:1] ParkedCall(“SIP/6030-00000398”, “71”) in new stack
[Oct 19 09:37:00] VERBOSE[30075] file.c: – Playing ‘pbx-invalidpark.gsm’ (language ‘en’)
[Oct 19 09:37:03] WARNING[30075] features.c: ast_streamfile of pbx-invalidpark failed on SIP/6030-00000398
[Oct 19 09:37:03] VERBOSE[30075] features.c: – Channel SIP/6030-00000398 tried to talk to nonexistent parked call 71
[Oct 19 09:37:03] VERBOSE[30075] pbx.c: == Spawn extension (from-internal, 71, 1) exited non-zero on ‘SIP/6030-00000398’
[Oct 19 09:37:03] VERBOSE[30075] pbx.c: – Executing [h@from-internal:1] Macro(“SIP/6030-00000398”, “hangupcall”) in new stack
[Oct 19 09:37:03] VERBOSE[30075] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/6030-00000398”, “1?skiprg”) in new stack
[Oct 19 09:37:03] VERBOSE[30075] pbx.c: – Goto (macro-hangupcall,s,4)
[Oct 19 09:37:03] VERBOSE[30075] pbx.c: – Executing [s@macro-hangupcall:4] GotoIf(“SIP/6030-00000398”, “1?skipblkvm”) in new stack
[Oct 19 09:37:03] VERBOSE[30075] pbx.c: – Goto (macro-hangupcall,s,7)
[Oct 19 09:37:03] VERBOSE[30075] pbx.c: – Executing [s@macro-hangupcall:7] GotoIf(“SIP/6030-00000398”, “1?theend”) in new stack
[Oct 19 09:37:03] VERBOSE[30075] pbx.c: – Goto (macro-hangupcall,s,9)
[Oct 19 09:37:03] VERBOSE[30075] pbx.c: – Executing [s@macro-hangupcall:9] Hangup(“SIP/6030-00000398”, “”) in new stack
[Oct 19 09:37:03] VERBOSE[30075] app_macro.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on ‘SIP/6030-00000398’ in macro ‘hangupcall’
[Oct 19 09:37:03] VERBOSE[30075] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/6030-00000398’
[Oct 19 09:37:38] VERBOSE[22424] netsock.c: == Using SIP RTP TOS bits 184
[Oct 19 09:37:38] VERBOSE[22424] netsock.c: == Using SIP RTP CoS mark 5
[Oct 19 09:37:38] VERBOSE[30076] pbx.c: – Executing [71@from-internal:1] ParkedCall(“SIP/6010-00000399”, “71”) in new stack
[Oct 19 09:37:38] VERBOSE[30076] file.c: – Playing ‘pbx-invalidpark.gsm’ (language ‘en’)
[Oct 19 09:37:41] WARNING[30076] features.c: ast_streamfile of pbx-invalidpark failed on SIP/6010-00000399
[Oct 19 09:37:41] VERBOSE[30076] features.c: – Channel SIP/6010-00000399 tried to talk to nonexistent parked call 71
[Oct 19 09:37:41] VERBOSE[30076] pbx.c: == Spawn extension (from-internal, 71, 1) exited non-zero on ‘SIP/6010-00000399’
[Oct 19 09:37:41] VERBOSE[30076] pbx.c: – Executing [h@from-internal:1] Macro(“SIP/6010-00000399”, “hangupcall”) in new stack
[Oct 19 09:37:41] VERBOSE[30076] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/6010-00000399”, “1?skiprg”) in new stack
[Oct 19 09:37:41] VERBOSE[30076] pbx.c: – Goto (macro-hangupcall,s,4)
[Oct 19 09:37:41] VERBOSE[30076] pbx.c: – Executing [s@macro-hangupcall:4] GotoIf(“SIP/6010-00000399”, “1?skipblkvm”) in new stack
[Oct 19 09:37:41] VERBOSE[30076] pbx.c: – Goto (macro-hangupcall,s,7)
[Oct 19 09:37:41] VERBOSE[30076] pbx.c: – Executing [s@macro-hangupcall:7] GotoIf(“SIP/6010-00000399”, “1?theend”) in new stack
[Oct 19 09:37:41] VERBOSE[30076] pbx.c: – Goto (macro-hangupcall,s,9)
[Oct 19 09:37:41] VERBOSE[30076] pbx.c: – Executing [s@macro-hangupcall:9] Hangup(“SIP/6010-00000399”, “”) in new stack
[Oct 19 09:37:41] VERBOSE[30076] app_macro.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on ‘SIP/6010-00000399’ in macro ‘hangupcall’
[Oct 19 09:37:41] VERBOSE[30076] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/6010-00000399’
[Oct 19 09:37:55] VERBOSE[22424] netsock.c: == Using SIP RTP TOS bits 184
[Oct 19 09:37:55] VERBOSE[22424] netsock.c: == Using SIP RTP CoS mark 5
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [3761031@from-internal:1] Macro(“SIP/6010-0000039a”, “user-callerid,SKIPTTL,”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/6010-0000039a”, “AMPUSER=6010”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:2] GotoIf(“SIP/6010-0000039a”, “0?report”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:3] ExecIf(“SIP/6010-0000039a”, “1?Set(REALCALLERIDNUM=6010)”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:4] Set(“SIP/6010-0000039a”, “AMPUSER=6010”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/6010-0000039a”, “AMPUSERCIDNAME=ScreenPlay 2-1”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/6010-0000039a”, “0?report”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:7] Set(“SIP/6010-0000039a”, “AMPUSERCID=6010”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:8] Set(“SIP/6010-0000039a”, “CALLERID(all)=“ScreenPlay 2-1” <6010>”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:9] ExecIf(“SIP/6010-0000039a”, “0?Set(CHANNEL(language)=)”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:10] GotoIf(“SIP/6010-0000039a”, “1?continue”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Goto (macro-user-callerid,s,19)
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:19] Set(“SIP/6010-0000039a”, “CALLERID(number)=6010”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:20] Set(“SIP/6010-0000039a”, “CALLERID(name)=ScreenPlay 2-1”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [s@macro-user-callerid:21] NoOp(“SIP/6010-0000039a”, “Using CallerID “ScreenPlay 2-1” <6010>”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [3761031@from-internal:2] Set(“SIP/6010-0000039a”, “_NODEST=”) in new stack
[Oct 19 09:37:55] VERBOSE[30078] pbx.c: – Executing [3761031@from-internal:3] Macro(“SIP/6010-0000039a”, “record-enable,6010,OUT,”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-record-enable:1] GotoIf(“SIP/6010-0000039a”, “1?check”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Goto (macro-record-enable,s,4)
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-record-enable:4] ExecIf(“SIP/6010-0000039a”, “0?MacroExit()”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-record-enable:5] GotoIf(“SIP/6010-0000039a”, “0?Group:OUT”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Goto (macro-record-enable,s,15)
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-record-enable:15] GotoIf(“SIP/6010-0000039a”, “0?IN”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-record-enable:16] ExecIf(“SIP/6010-0000039a”, “1?MacroExit()”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [3761031@from-internal:4] Macro(“SIP/6010-0000039a”, “dialout-trunk,1,3761031,”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:1] Set(“SIP/6010-0000039a”, “DIAL_TRUNK=1”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/6010-0000039a”, “0?sub-pincheck,s,1”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/6010-0000039a”, “0?disabletrunk,1”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:4] Set(“SIP/6010-0000039a”, “DIAL_NUMBER=3761031”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:5] Set(“SIP/6010-0000039a”, “DIAL_TRUNK_OPTIONS=tTrwW”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:6] Set(“SIP/6010-0000039a”, “OUTBOUND_GROUP=OUT_1”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/6010-0000039a”, “1?nomax”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Goto (macro-dialout-trunk,s,9)
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/6010-0000039a”, “0?skipoutcid”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:10] Set(“SIP/6010-0000039a”, “DIAL_TRUNK_OPTIONS=tTwW”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:11] Macro(“SIP/6010-0000039a”, “outbound-callerid,1”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/6010-0000039a”, “0?Set(CALLERPRES()=)”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/6010-0000039a”, “0?Set(REALCALLERIDNUM=6010)”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-outbound-callerid:3] GotoIf(“SIP/6010-0000039a”, “1?normcid”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Goto (macro-outbound-callerid,s,6)
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-outbound-callerid:6] Set(“SIP/6010-0000039a”, “USEROUTCID=”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-outbound-callerid:7] Set(“SIP/6010-0000039a”, “EMERGENCYCID=”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-outbound-callerid:8] Set(“SIP/6010-0000039a”, “TRUNKOUTCID=”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-outbound-callerid:9] GotoIf(“SIP/6010-0000039a”, “1?trunkcid”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Goto (macro-outbound-callerid,s,12)
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-outbound-callerid:12] ExecIf(“SIP/6010-0000039a”, “0?Set(CALLERID(all)=)”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-outbound-callerid:13] ExecIf(“SIP/6010-0000039a”, “0?Set(CALLERID(all)=)”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-outbound-callerid:14] ExecIf(“SIP/6010-0000039a”, “0?Set(CALLERID(all)=)”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/6010-0000039a”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:12] ExecIf(“SIP/6010-0000039a”, “0?AGI(fixlocalprefix)”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:13] Set(“SIP/6010-0000039a”, “OUTNUM=ww3761031”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:14] Set(“SIP/6010-0000039a”, “custom=DAHDI/g0”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/6010-0000039a”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^)tTwW)”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:16] Macro(“SIP/6010-0000039a”, “dialout-trunk-predial-hook,”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/6010-0000039a”, “”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:17] GotoIf(“SIP/6010-0000039a”, “0?bypass,1”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/6010-0000039a”, “0?customtrunk”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] pbx.c: – Executing [s@macro-dialout-trunk:19] Dial(“SIP/6010-0000039a”, “DAHDI/g0/ww3761031,300,tTwW”) in new stack
[Oct 19 09:37:56] VERBOSE[30078] app_dial.c: – Called g0/ww3761031
[Oct 19 09:37:59] VERBOSE[30078] app_dial.c: – DAHDI/3-1 answered SIP/6010-0000039a
[Oct 19 09:39:19] VERBOSE[30078] pbx.c: – Executing [h@macro-dialout-trunk:1] Macro(“SIP/6010-0000039a”, “hangupcall,”) in new stack
[Oct 19 09:39:19] VERBOSE[30078] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/6010-0000039a”, “1?skiprg”) in new stack
[Oct 19 09:39:19] VERBOSE[30078] pbx.c: – Goto (macro-hangupcall,s,4)
[Oct 19 09:39:19] VERBOSE[30078] pbx.c: – Executing [s@macro-hangupcall:4] GotoIf(“SIP/6010-0000039a”, “1?skipblkvm”) in new stack
[Oct 19 09:39:19] VERBOSE[30078] pbx.c: – Goto (macro-hangupcall,s,7)
[Oct 19 09:39:19] VERBOSE[30078] pbx.c: – Executing [s@macro-hangupcall:7] GotoIf(“SIP/6010-0000039a”, “1?theend”) in new stack
[Oct 19 09:39:19] VERBOSE[30078] pbx.c: – Goto (macro-hangupcall,s,9)
[Oct 19 09:39:19] VERBOSE[30078] pbx.c: – Executing [s@macro-hangupcall:9] Hangup(“SIP/6010-0000039a”, “”) in new stack
[Oct 19 09:39:19] VERBOSE[30078] app_macro.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on ‘SIP/6010-0000039a’ in macro ‘hangupcall’
[Oct 19 09:39:19] VERBOSE[30078] chan_dahdi.c: – Hungup ‘DAHDI/3-1’
[Oct 19 09:39:19] VERBOSE[30078] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 19) exited non-zero on ‘SIP/6010-0000039a’ in macro ‘dialout-trunk’
[Oct 19 09:39:19] VERBOSE[30078] pbx.c: == Spawn extension (from-internal, 3761031, 4) exited non-zero on ‘SIP/6010-0000039a’
[Oct 19 09:40:31] NOTICE[22424] chan_sip.c: Peer ‘6045’ is now UNREACHABLE! Last qualify: 44
[Oct 19 09:40:36] NOTICE[22424] chan_sip.c: Peer ‘6046’ is now UNREACHABLE! Last qualify: 43

[Oct 19 09:40:55] VERBOSE[22424] chan_sip.c: – Registered SIP ‘6045’ at 192.168.200.249 port 38993
[Oct 19 09:40:55] NOTICE[22424] chan_sip.c: Peer ‘6045’ is now Reachable. (38ms / 2000ms)
[Oct 19 09:40:56] VERBOSE[22424] chan_sip.c: – Registered SIP ‘6046’ at 192.168.200.249 port 46007
[Oct 19 09:40:56] NOTICE[22424] chan_sip.c: Peer ‘6046’ is now Reachable. (35ms / 2000ms)
[Oct 19 09:41:27] VERBOSE[22424] netsock.c: == Using SIP RTP TOS bits 184
[Oct 19 09:41:27] VERBOSE[22424] netsock.c: == Using SIP RTP CoS mark 5
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [6010@from-internal:1] Macro(“SIP/6045-0000039b”, “exten-vm,6010,6010”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-exten-vm:1] Macro(“SIP/6045-0000039b”, “user-callerid,”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/6045-0000039b”, “AMPUSER=6045”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:2] GotoIf(“SIP/6045-0000039b”, “0?report”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:3] ExecIf(“SIP/6045-0000039b”, “1?Set(REALCALLERIDNUM=6045)”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:4] Set(“SIP/6045-0000039b”, “AMPUSER=6045”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/6045-0000039b”, “AMPUSERCIDNAME=ScreenPlay Main1”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/6045-0000039b”, “0?report”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:7] Set(“SIP/6045-0000039b”, “AMPUSERCID=6045”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:8] Set(“SIP/6045-0000039b”, “CALLERID(all)=“ScreenPlay Main1” <6045>”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:9] ExecIf(“SIP/6045-0000039b”, “0?Set(CHANNEL(language)=)”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:10] GotoIf(“SIP/6045-0000039b”, “0?continue”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:11] Set(“SIP/6045-0000039b”, “__TTL=64”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Executing [s@macro-user-callerid:12] GotoIf(“SIP/6045-0000039b”, “1?continue”) in new stack
[Oct 19 09:41:27] VERBOSE[30115] pbx.c: – Goto (macro-user-callerid,s,19)