[Home]

Summary:ASTERISK-17669: Poor call quality – line drop, chopping sound, like robotic voice, Both party could not hear caller voice
Reporter:Mohd Aiman Rosli (man_evolution)Labels:
Date Opened:2011-04-11 05:06:55Date Closed:2011-06-07 14:00:25
Priority:MajorRegression?No
Status:Closed/CompleteComponents:Channels/chan_dahdi
Versions:1.8.4 Frequency of
Occurrence
Related
Issues:
Environment:Attachments:
Description:One of our client facing this issue, we have try to solve it but we're lack of asterisk knowledge. Anybody can help us? Isn't any problem with asterisk configuration or the problem come from PRI E1 itself?

****** ADDITIONAL INFORMATION ******

[Apr 11 15:32:48] VERBOSE[9231] chan_dahdi.c:     -- Requested transfer capability: 0x00 - SPEECH
[Apr 11 15:32:48] DEBUG[6888] channel.c: Avoiding initial deadlock for channel '0xb67f3d50'
[Apr 11 15:32:48] VERBOSE[9231] app_dial.c:     -- Called g0/0XXXXXXXXX
[Apr 11 15:32:48] DEBUG[9231] channel.c: Set channel DAHDI/2-1 to read format ulaw
[Apr 11 15:32:48] DEBUG[9231] channel.c: Set channel SIP/2130-000006fb to write format ulaw
[Apr 11 15:32:48] DEBUG[9231] channel.c: Set channel SIP/2130-000006fb to read format alaw
[Apr 11 15:32:48] DEBUG[2993] manager.c: Manager received command 'GetVar'
[Apr 11 15:32:48] NOTICE[9231] rtp.c: Unknown RTP codec 126 received from '192.168.100.130'
[Apr 11 15:32:48] DEBUG[2993] manager.c: Manager received command 'GetVar'
[Apr 11 15:32:48] DEBUG[6914] chan_dahdi.c: Queuing frame from PRI_EVENT_PROCEEDING on channel 0/2 span 1
[Apr 11 15:32:48] VERBOSE[9231] app_dial.c:     -- DAHDI/2-1 is proceeding passing it to SIP/2130-000006fb
[Apr 11 15:32:48] DEBUG[9231] rtp.c: Ooh, format changed from unknown to ulaw
[Apr 11 15:32:48] DEBUG[9232] audiohook.c: Failed to get 160 samples from read factory 0xb7817dd0
[Apr 11 15:32:48] DEBUG[9231] rtp.c: Created smoother: format: 4 ms: 20 len: 160
[Apr 11 15:32:48] DEBUG[6915] chan_dahdi.c: Queuing frame from PRI_EVENT_PROGRESS on channel 0/4 span 2
[Apr 11 15:32:48] VERBOSE[9226] app_dial.c:     -- DAHDI/35-1 is making progress passing it to SIP/2052-000006fa
[Apr 11 15:32:48] VERBOSE[9226] app_dial.c:     -- DAHDI/35-1 is making progress passing it to SIP/2052-000006fa
[Apr 11 15:32:48] DEBUG[6893] chan_sip.c: Allocating new SIP dialog for 656de8c01fcfde12371cfaa41a6cc357@127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:48] DEBUG[6893] chan_sip.c: Initializing initreq for method OPTIONS - callid 0ca5e0f16cc3027a450c5ce920189bc5@192.168.100.238
[Apr 11 15:32:48] DEBUG[6893] chan_sip.c: Stopping retransmission on '0ca5e0f16cc3027a450c5ce920189bc5@192.168.100.238' of Request 102: Match Found
[Apr 11 15:32:49] DEBUG[30773] rtp.c: Got RTCP report of 76 bytes
[Apr 11 15:32:49] DEBUG[9169] rtp.c: Got RTCP report of 76 bytes
[Apr 11 15:32:49] DEBUG[9198] rtp.c: Got RTCP report of 64 bytes
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Allocating new SIP dialog for 43bdc76362a70a0f138c364455fa976d@127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Initializing initreq for method OPTIONS - callid 645d2453470d5e3f1b3300d36c1f336b@192.168.100.238
[Apr 11 15:32:49] DEBUG[9189] rtp.c: Got RTCP report of 72 bytes
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Stopping retransmission on '645d2453470d5e3f1b3300d36c1f336b@192.168.100.238' of Request 102: Match Found
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Allocating new SIP dialog for 7c88de720bc203f659251e860637b998@127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Initializing initreq for method OPTIONS - callid 6229d4b2428b548648da2f357bd0eea6@192.168.100.238
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Allocating new SIP dialog for 7b0e287c51dcf9bc26f76b0c46e6aa5a@127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Initializing initreq for method OPTIONS - callid 49db5d9a0c803a873c1309244bbb034e@192.168.100.238
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Allocating new SIP dialog for 5e36015920aef5cd6bd842ba38143d86@127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Initializing initreq for method OPTIONS - callid 556cc68055c9aa9a1806c3ba0b3d0a43@192.168.100.238
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Stopping retransmission on '49db5d9a0c803a873c1309244bbb034e@192.168.100.238' of Request 102: Match Found
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Stopping retransmission on '556cc68055c9aa9a1806c3ba0b3d0a43@192.168.100.238' of Request 102: Match Found
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Stopping retransmission on '6229d4b2428b548648da2f357bd0eea6@192.168.100.238' of Request 102: Match Found
[Apr 11 15:32:49] DEBUG[9095] rtp.c: Got RTCP report of 72 bytes
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Allocating new SIP dialog for 405603ee4d0a129860728dbc01b42904@127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Initializing initreq for method OPTIONS - callid 2e8673db64cac2a0564cc1c81819aed3@192.168.100.238
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Stopping retransmission on '2e8673db64cac2a0564cc1c81819aed3@192.168.100.238' of Request 102: Match Found
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9203] rtp.c: Got RTCP report of 60 bytes
[Apr 11 15:32:49] DEBUG[9179] rtp.c: Got RTCP report of 72 bytes
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[7753] rtp.c: Got RTCP report of 72 bytes
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[1865] rtp.c: Got RTCP report of 72 bytes
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:49] DEBUG[9155] rtp.c: Got RTCP report of 76 bytes
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9106] audiohook.c: Failed to get 160 samples from read factory 0xb4a38510
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9204] audiohook.c: Failed to get 160 samples from read factory 0x87b8ee8
[Apr 11 15:32:50] DEBUG[9203] rtp.c: Channel '<unspecified>' has no RTP, not doing anything
[Apr 11 15:32:50] DEBUG[9203] channel.c: Hanging up channel 'DAHDI/69-1'
[Apr 11 15:32:50] DEBUG[9203] chan_dahdi.c: dahdi_hangup(DAHDI/69-1)
[Apr 11 15:32:50] DEBUG[9203] chan_dahdi.c: Set option AUDIO MODE, value: ON(1) on DAHDI/69-1
[Apr 11 15:32:50] DEBUG[9203] chan_dahdi.c: Hangup: channel: 69 index = 0, normal = 87, callwait = -1, thirdcall = -1
[Apr 11 15:32:50] DEBUG[9203] chan_dahdi.c: Not yet hungup...  Calling hangup once with icause, and clearing call
[Apr 11 15:32:50] DEBUG[9203] chan_dahdi.c: Set option TDD MODE, value: OFF(0) on DAHDI/69-1
[Apr 11 15:32:50] DEBUG[9203] chan_dahdi.c: Updated conferencing on 69, with 0 conference users
[Apr 11 15:32:50] DEBUG[9203] chan_dahdi.c: Set option AUDIO MODE, value: OFF(0) on DAHDI/69-1
[Apr 11 15:32:50] VERBOSE[9203] chan_dahdi.c:     -- Hungup 'DAHDI/69-1'
[Apr 11 15:32:50] DEBUG[9203] app_dial.c: Exiting with DIALSTATUS=CANCEL.
.........................................................................
[Apr 11 15:36:10] DEBUG[9337] audiohook.c: Failed to get 160 samples from read factory 0xb4243240
[Apr 11 15:36:10] DEBUG[9717] audiohook.c: Failed to get 160 samples from read factory 0x8872ac0
[Apr 11 15:36:10] DEBUG[9443] audiohook.c: Failed to get 160 samples from read factory 0xb4a4ad00
[Apr 11 15:36:10] DEBUG[7754] audiohook.c: Failed to get 160 samples from read factory 0xb780a800
[Apr 11 15:36:10] DEBUG[9389] audiohook.c: Failed to get 160 samples from read factory 0x879f710
[Apr 11 15:36:10] DEBUG[9170] audiohook.c: Failed to get 160 samples from read factory 0xb5cbb568
[Apr 11 15:36:10] DEBUG[2993] manager.c: Manager received command 'GetVar'
[Apr 11 15:36:10] DEBUG[6893] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '73e178f5465d0ff817ca38f73a1e3f1a@192.168.100.238' Request 102: Found
[Apr 11 15:36:10] DEBUG[6889] db.c: Unable to find key 'DND2105' in family 'CustomDevstate'
[Apr 11 15:36:10] DEBUG[9707] audiohook.c: Flushing audiohook 0x8959d48 so it remains in sync
[Apr 11 15:36:10] DEBUG[9335] rtp.c: Got RTCP report of 72 bytes
[Apr 11 15:36:10] DEBUG[9165] rtp.c: Got RTCP report of 76 bytes
[Apr 11 15:36:10] DEBUG[9442] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 35
[Apr 11 15:36:10] DEBUG[8518] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 63
[Apr 11 15:36:10] DEBUG[9169] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 7
[Apr 11 15:36:10] DEBUG[9316] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 71
[Apr 11 15:36:10] DEBUG[9388] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 6
[Apr 11 15:36:10] DEBUG[9723] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 75
[Apr 11 15:36:10] DEBUG[9707] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 9
[Apr 11 15:36:10] DEBUG[9336] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 67
[Apr 11 15:36:10] DEBUG[7799] chan_dahdi.c: Write returned -1 (Resource temporarily unavailable) on channel 36
-----------------------------------------------------------------------
[Apr 11 15:36:14] VERBOSE[10431] chan_dahdi.c:     -- Requested transfer capability: 0x00 - SPEECH
[Apr 11 15:36:14] DEBUG[6888] channel.c: Avoiding initial deadlock for channel '0xb5ce6220'
[Apr 11 15:36:14] VERBOSE[10431] app_dial.c:     -- Called g2/0138277798
[Apr 11 15:36:14] DEBUG[10431] channel.c: Set channel DAHDI/72-1 to read format ulaw
[Apr 11 15:36:14] DEBUG[10431] channel.c: Set channel SIP/2106-00000761 to write format ulaw
[Apr 11 15:36:14] DEBUG[10431] channel.c: Set channel SIP/2106-00000761 to read format alaw
[Apr 11 15:36:14] DEBUG[10431] chan_dahdi.c: Dropping frame since I'm still dialing on DAHDI/72-1...
[Apr 11 15:36:14] DEBUG[10432] audiohook.c: Failed to get 160 samples from write factory 0xb5c63440
[Apr 11 15:36:14] DEBUG[9237] audiohook.c: Failed to get 160 samples from read factory 0x8876a00
[Apr 11 15:36:14] DEBUG[9317] audiohook.c: Failed to get 160 samples from read factory 0xb5cd1e18
Comments:By: Leif Madsen (lmadsen) 2011-04-11 14:16:17

This is a support issue. Please use the asterisk-users mailing list. Thanks!