Hi Giovanni,<div><br></div><div>I have tested your suggestion, the call works fine, when answered in dial plan before bridge. <br><br></div><div><br><div class="gmail_quote">On Sat, Mar 5, 2011 at 5:01 AM, Giovanni Maruzzelli <span dir="ltr"><<a href="mailto:gmaruzz@gmail.com">gmaruzz@gmail.com</a>></span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex;">Hi Yi,<br>
<br>
could you please test your extension inserting an action "answer"<br>
before the action "bridge" ?<br>
<br>
-giovanni<br>
<div><div></div><div class="h5"><br>
On 3/5/11, Yihui Li <<a href="mailto:xyangni@gmail.com">xyangni@gmail.com</a>> wrote:<br>
> Dear all,<br>
><br>
> I am tring skypopen with latest git-head.<br>
> There are just 1 skype instance. When forward skype call to 5000, it works<br>
> fine. It also works fine with originate skypopen/interface1/*****<br>
> &bridge(user/1001)<br>
><br>
> But when I try to forward skype to 1001 with the following dial plan, call<br>
> hang up imediately when answered.<br>
><br>
> <extension name="skypetest"><br>
> <condition field="destination_number" expression="^(5100)$"><br>
> <action application="bridge" data="user/1001"/><br>
> </condition><br>
> </extension><br>
><br>
> I am working on l ubuntu 10.10 server edition and skype static 2.0.0.72<br>
><br>
> here is the skype configure<br>
> =============full mod_skypopen.conf.xml=====================<br>
> <configuration name="skypopen.conf" description="Skypopen Configuration"><br>
> <global_settings><br>
> <param name="debug" value="8"/><br>
> <param name="dialplan" value="XML"/><br>
> <param name="context" value="default"/><br>
> <param name="destination" value="5100"/><br>
> <param name="skype_user" value="user1"/><br>
> <param name="report_incoming_chatmessages" value="true"/><br>
> <param name="silent_mode" value="false"/><br>
> <param name="write_silence_when_idle" value="true"/><br>
> </global_settings><br>
> <!-- one entry here per each skypopen interface --><br>
> <per_interface_settings><br>
> <interface id="1" name="interface1"><br>
> <param name="X11-display" value="localhost:10.0"/><br>
> <param name="skype_user" value="niqizhi"/><br>
> </interface><br>
> </per_interface_settings><br>
> </configuration><br>
><br>
><br>
><br>
><br>
> the debug message of the call is listed below. May I ask what is the<br>
> possiable cause? Thanks.<br>
><br>
><br>
><br>
> 2011-03-05 03:15:13.353532 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][IDLE,IDLE] READING:<br>
> |||CALL 142 CONF_ID 0|||<br>
> 2011-03-05 03:15:13.438727 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][IDLE,IDLE] READING:<br>
> |||CALL 142 STATUS RINGING|||<br>
> 2011-03-05 03:15:13.438727 [DEBUG] skypopen_protocol.c:595<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 595 ][interface1 ][IDLE,IDLE] NO ACTIVE<br>
> calls in this moment, skype_call 142 is RINGING, to ask PARTNER_DISPNAME and<br>
> PARTNER_HANDLE<br>
> 2011-03-05 03:15:13.438727 [DEBUG] skypopen_protocol.c:1619<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1619 ][interface1 ][IDLE,IDLE] SENDING:<br>
> |||GET CALL 142 PARTNER_DISPNAME||||<br>
> 2011-03-05 03:15:13.438727 [DEBUG] skypopen_protocol.c:1619<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1619 ][interface1 ][IDLE,IDLE] SENDING:<br>
> |||GET CALL 142 PARTNER_HANDLE||||<br>
> 2011-03-05 03:15:13.576818 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][IDLE,IDLE] READING:<br>
> |||CALL 142 PARTNER_DISPNAME Eric Ni|||<br>
> 2011-03-05 03:15:13.609592 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][IDLE,IDLE] READING:<br>
> |||CALL 142 PARTNER_HANDLE eric.nqz|||<br>
> 2011-03-05 03:15:13.609592 [DEBUG] skypopen_protocol.c:506<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 506 ][interface1 ][IDLE,IDLE] Call 142<br>
> go to skypopen_partner_handle_ring<br>
> 2011-03-05 03:15:13.609592 [DEBUG] mod_skypopen.c:2626<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 2626 ][interface1 ][IDLE,IDLE] NOT FOUND<br>
> 2011-03-05 03:15:13.609592 [DEBUG] mod_skypopen.c:2244<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 2244 ][interface1 ][PRERING,IDLE] 2<br>
> SESSION_REQUEST c958d9be-46d6-11e0-bb71-d9b9e6428344<br>
> 2011-03-05 03:15:13.609592 [DEBUG] mod_skypopen.c:244<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 244 ][interface1 ][PRERING,IDLE]<br>
> codecs UP<br>
> 2011-03-05 03:15:13.609592 [DEBUG] mod_skypopen.c:273<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 273 ][interface1 ][PRERING,IDLE]<br>
> skypopen_tech_init SUCCESS<br>
> 2011-03-05 03:15:13.609592 [NOTICE] switch_channel.c:812 New Channel<br>
> skypopen/interface1 [c958d9be-46d6-11e0-bb71-d9b9e6428344]<br>
> 2011-03-05 03:15:13.609592 [DEBUG] mod_skypopen.c:2268 (skypopen/interface1)<br>
> State Change CS_NEW -> CS_INIT<br>
> 2011-03-05 03:15:13.609592 [DEBUG] switch_core_session.c:1116 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:13.609592 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][PRERING,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:13.609592 [DEBUG] mod_skypopen.c:2280<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 2280 ][interface1 ][PRERING,IDLE]<br>
> new_inbound_channel<br>
> 2011-03-05 03:15:13.610977 [DEBUG] switch_core_state_machine.c:320<br>
> (skypopen/interface1) Running State Change CS_INIT<br>
> 2011-03-05 03:15:13.610977 [DEBUG] switch_core_state_machine.c:356<br>
> (skypopen/interface1) State INIT<br>
> 2011-03-05 03:15:13.610977 [DEBUG] mod_skypopen.c:463 (skypopen/interface1)<br>
> State Change CS_INIT -> CS_ROUTING<br>
> 2011-03-05 03:15:13.610977 [DEBUG] switch_core_session.c:1116 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:13.610977 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][PRERING,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:13.610977 [DEBUG] mod_skypopen.c:464<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 464 ][interface1 ][PRERING,IDLE]<br>
> interface1 CHANNEL INIT c958d9be-46d6-11e0-bb71-d9b9e6428344<br>
> 2011-03-05 03:15:13.610977 [DEBUG] switch_core_state_machine.c:356<br>
> (skypopen/interface1) State INIT going to sleep<br>
> 2011-03-05 03:15:13.610977 [DEBUG] switch_core_state_machine.c:320<br>
> (skypopen/interface1) Running State Change CS_ROUTING<br>
> 2011-03-05 03:15:13.610977 [DEBUG] switch_channel.c:1664<br>
> (skypopen/interface1) Callstate Change DOWN -> RINGING<br>
> 2011-03-05 03:15:13.610977 [DEBUG] switch_core_state_machine.c:359<br>
> (skypopen/interface1) State ROUTING<br>
> 2011-03-05 03:15:13.610977 [DEBUG] mod_skypopen.c:664<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 664 ][interface1 ][PRERING,IDLE]<br>
> interface1 CHANNEL ROUTING<br>
> 2011-03-05 03:15:13.610977 [DEBUG] switch_core_state_machine.c:77<br>
> skypopen/interface1 Standard ROUTING<br>
> 2011-03-05 03:15:13.610977 [INFO] mod_dialplan_xml.c:331 Processing Eric Ni<br>
> <eric.nqz>->5100 in context default<br>
> Dialplan: skypopen/interface1 parsing [default->unloop] continue=false<br>
> Dialplan: skypopen/interface1 Regex (PASS) [unloop] ${unroll_loops}(true) =~<br>
> /^true$/ break=on-false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [unloop] ${sip_looped_call}() =~<br>
> /^true$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->tod_example] continue=true<br>
> Dialplan: skypopen/interface1 Date/Time Match (FAIL) [tod_example]<br>
> break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->holiday_example]<br>
> continue=true<br>
> Dialplan: skypopen/interface1 Date/Time Match (FAIL) [holiday_example]<br>
> break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->global-intercept]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [global-intercept]<br>
> destination_number(5100) =~ /^886$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->group-intercept]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [group-intercept]<br>
> destination_number(5100) =~ /^\*8$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->intercept-ext]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [intercept-ext]<br>
> destination_number(5100) =~ /^\*\*(\d+)$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->redial] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [redial] destination_number(5100)<br>
> =~ /^(redial|870)$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->global] continue=true<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [global] ${call_debug}(false) =~<br>
> /^true$/ break=never<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [global] ${sip_has_crypto}() =~<br>
> /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never<br>
> Dialplan: skypopen/interface1 Absolute Condition [global]<br>
> Dialplan: skypopen/interface1 Action<br>
> hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})<br>
> Dialplan: skypopen/interface1 Action<br>
> hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})<br>
> Dialplan: skypopen/interface1 Action<br>
> hash(insert/${domain_name}-last_dial/global/${uuid})<br>
> Dialplan: skypopen/interface1 Action set(RFC2822_DATE=${strftime(%a, %d %b<br>
> %Y %T %z)})<br>
> Dialplan: skypopen/interface1 parsing [default->snom-demo-2] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [snom-demo-2]<br>
> destination_number(5100) =~ /^9001$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->snom-demo-1] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [snom-demo-1]<br>
> destination_number(5100) =~ /^9000$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->eavesdrop] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [eavesdrop]<br>
> destination_number(5100) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->eavesdrop] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [eavesdrop]<br>
> destination_number(5100) =~ /^779$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->call_return] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [call_return]<br>
> destination_number(5100) =~ /^\*69$|^869$|^lcr$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->del-group] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [del-group]<br>
> destination_number(5100) =~ /^80(\d{2})$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->add-group] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [add-group]<br>
> destination_number(5100) =~ /^81(\d{2})$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->call-group-simo]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [call-group-simo]<br>
> destination_number(5100) =~ /^82(\d{2})$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->call-group-order]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [call-group-order]<br>
> destination_number(5100) =~ /^83(\d{2})$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->extension-intercom]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [extension-intercom]<br>
> destination_number(5100) =~ /^8(10[01][0-9])$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->Local_Extension]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [Local_Extension]<br>
> destination_number(5100) =~ /^(10[01][0-9])$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->Local_Extension_Skinny]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [Local_Extension_Skinny]<br>
> destination_number(5100) =~ /^(11[01][0-9])$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->group_dial_sales]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [group_dial_sales]<br>
> destination_number(5100) =~ /^2000$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->group_dial_support]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [group_dial_support]<br>
> destination_number(5100) =~ /^2001$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->group_dial_billing]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [group_dial_billing]<br>
> destination_number(5100) =~ /^2002$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->operator] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [operator]<br>
> destination_number(5100) =~ /^(operator|0)$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->vmain] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [vmain] destination_number(5100)<br>
> =~ /^vmain$|^4000$|^\*98$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->sip_uri] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [sip_uri]<br>
> destination_number(5100) =~ /^sip:(.*)$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->nb_conferences]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [nb_conferences]<br>
> destination_number(5100) =~ /^(30\d{2})$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->wb_conferences]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [wb_conferences]<br>
> destination_number(5100) =~ /^(31\d{2})$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->uwb_conferences]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [uwb_conferences]<br>
> destination_number(5100) =~ /^(32\d{2})$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->cdquality_conferences]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [cdquality_conferences]<br>
> destination_number(5100) =~ /^(33\d{2})$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing<br>
> [default->freeswitch_public_conf_via_sip] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [freeswitch_public_conf_via_sip]<br>
> destination_number(5100) =~ /^9(888|8888|1616|3232)$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->mad_boss_intercom]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [mad_boss_intercom]<br>
> destination_number(5100) =~ /^0911$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->mad_boss_intercom]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [mad_boss_intercom]<br>
> destination_number(5100) =~ /^0912$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->mad_boss] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [mad_boss]<br>
> destination_number(5100) =~ /^0913$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->ivr_demo] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [ivr_demo]<br>
> destination_number(5100) =~ /^5000$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->dynamic_conference]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [dynamic_conference]<br>
> destination_number(5100) =~ /^5001$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->rtp_multicast_page]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [rtp_multicast_page]<br>
> destination_number(5100) =~ /^pagegroup$|^7243$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->park] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [park] destination_number(5100)<br>
> =~ /^5900$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->unpark] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [unpark] destination_number(5100)<br>
> =~ /^5901$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->valet_park] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [valet_park]<br>
> destination_number(5100) =~ /^(6000)$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->valet_park] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [valet_park]<br>
> destination_number(5100) =~ /^(60\d[1-9])$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->park] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [park] source(mod_skypopen) =~<br>
> /mod_sofia/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->unpark] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [unpark] source(mod_skypopen) =~<br>
> /mod_sofia/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->park] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [park] source(mod_skypopen) =~<br>
> /mod_sofia/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->unpark] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [unpark] source(mod_skypopen) =~<br>
> /mod_sofia/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->wait] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [wait] destination_number(5100)<br>
> =~ /^wait$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->fax_receive] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [fax_receive]<br>
> destination_number(5100) =~ /^9178$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->fax_transmit] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [fax_transmit]<br>
> destination_number(5100) =~ /^9179$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->ringback_180] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [ringback_180]<br>
> destination_number(5100) =~ /^9180$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->ringback_183_uk_ring]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [ringback_183_uk_ring]<br>
> destination_number(5100) =~ /^9181$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->ringback_183_music_ring]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [ringback_183_music_ring]<br>
> destination_number(5100) =~ /^9182$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing<br>
> [default->ringback_post_answer_uk_ring] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [ringback_post_answer_uk_ring]<br>
> destination_number(5100) =~ /^9183$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->ringback_post_answer_music]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [ringback_post_answer_music]<br>
> destination_number(5100) =~ /^9184$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->ClueCon] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [ClueCon]<br>
> destination_number(5100) =~ /^9191$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->show_info] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [show_info]<br>
> destination_number(5100) =~ /^9192$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->video_record] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [video_record]<br>
> destination_number(5100) =~ /^9193$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->video_playback]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [video_playback]<br>
> destination_number(5100) =~ /^9194$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->delay_echo] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [delay_echo]<br>
> destination_number(5100) =~ /^9195$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->echo] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [echo] destination_number(5100)<br>
> =~ /^9196$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->milliwatt] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [milliwatt]<br>
> destination_number(5100) =~ /^9197$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->tone_stream] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [tone_stream]<br>
> destination_number(5100) =~ /^9198$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->zrtp_enrollement]<br>
> continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [zrtp_enrollement]<br>
> destination_number(5100) =~ /^9787$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->hold_music] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [hold_music]<br>
> destination_number(5100) =~ /^9664$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->pizza_demo] continue=false<br>
> Dialplan: skypopen/interface1 Regex (FAIL) [pizza_demo]<br>
> destination_number(5100) =~ /^(pizza|74992)$/ break=on-false<br>
> Dialplan: skypopen/interface1 parsing [default->skypetest] continue=false<br>
> Dialplan: skypopen/interface1 Regex (PASS) [skypetest]<br>
> destination_number(5100) =~ /^(5100)$/ break=on-false<br>
> Dialplan: skypopen/interface1 Action bridge(user/1001)<br>
> 2011-03-05 03:15:13.612058 [DEBUG] switch_core_state_machine.c:119<br>
> (skypopen/interface1) State Change CS_ROUTING -> CS_EXECUTE<br>
> 2011-03-05 03:15:13.612058 [DEBUG] switch_core_session.c:1116 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:13.612058 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][PRERING,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:13.612058 [DEBUG] switch_core_state_machine.c:359<br>
> (skypopen/interface1) State ROUTING going to sleep<br>
> 2011-03-05 03:15:13.612058 [DEBUG] switch_core_state_machine.c:320<br>
> (skypopen/interface1) Running State Change CS_EXECUTE<br>
> 2011-03-05 03:15:13.612058 [DEBUG] switch_core_state_machine.c:366<br>
> (skypopen/interface1) State EXECUTE<br>
> 2011-03-05 03:15:13.612058 [DEBUG] mod_skypopen.c:681<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 681 ][interface1 ][PRERING,IDLE]<br>
> interface1 CHANNEL EXECUTE<br>
> 2011-03-05 03:15:13.612058 [DEBUG] switch_core_state_machine.c:157<br>
> skypopen/interface1 Standard EXECUTE<br>
> EXECUTE skypopen/interface1<br>
> hash(insert/178.79.156.136-spymap/eric.nqz/c958d9be-46d6-11e0-bb71-d9b9e6428344)<br>
> 2011-03-05 03:15:13.612058 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PRERING,IDLE]<br>
> MSG_ID=26<br>
> 2011-03-05 03:15:13.612058 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PRERING,IDLE]<br>
> MSG_ID=27<br>
> EXECUTE skypopen/interface1<br>
> hash(insert/178.79.156.136-last_dial/eric.nqz/5100)<br>
> 2011-03-05 03:15:13.613142 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PRERING,IDLE]<br>
> MSG_ID=26<br>
> 2011-03-05 03:15:13.613142 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PRERING,IDLE]<br>
> MSG_ID=27<br>
> EXECUTE skypopen/interface1<br>
> hash(insert/178.79.156.136-last_dial/global/c958d9be-46d6-11e0-bb71-d9b9e6428344)<br>
> 2011-03-05 03:15:13.613142 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PRERING,IDLE]<br>
> MSG_ID=26<br>
> 2011-03-05 03:15:13.613142 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PRERING,IDLE]<br>
> MSG_ID=27<br>
> EXECUTE skypopen/interface1 set(RFC2822_DATE=Sat, 05 Mar 2011 03:15:13<br>
> +0000)<br>
> 2011-03-05 03:15:13.613142 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PRERING,IDLE]<br>
> MSG_ID=26<br>
> 2011-03-05 03:15:13.613142 [DEBUG] mod_dptools.c:1059 skypopen/interface1<br>
> SET [RFC2822_DATE]=[Sat, 05 Mar 2011 03:15:13 +0000]<br>
> 2011-03-05 03:15:13.613142 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PRERING,IDLE]<br>
> MSG_ID=27<br>
> EXECUTE skypopen/interface1 bridge(user/1001)<br>
> 2011-03-05 03:15:13.613142 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PRERING,IDLE]<br>
> MSG_ID=26<br>
> 2011-03-05 03:15:13.614232 [DEBUG] switch_ivr_originate.c:1971 variable<br>
> string 0 = [sip_invite_domain=178.79.156.136]<br>
> 2011-03-05 03:15:13.614232 [DEBUG] switch_ivr_originate.c:1971 variable<br>
> string 1 = [presence_id=<a href="mailto:1001@178.79.156.136">1001@178.79.156.136</a>]<br>
> 2011-03-05 03:15:13.614232 [NOTICE] switch_channel.c:812 New Channel<br>
> sofia/internal/sip:1001@90.198.86.129:62954[c959849a-46d6-11e0-bb72-d9b9e6428344]<br>
> 2011-03-05 03:15:13.614232 [DEBUG] mod_sofia.c:4151 (sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State Change CS_NEW -> CS_INIT<br>
> 2011-03-05 03:15:13.614232 [DEBUG] switch_core_session.c:1116 Send signal<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [BREAK]<br>
> 2011-03-05 03:15:13.614232 [DEBUG] switch_core_state_machine.c:320<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Running State Change CS_INIT<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_core_state_machine.c:356<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State INIT<br>
> 2011-03-05 03:15:13.615308 [DEBUG] mod_sofia.c:84 sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> SOFIA INIT<br>
> 2011-03-05 03:15:13.615308 [DEBUG] mod_sofia.c:124 (sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State Change CS_INIT -> CS_ROUTING<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_core_session.c:1116 Send signal<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [BREAK]<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_core_state_machine.c:356<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State INIT going to sleep<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_core_state_machine.c:320<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Running State Change<br>
> CS_ROUTING<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_channel.c:1664 (sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Callstate Change DOWN -> RINGING<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_core_state_machine.c:359<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State ROUTING<br>
> 2011-03-05 03:15:13.615308 [DEBUG] mod_sofia.c:147 sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> SOFIA ROUTING<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_ivr_originate.c:66<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State Change CS_ROUTING -><br>
> CS_CONSUME_MEDIA<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_core_session.c:1116 Send signal<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [BREAK]<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_core_state_machine.c:359<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State ROUTING going to sleep<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_core_state_machine.c:320<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Running State Change<br>
> CS_CONSUME_MEDIA<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_core_state_machine.c:378<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State CONSUME_MEDIA<br>
> 2011-03-05 03:15:13.615308 [DEBUG] sofia.c:4683 Channel sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> entering state [calling][0]<br>
> 2011-03-05 03:15:13.615308 [DEBUG] switch_core_state_machine.c:378<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State CONSUME_MEDIA going to<br>
> sleep<br>
> 2011-03-05 03:15:13.758128 [INFO] sofia.c:729 sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> Update Callee ID to "Outbound Call" <1001><br>
> 2011-03-05 03:15:13.759171 [DEBUG] sofia.c:4683 Channel sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> entering state [proceeding][180]<br>
> 2011-03-05 03:15:13.759171 [NOTICE] sofia.c:4761 Ring-Ready sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>!<br>
> 2011-03-05 03:15:13.759171 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PRERING,IDLE]<br>
> MSG_ID=7<br>
> 2011-03-05 03:15:13.759171 [DEBUG] switch_core_session.c:709 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:13.759171 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][PRERING,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:13.759171 [NOTICE] switch_ivr_originate.c:479 Ring Ready<br>
> skypopen/interface1!<br>
> 2011-03-05 03:15:13.759171 [NOTICE] switch_ivr_originate.c:479 Ring-Ready<br>
> skypopen/interface1!<br>
> 2011-03-05 03:15:15.372653 [DEBUG] sofia.c:4683 Channel sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> entering state [completing][200]<br>
> 2011-03-05 03:15:15.372653 [DEBUG] sofia.c:4694 Remote SDP:<br>
> v=0<br>
> o=- 1 2 IN IP4 90.198.86.129<br>
> s=CounterPath eyeBeam 1.5<br>
> c=IN IP4 90.198.86.129<br>
> t=0 0<br>
> m=audio 56446 RTP/AVP 8 101<br>
> a=rtpmap:101 telephone-event/8000<br>
> a=fmtp:101 0-15<br>
><br>
> 2011-03-05 03:15:15.373722 [DEBUG] sofia.c:4683 Channel sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> entering state [ready][200]<br>
> 2011-03-05 03:15:15.373722 [DEBUG] sofia_glue.c:4529 Audio Codec Compare<br>
> [PCMA:8:8000:20:64000]/[L16:10:16000:20:256000]<br>
> 2011-03-05 03:15:15.373722 [DEBUG] sofia_glue.c:4529 Audio Codec Compare<br>
> [PCMA:8:8000:20:64000]/[G7221:115:32000:20:48000]<br>
> 2011-03-05 03:15:15.373722 [DEBUG] sofia_glue.c:4529 Audio Codec Compare<br>
> [PCMA:8:8000:20:64000]/[G7221:107:16000:20:32000]<br>
> 2011-03-05 03:15:15.373722 [DEBUG] sofia_glue.c:4529 Audio Codec Compare<br>
> [PCMA:8:8000:20:64000]/[G722:9:8000:20:64000]<br>
> 2011-03-05 03:15:15.373722 [DEBUG] sofia_glue.c:4529 Audio Codec Compare<br>
> [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000]<br>
> 2011-03-05 03:15:15.373722 [DEBUG] sofia_glue.c:4529 Audio Codec Compare<br>
> [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000]<br>
> 2011-03-05 03:15:15.373722 [DEBUG] sofia_glue.c:2760 Set Codec<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> PCMA/8000 20 ms 160 samples<br>
> 64000 bits<br>
> 2011-03-05 03:15:15.373722 [DEBUG] sofia_glue.c:4635 Set 2833 dtmf send<br>
> payload to 101<br>
> 2011-03-05 03:15:15.373722 [DEBUG] sofia_glue.c:2990 AUDIO RTP<br>
> [sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>] 178.79.156.136 port 32054 -><br>
> 90.198.86.129 port 56446 codec: 8 ms: 20<br>
> 2011-03-05 03:15:15.373722 [DEBUG] switch_rtp.c:1621 Starting timer [soft]<br>
> 160 bytes per 20ms<br>
> 2011-03-05 03:15:15.374777 [DEBUG] sofia_glue.c:3235 Set 2833 dtmf send<br>
> payload to 101<br>
> 2011-03-05 03:15:15.374777 [DEBUG] sofia_glue.c:3240 Set 2833 dtmf receive<br>
> payload to 101<br>
> 2011-03-05 03:15:15.374777 [DEBUG] switch_channel.c:2795 (sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Callstate Change RINGING -> ACTIVE<br>
> 2011-03-05 03:15:15.374777 [DEBUG] switch_channel.c:2807 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:15.374777 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][PRERING,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:15.374777 [NOTICE] sofia.c:5267 Channel [sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>] has been answered<br>
> 2011-03-05 03:15:15.375852 [DEBUG] mod_skypopen.c:1115<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1115 ][interface1 ][PRERING,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_MESSAGE_INDICATE_ANSWER<br>
> 2011-03-05 03:15:15.375852 [DEBUG] mod_skypopen.c:2723<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 2723 ][interface1 ][PRERING,IDLE] NOT<br>
> FOUND<br>
> 2011-03-05 03:15:15.375852 [DEBUG] skypopen_protocol.c:1619<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1619 ][interface1 ][PREANSW,IDLE]<br>
> SENDING: |||ALTER CALL 142 ANSWER||||<br>
> 2011-03-05 03:15:15.375852 [DEBUG] mod_skypopen.c:2734<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 2734 ][interface1 ][PREANSW,IDLE] We<br>
> answered a Skype RING on skype_call 142<br>
> 2011-03-05 03:15:15.375852 [DEBUG] mod_skypopen.c:2742<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 2742 ][interface1 ][PREANSW,IDLE] NEW!<br>
> name: interface1, state: 11, value=eric.nqz,<br>
> tech_pvt->callid_number=eric.nqz, tech_pvt->skype_user=niqizhi<br>
> 2011-03-05 03:15:15.472676 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][PREANSW,IDLE]<br>
> READING: |||ALTER CALL 142 ANSWER|||<br>
> 2011-03-05 03:15:15.884213 [DEBUG] mod_skypopen.c:1142<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1142 ][interface1 ][PREANSW,IDLE]<br>
> Synching audio<br>
> 2011-03-05 03:15:15.884213 [DEBUG] switch_core_session.c:709 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:15.884213 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][PREANSW,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:15.884213 [DEBUG] switch_channel.c:2795<br>
> (skypopen/interface1) Callstate Change RINGING -> ACTIVE<br>
> 2011-03-05 03:15:15.884213 [NOTICE] switch_ivr_originate.c:3363 Channel<br>
> [skypopen/interface1] has been answered<br>
> 2011-03-05 03:15:15.884213 [DEBUG] mod_skypopen.c:1148<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1148 ][interface1 ][PREANSW,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_MESSAGE_INDICATE_AUDIO_SYNC<br>
> 2011-03-05 03:15:15.884213 [DEBUG] mod_skypopen.c:1170<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1170 ][interface1 ][PREANSW,IDLE]<br>
> Synching audio<br>
> 2011-03-05 03:15:15.884213 [DEBUG] switch_ivr_originate.c:3408 Originate<br>
> Resulted in Success: [sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>]<br>
> 2011-03-05 03:15:15.884213 [DEBUG] mod_skypopen.c:1148<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1148 ][interface1 ][PREANSW,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_MESSAGE_INDICATE_AUDIO_SYNC<br>
> 2011-03-05 03:15:15.884213 [DEBUG] mod_skypopen.c:1170<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1170 ][interface1 ][PREANSW,IDLE]<br>
> Synching audio<br>
> 2011-03-05 03:15:15.885293 [DEBUG] switch_ivr_originate.c:3408 Originate<br>
> Resulted in Success: [sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>]<br>
> 2011-03-05 03:15:15.885293 [DEBUG] mod_skypopen.c:1148<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1148 ][interface1 ][PREANSW,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_MESSAGE_INDICATE_AUDIO_SYNC<br>
> 2011-03-05 03:15:15.885293 [DEBUG] mod_skypopen.c:1170<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1170 ][interface1 ][PREANSW,IDLE]<br>
> Synching audio<br>
> 2011-03-05 03:15:15.885293 [DEBUG] switch_core_session.c:709 Send signal<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [BREAK]<br>
> 2011-03-05 03:15:15.885293 [DEBUG] mod_skypopen.c:1173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1173 ][interface1 ][PREANSW,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_MESSAGE_INDICATE_BRIDGE<br>
> 2011-03-05 03:15:15.885293 [DEBUG] mod_skypopen.c:1195<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1195 ][interface1 ][PREANSW,IDLE]<br>
> Synching audio<br>
> 2011-03-05 03:15:15.885293 [DEBUG] switch_core_session.c:709 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:15.885293 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][PREANSW,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:15.885293 [DEBUG] switch_ivr_bridge.c:1234 (sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State Change CS_CONSUME_MEDIA -><br>
> CS_EXCHANGE_MEDIA<br>
> 2011-03-05 03:15:15.885293 [DEBUG] switch_core_session.c:1116 Send signal<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [BREAK]<br>
> 2011-03-05 03:15:15.885293 [DEBUG] switch_core_state_machine.c:320<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Running State Change<br>
> CS_EXCHANGE_MEDIA<br>
> 2011-03-05 03:15:15.885293 [DEBUG] switch_core_state_machine.c:369<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State EXCHANGE_MEDIA<br>
> 2011-03-05 03:15:15.885293 [DEBUG] mod_sofia.c:552 SOFIA EXCHANGE_MEDIA<br>
> 2011-03-05 03:15:15.886388 [DEBUG] switch_core_session.c:771 Send signal<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [BREAK]<br>
> 2011-03-05 03:15:15.886388 [DEBUG] switch_core_session.c:771 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:15.886388 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][PREANSW,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:15.906103 [DEBUG] switch_ivr_bridge.c:500<br>
> skypopen/interface1 ending bridge by request from read function<br>
> 2011-03-05 03:15:15.906103 [DEBUG] switch_ivr_bridge.c:581 BRIDGE THREAD<br>
> DONE [skypopen/interface1]<br>
> 2011-03-05 03:15:15.906103 [DEBUG] switch_ivr_bridge.c:601 Send signal<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [BREAK]<br>
> 2011-03-05 03:15:15.909404 [DEBUG] switch_ivr_bridge.c:581 BRIDGE THREAD<br>
> DONE [sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>]<br>
> 2011-03-05 03:15:15.909404 [DEBUG] switch_ivr_bridge.c:601 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:15.909404 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][PREANSW,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:15.909404 [DEBUG] switch_channel.c:2545 (sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Callstate Change ACTIVE -> HANGUP<br>
> 2011-03-05 03:15:15.909404 [NOTICE] switch_ivr_bridge.c:653 Hangup<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [CS_EXCHANGE_MEDIA]<br>
> [NORMAL_CLEARING]<br>
> 2011-03-05 03:15:15.909404 [DEBUG] switch_channel.c:2561 Send signal<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [KILL]<br>
> 2011-03-05 03:15:15.909404 [DEBUG] switch_core_session.c:1116 Send signal<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [BREAK]<br>
> 2011-03-05 03:15:15.909404 [DEBUG] switch_core_state_machine.c:369<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State EXCHANGE_MEDIA going to<br>
> sleep<br>
> 2011-03-05 03:15:15.909404 [DEBUG] switch_core_state_machine.c:320<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Running State Change CS_HANGUP<br>
> 2011-03-05 03:15:15.910537 [DEBUG] switch_core_state_machine.c:560<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State HANGUP<br>
> 2011-03-05 03:15:15.910537 [DEBUG] mod_sofia.c:457 Channel sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> hanging up, cause: NORMAL_CLEARING<br>
> 2011-03-05 03:15:15.910537 [DEBUG] switch_ivr_bridge.c:1305 sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> skip receive message [UNBRIDGE] (channel is<br>
> hungup already)<br>
> 2011-03-05 03:15:15.910537 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PREANSW,IDLE]<br>
> MSG_ID=5<br>
> 2011-03-05 03:15:15.910537 [DEBUG] switch_core_session.c:709 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:15.910537 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][PREANSW,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:15.910537 [DEBUG] mod_skypopen.c:1201<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1201 ][interface1 ][PREANSW,IDLE]<br>
> MSG_ID=27<br>
> 2011-03-05 03:15:15.910537 [NOTICE] switch_core_state_machine.c:189<br>
> skypopen/interface1 has executed the last dialplan instruction, hanging up.<br>
> 2011-03-05 03:15:15.910537 [DEBUG] switch_channel.c:2545<br>
> (skypopen/interface1) Callstate Change ACTIVE -> HANGUP<br>
> 2011-03-05 03:15:15.910537 [NOTICE] switch_core_state_machine.c:191 Hangup<br>
> skypopen/interface1 [CS_EXECUTE] [NORMAL_CLEARING]<br>
> 2011-03-05 03:15:15.910537 [DEBUG] switch_channel.c:2561 Send signal<br>
> skypopen/interface1 [KILL]<br>
> 2011-03-05 03:15:15.910537 [DEBUG] mod_skypopen.c:700<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 700 ][interface1 ][PREANSW,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_KILL<br>
> 2011-03-05 03:15:15.910537 [DEBUG] switch_core_session.c:1116 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:15.910537 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][HANG_RQ,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:15.910537 [DEBUG] switch_core_state_machine.c:366<br>
> (skypopen/interface1) State EXECUTE going to sleep<br>
> 2011-03-05 03:15:15.910537 [DEBUG] mod_sofia.c:500 Sending BYE to<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a><br>
> 2011-03-05 03:15:15.910537 [DEBUG] switch_core_state_machine.c:320<br>
> (skypopen/interface1) Running State Change CS_HANGUP<br>
> 2011-03-05 03:15:15.910537 [DEBUG] switch_core_state_machine.c:560<br>
> (skypopen/interface1) State HANGUP<br>
> 2011-03-05 03:15:15.910537 [DEBUG] mod_skypopen.c:623<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 623 ][interface1 ][HANG_RQ,IDLE]<br>
> hanging up skype call: 142<br>
> 2011-03-05 03:15:15.911571 [DEBUG] skypopen_protocol.c:1619<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1619 ][interface1 ][HANG_RQ,IDLE]<br>
> SENDING: |||ALTER CALL 142 END HANGUP||||<br>
> 2011-03-05 03:15:15.911571 [DEBUG] skypopen_protocol.c:1619<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1619 ][interface1 ][HANG_RQ,IDLE]<br>
> SENDING: |||ALTER CALL 142 HANGUP||||<br>
> 2011-03-05 03:15:15.911571 [DEBUG] mod_skypopen.c:629<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 629 ][interface1 ][HANG_RQ,IDLE]<br>
> interface1 CHANNEL HANGUP<br>
> 2011-03-05 03:15:15.911571 [DEBUG] mod_skypopen.c:648 (skypopen/interface1)<br>
> State Change CS_HANGUP -> CS_DESTROY<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_session.c:1116 Send signal<br>
> skypopen/interface1 [BREAK]<br>
> 2011-03-05 03:15:15.911571 [DEBUG] mod_skypopen.c:727<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 727 ][interface1 ][DOWN,IDLE]<br>
> skypopen/interface1 CHANNEL got SWITCH_SIG_BREAK<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:560<br>
> (skypopen/interface1) State HANGUP going to sleep<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_session.c:1288 Session 24<br>
> (skypopen/interface1) Locked, Waiting on external entities<br>
> 2011-03-05 03:15:15.911571 [NOTICE] switch_core_session.c:1306 Session 24<br>
> (skypopen/interface1) Ended<br>
> 2011-03-05 03:15:15.911571 [NOTICE] switch_core_session.c:1308 Close Channel<br>
> skypopen/interface1 [CS_DESTROY]<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:46<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> Standard HANGUP, cause:<br>
> NORMAL_CLEARING<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:560<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State HANGUP going to sleep<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:351<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State Change CS_HANGUP -><br>
> CS_REPORTING<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_session.c:1116 Send signal<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [BREAK]<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:320<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Running State Change<br>
> CS_REPORTING<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:620<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State REPORTING<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:53<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> Standard REPORTING, cause:<br>
> NORMAL_CLEARING<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:620<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State REPORTING going to sleep<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:449<br>
> (skypopen/interface1) Callstate Change HANGUP -> DOWN<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:452<br>
> (skypopen/interface1) Running State Change CS_DESTROY<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:462<br>
> (skypopen/interface1) State DESTROY<br>
> 2011-03-05 03:15:15.911571 [DEBUG] mod_skypopen.c:479<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 479 ][interface1 ][DOWN,IDLE]<br>
> interface1 CHANNEL DESTROY c958d9be-46d6-11e0-bb71-d9b9e6428344<br>
> 2011-03-05 03:15:15.911571 [DEBUG] mod_skypopen.c:493<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 493 ][interface1 ][DOWN,IDLE] audio<br>
> tcp threads to DIE<br>
> 2011-03-05 03:15:15.911571 [DEBUG] mod_skypopen.c:503<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 503 ][interface1 ][DOWN,IDLE] audio<br>
> tcp srv thread DEAD 0<br>
> 2011-03-05 03:15:15.911571 [DEBUG] mod_skypopen.c:513<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 513 ][interface1 ][DOWN,IDLE] audio<br>
> tcp cli thread DEAD 0<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:345<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State Change CS_REPORTING -><br>
> CS_DESTROY<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_session.c:1116 Send signal<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [BREAK]<br>
> 2011-03-05 03:15:15.911571 [DEBUG] mod_skypopen.c:524<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 524 ][interface1 ][DOWN,IDLE] codecs<br>
> DOWN<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_session.c:1288 Session 25<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Locked, Waiting on external<br>
> entities<br>
> 2011-03-05 03:15:15.911571 [DEBUG] mod_skypopen.c:579<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 579 ][interface1 ][IDLE,IDLE] CHANNEL<br>
> DESTROYED c958d9be-46d6-11e0-bb71-d9b9e6428344<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:60<br>
> skypopen/interface1 Standard DESTROY<br>
> 2011-03-05 03:15:15.911571 [NOTICE] switch_core_session.c:1306 Session 25<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Ended<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:462<br>
> (skypopen/interface1) State DESTROY going to sleep<br>
> 2011-03-05 03:15:15.911571 [NOTICE] switch_core_session.c:1308 Close Channel<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> [CS_DESTROY]<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:449<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Callstate Change HANGUP -><br>
> DOWN<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:452<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) Running State Change<br>
> CS_DESTROY<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:462<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State DESTROY<br>
> 2011-03-05 03:15:15.911571 [DEBUG] mod_sofia.c:362 sofia/internal/<br>
> <a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> SOFIA DESTROY<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:60<br>
> sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a> Standard DESTROY<br>
> 2011-03-05 03:15:15.911571 [DEBUG] switch_core_state_machine.c:462<br>
> (sofia/internal/<a href="http://sip:1001@90.198.86.129:62954" target="_blank">sip:1001@90.198.86.129:62954</a>) State DESTROY going to sleep<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][IDLE,IDLE] READING:<br>
> |||CALL 142 STATUS INPROGRESS|||<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:719<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 719 ][interface1 ][IDLE,IDLE] no<br>
> tech_pvt->session_uuid_str<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:725<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 725 ][interface1 ][IDLE,IDLE]<br>
> skype_call: 142 is now active<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:732<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 732 ][interface1 ][UP,INPROGRS] START<br>
> start_audio_threads<br>
> 2011-03-05 03:15:16.149772 [DEBUG] mod_skypopen.c:2203<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 2203 ][interface1 ][UP,INPROGRS] started<br>
> tcp_srv_thread thread.<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:89<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 89 ][interface1 ][UP,INPROGRS]<br>
> Binded! *which_port=32783, tech_pvt->tcp_cli_port=32782,<br>
> tech_pvt->tcp_srv_port=32783<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:94<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 94 ][interface1 ][UP,INPROGRS] 1<br>
> SO_RCVBUF is 87380, size is 4<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:98<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 98 ][interface1 ][UP,INPROGRS] 1<br>
> SO_SNDBUF is 16384, size is 4<br>
> 2011-03-05 03:15:16.149772 [DEBUG] mod_skypopen.c:2219<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 2219 ][interface1 ][UP,INPROGRS] started<br>
> tcp_cli_thread thread.<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:115<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 115 ][interface1 ][UP,INPROGRS] 2<br>
> SO_RCVBUF is 87380, size is 4<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:130<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 130 ][interface1 ][UP,INPROGRS] 2<br>
> SO_SNDBUF is 16384, size is 4<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:89<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 89 ][interface1 ][UP,INPROGRS]<br>
> Binded! *which_port=32784, tech_pvt->tcp_cli_port=32784,<br>
> tech_pvt->tcp_srv_port=32783<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:134<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 134 ][interface1 ][UP,INPROGRS]<br>
> TCP_NODELAY is 0<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:94<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 94 ][interface1 ][UP,INPROGRS] 1<br>
> SO_RCVBUF is 87380, size is 4<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:141<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 141 ][interface1 ][UP,INPROGRS]<br>
> TCP_NODELAY is 0<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:98<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 98 ][interface1 ][UP,INPROGRS] 1<br>
> SO_SNDBUF is 16384, size is 4<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:833<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 833 ][interface1 ][UP,INPROGRS] started<br>
> tcp_srv_thread thread.<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:115<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 115 ][interface1 ][UP,INPROGRS] 2<br>
> SO_RCVBUF is 87380, size is 4<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:130<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 130 ][interface1 ][UP,INPROGRS] 2<br>
> SO_SNDBUF is 16384, size is 4<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:134<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 134 ][interface1 ][UP,INPROGRS]<br>
> TCP_NODELAY is 0<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:141<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 141 ][interface1 ][UP,INPROGRS]<br>
> TCP_NODELAY is 0<br>
> 2011-03-05 03:15:16.149772 [DEBUG] skypopen_protocol.c:997<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 997 ][interface1 ][UP,INPROGRS] started<br>
> tcp_cli_thread thread.<br>
> 2011-03-05 03:15:16.250297 [DEBUG] skypopen_protocol.c:1619<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1619 ][interface1 ][UP,INPROGRS]<br>
> SENDING: |||ALTER CALL 142 SET_INPUT PORT="32784"||||<br>
> 2011-03-05 03:15:16.250297 [DEBUG] skypopen_protocol.c:1619<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1619 ][interface1 ][UP,INPROGRS]<br>
> SENDING: |||#output ALTER CALL 142 SET_OUTPUT PORT="32783"||||<br>
> 2011-03-05 03:15:16.250297 [WARNING] skypopen_protocol.c:2036<br>
> [32b8f10|9350fb9] [WARNINGA 2036 ][interface1 ][UP,INPROGRS] no<br>
> tech_pvt->session_uuid_str after INPROGRESS, let's hangup<br>
> 2011-03-05 03:15:16.250297 [DEBUG] skypopen_protocol.c:1619<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1619 ][interface1 ][UP,INPROGRS]<br>
> SENDING: |||ALTER CALL 142 HANGUP||||<br>
> 2011-03-05 03:15:16.250297 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][UP,INPROGRS]<br>
> READING: |||CALL 142 VIDEO_SEND_STATUS AVAILABLE|||<br>
> 2011-03-05 03:15:16.290473 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][UP,INPROGRS]<br>
> READING: |||CALL 142 VIDEO_STATUS VIDEO_BOTH_ENABLED|||<br>
> 2011-03-05 03:15:16.363839 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][UP,INPROGRS]<br>
> READING: |||CALL 142 DURATION 1|||<br>
> 2011-03-05 03:15:16.432605 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][UP,INPROGRS]<br>
> READING: |||ALTER CALL 142 END HANGUP|||<br>
> 2011-03-05 03:15:16.494506 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][UP,INPROGRS]<br>
> READING: |||ERROR 559 CALL: Action failed|||<br>
> 2011-03-05 03:15:16.495584 [DEBUG] skypopen_protocol.c:228<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 228 ][interface1 ][UP,INPROGRS] Skype<br>
> got ERROR about a failed action (probably TRYING to HANGUP A CALL), no<br>
> problem: |||ERROR 559 CALL: Action failed|||<br>
> 2011-03-05 03:15:16.710271 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][UP,INPROGRS]<br>
> READING: |||ERROR 589 ALTER CALL: unable to alter input/output|||<br>
> 2011-03-05 03:15:16.711346 [DEBUG] skypopen_protocol.c:247<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 247 ][interface1 ][UP,INPROGRS] Skype<br>
> client was not able to correctly manage tcp audio sockets, probably got a<br>
> local or remote hangup: |||ERROR 589 ALTER CALL: unable to alter<br>
> input/output|||<br>
> 2011-03-05 03:15:16.711346 [DEBUG] skypopen_protocol.c:1619<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1619 ][interface1 ][UP,INPROGRS]<br>
> SENDING: |||ALTER CALL 142 HANGUP||||<br>
> 2011-03-05 03:15:16.711346 [DEBUG] skypopen_protocol.c:1619<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1619 ][interface1 ][UP,INPROGRS]<br>
> SENDING: |||ALTER CALL 142 END HANGUP||||<br>
> 2011-03-05 03:15:16.711346 [DEBUG] mod_skypopen.c:1413<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1413 ][interface1 ][DOWN,INPROGRS] skype<br>
> call ended<br>
> 2011-03-05 03:15:16.711346 [DEBUG] mod_skypopen.c:1433<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1433 ][interface1 ][DOWN,INPROGRS] no<br>
> session<br>
> 2011-03-05 03:15:16.711346 [DEBUG] mod_skypopen.c:1436<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1436 ][interface1 ][DOWN,INPROGRS] audio<br>
> tcp threads to DIE<br>
> 2011-03-05 03:15:16.712434 [DEBUG] skypopen_protocol.c:960<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 960 ][interface1 ][DOWN,INPROGRS]<br>
> incoming audio (read) server (I am it) EXITING<br>
> 2011-03-05 03:15:16.715692 [DEBUG] mod_skypopen.c:1446<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1446 ][interface1 ][DOWN,INPROGRS] audio<br>
> tcp srv thread DEAD 1<br>
> 2011-03-05 03:15:16.750763 [DEBUG] skypopen_protocol.c:1112<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1112 ][interface1 ][DOWN,INPROGRS]<br>
> outbound audio server (I am it) EXITING<br>
> 2011-03-05 03:15:16.751849 [DEBUG] mod_skypopen.c:1456<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1456 ][interface1 ][DOWN,INPROGRS] audio<br>
> tcp cli thread DEAD 7<br>
> 2011-03-05 03:15:16.751849 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][IDLE,IDLE] READING:<br>
> |||#output ERROR 589 ALTER CALL: unable to alter input/output|||<br>
> 2011-03-05 03:15:16.779660 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][IDLE,IDLE] READING:<br>
> |||ERROR 559 CALL: Action failed|||<br>
> 2011-03-05 03:15:16.780762 [DEBUG] skypopen_protocol.c:228<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 228 ][interface1 ][IDLE,IDLE] Skype got<br>
> ERROR about a failed action (probably TRYING to HANGUP A CALL), no problem:<br>
> |||ERROR 559 CALL: Action failed|||<br>
> 2011-03-05 03:15:16.828877 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][IDLE,IDLE] READING:<br>
> |||ERROR 559 CALL: Action failed|||<br>
> 2011-03-05 03:15:16.828877 [DEBUG] skypopen_protocol.c:228<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 228 ][interface1 ][IDLE,IDLE] Skype got<br>
> ERROR about a failed action (probably TRYING to HANGUP A CALL), no problem:<br>
> |||ERROR 559 CALL: Action failed|||<br>
> 2011-03-05 03:15:16.869183 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][IDLE,IDLE] READING:<br>
> |||ERROR 559 CALL: Action failed|||<br>
> 2011-03-05 03:15:16.869183 [DEBUG] skypopen_protocol.c:228<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 228 ][interface1 ][IDLE,IDLE] Skype got<br>
> ERROR about a failed action (probably TRYING to HANGUP A CALL), no problem:<br>
> |||ERROR 559 CALL: Action failed|||<br>
> 2011-03-05 03:15:16.911668 [DEBUG] skypopen_protocol.c:173<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 173 ][interface1 ][IDLE,IDLE] READING:<br>
> |||CALL 142 STATUS FINISHED|||<br>
> 2011-03-05 03:15:16.911668 [DEBUG] skypopen_protocol.c:661<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 661 ][interface1 ][IDLE,IDLE]<br>
> skype_call 142 is MY call, now I'm going DOWN<br>
> 2011-03-05 03:15:16.911668 [DEBUG] mod_skypopen.c:1413<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1413 ][interface1 ][IDLE,IDLE] skype<br>
> call ended<br>
> 2011-03-05 03:15:16.911668 [DEBUG] mod_skypopen.c:1433<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1433 ][interface1 ][IDLE,IDLE] no<br>
> session<br>
> 2011-03-05 03:15:16.911668 [DEBUG] mod_skypopen.c:1436<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1436 ][interface1 ][DOWN,IDLE] audio tcp<br>
> threads to DIE<br>
> 2011-03-05 03:15:16.911668 [DEBUG] mod_skypopen.c:1446<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1446 ][interface1 ][DOWN,IDLE] audio tcp<br>
> srv thread DEAD 0<br>
> 2011-03-05 03:15:16.911668 [DEBUG] mod_skypopen.c:1456<br>
> [32b8f10|9350fb9] [DEBUG_SKYPE 1456 ][interface1 ][DOWN,IDLE] audio tcp<br>
> cli thread DEAD 0<br>
><br>
<br>
</div></div>--<br>
Sent from my mobile device<br>
<br>
Sincerely,<br>
<br>
Giovanni Maruzzelli<br>
Cell : +39-347-2665618<br>
<br>
_______________________________________________<br>
FreeSWITCH-users mailing list<br>
<a href="mailto:FreeSWITCH-users@lists.freeswitch.org">FreeSWITCH-users@lists.freeswitch.org</a><br>
<a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>
UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br>
<a href="http://www.freeswitch.org" target="_blank">http://www.freeswitch.org</a><br>
</blockquote></div><br></div>