Question / Help Starting stream, Spiking kb/s, then dropping down to 0 kb/s

W

Wesleysnopes

New Member
CBR 3000 1920x1080 downscaled to 720p @ 30 fps. (have tried variable bitrates from 800-3500)

What's happening is when I start to stream, the stream connects, then automatically (about 5 seconds after start) I spike at around 3000kb/s, then drop down to around 750, then it jumps from around 750 to 0kb/s.
Dropping around 75% of frames.

Streaming WoW/NES games just to test out my settings, I'm using game capture with aero on (have tried with aero off/window capture same problems)

I'm connecting to Twitch, have tried all nearby servers (westcoast, central and midwest. Even tried eastcoast), refreshed my stream key multiple times.

I've used the log analyzer, only minor problem being SLI, which doesn't seem to be a problem at all.

The stream starts, then drops frames and stops sending data. I stop the stream manually.
Here's the log:
Code: 
10:15:54: Open Broadcaster Software v0.583b - 32bit (´・ω・｀)
10:15:54: -------------------------------
10:15:54: CPU Name: Intel(R) Core(TM) i5-2500K CPU @ 3.30GHz
10:15:54: CPU Speed: 3292MHz
10:15:54: Physical Memory:  4095MB Total, 4095MB Free
10:15:54: stepping id: 7, model 42, family 6, type 0, extmodel 1, extfamily 0, HTT 1, logical cores 4, total cores 4
10:15:54: monitor 1: pos={0, 0}, size={1920, 1080}
10:15:54: monitor 2: pos={1920, -546}, size={1080, 1920}
10:15:54: Windows Version: 6.1 Build 7601 S
10:15:54: Aero is Enabled
10:15:54: -------------------------------
10:15:54: OBS Modules:
10:15:54: Base Address     Module
10:15:54: 01390000         OBS.exe
10:15:54: 5FA80000         OBSApi.dll
10:15:54: 6FF50000         DShowPlugin.dll
10:15:54: 70A20000         GraphicsCapture.dll
10:15:54: 6F150000         NoiseGate.dll
10:15:54: 6F130000         PSVPlugin.dll
10:15:54: ------------------------------------------
10:15:54: Adapter 1
10:15:54:   Video Adapter: NVIDIA GeForce GTX 560 Ti  
10:15:54:   Video Adapter Dedicated Video Memory: 1024917504
10:15:54:   Video Adapter Shared System Memory: 3221106688
10:15:54:   Video Adapter Output 1: pos={0, 0}, size={1920, 1080}, attached=true
10:15:54: ------------------------------------------
10:15:54: Adapter 2
10:15:54:   Video Adapter: NVIDIA GeForce GTX 560 Ti  
10:15:54:   Video Adapter Dedicated Video Memory: 1025048576
10:15:54:   Video Adapter Shared System Memory: 3220975616
10:15:54:   Video Adapter Output 1: pos={1920, -546}, size={1080, 1920}, attached=true
10:15:54: ------------------------------------------
10:15:54: Adapter 3
10:15:54:   Video Adapter: Intel(R) HD Graphics 3000
10:15:54:   Video Adapter Dedicated Video Memory: 67108864
10:15:54:   Video Adapter Shared System Memory: 1711276032
10:15:54: =====Stream Start: 2013-11-04, 10:15:54===============================================
10:15:54:   Multithreaded optimizations: On
10:15:54:   Base resolution: 1920x1080
10:15:54:   Output resolution: 1280x720
10:15:54: ------------------------------------------
10:15:54: Loading up D3D10 on NVIDIA GeForce GTX 560 Ti...
10:15:54: ------------------------------------------
10:15:54: Audio Format: 48000hz
10:15:54: Playback device Default
10:15:54: ------------------------------------------
10:15:54: Using desktop audio input: Speakers (Realtek High Definition Audio)
10:15:54: ------------------------------------------
10:15:54: Using auxilary audio input: Microphone (HD Pro Webcam C920)
10:15:54: ------------------------------------------
10:15:54: Audio Encoding: AAC
10:15:54:     bitrate: 128
10:15:54: Using graphics capture
10:15:54: Scene buffering time set to 700
10:15:54: ------------------------------------------
10:15:54: Video Encoding: x264
10:15:54:     fps: 30
10:15:54:     width: 1280, height: 720
10:15:54:     preset: veryfast
10:15:54:     profile: high
10:15:54:     keyint: 60
10:15:54:     CBR: yes
10:15:54:     CFR: yes
10:15:54:     max bitrate: 3000
10:15:54:     buffer size: 3000
10:15:54: ------------------------------------------
10:15:54: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 1536000, samples per sec is 192000
10:15:54: MMDeviceAudioSource: Frequency for device 'Microphone (HD Pro Webcam C920)' is 128000, samples per sec is 16000
10:15:54: SharedTexCapture hooked
10:16:01: Total frames encoded: 168, total frames duplicated: 0 (0.00%)
10:16:01: Total frames rendered: 172, number of late frames: 0 (0.00%) (it's okay for some frames to be late)
10:16:01: 
10:16:01: Profiler time results:
10:16:01: 
10:16:01: ==============================================================
10:16:01: video thread frame - [100%] [avg time: 0.802 ms] [children: 5.24%] [unaccounted: 94.8%]
10:16:01: | scene->Preprocess - [0.125%] [avg time: 0.001 ms]
10:16:01: | GPU download and conversion - [5.11%] [avg time: 0.041 ms] [children: 4.61%] [unaccounted: 0.499%]
10:16:01: | | flush - [3.12%] [avg time: 0.025 ms]
10:16:01: | | CopyResource - [1.37%] [avg time: 0.011 ms]
10:16:01: | | conversion to 4:2:0 - [0.125%] [avg time: 0.001 ms]
10:16:01: Convert444Threads - [100%] [avg time: 0.36 ms] [children: 98.3%] [unaccounted: 1.67%]
10:16:01: | Convert444toNV12 - [98.3%] [avg time: 0.354 ms]
10:16:01: encoder thread frame - [100%] [avg time: 0.752 ms]
10:16:01: ==============================================================
10:16:01: 
10:16:01: 
10:16:01: Profiler CPU results:
10:16:01: 
10:16:01: ==============================================================
10:16:01: video thread frame - [cpu time: avg 0.09 ms, total 15.6 ms] [avg calls per frame: 1]
10:16:01: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
10:16:01: | GPU download and conversion - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
10:16:01: | | flush - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
10:16:01: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
10:16:01: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
10:16:01: Convert444Threads - [cpu time: avg 0.21 ms, total 62.4 ms] [avg calls per frame: 2]
10:16:01: | Convert444toNV12 - [cpu time: avg 0.21 ms, total 62.4 ms] [avg calls per frame: 2]
10:16:01: encoder thread frame - [cpu time: avg 0.212 ms, total 31.2 ms] [avg calls per frame: 1]
10:16:01: ==============================================================
10:16:01: 
10:16:01: =====Stream End: 2013-11-04, 10:16:01=================================================
10:16:02: =====Stream Start: 2013-11-04, 10:16:02===============================================
10:16:02:   Multithreaded optimizations: On
10:16:02:   Base resolution: 1920x1080
10:16:02:   Output resolution: 1280x720
10:16:02: ------------------------------------------
10:16:02: Loading up D3D10 on NVIDIA GeForce GTX 560 Ti...
10:16:02: ------------------------------------------
10:16:02: Audio Format: 48000hz
10:16:02: Playback device Default
10:16:02: ------------------------------------------
10:16:02: Using desktop audio input: Speakers (Realtek High Definition Audio)
10:16:02: ------------------------------------------
10:16:02: Using auxilary audio input: Microphone (HD Pro Webcam C920)
10:16:02: ------------------------------------------
10:16:02: Audio Encoding: AAC
10:16:02:     bitrate: 128
10:16:02: Using graphics capture
10:16:02: Scene buffering time set to 700
10:16:02: ------------------------------------------
10:16:02: Video Encoding: x264
10:16:02:     fps: 30
10:16:02:     width: 1280, height: 720
10:16:02:     preset: veryfast
10:16:02:     profile: high
10:16:02:     keyint: 60
10:16:02:     CBR: yes
10:16:02:     CFR: yes
10:16:02:     max bitrate: 3000
10:16:02:     buffer size: 3000
10:16:02: ------------------------------------------
10:16:02: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 1536000, samples per sec is 192000
10:16:02: MMDeviceAudioSource: Frequency for device 'Microphone (HD Pro Webcam C920)' is 128000, samples per sec is 16000
10:16:02: SharedTexCapture hooked
10:16:05: Using RTMP service: Twitch / Justin.tv
10:16:05:   Server selection: rtmp://live-lax.justin.tv/app
10:16:05:   Interface: Realtek PCIe GBE Family Controller (ethernet, 100 mbps)
10:16:05: Completed handshake with rtmp://live-lax.justin.tv/app in 63 ms.
10:16:06: SO_SNDBUF was at 8192
10:16:06: SO_SNDBUF is now 65536
10:16:07: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 16537 / 400384)
10:16:15: RTMPPublisher::SocketLoop: Stalled for 6682 ms to write 397741 bytes (buffer: 0 / 400384), unstable connection?
10:16:24: RTMPPublisher::SocketLoop: Stalled for 8864 ms to write 400101 bytes (buffer: 0 / 400384), unstable connection?
10:16:43: RTMPPublisher::SocketLoop: Stalled for 18860 ms to write 400256 bytes (buffer: 0 / 400384), unstable connection?
10:17:01: RTMPPublisher::SocketLoop: Stalled for 18422 ms to write 400027 bytes (buffer: 0 / 400384), unstable connection?
10:17:08: Total frames encoded: 1939, total frames duplicated: 1 (0.05%)
10:17:08: Total frames rendered: 1944, number of late frames: 1 (0.05%) (it's okay for some frames to be late)
10:17:20: RTMPPublisher::SocketLoop: Stalled for 19094 ms to write 396362 bytes (buffer: 0 / 400384), unstable connection?
10:17:39: RTMPPublisher::SocketLoop: Stalled for 18925 ms to write 400028 bytes (buffer: 0 / 400384), unstable connection?
10:17:58: RTMPPublisher::SocketLoop: Stalled for 18840 ms to write 399685 bytes (buffer: 0 / 400384), unstable connection?
10:17:58: ~RTMPPublisher: Network appears stalled with 397557 / 400384 buffered, dropping connection!
10:17:58: RTMPPublisher::SocketLoop: Graceful loop exit
10:17:58: Average send payload: 170713 bytes, average send interval: 5557 ms
10:17:58: Number of times waited to send: 10, Waited for a total of 40675 bytes
10:17:58: Number of b-frames dropped: 499 (27%), Number of p-frames dropped: 1042 (57%), Total 1541 (84%)
10:17:58: Number of bytes sent: 3414267
10:17:58: 
10:17:58: Profiler time results:
10:17:58: 
10:17:58: ==============================================================
10:17:58: video thread frame - [100%] [avg time: 0.648 ms] [children: 8.64%] [unaccounted: 91.4%]
10:17:58: | scene->Preprocess - [0.154%] [avg time: 0.001 ms]
10:17:58: | GPU download and conversion - [8.49%] [avg time: 0.055 ms] [children: 6.02%] [unaccounted: 2.47%]
10:17:58: | | flush - [2.93%] [avg time: 0.019 ms]
10:17:58: | | CopyResource - [2.78%] [avg time: 0.018 ms]
10:17:58: | | conversion to 4:2:0 - [0.309%] [avg time: 0.002 ms]
10:17:58: Convert444Threads - [100%] [avg time: 0.398 ms] [children: 97.2%] [unaccounted: 2.76%]
10:17:58: | Convert444toNV12 - [97.2%] [avg time: 0.387 ms]
10:17:58: encoder thread frame - [100%] [avg time: 0.862 ms]
10:17:58: ==============================================================
10:17:58: 
10:17:58: 
10:17:58: Profiler CPU results:
10:17:58: 
10:17:58: ==============================================================
10:17:58: video thread frame - [cpu time: avg 0.064 ms, total 124.8 ms] [avg calls per frame: 1]
10:17:58: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
10:17:58: | GPU download and conversion - [cpu time: avg 0.008 ms, total 15.6 ms] [avg calls per frame: 1]
10:17:58: | | flush - [cpu time: avg 0.008 ms, total 15.6 ms] [avg calls per frame: 1]
10:17:58: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
10:17:58: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
10:17:58: Convert444Threads - [cpu time: avg 0.325 ms, total 1248.01 ms] [avg calls per frame: 2]
10:17:58: | Convert444toNV12 - [cpu time: avg 0.325 ms, total 1248.01 ms] [avg calls per frame: 2]
10:17:58: encoder thread frame - [cpu time: avg 0.065 ms, total 124.8 ms] [avg calls per frame: 1]
10:17:58: ==============================================================
10:17:58: 
10:17:58: =====Stream End: 2013-11-04, 10:17:58=================================================


Last game capture log:
2013-11-04, 10:15:54: we're booting up: 
10:15:54: D3D9 Present
10:15:54: DXGI Present
10:15:54: (half life scientist) everything..  seems to be in order
10:15:54: DXGI: Found D3D 11
10:15:54: setting up d3d11 data
10:15:54: ---------------------- Cleared D3D11 Capture ----------------------
10:15:54: found dxgi format (dx11) of: 28, size: {1920, 1080}, multisampled: true
10:15:54: DoD3D11Hook: success
10:15:54: successfully capturing d3d11 frames via GPU
10:16:01: stop requested, terminating d3d11 capture
10:16:01: ---------------------- Cleared D3D11 Capture ----------------------
10:16:02: DoD3D11Hook: success
10:16:03: successfully capturing d3d11 frames via GPU
10:17:08: stop requested, terminating d3d11 capture
10:17:08: ---------------------- Cleared D3D11 Capture ----------------------

Thanks in advanced!
 

Attachments

  • 2013-11-04-1014-22.log
    11.7 KB · Views: 9
W

Wesleysnopes

New Member
Re: Starting stream, Spiking kb/s, then dropping down to 0 k

Oh, I forgot my up/down speeds.
From testmy (FROM TEXAS):
8QCfgT5.NwnlQ1Z.png


14 up, 3 down (it was about twice that last night, which I find strange) I feel like this whole problem may be my ISP's fault.

From test my (FROM SAN JOSE) [closest]
0MWbOUk.WRwMzrv.png
 
L

Lain

Forum Admin
Lain
Forum Moderator
Developer
Re: Starting stream, Spiking kb/s, then dropping down to 0 k

From what I can see it just seems like typical frame drops. The speed test sites aren't usually a good indicator of stable bitrate. Just because a speed test says you have 3.5 doesn't mean you will be able to sustain that much, usually you can only have a stable bitrate at about 75% at most of the number reported. Often even less, depending on the areas. At what bitrate does this stop occurring?
 
W

Wesleysnopes

New Member
Re: Starting stream, Spiking kb/s, then dropping down to 0 k

Hey, Jim. Thanks for the response.

I've tested bitrates from 800-3500, but no matter what bitrate I'm running at, when I hit Start Streaming this series of events happens:
  • It connects to twitch
  • Starts streaming
  • The bitrate indicator starts at green at whichever bitrate is set
  • around 5 seconds later, it immediately drops to red
  • the stream halts and drops thousands of frames(doesn't disconnect)

I then manually disconnect because it isn't transmitting any watchable data to the twitch servers.
 
dodgepong

dodgepong

Administrator
Community Helper
Re: Starting stream, Spiking kb/s, then dropping down to 0 k

Try some different Twitch servers besides the LA one.
 
FerretBomb

FerretBomb

Active Member
Re: Starting stream, Spiking kb/s, then dropping down to 0 k

I'd also recommend running ShaperProbe to see if your traffic is being shaped by your ISP. Cox are known for being... well.. Cox like that.

I'd also advise to manually run the 6MB test on http://testmy.net/upload instead of the 'auto discover' one. You can also run the next step up as well.

Have you tried using JTVPing to see which ingest servers give you the best ping? May have to trial-and-error a few of them to see which will give you good throughput, in the event that it's an ingest or route-based issue.
 
You must log in or register to reply here.
Top