Question / Help Serious Lag

A

AirKevin

New Member
Lately, probably since the last update, I get some serious lag most of the time. Some videos to prove my point.
http://www.twitch.tv/pw4056/b/482416744

http://www.twitch.tv/pw4056/b/482396747

In both videos, the lag lasts about 15-20 minutes, and then everything runs smooth again, even though I haven't changed any settings.

Log for the first link:

Code: 
15:05:22: Open Broadcaster Software v0.584b - 64bit (　^ω^)
15:05:22: -------------------------------
15:05:22: CPU Name: Intel(R) Core(TM) i5-2450M CPU @ 2.50GHz
15:05:22: CPU Speed: 2494MHz
15:05:22: Physical Memory:  8139MB Total, 2693MB Free
15:05:22: stepping id: 7, model 42, family 6, type 0, extmodel 1, extfamily 0, HTT 1, logical cores 4, total cores 2
15:05:22: monitor 1: pos={0, 0}, size={1366, 768}
15:05:22: Windows Version: 6.1 Build 7601 S
15:05:22: Aero is Enabled
15:05:22: -------------------------------
15:05:22: OBS Modules:
15:05:22: Base Address     Module
15:05:22: 000000003F3A0000 OBS.exe
15:05:22: 00000000EB2C0000 OBSApi.dll
15:05:22: 00000000F90F0000 DShowPlugin.dll
15:05:22: 00000000FB2F0000 GraphicsCapture.dll
15:05:22: 00000000FB340000 NoiseGate.dll
15:05:22: 00000000FB3D0000 PSVPlugin.dll
15:05:22: ------------------------------------------
15:05:22: Adapter 1
15:05:22:   Video Adapter: Intel(R) HD Graphics Family
15:05:22:   Video Adapter Dedicated Video Memory: 67108864
15:05:22:   Video Adapter Shared System Memory: 1711276032
15:05:22:   Video Adapter Output 1: pos={0, 0}, size={1366, 768}, attached=true
15:05:22: =====Stream Start: 2013-11-23, 15:05:22===============================================
15:05:22:   Multithreaded optimizations: On
15:05:22:   Base resolution: 1366x768
15:05:22:   Output resolution: 1364x768
15:05:22: ------------------------------------------
15:05:22: Loading up D3D10 on Intel(R) HD Graphics Family...
15:05:22: ------------------------------------------
15:05:22: Audio Format: 48000hz
15:05:22: Playback device Default
15:05:22: ------------------------------------------
15:05:22: Using desktop audio input: Speakers (2- USB Sound Device        )
15:05:22: ------------------------------------------
15:05:22: Using auxilary audio input: Microphone (Conexant SmartAudio HD)
15:05:22: ------------------------------------------
15:05:22: Audio Encoding: AAC
15:05:22:     bitrate: 128
15:05:22: Using graphics capture
15:05:22: Scene buffering time set to 400
15:05:22: ------------------------------------------
15:05:22: Video Encoding: x264
15:05:22:     fps: 30
15:05:22:     width: 1364, height: 768
15:05:22:     preset: veryfast
15:05:22:     profile: high
15:05:22:     keyint: 60
15:05:22:     CBR: yes
15:05:22:     CFR: yes
15:05:22:     max bitrate: 1000
15:05:22:     buffer size: 1000
15:05:22: ------------------------------------------
15:05:22: MMDeviceAudioSource: Frequency for device 'Speakers (2- USB Sound Device        )' is 352800, samples per sec is 44100
15:05:22: MMDeviceAudioSource: Frequency for device 'Microphone (Conexant SmartAudio HD)' is 352800, samples per sec is 44100
15:05:22: SharedTexCapture hooked
15:05:24: Using RTMP service: Twitch / Justin.tv
15:05:24:   Server selection: rtmp://live-jfk.justin.tv/app
15:05:24:   Interface: Realtek RTL8188CE Wireless LAN 802.11n PCI-E NIC (802.11, 48 mbps)
15:05:24: Completed handshake with rtmp://live-jfk.justin.tv/app in 202 ms.
15:05:25: SO_SNDBUF was at 8192
15:05:25: SO_SNDBUF is now 65536
15:10:45: Total frames encoded: 9311, total frames duplicated: 2966 (31.85%)
15:10:45: Number of frames skipped due to encoder lag: 2923 (31.39%)
15:10:45: Total frames rendered: 6392, number of late frames: 2 (0.03%) (it's okay for some frames to be late)
15:10:45: RTMPPublisher::SocketLoop: Graceful loop exit
15:10:45: Average send payload: 3771 bytes, average send interval: 27 ms
15:10:45: Number of times waited to send: 0, Waited for a total of 0 bytes
15:10:45: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
15:10:45: Number of bytes sent: 43496854
15:10:45: 
15:10:45: Profiler time results:
15:10:45: 
15:10:45: ==============================================================
15:10:45: video thread frame - [100%] [avg time: 1.494 ms] [children: 26.6%] [unaccounted: 73.4%]
15:10:45: | scene->Preprocess - [0.201%] [avg time: 0.003 ms]
15:10:45: | GPU download and conversion - [26.4%] [avg time: 0.395 ms] [children: 22%] [unaccounted: 4.48%]
15:10:45: | | flush - [8.84%] [avg time: 0.132 ms]
15:10:45: | | CopyResource - [12.6%] [avg time: 0.188 ms]
15:10:45: | | conversion to 4:2:0 - [0.535%] [avg time: 0.008 ms]
15:10:45: Convert444Thread - [100%] [avg time: 2.593 ms] [children: 99.3%] [unaccounted: 0.694%]
15:10:45: | Convert444toNV12 - [99.3%] [avg time: 2.575 ms]
15:10:45: encoder thread frame - [100%] [avg time: 14.223 ms]
15:10:45: ==============================================================
15:10:45: 
15:10:45: 
15:10:45: Profiler CPU results:
15:10:45: 
15:10:45: ==============================================================
15:10:45: video thread frame - [cpu time: avg 1.103 ms, total 7051.25 ms] [avg calls per frame: 1]
15:10:45: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:10:45: | GPU download and conversion - [cpu time: avg 0.412 ms, total 2636.42 ms] [avg calls per frame: 1]
15:10:45: | | flush - [cpu time: avg 0.19 ms, total 1216.81 ms] [avg calls per frame: 1]
15:10:45: | | CopyResource - [cpu time: avg 0.158 ms, total 1014.01 ms] [avg calls per frame: 1]
15:10:45: | | conversion to 4:2:0 - [cpu time: avg 0.012 ms, total 78.001 ms] [avg calls per frame: 1]
15:10:45: Convert444Thread - [cpu time: avg 2.512 ms, total 16021.3 ms] [avg calls per frame: 1]
15:10:45: | Convert444toNV12 - [cpu time: avg 2.507 ms, total 15990.1 ms] [avg calls per frame: 1]
15:10:45: encoder thread frame - [cpu time: avg 3.291 ms, total 30607.4 ms] [avg calls per frame: 1]
15:10:45: ==============================================================
15:10:45: 
15:10:45: =====Stream End: 2013-11-23, 15:10:45=================================================
15:10:51: =====Stream Start: 2013-11-23, 15:10:51===============================================
15:10:51:   Multithreaded optimizations: On
15:10:51:   Base resolution: 1366x768
15:10:51:   Output resolution: 1364x768
15:10:51: ------------------------------------------
15:10:51: Loading up D3D10 on Intel(R) HD Graphics Family...
15:10:51: ------------------------------------------
15:10:51: Audio Format: 48000hz
15:10:51: Playback device Default
15:10:51: ------------------------------------------
15:10:51: Using desktop audio input: Speakers (2- USB Sound Device        )
15:10:51: ------------------------------------------
15:10:51: Using auxilary audio input: Microphone (Conexant SmartAudio HD)
15:10:51: ------------------------------------------
15:10:51: Audio Encoding: AAC
15:10:51:     bitrate: 128
15:10:51: Using graphics capture
15:10:51: Scene buffering time set to 400
15:10:51: ------------------------------------------
15:10:51: Video Encoding: x264
15:10:51:     fps: 30
15:10:51:     width: 1364, height: 768
15:10:51:     preset: veryfast
15:10:51:     profile: high
15:10:51:     keyint: 60
15:10:51:     CBR: yes
15:10:51:     CFR: yes
15:10:51:     max bitrate: 1000
15:10:51:     buffer size: 1000
15:10:51: ------------------------------------------
15:10:51: MMDeviceAudioSource: Frequency for device 'Speakers (2- USB Sound Device        )' is 352800, samples per sec is 44100
15:10:51: MMDeviceAudioSource: Frequency for device 'Microphone (Conexant SmartAudio HD)' is 352800, samples per sec is 44100
15:10:51: SharedTexCapture hooked
15:10:53: Using RTMP service: Twitch / Justin.tv
15:10:53:   Server selection: rtmp://live-jfk.justin.tv/app
15:10:53:   Interface: Realtek RTL8188CE Wireless LAN 802.11n PCI-E NIC (802.11, 48 mbps)
15:10:53: Completed handshake with rtmp://live-jfk.justin.tv/app in 302 ms.
15:10:54: SO_SNDBUF was at 8192
15:10:54: SO_SNDBUF is now 65536
16:27:49: Total frames encoded: 138507, total frames duplicated: 10907 (7.87%)
16:27:49: Number of frames skipped due to encoder lag: 7846 (5.66%)
16:27:49: Total frames rendered: 130441, number of late frames: 469 (0.36%) (it's okay for some frames to be late)
16:27:49: RTMPPublisher::SocketLoop: Graceful loop exit
16:27:49: Average send payload: 3527 bytes, average send interval: 24 ms
16:27:49: Number of times waited to send: 0, Waited for a total of 0 bytes
16:27:49: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
16:27:49: Number of bytes sent: 654608531
16:27:49: 
16:27:49: Profiler time results:
16:27:49: 
16:27:49: ==============================================================
16:27:49: video thread frame - [100%] [avg time: 1.877 ms] [children: 47.9%] [unaccounted: 52.1%]
16:27:49: | scene->Preprocess - [0.107%] [avg time: 0.002 ms]
16:27:49: | GPU download and conversion - [47.8%] [avg time: 0.897 ms] [children: 41.2%] [unaccounted: 6.61%]
16:27:49: | | flush - [9.43%] [avg time: 0.177 ms]
16:27:49: | | CopyResource - [31.4%] [avg time: 0.589 ms]
16:27:49: | | conversion to 4:2:0 - [0.373%] [avg time: 0.007 ms]
16:27:49: Convert444Thread - [100%] [avg time: 3.039 ms] [children: 99.3%] [unaccounted: 0.658%]
16:27:49: | Convert444toNV12 - [99.3%] [avg time: 3.019 ms]
16:27:49: encoder thread frame - [100%] [avg time: 5.649 ms]
16:27:49: ==============================================================
16:27:49: 
16:27:49: 
16:27:49: Profiler CPU results:
16:27:49: 
16:27:49: ==============================================================
16:27:49: video thread frame - [cpu time: avg 0.713 ms, total 93007.8 ms] [avg calls per frame: 1]
16:27:49: | scene->Preprocess - [cpu time: avg 0 ms, total 78.002 ms] [avg calls per frame: 1]
16:27:49: | GPU download and conversion - [cpu time: avg 0.251 ms, total 32760.2 ms] [avg calls per frame: 1]
16:27:49: | | flush - [cpu time: avg 0.124 ms, total 16177.3 ms] [avg calls per frame: 1]
16:27:49: | | CopyResource - [cpu time: avg 0.093 ms, total 12230.5 ms] [avg calls per frame: 1]
16:27:49: | | conversion to 4:2:0 - [cpu time: avg 0.004 ms, total 624.005 ms] [avg calls per frame: 1]
16:27:49: Convert444Thread - [cpu time: avg 2.479 ms, total 323343 ms] [avg calls per frame: 1]
16:27:49: | Convert444toNV12 - [cpu time: avg 2.469 ms, total 322142 ms] [avg calls per frame: 1]
16:27:49: encoder thread frame - [cpu time: avg 2.345 ms, total 324888 ms] [avg calls per frame: 1]
16:27:49: ==============================================================
16:27:49: 
16:27:49: =====Stream End: 2013-11-23, 16:27:49=================================================


Last game capture log:
2013-11-23, 15:05:22: we're booting up: 
15:05:22: D3D9 Present
15:05:22: (half life scientist) everything..  seems to be in order
15:05:22: D3D9EndScene called
15:05:22: D3DPRESENT_PARAMETERS {
15:05:22: 	BackBufferWidth: 1366
15:05:22: 	BackBufferHeight: 768
15:05:22: 	BackBufferFormat: D3DFMT_X8R8G8B8
15:05:22: 	BackBufferCount: 1
15:05:22: 	MultiSampleType: D3DMULTISAMPLE_NONMASKABLE
15:05:22: 	MultiSampleQuality: 0
15:05:22: 	SwapEffect: D3DSWAPEFFECT_DISCARD
15:05:22: 	hDeviceWindow: 4459714
15:05:22: 	Windowed: false
15:05:22: 	EnableAutoDepthStencil: true
15:05:22: 	AutoDepthStencilFormat: D3DFMT_D24S8
15:05:22: 	Flags: D3DPRESENTFLAG_DISCARD_DEPTHSTENCIL 
15:05:22: 	FullScreen_RefreshRateInHz: 60
15:05:22: 	PresentationInterval: 0
15:05:22: };
15:05:22: successfully set up d3d9 hooks
15:05:22: D3D9Present called
15:05:22: DoD3D9GPUHook: success
15:05:22: D3DSURFACE_DESC {
15:05:22: 	Format: D3DFMT_X8R8G8B8
15:05:22: 	Type: D3DRTYPE_SURFACE
15:05:22: 	Usage: D3DUSAGE_RENDERTARGET 
15:05:22: 	Pool: D3DPOOL_DEFAULT
15:05:22: 	MultiSampleType: D3DMULTISAMPLE_NONMASKABLE
15:05:22: 	MultiSampleQuality: 0
15:05:22: 	Width: 1366
15:05:22: 	Height: 768
15:05:22: };
15:05:22: successfully capturing d3d9 frames via GPU
15:10:45: ---------------------- Cleared D3D9 Capture ----------------------
15:10:45: D3D9EndScene called
15:10:45: D3D9Present called
15:10:51: received restart event, capturing
15:10:51: DoD3D9GPUHook: success
15:10:52: D3DSURFACE_DESC {
15:10:52: 	Format: D3DFMT_X8R8G8B8
15:10:52: 	Type: D3DRTYPE_SURFACE
15:10:52: 	Usage: D3DUSAGE_RENDERTARGET 
15:10:52: 	Pool: D3DPOOL_DEFAULT
15:10:52: 	MultiSampleType: D3DMULTISAMPLE_NONMASKABLE
15:10:52: 	MultiSampleQuality: 0
15:10:52: 	Width: 1366
15:10:52: 	Height: 768
15:10:52: };
15:10:52: successfully capturing d3d9 frames via GPU
16:27:49: ---------------------- Cleared D3D9 Capture ----------------------
16:27:49: D3D9EndScene called
16:27:49: D3D9Present called
16:28:05: D3D9Reset called
16:28:05: ---------------------- Cleared D3D9 Capture ----------------------
16:28:05: successfully set up d3d9 hooks
16:28:06: D3D9EndScene called
16:28:06: D3D9Reset called
16:28:06: ---------------------- Cleared D3D9 Capture ----------------------
16:28:06: successfully set up d3d9 hooks
16:28:06: D3D9EndScene called

[b][u]END LOG[/u][/b]

Log for the second link:

16:36:19: Open Broadcaster Software v0.584b - 64bit (　^ω^)
16:36:19: -------------------------------
16:36:19: CPU Name: Intel(R) Core(TM) i5-2450M CPU @ 2.50GHz
16:36:19: CPU Speed: 2494MHz
16:36:19: Physical Memory:  8139MB Total, 3359MB Free
16:36:19: stepping id: 7, model 42, family 6, type 0, extmodel 1, extfamily 0, HTT 1, logical cores 4, total cores 2
16:36:19: monitor 1: pos={0, 0}, size={1366, 768}
16:36:19: Windows Version: 6.1 Build 7601 S
16:36:19: Aero is Disabled
16:36:19: -------------------------------
16:36:19: OBS Modules:
16:36:19: Base Address     Module
16:36:19: 000000003F7F0000 OBS.exe
16:36:19: 00000000EB2C0000 OBSApi.dll
16:36:19: 00000000F90F0000 DShowPlugin.dll
16:36:19: 00000000FB2F0000 GraphicsCapture.dll
16:36:19: 00000000FB340000 NoiseGate.dll
16:36:19: 00000000F5AF0000 PSVPlugin.dll
16:36:19: ------------------------------------------
16:36:19: Adapter 1
16:36:19:   Video Adapter: Intel(R) HD Graphics Family
16:36:19:   Video Adapter Dedicated Video Memory: 67108864
16:36:19:   Video Adapter Shared System Memory: 1711276032
16:36:19:   Video Adapter Output 1: pos={0, 0}, size={1366, 768}, attached=true
16:36:19: =====Stream Start: 2013-11-23, 16:36:19===============================================
16:36:19:   Multithreaded optimizations: On
16:36:19:   Base resolution: 1366x768
16:36:19:   Output resolution: 1364x768
16:36:19: ------------------------------------------
16:36:19: Loading up D3D10 on Intel(R) HD Graphics Family...
16:36:19: ------------------------------------------
16:36:19: Audio Format: 48000hz
16:36:19: Playback device Default
16:36:19: ------------------------------------------
16:36:19: Using desktop audio input: Speakers (2- USB Sound Device        )
16:36:19: ------------------------------------------
16:36:19: Using auxilary audio input: Microphone (Conexant SmartAudio HD)
16:36:19: ------------------------------------------
16:36:19: Audio Encoding: AAC
16:36:19:     bitrate: 128
16:36:19: Using graphics capture
16:36:19: Scene buffering time set to 400
16:36:19: ------------------------------------------
16:36:19: Video Encoding: x264
16:36:19:     fps: 30
16:36:19:     width: 1364, height: 768
16:36:19:     preset: veryfast
16:36:19:     profile: high
16:36:19:     keyint: 60
16:36:19:     CBR: yes
16:36:19:     CFR: yes
16:36:19:     max bitrate: 1000
16:36:19:     buffer size: 1000
16:36:19: ------------------------------------------
16:36:19: MMDeviceAudioSource: Frequency for device 'Speakers (2- USB Sound Device        )' is 352800, samples per sec is 44100
16:36:19: MMDeviceAudioSource: Frequency for device 'Microphone (Conexant SmartAudio HD)' is 352800, samples per sec is 44100
16:36:19: SharedTexCapture hooked
16:36:21: Using RTMP service: Twitch / Justin.tv
16:36:21:   Server selection: rtmp://live-jfk.justin.tv/app
16:36:21:   Interface: Realtek RTL8188CE Wireless LAN 802.11n PCI-E NIC (802.11, 48 mbps)
16:36:21: Completed handshake with rtmp://live-jfk.justin.tv/app in 194 ms.
16:36:22: SO_SNDBUF was at 8192
16:36:22: SO_SNDBUF is now 65536
17:16:00: Total frames encoded: 71422, total frames duplicated: 9480 (13.27%)
17:16:00: Number of frames skipped due to encoder lag: 3496 (4.89%)
17:16:00: Total frames rendered: 67519, number of late frames: 1301 (1.93%) (it's okay for some frames to be late)
17:16:00: RTMPPublisher::SocketLoop: Graceful loop exit
17:16:00: Average send payload: 3468 bytes, average send interval: 24 ms
17:16:00: Number of times waited to send: 0, Waited for a total of 0 bytes
17:16:00: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
17:16:00: Number of bytes sent: 337346712
17:16:01: 
17:16:01: Profiler time results:
17:16:01: 
17:16:01: ==============================================================
17:16:01: video thread frame - [100%] [avg time: 3.721 ms] [children: 51.7%] [unaccounted: 48.3%]
17:16:01: | scene->Preprocess - [0.107%] [avg time: 0.004 ms]
17:16:01: | GPU download and conversion - [51.6%] [avg time: 1.921 ms] [children: 46.7%] [unaccounted: 4.92%]
17:16:01: | | flush - [7.55%] [avg time: 0.281 ms]
17:16:01: | | CopyResource - [38.8%] [avg time: 1.444 ms]
17:16:01: | | conversion to 4:2:0 - [0.349%] [avg time: 0.013 ms]
17:16:01: Convert444Thread - [100%] [avg time: 4.982 ms] [children: 99.3%] [unaccounted: 0.682%]
17:16:01: | Convert444toNV12 - [99.3%] [avg time: 4.948 ms]
17:16:01: encoder thread frame - [100%] [avg time: 11.643 ms]
17:16:01: ==============================================================
17:16:01: 
17:16:01: 
17:16:01: Profiler CPU results:
17:16:01: 
17:16:01: ==============================================================
17:16:01: video thread frame - [cpu time: avg 1.548 ms, total 104552 ms] [avg calls per frame: 1]
17:16:01: | scene->Preprocess - [cpu time: avg 0.003 ms, total 218.401 ms] [avg calls per frame: 1]
17:16:01: | GPU download and conversion - [cpu time: avg 0.465 ms, total 31449.8 ms] [avg calls per frame: 1]
17:16:01: | | flush - [cpu time: avg 0.214 ms, total 14492.5 ms] [avg calls per frame: 1]
17:16:01: | | CopyResource - [cpu time: avg 0.186 ms, total 12620.5 ms] [avg calls per frame: 1]
17:16:01: | | conversion to 4:2:0 - [cpu time: avg 0.007 ms, total 483.602 ms] [avg calls per frame: 1]
17:16:01: Convert444Thread - [cpu time: avg 3.669 ms, total 247698 ms] [avg calls per frame: 1]
17:16:01: | Convert444toNV12 - [cpu time: avg 3.655 ms, total 246778 ms] [avg calls per frame: 1]
17:16:01: encoder thread frame - [cpu time: avg 3.916 ms, total 279679 ms] [avg calls per frame: 1]
17:16:01: ==============================================================
17:16:01: 
17:16:01: =====Stream End: 2013-11-23, 17:16:01=================================================


Last game capture log:
2013-11-23, 16:36:19: we're booting up: 
16:36:19: D3D9 Present
16:36:19: (half life scientist) everything..  seems to be in order
16:36:19: D3D9EndScene called
16:36:19: D3DPRESENT_PARAMETERS {
16:36:19: 	BackBufferWidth: 1366
16:36:19: 	BackBufferHeight: 768
16:36:19: 	BackBufferFormat: D3DFMT_X8R8G8B8
16:36:19: 	BackBufferCount: 1
16:36:19: 	MultiSampleType: D3DMULTISAMPLE_NONMASKABLE
16:36:19: 	MultiSampleQuality: 0
16:36:19: 	SwapEffect: D3DSWAPEFFECT_DISCARD
16:36:19: 	hDeviceWindow: 6753370
16:36:19: 	Windowed: false
16:36:19: 	EnableAutoDepthStencil: true
16:36:19: 	AutoDepthStencilFormat: D3DFMT_D24S8
16:36:19: 	Flags: D3DPRESENTFLAG_DISCARD_DEPTHSTENCIL 
16:36:19: 	FullScreen_RefreshRateInHz: 60
16:36:19: 	PresentationInterval: 0
16:36:19: };
16:36:19: successfully set up d3d9 hooks
16:36:19: D3D9Present called
16:36:19: DoD3D9GPUHook: success
16:36:19: D3DSURFACE_DESC {
16:36:19: 	Format: D3DFMT_X8R8G8B8
16:36:19: 	Type: D3DRTYPE_SURFACE
16:36:19: 	Usage: D3DUSAGE_RENDERTARGET 
16:36:19: 	Pool: D3DPOOL_DEFAULT
16:36:19: 	MultiSampleType: D3DMULTISAMPLE_NONMASKABLE
16:36:19: 	MultiSampleQuality: 0
16:36:19: 	Width: 1366
16:36:19: 	Height: 768
16:36:19: };
16:36:19: successfully capturing d3d9 frames via GPU
17:16:00: ---------------------- Cleared D3D9 Capture ----------------------
17:16:00: D3D9EndScene called
17:16:00: D3D9Present called
17:16:04: D3D9Reset called
17:16:04: ---------------------- Cleared D3D9 Capture ----------------------
17:16:04: successfully set up d3d9 hooks
17:16:04: D3D9EndScene called
17:16:04: D3D9Reset called
17:16:04: ---------------------- Cleared D3D9 Capture ----------------------
17:16:04: successfully set up d3d9 hooks
17:16:04: D3D9EndScene called
 
A

AirKevin

New Member
Funny thing is, I didn't have any issues with a third stream I did after those two. Link here:

http://www.twitch.tv/pw4056/b/482437680

The log for that here:

Code: 
18:03:44: Open Broadcaster Software v0.584b - 64bit (　^ω^)
18:03:44: -------------------------------
18:03:44: CPU Name: Intel(R) Core(TM) i5-2450M CPU @ 2.50GHz
18:03:44: CPU Speed: 2494MHz
18:03:44: Physical Memory:  8139MB Total, 3464MB Free
18:03:44: stepping id: 7, model 42, family 6, type 0, extmodel 1, extfamily 0, HTT 1, logical cores 4, total cores 2
18:03:44: monitor 1: pos={0, 0}, size={1366, 768}
18:03:44: Windows Version: 6.1 Build 7601 S
18:03:44: Aero is Disabled
18:03:44: -------------------------------
18:03:44: OBS Modules:
18:03:44: Base Address     Module
18:03:44: 000000003F950000 OBS.exe
18:03:44: 00000000EB2C0000 OBSApi.dll
18:03:44: 00000000F90F0000 DShowPlugin.dll
18:03:44: 00000000F7580000 GraphicsCapture.dll
18:03:44: 00000000FB370000 NoiseGate.dll
18:03:44: 00000000FB3D0000 PSVPlugin.dll
18:03:44: ------------------------------------------
18:03:44: Adapter 1
18:03:44:   Video Adapter: Intel(R) HD Graphics Family
18:03:44:   Video Adapter Dedicated Video Memory: 67108864
18:03:44:   Video Adapter Shared System Memory: 1711276032
18:03:44:   Video Adapter Output 1: pos={0, 0}, size={1366, 768}, attached=true
18:03:44: =====Stream Start: 2013-11-23, 18:03:44===============================================
18:03:44:   Multithreaded optimizations: On
18:03:44:   Base resolution: 1366x768
18:03:44:   Output resolution: 1364x768
18:03:44: ------------------------------------------
18:03:44: Loading up D3D10 on Intel(R) HD Graphics Family...
18:03:44: ------------------------------------------
18:03:44: Audio Format: 48000hz
18:03:44: Playback device Default
18:03:44: ------------------------------------------
18:03:44: Using desktop audio input: Speakers (2- USB Sound Device        )
18:03:44: ------------------------------------------
18:03:44: Using auxilary audio input: Microphone (Conexant SmartAudio HD)
18:03:44: ------------------------------------------
18:03:44: Audio Encoding: AAC
18:03:44:     bitrate: 128
18:03:44: Using graphics capture
18:03:44: Scene buffering time set to 400
18:03:44: ------------------------------------------
18:03:44: Video Encoding: x264
18:03:44:     fps: 30
18:03:44:     width: 1364, height: 768
18:03:44:     preset: veryfast
18:03:44:     profile: high
18:03:44:     keyint: 60
18:03:44:     CBR: yes
18:03:44:     CFR: yes
18:03:44:     max bitrate: 1000
18:03:44:     buffer size: 1000
18:03:44: ------------------------------------------
18:03:44: MMDeviceAudioSource: Frequency for device 'Speakers (2- USB Sound Device        )' is 352800, samples per sec is 44100
18:03:44: MMDeviceAudioSource: Frequency for device 'Microphone (Conexant SmartAudio HD)' is 352800, samples per sec is 44100
18:03:44: SharedTexCapture hooked
18:03:46: Using RTMP service: Twitch / Justin.tv
18:03:46:   Server selection: rtmp://live-jfk.justin.tv/app
18:03:46:   Interface: Realtek RTL8188CE Wireless LAN 802.11n PCI-E NIC (802.11, 48 mbps)
18:03:46: Completed handshake with rtmp://live-jfk.justin.tv/app in 227 ms.
18:03:47: SO_SNDBUF was at 8192
18:03:47: SO_SNDBUF is now 65536
21:19:29: Total frames encoded: 352320, total frames duplicated: 811 (0.23%)
21:19:29: Number of frames skipped due to encoder lag: 759 (0.22%)
21:19:29: Total frames rendered: 351547, number of late frames: 35 (0.01%) (it's okay for some frames to be late)
21:19:29: RTMPPublisher::SocketLoop: Graceful loop exit
21:19:29: Average send payload: 3753 bytes, average send interval: 26 ms
21:19:29: Number of times waited to send: 0, Waited for a total of 0 bytes
21:19:29: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
21:19:29: Number of bytes sent: 1665843387
21:19:29: 
21:19:29: Profiler time results:
21:19:29: 
21:19:29: ==============================================================
21:19:29: video thread frame - [100%] [avg time: 0.667 ms] [children: 24.9%] [unaccounted: 75.1%]
21:19:29: | scene->Preprocess - [0.3%] [avg time: 0.002 ms]
21:19:29: | GPU download and conversion - [24.6%] [avg time: 0.164 ms] [children: 20.8%] [unaccounted: 3.75%]
21:19:29: | | flush - [9.75%] [avg time: 0.065 ms]
21:19:29: | | CopyResource - [10.6%] [avg time: 0.071 ms]
21:19:29: | | conversion to 4:2:0 - [0.45%] [avg time: 0.003 ms]
21:19:29: Convert444Thread - [100%] [avg time: 1.439 ms] [children: 99.3%] [unaccounted: 0.695%]
21:19:29: | Convert444toNV12 - [99.3%] [avg time: 1.429 ms]
21:19:29: encoder thread frame - [100%] [avg time: 1.508 ms]
21:19:29: ==============================================================
21:19:29: 
21:19:29: 
21:19:29: Profiler CPU results:
21:19:29: 
21:19:29: ==============================================================
21:19:29: video thread frame - [cpu time: avg 0.084 ms, total 29858.6 ms] [avg calls per frame: 1]
21:19:29: | scene->Preprocess - [cpu time: avg 0 ms, total 15.6 ms] [avg calls per frame: 1]
21:19:29: | GPU download and conversion - [cpu time: avg 0.046 ms, total 16286.5 ms] [avg calls per frame: 1]
21:19:29: | | flush - [cpu time: avg 0.022 ms, total 7831.26 ms] [avg calls per frame: 1]
21:19:29: | | CopyResource - [cpu time: avg 0.017 ms, total 6068.44 ms] [avg calls per frame: 1]
21:19:29: | | conversion to 4:2:0 - [cpu time: avg 0.001 ms, total 436.802 ms] [avg calls per frame: 1]
21:19:29: Convert444Thread - [cpu time: avg 1.496 ms, total 526238 ms] [avg calls per frame: 1]
21:19:29: | Convert444toNV12 - [cpu time: avg 1.49 ms, total 523961 ms] [avg calls per frame: 1]
21:19:29: encoder thread frame - [cpu time: avg 1.006 ms, total 354684 ms] [avg calls per frame: 1]
21:19:29: ==============================================================
21:19:29: 
21:19:29: =====Stream End: 2013-11-23, 21:19:29=================================================


Last game capture log:
2013-11-23, 18:03:44: we're booting up: 
18:03:44: D3D9 Present
18:03:44: (half life scientist) everything..  seems to be in order
18:03:44: D3D9EndScene called
18:03:44: D3DPRESENT_PARAMETERS {
18:03:44: 	BackBufferWidth: 1366
18:03:44: 	BackBufferHeight: 768
18:03:44: 	BackBufferFormat: D3DFMT_X8R8G8B8
18:03:44: 	BackBufferCount: 1
18:03:44: 	MultiSampleType: D3DMULTISAMPLE_NONE
18:03:44: 	MultiSampleQuality: 0
18:03:44: 	SwapEffect: D3DSWAPEFFECT_DISCARD
18:03:44: 	hDeviceWindow: 4263204
18:03:44: 	Windowed: false
18:03:44: 	EnableAutoDepthStencil: true
18:03:44: 	AutoDepthStencilFormat: D3DFMT_D24S8
18:03:44: 	Flags: D3DPRESENTFLAG_LOCKABLE_BACKBUFFER D3DPRESENTFLAG_DISCARD_DEPTHSTENCIL 
18:03:44: 	FullScreen_RefreshRateInHz: 60
18:03:44: 	PresentationInterval: 0
18:03:44: };
18:03:44: successfully set up d3d9 hooks
18:03:44: D3D9Present called
18:03:44: DoD3D9GPUHook: success
18:03:44: D3DSURFACE_DESC {
18:03:44: 	Format: D3DFMT_X8R8G8B8
18:03:44: 	Type: D3DRTYPE_SURFACE
18:03:44: 	Usage: D3DUSAGE_RENDERTARGET 
18:03:44: 	Pool: D3DPOOL_DEFAULT
18:03:44: 	MultiSampleType: D3DMULTISAMPLE_NONE
18:03:44: 	MultiSampleQuality: 0
18:03:44: 	Width: 1366
18:03:44: 	Height: 768
18:03:44: };
18:03:44: successfully capturing d3d9 frames via GPU
21:19:29: ---------------------- Cleared D3D9 Capture ----------------------
21:19:29: D3D9EndScene called
21:19:29: D3D9Present called
 
A

AirKevin

New Member
And just to clarify, in the first two links, it wasn't just the stream I had an issue with, the stream resulted in the simulator itself lagging. If I killed the stream, then the lag went away, and I could fly properly. With this kind of lag, it was nearly impossible to fly.
 
dodgepong

dodgepong

Administrator
Community Helper
The first two streams are showing a lot of encoder lag, which probably means some other process was eating up CPU time. The third stream looks mostly OK with the same encoding settings. Were you doing anything CPU-intensive during the first two streams that you weren't doing in the third? Such as watching the stream as you streamed, or virus scanning, or something else?
 
A

AirKevin

New Member
dodgepong said:
The first two streams are showing a lot of encoder lag, which probably means some other process was eating up CPU time. The third stream looks mostly OK with the same encoding settings. Were you doing anything CPU-intensive during the first two streams that you weren't doing in the third? Such as watching the stream as you streamed, or virus scanning, or something else?
Click to expand...
Negative. All three streams were run the exact same way. I was watching the stream to make sure it was working, but that was done on a second computer, although I had done the same thing for all three streams.
 
You must log in or register to reply here.
Top