Advertisement
Not a member of Pastebin yet?
Sign Up,
it unlocks many cool features!
- recv 1138 bytes from udp/[192.168.199.147]:50452 at 23:18:58.814180:
- ------------------------------------------------------------------------
- INVITE sip:1000@192.168.199.209 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.147:50452;rport;branch=z9hG4bKPjZXNvascPfYDmhdOPhWVWSHpnG31mfrSk
- Max-Forwards: 70
- From: sip:1001@192.168.199.209;tag=ncjBVBvrLoZYKZG9hB-Dw9pc-zMQ6-X0
- To: sip:1000@192.168.199.209
- Contact: <sip:1001@192.168.199.147:50452;ob>
- Call-ID: TLCkh5yLFXegYOSvMqEDr6xV1AxFjRNm
- CSeq: 6682 INVITE
- Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
- Supported: replaces, 100rel, timer, norefersub
- Session-Expires: 1800
- Min-SE: 128
- User-Agent: Siphon PjSip v2.0.0-beta/arm-apple-darwin9
- Content-Type: application/sdp
- Content-Length: 489
- v=0
- o=- 3728874429 3728874429 IN IP4 192.168.199.147
- s=pjmedia
- c=IN IP4 192.168.199.147
- t=0 0
- a=X-nat:0
- m=audio 40002 RTP/AVP 98 97 99 104 18 3 0 8 96
- c=IN IP4 192.168.199.147
- a=rtcp:40003 IN IP4 192.168.199.147
- a=sendrecv
- a=rtpmap:98 speex/16000
- a=rtpmap:97 speex/8000
- a=rtpmap:99 speex/32000
- a=rtpmap:104 iLBC/8000
- a=fmtp:104 mode=30
- a=rtpmap:18 G729/8000
- a=rtpmap:3 GSM/8000
- a=rtpmap:0 PCMU/8000
- a=rtpmap:8 PCMA/8000
- a=rtpmap:96 telephone-event/8000
- a=fmtp:96 0-15
- ------------------------------------------------------------------------
- send 350 bytes to udp/[192.168.199.147]:50452 at 23:18:58.814740:
- ------------------------------------------------------------------------
- SIP/2.0 100 Trying
- Via: SIP/2.0/UDP 192.168.199.147:50452;rport=50452;branch=z9hG4bKPjZXNvascPfYDmhdOPhWVWSHpnG31mfrSk
- From: sip:1001@192.168.199.209;tag=ncjBVBvrLoZYKZG9hB-Dw9pc-zMQ6-X0
- To: sip:1000@192.168.199.209
- Call-ID: TLCkh5yLFXegYOSvMqEDr6xV1AxFjRNm
- CSeq: 6682 INVITE
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Content-Length: 0
- ------------------------------------------------------------------------
- 2018-02-28 23:18:58.797838 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1001@192.168.199.209 [b2fb430e-1c9a-11e8-b916-1f706e5b1202]
- 2018-02-28 23:18:58.797838 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1001@192.168.199.209) Running State Change CS_NEW (Cur 1 Tot 36)
- 2018-02-28 23:18:58.797838 [DEBUG] sofia.c:9834 sofia/internal/1001@192.168.199.209 receiving invite from 192.168.199.147:50452 version: 1.6.17 64bit
- 2018-02-28 23:18:58.797838 [DEBUG] sofia.c:10005 IP 192.168.199.147 Rejected by acl "domains". Falling back to Digest auth.
- 2018-02-28 23:18:58.797838 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/1001@192.168.199.209) State NEW
- send 858 bytes to udp/[192.168.199.147]:50452 at 23:18:58.816723:
- ------------------------------------------------------------------------
- SIP/2.0 407 Proxy Authentication Required
- Via: SIP/2.0/UDP 192.168.199.147:50452;rport=50452;branch=z9hG4bKPjZXNvascPfYDmhdOPhWVWSHpnG31mfrSk
- From: sip:1001@192.168.199.209;tag=ncjBVBvrLoZYKZG9hB-Dw9pc-zMQ6-X0
- To: <sip:1000@192.168.199.209>;tag=4DeBjKjt18yUF
- Call-ID: TLCkh5yLFXegYOSvMqEDr6xV1AxFjRNm
- CSeq: 6682 INVITE
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Proxy-Authenticate: Digest realm="192.168.199.209", nonce="b2fb59d4-1c9a-11e8-b917-1f706e5b1202", algorithm=MD5, qop="auth"
- Content-Length: 0
- ------------------------------------------------------------------------
- 2018-02-28 23:18:58.797838 [DEBUG] sofia.c:2334 detaching session b2fb430e-1c9a-11e8-b916-1f706e5b1202
- recv 349 bytes from udp/[192.168.199.147]:50452 at 23:18:58.908549:
- ------------------------------------------------------------------------
- ACK sip:1000@192.168.199.209 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.147:50452;rport;branch=z9hG4bKPjZXNvascPfYDmhdOPhWVWSHpnG31mfrSk
- Max-Forwards: 70
- From: sip:1001@192.168.199.209;tag=ncjBVBvrLoZYKZG9hB-Dw9pc-zMQ6-X0
- To: sip:1000@192.168.199.209;tag=4DeBjKjt18yUF
- Call-ID: TLCkh5yLFXegYOSvMqEDr6xV1AxFjRNm
- CSeq: 6682 ACK
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 1412 bytes from udp/[192.168.199.147]:50452 at 23:18:58.909156:
- ------------------------------------------------------------------------
- INVITE sip:1000@192.168.199.209 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.147:50452;rport;branch=z9hG4bKPjWwb7EBSODC0Uv9QMh4iITNWOfTYFdl4A
- Max-Forwards: 70
- From: sip:1001@192.168.199.209;tag=ncjBVBvrLoZYKZG9hB-Dw9pc-zMQ6-X0
- To: sip:1000@192.168.199.209
- Contact: <sip:1001@192.168.199.147:50452;ob>
- Call-ID: TLCkh5yLFXegYOSvMqEDr6xV1AxFjRNm
- CSeq: 6683 INVITE
- Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
- Supported: replaces, 100rel, timer, norefersub
- Session-Expires: 1800
- Min-SE: 128
- User-Agent: Siphon PjSip v2.0.0-beta/arm-apple-darwin9
- Proxy-Authorization: Digest username="1001", realm="192.168.199.209", nonce="b2fb59d4-1c9a-11e8-b917-1f706e5b1202", uri="sip:1000@192.168.199.209", response="61fc6ed9445f93a73c97f04ead0da742", algorithm=MD5, cnonce="Z2pp446FWAM-Eu5sm.p5pv8p306L6.xQ", qop=auth, nc=00000001
- Content-Type: application/sdp
- Content-Length: 489
- v=0
- o=- 3728874429 3728874429 IN IP4 192.168.199.147
- s=pjmedia
- c=IN IP4 192.168.199.147
- t=0 0
- a=X-nat:0
- m=audio 40002 RTP/AVP 98 97 99 104 18 3 0 8 96
- c=IN IP4 192.168.199.147
- a=rtcp:40003 IN IP4 192.168.199.147
- a=sendrecv
- a=rtpmap:98 speex/16000
- a=rtpmap:97 speex/8000
- a=rtpmap:99 speex/32000
- a=rtpmap:104 iLBC/8000
- a=fmtp:104 mode=30
- a=rtpmap:18 G729/8000
- a=rtpmap:3 GSM/8000
- a=rtpmap:0 PCMU/8000
- a=rtpmap:8 PCMA/8000
- a=rtpmap:96 telephone-event/8000
- a=fmtp:96 0-15
- ------------------------------------------------------------------------
- send 350 bytes to udp/[192.168.199.147]:50452 at 23:18:58.909584:
- ------------------------------------------------------------------------
- SIP/2.0 100 Trying
- Via: SIP/2.0/UDP 192.168.199.147:50452;rport=50452;branch=z9hG4bKPjWwb7EBSODC0Uv9QMh4iITNWOfTYFdl4A
- From: sip:1001@192.168.199.209;tag=ncjBVBvrLoZYKZG9hB-Dw9pc-zMQ6-X0
- To: sip:1000@192.168.199.209
- Call-ID: TLCkh5yLFXegYOSvMqEDr6xV1AxFjRNm
- CSeq: 6683 INVITE
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Content-Length: 0
- ------------------------------------------------------------------------
- 2018-02-28 23:18:58.897385 [DEBUG] sofia.c:2442 Re-attaching to session b2fb430e-1c9a-11e8-b916-1f706e5b1202
- 2018-02-28 23:18:58.917835 [DEBUG] sofia.c:9834 sofia/internal/1001@192.168.199.209 receiving invite from 192.168.199.147:50452 version: 1.6.17 64bit
- 2018-02-28 23:18:58.917835 [DEBUG] sofia.c:10005 IP 192.168.199.147 Rejected by acl "domains". Falling back to Digest auth.
- 2018-02-28 23:18:58.917835 [DEBUG] sofia.c:7048 Channel sofia/internal/1001@192.168.199.209 entering state [received][100]
- 2018-02-28 23:18:58.917835 [DEBUG] sofia.c:7058 Remote SDP:
- v=0
- o=- 3728874429 3728874429 IN IP4 192.168.199.147
- s=pjmedia
- c=IN IP4 192.168.199.147
- t=0 0
- a=X-nat:0
- m=audio 40002 RTP/AVP 98 97 99 104 18 3 0 8 96
- c=IN IP4 192.168.199.147
- a=rtpmap:98 speex/16000
- a=rtpmap:97 speex/8000
- a=rtpmap:99 speex/32000
- a=rtpmap:104 iLBC/8000
- a=fmtp:104 mode=30
- a=rtpmap:18 G729/8000
- a=rtpmap:3 GSM/8000
- a=rtpmap:0 PCMU/8000
- a=rtpmap:8 PCMA/8000
- a=rtpmap:96 telephone-event/8000
- a=fmtp:96 0-15
- a=rtcp:40003 IN IP4 192.168.199.147
- 2018-02-28 23:18:58.917835 [DEBUG] sofia.c:7450 (sofia/internal/1001@192.168.199.209) State Change CS_NEW -> CS_INIT
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1001@192.168.199.209) Running State Change CS_INIT (Cur 1 Tot 36)
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1001@192.168.199.209) State INIT
- 2018-02-28 23:18:58.917835 [DEBUG] mod_sofia.c:90 sofia/internal/1001@192.168.199.209 SOFIA INIT
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1001@192.168.199.209 Standard INIT
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1001@192.168.199.209) State Change CS_INIT -> CS_ROUTING
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1001@192.168.199.209) State INIT going to sleep
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1001@192.168.199.209) Running State Change CS_ROUTING (Cur 1 Tot 36)
- 2018-02-28 23:18:58.917835 [DEBUG] switch_channel.c:2249 (sofia/internal/1001@192.168.199.209) Callstate Change DOWN -> RINGING
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1001@192.168.199.209) State ROUTING
- 2018-02-28 23:18:58.917835 [DEBUG] mod_sofia.c:143 sofia/internal/1001@192.168.199.209 SOFIA ROUTING
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:236 sofia/internal/1001@192.168.199.209 Standard ROUTING
- 2018-02-28 23:18:58.917835 [INFO] mod_dialplan_xml.c:637 Processing 1001 <1001>->1000 in context default
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->unloop] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->tod_example] continue=true
- Dialplan: sofia/internal/1001@192.168.199.209 Date/TimeMatch (FAIL) [tod_example] break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->holiday_example] continue=true
- Dialplan: sofia/internal/1001@192.168.199.209 Date/TimeMatch (FAIL) [holiday_example] break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->global-intercept] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [global-intercept] destination_number(1000) =~ /^886$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->group-intercept] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [group-intercept] destination_number(1000) =~ /^\*8$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->intercept-ext] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [intercept-ext] destination_number(1000) =~ /^\*\*(\d+)$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->redial] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [redial] destination_number(1000) =~ /^(redial|870)$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->global] continue=true
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (PASS) [global] ${default_password}(1234) =~ /^1234$/ break=never
- Dialplan: sofia/internal/1001@192.168.199.209 Action log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING )
- Dialplan: sofia/internal/1001@192.168.199.209 Action log(CRIT Open /root/freeswitch/etc/freeswitch/vars.xml and change the default_password.)
- Dialplan: sofia/internal/1001@192.168.199.209 Action log(CRIT Once changed type 'reloadxml' at the console.)
- Dialplan: sofia/internal/1001@192.168.199.209 Action log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING )
- Dialplan: sofia/internal/1001@192.168.199.209 Action sleep(10000)
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [global] ${switch_r_sdp}(v=0
- o=- 3728874429 3728874429 IN IP4 192.168.199.147
- s=pjmedia
- c=IN IP4 192.168.199.147
- t=0 0
- a=X-nat:0
- m=audio 40002 RTP/AVP 98 97 99 104 18 3 0 8 96
- c=IN IP4 192.168.199.147
- a=rtpmap:98 speex/16000
- a=rtpmap:97 speex/8000
- a=rtpmap:99 speex/32000
- a=rtpmap:104 iLBC/8000
- a=fmtp:104 mode=30
- a=rtpmap:18 G729/8000
- a=rtpmap:3 GSM/8000
- a=rtpmap:0 PCMU/8000
- a=rtpmap:8 PCMA/8000
- a=rtpmap:96 telephone-event/8000
- a=fmtp:96 0-15
- a=rtcp:40003 IN IP4 192.168.199.147
- ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
- Dialplan: sofia/internal/1001@192.168.199.209 Absolute Condition [global]
- Dialplan: sofia/internal/1001@192.168.199.209 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
- Dialplan: sofia/internal/1001@192.168.199.209 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
- Dialplan: sofia/internal/1001@192.168.199.209 Action hash(insert/${domain_name}-last_dial/global/${uuid})
- Dialplan: sofia/internal/1001@192.168.199.209 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->snom-demo-2] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [snom-demo-2] destination_number(1000) =~ /^9001$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->snom-demo-1] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [snom-demo-1] destination_number(1000) =~ /^9000$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->eavesdrop] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [eavesdrop] destination_number(1000) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->eavesdrop] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [eavesdrop] destination_number(1000) =~ /^779$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->call_return] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [call_return] destination_number(1000) =~ /^\*69$|^869$|^lcr$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->del-group] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [del-group] destination_number(1000) =~ /^80(\d{2})$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->add-group] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [add-group] destination_number(1000) =~ /^81(\d{2})$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->call-group-simo] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [call-group-simo] destination_number(1000) =~ /^82(\d{2})$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->call-group-order] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [call-group-order] destination_number(1000) =~ /^83(\d{2})$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->extension-intercom] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (FAIL) [extension-intercom] destination_number(1000) =~ /^8(10[01][0-9])$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 parsing [default->Local_Extension] continue=false
- Dialplan: sofia/internal/1001@192.168.199.209 Regex (PASS) [Local_Extension] destination_number(1000) =~ /^(10[01][0-9])$/ break=on-false
- Dialplan: sofia/internal/1001@192.168.199.209 Action export(dialed_extension=1000)
- Dialplan: sofia/internal/1001@192.168.199.209 Action bind_meta_app(1 b s execute_extension::dx XML features)
- Dialplan: sofia/internal/1001@192.168.199.209 Action bind_meta_app(2 b s record_session::/root/freeswitch/var/lib/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav)
- Dialplan: sofia/internal/1001@192.168.199.209 Action bind_meta_app(3 b s execute_extension::cf XML features)
- Dialplan: sofia/internal/1001@192.168.199.209 Action bind_meta_app(4 b s execute_extension::att_xfer XML features)
- Dialplan: sofia/internal/1001@192.168.199.209 Action set(ringback=${us-ring})
- Dialplan: sofia/internal/1001@192.168.199.209 Action set(transfer_ringback=local_stream://moh)
- Dialplan: sofia/internal/1001@192.168.199.209 Action set(call_timeout=30)
- Dialplan: sofia/internal/1001@192.168.199.209 Action set(hangup_after_bridge=true)
- Dialplan: sofia/internal/1001@192.168.199.209 Action set(continue_on_fail=true)
- Dialplan: sofia/internal/1001@192.168.199.209 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
- Dialplan: sofia/internal/1001@192.168.199.209 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
- Dialplan: sofia/internal/1001@192.168.199.209 Action set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)})
- Dialplan: sofia/internal/1001@192.168.199.209 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid})
- Dialplan: sofia/internal/1001@192.168.199.209 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid})
- Dialplan: sofia/internal/1001@192.168.199.209 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid})
- Dialplan: sofia/internal/1001@192.168.199.209 Action bridge(user/${dialed_extension}@${domain_name})
- Dialplan: sofia/internal/1001@192.168.199.209 Action answer()
- Dialplan: sofia/internal/1001@192.168.199.209 Action sleep(1000)
- Dialplan: sofia/internal/1001@192.168.199.209 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension})
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/1001@192.168.199.209) State Change CS_ROUTING -> CS_EXECUTE
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1001@192.168.199.209) State ROUTING going to sleep
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1001@192.168.199.209) Running State Change CS_EXECUTE (Cur 1 Tot 36)
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1001@192.168.199.209) State EXECUTE
- 2018-02-28 23:18:58.917835 [DEBUG] mod_sofia.c:198 sofia/internal/1001@192.168.199.209 SOFIA EXECUTE
- 2018-02-28 23:18:58.917835 [DEBUG] switch_core_state_machine.c:328 sofia/internal/1001@192.168.199.209 Standard EXECUTE
- EXECUTE sofia/internal/1001@192.168.199.209 log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING )
- 2018-02-28 23:18:58.917835 [CRIT] mod_dptools.c:1724 WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING
- EXECUTE sofia/internal/1001@192.168.199.209 log(CRIT Open /root/freeswitch/etc/freeswitch/vars.xml and change the default_password.)
- 2018-02-28 23:18:58.917835 [CRIT] mod_dptools.c:1724 Open /root/freeswitch/etc/freeswitch/vars.xml and change the default_password.
- EXECUTE sofia/internal/1001@192.168.199.209 log(CRIT Once changed type 'reloadxml' at the console.)
- 2018-02-28 23:18:58.917835 [CRIT] mod_dptools.c:1724 Once changed type 'reloadxml' at the console.
- EXECUTE sofia/internal/1001@192.168.199.209 log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING )
- 2018-02-28 23:18:58.917835 [CRIT] mod_dptools.c:1724 WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING
- EXECUTE sofia/internal/1001@192.168.199.209 sleep(10000)
- send 1367 bytes to udp/[192.168.199.113]:64236 at 23:18:58.925062:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bK7BNUvmgp67N0B
- Max-Forwards: 70
- From: <sip:1001@192.168.199.209>;tag=Z4GBrKbDdmSR
- To: "1000" <sip:1000@192.168.199.209>;tag=53819c6d
- Call-ID: 90533M2VjZDgwMTFhOTA2ODdjNmYwMThmMThkOWM0M2M4Yzc
- CSeq: 254756901 NOTIFY
- Contact: <sip:1001@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3308
- Content-Type: application/pidf+xml
- Content-Length: 500
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:1001@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>open</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <rpid:activities>
- <rpid:on-the-phone/>
- </rpid:activities>
- <dm:note>Call 1000</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:18:58.927122:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bK7BNUvmgp67N0B
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=53819c6d
- From: <sip:1001@192.168.199.209>;tag=Z4GBrKbDdmSR
- Call-ID: 90533M2VjZDgwMTFhOTA2ODdjNmYwMThmMThkOWM0M2M4Yzc
- CSeq: 254756901 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 619 bytes from udp/[192.168.199.113]:64236 at 23:19:06.307366:
- ------------------------------------------------------------------------
- SUBSCRIBE sip:9664@192.168.199.209:5060 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---fc31a20281dfda03;rport
- Max-Forwards: 70
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: <sip:9664@192.168.199.209>;tag=Wt0rnE4uCOZl
- From: "1000" <sip:1000@192.168.199.209>;tag=1430427d
- Call-ID: 90533Y2E2Y2NhNDhkN2VjMDhiZTVhNzQzMDZjNjk5ZjNkZjc
- CSeq: 8 SUBSCRIBE
- Expires: 3599
- Accept: application/pidf+xml
- Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Event: presence
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 619 bytes from udp/[192.168.199.113]:64236 at 23:19:06.308073:
- ------------------------------------------------------------------------
- SUBSCRIBE sip:9196@192.168.199.209:5060 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---c921681b3c9e033b;rport
- Max-Forwards: 70
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: <sip:9196@192.168.199.209>;tag=3aPMpMWBXM0F
- From: "1000" <sip:1000@192.168.199.209>;tag=8869d805
- Call-ID: 90533MjI5Yzg2ZmVlNzgxZjJmYzEyMjRmNDJjNWVkMmFhNGY
- CSeq: 8 SUBSCRIBE
- Expires: 3599
- Accept: application/pidf+xml
- Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Event: presence
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 619 bytes from udp/[192.168.199.113]:64236 at 23:19:06.308319:
- ------------------------------------------------------------------------
- SUBSCRIBE sip:9195@192.168.199.209:5060 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---d5f6b0394c4a9534;rport
- Max-Forwards: 70
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: <sip:9195@192.168.199.209>;tag=LnV1BKYn4PFh
- From: "1000" <sip:1000@192.168.199.209>;tag=9ec67706
- Call-ID: 90533ZjNlOTc0MjM4NDM4YTFhNGZmYmM4NzBkMTRjNzI0MDc
- CSeq: 8 SUBSCRIBE
- Expires: 3599
- Accept: application/pidf+xml
- Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Event: presence
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 619 bytes from udp/[192.168.199.113]:64236 at 23:19:06.308483:
- ------------------------------------------------------------------------
- SUBSCRIBE sip:9198@192.168.199.209:5060 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---8802a05ae4b69449;rport
- Max-Forwards: 70
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: <sip:9198@192.168.199.209>;tag=kzCMdrY7sEKH
- From: "1000" <sip:1000@192.168.199.209>;tag=0d01e725
- Call-ID: 90533OGQ2ZTU1OWM4MDE5OGM3YmU2YmVhZjg5NmI5OGM5OTU
- CSeq: 8 SUBSCRIBE
- Expires: 3600
- Accept: application/pidf+xml
- Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Event: presence
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 619 bytes from udp/[192.168.199.113]:64236 at 23:19:06.308598:
- ------------------------------------------------------------------------
- SUBSCRIBE sip:9181@192.168.199.209:5060 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---385ac472de96b535;rport
- Max-Forwards: 70
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: <sip:9181@192.168.199.209>;tag=gw839ZzKclCD
- From: "1000" <sip:1000@192.168.199.209>;tag=b76edc0b
- Call-ID: 90533NGJlNjhkODk3ZDMyMTg3Y2UwYzRkOGRlNjcxOGU3OGM
- CSeq: 8 SUBSCRIBE
- Expires: 3600
- Accept: application/pidf+xml
- Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Event: presence
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 619 bytes from udp/[192.168.199.113]:64236 at 23:19:06.308677:
- ------------------------------------------------------------------------
- SUBSCRIBE sip:9183@192.168.199.209:5060 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---54f0b6228840b239;rport
- Max-Forwards: 70
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: <sip:9183@192.168.199.209>;tag=VrRP6nXhMpUQ
- From: "1000" <sip:1000@192.168.199.209>;tag=183b786d
- Call-ID: 90533NzFlNTMwYjE0ZGNjZTQyZTcyYTY1YjViYmEzZWQzYTA
- CSeq: 8 SUBSCRIBE
- Expires: 3600
- Accept: application/pidf+xml
- Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Event: presence
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 619 bytes from udp/[192.168.199.113]:64236 at 23:19:06.308740:
- ------------------------------------------------------------------------
- SUBSCRIBE sip:9184@192.168.199.209:5060 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---943df604c4b2d55b;rport
- Max-Forwards: 70
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: <sip:9184@192.168.199.209>;tag=HJOZdoxjLwdK
- From: "1000" <sip:1000@192.168.199.209>;tag=de06aa66
- Call-ID: 90533ODM2ZGNkNDUwZGRhZjZkZmEwYjIxZjc1ZTJkMTQ1ZDk
- CSeq: 8 SUBSCRIBE
- Expires: 3600
- Accept: application/pidf+xml
- Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Event: presence
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 619 bytes from udp/[192.168.199.113]:64236 at 23:19:06.308797:
- ------------------------------------------------------------------------
- SUBSCRIBE sip:5000@192.168.199.209:5060 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---cc1e8f06a5af276f;rport
- Max-Forwards: 70
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: <sip:5000@192.168.199.209>;tag=mDloONSA4Ag1
- From: "1000" <sip:1000@192.168.199.209>;tag=e7841062
- Call-ID: 90533YTM1NDAzNjkwMmM4Zjk1NDM1NWVkNjllMDBiZGY3MjY
- CSeq: 8 SUBSCRIBE
- Expires: 3600
- Accept: application/pidf+xml
- Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Event: presence
- Content-Length: 0
- ------------------------------------------------------------------------
- send 779 bytes to udp/[192.168.199.113]:64236 at 23:19:06.308923:
- ------------------------------------------------------------------------
- SIP/2.0 202 Accepted
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---fc31a20281dfda03;rport=64236
- From: "1000" <sip:1000@192.168.199.209>;tag=1430427d
- To: <sip:9664@192.168.199.209>;tag=Wt0rnE4uCOZl
- Call-ID: 90533Y2E2Y2NhNDhkN2VjMDhiZTVhNzQzMDZjNjk5ZjNkZjc
- CSeq: 8 SUBSCRIBE
- Contact: <sip:9664@192.168.199.209:5060>
- Expires: 3599
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3599
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 619 bytes from udp/[192.168.199.113]:64236 at 23:19:06.309148:
- ------------------------------------------------------------------------
- SUBSCRIBE sip:4000@192.168.199.209:5060 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---278f0273c9b8135c;rport
- Max-Forwards: 70
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: <sip:4000@192.168.199.209>;tag=N39qjU7RtLHx
- From: "1000" <sip:1000@192.168.199.209>;tag=1e8f204f
- Call-ID: 90533MWQ0NWZiZjk5ZmJkNzI4ODBhMjU1N2FhYmYwMDFhZTc
- CSeq: 8 SUBSCRIBE
- Expires: 3600
- Accept: application/pidf+xml
- Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Event: presence
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 619 bytes from udp/[192.168.199.113]:64236 at 23:19:06.309291:
- ------------------------------------------------------------------------
- SUBSCRIBE sip:1001@192.168.199.209:5060 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---06571717c1ac073a;rport
- Max-Forwards: 70
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: <sip:1001@192.168.199.209>;tag=Z4GBrKbDdmSR
- From: "1000" <sip:1000@192.168.199.209>;tag=53819c6d
- Call-ID: 90533M2VjZDgwMTFhOTA2ODdjNmYwMThmMThkOWM0M2M4Yzc
- CSeq: 8 SUBSCRIBE
- Expires: 3600
- Accept: application/pidf+xml
- Allow: SUBSCRIBE, NOTIFY, INVITE, ACK, CANCEL, BYE, REFER, INFO, OPTIONS, MESSAGE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Event: presence
- Content-Length: 0
- ------------------------------------------------------------------------
- send 1306 bytes to udp/[192.168.199.113]:64236 at 23:19:06.311075:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bK8memyF1S3gcKQ
- Max-Forwards: 70
- From: <sip:9664@192.168.199.209>;tag=Wt0rnE4uCOZl
- To: "1000" <sip:1000@192.168.199.209>;tag=1430427d
- Call-ID: 90533Y2E2Y2NhNDhkN2VjMDhiZTVhNzQzMDZjNjk5ZjNkZjc
- CSeq: 254757301 NOTIFY
- Contact: <sip:9664@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3599
- Content-Type: application/pidf+xml
- Content-Length: 439
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:9664@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>closed</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <dm:note>Unregistered</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- send 779 bytes to udp/[192.168.199.113]:64236 at 23:19:06.311440:
- ------------------------------------------------------------------------
- SIP/2.0 202 Accepted
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---c921681b3c9e033b;rport=64236
- From: "1000" <sip:1000@192.168.199.209>;tag=8869d805
- To: <sip:9196@192.168.199.209>;tag=3aPMpMWBXM0F
- Call-ID: 90533MjI5Yzg2ZmVlNzgxZjJmYzEyMjRmNDJjNWVkMmFhNGY
- CSeq: 8 SUBSCRIBE
- Contact: <sip:9196@192.168.199.209:5060>
- Expires: 3599
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3599
- Content-Length: 0
- ------------------------------------------------------------------------
- send 779 bytes to udp/[192.168.199.113]:64236 at 23:19:06.312345:
- ------------------------------------------------------------------------
- SIP/2.0 202 Accepted
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---d5f6b0394c4a9534;rport=64236
- From: "1000" <sip:1000@192.168.199.209>;tag=9ec67706
- To: <sip:9195@192.168.199.209>;tag=LnV1BKYn4PFh
- Call-ID: 90533ZjNlOTc0MjM4NDM4YTFhNGZmYmM4NzBkMTRjNzI0MDc
- CSeq: 8 SUBSCRIBE
- Contact: <sip:9195@192.168.199.209:5060>
- Expires: 3599
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3599
- Content-Length: 0
- ------------------------------------------------------------------------
- send 1306 bytes to udp/[192.168.199.113]:64236 at 23:19:06.313063:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bK9X7c0ajX0S25j
- Max-Forwards: 70
- From: <sip:9196@192.168.199.209>;tag=3aPMpMWBXM0F
- To: "1000" <sip:1000@192.168.199.209>;tag=8869d805
- Call-ID: 90533MjI5Yzg2ZmVlNzgxZjJmYzEyMjRmNDJjNWVkMmFhNGY
- CSeq: 254757302 NOTIFY
- Contact: <sip:9196@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3599
- Content-Type: application/pidf+xml
- Content-Length: 439
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:9196@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>closed</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <dm:note>Unregistered</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:06.313587:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bK8memyF1S3gcKQ
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=1430427d
- From: <sip:9664@192.168.199.209>;tag=Wt0rnE4uCOZl
- Call-ID: 90533Y2E2Y2NhNDhkN2VjMDhiZTVhNzQzMDZjNjk5ZjNkZjc
- CSeq: 254757301 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- send 779 bytes to udp/[192.168.199.113]:64236 at 23:19:06.314139:
- ------------------------------------------------------------------------
- SIP/2.0 202 Accepted
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---8802a05ae4b69449;rport=64236
- From: "1000" <sip:1000@192.168.199.209>;tag=0d01e725
- To: <sip:9198@192.168.199.209>;tag=kzCMdrY7sEKH
- Call-ID: 90533OGQ2ZTU1OWM4MDE5OGM3YmU2YmVhZjg5NmI5OGM5OTU
- CSeq: 8 SUBSCRIBE
- Contact: <sip:9198@192.168.199.209:5060>
- Expires: 3600
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:06.314663:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bK9X7c0ajX0S25j
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=8869d805
- From: <sip:9196@192.168.199.209>;tag=3aPMpMWBXM0F
- Call-ID: 90533MjI5Yzg2ZmVlNzgxZjJmYzEyMjRmNDJjNWVkMmFhNGY
- CSeq: 254757302 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- send 1306 bytes to udp/[192.168.199.113]:64236 at 23:19:06.315003:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKa7051520X2rre
- Max-Forwards: 70
- From: <sip:9195@192.168.199.209>;tag=LnV1BKYn4PFh
- To: "1000" <sip:1000@192.168.199.209>;tag=9ec67706
- Call-ID: 90533ZjNlOTc0MjM4NDM4YTFhNGZmYmM4NzBkMTRjNzI0MDc
- CSeq: 254757303 NOTIFY
- Contact: <sip:9195@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3599
- Content-Type: application/pidf+xml
- Content-Length: 439
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:9195@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>closed</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <dm:note>Unregistered</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:06.316007:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKa7051520X2rre
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=9ec67706
- From: <sip:9195@192.168.199.209>;tag=LnV1BKYn4PFh
- Call-ID: 90533ZjNlOTc0MjM4NDM4YTFhNGZmYmM4NzBkMTRjNzI0MDc
- CSeq: 254757303 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- send 1306 bytes to udp/[192.168.199.113]:64236 at 23:19:06.316684:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKBgty30K4tBFBa
- Max-Forwards: 70
- From: <sip:9198@192.168.199.209>;tag=kzCMdrY7sEKH
- To: "1000" <sip:1000@192.168.199.209>;tag=0d01e725
- Call-ID: 90533OGQ2ZTU1OWM4MDE5OGM3YmU2YmVhZjg5NmI5OGM5OTU
- CSeq: 254757304 NOTIFY
- Contact: <sip:9198@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Type: application/pidf+xml
- Content-Length: 439
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:9198@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>closed</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <dm:note>Unregistered</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- send 779 bytes to udp/[192.168.199.113]:64236 at 23:19:06.317162:
- ------------------------------------------------------------------------
- SIP/2.0 202 Accepted
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---385ac472de96b535;rport=64236
- From: "1000" <sip:1000@192.168.199.209>;tag=b76edc0b
- To: <sip:9181@192.168.199.209>;tag=gw839ZzKclCD
- Call-ID: 90533NGJlNjhkODk3ZDMyMTg3Y2UwYzRkOGRlNjcxOGU3OGM
- CSeq: 8 SUBSCRIBE
- Contact: <sip:9181@192.168.199.209:5060>
- Expires: 3600
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:06.317870:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKBgty30K4tBFBa
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=0d01e725
- From: <sip:9198@192.168.199.209>;tag=kzCMdrY7sEKH
- Call-ID: 90533OGQ2ZTU1OWM4MDE5OGM3YmU2YmVhZjg5NmI5OGM5OTU
- CSeq: 254757304 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- send 779 bytes to udp/[192.168.199.113]:64236 at 23:19:06.318231:
- ------------------------------------------------------------------------
- SIP/2.0 202 Accepted
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---54f0b6228840b239;rport=64236
- From: "1000" <sip:1000@192.168.199.209>;tag=183b786d
- To: <sip:9183@192.168.199.209>;tag=VrRP6nXhMpUQ
- Call-ID: 90533NzFlNTMwYjE0ZGNjZTQyZTcyYTY1YjViYmEzZWQzYTA
- CSeq: 8 SUBSCRIBE
- Contact: <sip:9183@192.168.199.209:5060>
- Expires: 3600
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Length: 0
- ------------------------------------------------------------------------
- send 779 bytes to udp/[192.168.199.113]:64236 at 23:19:06.319125:
- ------------------------------------------------------------------------
- SIP/2.0 202 Accepted
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---943df604c4b2d55b;rport=64236
- From: "1000" <sip:1000@192.168.199.209>;tag=de06aa66
- To: <sip:9184@192.168.199.209>;tag=HJOZdoxjLwdK
- Call-ID: 90533ODM2ZGNkNDUwZGRhZjZkZmEwYjIxZjc1ZTJkMTQ1ZDk
- CSeq: 8 SUBSCRIBE
- Contact: <sip:9184@192.168.199.209:5060>
- Expires: 3600
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Length: 0
- ------------------------------------------------------------------------
- send 1306 bytes to udp/[192.168.199.113]:64236 at 23:19:06.319404:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKcSKQ5U47Qm5XN
- Max-Forwards: 70
- From: <sip:9181@192.168.199.209>;tag=gw839ZzKclCD
- To: "1000" <sip:1000@192.168.199.209>;tag=b76edc0b
- Call-ID: 90533NGJlNjhkODk3ZDMyMTg3Y2UwYzRkOGRlNjcxOGU3OGM
- CSeq: 254757305 NOTIFY
- Contact: <sip:9181@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Type: application/pidf+xml
- Content-Length: 439
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:9181@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>closed</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <dm:note>Unregistered</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- send 779 bytes to udp/[192.168.199.113]:64236 at 23:19:06.320535:
- ------------------------------------------------------------------------
- SIP/2.0 202 Accepted
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---cc1e8f06a5af276f;rport=64236
- From: "1000" <sip:1000@192.168.199.209>;tag=e7841062
- To: <sip:5000@192.168.199.209>;tag=mDloONSA4Ag1
- Call-ID: 90533YTM1NDAzNjkwMmM4Zjk1NDM1NWVkNjllMDBiZGY3MjY
- CSeq: 8 SUBSCRIBE
- Contact: <sip:5000@192.168.199.209:5060>
- Expires: 3600
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:06.320702:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKcSKQ5U47Qm5XN
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=b76edc0b
- From: <sip:9181@192.168.199.209>;tag=gw839ZzKclCD
- Call-ID: 90533NGJlNjhkODk3ZDMyMTg3Y2UwYzRkOGRlNjcxOGU3OGM
- CSeq: 254757305 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- send 1306 bytes to udp/[192.168.199.113]:64236 at 23:19:06.321182:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKD2cg7pNBNXUgH
- Max-Forwards: 70
- From: <sip:9183@192.168.199.209>;tag=VrRP6nXhMpUQ
- To: "1000" <sip:1000@192.168.199.209>;tag=183b786d
- Call-ID: 90533NzFlNTMwYjE0ZGNjZTQyZTcyYTY1YjViYmEzZWQzYTA
- CSeq: 254757306 NOTIFY
- Contact: <sip:9183@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Type: application/pidf+xml
- Content-Length: 439
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:9183@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>closed</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <dm:note>Unregistered</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:06.322133:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKD2cg7pNBNXUgH
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=183b786d
- From: <sip:9183@192.168.199.209>;tag=VrRP6nXhMpUQ
- Call-ID: 90533NzFlNTMwYjE0ZGNjZTQyZTcyYTY1YjViYmEzZWQzYTA
- CSeq: 254757306 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- send 779 bytes to udp/[192.168.199.113]:64236 at 23:19:06.323387:
- ------------------------------------------------------------------------
- SIP/2.0 202 Accepted
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---278f0273c9b8135c;rport=64236
- From: "1000" <sip:1000@192.168.199.209>;tag=1e8f204f
- To: <sip:4000@192.168.199.209>;tag=N39qjU7RtLHx
- Call-ID: 90533MWQ0NWZiZjk5ZmJkNzI4ODBhMjU1N2FhYmYwMDFhZTc
- CSeq: 8 SUBSCRIBE
- Contact: <sip:4000@192.168.199.209:5060>
- Expires: 3600
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Length: 0
- ------------------------------------------------------------------------
- send 1306 bytes to udp/[192.168.199.113]:64236 at 23:19:06.324264:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKeB688H6ej6H3c
- Max-Forwards: 70
- From: <sip:9184@192.168.199.209>;tag=HJOZdoxjLwdK
- To: "1000" <sip:1000@192.168.199.209>;tag=de06aa66
- Call-ID: 90533ODM2ZGNkNDUwZGRhZjZkZmEwYjIxZjc1ZTJkMTQ1ZDk
- CSeq: 254757307 NOTIFY
- Contact: <sip:9184@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Type: application/pidf+xml
- Content-Length: 439
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:9184@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>closed</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <dm:note>Unregistered</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- send 779 bytes to udp/[192.168.199.113]:64236 at 23:19:06.324807:
- ------------------------------------------------------------------------
- SIP/2.0 202 Accepted
- Via: SIP/2.0/UDP 192.168.199.113:64236;branch=z9hG4bK-524287-1---06571717c1ac073a;rport=64236
- From: "1000" <sip:1000@192.168.199.209>;tag=53819c6d
- To: <sip:1001@192.168.199.209>;tag=Z4GBrKbDdmSR
- Call-ID: 90533M2VjZDgwMTFhOTA2ODdjNmYwMThmMThkOWM0M2M4Yzc
- CSeq: 8 SUBSCRIBE
- Contact: <sip:1001@192.168.199.209:5060>
- Expires: 3600
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:06.325333:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKeB688H6ej6H3c
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=de06aa66
- From: <sip:9184@192.168.199.209>;tag=HJOZdoxjLwdK
- Call-ID: 90533ODM2ZGNkNDUwZGRhZjZkZmEwYjIxZjc1ZTJkMTQ1ZDk
- CSeq: 254757307 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- send 1306 bytes to udp/[192.168.199.113]:64236 at 23:19:06.325553:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKFmZ1aDQjFF8Nr
- Max-Forwards: 70
- From: <sip:5000@192.168.199.209>;tag=mDloONSA4Ag1
- To: "1000" <sip:1000@192.168.199.209>;tag=e7841062
- Call-ID: 90533YTM1NDAzNjkwMmM4Zjk1NDM1NWVkNjllMDBiZGY3MjY
- CSeq: 254757308 NOTIFY
- Contact: <sip:5000@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Type: application/pidf+xml
- Content-Length: 439
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:5000@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>closed</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <dm:note>Unregistered</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:06.326540:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKFmZ1aDQjFF8Nr
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=e7841062
- From: <sip:5000@192.168.199.209>;tag=mDloONSA4Ag1
- Call-ID: 90533YTM1NDAzNjkwMmM4Zjk1NDM1NWVkNjllMDBiZGY3MjY
- CSeq: 254757308 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- send 1306 bytes to udp/[192.168.199.113]:64236 at 23:19:06.327542:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKgXrtc87Ncry8K
- Max-Forwards: 70
- From: <sip:4000@192.168.199.209>;tag=N39qjU7RtLHx
- To: "1000" <sip:1000@192.168.199.209>;tag=1e8f204f
- Call-ID: 90533MWQ0NWZiZjk5ZmJkNzI4ODBhMjU1N2FhYmYwMDFhZTc
- CSeq: 254757309 NOTIFY
- Contact: <sip:4000@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Type: application/pidf+xml
- Content-Length: 439
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:4000@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>closed</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <dm:note>Unregistered</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:06.328497:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKgXrtc87Ncry8K
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=1e8f204f
- From: <sip:4000@192.168.199.209>;tag=N39qjU7RtLHx
- Call-ID: 90533MWQ0NWZiZjk5ZmJkNzI4ODBhMjU1N2FhYmYwMDFhZTc
- CSeq: 254757309 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- send 1301 bytes to udp/[192.168.199.113]:64236 at 23:19:06.425054:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKH6HKe3rS90mUF
- Max-Forwards: 70
- From: <sip:1001@192.168.199.209>;tag=Z4GBrKbDdmSR
- To: "1000" <sip:1000@192.168.199.209>;tag=53819c6d
- Call-ID: 90533M2VjZDgwMTFhOTA2ODdjNmYwMThmMThkOWM0M2M4Yzc
- CSeq: 254757310 NOTIFY
- Contact: <sip:1001@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3600
- Content-Type: application/pidf+xml
- Content-Length: 434
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:1001@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>open</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <dm:note>Available</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:06.427017:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKH6HKe3rS90mUF
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=53819c6d
- From: <sip:1001@192.168.199.209>;tag=Z4GBrKbDdmSR
- Call-ID: 90533M2VjZDgwMTFhOTA2ODdjNmYwMThmMThkOWM0M2M4Yzc
- CSeq: 254757310 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- EXECUTE sofia/internal/1001@192.168.199.209 hash(insert/192.168.199.209-spymap/1001/b2fb430e-1c9a-11e8-b916-1f706e5b1202)
- EXECUTE sofia/internal/1001@192.168.199.209 hash(insert/192.168.199.209-last_dial/1001/1000)
- EXECUTE sofia/internal/1001@192.168.199.209 hash(insert/192.168.199.209-last_dial/global/b2fb430e-1c9a-11e8-b916-1f706e5b1202)
- EXECUTE sofia/internal/1001@192.168.199.209 export(RFC2822_DATE=Wed, 28 Feb 2018 23:19:09 +0800)
- 2018-02-28 23:19:09.177355 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Wed, 28 Feb 2018 23:19:09 +0800]
- EXECUTE sofia/internal/1001@192.168.199.209 export(dialed_extension=1000)
- 2018-02-28 23:19:09.177355 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [dialed_extension]=[1000]
- EXECUTE sofia/internal/1001@192.168.199.209 bind_meta_app(1 b s execute_extension::dx XML features)
- 2018-02-28 23:19:09.177355 [INFO] switch_ivr_async.c:4171 Bound B-Leg: *1 execute_extension::dx XML features
- EXECUTE sofia/internal/1001@192.168.199.209 bind_meta_app(2 b s record_session::/root/freeswitch/var/lib/freeswitch/recordings/1001.2018-02-28-23-19-09.wav)
- 2018-02-28 23:19:09.177355 [INFO] switch_ivr_async.c:4171 Bound B-Leg: *2 record_session::/root/freeswitch/var/lib/freeswitch/recordings/1001.2018-02-28-23-19-09.wav
- EXECUTE sofia/internal/1001@192.168.199.209 bind_meta_app(3 b s execute_extension::cf XML features)
- 2018-02-28 23:19:09.177355 [INFO] switch_ivr_async.c:4171 Bound B-Leg: *3 execute_extension::cf XML features
- EXECUTE sofia/internal/1001@192.168.199.209 bind_meta_app(4 b s execute_extension::att_xfer XML features)
- 2018-02-28 23:19:09.177355 [INFO] switch_ivr_async.c:4171 Bound B-Leg: *4 execute_extension::att_xfer XML features
- EXECUTE sofia/internal/1001@192.168.199.209 set(ringback=%(2000,4000,440,480))
- 2018-02-28 23:19:09.177355 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1001@192.168.199.209 [ringback]=[%(2000,4000,440,480)]
- EXECUTE sofia/internal/1001@192.168.199.209 set(transfer_ringback=local_stream://moh)
- 2018-02-28 23:19:09.177355 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1001@192.168.199.209 [transfer_ringback]=[local_stream://moh]
- EXECUTE sofia/internal/1001@192.168.199.209 set(call_timeout=30)
- 2018-02-28 23:19:09.177355 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1001@192.168.199.209 [call_timeout]=[30]
- EXECUTE sofia/internal/1001@192.168.199.209 set(hangup_after_bridge=true)
- 2018-02-28 23:19:09.177355 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1001@192.168.199.209 [hangup_after_bridge]=[true]
- EXECUTE sofia/internal/1001@192.168.199.209 set(continue_on_fail=true)
- 2018-02-28 23:19:09.177355 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1001@192.168.199.209 [continue_on_fail]=[true]
- EXECUTE sofia/internal/1001@192.168.199.209 hash(insert/192.168.199.209-call_return/1000/1001)
- EXECUTE sofia/internal/1001@192.168.199.209 hash(insert/192.168.199.209-last_dial_ext/1000/b2fb430e-1c9a-11e8-b916-1f706e5b1202)
- EXECUTE sofia/internal/1001@192.168.199.209 set(called_party_callgroup=techsupport)
- 2018-02-28 23:19:09.177355 [DEBUG] mod_dptools.c:1530 SET sofia/internal/1001@192.168.199.209 [called_party_callgroup]=[techsupport]
- EXECUTE sofia/internal/1001@192.168.199.209 hash(insert/192.168.199.209-last_dial_ext/techsupport/b2fb430e-1c9a-11e8-b916-1f706e5b1202)
- EXECUTE sofia/internal/1001@192.168.199.209 hash(insert/192.168.199.209-last_dial_ext/global/b2fb430e-1c9a-11e8-b916-1f706e5b1202)
- EXECUTE sofia/internal/1001@192.168.199.209 hash(insert/192.168.199.209-last_dial/techsupport/b2fb430e-1c9a-11e8-b916-1f706e5b1202)
- EXECUTE sofia/internal/1001@192.168.199.209 bridge(user/1000@192.168.199.209)
- 2018-02-28 23:19:09.177355 [DEBUG] switch_channel.c:1250 sofia/internal/1001@192.168.199.209 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 28 Feb 2018 23:19:09 +0800] to event
- 2018-02-28 23:19:09.177355 [DEBUG] switch_channel.c:1250 sofia/internal/1001@192.168.199.209 EXPORTING[export_vars] [dialed_extension]=[1000] to event
- 2018-02-28 23:19:09.177355 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
- 2018-02-28 23:19:09.177355 [DEBUG] switch_channel.c:1250 sofia/internal/1001@192.168.199.209 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 28 Feb 2018 23:19:09 +0800] to event
- 2018-02-28 23:19:09.177355 [DEBUG] switch_channel.c:1250 sofia/internal/1001@192.168.199.209 EXPORTING[export_vars] [dialed_extension]=[1000] to event
- 2018-02-28 23:19:09.177355 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
- 2018-02-28 23:19:09.177355 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1000@192.168.199.113:64236 [b92affda-1c9a-11e8-b939-1f706e5b1202]
- 2018-02-28 23:19:09.177355 [DEBUG] mod_sofia.c:4818 (sofia/internal/1000@192.168.199.113:64236) State Change CS_NEW -> CS_INIT
- 2018-02-28 23:19:09.177355 [NOTICE] switch_ivr_originate.c:2845 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
- 2018-02-28 23:19:09.177355 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@192.168.199.113:64236) Running State Change CS_INIT (Cur 2 Tot 37)
- 2018-02-28 23:19:09.177355 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1000@192.168.199.113:64236) State INIT
- 2018-02-28 23:19:09.177355 [DEBUG] mod_sofia.c:90 sofia/internal/1000@192.168.199.113:64236 SOFIA INIT
- 2018-02-28 23:19:09.177355 [DEBUG] sofia_glue.c:1295 sofia/internal/1000@192.168.199.113:64236 sending invite version: 1.6.17 64bit
- Local SDP:
- v=0
- o=FreeSWITCH 1519811797 1519811798 IN IP4 192.168.199.209
- s=FreeSWITCH
- c=IN IP4 192.168.199.209
- t=0 0
- m=audio 19352 RTP/AVP 0 8 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:8 PCMA/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- a=sendrecv
- 2018-02-28 23:19:09.177355 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1000@192.168.199.113:64236 Standard INIT
- 2018-02-28 23:19:09.177355 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1000@192.168.199.113:64236) State Change CS_INIT -> CS_ROUTING
- 2018-02-28 23:19:09.177355 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1000@192.168.199.113:64236) State INIT going to sleep
- 2018-02-28 23:19:09.177355 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@192.168.199.113:64236) Running State Change CS_ROUTING (Cur 2 Tot 37)
- send 1247 bytes to udp/[192.168.199.113]:64236 at 23:19:09.195676:
- ------------------------------------------------------------------------
- INVITE sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKjFBcgy9v69aeB
- Max-Forwards: 69
- From: "Extension 1001" <sip:1001@192.168.199.209>;tag=6Z0vN9K1UtB1p
- To: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- Call-ID: 90896b6d-973d-1236-83b5-000c295e44db
- CSeq: 119579510 INVITE
- Contact: <sip:mod_sofia@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 250
- X-FS-Support: update_display,send_info
- Remote-Party-ID: "Extension 1001" <sip:1001@192.168.199.209>;party=calling;screen=yes;privacy=off
- v=0
- o=FreeSWITCH 1519811797 1519811798 IN IP4 192.168.199.209
- s=FreeSWITCH
- c=IN IP4 192.168.199.209
- t=0 0
- m=audio 19352 RTP/AVP 0 8 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:8 PCMA/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- ------------------------------------------------------------------------
- 2018-02-28 23:19:09.177355 [DEBUG] sofia.c:7048 Channel sofia/internal/1000@192.168.199.113:64236 entering state [calling][0]
- 2018-02-28 23:19:09.177355 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1000@192.168.199.113:64236) State ROUTING
- 2018-02-28 23:19:09.177355 [DEBUG] mod_sofia.c:143 sofia/internal/1000@192.168.199.113:64236 SOFIA ROUTING
- 2018-02-28 23:19:09.177355 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/1000@192.168.199.113:64236) State Change CS_ROUTING -> CS_CONSUME_MEDIA
- 2018-02-28 23:19:09.177355 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1000@192.168.199.113:64236) State ROUTING going to sleep
- 2018-02-28 23:19:09.177355 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@192.168.199.113:64236) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 37)
- 2018-02-28 23:19:09.177355 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1000@192.168.199.113:64236) State CONSUME_MEDIA
- 2018-02-28 23:19:09.177355 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1000@192.168.199.113:64236) State CONSUME_MEDIA going to sleep
- recv 481 bytes from udp/[192.168.199.113]:64236 at 23:19:09.268445:
- ------------------------------------------------------------------------
- SIP/2.0 180 Ringing
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKjFBcgy9v69aeB
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>;tag=0df79c6e
- From: "Extension 1001" <sip:1001@192.168.199.209>;tag=6Z0vN9K1UtB1p
- Call-ID: 90896b6d-973d-1236-83b5-000c295e44db
- CSeq: 119579510 INVITE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Allow-Events: talk, hold
- Content-Length: 0
- ------------------------------------------------------------------------
- 2018-02-28 23:19:09.257364 [DEBUG] sofia.c:7048 Channel sofia/internal/1000@192.168.199.113:64236 entering state [proceeding][180]
- 2018-02-28 23:19:09.257364 [NOTICE] sofia.c:7156 Ring-Ready sofia/internal/1000@192.168.199.113:64236!
- 2018-02-28 23:19:09.257364 [DEBUG] switch_channel.c:3345 (sofia/internal/1000@192.168.199.113:64236) Callstate Change DOWN -> RINGING
- 2018-02-28 23:19:09.277369 [INFO] switch_ivr_originate.c:1215 Sending early media
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:98:16000:20:0:1]/[opus:116:48000:20:0:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:98:16000:20:0:1]/[G722:9:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:98:16000:20:0:1]/[PCMU:0:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:98:16000:20:0:1]/[PCMA:8:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:97:8000:20:0:1]/[opus:116:48000:20:0:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:97:8000:20:0:1]/[G722:9:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:97:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:97:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:99:32000:20:0:1]/[opus:116:48000:20:0:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:99:32000:20:0:1]/[G722:9:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:99:32000:20:0:1]/[PCMU:0:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [speex:99:32000:20:0:1]/[PCMA:8:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [iLBC:104:8000:30:0:1]/[opus:116:48000:20:0:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [iLBC:104:8000:30:0:1]/[G722:9:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [iLBC:104:8000:30:0:1]/[PCMU:0:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [iLBC:104:8000:30:0:1]/[PCMA:8:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [GSM:3:8000:20:13200:1]/[opus:116:48000:20:0:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G722:9:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4491 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4491 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4352 Set telephone-event payload to 96@8000
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:3056 Set Codec sofia/internal/1001@192.168.199.209 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_codec.c:111 sofia/internal/1001@192.168.199.209 Original read codec set to PCMU:0
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4695 Set telephone-event payload to 96@8000
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:4754 sofia/internal/1001@192.168.199.209 Set 2833 dtmf send payload to 96 recv payload to 96
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:6865 AUDIO RTP [sofia/internal/1001@192.168.199.209] 192.168.199.209 port 26514 -> 192.168.199.147 port 40002 codec: 0 ms: 20
- 2018-02-28 23:19:09.277369 [DEBUG] switch_rtp.c:4096 Starting timer [soft] 160 bytes per 20ms
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:7085 Activating RTCP PORT 40003
- 2018-02-28 23:19:09.277369 [DEBUG] switch_rtp.c:4488 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 40003
- 2018-02-28 23:19:09.277369 [DEBUG] switch_rtp.c:2560 Setting RTCP remote addr to 192.168.199.147:40003 2
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:7166 sofia/internal/1001@192.168.199.209 Set 2833 dtmf send payload to 96
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:7173 sofia/internal/1001@192.168.199.209 Set 2833 dtmf receive payload to 96
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:7196 sofia/internal/1001@192.168.199.209 Set rtp dtmf delay to 40
- 2018-02-28 23:19:09.277369 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1001@192.168.199.209!
- 2018-02-28 23:19:09.277369 [DEBUG] switch_channel.c:3473 (sofia/internal/1001@192.168.199.209) Callstate Change RINGING -> EARLY
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_media.c:6848 Audio params are unchanged for sofia/internal/1001@192.168.199.209.
- 2018-02-28 23:19:09.277369 [DEBUG] mod_sofia.c:2363 Ring SDP:
- v=0
- o=FreeSWITCH 1519804635 1519804636 IN IP4 192.168.199.209
- s=FreeSWITCH
- c=IN IP4 192.168.199.209
- t=0 0
- m=audio 26514 RTP/AVP 0 96
- a=rtpmap:0 PCMU/8000
- a=rtpmap:96 telephone-event/8000
- a=fmtp:96 0-16
- a=ptime:20
- a=sendrecv
- a=rtcp:26515 IN IP4 192.168.199.209
- 2018-02-28 23:19:09.277369 [DEBUG] switch_ivr_originate.c:1273 Raw Codec Activation Success L16@8000hz 1 channel 20ms
- 2018-02-28 23:19:09.277369 [DEBUG] switch_core_codec.c:223 sofia/internal/1001@192.168.199.209 Push codec L16:100
- 2018-02-28 23:19:09.277369 [DEBUG] switch_ivr_originate.c:1342 Play Ringback Tone [%(2000,4000,440,480)]
- send 1187 bytes to udp/[192.168.199.147]:50452 at 23:19:09.283023:
- ------------------------------------------------------------------------
- SIP/2.0 183 Session Progress
- Via: SIP/2.0/UDP 192.168.199.147:50452;rport=50452;branch=z9hG4bKPjWwb7EBSODC0Uv9QMh4iITNWOfTYFdl4A
- From: sip:1001@192.168.199.209;tag=ncjBVBvrLoZYKZG9hB-Dw9pc-zMQ6-X0
- To: <sip:1000@192.168.199.209>;tag=5p73Ke3XyHNeB
- Call-ID: TLCkh5yLFXegYOSvMqEDr6xV1AxFjRNm
- CSeq: 6683 INVITE
- Contact: <sip:1000@192.168.199.209:5060;transport=udp>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 260
- Remote-Party-ID: "1000" <sip:1000@192.168.199.209>;party=calling;privacy=off;screen=no
- v=0
- o=FreeSWITCH 1519804635 1519804636 IN IP4 192.168.199.209
- s=FreeSWITCH
- c=IN IP4 192.168.199.209
- t=0 0
- m=audio 26514 RTP/AVP 0 96
- a=rtpmap:0 PCMU/8000
- a=rtpmap:96 telephone-event/8000
- a=fmtp:96 0-16
- a=ptime:20
- a=rtcp:26515 IN IP4 192.168.199.209
- ------------------------------------------------------------------------
- 2018-02-28 23:19:09.297976 [DEBUG] sofia.c:7048 Channel sofia/internal/1001@192.168.199.209 entering state [early][183]
- 2018-02-28 23:19:09.317497 [DEBUG] switch_rtp.c:6679 Correct audio RTCP ip/port confirmed.
- 2018-02-28 23:19:09.337374 [DEBUG] switch_rtp.c:1885 rtcp_stats_init: audio ssrc[1547994498] base_seq[19063]
- 2018-02-28 23:19:09.337374 [DEBUG] switch_rtp.c:7229 Correct audio ip/port confirmed.
- recv 381 bytes from udp/[192.168.199.113]:64236 at 23:19:11.544613:
- ------------------------------------------------------------------------
- SIP/2.0 486 Busy Here
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKjFBcgy9v69aeB
- To: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>;tag=0df79c6e
- From: "Extension 1001" <sip:1001@192.168.199.209>;tag=6Z0vN9K1UtB1p
- Call-ID: 90896b6d-973d-1236-83b5-000c295e44db
- CSeq: 119579510 INVITE
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- send 393 bytes to udp/[192.168.199.113]:64236 at 23:19:11.545120:
- ------------------------------------------------------------------------
- ACK sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKjFBcgy9v69aeB
- Max-Forwards: 69
- From: "Extension 1001" <sip:1001@192.168.199.209>;tag=6Z0vN9K1UtB1p
- To: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>;tag=0df79c6e
- Call-ID: 90896b6d-973d-1236-83b5-000c295e44db
- CSeq: 119579510 ACK
- Content-Length: 0
- ------------------------------------------------------------------------
- 2018-02-28 23:19:11.537460 [DEBUG] sofia.c:7048 Channel sofia/internal/1000@192.168.199.113:64236 entering state [terminated][486]
- 2018-02-28 23:19:11.537460 [NOTICE] sofia.c:8237 Hangup sofia/internal/1000@192.168.199.113:64236 [CS_CONSUME_MEDIA] [USER_BUSY]
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@192.168.199.113:64236) Running State Change CS_HANGUP (Cur 2 Tot 37)
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1000@192.168.199.113:64236) Callstate Change RINGING -> HANGUP
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1000@192.168.199.113:64236) State HANGUP
- 2018-02-28 23:19:11.537460 [DEBUG] mod_sofia.c:438 Channel sofia/internal/1000@192.168.199.113:64236 hanging up, cause: USER_BUSY
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1000@192.168.199.113:64236 Standard HANGUP, cause: USER_BUSY
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1000@192.168.199.113:64236) State HANGUP going to sleep
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1000@192.168.199.113:64236) State Change CS_HANGUP -> CS_REPORTING
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@192.168.199.113:64236) Running State Change CS_REPORTING (Cur 2 Tot 37)
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1000@192.168.199.113:64236) State REPORTING
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1000@192.168.199.113:64236 Standard REPORTING, cause: USER_BUSY
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1000@192.168.199.113:64236) State REPORTING going to sleep
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1000@192.168.199.113:64236) State Change CS_REPORTING -> CS_DESTROY
- 2018-02-28 23:19:11.537460 [DEBUG] switch_core_session.c:1664 Session 37 (sofia/internal/1000@192.168.199.113:64236) Locked, Waiting on external entities
- 2018-02-28 23:19:11.559836 [DEBUG] switch_core_codec.c:248 sofia/internal/1001@192.168.199.209 Restore previous codec PCMU:0.
- 2018-02-28 23:19:11.559836 [DEBUG] switch_ivr_originate.c:3833 Originate Resulted in Error Cause: 17 [USER_BUSY]
- 2018-02-28 23:19:11.559836 [NOTICE] switch_core_session.c:1682 Session 37 (sofia/internal/1000@192.168.199.113:64236) Ended
- 2018-02-28 23:19:11.559836 [NOTICE] switch_core_session.c:1686 Close Channel sofia/internal/1000@192.168.199.113:64236 [CS_DESTROY]
- 2018-02-28 23:19:11.559836 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1000@192.168.199.113:64236) Running State Change CS_DESTROY (Cur 1 Tot 37)
- 2018-02-28 23:19:11.559836 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1000@192.168.199.113:64236) State DESTROY
- 2018-02-28 23:19:11.559836 [DEBUG] mod_sofia.c:343 sofia/internal/1000@192.168.199.113:64236 SOFIA DESTROY
- 2018-02-28 23:19:11.559836 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1000@192.168.199.113:64236 Standard DESTROY
- 2018-02-28 23:19:11.559836 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1000@192.168.199.113:64236) State DESTROY going to sleep
- 2018-02-28 23:19:11.559836 [NOTICE] switch_ivr_originate.c:2845 Cannot create outgoing channel of type [user] cause: [USER_BUSY]
- 2018-02-28 23:19:11.559836 [DEBUG] switch_ivr_originate.c:3833 Originate Resulted in Error Cause: 17 [USER_BUSY]
- 2018-02-28 23:19:11.559836 [INFO] mod_dptools.c:3418 Originate Failed. Cause: USER_BUSY
- EXECUTE sofia/internal/1001@192.168.199.209 answer()
- 2018-02-28 23:19:11.559836 [DEBUG] switch_core_media.c:6848 Audio params are unchanged for sofia/internal/1001@192.168.199.209.
- 2018-02-28 23:19:11.559836 [DEBUG] mod_sofia.c:850 Local SDP sofia/internal/1001@192.168.199.209:
- v=0
- o=FreeSWITCH 1519804635 1519804637 IN IP4 192.168.199.209
- s=FreeSWITCH
- c=IN IP4 192.168.199.209
- t=0 0
- m=audio 26514 RTP/AVP 0 96
- a=rtpmap:0 PCMU/8000
- a=rtpmap:96 telephone-event/8000
- a=fmtp:96 0-16
- a=ptime:20
- a=sendrecv
- a=rtcp:26515 IN IP4 192.168.199.209
- send 1201 bytes to udp/[192.168.199.147]:50452 at 23:19:11.565576:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.147:50452;rport=50452;branch=z9hG4bKPjWwb7EBSODC0Uv9QMh4iITNWOfTYFdl4A
- From: sip:1001@192.168.199.209;tag=ncjBVBvrLoZYKZG9hB-Dw9pc-zMQ6-X0
- To: <sip:1000@192.168.199.209>;tag=5p73Ke3XyHNeB
- Call-ID: TLCkh5yLFXegYOSvMqEDr6xV1AxFjRNm
- CSeq: 6683 INVITE
- Contact: <sip:1000@192.168.199.209:5060;transport=udp>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Require: timer
- Supported: timer, path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Session-Expires: 1800;refresher=uac
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 260
- Remote-Party-ID: "1000" <sip:1000@192.168.199.209>;party=calling;privacy=off;screen=no
- v=0
- o=FreeSWITCH 1519804635 1519804636 IN IP4 192.168.199.209
- s=FreeSWITCH
- c=IN IP4 192.168.199.209
- t=0 0
- m=audio 26514 RTP/AVP 0 96
- a=rtpmap:0 PCMU/8000
- a=rtpmap:96 telephone-event/8000
- a=fmtp:96 0-16
- a=ptime:20
- a=rtcp:26515 IN IP4 192.168.199.209
- ------------------------------------------------------------------------
- 2018-02-28 23:19:11.559836 [NOTICE] mod_dptools.c:1312 Channel [sofia/internal/1001@192.168.199.209] has been answered
- 2018-02-28 23:19:11.559836 [DEBUG] switch_channel.c:3772 (sofia/internal/1001@192.168.199.209) Callstate Change EARLY -> ACTIVE
- 2018-02-28 23:19:11.559836 [DEBUG] sofia.c:7048 Channel sofia/internal/1001@192.168.199.209 entering state [completed][200]
- EXECUTE sofia/internal/1001@192.168.199.209 sleep(1000)
- send 1367 bytes to udp/[192.168.199.113]:64236 at 23:19:11.569806:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKKr44HSt03j10p
- Max-Forwards: 70
- From: <sip:1001@192.168.199.209>;tag=Z4GBrKbDdmSR
- To: "1000" <sip:1000@192.168.199.209>;tag=53819c6d
- Call-ID: 90533M2VjZDgwMTFhOTA2ODdjNmYwMThmMThkOWM0M2M4Yzc
- CSeq: 254757551 NOTIFY
- Contact: <sip:1001@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3595
- Content-Type: application/pidf+xml
- Content-Length: 500
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:1001@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>open</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <rpid:activities>
- <rpid:on-the-phone/>
- </rpid:activities>
- <dm:note>Talk 1000</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:11.571596:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKKr44HSt03j10p
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=53819c6d
- From: <sip:1001@192.168.199.209>;tag=Z4GBrKbDdmSR
- Call-ID: 90533M2VjZDgwMTFhOTA2ODdjNmYwMThmMThkOWM0M2M4Yzc
- CSeq: 254757551 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 368 bytes from udp/[192.168.199.147]:50452 at 23:19:11.577975:
- ------------------------------------------------------------------------
- ACK sip:1000@192.168.199.209:5060;transport=udp SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.147:50452;rport;branch=z9hG4bKPj1wvw9xS1CbeOoLPuHfacwJRLuKzMNYeI
- Max-Forwards: 70
- From: sip:1001@192.168.199.209;tag=ncjBVBvrLoZYKZG9hB-Dw9pc-zMQ6-X0
- To: sip:1000@192.168.199.209;tag=5p73Ke3XyHNeB
- Call-ID: TLCkh5yLFXegYOSvMqEDr6xV1AxFjRNm
- CSeq: 6683 ACK
- Content-Length: 0
- ------------------------------------------------------------------------
- 2018-02-28 23:19:11.559836 [DEBUG] sofia.c:7048 Channel sofia/internal/1001@192.168.199.209 entering state [ready][200]
- 2018-02-28 23:19:11.937596 [DEBUG] switch_rtp.c:7229 Correct audio ip/port confirmed.
- EXECUTE sofia/internal/1001@192.168.199.209 bridge(loopback/app=voicemail:default 192.168.199.209 1000)
- 2018-02-28 23:19:12.577819 [DEBUG] switch_channel.c:1823 (sofia/internal/1001@192.168.199.209) Callstate Change ACTIVE -> RING_WAIT
- 2018-02-28 23:19:12.577819 [DEBUG] switch_channel.c:1250 sofia/internal/1001@192.168.199.209 EXPORTING[export_vars] [RFC2822_DATE]=[Wed, 28 Feb 2018 23:19:09 +0800] to event
- 2018-02-28 23:19:12.577819 [DEBUG] switch_channel.c:1250 sofia/internal/1001@192.168.199.209 EXPORTING[export_vars] [dialed_extension]=[1000] to event
- 2018-02-28 23:19:12.577819 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
- 2018-02-28 23:19:12.577819 [NOTICE] switch_channel.c:1104 New Channel loopback/app=voicemail:default 192.168.199.209 1000-a [bb2fc8b0-1c9a-11e8-b945-1f706e5b1202]
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:158 loopback/app=voicemail:default 192.168.199.209 1000-a setup codec PCMU/8000/20
- 2018-02-28 23:19:12.577819 [NOTICE] switch_channel.c:1102 Rename Channel loopback/app=voicemail:default 192.168.199.209 1000-a->loopback/voicemail-a [bb2fc8b0-1c9a-11e8-b945-1f706e5b1202]
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:1174 (loopback/voicemail-a) State Change CS_NEW -> CS_INIT
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:584 (loopback/voicemail-a) Running State Change CS_INIT (Cur 2 Tot 38)
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:627 (loopback/voicemail-a) State INIT
- 2018-02-28 23:19:12.577819 [NOTICE] switch_channel.c:1104 New Channel loopback/voicemail-b [bb2ff1fa-1c9a-11e8-b949-1f706e5b1202]
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:158 loopback/voicemail-b setup codec PCMU/8000/20
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:276 (loopback/voicemail-b) State Change CS_NEW -> CS_INIT
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:362 (loopback/voicemail-a) State Change CS_INIT -> CS_ROUTING
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:627 (loopback/voicemail-a) State INIT going to sleep
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:584 (loopback/voicemail-a) Running State Change CS_ROUTING (Cur 3 Tot 39)
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:643 (loopback/voicemail-a) State ROUTING
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:394 loopback/voicemail-a CHANNEL ROUTING
- 2018-02-28 23:19:12.577819 [DEBUG] switch_ivr_originate.c:67 (loopback/voicemail-a) State Change CS_ROUTING -> CS_CONSUME_MEDIA
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:643 (loopback/voicemail-a) State ROUTING going to sleep
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:584 (loopback/voicemail-a) Running State Change CS_CONSUME_MEDIA (Cur 3 Tot 39)
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:662 (loopback/voicemail-a) State CONSUME_MEDIA
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:661 CHANNEL CONSUME_MEDIA
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:662 (loopback/voicemail-a) State CONSUME_MEDIA going to sleep
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:584 (loopback/voicemail-b) Running State Change CS_INIT (Cur 3 Tot 39)
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:627 (loopback/voicemail-b) State INIT
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:362 (loopback/voicemail-b) State Change CS_INIT -> CS_ROUTING
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:627 (loopback/voicemail-b) State INIT going to sleep
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:584 (loopback/voicemail-b) Running State Change CS_ROUTING (Cur 3 Tot 39)
- 2018-02-28 23:19:12.577819 [DEBUG] switch_channel.c:2249 (loopback/voicemail-b) Callstate Change DOWN -> RINGING
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:643 (loopback/voicemail-b) State ROUTING
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:394 loopback/voicemail-b CHANNEL ROUTING
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:413 (loopback/voicemail-b) State Change CS_ROUTING -> CS_EXECUTE
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:643 (loopback/voicemail-b) State ROUTING going to sleep
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:584 (loopback/voicemail-b) Running State Change CS_EXECUTE (Cur 3 Tot 39)
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:650 (loopback/voicemail-b) State EXECUTE
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:436 loopback/voicemail-b CHANNEL EXECUTE
- 2018-02-28 23:19:12.577819 [DEBUG] switch_core_state_machine.c:328 loopback/voicemail-b Standard EXECUTE
- EXECUTE loopback/voicemail-b pre_answer()
- 2018-02-28 23:19:12.577819 [NOTICE] mod_loopback.c:961 Pre-Answer loopback/voicemail-a!
- 2018-02-28 23:19:12.577819 [DEBUG] switch_channel.c:3473 (loopback/voicemail-a) Callstate Change DOWN -> EARLY
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- 2018-02-28 23:19:12.577819 [NOTICE] mod_dptools.c:1355 Pre-Answer loopback/voicemail-b!
- 2018-02-28 23:19:12.577819 [DEBUG] switch_channel.c:3473 (loopback/voicemail-b) Callstate Change RINGING -> EARLY
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- EXECUTE loopback/voicemail-b voicemail(default 192.168.199.209 1000)
- 2018-02-28 23:19:12.577819 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- 2018-02-28 23:19:12.597624 [DEBUG] switch_ivr_originate.c:3690 Originate Resulted in Success: [loopback/voicemail-a]
- 2018-02-28 23:19:12.597624 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:12.597624 [DEBUG] switch_channel.c:2047 (sofia/internal/1001@192.168.199.209) Callstate Change RING_WAIT -> ACTIVE
- 2018-02-28 23:19:12.597624 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:12.597624 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:12.597624 [DEBUG] switch_ivr_bridge.c:1601 (loopback/voicemail-a) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
- 2018-02-28 23:19:12.597624 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:12.597624 [DEBUG] switch_core_state_machine.c:584 (loopback/voicemail-a) Running State Change CS_EXCHANGE_MEDIA (Cur 3 Tot 39)
- 2018-02-28 23:19:12.597624 [DEBUG] switch_core_state_machine.c:653 (loopback/voicemail-a) State EXCHANGE_MEDIA
- 2018-02-28 23:19:12.597624 [DEBUG] mod_loopback.c:623 CHANNEL LOOPBACK
- 2018-02-28 23:19:12.697418 [DEBUG] switch_ivr_play_say.c:70 No language specified - Using [en]
- 2018-02-28 23:19:12.697418 [DEBUG] switch_ivr_play_say.c:250 Handle play-file:[voicemail/vm-person.wav] (en:en)
- 2018-02-28 23:19:12.697418 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- 2018-02-28 23:19:12.697418 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
- 2018-02-28 23:19:14.058071 [DEBUG] switch_ivr_play_say.c:1942 done playing file /root/freeswitch/share/freeswitch/sounds/en/us/callie/voicemail/vm-person.wav
- 2018-02-28 23:19:14.177805 [DEBUG] switch_ivr_play_say.c:250 Handle say:[1000] (en:en)
- 2018-02-28 23:19:14.177805 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- 2018-02-28 23:19:14.177805 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
- 2018-02-28 23:19:14.597633 [DEBUG] switch_rtp.c:6679 Correct audio RTCP ip/port confirmed.
- recv 424 bytes from udp/[192.168.199.147]:50452 at 23:19:15.492727:
- ------------------------------------------------------------------------
- BYE sip:1000@192.168.199.209:5060;transport=udp SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.147:50452;rport;branch=z9hG4bKPjo5RfxgyjWMW4bueMURWJgjZ5.K9zivgH
- Max-Forwards: 70
- From: sip:1001@192.168.199.209;tag=ncjBVBvrLoZYKZG9hB-Dw9pc-zMQ6-X0
- To: sip:1000@192.168.199.209;tag=5p73Ke3XyHNeB
- Call-ID: TLCkh5yLFXegYOSvMqEDr6xV1AxFjRNm
- CSeq: 6684 BYE
- User-Agent: Siphon PjSip v2.0.0-beta/arm-apple-darwin9
- Content-Length: 0
- ------------------------------------------------------------------------
- 2018-02-28 23:19:15.497559 [DEBUG] switch_ivr_bridge.c:706 sofia/internal/1001@192.168.199.209 ending bridge by request from write function
- 2018-02-28 23:19:15.497559 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [loopback/voicemail-a]
- 2018-02-28 23:19:15.497559 [NOTICE] switch_ivr_bridge.c:889 Hangup loopback/voicemail-a [CS_EXCHANGE_MEDIA] [ORIGINATOR_CANCEL]
- 2018-02-28 23:19:15.497559 [NOTICE] sofia.c:1012 Hangup sofia/internal/1001@192.168.199.209 [CS_EXECUTE] [NORMAL_CLEARING]
- 2018-02-28 23:19:15.497559 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:15.497559 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:653 (loopback/voicemail-a) State EXCHANGE_MEDIA going to sleep
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:584 (loopback/voicemail-a) Running State Change CS_HANGUP (Cur 3 Tot 39)
- 2018-02-28 23:19:15.497559 [DEBUG] switch_ivr_play_say.c:1942 done playing file file_string://digits/1.wav!digits/0.wav!digits/0.wav!digits/0.wav
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:850 (loopback/voicemail-a) Callstate Change EARLY -> HANGUP
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:852 (loopback/voicemail-a) State HANGUP
- 2018-02-28 23:19:15.497559 [DEBUG] mod_loopback.c:548 loopback/voicemail-a CHANNEL HANGUP
- 2018-02-28 23:19:15.497559 [NOTICE] mod_loopback.c:564 Hangup loopback/voicemail-b [CS_EXECUTE] [ORIGINATOR_CANCEL]
- 2018-02-28 23:19:15.497559 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- 2018-02-28 23:19:15.497559 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:60 loopback/voicemail-a Standard HANGUP, cause: ORIGINATOR_CANCEL
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:852 (loopback/voicemail-a) State HANGUP going to sleep
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:619 (loopback/voicemail-a) State Change CS_HANGUP -> CS_REPORTING
- 2018-02-28 23:19:15.497559 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:584 (loopback/voicemail-a) Running State Change CS_REPORTING (Cur 3 Tot 39)
- send 505 bytes to udp/[192.168.199.147]:50452 at 23:19:15.503126:
- ------------------------------------------------------------------------
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:938 (loopback/voicemail-a) State REPORTING
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.147:50452;rport=50452;branch=z9hG4bKPjo5RfxgyjWMW4bueMURWJgjZ5.K9zivgH
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:174 loopback/voicemail-a Standard REPORTING, cause: ORIGINATOR_CANCEL
- From: sip:1001@192.168.199.209;tag=ncjBVBvrLoZYKZG9hB-Dw9pc-zMQ6-X0
- To: sip:1000@192.168.199.209;tag=5p73Ke3XyHNeB
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:938 (loopback/voicemail-a) State REPORTING going to sleep
- Call-ID: TLCkh5yLFXegYOSvMqEDr6xV1AxFjRNm
- CSeq: 6684 BYE
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Content-Length: 0
- ------------------------------------------------------------------------
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:610 (loopback/voicemail-a) State Change CS_REPORTING -> CS_DESTROY
- 2018-02-28 23:19:15.497559 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_session.c:1664 Session 38 (loopback/voicemail-a) Locked, Waiting on external entities
- 2018-02-28 23:19:15.497559 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/internal/1001@192.168.199.209]
- 2018-02-28 23:19:15.497559 [DEBUG] mod_loopback.c:601 loopback/voicemail-a CHANNEL KILL
- 2018-02-28 23:19:15.497559 [DEBUG] switch_ivr_bridge.c:1702 sofia/internal/1001@192.168.199.209 skip receive message [UNBRIDGE] (channel is hungup already)
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_session.c:2814 sofia/internal/1001@192.168.199.209 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1001@192.168.199.209) State EXECUTE going to sleep
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1001@192.168.199.209) Running State Change CS_HANGUP (Cur 3 Tot 39)
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1001@192.168.199.209) Callstate Change ACTIVE -> HANGUP
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1001@192.168.199.209) State HANGUP
- 2018-02-28 23:19:15.497559 [DEBUG] mod_sofia.c:432 sofia/internal/1001@192.168.199.209 Overriding SIP cause 480 with 486 from the other leg
- 2018-02-28 23:19:15.497559 [DEBUG] mod_sofia.c:438 Channel sofia/internal/1001@192.168.199.209 hanging up, cause: NORMAL_CLEARING
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_session.c:2814 loopback/voicemail-b skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:650 (loopback/voicemail-b) State EXECUTE going to sleep
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:584 (loopback/voicemail-b) Running State Change CS_HANGUP (Cur 3 Tot 39)
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:850 (loopback/voicemail-b) Callstate Change EARLY -> HANGUP
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:852 (loopback/voicemail-b) State HANGUP
- 2018-02-28 23:19:15.497559 [DEBUG] mod_loopback.c:548 loopback/voicemail-b CHANNEL HANGUP
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:60 loopback/voicemail-b Standard HANGUP, cause: ORIGINATOR_CANCEL
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:852 (loopback/voicemail-b) State HANGUP going to sleep
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:619 (loopback/voicemail-b) State Change CS_HANGUP -> CS_REPORTING
- 2018-02-28 23:19:15.497559 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:584 (loopback/voicemail-b) Running State Change CS_REPORTING (Cur 3 Tot 39)
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:938 (loopback/voicemail-b) State REPORTING
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:174 loopback/voicemail-b Standard REPORTING, cause: ORIGINATOR_CANCEL
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:938 (loopback/voicemail-b) State REPORTING going to sleep
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1001@192.168.199.209 Standard HANGUP, cause: NORMAL_CLEARING
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1001@192.168.199.209) State HANGUP going to sleep
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1001@192.168.199.209) State Change CS_HANGUP -> CS_REPORTING
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:610 (loopback/voicemail-b) State Change CS_REPORTING -> CS_DESTROY
- 2018-02-28 23:19:15.497559 [DEBUG] mod_loopback.c:601 loopback/voicemail-b CHANNEL KILL
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_session.c:1664 Session 39 (loopback/voicemail-b) Locked, Waiting on external entities
- 2018-02-28 23:19:15.497559 [NOTICE] switch_core_session.c:1682 Session 39 (loopback/voicemail-b) Ended
- 2018-02-28 23:19:15.497559 [NOTICE] switch_core_session.c:1686 Close Channel loopback/voicemail-b [CS_DESTROY]
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1001@192.168.199.209) Running State Change CS_REPORTING (Cur 2 Tot 39)
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:741 (loopback/voicemail-b) Running State Change CS_DESTROY (Cur 2 Tot 39)
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:751 (loopback/voicemail-b) State DESTROY
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:181 loopback/voicemail-b Standard DESTROY
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:751 (loopback/voicemail-b) State DESTROY going to sleep
- 2018-02-28 23:19:15.497559 [NOTICE] switch_core_session.c:1682 Session 38 (loopback/voicemail-a) Ended
- 2018-02-28 23:19:15.497559 [NOTICE] switch_core_session.c:1686 Close Channel loopback/voicemail-a [CS_DESTROY]
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:741 (loopback/voicemail-a) Running State Change CS_DESTROY (Cur 1 Tot 39)
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:751 (loopback/voicemail-a) State DESTROY
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:181 loopback/voicemail-a Standard DESTROY
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:751 (loopback/voicemail-a) State DESTROY going to sleep
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1001@192.168.199.209) State REPORTING
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1001@192.168.199.209 Standard REPORTING, cause: NORMAL_CLEARING
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1001@192.168.199.209) State REPORTING going to sleep
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1001@192.168.199.209) State Change CS_REPORTING -> CS_DESTROY
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_session.c:1664 Session 36 (sofia/internal/1001@192.168.199.209) Locked, Waiting on external entities
- 2018-02-28 23:19:15.497559 [NOTICE] switch_core_session.c:1682 Session 36 (sofia/internal/1001@192.168.199.209) Ended
- 2018-02-28 23:19:15.497559 [NOTICE] switch_core_session.c:1686 Close Channel sofia/internal/1001@192.168.199.209 [CS_DESTROY]
- send 1301 bytes to udp/[192.168.199.113]:64236 at 23:19:15.508405:
- ------------------------------------------------------------------------
- NOTIFY sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615 SIP/2.0
- Via: SIP/2.0/UDP 192.168.199.209;rport;branch=z9hG4bKm1XXKmB40UQKj
- Max-Forwards: 70
- From: <sip:1001@192.168.199.209>;tag=Z4GBrKbDdmSR
- To: "1000" <sip:1000@192.168.199.209>;tag=53819c6d
- Call-ID: 90533M2VjZDgwMTFhOTA2ODdjNmYwMThmMThkOWM0M2M4Yzc
- CSeq: 254757751 NOTIFY
- Contact: <sip:1001@192.168.199.209:5060>
- User-Agent: FreeSWITCH-mod_sofia/1.6.17~64bit
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: timer, path, replaces
- Event: presence
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Subscription-State: active;expires=3591
- Content-Type: application/pidf+xml
- Content-Length: 434
- <?xml version="1.0" encoding="ISO-8859-1"?>
- <presence xmlns='urn:ietf:params:xml:ns:pidf'
- xmlns:dm='urn:ietf:params:xml:ns:pidf:data-model'
- xmlns:rpid='urn:ietf:params:xml:ns:pidf:rpid'
- xmlns:c='urn:ietf:params:xml:ns:pidf:cipid' entity='sip:1001@192.168.199.209'>
- <tuple id='t6a5ed77e'>
- <status>
- <basic>open</basic>
- </status>
- </tuple>
- <dm:person id='p06360c4a'>
- <dm:note>Available</dm:note>
- </dm:person>
- </presence>
- ------------------------------------------------------------------------
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1001@192.168.199.209) Running State Change CS_DESTROY (Cur 0 Tot 39)
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1001@192.168.199.209) State DESTROY
- 2018-02-28 23:19:15.497559 [DEBUG] mod_sofia.c:343 sofia/internal/1001@192.168.199.209 SOFIA DESTROY
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1001@192.168.199.209 Standard DESTROY
- 2018-02-28 23:19:15.497559 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1001@192.168.199.209) State DESTROY going to sleep
- recv 411 bytes from udp/[192.168.199.113]:64236 at 23:19:15.509945:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.168.199.209;rport=5060;branch=z9hG4bKm1XXKmB40UQKj
- Contact: <sip:1000@192.168.199.113:64236;rinstance=6558b3528a5b2615>
- To: "1000"<sip:1000@192.168.199.209>;tag=53819c6d
- From: <sip:1001@192.168.199.209>;tag=Z4GBrKbDdmSR
- Call-ID: 90533M2VjZDgwMTFhOTA2ODdjNmYwMThmMThkOWM0M2M4Yzc
- CSeq: 254757751 NOTIFY
- User-Agent: X-Lite release 5.2.0 stamp 90533
- Content-Length: 0
- ------------------------------------------------------------------------
Advertisement
Add Comment
Please, Sign In to add comment
Advertisement