[Home]

Summary:ASTERISK-18989: Dropout in Moh. Seems to be a res_timing_timerfd issue
Reporter:Kristijan Vrban (vrban)Labels:
Date Opened:2011-12-08 04:46:07.000-0600Date Closed:2012-01-28 11:53:36.000-0600
Priority:MinorRegression?No
Status:Closed/CompleteComponents:Resources/res_timing_timerfd
Versions:1.8.7.1 Frequency of
Occurrence		Constant
Related
Issues:
Environment:Attachments:
Description:each time i see the following debug messages, the Moh has audio dropout:
{noformat}
[Dec  7 18:26:42] DEBUG[6993]: app_queue.c:3858 is_our_turn: There are 0 available members.
[Dec  7 18:26:42] DEBUG[6993]: app_queue.c:3875 is_our_turn: It's not our turn (SIP/TELEFONICA-00003a0e).
[Dec  7 18:26:42] DEBUG[6993]: res_timing_timerfd.c:206 timerfd_timer_ack: Expected to acknowledge 1 ticks but got 19 instead
[Dec  7 18:26:42] DEBUG[6993]: res_rtp_asterisk.c:1115 ast_rtp_raw_write: Difference is 2984, ms is 393


[Dec  7 18:28:41] DEBUG[7066]: app_queue.c:3858 is_our_turn: There are 0 available members.
[Dec  7 18:28:41] DEBUG[7066]: app_queue.c:3875 is_our_turn: It's not our turn (SIP/TELEFONICA-00003a11).
[Dec  7 18:28:41] DEBUG[7066]: res_timing_timerfd.c:206 timerfd_timer_ack: Expected to acknowledge 1 ticks but got 11 instead
[Dec  7 18:28:41] DEBUG[7066]: res_rtp_asterisk.c:1115 ast_rtp_raw_write: Difference is 1656, ms is 227


[Dec  7 18:31:02] DEBUG[7093]: res_timing_timerfd.c:206 timerfd_timer_ack: Expected to acknowledge 1 ticks but got 19 instead
[Dec  7 18:31:02] DEBUG[7093]: res_rtp_asterisk.c:1115 ast_rtp_raw_write: Difference is 3016, ms is 397

[Dec  7 18:32:24] DEBUG[7154]: app_queue.c:3858 is_our_turn: There are 0 available members.
[Dec  7 18:32:24] DEBUG[7154]: app_queue.c:3875 is_our_turn: It's not our turn (SIP/TELEFONICA-00003a17).
[Dec  7 18:32:24] DEBUG[7154]: res_timing_timerfd.c:206 timerfd_timer_ack: Expected to acknowledge 1 ticks but got 19 instead
[Dec  7 18:32:24] DEBUG[7154]: res_rtp_asterisk.c:1115 ast_rtp_raw_write: Difference is 2984, ms is 39

[Dec  7 18:33:46] DEBUG[7206]: app_queue.c:3858 is_our_turn: There are 0 available members.
[Dec  7 18:33:46] DEBUG[7206]: app_queue.c:3875 is_our_turn: It's not our turn (SIP/TELEFONICA-00003a1b).
[Dec  7 18:33:46] DEBUG[7206]: res_timing_timerfd.c:206 timerfd_timer_ack: Expected to acknowledge 1 ticks but got 12 instead
[Dec  7 18:33:46] DEBUG[7206]: res_rtp_asterisk.c:1115 ast_rtp_raw_write: Difference is 1808, ms is 246

[Dec  7 18:34:17] DEBUG[7206]: app_queue.c:3858 is_our_turn: There are 0 available members.
[Dec  7 18:34:17] DEBUG[7206]: app_queue.c:3875 is_our_turn: It's not our turn (SIP/TELEFONICA-00003a1b).
[Dec  7 18:34:17] DEBUG[7206]: res_timing_timerfd.c:206 timerfd_timer_ack: Expected to acknowledge 1 ticks but got 20 instead
[Dec  7 18:34:17] DEBUG[7206]: res_rtp_asterisk.c:1115 ast_rtp_raw_write: Difference is 3168, ms is 416
{noformat}
Comments:By: Leif Madsen (lmadsen) 2011-12-19 14:16:08.306-0600

What kernel are you on? (Distro, version, etc... also useful).

What was the load on the system at this time?

Are you able to provide any backtraces, 'core show locks' output when this is happening?

(To be honest I'm grasping at straws here a bit as I'm unsure exactly what information will be useful for debugging this issue.)
By: Paul Belanger (pabelanger) 2012-01-28 11:53:25.929-0600

Suspended due to lack of activity. Please request a bug marshal in #asterisk-bugs on the IRC network irc.freenode.net to reopen the issue should you have the additional information requested.  Further information can be found at http://www.asterisk.org/developers/bug-guidelines