Problem on elastix 1.6 with misdn and b400/b200p

alfil2k

Joined
Aug 17, 2009
Messages
25
Likes
0
Points
0
#1
Hi guys,

We have a couple of asterisk box installed with Elastix 1.6.2-7 with misdn 1.1.9.1-0. We found an error, when the asterisk run the dynamic loader, this is the log:

Code:
[Mar 17 10:35:27] VERBOSE[13089] logger.c:     -- mISDN/2-u3590 is proceeding passing it to SIP/108-000003ff
[Mar 17 10:35:34] VERBOSE[13089] logger.c:   == Everyone is busy/congested at this time (1:0/0/1)
[Mar 17 10:35:38] VERBOSE[13168] logger.c: Asterisk Event Logger Started /var/log/asterisk/event_log
[Mar 17 10:35:38] VERBOSE[13168] logger.c: Asterisk Dynamic Loader Starting:
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Parsing '/etc/asterisk/modules.conf': [Mar 17 10:35:38] VERBOSE[13168] logger.c: Found
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Parsing '/etc/asterisk/dnsmgr.conf': [Mar 17 10:35:38] VERBOSE[13168] logger.c: Found
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Parsing '/etc/asterisk/http.conf': [Mar 17 10:35:38] VERBOSE[13168] logger.c: Found
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Parsing '/etc/asterisk/codecs.conf': [Mar 17 10:35:38] VERBOSE[13168] logger.c: Found
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action Ping
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action Events
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action Logoff
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action Hangup
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action Status
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action Setvar
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action Getvar
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action GetConfig
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action UpdateConfig
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action Redirect
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action Atxfer
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action Originate
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action Command
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action ExtensionState
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action AbsoluteTimeout
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action MailboxStatus
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action MailboxCount
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action ListCommands
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action UserEvent
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Manager registered action WaitEvent
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Parsing '/etc/asterisk/manager.conf': [Mar 17 10:35:38] VERBOSE[13168] logger.c: Found
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Parsing '/etc/asterisk/manager_additional.conf': [Mar 17 10:35:38] VERBOSE[13168] logger.c: Found
[Mar 17 10:35:38] VERBOSE[13168] logger.c:   == Parsing '/etc/asterisk/manager_custom.conf': [Mar 17 10:35:38] VERBOSE[13168] logger.c: Found
Continue loading... and we can see

Code:
[Mar 17 10:35:40] VERBOSE[13168] logger.c:   == Parsing '/etc/asterisk/misdn.conf': [Mar 17 10:35:40] VERBOSE[13168] logger.c: Found
[Mar 17 10:35:40] WARNING[13168] misdn_config.c: misdn.conf: "l1watcher_timeout=0" (section: general) invalid or out of range. Please edit your misdn.conf and then do a "misdn reload".
[Mar 17 10:35:40] WARNING[13168] misdn_config.c: misdn.conf: "echotraining=no" (section: default) invalid or out of range. Please edit your misdn.conf and then do a "misdn reload".
[Mar 17 10:35:40] VERBOSE[13168] logger.c:   == Registered channel type 'mISDN' (Channel driver for mISDN Support (Bri/Pri))
[Mar 17 10:35:40] VERBOSE[13168] logger.c:   == Registered application 'misdn_set_opt'
[Mar 17 10:35:40] VERBOSE[13168] logger.c:   == Registered application 'misdn_facility'
[Mar 17 10:35:40] VERBOSE[13168] logger.c:   == Registered application 'misdn_check_l2l1'
[Mar 17 10:35:40] VERBOSE[13168] logger.c: chan_misdn.so => (Channel driver for mISDN Support (BRI/PRI))
Here, a post the misdn.log. At this time:

Code:
Thu Mar 17 10:35:40 2011: P[ 0]  -- mISDN Channel Driver Registered --
Thu Mar 17 10:35:40 2011: P[ 2]  MGMT: SSTATUS: L1_ACTIVATED
Thu Mar 17 10:35:40 2011: P[ 2]  MGMT: SSTATUS: L2_ESTABLISH
Thu Mar 17 10:35:40 2011: P[ 4]  MGMT: SSTATUS: L1_ACTIVATED
Thu Mar 17 10:35:40 2011: P[ 4]  MGMT: SSTATUS: L2_ESTABLISH
Thu Mar 17 10:35:40 2011: P[ 3]  MGMT: SSTATUS: L1_ACTIVATED
Thu Mar 17 10:35:40 2011: P[ 3]  MGMT: SSTATUS: L2_ESTABLISH
Thu Mar 17 10:35:40 2011: P[ 1]  MGMT: SSTATUS: L1_ACTIVATED
Thu Mar 17 10:35:40 2011: P[ 1]  MGMT: SSTATUS: L2_ESTABLISH
Thu Mar 17 10:35:40 2011: P[ 5]  MGMT: SSTATUS: L1_DEACTIVATED
Thu Mar 17 10:35:40 2011: P[ 5]  MGMT: SSTATUS: L2_RELEASED
Thu Mar 17 10:35:40 2011: P[ 8]  MGMT: SSTATUS: L1_DEACTIVATED
Thu Mar 17 10:35:40 2011: P[ 8]  MGMT: SSTATUS: L2_RELEASED
Thu Mar 17 10:35:40 2011: P[ 6]  MGMT: SSTATUS: L1_DEACTIVATED
Thu Mar 17 10:35:40 2011: P[ 6]  MGMT: SSTATUS: L2_RELEASED
Thu Mar 17 10:35:40 2011: P[ 7]  MGMT: SSTATUS: L1_DEACTIVATED
Thu Mar 17 10:35:40 2011: P[ 7]  MGMT: SSTATUS: L2_RELEASED
Thu Mar 17 10:35:42 2011: P[ 2]   --> Didn't find BC so temporarily creating dummy BC (l3id:1102ca) on this port.
Thu Mar 17 10:35:42 2011: P[ 2]   --> found chan: 1
Thu Mar 17 10:35:42 2011: P[ 2]   --> TRANSPARENT Mode
Thu Mar 17 10:35:42 2011: P[ 2]  I IND :CONNECT oad: dad: pid:0 state:none
Thu Mar 17 10:35:42 2011: P[ 2]   --> channel:1 mode:TE cause:0 ocause:0 rad: cad:
Thu Mar 17 10:35:42 2011: P[ 2]   --> info_dad: onumplan:0 dnumplan:0 rnumplan:0 cpnnumplan:
Thu Mar 17 10:35:42 2011: P[ 2]   --> caps:Speech pi:0 keypad: sending_complete:0
Thu Mar 17 10:35:42 2011: P[ 2]  Chan not existing at the moment bc->l3id:1102ca bc:0xb6e4a7e8 event:CONNECT port:2 channel:1
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:20181 with addr:52010201 dinfo:0
Thu Mar 17 10:35:42 2011: P[ 0]  received 1k Unhandled Bchannel Messages: prim 20181 len 0 from addr 52010201, dinfo 0 on this port.
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
Thu Mar 17 10:35:42 2011: P[ 0]  handle_bchan: BC not found for prim:120282 with addr:52010201 dinfo:ffffffff
This error don't stop to appears on log and asterisk console, and the asterisk don't work. We have this issue randomly.

We suspect, that happens when the asterisk restart automatically and reload misdn driver when the people is calling.

Any suggestions? We can stop to asterisk to start reload automatically.
 

Members online

No members online now.

Latest posts

Forum statistics

Threads
30,913
Messages
130,917
Members
17,589
Latest member
cristian.saiz
Top