[Freeswitch-users] FreeSwitch - mod_skypopen has no read codec or channel not ready

Shamun toha md shamun.toha at gmail.com
Tue Sep 28 04:35:23 PDT 2010


Hello,

This is another strange error i catch by screening it.

Materials:
===========

1. Switch 1 (30 channels as main simulation server)
2. Switch 2 (10 channels connects with in/out audio)
Step 2.a: 6 times originate skypopen/ANY/skypeswitch1 9999

3. Another PC running skype alone itself as a consumer test, to see what
happens in reality traffic.
Step 3.a: 1 times with real skype call skypeswitch1 and listen music quality

4. Medium Flood to switch 1 using remaining switch 2 channels

Note: When 7 channels are busy for 2 hours. And Problem 1 gets started, the
sound gets drop, and start latency, CPU gets overflow, and in the voice
there is a wind coming from left (like a storm/cyclone started).


Hardware status only for 7 active channels becomes as following:
===============================================
top - 13:15:44 up 3 days, 16:12,  2 users,  load average: 13.74, 10.06, 5.64
Tasks: 178 total,   3 running, 175 sleeping,   0 stopped,   0 zombie
*Cpu(s): 70.4%us, 13.6%sy,  0.0%ni, 15.5%id,  0.2%wa,  0.0%hi,  0.3%si,
0.0%st*
Mem:   8177580k total,  3371388k used,  4806192k free,   201836k buffers
Swap:  2096472k total,        0k used,  2096472k free,  1283920k cached


  PID USER      PR  NI  VIRT  RES  SHR S %CPU %MEM    TIME+
COMMAND

18719 root      18   0  434m  96m 6628 S 247.4  1.2  10:59.05
freeswitch

23094 root      15   0 93316  30m 3552 S 10.3  0.4  17:35.42
skype

22932 root      15   0 93568  30m 3556 S  9.0  0.4  20:43.74
skype

22706 root      15   0 92240  29m 3552 S  8.6  0.4  14:55.03
skype

.....


Problems1 : Non stop error like this, caused by flooding:
========================================

2010-09-28 12:54:45.878273 [ERR] switch_core_io.c:121 skypopen/interface14
has no read codec.
2010-09-28 12:54:45.881274 [ERR] switch_core_io.c:121 skypopen/interface14
has no read codec.
2010-09-28 12:54:45.883271 [ERR] switch_core_io.c:121 skypopen/interface14
has no read codec.
2010-09-28 12:54:45.886277 [ERR] switch_core_io.c:121 skypopen/interface14
has no read codec.
2010-09-28 12:54:45.888352 [ERR] switch_core_io.c:121 skypopen/interface14
has no read codec.
2010-09-28 12:54:45.891345 [ERR] switch_core_io.c:121 skypopen/interface14
has no read codec.


AND


2010-09-28 13:19:04.272557 [ERR] switch_core_io.c:121 skypopen/interface22
has no read codec.
2010-09-28 13:19:04.274541 [DEBUG] switch_ivr_play_say.c:1476 done playing
file
2010-09-28 13:19:04.274541 [DEBUG] switch_core_file.c:176 File
/usr/local/freeswitch/sounds/music/8000/partita-no-3-in-e-major-bwv-1006-1-preludio.wav
sample rate 8000 doesn't match requested rate 16000
2010-09-28 13:19:04.274541 [ERR] mod_skypopen.c:713 rev
git2svn-syncpoint-master-296-g25ddef5[(nil)|37     ][ERRORA  713
][interface14][-1, 0, 0] channel not ready
2010-09-28 13:19:04.274541 [DEBUG] switch_ivr_play_say.c:1476 done playing
file
2010-09-28 13:19:04.274541 [DEBUG] switch_ivr_play_say.c:1162 Codec
Activated L16 at 16000hz 1 channels 20ms
2010-09-28 13:19:04.274541 [DEBUG] switch_core_file.c:176 File
/usr/local/freeswitch/sounds/music/8000/partita-no-3-in-e-major-bwv-1006-1-preludio.wav
sample rate 8000 doesn't match requested rate 16000
2010-09-28 13:19:04.274541 [DEBUG] switch_ivr_play_say.c:1162 Codec
Activated L16 at 16000hz 1 channels 20ms
2010-09-28 13:19:04.274541 [ERR] switch_core_io.c:121 skypopen/interface25
has no read codec.
2010-09-28 13:19:04.274541 [DEBUG] switch_ivr_play_say.c:1476 done playing
file
2010-09-28 13:19:04.274541 [DEBUG] switch_core_file.c:176 File
/usr/local/freeswitch/sounds/music/8000/partita-no-3-in-e-major-bwv-1006-1-preludio.wav
sample rate 8000 doesn't match requested rate 16000
2010-09-28 13:19:04.274541 [DEBUG] switch_ivr_play_say.c:1162 Codec
Activated L16 at 16000hz 1 channels 20ms
2010-09-28 13:19:04.276545 [ERR] switch_core_io.c:121 skypopen/interface22
has no read codec.
2010-09-28 13:19:04.276545 [DEBUG] switch_ivr_play_say.c:1476 done playing
file
2010-09-28 13:19:04.276545 [DEBUG] switch_core_file.c:176 File
/usr/local/freeswitch/sounds/music/8000/partita-no-3-in-e-major-bwv-1006-1-preludio.wav
sample rate 8000 doesn't match requested rate 16000
2010-09-28 13:19:04.276545 [DEBUG] switch_ivr_play_say.c:1162 Codec
Activated L16 at 16000hz 1 channels 20ms
2010-09-28 13:19:04.276545 [ERR] switch_core_io.c:121 skypopen/interface25
has no read codec.
2010-09-28 13:19:04.276545 [DEBUG] switch_ivr_play_say.c:1476 done playing
file
2010-09-28 13:19:04.278564 [DEBUG] switch_core_file.c:176 File
/usr/local/freeswitch/sounds/music/8000/partita-no-3-in-e-major-bwv-1006-1-preludio.wav
sample rate 8000 doesn't match requested rate 16000
2010-09-28 13:19:04.278564 [DEBUG] switch_ivr_play_say.c:1162 Codec
Activated L16 at 16000hz 1 channels 20ms
2010-09-28 13:19:04.278564 [ERR] mod_skypopen.c:713 rev
git2svn-syncpoint-master-296-g25ddef5[(nil)|37     ][ERRORA  713
][interface14][-1, 0, 0] channel not ready
2010-09-28 13:19:04.278564 [DEBUG] switch_ivr_play_say.c:1476 done playing
file
2010-09-28 13:19:04.278564 [ERR] switch_core_io.c:121 skypopen/interface22
has no read codec.
2010-09-28 13:19:04.278564 [DEBUG] switch_ivr_play_say.c:1476 done playing
file
2010-09-28 13:19:04.280571 [DEBUG] switch_core_file.c:176 File
/usr/local/freeswitch/sounds/music/8000/partita-no-3-in-e-major-bwv-1006-1-preludio.wav
sample rate 8000 doesn't match requested rate 16000
2010-09-28 13:19:04.280571 [DEBUG] switch_ivr_play_say.c:1162 Codec
Activated L16 at 16000hz 1 channels 20ms
2010-09-28 13:19:04.280571 [ERR] switch_core_io.c:121 skypopen/interface25
has no read codec.
2010-09-28 13:19:04.280571 [DEBUG] switch_ivr_play_say.c:1476 done playing
file
2010-09-28 13:19:04.280571 [DEBUG] switch_core_file.c:176 File
/usr/local/freeswitch/sounds/music/8000/partita-no-3-in-e-major-bwv-1006-1-preludio.wav
sample rate 8000 doesn't match requested rate 16000
2010-09-28 13:19:04.280571 [DEBUG] switch_ivr_play_say.c:1162 Codec
Activated L16 at 16000hz 1 channels 20ms
2010-09-28 13:19:04.281800 [DEBUG] switch_core_file.c:176 File
/usr/local/freeswitch/sounds/music/8000/partita-no-3-in-e-major-bwv-1006-1-preludio.wav
sample rate 8000 doesn't match requested rate 16000
2010-09-28 13:19:04.281800 [DEBUG] switch_ivr_play_say.c:1162 Codec
Activated L16 at 16000hz 1 channels 20ms
2010-09-28 13:19:04.281800 [ERR] switch_core_io.c:121 skypopen/interface22
has no read codec.
2010-09-28 13:19:04.281800 [DEBUG] switch_ivr_play_say.c:1476 done playing
file
2010-09-28 13:19:04.281800 [ERR] switch_core_io.c:121 skypopen/interface25
has no read codec.
2010-09-28 13:19:04.281800 [DEBUG] switch_ivr_play_say.c:1476 done playing
file
2010-09-28 13:19:04.281800 [DEBUG] switch_core_file.c:176 File
/usr/local/freeswitch/sounds/music/8000/partita-no-3-in-e-major-bwv-1006-1-preludio.wav
sample rate 8000 doesn't match requested rate 16000
2010-09-28 13:19:04.281800 [DEBUG] switch_ivr_play_say.c:1162 Codec
Activated L16 at 16000hz 1 channels 20ms




Switch 1 - sk list
================================

freeswitch at a.com> sk list

sk console is NOT yet assigned
F ID        Name        IB (F/T)    OB (F/T)    State    CallFlw        UUID
= ====      ========      =======     =======    ======    ============
======
  1    [interface1]      1/3         0/0    IDLE    CALL_IDLE
  2    [interface2]      0/1         0/0    UP    STATUS_INPROGRS
e2f255cd-89ba-43e0-8d01-bf9579c98ffa
  3    [interface3]      1/7         0/0    IDLE    CALL_IDLE
  4    [interface4]      0/1         0/0    PREANSW    CALL_IDLE
1cc57d27-1db7-420e-8459-c27e588fd5b8
  5    [interface5]      0/1         0/0    UP    STATUS_INPROGRS
8d4719fe-8567-4c62-9224-8c9766aebc08
  6    [interface6]      0/0         0/0    IDLE    CALL_IDLE
  7    [interface7]      0/1         0/0    IDLE    CALL_IDLE
  8    [interface8]      0/1         0/0    IDLE    CALL_IDLE
  9    [interface9]      0/2         0/0    IDLE    CALL_IDLE
  10    [interface10]      0/1         0/0    UP    STATUS_INPROGRS
3ba37a2b-e1ec-436d-86be-76510ca7fe6a
  11    [interface11]      0/0         0/0    IDLE    CALL_IDLE
  12    [interface12]      1/4         0/0    IDLE    CALL_IDLE
  13    [interface13]      1/8         0/0    IDLE    CALL_IDLE
  14    [interface14]      1/5         0/0    IDLE    CALL_IDLE
  15    [interface15]      0/0         0/0    IDLE    CALL_IDLE
  16    [interface16]      0/1         0/0    PREANSW    CALL_IDLE
638935df-443d-4f02-af8d-40fb93eb21d4
  17    [interface17]      0/2         0/0    IDLE    CALL_IDLE
  18    [interface18]      0/1         0/0    UP    STATUS_INPROGRS
8aec831e-c410-4d85-aa5f-a84c3f364b4e
  19    [interface19]      1/5         0/0    IDLE    CALL_IDLE
  20    [interface20]      0/1         0/0    IDLE    CALL_IDLE
  21    [interface21]      0/1         0/0    UP    STATUS_INPROGRS
cf26b813-8557-46e0-8dcc-e30bdecce7d9
  22    [interface22]      6/9         0/0    IDLE    CALL_IDLE
  23    [interface23]      2/5         0/0    PREANSW    CALL_IDLE
a1fa5e30-5491-4941-b54c-1bec882cc4cd
  24    [interface24]      1/4         0/0    IDLE    CALL_IDLE
  25    [interface25]      2/5         0/0    IDLE    CALL_IDLE
  26    [interface26]      2/5         0/0    UP    STATUS_INPROGRS
9289a13e-bedc-43d1-92a2-8bec775188c6
  27    [interface27]      0/1         0/0    IDLE    CALL_IDLE
  28    [interface28]      0/0         0/0    IDLE    CALL_IDLE
  29    [interface29]      0/1         0/0    UP    STATUS_INPROGRS
32100a1d-38ac-4104-b5d7-35b5c4603a84
  30    [interface30]      1/2         0/0    IDLE    CALL_IDLE

Total Interfaces: 30  IB Calls(Failed/Total): 20/78  OB Calls(Failed/Total):
0/0



Switch 2 - sk list
========================================

freeswitch at a.com>


freeswitch at localhost.localdomain> sk list

sk console is NOT yet assigned
F ID        Name        IB (F/T)    OB (F/T)    State    CallFlw        UUID
= ====      ========      =======     =======    ======    ============
======
  1    [interface1]      0/0         5/8    UP    STATUS_INPROGRS
a7a35355-63de-4734-97a3-18dd97ee2f1e
  2    [interface2]      0/0        16/17    IDLE    CALL_IDLE
* 3    [interface3]      0/0         0/5    UP    STATUS_INPROGRS
a9256794-fa7f-4fac-bb23-aa3553bf9bb8
  4    [interface4]      0/0         0/3    UP    STATUS_INPROGRS
3423612f-8db5-481c-9fe8-a79cdd1234df
  5    [interface5]      0/1         1/3    UP    STATUS_INPROGRS
8f0878f5-d830-417a-a9b0-17c6b46f9e56
  6    [interface6]      0/0         7/8    UP    STATUS_INPROGRS
60b0b495-3115-42dd-bb18-a8b3d8b71087
  7    [interface7]      0/0        16/16    IDLE    CALL_IDLE
  8    [interface8]      0/0         1/3    UP    STATUS_INPROGRS
9da0beb5-0442-4c78-a2ed-ddd3c0852560
  9    [interface9]      0/0        16/16    IDLE    CALL_IDLE
  10    [interface10]      0/0        16/16    IDLE    CALL_IDLE

Total Interfaces: 10  IB Calls(Failed/Total): 0/1  OB Calls(Failed/Total):
78/95

freeswitch at localhost.localdomain>






When ERR switch_core_io.c:121 skypopen/xxxxinterface has no read codec and
ERR mod_skypopen.c:713 channel not ready gets started, whole active calls
get affected and this problem gets started.


Thanks for your guide, let me know your tips.

Best Regards
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20100928/a86ff403/attachment-0001.html 


More information about the FreeSWITCH-users mailing list