Question / Help Sudden Frame Drop

Ireality

New Member
Hello,

I'm trying to figure out what causes issue for me with a sudden frame drop, which never occured before.
After 20seconds of streaming I have a lot of dropped frames.
The game in question is final fantasy 14 using game capture methode.

The logfile, especially created for a short stream test:
Code:
22:25:59: Open Broadcaster Software v0.571b - 64bit ( ^ω^)
22:25:59: -------------------------------
22:25:59: CPU Name: Intel(R) Core(TM) i5-3450 CPU @ 3.10GHz
22:25:59: CPU Speed: 3093MHz
22:25:59: Physical Memory:  8079MB Total, 2816MB Free
22:25:59: stepping id: 9, model 10, family 6, type 0, extmodel 1, extfamily 0, HTT 1, logical cores 4, total cores 4
22:25:59: monitor 1: pos={0, 0}, size={1920, 1080}
22:25:59: monitor 2: pos={1920, 0}, size={1920, 1080}
22:25:59: Windows Version: 6.1 Build 7601 S
22:25:59: Aero is Enabled
22:25:59: -------------------------------
22:25:59: OBS Modules:
22:25:59: Base Address     Module
22:25:59: 000000003F970000 OBS.exe
22:25:59: 00000000ECC00000 OBSApi.dll
22:25:59: 00000000F8D10000 DShowPlugin.dll
22:25:59: 00000000F8E30000 GraphicsCapture.dll
22:25:59: 00000000F8CF0000 NoiseGate.dll
22:25:59: 00000000F8CD0000 PSVPlugin.dll
22:25:59: ------------------------------------------
22:25:59: Adapter 1
22:25:59:   Video Adapter: NVIDIA GeForce GTX 660 
22:25:59:   Video Adapter Dedicated Video Memory: 2091450368
22:25:59:   Video Adapter Shared System Memory: 2147676160
22:25:59: ------------------------------------------
22:25:59: Adapter 2
22:25:59:   Video Adapter: Intel(R) HD Graphics
22:25:59:   Video Adapter Dedicated Video Memory: 67108864
22:25:59:   Video Adapter Shared System Memory: 1711276032
22:25:59: =====Stream Start: 2013-10-01, 22:25:59===============================================
22:25:59:   Multithreaded optimizations: On
22:25:59:   Base resolution: 1920x1080
22:25:59:   Output resolution: 1280x720
22:25:59: ------------------------------------------
22:25:59: Loading up D3D10 on NVIDIA GeForce GTX 660...
22:25:59: ------------------------------------------
22:25:59: Audio Format: 48000hz
22:25:59: Playback device Default
22:25:59: ------------------------------------------
22:25:59: Using desktop audio input: Speakers (VIA High Definition Audio)
22:25:59: ------------------------------------------
22:25:59: Using auxilary audio input: Microphone (HD Webcam C310)
22:25:59: ------------------------------------------
22:25:59: Audio Encoding: AAC
22:25:59:     bitrate: 128
22:25:59: Using bitmap image
22:25:59: Using bitmap image
22:25:59: Using text output
22:25:59: Using bitmap image
22:25:59: Using bitmap image
22:25:59: Using Window Capture
22:25:59: ------------------------------------------
22:25:59:     device: Logitech HD Webcam C310,
22:25:59:     device id \\?\usb#vid_046d&pid_081b&mi_00#7&1231cb5b&0&0000#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
22:25:59:     chosen type: I420, usingFourCC: false, res: 1280x720 - 1280x720, frameIntervals: 333333-2000000, fourCC: 'I420'
22:25:59:     audio device: (null),
22:25:59:     audio device id (null),
22:25:59: 
22:25:59: Using directshow input
22:25:59: Using bitmap image
22:26:00: ------------------------------------------
22:26:00: Video Encoding: x264
22:26:00:     fps: 60
22:26:00:     width: 1280, height: 720
22:26:00:     preset: veryfast
22:26:00:     profile: main
22:26:00:     keyint: 120
22:26:00:     CBR: yes
22:26:00:     CFR: yes
22:26:00:     max bitrate: 2000
22:26:00:     buffer size: 2000
22:26:00: ------------------------------------------
22:26:00: MMDeviceAudioSource: Frequency for device 'Speakers (VIA High Definition Audio)' is 384000, samples per sec is 48000
22:26:00: MMDeviceAudioSource: Frequency for device 'Microphone (HD Webcam C310)' is 192000, samples per sec is 48000
22:26:02: Using RTMP service: Twitch / Justin.tv
22:26:02:   Server selection: rtmp://live-lhr.justin.tv/app
22:26:02:   Interface: Atheros AR8161/8165 PCI-E Gigabit Ethernet Controller (NDIS 6.20) (ethernet, 1000 mbps)
22:26:02: ++++++++++++++++++++++++++++++++++++++++++++++++++++++
22:26:02:   New Scene
22:26:03: Using bitmap image
22:26:03: Completed handshake with rtmp://live-lhr.justin.tv/app in 410 ms.
22:26:03: Using bitmap image
22:26:03: ------------------------------------------
22:26:03:     device: Logitech HD Webcam C310,
22:26:03:     device id \\?\usb#vid_046d&pid_081b&mi_00#7&1231cb5b&0&0000#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
22:26:03:     chosen type: I420, usingFourCC: false, res: 1280x720 - 1280x720, frameIntervals: 333333-2000000, fourCC: 'I420'
22:26:03:     audio device: Disable,
22:26:03:     audio device id Disabled,
22:26:03: 
22:26:03: Using directshow input
22:26:03: Using text output
22:26:03: Using Window Capture
22:26:04: PERFORMANCE WARNING: Scene change took 1180 ms, maybe some sources should be global sources?
22:26:04: SO_SNDBUF was at 8192
22:26:04: SO_SNDBUF is now 65536
22:26:29: RTMPPublisher::SendLoop: Stalled for 1768 ms to write 272284 bytes (buffer: 0 / 272384), unstable connection?
22:26:32: RTMPPublisher::SendLoop: Stalled for 2004 ms to write 269007 bytes (buffer: 0 / 272384), unstable connection?
22:26:36: RTMPPublisher::SendLoop: Stalled for 1940 ms to write 269464 bytes (buffer: 0 / 272384), unstable connection?
22:26:37: Using graphics capture
22:26:38: SharedTexCapture hooked
22:26:42: RTMPPublisher::SendLoop: Stalled for 1768 ms to write 271984 bytes (buffer: 0 / 272384), unstable connection?
22:26:44: RTMPPublisher::SendLoop: Stalled for 1575 ms to write 271088 bytes (buffer: 0 / 272384), unstable connection?
22:27:06: Total frames encoded: 3880, total frames duplicated: 730 (18.81%)
22:27:06: Number of frames skipped due to encoder lag: 6 (0.15%)
22:27:06: Total frames rendered: 3305, number of late frames: 55 (1.66%) (it's okay for some frames to be late)
22:27:06: RTMPPublisher::SocketLoop: Graceful loop exit
22:27:07: Average send payload: 9567 bytes, average send interval: 40 ms
22:27:07: Number of times waited to send: 13, Waited for a total of 44689 bytes
22:27:07: Number of b-frames dropped: 219 (6%), Number of p-frames dropped: 273 (7.5%), Total 492 (13%)
22:27:07: Number of bytes sent: 14629437
22:27:07: 
22:27:07: Profiler time results:
22:27:07: 
22:27:07: ==============================================================
22:27:07: video thread frame - [100%] [avg time: 5.108 ms] [children: 81.7%] [unaccounted: 18.3%]
22:27:07: | scene->Preprocess - [81.7%] [avg time: 4.173 ms]
22:27:07: GPU download and conversion - [100%] [avg time: 0.234 ms] [children: 69.2%] [unaccounted: 30.8%]
22:27:07: | flush - [31.6%] [avg time: 0.074 ms]
22:27:07: | CopyResource - [35%] [avg time: 0.082 ms]
22:27:07: | conversion to 4:2:0 - [2.56%] [avg time: 0.006 ms]
22:27:07: Convert444Threads - [100%] [avg time: 0.414 ms] [children: 99.3%] [unaccounted: 0.725%]
22:27:07: | Convert444toNV12 - [99.3%] [avg time: 0.411 ms]
22:27:07: encoder thread frame - [100%] [avg time: 0.904 ms]
22:27:07: ==============================================================
22:27:07: 
22:27:07: 
22:27:07: Profiler CPU results:
22:27:07: 
22:27:07: ==============================================================
22:27:07: video thread frame - [cpu time: avg 0.358 ms, total 1185.61 ms] [avg calls per frame: 1]
22:27:07: | scene->Preprocess - [cpu time: avg 0.061 ms, total 202.8 ms] [avg calls per frame: 1]
22:27:07: GPU download and conversion - [cpu time: avg 0.037 ms, total 124.8 ms] [avg calls per frame: 1]
22:27:07: | flush - [cpu time: avg 0.018 ms, total 62.4 ms] [avg calls per frame: 1]
22:27:07: | CopyResource - [cpu time: avg 0.004 ms, total 15.6 ms] [avg calls per frame: 1]
22:27:07: | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
22:27:07: Convert444Threads - [cpu time: avg 0.256 ms, total 1669.21 ms] [avg calls per frame: 2]
22:27:07: | Convert444toNV12 - [cpu time: avg 0.253 ms, total 1653.61 ms] [avg calls per frame: 2]
22:27:07: encoder thread frame - [cpu time: avg 0.081 ms, total 312.002 ms] [avg calls per frame: 1]
22:27:07: ==============================================================
22:27:07: 
22:27:07: =====Stream End: 2013-10-01, 22:27:07=================================================
22:27:09: =====Stream Start: 2013-10-01, 22:27:09===============================================
22:27:09:   Multithreaded optimizations: On
22:27:09:   Base resolution: 1920x1080
22:27:09:   Output resolution: 1280x720
22:27:09: ------------------------------------------
22:27:09: Loading up D3D10 on NVIDIA GeForce GTX 660...
22:27:09: ------------------------------------------
22:27:09: Audio Format: 48000hz
22:27:09: Playback device Default
22:27:09: ------------------------------------------
22:27:09: Using desktop audio input: Speakers (VIA High Definition Audio)
22:27:09: ------------------------------------------
22:27:09: Using auxilary audio input: Microphone (HD Webcam C310)
22:27:09: ------------------------------------------
22:27:09: Audio Encoding: AAC
22:27:09:     bitrate: 128
22:27:09: Using bitmap image
22:27:09: Using bitmap image
22:27:09: ------------------------------------------
22:27:09:     device: Logitech HD Webcam C310,
22:27:09:     device id \\?\usb#vid_046d&pid_081b&mi_00#7&1231cb5b&0&0000#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
22:27:09:     chosen type: I420, usingFourCC: false, res: 1280x720 - 1280x720, frameIntervals: 333333-2000000, fourCC: 'I420'
22:27:09:     audio device: Disable,
22:27:09:     audio device id Disabled,
22:27:09: 
22:27:09: Using directshow input
22:27:09: Using text output
22:27:09: Using graphics capture
22:27:10: ------------------------------------------
22:27:10: Video Encoding: x264
22:27:10:     fps: 60
22:27:10:     width: 1280, height: 720
22:27:10:     preset: veryfast
22:27:10:     profile: main
22:27:10:     keyint: 120
22:27:10:     CBR: yes
22:27:10:     CFR: yes
22:27:10:     max bitrate: 2000
22:27:10:     buffer size: 2000
22:27:10: ------------------------------------------
22:27:10: MMDeviceAudioSource: Frequency for device 'Speakers (VIA High Definition Audio)' is 384000, samples per sec is 48000
22:27:10: MMDeviceAudioSource: Frequency for device 'Microphone (HD Webcam C310)' is 192000, samples per sec is 48000
22:27:10: SharedTexCapture hooked
22:27:12: Using RTMP service: Twitch / Justin.tv
22:27:12:   Server selection: rtmp://live-lhr.justin.tv/app
22:27:12:   Interface: Atheros AR8161/8165 PCI-E Gigabit Ethernet Controller (NDIS 6.20) (ethernet, 1000 mbps)
22:27:12: Completed handshake with rtmp://live-lhr.justin.tv/app in 412 ms.
22:27:14: SO_SNDBUF was at 8192
22:27:14: SO_SNDBUF is now 65536
22:27:43: Total frames encoded: 1892, total frames duplicated: 98 (5.18%)
22:27:43: Total frames rendered: 1899, number of late frames: 2 (0.11%) (it's okay for some frames to be late)
22:27:43: RTMPPublisher::SocketLoop: Graceful loop exit
22:27:45: Average send payload: 10530 bytes, average send interval: 39 ms
22:27:45: Number of times waited to send: 4, Waited for a total of 12102 bytes
22:27:45: Number of b-frames dropped: 12 (0.7%), Number of p-frames dropped: 0 (0%), Total 12 (0.7%)
22:27:45: Number of bytes sent: 7634898
22:27:45: 
22:27:45: Profiler time results:
22:27:45: 
22:27:45: ==============================================================
22:27:45: video thread frame - [100%] [avg time: 0.973 ms] [children: 18.3%] [unaccounted: 81.7%]
22:27:45: | scene->Preprocess - [18.3%] [avg time: 0.178 ms]
22:27:45: GPU download and conversion - [100%] [avg time: 1.279 ms] [children: 26.8%] [unaccounted: 73.2%]
22:27:45: | flush - [16.3%] [avg time: 0.209 ms]
22:27:45: | CopyResource - [10.2%] [avg time: 0.131 ms]
22:27:45: | conversion to 4:2:0 - [0.235%] [avg time: 0.003 ms]
22:27:45: Convert444Threads - [100%] [avg time: 0.384 ms] [children: 99.2%] [unaccounted: 0.781%]
22:27:45: | Convert444toNV12 - [99.2%] [avg time: 0.381 ms]
22:27:45: encoder thread frame - [100%] [avg time: 0.952 ms]
22:27:45: ==============================================================
22:27:45: 
22:27:45: 
22:27:45: Profiler CPU results:
22:27:45: 
22:27:45: ==============================================================
22:27:45: video thread frame - [cpu time: avg 0.303 ms, total 577.203 ms] [avg calls per frame: 1]
22:27:45: | scene->Preprocess - [cpu time: avg 0.024 ms, total 46.8 ms] [avg calls per frame: 1]
22:27:45: GPU download and conversion - [cpu time: avg 0.008 ms, total 15.6 ms] [avg calls per frame: 1]
22:27:45: | flush - [cpu time: avg 0.008 ms, total 15.6 ms] [avg calls per frame: 1]
22:27:45: | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
22:27:45: | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
22:27:45: Convert444Threads - [cpu time: avg 0.231 ms, total 858.004 ms] [avg calls per frame: 2]
22:27:45: | Convert444toNV12 - [cpu time: avg 0.231 ms, total 858.004 ms] [avg calls per frame: 2]
22:27:45: encoder thread frame - [cpu time: avg 0.185 ms, total 343.202 ms] [avg calls per frame: 1]
22:27:45: ==============================================================
22:27:45: 
22:27:45: =====Stream End: 2013-10-01, 22:27:45=================================================


Last game capture log:
2013-10-01, 22:26:37: we're booting up: 
22:26:38: D3D9 Present
22:26:38: D3D9EndScene called
22:26:38: D3DPRESENT_PARAMETERS {
22:26:38: 	BackBufferWidth: 1
22:26:38: 	BackBufferHeight: 1
22:26:38: 	BackBufferFormat: D3DFMT_X8R8G8B8
22:26:38: 	BackBufferCount: 1
22:26:38: 	MultiSampleType: D3DMULTISAMPLE_NONE
22:26:38: 	MultiSampleQuality: 0
22:26:38: 	SwapEffect: D3DSWAPEFFECT_DISCARD
22:26:38: 	hDeviceWindow: 852402
22:26:38: 	Windowed: true
22:26:38: 	EnableAutoDepthStencil: false
22:26:38: 	AutoDepthStencilFormat: D3DFMT_UNKNOWN
22:26:38: 	Flags: None
22:26:38: 	FullScreen_RefreshRateInHz: 0
22:26:38: 	PresentationInterval: 2147483648
22:26:38: };
22:26:38: successfully set up d3d9 hooks
22:26:38: DXGI Present
22:26:38: (half life scientist) everything..  seems to be in order
22:26:38: D3D9SwapPresent called
22:26:38: DoD3D9GPUHook: success
22:26:38: D3DSURFACE_DESC {
22:26:38: 	Format: D3DFMT_X8R8G8B8
22:26:38: 	Type: D3DRTYPE_SURFACE
22:26:38: 	Usage: D3DUSAGE_RENDERTARGET 
22:26:38: 	Pool: D3DPOOL_DEFAULT
22:26:38: 	MultiSampleType: D3DMULTISAMPLE_NONE
22:26:38: 	MultiSampleQuality: 0
22:26:38: 	Width: 1920
22:26:38: 	Height: 1028
22:26:38: };
22:26:38: successfully capturing d3d9 frames via GPU
22:27:06: ---------------------- Cleared D3D9 Capture ----------------------
22:27:06: D3D9EndScene called
22:27:06: D3D9SwapPresent called
22:27:10: received restart event, capturing
22:27:10: DoD3D9GPUHook: success
22:27:10: D3DSURFACE_DESC {
22:27:10: 	Format: D3DFMT_X8R8G8B8
22:27:10: 	Type: D3DRTYPE_SURFACE
22:27:10: 	Usage: D3DUSAGE_RENDERTARGET 
22:27:10: 	Pool: D3DPOOL_DEFAULT
22:27:10: 	MultiSampleType: D3DMULTISAMPLE_NONE
22:27:10: 	MultiSampleQuality: 0
22:27:10: 	Width: 1920
22:27:10: 	Height: 1028
22:27:10: };
22:27:10: successfully capturing d3d9 frames via GPU
22:27:43: ---------------------- Cleared D3D9 Capture ----------------------
22:27:43: D3D9EndScene called
22:27:43: D3D9SwapPresent called
 

dodgepong

Administrator
Community Helper
The London servers are down and redirecting all their traffic to Amsterdam. Try the Frankfurt server.
 
Top