--> lib: prim 30582 dinfo 10040 port: 1
 --> lib: NEW_CR Ind with l3id:10040 port:1
 --> new_process: New L3Id: 10040
CALLING PARTY TYPE 0 PLAN 1
 --> Pres:0
 --> Screen:0
CALLED PARTY TYPE ffffffff PLAN ffffffff
 --> cap Audio
I IND :SETUP    pid:4   mode:NT addr:51400101   port:1
 --> l3id:10040 cause:16 dad: oad:586671 channel:-1 port:1
$$$ find_chan: No channel found for oad:586671 dad:
 --> Keypad:
 --> Bearer: Audio
 --> Numplan: No Numplan
 --> * NEW CHANNEL dad: oad:586671 ctx:default
 --> Setting Pickupgroup
 --> Number Screened
* Queuing chan 0x8f2b620
I SEND:SETUP_ACKNOWLEDGE        port:1  pid:4   mode:NT addr:51400101
 --> l3id:10040 cause:16 dad: oad:586671 channel:-1 port:1
 --> found chan 1
$$$ Setting up bc with stid :10000101
 --> Got Adr 51400101
 --> Channel is 1
 --> Transparent
$$$ Bchan Activated addr 51400101
BCHAN: bchan ACT Confirm
 --> lib: prim 37b82 dinfo 10040 port: 1
I IND :INFORMATION      pid:4   mode:NT addr:51400101   port:1
 --> l3id:10040 cause:16 dad: oad:586671 channel:1 port:1
 --> keypad:  info_dad: 1
 --> * Starting Ast ctx:default dad:1 oad:586671
Apr  9 19:01:29 WARNING[6766]: pbx.c:2233 ast_pbx_run: Allocated PBX at 0x8f6ee28 for mISDN/1/586671
    -- Executing Dial("mISDN/1/586671", "mISDN/g:extern/1") in new stack
Checking Availbl. Chan in Group: extern
 --> * NEW CHANNEL dad: oad:1 ctx:
 --> Not Setting Pickupgroup, we have no bc yet
* CALL: g:extern/1
 --> Group Call group: extern
 --> * dad:1 tech:mISDN/g:extern/1 ctx:
 --> * Setting Context to incoming
 --> * CallGrp: PickupGrp:
 --> * adding2newbc ext 1
 --> * adding2newbc callerid 586671
 --> Number Screened
* Queuing chan 0x8f6a140
I SEND:SETUP    port:2  pid:0   mode:TE addr:0
 --> l3id:0 cause:16 dad:1 oad:586671 channel:0 port:2
--> new_l3id 30001
 --> pid 5I>
 --> oad 586671 dad 1 channel 255
--> cap Speech
 --> * SEND: State Dialing pid:5
    -- Called g:extern/1
 --> lib: prim 37b82 dinfo 10040 port: 1
I IND :INFORMATION      pid:4   mode:NT addr:51400101   port:1
 --> l3id:10040 cause:16 dad:1 oad:586671 channel:1 port:1
 --> keypad:  info_dad: 7
Apr  9 19:01:29 WARNING[6766]: chan_misdn.c:2490 cb_te_events: Received INFO DTMF '7' on port 1
* IND : Digit 7
$$$ Setting up bc with stid :10000102
 --> Got Adr 51400102
 --> Channel is 1
 --> Transparent
I IND :SETUP_ACKNOWLEDGE        pid:5   mode:TE addr:51400102   port:2
 --> l3id:30001 cause:16 dad:1 oad:586671 channel:1 port:2
I SEND:INFORMATION      port:2  pid:5   mode:TE addr:51400102
 --> l3id:30001 cause:16 dad:17 oad:586671 channel:1 port:2
 --> lib: prim 37b82 dinfo 10040 port: 1
I IND :INFORMATION      pid:4   mode:NT addr:51400101   port:1
 --> l3id:10040 cause:16 dad:1 oad:586671 channel:1 port:1
 --> keypad:  info_dad: 0
Apr  9 19:01:29 WARNING[6766]: chan_misdn.c:2490 cb_te_events: Received INFO DTMF '0' on port 1
* IND : Digit 0
I SEND:INFORMATION      port:2  pid:5   mode:TE addr:51400102
 --> l3id:30001 cause:16 dad:170 oad:586671 channel:1 port:2
 --> lib: prim 37b82 dinfo 10040 port: 1
I IND :INFORMATION      pid:4   mode:NT addr:51400101   port:1
 --> l3id:10040 cause:16 dad:1 oad:586671 channel:1 port:1
 --> keypad:  info_dad: 7
Apr  9 19:01:29 WARNING[6766]: chan_misdn.c:2490 cb_te_events: Received INFO DTMF '7' on port 1
* IND : Digit 7
I SEND:INFORMATION      port:2  pid:5   mode:TE addr:51400102
 --> l3id:30001 cause:16 dad:1707 oad:586671 channel:1 port:2
 --> lib: prim 37b82 dinfo 10040 port: 1
I IND :INFORMATION      pid:4   mode:NT addr:51400101   port:1
 --> l3id:10040 cause:16 dad:1 oad:586671 channel:1 port:1
 --> keypad:  info_dad: 0
Apr  9 19:01:30 WARNING[6766]: chan_misdn.c:2490 cb_te_events: Received INFO DTMF '0' on port 1
* IND : Digit 0
I SEND:INFORMATION      port:2  pid:5   mode:TE addr:51400102
 --> l3id:30001 cause:16 dad:17070 oad:586671 channel:1 port:2
$$$ bc already upsetted stid :10000102
I IND :PROCEEDING       pid:5   mode:TE addr:51400102   port:2
 --> l3id:30001 cause:16 dad:17070 oad:586671 channel:1 port:2
$$$ bc already upsetted stid :10000102
I IND :ALERTING pid:5   mode:TE addr:51400102   port:2
 --> l3id:30001 cause:16 dad:17070 oad:586671 channel:1 port:2
 --> * SEND: Queue Frame Ringing pid:5
    -- mISDN/g:extern/1 is ringing
* IND : Indication from 1
 --> * IND :    ringing pid:4
I SEND:ALERTING port:1  pid:4   mode:NT addr:51400101
 --> l3id:10040 cause:16 dad:1 oad:586671 channel:1 port:1
$$$ bc already upsetted stid :10000101
 --> * SEND: State Ring pid:4
$$$ bc already upsetted stid :10000102
I IND :CONNECT  pid:5   mode:TE addr:51400102   port:2
 --> l3id:30001 cause:16 dad:17070 oad:586671 channel:1 port:2
I SEND:CONNECT_ACKNOWLEDGE      port:2  pid:5   mode:TE addr:51400102
 --> l3id:30001 cause:16 dad:17070 oad:586671 channel:1 port:2
$$$ Bchan Activated addr 51400102
 --> * SEND: Queue Answer pid:5
    -- mISDN/g:extern/1 answered mISDN/1/586671
* IND : Indication from 1
 --> * IND :    -1! pid:4
* ANSWER:
 --> Connection is without BF encryption
I SEND:CONNECT  port:1  pid:4   mode:NT addr:51400101
 --> l3id:10040 cause:16 dad:1 oad:586671 channel:1 port:1
$$$ bc already upsetted stid :10000101
BCHAN: bchan ACT Confirm
PH_CONTROL: port:1 channel:1 oad:586671 dad:1
 --> DTMF TONE: 1
I IND :DTMF_TONE        pid:4   mode:NT addr:51400101   port:1
 --> l3id:10040 cause:16 dad:1 oad:586671 channel:1 port:1
Apr  9 19:01:35 WARNING[6766]: chan_misdn.c:2395 cb_te_events: Received DTMF '1' on port 1
 --> * SEND: DTMF :1
* IND : Digit 1
 --> lib: prim 34582 dinfo 10040 port: 1
I IND :DISCONNECT       pid:4   mode:NT addr:51400101   port:1
 --> l3id:10040 cause:16 dad:1 oad:586671 channel:1 port:1
$$$ find_chan_holded: No channel found for oad:586671 dad:1
 --> ch->state CONNECTED, bc->holded 0
$$$ Bchan deActivated addr 51400101
 --> cause 16
I SEND:RELEASE  port:1  pid:4   mode:NT addr:51400101
 --> l3id:10040 cause:16 dad:1 oad:586671 channel:1 port:1
BCHAN: DeACT Conf
 --> lib: prim 3f182 dinfo 10040 port: 1
 --> Faking Realease_cr for 40200001
 --> lib: RELEASE_CR Ind with l3id:10040
 --> lib: CLEANING UP l3id: 10040
 --> empty chan 1
Idx: 0 stack->cchan: 0 Chan 1
Idx: 1 stack->cchan: 0 Chan 2
$$$ Cleaning up bc with stid :10000101
Idx: 0 stack->cchan: 0 Chan 1
Idx: 1 stack->cchan: 0 Chan 2
I IND :CLEAN_UP pid:0   mode:NT addr:51400101   port:1
 --> l3id:10040 cause:16 dad: oad: channel:0 port:1
* RELEASING CHANNEL pid:0 ctx:default dad:1 oad:586671 state: CONNECTED
 --> * State Down
 --> Setting AST State to down
* --> In State Default
* --> Queue Hangup
$$$ MGMT FRAME: prim f2481 addr 50400101 dinfo 0
* IND : HANGUP  pid:5 ctx:incoming dad:17070 oad:1 State:CONNECTED
 --> l3id:30001
 --> cause:16
 --> * State Connected
I SEND:DISCONNECT       port:2  pid:5   mode:TE addr:51400102
 --> l3id:30001 cause:16 dad:17070 oad:586671 channel:1 port:2
  == Spawn extension (default, 1, 1) exited non-zero on 'mISDN/1/586671'
misdn_hangup called, without chan_list obj.
I IND :RELEASE  pid:5   mode:TE addr:51400102   port:2
 --> l3id:30001 cause:-1 dad:17070 oad:586671 channel:1 port:2
 --> cause -1
$$$ Bchan deActivated addr 51400102
 --> lib: RELEASE_CR Ind with l3id:30001
 --> lib: CLEANING UP l3id: 30001
 --> empty chan 1
Idx: 0 stack->cchan: 0 Chan 1
Idx: 1 stack->cchan: 0 Chan 2
$$$ Cleaning up bc with stid :10000102
Idx: 0 stack->cchan: 0 Chan 1
Idx: 1 stack->cchan: 0 Chan 2
I IND :CLEAN_UP pid:0   mode:TE addr:51400102   port:2
 --> l3id:30001 cause:16 dad: oad: channel:0 port:2
$$$ find_chan: No channel found for oad: dad:
$$$ find_chan: No channel found for oad: dad:
$$$ find_chan: No channel found with l3id:30001
BCHAN: DeACT Conf
$$$ MGMT FRAME: prim f2481 addr 50400102 dinfo 0