Hi Phil, I just tried all the steps (exactly, just cut and paste) from the wiki page: http://wiki.freeswitch.org/wiki/Skypiax_Skype_Endpoint_and_Trunk#An_example_of_Skypiax_and_FreeSWITCH_installation_on_CentOS_5.2.2C_from_scratch
I substituted 5.3 instead of 5.2. I'm afraid it worked flawlessly for me. (shocked about: Anthony is right about CentOS being "boring and predictable", good qualities for a server OS!) At the start of Skype clients it will tell bizarre things about hdmi, but they are unharmful (I've not edited the alsa stuff, it still groak about non-existent hdmi, but it works nonetheless). So, I suspect your problems have some other cause. Now I go read the Jira and the attached files, and I hope to be more of help. -giovanni On Fri, May 1, 2009 at 4:14 PM, Giovanni Maruzzelli <[email protected]> wrote: > Gruss Phil, > > actually it was shooting in the dark from my side, because I not yet > tested centos5.3, only centos5.2 > > As soon as I test it out I'll be back to you. > Thanks for filing the Jira. > > -giovanni > > > On Fri, May 1, 2009 at 1:19 PM, <[email protected]> wrote: >> Ciao Giovanni, >> >> grazie per la tua risposta. Removing 'hdmi' did make some changes, but it >> still doesn't work. I have filed a jira: >> >> http://jira.freeswitch.org/browse/MODSKYPIAX-33 >> >> Buon primo maggio anche a te, >> Phil >> >> -------- Original-Nachricht -------- >>> Datum: Fri, 1 May 2009 08:20:10 +0200 >>> Von: Giovanni Maruzzelli <[email protected]> >>> An: [email protected] >>> Betreff: Re: [Freeswitch-users] skypiax - CALL FAILUREREASON 7 = Sound I/O >>> error >> >>> Have a happy MayDay! >>> >>> I cannot see the whole mail now, it's clipped for my mobile, but it >>> seems the nth bizarry of new alsa config file, that creates an hdmi >>> device even if you do not have one. Try to edit >>> /usr/share/alsa/alsa.conf or any other file in /usr/share/alsa dir and >>> delete any mention of 'hdmi'. >>> If this do not works, please file a jira or write again. >>> Giovanni >>> >>> >>> >>> On 5/1/09, Anthony Minessale <[email protected]> wrote: >>> > if you put that info in a jira ticket >>> > >>> > http://jira.freeswitch.org >>> > >>> > and route it to skypeiax , the guy who maintains that module will see >>> it. >>> > >>> > >>> > On Thu, Apr 30, 2009 at 5:37 PM, <[email protected]> wrote: >>> > >>> >> >>> >> Hello, >>> >> >>> >> I am trying to get skypiax working, but I am having trouble with the >>> >> sound. >>> >> The calls fail with CALL FAILUREREASON 7 = Sound I/O error and >>> >> I am getting the following error: >>> >> >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM >>> >> cards.pcm.hdmi >>> >> >>> >> >>> >> I am running centos 5.3 and have followed the installation guide on the >>> >> wiki. CaptureDevice, RingDevice and SoundDevice are all set to 2. When >>> >> saving >>> >> the configuration on my desktop I have set the sound card to snd_dummy. >>> On >>> >> the server the startup script load snd-dumy like this /sbin/modprobe >>> >> snd-dummy enable=1. >>> >> Below is the output of lsmod and the debug output from FS. It would be >>> >> great if someone could help me fix my problem. >>> >> >>> >> Thank you very much. >>> >> Best wishes, >>> >> Phil >>> >> >>> >> >>> >> >>> >> >>> >> -bash-3.2# lsmod >>> >> Module Size Used by >>> >> snd_dummy 12416 0 >>> >> snd_seq_oss 32832 0 >>> >> snd_seq_midi_event 7744 1 snd_seq_oss >>> >> snd_seq 55200 4 snd_seq_oss,snd_seq_midi_event >>> >> snd_seq_device 7120 1 snd_seq_oss >>> >> snd_pcm_oss 44480 0 >>> >> snd_mixer_oss 16512 1 snd_pcm_oss >>> >> snd_pcm 79624 2 snd_dummy,snd_pcm_oss >>> >> snd_timer 22088 2 snd_seq,snd_pcm >>> >> snd 55976 8 >>> >> >>> snd_dummy,snd_seq_oss,snd_seq,snd_seq_device,snd_pcm_oss,snd_mixer_oss,snd_pcm,snd_timer >>> >> soundcore 7456 1 snd >>> >> snd_page_alloc 8720 1 snd_pcm >>> >> >>> >> >>> >> >>> >> freeswi...@voipserverserverfreeswitch> load mod_skypiax >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:718 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 718 ][none ][-1,-1,-1] >>> >> globals.debug=0 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:720 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 720 ][none ][-1,-1,-1] >>> >> globals.debug=8 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:731 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 731 ][none ][-1,-1,-1] >>> >> codec-master >>> >> globals.debug=8 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:734 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 734 ][none ][-1,-1,-1] >>> >> globals.dialplan=XML >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:740 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 740 ][none ][-1,-1,-1] >>> >> globals.context=default >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:743 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 743 ][none ][-1,-1,-1] >>> >> globals.codec_string=gsm,ulaw >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:750 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 750 ][none ][-1,-1,-1] >>> >> globals.codec_rates_string=8000,16000 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:723 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 723 ][none ][-1,-1,-1] >>> >> globals.hold_music= >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:737 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 737 ][none ][-1,-1,-1] >>> >> globals.destination=5000 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:847 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 847 ][none ][-1,-1,-1] >>> >> interface_id=1 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:870 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 870 ][none ][-1,-1,-1] >>> >> name=skypiax1 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:876 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 876 ][none ][-1,-1,-1] >>> Initialized >>> >> XInitThreads! >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:897 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 897 ][skypiax1 ][-1, 0, 0] >>> CONFIGURING >>> >> interface_id=1 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:920 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 920 ][skypiax1 ][-1, 0, 0] >>> >> interface_id=1 >>> globals.SKYPIAX_INTERFACES[interface_id].X11_display=:101 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:924 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 924 ][skypiax1 ][-1, 0, 0] >>> >> interface_id=1 >>> globals.SKYPIAX_INTERFACES[interface_id].skype_user=xyzUK >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:928 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 928 ][skypiax1 ][-1, 0, 0] >>> >> interface_id=1 >>> globals.SKYPIAX_INTERFACES[interface_id].tcp_cli_port=15556 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:932 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 932 ][skypiax1 ][-1, 0, 0] >>> >> interface_id=1 >>> globals.SKYPIAX_INTERFACES[interface_id].tcp_srv_port=15557 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:935 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 935 ][skypiax1 ][-1, 0, 0] >>> >> interface_id=1 globals.SKYPIAX_INTERFACES[interface_id].name=skypiax1 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:938 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 938 ][skypiax1 ][-1, 0, 0] >>> >> interface_id=1 globals.SKYPIAX_INTERFACES[interface_id].context=default >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:942 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 942 ][skypiax1 ][-1, 0, 0] >>> >> interface_id=1 globals.SKYPIAX_INTERFACES[interface_id].dialplan=XML >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:946 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 946 ][skypiax1 ][-1, 0, 0] >>> >> interface_id=1 >>> globals.SKYPIAX_INTERFACES[interface_id].destination=3101 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:949 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 949 ][skypiax1 ][-1, 0, 0] >>> >> interface_id=1 globals.SKYPIAX_INTERFACES[interface_id].context=default >>> >> 2009-04-30 17:47:35 [WARNING] mod_skypiax.c:950 load_config() rev >>> >> 13177[(nil)|37 ][WARNINGA 950 ][skypiax1 ][-1, 0, 0] STARTING >>> >> interface_id=1 >>> >> 2009-04-30 17:47:35 [DEBUG] skypiax_protocol.c:1407 >>> >> skypiax_do_skypeapi_thread_func() rev 13177[(nil)|37 ][DEBUG_SKYPE >>> >> 1407 >>> >> ][skypiax1 ][-1, 0, 0] X Display ':101' opened >>> >> 2009-04-30 17:47:35 [DEBUG] skypiax_protocol.c:1309 skypiax_present() >>> rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1309 ][none ][-1,-1,-1] Skype >>> >> instance found with id #2097454 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:661 >>> >> skypiax_signaling_thread_func() rev 13177[(nil)|37 ][DEBUG_SKYPE >>> 661 >>> >> ][skypiax1 ][-1, 0, 0] In skypiax_signaling_thread_func: started, >>> >> p=0x2aaab93226f8 >>> >> 2009-04-30 17:47:35 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 0, 0] >>> >> READING: >>> >> |||OK||| >>> >> 2009-04-30 17:47:35 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 0, 0] >>> >> READING: >>> >> |||PROTOCOL 7||| >>> >> 2009-04-30 17:47:35 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 0, 0] >>> >> READING: >>> >> |||CONNSTATUS ONLINE||| >>> >> 2009-04-30 17:47:35 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 0, 0] >>> >> READING: >>> >> |||CURRENTUSERHANDLE xyzUK||| >>> >> 2009-04-30 17:47:35 [DEBUG] skypiax_protocol.c:111 >>> >> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 111 ][skypiax1 ][-1, 0, 0] >>> Skype >>> >> MSG: message: CURRENTUSERHANDLE, currentuserhandle: CURRENTUSERHANDLE, >>> >> cuh: >>> >> xyzUK, skype_user: xyzUK! >>> >> 2009-04-30 17:47:35 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 0, 0] >>> >> READING: >>> >> |||USERSTATUS ONLINE||| >>> >> 2009-04-30 17:47:35 [NOTICE] mod_skypiax.c:976 load_config() rev >>> >> 13177[(nil)|37 ][NOTICA 976 ][skypiax1 ][-1, 0, 0] WAITING >>> roughly >>> >> 10 >>> >> seconds to find a running Skype client and connect to its SKYPE API for >>> >> interface_id=1 >>> >> 2009-04-30 17:47:35 [NOTICE] mod_skypiax.c:986 load_config() rev >>> >> 13177[(nil)|37 ][NOTICA 986 ][skypiax1 ][-1, 0, 0] Found a >>> running >>> >> Skype client, connected to its SKYPE API for interface_id=1, waiting 60 >>> >> seconds for CURRENTUSERHANDLE==xyzUK >>> >> 2009-04-30 17:47:35 [WARNING] mod_skypiax.c:1004 load_config() rev >>> >> 13177[(nil)|37 ][WARNINGA 1004 ][skypiax1 ][-1, 0, 0] >>> Interface_id=1 >>> >> is now STARTED, the Skype client to which we are connected gave us the >>> >> correct CURRENTUSERHANDLE (xyzUK) >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:847 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 847 ][none ][-1,-1,-1] >>> >> interface_id=2 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:870 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 870 ][none ][-1,-1,-1] >>> >> name=skypiax2 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:876 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 876 ][none ][-1,-1,-1] >>> Initialized >>> >> XInitThreads! >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:897 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 897 ][skypiax2 ][-1, 0, 0] >>> CONFIGURING >>> >> interface_id=2 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:920 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 920 ][skypiax2 ][-1, 0, 0] >>> >> interface_id=2 >>> globals.SKYPIAX_INTERFACES[interface_id].X11_display=:102 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:924 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 924 ][skypiax2 ][-1, 0, 0] >>> >> interface_id=2 >>> >> globals.SKYPIAX_INTERFACES[interface_id].skype_user=voipserver >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:928 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 928 ][skypiax2 ][-1, 0, 0] >>> >> interface_id=2 >>> globals.SKYPIAX_INTERFACES[interface_id].tcp_cli_port=15558 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:932 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 932 ][skypiax2 ][-1, 0, 0] >>> >> interface_id=2 >>> globals.SKYPIAX_INTERFACES[interface_id].tcp_srv_port=15559 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:935 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 935 ][skypiax2 ][-1, 0, 0] >>> >> interface_id=2 globals.SKYPIAX_INTERFACES[interface_id].name=skypiax2 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:938 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 938 ][skypiax2 ][-1, 0, 0] >>> >> interface_id=2 globals.SKYPIAX_INTERFACES[interface_id].context=default >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:942 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 942 ][skypiax2 ][-1, 0, 0] >>> >> interface_id=2 globals.SKYPIAX_INTERFACES[interface_id].dialplan=XML >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:946 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 946 ][skypiax2 ][-1, 0, 0] >>> >> interface_id=2 >>> globals.SKYPIAX_INTERFACES[interface_id].destination=5000 >>> >> 2009-04-30 17:47:35 [DEBUG] mod_skypiax.c:949 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 949 ][skypiax2 ][-1, 0, 0] >>> >> interface_id=2 globals.SKYPIAX_INTERFACES[interface_id].context=default >>> >> 2009-04-30 17:47:35 [WARNING] mod_skypiax.c:950 load_config() rev >>> >> 13177[(nil)|37 ][WARNINGA 950 ][skypiax2 ][-1, 0, 0] STARTING >>> >> interface_id=2 >>> >> 2009-04-30 17:47:35 [DEBUG] skypiax_protocol.c:1407 >>> >> skypiax_do_skypeapi_thread_func() rev 13177[(nil)|37 ][DEBUG_SKYPE >>> >> 1407 >>> >> ][skypiax2 ][-1, 0, 0] X Display ':102' opened >>> >> 2009-04-30 17:47:35 [DEBUG] skypiax_protocol.c:1309 skypiax_present() >>> rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1309 ][none ][-1,-1,-1] Skype >>> >> instance found with id #2097454 >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:661 >>> >> skypiax_signaling_thread_func() rev 13177[(nil)|37 ][DEBUG_SKYPE >>> 661 >>> >> ][skypiax2 ][-1, 0, 0] In skypiax_signaling_thread_func: started, >>> >> p=0x2aaab9325c18 >>> >> 2009-04-30 17:47:36 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax2 ][-1, 0, 0] >>> >> READING: >>> >> |||OK||| >>> >> 2009-04-30 17:47:36 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax2 ][-1, 0, 0] >>> >> READING: >>> >> |||PROTOCOL 7||| >>> >> 2009-04-30 17:47:36 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax2 ][-1, 0, 0] >>> >> READING: >>> >> |||CONNSTATUS ONLINE||| >>> >> 2009-04-30 17:47:36 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax2 ][-1, 0, 0] >>> >> READING: >>> >> |||CURRENTUSERHANDLE voipserver||| >>> >> 2009-04-30 17:47:36 [DEBUG] skypiax_protocol.c:111 >>> >> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 111 ][skypiax2 ][-1, 0, 0] >>> Skype >>> >> MSG: message: CURRENTUSERHANDLE, currentuserhandle: CURRENTUSERHANDLE, >>> >> cuh: >>> >> voipserver, skype_user: voipserver! >>> >> 2009-04-30 17:47:36 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax2 ][-1, 0, 0] >>> >> READING: >>> >> |||USERSTATUS ONLINE||| >>> >> 2009-04-30 17:47:36 [NOTICE] mod_skypiax.c:976 load_config() rev >>> >> 13177[(nil)|37 ][NOTICA 976 ][skypiax2 ][-1, 0, 0] WAITING >>> roughly >>> >> 10 >>> >> seconds to find a running Skype client and connect to its SKYPE API for >>> >> interface_id=2 >>> >> 2009-04-30 17:47:36 [NOTICE] mod_skypiax.c:986 load_config() rev >>> >> 13177[(nil)|37 ][NOTICA 986 ][skypiax2 ][-1, 0, 0] Found a >>> running >>> >> Skype client, connected to its SKYPE API for interface_id=2, waiting 60 >>> >> seconds for CURRENTUSERHANDLE==voipserver >>> >> API CALL [load(mod_skypiax)] output: >>> >> +OK >>> >> >>> >> 2009-04-30 17:47:36 [WARNING] mod_skypiax.c:1004 load_config() rev >>> >> 13177[(nil)|37 ][WARNINGA 1004 ][skypiax2 ][-1, 0, 0] >>> Interface_id=2 >>> >> is now STARTED, the Skype client to which we are connected gave us the >>> >> correct CURRENTUSERHANDLE (voipserver) >>> >> >>> >> >>> >> >>> >> >>> >> >>> >> >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1028 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1028 ][skypiax1 ][-1, 0, 0] i=1 >>> >> globals.SKYPIAX_INTERFACES[1].interface_id=1 >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1030 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1030 ][skypiax1 ][-1, 0, 0] i=1 >>> >> globals.SKYPIAX_INTERFACES[1].X11_display=:101 >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1032 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1032 ][skypiax1 ][-1, 0, 0] i=1 >>> >> globals.SKYPIAX_INTERFACES[1].name=skypiax1 >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1034 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1034 ][skypiax1 ][-1, 0, 0] i=1 >>> >> globals.SKYPIAX_INTERFACES[1].context=default >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1036 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1036 ][skypiax1 ][-1, 0, 0] i=1 >>> >> globals.SKYPIAX_INTERFACES[1].dialplan=XML >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1038 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1038 ][skypiax1 ][-1, 0, 0] i=1 >>> >> globals.SKYPIAX_INTERFACES[1].destination=3101 >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1040 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1040 ][skypiax1 ][-1, 0, 0] i=1 >>> >> globals.SKYPIAX_INTERFACES[1].context=default >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1028 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1028 ][skypiax2 ][-1, 0, 0] i=2 >>> >> globals.SKYPIAX_INTERFACES[2].interface_id=2 >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1030 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1030 ][skypiax2 ][-1, 0, 0] i=2 >>> >> globals.SKYPIAX_INTERFACES[2].X11_display=:102 >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1032 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1032 ][skypiax2 ][-1, 0, 0] i=2 >>> >> globals.SKYPIAX_INTERFACES[2].name=skypiax2 >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1034 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1034 ][skypiax2 ][-1, 0, 0] i=2 >>> >> globals.SKYPIAX_INTERFACES[2].context=default >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1036 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1036 ][skypiax2 ][-1, 0, 0] i=2 >>> >> globals.SKYPIAX_INTERFACES[2].dialplan=XML >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1038 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1038 ][skypiax2 ][-1, 0, 0] i=2 >>> >> globals.SKYPIAX_INTERFACES[2].destination=5000 >>> >> 2009-04-30 17:47:36 [DEBUG] mod_skypiax.c:1040 load_config() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 1040 ][skypiax2 ][-1, 0, 0] i=2 >>> >> globals.SKYPIAX_INTERFACES[2].context=default >>> >> 2009-04-30 17:47:36 [CONSOLE] switch_loadable_module.c:889 >>> >> switch_loadable_module_load_file() Successfully Loaded [mod_skypiax] >>> >> 2009-04-30 17:47:36 [NOTICE] switch_loadable_module.c:142 >>> >> switch_loadable_module_process() Adding Endpoint 'skypiax' >>> >> 2009-04-30 17:47:36 [NOTICE] switch_loadable_module.c:270 >>> >> switch_loadable_module_process() Adding API Function 'sk' >>> >> 2009-04-30 17:47:36 [NOTICE] switch_loadable_module.c:270 >>> >> switch_loadable_module_process() Adding API Function 'skypiax' >>> >> freeswi...@voipserverserverfreeswitch> >>> >> freeswi...@voipserverserverfreeswitch> >>> >> freeswi...@voipserverserverfreeswitch> >>> >> freeswi...@voipserverserverfreeswitch> 2009-04-30 17:52:41 [DEBUG] >>> >> skypiax_protocol.c:57 skypiax_signaling_read() rev 13177[(nil)|37 >>> >> ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 0, 0] READING: |||USER paolofun6 >>> >> PHONE_MOBILE +420775216536||| >>> >> >>> >> freeswi...@voipserverserverfreeswitch> >>> >> freeswi...@voipserverserverfreeswitch> >>> >> freeswi...@voipserverserverfreeswitch> >>> >> freeswi...@voipserverserverfreeswitch> 2009-04-30 17:52:49 [NOTICE] >>> >> switch_channel.c:602 switch_channel_set_name() New Channel >>> sofia/external/ >>> >> [email protected] [fc670e69-1143-4241-8364-3158f1ffa6ef] >>> >> 2009-04-30 17:52:49 [DEBUG] sofia.c:2912 sofia_handle_sip_i_state() >>> >> Channel >>> >> sofia/external/[email protected] entering state [received][100] >>> >> 2009-04-30 17:52:49 [DEBUG] sofia.c:2919 sofia_handle_sip_i_state() >>> Remote >>> >> SDP: >>> >> v=0 >>> >> o=root 15141 15141 IN IP4 217.10.66.71 >>> >> s=session >>> >> c=IN IP4 217.10.66.71 >>> >> t=0 0 >>> >> m=audio 12950 RTP/AVP 8 0 3 97 18 112 101 >>> >> a=rtpmap:8 PCMA/8000 >>> >> a=rtpmap:0 PCMU/8000 >>> >> a=rtpmap:3 GSM/8000 >>> >> a=rtpmap:97 iLBC/8000 >>> >> a=fmtp:97 mode=30 >>> >> a=rtpmap:18 G729/8000 >>> >> a=fmtp:18 annexb=no >>> >> a=rtpmap:112 G726-32/8000 >>> >> a=rtpmap:101 telephone-event/8000 >>> >> a=fmtp:101 0-16 >>> >> a=silenceSupp:off - - - - >>> >> a=ptime:20 >>> >> >>> >> 2009-04-30 17:52:49 [DEBUG] sofia_glue.c:2931 >>> sofia_glue_negotiate_sdp() >>> >> Audio Codec Compare [PCMA:8:8000:20]/[SPEEX:98:8000:20] >>> >> 2009-04-30 17:52:49 [DEBUG] sofia_glue.c:2931 >>> sofia_glue_negotiate_sdp() >>> >> Audio Codec Compare [PCMA:8:8000:20]/[SPEEX:99:16000:20] >>> >> 2009-04-30 17:52:49 [DEBUG] sofia_glue.c:2931 >>> sofia_glue_negotiate_sdp() >>> >> Audio Codec Compare [PCMA:8:8000:20]/[PCMU:0:8000:20] >>> >> 2009-04-30 17:52:49 [DEBUG] sofia_glue.c:2931 >>> sofia_glue_negotiate_sdp() >>> >> Audio Codec Compare [PCMA:8:8000:20]/[PCMA:8:8000:20] >>> >> 2009-04-30 17:52:49 [DEBUG] sofia_glue.c:1912 >>> sofia_glue_tech_set_codec() >>> >> Set Codec sofia/external/[email protected] PCMA/8000 20 ms 160 >>> >> samples >>> >> 2009-04-30 17:52:49 [DEBUG] sofia_glue.c:2891 >>> sofia_glue_negotiate_sdp() >>> >> Set 2833 dtmf payload to 101 >>> >> 2009-04-30 17:52:49 [DEBUG] sofia.c:3078 sofia_handle_sip_i_state() >>> >> (sofia/external/[email protected]) State Change CS_NEW -> >>> CS_INIT >>> >> 2009-04-30 17:52:49 [DEBUG] switch_core_session.c:927 >>> >> switch_core_session_signal_state_change() Send signal sofia/external/ >>> >> [email protected] [BREAK] >>> >> 2009-04-30 17:52:49 [DEBUG] switch_core_state_machine.c:397 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> >> Running State Change CS_INIT >>> >> 2009-04-30 17:52:49 [DEBUG] switch_core_state_machine.c:480 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> State >>> >> INIT >>> >> 2009-04-30 17:52:49 [DEBUG] mod_sofia.c:83 sofia_on_init() >>> sofia/external/ >>> >> [email protected] SOFIA INIT >>> >> 2009-04-30 17:52:49 [DEBUG] mod_sofia.c:111 sofia_on_init() >>> >> (sofia/external/[email protected]) State Change CS_INIT -> >>> >> CS_ROUTING >>> >> 2009-04-30 17:52:49 [DEBUG] switch_core_session.c:927 >>> >> switch_core_session_signal_state_change() Send signal sofia/external/ >>> >> [email protected] [BREAK] >>> >> 2009-04-30 17:52:49 [DEBUG] switch_core_state_machine.c:480 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> State >>> >> INIT going to sleep >>> >> 2009-04-30 17:52:49 [DEBUG] switch_core_state_machine.c:397 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> >> Running State Change CS_ROUTING >>> >> 2009-04-30 17:52:49 [DEBUG] switch_core_state_machine.c:483 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> State >>> >> ROUTING >>> >> 2009-04-30 17:52:49 [DEBUG] mod_sofia.c:130 sofia_on_routing() >>> >> sofia/external/[email protected] SOFIA ROUTING >>> >> 2009-04-30 17:52:49 [DEBUG] switch_core_state_machine.c:78 >>> >> switch_core_standard_on_routing() >>> >> sofia/external/[email protected] ROUTING >>> >> 2009-04-30 17:52:49 [INFO] mod_dialplan_xml.c:252 dialplan_hunt() >>> >> Processing 07771236762->00442083324655 in context public >>> >> Dialplan: sofia/external/[email protected] parsing >>> >> [public->skype_uri] continue=false >>> >> Dialplan: sofia/external/[email protected] Regex (PASS) >>> >> [skype_uri] destination_number(00442083324655) =~ /^(00442083324655)$/ >>> >> break=on-false >>> >> Dialplan: sofia/external/[email protected] Action >>> >> bridge(skypiax/skypiax1/xyzTestUK) >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:114 >>> >> switch_core_standard_on_routing() (sofia/external/ >>> >> [email protected]) State Change CS_ROUTING -> CS_EXECUTE >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_session.c:927 >>> >> switch_core_session_signal_state_change() Send signal sofia/external/ >>> >> [email protected] [BREAK] >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:483 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> State >>> >> ROUTING going to sleep >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:397 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> >> Running State Change CS_EXECUTE >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:490 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> State >>> >> EXECUTE >>> >> 2009-04-30 17:52:51 [DEBUG] mod_sofia.c:173 sofia_on_execute() >>> >> sofia/external/[email protected] SOFIA EXECUTE >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:151 >>> >> switch_core_standard_on_execute() >>> >> sofia/external/[email protected] EXECUTE >>> >> EXECUTE >>> >> >>> sofia/external/[email protected](skypiax/skypiax1/xyzTestUK) >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:585 >>> channel_outgoing_channel() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 585 ][ ][-1, 0, 0] >>> >> globals.SKYPIAX_INTERFACES[1].name=|||skypiax1|||? >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:151 skypiax_tech_init() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 151 ][skypiax1 ][-1, 0, 0] >>> >> skypiax_codec >>> >> SUCCESS >>> >> 2009-04-30 17:52:51 [NOTICE] switch_channel.c:602 >>> >> switch_channel_set_name() >>> >> New Channel skypiax/skypiax1/xyzTestUK >>> >> [0375c668-b4a2-4364-a8c6-0a718d4f00a3] >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:773 skypiax_call() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 773 ][skypiax1 ][-1, 0, 0] Calling >>> >> Skype, rdest is: xyzTestUK >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:1262 >>> >> skypiax_signaling_write() rev 13177[(nil)|37 ][DEBUG_SKYPE 1262 >>> >> ][skypiax1 ][-1, 0, 0] SENDING: |||SET AGC OFF|||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 0, 0] >>> >> READING: >>> >> |||||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:1262 >>> >> skypiax_signaling_write() rev 13177[(nil)|37 ][DEBUG_SKYPE 1262 >>> >> ][skypiax1 ][-1, 0, 0] SENDING: |||SET AEC OFF|||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 0, 0] >>> >> READING: >>> >> |||||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:1262 >>> >> skypiax_signaling_write() rev 13177[(nil)|37 ][DEBUG_SKYPE 1262 >>> >> ][skypiax1 ][-1, 0, 0] SENDING: |||CALL xyzTestUK|||| >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:642 >>> channel_outgoing_channel() >>> >> (skypiax/skypiax1/xyzTestUK) State Change CS_NEW -> CS_INIT >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_session.c:927 >>> >> switch_core_session_signal_state_change() Send signal >>> >> skypiax/skypiax1/xyzTestUK [BREAK] >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:300 channel_kill_channel() >>> rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 300 ][skypiax1 ][-1, 0, 0] >>> >> skypiax/skypiax1/xyzTestUK CHANNEL got SWITCH_SIG_BREAK >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:397 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) Running State >>> >> Change >>> >> CS_INIT >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:480 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) State INIT >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:177 channel_on_init() >>> >> (skypiax/skypiax1/xyzTestUK) State Change CS_INIT -> CS_ROUTING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_session.c:927 >>> >> switch_core_session_signal_state_change() Send signal >>> >> skypiax/skypiax1/xyzTestUK [BREAK] >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:300 channel_kill_channel() >>> rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 300 ][skypiax1 ][-1, 0, 0] >>> >> skypiax/skypiax1/xyzTestUK CHANNEL got SWITCH_SIG_BREAK >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:182 channel_on_init() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 182 ][skypiax1 ][-1, 0, 0] >>> >> skypiax/skypiax1/xyzTestUK CHANNEL INIT >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:480 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) State INIT going >>> to >>> >> sleep >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:397 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) Running State >>> >> Change >>> >> CS_ROUTING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:483 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) State ROUTING >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:257 channel_on_routing() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 257 ][skypiax1 ][-1, 0, 0] >>> >> skypiax/skypiax1/xyzTestUK CHANNEL ROUTING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_ivr_originate.c:63 >>> >> originate_on_routing() (skypiax/skypiax1/xyzTestUK) State Change >>> >> CS_ROUTING >>> >> -> CS_CONSUME_MEDIA >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_session.c:927 >>> >> switch_core_session_signal_state_change() Send signal >>> >> skypiax/skypiax1/xyzTestUK [BREAK] >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:300 channel_kill_channel() >>> rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 300 ][skypiax1 ][-1, 0, 0] >>> >> skypiax/skypiax1/xyzTestUK CHANNEL got SWITCH_SIG_BREAK >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:483 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) State ROUTING >>> going >>> >> to sleep >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:397 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) Running State >>> >> Change >>> >> CS_CONSUME_MEDIA >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:502 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) State >>> CONSUME_MEDIA >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 0, 0] >>> >> READING: >>> >> |||AGC OFF||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 0, 0] >>> >> READING: >>> >> |||AEC OFF||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 0, 0] >>> >> READING: >>> >> |||CALL 455 STATUS UNPLACED||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:167 >>> >> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 167 ][skypiax1 ][-1, 0, 0] >>> Skype >>> >> MSG: message: CALL, obj: CALL, id: 455, prop: STATUS, value: >>> >> UNPLACED,where: >>> >> NULL! >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:371 >>> >> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 371 ][skypiax1 ][-1, 3,116] >>> >> skype_call: 455 is now UNPLACED >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> ALSA lib pcm.c:2184:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 3,116] >>> >> READING: >>> >> |||CALL 455 STATUS ROUTING||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:167 >>> >> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 167 ][skypiax1 ][-1, 3,116] >>> Skype >>> >> MSG: message: CALL, obj: CALL, id: 455, prop: STATUS, value: >>> >> ROUTING,where: >>> >> NULL! >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:365 >>> >> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 365 ][skypiax1 ][-1, 3,117] >>> >> skype_call: 455 is now ROUTING >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 3,117] >>> >> READING: >>> >> |||CALL 455 FAILUREREASON 7||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:167 >>> >> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 167 ][skypiax1 ][-1, 3,117] >>> Skype >>> >> MSG: message: CALL, obj: CALL, id: 455, prop: FAILUREREASON, value: >>> >> 7,where: >>> >> NULL! >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:201 >>> >> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 201 ][skypiax1 ][-1, 3,117] >>> Skype >>> >> FAILED on skype_call 455. Let's wait for the FAILED message. >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 3,117] >>> >> READING: >>> >> |||CALL 455 VAA_INPUT_STATUS FALSE||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:167 >>> >> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 167 ][skypiax1 ][-1, 3,117] >>> Skype >>> >> MSG: message: CALL, obj: CALL, id: 455, prop: VAA_INPUT_STATUS, value: >>> >> FALSE,where: NULL! >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 3,117] >>> >> READING: >>> >> |||CALL 455 STATUS FAILED||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:167 >>> >> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 167 ][skypiax1 ][-1, 3,117] >>> Skype >>> >> MSG: message: CALL, obj: CALL, id: 455, prop: STATUS, value: >>> FAILED,where: >>> >> NULL! >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:334 >>> >> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 334 ][skypiax1 ][-1, 3,112] we >>> >> tried >>> >> to call Skype on skype_call 455 and Skype has now FAILED >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:672 >>> >> skypiax_signaling_thread_func() rev 13177[(nil)|37 ][DEBUG_SKYPE >>> 672 >>> >> ][skypiax1 ][-1, 1,112] skype call ended >>> >> 2009-04-30 17:52:51 [NOTICE] mod_skypiax.c:680 >>> >> skypiax_signaling_thread_func() Hangup skypiax/skypiax1/xyzTestUK >>> >> [CS_CONSUME_MEDIA] [NORMAL_CLEARING] >>> >> 2009-04-30 17:52:51 [DEBUG] switch_channel.c:1641 >>> >> switch_channel_perform_hangup() Send signal skypiax/skypiax1/xyzTestUK >>> >> [KILL] >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:293 channel_kill_channel() >>> rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 293 ][skypiax1 ][-1, 1,112] >>> >> skypiax/skypiax1/xyzTestUK CHANNEL got SWITCH_SIG_KILL >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_session.c:927 >>> >> switch_core_session_signal_state_change() Send signal >>> >> skypiax/skypiax1/xyzTestUK [BREAK] >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:300 channel_kill_channel() >>> rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 300 ][skypiax1 ][-1, 1,112] >>> >> skypiax/skypiax1/xyzTestUK CHANNEL got SWITCH_SIG_BREAK >>> >> 2009-04-30 17:52:51 [DEBUG] switch_ivr_originate.c:2086 >>> >> switch_ivr_originate() Originate Resulted in Error Cause: 16 >>> >> [NORMAL_CLEARING] >>> >> 2009-04-30 17:52:51 [INFO] mod_dptools.c:2074 audio_bridge_function() >>> >> Originate Failed. Cause: NORMAL_CLEARING >>> >> 2009-04-30 17:52:51 [NOTICE] mod_dptools.c:2106 audio_bridge_function() >>> >> Hangup sofia/external/[email protected] [CS_EXECUTE] >>> >> [NORMAL_CLEARING] >>> >> 2009-04-30 17:52:51 [DEBUG] switch_channel.c:1641 >>> >> switch_channel_perform_hangup() Send signal sofia/external/ >>> >> [email protected] [KILL] >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_session.c:927 >>> >> switch_core_session_signal_state_change() Send signal sofia/external/ >>> >> [email protected] [BREAK] >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:490 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> State >>> >> EXECUTE going to sleep >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:397 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> >> Running State Change CS_HANGUP >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:433 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> State >>> >> HANGUP >>> >> 2009-04-30 17:52:51 [DEBUG] mod_sofia.c:323 sofia_on_hangup() Channel >>> >> sofia/external/[email protected] hanging up, cause: >>> >> NORMAL_CLEARING >>> >> 2009-04-30 17:52:51 [DEBUG] mod_sofia.c:399 sofia_on_hangup() >>> Responding >>> >> to >>> >> INVITE with: 480 >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:46 >>> >> switch_core_standard_on_hangup() >>> >> sofia/external/[email protected] HANGUP, cause: >>> >> NORMAL_CLEARING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:433 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> State >>> >> HANGUP going to sleep >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:475 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> State >>> >> Change CS_HANGUP -> CS_REPORTING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_session.c:927 >>> >> switch_core_session_signal_state_change() Send signal sofia/external/ >>> >> [email protected] [BREAK] >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:397 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> >> Running State Change CS_REPORTING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:609 >>> >> switch_core_session_reporting_state() (sofia/external/ >>> >> [email protected]) State REPORTING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:502 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) State >>> CONSUME_MEDIA >>> >> going to sleep >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:397 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) Running State >>> >> Change >>> >> CS_HANGUP >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:433 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) State HANGUP >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:228 channel_on_hangup() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 228 ][skypiax1 ][-1, 1,112] hanging >>> up >>> >> skype call: 455 >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:1262 >>> >> skypiax_signaling_write() rev 13177[(nil)|37 ][DEBUG_SKYPE 1262 >>> >> ][skypiax1 ][-1, 1,112] SENDING: |||ALTER CALL 455 HANGUP|||| >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:235 channel_on_hangup() rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 235 ][skypiax1 ][-1, 1,112] >>> >> skypiax/skypiax1/xyzTestUK CHANNEL HANGUP >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:46 >>> >> switch_core_standard_on_hangup() skypiax/skypiax1/xyzTestUK Standard >>> >> HANGUP, >>> >> cause: NORMAL_CLEARING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:433 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) State HANGUP >>> going >>> >> to >>> >> sleep >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:475 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) State Change >>> >> CS_HANGUP -> CS_REPORTING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_session.c:927 >>> >> switch_core_session_signal_state_change() Send signal >>> >> skypiax/skypiax1/xyzTestUK [BREAK] >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:300 channel_kill_channel() >>> rev >>> >> 13177[(nil)|37 ][DEBUG_SKYPE 300 ][skypiax1 ][-1, 1,112] >>> >> skypiax/skypiax1/xyzTestUK CHANNEL got SWITCH_SIG_BREAK >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:397 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) Running State >>> >> Change >>> >> CS_REPORTING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:609 >>> >> switch_core_session_reporting_state() (skypiax/skypiax1/xyzTestUK) >>> State >>> >> REPORTING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:53 >>> >> switch_core_standard_on_reporting() skypiax/skypiax1/xyzTestUK Standard >>> >> REPORTING, cause: NORMAL_CLEARING >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:609 >>> >> switch_core_session_reporting_state() (skypiax/skypiax1/xyzTestUK) >>> State >>> >> REPORTING going to sleep >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:410 >>> >> switch_core_session_run() (skypiax/skypiax1/xyzTestUK) State Change >>> >> CS_REPORTING -> CS_DESTROY >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_session.c:1061 >>> >> switch_core_session_thread() Session 2 (skypiax/skypiax1/xyzTestUK) >>> >> Locked, >>> >> Waiting on external entities >>> >> 2009-04-30 17:52:51 [NOTICE] switch_core_session.c:1079 >>> >> switch_core_session_thread() Session 2 (skypiax/skypiax1/xyzTestUK) >>> Ended >>> >> 2009-04-30 17:52:51 [NOTICE] switch_core_session.c:1081 >>> >> switch_core_session_thread() Close Channel skypiax/skypiax1/xyzTestUK >>> >> [CS_DESTROY] >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:559 >>> >> switch_core_session_destroy_state() (skypiax/skypiax1/xyzTestUK) State >>> >> DESTROY >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:60 >>> >> switch_core_standard_on_destroy() skypiax/skypiax1/xyzTestUK Standard >>> >> DESTROY >>> >> 2009-04-30 17:52:51 [DEBUG] switch_core_state_machine.c:559 >>> >> switch_core_session_destroy_state() (skypiax/skypiax1/xyzTestUK) State >>> >> DESTROY going to sleep >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:57 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 57 ][skypiax1 ][-1, 1,112] >>> >> READING: >>> >> |||ERROR 559 CALL: Action failed||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:91 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 91 ][skypiax1 ][-1, 1,112] >>> Skype >>> >> got ERROR: |||ERROR||| >>> >> 2009-04-30 17:52:51 [DEBUG] skypiax_protocol.c:93 >>> skypiax_signaling_read() >>> >> rev 13177[(nil)|37 ][DEBUG_SKYPE 93 ][skypiax1 ][-1, 1,110] >>> >> skype_call now is DOWN >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:672 >>> >> skypiax_signaling_thread_func() rev 13177[(nil)|37 ][DEBUG_SKYPE >>> 672 >>> >> ][skypiax1 ][-1, 1,110] skype call ended >>> >> 2009-04-30 17:52:51 [DEBUG] mod_skypiax.c:687 >>> >> skypiax_signaling_thread_func() rev 13177[(nil)|37 ][DEBUG_SKYPE >>> 687 >>> >> ][skypiax1 ][-1, 1,110] no session >>> >> 2009-04-30 17:52:54 [DEBUG] switch_core_state_machine.c:53 >>> >> switch_core_standard_on_reporting() sofia/external/ >>> >> [email protected] Standard REPORTING, cause: NORMAL_CLEARING >>> >> 2009-04-30 17:52:54 [DEBUG] switch_core_state_machine.c:609 >>> >> switch_core_session_reporting_state() (sofia/external/ >>> >> [email protected]) State REPORTING going to sleep >>> >> 2009-04-30 17:52:54 [DEBUG] switch_core_state_machine.c:410 >>> >> switch_core_session_run() (sofia/external/[email protected]) >>> State >>> >> Change CS_REPORTING -> CS_DESTROY >>> >> 2009-04-30 17:52:54 [DEBUG] switch_core_session.c:1061 >>> >> switch_core_session_thread() Session 1 (sofia/external/ >>> >> [email protected]) Locked, Waiting on external entities >>> >> 2009-04-30 17:52:54 [NOTICE] switch_core_session.c:1079 >>> >> switch_core_session_thread() Session 1 (sofia/external/ >>> >> [email protected]) Ended >>> >> 2009-04-30 17:52:54 [NOTICE] switch_core_session.c:1081 >>> >> switch_core_session_thread() Close Channel sofia/external/ >>> >> [email protected] [CS_DESTROY] >>> >> 2009-04-30 17:52:54 [DEBUG] switch_core_state_machine.c:559 >>> >> switch_core_session_destroy_state() (sofia/external/ >>> >> [email protected]) State DESTROY >>> >> 2009-04-30 17:52:54 [DEBUG] mod_sofia.c:240 sofia_on_destroy() >>> >> sofia/external/[email protected] SOFIA DESTROY >>> >> 2009-04-30 17:52:54 [DEBUG] switch_core_state_machine.c:60 >>> >> switch_core_standard_on_destroy() >>> >> sofia/external/[email protected] DESTROY >>> >> 2009-04-30 17:52:54 [DEBUG] switch_core_state_machine.c:559 >>> >> switch_core_session_destroy_state() (sofia/external/ >>> >> [email protected]) State DESTROY going to sleep >>> >> -- >>> >> Neu: GMX FreeDSL Komplettanschluss mit DSL 6.000 Flatrate + >>> >> Telefonanschluss für nur 17,95 Euro/mtl.!* >>> >> http://dslspecial.gmx.de/freedsl-surfflat/?ac=OM.AD.PD003K11308T4569a >>> >> >>> >> _______________________________________________ >>> >> Freeswitch-users mailing list >>> >> [email protected] >>> >> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users >>> >> >>> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users >>> >> http://www.freeswitch.org >>> >> >>> > >>> > >>> > >>> > -- >>> > Anthony Minessale II >>> > >>> > FreeSWITCH http://www.freeswitch.org/ >>> > ClueCon http://www.cluecon.com/ >>> > >>> > AIM: anthm >>> > MSN:[email protected] <msn%[email protected]> >>> > >>> GTALK/JABBER/PAYPAL:[email protected]<paypal%[email protected]> >>> > IRC: irc.freenode.net #freeswitch >>> > >>> > FreeSWITCH Developer Conference >>> > sip:[email protected] <sip%[email protected]> >>> > iax:[email protected]/888 >>> > >>> googletalk:[email protected]<googletalk%3aconf%[email protected]> >>> > pstn:213-799-1400 >>> > >>> >>> -- >>> Sent from my mobile device >>> >>> Sincerely, >>> >>> Giovanni Maruzzelli >>> ========================================= >>> www.celliax.org >>> via Pierlombardo 9, 20135 Milano >>> Italy >>> gmaruzz at celliax dot org >>> Cell : +39-347-2665618 >>> Fax : +39-02-87390039 >>> >>> _______________________________________________ >>> Freeswitch-users mailing list >>> [email protected] >>> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users >>> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users >>> http://www.freeswitch.org >> >> -- >> Neu: GMX FreeDSL Komplettanschluss mit DSL 6.000 Flatrate + Telefonanschluss >> für nur 17,95 Euro/mtl.!* >> http://dslspecial.gmx.de/freedsl-surfflat/?ac=OM.AD.PD003K11308T4569a >> >> _______________________________________________ >> Freeswitch-users mailing list >> [email protected] >> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users >> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users >> http://www.freeswitch.org >> > _______________________________________________ Freeswitch-users mailing list [email protected] http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org
