search

BelledonneCommunications / linphone-android

Linphone.org mirror for linphone-android (https://gitlab.linphone.org/BC/public/linphone-android)
https://linphone.org
GNU General Public License v3.0
1.11k stars 680 forks source link

video call #846

Closed elileo1 closed 4 years ago

elileo1 commented 4 years ago

sdk 4.2 can't switch camera .core.setVideoDevice(newDevice) . but it dose not response

Viish commented 4 years ago

Please attach library logs.

elileo1 commented 4 years ago

2019-11-30 11:45:16.380 26086-26086/hzhl.net.hlcall I/HLCall: Incoming call ringing for 1 seconds 2019-11-30 11:45:16.658 26086-26086/hzhl.net.hlcall I/HLCall: Found media local-ip from signaling. 2019-11-30 11:45:16.658 26086-26086/hzhl.net.hlcall I/HLCall: Don't put text stream on local offer for CallSession [0x7be7311018] 2019-11-30 11:45:16.659 26086-26086/hzhl.net.hlcall I/HLCall: Configuring prefered card sampling rate to [48000] 2019-11-30 11:45:16.659 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSRtpRecv:0x7be254ed00,0-->MSVoidSink:0x7be1eed900,0 2019-11-30 11:45:16.660 26086-26086/hzhl.net.hlcall I/HLCall: Accepting server transaction [0x7be728fe80] on op [0x7be6df6b00] 2019-11-30 11:45:16.660 26086-26302/hzhl.net.hlcall I/HLCall: Priority used: 99 2019-11-30 11:45:16.660 26086-26302/hzhl.net.hlcall I/HLCall: MSAudio MSTicker priority increased to maximum. 2019-11-30 11:45:16.660 26086-26086/hzhl.net.hlcall I/HLCall: Doing SDP offer/answer process of type incoming 2019-11-30 11:45:16.660 26086-26086/hzhl.net.hlcall I/HLCall: No match for CN/8000/1 2019-11-30 11:45:16.660 26086-26086/hzhl.net.hlcall I/HLCall: Doing offer/answer processing with specific provider for codec [H264] 2019-11-30 11:45:16.660 26086-26086/hzhl.net.hlcall I/HLCall: Doing offer/answer processing with specific provider for codec [H264] 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: message sent to [UDP://192.168.0.200:5060], size: [917] bytes 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: SIP/2.0 200 Ok 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: Via: SIP/2.0/UDP 192.168.0.200;rport;branch=z9hG4bKU22HNHK00jDcK 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: From: "8037" sip:8037@192.168.0.200;tag=aQNgN468epjaK 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: To: sip:8039@192.168.0.120:49841;transport=udp;tag=fLlL8z0 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: Call-ID: b3a97b2b-8e1b-1238-d898-00e24c6825f3 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: CSeq: 13007228 INVITE 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: User-Agent: Unknown (belle-sip/1.7.0) 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: Supported: replaces, outbound, gruu 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO, UPDATE 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: Contact: sip:8039@192.168.0.120:49841;transport=udp;expires=120;+sip.instance="" 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: Content-Type: application/sdp 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: Content-Length: 294 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: v=0 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: o=8039 2968 2266 IN IP4 192.168.0.120 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: s=Talk 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: c=IN IP4 192.168.0.120 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: t=0 0 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: m=audio 7078 RTP/AVP 0 8 101 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: a=rtpmap:101 telephone-event/8000 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: m=video 9078 RTP/AVP 98 99 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: a=rtpmap:98 H264/90000 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: a=fmtp:98 profile-level-id=42801F 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: a=rtpmap:99 H264/90000 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: a=fmtp:99 profile-level-id=42801F 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: Changing [server] [INVITE] transaction [0x7be728fe80], from state [PROCEEDING] to [ACCEPTED] 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: Dialog [0x7be726a400]: now updated by transaction [0x7be728fe80]. 2019-11-30 11:45:16.662 26086-26086/hzhl.net.hlcall I/HLCall: CallSession [0x7be7311018] moving from state State::IncomingReceived to State::Connected 2019-11-30 11:45:16.663 26086-26086/hzhl.net.hlcall D/MyTag: ┌──────────────────────────────────────────────────────────────────────────────────────────────────────────────── 2019-11-30 11:45:16.663 26086-26086/hzhl.net.hlcall D/MyTag: │ CallImpl.acceptWithParams (Call.java:-2) 2019-11-30 11:45:16.663 26086-26086/hzhl.net.hlcall D/MyTag: │ LinphoneService$1.onCallStateChanged (LinphoneService.java:160) 2019-11-30 11:45:16.664 26086-26086/hzhl.net.hlcall D/MyTag: ├┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄ 2019-11-30 11:45:16.664 26086-26086/hzhl.net.hlcall D/MyTag: │ state:Connected；Username:8037；message:Connected 2019-11-30 11:45:16.664 26086-26086/hzhl.net.hlcall D/MyTag: └──────────────────────────────────────────────────────────────────────────────────────────────────────────────── 2019-11-30 11:45:16.884 26086-26086/hzhl.net.hlcall E/HLCall: CallSession::acceptUpdate(): invalid state State::Connected to call this method 2019-11-30 11:45:16.885 26086-26086/hzhl.net.hlcall I/HLCall: Linphone core [0x7bf7348200] notified [call_state_changed] 2019-11-30 11:45:16.885 26086-26086/hzhl.net.hlcall I/HLCall: startStreams() CallSession=[0x7be7311018] local upload_bandwidth=[0] kbit/s; local download_bandwidth=[0] kbit/s 2019-11-30 11:45:16.885 26086-26086/hzhl.net.hlcall I/HLCall: Audio bandwidth for CallSession [0x7be7311018] is 80 2019-11-30 11:45:16.885 26086-26086/hzhl.net.hlcall W/HLCall: CallSession [0x7be7311018] - advanced adaptive rate control requested but avpf is not activated in this stream. Reverting to basic rate control instead 2019-11-30 11:45:16.885 26086-26086/hzhl.net.hlcall I/HLCall: RtpSession [0x7be25c9800] sending to rtp [::ffff:192.168.0.200]:26486 rtcp [::ffff:192.168.0.200]:26487 2019-11-30 11:45:16.885 26086-26086/hzhl.net.hlcall I/HLCall: Stun packet sent for session [0x7be25c9800] 2019-11-30 11:45:16.885 26086-26086/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:16.886 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_unlink: MSRtpRecv:0x7be254ed00,0-->MSVoidSink:0x7be1eed900,0 2019-11-30 11:45:16.886 26086-26086/hzhl.net.hlcall I/HLCall: speex_lib_ctl init with neon ? 1 2019-11-30 11:45:16.886 26086-26086/hzhl.net.hlcall I/HLCall: speex_lib_ctl init with neon ? 1 2019-11-30 11:45:16.886 26086-26086/hzhl.net.hlcall I/HLCall: MKVRecorder: initialisation 2019-11-30 11:45:16.886 26086-26086/hzhl.net.hlcall I/HLCall: speex_lib_ctl init with neon ? 1 2019-11-30 11:45:16.886 26086-26086/hzhl.net.hlcall I/HLCall: Configuring av recorder with audio format type=audio;encoding=opus;rate=48000;channels=1;fmtp='' 2019-11-30 11:45:16.886 26086-26086/hzhl.net.hlcall I/HLCall: MKVRecorder: set pin #1 format. type=audio;encoding=opus;rate=48000;channels=1;fmtp='' 2019-11-30 11:45:16.886 26086-26086/hzhl.net.hlcall I/HLCall: target bitrate not set for stream [0x7be705b200] using payload's bitrate is 80000 2019-11-30 11:45:16.886 26086-26086/hzhl.net.hlcall I/HLCall: Setting audio encoder network bitrate to [80000] on stream [0x7be705b200] 2019-11-30 11:45:16.886 26086-26086/hzhl.net.hlcall I/HLCall: MSUlawEnc want ptime=20 2019-11-30 11:45:16.893 26086-26086/hzhl.net.hlcall I/HLCall: This device (Xiaomi/MI 8/sdm845) declares it has a built-in echo canceller. 2019-11-30 11:45:16.893 26086-26086/hzhl.net.hlcall I/HLCall: No information available for [Xiaomi/MI 8/sdm845], 2019-11-30 11:45:16.894 26086-26086/hzhl.net.hlcall I/HLCall: Using android >= 8 sound device descriptor. 2019-11-30 11:45:16.894 26086-26086/hzhl.net.hlcall I/HLCall: Sound device information for [Xiaomi/MI 8/sdm845] is: builtin=[yes], delay=[0] ms 2019-11-30 11:45:16.896 26086-26086/hzhl.net.hlcall I/HLCall: This device (Xiaomi/MI 8/sdm845) declares it has a built-in echo canceller. 2019-11-30 11:45:16.896 26086-26086/hzhl.net.hlcall I/HLCall: No information available for [Xiaomi/MI 8/sdm845], 2019-11-30 11:45:16.896 26086-26086/hzhl.net.hlcall I/HLCall: Using android >= 8 sound device descriptor. 2019-11-30 11:45:16.896 26086-26086/hzhl.net.hlcall I/HLCall: Sound device information for [Xiaomi/MI 8/sdm845] is: builtin=[yes], delay=[0] ms 2019-11-30 11:45:16.896 26086-26086/hzhl.net.hlcall I/HLCall: MSVolume set gain to [0.000000 db], [1.000000] linear 2019-11-30 11:45:16.898 26086-26086/hzhl.net.hlcall I/HLCall: This device (Xiaomi/MI 8/sdm845) declares it has a built-in echo canceller. 2019-11-30 11:45:16.898 26086-26086/hzhl.net.hlcall I/HLCall: No information available for [Xiaomi/MI 8/sdm845], 2019-11-30 11:45:16.898 26086-26086/hzhl.net.hlcall I/HLCall: Using android >= 8 sound device descriptor. 2019-11-30 11:45:16.898 26086-26086/hzhl.net.hlcall I/HLCall: Sound device information for [Xiaomi/MI 8/sdm845] is: builtin=[yes], delay=[0] ms 2019-11-30 11:45:16.898 26086-26086/hzhl.net.hlcall I/HLCall: MSVolume set gain to [0.000000 db], [1.000000] linear 2019-11-30 11:45:16.898 26086-26086/hzhl.net.hlcall I/HLCall: configuring MSAAudioRecorder:0x7be254ed00-->MSUlawEnc:0x7be1eeda80 from rate [48000] to rate [8000] and from channel [1] to channel [1] 2019-11-30 11:45:16.898 26086-26086/hzhl.net.hlcall I/HLCall: configuring MSUlawDec:0x7be1eedb00-->MSAAudioPlayer:0x7be1eed900 from rate [8000] to rate [48000] and from channel [1] to channel [1] 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSAAudioRecorder:0x7be254ed00,0-->MSResample:0x7be1eedc00,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSResample:0x7be1eedc00,0-->MSEqualizer:0x7be6e34280,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSEqualizer:0x7be6e34280,0-->MSVolume:0x7be259c880,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSVolume:0x7be259c880,0-->MSAudioMixer:0x7be1eedd00,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSAudioMixer:0x7be1eedd00,0-->MSUlawEnc:0x7be1eeda80,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSUlawEnc:0x7be1eeda80,0-->MSRtpSend:0x7be259c800,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSRtpRecv:0x7be259c100,0-->MSUlawDec:0x7be1eedb00,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSUlawDec:0x7be1eedb00,0-->MSGenericPLC:0x7be6e34380,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSGenericPLC:0x7be6e34380,0-->MSAudioFlowControl:0x7be6e34400,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSAudioFlowControl:0x7be6e34400,0-->MSDtmfGen:0x7be6dc8f00,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSDtmfGen:0x7be6dc8f00,0-->MSVolume:0x7be1eedb80,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSVolume:0x7be1eedb80,0-->MSTee:0x7be1eede80,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSTee:0x7be1eede80,0-->MSEqualizer:0x7be6e34300,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSEqualizer:0x7be6e34300,0-->MSAudioMixer:0x7be6e34480,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: speex_lib_ctl init with neon ? 1 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSFilePlayer:0x7be6e34500,0-->MSResample:0x7be6e34580,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSResample:0x7be6e34580,0-->MSAudioMixer:0x7be6e34480,1 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSAudioMixer:0x7be6e34480,0-->MSResample:0x7be1eedc80,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSResample:0x7be1eedc80,0-->MSAAudioPlayer:0x7be1eed900,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSAudioMixer:0x7be1eede00,1-->MSResample:0x7be6e34180,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSResample:0x7be6e34180,0-->MSOpusEnc:0x7be6e34200,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSOpusEnc:0x7be6e34200,0-->MSMKVRecorder:0x7be1eedf00,1 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSItcSource:0x7be1eedf80,0-->MSMKVRecorder:0x7be1eedf00,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSAudioMixer:0x7be1eedd00,1-->MSAudioMixer:0x7be1eede00,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSTee:0x7be1eede80,1-->MSAudioMixer:0x7be1eede00,1 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSAudioMixer:0x7be1eede00,0-->MSFileRec:0x7be1eedd80,0 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: [AAudio] Asking for a session ID so we can use echo canceller 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall I/HLCall: [AAudio] Record stream configured with samplerate 48000 and 1 channels 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall D/AAudio: AAudioStreamBuilder_openStream() called ---------------------------------------- 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall D/AudioStreamBuilder: build() EXCLUSIVE sharing mode not supported. Use SHARED. 2019-11-30 11:45:16.899 26086-26086/hzhl.net.hlcall D/AudioStreamBuilder: build() MMAP not available because sessionId used. 2019-11-30 11:45:16.901 26086-26086/hzhl.net.hlcall I/AAudioStream: open() rate = 48000, channels = 1, format = 1, sharing = SH, dir = INPUT 2019-11-30 11:45:16.901 26086-26086/hzhl.net.hlcall I/AAudioStream: open() device = 0, sessionId = 0, perfMode = 12, callback: ON with frames = 0 2019-11-30 11:45:16.901 26086-26086/hzhl.net.hlcall I/AAudioStream: open() usage = 2, contentType = 1, inputPreset = 7 2019-11-30 11:45:16.901 26086-26086/hzhl.net.hlcall D/AudioRecord: set(): inputSource 0, sampleRate 48000, format 0x1, channelMask 0x10, frameCount 0, notificationFrames 0, sessionId 0, transferType 1, flags 0x5, opPackageName uid -1, pid -1 2019-11-30 11:45:16.917 26086-26086/hzhl.net.hlcall W/AudioStreamRecord: open() flags changed from 0x00000005 to 0x00000000 2019-11-30 11:45:16.917 26086-26086/hzhl.net.hlcall W/AudioStreamRecord: open() perfMode changed from 12 to 10 2019-11-30 11:45:16.918 26086-26086/hzhl.net.hlcall D/AAudio: AAudioStreamBuilder_openStream() returns 0 = AAUDIO_OK for (0x7be7310040) ---------------- 2019-11-30 11:45:16.918 26086-26086/hzhl.net.hlcall I/HLCall: [AAudio] Recorder stream opened 2019-11-30 11:45:16.918 26086-26086/hzhl.net.hlcall D/AAudio: AAudioStream_requestStart(0x7be7310040) called -------------- 2019-11-30 11:45:16.924 26086-26086/hzhl.net.hlcall D/AAudio: AAudioStream_requestStart(0x7be7310040) returned 0 --------- 2019-11-30 11:45:16.924 26086-26086/hzhl.net.hlcall I/HLCall: [AAudio] Recorder stream started 2019-11-30 11:45:16.924 26086-26086/hzhl.net.hlcall I/HLCall: [AAudio] Session ID is 21489, hardware echo canceller can be enabled 2019-11-30 11:45:16.924 26086-26157/hzhl.net.hlcall D/AudioStreamLegacy: onAudioDeviceUpdate() deviceId 14 2019-11-30 11:45:16.928 26086-26086/hzhl.net.hlcall I/HLCall: AcousticEchoCanceler successfully created. 2019-11-30 11:45:16.929 26086-26086/hzhl.net.hlcall I/HLCall: AcousticEchoCanceler enabled: 1 2019-11-30 11:45:16.929 26086-26086/hzhl.net.hlcall W/HLCall: AcousticEchoCanceler already enabled 2019-11-30 11:45:16.929 26086-26086/hzhl.net.hlcall I/HLCall: [AAudio] Hardware echo canceller enabled 2019-11-30 11:45:16.929 26086-26086/hzhl.net.hlcall I/HLCall: Initializing speex resampler in mode [voip] 2019-11-30 11:45:16.929 26086-26086/hzhl.net.hlcall I/chatty: uid=10302(hzhl.net.hlcall) identical 1 line 2019-11-30 11:45:16.929 26086-26086/hzhl.net.hlcall I/HLCall: Initializing speex resampler in mode [voip] 2019-11-30 11:45:16.929 26086-26086/hzhl.net.hlcall I/HLCall: [AAudio] Using COMMUNICATION mode 2019-11-30 11:45:16.929 26086-26086/hzhl.net.hlcall I/HLCall: [AAudio] Player stream configured with samplerate 48000 and 1 channels 2019-11-30 11:45:16.929 26086-26086/hzhl.net.hlcall D/AAudio: AAudioStreamBuilder_openStream() called ---------------------------------------- 2019-11-30 11:45:16.929 26086-26086/hzhl.net.hlcall D/AudioStreamBuilder: build() EXCLUSIVE sharing mode not supported. Use SHARED. 2019-11-30 11:45:16.930 26086-26086/hzhl.net.hlcall I/AAudioStream: open() rate = 48000, channels = 1, format = 1, sharing = SH, dir = OUTPUT 2019-11-30 11:45:16.930 26086-26086/hzhl.net.hlcall I/AAudioStream: open() device = 0, sessionId = 0, perfMode = 12, callback: ON with frames = 0 2019-11-30 11:45:16.930 26086-26086/hzhl.net.hlcall I/AAudioStream: open() usage = 2, contentType = 1, inputPreset = 6 2019-11-30 11:45:16.930 26086-26086/hzhl.net.hlcall D/AudioStreamTrack: open(), request notificationFrames = -8, frameCount = 0 2019-11-30 11:45:16.930 26086-26086/hzhl.net.hlcall D/AudioTrack: set(): streamType -1, sampleRate 48000, format 0x1, channelMask 0x1, frameCount 0, flags #104, notificationFrames -8, sessionId 0, transferType 1, uid -1, pid -1 2019-11-30 11:45:16.981 26086-26086/hzhl.net.hlcall W/AudioTrack: AUDIO_OUTPUT_FLAG_FAST denied by server; frameCount 0 -> 1924 2019-11-30 11:45:16.982 26086-26086/hzhl.net.hlcall W/AudioStreamTrack: open() flags changed from 0x00000104 to 0x00000000 2019-11-30 11:45:16.982 26086-26086/hzhl.net.hlcall W/AudioStreamTrack: open() perfMode changed from 12 to 10 2019-11-30 11:45:16.982 26086-26086/hzhl.net.hlcall D/AAudio: AAudioStreamBuilder_openStream() returns 0 = AAUDIO_OK for (0x7be7355a80) ---------------- 2019-11-30 11:45:16.983 26086-26086/hzhl.net.hlcall I/HLCall: [AAudio] Player stream opened 2019-11-30 11:45:16.983 26086-26086/hzhl.net.hlcall D/AAudio: AAudioStream_requestStart(0x7be7355a80) called -------------- 2019-11-30 11:45:17.016 26086-26303/hzhl.net.hlcall I/HLCall: ms_ticker_set_time_func: ticker's time method updated. 2019-11-30 11:45:17.017 26086-26086/hzhl.net.hlcall D/AAudio: AAudioStream_requestStart(0x7be7355a80) returned 0 --------- 2019-11-30 11:45:17.017 26086-26086/hzhl.net.hlcall I/HLCall: [AAudio] Player stream started 2019-11-30 11:45:17.017 26086-26086/hzhl.net.hlcall I/HLCall: Initializing speex resampler in mode [voip] 2019-11-30 11:45:17.017 26086-26086/hzhl.net.hlcall I/HLCall: MSOpusEnc: codec bitrate set to [30000] with ptime [20] 2019-11-30 11:45:17.017 26086-26086/hzhl.net.hlcall I/HLCall: Setting opus codec bitrate to [30000] from network bitrate [46000] with ptime [20] 2019-11-30 11:45:17.017 26086-26157/hzhl.net.hlcall D/AudioStreamLegacy: onAudioDeviceUpdate() deviceId 2 2019-11-30 11:45:17.017 26086-26086/hzhl.net.hlcall I/HLCall: Filter MSRtpRecv is already being scheduled; nothing to do. 2019-11-30 11:45:17.020 26086-26302/hzhl.net.hlcall I/HLCall: MSAudioMixer [0x7be1eedd00] is entering bypass mode. 2019-11-30 11:45:17.021 26086-26086/hzhl.net.hlcall I/HLCall: This device (Xiaomi/MI 8/sdm845) declares it has a built-in echo canceller. 2019-11-30 11:45:17.021 26086-26086/hzhl.net.hlcall I/HLCall: No information available for [Xiaomi/MI 8/sdm845], 2019-11-30 11:45:17.021 26086-26086/hzhl.net.hlcall I/HLCall: Using android >= 8 sound device descriptor. 2019-11-30 11:45:17.021 26086-26086/hzhl.net.hlcall I/HLCall: Sound device information for [Xiaomi/MI 8/sdm845] is: builtin=[yes], delay=[0] ms 2019-11-30 11:45:17.021 26086-26086/hzhl.net.hlcall I/HLCall: MSVolume set gain to [0.000000 db], [1.000000] linear 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: This device (Xiaomi/MI 8/sdm845) declares it has a built-in echo canceller. 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: No information available for [Xiaomi/MI 8/sdm845], 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: Using android >= 8 sound device descriptor. 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: Sound device information for [Xiaomi/MI 8/sdm845] is: builtin=[yes], delay=[0] ms 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: MSVolume set gain to [0.000000 db], [1.000000] linear 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: audio_stream_link_video() connecting itc filters 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: Setting video size 640x480 on stream [0x7be1faff80] 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall W/HLCall: CallSession [0x7be7311018] - advanced adaptive rate control requested but avpf is not activated in this stream. Reverting to basic rate control instead 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: startVideoStream: device_rotation=0 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Creating filter for camera Camera2Device1Facingfront 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Filter init 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: RtpSession [0x7be25cac00] sending to rtp [::ffff:192.168.0.200]:24114 rtcp [::ffff:192.168.0.200]:24115 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: Using permissive algorithm 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall W/HLCall: Fail to increase socket's recv buffer size with SO_RCVBUFFORCE: Operation not permitted. 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall W/HLCall: Fail to increase socket's send buffer size with SO_SNDBUFFORCE: Operation not permitted. 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall W/HLCall: Fail to increase socket's recv buffer size with SO_RCVBUFFORCE: Operation not permitted. 2019-11-30 11:45:17.025 26086-26086/hzhl.net.hlcall I/HLCall: Stun packet sent for session [0x7be25cac00] 2019-11-30 11:45:17.026 26086-26086/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:17.026 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent for session [0x7be25c9800] 2019-11-30 11:45:17.026 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:17.030 26086-26311/hzhl.net.hlcall I/OMXClient: IOmx service obtained 2019-11-30 11:45:17.038 26086-26086/hzhl.net.hlcall I/HLCall: Codec video/avc successfully created. 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: This device (Xiaomi/MI 8/sdm845) declares it has a built-in echo canceller. 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: No information available for [Xiaomi/MI 8/sdm845], 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: Using android >= 8 sound device descriptor. 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: Sound device information for [Xiaomi/MI 8/sdm845] is: builtin=[yes], delay=[0] ms 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: Using the default video configuration list 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: target and payload bitrates not set for stream [0x7be1faff80] using lowest configuration of preferred video size 640x480 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: Limiting bitrate of video encoder to 0 bits/s for stream [0x7be1faff80] 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: H26xEncoder: video configuration set (bitrate=128000b/s, fps=15.000000, vsize=352x288) 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: H26xEncoder: AVPF disabled 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Device rotation is 0 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] New native window id ptr is 0x3ec6, current one is 0x0 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Stopping capture 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall W/HLCall: [Camera2 Capture] Capture was already stopped, ignoring... 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] NativePreviewWindowId 0x3ec6 is a TextureView, let's get it's surfaceTexture first 2019-11-30 11:45:17.041 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Creating Surface from SurfaceTexture 0x85 2019-11-30 11:45:17.042 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Surface created: 0x3dfa 2019-11-30 11:45:17.042 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Starting capture 2019-11-30 11:45:17.042 26086-26086/hzhl.net.hlcall W/HLCall: [Camera2 Capture] Filter hasn't been fully configured yet, don't start 2019-11-30 11:45:17.042 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Stopping capture 2019-11-30 11:45:17.042 26086-26086/hzhl.net.hlcall W/HLCall: [Camera2 Capture] Capture was already stopped, ignoring... 2019-11-30 11:45:17.042 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Listing camera 1 configurations 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 2592, height 1940 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 2592, height 1458 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 2592, height 1296 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1920, height 1440 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1920, height 1080 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1600, height 1200 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1280, height 960 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1280, height 720 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1280, height 640 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 800, height 600 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 720, height 480 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 640, height 480 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 640, height 360 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 352, height 288 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 320, height 240 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 176, height 144 for requested format 35 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Found exact match for our required size of 640x480 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Starting capture 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Creating preview 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Opening camera 2019-11-30 11:45:17.043 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Opening camera 1 2019-11-30 11:45:17.053 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Image reader created 2019-11-30 11:45:17.053 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Capture window acquired 2019-11-30 11:45:17.196 26086-26302/hzhl.net.hlcall I/HLCall: First estimation 2019-11-30 11:45:17.217 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Capture started 2019-11-30 11:45:17.217 26086-26315/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Session is activated 0x7bdc943ee0 2019-11-30 11:45:17.217 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Previous preview size was 0/0, new size is 480/640 2019-11-30 11:45:17.217 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Getting preview size: 480x640 2019-11-30 11:45:17.217 26086-26086/hzhl.net.hlcall I/HLCall: Output video size adjusted to match camera resolution (480x640) 2019-11-30 11:45:17.217 26086-26086/hzhl.net.hlcall I/HLCall: Setting sent vsize=480x640, fps=15.000000 2019-11-30 11:45:17.217 26086-26086/hzhl.net.hlcall I/HLCall: H26xEncoder: video configuration set (bitrate=400000b/s, fps=15.000000, vsize=640x480) 2019-11-30 11:45:17.217 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSAndroidCamera2Capture:0x7be6e34b00,0-->MSPixConv:0x7bdc94d380,0 2019-11-30 11:45:17.217 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSPixConv:0x7bdc94d380,0-->MSTee:0x7be6e34c80,0 2019-11-30 11:45:17.217 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSTee:0x7be6e34c80,0-->MSMediaCodecH264Encoder:0x7be6e34b80,0 2019-11-30 11:45:17.217 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSMediaCodecH264Encoder:0x7be6e34b80,0-->MSRtpSend:0x7be259c980,0 2019-11-30 11:45:17.217 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSTee:0x7be6e34c80,2-->MSJpegWriter:0x7be6e34d80,0 2019-11-30 11:45:17.220 26086-26328/hzhl.net.hlcall I/OMXClient: IOmx service obtained 2019-11-30 11:45:17.228 26086-26086/hzhl.net.hlcall I/HLCall: Codec video/avc successfully created. 2019-11-30 11:45:17.228 26086-26086/hzhl.net.hlcall I/HLCall: MediaCodecDecoder: starting decoder with following parameters: {max-height=1920, color-format=2135033992, max-width=1920, mime=video/avc, width=240, priority=0, height=320} 2019-11-30 11:45:17.229 26086-26328/hzhl.net.hlcall I/ExtendedACodec: setupVideoDecoder() 2019-11-30 11:45:17.229 26086-26328/hzhl.net.hlcall I/ACodec: [OMX.qcom.video.decoder.avc] using color format 0x7fa30c04 in place of 0x7f420888 2019-11-30 11:45:17.230 26086-26328/hzhl.net.hlcall I/ExtendedACodec: Decoder will be in frame by frame mode 2019-11-30 11:45:17.247 26086-26086/hzhl.net.hlcall I/HLCall: MediaCodecDecoder: decoder successfully started. In-force parameters: {max-height=1920, color-format=2135033992, max-width=1920, mime=video/avc, width=240, priority=0, height=320} 2019-11-30 11:45:17.247 26086-26086/hzhl.net.hlcall I/HLCall: MediaCodecH264Decoder: got device info: { 'Xiaomi', 'MI 8', 'sdm845' } 2019-11-30 11:45:17.247 26086-26086/hzhl.net.hlcall E/HLCall: no such method on filter MSMediaCodecH264Decoder, fid=16389 method index=7 2019-11-30 11:45:17.247 26086-26086/hzhl.net.hlcall I/HLCall: H26xDecoder: disabling AVPF mode 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: H26xDecoder: freeze on error enabled 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall E/HLCall: no such method on filter MSAndroidTextureDisplay, fid=16387 method index=1 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: [TextureView Display] New window jobject ptr is 0x3e76, current one is 0x0 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall E/HLCall: no such method on filter MSAndroidTextureDisplay, fid=16387 method index=0 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSRtpRecv:0x7bdc94d880,0-->MSTee:0x7be259ca00,0 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSTee:0x7be259ca00,1-->MSItcSink:0x7be259ca80,0 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: Video ITC source updated. 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: Configuring av recorder with video format type=video;encoding=H264;vsize=0x0;fps=0.000000;fmtp='' 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: MKVRecorder: set pin #0 format. type=video;encoding=H264;vsize=0x0;fps=0.000000;fmtp='' 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: configure_itc(): format set to type=video;encoding=H264;vsize=0x0;fps=0.000000;fmtp='' 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSTee:0x7be259ca00,0-->MSMediaCodecH264Decoder:0x7bdc94d400,0 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSMediaCodecH264Decoder:0x7bdc94d400,0-->MSTee:0x7bdc94dc80,0 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSTee:0x7bdc94dc80,1-->MSJpegWriter:0x7bdc94dc00,0 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSTee:0x7bdc94dc80,0-->MSAndroidTextureDisplay:0x7bdc94d800,0 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSTee:0x7be6e34c80,1-->MSAndroidTextureDisplay:0x7bdc94d800,1 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Filter preprocess 2019-11-30 11:45:17.248 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] Initializing context 2019-11-30 11:45:17.248 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] Creating Surface from SurfaceTexture 0x3e76 2019-11-30 11:45:17.248 26086-26333/hzhl.net.hlcall I/HLCall: MSVideo MSTicker priority left to normal. 2019-11-30 11:45:17.248 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] Surface created: 0x3f16 2019-11-30 11:45:17.248 26086-26086/hzhl.net.hlcall I/HLCall: MediaCodecEncoder: configuring MediaCodec with the following parameters: {color-format=2135033992, i-frame-interval=20, level=512, mime=video/avc, latency=1, profile=1, width=480, bitrate-mode=1, bitrate=360000, priority=0, frame-rate=15, height=640} 2019-11-30 11:45:17.248 26086-26332/hzhl.net.hlcall D/libEGL: eglInitialize: enter 2019-11-30 11:45:17.248 26086-26332/hzhl.net.hlcall D/libEGL: eglInitialize: exit(res=1) 2019-11-30 11:45:17.249 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] Chosen format is 2 2019-11-30 11:45:17.249 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] Surface size is 1080x2159 2019-11-30 11:45:17.249 26086-26311/hzhl.net.hlcall I/ExtendedACodec: setupVideoEncoder() 2019-11-30 11:45:17.249 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c06 = 2141391878 2019-11-30 11:45:17.235 26086-26086/hzhl.net.hlcall W/Thread-15: type=1400 audit(0.0:38784): avc: denied { search } for name="ctx" dev="debugfs" ino=15815 scontext=u:r:untrusted_app:s0:c46,c257,c512,c768 tcontext=u:object_r:qti_debugfs:s0 tclass=dir permissive=0 2019-11-30 11:45:17.249 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c04 = 2141391876 2019-11-30 11:45:17.249 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c00 = 2141391872 2019-11-30 11:45:17.250 26086-26332/hzhl.net.hlcall I/HLCall: ogl_display_new : 0x7bdd56d900 2019-11-30 11:45:17.250 26086-26332/hzhl.net.hlcall I/HLCall: init opengles_display (1080 x 2159, gl initialized:0) 2019-11-30 11:45:17.250 26086-26332/hzhl.net.hlcall I/HLCall: resize opengles_display (1080 x 2159, gl initialized:0) 2019-11-30 11:45:17.250 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c09 = 2141391881 2019-11-30 11:45:17.250 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c0a = 2141391882 2019-11-30 11:45:17.250 26086-26332/hzhl.net.hlcall I/HLCall: OpenGL program info: [NO INFORMATION] 2019-11-30 11:45:17.250 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] Context initialized 2019-11-30 11:45:17.250 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c08 = 2141391880 2019-11-30 11:45:17.250 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c07 = 2141391879 2019-11-30 11:45:17.251 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7f000789 = 2130708361 2019-11-30 11:45:17.251 26086-26311/hzhl.net.hlcall I/ACodec: [OMX.qcom.video.encoder.avc] using color format 0x15 in place of 0x7f420888 2019-11-30 11:45:17.253 26086-26311/hzhl.net.hlcall I/ACodec: setupAVCEncoderParameters with [profile: Baseline] [level: Level31] 2019-11-30 11:45:17.254 26086-26311/hzhl.net.hlcall I/ACodec: [OMX.qcom.video.encoder.avc] cannot encode HDR static metadata. Ignoring. 2019-11-30 11:45:17.254 26086-26311/hzhl.net.hlcall I/ACodec: setupVideoEncoder succeeded 2019-11-30 11:45:17.254 26086-26311/hzhl.net.hlcall I/ExtendedACodec: [OMX.qcom.video.encoder.avc] configure, AMessage : AMessage(what = 'conf', target = 29) = { int32_t color-format = 2135033992 int32_t i-frame-interval = 20 int32_t level = 512 string mime = "video/avc" int32_t latency = 1 int32_t profile = 1 int32_t width = 480 int32_t bitrate-mode = 1 int32_t bitrate = 360000 int32_t priority = 0 int32_t frame-rate = 15 int32_t height = 640 int32_t encoder = 1 } 2019-11-30 11:45:17.259 26086-26086/hzhl.net.hlcall I/HLCall: MediaCodecEncoder: encoder successfully configured. In-force parameters: {max-bitrate=360000, mime=video/avc, width=480, bitrate=360000, frame-rate=15, height=640} 2019-11-30 11:45:17.266 26086-26086/hzhl.net.hlcall I/HLCall: MediaCodecEncoder: encoder successfully started 2019-11-30 11:45:17.266 26086-26086/hzhl.net.hlcall I/HLCall: Video ITC source updated. 2019-11-30 11:45:17.266 26086-26086/hzhl.net.hlcall I/HLCall: Configuring av recorder with video format type=video;encoding=H264;vsize=0x0;fps=0.000000;fmtp='' 2019-11-30 11:45:17.266 26086-26086/hzhl.net.hlcall I/HLCall: MKVRecorder: set pin #0 format. type=video;encoding=H264;vsize=0x0;fps=0.000000;fmtp='' 2019-11-30 11:45:17.266 26086-26086/hzhl.net.hlcall I/HLCall: Filter MSRtpRecv is already being scheduled; nothing to do. 2019-11-30 11:45:17.266 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Getting preview size: 480x640 2019-11-30 11:45:17.266 26086-26086/hzhl.net.hlcall I/HLCall: Resizing video preview to: 480x640 2019-11-30 11:45:17.266 26086-26086/hzhl.net.hlcall I/HLCall: [Platform Helper] Found CaptureTextureView, setting video capture size to 480x640 2019-11-30 11:45:17.266 26086-26086/hzhl.net.hlcall I/HLCall: [CaptureTextureView] Changing preview texture ratio to match 480x640 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall I/HLCall: CallSession[0x7be7311018] : payload type 0 PCMU/8000 fmtp= added to frozen list 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall I/HLCall: CallSession[0x7be7311018] : payload type 8 PCMA/8000 fmtp= added to frozen list 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall I/HLCall: CallSession[0x7be7311018] : payload type 101 telephone-event/8000 fmtp= added to frozen list 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall I/HLCall: CallSession[0x7be7311018] : payload type 98 H264/90000 fmtp=profile-level-id=42801F added to frozen list 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall I/HLCall: CallSession[0x7be7311018] : payload type 99 H264/90000 fmtp=profile-level-id=42801F added to frozen list 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall I/HLCall: CallSession [0x7be7311018] moving from state State::Connected to State::StreamsRunning 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall D/MyTag: ┌──────────────────────────────────────────────────────────────────────────────────────────────────────────────── 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall D/MyTag: │ CallImpl.acceptWithParams (Call.java:-2) 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall D/MyTag: │ LinphoneService$1.onCallStateChanged (LinphoneService.java:160) 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall D/MyTag: ├┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄ 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall D/MyTag: │ state:StreamsRunning；Username:8037；message:Connected (streams running) 2019-11-30 11:45:17.267 26086-26086/hzhl.net.hlcall D/MyTag: └──────────────────────────────────────────────────────────────────────────────────────────────────────────────── 2019-11-30 11:45:17.268 26086-26086/hzhl.net.hlcall I/HLCall: Linphone core [0x7bf7348200] notified [call_state_changed] 2019-11-30 11:45:17.268 26086-26086/hzhl.net.hlcall I/HLCall: CallSession accepted 2019-11-30 11:45:17.268 26086-26086/hzhl.net.hlcall D/MyTag: ┌──────────────────────────────────────────────────────────────────────────────────────────────────────────────── 2019-11-30 11:45:17.268 26086-26086/hzhl.net.hlcall D/MyTag: │ CallRingActivity.onClickVoid (CallRingActivity.java:535) 2019-11-30 11:45:17.268 26086-26086/hzhl.net.hlcall D/MyTag: │ CallRingActivity.answer (CallRingActivity.java:1071) 2019-11-30 11:45:17.268 26086-26086/hzhl.net.hlcall D/MyTag: ├┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄┄ 2019-11-30 11:45:17.268 26086-26086/hzhl.net.hlcall D/MyTag: │ acceptWithParams 2019-11-30 11:45:17.268 26086-26086/hzhl.net.hlcall D/MyTag: └──────────────────────────────────────────────────────────────────────────────────────────────────────────────── 2019-11-30 11:45:17.268 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent for session [0x7be25cac00] 2019-11-30 11:45:17.269 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:17.270 26086-26086/hzhl.net.hlcall V/MediaPlayer: resetDrmState: mDrmInfo=null mDrmProvisioningThread=null mPrepareDrmInProgress=false mActiveDrmScheme=false 2019-11-30 11:45:17.270 26086-26086/hzhl.net.hlcall V/MediaPlayer: cleanDrmObj: mDrmObj=null mDrmSessionId=null 2019-11-30 11:45:17.298 26086-26086/hzhl.net.hlcall I/HLCall: bellesip_wake_lock_acquire(): Android wake lock [belle-sip recv channel] acquired [ref=0x3be6] 2019-11-30 11:45:17.299 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: starting recv background task with id=[3be6]. 2019-11-30 11:45:17.299 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: received [392] new bytes from [UDP://192.168.0.200:5060]: ACK sip:8039@192.168.0.120:49841;transport=udp SIP/2.0 Via: SIP/2.0/UDP 192.168.0.200;rport;branch=z9hG4bKvBvaQc43XU3ye Max-Forwards: 70 From: "8037" sip:8037@192.168.0.200;tag=aQNgN468epjaK To: sip:8039@192.168.0.120:49841;transport=udp;tag=fLlL8z0 Call-ID: b3a97b2b-8e1b-1238-d898-00e24c6825f3 CSeq: 13007228 ACK Contact: sip:mod_sofia@192.168.0.200:5060 Content-Length: 0 2019-11-30 11:45:17.302 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980] [392] bytes parsed 2019-11-30 11:45:17.302 26086-26086/hzhl.net.hlcall I/HLCall: Incoming INVITE has ACK, dialog is happy 2019-11-30 11:45:17.303 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: ending recv background task with id=[3be6]. 2019-11-30 11:45:17.303 26086-26086/hzhl.net.hlcall I/HLCall: bellesip_wake_lock_release(): Android wake lock released [ref=0x3be6] 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: bellesip_wake_lock_acquire(): Android wake lock [belle-sip recv channel] acquired [ref=0x3f26] 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: starting recv background task with id=[3f26]. 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: received [720] new bytes from [UDP://192.168.0.200:5060]: 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: INFO sip:8039@192.168.0.120:49841;transport=udp SIP/2.0 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: Via: SIP/2.0/UDP 192.168.0.200;rport;branch=z9hG4bKXmN3r7m7t4SHa 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: Max-Forwards: 70 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: From: "8037" sip:8037@192.168.0.200;tag=aQNgN468epjaK 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: To: sip:8039@192.168.0.120:49841;transport=udp;tag=fLlL8z0 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: Call-ID: b3a97b2b-8e1b-1238-d898-00e24c6825f3 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: CSeq: 13007229 INFO 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: Contact: sip:mod_sofia@192.168.0.200:5060 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: User-Agent: Uhope_dispatch 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE 2019-11-30 11:45:17.304 26086-26086/hzhl.net.hlcall I/HLCall: Supported: timer, path, replaces 2019-11-30 11:45:17.305 26086-26086/hzhl.net.hlcall I/HLCall: Content-Type: application/media_control+xml 2019-11-30 11:45:17.305 26086-26086/hzhl.net.hlcall I/HLCall: Content-Length: 107 2019-11-30 11:45:17.305 26086-26086/hzhl.net.hlcall I/HLCall: 2019-11-30 11:45:17.307 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980] [613] bytes parsed 2019-11-30 11:45:17.307 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980] read [107] bytes of body from [192.168.0.200:5060] 2019-11-30 11:45:17.308 26086-26086/hzhl.net.hlcall I/HLCall: bellesip_wake_lock_acquire(): Android wake lock [belle-sip transaction(0x7bdc944480)] acquired [ref=0x3f46] 2019-11-30 11:45:17.309 26086-26086/hzhl.net.hlcall I/HLCall: transaction [0x7bdc944480]: starting transaction background task with id=[3f46]. 2019-11-30 11:45:17.309 26086-26086/hzhl.net.hlcall I/HLCall: Changing [server] [INFO] transaction [0x7bdc944480], from state [INIT] to [TRYING] 2019-11-30 11:45:17.309 26086-26086/hzhl.net.hlcall I/HLCall: Receiving VFU request on op [0x7be6df6b00] 2019-11-30 11:45:17.309 26086-26086/hzhl.net.hlcall I/HLCall: H26xEncoder: VFU requested 2019-11-30 11:45:17.309 26086-26086/hzhl.net.hlcall I/HLCall: Changing [server] [INFO] transaction [0x7bdc944480], from state [TRYING] to [COMPLETED] 2019-11-30 11:45:17.309 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: message sent to [UDP://192.168.0.200:5060], size: [347] bytes SIP/2.0 200 Ok Via: SIP/2.0/UDP 192.168.0.200;rport;branch=z9hG4bKXmN3r7m7t4SHa From: "8037" sip:8037@192.168.0.200;tag=aQNgN468epjaK To: sip:8039@192.168.0.120:49841;transport=udp;tag=fLlL8z0 Call-ID: b3a97b2b-8e1b-1238-d898-00e24c6825f3 CSeq: 13007229 INFO User-Agent: Unknown (belle-sip/1.7.0) Supported: replaces, outbound, gruu 2019-11-30 11:45:17.309 26086-26086/hzhl.net.hlcall I/HLCall: Dialog [0x7be726a400]: now updated by transaction [0x7bdc944480]. 2019-11-30 11:45:17.309 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: ending recv background task with id=[3f26]. 2019-11-30 11:45:17.309 26086-26086/hzhl.net.hlcall I/HLCall: bellesip_wake_lock_release(): Android wake lock released [ref=0x3f26] 2019-11-30 11:45:17.313 26086-26086/hzhl.net.hlcall W/Looper: Slow Looper: doFrame is 412ms late because of 17 msg, msg 1 took 646ms (h=android.view.ViewRootImpl$ViewRootHandler c=android.view.View$PerformClick) 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: bellesip_wake_lock_acquire(): Android wake lock [belle-sip recv channel] acquired [ref=0x3f56] 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: starting recv background task with id=[3f56]. 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: received [720] new bytes from [UDP://192.168.0.200:5060]: 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: INFO sip:8039@192.168.0.120:49841;transport=udp SIP/2.0 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: Via: SIP/2.0/UDP 192.168.0.200;rport;branch=z9hG4bKZ67mvXpeNp6pH 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: Max-Forwards: 70 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: From: "8037" sip:8037@192.168.0.200;tag=aQNgN468epjaK 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: To: sip:8039@192.168.0.120:49841;transport=udp;tag=fLlL8z0 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: Call-ID: b3a97b2b-8e1b-1238-d898-00e24c6825f3 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: CSeq: 13007230 INFO 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: Contact: sip:mod_sofia@192.168.0.200:5060 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: User-Agent: Uhope_dispatch 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: Supported: timer, path, replaces 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: Content-Type: application/media_control+xml 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: Content-Length: 107 2019-11-30 11:45:17.315 26086-26086/hzhl.net.hlcall I/HLCall: 2019-11-30 11:45:17.317 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980] [613] bytes parsed 2019-11-30 11:45:17.317 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980] read [107] bytes of body from [192.168.0.200:5060] 2019-11-30 11:45:17.319 26086-26086/hzhl.net.hlcall I/HLCall: bellesip_wake_lock_acquire(): Android wake lock [belle-sip transaction(0x7bdc945060)] acquired [ref=0x3f76] 2019-11-30 11:45:17.319 26086-26086/hzhl.net.hlcall I/HLCall: transaction [0x7bdc945060]: starting transaction background task with id=[3f76]. 2019-11-30 11:45:17.319 26086-26086/hzhl.net.hlcall I/HLCall: Changing [server] [INFO] transaction [0x7bdc945060], from state [INIT] to [TRYING] 2019-11-30 11:45:17.319 26086-26086/hzhl.net.hlcall I/HLCall: Receiving VFU request on op [0x7be6df6b00] 2019-11-30 11:45:17.319 26086-26086/hzhl.net.hlcall I/HLCall: H26xEncoder: VFU requested 2019-11-30 11:45:17.319 26086-26086/hzhl.net.hlcall I/HLCall: Changing [server] [INFO] transaction [0x7bdc945060], from state [TRYING] to [COMPLETED] 2019-11-30 11:45:17.319 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: message sent to [UDP://192.168.0.200:5060], size: [347] bytes SIP/2.0 200 Ok Via: SIP/2.0/UDP 192.168.0.200;rport;branch=z9hG4bKZ67mvXpeNp6pH From: "8037" sip:8037@192.168.0.200;tag=aQNgN468epjaK To: sip:8039@192.168.0.120:49841;transport=udp;tag=fLlL8z0 Call-ID: b3a97b2b-8e1b-1238-d898-00e24c6825f3 CSeq: 13007230 INFO User-Agent: Unknown (belle-sip/1.7.0) Supported: replaces, outbound, gruu 2019-11-30 11:45:17.319 26086-26086/hzhl.net.hlcall I/HLCall: Dialog [0x7be726a400]: now updated by transaction [0x7bdc945060]. 2019-11-30 11:45:17.319 26086-26086/hzhl.net.hlcall I/HLCall: channel [0x7be726d980]: ending recv background task with id=[3f56]. 2019-11-30 11:45:17.320 26086-26086/hzhl.net.hlcall I/HLCall: bellesip_wake_lock_release(): Android wake lock released [ref=0x3f56] 2019-11-30 11:45:17.320 26086-26086/hzhl.net.hlcall W/MediaPlayer: mediaplayer went away with unhandled events 2019-11-30 11:45:17.392 26086-26086/hzhl.net.hlcall I/HLCall: First estimation 2019-11-30 11:45:17.392 26086-26086/hzhl.net.hlcall I/chatty: uid=10302(hzhl.net.hlcall) identical 1 line 2019-11-30 11:45:17.392 26086-26086/hzhl.net.hlcall I/HLCall: First estimation 2019-11-30 11:45:17.392 26086-26086/hzhl.net.hlcall I/HLCall: Bandwidth usage for CallSession [0x7be7311018]: RTP audio=[d=42.18,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-30 11:45:17.392 26086-26086/hzhl.net.hlcall I/HLCall: Thread processing load: audio=3.40939 video=0.346337 text=0 2019-11-30 11:45:17.399 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: enter 2019-11-30 11:45:17.399 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: exit(res=1) 2019-11-30 11:45:17.466 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: enter 2019-11-30 11:45:17.466 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: exit(res=1) 2019-11-30 11:45:17.468 26086-26333/hzhl.net.hlcall I/HLCall: H26xEncoder: requesting I-frame to the encoder. 2019-11-30 11:45:17.469 26086-26333/hzhl.net.hlcall I/HLCall: AMediaCodec_setParams() request-sync key transfered to Bundle with value 0 2019-11-30 11:45:17.469 26086-26333/hzhl.net.hlcall E/HLCall: MediaCodecEncoder: I-frame requested to MediaCodec 2019-11-30 11:45:17.488 26086-26333/hzhl.net.hlcall I/HLCall: MediaCodecEncoder: output format has changed. 2019-11-30 11:45:17.489 26086-26333/hzhl.net.hlcall I/HLCall: MediaCodecEncoder: new output format: {max-bitrate=360000, csd-1=java.nio.HeapByteBuffer[pos=0 lim=8 cap=8], mime=video/avc, width=480, bitrate=360000, frame-rate=15, height=640, csd-0=java.nio.HeapByteBuffer[pos=0 lim=21 cap=21]} 2019-11-30 11:45:17.527 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:17.532 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: enter 2019-11-30 11:45:17.533 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: exit(res=1) 2019-11-30 11:45:17.533 26086-26086/hzhl.net.hlcall I/HLCall: Changing [server] [NOTIFY] transaction [0x7be7262120], from state [COMPLETED] to [TERMINATED] 2019-11-30 11:45:17.533 26086-26086/hzhl.net.hlcall I/HLCall: Server NOTIFY transaction [0x7be7262120] terminated 2019-11-30 11:45:17.533 26086-26086/hzhl.net.hlcall I/HLCall: Unhandled transaction terminated [0x7be7262120] 2019-11-30 11:45:17.533 26086-26086/hzhl.net.hlcall I/HLCall: transaction [0x7be7262120]: ending transaction background task with id=[3aa6]. 2019-11-30 11:45:17.534 26086-26086/hzhl.net.hlcall I/HLCall: bellesip_wake_lock_release(): Android wake lock released [ref=0x3aa6] 2019-11-30 11:45:17.534 26086-26086/hzhl.net.hlcall I/HLCall: Transaction [0x7be7262120] deleted 2019-11-30 11:45:17.599 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: enter 2019-11-30 11:45:17.599 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: exit(res=1) 2019-11-30 11:45:17.666 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: enter 2019-11-30 11:45:17.666 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: exit(res=1) 2019-11-30 11:45:17.768 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:18.016 26086-26302/hzhl.net.hlcall I/HLCall: MSAudioMixer [0x7be6e34480] is entering bypass mode. 2019-11-30 11:45:18.026 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:18.268 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:18.383 26086-26086/hzhl.net.hlcall I/HLCall: Bandwidth usage for CallSession [0x7be7311018]: RTP audio=[d=73.68,u=69.46], video=[d=0.00,u=201.52,ed=0.00], text=[d=0.00,u=0.00] kbits/sec RTCP audio=[d=0.00,u=1.49], video=[d=0.00,u=0.94], text=[d=0.00,u=0.00] kbits/sec 2019-11-30 11:45:18.383 26086-26086/hzhl.net.hlcall I/HLCall: Thread processing load: audio=5.71197 video=7.46009 text=0 2019-11-30 11:45:18.417 26086-26302/hzhl.net.hlcall I/HLCall: Sending RTCP SR compound message on session [0x7be25c9800]. 2019-11-30 11:45:18.423 26086-26086/hzhl.net.hlcall I/HLCall: MSAudio_stream_iterate[0x7be705b200], local statistics available: Local current jitter buffer size: 50.2ms 2019-11-30 11:45:18.424 26086-26086/hzhl.net.hlcall I/HLCall: Linphone core [0x7bf7348200] notified [call_stats_updated] 2019-11-30 11:45:18.536 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:18.768 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:19.046 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:19.269 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:19.269 26086-26333/hzhl.net.hlcall I/HLCall: Sending RTCP SR compound message on session [0x7be25cac00]. 2019-11-30 11:45:19.301 26086-26086/hzhl.net.hlcall I/HLCall: MSVideo_stream_iterate[0x7be1faff80], local statistics available: Local current jitter buffer size: 0.0ms 2019-11-30 11:45:19.301 26086-26086/hzhl.net.hlcall I/HLCall: Linphone core [0x7bf7348200] notified [call_stats_updated] 2019-11-30 11:45:19.379 26086-26086/hzhl.net.hlcall I/HLCall: Bandwidth usage for CallSession [0x7be7311018]: RTP audio=[d=60.17,u=80.00], video=[d=0.00,u=350.69,ed=0.00], text=[d=0.00,u=0.00] kbits/sec RTCP audio=[d=0.00,u=1.89], video=[d=0.00,u=0.77], text=[d=0.00,u=0.00] kbits/sec 2019-11-30 11:45:19.379 26086-26086/hzhl.net.hlcall I/HLCall: Thread processing load: audio=3.15511 video=8.96567 text=0 2019-11-30 11:45:19.488 26086-26333/hzhl.net.hlcall I/HLCall: H26xEncoder: requesting I-frame to the encoder. 2019-11-30 11:45:19.488 26086-26333/hzhl.net.hlcall I/HLCall: AMediaCodec_setParams() request-sync key transfered to Bundle with value 0 2019-11-30 11:45:19.489 26086-26333/hzhl.net.hlcall E/HLCall: MediaCodecEncoder: I-frame requested to MediaCodec 2019-11-30 11:45:19.546 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:19.769 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:20.047 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:20.268 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:20.357 26086-26302/hzhl.net.hlcall I/HLCall: Sending RTCP SR compound message on session [0x7be25c9800]. 2019-11-30 11:45:20.364 26086-26086/hzhl.net.hlcall I/HLCall: MSAudio_stream_iterate[0x7be705b200], local statistics available: Local current jitter buffer size: 50.3ms 2019-11-30 11:45:20.364 26086-26086/hzhl.net.hlcall I/HLCall: Linphone core [0x7bf7348200] notified [call_stats_updated] 2019-11-30 11:45:20.385 26086-26086/hzhl.net.hlcall I/HLCall: Bandwidth usage for CallSession [0x7be7311018]: RTP audio=[d=72.35,u=79.96], video=[d=0.00,u=445.62,ed=0.00], text=[d=0.00,u=0.00] kbits/sec RTCP audio=[d=0.00,u=0.77], video=[d=0.00,u=1.70], text=[d=0.00,u=0.00] kbits/sec 2019-11-30 11:45:20.385 26086-26086/hzhl.net.hlcall I/HLCall: Thread processing load: audio=3.26268 video=7.30766 text=0 2019-11-30 11:45:20.546 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:20.768 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:21.046 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:21.269 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:21.381 26086-26086/hzhl.net.hlcall I/HLCall: Bandwidth usage for CallSession [0x7be7311018]: RTP audio=[d=81.06,u=80.05], video=[d=0.00,u=372.36,ed=0.00], text=[d=0.00,u=0.00] kbits/sec RTCP audio=[d=0.00,u=1.89], video=[d=0.00,u=0.77], text=[d=0.00,u=0.00] kbits/sec 2019-11-30 11:45:21.382 26086-26086/hzhl.net.hlcall I/HLCall: Thread processing load: audio=2.8652 video=6.52421 text=0 2019-11-30 11:45:21.489 26086-26333/hzhl.net.hlcall I/HLCall: H26xEncoder: requesting I-frame to the encoder. 2019-11-30 11:45:21.489 26086-26333/hzhl.net.hlcall I/HLCall: AMediaCodec_setParams() request-sync key transfered to Bundle with value 0 2019-11-30 11:45:21.490 26086-26333/hzhl.net.hlcall E/HLCall: MediaCodecEncoder: I-frame requested to MediaCodec 2019-11-30 11:45:21.546 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:21.657 26086-26302/hzhl.net.hlcall I/HLCall: [AAudio] sound/wall clock skew is average=1.10777 ms 2019-11-30 11:45:21.768 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:21.777 26086-26086/hzhl.net.hlcall I/HLCall: Setting video size 640x480 on stream [0x7be1faff80] 2019-11-30 11:45:21.778 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Filter postprocess 2019-11-30 11:45:21.778 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Stopping capture 2019-11-30 11:45:21.778 26086-26086/hzhl.net.hlcall W/NdkImageReader: A frame is available after AImageReader closed! 2019-11-30 11:45:21.778 26086-26086/hzhl.net.hlcall I/chatty: uid=10302(hzhl.net.hlcall) identical 2 lines 2019-11-30 11:45:21.778 26086-26086/hzhl.net.hlcall W/NdkImageReader: A frame is available after AImageReader closed! 2019-11-30 11:45:21.779 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Destroying preview 2019-11-30 11:45:21.779 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Preview window destroyed 2019-11-30 11:45:21.779 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Preview surface destroyed 2019-11-30 11:45:21.779 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Closing camera 2019-11-30 11:45:21.782 26086-26100/hzhl.net.hlcall E/BufferQueueProducer: [ImageReader-640x480f23u3m1-26086-2] dequeueBuffer: BufferQueue has been abandoned 2019-11-30 11:45:21.783 26086-26100/hzhl.net.hlcall D/ACameraDevice: Device error received, code 3, frame number 137, request ID 0, subseq ID 1 2019-11-30 11:45:21.819 26086-26100/hzhl.net.hlcall E/BufferQueueProducer: [ImageReader-640x480f23u3m1-26086-2] queueBuffer: BufferQueue has been abandoned 2019-11-30 11:45:21.885 26086-26100/hzhl.net.hlcall E/BufferQueueProducer: [ImageReader-640x480f23u3m1-26086-2] queueBuffer: BufferQueue has been abandoned 2019-11-30 11:45:21.952 26086-26100/hzhl.net.hlcall E/BufferQueueProducer: [ImageReader-640x480f23u3m1-26086-2] queueBuffer: BufferQueue has been abandoned 2019-11-30 11:45:22.047 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:22.054 26086-26086/hzhl.net.hlcall W/ACameraCaptureSession: Device is closed but session 0 is not notified 2019-11-30 11:45:22.054 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Session is closed 0x7bdc943ee0 2019-11-30 11:45:22.054 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Camera closed 1 2019-11-30 11:45:22.054 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Capture stopped 2019-11-30 11:45:22.069 26086-26311/hzhl.net.hlcall I/OMXClient: IOmx service obtained 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_unlink: MSAndroidCamera2Capture:0x7be6e34b00,0-->MSPixConv:0x7bdc94d380,0 2019-11-30 11:45:22.074 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] Destroying context 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_unlink: MSPixConv:0x7bdc94d380,0-->MSTee:0x7be6e34c80,0 2019-11-30 11:45:22.074 26086-26332/hzhl.net.hlcall I/HLCall: uninit opengles_display (gl initialized:1) 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_unlink: MSTee:0x7be6e34c80,0-->MSMediaCodecH264Encoder:0x7be6e34b80,0 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Filter uninit 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Creating filter for camera Camera2Device0Facingback 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Filter init 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: Using the default video configuration list 2019-11-30 11:45:22.074 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] OGL display destroyed 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: target and payload bitrates not set for stream [0x7be1faff80] using lowest configuration of preferred video size 640x480 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: Limiting bitrate of video encoder to 0 bits/s for stream [0x7be1faff80] 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: H26xEncoder: video configuration set (bitrate=400000b/s, fps=15.000000, vsize=480x640) 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Device rotation is 0 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] New native window id ptr is 0x3ec6, current one is 0x0 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Stopping capture 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall W/HLCall: [Camera2 Capture] Capture was already stopped, ignoring... 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] NativePreviewWindowId 0x3ec6 is a TextureView, let's get it's surfaceTexture first 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Creating Surface from SurfaceTexture 0xa9 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Surface created: 0x3df2 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Starting capture 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall W/HLCall: [Camera2 Capture] Filter hasn't been fully configured yet, don't start 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Stopping capture 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall W/HLCall: [Camera2 Capture] Capture was already stopped, ignoring... 2019-11-30 11:45:22.074 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Listing camera 0 configurations 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 4032, height 3024 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 4000, height 3000 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 4032, height 2268 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 4032, height 2016 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 3840, height 2160 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 2880, height 2156 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 2688, height 1512 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 2592, height 1940 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 2592, height 1458 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 2592, height 1296 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1920, height 1440 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1920, height 1080 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1600, height 1200 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1280, height 960 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1280, height 720 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 1280, height 640 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 800, height 600 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 720, height 480 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 640, height 480 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 640, height 360 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 352, height 288 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 320, height 240 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Available size width 176, height 144 for requested format 35 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Found exact match for our required size of 640x480 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Starting capture 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Creating preview 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Opening camera 2019-11-30 11:45:22.075 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Opening camera 0 2019-11-30 11:45:22.077 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] EGL display destroyed 2019-11-30 11:45:22.077 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] Window released 2019-11-30 11:45:22.077 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] Surface destroyed 2019-11-30 11:45:22.077 26086-26332/hzhl.net.hlcall I/HLCall: [TextureView Display] Context destroyed 2019-11-30 11:45:22.085 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Image reader created 2019-11-30 11:45:22.085 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Capture window acquired 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall E/ACameraDevice: Camera device 0 cannnot support app output configuration: Status(-8): '3: endConfigure:517: Camera 0: Unsupported set of inputs/outputs provided' 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall E/ACameraDevice: Fail to create new session. cannot configure streams 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall E/NdkCameraCaptureSession: ACameraCaptureSession_setRepeatingRequest: Error: invalid input: session 0x0, numRequest 2, requests 0x7fdaeba6f8 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Capture started 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Previous preview size was 0/0, new size is 480/640 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Getting preview size: 480x640 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall I/HLCall: Output video size adjusted to match camera resolution (480x640) 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall I/HLCall: Setting sent vsize=480x640, fps=15.000000 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall I/HLCall: H26xEncoder: video configuration set (bitrate=400000b/s, fps=15.000000, vsize=640x480) 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSAndroidCamera2Capture:0x7bdc94d380,0-->MSPixConv:0x7be1eed600,0 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSPixConv:0x7be1eed600,0-->MSTee:0x7be6e34c80,0 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall I/HLCall: ms_filter_link: MSTee:0x7be6e34c80,0-->MSMediaCodecH264Encoder:0x7be6e34b80,0 2019-11-30 11:45:22.087 26086-26086/hzhl.net.hlcall I/HLCall: [Camera2 Capture] Filter preprocess 2019-11-30 11:45:22.088 26086-26086/hzhl.net.hlcall I/HLCall: MediaCodecEncoder: configuring MediaCodec with the following parameters: {color-format=2135033992, i-frame-interval=20, level=512, mime=video/avc, latency=1, profile=1, width=480, bitrate-mode=1, bitrate=360000, priority=0, frame-rate=15, height=640} 2019-11-30 11:45:22.088 26086-26311/hzhl.net.hlcall I/ExtendedACodec: setupVideoEncoder() 2019-11-30 11:45:22.089 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c06 = 2141391878 2019-11-30 11:45:22.089 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c04 = 2141391876 2019-11-30 11:45:22.089 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c00 = 2141391872 2019-11-30 11:45:22.089 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c09 = 2141391881 2019-11-30 11:45:22.089 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c0a = 2141391882 2019-11-30 11:45:22.089 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c08 = 2141391880 2019-11-30 11:45:22.090 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7fa30c07 = 2141391879 2019-11-30 11:45:22.090 26086-26311/hzhl.net.hlcall W/OMXUtils: do not know color format 0x7f000789 = 2130708361 2019-11-30 11:45:22.090 26086-26311/hzhl.net.hlcall I/ACodec: [OMX.qcom.video.encoder.avc] using color format 0x15 in place of 0x7f420888 2019-11-30 11:45:22.092 26086-26311/hzhl.net.hlcall I/ACodec: setupAVCEncoderParameters with [profile: Baseline] [level: Level31] 2019-11-30 11:45:22.093 26086-26311/hzhl.net.hlcall I/ACodec: [OMX.qcom.video.encoder.avc] cannot encode HDR static metadata. Ignoring. 2019-11-30 11:45:22.093 26086-26311/hzhl.net.hlcall I/ACodec: setupVideoEncoder succeeded 2019-11-30 11:45:22.093 26086-26311/hzhl.net.hlcall I/ExtendedACodec: [OMX.qcom.video.encoder.avc] configure, AMessage : AMessage(what = 'conf', target = 37) = { int32_t color-format = 2135033992 int32_t i-frame-interval = 20 int32_t level = 512 string mime = "video/avc" int32_t latency = 1 int32_t profile = 1 int32_t width = 480 int32_t bitrate-mode = 1 int32_t bitrate = 360000 int32_t priority = 0 int32_t frame-rate = 15 int32_t height = 640 int32_t encoder = 1 } 2019-11-30 11:45:22.099 26086-26086/hzhl.net.hlcall I/HLCall: MediaCodecEncoder: encoder successfully configured. In-force parameters: {max-bitrate=360000, mime=video/avc, width=480, bitrate=360000, frame-rate=15, height=640} 2019-11-30 11:45:22.106 26086-26086/hzhl.net.hlcall I/HLCall: MediaCodecEncoder: encoder successfully started 2019-11-30 11:45:22.106 26086-26086/hzhl.net.hlcall I/HLCall: Video ITC source updated. 2019-11-30 11:45:22.106 26086-26086/hzhl.net.hlcall I/HLCall: Configuring av recorder with video format type=video;encoding=H264;vsize=0x0;fps=0.000000;fmtp='' 2019-11-30 11:45:22.106 26086-26086/hzhl.net.hlcall I/HLCall: MKVRecorder: set pin #0 format. type=video;encoding=H264;vsize=0x0;fps=0.000000;fmtp='' 2019-11-30 11:45:22.106 26086-26086/hzhl.net.hlcall I/HLCall: Resizing video preview to: 640x480 2019-11-30 11:45:22.106 26086-26086/hzhl.net.hlcall I/HLCall: [Platform Helper] Found CaptureTextureView, setting video capture size to 640x480 2019-11-30 11:45:22.106 26086-26086/hzhl.net.hlcall I/HLCall: [CaptureTextureView] Changing preview texture ratio to match 640x480 2019-11-30 11:45:22.111 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: enter 2019-11-30 11:45:22.111 26086-26126/hzhl.net.hlcall D/libEGL: eglInitialize: exit(res=1) 2019-11-30 11:45:22.168 26086-26333/hzhl.net.hlcall I/HLCall: Sending RTCP SR compound message on session [0x7be25cac00]. 2019-11-30 11:45:22.170 26086-26086/hzhl.net.hlcall I/HLCall: MSVideo_stream_iterate[0x7be1faff80], local statistics available: Local current jitter buffer size: 0.0ms 2019-11-30 11:45:22.171 26086-26086/hzhl.net.hlcall I/HLCall: Linphone core [0x7bf7348200] notified [call_stats_updated] 2019-11-30 11:45:22.206 26086-26302/hzhl.net.hlcall I/HLCall: jitter buffer stable: target-size: 59.999999 ms, effective-size: 50.315788 (min: 40 nom: 60, max: 500) 2019-11-30 11:45:22.206 26086-26302/hzhl.net.hlcall I/HLCall: jitter buffer rls stats: count=245, clockrate=8000, offset=-199.003 clock_ratio=0.994098, capped_offset=-1466850449 capped_clock_ratio=0.994098, max_ts_deviation=35.000000 prev_max_ts_deviation=480.000000, deviation=35, RLS VARIABLES: P[0][0]=0.000000, P[1][0]=-0.000000, P[0][1]=-0.000000, P[1][1]=0.011971 2019-11-30 11:45:22.248 26086-26333/hzhl.net.hlcall I/HLCall: video processing delay = { min=0ms, mean=0.0ms, max=0ms } (RtpSession=0x7be25cac00) 2019-11-30 11:45:22.268 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:22.391 26086-26086/hzhl.net.hlcall I/HLCall: Bandwidth usage for CallSession [0x7be7311018]: RTP audio=[d=77.21,u=79.93], video=[d=0.00,u=206.31,ed=0.00], text=[d=0.00,u=0.00] kbits/sec RTCP audio=[d=0.00,u=0.77], video=[d=0.00,u=1.70], text=[d=0.00,u=0.00] kbits/sec 2019-11-30 11:45:22.391 26086-26086/hzhl.net.hlcall I/HLCall: Thread processing load: audio=1.66144 video=0.327757 text=0 2019-11-30 11:45:22.546 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:22.768 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:23.046 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:23.268 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:23.378 26086-26086/hzhl.net.hlcall I/HLCall: Bandwidth usage for CallSession [0x7be7311018]: RTP audio=[d=74.56,u=80.04], 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.77], video=[d=0.00,u=0.77], text=[d=0.00,u=0.00] kbits/sec 2019-11-30 11:45:23.379 26086-26086/hzhl.net.hlcall I/HLCall: Thread processing load: audio=3.77528 video=0.622155 text=0 2019-11-30 11:45:23.436 26086-26302/hzhl.net.hlcall I/HLCall: Sending RTCP SR compound message on session [0x7be25c9800]. 2019-11-30 11:45:23.438 26086-26086/hzhl.net.hlcall I/HLCall: MSAudio_stream_iterate[0x7be705b200], local statistics available: Local current jitter buffer size: 54.7ms 2019-11-30 11:45:23.439 26086-26086/hzhl.net.hlcall I/HLCall: Linphone core [0x7bf7348200] notified [call_stats_updated] 2019-11-30 11:45:23.547 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:23.768 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:24.046 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:24.268 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00] 2019-11-30 11:45:24.385 26086-26086/hzhl.net.hlcall I/HLCall: Bandwidth usage for CallSession [0x7be7311018]: RTP audio=[d=79.63,u=79.98], 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=1.89], video=[d=0.00,u=0.77], text=[d=0.00,u=0.00] kbits/sec 2019-11-30 11:45:24.385 26086-26086/hzhl.net.hlcall I/HLCall: Thread processing load: audio=3.13708 video=0.614959 text=0 2019-11-30 11:45:24.547 26086-26302/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25c9800] 2019-11-30 11:45:24.769 26086-26333/hzhl.net.hlcall I/HLCall: Stun packet sent on rtcp for session [0x7be25cac00]

elileo1 commented 4 years ago

the captureTextureView width is 150dp, height is 200dp when i switch the camera to back camera, it catch error. because of textureView size ???

Viish commented 4 years ago

From the camera error log it looks like more of a hardware device issue. We check that the resolution we gonna ask the camera for is supported and yet ACameraCaptureSession_setRepeatingRequest: Error: invalid input Can you reproduce with another device ? If you want to rule out the TextureView size issue, use our org.linphone.mediastream.video.capture.CaptureTextureView instead and give it a size like 200dp x 200dp.

Please also make sure you are using the latest version of SDK branch release/4.3, I've made fixes & improvements for Camera2 capture filter.

elileo1 commented 4 years ago

yes, it’s reproduce with another device, and i use CaptureTextureView but the size is 150dp * 200dp. i use 4.2 version

Viish commented 4 years ago

Please attach logs from this other device, it may help understand the issue and find a fix (attach full logs from the start of the app to the end of the call).

elileo1 commented 4 years ago

is it the proxy server need to config something let it can switch camera??

Viish commented 4 years ago

No the proxy server isn't involved in the camera switch process

elileo1 commented 4 years ago

i upgrade sdk to 4.3 and it is ok, thanks viish