Question / Help Can someone explain this log to me? 60fps issues.

dramabomb

Member
Streaming Path of Exile at 720p/60fps and it doesn't look quite that smooth to me. It seems to be visibly hitching/micro stuttering at times. Is this an OBS/Twitch issue? I see a lot of "buffer full" and p/b-frame dropped stuff in the log, not sure what that's about.

The clip: http://www.twitch.tv/thedigitalbench/b/357914582

The log:

Code:
Open Broadcaster Software v0.466a - 32bit (´・ω・`)
-------------------------------
CPU Name: Intel(R) Core(TM) i5-2500K CPU @ 3.30GHz
CPU Speed: 3300MHz
Physical Memory:  4095MB Total, 4095MB Free
stepping id: 7, model 10, family 6, type 0, extmodel 1, extfamily 0, HTT 1, logical cores 4, total cores 4
Windows Version: 6.1 Build 7601 S
Aero is Disabled
------------------------------------------
Adapter 1
  Video Adapter: NVIDIA GeForce GTX 560 Ti  
  Video Adapter Dedicated Video Memory: 1025966080
  Video Adapter Shared System Memory: 3221106688
=====Stream Start=====================================================================
  Multithreaded optimizations: On
  Base resolution: 1920x1080
  Output resolution: 1280x720
------------------------------------------
Loading up D3D10...
------------------------------------------
Audio Encoding: AAC
    bitrate: 128
Using graphics capture
------------------------------------------
Video Encoding: x264
    fps: 60
    width: 1280, height: 720
    preset: veryfast
    CBR: no
    max bitrate: 3000
    buffer size: 3000
    quality: 8
------------------------------------------
SharedTexCapture hooked
Total frames rendered: 175, number of frames that lagged: 7 (4.00%) (it's okay for some frames to lag)
=====Stream End=======================================================================
=====Stream Start=====================================================================
  Multithreaded optimizations: On
  Base resolution: 1920x1080
  Output resolution: 1280x720
------------------------------------------
Loading up D3D10...
------------------------------------------
Audio Encoding: AAC
    bitrate: 128
Using graphics capture
------------------------------------------
Video Encoding: x264
    fps: 60
    width: 1280, height: 720
    preset: veryfast
    CBR: no
    max bitrate: 3000
    buffer size: 3000
    quality: 8
------------------------------------------
Total frames rendered: 25, number of frames that lagged: 0 (0.00%) (it's okay for some frames to lag)
=====Stream End=======================================================================
=====Stream Start=====================================================================
  Multithreaded optimizations: On
  Base resolution: 1920x1080
  Output resolution: 1280x720
------------------------------------------
Loading up D3D10...
------------------------------------------
Audio Encoding: AAC
    bitrate: 128
Using graphics capture
------------------------------------------
Video Encoding: x264
    fps: 60
    width: 1280, height: 720
    preset: veryfast
    CBR: no
    max bitrate: 3000
    buffer size: 3000
    quality: 8
------------------------------------------
SharedTexCapture hooked
Using RTMP service: Twitch / Justin.tv
  Server selection: rtmp://live-iad.justin.tv/app
bufferTime: 1441, outputRateWindowTime: 1000, dropThreshold: 1941
SharedTexCapture hooked
SharedTexCapture hooked
SharedTexCapture hooked
RTMPPublisher::BufferedSend: Buffer is full (398227 / 400384 bytes), waiting to send 2801 bytes
RTMPPublisher::BufferedSend: Buffer is full (398227 / 400384 bytes), waiting to send 2801 bytes
SharedTexCapture hooked
RTMPPublisher::BufferedSend: Buffer is full (397802 / 400384 bytes), waiting to send 4104 bytes
RTMPPublisher::BufferedSend: Buffer is full (397802 / 400384 bytes), waiting to send 4104 bytes
RTMPPublisher::BufferedSend: Buffer is full (397158 / 400384 bytes), waiting to send 4104 bytes
RTMPPublisher::BufferedSend: Buffer is full (397158 / 400384 bytes), waiting to send 4104 bytes
RTMPPublisher::BufferedSend: Buffer is full (397094 / 400384 bytes), waiting to send 4097 bytes
RTMPPublisher::BufferedSend: Buffer is full (400178 / 400384 bytes), waiting to send 227 bytes
RTMPPublisher::BufferedSend: Buffer is full (400178 / 400384 bytes), waiting to send 227 bytes
RTMPPublisher::BufferedSend: Buffer is full (399075 / 400384 bytes), waiting to send 4104 bytes
RTMPPublisher::BufferedSend: Buffer is full (399075 / 400384 bytes), waiting to send 4104 bytes
RTMPPublisher::BufferedSend: Buffer is full (400357 / 400384 bytes), waiting to send 383 bytes
RTMPPublisher::BufferedSend: Buffer is full (400357 / 400384 bytes), waiting to send 383 bytes
RTMPPublisher::SocketLoop: Aborting due to FD_CLOSE, error 0
Total frames rendered: 276216, number of frames that lagged: 66 (0.02%) (it's okay for some frames to lag)
Number of b-frames dropped: 223 (0.047%), Number of p-frames dropped: 155 (0.033%), Total 378 (0.08%)
=====Stream End=======================================================================
=====Stream Start=====================================================================
  Multithreaded optimizations: On
  Base resolution: 1920x1080
  Output resolution: 1280x720
------------------------------------------
Loading up D3D10...
------------------------------------------
Audio Encoding: AAC
    bitrate: 128
Using graphics capture
------------------------------------------
Video Encoding: x264
    fps: 60
    width: 1280, height: 720
    preset: veryfast
    CBR: no
    max bitrate: 3000
    buffer size: 3000
    quality: 8
------------------------------------------
SharedTexCapture hooked
Using RTMP service: Twitch / Justin.tv
  Server selection: rtmp://live-iad.justin.tv/app
bufferTime: 1516, outputRateWindowTime: 1000, dropThreshold: 2016
SharedTexCapture hooked
Total frames rendered: 11019, number of frames that lagged: 13 (0.12%) (it's okay for some frames to lag)
RTMPPublisher::SocketLoop: Aborting due to bStopping
Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
=====Stream End=======================================================================

Profiler results:

==============================================================
frame - [100%] [avg time: 2.123 ms] [avg calls per frame: 1] [children: 82.9%] [unaccounted: 17.1%]
| scene->Preprocess - [0.236%] [avg time: 0.005 ms] [avg calls per frame: 1]
| video encoding and uploading - [82.7%] [avg time: 1.756 ms] [avg calls per frame: 1] [children: 42%] [unaccounted: 40.7%]
| | CopyResource - [0.895%] [avg time: 0.019 ms] [avg calls per frame: 0]
| | conversion to 4:2:0 - [0.188%] [avg time: 0.004 ms] [avg calls per frame: 0]
| | call to encoder - [40.2%] [avg time: 0.854 ms] [avg calls per frame: 0]
| | sending stuff out - [0.707%] [avg time: 0.015 ms] [avg calls per frame: 0]
==============================================================

Memory Leaks Were Detected.

My speed: http://www.speedtest.net/result/2443601304.png

Any help would be greatly apprecited!
 

Warchamp7

Forum Admin
I watched a couple minutes of your VOD and it looked fine, do you have any specific examples of this stuttering? Like a timestamp in the VOD
 

dramabomb

Member
Near the end of the video, when I'm in the Lower Prison. Maybe the last 8 minutes? I am just seeing a lot of micro-stutters, but it may be because I am not a Twitch partner and not allotted proper bandwidth. I know I can definitely handle 60fps, so I am confused as to why I'm seeing buffer full and frame drops.
 

Warchamp7

Forum Admin
Glad to hear that. As a note, frame drops occur when your connection can't handle what you're trying to output. Could be your connection just being too saturated for a quick moment. You have a really low amount of frame drops though, so it's nothing to be worried about.
 

dramabomb

Member
With 10mbps up, I would assume that I could handle a measly 3k bitrate/buffer. I had it at 3500 before, but decided to drop it because I don't think I need that extra 500 for 720p.

Even if I do have p/b frame drops, as long as they're very low, that's okay? I may experiment more with a slightly higher bitrate for more clarity in the picture, but I don't think I'm going to move it from Quality 8. I doubt I'd see much improvement at all.
 

dodgepong

Administrator
Community Helper
Yeah, if they're really low, that's fine. 378 frames dropped out of 276216 is very very little. My guess is that something might have caused your network connection to slowed for just a moment, and while that happened you dropped a few seconds worth of frames, and that's it.
 

DAOWAce

Member
Video isn't 60 FPS in some places (drops to low 50's, mid 40's), but other than that I don't really see any problems.

I suffer the same kind of thing sometimes; don't know why; I just assume it's a congestion issue with the streaming service.

I also can't do 1080p60 for some reason despite my CPU/GPU never maxing out; sometimes not even being close. Network connection isn't maxing out either. Just another issue I can't figure out the cause of.
 

dramabomb

Member
Yeah, it's odd, isn't it? I've checked my logs for my connection and it's not even close to being maxed out. I think it's an unfortunate issue of streaming. You're going to run into issues without any explanation or fix.

Personally, I blame Twitch.

Another video of 60fps test: http://www.twitch.tv/thedigitalbench/b/358245673

The log:
Code:
Open Broadcaster Software v0.466a - 32bit (´・ω・`)
-------------------------------
CPU Name: Intel(R) Core(TM) i5-2500K CPU @ 3.30GHz
CPU Speed: 3300MHz
Physical Memory:  4095MB Total, 4095MB Free
stepping id: 7, model 10, family 6, type 0, extmodel 1, extfamily 0, HTT 1, logical cores 4, total cores 4
Windows Version: 6.1 Build 7601 S
Aero is Disabled
------------------------------------------
Adapter 1
  Video Adapter: NVIDIA GeForce GTX 560 Ti  
  Video Adapter Dedicated Video Memory: 1025966080
  Video Adapter Shared System Memory: 3221106688
=====Stream Start=====================================================================
  Multithreaded optimizations: On
  Base resolution: 1920x1080
  Output resolution: 1280x720
------------------------------------------
Loading up D3D10...
------------------------------------------
Audio Encoding: AAC
    bitrate: 128
Using graphics capture
------------------------------------------
Video Encoding: x264
    fps: 60
    width: 1280, height: 720
    preset: veryfast
    CBR: no
    max bitrate: 3300
    buffer size: 3300
    quality: 8
------------------------------------------
SharedTexCapture hooked
Using RTMP service: Twitch / Justin.tv
  Server selection: rtmp://live-iad-backup.justin.tv/app
bufferTime: 1714, outputRateWindowTime: 1000, dropThreshold: 2214
RTMPPublisher::BufferedSend: Buffer is full (435106 / 438272 bytes), waiting to send 4097 bytes
RTMPPublisher::BufferedSend: Buffer is full (435106 / 438272 bytes), waiting to send 4097 bytes
RTMPPublisher::BufferedSend: Buffer is full (437252 / 438272 bytes), waiting to send 1663 bytes
RTMPPublisher::BufferedSend: Buffer is full (437252 / 438272 bytes), waiting to send 1663 bytes
RTMPPublisher::BufferedSend: Buffer is full (435729 / 438272 bytes), waiting to send 3412 bytes
RTMPPublisher::BufferedSend: Buffer is full (435729 / 438272 bytes), waiting to send 3412 bytes
RTMPPublisher::BufferedSend: Buffer is full (435936 / 438272 bytes), waiting to send 2423 bytes
RTMPPublisher::BufferedSend: Buffer is full (435936 / 438272 bytes), waiting to send 2423 bytes
RTMPPublisher::BufferedSend: Buffer is full (436685 / 438272 bytes), waiting to send 4097 bytes
RTMPPublisher::BufferedSend: Buffer is full (436685 / 438272 bytes), waiting to send 4097 bytes
RTMPPublisher::BufferedSend: Buffer is full (437942 / 438272 bytes), waiting to send 4104 bytes
RTMPPublisher::BufferedSend: Buffer is full (437942 / 438272 bytes), waiting to send 4104 bytes
RTMPPublisher::BufferedSend: Buffer is full (435912 / 438272 bytes), waiting to send 4097 bytes
RTMPPublisher::BufferedSend: Buffer is full (435912 / 438272 bytes), waiting to send 4097 bytes
RTMPPublisher::BufferedSend: Buffer is full (435640 / 438272 bytes), waiting to send 4104 bytes
Total frames rendered: 100159, number of frames that lagged: 27 (0.03%) (it's okay for some frames to lag)
RTMPPublisher::SocketLoop: Aborting due to bStopping
Number of b-frames dropped: 58 (0.034%), Number of p-frames dropped: 62 (0.036%), Total 120 (0.07%)
=====Stream End=======================================================================

Profiler results:

==============================================================
frame - [100%] [avg time: 2.005 ms] [avg calls per frame: 1] [children: 82.5%] [unaccounted: 17.5%]
| scene->Preprocess - [0.2%] [avg time: 0.004 ms] [avg calls per frame: 1]
| video encoding and uploading - [82.3%] [avg time: 1.651 ms] [avg calls per frame: 1] [children: 44.9%] [unaccounted: 37.4%]
| | CopyResource - [0.898%] [avg time: 0.018 ms] [avg calls per frame: 0]
| | conversion to 4:2:0 - [0.2%] [avg time: 0.004 ms] [avg calls per frame: 0]
| | call to encoder - [43.1%] [avg time: 0.864 ms] [avg calls per frame: 0]
| | sending stuff out - [0.748%] [avg time: 0.015 ms] [avg calls per frame: 0]
==============================================================

I really don't understand the full buffer stuff. It's not my connection at all.
 

dramabomb

Member
Code:
DiffProbe release. January 2012. Build 1008.
Shaper Detection Module.

Connected to server 217.163.1.74.

Estimating capacity:
Upstream: 3481 Kbps.
Downstream: 116377 Kbps.

The measurement will take upto 3.0 minutes. Please wait.

Checking for traffic shapers:

Upstream: No shaper detected.
Median received rate: 3434 Kbps.

Downstream: No shaper detected.
Median received rate: 52826 Kbps.

For more information, visit: http://www.cc.gatech.edu/~partha/diffprobe

I'm supposed to have 10mbps upload. What's up with this? When I upload Youtube videos it's super fast. Is this actually telling me I have 3mbps upload? I have a Netgear WNDR3700v4 router with the latest firmware.
 

dramabomb

Member
Code:
DiffProbe release. January 2012. Build 1008.
Shaper Detection Module.

Connected to server 4.71.251.175.

Estimating capacity:
Upstream: 10832 Kbps.
Downstream: 105518 Kbps.

The measurement will take upto 2.5 minutes. Please wait.

Checking for traffic shapers:

Upstream: No shaper detected.
Median received rate: 10640 Kbps.

Downstream: No shaper detected.
Median received rate: 53237 Kbps.

For more information, visit: http://www.cc.gatech.edu/~partha/diffprobe

I ran it again and this looks much better.
 

Krazy

Town drunk
Well, the first shaper probe test was to a server in the UK, the second one was to a server in Kansas City. This likely explains the discrepancy. Anyway, as long as you are streaming the the NYC or the Ashburn servers, you shouldn't have network congestion issues.

edit: oh, I see your last log was indeed to the Ashburn secondary. Very odd. It could just be something over the last couple of days, both Ashburn servers are generally quite amazing. You should try one of the other NA servers whenever you have network congestion issues, though. You never know when a server is gonna have a bad day
 

dramabomb

Member
So long as it's nothing on my end, I'm content with minor issues sometimes. I usually switch off from VA/VA Secondary. NY doesn't ping well for me.
 

dramabomb

Member
I just ran another Shaperprobe and it gave me a 1.5mbps upload. What's the deal here? Is this my router not doing its job?

Edit: Ran it again, 1358kbps up. lol. I guess I have to return the router.
 

Krazy

Town drunk
As you can probably see, the shaper probe tool uses a different server every time, so you have to be aware of the location it's using in these tests as well.

The important bit you are looking for is "No shaper detected" which means "your ISP is not lying about the speeds you are paying to get". Obviously, true network throughput is affected by distance.
 

dramabomb

Member
That's a good point. I guess I won't go through the trouble of switching anything. The buffer stuff concerns me, but it could have nothing to do with things on my end. It doesn't happen every time either.
 
Top