Recherche avancée

Sur d’autres sites (7031)

• Laravel Process() with FFMPEG times out for any video that is even kind of large

  16 août 2024, par Hunter

  I am creating an application that lets users upload video files, and once they do it will convert them all to .mp4's (it does some other things, but since this first part of the code is breaking before it gets a chance to reach the other stuff, and the process for each is pretty similar, lets just discuss this issue).

  



  Once a user submits, it gets sent to GameController@store. Below is a code sample (the one that keeps getting sent back to me as problematic) from the controller :

  



  $process = new Process(env('APP_FFMPEG', 'ffmpeg') . ' -i ' . $fileURL . ' -f mp4 -vcodec libx264 -preset medium -profile:v main -c:a aac -movflags +faststart ' . $newFileName . ' -hide_banner');
              $process->setTimeout(360);
              $process->setIdleTimeout(60);
              $process->run();
              if (!$process->isSuccessful()) {
                throw new ProcessFailedException($process);
              }


  



  I am using the Symfony Process() class to run the FFMpeg conversion. The weird thing is, when I run this with a 1 or 2 second video, it goes without a hitch. This, to me, rules out issues like path problems, permission problems, etc. Multiple file types work with this, as long as they are very short. As soon as I put in a video that is even around 1min, it returns with this :

  



  The process "/usr/local/bin/ffmpeg -i http://localhost/storage/team_1_folder/game_26/team_1_game_26_vid_1.mp4 -f mp4 -vcodec libx264 -preset medium -profile:v main -c:a aac -movflags +faststart storage/team_1_folder/game_26/convertedVideo_1.mp4 -hide_banner" exceeded the timeout of 360 seconds.


  



  Now, notice that it says 'timeout of 360 seconds'. That is because I have also edited ALL of the possible timeout constraints, as well as the file size constraints that I can think of. Here is what I have done :
  

  



  -Changed php.ini (in my MAMP installation) values :
  
—max_execution_time = 300 (default was 30)
  
—memory_limit = 1280M (default was 128)
  
—post_max_size = 800M
  
—upload_max_filesize = 3200M
  
-max_input_time=300
  

  



  -In the GameController (code above)
  
—$process->setTimeout(360) ;
  
—$process->setTimeout(360) ;
  

  



  After all that, with a big file, the thing will just stall for the 6 minutes that I have set on the timeout thing, and then send an error. Is FFmpeg just stalling, or is this a process issue ? Who knows. Errors surrounding these things are just beautifully vague.

  



  I have tagged Laravel, PHP, and FFmpeg in hopes that someone will recognize this issue. I know that Process() is sending me the error, but since it is sending me a timeout, I don't know what is at fault.

  



  I'm not ruling anything out, so hit me with ideas, even crazy ones !

  



  Edit
Here is the output of the -report. I cut some of it off because the end part gets repetitive and goes for literally 1000 lines :

  



  ffmpeg started on 2019-06-24 at 18:50:23
Report written to "ffmpeg-20190624-185023.log"
Command line:
/usr/local/bin/ffmpeg -i http://localhost/storage/team_1_folder/game_31/team_1_game_31_vid_1.mp4 -f mp4 -vcodec libx264 -preset medium -profile:v main -c:a aac -movflags +faststart storage/team_1_folder/game_31/convertedVideo_1.mp4 -report
ffmpeg version 4.1.3 Copyright (c) 2000-2019 the FFmpeg developers
  built with Apple LLVM version 10.0.1 (clang-1001.0.46.4)
  configuration: --prefix=/usr/local/Cellar/ffmpeg/4.1.3_1 --enable-shared --enable-pthreads --enable-version3 --enable-hardcoded-tables --enable-avresample --cc=clang --host-cflags='-I/Library/Java/JavaVirtualMachines/adoptopenjdk-11.0.2.jdk/Contents/Home/include -I/Library/Java/JavaVirtualMachines/adoptopenjdk-11.0.2.jdk/Contents/Home/include/darwin' --host-ldflags= --enable-ffplay --enable-gnutls --enable-gpl --enable-libaom --enable-libbluray --enable-libmp3lame --enable-libopus --enable-librubberband --enable-libsnappy --enable-libtesseract --enable-libtheora --enable-libvorbis --enable-libvpx --enable-libx264 --enable-libx265 --enable-libxvid --enable-lzma --enable-libfontconfig --enable-libfreetype --enable-frei0r --enable-libass --enable-libopencore-amrnb --enable-libopencore-amrwb --enable-libopenjpeg --enable-librtmp --enable-libspeex --enable-videotoolbox --disable-libjack --disable-indev=jack --enable-libaom --enable-libsoxr
  libavutil      56. 22.100 / 56. 22.100
  libavcodec     58. 35.100 / 58. 35.100
  libavformat    58. 20.100 / 58. 20.100
  libavdevice    58.  5.100 / 58.  5.100
  libavfilter     7. 40.101 /  7. 40.101
  libavresample   4.  0.  0 /  4.  0.  0
  libswscale      5.  3.100 /  5.  3.100
  libswresample   3.  3.100 /  3.  3.100
  libpostproc    55.  3.100 / 55.  3.100
Splitting the commandline.
Reading option '-i' ... matched as input url with argument 'http://localhost/storage/team_1_folder/game_31/team_1_game_31_vid_1.mp4'.
Reading option '-f' ... matched as option 'f' (force format) with argument 'mp4'.
Reading option '-vcodec' ... matched as option 'vcodec' (force video codec ('copy' to copy stream)) with argument 'libx264'.
Reading option '-preset' ... matched as AVOption 'preset' with argument 'medium'.
Reading option '-profile:v' ... matched as option 'profile' (set profile) with argument 'main'.
Reading option '-c:a' ... matched as option 'c' (codec name) with argument 'aac'.
Reading option '-movflags' ... matched as AVOption 'movflags' with argument '+faststart'.
Reading option 'storage/team_1_folder/game_31/convertedVideo_1.mp4' ... matched as output url.
Reading option '-report' ... matched as option 'report' (generate a report) with argument '1'.
Finished splitting the commandline.
Parsing a group of options: global .
Applying option report (generate a report) with argument 1.
Successfully parsed a group of options.
Parsing a group of options: input url http://localhost/storage/team_1_folder/game_31/team_1_game_31_vid_1.mp4.
Successfully parsed a group of options.
Opening an input file: http://localhost/storage/team_1_folder/game_31/team_1_game_31_vid_1.mp4.
[NULL @ 0x7f9ad480ae00] Opening 'http://localhost/storage/team_1_folder/game_31/team_1_game_31_vid_1.mp4' for reading
[http @ 0x7f9ad3c6b540] Setting default whitelist 'http,https,tls,rtp,tcp,udp,crypto,httpproxy'
[tcp @ 0x7f9ad3e00400] Original list of addresses:
[tcp @ 0x7f9ad3e00400] Address ::1 port 80
[tcp @ 0x7f9ad3e00400] Address 127.0.0.1 port 80
[tcp @ 0x7f9ad3e00400] Interleaved list of addresses:
[tcp @ 0x7f9ad3e00400] Address ::1 port 80
[tcp @ 0x7f9ad3e00400] Address 127.0.0.1 port 80
[tcp @ 0x7f9ad3e00400] Starting connection attempt to ::1 port 80
[tcp @ 0x7f9ad3e00400] Successfully connected to ::1 port 80
[http @ 0x7f9ad3c6b540] request: GET /storage/team_1_folder/game_31/team_1_game_31_vid_1.mp4 HTTP/1.1
User-Agent: Lavf/58.20.100
Accept: */*
Range: bytes=0-
Connection: close
Host: localhost
Icy-MetaData: 1


[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] ISO: File Type Major Brand: isom
[tcp @ 0x7f9ad3c6b840] Original list of addresses:
[tcp @ 0x7f9ad3c6b840] Address ::1 port 80
[tcp @ 0x7f9ad3c6b840] Address 127.0.0.1 port 80
[tcp @ 0x7f9ad3c6b840] Interleaved list of addresses:
[tcp @ 0x7f9ad3c6b840] Address ::1 port 80
[tcp @ 0x7f9ad3c6b840] Address 127.0.0.1 port 80
[tcp @ 0x7f9ad3c6b840] Starting connection attempt to ::1 port 80
[tcp @ 0x7f9ad3c6b840] Successfully connected to ::1 port 80
[http @ 0x7f9ad3c6b540] request: GET /storage/team_1_folder/game_31/team_1_game_31_vid_1.mp4 HTTP/1.1
User-Agent: Lavf/58.20.100
Accept: */*
Range: bytes=170169585-
Connection: close
Host: localhost
Icy-MetaData: 1


[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] Unknown dref type 0x206c7275 size 12
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] Processing st: 0, edit list 0 - media time: 0, duration: 10584600
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] stts: 0 ctts: 0, ctts_index: 0, ctts_count: 10575
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] stts: 1 ctts: 4002, ctts_index: 1, ctts_count: 10575
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] stts: 1000 ctts: 0, ctts_index: 2, ctts_count: 10575
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] stts: 2001 ctts: 0, ctts_index: 3, ctts_count: 10575
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] stts: 3002 ctts: 0, ctts_index: 4, ctts_count: 10575
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] stts: 4003 ctts: 4004, ctts_index: 5, ctts_count: 10575
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] stts: 5004 ctts: 0, ctts_index: 6, ctts_count: 10575


  



  Edit 2
I also found this towards the bottom :

  



  [mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] stts: 10582571 ctts: 0, ctts_index: 10573, ctts_count: 10575
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] stts: 10583572 ctts: 1001, ctts_index: 10574, ctts_count: 10575
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] Setting codecpar->delay to 1 for stream st: 0
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] Unknown dref type 0x206c7275 size 12
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] Processing st: 1, edit list 0 - media time: 0, duration: 15563816
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] Before avformat_find_stream_info() pos: 170509020 bytes read:372203 seeks:1 nb_streams:2
[h264 @ 0x7f9ad4811200] nal_unit_type: 7(SPS), nal_ref_idc: 3
[h264 @ 0x7f9ad4811200] nal_unit_type: 8(PPS), nal_ref_idc: 3
[tcp @ 0x7f9ad3c72d40] Original list of addresses:
[tcp @ 0x7f9ad3c72d40] Address ::1 port 80
[tcp @ 0x7f9ad3c72d40] Address 127.0.0.1 port 80
[tcp @ 0x7f9ad3c72d40] Interleaved list of addresses:
[tcp @ 0x7f9ad3c72d40] Address ::1 port 80
[tcp @ 0x7f9ad3c72d40] Address 127.0.0.1 port 80
[tcp @ 0x7f9ad3c72d40] Starting connection attempt to ::1 port 80
[tcp @ 0x7f9ad3c72d40] Successfully connected to ::1 port 80
[http @ 0x7f9ad3c6b540] request: GET /storage/team_1_folder/game_31/team_1_game_31_vid_1.mp4 HTTP/1.1
User-Agent: Lavf/58.20.100
Accept: */*
Range: bytes=48-
Connection: close
Host: localhost
Icy-MetaData: 1


[h264 @ 0x7f9ad4811200] nal_unit_type: 5(IDR), nal_ref_idc: 1
[h264 @ 0x7f9ad4811200] Format yuv420p chosen by get_format().
[h264 @ 0x7f9ad4811200] Reinit context to 1920x1088, pix_fmt: yuv420p
[h264 @ 0x7f9ad4811200] no picture 
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] All info found
[mov,mp4,m4a,3gp,3g2,mj2 @ 0x7f9ad480ae00] After avformat_find_stream_info() pos: 308454 bytes read:680609 seeks:2 frames:2
Input #0, mov,mp4,m4a,3gp,3g2,mj2, from 'http://localhost/storage/team_1_folder/game_31/team_1_game_31_vid_1.mp4':
  Metadata:
    major_brand     : isom
    minor_version   : 512
    compatible_brands: isomiso2avc1mp41
    encoder         : Lavf56.40.101
  Duration: 00:05:52.92, start: 0.000000, bitrate: 3865 kb/s
    Stream #0:0(und), 1, 1/30000: Video: h264 (High) (avc1 / 0x31637661), yuv420p(tv, bt709), 1920x1080 [SAR 1:1 DAR 16:9], 3730 kb/s, 29.97 fps, 29.97 tbr, 30k tbn, 59.94 tbc (default)
    Metadata:
      handler_name    : VideoHandler
    Stream #0:1(und), 1, 1/44100: Audio: aac (LC) (mp4a / 0x6134706D), 44100 Hz, stereo, fltp, 127 kb/s (default)
    Metadata:
      handler_name    : SoundHandler
Successfully opened the file.
Parsing a group of options: output url storage/team_1_folder/game_31/convertedVideo_1.mp4.
Applying option f (force format) with argument mp4.
Applying option vcodec (force video codec ('copy' to copy stream)) with argument libx264.
Applying option profile:v (set profile) with argument main.
Applying option c:a (codec name) with argument aac.
Successfully parsed a group of options.
Opening an output file: storage/team_1_folder/game_31/convertedVideo_1.mp4.
[file @ 0x7f9ad3f02740] Setting default whitelist 'file,crypto'
Successfully opened the file.
detected 4 logical cores
[h264 @ 0x7f9ad5813a00] nal_unit_type: 7(SPS), nal_ref_idc: 3
[h264 @ 0x7f9ad5813a00] nal_unit_type: 8(PPS), nal_ref_idc: 3
Stream mapping:
  Stream #0:0 -> #0:0 (h264 (native) -> h264 (libx264))
  Stream #0:1 -> #0:1 (aac (native) -> aac (native))
Press [q] to stop, [?] for help
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
[graph_1_in_0_1 @ 0x7f9ad3dbcc00] Setting 'time_base' to value '1/44100'
[graph_1_in_0_1 @ 0x7f9ad3dbcc00] Setting 'sample_rate' to value '44100'
[graph_1_in_0_1 @ 0x7f9ad3dbcc00] Setting 'sample_fmt' to value 'fltp'
[graph_1_in_0_1 @ 0x7f9ad3dbcc00] Setting 'channel_layout' to value '0x3'
[graph_1_in_0_1 @ 0x7f9ad3dbcc00] tb:1/44100 samplefmt:fltp samplerate:44100 chlayout:0x3
[format_out_0_1 @ 0x7f9ad3c71040] Setting 'sample_fmts' to value 'fltp'
[format_out_0_1 @ 0x7f9ad3c71040] Setting 'sample_rates' to value '96000|88200|64000|48000|44100|32000|24000|22050|16000|12000|11025|8000|7350'
[AVFilterGraph @ 0x7f9ad3e00440] query_formats: 4 queried, 9 merged, 0 already done, 0 delayed
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
[h264 @ 0x7f9ad5813a00] nal_unit_type: 5(IDR), nal_ref_idc: 1
[h264 @ 0x7f9ad5813a00] Format yuv420p chosen by get_format().
[h264 @ 0x7f9ad5813a00] Reinit context to 1920x1088, pix_fmt: yuv420p
[h264 @ 0x7f9ad5813a00] no picture 
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
[h264 @ 0x7f9ad5804600] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 1
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
[h264 @ 0x7f9ad5804c00] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
[h264 @ 0x7f9ad5805200] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
[h264 @ 0x7f9ad5805800] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
[h264 @ 0x7f9ad5813a00] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 1
[graph 0 input from stream 0:0 @ 0x7f9ad3dbfb80] Setting 'video_size' to value '1920x1080'
[graph 0 input from stream 0:0 @ 0x7f9ad3dbfb80] Setting 'pix_fmt' to value '0'
[graph 0 input from stream 0:0 @ 0x7f9ad3dbfb80] Setting 'time_base' to value '1/30000'
[graph 0 input from stream 0:0 @ 0x7f9ad3dbfb80] Setting 'pixel_aspect' to value '1/1'
[graph 0 input from stream 0:0 @ 0x7f9ad3dbfb80] Setting 'sws_param' to value 'flags=2'
[graph 0 input from stream 0:0 @ 0x7f9ad3dbfb80] Setting 'frame_rate' to value '30000/1001'
[graph 0 input from stream 0:0 @ 0x7f9ad3dbfb80] w:1920 h:1080 pixfmt:yuv420p tb:1/30000 fr:30000/1001 sar:1/1 sws_param:flags=2
[format @ 0x7f9ad3dc0100] Setting 'pix_fmts' to value 'yuv420p|yuvj420p|yuv422p|yuvj422p|yuv444p|yuvj444p|nv12|nv16|nv21|yuv420p10le|yuv422p10le|yuv444p10le|nv20le'
[AVFilterGraph @ 0x7f9ad3c6e880] query_formats: 4 queried, 3 merged, 0 already done, 0 delayed
[libx264 @ 0x7f9ad5811200] using mv_range_thread = 88
[libx264 @ 0x7f9ad5811200] using SAR=1/1
[libx264 @ 0x7f9ad5811200] using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 AVX FMA3 BMI2 AVX2
[libx264 @ 0x7f9ad5811200] profile Main, level 4.0
[libx264 @ 0x7f9ad5811200] 264 - core 155 r2917 0a84d98 - H.264/MPEG-4 AVC codec - Copyleft 2003-2018 - http://www.videolan.org/x264.html - options: cabac=1 ref=3 deblock=1:0:0 analyse=0x1:0x111 me=hex subme=7 psy=1 psy_rd=1.00:0.00 mixed_ref=1 me_range=16 chroma_me=1 trellis=1 8x8dct=0 cqm=0 deadzone=21,11 fast_pskip=1 chroma_qp_offset=-2 threads=6 lookahead_threads=1 sliced_threads=0 nr=0 decimate=1 interlaced=0 bluray_compat=0 constrained_intra=0 bframes=3 b_pyramid=2 b_adapt=1 b_bias=0 direct=1 weightb=1 open_gop=0 weightp=2 keyint=250 keyint_min=25 scenecut=40 intra_refresh=0 rc_lookahead=40 rc=crf mbtree=1 crf=23.0 qcomp=0.60 qpmin=0 qpmax=69 qpstep=4 ip_ratio=1.40 aq=1:1.00
Output #0, mp4, to 'storage/team_1_folder/game_31/convertedVideo_1.mp4':
  Metadata:
    major_brand     : isom
    minor_version   : 512
    compatible_brands: isomiso2avc1mp41
    encoder         : Lavf58.20.100
    Stream #0:0(und), 0, 1/30000: Video: h264 (libx264) (avc1 / 0x31637661), yuv420p, 1920x1080 [SAR 1:1 DAR 16:9], q=-1--1, 29.97 fps, 30k tbn, 29.97 tbc (default)
    Metadata:
      handler_name    : VideoHandler
      encoder         : Lavc58.35.100 libx264
    Side data:
      cpb: bitrate max/min/avg: 0/0/0 buffer size: 0 vbv_delay: -1
    Stream #0:1(und), 0, 1/44100: Audio: aac (LC) (mp4a / 0x6134706D), 44100 Hz, stereo, fltp, 128 kb/s (default)
    Metadata:
      handler_name    : SoundHandler
      encoder         : Lavc58.35.100 aac
Clipping frame in rate conversion by 0.000008
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
[h264 @ 0x7f9ad5804600] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
Clipping frame in rate conversion by 0.000999
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
[h264 @ 0x7f9ad5804c00] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
Clipping frame in rate conversion by 0.000999
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5805200] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5805800] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 1
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5813a00] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5804600] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5804c00] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5805200] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 1
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5805800] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5813a00] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5804600] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5804c00] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 1
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5805200] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5805800] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5813a00] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5804600] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 1
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5804c00] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999
[h264 @ 0x7f9ad5805200] nal_unit_type: 1(Coded slice of a non-IDR picture), nal_ref_idc: 0
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
cur_dts is invalid (this is harmless if it occurs once at the start per stream)
Clipping frame in rate conversion by 0.000999


  


• Android : FFMpeg (video creation) crashes with no exception when loading binaries in lower APIs (18 in my case) but works in newer ones

  6 mai 2019, par Diego Perez

  I have an app that uses FFMpeg for video creation (these next lines are the relevant build.gradle plugin files) :

  //writingminds
  
  api 'com.writingminds:FFmpegAndroid:0.3.2'
  
  //JavaCV video
  
  api group: 'org.bytedeco', name: 'javacv', version: '1.4.4'
  
  api group: 'org.bytedeco.javacpp-presets', name: 'opencv', version: '4.0.1-1.4.4', classifier: 'android-arm'
  
  api group: 'org.bytedeco.javacpp-presets', name: 'ffmpeg', version: '4.1-1.4.4', classifier: 'android-arm'

  And my app is working (and creating video) just fine in my phone with a newer Android 8 version but I’m having weird problems in my old API 18 tablet (where, as a note, I had to install multidex).

  These next lines are the main part of FFMpeg video creation, where binaries are loaded, and, in fact, binaries load are where app crashes in my tablet in the line "ffmpeg.loadBinary(new LoadBinaryResponseHandler()..."

  As you can see, I have a try/catch where the app crashes, but it crashes with no aparent exception, as catch blocks are never hit.

  public static String recordVideo(JSONObject objJSON) {
  
  
  
      String strReturn = Enum.Result.OK;
  
  
  
      try {
  
          fileName = objJSON.has("file_name") ? String.valueOf(objJSON.getString("file_name")) : "";
  
          videoPath = objJSON.has("video_path") ? String.valueOf(objJSON.getString("video_path")) : "";
  
      } catch (JSONException e) {
  
          ExceptionHandler.logException(e);
  
      }
  
  
  
      FFmpeg ffmpeg = FFmpeg.getInstance(ApplicationContext.get());
  
      try {
  
          ffmpeg.loadBinary(new LoadBinaryResponseHandler() {
  
  
  
              @Override
  
              public void onStart() {}
  
  
  
              @Override
  
              public void onFailure() {}
  
  
  
              @Override
  
              public void onSuccess() {}
  
  
  
              @Override
  
              public void onFinish() {}
  
          });
  
      } catch (FFmpegNotSupportedException e) {
  
          // Handle if FFmpeg is not supported by device
  
      } catch (Exception e) {
  
  
  
      }
  
  ...

  These next lines are the relevant part of the LogCat, but I cannot figure out where the problem resides, maybe an out of memory problem ?

  Any help will be much appreciated.

  04-28 21:44:45.873 13743-13964/com.artandwords.thoughtoftheday A/libc: Fatal signal 11 (SIGSEGV) at 0x00000000 (code=1), thread 13964 (AsyncTask #4)
  
  04-28 21:44:45.973 144-144/? I/DEBUG: *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
  
  04-28 21:44:45.983 144-144/? I/DEBUG: Build fingerprint: 'asus/WW_epad/ME302C:4.3/JSS15Q/WW_epad-V5.0.21-20140701:user/release-keys'
  
  04-28 21:44:45.983 144-144/? I/DEBUG: Revision: '0'
  
  04-28 21:44:45.983 144-144/? I/DEBUG: pid: 13743, tid: 13964, name: AsyncTask #4  >>> com.artandwords.thoughtoftheday <<<
  
  04-28 21:44:45.983 144-144/? I/DEBUG: signal 11 (SIGSEGV), code 1 (SEGV_MAPERR), fault addr 00000000
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     eax 00000000  ebx 000000c6  ecx 00000000  edx 00000000
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     esi 00000e59  edi 00000000
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     xcs 00000073  xds 0000007b  xes 0000007b  xfs 00000043  xss 0000007b
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     eip 784ed378  ebp 2200ff0c  esp 2200fec4  flags 00210246
  
  04-28 21:44:46.003 144-144/? I/DEBUG: backtrace:
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #00  pc 00087378  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #01  pc 00085d0e  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #02  pc 00073328  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #03  pc 0006f7ff  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #04  pc 0006f3bf  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #05  pc 000b92de  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #06  pc ffffffff  <unknown>
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #07  pc 001445aa  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.013 144-144/? I/DEBUG: stack:
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436850  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436854  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436858  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b43685c  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436860  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436864  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436868  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b43686c  3822676c  /system/lib/arm/libc.so
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436870  7b436a98  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436874  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436878  7b4368c8  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b43687c  7b436a98  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436880  383003a0  /system/lib/arm/libdl.so
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436884  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436888  7b4368c8  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b43688c  785aa5ab  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.013 144-144/? I/DEBUG:     #07  7b436890  7b4368a0  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436894  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436898  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b43689c  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368a0  7b4368c8  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368a4  7b436890  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368a8  785aa59d  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368ac  7b436a98  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368b0  7b437930  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368b4  220001d0  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368b8  7b436a70  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368bc  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368c0  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368c4  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368c8  7b436a88  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368cc  785f3141  /system/lib/libhoudini.so.3.4.7.44914
  
  
  
  
  
      --------- beginning of /dev/log/system
  
  04-28 21:44:46.063 450-470/? I/BootReceiver: Copying /data/tombstones/tombstone_03 to DropBox (SYSTEM_TOMBSTONE)
  
  04-28 21:44:46.063 450-13973/? W/ActivityManager:   Force finishing activity com.artandwords.thoughtoftheday/.activities.DisplayThoughtActivity
  
  04-28 21:44:46.073 145-862/? E/IMGSRV: :0: PVRDRMOpen: TP3, ret = 75
  
  04-28 21:44:46.093 450-13973/? E/JavaBinder: !!! FAILED BINDER TRANSACTION !!!
  
  04-28 21:44:46.093 450-483/? W/InputDispatcher: channel '21edd9e8 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.main.MainActivity (server)' ~ Consumer closed input channel or an error occurred.  events=0x9
  
  04-28 21:44:46.093 450-483/? E/InputDispatcher: channel '21edd9e8 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.main.MainActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
  
  04-28 21:44:46.093 155-13945/? W/TimedEventQueue: Event 25 was not found in the queue, already cancelled?
  
  04-28 21:44:46.093 155-3134/? W/AudioFlinger: session id 324 not found for pid 155
  
  04-28 21:44:46.103 450-450/? W/InputDispatcher: Attempted to unregister already unregistered input channel '21edd9e8 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.main.MainActivity (server)'
  
  04-28 21:44:46.103 450-755/? I/WindowState: WIN DEATH: Window{21b33a28 u0 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.DisplayThoughtActivity}
  
  04-28 21:44:46.103 450-13973/? W/ActivityManager: Exception thrown during pause
  
      android.os.TransactionTooLargeException
  
          at android.os.BinderProxy.transact(Native Method)
  
          at android.app.ApplicationThreadProxy.schedulePauseActivity(ApplicationThreadNative.java:642)
  
          at com.android.server.am.ActivityStack.startPausingLocked(ActivityStack.java:1007)
  
          at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3905)
  
          at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3837)
  
          at com.android.server.am.ActivityManagerService.handleAppCrashLocked(ActivityManagerService.java:8588)
  
          at com.android.server.am.ActivityManagerService.makeAppCrashingLocked(ActivityManagerService.java:8465)
  
          at com.android.server.am.ActivityManagerService.crashApplication(ActivityManagerService.java:9170)
  
          at com.android.server.am.ActivityManagerService.handleApplicationCrashInner(ActivityManagerService.java:8699)
  
          at com.android.server.am.NativeCrashListener$NativeCrashReporter.run(NativeCrashListener.java:86)
  
  04-28 21:44:46.103 450-450/? I/WindowState: WIN DEATH: Window{21edd9e8 u0 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.main.MainActivity}
  
  04-28 21:44:46.103 450-636/? I/WindowState: WIN DEATH: Window{21be0690 u0 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.DisplayThoughtActivity}
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: computeScreenConfigurationLocked() Enter {1.15 ?mcc?mnc ?locale ?layoutDir ?swdp ?wdp ?hdp ?density ?lsize ?long ?orien ?uimode ?night ?touch ?keyb/?/? ?nav/?}
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: dw=1200, dh=1920
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: appWidth=1200, appHeight=1848
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: tempdm=DisplayMetrics{density=1.5, width=1200, height=1848, scaledDensity=1.5, xdpi=221.201, ydpi=220.591}
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: dm=DisplayMetrics{density=1.5, width=1200, height=1848, scaledDensity=1.5, xdpi=221.201, ydpi=220.591}, ro.product.device=ME302C
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: getConfigDisplayWidth=1200, getConfigDisplayHeight=1810
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: screenWidthDp=800, screenHeightDp=1206
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: computeScreenConfigurationLocked() Leave {1.15 ?mcc?mnc ?locale ?layoutDir sw800dp w800dp h1206dp 240dpi xlrg port ?uimode ?night finger -keyb/v/h -nav/h}
  
  04-28 21:44:46.113 450-13973/? I/ActivityManager: Restarting because process died: ActivityRecord{21ab1f80 u0 com.artandwords.thoughtoftheday/.activities.main.MainActivity}
  
  04-28 21:44:46.113 450-13973/? W/ActivityManager: Exception when starting activity com.artandwords.thoughtoftheday/.activities.main.MainActivity
  
      android.os.DeadObjectException
  
          at android.os.BinderProxy.transact(Native Method)
  
          at android.app.ApplicationThreadProxy.scheduleLaunchActivity(ApplicationThreadNative.java:730)
  
          at com.android.server.am.ActivityStack.realStartActivityLocked(ActivityStack.java:733)
  
          at com.android.server.am.ActivityStack.startSpecificActivityLocked(ActivityStack.java:840)
  
          at com.android.server.am.ActivityStack.resumeTopActivityLocked(ActivityStack.java:1790)
  
          at com.android.server.am.ActivityStack.resumeTopActivityLocked(ActivityStack.java:1449)
  
          at com.android.server.am.ActivityStack.startPausingLocked(ActivityStack.java:1058)
  
          at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3905)
  
          at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3837)
  
          at com.android.server.am.ActivityManagerService.handleAppCrashLocked(ActivityManagerService.java:8588)
  
          at com.android.server.am.ActivityManagerService.makeAppCrashingLocked(ActivityManagerService.java:8465)
  
          at com.android.server.am.ActivityManagerService.crashApplication(ActivityManagerService.java:9170)
  
          at com.android.server.am.ActivityManagerService.handleApplicationCrashInner(ActivityManagerService.java:8699)
  
          at com.android.server.am.NativeCrashListener$NativeCrashReporter.run(NativeCrashListener.java:86)
  
  04-28 21:44:46.123 450-13973/? W/ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1396 com.android.server.am.ActivityStack.sendActivityBroadcastLocked:4923 com.android.server.am.ActivityStack.removeActivityFromHistoryLocked:4089 com.android.server.am.ActivityStack.removeHistoryRecordsForAppLocked:4346 com.android.server.am.ActivityManagerService.handleAppDiedLocked:3163 
  
  04-28 21:44:46.123 450-13973/? I/ActivityManager: Start proc com.artandwords.thoughtoftheday for activity com.artandwords.thoughtoftheday/.activities.main.MainActivity: pid=13975 
  
  </unknown>

  Edit 1 :

  Still investigating and entered FFmpeg.java to the method loadBinary while debugging, which code I’ll paste below and the line making the crash is switch (CpuArchHelper.getCpuArch())

  @Override
  
  public void loadBinary(FFmpegLoadBinaryResponseHandler ffmpegLoadBinaryResponseHandler) throws FFmpegNotSupportedException {
  
      String cpuArchNameFromAssets = null;
  
      switch (CpuArchHelper.getCpuArch()) {
  
          case x86:
  
              Log.i("Loading FFmpeg for x86 CPU");
  
              cpuArchNameFromAssets = "x86";
  
              break;
  
          case ARMv7:
  
              Log.i("Loading FFmpeg for armv7 CPU");
  
              cpuArchNameFromAssets = "armeabi-v7a";
  
              break;
  
          case NONE:
  
              throw new FFmpegNotSupportedException("Device not supported");
  
      }
  
  
  
      if (!TextUtils.isEmpty(cpuArchNameFromAssets)) {
  
          ffmpegLoadLibraryAsyncTask = new FFmpegLoadLibraryAsyncTask(context, cpuArchNameFromAssets, ffmpegLoadBinaryResponseHandler);
  
          ffmpegLoadLibraryAsyncTask.execute();
  
      } else {
  
          throw new FFmpegNotSupportedException("Device not supported");
  
      }
  
  }

  I’ll keep on investigating...

  Edit 2 :

  Further debugging has just lead me to the exact line where app crashes, and it’s CpuArchHelper.java from FFmpeg library :

  The line causing the crash is the next :

  String archInfo = cpuNativeArchHelper.cpuArchFromJNI();

  and I cannot even go inside cpuArchFromJNI() with F7 as it just crashes.

  package com.github.hiteshsondhi88.libffmpeg;
  
  
  
  import android.os.Build;
  
  
  
  class CpuArchHelper {
  
  
  
      static CpuArch getCpuArch() {
  
          Log.d("Build.CPU_ABI : " + Build.CPU_ABI);
  
          // check if device is x86 or x86_64
  
          if (Build.CPU_ABI.equals(getx86CpuAbi()) || Build.CPU_ABI.equals(getx86_64CpuAbi())) {
  
              return CpuArch.x86;
  
          } else {
  
              // check if device is armeabi
  
              if (Build.CPU_ABI.equals(getArmeabiv7CpuAbi())) {
  
                  ArmArchHelper cpuNativeArchHelper = new ArmArchHelper();
  
                  String archInfo = cpuNativeArchHelper.cpuArchFromJNI();
  
                  // check if device is arm v7
  
                  if (cpuNativeArchHelper.isARM_v7_CPU(archInfo)) {
  
                      // check if device is neon
  
                      return CpuArch.ARMv7;
  
                  }
  
                  // check if device is arm64 which is supported by ARMV7
  
              } else if (Build.CPU_ABI.equals(getArm64CpuAbi())) {
  
                  return CpuArch.ARMv7;
  
              }
  
          }
  
          return CpuArch.NONE;
  
      }
  
  
  
      static String getx86CpuAbi() {
  
          return "x86";
  
      }
  
  
  
      static String getx86_64CpuAbi() {
  
          return "x86_64";
  
      }
  
  
  
      static String getArm64CpuAbi() {
  
          return "arm64-v8a";
  
      }
  
  
  
      static String getArmeabiv7CpuAbi() {
  
          return "armeabi-v7a";
  
      }
  
  }

  This is ArmArchHelper.java class :

  package com.github.hiteshsondhi88.libffmpeg;
  
  
  
  class ArmArchHelper {
  
      static {
  
          System.loadLibrary("ARM_ARCH");
  
      }
  
  
  
      native String cpuArchFromJNI();
  
  
  
      boolean isARM_v7_CPU(String cpuInfoString) {
  
          return cpuInfoString.contains("v7");
  
      }
  
  
  
      boolean isNeonSupported(String cpuInfoString) {
  
          // check cpu arch for loading correct ffmpeg lib
  
          return cpuInfoString.contains("-neon");
  
      }
  
  
  
  }

  Edit 3 :

  Reading carefully LogCat I’ve noticed there is a TransactionTooLarge Exception :

  04-28 21:44:46.103 450-13973/? W/ActivityManager: Exception thrown during pause
  
      android.os.TransactionTooLargeException
  
          at android.os.BinderProxy.transact(Native Method)
  
          at android.app.ApplicationThreadProxy.schedulePauseActivity(ApplicationThreadNative.java:642)
  
          at com.android.server.am.ActivityStack.startPausingLocked(ActivityStack.java:1007)
  
          at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3905)
  
          at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3837)
  
          at com.android.server.am.ActivityManagerService.handleAppCrashLocked(ActivityManagerService.java:8588)
  
          at com.android.server.am.ActivityManagerService.makeAppCrashingLocked(ActivityManagerService.java:8465)
  
          at com.android.server.am.ActivityManagerService.crashApplication(ActivityManagerService.java:9170)
  
          at com.android.server.am.ActivityManagerService.handleApplicationCrashInner(ActivityManagerService.java:8699)
  
          at com.android.server.am.NativeCrashListener$NativeCrashReporter.run(NativeCrashListener.java:86)

  Maybe this is what makes my app to crash, but I don’t know what to do with that, as it happens inside the FFMpeg library :s

  Edit 3 :

  As a note, I’ve tried in an old Android 4.2.2 (API 17) phone I also own and it’s working just fine, the video is generated without crashing.

• Android : FFMpeg video creation crashes with no exception when loading binaries in lower APIs (18 in my case)

  29 avril 2019, par Diego Perez

  I have an app that uses FFMpeg for video creation (these next lines are the relevant build.gradle plugin files) :

  //writingminds
  
  api 'com.writingminds:FFmpegAndroid:0.3.2'
  
  //JavaCV video
  
  api group: 'org.bytedeco', name: 'javacv', version: '1.4.4'
  
  api group: 'org.bytedeco.javacpp-presets', name: 'opencv', version: '4.0.1-1.4.4', classifier: 'android-arm'
  
  api group: 'org.bytedeco.javacpp-presets', name: 'ffmpeg', version: '4.1-1.4.4', classifier: 'android-arm'

  And my app is working (and creating video) just fine in my phone with a newer Android 8 version but I’m having weird problems in my old API 18 tablet (where, as a note, I had to install multidex).

  These next lines are the main part of FFMpeg video creation, where binaries are loaded, and, in fact, binaries load are where app crashes in my old tablet in the line "ffmpeg.loadBinary(new LoadBinaryResponseHandler()..."

  As you can see, I have a try/catch where the app crashes, but it crashes with no exception, as catch blocks are never hit.

  public static String recordVideo(JSONObject objJSON) {
  
  
  
      String strReturn = Enum.Result.OK;
  
  
  
      try {
  
          fileName = objJSON.has("file_name") ? String.valueOf(objJSON.getString("file_name")) : "";
  
          videoPath = objJSON.has("video_path") ? String.valueOf(objJSON.getString("video_path")) : "";
  
      } catch (JSONException e) {
  
          ExceptionHandler.logException(e);
  
      }
  
  
  
      FFmpeg ffmpeg = FFmpeg.getInstance(ApplicationContext.get());
  
      try {
  
          ffmpeg.loadBinary(new LoadBinaryResponseHandler() {
  
  
  
              @Override
  
              public void onStart() {}
  
  
  
              @Override
  
              public void onFailure() {}
  
  
  
              @Override
  
              public void onSuccess() {}
  
  
  
              @Override
  
              public void onFinish() {}
  
          });
  
      } catch (FFmpegNotSupportedException e) {
  
          // Handle if FFmpeg is not supported by device
  
      } catch (Exception e) {
  
  
  
      }
  
  ...

  These next lines are the relevant part of the LogCat, but I cannot figure out where the problem resides, maybe an out of memory problem ?

  Any help will be much appreciated.

  04-28 21:44:45.873 13743-13964/com.artandwords.thoughtoftheday A/libc: Fatal signal 11 (SIGSEGV) at 0x00000000 (code=1), thread 13964 (AsyncTask #4)
  
  04-28 21:44:45.973 144-144/? I/DEBUG: *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
  
  04-28 21:44:45.983 144-144/? I/DEBUG: Build fingerprint: 'asus/WW_epad/ME302C:4.3/JSS15Q/WW_epad-V5.0.21-20140701:user/release-keys'
  
  04-28 21:44:45.983 144-144/? I/DEBUG: Revision: '0'
  
  04-28 21:44:45.983 144-144/? I/DEBUG: pid: 13743, tid: 13964, name: AsyncTask #4  >>> com.artandwords.thoughtoftheday <<<
  
  04-28 21:44:45.983 144-144/? I/DEBUG: signal 11 (SIGSEGV), code 1 (SEGV_MAPERR), fault addr 00000000
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     eax 00000000  ebx 000000c6  ecx 00000000  edx 00000000
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     esi 00000e59  edi 00000000
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     xcs 00000073  xds 0000007b  xes 0000007b  xfs 00000043  xss 0000007b
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     eip 784ed378  ebp 2200ff0c  esp 2200fec4  flags 00210246
  
  04-28 21:44:46.003 144-144/? I/DEBUG: backtrace:
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #00  pc 00087378  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #01  pc 00085d0e  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #02  pc 00073328  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #03  pc 0006f7ff  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #04  pc 0006f3bf  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #05  pc 000b92de  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #06  pc ffffffff  <unknown>
  
  04-28 21:44:46.003 144-144/? I/DEBUG:     #07  pc 001445aa  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.013 144-144/? I/DEBUG: stack:
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436850  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436854  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436858  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b43685c  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436860  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436864  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436868  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b43686c  3822676c  /system/lib/arm/libc.so
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436870  7b436a98  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436874  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436878  7b4368c8  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b43687c  7b436a98  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436880  383003a0  /system/lib/arm/libdl.so
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436884  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436888  7b4368c8  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b43688c  785aa5ab  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.013 144-144/? I/DEBUG:     #07  7b436890  7b4368a0  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436894  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b436898  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b43689c  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368a0  7b4368c8  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368a4  7b436890  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368a8  785aa59d  /system/lib/libhoudini.so.3.4.7.44914
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368ac  7b436a98  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368b0  7b437930  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368b4  220001d0  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368b8  7b436a70  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368bc  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368c0  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368c4  00000000  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368c8  7b436a88  
  
  04-28 21:44:46.013 144-144/? I/DEBUG:          7b4368cc  785f3141  /system/lib/libhoudini.so.3.4.7.44914
  
  
  
  
  
      --------- beginning of /dev/log/system
  
  04-28 21:44:46.063 450-470/? I/BootReceiver: Copying /data/tombstones/tombstone_03 to DropBox (SYSTEM_TOMBSTONE)
  
  04-28 21:44:46.063 450-13973/? W/ActivityManager:   Force finishing activity com.artandwords.thoughtoftheday/.activities.DisplayThoughtActivity
  
  04-28 21:44:46.073 145-862/? E/IMGSRV: :0: PVRDRMOpen: TP3, ret = 75
  
  04-28 21:44:46.093 450-13973/? E/JavaBinder: !!! FAILED BINDER TRANSACTION !!!
  
  04-28 21:44:46.093 450-483/? W/InputDispatcher: channel '21edd9e8 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.main.MainActivity (server)' ~ Consumer closed input channel or an error occurred.  events=0x9
  
  04-28 21:44:46.093 450-483/? E/InputDispatcher: channel '21edd9e8 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.main.MainActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
  
  04-28 21:44:46.093 155-13945/? W/TimedEventQueue: Event 25 was not found in the queue, already cancelled?
  
  04-28 21:44:46.093 155-3134/? W/AudioFlinger: session id 324 not found for pid 155
  
  04-28 21:44:46.103 450-450/? W/InputDispatcher: Attempted to unregister already unregistered input channel '21edd9e8 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.main.MainActivity (server)'
  
  04-28 21:44:46.103 450-755/? I/WindowState: WIN DEATH: Window{21b33a28 u0 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.DisplayThoughtActivity}
  
  04-28 21:44:46.103 450-13973/? W/ActivityManager: Exception thrown during pause
  
      android.os.TransactionTooLargeException
  
          at android.os.BinderProxy.transact(Native Method)
  
          at android.app.ApplicationThreadProxy.schedulePauseActivity(ApplicationThreadNative.java:642)
  
          at com.android.server.am.ActivityStack.startPausingLocked(ActivityStack.java:1007)
  
          at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3905)
  
          at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3837)
  
          at com.android.server.am.ActivityManagerService.handleAppCrashLocked(ActivityManagerService.java:8588)
  
          at com.android.server.am.ActivityManagerService.makeAppCrashingLocked(ActivityManagerService.java:8465)
  
          at com.android.server.am.ActivityManagerService.crashApplication(ActivityManagerService.java:9170)
  
          at com.android.server.am.ActivityManagerService.handleApplicationCrashInner(ActivityManagerService.java:8699)
  
          at com.android.server.am.NativeCrashListener$NativeCrashReporter.run(NativeCrashListener.java:86)
  
  04-28 21:44:46.103 450-450/? I/WindowState: WIN DEATH: Window{21edd9e8 u0 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.main.MainActivity}
  
  04-28 21:44:46.103 450-636/? I/WindowState: WIN DEATH: Window{21be0690 u0 com.artandwords.thoughtoftheday/com.artandwords.thoughtoftheday.activities.DisplayThoughtActivity}
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: computeScreenConfigurationLocked() Enter {1.15 ?mcc?mnc ?locale ?layoutDir ?swdp ?wdp ?hdp ?density ?lsize ?long ?orien ?uimode ?night ?touch ?keyb/?/? ?nav/?}
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: dw=1200, dh=1920
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: appWidth=1200, appHeight=1848
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: tempdm=DisplayMetrics{density=1.5, width=1200, height=1848, scaledDensity=1.5, xdpi=221.201, ydpi=220.591}
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: dm=DisplayMetrics{density=1.5, width=1200, height=1848, scaledDensity=1.5, xdpi=221.201, ydpi=220.591}, ro.product.device=ME302C
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: getConfigDisplayWidth=1200, getConfigDisplayHeight=1810
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: screenWidthDp=800, screenHeightDp=1206
  
  04-28 21:44:46.113 450-13973/? I/WindowManager: computeScreenConfigurationLocked() Leave {1.15 ?mcc?mnc ?locale ?layoutDir sw800dp w800dp h1206dp 240dpi xlrg port ?uimode ?night finger -keyb/v/h -nav/h}
  
  04-28 21:44:46.113 450-13973/? I/ActivityManager: Restarting because process died: ActivityRecord{21ab1f80 u0 com.artandwords.thoughtoftheday/.activities.main.MainActivity}
  
  04-28 21:44:46.113 450-13973/? W/ActivityManager: Exception when starting activity com.artandwords.thoughtoftheday/.activities.main.MainActivity
  
      android.os.DeadObjectException
  
          at android.os.BinderProxy.transact(Native Method)
  
          at android.app.ApplicationThreadProxy.scheduleLaunchActivity(ApplicationThreadNative.java:730)
  
          at com.android.server.am.ActivityStack.realStartActivityLocked(ActivityStack.java:733)
  
          at com.android.server.am.ActivityStack.startSpecificActivityLocked(ActivityStack.java:840)
  
          at com.android.server.am.ActivityStack.resumeTopActivityLocked(ActivityStack.java:1790)
  
          at com.android.server.am.ActivityStack.resumeTopActivityLocked(ActivityStack.java:1449)
  
          at com.android.server.am.ActivityStack.startPausingLocked(ActivityStack.java:1058)
  
          at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3905)
  
          at com.android.server.am.ActivityStack.finishActivityLocked(ActivityStack.java:3837)
  
          at com.android.server.am.ActivityManagerService.handleAppCrashLocked(ActivityManagerService.java:8588)
  
          at com.android.server.am.ActivityManagerService.makeAppCrashingLocked(ActivityManagerService.java:8465)
  
          at com.android.server.am.ActivityManagerService.crashApplication(ActivityManagerService.java:9170)
  
          at com.android.server.am.ActivityManagerService.handleApplicationCrashInner(ActivityManagerService.java:8699)
  
          at com.android.server.am.NativeCrashListener$NativeCrashReporter.run(NativeCrashListener.java:86)
  
  04-28 21:44:46.123 450-13973/? W/ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.startService:1396 com.android.server.am.ActivityStack.sendActivityBroadcastLocked:4923 com.android.server.am.ActivityStack.removeActivityFromHistoryLocked:4089 com.android.server.am.ActivityStack.removeHistoryRecordsForAppLocked:4346 com.android.server.am.ActivityManagerService.handleAppDiedLocked:3163 
  
  04-28 21:44:46.123 450-13973/? I/ActivityManager: Start proc com.artandwords.thoughtoftheday for activity com.artandwords.thoughtoftheday/.activities.main.MainActivity: pid=13975 
  
  </unknown>

  Edit 1 :

  Still investigating and entered FFmpeg.java to the method loadBinary while debugging, which code I’ll paste below and the line making the crash is switch (CpuArchHelper.getCpuArch())

  @Override
  public void loadBinary(FFmpegLoadBinaryResponseHandler ffmpegLoadBinaryResponseHandler) throws FFmpegNotSupportedException
  String cpuArchNameFromAssets = null ;
  switch (CpuArchHelper.getCpuArch())
  case x86 :
  Log.i("Loading FFmpeg for x86 CPU") ;
  cpuArchNameFromAssets = "x86" ;
  break ;
  case ARMv7 :
  Log.i("Loading FFmpeg for armv7 CPU") ;
  cpuArchNameFromAssets = "armeabi-v7a" ;
  break ;
  case NONE :
  throw new FFmpegNotSupportedException("Device not supported") ;
  

  if (!TextUtils.isEmpty(cpuArchNameFromAssets)) {
  
      ffmpegLoadLibraryAsyncTask = new FFmpegLoadLibraryAsyncTask(context, cpuArchNameFromAssets, ffmpegLoadBinaryResponseHandler);
  
      ffmpegLoadLibraryAsyncTask.execute();
  
  } else {
  
      throw new FFmpegNotSupportedException("Device not supported");
  
  }

  I’ll keep on investigating...

  Edit 2 :

  Further debugging has just lead me to the exact line where app crashes, and it’s CpuArchHelper.java from FFmpeg library :

  The line causing the crash is the next :

  String archInfo = cpuNativeArchHelper.cpuArchFromJNI();

  and I cannot even go inside cpuArchFromJNI() with F7 as it just crashes.

  package com.github.hiteshsondhi88.libffmpeg;
  
  
  
  import android.os.Build;
  
  
  
  class CpuArchHelper {
  
  
  
      static CpuArch getCpuArch() {
  
          Log.d("Build.CPU_ABI : " + Build.CPU_ABI);
  
          // check if device is x86 or x86_64
  
          if (Build.CPU_ABI.equals(getx86CpuAbi()) || Build.CPU_ABI.equals(getx86_64CpuAbi())) {
  
              return CpuArch.x86;
  
          } else {
  
              // check if device is armeabi
  
              if (Build.CPU_ABI.equals(getArmeabiv7CpuAbi())) {
  
                  ArmArchHelper cpuNativeArchHelper = new ArmArchHelper();
  
                  String archInfo = cpuNativeArchHelper.cpuArchFromJNI();
  
                  // check if device is arm v7
  
                  if (cpuNativeArchHelper.isARM_v7_CPU(archInfo)) {
  
                      // check if device is neon
  
                      return CpuArch.ARMv7;
  
                  }
  
                  // check if device is arm64 which is supported by ARMV7
  
              } else if (Build.CPU_ABI.equals(getArm64CpuAbi())) {
  
                  return CpuArch.ARMv7;
  
              }
  
          }
  
          return CpuArch.NONE;
  
      }
  
  
  
      static String getx86CpuAbi() {
  
          return "x86";
  
      }
  
  
  
      static String getx86_64CpuAbi() {
  
          return "x86_64";
  
      }
  
  
  
      static String getArm64CpuAbi() {
  
          return "arm64-v8a";
  
      }
  
  
  
      static String getArmeabiv7CpuAbi() {
  
          return "armeabi-v7a";
  
      }
  
  }

  This is ArmArchHelper.java class :

  package com.github.hiteshsondhi88.libffmpeg;
  
  
  
  class ArmArchHelper {
  
      static {
  
          System.loadLibrary("ARM_ARCH");
  
      }
  
  
  
      native String cpuArchFromJNI();
  
  
  
      boolean isARM_v7_CPU(String cpuInfoString) {
  
          return cpuInfoString.contains("v7");
  
      }
  
  
  
      boolean isNeonSupported(String cpuInfoString) {
  
          // check cpu arch for loading correct ffmpeg lib
  
          return cpuInfoString.contains("-neon");
  
      }
  
  
  
  }