Question / Help FPS Lag + Lag Spikes

NETTOBEAR · Jan 25, 2014

I was hoping to start streaming but I get mad FPS drops and Lag spikes ping spikes to 200-400 really hard to stream with that.
Hopefully you guys can help fix my problem and I can stream thanks.

Code:

16:33:04: =====Stream Start: 2014-01-25, 16:33:04===============================================
16:33:04:   Multithreaded optimizations: On
16:33:04:   Base resolution: 1920x1080
16:33:04:   Output resolution: 1096x616
16:33:04: ------------------------------------------
16:33:04: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
16:33:04: ------------------------------------------
16:33:04: Audio Format: 48000hz
16:33:04: Playback device Default
16:33:04: ------------------------------------------
16:33:04: Using desktop audio input: Speakers (Realtek High Definition Audio)
16:33:04: ------------------------------------------
16:33:04: Using auxilary audio input: Microphone (Realtek High Definition Audio)
16:33:04: ------------------------------------------
16:33:04: Audio Encoding: AAC
16:33:04:     bitrate: 128
16:33:04: Using graphics capture
16:33:04: Scene buffering time set to 1800
16:33:04: ------------------------------------------
16:33:04: Video Encoding: x264
16:33:04:     fps: 60
16:33:04:     width: 1096, height: 616
16:33:04:     preset: medium
16:33:04:     profile: main
16:33:04:     keyint: 250
16:33:04:     CBR: yes
16:33:04:     CFR: yes
16:33:04:     max bitrate: 650
16:33:04:     buffer size: 1000
16:33:04: ------------------------------------------
16:33:04: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
16:33:04: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
16:33:11: Using RTMP service: Twitch / Justin.tv
16:33:11:   Server selection: rtmp://live-fra.justin.tv/app
16:33:11:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
16:33:11: Completed handshake with rtmp://live-fra.justin.tv/app in 653 ms.
16:33:12: SO_SNDBUF was at 8192
16:33:12: SO_SNDBUF is now 65536
16:33:31: SharedTexCapture hooked
16:33:32: GraphicsCaptureSource::NewCapture:  eliminating old capture
16:33:32: SharedTexCapture hooked
16:34:04: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 0 / 131072)
16:34:10: Capture window 0x001206DE invalid or changing, terminating capture
16:34:25: Total frames encoded: 4764, total frames duplicated: 424 (8.90%)
16:34:25: Number of frames skipped due to encoder lag: 201 (4.22%)
16:34:25: Total frames rendered: 4462, number of late frames: 40 (0.90%) (it's okay for some frames to be late)
16:34:26: RTMPPublisher::SocketLoop: Graceful loop exit
16:34:26: Average send payload: 4156 bytes, average send interval: 50 ms
16:34:26: Number of times waited to send: 0, Waited for a total of 0 bytes
16:34:26: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
16:34:26: Number of bytes sent: 6094121
16:34:26: 
16:34:26: Profiler time results:
16:34:26: 
16:34:26: ==============================================================
16:34:26: video thread frame - [100%] [avg time: 1.501 ms] [children: 35.2%] [unaccounted: 64.8%]
16:34:26: | scene->Preprocess - [0.133%] [avg time: 0.002 ms]
16:34:26: | GPU download and conversion - [35.1%] [avg time: 0.527 ms] [children: 27.4%] [unaccounted: 7.73%]
16:34:26: | | flush - [23.7%] [avg time: 0.355 ms]
16:34:26: | | CopyResource - [3.66%] [avg time: 0.055 ms]
16:34:26: | | conversion to 4:2:0 - [0.0666%] [avg time: 0.001 ms]
16:34:26: Convert444Thread - [100%] [avg time: 0.65 ms] [children: 92.8%] [unaccounted: 7.23%]
16:34:26: | Convert444toNV12 - [92.8%] [avg time: 0.603 ms]
16:34:26: encoder thread frame - [100%] [avg time: 2.128 ms]
16:34:26: ==============================================================
16:34:26: 
16:34:26: 
16:34:26: Profiler CPU results:
16:34:26: 
16:34:26: ==============================================================
16:34:26: video thread frame - [cpu time: avg 0.111 ms, total 499.203 ms] [avg calls per frame: 1]
16:34:26: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
16:34:26: | GPU download and conversion - [cpu time: avg 0.059 ms, total 265.203 ms] [avg calls per frame: 1]
16:34:26: | | flush - [cpu time: avg 0.052 ms, total 234.002 ms] [avg calls per frame: 1]
16:34:26: | | CopyResource - [cpu time: avg 0.003 ms, total 15.601 ms] [avg calls per frame: 1]
16:34:26: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
16:34:26: Convert444Thread - [cpu time: avg 0.351 ms, total 1528.81 ms] [avg calls per frame: 1]
16:34:26: | Convert444toNV12 - [cpu time: avg 0.351 ms, total 1528.81 ms] [avg calls per frame: 1]
16:34:26: encoder thread frame - [cpu time: avg 0.244 ms, total 1138.81 ms] [avg calls per frame: 1]
16:34:26: ==============================================================
16:34:26: 
16:34:26: =====Stream End: 2014-01-25, 16:34:26=================================================

Sapiens · Jan 25, 2014

Post a complete log file.

alpinlol · Jan 25, 2014

yeah complete would be nice but i can already tell that your hardware isnt enough for your settings since you have quite some late and duplicated frames

NETTOBEAR · Jan 25, 2014

Code:

15:37:48: Open Broadcaster Software v0.592b - 32bit (´・ω・｀)
15:37:48: -------------------------------
15:37:48: CPU Name: Intel(R) Core(TM) i3-3220 CPU @ 3.30GHz
15:37:48: CPU Speed: 3292MHz
15:37:48: Physical Memory:  4095MB Total, 4095MB Free
15:37:48: stepping id: 9, model 58, family 6, type 0, extmodel 1, extfamily 0, HTT 1, logical cores 4, total cores 2
15:37:48: monitor 1: pos={0, 0}, size={1920, 1080}
15:37:48: Windows Version: 6.1 Build 7601 S
15:37:48: Aero is Enabled
15:37:48: -------------------------------
15:37:48: OBS Modules:
15:37:48: Base Address     Module
15:37:48: 01300000         OBS.exe
15:37:48: 62010000         OBSApi.dll
15:37:48: 67B50000         DShowPlugin.dll
15:37:48: 67B30000         GraphicsCapture.dll
15:37:48: 67B10000         NoiseGate.dll
15:37:48: 679A0000         PSVPlugin.dll
15:37:48: ------------------------------------------
15:37:48: Adapter 1
15:37:48:   Video Adapter: AMD Radeon R9 200 Series
15:37:48:   Video Adapter Dedicated Video Memory: 3193987072
15:37:48:   Video Adapter Shared System Memory: 1100914688
15:37:48:   Video Adapter Output 1: pos={0, 0}, size={1920, 1080}, attached=true
15:37:48: =====Stream Start: 2014-01-25, 15:37:48===============================================
15:37:48:   Multithreaded optimizations: On
15:37:48:   Base resolution: 1920x1080
15:37:48:   Output resolution: 1280x720
15:37:48: ------------------------------------------
15:37:48: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
15:37:49: ------------------------------------------
15:37:49: Audio Format: 48000hz
15:37:49: Playback device Default
15:37:49: ------------------------------------------
15:37:49: Using desktop audio input: Speakers (Realtek High Definition Audio)
15:37:49: ------------------------------------------
15:37:49: Using auxilary audio input: Microphone (Realtek High Definition Audio)
15:37:49: ------------------------------------------
15:37:49: Audio Encoding: AAC
15:37:49:     bitrate: 128
15:37:49: Using graphics capture
15:37:49: Scene buffering time set to 1800
15:37:49: ------------------------------------------
15:37:49: Video Encoding: x264
15:37:49:     fps: 30
15:37:49:     width: 1280, height: 720
15:37:49:     preset: medium
15:37:49:     profile: main
15:37:49:     keyint: 250
15:37:49:     CBR: yes
15:37:49:     CFR: yes
15:37:49:     max bitrate: 1800
15:37:49:     buffer size: 1800
15:37:49: ------------------------------------------
15:37:49: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
15:37:49: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
15:37:57: SharedTexCapture hooked
15:38:22: ++++++++++++++++++++++++++++++++++++++++++++++++++++++
15:38:22:   New Scene
15:38:23: ++++++++++++++++++++++++++++++++++++++++++++++++++++++
15:38:23:   New Scene
15:38:23: Using graphics capture
15:38:29: Total frames encoded: 1147, total frames duplicated: 35 (3.05%)
15:38:29: Total frames rendered: 1136, number of late frames: 5 (0.44%) (it's okay for some frames to be late)
15:38:29: 
15:38:29: Profiler time results:
15:38:29: 
15:38:29: ==============================================================
15:38:29: video thread frame - [100%] [avg time: 1.639 ms] [children: 15.1%] [unaccounted: 84.9%]
15:38:29: | scene->Preprocess - [0.061%] [avg time: 0.001 ms]
15:38:29: | GPU download and conversion - [15%] [avg time: 0.246 ms] [children: 13.3%] [unaccounted: 1.71%]
15:38:29: | | flush - [11.3%] [avg time: 0.185 ms]
15:38:29: | | CopyResource - [1.1%] [avg time: 0.018 ms]
15:38:29: | | conversion to 4:2:0 - [0.915%] [avg time: 0.015 ms]
15:38:29: Convert444Thread - [100%] [avg time: 0.679 ms] [children: 98.7%] [unaccounted: 1.33%]
15:38:29: | Convert444toNV12 - [98.7%] [avg time: 0.67 ms]
15:38:29: encoder thread frame - [100%] [avg time: 1.198 ms]
15:38:29: ==============================================================
15:38:29: 
15:38:29: 
15:38:29: Profiler CPU results:
15:38:29: 
15:38:29: ==============================================================
15:38:29: video thread frame - [cpu time: avg 0.082 ms, total 93.6 ms] [avg calls per frame: 1]
15:38:29: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:38:29: | GPU download and conversion - [cpu time: avg 0.027 ms, total 31.2 ms] [avg calls per frame: 1]
15:38:29: | | flush - [cpu time: avg 0.027 ms, total 31.2 ms] [avg calls per frame: 1]
15:38:29: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:38:29: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:38:29: Convert444Thread - [cpu time: avg 0.621 ms, total 670.804 ms] [avg calls per frame: 1]
15:38:29: | Convert444toNV12 - [cpu time: avg 0.607 ms, total 655.203 ms] [avg calls per frame: 1]
15:38:29: encoder thread frame - [cpu time: avg 0.499 ms, total 546.003 ms] [avg calls per frame: 1]
15:38:29: ==============================================================
15:38:29: 
15:38:29: =====Stream End: 2014-01-25, 15:38:29=================================================
15:38:29: =====Stream Start: 2014-01-25, 15:38:29===============================================
15:38:29:   Multithreaded optimizations: On
15:38:29:   Base resolution: 1920x1080
15:38:29:   Output resolution: 1280x720
15:38:29: ------------------------------------------
15:38:29: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
15:38:29: ------------------------------------------
15:38:29: Audio Format: 48000hz
15:38:29: Playback device Default
15:38:29: ------------------------------------------
15:38:29: Using desktop audio input: Speakers (Realtek High Definition Audio)
15:38:29: ------------------------------------------
15:38:29: Using auxilary audio input: Microphone (Realtek High Definition Audio)
15:38:29: ------------------------------------------
15:38:29: Audio Encoding: AAC
15:38:29:     bitrate: 128
15:38:29: Using graphics capture
15:38:29: Scene buffering time set to 1800
15:38:29: ------------------------------------------
15:38:29: Video Encoding: x264
15:38:29:     fps: 30
15:38:29:     width: 1280, height: 720
15:38:29:     preset: medium
15:38:29:     profile: main
15:38:29:     keyint: 250
15:38:29:     CBR: yes
15:38:29:     CFR: yes
15:38:29:     max bitrate: 1800
15:38:29:     buffer size: 1800
15:38:29: ------------------------------------------
15:38:29: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
15:38:29: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
15:38:31: SharedTexCapture hooked
15:38:32: GraphicsCaptureSource::NewCapture:  eliminating old capture
15:38:32: SharedTexCapture hooked
15:38:55: Total frames encoded: 707, total frames duplicated: 14 (1.98%)
15:38:55: Total frames rendered: 701, number of late frames: 4 (0.57%) (it's okay for some frames to be late)
15:38:55: 
15:38:55: Profiler time results:
15:38:55: 
15:38:55: ==============================================================
15:38:55: video thread frame - [100%] [avg time: 2.048 ms] [children: 16.2%] [unaccounted: 83.8%]
15:38:55: | scene->Preprocess - [0.0488%] [avg time: 0.001 ms]
15:38:55: | GPU download and conversion - [16.1%] [avg time: 0.33 ms] [children: 15.2%] [unaccounted: 0.879%]
15:38:55: | | flush - [14.7%] [avg time: 0.302 ms]
15:38:55: | | CopyResource - [0.439%] [avg time: 0.009 ms]
15:38:55: | | conversion to 4:2:0 - [0.0488%] [avg time: 0.001 ms]
15:38:55: Convert444Thread - [100%] [avg time: 0.656 ms] [children: 98.5%] [unaccounted: 1.52%]
15:38:55: | Convert444toNV12 - [98.5%] [avg time: 0.646 ms]
15:38:55: encoder thread frame - [100%] [avg time: 0.965 ms]
15:38:55: ==============================================================
15:38:55: 
15:38:55: 
15:38:55: Profiler CPU results:
15:38:55: 
15:38:55: ==============================================================
15:38:55: video thread frame - [cpu time: avg 0.111 ms, total 78 ms] [avg calls per frame: 1]
15:38:55: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:38:55: | GPU download and conversion - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:38:55: | | flush - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:38:55: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:38:55: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:38:55: Convert444Thread - [cpu time: avg 0.457 ms, total 296.401 ms] [avg calls per frame: 1]
15:38:55: | Convert444toNV12 - [cpu time: avg 0.457 ms, total 296.401 ms] [avg calls per frame: 1]
15:38:55: encoder thread frame - [cpu time: avg 0.215 ms, total 140.4 ms] [avg calls per frame: 1]
15:38:55: ==============================================================
15:38:55: 
15:38:55: =====Stream End: 2014-01-25, 15:38:55=================================================
15:38:58: =====Stream Start: 2014-01-25, 15:38:58===============================================
15:38:58:   Multithreaded optimizations: On
15:38:58:   Base resolution: 1920x1080
15:38:58:   Output resolution: 1280x720
15:38:58: ------------------------------------------
15:38:58: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
15:38:59: ------------------------------------------
15:38:59: Audio Format: 48000hz
15:38:59: Playback device Default
15:38:59: ------------------------------------------
15:38:59: Using desktop audio input: Speakers (Realtek High Definition Audio)
15:38:59: ------------------------------------------
15:38:59: Using auxilary audio input: Microphone (Realtek High Definition Audio)
15:38:59: ------------------------------------------
15:38:59: Audio Encoding: AAC
15:38:59:     bitrate: 128
15:38:59: Using graphics capture
15:38:59: Scene buffering time set to 1800
15:38:59: ------------------------------------------
15:38:59: Video Encoding: x264
15:38:59:     fps: 30
15:38:59:     width: 1280, height: 720
15:38:59:     preset: medium
15:38:59:     profile: main
15:38:59:     keyint: 250
15:38:59:     CBR: yes
15:38:59:     CFR: yes
15:38:59:     max bitrate: 1800
15:38:59:     buffer size: 1800
15:38:59: ------------------------------------------
15:38:59: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
15:38:59: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
Warning -- SharedTexCapture::Init: Could not open file mapping: 2
15:39:05: SharedTexCapture hooked
15:39:06: Using RTMP service: Twitch / Justin.tv
15:39:06:   Server selection: rtmp://live-lhr.justin.tv/app
15:39:06:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
15:39:07: Completed handshake with rtmp://live-lhr.justin.tv/app in 568 ms.
15:39:08: SO_SNDBUF was at 8192
15:39:08: SO_SNDBUF is now 65536
15:39:09: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 22593 / 246784)
15:39:14: RTMPPublisher::SocketLoop: Stalled for 2198 ms to write 246137 bytes (buffer: 0 / 246784), unstable connection?
15:39:16: RTMPPublisher::SocketLoop: Stalled for 2064 ms to write 152746 bytes (buffer: 0 / 246784), unstable connection?
15:39:18: RTMPPublisher::SocketLoop: Stalled for 2188 ms to write 244168 bytes (buffer: 0 / 246784), unstable connection?
15:39:22: RTMPPublisher::SocketLoop: Stalled for 2187 ms to write 1575 bytes (buffer: 0 / 246784), unstable connection?
15:39:30: Total frames encoded: 874, total frames duplicated: 26 (2.97%)
15:39:30: Total frames rendered: 864, number of late frames: 6 (0.69%) (it's okay for some frames to be late)
15:39:31: RTMPPublisher::SocketLoop: Stalled for 1932 ms to write 244528 bytes (buffer: 0 / 246784), unstable connection?
15:39:33: RTMPPublisher::SocketLoop: Stalled for 2121 ms to write 197675 bytes (buffer: 0 / 246784), unstable connection?
15:39:35: RTMPPublisher::SocketLoop: Aborting due to WSAEnumNetworkEvents failure, 10038
15:39:35: Average send payload: 18145 bytes, average send interval: 148 ms
15:39:35: Number of times waited to send: 9, Waited for a total of 30984 bytes
15:39:35: Number of b-frames dropped: 174 (23%), Number of p-frames dropped: 176 (23%), Total 350 (45%)
15:39:35: Number of bytes sent: 3102914
15:39:35: 
15:39:35: Profiler time results:
15:39:35: 
15:39:35: ==============================================================
15:39:35: video thread frame - [100%] [avg time: 1.8 ms] [children: 20.2%] [unaccounted: 79.8%]
15:39:35: | scene->Preprocess - [0.0556%] [avg time: 0.001 ms]
15:39:35: | GPU download and conversion - [20.2%] [avg time: 0.363 ms] [children: 10.3%] [unaccounted: 9.89%]
15:39:35: | | flush - [9.5%] [avg time: 0.171 ms]
15:39:35: | | CopyResource - [0.722%] [avg time: 0.013 ms]
15:39:35: | | conversion to 4:2:0 - [0.0556%] [avg time: 0.001 ms]
15:39:35: Convert444Thread - [100%] [avg time: 0.696 ms] [children: 97.7%] [unaccounted: 2.3%]
15:39:35: | Convert444toNV12 - [97.7%] [avg time: 0.68 ms]
15:39:35: encoder thread frame - [100%] [avg time: 1.029 ms]
15:39:35: ==============================================================
15:39:35: 
15:39:35: 
15:39:35: Profiler CPU results:
15:39:35: 
15:39:35: ==============================================================
15:39:35: video thread frame - [cpu time: avg 0.054 ms, total 46.8 ms] [avg calls per frame: 1]
15:39:35: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:39:35: | GPU download and conversion - [cpu time: avg 0.018 ms, total 15.6 ms] [avg calls per frame: 1]
15:39:35: | | flush - [cpu time: avg 0.018 ms, total 15.6 ms] [avg calls per frame: 1]
15:39:35: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:39:35: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:39:35: Convert444Thread - [cpu time: avg 0.638 ms, total 514.803 ms] [avg calls per frame: 1]
15:39:35: | Convert444toNV12 - [cpu time: avg 0.619 ms, total 499.203 ms] [avg calls per frame: 1]
15:39:35: encoder thread frame - [cpu time: avg 0.361 ms, total 296.401 ms] [avg calls per frame: 1]
15:39:35: ==============================================================
15:39:35: 
15:39:35: =====Stream End: 2014-01-25, 15:39:35=================================================
15:43:01: Using fixed low latency mode, factor 20
15:43:01: =====Stream Start: 2014-01-25, 15:43:01===============================================
15:43:01:   Multithreaded optimizations: On
15:43:01:   Base resolution: 1920x1080
15:43:01:   Output resolution: 1280x720
15:43:01: ------------------------------------------
15:43:01: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
15:43:01: ------------------------------------------
15:43:01: Audio Format: 48000hz
15:43:01: Playback device Default
15:43:01: ------------------------------------------
15:43:01: Using desktop audio input: Speakers (Realtek High Definition Audio)
15:43:01: ------------------------------------------
15:43:01: Using auxilary audio input: Microphone (Realtek High Definition Audio)
15:43:01: ------------------------------------------
15:43:01: Audio Encoding: AAC
15:43:01:     bitrate: 128
15:43:01: Using graphics capture
15:43:01: Scene buffering time set to 1800
15:43:01: ------------------------------------------
15:43:01: Video Encoding: x264
15:43:01:     fps: 30
15:43:01:     width: 1280, height: 720
15:43:01:     preset: medium
15:43:01:     profile: main
15:43:01:     keyint: 250
15:43:01:     CBR: yes
15:43:01:     CFR: yes
15:43:01:     max bitrate: 1500
15:43:01:     buffer size: 1500
15:43:01: ------------------------------------------
15:43:01: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
15:43:01: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
Warning -- SharedTexCapture::Init: Could not open file mapping: 2
15:43:04: SharedTexCapture hooked
15:43:09: Using RTMP service: Twitch / Justin.tv
15:43:09:   Server selection: rtmp://live-lhr.justin.tv/app
15:43:09:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
15:43:09: Completed handshake with rtmp://live-lhr.justin.tv/app in 453 ms.
15:43:10: SO_SNDBUF was at 8192
15:43:10: SO_SNDBUF is now 65536
15:43:11: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 13586 / 207872)
15:43:31: Total frames encoded: 843, total frames duplicated: 20 (2.37%)
15:43:31: Total frames rendered: 834, number of late frames: 6 (0.72%) (it's okay for some frames to be late)
15:43:35: RTMPPublisher::SocketLoop: Socket error, send() returned -1, GetLastError() 10038
15:43:35: Average send payload: 7658 bytes, average send interval: 76 ms
15:43:35: Number of times waited to send: 85, Waited for a total of 296903 bytes
15:43:35: Number of b-frames dropped: 205 (28%), Number of p-frames dropped: 157 (21%), Total 362 (49%)
15:43:35: Number of bytes sent: 2435378
15:43:35: 
15:43:35: Profiler time results:
15:43:35: 
15:43:35: ==============================================================
15:43:35: video thread frame - [100%] [avg time: 2.022 ms] [children: 27.9%] [unaccounted: 72.1%]
15:43:35: | scene->Preprocess - [0.0495%] [avg time: 0.001 ms]
15:43:35: | GPU download and conversion - [27.9%] [avg time: 0.564 ms] [children: 18.9%] [unaccounted: 9%]
15:43:35: | | flush - [18.4%] [avg time: 0.372 ms]
15:43:35: | | CopyResource - [0.396%] [avg time: 0.008 ms]
15:43:35: | | conversion to 4:2:0 - [0.0989%] [avg time: 0.002 ms]
15:43:35: Convert444Thread - [100%] [avg time: 0.666 ms] [children: 97.1%] [unaccounted: 2.85%]
15:43:35: | Convert444toNV12 - [97.1%] [avg time: 0.647 ms]
15:43:35: encoder thread frame - [100%] [avg time: 0.932 ms]
15:43:35: ==============================================================
15:43:35: 
15:43:35: 
15:43:35: Profiler CPU results:
15:43:35: 
15:43:35: ==============================================================
15:43:35: video thread frame - [cpu time: avg 0.112 ms, total 93.6 ms] [avg calls per frame: 1]
15:43:35: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:43:35: | GPU download and conversion - [cpu time: avg 0.056 ms, total 46.8 ms] [avg calls per frame: 1]
15:43:35: | | flush - [cpu time: avg 0.037 ms, total 31.2 ms] [avg calls per frame: 1]
15:43:35: | | CopyResource - [cpu time: avg 0.019 ms, total 15.6 ms] [avg calls per frame: 1]
15:43:35: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:43:35: Convert444Thread - [cpu time: avg 0.419 ms, total 327.601 ms] [avg calls per frame: 1]
15:43:35: | Convert444toNV12 - [cpu time: avg 0.399 ms, total 312.001 ms] [avg calls per frame: 1]
15:43:35: encoder thread frame - [cpu time: avg 0.316 ms, total 249.601 ms] [avg calls per frame: 1]
15:43:35: ==============================================================
15:43:35: 
15:43:35: =====Stream End: 2014-01-25, 15:43:35=================================================
15:44:39: Using fixed low latency mode, factor 20
15:44:39: =====Stream Start: 2014-01-25, 15:44:39===============================================
15:44:39:   Multithreaded optimizations: On
15:44:39:   Base resolution: 1920x1080
15:44:39:   Output resolution: 1280x720
15:44:39: ------------------------------------------
15:44:39: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
15:44:39: ------------------------------------------
15:44:39: Audio Format: 48000hz
15:44:39: Playback device Default
15:44:39: ------------------------------------------
15:44:39: Using desktop audio input: Speakers (Realtek High Definition Audio)
15:44:39: ------------------------------------------
15:44:39: Using auxilary audio input: Microphone (Realtek High Definition Audio)
15:44:39: ------------------------------------------
15:44:39: Audio Encoding: AAC
15:44:39:     bitrate: 128
15:44:39: Using graphics capture
15:44:39: Scene buffering time set to 1800
15:44:39: ------------------------------------------
15:44:39: Video Encoding: x264
15:44:39:     fps: 30
15:44:39:     width: 1280, height: 720
15:44:39:     preset: medium
15:44:39:     profile: main
15:44:39:     keyint: 250
15:44:39:     CBR: yes
15:44:39:     CFR: yes
15:44:39:     max bitrate: 300
15:44:39:     buffer size: 300
15:44:39: ------------------------------------------
15:44:39: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
15:44:39: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
15:44:42: SharedTexCapture hooked
15:44:42: GraphicsCaptureSource::NewCapture:  eliminating old capture
15:44:42: SharedTexCapture hooked
15:44:46: Using RTMP service: Twitch / Justin.tv
15:44:46:   Server selection: rtmp://live-lhr.justin.tv/app
15:44:46:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
15:44:47: Completed handshake with rtmp://live-lhr.justin.tv/app in 400 ms.
15:44:48: SO_SNDBUF was at 8192
15:44:48: SO_SNDBUF is now 65536
15:46:48: Total frames encoded: 3800, total frames duplicated: 68 (1.79%)
15:46:48: Total frames rendered: 3779, number of late frames: 12 (0.32%) (it's okay for some frames to be late)
15:46:49: RTMPPublisher::SocketLoop: Socket error, send() returned -1, GetLastError() 10038
15:46:49: Average send payload: 1931 bytes, average send interval: 50 ms
15:46:49: Number of times waited to send: 0, Waited for a total of 0 bytes
15:46:49: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
15:46:49: Number of bytes sent: 4654903
15:46:49: 
15:46:49: Profiler time results:
15:46:49: 
15:46:49: ==============================================================
15:46:49: video thread frame - [100%] [avg time: 1.751 ms] [children: 50%] [unaccounted: 50%]
15:46:49: | scene->Preprocess - [0.0571%] [avg time: 0.001 ms]
15:46:49: | GPU download and conversion - [49.9%] [avg time: 0.874 ms] [children: 30.2%] [unaccounted: 19.7%]
15:46:49: | | flush - [29.4%] [avg time: 0.515 ms]
15:46:49: | | CopyResource - [0.685%] [avg time: 0.012 ms]
15:46:49: | | conversion to 4:2:0 - [0.114%] [avg time: 0.002 ms]
15:46:49: Convert444Thread - [100%] [avg time: 0.704 ms] [children: 98%] [unaccounted: 1.99%]
15:46:49: | Convert444toNV12 - [98%] [avg time: 0.69 ms]
15:46:49: encoder thread frame - [100%] [avg time: 1.065 ms]
15:46:49: ==============================================================
15:46:49: 
15:46:49: 
15:46:49: Profiler CPU results:
15:46:49: 
15:46:49: ==============================================================
15:46:49: video thread frame - [cpu time: avg 0.136 ms, total 514.803 ms] [avg calls per frame: 1]
15:46:49: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:46:49: | GPU download and conversion - [cpu time: avg 0.037 ms, total 140.4 ms] [avg calls per frame: 1]
15:46:49: | | flush - [cpu time: avg 0.037 ms, total 140.4 ms] [avg calls per frame: 1]
15:46:49: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:46:49: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:46:49: Convert444Thread - [cpu time: avg 0.628 ms, total 2340.02 ms] [avg calls per frame: 1]
15:46:49: | Convert444toNV12 - [cpu time: avg 0.62 ms, total 2308.82 ms] [avg calls per frame: 1]
15:46:49: encoder thread frame - [cpu time: avg 0.345 ms, total 1294.81 ms] [avg calls per frame: 1]
15:46:49: ==============================================================
15:46:49: 
15:46:49: =====Stream End: 2014-01-25, 15:46:49=================================================
15:50:58: Settings::Video: Enabling Aero
15:51:00: Using fixed low latency mode, factor 20
15:51:00: =====Stream Start: 2014-01-25, 15:51:00===============================================
15:51:00:   Multithreaded optimizations: On
15:51:00:   Base resolution: 1920x1080
15:51:00:   Output resolution: 1920x1080
15:51:00: ------------------------------------------
15:51:00: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
15:51:00: ------------------------------------------
15:51:00: Audio Format: 48000hz
15:51:00: Playback device Default
15:51:00: ------------------------------------------
15:51:00: Using desktop audio input: Speakers (Realtek High Definition Audio)
15:51:00: ------------------------------------------
15:51:00: Using auxilary audio input: Microphone (Realtek High Definition Audio)
15:51:00: ------------------------------------------
15:51:00: Audio Encoding: AAC
15:51:00:     bitrate: 128
15:51:00: Using graphics capture
15:51:00: Scene buffering time set to 1800
15:51:00: ------------------------------------------
15:51:00: Video Encoding: x264
15:51:00:     fps: 30
15:51:00:     width: 1920, height: 1080
15:51:00:     preset: medium
15:51:00:     profile: main
15:51:00:     keyint: 250
15:51:00:     CBR: yes
15:51:00:     CFR: yes
15:51:00:     max bitrate: 300
15:51:00:     buffer size: 300
15:51:00: ------------------------------------------
15:51:00: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
15:51:00: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
15:51:03: SharedTexCapture hooked
15:51:03: GraphicsCaptureSource::NewCapture:  eliminating old capture
15:51:03: SharedTexCapture hooked
15:51:08: Using RTMP service: Twitch / Justin.tv
15:51:08:   Server selection: rtmp://live-lhr.justin.tv/app
15:51:08:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
15:51:08: Completed handshake with rtmp://live-lhr.justin.tv/app in 412 ms.
15:51:10: SO_SNDBUF was at 8192
15:51:10: SO_SNDBUF is now 65536
15:51:53: GraphicsCaptureSource::NewCapture:  eliminating old capture
15:51:53: SharedTexCapture hooked
15:53:43: Capture window 0x00120716 invalid or changing, terminating capture
15:54:25: Settings::Encoding: Changing bitrate from 300kb/s to 2000kb/s
15:54:29: Total frames encoded: 6205, total frames duplicated: 672 (10.83%)
15:54:29: Number of frames skipped due to encoder lag: 327 (5.27%)
15:54:29: Total frames rendered: 5773, number of late frames: 96 (1.66%) (it's okay for some frames to be late)
15:54:32: RTMPPublisher::SocketLoop: Socket error, send() returned -1, GetLastError() 10038
15:54:32: Average send payload: 1997 bytes, average send interval: 51 ms
15:54:32: Number of times waited to send: 0, Waited for a total of 0 bytes
15:54:32: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
15:54:32: Number of bytes sent: 7876081
15:54:32: 
15:54:32: Profiler time results:
15:54:32: 
15:54:32: ==============================================================
15:54:32: video thread frame - [100%] [avg time: 4.066 ms] [children: 45.2%] [unaccounted: 54.8%]
15:54:32: | scene->Preprocess - [0.0246%] [avg time: 0.001 ms]
15:54:32: | GPU download and conversion - [45.2%] [avg time: 1.836 ms] [children: 28.8%] [unaccounted: 16.4%]
15:54:32: | | flush - [28%] [avg time: 1.14 ms]
15:54:32: | | CopyResource - [0.689%] [avg time: 0.028 ms]
15:54:32: | | conversion to 4:2:0 - [0.0738%] [avg time: 0.003 ms]
15:54:32: Convert444Thread - [100%] [avg time: 1.827 ms] [children: 99.5%] [unaccounted: 0.547%]
15:54:32: | Convert444toNV12 - [99.5%] [avg time: 1.817 ms]
15:54:32: encoder thread frame - [100%] [avg time: 5.279 ms]
15:54:32: ==============================================================
15:54:32: 
15:54:32: 
15:54:32: Profiler CPU results:
15:54:32: 
15:54:32: ==============================================================
15:54:32: video thread frame - [cpu time: avg 0.175 ms, total 1014.01 ms] [avg calls per frame: 1]
15:54:32: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:54:32: | GPU download and conversion - [cpu time: avg 0.07 ms, total 405.603 ms] [avg calls per frame: 1]
15:54:32: | | flush - [cpu time: avg 0.054 ms, total 312.002 ms] [avg calls per frame: 1]
15:54:32: | | CopyResource - [cpu time: avg 0.008 ms, total 46.8 ms] [avg calls per frame: 1]
15:54:32: | | conversion to 4:2:0 - [cpu time: avg 0.002 ms, total 15.601 ms] [avg calls per frame: 1]
15:54:32: Convert444Thread - [cpu time: avg 1.626 ms, total 9297.66 ms] [avg calls per frame: 1]
15:54:32: | Convert444toNV12 - [cpu time: avg 1.626 ms, total 9297.66 ms] [avg calls per frame: 1]
15:54:32: encoder thread frame - [cpu time: avg 1.701 ms, total 10467.7 ms] [avg calls per frame: 1]
15:54:32: ==============================================================
15:54:32: 
15:54:32: =====Stream End: 2014-01-25, 15:54:32=================================================
15:54:33: Using fixed low latency mode, factor 20
15:54:33: =====Stream Start: 2014-01-25, 15:54:33===============================================
15:54:33:   Multithreaded optimizations: On
15:54:33:   Base resolution: 1920x1080
15:54:33:   Output resolution: 1920x1080
15:54:33: ------------------------------------------
15:54:33: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
15:54:33: ------------------------------------------
15:54:33: Audio Format: 48000hz
15:54:33: Playback device Default
15:54:33: ------------------------------------------
15:54:33: Using desktop audio input: Speakers (Realtek High Definition Audio)
15:54:33: ------------------------------------------
15:54:33: Using auxilary audio input: Microphone (Realtek High Definition Audio)
15:54:33: ------------------------------------------
15:54:33: Audio Encoding: AAC
15:54:33:     bitrate: 128
15:54:33: Using graphics capture
15:54:33: Scene buffering time set to 1800
15:54:33: ------------------------------------------
15:54:33: Video Encoding: x264
15:54:33:     fps: 30
15:54:33:     width: 1920, height: 1080
15:54:33:     preset: medium
15:54:33:     profile: main
15:54:33:     keyint: 250
15:54:33:     CBR: yes
15:54:33:     CFR: yes
15:54:33:     max bitrate: 2000
15:54:33:     buffer size: 2000
15:54:33: ------------------------------------------
15:54:33: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
15:54:33: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
15:54:41: Using RTMP service: Twitch / Justin.tv
15:54:41:   Server selection: rtmp://live-lhr.justin.tv/app
15:54:41:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
15:54:41: Completed handshake with rtmp://live-lhr.justin.tv/app in 418 ms.
15:54:42: SO_SNDBUF was at 8192
15:54:42: SO_SNDBUF is now 65536
15:54:43: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 58285 / 272384)
15:54:46: SharedTexCapture hooked
15:55:19: Total frames encoded: 1320, total frames duplicated: 56 (4.24%)
15:55:19: Total frames rendered: 1311, number of late frames: 7 (0.53%) (it's okay for some frames to be late)
15:55:21: RTMPPublisher::SocketLoop: Aborting due to WSAEnumNetworkEvents failure, 10038
15:55:21: Average send payload: 10463 bytes, average send interval: 99 ms
15:55:21: Number of times waited to send: 64, Waited for a total of 248690 bytes
15:55:21: Number of b-frames dropped: 349 (31%), Number of p-frames dropped: 318 (28%), Total 667 (58%)
15:55:21: Number of bytes sent: 3965670
15:55:21: 
15:55:21: Profiler time results:
15:55:21: 
15:55:21: ==============================================================
15:55:21: video thread frame - [100%] [avg time: 1.988 ms] [children: 32.6%] [unaccounted: 67.4%]
15:55:21: | scene->Preprocess - [0.0503%] [avg time: 0.001 ms]
15:55:21: | GPU download and conversion - [32.6%] [avg time: 0.648 ms] [children: 26.8%] [unaccounted: 5.84%]
15:55:21: | | flush - [20.1%] [avg time: 0.399 ms]
15:55:21: | | CopyResource - [5.18%] [avg time: 0.103 ms]
15:55:21: | | conversion to 4:2:0 - [1.51%] [avg time: 0.03 ms]
15:55:21: Convert444Thread - [100%] [avg time: 2.018 ms] [children: 99.5%] [unaccounted: 0.496%]
15:55:21: | Convert444toNV12 - [99.5%] [avg time: 2.008 ms]
15:55:21: encoder thread frame - [100%] [avg time: 3.071 ms]
15:55:21: ==============================================================
15:55:21: 
15:55:21: 
15:55:21: Profiler CPU results:
15:55:21: 
15:55:21: ==============================================================
15:55:21: video thread frame - [cpu time: avg 0.083 ms, total 109.2 ms] [avg calls per frame: 1]
15:55:21: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:55:21: | GPU download and conversion - [cpu time: avg 0.011 ms, total 15.6 ms] [avg calls per frame: 1]
15:55:21: | | flush - [cpu time: avg 0.011 ms, total 15.6 ms] [avg calls per frame: 1]
15:55:21: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:55:21: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:55:21: Convert444Thread - [cpu time: avg 1.63 ms, total 2043.61 ms] [avg calls per frame: 1]
15:55:21: | Convert444toNV12 - [cpu time: avg 1.63 ms, total 2043.61 ms] [avg calls per frame: 1]
15:55:21: encoder thread frame - [cpu time: avg 1.996 ms, total 2527.22 ms] [avg calls per frame: 1]
15:55:21: ==============================================================
15:55:21: 
15:55:21: =====Stream End: 2014-01-25, 15:55:21=================================================
15:55:53: Using fixed low latency mode, factor 20
15:55:53: =====Stream Start: 2014-01-25, 15:55:53===============================================
15:55:53:   Multithreaded optimizations: On
15:55:53:   Base resolution: 1920x1080
15:55:53:   Output resolution: 1920x1080
15:55:53: ------------------------------------------
15:55:53: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
15:55:53: ------------------------------------------
15:55:53: Audio Format: 48000hz
15:55:53: Playback device Default
15:55:53: ------------------------------------------
15:55:53: Using desktop audio input: Speakers (Realtek High Definition Audio)
15:55:53: ------------------------------------------
15:55:53: Using auxilary audio input: Microphone (Realtek High Definition Audio)
15:55:53: ------------------------------------------
15:55:53: Audio Encoding: AAC
15:55:53:     bitrate: 128
15:55:53: Using graphics capture
15:55:53: Scene buffering time set to 1800
15:55:53: ------------------------------------------
15:55:53: Video Encoding: x264
15:55:53:     fps: 30
15:55:53:     width: 1920, height: 1080
15:55:53:     preset: medium
15:55:53:     profile: main
15:55:53:     keyint: 250
15:55:53:     CBR: yes
15:55:53:     CFR: yes
15:55:53:     max bitrate: 1500
15:55:53:     buffer size: 1500
15:55:53: ------------------------------------------
15:55:53: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
15:55:53: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
15:55:53: SharedTexCapture hooked
15:55:57: GraphicsCaptureSource::NewCapture:  eliminating old capture
15:55:57: SharedTexCapture hooked
15:56:00: Using RTMP service: Twitch / Justin.tv
15:56:00:   Server selection: rtmp://live-lhr.justin.tv/app
15:56:00:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
15:56:01: Completed handshake with rtmp://live-lhr.justin.tv/app in 406 ms.
15:56:02: SO_SNDBUF was at 8192
15:56:02: SO_SNDBUF is now 65536
15:56:03: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 21900 / 207872)
15:56:23: Total frames encoded: 831, total frames duplicated: 43 (5.17%)
15:56:23: Total frames rendered: 819, number of late frames: 5 (0.61%) (it's okay for some frames to be late)
15:56:24: RTMPPublisher::SocketLoop: Socket error, send() returned -1, GetLastError() 10038
15:56:24: Average send payload: 7068 bytes, average send interval: 74 ms
15:56:24: Number of times waited to send: 59, Waited for a total of 207028 bytes
15:56:24: Number of b-frames dropped: 160 (25%), Number of p-frames dropped: 128 (20%), Total 288 (44%)
15:56:24: Number of bytes sent: 2049804
15:56:24: 
15:56:24: Profiler time results:
15:56:24: 
15:56:24: ==============================================================
15:56:24: video thread frame - [100%] [avg time: 2.08 ms] [children: 25.3%] [unaccounted: 74.7%]
15:56:24: | scene->Preprocess - [0.0481%] [avg time: 0.001 ms]
15:56:24: | GPU download and conversion - [25.3%] [avg time: 0.526 ms] [children: 15.3%] [unaccounted: 9.95%]
15:56:24: | | flush - [14.6%] [avg time: 0.304 ms]
15:56:24: | | CopyResource - [0.673%] [avg time: 0.014 ms]
15:56:24: | | conversion to 4:2:0 - [0.0481%] [avg time: 0.001 ms]
15:56:24: Convert444Thread - [100%] [avg time: 1.806 ms] [children: 96.7%] [unaccounted: 3.32%]
15:56:24: | Convert444toNV12 - [96.7%] [avg time: 1.746 ms]
15:56:24: encoder thread frame - [100%] [avg time: 2.477 ms]
15:56:24: ==============================================================
15:56:24: 
15:56:24: 
15:56:24: Profiler CPU results:
15:56:24: 
15:56:24: ==============================================================
15:56:24: video thread frame - [cpu time: avg 0.114 ms, total 93.6 ms] [avg calls per frame: 1]
15:56:24: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:56:24: | GPU download and conversion - [cpu time: avg 0.038 ms, total 31.2 ms] [avg calls per frame: 1]
15:56:24: | | flush - [cpu time: avg 0.038 ms, total 31.2 ms] [avg calls per frame: 1]
15:56:24: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:56:24: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:56:24: Convert444Thread - [cpu time: avg 1.68 ms, total 1279.21 ms] [avg calls per frame: 1]
15:56:24: | Convert444toNV12 - [cpu time: avg 1.68 ms, total 1279.21 ms] [avg calls per frame: 1]
15:56:24: encoder thread frame - [cpu time: avg 1.485 ms, total 1154.41 ms] [avg calls per frame: 1]
15:56:24: ==============================================================
15:56:24: 
15:56:24: =====Stream End: 2014-01-25, 15:56:24=================================================
15:56:35: Using fixed low latency mode, factor 20
15:56:35: =====Stream Start: 2014-01-25, 15:56:35===============================================
15:56:35:   Multithreaded optimizations: On
15:56:35:   Base resolution: 1920x1080
15:56:35:   Output resolution: 1920x1080
15:56:35: ------------------------------------------
15:56:35: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
15:56:35: ------------------------------------------
15:56:35: Audio Format: 48000hz
15:56:35: Playback device Default
15:56:35: ------------------------------------------
15:56:35: Using desktop audio input: Speakers (Realtek High Definition Audio)
15:56:35: ------------------------------------------
15:56:35: Using auxilary audio input: Microphone (Realtek High Definition Audio)
15:56:35: ------------------------------------------
15:56:35: Audio Encoding: AAC
15:56:35:     bitrate: 128
15:56:35: Using graphics capture
15:56:35: Scene buffering time set to 1800
15:56:35: ------------------------------------------
15:56:35: Video Encoding: x264
15:56:35:     fps: 30
15:56:35:     width: 1920, height: 1080
15:56:35:     preset: medium
15:56:35:     profile: main
15:56:35:     keyint: 250
15:56:35:     CBR: yes
15:56:35:     CFR: yes
15:56:35:     max bitrate: 1000
15:56:35:     buffer size: 1000
15:56:35: ------------------------------------------
15:56:35: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
15:56:35: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
15:56:37: SharedTexCapture hooked
15:56:38: GraphicsCaptureSource::NewCapture:  eliminating old capture
15:56:38: SharedTexCapture hooked
15:56:43: Using RTMP service: Twitch / Justin.tv
15:56:43:   Server selection: rtmp://live-lhr.justin.tv/app
15:56:43:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
15:56:43: Completed handshake with rtmp://live-lhr.justin.tv/app in 452 ms.
15:56:44: SO_SNDBUF was at 8192
15:56:44: SO_SNDBUF is now 65536
15:56:46: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 0 / 144384)
15:57:02: Total frames encoded: 724, total frames duplicated: 31 (4.28%)
15:57:02: Total frames rendered: 715, number of late frames: 5 (0.70%) (it's okay for some frames to be late)
15:57:03: RTMPPublisher::SocketLoop: Socket error, send() returned -1, GetLastError() 10038
15:57:03: Average send payload: 7274 bytes, average send interval: 62 ms
15:57:03: Number of times waited to send: 65, Waited for a total of 246532 bytes
15:57:03: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
15:57:03: Number of bytes sent: 2102409
15:57:03: 
15:57:03: Profiler time results:
15:57:03: 
15:57:03: ==============================================================
15:57:03: video thread frame - [100%] [avg time: 2.333 ms] [children: 23.7%] [unaccounted: 76.3%]
15:57:03: | scene->Preprocess - [0.0429%] [avg time: 0.001 ms]
15:57:03: | GPU download and conversion - [23.6%] [avg time: 0.551 ms] [children: 14.5%] [unaccounted: 9.09%]
15:57:03: | | flush - [10.9%] [avg time: 0.255 ms]
15:57:03: | | CopyResource - [3.56%] [avg time: 0.083 ms]
15:57:03: | | conversion to 4:2:0 - [0.0429%] [avg time: 0.001 ms]
15:57:03: Convert444Thread - [100%] [avg time: 1.949 ms] [children: 94.9%] [unaccounted: 5.13%]
15:57:03: | Convert444toNV12 - [94.9%] [avg time: 1.849 ms]
15:57:03: encoder thread frame - [100%] [avg time: 2.952 ms]
15:57:03: ==============================================================
15:57:03: 
15:57:03: 
15:57:03: Profiler CPU results:
15:57:03: 
15:57:03: ==============================================================
15:57:03: video thread frame - [cpu time: avg 0.174 ms, total 124.8 ms] [avg calls per frame: 1]
15:57:03: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:57:03: | GPU download and conversion - [cpu time: avg 0.043 ms, total 31.2 ms] [avg calls per frame: 1]
15:57:03: | | flush - [cpu time: avg 0.021 ms, total 15.6 ms] [avg calls per frame: 1]
15:57:03: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:57:03: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:57:03: Convert444Thread - [cpu time: avg 1.266 ms, total 842.405 ms] [avg calls per frame: 1]
15:57:03: | Convert444toNV12 - [cpu time: avg 1.266 ms, total 842.405 ms] [avg calls per frame: 1]
15:57:03: encoder thread frame - [cpu time: avg 1.513 ms, total 1014.01 ms] [avg calls per frame: 1]
15:57:03: ==============================================================
15:57:03: 
15:57:03: =====Stream End: 2014-01-25, 15:57:03=================================================
15:57:33: Using fixed low latency mode, factor 20
15:57:33: =====Stream Start: 2014-01-25, 15:57:33===============================================
15:57:33:   Multithreaded optimizations: On
15:57:33:   Base resolution: 1920x1080
15:57:33:   Output resolution: 1920x1080
15:57:33: ------------------------------------------
15:57:33: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
15:57:33: ------------------------------------------
15:57:33: Audio Format: 48000hz
15:57:33: Playback device Default
15:57:33: ------------------------------------------
15:57:33: Using desktop audio input: Speakers (Realtek High Definition Audio)
15:57:33: ------------------------------------------
15:57:33: Using auxilary audio input: Microphone (Realtek High Definition Audio)
15:57:33: ------------------------------------------
15:57:33: Audio Encoding: AAC
15:57:33:     bitrate: 128
15:57:33: Using graphics capture
15:57:33: Scene buffering time set to 1800
15:57:33: ------------------------------------------
15:57:33: Video Encoding: x264
15:57:33:     fps: 30
15:57:33:     width: 1920, height: 1080
15:57:33:     preset: medium
15:57:33:     profile: main
15:57:33:     keyint: 250
15:57:33:     CBR: yes
15:57:33:     CFR: yes
15:57:33:     max bitrate: 700
15:57:33:     buffer size: 700
15:57:33: ------------------------------------------
15:57:33: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
15:57:33: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
Warning -- SharedTexCapture::Init: Could not open file mapping: 2
15:57:35: SharedTexCapture hooked
15:57:40: Using RTMP service: Twitch / Justin.tv
15:57:40:   Server selection: rtmp://live-lhr.justin.tv/app
15:57:40:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
15:57:41: Completed handshake with rtmp://live-lhr.justin.tv/app in 409 ms.
15:57:42: SO_SNDBUF was at 8192
15:57:42: SO_SNDBUF is now 65536
15:57:52: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 0 / 131072)
15:59:21: Total frames encoded: 3191, total frames duplicated: 586 (18.36%)
15:59:21: Number of frames skipped due to encoder lag: 424 (13.29%)
15:59:21: Total frames rendered: 2720, number of late frames: 46 (1.69%) (it's okay for some frames to be late)
15:59:25: RTMPPublisher::SocketLoop: Graceful loop exit
15:59:25: Average send payload: 4657 bytes, average send interval: 52 ms
15:59:25: Number of times waited to send: 0, Waited for a total of 0 bytes
15:59:25: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
15:59:25: Number of bytes sent: 9095430
15:59:25: 
15:59:25: Profiler time results:
15:59:25: 
15:59:25: ==============================================================
15:59:25: video thread frame - [100%] [avg time: 3.854 ms] [children: 51.6%] [unaccounted: 48.4%]
15:59:25: | scene->Preprocess - [0.0259%] [avg time: 0.001 ms]
15:59:25: | GPU download and conversion - [51.6%] [avg time: 1.989 ms] [children: 42.6%] [unaccounted: 9%]
15:59:25: | | flush - [41.8%] [avg time: 1.612 ms]
15:59:25: | | CopyResource - [0.727%] [avg time: 0.028 ms]
15:59:25: | | conversion to 4:2:0 - [0.0519%] [avg time: 0.002 ms]
15:59:25: Convert444Thread - [100%] [avg time: 1.874 ms] [children: 99.3%] [unaccounted: 0.694%]
15:59:25: | Convert444toNV12 - [99.3%] [avg time: 1.861 ms]
15:59:25: encoder thread frame - [100%] [avg time: 7.701 ms]
15:59:25: ==============================================================
15:59:25: 
15:59:25: 
15:59:25: Profiler CPU results:
15:59:25: 
15:59:25: ==============================================================
15:59:25: video thread frame - [cpu time: avg 0.2 ms, total 546.003 ms] [avg calls per frame: 1]
15:59:25: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:59:25: | GPU download and conversion - [cpu time: avg 0.045 ms, total 124.8 ms] [avg calls per frame: 1]
15:59:25: | | flush - [cpu time: avg 0.034 ms, total 93.6 ms] [avg calls per frame: 1]
15:59:25: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:59:25: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
15:59:25: Convert444Thread - [cpu time: avg 1.824 ms, total 4867.23 ms] [avg calls per frame: 1]
15:59:25: | Convert444toNV12 - [cpu time: avg 1.812 ms, total 4836.03 ms] [avg calls per frame: 1]
15:59:25: encoder thread frame - [cpu time: avg 2.033 ms, total 6380.44 ms] [avg calls per frame: 1]
15:59:25: ==============================================================
15:59:25: 
15:59:25: =====Stream End: 2014-01-25, 15:59:25=================================================
16:00:04: Using fixed low latency mode, factor 20
16:00:04: =====Stream Start: 2014-01-25, 16:00:04===============================================
16:00:04:   Multithreaded optimizations: On
16:00:04:   Base resolution: 1920x1080
16:00:04:   Output resolution: 1920x1080
16:00:04: ------------------------------------------
16:00:04: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
16:00:04: ------------------------------------------
16:00:04: Audio Format: 48000hz
16:00:04: Playback device Default
16:00:04: ------------------------------------------
16:00:04: Using desktop audio input: Speakers (Realtek High Definition Audio)
16:00:04: ------------------------------------------
16:00:04: Using auxilary audio input: Microphone (Realtek High Definition Audio)
16:00:04: ------------------------------------------
16:00:04: Audio Encoding: AAC
16:00:04:     bitrate: 128
16:00:04: Using graphics capture
16:00:04: Scene buffering time set to 1800
16:00:04: ------------------------------------------
16:00:04: Video Encoding: x264
16:00:04:     fps: 30
16:00:04:     width: 1920, height: 1080
16:00:04:     preset: medium
16:00:04:     profile: main
16:00:04:     keyint: 250
16:00:04:     CBR: yes
16:00:04:     CFR: yes
16:00:04:     max bitrate: 3500
16:00:04:     buffer size: 3500
16:00:04: ------------------------------------------
16:00:04: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
16:00:04: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
16:00:12: Using RTMP service: Twitch / Justin.tv
16:00:12:   Server selection: rtmp://live-lhr.justin.tv/app
16:00:12:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
16:00:12: Completed handshake with rtmp://live-lhr.justin.tv/app in 415 ms.
16:00:13: SO_SNDBUF was at 8192
16:00:13: SO_SNDBUF is now 65536
16:00:14: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 211632 / 463872)
16:00:35: Total frames encoded: 863, total frames duplicated: 3 (0.35%)
16:00:35: Total frames rendered: 868, number of late frames: 1 (0.12%) (it's okay for some frames to be late)
16:00:36: RTMPPublisher::SocketLoop: Aborting due to WSAEnumNetworkEvents failure, 10038
16:00:36: Average send payload: 17698 bytes, average send interval: 159 ms
16:00:36: Number of times waited to send: 18, Waited for a total of 71974 bytes
16:00:36: Number of b-frames dropped: 257 (38%), Number of p-frames dropped: 246 (36%), Total 503 (74%)
16:00:36: Number of bytes sent: 2495543
16:00:36: 
16:00:36: Profiler time results:
16:00:36: 
16:00:36: ==============================================================
16:00:36: video thread frame - [100%] [avg time: 1.245 ms] [children: 56.5%] [unaccounted: 43.5%]
16:00:36: | scene->Preprocess - [0.0803%] [avg time: 0.001 ms]
16:00:36: | GPU download and conversion - [56.5%] [avg time: 0.703 ms] [children: 37.7%] [unaccounted: 18.8%]
16:00:36: | | flush - [35.9%] [avg time: 0.447 ms]
16:00:36: | | CopyResource - [1.69%] [avg time: 0.021 ms]
16:00:36: | | conversion to 4:2:0 - [0.0803%] [avg time: 0.001 ms]
16:00:36: Convert444Thread - [100%] [avg time: 1.578 ms] [children: 99.3%] [unaccounted: 0.697%]
16:00:36: | Convert444toNV12 - [99.3%] [avg time: 1.567 ms]
16:00:36: encoder thread frame - [100%] [avg time: 2.117 ms]
16:00:36: ==============================================================
16:00:36: 
16:00:36: 
16:00:36: Profiler CPU results:
16:00:36: 
16:00:36: ==============================================================
16:00:36: video thread frame - [cpu time: avg 0.071 ms, total 62.4 ms] [avg calls per frame: 1]
16:00:36: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
16:00:36: | GPU download and conversion - [cpu time: avg 0.053 ms, total 46.8 ms] [avg calls per frame: 1]
16:00:36: | | flush - [cpu time: avg 0.053 ms, total 46.8 ms] [avg calls per frame: 1]
16:00:36: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
16:00:36: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
16:00:36: Convert444Thread - [cpu time: avg 1.194 ms, total 967.206 ms] [avg calls per frame: 1]
16:00:36: | Convert444toNV12 - [cpu time: avg 1.194 ms, total 967.206 ms] [avg calls per frame: 1]
16:00:36: encoder thread frame - [cpu time: avg 1.33 ms, total 1076.41 ms] [avg calls per frame: 1]
16:00:36: ==============================================================
16:00:36: 
16:00:36: =====Stream End: 2014-01-25, 16:00:36=================================================
16:02:55: Settings::Video: Disabling Aero
16:02:58: Using fixed low latency mode, factor 20
16:02:58: =====Stream Start: 2014-01-25, 16:02:58===============================================
16:02:58:   Multithreaded optimizations: On
16:02:58:   Base resolution: 1920x1080
16:02:58:   Output resolution: 1920x1080
16:02:58: ------------------------------------------
16:02:58: Loading up D3D10 on AMD Radeon R9 200 Series (Adapter 1)...
16:02:58: ------------------------------------------
16:02:58: Audio Format: 48000hz
16:02:58: Playback device Default
16:02:58: ------------------------------------------
16:02:58: Using desktop audio input: Speakers (Realtek High Definition Audio)
16:02:58: ------------------------------------------
16:02:58: Using auxilary audio input: Microphone (Realtek High Definition Audio)
16:02:58: ------------------------------------------
16:02:58: Audio Encoding: AAC
16:02:58:     bitrate: 128
16:02:58: Using graphics capture
16:02:58: Scene buffering time set to 1800
16:02:58: ------------------------------------------
16:02:58: Video Encoding: x264
16:02:58:     fps: 30
16:02:58:     width: 1920, height: 1080
16:02:58:     preset: medium
16:02:58:     profile: main
16:02:58:     keyint: 250
16:02:58:     CBR: yes
16:02:58:     CFR: yes
16:02:58:     max bitrate: 3500
16:02:58:     buffer size: 3500
16:02:58: ------------------------------------------
16:02:58: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
16:02:58: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
16:03:06: Using RTMP service: Twitch / Justin.tv
16:03:06:   Server selection: rtmp://live-lhr.justin.tv/app
16:03:06:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
16:03:06: Completed handshake with rtmp://live-lhr.justin.tv/app in 431 ms.
16:03:07: SO_SNDBUF was at 8192
16:03:07: SO_SNDBUF is now 65536
16:03:08: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 185892 / 463872)
16:03:24: Total frames encoded: 697, total frames duplicated: 3 (0.43%)
16:03:24: Total frames rendered: 702, number of late frames: 2 (0.28%) (it's okay for some frames to be late)
16:03:25: RTMPPublisher::SocketLoop: Aborting due to WSAEnumNetworkEvents failure, 10038
16:03:25: Average send payload: 16726 bytes, average send interval: 143 ms
16:03:25: Number of times waited to send: 12, Waited for a total of 47390 bytes
16:03:25: Number of b-frames dropped: 190 (36%), Number of p-frames dropped: 183 (35%), Total 373 (71%)
16:03:25: Number of bytes sent: 1990428
16:03:25: 
16:03:25: Profiler time results:
16:03:25: 
16:03:25: ==============================================================
16:03:25: video thread frame - [100%] [avg time: 0.967 ms] [children: 49.5%] [unaccounted: 50.5%]
16:03:25: | scene->Preprocess - [0.207%] [avg time: 0.002 ms]
16:03:25: | GPU download and conversion - [49.3%] [avg time: 0.477 ms] [children: 38.8%] [unaccounted: 10.5%]
16:03:25: | | flush - [37.4%] [avg time: 0.362 ms]
16:03:25: | | CopyResource - [0.931%] [avg time: 0.009 ms]
16:03:25: | | conversion to 4:2:0 - [0.414%] [avg time: 0.004 ms]
16:03:25: Convert444Thread - [100%] [avg time: 1.722 ms] [children: 99.4%] [unaccounted: 0.581%]
16:03:25: | Convert444toNV12 - [99.4%] [avg time: 1.712 ms]
16:03:25: encoder thread frame - [100%] [avg time: 2.172 ms]
16:03:25: ==============================================================
16:03:25: 
16:03:25: 
16:03:25: Profiler CPU results:
16:03:25: 
16:03:25: ==============================================================
16:03:25: video thread frame - [cpu time: avg 0.066 ms, total 46.8 ms] [avg calls per frame: 1]
16:03:25: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
16:03:25: | GPU download and conversion - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
16:03:25: | | flush - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
16:03:25: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
16:03:25: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
16:03:25: Convert444Thread - [cpu time: avg 1.501 ms, total 967.206 ms] [avg calls per frame: 1]
16:03:25: | Convert444toNV12 - [cpu time: avg 1.501 ms, total 967.206 ms] [avg calls per frame: 1]
16:03:25: encoder thread frame - [cpu time: avg 1.261 ms, total 811.205 ms] [avg calls per frame: 1]
16:03:25: ==============================================================
16:03:25: 
16:03:25: =====Stream End: 2014-01-25, 16:03:25=================================================

alpinlol · Jan 25, 2014

for further logfiles post use either pastebin or the code function on the forum.

and yes as guessed your i3 wont handle anything especially not that what you tried

Code:

16:02:58: Scene buffering time set to 1800
16:02:58: ------------------------------------------
16:02:58: Video Encoding: x264
16:02:58: fps: 30
16:02:58: width: 1920, height: 1080
16:02:58: preset: medium
16:02:58: profile: main
16:02:58: keyint: 250
16:02:58: CBR: yes
16:02:58: CFR: yes
16:02:58: max bitrate: 3500
16:02:58: buffer size: 3500

Code:

15:55:53: Scene buffering time set to 1800
15:55:53: ------------------------------------------
15:55:53: Video Encoding: x264
15:55:53: fps: 30
15:55:53: width: 1920, height: 1080
15:55:53: preset: medium
15:55:53: profile: main
15:55:53: keyint: 250
15:55:53: CBR: yes
15:55:53: CFR: yes
15:55:53: max bitrate: 1500
15:55:53: buffer size: 1500

also your internet connection seems to be more than just bad since you drop a shit ton of frames even on 1500 bitrate.

honest opinion i'd give up streaming already if i'd be you

Question / Help FPS Lag + Lag Spikes

NETTOBEAR

New Member

Sapiens

alpinlol

Active Member

NETTOBEAR

New Member

alpinlol

Active Member