Javacv: Android App restarts everytime I try to overlay a timer using RecordActivity.java: start() was not called successfully!

Created on 26 Nov 2019 · 8Comments · Source: bytedeco/javacv

Hey,
the modified RecordActivity.java can be found here.

Basically I am using the Timer.schedule in Java to stop the older filter and start a new filter every second with the updated seconds count.
The following is running every seconds:


    class ClockTimer extends TimerTask{
        public void run(){
           if(seconds == 59){
               seconds = 0;
               minute ++;
           }else {
               seconds++;
           }
            secondsText = Integer.toString(seconds);
            minuteText = Integer.toString(minute);
            String displayText = String.format("%s\\:%s", minuteText, secondsText);
            filterString = String.format("drawtext=fontfile=\'/system/fonts/DroidSansMono.ttf\':text=\'%s\':fontsize=30:fontcolor=white", displayText);
            // Remove old filter
            removeFilter();
            // Create a new filter
            filter = new FFmpegFrameFilter(filterString, imageWidth, imageHeight);
            filter.setPixelFormat(avutil.AV_PIX_FMT_NV21);
            // Start a new filter
            startFilter();
        }

    }

Where :

// Used to remove current running filter
    public void removeFilter(){
        try {
            filter.stop();
            filter.release();
        }catch (FrameFilter.Exception e ){
            e.printStackTrace();
        }

    }


//used to start a new filter after stopping current running filter
    public void startFilter(){
        try{
            filter.start();
            FFmpegLogCallback.set();
        }catch (FrameFilter.Exception e){
            e.printStackTrace();
            Log.v("start filter", e.getLocalizedMessage() );

        }
    }

Logs

1-26 13:09:24.290 26298-26298/? I/portvotbrodcas: Late-enabling -Xcheck:jni
2019-11-26 13:09:25.060 26298-26298/com.example.test D/OpenGLRenderer: Skia GL Pipeline
2019-11-26 13:09:25.259 26298-26344/com.example.test I/Adreno: QUALCOMM build                   : 0f7742b, Ib21e741bcf
    Build Date                       : 09/05/18
    OpenGL ES Shader Compiler Version: EV031.25.03.00
    Local Branch                     :
    Remote Branch                    :
    Remote Branch                    :
    Reconstruct Branch               :
2019-11-26 13:09:25.259 26298-26344/com.example.test I/Adreno: Build Config                     : S L 6.0.7 AArch64
2019-11-26 13:09:25.264 26298-26344/com.example.test I/Adreno: PFP: 0x005ff112, ME: 0x005ff066
2019-11-26 13:09:25.269 26298-26344/com.example.test I/ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasWideColorDisplay retrieved: 0
2019-11-26 13:09:25.269 26298-26344/com.example.test I/ConfigStore: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasHDRDisplay retrieved: 0
2019-11-26 13:09:25.270 26298-26344/com.example.test I/OpenGLRenderer: Initialized EGL, version 1.4
2019-11-26 13:09:25.270 26298-26344/com.example.test D/OpenGLRenderer: Swap behavior 2
2019-11-26 13:09:42.232 26298-26298/com.example.test D/TextClassificationManager: Initialized SystemTextClassifier
2019-11-26 13:09:43.364 26298-26344/com.example.test D/OpenGLRenderer: endAllActiveAnimators on 0x770f543600 (RippleDrawable) with handle 0x770f5375a0
2019-11-26 13:09:43.915 26298-26298/com.example.test W/ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@4900821
2019-11-26 13:09:44.140 26298-26298/com.example.test I/RecordActivity: cameara open
2019-11-26 13:09:44.144 26298-26298/com.example.test W/camera: camera view
2019-11-26 13:09:44.145 26298-26298/com.example.test I/RecordActivity: cameara preview start: OK
2019-11-26 13:09:44.257 26298-26298/com.example.test V/RecordActivity: Changed to supported resolution: 720x480
2019-11-26 13:09:44.257 26298-26298/com.example.test V/RecordActivity: Setting imageWidth: 720 imageHeight: 480 frameRate: 30
2019-11-26 13:09:44.258 26298-26298/com.example.test V/RecordActivity: Preview Framerate: 30
2019-11-26 13:10:06.547 26298-26298/com.example.test W/RecordActivity: init recorder
2019-11-26 13:10:06.547 26298-26298/com.example.test I/RecordActivity: ffmpeg_url: rtmp://a.rtmp.youtube.com/live2/epja-tcyb-sdud-frfk
2019-11-26 13:10:06.645 26298-26298/com.example.test W/System.err: Warning: Version of org.bytedeco:ffmpeg could not be found.
2019-11-26 13:10:06.705 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:06.705 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:06.705 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:06.705 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:06.810 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:06.810 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:06.811 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:06.811 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:06.928 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:06.928 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:06.929 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:06.929 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:07.080 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:07.081 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:07.081 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:07.081 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:07.193 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:07.193 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:07.193 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:07.193 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:07.285 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:07.285 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:07.285 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:07.285 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:07.391 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:07.391 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:07.391 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:07.391 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:07.511 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:07.511 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:07.511 26298-26298/com.example.test E/linker: normalize_path - invalid input: "lib/", the input path should be absolute
2019-11-26 13:10:07.512 26298-26298/com.example.test W/linker: Warning: unable to normalize "lib/" (ignoring)
2019-11-26 13:10:08.133 26298-26298/com.example.test I/RecordActivity: create yuvImage
2019-11-26 13:10:08.133 26298-26298/com.example.test I/RecordActivity: recorder initialize success
2019-11-26 13:10:09.360 26298-26616/com.example.test D/RecordActivity: audioRecord.startRecording()
2019-11-26 13:10:09.619 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:09.699 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:09.779 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:09.795 26298-26298/com.example.test W/RecordActivity: Start Button Pushed
2019-11-26 13:10:09.800 26298-26298/com.example.test I/Choreographer: Skipped 194 frames!  The application may be doing too much work on its main thread.
2019-11-26 13:10:09.811 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:09.811 26298-26298/com.example.test V/RecordActivity: start() was not called successfully!
2019-11-26 13:10:09.812 26298-26298/com.example.test W/System.err: org.bytedeco.javacv.FrameFilter$Exception: start() was not called successfully!
2019-11-26 13:10:09.812 26298-26298/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:503)
2019-11-26 13:10:09.812 26298-26298/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:496)
2019-11-26 13:10:09.812 26298-26298/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:493)
2019-11-26 13:10:09.812 26298-26298/com.example.test W/System.err:     at com.example.test.RecordActivity$CameraView.onPreviewFrame(RecordActivity.java:523)
2019-11-26 13:10:09.812 26298-26298/com.example.test W/System.err:     at android.hardware.Camera$EventHandler.handleMessage(Camera.java:1262)
2019-11-26 13:10:09.812 26298-26298/com.example.test W/System.err:     at android.os.Handler.dispatchMessage(Handler.java:106)
2019-11-26 13:10:09.812 26298-26298/com.example.test W/System.err:     at android.os.Looper.loop(Looper.java:193)
2019-11-26 13:10:09.812 26298-26298/com.example.test W/System.err:     at android.app.ActivityThread.main(ActivityThread.java:6912)
2019-11-26 13:10:09.812 26298-26298/com.example.test W/System.err:     at java.lang.reflect.Method.invoke(Native Method)
2019-11-26 13:10:09.812 26298-26298/com.example.test W/System.err:     at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:493)
2019-11-26 13:10:09.813 26298-26298/com.example.test W/System.err:     at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:860)
2019-11-26 13:10:09.814 26298-26344/com.example.test I/OpenGLRenderer: Davey! duration=3261ms; Flags=0, IntendedVsync=114210775166749, Vsync=114214008499953, OldestInputEvent=9223372036854775807, NewestInputEvent=0, HandleInputStart=114214023346042, AnimationStart=114214023414271, PerformTraversalsStart=114214023944896, DrawStart=114214029482761, SyncQueued=114214032426928, SyncStart=114214032489949, IssueDrawCommandsStart=114214032657345, SwapBuffers=114214035085210, FrameCompleted=114214036799064, DequeueBufferDuration=549000, QueueBufferDuration=888000,
2019-11-26 13:10:09.860 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:09.886 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:09.939 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:09.957 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.020 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.026 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.103 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.110 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.166 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.189 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.232 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.272 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.306 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.352 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.378 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.431 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.450 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.511 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.515 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.586 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.591 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.653 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.681 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.728 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.762 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.799 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.800 26298-26298/com.example.test V/RecordActivity: start() was not called successfully!
2019-11-26 13:10:10.800 26298-26298/com.example.test W/System.err: org.bytedeco.javacv.FrameFilter$Exception: start() was not called successfully!
2019-11-26 13:10:10.801 26298-26298/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:503)
2019-11-26 13:10:10.801 26298-26298/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:496)
2019-11-26 13:10:10.801 26298-26298/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:493)
2019-11-26 13:10:10.801 26298-26298/com.example.test W/System.err:     at com.example.test.RecordActivity$CameraView.onPreviewFrame(RecordActivity.java:523)
2019-11-26 13:10:10.801 26298-26298/com.example.test W/System.err:     at android.hardware.Camera$EventHandler.handleMessage(Camera.java:1262)
2019-11-26 13:10:10.801 26298-26298/com.example.test W/System.err:     at android.os.Handler.dispatchMessage(Handler.java:106)
2019-11-26 13:10:10.801 26298-26298/com.example.test W/System.err:     at android.os.Looper.loop(Looper.java:193)
2019-11-26 13:10:10.802 26298-26298/com.example.test W/System.err:     at android.app.ActivityThread.main(ActivityThread.java:6912)
2019-11-26 13:10:10.802 26298-26298/com.example.test W/System.err:     at java.lang.reflect.Method.invoke(Native Method)
2019-11-26 13:10:10.802 26298-26298/com.example.test W/System.err:     at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:493)
2019-11-26 13:10:10.803 26298-26298/com.example.test W/System.err:     at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:860)
2019-11-26 13:10:10.842 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.867 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:10.922 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:10.939 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.002 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.009 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.078 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.081 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.145 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.161 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.218 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.251 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.288 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.331 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.357 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.412 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.429 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.491 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.504 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.568 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.571 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.640 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.651 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.706 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.724 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.780 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.814 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.849 26298-26298/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:10:11.894 26298-26616/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:10:11.915 26298-26298/com.example.test V/RecordActivity: Writing Frame

And the logs continuous basically the same.... and after 1 or 2 mins, it restarts the app and by then the logs also clear out.
Any help would be appreciated :)

question

Source

davepaiva

All 8 comments

Make sure to call FFmpegLogCallback.set() to get more information in the log.

saudet on 26 Nov 2019

04.882 26413-26413/com.example.test I/RecordActivity: create yuvImage
2019-11-26 13:52:04.882 26413-26413/com.example.test I/RecordActivity: recorder initialize success
2019-11-26 13:52:08.333 26413-26585/com.example.test D/RecordActivity: audioRecord.startRecording()
2019-11-26 13:52:08.601 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:08.681 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:08.761 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:08.841 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:08.888 26413-26413/com.example.test W/RecordActivity: Start Button Pushed
2019-11-26 13:52:08.893 26413-26413/com.example.test I/Choreographer: Skipped 339 frames!  The application may be doing too much work on its main thread.
2019-11-26 13:52:08.903 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:08.921 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:08.938 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] Setting 'video_size' to value '720x480'
2019-11-26 13:52:08.938 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] Setting 'pix_fmt' to value '24'
2019-11-26 13:52:08.938 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] Setting 'time_base' to value '1/30'
2019-11-26 13:52:08.938 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] Setting 'pixel_aspect' to value '1/1'
2019-11-26 13:52:08.938 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] w:720 h:480 pixfmt:nv21 tb:1/30 fr:0/1 sar:1/1 sws_param:
2019-11-26 13:52:08.939 26413-26603/com.example.test I/System.out: [setpts @ 0x770f45f1c0] Setting 'expr' to value 'N'
2019-11-26 13:52:08.939 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] Setting 'fontfile' to value '/system/fonts/DroidSansMono.ttf'
2019-11-26 13:52:08.939 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] Setting 'text' to value '0:1'
2019-11-26 13:52:08.939 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] Setting 'fontsize' to value '30'
2019-11-26 13:52:08.940 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] Setting 'fontcolor' to value 'white'
2019-11-26 13:52:08.941 26413-26603/com.example.test I/System.out: [AVFilterGraph @ 0x770f47ec60] query_formats: 4 queried, 3 merged, 0 already done, 0 delayed
2019-11-26 13:52:08.941 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] TB:0.033333 FRAME_RATE:nan SAMPLE_RATE:nan
2019-11-26 13:52:08.970 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:08.971 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:0 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:08.972 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:08.972 26413-26413/com.example.test I/System.out:  -> PTS:0 T:0.000000
2019-11-26 13:52:08.972 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:0 t:0.000000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.001 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.053 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.056 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:1 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.057 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.057 26413-26413/com.example.test I/System.out:  -> PTS:1 T:0.033333
2019-11-26 13:52:09.058 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:1 t:0.033333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.091 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.132 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.133 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:2 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.133 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.133 26413-26413/com.example.test I/System.out:  -> PTS:2 T:0.066667
2019-11-26 13:52:09.134 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:2 t:0.066667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.172 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.210 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.211 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:3 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.211 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.211 26413-26413/com.example.test I/System.out:  -> PTS:3 T:0.100000
2019-11-26 13:52:09.212 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:3 t:0.100000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.251 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.292 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.293 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:4 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.293 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.293 26413-26413/com.example.test I/System.out:  -> PTS:4 T:0.133333
2019-11-26 13:52:09.294 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:4 t:0.133333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.332 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.373 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.374 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:5 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.374 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.375 26413-26413/com.example.test I/System.out:  -> PTS:5 T:0.166667
2019-11-26 13:52:09.375 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:5 t:0.166667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.411 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.451 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.454 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:6 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.454 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.454 26413-26413/com.example.test I/System.out:  -> PTS:6 T:0.200000
2019-11-26 13:52:09.454 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:6 t:0.200000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.491 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.530 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.533 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:7 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.533 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.533 26413-26413/com.example.test I/System.out:  -> PTS:7 T:0.233333
2019-11-26 13:52:09.533 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:7 t:0.233333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.571 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.616 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.617 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:8 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.617 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.617 26413-26413/com.example.test I/System.out:  -> PTS:8 T:0.266667
2019-11-26 13:52:09.617 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:8 t:0.266667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.661 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.695 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.697 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:9 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.697 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.697 26413-26413/com.example.test I/System.out:  -> PTS:9 T:0.300000
2019-11-26 13:52:09.697 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:9 t:0.300000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.742 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.774 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.775 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:10 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.776 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.776 26413-26413/com.example.test I/System.out:  -> PTS:10 T:0.333333
2019-11-26 13:52:09.776 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:10 t:0.333333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.821 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.853 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.857 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f1c0] N:11 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.857 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.857 26413-26413/com.example.test I/System.out:  -> PTS:11 T:0.366667
2019-11-26 13:52:09.857 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f400] n:11 t:0.366667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.902 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:09.902 26413-26603/com.example.test I/System.out: [in @ 0x770f45f340] Setting 'video_size' to value '720x480'
2019-11-26 13:52:09.902 26413-26603/com.example.test I/System.out: [in @ 0x770f45f340] Setting 'pix_fmt' to value '24'
2019-11-26 13:52:09.902 26413-26603/com.example.test I/System.out: [in @ 0x770f45f340] Setting 'time_base' to value '1/30'
2019-11-26 13:52:09.902 26413-26603/com.example.test I/System.out: [in @ 0x770f45f340] Setting 'pixel_aspect' to value '1/1'
2019-11-26 13:52:09.903 26413-26603/com.example.test I/System.out: [in @ 0x770f45f340] w:720 h:480 pixfmt:nv21 tb:1/30 fr:0/1 sar:1/1 sws_param:
2019-11-26 13:52:09.903 26413-26603/com.example.test I/System.out: [setpts @ 0x770f45f4c0] Setting 'expr' to value 'N'
2019-11-26 13:52:09.904 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] Setting 'fontfile' to value '/system/fonts/DroidSansMono.ttf'
2019-11-26 13:52:09.904 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] Setting 'text' to value '0:2'
2019-11-26 13:52:09.904 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] Setting 'fontsize' to value '30'
2019-11-26 13:52:09.904 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] Setting 'fontcolor' to value 'white'
2019-11-26 13:52:09.906 26413-26603/com.example.test I/System.out: [AVFilterGraph @ 0x770f47ec60] query_formats: 4 queried, 3 merged, 0 already done, 0 delayed
2019-11-26 13:52:09.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45f340] TB:0.033333 FRAME_RATE:nan SAMPLE_RATE:nan
2019-11-26 13:52:09.934 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:09.935 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:0 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:09.935 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:09.935 26413-26413/com.example.test I/System.out:  -> PTS:0 T:0.000000
2019-11-26 13:52:09.935 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:0 t:0.000000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:09.941 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=   0 QP=14.00 NAL=3 Slice:I Poc:0   I:1350 P:0    SKIP:0    size=53774 bytes
2019-11-26 13:52:09.982 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.013 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.014 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:1 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.015 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.015 26413-26413/com.example.test I/System.out:  -> PTS:1 T:0.033333
2019-11-26 13:52:10.015 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:1 t:0.033333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.021 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=   1 QP=19.00 NAL=2 Slice:P Poc:2   I:1088 P:262  SKIP:0    size=59336 bytes
2019-11-26 13:52:10.062 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.097 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.100 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:2 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.100 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.101 26413-26413/com.example.test I/System.out:  -> PTS:2 T:0.066667
2019-11-26 13:52:10.101 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:2 t:0.066667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.106 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=   2 QP=18.00 NAL=2 Slice:P Poc:4   I:64   P:1249 SKIP:37   size=42595 bytes
2019-11-26 13:52:10.141 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.169 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.170 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:3 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.170 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.171 26413-26413/com.example.test I/System.out:  -> PTS:3 T:0.100000
2019-11-26 13:52:10.171 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:3 t:0.100000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.175 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=   3 QP=17.00 NAL=2 Slice:P Poc:6   I:71   P:1264 SKIP:15   size=49115 bytes
2019-11-26 13:52:10.232 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.257 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.260 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:4 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.260 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.260 26413-26413/com.example.test I/System.out:  -> PTS:4 T:0.133333
2019-11-26 13:52:10.260 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:4 t:0.133333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.265 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=   4 QP=16.00 NAL=2 Slice:P Poc:8   I:72   P:1268 SKIP:10   size=57351 bytes
2019-11-26 13:52:10.311 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.332 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.333 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:5 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.333 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.333 26413-26413/com.example.test I/System.out:  -> PTS:5 T:0.166667
2019-11-26 13:52:10.333 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:5 t:0.166667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.338 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=   5 QP=16.00 NAL=2 Slice:P Poc:10  I:64   P:1275 SKIP:11   size=54743 bytes
2019-11-26 13:52:10.340 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:10.392 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.413 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.414 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:6 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.414 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.415 26413-26413/com.example.test I/System.out:  -> PTS:6 T:0.200000
2019-11-26 13:52:10.415 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:6 t:0.200000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.420 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=   6 QP=16.00 NAL=2 Slice:P Poc:12  I:69   P:1272 SKIP:9    size=56139 bytes
2019-11-26 13:52:10.471 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.500 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.502 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:7 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.502 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.502 26413-26413/com.example.test I/System.out:  -> PTS:7 T:0.233333
2019-11-26 13:52:10.503 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:7 t:0.233333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.507 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=   7 QP=16.00 NAL=2 Slice:P Poc:14  I:139  P:1200 SKIP:11   size=54960 bytes
2019-11-26 13:52:10.553 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.573 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.575 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:8 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.575 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.576 26413-26413/com.example.test I/System.out:  -> PTS:8 T:0.266667
2019-11-26 13:52:10.576 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:8 t:0.266667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.580 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=   8 QP=16.00 NAL=2 Slice:P Poc:16  I:231  P:1111 SKIP:8    size=52330 bytes
2019-11-26 13:52:10.633 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.654 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.655 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:9 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.655 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.655 26413-26413/com.example.test I/System.out:  -> PTS:9 T:0.300000
2019-11-26 13:52:10.656 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:9 t:0.300000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.660 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=   9 QP=17.00 NAL=2 Slice:P Poc:18  I:282  P:1059 SKIP:9    size=41187 bytes
2019-11-26 13:52:10.661 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:10.707 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.732 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.733 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:10 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.734 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.734 26413-26413/com.example.test I/System.out:  -> PTS:10 T:0.333333
2019-11-26 13:52:10.734 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:10 t:0.333333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.739 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  10 QP=17.00 NAL=2 Slice:P Poc:20  I:191  P:1148 SKIP:11   size=43635 bytes
2019-11-26 13:52:10.798 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.814 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.815 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f4c0] N:11 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.815 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.815 26413-26413/com.example.test I/System.out:  -> PTS:11 T:0.366667
2019-11-26 13:52:10.815 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f580] n:11 t:0.366667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.819 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  11 QP=16.00 NAL=2 Slice:P Poc:22  I:117  P:1227 SKIP:6    size=59463 bytes
2019-11-26 13:52:10.829 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:10.879 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.897 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.897 26413-26413/com.example.test V/RecordActivity: start() was not called successfully!
2019-11-26 13:52:10.898 26413-26413/com.example.test W/System.err: org.bytedeco.javacv.FrameFilter$Exception: start() was not called successfully!
2019-11-26 13:52:10.899 26413-26413/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:503)
2019-11-26 13:52:10.899 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] Setting 'video_size' to value '720x480'
2019-11-26 13:52:10.900 26413-26413/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:496)
2019-11-26 13:52:10.900 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] Setting 'pix_fmt' to value '24'
2019-11-26 13:52:10.900 26413-26413/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:493)
2019-11-26 13:52:10.900 26413-26413/com.example.test W/System.err:     at com.example.test.RecordActivity$CameraView.onPreviewFrame(RecordActivity.java:522)
2019-11-26 13:52:10.900 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] Setting 'time_base' to value '1/30'
2019-11-26 13:52:10.900 26413-26413/com.example.test W/System.err:     at android.hardware.Camera$EventHandler.handleMessage(Camera.java:1262)
2019-11-26 13:52:10.900 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] Setting 'pixel_aspect' to value '1/1'
2019-11-26 13:52:10.900 26413-26413/com.example.test W/System.err:     at android.os.Handler.dispatchMessage(Handler.java:106)
2019-11-26 13:52:10.900 26413-26413/com.example.test W/System.err:     at android.os.Looper.loop(Looper.java:193)
2019-11-26 13:52:10.900 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] w:720 h:480 pixfmt:nv21 tb:1/30 fr:0/1 sar:1/1 sws_param:
2019-11-26 13:52:10.900 26413-26413/com.example.test W/System.err:     at android.app.ActivityThread.main(ActivityThread.java:6912)
2019-11-26 13:52:10.900 26413-26413/com.example.test W/System.err:     at java.lang.reflect.Method.invoke(Native Method)
2019-11-26 13:52:10.900 26413-26413/com.example.test W/System.err:     at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:493)
2019-11-26 13:52:10.901 26413-26413/com.example.test W/System.err:     at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:860)
2019-11-26 13:52:10.901 26413-26603/com.example.test I/System.out: [setpts @ 0x770f45f7c0] Setting 'expr' to value 'N'
2019-11-26 13:52:10.901 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] Setting 'fontfile' to value '/system/fonts/DroidSansMono.ttf'
2019-11-26 13:52:10.902 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] Setting 'text' to value '0:3'
2019-11-26 13:52:10.902 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] Setting 'fontsize' to value '30'
2019-11-26 13:52:10.902 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] Setting 'fontcolor' to value 'white'
2019-11-26 13:52:10.905 26413-26603/com.example.test I/System.out: [AVFilterGraph @ 0x770f47ec60] query_formats: 4 queried, 3 merged, 0 already done, 0 delayed
2019-11-26 13:52:10.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45f040] TB:0.033333 FRAME_RATE:nan SAMPLE_RATE:nan
2019-11-26 13:52:10.961 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:10.974 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:10.975 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:0 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:10.975 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:10.975 26413-26413/com.example.test I/System.out:  -> PTS:0 T:0.000000
2019-11-26 13:52:10.976 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:0 t:0.000000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:10.980 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  12 QP=17.00 NAL=2 Slice:P Poc:24  I:73   P:1269 SKIP:8    size=53505 bytes
2019-11-26 13:52:11.040 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.052 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.053 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:1 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.053 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.053 26413-26413/com.example.test I/System.out:  -> PTS:1 T:0.033333
2019-11-26 13:52:11.054 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:1 t:0.033333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.058 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  13 QP=17.00 NAL=2 Slice:P Poc:26  I:117  P:1219 SKIP:14   size=52381 bytes
2019-11-26 13:52:11.119 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.132 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.134 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:2 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.134 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.134 26413-26413/com.example.test I/System.out:  -> PTS:2 T:0.066667
2019-11-26 13:52:11.134 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:2 t:0.066667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.138 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  14 QP=17.00 NAL=2 Slice:P Poc:28  I:113  P:1219 SKIP:18   size=51203 bytes
2019-11-26 13:52:11.139 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:11.200 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.214 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.215 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:3 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.216 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.216 26413-26413/com.example.test I/System.out:  -> PTS:3 T:0.100000
2019-11-26 13:52:11.216 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:3 t:0.100000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.221 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  15 QP=17.00 NAL=2 Slice:P Poc:30  I:156  P:1180 SKIP:14   size=54000 bytes
2019-11-26 13:52:11.280 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.300 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.301 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:4 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.302 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.302 26413-26413/com.example.test I/System.out:  -> PTS:4 T:0.133333
2019-11-26 13:52:11.302 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:4 t:0.133333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.314 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  16 QP=16.00 NAL=2 Slice:P Poc:32  I:102  P:1239 SKIP:9    size=60907 bytes
2019-11-26 13:52:11.316 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:11.370 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.377 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.378 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:5 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.378 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.378 26413-26413/com.example.test I/System.out:  -> PTS:5 T:0.166667
2019-11-26 13:52:11.378 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:5 t:0.166667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.383 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  17 QP=17.00 NAL=2 Slice:P Poc:34  I:114  P:1225 SKIP:11   size=53588 bytes
2019-11-26 13:52:11.450 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.455 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.456 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:6 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.456 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.456 26413-26413/com.example.test I/System.out:  -> PTS:6 T:0.200000
2019-11-26 13:52:11.457 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:6 t:0.200000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.461 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  18 QP=17.00 NAL=2 Slice:P Poc:36  I:142  P:1197 SKIP:11   size=53880 bytes
2019-11-26 13:52:11.462 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:11.530 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.535 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.536 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:7 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.537 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.537 26413-26413/com.example.test I/System.out:  -> PTS:7 T:0.233333
2019-11-26 13:52:11.537 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:7 t:0.233333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.541 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  19 QP=16.00 NAL=2 Slice:P Poc:38  I:73   P:1268 SKIP:9    size=60603 bytes
2019-11-26 13:52:11.610 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.617 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.618 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:8 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.618 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.618 26413-26413/com.example.test I/System.out:  -> PTS:8 T:0.266667
2019-11-26 13:52:11.618 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:8 t:0.266667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.623 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  20 QP=17.00 NAL=2 Slice:P Poc:40  I:100  P:1241 SKIP:9    size=51906 bytes
2019-11-26 13:52:11.633 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:11.690 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.693 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.695 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:9 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.695 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.695 26413-26413/com.example.test I/System.out:  -> PTS:9 T:0.300000
2019-11-26 13:52:11.695 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:9 t:0.300000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.699 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  21 QP=16.00 NAL=2 Slice:P Poc:42  I:205  P:1137 SKIP:8    size=59482 bytes
2019-11-26 13:52:11.770 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.777 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.778 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:10 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.778 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.778 26413-26413/com.example.test I/System.out:  -> PTS:10 T:0.333333
2019-11-26 13:52:11.779 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:10 t:0.333333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.783 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  22 QP=17.00 NAL=2 Slice:P Poc:44  I:134  P:1208 SKIP:8    size=50407 bytes
2019-11-26 13:52:11.849 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.855 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.857 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45f7c0] N:11 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.857 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.857 26413-26413/com.example.test I/System.out:  -> PTS:11 T:0.366667
2019-11-26 13:52:11.858 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45f940] n:11 t:0.366667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.862 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  23 QP=17.00 NAL=2 Slice:P Poc:46  I:199  P:1131 SKIP:20   size=48213 bytes
2019-11-26 13:52:11.863 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:11.898 26413-26603/com.example.test I/System.out: [in @ 0x770f45f880] Setting 'video_size' to value '720x480'
2019-11-26 13:52:11.898 26413-26603/com.example.test I/System.out: [in @ 0x770f45f880] Setting 'pix_fmt' to value '24'
2019-11-26 13:52:11.899 26413-26603/com.example.test I/System.out: [in @ 0x770f45f880] Setting 'time_base' to value '1/30'
2019-11-26 13:52:11.899 26413-26603/com.example.test I/System.out: [in @ 0x770f45f880] Setting 'pixel_aspect' to value '1/1'
2019-11-26 13:52:11.899 26413-26603/com.example.test I/System.out: [in @ 0x770f45f880] w:720 h:480 pixfmt:nv21 tb:1/30 fr:0/1 sar:1/1 sws_param:
2019-11-26 13:52:11.899 26413-26603/com.example.test I/System.out: [setpts @ 0x770f45fa00] Setting 'expr' to value 'N'
2019-11-26 13:52:11.900 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] Setting 'fontfile' to value '/system/fonts/DroidSansMono.ttf'
2019-11-26 13:52:11.900 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] Setting 'text' to value '0:4'
2019-11-26 13:52:11.901 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] Setting 'fontsize' to value '30'
2019-11-26 13:52:11.901 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] Setting 'fontcolor' to value 'white'
2019-11-26 13:52:11.903 26413-26603/com.example.test I/System.out: [AVFilterGraph @ 0x770f47ec60] query_formats: 4 queried, 3 merged, 0 already done, 0 delayed
2019-11-26 13:52:11.903 26413-26603/com.example.test I/System.out: [in @ 0x770f45f880] TB:0.033333 FRAME_RATE:nan SAMPLE_RATE:nan
2019-11-26 13:52:11.932 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:11.934 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:0 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:11.934 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:11.934 26413-26413/com.example.test I/System.out:  -> PTS:0 T:0.000000
2019-11-26 13:52:11.935 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:0 t:0.000000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:11.939 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:11.940 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  24 QP=16.00 NAL=2 Slice:P Poc:48  I:241  P:1098 SKIP:11   size=54286 bytes
2019-11-26 13:52:12.017 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.018 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.019 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:1 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.019 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.019 26413-26413/com.example.test I/System.out:  -> PTS:1 T:0.033333
2019-11-26 13:52:12.020 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:1 t:0.033333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.024 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  25 QP=16.00 NAL=2 Slice:P Poc:50  I:420  P:925  SKIP:5    size=63865 bytes
2019-11-26 13:52:12.025 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:12.092 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.093 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:2 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.094 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.094 26413-26413/com.example.test I/System.out:  -> PTS:2 T:0.066667
2019-11-26 13:52:12.094 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:2 t:0.066667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.097 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.097 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  26 QP=17.00 NAL=2 Slice:P Poc:52  I:211  P:1135 SKIP:4    size=50780 bytes
2019-11-26 13:52:12.100 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:12.177 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.178 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.179 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:3 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.180 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.180 26413-26413/com.example.test I/System.out:  -> PTS:3 T:0.100000
2019-11-26 13:52:12.180 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:3 t:0.100000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.186 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  27 QP=17.00 NAL=2 Slice:P Poc:54  I:169  P:1171 SKIP:10   size=49230 bytes
2019-11-26 13:52:12.255 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.257 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:4 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.257 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.258 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.258 26413-26413/com.example.test I/System.out:  -> PTS:4 T:0.133333
2019-11-26 13:52:12.258 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:4 t:0.133333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.262 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  28 QP=16.00 NAL=2 Slice:P Poc:56  I:237  P:1108 SKIP:5    size=54010 bytes
2019-11-26 13:52:12.336 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.337 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:5 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.337 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.337 26413-26413/com.example.test I/System.out:  -> PTS:5 T:0.166667
2019-11-26 13:52:12.338 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.339 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:5 t:0.166667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.345 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  29 QP=17.00 NAL=2 Slice:P Poc:58  I:140  P:1204 SKIP:6    size=45227 bytes
2019-11-26 13:52:12.346 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:12.416 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.417 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:6 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.417 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.417 26413-26413/com.example.test I/System.out:  -> PTS:6 T:0.200000
2019-11-26 13:52:12.417 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:6 t:0.200000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.418 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.423 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  30 QP=16.00 NAL=2 Slice:P Poc:60  I:133  P:1209 SKIP:8    size=52395 bytes
2019-11-26 13:52:12.495 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.497 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:7 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.497 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.497 26413-26413/com.example.test I/System.out:  -> PTS:7 T:0.233333
2019-11-26 13:52:12.497 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:7 t:0.233333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.502 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  31 QP=17.00 NAL=2 Slice:P Poc:62  I:118  P:1225 SKIP:7    size=47444 bytes
2019-11-26 13:52:12.503 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:12.510 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.579 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.580 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:8 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.581 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.582 26413-26413/com.example.test I/System.out:  -> PTS:8 T:0.266667
2019-11-26 13:52:12.582 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:8 t:0.266667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.587 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  32 QP=16.00 NAL=2 Slice:P Poc:64  I:125  P:1219 SKIP:6    size=56957 bytes
2019-11-26 13:52:12.589 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.657 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.658 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:9 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.658 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.658 26413-26413/com.example.test I/System.out:  -> PTS:9 T:0.300000
2019-11-26 13:52:12.659 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:9 t:0.300000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.664 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  33 QP=17.00 NAL=2 Slice:P Poc:66  I:375  P:963  SKIP:12   size=47875 bytes
2019-11-26 13:52:12.665 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:12.669 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.736 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.737 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:10 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.737 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.738 26413-26413/com.example.test I/System.out:  -> PTS:10 T:0.333333
2019-11-26 13:52:12.738 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:10 t:0.333333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.741 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  34 QP=17.00 NAL=2 Slice:P Poc:68  I:169  P:1169 SKIP:12   size=52251 bytes
2019-11-26 13:52:12.747 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.813 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.814 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45fa00] N:11 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.815 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.815 26413-26413/com.example.test I/System.out:  -> PTS:11 T:0.366667
2019-11-26 13:52:12.815 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45ee00] n:11 t:0.366667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.819 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  35 QP=16.00 NAL=2 Slice:P Poc:70  I:115  P:1229 SKIP:6    size=59388 bytes
2019-11-26 13:52:12.826 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:12.827 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.898 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.899 26413-26413/com.example.test V/RecordActivity: start() was not called successfully!
2019-11-26 13:52:12.899 26413-26413/com.example.test W/System.err: org.bytedeco.javacv.FrameFilter$Exception: start() was not called successfully!
2019-11-26 13:52:12.899 26413-26413/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:503)
2019-11-26 13:52:12.899 26413-26413/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:496)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:493)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at com.example.test.RecordActivity$CameraView.onPreviewFrame(RecordActivity.java:522)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at android.hardware.Camera$EventHandler.handleMessage(Camera.java:1262)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at android.os.Handler.dispatchMessage(Handler.java:106)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at android.os.Looper.loop(Looper.java:193)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at android.app.ActivityThread.main(ActivityThread.java:6912)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at java.lang.reflect.Method.invoke(Native Method)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:493)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:860)
2019-11-26 13:52:12.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] Setting 'video_size' to value '720x480'
2019-11-26 13:52:12.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] Setting 'pix_fmt' to value '24'
2019-11-26 13:52:12.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] Setting 'time_base' to value '1/30'
2019-11-26 13:52:12.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] Setting 'pixel_aspect' to value '1/1'
2019-11-26 13:52:12.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] w:720 h:480 pixfmt:nv21 tb:1/30 fr:0/1 sar:1/1 sws_param:
2019-11-26 13:52:12.907 26413-26603/com.example.test I/System.out: [setpts @ 0x770f45eec0] Setting 'expr' to value 'N'
2019-11-26 13:52:12.907 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] Setting 'fontfile' to value '/system/fonts/DroidSansMono.ttf'
2019-11-26 13:52:12.907 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] Setting 'text' to value '0:5'
2019-11-26 13:52:12.908 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] Setting 'fontsize' to value '30'
2019-11-26 13:52:12.908 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] Setting 'fontcolor' to value 'white'
2019-11-26 13:52:12.908 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.914 26413-26603/com.example.test I/System.out: [AVFilterGraph @ 0x770f47ec60] query_formats: 4 queried, 3 merged, 0 already done, 0 delayed
2019-11-26 13:52:12.914 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] TB:0.033333 FRAME_RATE:nan SAMPLE_RATE:nan
2019-11-26 13:52:12.978 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:12.979 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45eec0] N:0 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:12.979 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:12.980 26413-26413/com.example.test I/System.out:  -> PTS:0 T:0.000000
2019-11-26 13:52:12.980 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] n:0 t:0.000000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:12.982 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.988 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  36 QP=17.00 NAL=2 Slice:P Poc:72  I:100  P:1243 SKIP:7    size=51411 bytes
2019-11-26 13:52:13.059 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:13.061 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45eec0] N:1 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:13.062 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:13.062 26413-26413/com.example.test I/System.out:  -> PTS:1 T:0.033333
2019-11-26 13:52:13.062 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] n:1 t:0.033333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:13.067 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  37 QP=16.00 NAL=2 Slice:P Poc:74  I:97   P:1245 SKIP:8    size=56749 bytes
2019-11-26 13:52:13.072 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:13.136 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:13.137 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45eec0] N:2 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:13.137 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:13.137 26413-26413/com.example.test I/System.out:  -> PTS:2 T:0.066667
2019-11-26 13:52:13.137 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] n:2 t:0.066667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:13.141 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  38 QP=16.00 NAL=2 Slice:P Poc:76  I:86   P:1260 SKIP:4    size=58764 bytes
2019-11-26 13:52:13.142 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:13.151 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:13.021 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:13.022 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45eec0] N:3 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:13.023 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:13.023 26413-26413/com.example.test I/System.out:  -> PTS:3 T:0.100000
2019-11-26 13:52:13.023 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] n:3 t:0.100000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:13.025 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  39 QP=17.00 NAL=2 Slice:P Poc:78  I:88   P:1253 SKIP:9    size=51118 bytes
2019-11-26 13:52:13.037 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:13.106 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:13.107 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45eec0] N:4 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:13.107 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:13.107 26413-26413/com.example.test I/System.out:  -> PTS:4 T:0.133333
2019-11-26 13:52:13.107 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] n:4 t:0.133333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:13.112 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  40 QP=16.00 NAL=2 Slice:P Poc:80  I:92   P:1254 SKIP:4    size=58330 bytes
2019-11-26 13:52:13.114 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:13.120 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:13.184 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:13.186 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45eec0] N:5 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:13.186 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:13.186 26413-26413/com.example.test I/System.out:  -> PTS:5 T:0.166667
2019-11-26 13:52:13.186 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] n:5 t:0.166667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:13.191 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  41 QP=16.00 NAL=2 Slice:P Poc:82  I:102  P:1244 SKIP:4    size=59043 bytes
2019-11-26 13:52:13.199 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:13.265 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:13.266 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45eec0] N:6 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:13.267 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:13.267 26413-26413/com.example.test I/System.out:  -> PTS:6 T:0.200000
2019-11-26 13:52:13.267 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] n:6 t:0.200000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:13.272 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  42 QP=16.00 NAL=2 Slice:P Poc:84  I:112  P:1230 SKIP:8    size=57083 bytes
2019-11-26 13:52:13.273 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:13.278 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:13.341 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:13.342 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45eec0] N:7 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:13.342 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:13.343 26413-26413/com.example.test I/System.out:  -> PTS:7 T:0.233333
2019-11-26 13:52:13.343 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] n:7 t:0.233333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:13.348 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  43 QP=16.00 NAL=2 Slice:P Poc:86  I:93   P:1252 SKIP:5    size=58232 bytes
2019-11-26 13:52:13.368 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:13.427 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:13.429 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45eec0] N:8 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:13.429 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:13.429 26413-26413/com.example.test I/System.out:  -> PTS:8 T:0.266667
2019-11-26 13:52:13.429 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] n:8 t:0.266667 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:13.433 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  44 QP=17.00 NAL=2 Slice:P Poc:88  I:174  P:1165 SKIP:11   size=50529 bytes
2019-11-26 13:52:13.448 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:13.448 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:13.501 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:13.502 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45eec0] N:9 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:13.502 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:13.502 26413-26413/com.example.test I/System.out:  -> PTS:9 T:0.300000
2019-11-26 13:52:13.503 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] n:9 t:0.300000 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:13.507 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  45 QP=16.00 NAL=2 Slice:P Poc:90  I:187  P:1159 SKIP:4    size=58453 bytes
2019-11-26 13:52:13.528 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:13.585 26413-26413/com.example.test V/RecordActivity: Writing Frame
2019-11-26 13:52:13.586 26413-26413/com.example.test I/System.out: [setpts @ 0x770f45eec0] N:10 PTS:0 T:0.000000 POS:nan
2019-11-26 13:52:13.586 26413-26413/com.example.test I/System.out:  INTERLACED:0
2019-11-26 13:52:13.586 26413-26413/com.example.test I/System.out:  -> PTS:10 T:0.333333
2019-11-26 13:52:13.587 26413-26413/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] n:10 t:0.333333 text_w:54 text_h:21 x:0 y:0
2019-11-26 13:52:13.591 26413-26413/com.example.test I/System.out: [libx264 @ 0x771d6a7a00] frame=  46 QP=17.00 NAL=2 Slice:P Poc:92  I:221  P:1125 SKIP:4    size=47953 bytes
2019-11-26 13:52:13.596 26413-26413/com.example.test I/System.out: [rtmp @ 0x771f0b05a0] received bytes read report
2019-11-26 13:52:13.608 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:13.663 26413-26413/com.example.test V/RecordActivity: Writing Frame

And so on....

davepaiva on 26 Nov 2019

So, it's working just fine. What is the issue?

saudet on 26 Nov 2019

I keep getting this periodically and the app restarts after a minute or two

2019-11-26 13:52:12.899 26413-26413/com.example.test V/RecordActivity: start() was not called successfully!
2019-11-26 13:52:12.899 26413-26413/com.example.test W/System.err: org.bytedeco.javacv.FrameFilter$Exception: start() was not called successfully!
2019-11-26 13:52:12.899 26413-26413/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:503)
2019-11-26 13:52:12.899 26413-26413/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:496)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at org.bytedeco.javacv.FFmpegFrameFilter.push(FFmpegFrameFilter.java:493)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at com.example.test.RecordActivity$CameraView.onPreviewFrame(RecordActivity.java:522)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at android.hardware.Camera$EventHandler.handleMessage(Camera.java:1262)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at android.os.Handler.dispatchMessage(Handler.java:106)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at android.os.Looper.loop(Looper.java:193)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at android.app.ActivityThread.main(ActivityThread.java:6912)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at java.lang.reflect.Method.invoke(Native Method)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:493)
2019-11-26 13:52:12.900 26413-26413/com.example.test W/System.err:     at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:860)
2019-11-26 13:52:12.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] Setting 'video_size' to value '720x480'
2019-11-26 13:52:12.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] Setting 'pix_fmt' to value '24'
2019-11-26 13:52:12.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] Setting 'time_base' to value '1/30'
2019-11-26 13:52:12.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] Setting 'pixel_aspect' to value '1/1'
2019-11-26 13:52:12.906 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] w:720 h:480 pixfmt:nv21 tb:1/30 fr:0/1 sar:1/1 sws_param:
2019-11-26 13:52:12.907 26413-26603/com.example.test I/System.out: [setpts @ 0x770f45eec0] Setting 'expr' to value 'N'
2019-11-26 13:52:12.907 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] Setting 'fontfile' to value '/system/fonts/DroidSansMono.ttf'
2019-11-26 13:52:12.907 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] Setting 'text' to value '0:5'
2019-11-26 13:52:12.908 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] Setting 'fontsize' to value '30'
2019-11-26 13:52:12.908 26413-26603/com.example.test I/System.out: [Parsed_drawtext_0 @ 0x770f45fac0] Setting 'fontcolor' to value 'white'
2019-11-26 13:52:12.908 26413-26585/com.example.test V/RecordActivity: bufferReadResult: 3584
2019-11-26 13:52:12.914 26413-26603/com.example.test I/System.out: [AVFilterGraph @ 0x770f47ec60] query_formats: 4 queried, 3 merged, 0 already done, 0 delayed
2019-11-26 13:52:12.914 26413-26603/com.example.test I/System.out: [in @ 0x770f45ec80] TB:0.033333 FRAME_RATE:nan SAMPLE_RATE:nan
2019-11-26 13:52:12.978 26413-26413/com.example.test V/RecordActivity: Writing Frame

davepaiva on 26 Nov 2019

was wondering if anyone had any idea as to why the error keeps popping up

davepaiva on 26 Nov 2019

Well, it's not thread-safe, and you're not running everything in the same thread, so try to run everything in the same thread. If you still have issues running everything in the same thread, let me know! Thanks

saudet on 26 Nov 2019

👍1

Thanks, will try it out in some time and let you know :)

davepaiva on 26 Nov 2019

I can confirm that running it on the same thread works.
I ran the app for around 7 minutes and it did not result in any crashes :)
Thanks again !

davepaiva on 27 Nov 2019

👍1

Was this page helpful?

0 / 5 - 0 ratings