[Freeswitch-users] SIP Call from Videodevice

Michael Jerris mike at jerris.com
Mon Sep 19 20:16:06 MSD 2016 

look at the sip trace, something in mod_sofia is killing it.
> On Sep 19, 2016, at 1:48 AM, Jürgen Wendler <jw at vision-gmbh.de> wrote:
> 
> Thanks for your answer.
>  
> Well i have some codecs in common:
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4331 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4331 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4276 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4331 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
> …
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4784 Video Codec Compare [H264:105] +++ is saved as a match
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [MP4V-ES:96]/[H261:31]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [MP4V-ES:96]/[VP8:99]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [MP4V-ES:96]/[H263:34]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [MP4V-ES:96]/[H264:99]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [H263:34]/[H261:31]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [H263:34]/[VP8:99]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [H263:34]/[H263:34]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4784 Video Codec Compare [H263:34] +++ is saved as a match
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [H263:34]/[H264:99]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [H261:31]/[H261:31]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4784 Video Codec Compare [H261:31] +++ is saved as a match
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [H261:31]/[VP8:99]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [H261:31]/[H263:34]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.450128 [DEBUG] switch_core_media.c:4760 Video Codec Compare [H261:31]/[H264:99]
>  
>  
> After this, the log says:
>  
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.470147 [NOTICE] mod_dptools.c:1309 Channel [sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21>] has been answered
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.470147 [DEBUG] switch_channel.c:3770 (sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21>) Callstate Change EARLY -> ACTIVE
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.470147 [DEBUG] sofia.c:6962 Channel sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21> entering state [completed][200]
> …
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.490154 [DEBUG] conference_loop.c:1102 Setup timer soft success interval: 20  samples: 160
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.510307 [NOTICE] switch_core_io.c:1202 Activating write resampler
> 2016-09-19 07:41:55.560315 [NOTICE] avcodec.c:1014 codec: id=28 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
> 2016-09-19 07:41:55.560315 [DEBUG] conference_video.c:2446 Setting up video write codec H264 at slot 0
> 2016-09-19 07:41:55.560315 [INFO] avcodec.c:1072 initializing encoder 1408x1152
> 2016-09-19 07:41:55.560315 [DEBUG] avcodec.c:834 NVENC HW CODEC NOT PRESENT
> using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 AVX XOP FMA4 FMA3 LZCNT BMI1
> profile Constrained Baseline, level 4.1
> 2016-09-19 07:41:55.630294 [DEBUG] conference_video.c:1111 Canvas position 1 applied layout 1x1
> 2016-09-19 07:41:55.680312 [DEBUG] conference_video.c:1111 Canvas position 1 applied layout 1x1
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.710321 [DEBUG] conference_member.c:1654 Raw Codec Activation Success L16 at 16000hz 1 channel 20ms
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.710321 [DEBUG] conference_member.c:1701 Raw Codec Activation Success L16 at 48000hz 2 channel 20ms
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:41:55.710321 [DEBUG] conference_loop.c:1102 Setup timer soft success interval: 20  samples: 160
> 2016-09-19 07:41:58.250405 [DEBUG] mod_local_stream.c:848 Opening Stream [moh/48000] 48000hz
> 2016-09-19 07:41:58.250405 [WARNING] switch_core_file.c:348 File has 1 channels, muxing to 2 channels will occur.
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.490314 [DEBUG] sofia.c:6962 Channel sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21> entering state [terminating][0]
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.490314 [NOTICE] sofia.c:8048 Hangup sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21> [CS_EXECUTE] [NORMAL_UNSPECIFIED]
> 2016-09-19 07:42:27.500352 [DEBUG] switch_core_media.c:5544 sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21>Video thread ended
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.511294 [INFO] conference_loop.c:1403 Channel leaving conference, cause: NORMAL_UNSPECIFIED
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.511294 [DEBUG] mod_conference.c:2215 sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21> skip receive message [UNBRIDGE] (channel is hungup already)
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.511294 [DEBUG] switch_core_media.c:9305 sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21> skip receive message [HARD_MUTE] (channel is hungup already)
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.511294 [DEBUG] switch_core_codec.c:258 Restore original codec.
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.511294 [DEBUG] switch_core_media.c:11114 sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21> skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.511294 [DEBUG] switch_core_session.c:2797 sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21> skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.511294 [DEBUG] switch_core_state_machine.c:609 (sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21>) State EXECUTE going to sleep
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.511294 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21>) Running State Change CS_HANGUP
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.511294 [DEBUG] switch_core_state_machine.c:809 (sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21>) Callstate Change ACTIVE -> HANGUP
> a377bf2e-d94c-4de2-abf0-03b84f7a540b 2016-09-19 07:42:27.511294 [DEBUG] switch_core_state_machine.c:811 (sofia/internal/nobody at 192.168.88.21 <mailto:sofia/internal/nobody at 192.168.88.21>) State HANGUP
>  
>  
>  
> And not session is established. The Hardware system only says: SIP_TRANSACTION_TIMEOUT and ends the call.
> So I think I have some codecs in common, but I have another problem why the call gets no answer.
> Can anyone point me in the right direction here?
>  
> Thanks in advance!
> Jürgen
>  
>  
> Von: freeswitch-users-bounces at lists.freeswitch.org [mailto:freeswitch-users-bounces at lists.freeswitch.org]Im Auftrag von Michael Jerris
> Gesendet: Freitag, 16. September 2016 17:20
> An: FreeSWITCH Users Help <freeswitch-users at lists.freeswitch.org>
> Betreff: Re: [Freeswitch-users] SIP Call from Videodevice
>  
> sure, as long as you have codecs in common it should be no problem.  Look at the logs to see why the call is failing.
> 
> On Friday, September 16, 2016, Jürgen Wendler <jw at vision-gmbh.de <mailto:jw at vision-gmbh.de>> wrote:
> Hello everyone,
>  
> i’m trying to make a SIP call from an external device (e.g. SONY or POLYCOM) to the “default” 3500 conference room which has the video-mcu-profile attached.
> When the call is ringing it does not appear to gets really connected.
> When I use X-Lite or another SIP softphone everything is working so far. But with external hardware devices I am not able to join the conference room.
> Does anyone have experience with calls from hardware videoconf systems via SIP to freeswitch?
>  
> Best Regards
> Jürgen
> _________________________________________________________________________
> Professional FreeSWITCH Consulting Services: 
> consulting at freeswitch.org <mailto:consulting at freeswitch.org>
> http://www.freeswitchsolutions.com <http://www.freeswitchsolutions.com/>
> 
> Official FreeSWITCH Sites
> http://www.freeswitch.org <http://www.freeswitch.org/>
> http://confluence.freeswitch.org <http://confluence.freeswitch.org/>
> http://www.cluecon.com <http://www.cluecon.com/>
> 
> FreeSWITCH-users mailing list
> FreeSWITCH-users at lists.freeswitch.org <mailto:FreeSWITCH-users at lists.freeswitch.org>
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users <http://lists.freeswitch.org/mailman/listinfo/freeswitch-users>
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users <http://lists.freeswitch.org/mailman/options/freeswitch-users>
> http://www.freeswitch.org <http://www.freeswitch.org/>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20160919/4cecf30d/attachment-0001.html

Join us at ClueCon 2016 Aug 8-12, 2016
More information about the FreeSWITCH-users mailing list