Early Media not delivering

Previous Topic Next Topic
 
classic Classic list List threaded Threaded
1 message Options
Reply | Threaded
Open this post in threaded view
|

Early Media not delivering

Florian Riedmaier | Callom GmbH

Hi, hope to get some help here.

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

 


_______________________________________________
Linphone-users mailing list
[hidden email]
https://lists.nongnu.org/mailman/listinfo/linphone-users