[asterisk-users] Poor call quality – line drop, chopping sound, like robotic voice, Both party could not hear caller voice

Mon Apr 11 20:42:37 CDT 2011

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?

[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 at 127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:48] DEBUG[6893] chan_sip.c: Initializing initreq for method
OPTIONS - callid 0ca5e0f16cc3027a450c5ce920189bc5 at 192.168.100.238
[Apr 11 15:32:48] DEBUG[6893] chan_sip.c: Stopping retransmission on '
0ca5e0f16cc3027a450c5ce920189bc5 at 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 at 127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Initializing initreq for method
OPTIONS - callid 645d2453470d5e3f1b3300d36c1f336b at 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 at 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 at 127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Initializing initreq for method
OPTIONS - callid 6229d4b2428b548648da2f357bd0eea6 at 192.168.100.238
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Allocating new SIP dialog for
7b0e287c51dcf9bc26f76b0c46e6aa5a at 127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Initializing initreq for method
OPTIONS - callid 49db5d9a0c803a873c1309244bbb034e at 192.168.100.238
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Allocating new SIP dialog for
5e36015920aef5cd6bd842ba38143d86 at 127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Initializing initreq for method
OPTIONS - callid 556cc68055c9aa9a1806c3ba0b3d0a43 at 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 at 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 at 192.168.100.238' of Request 102: Match
Found
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Stopping retransmission on '
6229d4b2428b548648da2f357bd0eea6 at 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 at 127.0.1.1 - OPTIONS (No RTP)
[Apr 11 15:32:49] DEBUG[6893] chan_sip.c: Initializing initreq for method
OPTIONS - callid 2e8673db64cac2a0564cc1c81819aed3 at 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 at 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 at 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

Thanks & Regards,
Aiman Rosli
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.digium.com/pipermail/asterisk-users/attachments/20110412/9923dd3f/attachment.htm>