4 Replies Latest reply on May 27, 2016 7:47 AM by jay

    Push ISDN/T1 Number to FXS ports?

    skirschplex New Member

      After doing some further reading I'm not pretty sure there's a much easier way to do this...  I've been trying to pull some numbers out of the PRI trunk to copper ports.

       

      I have this AdTran registered as a Endpoint with my VoIP provider.  Since I was originally unsure of how to do this otherwise I decided to pull two numbers out of that trunk and point them at our main gateway, and Asterisk server.  I then set up two SIP users on the FXS ports to register to our asterisk box.

       

      We can call out from those ports but inbound calls result in 486 BUSY HERE.

       

       

      Looking over things again I'm starting to think there is probably a more elegant way to to point certain DIDs to the FXS ports I want from the PRI, instead of this ridiculous workaround that is not actually working.  But I am unclear on how to do this....

       

       

      If that's not the case, here is my current config:

       

       

      Any help would be greatly appreciated!

       

       

      !

      !

      ! ADTRAN, Inc. OS version A4.11.00.E

      ! Boot ROM version 14.04.00

      ! Platform: Total Access 916 (2nd Gen), part number 4212916L1

      ! Serial number CFG1326470

      !

      !

      hostname "XXXXXXXXXXXXXXXX"

      enable password XXXXXXXXXXXXXXXX

      !

      clock timezone -5-Eastern-Time

      !

      ip subnet-zero

      ip classless

      ip default-gateway XXXXXXXXXXXXXXXX

      ip routing

      !

      !

      ip name-server XXXXXXXXXXXXXXXX XXXXXXXXXXXXXXXX

      !

      !

      no auto-config

      !

      event-history on

      no logging forwarding

      no logging email

      !

      no service password-encryption

      !

      username "XXXXXXXXXXXXXXXX" password "XXXXXXXXXXXXXXXX"

      !

      !

      no ip firewall alg msn

      no ip firewall alg mszone

      no ip firewall alg h323

      !

      !

      !

      !

      !

      no dot11ap access-point-control

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      interface eth 0/1

        ip address  XXXXXXXXXXXXXXXX  255.255.255.252

        media-gateway ip primary

        no awcp

        no shutdown

      !

      !

      !

      !

      interface t1 0/1

        shutdown

      !

      interface t1 0/2

        tdm-group 1 timeslots 1-24 speed 64

        no shutdown

      !

      !

      interface pri 1

        description PRI to PBX

        isdn name-delivery setup

        connect t1 0/2 tdm-group 1

        role network b-channel-restarts disable

        no shutdown

      !

      !

      interface fxs 0/1

        no shutdown

      !

      interface fxs 0/2

        no shutdown

      !

      interface fxs 0/3

        no shutdown

      !

      interface fxs 0/4

        no shutdown

      !

      interface fxs 0/5

        no shutdown

      !

      interface fxs 0/6

        no shutdown

      !

      interface fxs 0/7

        no shutdown

      !

      interface fxs 0/8

        no shutdown

      !

      interface fxs 0/9

        no shutdown

      !

      interface fxs 0/10

        no shutdown

      !

      interface fxs 0/11

        no shutdown

      !

      interface fxs 0/12

        no shutdown

      !

      interface fxs 0/13

        no shutdown

      !

      interface fxs 0/14

        no shutdown

      !

      interface fxs 0/15

        no shutdown

      !

      interface fxs 0/16

        no shutdown

      !

      !

      isdn-group 1

        connect pri 1

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      ip route 0.0.0.0 0.0.0.0 XXXXXXXXXXXXXXXX

      !

      no ip tftp server

      no ip tftp server overwrite

      ip http server

      no ip http secure-server

      no ip snmp agent

      no ip ftp server

      no ip scp server

      no ip sntp server

      !

      !

      !

      !

      !

      !

      ip sip

      ip sip udp 5060

      no ip sip tcp

      !

      !

      !

      voice feature-mode network

      voice forward-mode network

      !

      !

      !

      !

      !

      !

      !

      voice dial-plan 1 local NXX-XXXX

      voice dial-plan 3 international 011-$

      voice dial-plan 4 long-distance 1-NXX-NXX-XXXX

      !

      !

      !

      !

      voice codec-list "PRI to PBX"

        codec g729

        codec g711ulaw

      !

      !

      !

      voice trunk T01 type sip

        description "vi1"

        match dnis "NXX-XXXX" substitute "1-607-NXX-XXXX" name "local"

        sip-server primary XXXXXXXXXXXXXXXX

        codec-group "PRI to PBX"

      !

      voice trunk T02 type sip

        description "vi2"

        match dnis "NXX-XXXX" substitute "1-607-NXX-XXXX" name "local"

        sip-server primary XXXXXXXXXXXXXXXX

      !

      voice trunk T03 type isdn

        description "PRI to PBX"

        resource-selection circular descending

        connect isdn-group 1

        modem-passthrough

        t38

        rtp delay-mode adaptive

        rtp dtmf-relay inband

        codec-group "PRI to PBX"

      !

      voice trunk T04 type sip

        description "fxS15-SIP"

        match dnis "NXX-XXXX" substitute "1-607-NXX-XXXX" name "local prefix"

        sip-server primary XXXXXXXXXXXXXXXX

        registrar primary XXXXXXXXXXXXXXXX

        outbound-proxy primary XXXXXXXXXXXXXXXX

        authentication username "XXXXXXXXXXXXXXXX" password "XXXXXXXXXXXXXXXX"

      !

      voice trunk T05 type sip

        description "fxS16-SIP"

        match dnis "NXX-XXXX" substitute "1-607-NXX-XXXX" name "local prefix"

        sip-server primary XXXXXXXXXXXXXXXX

        registrar primary XXXXXXXXXXXXXXXX

        outbound-proxy primary XXXXXXXXXXXXXXXX

        authentication username "XXXXXXXXXXXXXXXX" password "XXXXXXXXXXXXXXXX"

      !

      !

      voice grouped-trunk "PRI TO PBX"

        description "PRI to PBX"

        trunk T03

        accept $ cost 0

      !

      !

      voice grouped-trunk "SIP VI"

        description "SIP Trunk"

        trunk T01

        trunk T02

        accept $ cost 0

      !

      !

      voice grouped-trunk STANDALONE-PORTS

        trunk T04

        trunk T05

        accept NXX-XXXX cost 0

        accept 1-NXX-NXX-XXXX cost 0

        accept 1-800-NXX-XXXX cost 0

        accept 1-888-NXX-XXXX cost 0

        accept 1-877-NXX-XXXX cost 0

        accept 1-866-NXX-XXXX cost 0

        accept 1-855-NXX-XXXX cost 0

        accept 011-$ cost 0

        accept 411 cost 0

        accept 611 cost 0

        accept 911 cost 0

        accept 0-NXX-NXX-XXXX cost 0

        accept 10-10-XXX-$ cost 0

        reject 976-XXXX

        reject 1-900-NXX-XXXX

        reject 1-976-NXX-XXXX

      !

      !

      voice user 9901

        connect fxs 0/15

        first-name "XXXXXXXXXXXXXXXX"

        last-name "XXXXXXXXXXXXXXXX"

        password "XXXXXXXXXXXXXXXX"

        num-rings 9

        sip-identity XXXXXXXXXXXXXXXX T04 register auth-name "XXXXXXXXXXXXXXXX" password "XXXXXXXXXXXXXXXX"

        sip-authentication password "XXXXXXXXXXXXXXXX"

        t38

        codec-group "PRI to PBX"

      !

      !

      voice user 9902

        connect fxs 0/16

        first-name "XXXXXXXXXXXXXXXX"

        last-name "XXXXXXXXXXXXXXXX"

        password "XXXXXXXXXXXXXXXX"

        sip-identity XXXXXXXXXXXXXXXX T05 register auth-name "XXXXXXXXXXXXXXXX" password "XXXXXXXXXXXXXXXX"

        sip-authentication password "XXXXXXXXXXXXXXXX"

        t38

        codec-group "PRI to PBX"

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      !

      line con 0

        login

      !

      line telnet 0 4

        login

        password XXXXXXXXXXXXXXXX

        no shutdown

      line ssh 0 4

        login local-userlist

        no shutdown

      !

      !

      ntp source ethernet 0/1

      ntp server XXXXXXXXXXXXXXXX version 3 source ethernet 0/1 prefer

      !

      !

      !

      end

        • Re: Push ISDN/T1 Number to FXS ports?
          jay Employee

          Sam, direct TDM to TDM connection is not supported. You would need to route the numbers to a PBX before routing back to the 900. Thanks

           

          Jay

            • Re: Push ISDN/T1 Number to FXS ports?
              skirschplex New Member

              Hello Jay, thanks for the reply!

               

              Can you elaborate on that?

               

               

              I have gotten things working a bit better and more streamlined. I can call into all the FXS ports I just cannot call out, I guess a 'Busy Here' message.  This is my current configuration;

               

               

              !

              !

              ! ADTRAN, Inc. OS version A4.11.00.E

              ! Boot ROM version 14.04.00

              ! Platform: Total Access 916 (2nd Gen), part number 4212916L1

              ! Serial number CFG1326470

              !

              !

              hostname "XXXXXXXXXXXXXXXXXXXX"

              enable password XXXXXXXXXXXXXXXXXXXX

              !

              clock timezone -5-Eastern-Time

              !

              ip subnet-zero

              ip classless

              ip default-gateway XXXXXXXXXXXXXXXXXXXX

              ip routing

              !

              !

              ip name-server XXXXXXXXXXXXXXXXXXXX XXXXXXXXXXXXXXXXXXXX

              !

              !

              no auto-config

              !

              event-history on

              no logging forwarding

              no logging email

              !

              no service password-encryption

              !

              username "admin" password "XXXXXXXXXXXXXXXXXXXX"

              !

              !

              no ip firewall alg msn

              no ip firewall alg mszone

              no ip firewall alg h323

              !

              !

              !

              !

              !

              no dot11ap access-point-control

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              interface eth 0/1

                ip address  XXXXXXXXXXXXXXXXXXXX  255.255.255.252

                media-gateway ip primary

                no awcp

                no shutdown

              !

              !

              !

              !

              interface t1 0/1

                shutdown

              !

              interface t1 0/2

                tdm-group 1 timeslots 1-24 speed 64

                no shutdown

              !

              !

              interface pri 1

                description PRI to PBX

                isdn name-delivery setup

                connect t1 0/2 tdm-group 1

                role network b-channel-restarts disable

                no shutdown

              !

              !

              interface fxs 0/1

                no shutdown

              !

              interface fxs 0/2

                no shutdown

              !

              interface fxs 0/3

                no shutdown

              !

              interface fxs 0/4

                no shutdown

              !

              interface fxs 0/5

                no shutdown

              !

              interface fxs 0/6

                no shutdown

              !

              interface fxs 0/7

                no shutdown

              !

              interface fxs 0/8

                no shutdown

              !

              interface fxs 0/9

                no shutdown

              !

              interface fxs 0/10

                no shutdown

              !

              interface fxs 0/11

                no shutdown

              !

              interface fxs 0/12

                no shutdown

              !

              interface fxs 0/13

                no shutdown

              !

              interface fxs 0/14

                no shutdown

              !

              interface fxs 0/15

                no shutdown

              !

              interface fxs 0/16

                no shutdown

              !

              !

              isdn-group 1

                connect pri 1

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              ip route 0.0.0.0 0.0.0.0 XXXXXXXXXXXXXXXXXXXX

              !

              no ip tftp server

              no ip tftp server overwrite

              ip http server

              no ip http secure-server

              no ip snmp agent

              no ip ftp server

              no ip scp server

              no ip sntp server

              !

              !

              !

              !

              !

              !

              ip sip

              ip sip udp 5060

              no ip sip tcp

              !

              !

              !

              voice feature-mode network

              voice forward-mode network

              !

              !

              !

              !

              !

              !

              !

              voice dial-plan 1 local NXX-XXXX

              voice dial-plan 3 international 011-$

              voice dial-plan 4 long-distance 1-NXX-NXX-XXXX

              !

              !

              !

              !

              voice codec-list "PRI to PBX"

                codec g729

                codec g711ulaw

              !

              !

              !

              voice trunk T01 type sip

                description "vi1"

                match dnis "NXX-XXXX" substitute "1-607-NXX-XXXX" name "local"

                sip-server primary XXXXXXXXXXXXXXXXXXXX

                codec-group "PRI to PBX"

              !

              voice trunk T02 type sip

                description "vi2"

                match dnis "NXX-XXXX" substitute "1-607-NXX-XXXX" name "local"

                sip-server primary XXXXXXXXXXXXXXXXXXXX

              !

              voice trunk T03 type isdn

                description "PRI to PBX"

                resource-selection circular descending

                connect isdn-group 1

                modem-passthrough

                t38

                rtp delay-mode adaptive

                rtp dtmf-relay inband

                codec-group "PRI to PBX"

              !

              !

              voice grouped-trunk "PRI TO PBX"

                description "PRI to PBX"

                trunk T03

                accept $ cost 0

              !

              !

              voice grouped-trunk "SIP VI"

                description "SIP Trunk"

                trunk T01

                trunk T02

                accept $ cost 0

              !

              !

              voice user 9901

                connect fxs 0/15

                first-name "XXXX"

                last-name "XXXX"

                password "1234"

                caller-id-override external-number nnnnnn7603

                caller-id-override internal-name "XXXX"

                caller-id-override internal-number nnnnnn7603

                did "nnnnnn7603"

                sip-authentication password "1234"

                modem-passthrough

                t38

                codec-group "PRI to PBX"

              !

              !

              voice user 9902

                connect fxs 0/16

                first-name "XXXX"

                last-name "XXXX"

                password "1234"

                caller-id-override external-number nnnnnn7439

                caller-id-override internal-name "XXXX"

                caller-id-override internal-number nnnnnn7439

                did "nnnnnn7439"

                sip-authentication password "1234"

                modem-passthrough

                t38

                codec-group "PRI to PBX"

              !

              !

              voice user 9903

                connect fxs 0/14

                first-name "XXXX"

                last-name "pXXXX"

                password "1234"

                caller-id-override external-number nnnnnn4673

                caller-id-override internal-name "XXXX"

                caller-id-override internal-number nnnnnn4673

                did "nnnnnn4673"

                sip-authentication password "1234"

                modem-passthrough

                t38

                codec-group "PRI to PBX"

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              !

              line con 0

                login

              !

              line telnet 0 4

                login

                password XXXXXXXXXXXXXXXXXXXX

                no shutdown

              line ssh 0 4

                login local-userlist

                no shutdown

              !

              !

              ntp source ethernet 0/1

              ntp server XXXXXXXXXXXXXXXXXXXX version 3 source ethernet 0/1 prefer

              !

              !

              !

              end

              • Re: Push ISDN/T1 Number to FXS ports?
                skirschplex New Member

                It does look like its trying to route the call from the FXS port into the ISDN PRI port.  Is that what you were referring to with TDM to TDM?

                 

                 

                I have a few options for how I can do this.  I'd like to make it all work through the Adtran but if its not possible we can drop some smaller Cisco SPA122s.  But here is my setup and what I have at my disposal:

                 

                This Adtran is setup as an Endpoint through my VoIP Wholesaler.  You've seen the rest of the config.

                 

                I have an asterisk server set up as a separate endpoint through the same wholesaler.  Would I be able to set up the FXS ports as entirely stand alone SIP users?  I can take the three DIDs they want on the FXS ports and point them at the other endpoint.  I tried this before with one of the lines and it didn't seem to work properly, but maybe I flubbed something up there.  What would be the best way to have these two separate trunks working in tandem on the same unit?

                 

                 

                Here is my debug info:

                 

                 

                16:14:40.814 PM.0:14 Idle             Processed OFFHOOK
                16:14:40.815 PM.0:14 State change  >> Idle->Requesting Dialtone
                16:14:40.815 SA.9903 Ca:0 Idle             rcvd: AcctPhoneMgr_appearance(ON) from PM
                16:14:40.816 SA.9903 Ca:0 State change  >> Idle->DigitGathering
                16:14:40.816 SA.9903 Ca:0 DigitGathering   sent: AcctPhoneMgr_cachg(CAS_ReqDigits) to PM

                16:14:40.817 PM.0:14 Requesting Dialtone  CACHG:ReqDigits on primary CA

                16:14:40.817 PM.0:14 State change  >> Requesting Dialtone->SendingDigits

                16:14:40.819 TONESERVICES.EVENTS fxs 0/14 - empty - Tone Detection: Request resource

                16:14:40.820 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: DSP channel allocated for the resource

                16:14:40.821 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: constructed

                16:14:40.821 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: starting

                16:14:40.822 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: TDM map

                16:14:41.321 TONESERVICES.EVENTS fxs 0/14 - empty - DialTone Generation: Request resource

                16:14:41.322 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: DSP channel allocated for the resource

                16:14:41.322 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: constructed

                16:14:41.323 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: starting

                16:14:41.323 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: TDM map

                16:14:44.079 PM.0:14 SendingDigits    Digit 2 processed

                16:14:44.080 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:14:44.081 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: stopping

                16:14:44.082 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: TDM unmap

                16:14:44.082 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - DialTone Generation: releasing RTP resource

                16:14:44.083 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: release

                16:14:44.084 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:14:44.084 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 second(s) for more digits
                16:14:44.369 PM.0:14 SendingDigits    Digit 2 processed

                16:14:44.371 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:14:44.371 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:14:44.372 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:14:44.589 PM.0:14 SendingDigits    Digit 2 processed

                16:14:44.591 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:14:44.591 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:14:44.592 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:14:44.969 PM.0:14 SendingDigits    Digit 5 processed

                16:14:44.970 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (5) event

                16:14:44.971 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(5) from PM
                16:14:44.972 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:14:45.309 PM.0:14 SendingDigits    Digit 3 processed

                16:14:45.311 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (3) event

                16:14:45.311 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(3) from PM
                16:14:45.312 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:14:45.770 PM.0:14 SendingDigits    Digit 9 processed

                16:14:45.771 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (9) event

                16:14:45.771 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(9) from PM
                16:14:45.772 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:14:46.189 PM.0:14 SendingDigits    Digit 3 processed

                16:14:46.190 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (3) event

                16:14:46.191 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(3) from PM
                16:14:46.192 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:14:50.192 SA.9903 Ca:0 State change  >> DigitGathering->DigitGathering
                16:14:50.193 SA.9903 Ca:0 DigitGathering   sent: AcctPhoneMgr_cachg(CAS_Active) to PM
                16:14:50.194 PM.0:14 State change  >> SendingDigits->Call Pending
                16:14:50.195 SA.9903 Ca:0 DigitGathering   sent: call to SB
                16:14:50.195 SA.9903 Ca:0 State change  >> DigitGathering->CallPending

                16:14:50.196 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: stopping

                16:14:50.197 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: TDM unmap

                16:14:50.198 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - Tone Detection: releasing RTP resource

                16:14:50.198 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: release

                16:14:50.199 SA.9903 rcvd: AcctPhoneMgr_billingCode from PM

                16:14:50.199 SB.CALL 184 Idle             Called the call routine with 2225393

                16:14:50 SB.TGMgr For dialed number 2225393, against template $, on TrunkGroup PRI TO PBX, the score is 500

                16:14:50 SB.TGMgr For dialed number 2225393, against template $, on TrunkGroup SIP VI, the score is 500

                16:14:50.201 SB.CCM isMappable:

                16:14:50.202 SB.CCM  :  Call Struct 0x2952e10 :   Call-ID = 184

                16:14:50.202 SB.CCM  :  Org Acct = 9903Dst Acct = T03

                16:14:50.203 SB.CCM  :  Org Port ID = 0/14.0   Dst Port ID = 0/0.0

                16:14:50.203 SB.CCM  :  Org TID = Fxs   Dst TID =

                16:14:50.204 SB.CCM isMappable: Call Connection Type is TDM_TO_TDM

                16:14:50.205 SB.CALL 184 Idle             Call sent from 9903 to T03 (2225393)
                16:14:50.205 SB.CALL 184 State change  >> Idle->Delivering
                16:14:50.206 SA.9903 Ca:0 CallPending      rcvd: callResponse from SB
                16:14:50.206 SA.9903 Ca:0 State change  >> CallPending->Calling
                16:14:50.207 TA.T03 07 State change  >> TAIdle->TAOutGoing (TAS_Delivering)

                16:14:50.208 TM.T03 07 tachg_Delivering

                16:14:50.209 TM.T03 07 IsdnTmStateIdle->IsdnTmStateOutboundDeliver

                16:14:50.210 TM.T03 07 IsdnTmStateOutboundDeliver::enter()

                16:14:50.211 ISDN.L2_FMT PRI  1  ==============================================

                16:14:50.212 ISDN.L2_FMT PRI  1  Sent  Sapi:00 C/R:C Tei:00 INFO Ns:57  Nr:5   P:0

                16:14:50.212 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:006C
                16:14:50.212 ISDN.L2_FMT PRI  1    M - 05 SETUP 
                16:14:50.213 ISDN.L2_FMT PRI  1     IE - 04 BEARER CAPABILITY   Len=3
                16:14:50.213 ISDN.L2_FMT PRI  1          80 Xfer Cap.:SPEECH      
                16:14:50.213 ISDN.L2_FMT PRI  1          90 Xfer Rate:64k  
                16:14:50.214 ISDN.L2_FMT PRI  1          A2 Layer 1:u-Law    
                16:14:50.214 ISDN.L2_FMT PRI  1     IE - 18 CHANNEL ID      Len=3
                16:14:50.214 ISDN.L2_FMT PRI  1          A1 Primary Rate
                16:14:50.215 ISDN.L2_FMT PRI  1             Intfc ID:IMPLICIT
                16:14:50.215 ISDN.L2_FMT PRI  1             Pref/Excl:PREFERRED
                16:14:50.215 ISDN.L2_FMT PRI  1             D-Chan Indicated:NO
                16:14:50.216 ISDN.L2_FMT PRI  1             Chan. Sel:FOLLOWS
                16:14:50.216 ISDN.L2_FMT PRI  1          83 Numb/Map:NUMBER
                16:14:50.216 ISDN.L2_FMT PRI  1          87 Channel:7
                16:14:50.217 ISDN.L2_FMT PRI  1     IE - 1C FACILITY        Len=28
                16:14:50.217 ISDN.L2_FMT PRI  1      Calling Name: XXXXXXXXXXXXXXXXXXX
                16:14:50.218 ISDN.L2_FMT PRI  1     IE - 6C CALLING PARTY # Len=12
                16:14:50.218 ISDN.L2_FMT PRI  1          00 Numb. Type:UNKNOWN 
                16:14:50.218 ISDN.L2_FMT PRI  1             Numb. Plan:UNKNOWN  
                16:14:50.219 ISDN.L2_FMT PRI  1          80 Presentation:ALLOWED
                16:14:50.219 ISDN.L2_FMT PRI  1             Ph.# 6073044673
                16:14:50.220 ISDN.L2_FMT PRI  1     IE - 70 CALLED PARTY #  Len=8
                16:14:50.220 ISDN.L2_FMT PRI  1          80 Numb. Type:UNKNOWN 
                16:14:50.220 ISDN.L2_FMT PRI  1             Numb. Plan:UNKNOWN  
                16:14:50.221 ISDN.L2_FMT PRI  1             Ph.# 2225393
                16:14:50.221 SB.CALL 184 Delivering       Called the deliverResponse routine from Delivering
                16:14:50.222 SB.CALL 184 Delivering       DeliverResponse(accept) sent from T03 to 9903
                16:14:50.223 SA.9903 Ca:0 Calling          rcvd: deliverResponse from SB
                16:14:50.223 SA.9903 Ca:0 Calling          sent: AcctPhoneMgr_info to PM

                16:14:50.224 PM.0:14 ERROR! APM_Info ignored

                16:14:50.336 ISDN.L2_FMT PRI  1  ==============================================

                16:14:50.337 ISDN.L2_FMT PRI  1  Recd  Sapi:00 C/R:R Tei:00 INFO Ns:5   Nr:58  P:0

                16:14:50.337 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:806C
                16:14:50.337 ISDN.L2_FMT PRI  1    M - 5A RELEASE_CMP
                16:14:50.338 ISDN.L2_FMT PRI  1     IE - 08 CAUSE           Len=2
                16:14:50.338 ISDN.L2_FMT PRI  1          80 Location:U
                16:14:50.339 ISDN.L2_FMT PRI  1          91 Cause:17 (USER_BUSY)

                16:14:50.349 TM.T03 07 IsdnTmStateOutboundDeliver->IsdnTmStateTrunkClearing

                16:14:50.349 TM.T03 07 IsdnTmStateTrunkClearing::enter()

                16:14:50.350 TM.T03 07 IsdnTmStateTrunkClearing->IsdnTmStateIdling

                16:14:50.351 TM.T03 07 IsdnTmStateIdling::enter()

                16:14:50.352 TM.T03 07 IsdnTmStateIdling - send appearance off

                16:14:50.352 TM.T03 07 IsdnTmStateIdling->IsdnTmStateIdle

                16:14:50.353 TM.T03 07 IsdnAppearanceChannel::releaseChannel

                16:14:50.353 TM.T03 07 IsdnTmStateIdle::enter()

                16:14:50.354 TA.T03 07 TAOutGoing       rcvd: clear from TM
                16:14:50.355 TA.T03 07 State change  >> TAOutGoing->TATrunkClearing (TAS_Clearing)

                16:14:50.355 TM.T03 07 IsdnTmStateIdle::tachgClearing - send appearance off

                16:14:50.356 TA.T03 07 TATrunkClearing  rcvd: clear from TM
                16:14:50.357 TA.T03 07 State change  >> TATrunkClearing->TAClearingComplete (TAS_Clearing)

                16:14:50.357 TA.T03 07 TAClearingComplete   rcvd: appearance off from TM

                16:14:50.358 TA.T03 07 TAClearingComplete   Clear Local Variables

                16:14:50.358 TA.T03 07 State change  >> TAClearingComplete->TAIdle (TAS_Idle)
                16:14:50.359 SB.CALL 184 Delivering       Called the clearCall routine from Delivering
                16:14:50.360 SB.CALL 184 Delivering       Clearing due to Trunk Clear Reason on call from T03 to 9903
                16:14:50.361 SB.CALL 184 State change  >> Delivering->Clearing
                16:14:50.361 TA.T03 07 TAIdle           rcvd: appearance off from TM
                16:14:50.362 TA.T03 07 TAIdle           Processing an appearance OFF
                16:14:50.363 SA.9903 Ca:0 Calling          rcvd: clearCall from SB
                16:14:50.363 SA.9903 Ca:0 Calling          sent: clearResponse(pass) to SB
                16:14:50.364 SA.9903 Ca:0 State change  >> Calling->Idle
                16:14:50.364 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_faxModem to PM
                16:14:50.365 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_cachg(CAS_Idle) to PM
                16:14:50.365 PM.0:14 Call Pending     Pri CA, Idle response, App OFF sent
                16:14:50.366 PM.0:14 State change  >> Call Pending->Clearing Busy
                16:14:50.367 SB.CALL 184 Clearing         Called the clearResponse routine
                16:14:50.368 SB.CALL 184 State change  >> Clearing->CallIdlePending

                16:14:50.369 SB.CCM release:

                16:14:50.369 SB.CCM  :  Call Struct 0x2952e10 :   Call-ID = 184

                16:14:50.370 SB.CCM  :  Org Acct = 9903Dst Acct = T03

                16:14:50.371 SB.CCM  :  Org Port ID = 0/14.0   Dst Port ID = 0/0.0

                16:14:50.371 SB.CCM  :  Org TID = Fxs   Dst TID = Isdn Group Table

                16:14:50.372 SB.CCM release: Call Connection Type is TDM_TO_TDM

                16:14:50.372 SB.CALL 184 CallIdlePending  ClearResponse sent from 9903 to T03
                16:14:50.373 SA.9903 Ca:0 Idle             rcvd: AcctPhoneMgr_appearance(OFF) from PM
                16:14:50.374 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_cachg(CAS_Idle) to PM
                16:14:50.374 PM.0:14 Clearing Busy    Dropped CACHG w/Call State not RINGING

                16:14:50.375 TONESERVICES.EVENTS fxs 0/14 - empty - Busy Generation: Request resource

                16:14:50.376 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: DSP channel allocated for the resource

                16:14:50.376 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: constructed

                16:14:50.377 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: starting

                16:14:50.377 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: TDM map

                16:14:50.378 TA.T03 clearResponse event rejected, no matching CallID

                2016.05.26 16:14:50 TM.T03 07 IsdnTmStateIdling - clear trunk appearance

                2016.05.26 16:14:51 SMDR 184    05/26/2016 16:14:50  0.0 0I  00/14 XXXXXXXXXXXXXXXXXXX  6073044673  00/00 T03         2225393     0 N 
                16:14:55.642 PM.0:14 Clearing Busy    Processed OnHook
                16:14:55.643 PM.0:14 State change  >> Clearing Busy->Idle

                16:14:55.644 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: stopping

                16:14:55.645 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: TDM unmap

                16:14:55.645 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - Busy Generation: releasing RTP resource

                16:14:55.646 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: release

                16:14:55.647 SA.9903 rcvd: AcctPhoneMgr_COSOverride from PM

                16:14:58.525 PM.0:14 Idle             Processed OFFHOOK
                16:14:58.525 PM.0:14 State change  >> Idle->Requesting Dialtone
                16:14:58.526 SA.9903 Ca:0 Idle             rcvd: AcctPhoneMgr_appearance(ON) from PM
                16:14:58.526 SA.9903 Ca:0 State change  >> Idle->DigitGathering
                16:14:58.527 SA.9903 Ca:0 DigitGathering   sent: AcctPhoneMgr_cachg(CAS_ReqDigits) to PM

                16:14:58.527 PM.0:14 Requesting Dialtone  CACHG:ReqDigits on primary CA

                16:14:58.528 PM.0:14 State change  >> Requesting Dialtone->SendingDigits

                16:14:58.530 TONESERVICES.EVENTS fxs 0/14 - empty - Tone Detection: Request resource

                16:14:58.531 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: DSP channel allocated for the resource

                16:14:58.531 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: constructed

                16:14:58.532 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: starting

                16:14:58.533 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: TDM map

                16:14:59.031 TONESERVICES.EVENTS fxs 0/14 - empty - DialTone Generation: Request resource

                16:14:59.032 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: DSP channel allocated for the resource

                16:14:59.033 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: constructed

                16:14:59.033 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: starting

                16:14:59.034 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: TDM map

                16:14:59.591 PM.0:14 SendingDigits    Processed ONHOOK
                16:14:59.592 PM.0:14 State change  >> SendingDigits->Idle
                16:14:59.594 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_appearance(OFF) from PM
                16:14:59.594 SA.9903 Ca:0 State change  >> DigitGathering->Idle
                16:14:59.595 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_faxModem to PM
                16:14:59.595 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_cachg(CAS_Idle) to PM
                16:14:59.596 PM.0:14 Idle             Dropped CACHG w/Call State not RINGING

                16:14:59.597 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: stopping

                16:14:59.597 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: TDM unmap

                16:14:59.598 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - DialTone Generation: releasing RTP resource

                16:14:59.599 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: release

                16:14:59.599 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: stopping

                16:14:59.600 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: TDM unmap

                16:14:59.600 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - Tone Detection: releasing RTP resource

                16:14:59.601 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: release

                16:14:59.602 SA.9903 rcvd: AcctPhoneMgr_COSOverride from PM

                16:15:10.647 PM.0:14 Idle             Processed OFFHOOK
                16:15:10.648 PM.0:14 State change  >> Idle->Requesting Dialtone
                16:15:10.648 SA.9903 Ca:0 Idle             rcvd: AcctPhoneMgr_appearance(ON) from PM
                16:15:10.649 SA.9903 Ca:0 State change  >> Idle->DigitGathering
                16:15:10.649 SA.9903 Ca:0 DigitGathering   sent: AcctPhoneMgr_cachg(CAS_ReqDigits) to PM

                16:15:10.650 PM.0:14 Requesting Dialtone  CACHG:ReqDigits on primary CA

                16:15:10.651 PM.0:14 State change  >> Requesting Dialtone->SendingDigits

                16:15:10.653 TONESERVICES.EVENTS fxs 0/14 - empty - Tone Detection: Request resource

                16:15:10.653 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: DSP channel allocated for the resource

                16:15:10.654 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: constructed

                16:15:10.655 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: starting

                16:15:10.655 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: TDM map

                16:15:11.154 TONESERVICES.EVENTS fxs 0/14 - empty - DialTone Generation: Request resource

                16:15:11.155 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: DSP channel allocated for the resource

                16:15:11.155 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: constructed

                16:15:11.156 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: starting

                16:15:11.156 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: TDM map

                16:15:12.631 PM.0:14 SendingDigits    Digit 1 processed

                16:15:12.632 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (1) event

                16:15:12.632 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: stopping

                16:15:12.633 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: TDM unmap

                16:15:12.633 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - DialTone Generation: releasing RTP resource

                16:15:12.634 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: release

                16:15:12.635 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(1) from PM
                16:15:12.635 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 second(s) for more digits
                16:15:13.370 PM.0:14 SendingDigits    Digit 6 processed

                16:15:13.371 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (6) event

                16:15:13.372 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(6) from PM
                16:15:13.372 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:13.800 PM.0:14 SendingDigits    Digit 0 processed

                16:15:13.801 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (0) event

                16:15:13.801 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(0) from PM
                16:15:13.802 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:14.160 PM.0:14 SendingDigits    Digit 7 processed

                16:15:14.161 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (7) event

                16:15:14.161 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(7) from PM
                16:15:14.162 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:14.740 PM.0:14 SendingDigits    Digit 2 processed

                16:15:14.741 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:15:14.741 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:15:14.742 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:15.070 PM.0:14 SendingDigits    Digit 2 processed

                16:15:15.071 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:15:15.072 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:15:15.072 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:15.350 PM.0:14 SendingDigits    Digit 2 processed

                16:15:15.351 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:15:15.352 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:15:15.352 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:16.130 PM.0:14 SendingDigits    Digit 5 processed

                16:15:16.131 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (5) event

                16:15:16.132 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(5) from PM
                16:15:16.132 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:17.940 PM.0:14 SendingDigits    Processed ONHOOK
                16:15:17.941 PM.0:14 State change  >> SendingDigits->Idle
                16:15:17.942 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_appearance(OFF) from PM
                16:15:17.942 SA.9903 Ca:0 State change  >> DigitGathering->Idle
                16:15:17.943 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_faxModem to PM
                16:15:17.943 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_cachg(CAS_Idle) to PM
                16:15:17.944 PM.0:14 Idle             Dropped CACHG w/Call State not RINGING

                16:15:17.945 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: stopping

                16:15:17.945 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: TDM unmap

                16:15:17.946 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - Tone Detection: releasing RTP resource

                16:15:17.947 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: release

                16:15:17.947 SA.9903 rcvd: AcctPhoneMgr_COSOverride from PM

                16:15:18.072 PM.0:14 Idle             Processed OFFHOOK
                16:15:18.073 PM.0:14 State change  >> Idle->Requesting Dialtone
                16:15:18.073 SA.9903 Ca:0 Idle             rcvd: AcctPhoneMgr_appearance(ON) from PM
                16:15:18.074 SA.9903 Ca:0 State change  >> Idle->DigitGathering
                16:15:18.074 SA.9903 Ca:0 DigitGathering   sent: AcctPhoneMgr_cachg(CAS_ReqDigits) to PM

                16:15:18.075 PM.0:14 Requesting Dialtone  CACHG:ReqDigits on primary CA

                16:15:18.075 PM.0:14 State change  >> Requesting Dialtone->SendingDigits

                16:15:18.077 TONESERVICES.EVENTS fxs 0/14 - empty - Tone Detection: Request resource

                16:15:18.078 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: DSP channel allocated for the resource

                16:15:18.078 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: constructed

                16:15:18.079 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: starting

                16:15:18.080 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: TDM map

                16:15:18.579 TONESERVICES.EVENTS fxs 0/14 - empty - DialTone Generation: Request resource

                16:15:18.579 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: DSP channel allocated for the resource

                16:15:18.580 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: constructed

                16:15:18.581 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: starting

                16:15:18.582 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: TDM map

                16:15:19.408 ISDN.L2_FMT PRI  1  ==============================================

                16:15:19.408 ISDN.L2_FMT PRI  1  Recd  Sapi:00 C/R:R Tei:00 INFO Ns:6   Nr:58  P:0

                16:15:19.408 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:02F2
                16:15:19.409 ISDN.L2_FMT PRI  1    M - 05 SETUP 
                16:15:19.409 ISDN.L2_FMT PRI  1     IE - 04 BEARER CAPABILITY   Len=3
                16:15:19.410 ISDN.L2_FMT PRI  1          80 Xfer Cap.:SPEECH      
                16:15:19.410 ISDN.L2_FMT PRI  1          90 Xfer Rate:64k  
                16:15:19.411 ISDN.L2_FMT PRI  1          A2 Layer 1:u-Law    
                16:15:19.411 ISDN.L2_FMT PRI  1     IE - 18 CHANNEL ID      Len=3
                16:15:19.412 ISDN.L2_FMT PRI  1          A9 Primary Rate
                16:15:19.412 ISDN.L2_FMT PRI  1             Intfc ID:IMPLICIT
                16:15:19.412 ISDN.L2_FMT PRI  1             Pref/Excl:EXCLUSIVE
                16:15:19.413 ISDN.L2_FMT PRI  1             D-Chan Indicated:NO
                16:15:19.413 ISDN.L2_FMT PRI  1             Chan. Sel:FOLLOWS
                16:15:19.413 ISDN.L2_FMT PRI  1          83 Numb/Map:NUMBER
                16:15:19.414 ISDN.L2_FMT PRI  1          96 Channel:22
                16:15:19.414 ISDN.L2_FMT PRI  1     IE - 1E PROGRESS INDICATOR  Len=2
                16:15:19.415 ISDN.L2_FMT PRI  1          81 Location:LPN
                16:15:19.415 ISDN.L2_FMT PRI  1          83 Description:ORIG. NOT ISDN   
                16:15:19.415 ISDN.L2_FMT PRI  1     IE - 6C CALLING PARTY # Len=12
                16:15:19.416 ISDN.L2_FMT PRI  1          21 Numb. Type:NATIONAL
                16:15:19.416 ISDN.L2_FMT PRI  1             Numb. Plan:E.164    
                16:15:19.416 ISDN.L2_FMT PRI  1          80 Presentation:ALLOWED
                16:15:19.417 ISDN.L2_FMT PRI  1             Ph.# 6072387077
                16:15:19.417 ISDN.L2_FMT PRI  1     IE - 70 CALLED PARTY #  Len=8
                16:15:19.418 ISDN.L2_FMT PRI  1          80 Numb. Type:UNKNOWN 
                16:15:19.418 ISDN.L2_FMT PRI  1             Numb. Plan:UNKNOWN  
                16:15:19.418 ISDN.L2_FMT PRI  1             Ph.# 2395254
                16:15:19.419 ISDN.L2_FMT PRI  1     IE - 7C LOW LAYER COMPAT.   Len=3
                16:15:19.419 ISDN.L2_FMT PRI  1          80 Info Xfer Cap:Speech.
                16:15:19.419 ISDN.L2_FMT PRI  1          90 Octet 4
                16:15:19.420 ISDN.L2_FMT PRI  1          A2 Octet 5
                16:15:19.420 ISDN.L2_FMT PRI  1     IE - 7D HIGH LAYER COMPAT.  Len=2
                16:15:19.420 ISDN.L2_FMT PRI  1          91 Coding Standard:CCITT.
                16:15:19.421 ISDN.L2_FMT PRI  1             Interpretation:Octet 4 only.
                16:15:19.421 ISDN.L2_FMT PRI  1             Pres Method:High Layer Prot Profile
                16:15:19.422 ISDN.L2_FMT PRI  1          81 High Layer Char ID:Telephony.

                16:15:19.423 ISDN.L2_FMT PRI  1  ==============================================

                16:15:19.424 ISDN.L2_FMT PRI  1  Sent  Sapi:00 C/R:C Tei:00 INFO Ns:58  Nr:7   P:0

                16:15:19.424 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:82F2
                16:15:19.425 ISDN.L2_FMT PRI  1    M - 02 CALL_PROC  
                16:15:19.425 ISDN.L2_FMT PRI  1     IE - 18 CHANNEL ID      Len=3
                16:15:19.426 ISDN.L2_FMT PRI  1          A9 Primary Rate
                16:15:19.426 ISDN.L2_FMT PRI  1             Intfc ID:IMPLICIT
                16:15:19.426 ISDN.L2_FMT PRI  1             Pref/Excl:EXCLUSIVE
                16:15:19.427 ISDN.L2_FMT PRI  1             D-Chan Indicated:NO
                16:15:19.427 ISDN.L2_FMT PRI  1             Chan. Sel:FOLLOWS
                16:15:19.427 ISDN.L2_FMT PRI  1          83 Numb/Map:NUMBER
                16:15:19.428 ISDN.L2_FMT PRI  1          96 Channel:22

                16:15:19.428 TM.T03 22 en bloc sending call rec'd

                16:15:19.429 TM.T03 22 IsdnTmStateIdle->IsdnTmStateInboundAccept

                16:15:19.430 TM.T03 22 IsdnTmStateInboundAccept::enter() send call to acct

                16:15:19.431 TA.T03 22 TAIdle           rcvd: inboundCall from TM
                16:15:19.431 TA.T03 22 State change  >> TAIdle->TAInboundCall (TAS_Calling)

                16:15:19.432 TA.T03 22 Failed - DID translation: no match for 2395254, using 2395254

                16:15:19.433 TA.T03 22 TAIdle           sent: call to SB

                16:15:19.434 TM.T03 22 tachg_TAInboundCall do nothing

                16:15:19.434 SB.CALL 185 Idle             Called the call routine with 2395254

                16:15:19 SB.TGMgr For dialed number 2395254, against template $, on TrunkGroup PRI TO PBX, the score is 500

                16:15:19 SB.TGMgr For dialed number 2395254, against template $, on TrunkGroup SIP VI, the score is 500

                16:15:19.437 SB.CCM isMappable:

                16:15:19.437 SB.CCM  :  Call Struct 0x2984c10 :   Call-ID = 185

                16:15:19.438 SB.CCM  :  Org Acct = T03Dst Acct = T01

                16:15:19.438 SB.CCM  :  Org Port ID = 0/2.22   Dst Port ID = 0/0.0

                16:15:19.439 SB.CCM  :  Org TID = Ds1Ds0Usage   Dst TID =

                16:15:19.439 SB.CCM isMappable: Call Connection Type is TDM_TO_RTP

                16:15:19.440 SB.CCM isMappable: Reserving RTP Channel 0/1.3

                16:15:19.441 SB.CCM isMappable: Creating SDP Offer

                16:15:19.443 SB.CCM getBestMatchCodecList: G729 PCMU

                16:15:19.445 SB.CALL 185 Idle             Call sent from T03 to T01 (2395254)
                16:15:19.446 SB.CALL 185 State change  >> Idle->Delivering

                16:15:19.446 RTP.MANAGER t1 0/2.0.22 - empty - RTP: Request resource

                16:15:19.447 RTP.MANAGER t1 0/2.0.22 - dsp 0/1.3 - RTP: DSP channel allocated for the resource

                16:15:19.448 RTP.PROVIDER t1 0/2.0.22 - dsp 0/1.3 - RTP: providing already allocated RTP channel

                16:15:19.448 TA.T03 22 TAInboundCall    CallResp event accepted
                16:15:19.449 TA.T03 22 State change  >> TAInboundCall->TAConnectWaitIn (TAS_Calling)
                16:15:19.450 TA.T01 33 State change  >> TAIdle->TAOutGoing (TAS_Delivering)
                16:15:19.451 TM.T01 33 SipTM_Idle       State change  >> SipTM_Idle->SipTM_Delivering

                16:15:19.452 TA.T01 33 DNIS Substitution: dialed number 2395254 -> 16072395254

                16:15:19.452 TA.T01 33 DNIS Substitution: dialed number 2395254 -> dialed name "local"

                16:15:19.454 TM.T01 33 call-leg (0x259eac0) -> src-ip: XXX.XXX.XXX.XXX  dst-ip: 64.136.174.30

                16:15:19.456 TM.T01 33 Undo of previous operation not required (RTP NAT Entry for 127.0.0.2:10004 not found)

                16:15:19.456 TM.T01 33 Checking for internal Media Gateway IP Address

                16:15:19.457 TM.T01 33 Using RTP Channel 0/1.3

                16:15:19.457 TM.T01 33 Inserting XXX.XXX.XXX.XXX into SDP for Media Gateway on interface eth 0/1

                16:15:19.459 TM.T01 33 Adding RTP Media Gateway Entry: 127.0.0.2:10004 -> XXX.XXX.XXX.XXX:10004

                16:15:19.459 TM.T01 33 No action taken, firewall traversal is not enabled

                16:15:19.464 SIP.STACK MSG Tx: UDP src=XXX.XXX.XXX.XXX:5060 dst=64.136.174.30:5060

                 

                16:15:19.464 SIP.STACK MSG     INVITE sip:16072395254@64.136.174.30:5060 SIP/2.0
                16:15:19.465 SIP.STACK MSG     From: <sip:6072387077@64.136.174.30:5060;transport=UDP>;tag=25843b0-7f000001-13c4-d092-512dd0d9-d092
                16:15:19.465 SIP.STACK MSG     To: "local" <sip:16072395254@64.136.174.30:5060>
                16:15:19.466 SIP.STACK MSG     Call-ID: 259eac0-7f000001-13c4-d092-390708b9-d092@64.136.174.30
                16:15:19.466 SIP.STACK MSG     CSeq: 1 INVITE
                16:15:19.467 SIP.STACK MSG     Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:5060;branch=z9hG4bK-d092-32ebe19-1b069291
                16:15:19.467 SIP.STACK MSG     Max-Forwards: 70
                16:15:19.468 SIP.STACK MSG     Supported: 100rel,replaces
                16:15:19.468 SIP.STACK MSG     Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER
                16:15:19.469 SIP.STACK MSG     User-Agent: ADTRAN_Total_Access_916_2nd_Gen/A4.11.00.E
                16:15:19.470 SIP.STACK MSG     Contact: <sip:6072387077@XXX.XXX.XXX.XXX:5060;transport=UDP>
                16:15:19.470 SIP.STACK MSG     Content-Type: application/sdp
                16:15:19.471 SIP.STACK MSG     Content-Length: 208
                16:15:19.471 SIP.STACK MSG
                16:15:19.472 SIP.STACK MSG     v=0
                16:15:19.472 SIP.STACK MSG     o=- 1464293719 1464293719 IN IP4 XXX.XXX.XXX.XXX
                16:15:19.473 SIP.STACK MSG     s=-
                16:15:19.473 SIP.STACK MSG     c=IN IP4 XXX.XXX.XXX.XXX
                16:15:19.474 SIP.STACK MSG     t=0 0
                16:15:19.474 SIP.STACK MSG     m=audio 10004 RTP/AVP 18 0
                16:15:19.475 SIP.STACK MSG     a=rtpmap:18 G729/8000
                16:15:19.475 SIP.STACK MSG     a=fmtp:18 annexb=no
                16:15:19.476 SIP.STACK MSG     a=rtpmap:0 PCMU/8000
                16:15:19.476 SIP.STACK MSG     a=silenceSupp:off - - - -
                16:15:19.477 SIP.STACK MSG
                16:15:19.478 TM.T01 33 SipTM_Delivering call-leg -> Inviting
                16:15:19.479 TM.T01 33 SipTM_Delivering sent: INVITE
                16:15:19.480 SB.CALL 185 Delivering       Called the deliverResponse routine from Delivering
                16:15:19.481 SB.CALL 185 Delivering       DeliverResponse(accept) sent from T01 to T03
                16:15:19.482 TA.T03 22 TAConnectWaitIn  deliverResponse event accepted
                16:15:19.482 TA.T03 22 TAConnectWaitIn  ERROR! deliverResponse ignored
                16:15:19.641 SIP.STACK MSG Rx: UDP src=64.136.174.30:5060 dst=XXX.XXX.XXX.XXX:5060

                 

                16:15:19.641 SIP.STACK MSG     SIP/2.0 100 Trying
                16:15:19.642 SIP.STACK MSG     Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:5060;branch=z9hG4bK-d092-32ebe19-1b069291
                16:15:19.642 SIP.STACK MSG     To: "local" <sip:16072395254@64.136.174.30:5060>
                16:15:19.643 SIP.STACK MSG     From: <sip:6072387077@64.136.174.30:5060;transport=UDP>;tag=25843b0-7f000001-13c4-d092-512dd0d9-d092
                16:15:19.643 SIP.STACK MSG     Call-ID: 259eac0-7f000001-13c4-d092-390708b9-d092@64.136.174.30
                16:15:19.644 SIP.STACK MSG     CSeq: 1 INVITE
                16:15:19.644 SIP.STACK MSG     Content-Length: 0
                16:15:19.645 SIP.STACK MSG
                16:15:19.648 TM.T01 33 SipTM_Delivering rcvd SIP call-leg response: 100 Trying
                16:15:19.649 TM.T01 33 SipTM_Delivering No Supported header in message
                16:15:19.649 TM.T01 33 SipTM_Delivering rcvd: Provisional Response 100 Trying
                16:15:19.650 TM.T01 33 SipTM_Delivering call-leg -> Proceeding
                16:15:21.517 SIP.STACK MSG Rx: UDP src=64.136.174.30:5060 dst=XXX.XXX.XXX.XXX:5060

                 

                16:15:21.517 SIP.STACK MSG     SIP/2.0 183 Session Progress
                16:15:21.518 SIP.STACK MSG     Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:5060;branch=z9hG4bK-d092-32ebe19-1b069291
                16:15:21.518 SIP.STACK MSG     Record-Route: <sip:sansay2589032518rdb16371@64.136.174.30:5060;lr;transport=udp>
                16:15:21.519 SIP.STACK MSG     To: "local" <sip:16072395254@64.136.174.30:5060>;tag=sansay2589032518rdb16371
                16:15:21.520 SIP.STACK MSG     From: <sip:6072387077@64.136.174.30:5060;transport=UDP>;tag=25843b0-7f000001-13c4-d092-512dd0d9-d092
                16:15:21.520 SIP.STACK MSG     Call-ID: 259eac0-7f000001-13c4-d092-390708b9-d092@64.136.174.30
                16:15:21.521 SIP.STACK MSG     CSeq: 1 INVITE
                16:15:21.521 SIP.STACK MSG     Contact: <sip:16072395254@64.136.174.30:5060>
                16:15:21.522 SIP.STACK MSG     Content-Type: application/sdp
                16:15:21.522 SIP.STACK MSG     Content-Length: 170
                16:15:21.523 SIP.STACK MSG
                16:15:21.523 SIP.STACK MSG     v=0
                16:15:21.524 SIP.STACK MSG     o=Sansay-VSXi 188 1 IN IP4 64.136.174.30
                16:15:21.524 SIP.STACK MSG     s=Session Controller
                16:15:21.525 SIP.STACK MSG     c=IN IP4 69.85.181.73
                16:15:21.525 SIP.STACK MSG     t=0 0
                16:15:21.526 SIP.STACK MSG     m=audio 20958 RTP/AVP 0
                16:15:21.526 SIP.STACK MSG     a=rtpmap:0 PCMU/8000
                16:15:21.527 SIP.STACK MSG     a=sendrecv
                16:15:21.527 SIP.STACK MSG     a=ptime:20
                16:15:21.528 SIP.STACK MSG
                16:15:21.532 TM.T01 33 SipTM_Delivering rcvd SIP call-leg response: 183 Session Progress
                16:15:21.533 TM.T01 33 SipTM_Delivering No Supported header in message
                16:15:21.534 TM.T01 33 SipTM_Delivering rcvd: Provisional Response 183 Session Progress (with SDP)
                16:15:21.535 TM.T01 33 SipTM_Delivering sent: TA->PreConnect
                16:15:21.536 TA.T01 33 TAOutGoing       rcvd: preConnect from TM
                16:15:21.536 SB.CALL 185 State change  >> Delivering->PreConnecting
                16:15:21.537 SB.CALL 185 PreConnecting    Call PreConnecting from T01 to T03
                16:15:21.538 TA.T03 22 TAConnectWaitIn  preConnect event accepted

                16:15:21.539 TM.T03 22 IsdnTmStateInboundAccept->IsdnTmStateInboundPreconnect

                16:15:21.539 TM.T03 22 IsdnTmStateInboundPreconnect::enter()

                16:15:21.540 TA.T03 22 TAConnectWaitIn  rcvd: preConnectResponse from TM

                16:15:21.541 SB.CCM connect:

                16:15:21.541 SB.CCM  :  Call Struct 0x2984c10 :   Call-ID = 185

                16:15:21.542 SB.CCM  :  Org Acct = T03Dst Acct = T01

                16:15:21.542 SB.CCM  :  Org Port ID = 0/2.22   Dst Port ID = 0/0.32

                16:15:21.543 SB.CCM  :  Org TID = Ds1Ds0Usage   Dst TID =

                16:15:21.543 SB.CCM  :  SDP Transaction = CallID: 185

                16:15:21.544 SB.CCM  :  SDP Offer = 0x02991d10, (127.0.0.2:10004)

                16:15:21.545 SB.CCM  :  SDP Answer = 0x0298a610, (69.85.181.73:20958)

                16:15:21.545 SB.CCM  :  RTP Channel = 0/1.3

                16:15:21.546 SB.CCM connect: Call Connection Type is TDM_TO_RTP

                16:15:21.546 SB.CCM offer ip 127.0.0.2, 10004, answer ip 69.85.181.73, 20958

                16:15:21.548 SB.CCM Looking up outbound interface to 69.85.181.73

                16:15:21.549 ISDN.L2_FMT PRI  1  ==============================================

                16:15:21.549 ISDN.L2_FMT PRI  1  Sent  Sapi:00 C/R:C Tei:00 INFO Ns:59  Nr:7   P:0

                16:15:21.550 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:82F2
                16:15:21.550 ISDN.L2_FMT PRI  1    M - 03 PROGRESS   
                16:15:21.551 ISDN.L2_FMT PRI  1     IE - 1E PROGRESS INDICATOR  Len=2
                16:15:21.551 ISDN.L2_FMT PRI  1          82 Location:LN
                16:15:21.551 ISDN.L2_FMT PRI  1          88 Description:INBAND AUDIO AVAIL
                16:15:21.553 PM.0:14 SendingDigits    Digit 6 processed

                16:15:21.553 SB.CCM Changing RTP Channel source IP Address to XXX.XXX.XXX.XXX for Media Gateway on interface eth 0/1

                16:15:21.554 SB.CCM connect: TDM streams: Table Ds1Ds0Usage 0/2.22 to Table 12372 0/1.3

                16:15:21.555 SB.CCM not tdm only, call setupRtpChannel

                16:15:21.555 SB.CCM setupRtpChannel, type 3, source 1, silence 0

                16:15:21.556 SB.CCM TheCallConnectionManager::setupRtpChannel, IP addr = 69.85.181.73, port = 20958

                16:15:21.557 SB.CCM connect: Undo of previous operation not required

                16:15:21.558 SB.CCM getFinalCodec: PCMU

                16:15:21.559 SB.CCM connect: Configuring RTP Channel 0/1.3 to 69.85.181.73:20958 via PCMU

                16:15:21.560 SB.CCM connect: fpp=2 echo=on dtmf=0/0 dscp=46 vad=off

                16:15:21.561 SB.CCM connect: Starting RTP Channel

                16:15:21.561 RTP.CHANNEL Channel 0/1.3 session statistics cleared.

                16:15:21.562 RTP.CHANNEL Channel 0/1.3 started sucessfully.

                16:15:21.562 SB.CCM firewallConnectCall: No action taken, firewall traversal is not enabled

                16:15:21.563 SB.CALL 185 State change  >> PreConnecting->PreConnected
                16:15:21.564 SB.CALL 185 PreConnected     Call PreConnecting from T03 to T01

                16:15:21.565 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (6) event

                16:15:21.565 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: stopping

                16:15:21.566 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: TDM unmap

                16:15:21.567 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - DialTone Generation: releasing RTP resource

                16:15:21.567 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: release

                16:15:21.568 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(6) from PM
                16:15:21.569 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 second(s) for more digits

                16:15:21.570 RTP.CHANNEL t1 0/2.0.22 - dsp 0/1.3 - RTP: starting

                16:15:21.573 TA.T01 ERROR! preConnectResponse ignored

                16:15:22.440 PM.0:14 SendingDigits    Digit 0 processed

                16:15:22.441 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (0) event

                16:15:22.441 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(0) from PM
                16:15:22.442 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:23.010 PM.0:14 SendingDigits    Digit 7 processed

                16:15:23.011 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (7) event

                16:15:23.012 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(7) from PM
                16:15:23.013 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:23.770 PM.0:14 SendingDigits    Digit 2 processed

                16:15:23.771 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:15:23.772 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:15:23.773 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:24.120 PM.0:14 SendingDigits    Digit 2 processed

                16:15:24.121 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:15:24.121 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:15:24.122 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:24.400 PM.0:14 SendingDigits    Digit 2 processed

                16:15:24.401 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:15:24.401 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:15:24.402 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:24.870 PM.0:14 SendingDigits    Digit 5 processed

                16:15:24.871 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (5) event

                16:15:24.872 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(5) from PM
                16:15:24.873 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:25.230 PM.0:14 SendingDigits    Digit 3 processed

                16:15:25.231 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (3) event

                16:15:25.232 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(3) from PM
                16:15:25.232 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:25.660 PM.0:14 SendingDigits    Digit 9 processed

                16:15:25.661 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (9) event

                16:15:25.661 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(9) from PM
                16:15:25.662 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:26.050 PM.0:14 SendingDigits    Digit 3 processed

                16:15:26.051 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (3) event

                16:15:26.052 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(3) from PM
                16:15:26.052 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:26.053 SA.9903 Ca:0 State change  >> DigitGathering->DigitGathering
                16:15:26.054 SA.9903 Ca:0 DigitGathering   sent: AcctPhoneMgr_cachg(CAS_Active) to PM
                16:15:26.054 PM.0:14 State change  >> SendingDigits->Call Pending
                16:15:26.056 SA.9903 Ca:0 DigitGathering   sent: call to SB
                16:15:26.056 SA.9903 Ca:0 State change  >> DigitGathering->CallPending

                16:15:26.057 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: stopping

                16:15:26.058 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: TDM unmap

                16:15:26.059 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - Tone Detection: releasing RTP resource

                16:15:26.059 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: release

                16:15:26.060 SA.9903 rcvd: AcctPhoneMgr_billingCode from PM

                16:15:26.060 SB.CALL 186 Idle             Called the call routine with 6072225393

                16:15:26 SB.TGMgr For dialed number 6072225393, against template $, on TrunkGroup PRI TO PBX, the score is 500

                16:15:26 SB.TGMgr For dialed number 6072225393, against template $, on TrunkGroup SIP VI, the score is 500

                16:15:26.062 SB.CCM isMappable:

                16:15:26.063 SB.CCM  :  Call Struct 0x2983c10 :   Call-ID = 186

                16:15:26.063 SB.CCM  :  Org Acct = 9903Dst Acct = T03

                16:15:26.064 SB.CCM  :  Org Port ID = 0/14.0   Dst Port ID = 0/0.0

                16:15:26.065 SB.CCM  :  Org TID = Fxs   Dst TID =

                16:15:26.065 SB.CCM isMappable: Call Connection Type is TDM_TO_TDM

                16:15:26.066 SB.CALL 186 Idle             Call sent from 9903 to T03 (6072225393)
                16:15:26.066 SB.CALL 186 State change  >> Idle->Delivering
                16:15:26.067 SA.9903 Ca:0 CallPending      rcvd: callResponse from SB
                16:15:26.067 SA.9903 Ca:0 State change  >> CallPending->Calling
                16:15:26.068 TA.T03 06 State change  >> TAIdle->TAOutGoing (TAS_Delivering)

                16:15:26.069 TM.T03 06 tachg_Delivering

                16:15:26.070 TM.T03 06 IsdnTmStateIdle->IsdnTmStateOutboundDeliver

                16:15:26.071 TM.T03 06 IsdnTmStateOutboundDeliver::enter()

                16:15:26.072 ISDN.L2_FMT PRI  1  ==============================================

                16:15:26.073 ISDN.L2_FMT PRI  1  Sent  Sapi:00 C/R:C Tei:00 INFO Ns:60  Nr:7   P:0

                16:15:26.073 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:006D
                16:15:26.074 ISDN.L2_FMT PRI  1    M - 05 SETUP 
                16:15:26.074 ISDN.L2_FMT PRI  1     IE - 04 BEARER CAPABILITY   Len=3
                16:15:26.074 ISDN.L2_FMT PRI  1          80 Xfer Cap.:SPEECH      
                16:15:26.075 ISDN.L2_FMT PRI  1          90 Xfer Rate:64k  
                16:15:26.075 ISDN.L2_FMT PRI  1          A2 Layer 1:u-Law    
                16:15:26.075 ISDN.L2_FMT PRI  1     IE - 18 CHANNEL ID      Len=3
                16:15:26.076 ISDN.L2_FMT PRI  1          A1 Primary Rate
                16:15:26.076 ISDN.L2_FMT PRI  1             Intfc ID:IMPLICIT
                16:15:26.076 ISDN.L2_FMT PRI  1             Pref/Excl:PREFERRED
                16:15:26.077 ISDN.L2_FMT PRI  1             D-Chan Indicated:NO
                16:15:26.077 ISDN.L2_FMT PRI  1             Chan. Sel:FOLLOWS
                16:15:26.077 ISDN.L2_FMT PRI  1          83 Numb/Map:NUMBER
                16:15:26.078 ISDN.L2_FMT PRI  1          86 Channel:6
                16:15:26.078 ISDN.L2_FMT PRI  1     IE - 1C FACILITY        Len=28
                16:15:26.078 ISDN.L2_FMT PRI  1      Calling Name: XXXXXXXXXXXXXXXXXXX
                16:15:26.079 ISDN.L2_FMT PRI  1     IE - 6C CALLING PARTY # Len=12
                16:15:26.079 ISDN.L2_FMT PRI  1          00 Numb. Type:UNKNOWN 
                16:15:26.080 ISDN.L2_FMT PRI  1             Numb. Plan:UNKNOWN  
                16:15:26.080 ISDN.L2_FMT PRI  1          80 Presentation:ALLOWED
                16:15:26.081 ISDN.L2_FMT PRI  1             Ph.# 6073044673
                16:15:26.081 ISDN.L2_FMT PRI  1     IE - 70 CALLED PARTY #  Len=11
                16:15:26.081 ISDN.L2_FMT PRI  1          80 Numb. Type:UNKNOWN 
                16:15:26.082 ISDN.L2_FMT PRI  1             Numb. Plan:UNKNOWN  
                16:15:26.082 ISDN.L2_FMT PRI  1             Ph.# 6072225393
                16:15:26.083 SB.CALL 186 Delivering       Called the deliverResponse routine from Delivering
                16:15:26.083 SB.CALL 186 Delivering       DeliverResponse(accept) sent from T03 to 9903
                16:15:26.084 SA.9903 Ca:0 Calling          rcvd: deliverResponse from SB
                16:15:26.085 SA.9903 Ca:0 Calling          sent: AcctPhoneMgr_info to PM

                16:15:26.085 PM.0:14 ERROR! APM_Info ignored

                16:15:26.163 ISDN.L2_FMT PRI  1  ==============================================

                16:15:26.164 ISDN.L2_FMT PRI  1  Recd  Sapi:00 C/R:R Tei:00 INFO Ns:7   Nr:61  P:0

                16:15:26.164 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:806D
                16:15:26.164 ISDN.L2_FMT PRI  1    M - 5A RELEASE_CMP
                16:15:26.165 ISDN.L2_FMT PRI  1     IE - 08 CAUSE           Len=2
                16:15:26.165 ISDN.L2_FMT PRI  1          80 Location:U
                16:15:26.166 ISDN.L2_FMT PRI  1          91 Cause:17 (USER_BUSY)

                16:15:26.169 TM.T03 06 IsdnTmStateOutboundDeliver->IsdnTmStateTrunkClearing

                16:15:26.170 TM.T03 06 IsdnTmStateTrunkClearing::enter()

                16:15:26.171 TM.T03 06 IsdnTmStateTrunkClearing->IsdnTmStateIdling

                16:15:26.171 TM.T03 06 IsdnTmStateIdling::enter()

                16:15:26.172 TM.T03 06 IsdnTmStateIdling - send appearance off

                16:15:26.172 TM.T03 06 IsdnTmStateIdling->IsdnTmStateIdle

                16:15:26.173 TM.T03 06 IsdnAppearanceChannel::releaseChannel

                16:15:26.173 TM.T03 06 IsdnTmStateIdle::enter()

                16:15:26.174 TA.T03 06 TAOutGoing       rcvd: clear from TM
                16:15:26.175 TA.T03 06 State change  >> TAOutGoing->TATrunkClearing (TAS_Clearing)

                16:15:26.175 TM.T03 06 IsdnTmStateIdle::tachgClearing - send appearance off

                16:15:26.176 TA.T03 06 TATrunkClearing  rcvd: clear from TM
                16:15:26.177 TA.T03 06 State change  >> TATrunkClearing->TAClearingComplete (TAS_Clearing)

                16:15:26.177 TA.T03 06 TAClearingComplete   rcvd: appearance off from TM

                16:15:26.178 TA.T03 06 TAClearingComplete   Clear Local Variables

                16:15:26.178 TA.T03 06 State change  >> TAClearingComplete->TAIdle (TAS_Idle)
                16:15:26.179 SB.CALL 186 Delivering       Called the clearCall routine from Delivering
                16:15:26.180 SB.CALL 186 Delivering       Clearing due to Trunk Clear Reason on call from T03 to 9903
                16:15:26.181 SB.CALL 186 State change  >> Delivering->Clearing
                16:15:26.181 TA.T03 06 TAIdle           rcvd: appearance off from TM
                16:15:26.182 TA.T03 06 TAIdle           Processing an appearance OFF
                16:15:26.182 SA.9903 Ca:0 Calling          rcvd: clearCall from SB
                16:15:26.183 SA.9903 Ca:0 Calling          sent: clearResponse(pass) to SB
                16:15:26.183 SA.9903 Ca:0 State change  >> Calling->Idle
                16:15:26.184 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_faxModem to PM
                16:15:26.185 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_cachg(CAS_Idle) to PM
                16:15:26.186 PM.0:14 Call Pending     Pri CA, Idle response, App OFF sent
                16:15:26.186 PM.0:14 State change  >> Call Pending->Clearing Busy
                16:15:26.188 SB.CALL 186 Clearing         Called the clearResponse routine
                16:15:26.188 SB.CALL 186 State change  >> Clearing->CallIdlePending

                16:15:26.189 SB.CCM release:

                16:15:26.189 SB.CCM  :  Call Struct 0x2983c10 :   Call-ID = 186

                16:15:26.191 SB.CCM  :  Org Acct = 9903Dst Acct = T03

                16:15:26.191 SB.CCM  :  Org Port ID = 0/14.0   Dst Port ID = 0/0.0

                16:15:26.192 SB.CCM  :  Org TID = Fxs   Dst TID = Isdn Group Table

                16:15:26.192 SB.CCM release: Call Connection Type is TDM_TO_TDM

                16:15:26.193 SB.CALL 186 CallIdlePending  ClearResponse sent from 9903 to T03
                16:15:26.194 SA.9903 Ca:0 Idle             rcvd: AcctPhoneMgr_appearance(OFF) from PM
                16:15:26.194 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_cachg(CAS_Idle) to PM
                16:15:26.195 PM.0:14 Clearing Busy    Dropped CACHG w/Call State not RINGING

                16:15:26.196 TONESERVICES.EVENTS fxs 0/14 - empty - Busy Generation: Request resource

                16:15:26.196 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: DSP channel allocated for the resource

                16:15:26.197 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: constructed

                16:15:26.197 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: starting

                16:15:26.198 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: TDM map

                16:15:26.199 TA.T03 clearResponse event rejected, no matching CallID

                2016.05.26 16:15:26 TM.T03 06 IsdnTmStateIdling - clear trunk appearance

                2016.05.26 16:15:27 SMDR 186    05/26/2016 16:15:26  0.0 0I  00/14 XXXXXXXXXXXXXXXXXXX  6073044673  00/00 T03         6072225393  0 N 
                16:15:28.725 SIP.STACK MSG Rx: UDP src=64.136.174.30:5060 dst=XXX.XXX.XXX.XXX:5060

                 

                16:15:28.726 SIP.STACK MSG     SIP/2.0 200 OK
                16:15:28.727 SIP.STACK MSG     Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:5060;branch=z9hG4bK-d092-32ebe19-1b069291
                16:15:28.727 SIP.STACK MSG     Record-Route: <sip:sansay2589032518rdb16371@64.136.174.30:5060;lr;transport=udp>
                16:15:28.728 SIP.STACK MSG     To: "local" <sip:16072395254@64.136.174.30:5060>;tag=sansay2589032518rdb16371
                16:15:28.728 SIP.STACK MSG     From: <sip:6072387077@64.136.174.30:5060;transport=UDP>;tag=25843b0-7f000001-13c4-d092-512dd0d9-d092
                16:15:28.729 SIP.STACK MSG     Call-ID: 259eac0-7f000001-13c4-d092-390708b9-d092@64.136.174.30
                16:15:28.729 SIP.STACK MSG     CSeq: 1 INVITE
                16:15:28.730 SIP.STACK MSG     Contact: <sip:16072395254@64.136.174.30:5060>
                16:15:28.730 SIP.STACK MSG     Content-Type: application/sdp
                16:15:28.732 SIP.STACK MSG     Content-Length: 170
                16:15:28.732 SIP.STACK MSG
                16:15:28.732 SIP.STACK MSG     v=0
                16:15:28.733 SIP.STACK MSG     o=Sansay-VSXi 188 1 IN IP4 64.136.174.30
                16:15:28.733 SIP.STACK MSG     s=Session Controller
                16:15:28.734 SIP.STACK MSG     c=IN IP4 69.85.181.73
                16:15:28.734 SIP.STACK MSG     t=0 0
                16:15:28.735 SIP.STACK MSG     m=audio 20958 RTP/AVP 0
                16:15:28.735 SIP.STACK MSG     a=rtpmap:0 PCMU/8000
                16:15:28.736 SIP.STACK MSG     a=sendrecv
                16:15:28.736 SIP.STACK MSG     a=ptime:20
                16:15:28.737 SIP.STACK MSG
                16:15:28.741 TM.T01 33 SipTM_Delivering rcvd SIP call-leg response: 200 OK
                16:15:28.741 TM.T01 33 SipTM_Delivering No Supported header in message
                16:15:28.742 TM.T01 33 SipTM_Delivering call-leg -> RemoteAccepted
                16:15:28.743 TM.T01 33 SipTM_Delivering Loose Routing detected in Record-Route header URL.
                16:15:28.744 TM.T01 33 SipTM_Delivering Using addr spec from Record-Route instead of Contact.
                16:15:28.745 TM.T01 33 SipTM_Delivering State change  >> SipTM_Delivering->SipTM_Answering
                16:15:28.746 TM.T01 33 SipTM_Answering  rcvd: SIP 200 OK
                16:15:28.747 TM.T01 33 SipTM_Answering  sent: TA->Connect
                16:15:28.748 TA.T01 33 TAOutGoing       rcvd: connect from TM
                16:15:28.749 TA.T01 33 State change  >> TAOutGoing->TAConnectWaitOut (TAS_Delivering)
                16:15:28.750 SB.CALL 185 PreConnected     Called the connect routine
                16:15:28.750 SB.CALL 185 State change  >> PreConnected->Connecting
                16:15:28.751 SB.CALL 185 Connecting       Connect sent from T01 to T03
                16:15:28.752 TA.T03 22 TAConnectWaitIn  connect event accepted
                16:15:28.752 TA.T03 22 State change  >> TAConnectWaitIn->TAConnectPending (TAS_Connected)

                16:15:28.753 TM.T03 22 IsdnTmStateInboundPreconnect->IsdnTmStateInboundConnecting

                16:15:28.754 TM.T03 22 IsdnTmStateInboundConnecting::enter()

                16:15:28.755 TM.T03 22 IsdnTmStateInboundConnecting->IsdnTmStateInboundConnected

                16:15:28.755 TM.T03 22 IsdnTmStateInboundConnected::enter()

                16:15:28.756 TA.T03 22 TAConnectPending rcvd: connect from TM

                16:15:28.756 TM.T03 22 IsdnAppearanceChannel::enableFaxModemToneDetect - delayFaxEnableEvent enqueued

                16:15:28.757 TA.T03 22 State change  >> TAConnectPending->TAConnected (TAS_Connected)
                16:15:28.758 SB.CALL 185 Connecting       Called the connectResponse routine

                16:15:28.758 SB.CCM connect:

                16:15:28.759 SB.CCM  :  Call Struct 0x2984c10 :   Call-ID = 185

                16:15:28.759 SB.CCM  :  Org Acct = T03Dst Acct = T01

                16:15:28.760 SB.CCM  :  Org Port ID = 0/2.22   Dst Port ID = 0/0.32

                16:15:28.760 SB.CCM  :  Org TID = Ds1Ds0Usage   Dst TID =

                16:15:28.761 SB.CCM  :  SDP Transaction = CallID: 185

                16:15:28.762 SB.CCM  :  SDP Offer = 0x02991d10, (127.0.0.2:10004)

                16:15:28.762 SB.CCM  :  SDP Answer = 0x028b2310, (69.85.181.73:20958)

                16:15:28.763 SB.CCM  :  RTP Channel = 0/1.3

                16:15:28.763 SB.CCM connect: Call Connection Type is TDM_TO_RTP

                16:15:28.764 SB.CCM offer ip 127.0.0.2, 10004, answer ip 69.85.181.73, 20958

                16:15:28.766 SB.CCM Looking up outbound interface to 69.85.181.73

                16:15:28.767 SB.CCM Changing RTP Channel source IP Address to XXX.XXX.XXX.XXX for Media Gateway on interface eth 0/1

                16:15:28.767 SB.CCM connect: TDM streams: Table Ds1Ds0Usage 0/2.22 to Table 12372 0/1.3

                16:15:28.768 SB.CCM not tdm only, call setupRtpChannel

                16:15:28.768 SB.CCM setupRtpChannel, type 3, source 2, silence 0

                16:15:28.769 ISDN.L2_FMT PRI  1  ==============================================

                16:15:28.770 ISDN.L2_FMT PRI  1  Sent  Sapi:00 C/R:C Tei:00 INFO Ns:61  Nr:8   P:0

                16:15:28.770 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:82F2
                16:15:28.771 ISDN.L2_FMT PRI  1    M - 07 CONNECT

                16:15:28.772 SB.CCM TheCallConnectionManager::setupRtpChannel, IP addr = 69.85.181.73, port = 20958

                16:15:28.772 SB.CCM connect: Undo of previous operation not required

                16:15:28.773 SB.CCM getFinalCodec: PCMU

                16:15:28.774 SB.CCM connect: Configuring RTP Channel 0/1.3 to 69.85.181.73:20958 via PCMU

                16:15:28.775 SB.CCM connect: fpp=2 echo=on dtmf=0/0 dscp=46 vad=off

                16:15:28.776 RTP.CHANNEL Channel 0/1.3 stopped sucessfully.

                16:15:28.777 SB.CCM connect: Starting RTP Channel

                16:15:28.777 RTP.CHANNEL Channel 0/1.3 session statistics cleared.

                16:15:28.778 RTP.CHANNEL Channel 0/1.3 started sucessfully.

                16:15:28.778 SB.CCM firewallConnectCall: No action taken, firewall traversal is not enabled

                16:15:28.779 SB.CALL 185 State change  >> Connecting->Connected
                16:15:28.780 SB.CALL 185 Connected        ConnectResponse sent from T03 to T01

                16:15:28.780 RTP.CHANNEL t1 0/2.0.22 - dsp 0/1.3 - RTP: stopping

                16:15:28.781 RTP.CHANNEL t1 0/2.0.22 - dsp 0/1.3 - RTP: starting

                16:15:28.782 TA.T01 33 TAConnectWaitOut connectResponse event accepted
                16:15:28.782 TA.T01 33 State change  >> TAConnectWaitOut->TAConnected (TAS_Connected)
                16:15:28.783 TM.T01 33 SipTM_Answering  tachg -> TAConnected
                16:15:28.784 TM.T01 33 SipTM_Answering  State change  >> SipTM_Answering->SipTM_Acking
                16:15:28.787 SIP.STACK MSG Tx: UDP src=XXX.XXX.XXX.XXX:5060 dst=64.136.174.30:5060

                 

                16:15:28.788 SIP.STACK MSG     ACK sip:16072395254@64.136.174.30:5060;transport=UDP SIP/2.0
                16:15:28.788 SIP.STACK MSG     From: <sip:6072387077@64.136.174.30:5060;transport=UDP>;tag=25843b0-7f000001-13c4-d092-512dd0d9-d092
                16:15:28.789 SIP.STACK MSG     To: "local" <sip:16072395254@64.136.174.30:5060>;tag=sansay2589032518rdb16371
                16:15:28.790 SIP.STACK MSG     Call-ID: 259eac0-7f000001-13c4-d092-390708b9-d092@64.136.174.30
                16:15:28.790 SIP.STACK MSG     CSeq: 1 ACK
                16:15:28.791 SIP.STACK MSG     Via: SIP/2.0/UDP XXX.XXX.XXX.XXX:5060;branch=z9hG4bK-d09c-32ee284-7160fc46
                16:15:28.792 SIP.STACK MSG     Max-Forwards: 70
                16:15:28.792 SIP.STACK MSG     Supported: 100rel,replaces
                16:15:28.793 SIP.STACK MSG     Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, PRACK, REFER, REGISTER
                16:15:28.793 SIP.STACK MSG     User-Agent: ADTRAN_Total_Access_916_2nd_Gen/A4.11.00.E
                16:15:28.794 SIP.STACK MSG     Contact: <sip:6072387077@XXX.XXX.XXX.XXX:5060;transport=UDP>
                16:15:28.794 SIP.STACK MSG     Route: <sip:sansay2589032518rdb16371@64.136.174.30:5060;transport=udp;lr>
                16:15:28.795 SIP.STACK MSG     Content-Length: 0
                16:15:28.795 SIP.STACK MSG
                16:15:28.797 TM.T01 33 SipTM_Acking     call-leg -> Connected
                16:15:28.798 TM.T01 33 SipTM_Acking     State change  >> SipTM_Acking->SipTM_Connected
                16:15:28.798 TM.T01 33 SipTM_Connected  call-leg-mod -> Modify Idle
                16:15:28.799 TM.T01 33 SipTM_Acking     sent: ACK

                16:15:29.007 TM.T03 22 IsdnApperanceChannel::delayFax

                16:15:29.008 TM.T03 22 faxModemDetResource - startResource Passed TA-21  dspRes-295f090

                16:15:29.009 TONESERVICES.EVENTS t1 0/2.0.22 - empty - Modem/FAX Detection: Request resource

                16:15:29.010 TONESERVICES.EVENTS t1 0/2.0.22 - dsp 0/1.3 - Modem/FAX Detection: DSP channel allocated for the resource

                16:15:29.011 TONESERVICES.EVENTS t1 0/2.0.22 - dsp 0/1.3 - Modem/FAX Detection: constructed

                16:15:29.011 TONESERVICES.EVENTS t1 0/2.0.22 - dsp 0/1.3 - Modem/FAX Detection: starting

                16:15:29.012 TONESERVICES.EVENTS t1 0/2.0.22 - dsp 0/1.3 - Modem/FAX Detection: TDM map

                16:15:30.326 PM.0:14 Clearing Busy    Processed OnHook
                16:15:30.327 PM.0:14 State change  >> Clearing Busy->Idle

                16:15:30.328 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: stopping

                16:15:30.329 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: TDM unmap

                16:15:30.330 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - Busy Generation: releasing RTP resource

                16:15:30.330 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: release

                16:15:30.331 SA.9903 rcvd: AcctPhoneMgr_COSOverride from PM

                16:15:33.462 PM.0:14 Idle             Processed OFFHOOK
                16:15:33.462 PM.0:14 State change  >> Idle->Requesting Dialtone
                16:15:33.463 SA.9903 Ca:0 Idle             rcvd: AcctPhoneMgr_appearance(ON) from PM
                16:15:33.463 SA.9903 Ca:0 State change  >> Idle->DigitGathering
                16:15:33.464 SA.9903 Ca:0 DigitGathering   sent: AcctPhoneMgr_cachg(CAS_ReqDigits) to PM

                16:15:33.465 PM.0:14 Requesting Dialtone  CACHG:ReqDigits on primary CA

                16:15:33.465 PM.0:14 State change  >> Requesting Dialtone->SendingDigits

                16:15:33.467 TONESERVICES.EVENTS fxs 0/14 - empty - Tone Detection: Request resource

                16:15:33.468 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: DSP channel allocated for the resource

                16:15:33.468 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: constructed

                16:15:33.469 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: starting

                16:15:33.470 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: TDM map

                16:15:33.968 TONESERVICES.EVENTS fxs 0/14 - empty - DialTone Generation: Request resource

                16:15:33.969 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: DSP channel allocated for the resource

                16:15:33.970 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: constructed

                16:15:33.971 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: starting

                16:15:33.972 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: TDM map

                16:15:35.591 PM.0:14 SendingDigits    Digit 1 processed

                16:15:35.592 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (1) event

                16:15:35.593 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: stopping

                16:15:35.593 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: TDM unmap

                16:15:35.594 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - DialTone Generation: releasing RTP resource

                16:15:35.595 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - DialTone Generation: release

                16:15:35.596 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(1) from PM
                16:15:35.596 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 second(s) for more digits
                16:15:36.261 PM.0:14 SendingDigits    Digit 6 processed

                16:15:36.262 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (6) event

                16:15:36.262 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(6) from PM
                16:15:36.263 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:36.731 PM.0:14 SendingDigits    Digit 0 processed

                16:15:36.732 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (0) event

                16:15:36.732 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(0) from PM
                16:15:36.733 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:37.160 PM.0:14 SendingDigits    Digit 7 processed

                16:15:37.161 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (7) event

                16:15:37.162 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(7) from PM
                16:15:37.163 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:37.840 PM.0:14 SendingDigits    Digit 2 processed

                16:15:37.841 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:15:37.842 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:15:37.843 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:38.200 PM.0:14 SendingDigits    Digit 2 processed

                16:15:38.201 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:15:38.202 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:15:38.203 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:38.511 PM.0:14 SendingDigits    Digit 2 processed

                16:15:38.512 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (2) event

                16:15:38.512 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(2) from PM
                16:15:38.513 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:38.991 PM.0:14 SendingDigits    Digit 5 processed

                16:15:38.992 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (5) event

                16:15:38.992 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(5) from PM
                16:15:38.993 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:39.371 PM.0:14 SendingDigits    Digit 3 processed

                16:15:39.372 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (3) event

                16:15:39.372 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(3) from PM
                16:15:39.373 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:39.840 PM.0:14 SendingDigits    Digit 9 processed

                16:15:39.842 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (9) event

                16:15:39.842 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(9) from PM
                16:15:39.843 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:40.260 PM.0:14 SendingDigits    Digit 3 processed

                16:15:40.261 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: received digit (3) event

                16:15:40.262 SA.9903 Ca:0 DigitGathering   rcvd: AcctPhoneMgr_dialDigit(3) from PM
                16:15:40.263 SA.9903 Ca:0 DigitGathering   Named-digit-timeout waiting 0 seconds for more digits
                16:15:40.263 SA.9903 Ca:0 State change  >> DigitGathering->DigitGathering
                16:15:40.264 SA.9903 Ca:0 DigitGathering   sent: AcctPhoneMgr_cachg(CAS_Active) to PM
                16:15:40.265 PM.0:14 State change  >> SendingDigits->Call Pending
                16:15:40.266 SA.9903 Ca:0 DigitGathering   sent: call to SB
                16:15:40.267 SA.9903 Ca:0 State change  >> DigitGathering->CallPending

                16:15:40.268 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: stopping

                16:15:40.268 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: TDM unmap

                16:15:40.269 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - Tone Detection: releasing RTP resource

                16:15:40.270 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Tone Detection: release

                16:15:40.271 SA.9903 rcvd: AcctPhoneMgr_billingCode from PM

                16:15:40.271 SB.CALL 187 Idle             Called the call routine with 16072225393

                16:15:40 SB.TGMgr For dialed number 16072225393, against template $, on TrunkGroup PRI TO PBX, the score is 500

                16:15:40 SB.TGMgr For dialed number 16072225393, against template $, on TrunkGroup SIP VI, the score is 500

                16:15:40.273 SB.CCM isMappable:

                16:15:40.274 SB.CCM  :  Call Struct 0x280bc10 :   Call-ID = 187

                16:15:40.274 SB.CCM  :  Org Acct = 9903Dst Acct = T03

                16:15:40.275 SB.CCM  :  Org Port ID = 0/14.0   Dst Port ID = 0/0.0

                16:15:40.275 SB.CCM  :  Org TID = Fxs   Dst TID =

                16:15:40.276 SB.CCM isMappable: Call Connection Type is TDM_TO_TDM

                16:15:40.277 SB.CALL 187 Idle             Call sent from 9903 to T03 (16072225393)
                16:15:40.277 SB.CALL 187 State change  >> Idle->Delivering
                16:15:40.278 SA.9903 Ca:0 CallPending      rcvd: callResponse from SB
                16:15:40.278 SA.9903 Ca:0 State change  >> CallPending->Calling
                16:15:40.279 TA.T03 05 State change  >> TAIdle->TAOutGoing (TAS_Delivering)

                16:15:40.280 TM.T03 05 tachg_Delivering

                16:15:40.281 TM.T03 05 IsdnTmStateIdle->IsdnTmStateOutboundDeliver

                16:15:40.282 TM.T03 05 IsdnTmStateOutboundDeliver::enter()

                16:15:40.283 ISDN.L2_FMT PRI  1  ==============================================

                16:15:40.283 ISDN.L2_FMT PRI  1  Sent  Sapi:00 C/R:C Tei:00 INFO Ns:62  Nr:8   P:0

                16:15:40.284 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:006E
                16:15:40.284 ISDN.L2_FMT PRI  1    M - 05 SETUP 
                16:15:40.284 ISDN.L2_FMT PRI  1     IE - 04 BEARER CAPABILITY   Len=3
                16:15:40.285 ISDN.L2_FMT PRI  1          80 Xfer Cap.:SPEECH      
                16:15:40.285 ISDN.L2_FMT PRI  1          90 Xfer Rate:64k  
                16:15:40.286 ISDN.L2_FMT PRI  1          A2 Layer 1:u-Law    
                16:15:40.286 ISDN.L2_FMT PRI  1     IE - 18 CHANNEL ID      Len=3
                16:15:40.286 ISDN.L2_FMT PRI  1          A1 Primary Rate
                16:15:40.287 ISDN.L2_FMT PRI  1             Intfc ID:IMPLICIT
                16:15:40.287 ISDN.L2_FMT PRI  1             Pref/Excl:PREFERRED
                16:15:40.287 ISDN.L2_FMT PRI  1             D-Chan Indicated:NO
                16:15:40.288 ISDN.L2_FMT PRI  1             Chan. Sel:FOLLOWS
                16:15:40.288 ISDN.L2_FMT PRI  1          83 Numb/Map:NUMBER
                16:15:40.288 ISDN.L2_FMT PRI  1          85 Channel:5
                16:15:40.289 ISDN.L2_FMT PRI  1     IE - 1C FACILITY        Len=28
                16:15:40.289 ISDN.L2_FMT PRI  1      Calling Name: XXXXXXXXXXXXXXXXXXX
                16:15:40.289 ISDN.L2_FMT PRI  1     IE - 6C CALLING PARTY # Len=12
                16:15:40.290 ISDN.L2_FMT PRI  1          00 Numb. Type:UNKNOWN 
                16:15:40.290 ISDN.L2_FMT PRI  1             Numb. Plan:UNKNOWN  
                16:15:40.291 ISDN.L2_FMT PRI  1          80 Presentation:ALLOWED
                16:15:40.291 ISDN.L2_FMT PRI  1             Ph.# 6073044673
                16:15:40.291 ISDN.L2_FMT PRI  1     IE - 70 CALLED PARTY #  Len=12
                16:15:40.292 ISDN.L2_FMT PRI  1          80 Numb. Type:UNKNOWN 
                16:15:40.292 ISDN.L2_FMT PRI  1             Numb. Plan:UNKNOWN  
                16:15:40.293 ISDN.L2_FMT PRI  1             Ph.# 16072225393
                16:15:40.294 SB.CALL 187 Delivering       Called the deliverResponse routine from Delivering
                16:15:40.295 SB.CALL 187 Delivering       DeliverResponse(accept) sent from T03 to 9903
                16:15:40.295 SA.9903 Ca:0 Calling          rcvd: deliverResponse from SB
                16:15:40.296 SA.9903 Ca:0 Calling          sent: AcctPhoneMgr_info to PM

                16:15:40.296 PM.0:14 ERROR! APM_Info ignored

                16:15:40.402 ISDN.L2_FMT PRI  1  ==============================================

                16:15:40.402 ISDN.L2_FMT PRI  1  Recd  Sapi:00 C/R:R Tei:00 INFO Ns:8   Nr:63  P:0

                16:15:40.403 ISDN.L2_FMT PRI  1    Prot:08  CRL:2  CRV:806E
                16:15:40.403 ISDN.L2_FMT PRI  1    M - 5A RELEASE_CMP
                16:15:40.404 ISDN.L2_FMT PRI  1     IE - 08 CAUSE           Len=2
                16:15:40.404 ISDN.L2_FMT PRI  1          80 Location:U
                16:15:40.405 ISDN.L2_FMT PRI  1          91 Cause:17 (USER_BUSY)

                16:15:40.410 TM.T03 05 IsdnTmStateOutboundDeliver->IsdnTmStateTrunkClearing

                16:15:40.410 TM.T03 05 IsdnTmStateTrunkClearing::enter()

                16:15:40.411 TM.T03 05 IsdnTmStateTrunkClearing->IsdnTmStateIdling

                16:15:40.412 TM.T03 05 IsdnTmStateIdling::enter()

                16:15:40.412 TM.T03 05 IsdnTmStateIdling - send appearance off

                16:15:40.413 TM.T03 05 IsdnTmStateIdling->IsdnTmStateIdle

                16:15:40.414 TM.T03 05 IsdnAppearanceChannel::releaseChannel

                16:15:40.414 TM.T03 05 IsdnTmStateIdle::enter()

                16:15:40.415 TA.T03 05 TAOutGoing       rcvd: clear from TM
                16:15:40.415 TA.T03 05 State change  >> TAOutGoing->TATrunkClearing (TAS_Clearing)

                16:15:40.416 TM.T03 05 IsdnTmStateIdle::tachgClearing - send appearance off

                16:15:40.417 TA.T03 05 TATrunkClearing  rcvd: clear from TM
                16:15:40.417 TA.T03 05 State change  >> TATrunkClearing->TAClearingComplete (TAS_Clearing)

                16:15:40.418 TA.T03 05 TAClearingComplete   rcvd: appearance off from TM

                16:15:40.418 TA.T03 05 TAClearingComplete   Clear Local Variables

                16:15:40.419 TA.T03 05 State change  >> TAClearingComplete->TAIdle (TAS_Idle)
                16:15:40.420 SB.CALL 187 Delivering       Called the clearCall routine from Delivering
                16:15:40.420 SB.CALL 187 Delivering       Clearing due to Trunk Clear Reason on call from T03 to 9903
                16:15:40.421 SB.CALL 187 State change  >> Delivering->Clearing
                16:15:40.422 TA.T03 05 TAIdle           rcvd: appearance off from TM
                16:15:40.423 TA.T03 05 TAIdle           Processing an appearance OFF
                16:15:40.423 SA.9903 Ca:0 Calling          rcvd: clearCall from SB
                16:15:40.424 SA.9903 Ca:0 Calling          sent: clearResponse(pass) to SB
                16:15:40.424 SA.9903 Ca:0 State change  >> Calling->Idle
                16:15:40.425 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_faxModem to PM
                16:15:40.426 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_cachg(CAS_Idle) to PM
                16:15:40.427 PM.0:14 Call Pending     Pri CA, Idle response, App OFF sent
                16:15:40.427 PM.0:14 State change  >> Call Pending->Clearing Busy
                16:15:40.429 SB.CALL 187 Clearing         Called the clearResponse routine
                16:15:40.429 SB.CALL 187 State change  >> Clearing->CallIdlePending

                16:15:40.430 SB.CCM release:

                16:15:40.431 SB.CCM  :  Call Struct 0x280bc10 :   Call-ID = 187

                16:15:40.431 SB.CCM  :  Org Acct = 9903Dst Acct = T03

                16:15:40.432 SB.CCM  :  Org Port ID = 0/14.0   Dst Port ID = 0/0.0

                16:15:40.432 SB.CCM  :  Org TID = Fxs   Dst TID = Isdn Group Table

                16:15:40.433 SB.CCM release: Call Connection Type is TDM_TO_TDM

                16:15:40.433 SB.CALL 187 CallIdlePending  ClearResponse sent from 9903 to T03
                16:15:40.434 SA.9903 Ca:0 Idle             rcvd: AcctPhoneMgr_appearance(OFF) from PM
                16:15:40.435 SA.9903 Ca:0 Idle             sent: AcctPhoneMgr_cachg(CAS_Idle) to PM
                16:15:40.435 PM.0:14 Clearing Busy    Dropped CACHG w/Call State not RINGING

                16:15:40.436 TONESERVICES.EVENTS fxs 0/14 - empty - Busy Generation: Request resource

                16:15:40.437 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: DSP channel allocated for the resource

                16:15:40.437 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: constructed

                16:15:40.438 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: starting

                16:15:40.439 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: TDM map

                16:15:40.439 TA.T03 clearResponse event rejected, no matching CallID

                2016.05.26 16:15:40 TM.T03 05 IsdnTmStateIdling - clear trunk appearance

                2016.05.26 16:15:41 SMDR 187    05/26/2016 16:15:40  0.0 0I  00/14 XXXXXXXXXXXXXXXXXXX  6073044673  00/00 T03         16072225393 0 N 
                16:15:44.582 PM.0:14 Clearing Busy    Processed OnHook
                16:15:44.583 PM.0:14 State change  >> Clearing Busy->Idle

                16:15:44.584 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: stopping

                16:15:44.585 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: TDM unmap

                16:15:44.586 RTP.CHANNEL fxs 0/14 - dsp 0/1.2 - Busy Generation: releasing RTP resource

                16:15:44.587 TONESERVICES.EVENTS fxs 0/14 - dsp 0/1.2 - Busy Generation: release

                16:15:44.587 SA.9903 rcvd: AcctPhoneMgr_COSOverride from PM

                • Re: Push ISDN/T1 Number to FXS ports?
                  jay Employee

                  Sam, the 900 is designed to act as a gateway between an IP source and a TDM source, whether it be one direction or another. It is not designed to route calls from one TDM interface to another and as such, that application has not been tested and can not be guaranteed to work. Thanks

                   

                  Jay

                  ADTRAN TSE