TheMoatman
New Member
Hi,
I started up OBS today and I saw the red "WARNING: Taking too long to encode" alert when I was doing a preview to get the layout set up. I never had this problem until today, even though I was recording 1080p @ 60fps. I'm running a 4790k.
I've uploaded two logs, one from the 22nd (a working 1080p60 stream) and one from today. I'm more interested in why this would start happening than fixing it, but a fix would be nice, too.
e: It's skipping frames at 720p60, too. Relevant parts of the log are below.
I started up OBS today and I saw the red "WARNING: Taking too long to encode" alert when I was doing a preview to get the layout set up. I never had this problem until today, even though I was recording 1080p @ 60fps. I'm running a 4790k.
I've uploaded two logs, one from the 22nd (a working 1080p60 stream) and one from today. I'm more interested in why this would start happening than fixing it, but a fix would be nice, too.
e: It's skipping frames at 720p60, too. Relevant parts of the log are below.
Code:
05:58:18: Open Broadcaster Software v0.625b - 32bit (´・ω・`)
05:58:18: -------------------------------
05:58:18: CPU Name: Intel(R) Core(TM) i7-4790K CPU @ 4.00GHz
05:58:18: CPU Speed: 3991MHz
05:58:18: Physical Memory: 4095MB Total, 4095MB Free
05:58:18: stepping id: 3, model 60, family 6, type 0, extmodel 1, extfamily 0, HTT 1, logical cores 8, total cores 4
05:58:18: monitor 1: pos={0, 0}, size={1920, 1080}
05:58:18: Windows Version: 6.2 Build 9200
05:58:18: Aero is Enabled
05:58:18: -------------------------------
05:58:18: OBS Modules:
05:58:18: Base Address Module
05:58:18: 013A0000 OBS.exe
05:58:18: 562C0000 OBSApi.dll
05:58:18: 649E0000 DShowPlugin.dll
05:58:18: 649B0000 GraphicsCapture.dll
05:58:18: 64980000 NoiseGate.dll
05:58:18: 64960000 PSVPlugin.dll
05:58:18: ------------------------------------------
05:58:18: Adapter 1
05:58:18: Video Adapter: AMD Radeon R9 200 Series
05:58:18: Video Adapter Dedicated Video Memory: 2128662528
05:58:18: Video Adapter Shared System Memory: 2166239232
05:58:18: Video Adapter Output 1: pos={0, 0}, size={1920, 1080}, attached=true
06:03:29: =====Stream Start: 2014-08-26, 06:03:29===============================================
06:03:29: Multithreaded optimizations: On
06:03:29: Base resolution: 1280x720
06:03:29: Output resolution: 1280x720
06:03:29: ------------------------------------------
06:03:29: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
06:03:29: ------------------------------------------
06:03:29: Audio Format: 48000 Hz
06:03:29: ------------------------------------------
06:03:29: Audio Channels: 2 Ch
06:03:29: Playback device Default
06:03:29: ------------------------------------------
06:03:29: Using desktop audio input: Speakers (Realtek High Definition Audio)
06:03:29: Global Audio time adjust: 0
06:03:29: ------------------------------------------
06:03:29: Audio Encoding: AAC
06:03:29: bitrate: 128
06:03:29: Using Window Capture
06:03:29: Scene buffering time set to 700
06:03:29: ------------------------------------------
06:03:29: Video Encoding: x264
06:03:29: fps: 60
06:03:29: width: 1280, height: 720
06:03:29: preset: veryfast
06:03:29: profile: main
06:03:29: keyint: 120
06:03:29: CBR: yes
06:03:29: CFR: yes
06:03:29: max bitrate: 3500
06:03:29: buffer size: 3500
06:03:29: ------------------------------------------
06:03:31: Using RTMP service: Twitch / Justin.tv
06:03:31: Server selection: rtmp://live.justin.tv/app
06:03:31: Interface: Intel(R) Centrino(R) Advanced-N 6205 (802.11, 43 mbps)
06:03:31: Completed handshake with rtmp://live.justin.tv/app in 177 ms.
06:03:32: SO_SNDBUF was at 65536
06:03:33: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 37976 / 463872)
06:03:37: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 262144 (buffer: 0 / 463872)
06:05:29: Total frames encoded: 7145, total frames duplicated: 285 (3.99%)
06:05:29: Number of frames skipped due to encoder lag: 179 (2.51%)
06:05:29: Total frames rendered: 6975, number of late frames: 20 (0.29%) (it's okay for some frames to be late)
06:05:30: RTMPPublisher::SocketLoop: Graceful loop exit
06:05:31: Average send payload: 7683 bytes, average send interval: 16 ms
06:05:31: Number of times waited to send: 4, Waited for a total of 9258 bytes
06:05:31: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
06:05:31: Number of bytes sent: 53241392
06:05:31:
06:05:31: Profiler time results:
06:05:31:
06:05:31: ==============================================================
06:05:31: video thread frame - [100%] [avg time: 2.277 ms] [children: 46.6%] [unaccounted: 53.4%]
06:05:31: | scene->Preprocess - [30.3%] [avg time: 0.691 ms]
06:05:31: | GPU download and conversion - [16.2%] [avg time: 0.37 ms] [children: 14.4%] [unaccounted: 1.89%]
06:05:31: | | flush - [11.8%] [avg time: 0.269 ms]
06:05:31: | | CopyResource - [2.15%] [avg time: 0.049 ms]
06:05:31: | | conversion to 4:2:0 - [0.395%] [avg time: 0.009 ms]
06:05:31: Convert444Threads - [100%] [avg time: 2.114 ms] [children: 99.1%] [unaccounted: 0.899%]
06:05:31: | Convert444toNV12 - [99.1%] [avg time: 2.095 ms]
06:05:31: encoder thread frame - [100%] [avg time: 4.258 ms] [children: 2.18%] [unaccounted: 97.8%]
06:05:31: | sending stuff out - [2.18%] [avg time: 0.093 ms]
06:05:31: ==============================================================
06:05:31:
06:05:31:
06:05:31: Profiler CPU results:
06:05:31:
06:05:31: ==============================================================
06:05:31: video thread frame - [cpu time: avg 0.938 ms, total 6546.88 ms] [avg calls per frame: 1]
06:05:31: | scene->Preprocess - [cpu time: avg 0.051 ms, total 359.375 ms] [avg calls per frame: 1]
06:05:31: | GPU download and conversion - [cpu time: avg 0.226 ms, total 1578.13 ms] [avg calls per frame: 1]
06:05:31: | | flush - [cpu time: avg 0.161 ms, total 1125 ms] [avg calls per frame: 1]
06:05:31: | | CopyResource - [cpu time: avg 0.02 ms, total 140.625 ms] [avg calls per frame: 1]
06:05:31: | | conversion to 4:2:0 - [cpu time: avg 0.015 ms, total 109.375 ms] [avg calls per frame: 1]
06:05:31: Convert444Threads - [cpu time: avg 1.987 ms, total 27531.3 ms] [avg calls per frame: 2]
06:05:31: | Convert444toNV12 - [cpu time: avg 1.977 ms, total 27390.6 ms] [avg calls per frame: 2]
06:05:31: encoder thread frame - [cpu time: avg 3.07 ms, total 21875 ms] [avg calls per frame: 1]
06:05:31: | sending stuff out - [cpu time: avg 0.059 ms, total 421.875 ms] [avg calls per frame: 1]
06:05:31: ==============================================================
06:05:31:
06:05:31: =====Stream End: 2014-08-26, 06:05:31=================================================
Attachments
Last edited: