Server Crash with Unknown Error

#1
Hi, I’m using CasparCG 2.0.7 Server on Windows 10 to stream-in a video channel via udp. I have put a banner that worked perfectly fine. When I tested the playout for longer time, it crashed at random times (15 minutes to 45 minutes) showing the following error:

"Unknown Error" [struct caspar::tag_msg_info *] = Invalid data found when processing input

or
mmco: unref short failure

I have tested it many times and it always crashes. I have run the same video channel using ffmpeg library (ffplay.exe). It did not crash even for once despite showing some errors (concealing dc ac mv errors, PES mismatch etc).

System Information/Log:

Code: Select all

Type "q" to close application.
Logging [info] or higher severity to log\

[2018-02-26 08:41:46.908] [4540] [info]    ############################################################################
[2018-02-26 08:41:46.916] [4540] [info]    CasparCG Server is distributed by the Swedish Broadcasting Corporation (SVT)
[2018-02-26 08:41:46.920] [4540] [info]    under the GNU General Public License GPLv3 or higher.
[2018-02-26 08:41:46.924] [4540] [info]    Please see LICENSE.TXT for details.
[2018-02-26 08:41:46.927] [4540] [info]    http://www.casparcg.com/
[2018-02-26 08:41:46.930] [4540] [info]    ############################################################################
[2018-02-26 08:41:46.935] [4540] [info]    Starting CasparCG Video and Graphics Playout Server 2.0.7.e9fc25a Stable
[2018-02-26 08:41:46.938] [4540] [info]    on Windows 10 Pro
[2018-02-26 08:41:46.940] [4540] [info]    Intel(R) Core(TM) i7-3740QM CPU @ 2.70GHz Physical Threads: 8
[2018-02-26 08:41:46.944] [4540] [info]    Latitude E6430
[2018-02-26 08:41:46.946] [4540] [info]    Decklink Not found
[2018-02-26 08:41:46.947] [4540] [info]    Bluefish Not found
[2018-02-26 08:41:46.949] [4540] [info]    FreeImage 3.15.4
[2018-02-26 08:41:46.951] [4540] [info]    FFMPEG-avcodec 55.52.102
[2018-02-26 08:41:46.954] [4540] [info]    FFMPEG-avformat 55.33.100
[2018-02-26 08:41:46.956] [4540] [info]    FFMPEG-avfilter 4.2.100
[2018-02-26 08:41:46.958] [4540] [info]    FFMPEG-avutil 52.66.100
[2018-02-26 08:41:46.960] [4540] [info]    FFMPEG-swscale 2.5.102
[2018-02-26 08:41:46.962] [4540] [info]    Flash 18.0.0.203
[2018-02-26 08:41:46.964] [4540] [info]    flash[cg20.fth.pal|0] Initialized.
[2018-02-26 08:41:46.966] [4540] [info]    flash[cg20.fth.pal|0] Invoking info-command: <invoke name="GetInfo" returntype="xml"><arguments></arguments></invoke>
[2018-02-26 08:41:47.043] [11584] [debug]   flash-player[cg20.fth.pal|1024x576] [command]      <invoke name="OnCommand" returntype="xml"><arguments><string>Command recieved @GetInfo@?@</string></arguments></invoke>
[2018-02-26 08:41:47.105] [11584] [info]    flash-player[cg20.fth.pal|1024x576] Initialized.
[2018-02-26 08:41:47.109] [11584] [debug]   flash-player[cg20.fth.pal|1024x576] [command]      <invoke name="OnCommand" returntype="xml"><arguments><string>Command recieved @GetInfo@?@</string></arguments></invoke>
[2018-02-26 08:41:47.185] [4540]  [trace]   Template-Host 2.0.4.3803 RC
[2018-02-26 08:41:47.188] [4540]  [info]    NewTek iVGA unavailable (Processing.AirSend.x86.dll)
[2018-02-26 08:41:47.192] [4540]  [info]    casparcg.config:
-----------------------------------------
<?xml version="1.0" encoding="utf-8"?>
<configuration>
   <paths>
      <media-path>media\</media-path>
      <log-path>log\</log-path>
      <data-path>data\</data-path>
      <template-path>templates\</template-path>
      <thumbnails-path>thumbnails\</thumbnails-path>
   </paths>
   <channels>
      <channel>
         <video-mode>PAL</video-mode>
         <consumers>
            <screen>
               <device>1</device>
            </screen>
            <system-audio/>
         </consumers>
      </channel>
   </channels>
   <controllers>
      <tcp>
         <port>5250</port>
         <protocol>AMCP</protocol>
      </tcp>
   </controllers>
</configuration>
-----------------------------------------
[2018-02-26 08:41:47.236] [4540]  [info]    Initialized html module.
[2018-02-26 08:41:47.238] [4540]  [info]    Initializing OpenGL Device.
[2018-02-26 08:41:47.270] [6104]  [info]    OpenGL 4.0.0 - Build 10.18.10.4425 Intel
[2018-02-26 08:41:47.273] [6104]  [info]    Successfully initialized OpenGL Device.
[2018-02-26 08:41:47.290] [4540]  [info]    Initialized ffmpeg module.
[2018-02-26 08:41:47.294] [4540]  [info]    Initialized bluefish module.
[2018-02-26 08:41:47.310] [4540]  [info]    Initialized decklink module.
[2018-02-26 08:41:47.313] [4540]  [info]    Initialized oal module.
[2018-02-26 08:41:47.317] [4540]  [info]    Initialized newtek module.
[2018-02-26 08:41:47.321] [4540]  [info]    Initialized ogl module.
[2018-02-26 08:41:47.324] [4540]  [info]    Initialized flash module.
[2018-02-26 08:41:47.327] [4540]  [info]    Initialized image module.
[2018-02-26 08:41:47.815] [6104]  [info]    [shader] Blend-modes are disabled.
[2018-02-26 08:41:47.818] [4540]  [warning] [image_mixer] TextureBarrierNV not supported. Post processing will not be available
[2018-02-26 08:41:47.825] [4540]  [info]    video_channel[1|PAL] Successfully Initialized.
[2018-02-26 08:41:47.871] [4540]  [info]
+---------------+
| filter_buffer |default--[720x576 64:45 bgra]--auto-inserted scaler 1:default
|   (buffer)    |
+---------------+

                                                             +-------------------+
auto-inserted scaler 0:default--[720x576 64:45 bgra]--default| filter_buffersink |
                                                             |   (buffersink)    |
                                                             +-------------------+

                                                             +-----------------+
auto-inserted scaler 1:default--[720x576 64:45 gbrp]--default| Parsed_format_0 |default--[720x576 64:45 gbrp]--Parsed_yadif_1:default
                                                             |    (format)     |
                                                             +-----------------+

                                                      +----------------+
Parsed_format_0:default--[720x576 64:45 gbrp]--default| Parsed_yadif_1 |default--[720x576 64:45 gbrp]--auto-inserted scaler 0:default
                                                      |    (yadif)     |
                                                      +----------------+

                                                     +------------------------+
Parsed_yadif_1:default--[720x576 64:45 gbrp]--default| auto-inserted scaler 0 |default--[720x576 64:45 bgra]--filter_buffersink:default
                                                     |        (scale)         |
                                                     +------------------------+

                                                    +------------------------+
filter_buffer:default--[720x576 64:45 bgra]--default| auto-inserted scaler 1 |default--[720x576 64:45 gbrp]--Parsed_format_0:default
                                                    |        (scale)         |
                                                    +------------------------+


[2018-02-26 08:41:47.974] [4540]  [info]    Screen consumer [1|PAL] Successfully Initialized.
[2018-02-26 08:41:47.979] [1988]  [info]    output[1] Screen consumer [1|PAL] Added.
[2018-02-26 08:41:48.135] [9924]  [info]    Screen consumer [1|PAL] Successfully Initialized.
[2018-02-26 08:41:48.215] [4540]  [info]    oal[1|PAL] Sucessfully Initialized.
[2018-02-26 08:41:48.256] [1988]  [info]    output[1] oal[1|PAL] Added.
[2018-02-26 08:41:48.260] [4540]  [info]    Initialized channels.
[2018-02-26 08:41:48.263] [4540]  [warning] [image_mixer] TextureBarrierNV not supported. Post processing will not be available
[2018-02-26 08:41:48.271] [4540]  [info]    Initialized thumbnail generator.
[2018-02-26 08:41:48.278] [4540]  [info]    WinSock2 Initialized.
[2018-02-26 08:41:48.283] [4540]  [info]    Listener successfully initialized
[2018-02-26 08:41:48.290] [4540]  [info]    Initialized controllers.
[2018-02-26 08:41:48.293] [4540]  [info]    Initialized osc.
[2018-02-26 08:41:48.302] [4540]  [info]    Started initial media information retrieval.
[2018-02-26 08:41:48.441] [11584] [info]    flash-player[cg20.fth.pal|1024x576] Uninitialized.
[2018-02-26 08:41:48.446] [528]   [info]    flash[cg20.fth.pal|5000] Uninitialized.
[2018-02-26 08:41:48.913] [8136]  [info]    Initial media information retrieval finished.
Error Log:

Code: Select all

PLAY 1-1 udp://10.201.1.62:05656
[2018-02-26 08:44:27.536] [3272] [info]    Received message from Console: PLAY 1-1 udp://10.201.1.62:05656\r\n
[2018-02-26 08:44:31.174] [3944] [error]   [ffmpeg] [h264 @ 0B765EA0] non-existing PPS 0 referenced
[2018-02-26 08:44:31.178] [3944] [error]   [ffmpeg] [h264 @ 0B765EA0] non-existing PPS 0 referenced
[2018-02-26 08:44:31.181] [3944] [error]   [ffmpeg] [h264 @ 0B765EA0] decode_slice_header error
[2018-02-26 08:44:31.185] [3944] [error]   [ffmpeg] [h264 @ 0B765EA0] no frame!
[2018-02-26 08:44:31.428] [3944] [error]   [ffmpeg] [h264 @ 0B765EA0] non-existing PPS 0 referenced
[2018-02-26 08:44:31.436] [3944] [error]   [ffmpeg] [h264 @ 0B765EA0] non-existing PPS 0 referenced
[2018-02-26 08:44:31.446] [3944] [error]   [ffmpeg] [h264 @ 0B765EA0] decode_slice_header error
[2018-02-26 08:44:31.453] [3944] [error]   [ffmpeg] [h264 @ 0B765EA0] no frame!
[2018-02-26 08:44:31.456] [3944] [info]    ffmpeg[10.201.1.62:05656|1280x720i60.00|0/0] [video-decoder] H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
#202 PLAY OK
[2018-02-26 08:44:31.465] [3944] [debug]   [audio-decoder] AAC (Advanced Audio Coding) Selected channel layout STEREO
[2018-02-26 08:44:31.478] [3944] [info]    ffmpeg[10.201.1.62:05656|1280x720i60.00|0/0] [audio-decoder] AAC (Advanced Audio Coding)
[2018-02-26 08:44:31.484] [3944] [info]    transition[empty=>ffmpeg[10.201.1.62:05656|1280x720i60.00|0/0]] Initialized.
[2018-02-26 08:44:31.489] [3944] [debug]   Executed command: PlayCommand
[2018-02-26 08:44:31.494] [1396] [info]    transition[empty=>ffmpeg[10.201.1.62:05656|1280x720i60.00|0/0]] End Of File.
[2018-02-26 08:44:31.541] [1396] [info]    transition[empty=>ffmpeg[10.201.1.62:05656|1280x720i60.00|0/0]] Uninitialized.
[2018-02-26 08:44:31.769] [1396] [warning] [frame_muxer] Auto-transcode: Failed to detect display-mode.
[2018-02-26 08:44:31.773] [1396] [info]
+---------------+
| filter_buffer |default--[1280x720 0:1 yuv420p]--filter_buffersink:default
|   (buffer)    |
+---------------+

                                                      +-------------------+
filter_buffer:default--[1280x720 0:1 yuv420p]--default| filter_buffersink |
                                                      |   (buffersink)    |
                                                      +-------------------+


[2018-02-26 08:44:31.803] [1396] [info]    [frame_muxer] simple 1280x720p30.00

CG 1-20 ADD 1 "SCROLLINGTEXT" 1 "<templateData></templateData>"
[2018-02-25 07:04:32.167] [6352] [info]    Received message from Console: CG 1-20 ADD 1 "SCROLLINGTEXT" 1 "<templateData></templateData>"\r\n
[2018-02-25 07:04:32.181] [1704] [info]    flash[cg20.fth.pal|0] Initialized.
[2018-02-25 07:04:32.191] [1704] [info]    flash[cg20.fth.pal|0] Invoking add-command: <invoke name="Add" returntype="xml"><arguments><number>1</number><string>SCROLLINGTEXT.ft</string><true/><string></string><string><![CDATA[ <templateData></templateData>]]></string></arguments></invoke>
[2018-02-25 07:04:32.299] [3304] [debug]   flash-player[cg20.fth.pal|1024x576] [command]      <invoke name="OnCommand" returntype="xml"><arguments><string>Command recieved @GetInfo@?@</string></arguments></invoke>
[2018-02-25 07:04:32.319] [3304] [info]    flash-player[cg20.fth.pal|1024x576] Initialized.
[2018-02-25 07:04:32.325] [3304] [debug]   flash-player[cg20.fth.pal|1024x576] [command]      <invoke name="OnCommand" returntype="xml"><arguments><string>Command recieved @Add@1@</string></arguments></invoke>
[2018-02-25 07:04:32.471] [3304] [debug]   flash-player[cg20.fth.pal|1024x576] [activity]     <invoke name="OnActivity" returntype="xml"><arguments><string>Command finished @Add@1@</string></arguments></invoke>
[2018-02-25 07:04:32.534] [3304] [debug]   flash-player[cg20.fth.pal|1024x576] [activity]     <invoke name="OnActivity" returntype="xml"><arguments><string>Command finished @Play@1@</string></arguments></invoke>
#202 CG OK
[2018-02-25 07:04:32.590] [1704] [debug]   Executed command: CGCommand
[2018-02-25 07:04:39.241] [9176] [error]   [ffmpeg] [h264 @ 0CE1D0A0] error while decoding MB 32 25, bytestream td
[2018-02-25 07:04:39.246] [9176] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 1617 DC, 1617 AC, 1617 MV errors in P frame
[2018-02-25 07:06:24.481] [2580] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 518 DC, 518 AC, 518 MV errors in P frame
[2018-02-25 07:06:44.203] [8984] [error]   [ffmpeg] [h264 @ 0CE1D0A0] error while decoding MB 58 32, bytestream td
[2018-02-25 07:06:44.210] [8984] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 1031 DC, 1031 AC, 1031 MV errors in P frame
[2018-02-25 07:12:57.126] [9176] [error]   [ffmpeg] [h264 @ 0CE1D0A0] error while decoding MB 48 32, bytestream td
[2018-02-25 07:12:57.131] [9176] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 1041 DC, 1041 AC, 1041 MV errors in I frame
[2018-02-25 07:13:06.921] [9176] [error]   [ffmpeg] [h264 @ 0CE1D0A0] error while decoding MB 8 39, bytestream td
[2018-02-25 07:13:06.925] [9176] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 521 DC, 521 AC, 521 MV errors in P frame
[2018-02-25 07:13:56.770] [2580] [error]   [ffmpeg] [h264 @ 0CE1D0A0] error while decoding MB 75 38, bytestream td
[2018-02-25 07:13:56.775] [2580] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 534 DC, 534 AC, 534 MV errors in I frame
[2018-02-25 07:14:06.127] [9176] [error]   [ffmpeg] [h264 @ 0CE1D0A0] cabac decode of qscale diff failed at 38 35
[2018-02-25 07:14:06.132] [9176] [error]   [ffmpeg] [h264 @ 0CE1D0A0] error while decoding MB 38 35, bytestream td
[2018-02-25 07:14:06.136] [9176] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 811 DC, 811 AC, 811 MV errors in I frame
[2018-02-25 07:15:06.201] [8984] [error]   [ffmpeg] [h264 @ 0CE1D0A0] error while decoding MB 46 38, bytestream td
[2018-02-25 07:15:06.207] [8984] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 563 DC, 563 AC, 563 MV errors in B frame
[2018-02-25 07:15:46.200] [9176] [error]   [ffmpeg] [h264 @ 0CE1D0A0] error while decoding MB 52 20, bytestream td
[2018-02-25 07:15:46.205] [9176] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 1997 DC, 1997 AC, 1997 MV errors in P frame
[2018-02-25 07:16:50.963] [8984] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 1214 DC, 1214 AC, 1214 MV errors in P frame
[2018-02-25 07:16:51.084] [9176] [error]   [ffmpeg] [h264 @ 0CE1D0A0] mmco: unref short failure
[2018-02-25 07:17:30.683] [2580] [error]   [ffmpeg] [h264 @ 0CE1D0A0] mmco: unref short failure
[2018-02-25 07:20:30.682] [2580] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 1531 DC, 1531 AC, 1531 MV errors in P frame
[2018-02-25 07:38:57.243] [9176] [error]   [ffmpeg] [h264 @ 0CE1D0A0] cabac decode of qscale diff failed at 74 41
[2018-02-25 07:38:57.247] [9176] [error]   [ffmpeg] [h264 @ 0CE1D0A0] error while decoding MB 74 41, bytestream td
[2018-02-25 07:38:57.251] [9176] [info]    [ffmpeg] [h264 @ 0CE1D0A0] concealing 295 DC, 295 AC, 295 MV errors in P frame
[2018-02-25 07:47:57.895] [1800] [warning] [ffmpeg] [mpegts @ 14B8E720] PES packet size mismatch
[2018-02-25 07:47:57.928] [8856] [error]   [ffmpeg] [aac @ 0CE1B860] channel element 0.0 is not allocated
[2018-02-25 07:47:57.934] [8984] [error]   producer\audio\audio_decoder.cpp(135): Throw in function caspar::ffmpeg::`anonymous-namespace'::<lambda3>::operator ()
Dynamic exception type: class boost::exception_detail::clone_impl<struct caspar::ffmpeg::ffmpeg_error>
std::exception::what: Unknown exception
[struct boost::errinfo_api_function_ *] = avcodec_decode_audio4(codec_context_.get(), decoded_frame.get(), &got_frame, &pkt)
1094995529, "Unknown error"[struct caspar::tag_msg_info *] = Invalid data found when processing input
[struct caspar::tag_source_info *] = [audio_decoder]
Can somebody please help me get out of this issue?