Video not going thru

Status
Not open for further replies.
S

straitllc

New Member
Jan 26, 2021
3
0
1
46
When I try to make video calls no video is going out or being received one. I have enabled H264 and set it in the proper global and outbound prefs in variables. variables.pnginternal settings.png
I have attached my log file and help would be much appreciated.
 

Attachments

  • video call log.txt
    31.6 KB · Views: 5
S

straitllc

New Member
Jan 26, 2021
3
0
1
46
021-02-02 19:44:18.203733 [DEBUG] switch_core_media.c:9495 VIDEO RTP [sofia/internal/3107@205.189.**.***] 205.189.**.***:32046->192.168.86.31:15006 codec: 125 ms: 0 [SUCCESS]
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.203733 [DEBUG] switch_core_media.c:7630 sofia/internal/3107@205.189.**.*** Starting Video thread
2021-02-02 19:44:18.203733 [DEBUG] switch_core_media.c:7496 sofia/internal/3107@205.189.**.*** Video thread started. Echo is off
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.203733 [INFO] switch_core_media.c:9576 Activating VIDEO RTCP PORT 15007 interval 1000 mux -1
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.203733 [DEBUG] switch_rtp.c:4848 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 15007
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.203733 [DEBUG] switch_rtp.c:2636 Setting RTCP remote addr to 192.168.86.31:15007 2
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.203733 [DEBUG] mod_sofia.c:898 Local SDP sofia/internal/3107@205.189.**.***:
39b3884b-5d3e-4def-b4f9-7d69dab53f48 v=0
39b3884b-5d3e-4def-b4f9-7d69dab53f48 o=FreeSWITCH 1612288002 1612288003 IN IP4 205.189.**.***
39b3884b-5d3e-4def-b4f9-7d69dab53f48 s=FreeSWITCH
39b3884b-5d3e-4def-b4f9-7d69dab53f48 c=IN IP4 205.189.**.***
39b3884b-5d3e-4def-b4f9-7d69dab53f48 t=0 0
39b3884b-5d3e-4def-b4f9-7d69dab53f48 m=audio 32256 RTP/AVP 8 101
39b3884b-5d3e-4def-b4f9-7d69dab53f48 a=rtpmap:8 PCMA/8000
39b3884b-5d3e-4def-b4f9-7d69dab53f48 a=rtpmap:101 telephone-event/8000
39b3884b-5d3e-4def-b4f9-7d69dab53f48 a=fmtp:101 0-16
39b3884b-5d3e-4def-b4f9-7d69dab53f48 a=ptime:20
39b3884b-5d3e-4def-b4f9-7d69dab53f48 a=sendrecv
39b3884b-5d3e-4def-b4f9-7d69dab53f48 m=video 32046 RTP/AVP 125
39b3884b-5d3e-4def-b4f9-7d69dab53f48 b=AS:1024
39b3884b-5d3e-4def-b4f9-7d69dab53f48 a=rtpmap:125 H264/90000
39b3884b-5d3e-4def-b4f9-7d69dab53f48 a=fmtp:125 profile-level-id=42801E;packetization-mode=0
39b3884b-5d3e-4def-b4f9-7d69dab53f48 a=inactive
39b3884b-5d3e-4def-b4f9-7d69dab53f48 a=rtcp:32047 IN IP4 205.189.**.***
39b3884b-5d3e-4def-b4f9-7d69dab53f48 a=rtcp-fb:125 nack
39b3884b-5d3e-4def-b4f9-7d69dab53f48 a=rtcp-fb:125 nack pli
39b3884b-5d3e-4def-b4f9-7d69dab53f48
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.203733 [NOTICE] switch_ivr_originate.c:3794 Channel [sofia/internal/3107@205.189.**.***] has been answered
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.203733 [DEBUG] switch_channel.c:3865 (sofia/internal/3107@205.189.**.***) Callstate Change RINGING -> ACTIVE
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.203733 [DEBUG] sofia.c:7326 Channel sofia/internal/3107@205.189.**.*** entering state [completed][200]
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.203733 [DEBUG] switch_ivr_originate.c:3852 Originate Resulted in Success: [sofia/internal/3115@67.60.57.229:8812]
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.203733 [DEBUG] switch_ivr_originate.c:3111 sofia/internal/3115@67.60.57.229:8812 Setting leg timeout to 30
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.203733 [DEBUG] switch_ivr_originate.c:3852 Originate Resulted in Success: [sofia/internal/3115@67.60.57.229:8812]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:18.203733 [DEBUG] switch_ivr_bridge.c:1793 (sofia/internal/3115@67.60.57.229:8812) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:18.203733 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/3115@67.60.57.229:8812) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 11)
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:18.203733 [DEBUG] switch_core_state_machine.c:654 (sofia/internal/3115@67.60.57.229:8812) State EXCHANGE_MEDIA
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:18.203733 [DEBUG] mod_sofia.c:656 SOFIA EXCHANGE_MEDIA
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.523783 [DEBUG] sofia.c:7326 Channel sofia/internal/3107@205.189.**.*** entering state [ready][200]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:18.703758 [INFO] switch_rtp.c:7719 Auto Changing audio port from 192.168.86.32:10004 to 67.60.57.229:10004
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:18.843786 [INFO] switch_rtp.c:7719 Auto Changing audio port from 192.168.86.31:10004 to 67.60.57.229:10004
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:19.063781 [INFO] switch_rtp.c:7136 Auto Changing video RTCP port from 192.168.86.31:15007 to 67.60.57.229:15007
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:19.063781 [DEBUG] switch_rtp.c:2636 Setting RTCP remote addr to 67.60.57.229:15007 2
2021-02-02 19:44:24.583734 [DEBUG] switch_core_file.c:405 File /usr/share/freeswitch/sounds/music/205.189.**.***/default/48000/2_HOLD-MESSAGE.wav sample rate 44100 doesn't match requested rate 48000
2021-02-02 19:44:24.583734 [WARNING] switch_core_file.c:424 File has 2 channels, muxing to 1 channel will occur.
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] sofia.c:7326 Channel sofia/internal/3115@67.60.57.229:8812 entering state [received][100]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] sofia.c:7336 Remote SDP:
9613bc86-597d-46ce-a873-10d282347a36 v=0
9613bc86-597d-46ce-a873-10d282347a36 o=- 1612320254 2 IN IP4 192.168.86.32
9613bc86-597d-46ce-a873-10d282347a36 s=ps
9613bc86-597d-46ce-a873-10d282347a36 c=IN IP4 192.168.86.32
9613bc86-597d-46ce-a873-10d282347a36 t=0 0
9613bc86-597d-46ce-a873-10d282347a36 m=audio 10004 RTP/AVP 18 8 0 105 101
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:18 G729/8000
9613bc86-597d-46ce-a873-10d282347a36 a=fmtp:18 annexb=no
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:8 PCMA/8000
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:0 PCMU/8000
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:105 opus/48000/2
9613bc86-597d-46ce-a873-10d282347a36 a=fmtp:105 useinbandfec=1
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:101 telephone-event/8000
9613bc86-597d-46ce-a873-10d282347a36 a=fmtp:101 0-16
9613bc86-597d-46ce-a873-10d282347a36 m=video 15006 RTP/AVP 125 120 122
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:125 H264/90000
9613bc86-597d-46ce-a873-10d282347a36 a=fmtp:125 profile-level-id=42801E;packetization-mode=0
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:120 VP8/90000
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:122 VP9/90000
9613bc86-597d-46ce-a873-10d282347a36 a=rtcp-fb:* nack pli
9613bc86-597d-46ce-a873-10d282347a36
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [opus:105:48000:20:0:2]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [opus:105:48000:20:0:2]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5510 Set telephone-event payload to 101@8000
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5853 Set telephone-event payload to 101@8000
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:5911 sofia/internal/3115@67.60.57.229:8812 Set 2833 dtmf send payload to 101 recv payload to 101
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:6196 Video Codec Compare [H264:125]/[H264:97]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:6228 Video Codec Compare [H264:125] +++ is saved as a match
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:6196 Video Codec Compare [VP8:120]/[H264:97]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:6196 Video Codec Compare [VP9:122]/[H264:97]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:3649 Set VIDEO Codec sofia/internal/3115@67.60.57.229:8812 H264/90000 0 ms
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:8645 Audio params are unchanged for sofia/internal/3115@67.60.57.229:8812.
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_rtp.c:4465 Starting video timer.
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:9495 VIDEO RTP [sofia/internal/3115@67.60.57.229:8812] 205.189.**.***:28960->192.168.86.32:15006 codec: 125 ms: 0 [SUCCESS]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:7630 sofia/internal/3115@67.60.57.229:8812 Starting Video thread
2021-02-02 19:44:25.263798 [DEBUG] switch_core_media.c:7496 sofia/internal/3115@67.60.57.229:8812 Video thread started. Echo is off
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [INFO] switch_core_media.c:9576 Activating VIDEO RTCP PORT 15007 interval 1000 mux -1
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_rtp.c:4848 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 15007
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] switch_rtp.c:2636 Setting RTCP remote addr to 192.168.86.32:15007 2
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] sofia.c:8275 Processing updated SDP
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.263798 [DEBUG] sofia.c:7326 Channel sofia/internal/3115@67.60.57.229:8812 entering state [completed][200]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:25.403798 [DEBUG] sofia.c:7326 Channel sofia/internal/3115@67.60.57.229:8812 entering state [ready][200]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:26.123753 [INFO] switch_rtp.c:7136 Auto Changing video RTCP port from 192.168.86.32:15007 to 67.60.57.229:15007
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:26.123753 [DEBUG] switch_rtp.c:2636 Setting RTCP remote addr to 67.60.57.229:15007 2
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:26.123753 [DEBUG] switch_rtp.c:1921 rtcp_stats_init: video ssrc[2263358706] base_seq[21663]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:26.983798 [INFO] switch_rtp.c:7719 Auto Changing video port from 192.168.86.32:15006 to 67.60.57.229:15006
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] sofia.c:7326 Channel sofia/internal/3115@67.60.57.229:8812 entering state [received][100]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] sofia.c:7336 Remote SDP:
9613bc86-597d-46ce-a873-10d282347a36 v=0
9613bc86-597d-46ce-a873-10d282347a36 o=- 1612320254 3 IN IP4 192.168.86.32
9613bc86-597d-46ce-a873-10d282347a36 s=ps
9613bc86-597d-46ce-a873-10d282347a36 c=IN IP4 192.168.86.32
9613bc86-597d-46ce-a873-10d282347a36 t=0 0
9613bc86-597d-46ce-a873-10d282347a36 m=audio 10004 RTP/AVP 18 8 0 105 101
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:18 G729/8000
9613bc86-597d-46ce-a873-10d282347a36 a=fmtp:18 annexb=no
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:8 PCMA/8000
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:0 PCMU/8000
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:105 opus/48000/2
9613bc86-597d-46ce-a873-10d282347a36 a=fmtp:105 useinbandfec=1
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:101 telephone-event/8000
9613bc86-597d-46ce-a873-10d282347a36 a=fmtp:101 0-16
9613bc86-597d-46ce-a873-10d282347a36 m=video 0 RTP/AVP 125 120 122
9613bc86-597d-46ce-a873-10d282347a36
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [opus:105:48000:20:0:2]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [opus:105:48000:20:0:2]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5510 Set telephone-event payload to 101@8000
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5853 Set telephone-event payload to 101@8000
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:5911 sofia/internal/3115@67.60.57.229:8812 Set 2833 dtmf send payload to 101 recv payload to 101
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:8645 Audio params are unchanged for sofia/internal/3115@67.60.57.229:8812.
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] switch_core_media.c:9359 Video params are unchanged for sofia/internal/3115@67.60.57.229:8812.
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.163751 [DEBUG] sofia.c:8275 Processing updated SDP
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.183763 [DEBUG] sofia.c:7326 Channel sofia/internal/3115@67.60.57.229:8812 entering state [completed][200]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.323782 [DEBUG] sofia.c:7326 Channel sofia/internal/3115@67.60.57.229:8812 entering state [ready][200]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] sofia.c:7326 Channel sofia/internal/3115@67.60.57.229:8812 entering state [received][100]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] sofia.c:7336 Remote SDP:
9613bc86-597d-46ce-a873-10d282347a36 v=0
9613bc86-597d-46ce-a873-10d282347a36 o=- 1612320254 4 IN IP4 192.168.86.32
9613bc86-597d-46ce-a873-10d282347a36 s=ps
9613bc86-597d-46ce-a873-10d282347a36 c=IN IP4 192.168.86.32
9613bc86-597d-46ce-a873-10d282347a36 t=0 0
9613bc86-597d-46ce-a873-10d282347a36 m=audio 10004 RTP/AVP 18 8 0 105 101
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:18 G729/8000
9613bc86-597d-46ce-a873-10d282347a36 a=fmtp:18 annexb=no
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:8 PCMA/8000
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:0 PCMU/8000
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:105 opus/48000/2
9613bc86-597d-46ce-a873-10d282347a36 a=fmtp:105 useinbandfec=1
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:101 telephone-event/8000
9613bc86-597d-46ce-a873-10d282347a36 a=fmtp:101 0-16
9613bc86-597d-46ce-a873-10d282347a36 m=video 15010 RTP/AVP 125 120 122
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:125 H264/90000
9613bc86-597d-46ce-a873-10d282347a36 a=fmtp:125 profile-level-id=42801E;packetization-mode=0
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:120 VP8/90000
9613bc86-597d-46ce-a873-10d282347a36 a=rtpmap:122 VP9/90000
9613bc86-597d-46ce-a873-10d282347a36 a=rtcp-fb:* nack pli
9613bc86-597d-46ce-a873-10d282347a36
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5649 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [opus:105:48000:20:0:2]/[PCMA:8:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5594 Audio Codec Compare [opus:105:48000:20:0:2]/[PCMU:0:8000:20:64000:1]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5510 Set telephone-event payload to 101@8000
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5853 Set telephone-event payload to 101@8000
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:5911 sofia/internal/3115@67.60.57.229:8812 Set 2833 dtmf send payload to 101 recv payload to 101
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:6196 Video Codec Compare [H264:125]/[H264:97]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:6228 Video Codec Compare [H264:125] +++ is saved as a match
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:6196 Video Codec Compare [VP8:120]/[H264:97]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:6196 Video Codec Compare [VP9:122]/[H264:97]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:8645 Audio params are unchanged for sofia/internal/3115@67.60.57.229:8812.
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:9364 Video params changed for sofia/internal/3115@67.60.57.229:8812 from 192.168.86.32:15006 to 192.168.86.32:15010
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:9372 VIDEO RTP [sofia/internal/3115@67.60.57.229:8812] 205.189.**.*** port 28960 -> 192.168.86.32 port 15010 codec: 125
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] switch_core_media.c:9403 VIDEO RTP CHANGING DEST TO: [192.168.86.32:15010]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.943788 [DEBUG] sofia.c:8275 Processing updated SDP
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:27.963760 [DEBUG] sofia.c:7326 Channel sofia/internal/3115@67.60.57.229:8812 entering state [completed][200]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:28.083784 [DEBUG] sofia.c:7326 Channel sofia/internal/3115@67.60.57.229:8812 entering state [ready][200]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:29.223798 [INFO] switch_rtp.c:7136 Auto Changing video RTCP port from 67.60.57.229:15007 to 67.60.57.229:15011
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:29.223798 [DEBUG] switch_rtp.c:2636 Setting RTCP remote addr to 67.60.57.229:15011 2
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:29.223798 [DEBUG] switch_rtp.c:1921 rtcp_stats_init: video ssrc[3424642960] base_seq[6543]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:30.103805 [INFO] switch_rtp.c:7719 Auto Changing video port from 192.168.86.32:15010 to 67.60.57.229:15010
2021-02-02 19:44:32.903771 [WARNING] sofia_reg.c:1794 SIP auth challenge (INVITE) on sofia profile 'internal' for [*281@205.189.**.***] from ip 10.150.4.119
2021-02-02 19:44:33.203798 [WARNING] sofia_reg.c:1794 SIP auth challenge (INVITE) on sofia profile 'internal' for [*282@205.189.**.***] from ip 10.150.4.119
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.023798 [NOTICE] sofia.c:1089 Hangup sofia/internal/3115@67.60.57.229:8812 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.023798 [DEBUG] switch_ivr_bridge.c:843 Ending video thread.
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.023798 [DEBUG] switch_ivr_bridge.c:901 Ending video thread.
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.023798 [DEBUG] switch_ivr_bridge.c:253 sofia/internal/3115@67.60.57.229:8812 video thread ended.
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.023798 [DEBUG] switch_ivr_bridge.c:255 sofia/internal/3115@67.60.57.229:8812 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
2021-02-02 19:44:35.023798 [DEBUG] switch_core_media.c:7597 sofia/internal/3115@67.60.57.229:8812 Video thread ended
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] switch_ivr_bridge.c:253 sofia/internal/3107@205.189.**.*** video thread ended.
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_ivr_bridge.c:912 BRIDGE THREAD DONE [sofia/internal/3115@67.60.57.229:8812]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:654 (sofia/internal/3115@67.60.57.229:8812) State EXCHANGE_MEDIA going to sleep
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/3115@67.60.57.229:8812) Running State Change CS_HANGUP (Cur 2 Tot 11)
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:848 (sofia/internal/3115@67.60.57.229:8812) Callstate Change ACTIVE -> HANGUP
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/3115@67.60.57.229:8812) State HANGUP
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] mod_sofia.c:453 Channel sofia/internal/3115@67.60.57.229:8812 hanging up, cause: NORMAL_CLEARING
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:60 sofia/internal/3115@67.60.57.229:8812 Standard HANGUP, cause: NORMAL_CLEARING
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/3115@67.60.57.229:8812) State HANGUP going to sleep
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:620 (sofia/internal/3115@67.60.57.229:8812) State Change CS_HANGUP -> CS_REPORTING
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/3115@67.60.57.229:8812) Running State Change CS_REPORTING (Cur 2 Tot 11)
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/3115@67.60.57.229:8812) State REPORTING
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:174 sofia/internal/3115@67.60.57.229:8812 Standard REPORTING, cause: NORMAL_CLEARING
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/3115@67.60.57.229:8812) State REPORTING going to sleep
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:611 (sofia/internal/3115@67.60.57.229:8812) State Change CS_REPORTING -> CS_DESTROY
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_session.c:1726 Session 11 (sofia/internal/3115@67.60.57.229:8812) Locked, Waiting on external entities
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] switch_ivr_bridge.c:820 sofia/internal/3115@67.60.57.229:8812 ending bridge by request from write function
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] switch_ivr_bridge.c:912 BRIDGE THREAD DONE [sofia/internal/3107@205.189.**.***]
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [NOTICE] switch_ivr_bridge.c:1944 Hangup sofia/internal/3107@205.189.**.*** [CS_EXECUTE] [NORMAL_CLEARING]
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] mod_hash.c:296 Usage for 205.189.**.***_3115 is now 0
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [NOTICE] switch_core_session.c:1744 Session 11 (sofia/internal/3115@67.60.57.229:8812) Ended
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [NOTICE] switch_core_session.c:1748 Close Channel sofia/internal/3115@67.60.57.229:8812 [CS_DESTROY]
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] switch_core_session.c:2905 sofia/internal/3107@205.189.**.*** skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/3107@205.189.**.***) State EXECUTE going to sleep
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/3107@205.189.**.***) Running State Change CS_HANGUP (Cur 1 Tot 11)
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/3115@67.60.57.229:8812) Running State Change CS_DESTROY (Cur 1 Tot 11)
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/3115@67.60.57.229:8812) State DESTROY
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] mod_sofia.c:364 sofia/internal/3115@67.60.57.229:8812 SOFIA DESTROY
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_rtp.c:5146 NACK: Added to JB: [0]
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:181 sofia/internal/3115@67.60.57.229:8812 Standard DESTROY
9613bc86-597d-46ce-a873-10d282347a36 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/3115@67.60.57.229:8812) State DESTROY going to sleep
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:848 (sofia/internal/3107@205.189.**.***) Callstate Change ACTIVE -> HANGUP
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/3107@205.189.**.***) State HANGUP
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] mod_sofia.c:447 sofia/internal/3107@205.189.**.*** Overriding SIP cause 480 with 200 from the other leg
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] mod_sofia.c:453 Channel sofia/internal/3107@205.189.**.*** hanging up, cause: NORMAL_CLEARING
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] mod_sofia.c:507 Sending BYE to sofia/internal/3107@205.189.**.***
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:60 sofia/internal/3107@205.189.**.*** Standard HANGUP, cause: NORMAL_CLEARING
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.043796 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/3107@205.189.**.***) State HANGUP going to sleep
2021-02-02 19:44:35.063820 [DEBUG] switch_core_media.c:7597 sofia/internal/3107@205.189.**.*** Video thread ended
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.063820 [DEBUG] switch_core_state_machine.c:781 Hangup Command with no Session lua(app.lua hangup):
39b3884b-5d3e-4def-b4f9-7d69dab53f48
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.063820 [DEBUG] switch_core_state_machine.c:620 (sofia/internal/3107@205.189.**.***) State Change CS_HANGUP -> CS_REPORTING
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.063820 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/3107@205.189.**.***) Running State Change CS_REPORTING (Cur 1 Tot 11)
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.063820 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/3107@205.189.**.***) State REPORTING
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [DEBUG] switch_core_state_machine.c:174 sofia/internal/3107@205.189.**.*** Standard REPORTING, cause: NORMAL_CLEARING
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/3107@205.189.**.***) State REPORTING going to sleep
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [DEBUG] switch_core_state_machine.c:611 (sofia/internal/3107@205.189.**.***) State Change CS_REPORTING -> CS_DESTROY
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [DEBUG] switch_core_session.c:1726 Session 10 (sofia/internal/3107@205.189.**.***) Locked, Waiting on external entities
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [NOTICE] switch_core_session.c:1744 Session 10 (sofia/internal/3107@205.189.**.***) Ended
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [NOTICE] switch_core_session.c:1748 Close Channel sofia/internal/3107@205.189.**.*** [CS_DESTROY]
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/3107@205.189.**.***) Running State Change CS_DESTROY (Cur 0 Tot 11)
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/3107@205.189.**.***) State DESTROY
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [DEBUG] mod_sofia.c:364 sofia/internal/3107@205.189.**.*** SOFIA DESTROY
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [DEBUG] switch_rtp.c:5146 NACK: Added to JB: [0]
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [DEBUG] switch_core_state_machine.c:181 sofia/internal/3107@205.189.**.*** Standard DESTROY
39b3884b-5d3e-4def-b4f9-7d69dab53f48 2021-02-02 19:44:35.163770 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/3107@205.189.**.***) State DESTROY going to sleep
 
Status
Not open for further replies.
Top Bottom