[Freeswitch-users] origainate through sofia gateway

Jacek Sokulski jsokulski at dotsystems.pl
Thu Feb 5 05:09:15 PST 2009


the result of 
apiExecute("bgapi", "originate
{effective_caller_id_number=fixed0248b,origination_caller_id_number=1000,ignore_early_media=true}user/1008 at 192.168.1.122 bridge:sofia/gateway/halonet/0225490317 inline"); 
> /:
> 2009-02-05 14:04:48 [DEBUG] switch_ivr_originate.c:777 switch_ivr_originate() variable string 0 = [effective_caller_id_number=fixed0248b]
> 2009-02-05 14:04:48 [DEBUG] switch_ivr_originate.c:777 switch_ivr_originate() variable string 1 = [origination_caller_id_number=1000]
> 2009-02-05 14:04:48 [DEBUG] switch_ivr_originate.c:777 switch_ivr_originate() variable string 2 = [ignore_early_media=true]
> 2009-02-05 14:04:48 [DEBUG] switch_ivr_originate.c:777 switch_ivr_originate() variable string 0 = [presence_id=1008 at 192.168.1.122]
> 2009-02-05 14:04:48 [NOTICE] switch_channel.c:565 switch_channel_set_name() New Channel sofia/internal/sip:1008 at 192.168.1.126:5070 [f9b18b2e-b0a9-4e24-8452-40e1cce047bd]
> 2009-02-05 14:04:48 [DEBUG] mod_sofia.c:2518 sofia_outgoing_channel() (sofia/internal/sip:1008 at 192.168.1.126:5070) State Change CS_NEW -> CS_INIT
> 2009-02-05 14:04:48 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal sofia/internal/sip:1008 at 192.168.1.126:5070 [BREAK]
> 2009-02-05 14:04:48 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) Running State Change CS_INIT
> 2009-02-05 14:04:48 [DEBUG] switch_core_state_machine.c:444 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State INIT
> 2009-02-05 14:04:48 [DEBUG] mod_sofia.c:83 sofia_on_init() sofia/internal/sip:1008 at 192.168.1.126:5070 SOFIA INIT
> send 1196 bytes to udp/[192.168.1.126]:5070 at 13:04:48.127004:
>    ------------------------------------------------------------------------
>    INVITE sip:1008 at 192.168.1.126:5070 SIP/2.0
>    Via: SIP/2.0/UDP 192.168.1.122;rport;branch=z9hG4bKFpQjUmp1vNHZB
>    Max-Forwards: 70
>    From: "FreeSWITCH" <sip:1000 at 192.168.1.122>;tag=9vpFm3tBc8gSe
>    To: <sip:1008 at 192.168.1.126:5070>
>    Call-ID: 68736fc7-6e28-122c-8396-000c7680c408
>    CSeq: 110801208 INVITE
>    Contact: <sip:mod_sofia at 192.168.1.122:5060>
>    User-Agent: FreeSWITCH-mod_sofia/1.0.2-wyeksportowane
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
>    Supported: timer, precondition, path, replaces
>    Allow-Events: talk, presence, dialog, call-info, sla, include-session-description, presence.winfo, message-summary, refer
>    Min-SE: 120
>    Content-Type: application/sdp
>    Content-Disposition: session
>    Content-Length: 335
>    Remote-Party-ID: "FreeSWITCH" <sip:1000 at 192.168.1.122>;screen=yes;privacy=off
>    
>    v=0
>    o=FreeSWITCH 1927164999227225404 3276738624485570081 IN IP4 192.168.1.122
>    s=FreeSWITCH
>    c=IN IP4 192.168.1.122
>    t=0 0
>    m=audio 27044 RTP/AVP 9 0 8 3 101 13
>    a=rtpmap:9 G722/8000
>    a=rtpmap:0 PCMU/8000
>    a=rtpmap:8 PCMA/8000
>    a=rtpmap:3 GSM/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=rtpmap:13 CN/8000
>    a=ptime:20
>    ------------------------------------------------------------------------
> 2009-02-05 14:04:48 [DEBUG] mod_sofia.c:111 sofia_on_init() (sofia/internal/sip:1008 at 192.168.1.126:5070) State Change CS_INIT -> CS_ROUTING
> 2009-02-05 14:04:48 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal sofia/internal/sip:1008 at 192.168.1.126:5070 [BREAK]
> 2009-02-05 14:04:48 [DEBUG] sofia.c:2542 sofia_handle_sip_i_state() Channel sofia/internal/sip:1008 at 192.168.1.126:5070 entering state [calling]
> 2009-02-05 14:04:48 [DEBUG] switch_core_state_machine.c:444 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State INIT going to sleep
> 2009-02-05 14:04:48 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) Running State Change CS_ROUTING
> 2009-02-05 14:04:48 [DEBUG] switch_core_state_machine.c:447 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State ROUTING
> 2009-02-05 14:04:48 [DEBUG] mod_sofia.c:130 sofia_on_routing() sofia/internal/sip:1008 at 192.168.1.126:5070 SOFIA ROUTING
> 2009-02-05 14:04:48 [DEBUG] switch_ivr_originate.c:58 originate_on_routing() (sofia/internal/sip:1008 at 192.168.1.126:5070) State Change CS_ROUTING -> CS_CONSUME_MEDIA
> 2009-02-05 14:04:48 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal sofia/internal/sip:1008 at 192.168.1.126:5070 [BREAK]
> 2009-02-05 14:04:48 [DEBUG] switch_core_state_machine.c:447 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State ROUTING going to sleep
> 2009-02-05 14:04:48 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) Running State Change CS_CONSUME_MEDIA
> 2009-02-05 14:04:48 [DEBUG] switch_core_state_machine.c:466 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State CONSUME_MEDIA
> recv 361 bytes from udp/[192.168.1.126]:5070 at 13:04:48.130745:
>    ------------------------------------------------------------------------
>    SIP/2.0 100 Trying
>    Via: SIP/2.0/UDP 192.168.1.122;rport;branch=z9hG4bKFpQjUmp1vNHZB
>    From: "FreeSWITCH" <sip:1000 at 192.168.1.122>;tag=9vpFm3tBc8gSe
>    To: <sip:1008 at 192.168.1.126:5070>;tag=2111843199
>    Contact: <sip:1008 at 192.168.1.126:5070>
>    Call-ID: 68736fc7-6e28-122c-8396-000c7680c408
>    CSeq: 110801208 INVITE
>    Server: X-Lite release 1105d
>    Content-Length: 0
>    
>    ------------------------------------------------------------------------
> recv 362 bytes from udp/[192.168.1.126]:5070 at 13:04:48.181571:
>    ------------------------------------------------------------------------
>    SIP/2.0 180 Ringing
>    Via: SIP/2.0/UDP 192.168.1.122;rport;branch=z9hG4bKFpQjUmp1vNHZB
>    From: "FreeSWITCH" <sip:1000 at 192.168.1.122>;tag=9vpFm3tBc8gSe
>    To: <sip:1008 at 192.168.1.126:5070>;tag=2111843199
>    Contact: <sip:1008 at 192.168.1.126:5070>
>    Call-ID: 68736fc7-6e28-122c-8396-000c7680c408
>    CSeq: 110801208 INVITE
>    Server: X-Lite release 1105d
>    Content-Length: 0
>    
>    ------------------------------------------------------------------------
> 2009-02-05 14:04:48 [DEBUG] sofia.c:2542 sofia_handle_sip_i_state() Channel sofia/internal/sip:1008 at 192.168.1.126:5070 entering state [proceeding]
> 2009-02-05 14:04:48 [NOTICE] sofia.c:2596 sofia_handle_sip_i_state() Ring-Ready sofia/internal/sip:1008 at 192.168.1.126:5070!
> recv 678 bytes from udp/[192.168.1.126]:5070 at 13:04:51.914714:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 Ok
>    Via: SIP/2.0/UDP 192.168.1.122;rport;branch=z9hG4bKFpQjUmp1vNHZB
>    From: "FreeSWITCH" <sip:1000 at 192.168.1.122>;tag=9vpFm3tBc8gSe
>    To: <sip:1008 at 192.168.1.126:5070>;tag=2111843199
>    Contact: <sip:1008 at 192.168.1.126:5070>
>    Call-ID: 68736fc7-6e28-122c-8396-000c7680c408
>    CSeq: 110801208 INVITE
>    Content-Type: application/sdp
>    Server: X-Lite release 1105d
>    Content-Length: 288
>    
>    v=0
>    o=1008 1183460117 1183463903 IN IP4 192.168.1.126
>    s=X-Lite
>    c=IN IP4 192.168.1.126
>    t=0 0
>    m=audio 9000 RTP/AVP 0 8 98 97 101
>    a=rtpmap:0 pcmu/8000
>    a=rtpmap:8 pcma/8000
>    a=rtpmap:98 iLBC/8000
>    a=rtpmap:97 speex/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-15
>    a=sendrecv
>    ------------------------------------------------------------------------
> send 372 bytes to udp/[192.168.1.126]:5070 at 13:04:51.915303:
>    ------------------------------------------------------------------------
>    ACK sip:1008 at 192.168.1.126:5070 SIP/2.0
>    Via: SIP/2.0/UDP 192.168.1.122;rport;branch=z9hG4bKgZgBXF74Sy7HQ
>    Max-Forwards: 70
>    From: "FreeSWITCH" <sip:1000 at 192.168.1.122>;tag=9vpFm3tBc8gSe
>    To: <sip:1008 at 192.168.1.126:5070>;tag=2111843199
>    Call-ID: 68736fc7-6e28-122c-8396-000c7680c408
>    CSeq: 110801208 ACK
>    Contact: <sip:mod_sofia at 192.168.1.122:5060>
>    Content-Length: 0
>    
>    ------------------------------------------------------------------------
> 2009-02-05 14:04:51 [DEBUG] sofia.c:2542 sofia_handle_sip_i_state() Channel sofia/internal/sip:1008 at 192.168.1.126:5070 entering state [ready]
> 2009-02-05 14:04:51 [DEBUG] sofia.c:2546 sofia_handle_sip_i_state() Remote SDP:
> v=0
> o=1008 1183460117 1183463903 IN IP4 192.168.1.126
> s=X-Lite
> c=IN IP4 192.168.1.126
> t=0 0
> m=audio 9000 RTP/AVP 0 8 98 97 101
> a=rtpmap:0 pcmu/8000
> a=rtpmap:8 pcma/8000
> a=rtpmap:98 iLBC/8000
> a=rtpmap:97 speex/8000
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-15
> 
> 2009-02-05 14:04:51 [DEBUG] sofia_glue.c:2509 sofia_glue_negotiate_sdp() Audio Codec Compare [pcmu:0:8000]/[G722:9:8000]
> 2009-02-05 14:04:51 [DEBUG] sofia_glue.c:2509 sofia_glue_negotiate_sdp() Audio Codec Compare [pcmu:0:8000]/[PCMU:0:8000]
> 2009-02-05 14:04:51 [DEBUG] sofia_glue.c:1670 sofia_glue_tech_set_codec() Set Codec sofia/internal/sip:1008 at 192.168.1.126:5070 PCMU/8000 20 ms 160 samples
> 2009-02-05 14:04:51 [DEBUG] sofia_glue.c:2473 sofia_glue_negotiate_sdp() Set 2833 dtmf payload to 101
> 2009-02-05 14:04:51 [DEBUG] sofia_glue.c:1890 sofia_glue_activate_rtp() AUDIO RTP [sofia/internal/sip:1008 at 192.168.1.126:5070] 192.168.1.122 port 27044 -> 192.168.1.126 port 9000 codec: 0 ms: 20
> 2009-02-05 14:04:51 [DEBUG] switch_rtp.c:865 switch_rtp_create() Starting timer [soft] 160 bytes per 20000ms
> 2009-02-05 14:04:51 [NOTICE] sofia.c:3031 sofia_handle_sip_i_state() Channel [sofia/internal/sip:1008 at 192.168.1.126:5070] has been answered
> 2009-02-05 14:04:51 [DEBUG] switch_channel.c:177 switch_channel_audio_sync() sofia/internal/sip:1008 at 192.168.1.126:5070 receive message [AUDIO_SYNC]
> 2009-02-05 14:04:51 [DEBUG] switch_ivr_originate.c:1627 switch_ivr_originate() Originate Resulted in Success: [sofia/internal/sip:1008 at 192.168.1.126:5070]
> 2009-02-05 14:04:51 [DEBUG] switch_channel.c:177 switch_channel_audio_sync() sofia/internal/sip:1008 at 192.168.1.126:5070 receive message [AUDIO_SYNC]
> 2009-02-05 14:04:51 [DEBUG] switch_ivr_originate.c:1627 switch_ivr_originate() Originate Resulted in Success: [sofia/internal/sip:1008 at 192.168.1.126:5070]
> 2009-02-05 14:04:51 [DEBUG] switch_channel.c:177 switch_channel_audio_sync() sofia/internal/sip:1008 at 192.168.1.126:5070 receive message [AUDIO_SYNC]
> 2009-02-05 14:04:51 [DEBUG] switch_ivr.c:1245 switch_ivr_session_transfer() (sofia/internal/sip:1008 at 192.168.1.126:5070) State Change CS_CONSUME_MEDIA -> CS_ROUTING
> 2009-02-05 14:04:51 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal sofia/internal/sip:1008 at 192.168.1.126:5070 [BREAK]
> 2009-02-05 14:04:51 [DEBUG] switch_ivr.c:1249 switch_ivr_session_transfer() sofia/internal/sip:1008 at 192.168.1.126:5070 receive message [TRANSFER]
> 2009-02-05 14:04:51 [DEBUG] switch_core_session.c:511 switch_core_session_perform_receive_message() Send signal sofia/internal/sip:1008 at 192.168.1.126:5070 [BREAK]
> 2009-02-05 14:04:51 [NOTICE] switch_ivr.c:1251 switch_ivr_session_transfer() Transfer sofia/internal/sip:1008 at 192.168.1.126:5070 to inline[bridge:sofia/gateway/halonet/0225490317 at default]
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:466 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State CONSUME_MEDIA going to sleep
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) Running State Change CS_ROUTING
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:447 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State ROUTING
> 2009-02-05 14:04:51 [DEBUG] mod_sofia.c:130 sofia_on_routing() sofia/internal/sip:1008 at 192.168.1.126:5070 SOFIA ROUTING
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:64 switch_core_standard_on_routing() sofia/internal/sip:1008 at 192.168.1.126:5070 Standard ROUTING
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:100 switch_core_standard_on_routing() (sofia/internal/sip:1008 at 192.168.1.126:5070) State Change CS_ROUTING -> CS_EXECUTE
> 2009-02-05 14:04:51 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal sofia/internal/sip:1008 at 192.168.1.126:5070 [BREAK]
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:447 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State ROUTING going to sleep
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) Running State Change CS_EXECUTE
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:454 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State EXECUTE
> 2009-02-05 14:04:51 [DEBUG] mod_sofia.c:173 sofia_on_execute() sofia/internal/sip:1008 at 192.168.1.126:5070 SOFIA EXECUTE
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:137 switch_core_standard_on_execute() sofia/internal/sip:1008 at 192.168.1.126:5070 Standard EXECUTE
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:152 switch_core_standard_on_execute() sofia/internal/sip:1008 at 192.168.1.126:5070 Execute bridge(sofia/gateway/halonet/0225490317)
> 2009-02-05 14:04:51 [NOTICE] switch_channel.c:565 switch_channel_set_name() New Channel sofia/external/0225490317 [bf4fece9-38fc-40fa-8e9e-91f836f05e55]
> 2009-02-05 14:04:51 [DEBUG] mod_sofia.c:2518 sofia_outgoing_channel() (sofia/external/0225490317) State Change CS_NEW -> CS_INIT
> 2009-02-05 14:04:51 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal sofia/external/0225490317 [BREAK]
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (sofia/external/0225490317) Running State Change CS_INIT
> 2009-02-05 14:04:51 [DEBUG] switch_core_state_machine.c:444 switch_core_session_run() (sofia/external/0225490317) State INIT
> 2009-02-05 14:04:51 [DEBUG] mod_sofia.c:83 sofia_on_init() sofia/external/0225490317 SOFIA INIT
> 2009-02-05 14:04:52 [DEBUG] sofia_glue.c:566 sofia_glue_ext_address_lookup() STUN Success [89.77.89.244]:[50863]
> 2009-02-05 14:04:52 [DEBUG] mod_sofia.c:111 sofia_on_init() (sofia/external/0225490317) State Change CS_INIT -> CS_ROUTING
> 2009-02-05 14:04:52 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal sofia/external/0225490317 [BREAK]
> 2009-02-05 14:04:52 [DEBUG] switch_core_state_machine.c:444 switch_core_session_run() (sofia/external/0225490317) State INIT going to sleep
> 2009-02-05 14:04:52 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (sofia/external/0225490317) Running State Change CS_ROUTING
> 2009-02-05 14:04:52 [DEBUG] switch_core_state_machine.c:447 switch_core_session_run() (sofia/external/0225490317) State ROUTING
> 2009-02-05 14:04:52 [DEBUG] mod_sofia.c:130 sofia_on_routing() sofia/external/0225490317 SOFIA ROUTING
> 2009-02-05 14:04:52 [DEBUG] switch_ivr_originate.c:58 originate_on_routing() (sofia/external/0225490317) State Change CS_ROUTING -> CS_CONSUME_MEDIA
> 2009-02-05 14:04:52 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal sofia/external/0225490317 [BREAK]
> 2009-02-05 14:04:52 [DEBUG] switch_core_state_machine.c:447 switch_core_session_run() (sofia/external/0225490317) State ROUTING going to sleep
> 2009-02-05 14:04:52 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (sofia/external/0225490317) Running State Change CS_CONSUME_MEDIA
> 2009-02-05 14:04:52 [DEBUG] switch_core_state_machine.c:466 switch_core_session_run() (sofia/external/0225490317) State CONSUME_MEDIA
> 2009-02-05 14:04:52 [DEBUG] sofia.c:2542 sofia_handle_sip_i_state() Channel sofia/external/0225490317 entering state [calling]
> send 1117 bytes to udp/[194.9.25.21]:5060 at 13:04:52.572008:
>    ------------------------------------------------------------------------
>    INVITE sip:0225490317 at sip.halonet.pl SIP/2.0
>    Via: SIP/2.0/UDP 83.13.98.165:5080;rport;branch=z9hG4bKyvKBDBpvBQe2p
>    Max-Forwards: 69
>    From: "Extension 1008" <sip:fixed0248b at sip.halonet.pl;transport=udp>;tag=FZp353yettFNN
>    To: <sip:0225490317 at sip.halonet.pl>
>    Call-ID: 6b05cee4-6e28-122c-8396-000c7680c408
>    CSeq: 110801210 INVITE
>    Contact: <sip:fixed0248b at 83.13.98.165:5080;transport=udp>
>    User-Agent: FreeSWITCH-mod_sofia/1.0.2-wyeksportowane
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO
>    Supported: timer, precondition, path, replaces
>    Allow-Events: talk, refer
>    Min-SE: 120
>    Content-Type: application/sdp
>    Content-Disposition: session
>    Content-Length: 309
>    Remote-Party-ID: "Extension 1008" <sip:1000 at sip.halonet.pl>;screen=yes;privacy=off
>    
>    v=0
>    o=FreeSWITCH 3996368035436745512 7588776177330183331 IN IP4 89.77.89.244
>    s=FreeSWITCH
>    c=IN IP4 89.77.89.244
>    t=0 0
>    m=audio 50863 RTP/AVP 0 8 3 101 13
>    a=rtpmap:0 PCMU/8000
>    a=rtpmap:8 PCMA/8000
>    a=rtpmap:3 GSM/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=rtpmap:13 CN/8000
>    a=ptime:20
>    ------------------------------------------------------------------------
> recv 760 bytes from udp/[194.9.25.21]:5060 at 13:04:52.993246:
>    ------------------------------------------------------------------------
>    SIP/2.0 407 Proxy Authentication Required
>    Via: SIP/2.0/UDP 83.13.98.165:5080;rport=5080;branch=z9hG4bKyvKBDBpvBQe2p;received=89.77.89.244
>    From: "Extension 1008" <sip:fixed0248b at sip.halonet.pl;transport=udp>;tag=FZp353yettFNN
>    To: <sip:0225490317 at sip.halonet.pl>;tag=03bd8e75ec97c9ee65c772e401792a5a.5fa3
>    Call-ID: 6b05cee4-6e28-122c-8396-000c7680c408
>    CSeq: 110801210 INVITE
>    Proxy-Authenticate: Digest realm="sip.halonet.pl", nonce="498ae51439454939d240f51ab9455e2c8505c7aa", qop="auth"
>    Server: Sip EXpress router (2.0.0-rc1 (i386/linux))
>    Content-Length: 0
>    Warning: 392 194.9.25.21:5060 "Noisy feedback tells:  pid=22400 req_src_ip=89.77.89.244 req_src_port=50866 in_uri=sip:0225490317 at sip.halonet.pl out_uri=sip:0225490317 at sip.halonet.pl via_cnt==1"
>    
>    ------------------------------------------------------------------------
> send 387 bytes to udp/[194.9.25.21]:5060 at 13:04:52.993616:
>    ------------------------------------------------------------------------
>    ACK sip:0225490317 at sip.halonet.pl SIP/2.0
>    Via: SIP/2.0/UDP 83.13.98.165:5080;rport;branch=z9hG4bKyvKBDBpvBQe2p
>    Max-Forwards: 69
>    From: "Extension 1008" <sip:fixed0248b at sip.halonet.pl;transport=udp>;tag=FZp353yettFNN
>    To: <sip:0225490317 at sip.halonet.pl>;tag=03bd8e75ec97c9ee65c772e401792a5a.5fa3
>    Call-ID: 6b05cee4-6e28-122c-8396-000c7680c408
>    CSeq: 110801210 ACK
>    Content-Length: 0
>    
>    ------------------------------------------------------------------------
> send 1409 bytes to udp/[194.9.25.21]:5060 at 13:04:52.994530:
>    ------------------------------------------------------------------------
>    INVITE sip:0225490317 at sip.halonet.pl SIP/2.0
>    Via: SIP/2.0/UDP 83.13.98.165:5080;rport;branch=z9hG4bKZ5c4e66Z8Z4mj
>    Max-Forwards: 69
>    From: "Extension 1008" <sip:fixed0248b at sip.halonet.pl;transport=udp>;tag=FZp353yettFNN
>    To: <sip:0225490317 at sip.halonet.pl>
>    Call-ID: 6b05cee4-6e28-122c-8396-000c7680c408
>    CSeq: 110801211 INVITE
>    Contact: <sip:fixed0248b at 83.13.98.165:5080;transport=udp>
>    Expires: 600
>    User-Agent: FreeSWITCH-mod_sofia/1.0.2-wyeksportowane
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO
>    Supported: timer, precondition, path, replaces
>    Allow-Events: talk, refer
>    Proxy-Authorization: Digest username="fixed0248b", realm="sip.halonet.pl", nonce="498ae51439454939d240f51ab9455e2c8505c7aa", cnonce="a1oY524oEiyWgwAMdoDECA", algorithm=MD5, uri="sip:0225490317 at sip.halonet.pl", response="f05fad749d4ff6d5a75d61e3283c3afa", qop=auth, nc=00000001
>    Min-SE: 120
>    Content-Type: application/sdp
>    Content-Disposition: session
>    Content-Length: 309
>    Remote-Party-ID: "Extension 1008" <sip:1000 at sip.halonet.pl>;screen=yes;privacy=off
>    
>    v=0
>    o=FreeSWITCH 3996368035436745512 7588776177330183331 IN IP4 89.77.89.244
>    s=FreeSWITCH
>    c=IN IP4 89.77.89.244
>    t=0 0
>    m=audio 50863 RTP/AVP 0 8 3 101 13
>    a=rtpmap:0 PCMU/8000
>    a=rtpmap:8 PCMA/8000
>    a=rtpmap:3 GSM/8000
>    a=rtpmap:101 telephone-event/8000
>    a=fmtp:101 0-16
>    a=rtpmap:13 CN/8000
>    a=ptime:20
>    ------------------------------------------------------------------------
> 2009-02-05 14:04:52 [DEBUG] sofia.c:2542 sofia_handle_sip_i_state() Channel sofia/external/0225490317 entering state [calling]
> recv 618 bytes from udp/[194.9.25.21]:5060 at 13:04:53.349700:
>    ------------------------------------------------------------------------
>    SIP/2.0 100 trying -- your call is important to us
>    Via: SIP/2.0/UDP 83.13.98.165:5080;rport=5080;branch=z9hG4bKZ5c4e66Z8Z4mj;received=89.77.89.244
>    From: "Extension 1008" <sip:fixed0248b at sip.halonet.pl;transport=udp>;tag=FZp353yettFNN
>    To: <sip:0225490317 at sip.halonet.pl>
>    Call-ID: 6b05cee4-6e28-122c-8396-000c7680c408
>    CSeq: 110801211 INVITE
>    Server: Sip EXpress router (2.0.0-rc1 (i386/linux))
>    Content-Length: 0
>    Warning: 392 194.9.25.21:5060 "Noisy feedback tells:  pid=22332 req_src_ip=89.77.89.244 req_src_port=50866 in_uri=sip:0225490317 at sip.halonet.pl out_uri=sip:0225490317 at 217.11.128.50:5060 via_cnt==1"
>    
>    ------------------------------------------------------------------------
> recv 469 bytes from udp/[194.9.25.21]:5060 at 13:04:53.861812:
>    ------------------------------------------------------------------------
>    SIP/2.0 500 Internal Server Error
>    Via: SIP/2.0/UDP 83.13.98.165:5080;received=89.77.89.244;rport=5080;branch=z9hG4bKZ5c4e66Z8Z4mj
>    From: "Extension 1008" <sip:fixed0248b at sip.halonet.pl;transport=udp>;tag=FZp353yettFNN
>    To: <sip:0225490317 at sip.halonet.pl>;tag=4961D2C4-DA7
>    Date: Thu, 05 Feb 2009 13:04:39 GMT
>    Call-ID: 6b05cee4-6e28-122c-8396-000c7680c408
>    Server: Cisco-SIPGateway/IOS-12.x
>    CSeq: 110801211 INVITE
>    Allow-Events: telephone-event
>    Content-Length: 0
>    
>    ------------------------------------------------------------------------
> send 362 bytes to udp/[194.9.25.21]:5060 at 13:04:53.862199:
>    ------------------------------------------------------------------------
>    ACK sip:0225490317 at sip.halonet.pl SIP/2.0
>    Via: SIP/2.0/UDP 83.13.98.165:5080;rport;branch=z9hG4bKZ5c4e66Z8Z4mj
>    Max-Forwards: 69
>    From: "Extension 1008" <sip:fixed0248b at sip.halonet.pl;transport=udp>;tag=FZp353yettFNN
>    To: <sip:0225490317 at sip.halonet.pl>;tag=4961D2C4-DA7
>    Call-ID: 6b05cee4-6e28-122c-8396-000c7680c408
>    CSeq: 110801211 ACK
>    Content-Length: 0
>    
>    ------------------------------------------------------------------------
> 2009-02-05 14:04:53 [DEBUG] sofia.c:2542 sofia_handle_sip_i_state() Channel sofia/external/0225490317 entering state [terminated]
> 2009-02-05 14:04:53 [NOTICE] sofia.c:3090 sofia_handle_sip_i_state() Hangup sofia/external/0225490317 [CS_CONSUME_MEDIA] [NORMAL_TEMPORARY_FAILURE]
> 2009-02-05 14:04:53 [DEBUG] switch_channel.c:1494 switch_channel_perform_hangup() Send signal sofia/external/0225490317 [KILL]
> 2009-02-05 14:04:53 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal sofia/external/0225490317 [BREAK]
> 2009-02-05 14:04:53 [DEBUG] switch_core_state_machine.c:466 switch_core_session_run() (sofia/external/0225490317) State CONSUME_MEDIA going to sleep
> 2009-02-05 14:04:53 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (sofia/external/0225490317) Running State Change CS_HANGUP
> 2009-02-05 14:04:53 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (sofia/external/0225490317) State HANGUP
> 2009-02-05 14:04:53 [DEBUG] mod_sofia.c:253 sofia_on_hangup() sofia/external/0225490317 Overriding SIP cause 503 with 500 from the other leg
> 2009-02-05 14:04:53 [DEBUG] mod_sofia.c:287 sofia_on_hangup() Channel sofia/external/0225490317 hanging up, cause: NORMAL_TEMPORARY_FAILURE
> 2009-02-05 14:04:53 [DEBUG] switch_core_state_machine.c:46 switch_core_standard_on_hangup() sofia/external/0225490317 Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE
> 2009-02-05 14:04:53 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (sofia/external/0225490317) State HANGUP going to sleep
> 2009-02-05 14:04:53 [DEBUG] switch_core_session.c:939 switch_core_session_thread() Session 16 (sofia/external/0225490317) Locked, Waiting on external entities
> 2009-02-05 14:04:53 [DEBUG] switch_ivr_originate.c:1695 switch_ivr_originate() Originate Resulted in Error Cause: 41 [NORMAL_TEMPORARY_FAILURE]
> 2009-02-05 14:04:53 [DEBUG] switch_channel.c:177 switch_channel_audio_sync() sofia/internal/sip:1008 at 192.168.1.126:5070 receive message [AUDIO_SYNC]
> 2009-02-05 14:04:53 [NOTICE] switch_core_session.c:957 switch_core_session_thread() Session 16 (sofia/external/0225490317) Ended
> 2009-02-05 14:04:53 [INFO] mod_dptools.c:1909 audio_bridge_function() Originate Failed.  Cause: NORMAL_TEMPORARY_FAILURE
> 2009-02-05 14:04:53 [NOTICE] mod_dptools.c:1936 audio_bridge_function() Hangup sofia/internal/sip:1008 at 192.168.1.126:5070 [CS_EXECUTE] [NORMAL_TEMPORARY_FAILURE]
> 2009-02-05 14:04:53 [NOTICE] switch_core_session.c:959 switch_core_session_thread() Close Channel sofia/external/0225490317 [CS_HANGUP]
> 2009-02-05 14:04:53 [DEBUG] switch_channel.c:1494 switch_channel_perform_hangup() Send signal sofia/internal/sip:1008 at 192.168.1.126:5070 [KILL]
> 2009-02-05 14:04:53 [DEBUG] switch_core_session.c:807 switch_core_session_signal_state_change() Send signal sofia/internal/sip:1008 at 192.168.1.126:5070 [BREAK]
> 2009-02-05 14:04:53 [DEBUG] switch_core_state_machine.c:454 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State EXECUTE going to sleep
> 2009-02-05 14:04:53 [DEBUG] switch_core_state_machine.c:379 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) Running State Change CS_HANGUP
> 2009-02-05 14:04:53 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State HANGUP
> 2009-02-05 14:04:53 [DEBUG] mod_sofia.c:253 sofia_on_hangup() sofia/internal/sip:1008 at 192.168.1.126:5070 Overriding SIP cause 503 with 500 from the other leg
> 2009-02-05 14:04:53 [DEBUG] mod_sofia.c:287 sofia_on_hangup() Channel sofia/internal/sip:1008 at 192.168.1.126:5070 hanging up, cause: NORMAL_TEMPORARY_FAILURE
> 2009-02-05 14:04:53 [DEBUG] mod_sofia.c:344 sofia_on_hangup() Sending BYE to sofia/internal/sip:1008 at 192.168.1.126:5070
> send 648 bytes to udp/[192.168.1.126]:5070 at 13:04:53.868506:
>    ------------------------------------------------------------------------
>    BYE sip:1008 at 192.168.1.126:5070 SIP/2.0
>    Via: SIP/2.0/UDP 192.168.1.122;rport;branch=z9hG4bKH893yar8p7X4j
>    Max-Forwards: 70
>    From: "FreeSWITCH" <sip:1000 at 192.168.1.122>;tag=9vpFm3tBc8gSe
>    To: <sip:1008 at 192.168.1.126:5070>;tag=2111843199
>    Call-ID: 68736fc7-6e28-122c-8396-000c7680c408
>    CSeq: 110801209 BYE
>    Contact: <sip:mod_sofia at 192.168.1.122:5060>
>    User-Agent: FreeSWITCH-mod_sofia/1.0.2-wyeksportowane
>    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE, NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
>    Supported: timer, precondition, path, replaces
>    Reason: Q.850;cause=41;text="NORMAL_TEMPORARY_FAILURE"
>    Content-Length: 0
>    
>    ------------------------------------------------------------------------
> 2009-02-05 14:04:53 [DEBUG] switch_core_state_machine.c:46 switch_core_standard_on_hangup() sofia/internal/sip:1008 at 192.168.1.126:5070 Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE
> 2009-02-05 14:04:53 [DEBUG] switch_core_state_machine.c:410 switch_core_session_run() (sofia/internal/sip:1008 at 192.168.1.126:5070) State HANGUP going to sleep
> 2009-02-05 14:04:53 [DEBUG] switch_core_session.c:939 switch_core_session_thread() Session 15 (sofia/internal/sip:1008 at 192.168.1.126:5070) Locked, Waiting on external entities
> 2009-02-05 14:04:53 [NOTICE] switch_core_session.c:957 switch_core_session_thread() Session 15 (sofia/internal/sip:1008 at 192.168.1.126:5070) Ended
> 2009-02-05 14:04:53 [NOTICE] switch_core_session.c:959 switch_core_session_thread() Close Channel sofia/internal/sip:1008 at 192.168.1.126:5070 [CS_HANGUP]
> recv 354 bytes from udp/[192.168.1.126]:5070 at 13:04:53.882344:
>    ------------------------------------------------------------------------
>    SIP/2.0 200 Ok
>    Via: SIP/2.0/UDP 192.168.1.122;rport;branch=z9hG4bKH893yar8p7X4j
>    From: "FreeSWITCH" <sip:1000 at 192.168.1.122>;tag=9vpFm3tBc8gSe
>    To: <sip:1008 at 192.168.1.126:5070>;tag=2111843199
>    Contact: <sip:1008 at 192.168.1.126:5070>
>    Call-ID: 68736fc7-6e28-122c-8396-000c7680c408
>    CSeq: 110801209 BYE
>    Server: X-Lite release 1105d
>    Content-Length: 0
>    
>    ------------------------------------------------------------------------
Dnia 04-02-2009, śro o godzinie 10:22 -0600, Anthony Minessale pisze:
> can you press f8 for debug and try that apiExecute and post the
> results?
> 
> On Wed, Feb 4, 2009 at 8:46 AM, Jacek Sokulski
> <jsokulski at dotsystems.pl> wrote:
>         Thanks Anthony,
>         the js snippets are very instructive.
>         A couple of points:
>         1. The code with apiExecute does not work (local phone is
>         connected, but
>         after picking up it hungs up immediately), other examples are
>         working
>         fine.
>         
>         2. It does not show how initiate external call without
>         existing session.
>         
>         3. How can one pass the call through dialplan?
>         
>         Jacek
>         
>         PS.
>         we got the code probable from wiki or from this mialing list.
>         
>         Dnia 04-02-2009, śro o godzinie 08:09 -0600, Anthony Minessale
>         pisze:
>         
>         > Where did you learn how to use js this way?
>         > session.originate is being misused here and is depricated
>         and may be
>         > removed.
>         >
>         > the first arg to session.originate is either undefined or a
>         > *different* session (the a leg)
>         >
>         > session1 = new Session();
>         > session1.originate(undefined,
>         > "{ignore_early_media=true}user/1008 at 192.168.1.122");
>         >
>         >
>         session1.setVariable("effective_caller_id_number","fixed0248b");
>         >
>         > //once you have session1 when you originate session2 you
>         pass session1
>         > as the arg
>         > // the effective_caller_id is taken from session1
>         >
>         > session2 = new Session();
>         > session2.originate(session1,
>         "sofia/gateway/halonet/0225490317");
>         >
>         > Anyway this whole code is depricated in favor of this:
>         >
>         > session1 = new
>         > Session("{ignore_early_media=true}user/1008 at 192.168.1.122");
>         >
>         > if (session1.ready()) {
>         >
>         session1.setVariable("effective_caller_id_number","fixed0248b");
>         >   session2 = new Session("sofia/gateway/halonet/0225490317",
>         > session1);
>         > }
>         >
>         > and could be further refactored down to this:
>         >
>         > session1 = new
>         > Session("{ignore_early_media=true}user/1008 at 192.168.1.122");
>         > if (session1.ready()) {
>         >
>         session1.setVariable("effective_caller_id_number","fixed0248b");
>         >   session1.execute("bridge",
>         "sofia/gateway/halonet/0225490317");
>         > }
>         >
>         > or down to this one line of code that will setup the call
>         detached
>         > from the script and exit.
>         >
>         > var result = apiExecute("originate",
>         >
>         "{effective_caller_id_number=fixed0248b,origination_caller_id_number=1000,ignore_early_media=true}user/1008 at 192.168.1.122 bridge:sofia/gateway/halonet/0225490317 inline");
>         >
>         > if you dont care about the result and want to exit even
>         before the
>         > call is completed.
>         >
>         > var result = apiExecute("bgapi", "originate
>         >
>         {effective_caller_id_number=fixed0248b,origination_caller_id_number=1000,ignore_early_media=true}user/1008 at 192.168.1.122 bridge:sofia/gateway/halonet/0225490317 inline");
>         >
>         >
>         >
>         > On Wed, Feb 4, 2009 at 2:51 AM, Jacek Sokulski
>         > <jsokulski at dotsystems.pl> wrote:
>         >
>         >         We have tried setting both
>         effective_caller_id_number and
>         >         origination_caller_id_number:
>         >
>         >
>         session1.originate(session1,"{origination_caller_id_number=fixed0248b}sofia/gateway/halonet/0225490317",15);
>         >          but the problem still exists. The solution we have
>         found for
>         >         the case
>         >         when we originate two calls, local and external, is
>         as follow:
>         >
>         >         session1 = new Session();
>         >
>         session1.originate(session1,"user/1003 at 192.168.1.122",15);//local
>         >         if(session1.ready()) {
>         >
>          session1.execute("execute_extension","00930691688627 XML
>         >         default");//external
>         >         }
>         >
>         >         so the external call goes through the dialplan.
>         >         It does not work if both calls are external. One
>         possible
>         >         solution could be
>         >         to pass the originating call through dialplan
>         (loopback?) but
>         >         we have not managed
>         >         to figure out how to do it.
>         >
>         >         Thanks
>         >         Jacek
>         >
>         >         Dnia 03-02-2009, wto o godzinie 14:31 -0300, Nicolas
>         Brenner
>         >         pisze:
>         >
>         >         > Oops! Well, fortunately I don't use that voip
>         provider
>         >         anymore (nor the script).
>         >         >
>         >         > Thanks Brian.
>         >         >
>         >         > Nicolas
>         >         >
>         >         > On Tue, Feb 3, 2009 at 2:25 PM, Brian West
>         >         <brian at freeswitch.org> wrote:
>         >         > > YOU should NEVER use this method or call
>         setCallerData at
>         >         all  you
>         >         > > should use the correct methods to override the
>         callerid.
>         >         > >
>         >         > > If its a B-Leg born from an A-Leg you use these
>         on the on
>         >         the A-Leg:
>         >         > >
>         >         > >
>         >
>         http://wiki.freeswitch.org/wiki/Channel_Variables#effective_caller_id_name
>         >         > >
>         >
>         http://wiki.freeswitch.org/wiki/Channel_Variables#effective_caller_id_number
>         >         > >
>         >         > > If you're originating you use this:
>         >         > >
>         >         > >
>         >
>         http://wiki.freeswitch.org/wiki/Channel_Variables#origination_caller_id_name
>         >         > >
>         >
>         http://wiki.freeswitch.org/wiki/Channel_Variables#origination_caller_id_number
>         >         > >
>         >         > > /b
>         >         >
>         >         > _______________________________________________
>         >         > Freeswitch-users mailing list
>         >         > Freeswitch-users at lists.freeswitch.org
>         >         >
>         >
>         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
>         >         Freeswitch-users at lists.freeswitch.org
>         >
>         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:anthony_minessale at hotmail.com
>         > GTALK/JABBER/PAYPAL:anthony.minessale at gmail.com
>         > IRC: irc.freenode.net #freeswitch
>         >
>         > FreeSWITCH Developer Conference
>         > sip:888 at conference.freeswitch.org
>         > iax:guest at conference.freeswitch.org/888
>         > googletalk:conf+888 at conference.freeswitch.org
>         > pstn:213-799-1400
>         > _______________________________________________
>         > Freeswitch-users mailing list
>         > Freeswitch-users at lists.freeswitch.org
>         >
>         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
>         Freeswitch-users at lists.freeswitch.org
>         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:anthony_minessale at hotmail.com
> GTALK/JABBER/PAYPAL:anthony.minessale at gmail.com
> IRC: irc.freenode.net #freeswitch
> 
> FreeSWITCH Developer Conference
> sip:888 at conference.freeswitch.org
> iax:guest at conference.freeswitch.org/888
> googletalk:conf+888 at conference.freeswitch.org
> pstn:213-799-1400
> _______________________________________________
> Freeswitch-users mailing list
> Freeswitch-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org





More information about the FreeSWITCH-users mailing list