BAD [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@from-sip2:1] Gosub("SIP/7799-000019d7", "sub-ChanSpy,7703*,1(DAHDI/4,7703)") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-ChanSpy:1] Gosub("SIP/7799-000019d7", "sub-GetSourceCID,7703*,1") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:1] NoOp("SIP/7799-000019d7", "Determining the source caller ID") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:2] GotoIf("SIP/7799-000019d7", "0?11") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:3] Set("SIP/7799-000019d7", "_tech=SIP") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:4] GotoIf("SIP/7799-000019d7", "0?11") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:5] Set("SIP/7799-000019d7", "_fullchan=SIP/7799") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:6] Set("SIP/7799-000019d7", "tempchan=7799-000019d7") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:7] Set("SIP/7799-000019d7", "_realchan=7799") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:8] GotoIf("SIP/7799-000019d7", "0?dblookup") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:9] GotoIf("SIP/7799-000019d7", "1?dblookup") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Goto (sub-GetSourceCID,7703*,14) [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:14] Gosub("SIP/7799-000019d7", "sub-DBConnect,7703*,1") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-DBConnect:1] NoOp("SIP/7799-000019d7", "Connecting to DB asterisk on host localhost") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-DBConnect:2] MYSQL("SIP/7799-000019d7", "Connect connid localhost username "password" asterisk") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-DBConnect:3] GosubIf("SIP/7799-000019d7", "0?sub-die,7703*,1") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-DBConnect:4] Return("SIP/7799-000019d7", "") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:15] MYSQL("SIP/7799-000019d7", "Query resultid 1 SELECT callerid FROM sip_friends WHERE name='7799'") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:16] MYSQL("SIP/7799-000019d7", "Fetch fetchid 2 gscresult") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:17] NoOp("SIP/7799-000019d7", "FetchID: 1 gscresult: "Nathan Thomas" <7799> ConnID: 1 ResultID: 2") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:18] MYSQL("SIP/7799-000019d7", "clear 2") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:19] MYSQL("SIP/7799-000019d7", "disconnect 1") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:20] Set("SIP/7799-000019d7", "CALLERID(all)=Nathan Thomas <7799>") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:21] Set("SIP/7799-000019d7", "__src=7799") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-GetSourceCID:22] Return("SIP/7799-000019d7", "") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-ChanSpy:2] Verbose("SIP/7799-000019d7", "0,Nathan Thomas <7799> is monitoring 7703") in new stack [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] app_verbose.c: Nathan Thomas <7799> is monitoring 7703 [Oct 13 16:43:37] VERBOSE[27837][C-00001f01] pbx.c: -- Executing [7703*@sub-ChanSpy:3] ChanSpy("SIP/7799-000019d7", "DAHDI/4,qX") in new stack [Oct 13 16:43:38] VERBOSE[27837][C-00001f01] app_chanspy.c: == Spying on channel DAHDI/43-1 [Oct 13 16:43:38] NOTICE[27837][C-00001f01] app_chanspy.c: Attaching SIP/7799-000019d7 to DAHDI/43-1 [Oct 13 16:43:38] VERBOSE[27819][C-00001f00] app_dial.c: -- SIP/sotel-000019d6 is making progress passing it to DAHDI/43-1 GOOD [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@from-sip2:1] Gosub("SIP/7799-00001c95", "sub-ChanSpy,7703*,1(DAHDI/4,7703)") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-ChanSpy:1] Gosub("SIP/7799-00001c95", "sub-GetSourceCID,7703*,1") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:1] NoOp("SIP/7799-00001c95", "Determining the source caller ID") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:2] GotoIf("SIP/7799-00001c95", "0?11") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:3] Set("SIP/7799-00001c95", "_tech=SIP") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:4] GotoIf("SIP/7799-00001c95", "0?11") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:5] Set("SIP/7799-00001c95", "_fullchan=SIP/7799") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:6] Set("SIP/7799-00001c95", "tempchan=7799-00001c95") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:7] Set("SIP/7799-00001c95", "_realchan=7799") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:8] GotoIf("SIP/7799-00001c95", "0?dblookup") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:9] GotoIf("SIP/7799-00001c95", "1?dblookup") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Goto (sub-GetSourceCID,7703*,14) [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:14] Gosub("SIP/7799-00001c95", "sub-DBConnect,7703*,1") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-DBConnect:1] NoOp("SIP/7799-00001c95", "Connecting to DB asterisk on host localhost") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-DBConnect:2] MYSQL("SIP/7799-00001c95", "Connect connid localhost username "password" asterisk") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-DBConnect:3] GosubIf("SIP/7799-00001c95", "0?sub-die,7703*,1") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-DBConnect:4] Return("SIP/7799-00001c95", "") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:15] MYSQL("SIP/7799-00001c95", "Query resultid 1 SELECT callerid FROM sip_friends WHERE name='7799'") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:16] MYSQL("SIP/7799-00001c95", "Fetch fetchid 2 gscresult") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:17] NoOp("SIP/7799-00001c95", "FetchID: 1 gscresult: "Nathan Thomas" <7799> ConnID: 1 ResultID: 2") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:18] MYSQL("SIP/7799-00001c95", "clear 2") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:19] MYSQL("SIP/7799-00001c95", "disconnect 1") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:20] Set("SIP/7799-00001c95", "CALLERID(all)=Nathan Thomas <7799>") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:21] Set("SIP/7799-00001c95", "__src=7799") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-GetSourceCID:22] Return("SIP/7799-00001c95", "") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-ChanSpy:2] Verbose("SIP/7799-00001c95", "0,Nathan Thomas <7799> is monitoring 7703") in new stack [Oct 14 07:57:52] VERBOSE[16646][C-00002247] app_verbose.c: Nathan Thomas <7799> is monitoring 7703 [Oct 14 07:57:52] VERBOSE[16646][C-00002247] pbx.c: -- Executing [7703*@sub-ChanSpy:3] ChanSpy("SIP/7799-00001c95", "DAHDI/4,qX") in new stack [Oct 14 07:57:53] VERBOSE[16646][C-00002247] app_chanspy.c: == Spying on channel DAHDI/4-1 [Oct 14 07:57:53] NOTICE[16646][C-00002247] app_chanspy.c: Attaching SIP/7799-00001c95 to DAHDI/4-1 BAD [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@from-sip2:1] Gosub("SIP/7799-00001ce8", "sub-ChanSpy,7703*,1(DAHDI/4,7703)") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-ChanSpy:1] Gosub("SIP/7799-00001ce8", "sub-GetSourceCID,7703*,1") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:1] NoOp("SIP/7799-00001ce8", "Determining the source caller ID") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:2] GotoIf("SIP/7799-00001ce8", "0?11") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:3] Set("SIP/7799-00001ce8", "_tech=SIP") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:4] GotoIf("SIP/7799-00001ce8", "0?11") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:5] Set("SIP/7799-00001ce8", "_fullchan=SIP/7799") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:6] Set("SIP/7799-00001ce8", "tempchan=7799-00001ce8") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:7] Set("SIP/7799-00001ce8", "_realchan=7799") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:8] GotoIf("SIP/7799-00001ce8", "0?dblookup") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:9] GotoIf("SIP/7799-00001ce8", "1?dblookup") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Goto (sub-GetSourceCID,7703*,14) [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:14] Gosub("SIP/7799-00001ce8", "sub-DBConnect,7703*,1") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-DBConnect:1] NoOp("SIP/7799-00001ce8", "Connecting to DB asterisk on host localhost") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-DBConnect:2] MYSQL("SIP/7799-00001ce8", "Connect connid localhost username "password" asterisk") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-DBConnect:3] GosubIf("SIP/7799-00001ce8", "0?sub-die,7703*,1") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-DBConnect:4] Return("SIP/7799-00001ce8", "") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:15] MYSQL("SIP/7799-00001ce8", "Query resultid 1 SELECT callerid FROM sip_friends WHERE name='7799'") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:16] MYSQL("SIP/7799-00001ce8", "Fetch fetchid 2 gscresult") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:17] NoOp("SIP/7799-00001ce8", "FetchID: 1 gscresult: "Nathan Thomas" <7799> ConnID: 1 ResultID: 2") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:18] MYSQL("SIP/7799-00001ce8", "clear 2") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:19] MYSQL("SIP/7799-00001ce8", "disconnect 1") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:20] Set("SIP/7799-00001ce8", "CALLERID(all)=Nathan Thomas <7799>") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:21] Set("SIP/7799-00001ce8", "__src=7799") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-GetSourceCID:22] Return("SIP/7799-00001ce8", "") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-ChanSpy:2] Verbose("SIP/7799-00001ce8", "0,Nathan Thomas <7799> is monitoring 7703") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] app_verbose.c: Nathan Thomas <7799> is monitoring 7703 [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] pbx.c: -- Executing [7703*@sub-ChanSpy:3] ChanSpy("SIP/7799-00001ce8", "DAHDI/4,qX") in new stack [Oct 14 08:05:34] VERBOSE[17794][C-000022a4] app_chanspy.c: == Spying on channel DAHDI/40-1 [Oct 14 08:05:34] NOTICE[17794][C-000022a4] app_chanspy.c: Attaching SIP/7799-00001ce8 to DAHDI/40-1 BAD [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@from-sip2:1] Gosub("SIP/7799-00001d03", "sub-ChanSpy,7703*,1(DAHDI/4,7703)") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-ChanSpy:1] Gosub("SIP/7799-00001d03", "sub-GetSourceCID,7703*,1") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:1] NoOp("SIP/7799-00001d03", "Determining the source caller ID") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:2] GotoIf("SIP/7799-00001d03", "0?11") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:3] Set("SIP/7799-00001d03", "_tech=SIP") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:4] GotoIf("SIP/7799-00001d03", "0?11") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:5] Set("SIP/7799-00001d03", "_fullchan=SIP/7799") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:6] Set("SIP/7799-00001d03", "tempchan=7799-00001d03") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:7] Set("SIP/7799-00001d03", "_realchan=7799") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:8] GotoIf("SIP/7799-00001d03", "0?dblookup") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:9] GotoIf("SIP/7799-00001d03", "1?dblookup") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Goto (sub-GetSourceCID,7703*,14) [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:14] Gosub("SIP/7799-00001d03", "sub-DBConnect,7703*,1") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-DBConnect:1] NoOp("SIP/7799-00001d03", "Connecting to DB asterisk on host localhost") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-DBConnect:2] MYSQL("SIP/7799-00001d03", "Connect connid localhost username "password" asterisk") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-DBConnect:3] GosubIf("SIP/7799-00001d03", "0?sub-die,7703*,1") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-DBConnect:4] Return("SIP/7799-00001d03", "") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:15] MYSQL("SIP/7799-00001d03", "Query resultid 1 SELECT callerid FROM sip_friends WHERE name='7799'") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:16] MYSQL("SIP/7799-00001d03", "Fetch fetchid 2 gscresult") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:17] NoOp("SIP/7799-00001d03", "FetchID: 1 gscresult: "Nathan Thomas" <7799> ConnID: 1 ResultID: 2") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:18] MYSQL("SIP/7799-00001d03", "clear 2") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:19] MYSQL("SIP/7799-00001d03", "disconnect 1") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:20] Set("SIP/7799-00001d03", "CALLERID(all)=Nathan Thomas <7799>") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:21] Set("SIP/7799-00001d03", "__src=7799") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-GetSourceCID:22] Return("SIP/7799-00001d03", "") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-ChanSpy:2] Verbose("SIP/7799-00001d03", "0,Nathan Thomas <7799> is monitoring 7703") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] app_verbose.c: Nathan Thomas <7799> is monitoring 7703 [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] pbx.c: -- Executing [7703*@sub-ChanSpy:3] ChanSpy("SIP/7799-00001d03", "DAHDI/4,qXo") in new stack [Oct 14 08:09:08] VERBOSE[18318][C-000022c1] app_chanspy.c: == Spying on channel DAHDI/40-1 [Oct 14 08:09:08] NOTICE[18318][C-000022c1] app_chanspy.c: Attaching SIP/7799-00001d03 to DAHDI/40-1