|
From: | Florian Riedmaier | Callom GmbH |
Subject: | Re: [Linphone-developers] Early Media not delivering |
Date: | Fri, 15 Nov 2019 12:02:45 +0000 |
Partly answering myself. What do I have to do, when LinphoneService receives State OutgoingEarlyMedia? I can see in the log, that there is no valid video stream defined? How can I define it? Found payload H264/90000 fmtp=packetization-mode=1;sprop-parameter-sets=Z0IAHqtAUB7I,aM44gA== Doing SDP offer/answer process of type outgoing Processing for stream 0 No matching stream for 0 Processing for stream 1 No matching stream for 1 CallSession [0x830f698c] moving from state State::OutgoingRinging to State::OutgoingEarlyMedia Linphone core [0x9a9de500] notified [call_state_changed] stop() called with 5376 frames delivered ms_filter_unlink: MSFilePlayer:0x9af6c7f8,0-->MSDtmfGen:0x9af6d240,0 ms_filter_unlink: MSDtmfGen:0x9af6d240,0-->MSResample:0x9af6d208,0 ms_filter_unlink: MSResample:0x9af6d208,0-->MSOpenSLESPlayer:0x9af6d0f0,0 Ring MSTicker thread exiting Doing early media... startStreams() CallSession=[0x830f698c] local upload_bandwidth=[0] kbit/s; local download_bandwidth=[0] kbit/s [Camera2 Capture] Filter postprocess ms_filter_unlink: MSAndroidCamera2Capture:0x9af6d828,0-->MSPixConv:0x9af6ddd8,0 ms_filter_unlink: MSPixConv:0x9af6ddd8,0-->MSTee:0x9af6d128,0 ms_filter_unlink: MSTee:0x9af6d128,1-->MSVoidSink:0x9af682d8,0 ms_filter_unlink: MSTee:0x9af6d128,2-->MSJpegWriter:0x9af6d0b8,0 Video MSTicker thread exiting [Camera2 Capture] Filter uninit No valid video stream defined Best regards, Flo Von: Linphone-developers <linphone-developers-bounces+florian.riedmaier=address@hidden> im Auftrag von Florian Riedmaier | Callom GmbH <address@hidden> Hi, hope to get some help here, I already posted in Users Section but I think this is more dev-related. I’m doing some tests with the sample app and fail to see early media video before the call gets answered. I’m doing the call without registration to a device which wants Early Media. Can someone send me a hint how to get early media video h264 enabled? Here is some log output, if more is needed please let me know. Thanks in advance Flo 2019-11-12 09:52:03.511 7345-7345/org.linphone.sample I/chatty: uid=10065(org.linphone.sample) expire 6 lines 2019-11-12 09:52:33.529 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0]: keep alive sent to [UDP://10.100.3.111:5060] 2019-11-12 09:52:40.774 7345-7345/org.linphone.sample I/Linphone Sample: New MediaSession [0x830f698c] initialized (LinphoneCore version: 3.12.0-3579-g37ec0fabd) 2019-11-12 09:52:40.786 7345-7345/org.linphone.sample I/Linphone Sample: CallSession [0x830f698c], stream type [audio], multicast role is [inactive] 2019-11-12 09:52:40.788 7345-7345/org.linphone.sample I/Linphone Sample: RtpSession bound to [::0] ports [4000] [4001] 2019-11-12 09:52:40.788 7345-7345/org.linphone.sample I/Linphone Sample: rtp_session_enable_network_simulation:DISABLING NETWORK SIMULATION 2019-11-12 09:52:40.790 7345-7345/org.linphone.sample I/Linphone Sample: Configured srtp crypto suite: AES_CM_128_HMAC_SHA1_80 2019-11-12 09:52:40.791 7345-7345/org.linphone.sample I/Linphone Sample: Configured srtp crypto suite: AES_CM_128_HMAC_SHA1_32 2019-11-12 09:52:40.791 7345-7345/org.linphone.sample I/Linphone Sample: Configured srtp crypto suite: AES_256_CM_HMAC_SHA1_80 2019-11-12 09:52:40.791 7345-7345/org.linphone.sample I/Linphone Sample: Configured srtp crypto suite: AES_256_CM_HMAC_SHA1_32 2019-11-12 09:52:40.791 7345-7345/org.linphone.sample I/Linphone Sample: Creating ZRTP engine on rtp session [0x9af36600] ssrc 0x33ff663a 2019-11-12 09:52:40.793 7345-7345/org.linphone.sample I/Linphone Sample: Setting DSCP to 46 for MSAudio stream. 2019-11-12 09:52:40.793 7345-7345/org.linphone.sample I/Linphone Sample: Equalizer location: hp 2019-11-12 09:52:40.798 7345-7345/org.linphone.sample I/Linphone Sample: cannot set noise gate mode to [0] because no volume send 2019-11-12 09:52:40.801 7345-7345/org.linphone.sample I/Linphone Sample: CallSession [0x830f698c], stream type [video], multicast role is [inactive] 2019-11-12 09:52:40.802 7345-7345/org.linphone.sample I/Linphone Sample: RtpSession bound to [::0] ports [4010] [4011] 2019-11-12 09:52:40.809 7345-7345/org.linphone.sample I/Linphone Sample: This device (freescale/VAR_SOM_MX6/imx6) says it has no built-in echo canceller. 2019-11-12 09:52:40.810 7345-7345/org.linphone.sample I/Linphone Sample: No information available for [freescale/VAR_SOM_MX6/imx6], 2019-11-12 09:52:40.810 7345-7345/org.linphone.sample I/Linphone Sample: Using android >= 8 sound device descriptor. 2019-11-12 09:52:40.810 7345-7345/org.linphone.sample I/Linphone Sample: Sound device information for [freescale/VAR_SOM_MX6/imx6] is: builtin=[yes], delay=[0] ms 2019-11-12 09:52:40.811 7345-7345/org.linphone.sample I/Linphone Sample: rtp_session_enable_network_simulation:DISABLING NETWORK SIMULATION 2019-11-12 09:52:40.811 7345-7345/org.linphone.sample I/Linphone Sample: Initializing multistream ZRTP context on rtp session [0x9af37400] ssrc 0x875fe094 2019-11-12 09:52:40.811 7345-7345/org.linphone.sample I/Linphone Sample: Setting DSCP to 0 for MSVideo stream. 2019-11-12 09:52:40.812 7345-7345/org.linphone.sample I/Linphone Sample: CallSession [0x830f698c], stream type [text], multicast role is [inactive] 2019-11-12 09:52:40.812 7345-7345/org.linphone.sample I/Linphone Sample: RtpSession bound to [::0] ports [11078] [11079] 2019-11-12 09:52:40.813 7345-7345/org.linphone.sample I/Linphone Sample: rtp_session_enable_network_simulation:DISABLING NETWORK SIMULATION 2019-11-12 09:52:40.813 7345-7345/org.linphone.sample I/Linphone Sample: Linphone core [0x9a9de500] notified [call_created] 2019-11-12 09:52:40.814 7345-7345/org.linphone.sample I/Linphone Sample: CallSession [0x830f698c] moving from state State::Idle to State::OutgoingInit 2019-11-12 09:52:40.815 7345-7345/org.linphone.sample I/Linphone Sample: [Platform Helper] acquireWifiLock() 2019-11-12 09:52:40.817 7345-7345/org.linphone.sample I/Linphone Sample: [Platform Helper] acquireMcastLock() 2019-11-12 09:52:40.820 7345-7345/org.linphone.sample I/Linphone Sample: [Platform Helper] acquireCpuLock() 2019-11-12 09:52:40.844 7345-7345/org.linphone.sample I/Linphone Sample: HEY, CallState is OutgoingInit 2019-11-12 09:52:40.845 7345-7345/org.linphone.sample I/Linphone Sample: Linphone core [0x9a9de500] notified [call_state_changed] 2019-11-12 09:52:40.849 7345-7345/org.linphone.sample I/Linphone Sample: Don't put text stream on local offer for CallSession [0x830f698c] 2019-11-12 09:52:40.849 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_link: MSRtpRecv:0x9af6c7f8,0-->MSVoidSink:0x9af6c8a0,0 2019-11-12 09:52:40.850 7345-7453/org.linphone.sample I/Linphone Sample: Priority used: 99 2019-11-12 09:52:40.851 7345-7453/org.linphone.sample I/Linphone Sample: MSAudio MSTicker priority increased to maximum. 2019-11-12 09:52:40.853 7345-7345/org.linphone.sample I/Linphone Sample: Contact has not been fixed, stack will do 2019-11-12 09:52:40.856 7345-7345/org.linphone.sample I/Linphone Sample: ["SIP Unit" <sip:sipunit@10.100.3.163:5060>] calling [sip:10.100.3.111] on op [0xa4cc0ec0] 2019-11-12 09:52:40.860 7345-7345/org.linphone.sample I/Linphone Sample: bellesip_wake_lock_acquire(): Android wake lock [belle-sip transaction(0xa4cb7190)] acquired [ref=0x2b02] 2019-11-12 09:52:40.861 7345-7345/org.linphone.sample I/Linphone Sample: transaction [0xa4cb7190]: starting transaction background task with id=[2b02]. 2019-11-12 09:52:40.861 7345-7345/org.linphone.sample I/Linphone Sample: Changing [client] [INVITE] transaction [0xa4cb7190], from state [INIT] to [CALLING] 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0]: message sent to [UDP://10.100.3.111:5060], size: [1405] bytes 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: INVITE sip:10.100.3.111 SIP/2.0 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: Via: SIP/2.0/UDP 10.100.3.163:5060;branch=z9hG4bK.ttDYOuLbv;rport 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: From: "SIP Unit" <sip:sipunit@10.100.3.163>;tag=XitOykd5K 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: To: sip:10.100.3.111 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: CSeq: 20 INVITE 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: Call-ID: PL1a~vys7U 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: Max-Forwards: 70 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: Supported: replaces, outbound, gruu 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: Content-Type: application/sdp 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: Content-Length: 821 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: Contact: "SIP Unit" <sip:sipunit@10.100.3.163;transport=udp>;+sip.instance="<urn:uuid:d4e06272-5065-008f-a116-1915910512dc>" 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: User-Agent: Unknown (belle-sip/1.7.0) 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: v=0 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: o=sipunit 2281 3983 IN IP4 10.100.3.163 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: s=Talk 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: c=IN IP4 10.100.3.163 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: t=0 0 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: m=audio 4000 RTP/AVP 0 96 97 98 99 8 101 100 102 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: a=rtpmap:96 opus/48000/2 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: a=fmtp:96 useinbandfec=1 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: a=rtpmap:97 PCMU/8000/2 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: a=rtpmap:98 speex/16000 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: a=fmtp:98 vbr=on 2019-11-12 09:52:40.862 7345-7345/org.linphone.sample I/Linphone Sample: a=rtpmap:99 speex/8000 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=fmtp:99 vbr=on 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtpmap:101 telephone-event/8000 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtpmap:100 telephone-event/48000 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtpmap:102 telephone-event/16000 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtcp-fb:* trr-int 5000 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtcp-fb:* ccm tmmbr 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: m=video 4010 RTP/AVP 96 97 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtpmap:96 H264/90000 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=fmtp:96 profile-level-id=42801F 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtpmap:97 VP8/90000 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtcp-fb:* trr-int 5000 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtcp-fb:* ccm tmmbr 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtcp-fb:96 nack pli 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtcp-fb:96 ccm fir 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtcp-fb:97 nack pli 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtcp-fb:97 nack sli 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtcp-fb:97 ack rpsi 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: a=rtcp-fb:97 ccm fir 2019-11-12 09:52:40.863 7345-7345/org.linphone.sample I/Linphone Sample: CallSession [0x830f698c] moving from state State::OutgoingInit to State::OutgoingProgress 2019-11-12 09:52:40.880 7345-7345/org.linphone.sample I/Linphone Sample: HEY, CallState is OutgoingProgress 2019-11-12 09:52:40.880 7345-7345/org.linphone.sample I/Linphone Sample: Linphone core [0x9a9de500] notified [call_state_changed] 2019-11-12 09:52:40.881 7345-7345/org.linphone.sample I/Linphone Sample: using Video Device Camera2Device1Facingfront 2019-11-12 09:52:40.899 7345-7345/org.linphone.sample I/Linphone Sample: bellesip_wake_lock_acquire(): Android wake lock [belle-sip recv channel] acquired [ref=0x2a72] 2019-11-12 09:52:40.902 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0]: starting recv background task with id=[2a72]. 2019-11-12 09:52:40.902 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0]: received [260] new bytes from [UDP://10.100.3.111:5060]: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.100.3.163:5060;branch=z9hG4bK.ttDYOuLbv;rport=5060 From: "SIP Unit" <sip:sipunit@10.100.3.163>;tag=XitOykd5K To: <sip:10.100.3.111> Call-ID: PL1a~vys7U CSeq: 20 INVITE User-Agent: eXosip/4.0.0 Content-Length: 0 2019-11-12 09:52:40.909 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0] [260] bytes parsed 2019-11-12 09:52:40.909 7345-7345/org.linphone.sample I/Linphone Sample: Found transaction matching response. 2019-11-12 09:52:40.909 7345-7345/org.linphone.sample I/Linphone Sample: Changing [client] [INVITE] transaction [0xa4cb7190], from state [CALLING] to [PROCEEDING] 2019-11-12 09:52:40.909 7345-7345/org.linphone.sample I/Linphone Sample: op [0xa4cc0ec0] : set_or_update_dialog() current=[0x0] new=[0x0] 2019-11-12 09:52:40.910 7345-7345/org.linphone.sample I/Linphone Sample: Op [0xa4cc0ec0] receiving call response [100], dialog is [0x0] in state [BELLE_SIP_DIALOG_NULL] 2019-11-12 09:52:40.911 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0]: ending recv background task with id=[2a72]. 2019-11-12 09:52:40.914 7345-7345/org.linphone.sample I/Linphone Sample: bellesip_wake_lock_release(): Android wake lock released [ref=0x2a72] 2019-11-12 09:52:40.918 7345-7345/org.linphone.sample I/Linphone Sample: bellesip_wake_lock_acquire(): Android wake lock [belle-sip recv channel] acquired [ref=0x2a6a] 2019-11-12 09:52:40.918 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0]: starting recv background task with id=[2a6a]. 2019-11-12 09:52:40.918 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0]: received [309] new bytes from [UDP://10.100.3.111:5060]: SIP/2.0 180 Ringing Via: SIP/2.0/UDP 10.100.3.163:5060;branch=z9hG4bK.ttDYOuLbv;rport=5060 From: "SIP Unit" <sip:sipunit@10.100.3.163>;tag=XitOykd5K To: <sip:10.100.3.111>;tag=663482644 Call-ID: PL1a~vys7U CSeq: 20 INVITE Contact: <sip:10.100.3.111:5060> User-Agent: eXosip/4.0.0 Content-Length: 0 2019-11-12 09:52:40.924 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0] [309] bytes parsed 2019-11-12 09:52:40.924 7345-7345/org.linphone.sample I/Linphone Sample: Found transaction matching response. 2019-11-12 09:52:40.925 7345-7345/org.linphone.sample I/Linphone Sample: New client dialog [0x9d306a20] , local tag [XitOykd5K], remote tag [663482644] 2019-11-12 09:52:40.925 7345-7345/org.linphone.sample I/Linphone Sample: Dialog [0x9d306a20]: now updated by transaction [0xa4cb7190]. 2019-11-12 09:52:40.926 7345-7345/org.linphone.sample I/Linphone Sample: op [0xa4cc0ec0] : set_or_update_dialog() current=[0x0] new=[0x9d306a20] 2019-11-12 09:52:40.926 7345-7345/org.linphone.sample I/Linphone Sample: Op [0xa4cc0ec0] receiving call response [180], dialog is [0x9d306a20] in state [BELLE_SIP_DIALOG_EARLY] 2019-11-12 09:52:40.926 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_unlink: MSRtpRecv:0x9af6c7f8,0-->MSVoidSink:0x9af6c8a0,0 2019-11-12 09:52:40.927 7345-7345/org.linphone.sample I/Linphone Sample: speex_lib_ctl init with neon ? 1 2019-11-12 09:52:40.927 7345-7345/org.linphone.sample I/Linphone Sample: Configuring resampler input with rate=[8000], nchannels=[1] 2019-11-12 09:52:40.927 7345-7345/org.linphone.sample I/Linphone Sample: MSFilePlayer[0x9af6c7f8]: /data/user/0/org.linphone.sample/files/share/sounds/linphone/ringback.wav opened: rate=8000,channel=1 2019-11-12 09:52:40.927 7345-7345/org.linphone.sample I/Linphone Sample: configuring resampler output to rate=[44100], nchannels=[1] 2019-11-12 09:52:40.928 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_link: MSFilePlayer:0x9af6c7f8,0-->MSDtmfGen:0x9af6d240,0 2019-11-12 09:52:40.928 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_link: MSDtmfGen:0x9af6d240,0-->MSResample:0x9af6d208,0 2019-11-12 09:52:40.928 7345-7455/org.linphone.sample I/Linphone Sample: Priority used: 99 2019-11-12 09:52:40.928 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_link: MSResample:0x9af6d208,0-->MSOpenSLESPlayer:0x9af6d0f0,0 2019-11-12 09:52:40.928 7345-7455/org.linphone.sample I/Linphone Sample: Ring MSTicker priority increased to maximum. 2019-11-12 09:52:40.928 7345-7345/org.linphone.sample I/Linphone Sample: Initializing speex resampler in mode [voip] 2019-11-12 09:52:40.930 7345-7345/org.linphone.sample I/libOpenSLES: Emulating old channel mask behavior (ignoring positional mask 0x4, using default mask 0x1 based on channel count of 1) 2019-11-12 09:52:40.932 7345-7345/org.linphone.sample I/AudioTrack: AUDIO_OUTPUT_FLAG_FAST successful; frameCount 384 -> 384 2019-11-12 09:52:40.932 7345-7345/org.linphone.sample D/AudioTrack: Client defaulted notificationFrames to 192 for frameCount 384 2019-11-12 09:52:40.935 7345-7345/org.linphone.sample I/Linphone Sample: Remote ringing... 2019-11-12 09:52:40.935 7345-7345/org.linphone.sample I/Linphone Sample: CallSession [0x830f698c] moving from state State::OutgoingProgress to State::OutgoingRinging 2019-11-12 09:52:40.951 7345-7345/org.linphone.sample I/Linphone Sample: HEY, CallState is OutgoingRinging 2019-11-12 09:52:40.952 7345-7345/org.linphone.sample I/Linphone Sample: Linphone core [0x9a9de500] notified [call_state_changed] 2019-11-12 09:52:40.952 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0]: ending recv background task with id=[2a6a]. 2019-11-12 09:52:40.954 7345-7345/org.linphone.sample I/Linphone Sample: bellesip_wake_lock_release(): Android wake lock released [ref=0x2a6a] 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: bellesip_wake_lock_acquire(): Android wake lock [belle-sip recv channel] acquired [ref=0x2a3a] 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0]: starting recv background task with id=[2a3a]. 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0]: received [581] new bytes from [UDP://10.100.3.111:5060]: 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: SIP/2.0 183 Session Progress 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: Via: SIP/2.0/UDP 10.100.3.163:5060;branch=z9hG4bK.ttDYOuLbv;rport=5060 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: From: "SIP Unit" <sip:sipunit@10.100.3.163>;tag=XitOykd5K 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: To: <sip:10.100.3.111>;tag=663482644 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: Call-ID: PL1a~vys7U 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: CSeq: 20 INVITE 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: Contact: <sip:10.100.3.111:5060> 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: Content-Type: application/sdp 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: User-Agent: eXosip/4.0.0 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: Content-Length:
228 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: v=0 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: o=g1 1573548762 1573548762 IN IP4 10.100.3.111 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: s=- 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: c=IN IP4 10.100.3.111 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: t=0 0 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: m=video 11500 RTP/AVP 103 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: a=rtpmap:103 H264/90000 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: a=fmtp:103 packetization-mode=1;sprop-parameter-sets=Z0IAHqtAUB7I,aM44gA== 2019-11-12 09:52:40.958 7345-7345/org.linphone.sample I/Linphone Sample: a=recvonly 2019-11-12 09:52:40.968 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0] [353] bytes parsed 2019-11-12 09:52:40.968 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0] read [228] bytes of body from [10.100.3.111:5060] 2019-11-12 09:52:40.969 7345-7345/org.linphone.sample I/Linphone Sample: Found transaction matching response. 2019-11-12 09:52:40.969 7345-7345/org.linphone.sample I/Linphone Sample: Dialog [0x9d306a20]: now updated by transaction [0xa4cb7190]. 2019-11-12 09:52:40.973 7345-7345/org.linphone.sample I/Linphone Sample: op [0xa4cc0ec0] : set_or_update_dialog() current=[0x9d306a20] new=[0x9d306a20] 2019-11-12 09:52:40.973 7345-7345/org.linphone.sample I/Linphone Sample: Op [0xa4cc0ec0] receiving call response [183], dialog is [0x9d306a20] in state [BELLE_SIP_DIALOG_EARLY] 2019-11-12 09:52:40.977 7345-7345/org.linphone.sample I/Linphone Sample: Found payload H264/90000 fmtp=packetization-mode=1;sprop-parameter-sets=Z0IAHqtAUB7I,aM44gA== 2019-11-12 09:52:40.977 7345-7345/org.linphone.sample I/Linphone Sample: Doing SDP offer/answer process of type outgoing 2019-11-12 09:52:40.978 7345-7345/org.linphone.sample I/Linphone Sample: Processing for stream 0 2019-11-12 09:52:40.978 7345-7345/org.linphone.sample W/Linphone Sample: No matching stream for 0 2019-11-12 09:52:40.978 7345-7345/org.linphone.sample I/Linphone Sample: Processing for stream 1 2019-11-12 09:52:40.978 7345-7345/org.linphone.sample W/Linphone Sample: No matching stream for 1 2019-11-12 09:52:40.979 7345-7345/org.linphone.sample I/Linphone Sample: CallSession [0x830f698c] moving from state State::OutgoingRinging to State::OutgoingEarlyMedia 2019-11-12 09:52:41.003 7345-7345/org.linphone.sample I/Linphone Sample: HEY, outgoing early media would be fine, early media is enabled? true, SendRecv 2019-11-12 09:52:41.004 7345-7345/org.linphone.sample I/Linphone Sample: Linphone core [0x9a9de500] notified [call_state_changed] 2019-11-12 09:52:41.004 7345-7345/org.linphone.sample D/AudioTrack: stop() called with 5376 frames delivered 2019-11-12 09:52:41.005 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_unlink: MSFilePlayer:0x9af6c7f8,0-->MSDtmfGen:0x9af6d240,0 2019-11-12 09:52:41.006 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_unlink: MSDtmfGen:0x9af6d240,0-->MSResample:0x9af6d208,0 2019-11-12 09:52:41.006 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_unlink: MSResample:0x9af6d208,0-->MSOpenSLESPlayer:0x9af6d0f0,0 2019-11-12 09:52:41.008 7345-7455/org.linphone.sample I/Linphone Sample: Ring MSTicker thread exiting 2019-11-12 09:52:41.009 7345-7345/org.linphone.sample I/Linphone Sample: Doing early media... 2019-11-12 09:52:41.009 7345-7345/org.linphone.sample I/Linphone Sample: startStreams() CallSession=[0x830f698c] local upload_bandwidth=[0] kbit/s; local download_bandwidth=[0] kbit/s 2019-11-12 09:52:41.009 7345-7345/org.linphone.sample I/Linphone Sample: [Camera2 Capture] Filter postprocess 2019-11-12 09:52:41.009 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_unlink: MSAndroidCamera2Capture:0x9af6d828,0-->MSPixConv:0x9af6ddd8,0 2019-11-12 09:52:41.009 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_unlink: MSPixConv:0x9af6ddd8,0-->MSTee:0x9af6d128,0 2019-11-12 09:52:41.009 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_unlink: MSTee:0x9af6d128,1-->MSVoidSink:0x9af682d8,0 2019-11-12 09:52:41.010 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_unlink: MSTee:0x9af6d128,2-->MSJpegWriter:0x9af6d0b8,0 2019-11-12 09:52:41.011 7345-7431/org.linphone.sample I/Linphone Sample: Video MSTicker thread exiting 2019-11-12 09:52:41.012 7345-7345/org.linphone.sample I/Linphone Sample: [Camera2 Capture] Filter uninit 2019-11-12 09:52:41.012 7345-7345/org.linphone.sample I/Linphone Sample: No valid video stream defined 2019-11-12 09:52:41.012 7345-7345/org.linphone.sample I/Linphone Sample: speex_lib_ctl init with neon ? 1 2019-11-12 09:52:41.013 7345-7345/org.linphone.sample I/Linphone Sample: Configuring resampler input with rate=[8000], nchannels=[1] 2019-11-12 09:52:41.013 7345-7345/org.linphone.sample I/Linphone Sample: MSFilePlayer[0x9af6d128]: /data/user/0/org.linphone.sample/files/share/sounds/linphone/ringback.wav opened: rate=8000,channel=1 2019-11-12 09:52:41.013 7345-7345/org.linphone.sample I/Linphone Sample: configuring resampler output to rate=[44100], nchannels=[1] 2019-11-12 09:52:41.013 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_link: MSFilePlayer:0x9af6d128,0-->MSDtmfGen:0x9af6ddd8,0 2019-11-12 09:52:41.013 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_link: MSDtmfGen:0x9af6ddd8,0-->MSResample:0x9af6d0b8,0 2019-11-12 09:52:41.013 7345-7345/org.linphone.sample I/Linphone Sample: ms_filter_link: MSResample:0x9af6d0b8,0-->MSOpenSLESPlayer:0x9af682d8,0 2019-11-12 09:52:41.014 7345-7345/org.linphone.sample I/Linphone Sample: Initializing speex resampler in mode [voip] 2019-11-12 09:52:41.014 7345-7458/org.linphone.sample I/Linphone Sample: Priority used: 99 2019-11-12 09:52:41.014 7345-7458/org.linphone.sample I/Linphone Sample: Ring MSTicker priority increased to maximum. 2019-11-12 09:52:41.015 7345-7345/org.linphone.sample I/libOpenSLES: Emulating old channel mask behavior (ignoring positional mask 0x4, using default mask 0x1 based on channel count of 1) 2019-11-12 09:52:41.016 7345-7345/org.linphone.sample I/AudioTrack: AUDIO_OUTPUT_FLAG_FAST successful; frameCount 384 -> 384 2019-11-12 09:52:41.016 7345-7345/org.linphone.sample D/AudioTrack: Client defaulted notificationFrames to 192 for frameCount 384 2019-11-12 09:52:41.019 7345-7345/org.linphone.sample I/Linphone Sample: channel [0x8121f8c0]: ending recv background task with id=[2a3a]. 2019-11-12 09:52:41.025 7345-7345/org.linphone.sample I/Linphone Sample: bellesip_wake_lock_release(): Android wake lock released [ref=0x2a3a] 2019-11-12 09:52:41.025 7345-7345/org.linphone.sample I/Linphone Sample: Garbage collecting unowned object of type belle_sdp_session_description_t 2019-11-12 09:52:41.528 7345-7345/org.linphone.sample I/Linphone Sample: Bandwidth usage for CallSession [0x830f698c]:
RTP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00,ed=0.00], text=[d=0.00,u=0.00] kbits/sec
RTCP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00], text=[d=0.00,u=0.00] kbits/sec 2019-11-12 09:52:41.528 7345-7345/org.linphone.sample I/Linphone Sample: Thread processing load: audio=0.0192305
video=0 text=0 2019-11-12 09:52:42.482 7345-7345/org.linphone.sample I/Linphone Sample: Bandwidth usage for CallSession [0x830f698c]:
RTP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00,ed=0.00], text=[d=0.00,u=0.00] kbits/sec
RTCP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00], text=[d=0.00,u=0.00] kbits/sec 2019-11-12 09:52:42.482 7345-7345/org.linphone.sample I/Linphone Sample: Thread processing load: audio=0.0165643
video=0 text=0 --------- beginning of system 2019-11-12 09:52:43.488 7345-7345/org.linphone.sample I/Linphone Sample: Bandwidth usage for CallSession [0x830f698c]:
RTP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00,ed=0.00], text=[d=0.00,u=0.00] kbits/sec
RTCP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00], text=[d=0.00,u=0.00] kbits/sec 2019-11-12 09:52:43.488 7345-7345/org.linphone.sample I/Linphone Sample: Thread processing load: audio=0.0186117
video=0 text=0 2019-11-12 09:52:44.477 7345-7345/org.linphone.sample I/Linphone Sample: Bandwidth usage for CallSession [0x830f698c]:
RTP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00,ed=0.00], text=[d=0.00,u=0.00] kbits/sec
RTCP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00], text=[d=0.00,u=0.00] kbits/sec 2019-11-12 09:52:44.477 7345-7345/org.linphone.sample I/Linphone Sample: Thread processing load: audio=0.0494753
video=0 text=0 2019-11-12 09:52:45.487 7345-7345/org.linphone.sample I/Linphone Sample: Bandwidth usage for CallSession [0x830f698c]:
RTP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00,ed=0.00], text=[d=0.00,u=0.00] kbits/sec
RTCP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00], text=[d=0.00,u=0.00] kbits/sec 2019-11-12 09:52:45.488 7345-7345/org.linphone.sample I/Linphone Sample: Thread processing load: audio=0.0201843
video=0 text=0 2019-11-12 09:52:46.481 7345-7345/org.linphone.sample I/Linphone Sample: Bandwidth usage for CallSession [0x830f698c]:
RTP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00,ed=0.00], text=[d=0.00,u=0.00] kbits/sec
RTCP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00], text=[d=0.00,u=0.00] kbits/sec 2019-11-12 09:52:46.481 7345-7345/org.linphone.sample I/Linphone Sample: Thread processing load: audio=0.0185275
video=0 text=0 2019-11-12 09:52:47.478 7345-7345/org.linphone.sample I/Linphone Sample: Bandwidth usage for CallSession [0x830f698c]:
RTP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00,ed=0.00], text=[d=0.00,u=0.00] kbits/sec
RTCP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00], text=[d=0.00,u=0.00] kbits/sec 2019-11-12 09:52:47.479 7345-7345/org.linphone.sample I/Linphone Sample: Thread processing load: audio=0.0182161
video=0 text=0 2019-11-12 09:52:48.488 7345-7345/org.linphone.sample I/Linphone Sample: Bandwidth usage for CallSession [0x830f698c]:
RTP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00,ed=0.00], text=[d=0.00,u=0.00] kbits/sec
RTCP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00], text=[d=0.00,u=0.00] kbits/sec 2019-11-12 09:52:48.488 7345-7345/org.linphone.sample I/Linphone Sample: Thread processing load: audio=0.0170001
video=0 text=0 2019-11-12 09:52:49.497 7345-7345/org.linphone.sample I/Linphone Sample: Bandwidth usage for CallSession [0x830f698c]:
RTP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00,ed=0.00], text=[d=0.00,u=0.00] kbits/sec
RTCP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00], text=[d=0.00,u=0.00] kbits/sec 2019-11-12 09:52:49.497 7345-7345/org.linphone.sample I/Linphone Sample: Thread processing load: audio=0.0178821
video=0 text=0 2019-11-12 09:52:50.481 7345-7345/org.linphone.sample I/Linphone Sample: Bandwidth usage for CallSession [0x830f698c]:
RTP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00,ed=0.00], text=[d=0.00,u=0.00] kbits/sec
RTCP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00], text=[d=0.00,u=0.00] kbits/sec 2019-11-12 09:52:50.482 7345-7345/org.linphone.sample I/Linphone Sample: Thread processing load: audio=0.0157053
video=0 text=0 2019-11-12 09:52:51.488 7345-7345/org.linphone.sample I/Linphone Sample: Bandwidth usage for CallSession [0x830f698c]:
RTP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00,ed=0.00], text=[d=0.00,u=0.00] kbits/sec
RTCP audio=[d=0.00,u=0.00], video=[d=0.00,u=0.00], text=[d=0.00,u=0.00] kbits/sec 2019-11-12 09:52:51.488 7345-7345/org.linphone.sample I/Linphone Sample: Thread processing load: audio=0.0572969
video=0 text=0 |
[Prev in Thread] | Current Thread | [Next in Thread] |