Tek-Tips is the largest IT community on the Internet today!

Members share and learn making Tek-Tips Forums the best source of peer-reviewed technical information on the Internet!

Register Log in
  • Congratulations biv343 on being selected by the Tek-Tips community for having the most helpful posts in the forums last week. Way to Go!

**ERROR**: host_disconnect_ack: Unfound B-channel on Discon

Status
Not open for further replies.
KeanoJ

KeanoJ

Technical User
Aug 22, 2008
4
IE
Any one figure out why My Dialup isn't working ?






version 12.4
service timestamps debug datetime msec
service timestamps log datetime msec
no service password-encryption
!
hostname XXXXXXX
!
boot-start-marker
boot-end-marker
!
logging buffered 4096 debugging
enable secret xxxxxxxxxxxxxxxxxxxxxxxxxxxxx
enable password xxxxx
!
no aaa new-model
!
resource policy
!
mmi polling-interval 60
no mmi auto-configure
no mmi pvc
mmi snmp-timeout 180
ip subnet-zero
ip cef
!
!
no ip dhcp use vrf connected
!
!
isdn switch-type basic-net3
!
!
!
!
interface FastEthernet0/0
no ip address
speed auto
full-duplex
no mop enabled
!
interface FastEthernet0/1
ip address 172.17.10.100 255.255.255.0
duplex auto
speed auto
!
interface BRI0/0/0
no ip address
encapsulation ppp
dialer pool-member 1
isdn switch-type basic-net3
isdn point-to-point-setup
ppp authentication chap
!
interface Dialer1
description outgoing to BNP
ip address 10.246.11.2 255.255.255.252
encapsulation ppp
dialer pool 1
dialer idle-timeout 300
dialer string xxxxxxxxx
dialer-group 1
ppp authentication chap
ppp chap hostname XXXXXX
ppp chap password 0 xxxxxxx
!
ip classless
ip route 10.5.0.0 255.255.255.0 10.246.11.1
ip route 192.168.1.90 255.255.255.255 172.17.10.1
!
ip http server
!
dialer-list 1 protocol ip permit
!
control-plane
!
!
line con 0
line aux 0
line vty 0 4
password xxxxx
login
!
end





Aug 22 17:01:42.626: BR0/0/0 DDR: rotor dialout [best] least recent failure is also most recent failure
Aug 22 17:01:42.626: BR0/0/0 DDR: rotor dialout [best] also has most recent failure
Aug 22 17:01:42.626: BR0/0/0 DDR: rotor dialout [best]
Aug 22 17:01:42.626: BR0/0/0 DDR: Dialing cause ip (s=10.246.11.2, d=10.246.11.1)
Aug 22 17:01:42.626: BR0/0/0 DDR: Attempting to dial xxxxxxxxxxxx
Aug 22 17:01:42.626: ISDN BR0/0/0 EVENT: UserIdle: callid 0x801D received ISDN_CALL (0x0)
Aug 22 17:01:42.626: ISDN BR0/0/0 EVENTd: UserIdle: Call to 015114300 at 64 Kb/s
Aug 22 17:01:42.626: ISDN BR0/0/0 SERROR: isdn_get_guid: Cannot allocate a GUID(5)
Aug 22 17:01:42.626: ISDN BR0/0/0 EVENTd: isdn_get_guid: Got Guid 00002644623C
Aug 22 17:01:42.626: ISDN BR0/0/0 EVENT: process_bri_call: call id 0x801D, called_number 015114300, Guid 00002644623C speed 64, call type DATA, bchan -1 clng_num none
Aug 22 17:01:42.626: ISDN BR0/0/0 EVENTd: process_bri_call: No name in GTD
Aug 22 17:01:42.626: ISDN BR0/0/0 SERROR: isdn_get_display_text_from_gtd: falseret
Aug 22 17:01:42.626: ISDN BR0/0/0 SERROR: isdn_get_mlpp_from_gtd: MLPP from GTDfailed
Aug 22 17:01:42.626: ISDN BR0/0/0 Q931d: Default type/plan 0x0 0x0 sw-type 1 Called number xxxxxxxx isdn_map 0 mask 0x0
Aug 22 17:01:42.626: ISDN BR0/0/0 Q931d: No call_decode, isdn default set
Aug 22 17:01:42.626: ISDN BR0/0/0 Q931: Applying typeplan for sw-type 0x1 is 0x0 0x0, Called num 015114300
Aug 22 17:01:42.626: ISDN BR0/0/0 CC: CCBRI_Go: source id 0x500, state 0, call id 0x0, event 0x1
Aug 22 17:01:42.626: ISDN BR0/0/0 CCd: CCBRI_Go: Host PkgInfo:
Aug 22 17:01:42.626: 010001801D0D700B0000303135313134
Aug 22 17:01:42.626: 33303004028890180183
Aug 22 17:01:42.626: ISDN BR0/0/0 CC: CCBRI_Go: call id 0x801D callref 0x0 state 1 event 0x1 Src->HOST
Aug 22 17:01:42.626: ISDN BR0/0/0 CCd: CCBRI_SetNewChan: ReleaseChan 3 earlier chan 0 exclusive 0
Aug 22 17:01:42.626: ISDN BR0/0/0 Q931d: CC_CHAN_GetIdleChanbri: Found idle channel B1
Aug 22 17:01:42.626: ISDN BR0/0/0 TGRM: get_tgrm_avail_state: idb 0x62B1F5A4 bchan 1 service_state 0 call_state 1 false busy 0x0 dsl 0
Aug 22 17:01:42.630: ISDN BR0/0/0 TGRM: update_tgrm_call_status: idb 0x62B1F5A4bchan 1 availability state 1 call state(prev,new) (0,1), dsl 0
Aug 22 17:01:42.630: ISDN BR0/0/0 TGRM: update_tgrm_call_status: Calling TGRM wi
th tgrm_call_isdn_update: idb 0x62B1F5A4 bchan 1 call state 2 call type 1 call dir 2
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 0 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 3 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 5 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 7 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 8 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_.msg: message 0x80 ie = 9 ie_allowed =0
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 10 ie_allowed =0
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 12 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 26 ie_allowed =0
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 15 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 16 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 17 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 19 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 21 ie_allowed =0
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 22 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 23 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 24 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 25 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 CC: ie_in_out_msg: message 0x80 ie = 4 ie_allowed =1
Aug 22 17:01:42.630: ISDN BR0/0/0 EVENTd: calltrkr_setup_received: isdn_info=1655834944l, call_id=0x801D ORIGINATE
Aug 22 17:01:42.630: ISDN BR0/0/0 EVENTd: calltrkr_setup_received: calltracker disabled
Aug 22 17:01:42.630: ISDN BR0/0/0 Q931d: L3_Go: source 0x0400, event 0x0080, call id 0x int id 0x801D
Aug 22 17:01:42.630: ISDN BR0/0/0 Q931d: L3_Go: event 0x80 cr_len 1 cr 0
Aug 22 17:01:42.630: ISDN BR0/0/0 Q931d: L3_Go: call_id 0x801D cr 0x0 state 0 event 0x80 ces 1
Aug 22 17:01:42.630: ISDN BR0/0/0 Q931d: L3_Proc.essEvent: callref = 0x0000 CC_SETUP_REQ:U0_SetupReq(nlcb)
Aug 22 17:01:42.630: ISDN BR0/0/0 Q931d: srl_send_l3_pak:source_id = Q.931 0x0300, dest_id = Q.921 0x0000, prim = DL_DATA_REQ 0x0240 priv_len = 4 int_id = 0x62B1F5A4 datasize = 39
Aug 22 17:01:42.630: ISDN BR0/0/0 Q931d: data =
Aug 22 17:01:42.634: 62B1F5A400000300024004BC00019000
Aug 22 17:01:42.634: 08011D0504028890180181700A803031
Aug 22 17:01:42.634: 35313134333030
Aug 22 17:01:42.634: ISDN BR0/0/0 Q931d: L3_state_change: callref 0x001D old NULL_STATE, new CALL_INIT
Aug 22 17:01:42.634: ISDN BR0/0/0 PACKET: handle_mail: received:dest_id = 0, source_id = 768, prim = 240priv_ln = 4, int_id = 1655829924, datasize = 39
Aug 22 17:01:42.634: ISDN BR0/0/0 PACKET: L2IF_DispPak: packet - start(E7001118), size (39)
Aug 22 17:01:42.634: 08011D0504028890180181700A803031
Aug 22 17:01:42.634: 35313134333030000000000000000000
Aug 22 17:01:42.634: 00000000000000
Aug 22 17:01:42.634: ISDN BR0/0/0 PACKET: handle_mail: received data =
Aug 22 17:01:42.634: 08011D0504028890180181700A803031
Aug 22 17:01:42.634: 35313134333030
Aug 22 17:01:42.634: ISDN BR0/0/0 Q921d: NOP: DLCB state 4 EventIndex 1 L2_Event576 Tei 0 DSL_Chan 0 ces 1 SAPI 0
Aug 22 17:01:46.634: ISDN LIFd: l3_timer: timer Expiry (0x62F60874), timer_type (0x1313)
Aug 22 17:01:46.634: ISDN BR0/0/0 Q931d: L3_Go: source 0x0300, event 0x1313, call id 0x int id 0x1D
Aug 22 17:01:46.634: ISDN BR0/0/0 Q931d: L3_Go: event 0x1313 cr_len 0 cr 0
Aug 22 17:01:46.634: ISDN BR0/0/0 Q931d: L3_Go: call_id 0x801D cr 0x1D state 1 event 0x1313 ces 1
Aug 22 17:01:46.634: ISDN BR0/0/0 Q931d: L3_ProcessEvent: callref = 0x001D T303_EXPIRY:U1_T303Expiry(nlcb)
Aug 22 17:0.1:46.634: ISDN BR0/0/0 Q931d: srl_send_l3_pak:source_id = Q.931 0x0300, dest_id = Q.921 0x0000, prim = DL_DATA_REQ 0x0240priv_len = 4 int_id = 0x62B1F5A4 datasize = 39
Aug 22 17:01:46.634: ISDN BR0/0/0 Q931d: data =
Aug 22 17:01:46.634: 62B1F5A400000300024004BC00019000
Aug 22 17:01:46.634: 08011D0504028890180181700A803031
Aug 22 17:01:46.634: 35313134333030
Aug 22 17:01:46.634: ISDN BR0/0/0 PACKET: handle_mail: received:dest_id = 0, source_id = 768, prim = 240priv_ln = 4, int_id = 1655829924, datasize = 39
Aug 22 17:01:46.634: ISDN BR0/0/0 PACKET: L2IF_DispPak: packet - start(E7001D98), size (39)
Aug 22 17:01:46.634: 08011D0504028890180181700A803031
Aug 22 17:01:46.634: 35313134333030000000000000000000
Aug 22 17:01:46.634: 00000000000000
Aug 22 17:01:46.634: ISDN BR0/0/0 PACKET: handle_mail: received data =
Aug 22 17:01:46.634: 08011D0504028890180181700A803031
Aug 22 17:01:46.634: 35313134333030
Aug 22 17:01:46.634: ISDN BR0/0/0 Q921d: NOP: DLCB state 4 EventIndex 1 L2_Event 576 Tei 0 DSL_Chan 0 ces 1 SAPI 0
Aug 22 17:01:46.634: ISDN LIFd: isdn_L3_timer_process: event_count (1).
Aug 22 17:01:50.634: ISDN LIFd: l3_timer: timer Expiry (0x62F60874), timer_type (0x1313)
Aug 22 17:01:50.634: ISDN BR0/0/0 Q931d: L3_Go: source 0x0300, event 0x1313, call id 0x int id 0x1D
Aug 22 17:01:50.634: ISDN BR0/0/0 Q931d: L3_Go: event 0x1313 cr_len 0 cr 0
Aug 22 17:01:50.634: ISDN BR0/0/0 Q931d: L3_Go: call_id 0x801D cr 0x1D state 1 event 0x1313 ces 1
Aug 22 17:01:50.634: ISDN BR0/0/0 Q931d: L3_ProcessEvent: callref = 0x001D T303_EXPIRY:U1_T303Expiry(nlcb)
Aug 22 17:01:50.634: ISDN BR0/0/0 Q931d: srl_send_l3_pak:source_id = Q.931 0x0300, dest_id = Q.921 0x0000, prim = DL_DATA_REQ 0x0240 priv_len = 4 int_id = 0x62B1F5A4 datasize = 24
Aug 22 17:01:50.634: ISDN BR0/0/0 Q931d: data =
Aug 22 17:01:50.634: 62B1F5A400000300024004BC00019000
Aug 22 17:01:50.634: 08011D5A080280E6
Aug 22 17:01:50.634: ISDN BR0/0/0 Q931d: L3_state_change: callref 0x001D old CALL_INIT, new NULL_STATE
Aug 22 17:01:50.634: ISDN BR0/0/0 PACKET: handle_mail: received: dest_id = 0, source_id = 768, prim = 240priv_ln = 4, int_id = 1655829924, datasize = 24
Aug 22 17:01:50.634: ISDN BR0/0/0 PACKET: L2IF_DispPak: packet - start(E73F4938), size (24)
Aug 22 17:01:50.634: 08011D5A080280E60000000000000000
Aug 22 17:01:50.634: 0000000000000000
Aug 22 17:01:50.634: ISDN BR0/0/0 PACKET: handle_mail: received data =
Aug 22 17:01:50.634: 08011D5A080280E6
Aug 22 17:01:50.634: ISDN BR0/0/0 Q921d: NOP: DLCB state 4 EventIndex 1 L2_Event 576 Tei 0 DSL_Chan 0 ces 1 SAPI 0
Aug 22 17:01:50.634: ISDN LIFd: isdn_L3_timer_process: event_count (1)
Aug 22 17:01:50.634: ISDN BR0/0/0 CC: CCBRI_Go: source id 0x300, state 1, call id 0x801D, event 0x341
Aug 22 17:01:50.634: ISDN BR0/0/0 CC: CCBRI_Go: call id 0x801D call ref 0x1D state 6 event 0x91 Src->L3
Aug 22 17:01:50.634: ISDN BR0/0/0 TGRM: get_tgrm_avail_state: idb 0x62B1F5A4 bchan 1 service_state 0 call_state 0 false busy 0x0 dsl 0
Aug 22 17:01:50.634: ISDN BR0/0/0 TGRM: update_tgrm_call_status: idb 0x62B1F5A4bchan 1 availability state 1 call state(prev,new) (1,0), dsl 0
Aug 22 17:01:50.634: ISDN BR0/0/0 TGRM: update_tgrm_call_status: Calling TGRM with tgrm_call_isdn_update: idb 0x62B1F5A4 bchan 1 call state 0 call type 0 call dir 1
Aug 22 17:01:50.638: ISDN EVENTd: cc_clear_free_list freed 0x63178B80
Aug 22 17:01:50.638: ISDN BR0/0/0 EVENT: process_rxstate: ces/callid 1/0x801D calltype 1 HOST_DISCONNECT_ACK
Aug 22 17:01:50.638: ISDN BR0/0/0 PACKET: process_rxstate:
Aug 22 17:01:50.638: 060001801D00
Aug 22 17:01:50.638: ISDN BR0/0/0 EVENTd: calltrkr_call_cleared: isdn_info=0x62B20940, call_id=0x801D
Aug 22 17:01:50.638: ISDN BR0/0/0 EVENTd: calltrkr_call_cleared: hndl=0l, cause=0, Unknown cause value
Aug 22 17:01:50.638: ISDN BR0/0/0 **ERROR**: host_disconnect_ack: Unfound B-channel on Disconnect_Ack call id 0x801D
Aug 22 17:02:12.626: BRI0/0/0: wait for isdn carrier timeout, call id=0x801D
Aug 22 17:02:12.626: ISDN BR0/0/0 EVENT: UserIdle: callid 0x801D received ISDN_HANGUP (0x1)
Aug 22 17:02:12.626: ISDN BR0/0/0 EVENTd: process_disconnect: call id 0x801D, call type is DATA, b_idb 0x62B1F5A4, ces 1, cause Normal call clearing(0x10)
Aug 22 17:02:12.626: ISDN BR0/0/0 EVENTd: calltrkr_call_disconnected: isdn_info=0x62B20940, call_id=0x801D
Aug 22 17:02:12.626: ISDN BR0/0/0 EVENTd: process_disconnect: Raw Release Message
Aug 22 17:02:12.626: 050001801D040802FF9008028090
Aug 22 17:02:12.626: ISDN BR0/0/0 CC: CCBRI_Go: source id 0x500, state 0, call id 0x0, event 0x5
Aug 22 17:02:12.626: ISDN BR0/0/0 CCd: CCBRI_Go: Host PkgInfo:
Aug 22 17:02:12.626: 050001801D040802FF9008028090
Aug 22 17:02:12.626: ISDN BR0/0/0 **ERROR**: CCBRI_Go: NO CCB Src->HOST call id0x801D, event 0x5 ces 1
Aug 22 17:02:12.626: ISDN BR0/0/0 EVENT: process_rxstate: ces/callid 1/0x801D calltype 1 HOST_QUERY_RESPONSE
Aug 22 17:02:12.626: ISDN BR0/0/0 PACKET: process_rxstate:
Aug 22 17:02:12.626: 0B0001801D03140100

 
Sort by date Sort by votes
Cisco IOS Software, 1841 Software (C1841-IPBASE-M), Version 12.4(1c), RELEASE SOFTWARE (fc1)
Technical Support: Copyright (c) 1986-2005 by Cisco Systems, Inc.
Compiled Tue 25-Oct-05 17:10 by evmiller

ROM: System Bootstrap, Version 12.4(13r)T, RELEASE SOFTWARE (fc1)

BallypheCD uptime is 1 week, 1 day, 23 hours, 30 minutes
System returned to ROM by reload at 17:58:54 UTC Wed Aug 13 2008
System restarted at 18:58:44 UTC Wed Aug 13 2008
System image file is "flash:c1841-ipbase-mz.124-1c.bin"

Cisco 1841 (revision 7.0) with 114688K/16384K bytes of memory.
Processor board ID FCZ122571UN
2 FastEthernet interfaces
1 ISDN Basic Rate interface
DRAM configuration is 64 bits wide with parity disabled.
191K bytes of NVRAM.
31360K bytes of ATA CompactFlash (Read/Write)
 
Upvote 0 Downvote
What are the chances of upgrading to a more recent release? You're running an extremely buggy version of IOS. I would highly recommend upgrading. It's pointless to waste time troubleshooting a config if the problem is actually a bug. There are many ISDN-related bugs in the code you're running. Can you upgrade to the most recent 12.4 image and see if it's still happening?
 
Upvote 0 Downvote
Thanks Jneiberger, I have tested the line using a spare draytek router we had lying around and it works fine, but heres the interesting thing, If I bring up the line using the draytek and immediately unplug the ISDN cable and insert it into the cisco Layer 1 comes up. it goes down again after a few seconds if I don't attempt to ping the destination, But Layer 2 still stays down... I will try and get a newer version of IOS from somewhere, I'm not quite sure where yet as we're not cisco partners, but we'll enlist outside help if needs be. hopefully this will solve my problem.
Many Thanks for your reply.
 
Upvote 0 Downvote
Have you verified that the Draytek is using the same ISDN switch type as the Cisco router?
 
Upvote 0 Downvote
I'm in Ireland, only one phone provider(Eircom) -I'm 99.9% sure it has to be basic-net3,
 
Upvote 0 Downvote
Status
Not open for further replies.

Similar threads

testman1
  • Locked
  • Question
SIP telephone ring on second call
Replies
0
Views
226
testman1
testman1
Skip Rango
  • Locked
  • Question
how to backup cisco sg500-52p switch
Replies
1
Views
414
madwok
madwok
stanlyn
  • Locked
  • Question
HowTo Install Multiple PAP2T ATA Devices on Same Lan
Replies
3
Views
322
iggsterman
iggsterman
VRRyan
  • Locked
  • Question
8831 Firmware Bug
Replies
0
Views
205
VRRyan
VRRyan
Pankaj88
  • Locked
  • Question
BGP Routing Clarification
Replies
0
Views
250
Pankaj88
Pankaj88

Part and Inventory Search

Sponsor

Back
Top