[Home]

Summary:ASTERISK-24443: CDR fields (dst, dcontext) empty in transfer call started from Macro
Reporter:Arveno Santoro (eco)Labels:
Date Opened:2014-10-20 09:13:47Date Closed:2015-06-14 11:05:26
Priority:MajorRegression?
Status:Closed/CompleteComponents:CDR/General
Versions:12.6.0 Frequency of
Occurrence
Constant
Related
Issues:
Environment:Debian wheezyAttachments:( 0) ASTERISK-24443-12.diff
( 1) cdrlog.txt
Description:Hi there,
I have installed Asterisk version 12.6 (on Debian wheezy) and I note
that, only when I make a transfer of call (attended or unattended),
the fields 'dst' and 'dcontex' in the CDR are empty.
This happen both in MySQL record and in CVS.

Below the log of the transfered call.

\[edit: mjordan\]

Removed inline log file.
Comments:By: Matt Jordan (mjordan) 2014-12-06 22:15:00.532-0600

[~eco]: Attached is a patch which should fix this for Asterisk 12. It will force the {{dst}}/{{dcontext}} fields to be updated even when a Macro is present, if we have not yet recorded a {{dst}}/{{dcontext}} field.

If you could test and make sure it fixes the problem with the dialplan that reproduced the problem, that'd be appreciated. Thanks!

By: Rusty Newton (rnewton) 2014-12-22 18:07:49.219-0600

Arveno, we haven't heard back from you, but I know it is the Holidays. I'm going to leave this open for a while hoping you are able to test the patch. :)

By: Perssy Llamosas (pll) 2015-01-07 19:50:57.142-0600

I happen to have the same issue. Running Asterisk 13.1.0

Dialplan is simple:
{code}
[from-pstn]
exten => _X.,1,Macro(dial-queue,myqueue)

[macro-dial-queue]
exten => s,1,Set(CHANNEL(amaflags)=BILLING)
exten => s,n,Ringing
exten => s,n,Queue(${ARG1},t)
{code}

Applying the patch, the CDR generated:
|| calldate | uniqueid | dst | dcontext | channel | dstchanne ||
| 2015-01-07 20:42:26 | 1420681346.8 | 999999 | from-pstn | DAHDI/3-1 | SIP/03-00000006 |
| 2015-01-07 20:42:30 | 1420681346.8 | s | macro-dial-queue | DAHDI/3-1 | SIP/04-00000007 |
| 2015-01-07 20:42:30 | 1420681346.8 | s | macro-dial-queue | DAHDI/3-1 | SIP/01-00000008 |

Only one line has the correct dst/dcontext, the rest is empty without the patch or wrong with the patch.

By: Matt Jordan (mjordan) 2015-01-19 12:39:42.075-0600

[~pll]: Was that a parallel dial that occurred? Can you provide a log with 'cdr set debug on' enabled?

By: Perssy Llamosas (pll) 2015-01-19 16:05:30.096-0600

Yes, it was a parallel dial. I managed to do the simplest Asterisk install, I can reproduce the error always.
Important files:
{code:title=cdr.conf|borderStyle=solid}
[general]
enable=yes
unanswered=yes
congestion=no
endbeforehexten=yes
batch=no

[csv]
usegmtime=yes
loguniqueid=yes
loguserfield=yes
accountlogs=no
{code}

{code:title=users.conf|borderStyle=solid}
[general]
hassip=yes
context=default

[9995]
secret=9999
type=friend
host=dynamic

[9996]
secret=9999
type=friend
host=dynamic

[9997]
secret=9999
type=friend
host=dynamic

[9998]
secret=9999
type=friend
host=dynamic

[9999]
secret=9999
type=friend
host=dynamic
{code}

{code:title=extensions.conf|borderStyle=solid}
[default]
exten => s,1,Macro(dial-queue,test)

[macro-dial-queue]
exten => s,1,Queue(${ARG1},t)
{code}

{code:title=queue.conf|borderStyle=solid}
[test]
strategy=ringall
ringinuse=yes
member=>sip/9995
member=>sip/9996
member=>sip/9997
member=>sip/9998
member=>sip/9999
{code}

I called to the queue, did a hangup in each phone, then answered one. Output from Master.csv:
||src||dst||dcontext||clid||channel||dstchannel||lastapp||lastdata||start||answer||end||d||b||disposition||uniqueid||
|9999|s|default|Operador <9999>|SIP/9999-00000000|SIP/9997-00000001|Queue|test,t|2015-01-19 21:37:13| |2015-01-19 21:37:19|6|0|BUSY|1421703433.0|
|9999| | |Operador <9999>|SIP/9999-00000000|SIP/9996-00000002|Queue|test,t|2015-01-19 21:37:13| |2015-01-19 21:37:19|5|0|BUSY|1421703433.0|
|9999| | |Operador <9999>|SIP/9999-00000000|SIP/9999-00000003|Queue|test,t|2015-01-19 21:37:13| |2015-01-19 21:37:20|6|0|BUSY|1421703433.0|
|9999| | |Operador <9999>|SIP/9999-00000000|SIP/9995-00000004|Queue|test,t|2015-01-19 21:37:13| |2015-01-19 21:37:18|5|0|BUSY|1421703433.0|
|9999| | |Operador <9999>|SIP/9999-00000000|SIP/9998-00000005|Queue|test,t|2015-01-19 21:37:13| |2015-01-19 21:37:20|6|0|BUSY|1421703433.0|
|9999| | |Operador <9999>|SIP/9999-00000000|SIP/9997-00000006|Queue|test,t|2015-01-19 21:37:25| |2015-01-19 21:37:36|10|0|NO ANSWER|1421703433.0|
|9999| | |Operador <9999>|SIP/9999-00000000|SIP/9996-00000007|Queue|test,t|2015-01-19 21:37:25| |2015-01-19 21:37:36|10|0|NO ANSWER|1421703433.0|
|9999| | |Operador <9999>|SIP/9999-00000000|SIP/9999-00000008|Queue|test,t|2015-01-19 21:37:25| |2015-01-19 21:37:36|10|0|NO ANSWER|1421703433.0|
|9999| | |Operador <9999>|SIP/9999-00000000|SIP/9995-00000009|Queue|test,t|2015-01-19 21:37:25|2015-01-19 21:37:36|2015-01-19 21:38:08|42|32|ANSWERED|1421703433.0|
|9999| | |Operador <9999>|SIP/9999-00000000|SIP/9998-0000000a|Queue|test,t|2015-01-19 21:37:25| |2015-01-19 21:37:36|10|0|NO ANSWER|1421703433.0|

This is the log in console with 'cdr set debug on'
{code:title=Console|borderStyle=solid}
  == Using SIP RTP CoS mark 5
0x7f6d28000978 - Created CDR for channel SIP/9999-00000000
0x7f6d28000978 - Transitioning CDR for SIP/9999-00000000 from state NONE to Single
   -- Executing [s@default:1] Macro("SIP/9999-00000000", "dial-queue,test") in new stack
   -- Executing [s@macro-dial-queue:1] Queue("SIP/9999-00000000", "test,t") in new stack
   -- Music class  requested but no musiconhold loaded.
 == Using SIP RTP CoS mark 5
0x7f6d28001a28 - Created CDR for channel SIP/9997-00000001
0x7f6d28001a28 - Transitioning CDR for SIP/9997-00000001 from state NONE to Single
Dial Begin message for SIP/9999-00000000, SIP/9997-00000001: 1421703433.00899160
0x7f6d28000978 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9997-00000001
0x7f6d28000978 - Updated Party A SIP/9999-00000000 snapshot
0x7f6d28000978 - Updated Party B SIP/9997-00000001 snapshot
0x7f6d28000978 - Transitioning CDR for SIP/9999-00000000 from state Single to Dial
   -- Called sip/9997
 == Using SIP RTP CoS mark 5
0x7f6d28001f58 - Created CDR for channel SIP/9996-00000002
0x7f6d28001f58 - Transitioning CDR for SIP/9996-00000002 from state NONE to Single
Dial Begin message for SIP/9999-00000000, SIP/9996-00000002: 1421703433.00899980
0x7f6d28000978 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9996-00000002
0x7f6d280030b8 - Created CDR for channel SIP/9999-00000000
0x7f6d280030b8 - Transitioning CDR for SIP/9999-00000000 from state NONE to Single
0x7f6d280030b8 - Updated Party A SIP/9999-00000000 snapshot
0x7f6d280030b8 - Updated Party B SIP/9996-00000002 snapshot
0x7f6d280030b8 - Transitioning CDR for SIP/9999-00000000 from state Single to Dial
   -- Called sip/9996
 == Using SIP RTP CoS mark 5
0x7f6d28002488 - Created CDR for channel SIP/9999-00000003
0x7f6d28002488 - Transitioning CDR for SIP/9999-00000003 from state NONE to Single
Dial Begin message for SIP/9999-00000000, SIP/9999-00000003: 1421703433.00900876
0x7f6d28000978 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9999-00000003
0x7f6d280030b8 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9999-00000003
0x7f6d28003da8 - Created CDR for channel SIP/9999-00000000
0x7f6d28003da8 - Transitioning CDR for SIP/9999-00000000 from state NONE to Single
0x7f6d28003da8 - Updated Party A SIP/9999-00000000 snapshot
0x7f6d28003da8 - Updated Party B SIP/9999-00000003 snapshot
0x7f6d28003da8 - Transitioning CDR for SIP/9999-00000000 from state Single to Dial
   -- Called sip/9999
 == Using SIP RTP CoS mark 5
0x7f6d28002cd8 - Created CDR for channel SIP/9995-00000004
0x7f6d28002cd8 - Transitioning CDR for SIP/9995-00000004 from state NONE to Single
Dial Begin message for SIP/9999-00000000, SIP/9995-00000004: 1421703433.00901695
0x7f6d28000978 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9995-00000004
0x7f6d280030b8 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9995-00000004
0x7f6d28003da8 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9995-00000004
0x7f6d280052b8 - Created CDR for channel SIP/9999-00000000
0x7f6d280052b8 - Transitioning CDR for SIP/9999-00000000 from state NONE to Single
0x7f6d280052b8 - Updated Party A SIP/9999-00000000 snapshot
0x7f6d280052b8 - Updated Party B SIP/9995-00000004 snapshot
0x7f6d280052b8 - Transitioning CDR for SIP/9999-00000000 from state Single to Dial
   -- Called sip/9995
 == Using SIP RTP CoS mark 5
0x7f6d280037c8 - Created CDR for channel SIP/9998-00000005
0x7f6d280037c8 - Transitioning CDR for SIP/9998-00000005 from state NONE to Single
Dial Begin message for SIP/9999-00000000, SIP/9998-00000005: 1421703433.00902544
0x7f6d28000978 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9998-00000005
0x7f6d280030b8 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9998-00000005
0x7f6d28003da8 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9998-00000005
0x7f6d280052b8 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9998-00000005
0x7f6d280061a8 - Created CDR for channel SIP/9999-00000000
0x7f6d280061a8 - Transitioning CDR for SIP/9999-00000000 from state NONE to Single
0x7f6d280061a8 - Updated Party A SIP/9999-00000000 snapshot
0x7f6d280061a8 - Updated Party B SIP/9998-00000005 snapshot
0x7f6d280061a8 - Transitioning CDR for SIP/9999-00000000 from state Single to Dial
   -- Called sip/9998
   -- SIP/9998-00000005 connected line has changed. Saving it until answer for SIP/9999-00000000
   -- SIP/9995-00000004 connected line has changed. Saving it until answer for SIP/9999-00000000
   -- SIP/9999-00000003 connected line has changed. Saving it until answer for SIP/9999-00000000
   -- SIP/9996-00000002 connected line has changed. Saving it until answer for SIP/9999-00000000
   -- SIP/9997-00000001 connected line has changed. Saving it until answer for SIP/9999-00000000
   -- SIP/9999-00000003 is ringing
   -- SIP/9998-00000005 is ringing
   -- SIP/9997-00000001 is ringing
   -- SIP/9996-00000002 is ringing
   -- SIP/9995-00000004 is ringing
   -- Got SIP response 603 "Decline" back from 127.0.0.1:5070
   -- SIP/9995-00000004 is busy
Dial End message for SIP/9999-00000000, SIP/9995-00000004: 1421703438.00916347
0x7f6d28000978 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9995-00000004
0x7f6d280030b8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9995-00000004
0x7f6d28003da8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9995-00000004
0x7f6d280052b8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9995-00000004
0x7f6d280052b8 - Transitioning CDR for SIP/9999-00000000 from state Dial to Finalized
0x7f6d280061a8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9995-00000004
   -- Nobody picked up in 5000 ms
0x7f6d28002cd8 - Transitioning CDR for SIP/9995-00000004 from state Single to Finalized
0x7f6d28002cd8 - Beginning finalize/dispatch for SIP/9995-00000004
0x7f6d28002cd8 - Dispatching CDR for Party A SIP/9995-00000004, Party B <none>
   -- Got SIP response 603 "Decline" back from 127.0.0.1:5068
   -- SIP/9996-00000002 is busy
Dial End message for SIP/9999-00000000, SIP/9996-00000002: 1421703439.00659827
0x7f6d28000978 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9996-00000002
0x7f6d280030b8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9996-00000002
0x7f6d280030b8 - Transitioning CDR for SIP/9999-00000000 from state Dial to Finalized
0x7f6d28003da8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9996-00000002
0x7f6d280061a8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9996-00000002
   -- Nobody picked up in 6000 ms
0x7f6d28001f58 - Transitioning CDR for SIP/9996-00000002 from state Single to Finalized
0x7f6d28001f58 - Beginning finalize/dispatch for SIP/9996-00000002
0x7f6d28001f58 - Dispatching CDR for Party A SIP/9996-00000002, Party B <none>
   -- Got SIP response 603 "Decline" back from 127.0.0.1:5066
   -- SIP/9997-00000001 is busy
Dial End message for SIP/9999-00000000, SIP/9997-00000001: 1421703439.00975240
0x7f6d28000978 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9997-00000001
0x7f6d28000978 - Transitioning CDR for SIP/9999-00000000 from state Dial to Finalized
0x7f6d28003da8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9997-00000001
0x7f6d280061a8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9997-00000001
   -- Nobody picked up in 6000 ms
0x7f6d28001a28 - Transitioning CDR for SIP/9997-00000001 from state Single to Finalized
0x7f6d28001a28 - Beginning finalize/dispatch for SIP/9997-00000001
0x7f6d28001a28 - Dispatching CDR for Party A SIP/9997-00000001, Party B <none>
   -- Got SIP response 603 "Decline" back from 127.0.0.1:5064
   -- SIP/9998-00000005 is busy
Dial End message for SIP/9999-00000000, SIP/9998-00000005: 1421703440.00175778
0x7f6d28003da8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9998-00000005
0x7f6d280061a8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9998-00000005
0x7f6d280061a8 - Transitioning CDR for SIP/9999-00000000 from state Dial to Finalized
   -- Nobody picked up in 7000 ms
0x7f6d280037c8 - Transitioning CDR for SIP/9998-00000005 from state Single to Finalized
0x7f6d280037c8 - Beginning finalize/dispatch for SIP/9998-00000005
0x7f6d280037c8 - Dispatching CDR for Party A SIP/9998-00000005, Party B <none>
   -- Got SIP response 603 "Decline" back from 127.0.0.1:5062
   -- SIP/9999-00000003 is busy
Dial End message for SIP/9999-00000000, SIP/9999-00000003: 1421703440.00398921
0x7f6d28003da8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9999-00000003
0x7f6d28003da8 - Transitioning CDR for SIP/9999-00000000 from state Dial to Finalized
   -- Nobody picked up in 7000 ms
0x7f6d28002488 - Transitioning CDR for SIP/9999-00000003 from state Single to Finalized
0x7f6d28002488 - Beginning finalize/dispatch for SIP/9999-00000003
0x7f6d28002488 - Dispatching CDR for Party A SIP/9999-00000003, Party B <none>
 == Using SIP RTP CoS mark 5
0x7f6d28005608 - Created CDR for channel SIP/9997-00000006
0x7f6d28005608 - Transitioning CDR for SIP/9997-00000006 from state NONE to Single
Dial Begin message for SIP/9999-00000000, SIP/9997-00000006: 1421703445.00405322
0x7f6d28002c48 - Created CDR for channel SIP/9999-00000000
0x7f6d28002c48 - Transitioning CDR for SIP/9999-00000000 from state NONE to Single
0x7f6d28002c48 - Updated Party A SIP/9999-00000000 snapshot
0x7f6d28002c48 - Updated Party B SIP/9997-00000006 snapshot
0x7f6d28002c48 - Transitioning CDR for SIP/9999-00000000 from state Single to Dial
   -- Called sip/9997
 == Using SIP RTP CoS mark 5
0x7f6d280037c8 - Created CDR for channel SIP/9996-00000007
0x7f6d280037c8 - Transitioning CDR for SIP/9996-00000007 from state NONE to Single
Dial Begin message for SIP/9999-00000000, SIP/9996-00000007: 1421703445.00406121
0x7f6d28002c48 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9996-00000007
0x7f6d28005e58 - Created CDR for channel SIP/9999-00000000
0x7f6d28005e58 - Transitioning CDR for SIP/9999-00000000 from state NONE to Single
0x7f6d28005e58 - Updated Party A SIP/9999-00000000 snapshot
0x7f6d28005e58 - Updated Party B SIP/9996-00000007 snapshot
0x7f6d28005e58 - Transitioning CDR for SIP/9999-00000000 from state Single to Dial
   -- Called sip/9996
 == Using SIP RTP CoS mark 5
0x7f6d28001a28 - Created CDR for channel SIP/9999-00000008
0x7f6d28001a28 - Transitioning CDR for SIP/9999-00000008 from state NONE to Single
Dial Begin message for SIP/9999-00000000, SIP/9999-00000008: 1421703445.00412743
0x7f6d28002c48 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9999-00000008
0x7f6d28005e58 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9999-00000008
0x7f6d280046b8 - Created CDR for channel SIP/9999-00000000
0x7f6d280046b8 - Transitioning CDR for SIP/9999-00000000 from state NONE to Single
0x7f6d280046b8 - Updated Party A SIP/9999-00000000 snapshot
0x7f6d280046b8 - Updated Party B SIP/9999-00000008 snapshot
0x7f6d280046b8 - Transitioning CDR for SIP/9999-00000000 from state Single to Dial
   -- Called sip/9999
 == Using SIP RTP CoS mark 5
0x7f6d28001e28 - Created CDR for channel SIP/9995-00000009
0x7f6d28001e28 - Transitioning CDR for SIP/9995-00000009 from state NONE to Single
Dial Begin message for SIP/9999-00000000, SIP/9995-00000009: 1421703445.00413605
0x7f6d28002c48 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9995-00000009
0x7f6d28005e58 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9995-00000009
0x7f6d280046b8 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9995-00000009
0x7f6d28007278 - Created CDR for channel SIP/9999-00000000
0x7f6d28007278 - Transitioning CDR for SIP/9999-00000000 from state NONE to Single
0x7f6d28007278 - Updated Party A SIP/9999-00000000 snapshot
0x7f6d28007278 - Updated Party B SIP/9995-00000009 snapshot
0x7f6d28007278 - Transitioning CDR for SIP/9999-00000000 from state Single to Dial
   -- Called sip/9995
 == Using SIP RTP CoS mark 5
0x7f6d280042d8 - Created CDR for channel SIP/9998-0000000a
0x7f6d280042d8 - Transitioning CDR for SIP/9998-0000000a from state NONE to Single
Dial Begin message for SIP/9999-00000000, SIP/9998-0000000a: 1421703445.00414454
0x7f6d28002c48 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9998-0000000a
0x7f6d28005e58 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9998-0000000a
0x7f6d280046b8 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9998-0000000a
0x7f6d28007278 - Processing Dial Begin message for channel SIP/9999-00000000, peer SIP/9998-0000000a
0x7f6d28008168 - Created CDR for channel SIP/9999-00000000
0x7f6d28008168 - Transitioning CDR for SIP/9999-00000000 from state NONE to Single
0x7f6d28008168 - Updated Party A SIP/9999-00000000 snapshot
0x7f6d28008168 - Updated Party B SIP/9998-0000000a snapshot
0x7f6d28008168 - Transitioning CDR for SIP/9999-00000000 from state Single to Dial
   -- Called sip/9998
   -- SIP/9998-0000000a connected line has changed. Saving it until answer for SIP/9999-00000000
   -- SIP/9995-00000009 connected line has changed. Saving it until answer for SIP/9999-00000000
   -- SIP/9999-00000008 connected line has changed. Saving it until answer for SIP/9999-00000000
   -- SIP/9996-00000007 connected line has changed. Saving it until answer for SIP/9999-00000000
   -- SIP/9997-00000006 connected line has changed. Saving it until answer for SIP/9999-00000000
   -- SIP/9997-00000006 is ringing
   -- SIP/9999-00000008 is ringing
   -- SIP/9998-0000000a is ringing
   -- SIP/9996-00000007 is ringing
   -- SIP/9995-00000009 is ringing
   -- SIP/9995-00000009 connected line has changed. Saving it until answer for SIP/9999-00000000
0x7f6d28001e28 - Set answered time to 1421703456.193455
   -- SIP/9995-00000009 answered SIP/9999-00000000
Dial End message for SIP/9999-00000000, SIP/9995-00000009: 1421703456.00193620
0x7f6d28002c48 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9995-00000009
0x7f6d28005e58 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9995-00000009
0x7f6d280046b8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9995-00000009
0x7f6d28007278 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9995-00000009
0x7f6d28007278 - Transitioning CDR for SIP/9999-00000000 from state Dial to DialedPending
0x7f6d28008168 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9995-00000009
Dial End message for SIP/9999-00000000, SIP/9997-00000006: 1421703456.00193735
0x7f6d28002c48 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9997-00000006
0x7f6d28002c48 - Transitioning CDR for SIP/9999-00000000 from state Dial to Finalized
0x7f6d28005e58 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9997-00000006
0x7f6d280046b8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9997-00000006
0x7f6d28008168 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9997-00000006
Dial End message for SIP/9999-00000000, SIP/9996-00000007: 1421703456.00193847
0x7f6d28005e58 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9996-00000007
0x7f6d28005e58 - Transitioning CDR for SIP/9999-00000000 from state Dial to Finalized
0x7f6d280046b8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9996-00000007
0x7f6d28008168 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9996-00000007
Dial End message for SIP/9999-00000000, SIP/9999-00000008: 1421703456.00193956
0x7f6d280046b8 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9999-00000008
0x7f6d280046b8 - Transitioning CDR for SIP/9999-00000000 from state Dial to Finalized
0x7f6d28008168 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9999-00000008
Dial End message for SIP/9999-00000000, SIP/9998-0000000a: 1421703456.00194048
0x7f6d28008168 - Processing Dial End message for channel SIP/9999-00000000, peer SIP/9998-0000000a
0x7f6d28008168 - Transitioning CDR for SIP/9999-00000000 from state Dial to Finalized
Dial End message for SIP/9999-00000000, SIP/9997-00000006: 1421703456.00194210
0x7f6d28005608 - Transitioning CDR for SIP/9997-00000006 from state Single to Finalized
0x7f6d28005608 - Beginning finalize/dispatch for SIP/9997-00000006
0x7f6d28005608 - Dispatching CDR for Party A SIP/9997-00000006, Party B <none>
Dial End message for SIP/9999-00000000, SIP/9996-00000007: 1421703456.00194673
0x7f6d280037c8 - Transitioning CDR for SIP/9996-00000007 from state Single to Finalized
0x7f6d280037c8 - Beginning finalize/dispatch for SIP/9996-00000007
0x7f6d280037c8 - Dispatching CDR for Party A SIP/9996-00000007, Party B <none>
Dial End message for SIP/9999-00000000, SIP/9999-00000008: 1421703456.00195602
0x7f6d28001a28 - Transitioning CDR for SIP/9999-00000008 from state Single to Finalized
0x7f6d28001a28 - Beginning finalize/dispatch for SIP/9999-00000008
0x7f6d28001a28 - Dispatching CDR for Party A SIP/9999-00000008, Party B <none>
Dial End message for SIP/9999-00000000, SIP/9998-0000000a: 1421703456.00196062
0x7f6d280042d8 - Transitioning CDR for SIP/9998-0000000a from state Single to Finalized
0x7f6d280042d8 - Beginning finalize/dispatch for SIP/9998-0000000a
0x7f6d280042d8 - Dispatching CDR for Party A SIP/9998-0000000a, Party B <none>
0x7f6d28007278 - Set answered time to 1421703456.196945
   -- Channel SIP/9999-00000000 joined 'simple_bridge' basic-bridge <6134ae49-0841-4c24-a6f8-a15ce895bb1d>
Bridge Enter message for channel SIP/9999-00000000: 1421703456.00197582
0x7f6d28000978 - Updating Party A SIP/9999-00000000 snapshot
0x7f6d28000978 - Processing bridge enter for SIP/9999-00000000
0x7f6d280030b8 - Updating Party A SIP/9999-00000000 snapshot
0x7f6d280030b8 - Processing bridge enter for SIP/9999-00000000
0x7f6d28003da8 - Updating Party A SIP/9999-00000000 snapshot
0x7f6d28003da8 - Processing bridge enter for SIP/9999-00000000
0x7f6d280052b8 - Updating Party A SIP/9999-00000000 snapshot
0x7f6d280052b8 - Processing bridge enter for SIP/9999-00000000
0x7f6d280061a8 - Updating Party A SIP/9999-00000000 snapshot
0x7f6d280061a8 - Processing bridge enter for SIP/9999-00000000
0x7f6d28002c48 - Updating Party A SIP/9999-00000000 snapshot
0x7f6d28002c48 - Processing bridge enter for SIP/9999-00000000
0x7f6d28005e58 - Updating Party A SIP/9999-00000000 snapshot
0x7f6d28005e58 - Processing bridge enter for SIP/9999-00000000
0x7f6d280046b8 - Updating Party A SIP/9999-00000000 snapshot
0x7f6d280046b8 - Processing bridge enter for SIP/9999-00000000
0x7f6d28007278 - Updating Party A SIP/9999-00000000 snapshot
0x7f6d28007278 - Processing bridge enter for SIP/9999-00000000
0x7f6d28007278 - Transitioning CDR for SIP/9999-00000000 from state DialedPending to Dial
0x7f6d28007278 - Transitioning CDR for SIP/9999-00000000 from state Dial to Bridged
0x7f6d28008168 - Updating Party A SIP/9999-00000000 snapshot
0x7f6d28008168 - Processing bridge enter for SIP/9999-00000000
   -- Channel SIP/9995-00000009 joined 'simple_bridge' basic-bridge <6134ae49-0841-4c24-a6f8-a15ce895bb1d>
Bridge Enter message for channel SIP/9995-00000009: 1421703456.00198258
0x7f6d28001e28 - Updating Party A SIP/9995-00000009 snapshot
0x7f6d28001e28 - Processing bridge enter for SIP/9995-00000009
0x7f6d28001e28 - Transitioning CDR for SIP/9995-00000009 from state Single to Bridged
0x7f6d28007278 - Party A SIP/9999-00000000 has new Party B SIP/9995-00000009
   -- Channel SIP/9999-00000000 left 'simple_bridge' basic-bridge <6134ae49-0841-4c24-a6f8-a15ce895bb1d>
Bridge Leave message for SIP/9999-00000000: 1421703488.00197144
 == Spawn extension (macro-dial-queue, s, 1) exited non-zero on 'SIP/9999-00000000' in macro 'dial-queue'
0x7f6d28007278 - Processing Bridge Leave for SIP/9999-00000000
0x7f6d28007278 - Transitioning CDR for SIP/9999-00000000 from state Bridged to Finalized
 == Spawn extension (default, s, 1) exited non-zero on 'SIP/9999-00000000'
   -- Channel SIP/9995-00000009 left 'simple_bridge' basic-bridge <6134ae49-0841-4c24-a6f8-a15ce895bb1d>
Bridge Leave message for SIP/9995-00000009: 1421703488.00197456
0x7f6d28001e28 - Processing Bridge Leave for SIP/9995-00000009
0x7f6d28001e28 - Transitioning CDR for SIP/9995-00000009 from state Bridged to Finalized
0x7f6d28001e28 - Beginning finalize/dispatch for SIP/9995-00000009
0x7f6d28001e28 - Dispatching CDR for Party A SIP/9995-00000009, Party B <none>
0x7f6d28000978 - Beginning finalize/dispatch for SIP/9999-00000000
0x7f6d28000978 - Dispatching CDR for Party A SIP/9999-00000000, Party B SIP/9997-00000001
{code}

The patch sets the fields to s, macro-dial-queue which is wrong.

By: Matt Jordan (mjordan) 2015-06-13 10:00:34.619-0500

I've just placed a different patch up for review here:

https://gerrit.asterisk.org/#/c/652/

It should resolve the issue without specifying an incorrect dst/dcontext in the newly generated CDRs.