[2021-01-11 20:47:12.297] [16228] [info]    process started
[2021-01-11 20:47:12.298] [16228] [info]    ############################################################################
[2021-01-11 20:47:12.298] [16228] [info]    CasparCG Server is distributed by the Swedish Broadcasting Corporation (SVT)
[2021-01-11 20:47:12.298] [16228] [info]    under the GNU General Public License GPLv3 or higher.
[2021-01-11 20:47:12.298] [16228] [info]    Please see LICENSE.TXT for details.
[2021-01-11 20:47:12.298] [16228] [info]    http://www.casparcg.com/
[2021-01-11 20:47:12.298] [16228] [info]    ############################################################################
[2021-01-11 20:47:12.298] [16228] [info]    Starting CasparCG Video and Graphics Playout Server 2.1.12.12436 11fdd364e NRK
[2021-01-11 20:47:12.298] [16228] [info]    on Windows 10 Home 
[2021-01-11 20:47:12.298] [16228] [info]    Intel(R) Core(TM) i5-10600KF CPU @ 4.10GHz Physical Threads: 12
[2021-01-11 20:47:12.298] [16228] [info]    Komplett PC
[2021-01-11 20:47:12.298] [16228] [info]    Initialized reroute module.
[2021-01-11 20:47:12.299] [16228] [info]    Initialized ffmpeg module.
[2021-01-11 20:47:12.299] [16228] [info]    Initialized oal module.
[2021-01-11 20:47:12.424] [16228] [info]    Initialized bluefish module.
[2021-01-11 20:47:12.424] [16228] [info]    Initialized decklink module.
[2021-01-11 20:47:12.424] [16228] [info]    Initialized screen module.
[2021-01-11 20:47:12.443] [16228] [info]    Initialized html module.
[2021-01-11 20:47:12.443] [16228] [info]    Initialized psd module.
[2021-01-11 20:47:12.472] [16228] [info]    Initialized flash module.
[2021-01-11 20:47:12.472] [16228] [info]    Initialized newtek module.
[2021-01-11 20:47:12.472] [16228] [info]    Initialized image module.
[2021-01-11 20:47:12.501] [16228] [info]    Loaded C:\windows\SYSTEM32\Processing.AirSend.x64.dll
[2021-01-11 20:47:12.501] [16228] [info]    ffmpeg.avcodec 58.11.101
[2021-01-11 20:47:12.502] [16228] [info]    ffmpeg.avformat 58.9.100
[2021-01-11 20:47:12.502] [16228] [info]    ffmpeg.avfilter 7.12.100
[2021-01-11 20:47:12.502] [16228] [info]    ffmpeg.avutil 56.7.101
[2021-01-11 20:47:12.502] [16228] [info]    ffmpeg.swscale 5.0.101
[2021-01-11 20:47:12.502] [16228] [info]    bluefish.version Not found
[2021-01-11 20:47:12.502] [16228] [info]    decklink.version 11.7
[2021-01-11 20:47:12.502] [16228] [info]    decklink.device DeckLink Duo 2 [1]
[2021-01-11 20:47:12.502] [16228] [info]    decklink.device DeckLink Duo 2 [2]
[2021-01-11 20:47:12.502] [16228] [info]    decklink.device DeckLink Duo 2 [3]
[2021-01-11 20:47:12.502] [16228] [info]    decklink.device DeckLink Duo 2 [4]
[2021-01-11 20:47:12.502] [16228] [info]    cef.version 3.3578.1870
[2021-01-11 20:47:12.502] [16228] [info]    cef.chromeversion 71.0.3578.98
[2021-01-11 20:47:12.502] [16228] [info]    flash 32.0.0.387
[2021-01-11 20:47:12.502] [16228] [info]    newtek-ivga.version available
[2021-01-11 20:47:12.502] [16228] [info]    freeimage 3.16.0
[2021-01-11 20:47:12.502] [16228] [info]    casparcg.config:
[2021-01-11 20:47:12.502] [16228] [info]    -----------------------------------------
[2021-01-11 20:47:12.502] [16228] [info]    <?xml version="1.0" encoding="utf-8"?>
[2021-01-11 20:47:12.502] [16228] [info]    <configuration>
[2021-01-11 20:47:12.502] [16228] [info]       <log-level>debug</log-level>
[2021-01-11 20:47:12.502] [16228] [info]       <paths>
[2021-01-11 20:47:12.502] [16228] [info]          <media-path>media/</media-path>
[2021-01-11 20:47:12.502] [16228] [info]          <log-path>log/</log-path>
[2021-01-11 20:47:12.502] [16228] [info]          <data-path>data/</data-path>
[2021-01-11 20:47:12.502] [16228] [info]          <font-path>font/</font-path>
[2021-01-11 20:47:12.502] [16228] [info]          <template-path>template/</template-path>
[2021-01-11 20:47:12.502] [16228] [info]       </paths>
[2021-01-11 20:47:12.502] [16228] [info]       <lock-clear-phrase>secret</lock-clear-phrase>
[2021-01-11 20:47:12.502] [16228] [info]       <channels>
[2021-01-11 20:47:12.502] [16228] [info]          <channel>
[2021-01-11 20:47:12.502] [16228] [info]             <video-mode>1080i5994</video-mode>
[2021-01-11 20:47:12.502] [16228] [info]             <consumers>
[2021-01-11 20:47:12.502] [16228] [info]                <screen>
[2021-01-11 20:47:12.502] [16228] [info]                   <name>PGM</name>
[2021-01-11 20:47:12.502] [16228] [info]                   <device>1</device>
[2021-01-11 20:47:12.502] [16228] [info]                   <aspect-ratio>default</aspect-ratio>
[2021-01-11 20:47:12.502] [16228] [info]                   <stretch>fill</stretch>
[2021-01-11 20:47:12.502] [16228] [info]                   <windowed>true</windowed>
[2021-01-11 20:47:12.502] [16228] [info]                   <key-only>false</key-only>
[2021-01-11 20:47:12.502] [16228] [info]                   <vsync>false</vsync>
[2021-01-11 20:47:12.502] [16228] [info]                   <borderless>false</borderless>
[2021-01-11 20:47:12.502] [16228] [info]                   <interactive>true</interactive>
[2021-01-11 20:47:12.502] [16228] [info]                   <always-on-top>false</always-on-top>
[2021-01-11 20:47:12.502] [16228] [info]                   <x>0</x>
[2021-01-11 20:47:12.502] [16228] [info]                   <y>0</y>
[2021-01-11 20:47:12.502] [16228] [info]                   <width>480</width>
[2021-01-11 20:47:12.502] [16228] [info]                   <height>270</height>
[2021-01-11 20:47:12.502] [16228] [info]                   <sbs-key>false</sbs-key>
[2021-01-11 20:47:12.502] [16228] [info]                   <colour-space>RGB</colour-space>
[2021-01-11 20:47:12.502] [16228] [info]                </screen>
[2021-01-11 20:47:12.502] [16228] [info]                <ndi>
[2021-01-11 20:47:12.502] [16228] [info]                   <name>CasparCG - PGM</name>
[2021-01-11 20:47:12.502] [16228] [info]                   <allow-fields>false</allow-fields>
[2021-01-11 20:47:12.502] [16228] [info]                </ndi>
[2021-01-11 20:47:12.502] [16228] [info]                <decklink>
[2021-01-11 20:47:12.502] [16228] [info]                   <device>1</device>
[2021-01-11 20:47:12.502] [16228] [info]                   <key-device>3</key-device>
[2021-01-11 20:47:12.502] [16228] [info]                   <embedded-audio>false</embedded-audio>
[2021-01-11 20:47:12.502] [16228] [info]                   <latency>normal</latency>
[2021-01-11 20:47:12.502] [16228] [info]                   <keyer>external</keyer>
[2021-01-11 20:47:12.502] [16228] [info]                   <key-only>false</key-only>
[2021-01-11 20:47:12.502] [16228] [info]                   <buffer-depth>3</buffer-depth>
[2021-01-11 20:47:12.502] [16228] [info]                </decklink>
[2021-01-11 20:47:12.502] [16228] [info]             </consumers>
[2021-01-11 20:47:12.502] [16228] [info]          </channel>
[2021-01-11 20:47:12.502] [16228] [info]       </channels>
[2021-01-11 20:47:12.502] [16228] [info]       <controllers>
[2021-01-11 20:47:12.502] [16228] [info]          <tcp>
[2021-01-11 20:47:12.502] [16228] [info]             <port>5250</port>
[2021-01-11 20:47:12.502] [16228] [info]             <protocol>AMCP</protocol>
[2021-01-11 20:47:12.502] [16228] [info]          </tcp>
[2021-01-11 20:47:12.502] [16228] [info]       </controllers>
[2021-01-11 20:47:12.502] [16228] [info]       <amcp>
[2021-01-11 20:47:12.502] [16228] [info]          <media-server>
[2021-01-11 20:47:12.502] [16228] [info]             <host>localhost</host>
[2021-01-11 20:47:12.502] [16228] [info]             <port>8000</port>
[2021-01-11 20:47:12.502] [16228] [info]          </media-server>
[2021-01-11 20:47:12.502] [16228] [info]       </amcp>
[2021-01-11 20:47:12.502] [16228] [info]       <flash>
[2021-01-11 20:47:12.502] [16228] [info]          <buffer-depth>auto</buffer-depth>
[2021-01-11 20:47:12.502] [16228] [info]          <enabled>false</enabled>
[2021-01-11 20:47:12.502] [16228] [info]       </flash>
[2021-01-11 20:47:12.502] [16228] [info]       <html>
[2021-01-11 20:47:12.502] [16228] [info]          <remote-debugging-port>0</remote-debugging-port>
[2021-01-11 20:47:12.502] [16228] [info]          <enable-gpu>false</enable-gpu>
[2021-01-11 20:47:12.502] [16228] [info]       </html>
[2021-01-11 20:47:12.502] [16228] [info]       <ffmpeg>
[2021-01-11 20:47:12.502] [16228] [info]          <producer>
[2021-01-11 20:47:12.502] [16228] [info]             <auto-deinterlace>interlaced</auto-deinterlace>
[2021-01-11 20:47:12.502] [16228] [info]             <threads>4</threads>
[2021-01-11 20:47:12.502] [16228] [info]          </producer>
[2021-01-11 20:47:12.502] [16228] [info]       </ffmpeg>
[2021-01-11 20:47:12.502] [16228] [info]       <ndi>
[2021-01-11 20:47:12.502] [16228] [info]          <auto-load>true</auto-load>
[2021-01-11 20:47:12.502] [16228] [info]       </ndi>
[2021-01-11 20:47:12.502] [16228] [info]       <osc>
[2021-01-11 20:47:12.502] [16228] [info]          <default-port>6250</default-port>
[2021-01-11 20:47:12.502] [16228] [info]          <disable-send-to-amcp-clients>false</disable-send-to-amcp-clients>
[2021-01-11 20:47:12.502] [16228] [info]          <predefined-clients/>
[2021-01-11 20:47:12.502] [16228] [info]       </osc>
[2021-01-11 20:47:12.502] [16228] [info]    </configuration>
[2021-01-11 20:47:12.502] [16228] [info]    -----------------------------------------
[2021-01-11 20:47:12.502] [16228] [info]    Initialized video modes.
[2021-01-11 20:47:12.503] [16228] [info]    Initialized audio config.
[2021-01-11 20:47:12.503] [16228] [info]    Initializing OpenGL Device.
[2021-01-11 20:47:12.583] [16228] [info]    Successfully initialized OpenGL 4.6.0 NVIDIA 460.89 NVIDIA Corporation
[2021-01-11 20:47:12.586] [16228] [info]    Initialized OpenGL Accelerated GPU Image Mixer for channel 1
[2021-01-11 20:47:12.586] [16228] [info]    video_channel[1|1080i5994] Successfully Initialized.
[2021-01-11 20:47:12.604] [16228] [debug]   [ffmpeg] [filter_buffer @ 000001D61E782D40] w:1920 h:1080 pixfmt:bgra tb:1001/30000 fr:30000/1001 sar:1/1 sws_param:
[2021-01-11 20:47:12.604] [16228] [debug]   
[2021-01-11 20:47:12.604] [16228] [debug]   [ffmpeg] [auto_scaler_0 @ 000001D61E786780] w:iw h:ih flags:'bilinear' interl:0
[2021-01-11 20:47:12.604] [16228] [debug]   
[2021-01-11 20:47:12.604] [16228] [debug]   [ffmpeg] [filter_buffersink @ 000001D61E7830C0] auto-inserting filter 'auto_scaler_0' between the filter 'Parsed_yadif_1' and the filter 'filter_buffersink'
[2021-01-11 20:47:12.604] [16228] [debug]   
[2021-01-11 20:47:12.604] [16228] [debug]   [ffmpeg] [auto_scaler_1 @ 000001D61E789D00] w:iw h:ih flags:'bilinear' interl:0
[2021-01-11 20:47:12.604] [16228] [debug]   
[2021-01-11 20:47:12.604] [16228] [debug]   [ffmpeg] [Parsed_format_0 @ 000001D61E7833C0] auto-inserting filter 'auto_scaler_1' between the filter 'filter_buffer' and the filter 'Parsed_format_0'
[2021-01-11 20:47:12.604] [16228] [debug]   
[2021-01-11 20:47:12.605] [16228] [debug]   [ffmpeg] [auto_scaler_1 @ 000001D61E789D00] w:1920 h:1080 fmt:bgra sar:1/1 -> w:1920 h:1080 fmt:gbrp sar:1/1 flags:0x2
[2021-01-11 20:47:12.605] [16228] [debug]   
[2021-01-11 20:47:12.605] [16228] [debug]   [ffmpeg] [auto_scaler_0 @ 000001D61E786780] w:1920 h:1080 fmt:gbrp sar:1/1 -> w:1920 h:1080 fmt:bgra sar:1/1 flags:0x2
[2021-01-11 20:47:12.605] [16228] [debug]   
[2021-01-11 20:47:12.605] [16228] [debug]   
[2021-01-11 20:47:12.605] [16228] [debug]   +---------------+
[2021-01-11 20:47:12.605] [16228] [debug]   | filter_buffer |default--[1920x1080 1:1 bgra]--auto_scaler_1:default
[2021-01-11 20:47:12.605] [16228] [debug]   |   (buffer)    |
[2021-01-11 20:47:12.605] [16228] [debug]   +---------------+
[2021-01-11 20:47:12.605] [16228] [debug]   
[2021-01-11 20:47:12.605] [16228] [debug]                                                       +-------------------+
[2021-01-11 20:47:12.605] [16228] [debug]   auto_scaler_0:default--[1920x1080 1:1 bgra]--default| filter_buffersink |
[2021-01-11 20:47:12.605] [16228] [debug]                                                       |   (buffersink)    |
[2021-01-11 20:47:12.605] [16228] [debug]                                                       +-------------------+
[2021-01-11 20:47:12.605] [16228] [debug]   
[2021-01-11 20:47:12.605] [16228] [debug]                                                       +-----------------+
[2021-01-11 20:47:12.605] [16228] [debug]   auto_scaler_1:default--[1920x1080 1:1 gbrp]--default| Parsed_format_0 |default--[1920x1080 1:1 gbrp]--Parsed_yadif_1:default
[2021-01-11 20:47:12.605] [16228] [debug]                                                       |    (format)     |
[2021-01-11 20:47:12.605] [16228] [debug]                                                       +-----------------+
[2021-01-11 20:47:12.605] [16228] [debug]   
[2021-01-11 20:47:12.605] [16228] [debug]                                                         +----------------+
[2021-01-11 20:47:12.605] [16228] [debug]   Parsed_format_0:default--[1920x1080 1:1 gbrp]--default| Parsed_yadif_1 |default--[1920x1080 1:1 gbrp]--auto_scaler_0:default
[2021-01-11 20:47:12.605] [16228] [debug]                                                         |    (yadif)     |
[2021-01-11 20:47:12.605] [16228] [debug]                                                         +----------------+
[2021-01-11 20:47:12.605] [16228] [debug]   
[2021-01-11 20:47:12.605] [16228] [debug]                                                        +---------------+
[2021-01-11 20:47:12.605] [16228] [debug]   Parsed_yadif_1:default--[1920x1080 1:1 gbrp]--default| auto_scaler_0 |default--[1920x1080 1:1 bgra]--filter_buffersink:default
[2021-01-11 20:47:12.605] [16228] [debug]                                                        |    (scale)    |
[2021-01-11 20:47:12.605] [16228] [debug]                                                        +---------------+
[2021-01-11 20:47:12.605] [16228] [debug]   
[2021-01-11 20:47:12.605] [16228] [debug]                                                       +---------------+
[2021-01-11 20:47:12.605] [16228] [debug]   filter_buffer:default--[1920x1080 1:1 bgra]--default| auto_scaler_1 |default--[1920x1080 1:1 gbrp]--Parsed_format_0:default
[2021-01-11 20:47:12.605] [16228] [debug]                                                       |    (scale)    |
[2021-01-11 20:47:12.605] [16228] [debug]                                                       +---------------+
[2021-01-11 20:47:12.605] [16228] [debug]   
[2021-01-11 20:47:12.605] [16228] [debug]   
[2021-01-11 20:47:12.606] [16228] [info]    PGM [1|1080i5994] Initialized.
[2021-01-11 20:47:12.606] [16228] [debug]   core\consumer\frame_consumer.cpp(337): Throw in function class caspar::spl::shared_ptr<class caspar::core::frame_consumer> __cdecl caspar::core::frame_consumer_registry::create_consumer(const class std::basic_string<wchar_t,struct std::char_traits<wchar_t>,class std::allocator<wchar_t> > &,const class boost::property_tree::basic_ptree<class std::basic_string<wchar_t,struct std::char_traits<wchar_t>,class std::allocator<wchar_t> >,class std::basic_string<wchar_t,struct std::char_traits<wchar_t>,class std::allocator<wchar_t> >,struct std::less<class std::basic_string<wchar_t,struct std::char_traits<wchar_t>,class std::allocator<wchar_t> > > > &,struct caspar::core::interaction_sink *,class std::vector<class caspar::spl::shared_ptr<class caspar::core::video_channel>,class std::allocator<class caspar::spl::shared_ptr<class caspar::core::video_channel> > >) const
[2021-01-11 20:47:12.606] [16228] [debug]   Dynamic exception type: class boost::exception_detail::clone_impl<struct caspar::user_error>
[2021-01-11 20:47:12.606] [16228] [debug]   [struct caspar::tag_call_stack_info * __ptr64] = 
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA3BA1AD (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA37FF28 (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA3E802E (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA2FC87E (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA2FFF78 (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA2C6214 (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA2C8D24 (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA86161D (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FFB0FA97034 (KERNEL32): (filename not available): BaseThreadInitThunk
[2021-01-11 20:47:12.606] [16228] [debug]       00007FFB1017D0D1 (ntdll): (filename not available): RtlUserThreadStart
[2021-01-11 20:47:12.606] [16228] [debug]   
[2021-01-11 20:47:12.606] [16228] [debug]   [struct caspar::tag_context_info * __ptr64] = casparcg.config: /consumers/ndi[1]
[2021-01-11 20:47:12.606] [16228] [debug]   [struct caspar::tag_msg_info * __ptr64] = No consumer factory registered for element name ndi
[2021-01-11 20:47:12.606] [16228] [debug]   Caught at (main thread):
[2021-01-11 20:47:12.606] [16228] [debug]   
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA3BA1AD (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA37FF28 (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA8B627A (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FFB054B1030 (VCRUNTIME140): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FFB054B43A8 (VCRUNTIME140): (filename not available): is_exception_typeof
[2021-01-11 20:47:12.606] [16228] [debug]       00007FFB101D0696 (ntdll): (filename not available): RtlCaptureContext2
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA2FC87E (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA2FFF78 (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA2C6214 (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA2C8D24 (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FF7CA86161D (casparcg): (filename not available): (function-name not available)
[2021-01-11 20:47:12.606] [16228] [debug]       00007FFB0FA97034 (KERNEL32): (filename not available): BaseThreadInitThunk
[2021-01-11 20:47:12.606] [16228] [debug]       00007FFB1017D0D1 (ntdll): (filename not available): RtlUserThreadStart
[2021-01-11 20:47:12.606] [16228] [debug]   
[2021-01-11 20:47:12.607] [16228] [error]   No consumer factory registered for element name ndi (casparcg.config: /consumers/ndi[1]). Turn on log level debug for stacktrace.
[2021-01-11 20:47:12.618] [6668]  [debug]   [audio_channel_remapper] Input:  [audio_channel_layout] num_channels=2 type=STEREO channel_order=FL FR
[2021-01-11 20:47:12.618] [6668]  [debug]   [audio_channel_remapper] Output: [audio_channel_layout] num_channels=2 type=STEREO channel_order=FL FR
[2021-01-11 20:47:12.618] [6668]  [debug]   [audio_channel_remapper] No remapping/mixing needed because the input and output layout is equal.
[2021-01-11 20:47:12.618] [6668]  [info]    DeckLink Duo 2 [1-1|1080i5994] Disabled low-latency mode.
[2021-01-11 20:47:12.618] [6668]  [error]   DeckLink Duo 2 [1-1|1080i5994] Failed to enable external keyer.
[2021-01-11 20:47:12.647] [16228] [info]    DeckLink Duo 2 [1-1|1080i5994] Initialized.
[2021-01-11 20:47:12.647] [16228] [info]    Initialized channels.
[2021-01-11 20:47:12.647] [16228] [info]    Initialized OpenGL Accelerated GPU Image Mixer for channel 0
[2021-01-11 20:47:12.647] [16228] [info]    Initialized thumbnail generator.
[2021-01-11 20:47:12.648] [16228] [info]    Initialized command repository.
[2021-01-11 20:47:12.648] [16228] [info]    timecode[1] - Set to freerun
[2021-01-11 20:47:12.648] [16228] [info]    Initialized channel predefined producers.
[2021-01-11 20:47:12.648] [16228] [info]    Initialized controllers.
[2021-01-11 20:47:12.648] [16228] [info]    Initialized osc.
[2021-01-11 20:47:12.648] [16228] [info]    Started initial media information retrieval.
[2021-01-11 20:47:12.654] [6948]  [debug]   [diagnostics] [PGM [1|1080i5994]] dropped-frame [ch=1]
[2021-01-11 20:47:12.654] [6948]  [debug]   [diagnostics] [PGM [1|1080i5994]] dropped-frame [ch=1]
[2021-01-11 20:47:12.654] [6948]  [debug]   [diagnostics] [PGM [1|1080i5994]] dropped-frame [ch=1]
[2021-01-11 20:47:12.655] [6948]  [debug]   [diagnostics] [PGM [1|1080i5994]] dropped-frame [ch=1]
[2021-01-11 20:47:12.655] [6948]  [debug]   [diagnostics] [PGM [1|1080i5994]] dropped-frame [ch=1]
[2021-01-11 20:47:12.658] [4444]  [debug]   [ffmpeg] [auto_scaler_1 @ 000001D61E789D00] w:1920 h:1080 fmt:bgra sar:0/1 -> w:1920 h:1080 fmt:gbrp sar:0/1 flags:0x2
[2021-01-11 20:47:12.658] [4444]  [debug]   
[2021-01-11 20:47:12.673] [7744]  [info]    async_event_server[:5250] Accepted connection from 127.0.0.1 (1 connections).
[2021-01-11 20:47:12.673] [7744]  [info]    Received message from 127.0.0.1: TLS\r\n
[2021-01-11 20:47:12.673] [9396]  [debug]   Executing command: TLS
[2021-01-11 20:47:12.682] [18316] [info]    Sent more than 512 bytes to 127.0.0.1
[2021-01-11 20:47:12.682] [18316] [debug]   Executed command (0.009s): TLS
[2021-01-11 20:47:12.685] [7744]  [info]    Received message from 127.0.0.1: CLS\r\n
[2021-01-11 20:47:12.685] [9396]  [debug]   Executing command: CLS
[2021-01-11 20:47:12.702] [16860] [info]    DeckLink Duo 2 [1-1|1080i5994] Reference signal: not detected.
[2021-01-11 20:47:12.702] [6948]  [warning] [channel] Performance warning. Consume blocked: 0.048
[2021-01-11 20:47:12.713] [8764]  [debug]   [frame_muxer] simple 720x486p29.97
[2021-01-11 20:47:12.714] [4444]  [debug]   [ffmpeg] [auto_scaler_0 @ 000001D61E786780] w:1920 h:1080 fmt:gbrp sar:0/1 -> w:1920 h:1080 fmt:bgra sar:0/1 flags:0x2
[2021-01-11 20:47:12.714] [4444]  [debug]   
[2021-01-11 20:47:12.714] [8016]  [debug]   [buffer] Buffer allocation (349920b) took: 0
[2021-01-11 20:47:12.714] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:12.714] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:12.716] [8016]  [debug]   [buffer] Buffer allocation (349920b) took: 0
[2021-01-11 20:47:12.716] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:12.716] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:12.769] [6948]  [debug]   [diagnostics] [PGM [1|1080i5994]] dropped-frame [ch=1]
[2021-01-11 20:47:12.798] [8016]  [debug]   [buffer] Buffer allocation (349920b) took: 0
[2021-01-11 20:47:12.799] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:12.799] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0.001
[2021-01-11 20:47:12.803] [6948]  [debug]   [diagnostics] [PGM [1|1080i5994]] dropped-frame [ch=1]
[2021-01-11 20:47:12.840] [8016]  [debug]   [buffer] Buffer allocation (349920b) took: 0
[2021-01-11 20:47:12.840] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:12.840] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:12.898] [16856] [info]    Initial media information retrieval finished.
[2021-01-11 20:47:12.901] [18316] [info]    Sent more than 512 bytes to 127.0.0.1
[2021-01-11 20:47:12.901] [18316] [debug]   Executed command (0.217s): CLS
[2021-01-11 20:47:12.974] [7744]  [info]    async_event_server[:5250] Accepted connection from 127.0.0.1 (2 connections).
[2021-01-11 20:47:12.974] [7744]  [info]    Received message from 127.0.0.1: VERSION SERVER\r\n
[2021-01-11 20:47:12.974] [9396]  [debug]   Executing command: VERSION
[2021-01-11 20:47:12.974] [18316] [info]    Sent message to 127.0.0.1:201 VERSION OK\r\n2.1.12.12436 11fdd364e NRK\r\n
[2021-01-11 20:47:12.974] [18316] [debug]   Executed command (0.001s): VERSION
[2021-01-11 20:47:12.975] [7744]  [info]    Received message from 127.0.0.1: INFO\r\n
[2021-01-11 20:47:12.975] [9396]  [debug]   Executing command: INFO
[2021-01-11 20:47:12.975] [18316] [info]    Sent message to 127.0.0.1:200 INFO OK\r\n1 1080i5994 PLAYING\r\n\r\n
[2021-01-11 20:47:12.975] [18316] [debug]   Executed command (0s): INFO
[2021-01-11 20:47:12.976] [7744]  [info]    Received message from 127.0.0.1: CLS\r\n
[2021-01-11 20:47:12.976] [9396]  [debug]   Executing command: CLS
[2021-01-11 20:47:12.977] [7744]  [info]    Received message from 127.0.0.1: TLS\r\n
[2021-01-11 20:47:12.977] [7744]  [info]    Received message from 127.0.0.1: DATA LIST\r\n
[2021-01-11 20:47:12.978] [7744]  [info]    Received message from 127.0.0.1: THUMBNAIL LIST\r\n
[2021-01-11 20:47:12.993] [18316] [info]    Sent more than 512 bytes to 127.0.0.1
[2021-01-11 20:47:12.993] [18316] [debug]   Executed command (0.016s): CLS
[2021-01-11 20:47:12.993] [9396]  [debug]   Executing command: TLS
[2021-01-11 20:47:13.001] [18316] [info]    Sent more than 512 bytes to 127.0.0.1
[2021-01-11 20:47:13.001] [18316] [debug]   Executed command (0.008s): TLS
[2021-01-11 20:47:13.001] [9396]  [debug]   Executing command: DATA LIST
[2021-01-11 20:47:13.001] [18316] [info]    Sent message to 127.0.0.1:200 DATA LIST OK\r\n\r\n
[2021-01-11 20:47:13.001] [18316] [debug]   Executed command (0s): DATA LIST
[2021-01-11 20:47:13.001] [9396]  [debug]   Executing command: THUMBNAIL LIST
[2021-01-11 20:47:13.015] [18316] [info]    Sent more than 512 bytes to 127.0.0.1
[2021-01-11 20:47:13.015] [18316] [debug]   Executed command (0.014s): THUMBNAIL LIST
[2021-01-11 20:47:13.092] [8016]  [debug]   [buffer] Buffer allocation (349920b) took: 0
[2021-01-11 20:47:13.092] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:13.092] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:13.547] [8016]  [debug]   [buffer] Buffer allocation (349920b) took: 0
[2021-01-11 20:47:13.548] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:13.548] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:13.880] [8764]  [debug]   Shutting down FFmpeg worker - media//TestPatterns\NTSC_Test.mov
[2021-01-11 20:47:13.881] [8764]  [debug]   Shutting down ffmpeg_input[media//TestPatterns\NTSC_Test.mov)]
[2021-01-11 20:47:13.928] [8764]  [debug]   [frame_muxer] simple 720x486p29.97
[2021-01-11 20:47:14.012] [8016]  [debug]   [buffer] Buffer allocation (349920b) took: 0
[2021-01-11 20:47:14.012] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:14.013] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:14.054] [8016]  [debug]   [buffer] Buffer allocation (349920b) took: 0
[2021-01-11 20:47:14.055] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:14.055] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:14.304] [8016]  [debug]   [buffer] Buffer allocation (349920b) took: 0
[2021-01-11 20:47:14.304] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:14.304] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:14.765] [8016]  [debug]   [buffer] Buffer allocation (349920b) took: 0
[2021-01-11 20:47:14.765] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:14.765] [8016]  [debug]   [buffer] Buffer allocation (87480b) took: 0
[2021-01-11 20:47:15.019] [7744]  [info]    Received message from 127.0.0.1: THUMBNAIL RETRIEVE "TESTPATTERNS/NTSC_TEST"\r\n
[2021-01-11 20:47:15.019] [9396]  [debug]   Executing command: THUMBNAIL RETRIEVE
[2021-01-11 20:47:15.019] [18316] [info]    Sent more than 512 bytes to 127.0.0.1
[2021-01-11 20:47:15.019] [18316] [debug]   Executed command (0s): THUMBNAIL RETRIEVE
[2021-01-11 20:47:15.100] [8764]  [debug]   Shutting down FFmpeg worker - media//TestPatterns\NTSC_Test_a.mov
[2021-01-11 20:47:15.101] [8764]  [debug]   Shutting down ffmpeg_input[media//TestPatterns\NTSC_Test_a.mov)]
[2021-01-11 20:47:15.102] [8016]  [debug]   [texture] Texture allocation: 720x486x1
[2021-01-11 20:47:15.102] [8016]  [debug]   [texture] Texture allocation: 1280x720x4
[2021-01-11 20:47:15.104] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.104] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.104] [8016]  [debug]   [texture] Texture allocation: 1280x720x1
[2021-01-11 20:47:15.106] [8016]  [debug]   [texture] Texture allocation: 720x486x1
[2021-01-11 20:47:15.106] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.106] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.107] [8016]  [debug]   [texture] Texture allocation: 720x486x1
[2021-01-11 20:47:15.107] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.107] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.108] [8016]  [debug]   [texture] Texture allocation: 720x486x1
[2021-01-11 20:47:15.108] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.109] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.109] [8016]  [debug]   [texture] Texture allocation: 720x486x1
[2021-01-11 20:47:15.109] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.109] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.110] [8016]  [debug]   [texture] Texture allocation: 720x486x1
[2021-01-11 20:47:15.110] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.110] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.110] [8016]  [debug]   [texture] Texture allocation: 720x486x1
[2021-01-11 20:47:15.111] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.111] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.111] [8016]  [debug]   [texture] Texture allocation: 720x486x1
[2021-01-11 20:47:15.111] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.111] [8016]  [debug]   [texture] Texture allocation: 360x243x1
[2021-01-11 20:47:15.111] [8016]  [debug]   [buffer] Buffer allocation (3686400b) took: 0
[2021-01-11 20:47:17.109] [8764]  [info]    Generated thumbnail for "TestPatterns\NTSC_Test.tga"
[2021-01-11 20:47:17.156] [8764]  [debug]   [frame_muxer] simple 720x576p25.00
[2021-01-11 20:47:17.156] [8016]  [debug]   [buffer] Buffer allocation (414720b) took: 0
[2021-01-11 20:47:17.156] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:17.156] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:17.157] [8016]  [debug]   [buffer] Buffer allocation (414720b) took: 0
[2021-01-11 20:47:17.157] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:17.158] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0.001
[2021-01-11 20:47:17.240] [8016]  [debug]   [buffer] Buffer allocation (414720b) took: 0
[2021-01-11 20:47:17.240] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:17.240] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:17.281] [8016]  [debug]   [buffer] Buffer allocation (414720b) took: 0
[2021-01-11 20:47:17.281] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:17.281] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:17.529] [8016]  [debug]   [buffer] Buffer allocation (414720b) took: 0
[2021-01-11 20:47:17.529] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:17.529] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:17.983] [8016]  [debug]   [buffer] Buffer allocation (414720b) took: 0
[2021-01-11 20:47:17.983] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:17.983] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:18.208] [6948]  [debug]   [diagnostics] [PGM [1|1080i5994]] dropped-frame [ch=1]
[2021-01-11 20:47:18.315] [8764]  [debug]   Shutting down FFmpeg worker - media//TestPatterns\PAL_Test.mov
[2021-01-11 20:47:18.316] [8764]  [debug]   Shutting down ffmpeg_input[media//TestPatterns\PAL_Test.mov)]
[2021-01-11 20:47:18.362] [8764]  [debug]   [frame_muxer] simple 720x576p25.00
[2021-01-11 20:47:18.445] [8016]  [debug]   [buffer] Buffer allocation (414720b) took: 0
[2021-01-11 20:47:18.445] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:18.446] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0.001
[2021-01-11 20:47:18.487] [8016]  [debug]   [buffer] Buffer allocation (414720b) took: 0
[2021-01-11 20:47:18.488] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:18.488] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:18.736] [8016]  [debug]   [buffer] Buffer allocation (414720b) took: 0
[2021-01-11 20:47:18.736] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:18.736] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:19.191] [8016]  [debug]   [buffer] Buffer allocation (414720b) took: 0
[2021-01-11 20:47:19.191] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:19.191] [8016]  [debug]   [buffer] Buffer allocation (103680b) took: 0
[2021-01-11 20:47:19.443] [6948]  [debug]   [diagnostics] [PGM [1|1080i5994]] dropped-frame [ch=1]
[2021-01-11 20:47:19.525] [8764]  [debug]   Shutting down FFmpeg worker - media//TestPatterns\PAL_Test_a.mov
[2021-01-11 20:47:19.526] [8764]  [debug]   Shutting down ffmpeg_input[media//TestPatterns\PAL_Test_a.mov)]
[2021-01-11 20:47:19.529] [8016]  [debug]   [texture] Texture allocation: 720x576x1
[2021-01-11 20:47:19.530] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.530] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.530] [8016]  [debug]   [texture] Texture allocation: 720x576x1
[2021-01-11 20:47:19.530] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.531] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.531] [8016]  [debug]   [texture] Texture allocation: 720x576x1
[2021-01-11 20:47:19.531] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.531] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.532] [8016]  [debug]   [texture] Texture allocation: 720x576x1
[2021-01-11 20:47:19.532] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.532] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.533] [8016]  [debug]   [texture] Texture allocation: 720x576x1
[2021-01-11 20:47:19.533] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.533] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.533] [8016]  [debug]   [texture] Texture allocation: 720x576x1
[2021-01-11 20:47:19.533] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.534] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.534] [8016]  [debug]   [texture] Texture allocation: 720x576x1
[2021-01-11 20:47:19.535] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.535] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.535] [8016]  [debug]   [texture] Texture allocation: 720x576x1
[2021-01-11 20:47:19.535] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:19.535] [8016]  [debug]   [texture] Texture allocation: 360x288x1
[2021-01-11 20:47:21.536] [8764]  [info]    Generated thumbnail for "TestPatterns\PAL_Test.mov"
[2021-01-11 20:47:21.584] [8764]  [debug]   [frame_muxer] simple 720x576p25.00
[2021-01-11 20:47:22.744] [8764]  [debug]   Shutting down FFmpeg worker - media//TestPatterns\PAL_Test.mov
[2021-01-11 20:47:22.745] [8764]  [debug]   Shutting down ffmpeg_input[media//TestPatterns\PAL_Test.mov)]
[2021-01-11 20:47:22.790] [8764]  [debug]   [frame_muxer] simple 720x576p25.00
[2021-01-11 20:47:23.997] [8764]  [debug]   Shutting down FFmpeg worker - media//TestPatterns\PAL_Test_a.mov
[2021-01-11 20:47:23.998] [8764]  [debug]   Shutting down ffmpeg_input[media//TestPatterns\PAL_Test_a.mov)]
[2021-01-11 20:47:26.004] [8764]  [info]    Generated thumbnail for "TestPatterns\PAL_Test.tga"
[2021-01-11 20:47:42.700] [6948]  [debug]   [diagnostics] [PGM [1|1080i5994]] dropped-frame [ch=1]