Question / Help Just Making Sure - Please look at my log.

P

p4ck3tl055

New Member
Just so I can confirm my suspicions that my streaming problem is being caused by my Internet connection, can someone look over the log below and see what is causing about 20% dropped frames nearly every time I stream.

Obviously, if there are any other issues you see, please point those out too. :)

Here's the Archived Replay of the stream for the log: http://www.twitch.tv/p4ck3tl055/b/486285231

Thanks in advance.

(The i5 @3.4GHz below is wrong, I've got it overclocked to 4.4GHz.)


22:43:45: Open Broadcaster Software v0.584b - 64bit (　^ω^)
22:43:45: -------------------------------
22:43:45: CPU Name: Intel(R) Core(TM) i5-3570K CPU @ 3.40GHz
22:43:45: CPU Speed: 3400MHz
22:43:45: Physical Memory: 16269MB Total, 9924MB Free
22:43:45: stepping id: 9, model 58, family 6, type 0, extmodel 1, extfamily 0, HTT 1, logical cores 4, total cores 4
22:43:45: monitor 1: pos={0, 0}, size={1920, 1080}
22:43:45: monitor 2: pos={1920, 0}, size={1920, 1200}
22:43:45: Windows Version: 6.1 Build 7601 S
22:43:45: Aero is Enabled
22:43:45: -------------------------------
22:43:45: OBS Modules:
22:43:45: Base Address Module
22:43:45: 000000003FFB0000 OBS.exe
22:43:45: 00000000E29E0000 OBSApi.dll
22:43:45: 00000000FA6D0000 DShowPlugin.dll
22:43:45: 00000000FA690000 GraphicsCapture.dll
22:43:45: 00000000FA670000 NoiseGate.dll
22:43:45: 00000000FA650000 PSVPlugin.dll
22:43:45: ------------------------------------------
22:43:45: Adapter 1
22:43:45: Video Adapter: NVIDIA GeForce GTX 660
22:43:45: Video Adapter Dedicated Video Memory: 2086469632
22:43:45: Video Adapter Shared System Memory: 2147807232
22:43:45: Video Adapter Output 1: pos={0, 0}, size={1920, 1080}, attached=true
22:43:45: Video Adapter Output 2: pos={1920, 0}, size={1920, 1200}, attached=true
22:43:45: ------------------------------------------
22:43:45: Adapter 2
22:43:45: Video Adapter: Intel(R) HD Graphics 4000
22:43:45: Video Adapter Dedicated Video Memory: 67108864
22:43:45: Video Adapter Shared System Memory: 1711276032
22:43:45: =====Stream Start: 2013-12-09, 22:43:45===============================================
22:43:45: Multithreaded optimizations: On
22:43:45: Base resolution: 1920x1080
22:43:45: Output resolution: 1280x720
22:43:45: ------------------------------------------
22:43:45: Loading up D3D10 on NVIDIA GeForce GTX 660...
22:43:45: ------------------------------------------
22:43:45: Audio Format: 48000hz
22:43:45: Playback device Default
22:43:45: ------------------------------------------
22:43:45: Using desktop audio input: Speakers (Realtek High Definition Audio)
22:43:45: ------------------------------------------
22:43:45: Using auxilary audio input: Microphone (Realtek High Definition Audio)
22:43:45: ------------------------------------------
22:43:45: Audio Encoding: AAC
22:43:45: bitrate: 128
22:43:45: ------------------------------------------
22:43:45: device: Logitech HD Pro Webcam C910,
22:43:45: device id \\?\usb#vid_046d&pid_0821&mi_02#8&1f9d81a6&0&0002#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
22:43:45: chosen type: I420, usingFourCC: false, res: 960x720 - 960x720, frameIntervals: 333333-2000000
22:43:45: use buffering: false - 0, fourCC: 'I420'
22:43:45: audio device: Disable,
22:43:45: audio device id Disabled,
22:43:45:
22:43:45: Using directshow input
22:43:45: Using graphics capture
22:43:46: Scene buffering time set to 400
22:43:46: ------------------------------------------
22:43:46: Video Encoding: x264
22:43:46: fps: 30
22:43:46: width: 1280, height: 720
22:43:46: preset: veryfast
22:43:46: profile: high
22:43:46: keyint: 60
22:43:46: CBR: yes
22:43:46: CFR: yes
22:43:46: max bitrate: 2500
22:43:46: buffer size: 2500
22:43:46: ------------------------------------------
22:43:46: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
22:43:46: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
22:43:46: SharedTexCapture hooked
22:43:47: Using RTMP service: Twitch / Justin.tv
22:43:47: Server selection: rtmp://live-ord.justin.tv/app
22:43:47: Interface: Broadcom NetLink (TM) Gigabit Ethernet (ethernet, 100 mbps)
22:43:48: Completed handshake with rtmp://live-ord.justin.tv/app in 233 ms.
22:43:48: SO_SNDBUF was at 8192
22:43:48: SO_SNDBUF is now 65536
22:43:50: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 89485 / 335872)
22:43:50: GraphicsCaptureSource::NewCapture: eliminating old capture
22:43:50: SharedTexCapture hooked
22:44:45: Capture window 0x004A00E0 invalid or changing, terminating capture
22:44:55: RTMPPublisher::SocketLoop: Stalled for 1577 ms to write 332614 bytes (buffer: 0 / 335872), unstable connection?
22:44:56: RTMPPublisher::SocketLoop: Stalled for 1578 ms to write 333085 bytes (buffer: 0 / 335872), unstable connection?
22:45:01: SharedTexCapture hooked
22:45:42: ------------------------------------------
22:45:42: device: Logitech HD Pro Webcam C910,
22:45:42: device id \\?\usb#vid_046d&pid_0821&mi_02#8&1f9d81a6&0&0002#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
22:45:42: chosen type: I420, usingFourCC: false, res: 960x720 - 960x720, frameIntervals: 333333-2000000
22:45:42: use buffering: false - 0, fourCC: 'I420'
22:45:42: audio device: Disable,
22:45:42: audio device id Disabled,
22:45:42:
22:45:48: GraphicsCaptureSource::NewCapture: eliminating old capture
22:45:48: SharedTexCapture hooked
22:46:18: GraphicsCaptureSource::NewCapture: eliminating old capture
22:46:18: SharedTexCapture hooked
22:46:55: GraphicsCaptureSource::NewCapture: eliminating old capture
22:46:55: SharedTexCapture hooked
22:50:43: RTMPPublisher::SocketLoop: Stalled for 1589 ms to write 335333 bytes (buffer: 0 / 335872), unstable connection?
22:57:14: GraphicsCaptureSource::NewCapture: eliminating old capture
22:57:14: SharedTexCapture hooked
23:03:17: RTMPPublisher::SocketLoop: Stalled for 1582 ms to write 333961 bytes (buffer: 0 / 335872), unstable connection?
23:05:48: RTMPPublisher::SocketLoop: Stalled for 1607 ms to write 333649 bytes (buffer: 0 / 335872), unstable connection?
23:07:58: Total frames encoded: 43564, total frames duplicated: 80 (0.18%)
23:07:58: Total frames rendered: 43544, number of late frames: 4 (0.01%) (it's okay for some frames to be late)
23:08:00: RTMPPublisher::SocketLoop: Graceful loop exit
23:08:02: Average send payload: 295233 bytes, average send interval: 1046 ms
23:08:02: Number of times waited to send: 1201, Waited for a total of 4475369 bytes
23:08:02: Number of b-frames dropped: 2778 (6.4%), Number of p-frames dropped: 6199 (14%), Total 8977 (21%)
23:08:02: Number of bytes sent: 409193151
23:08:02:
23:08:02: Profiler time results:
23:08:02:
23:08:02: ==============================================================
23:08:02: video thread frame - [100%] [avg time: 0.705 ms] [children: 24.5%] [unaccounted: 75.5%]
23:08:02: | scene->Preprocess - [5.25%] [avg time: 0.037 ms]
23:08:02: | GPU download and conversion - [19.3%] [avg time: 0.136 ms] [children: 12.5%] [unaccounted: 6.81%]
23:08:02: | | flush - [10.1%] [avg time: 0.071 ms]
23:08:02: | | CopyResource - [2.27%] [avg time: 0.016 ms]
23:08:02: | | conversion to 4:2:0 - [0.142%] [avg time: 0.001 ms]
23:08:02: Convert444Threads - [100%] [avg time: 0.339 ms] [children: 97.6%] [unaccounted: 2.36%]
23:08:02: | Convert444toNV12 - [97.6%] [avg time: 0.331 ms]
23:08:02: encoder thread frame - [100%] [avg time: 0.746 ms]
23:08:02: ==============================================================
23:08:02:
23:08:02:
23:08:02: Profiler CPU results:
23:08:02:
23:08:02: ==============================================================
23:08:02: video thread frame - [cpu time: avg 0.073 ms, total 3198.02 ms] [avg calls per frame: 1]
23:08:02: | scene->Preprocess - [cpu time: avg 0 ms, total 31.2 ms] [avg calls per frame: 1]
23:08:02: | GPU download and conversion - [cpu time: avg 0.013 ms, total 577.203 ms] [avg calls per frame: 1]
23:08:02: | | flush - [cpu time: avg 0.008 ms, total 358.802 ms] [avg calls per frame: 1]
23:08:02: | | CopyResource - [cpu time: avg 0.002 ms, total 124.801 ms] [avg calls per frame: 1]
23:08:02: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 31.2 ms] [avg calls per frame: 1]
23:08:02: Convert444Threads - [cpu time: avg 0.205 ms, total 17877.7 ms] [avg calls per frame: 2]
23:08:02: | Convert444toNV12 - [cpu time: avg 0.202 ms, total 17659.3 ms] [avg calls per frame: 2]
23:08:02: encoder thread frame - [cpu time: avg 0.044 ms, total 1918.81 ms] [avg calls per frame: 1]
23:08:02: ==============================================================
23:08:02:
23:08:02: =====Stream End: 2013-12-09, 23:08:02=================================================
23:08:21: =====Stream Start: 2013-12-09, 23:08:21===============================================
23:08:21: Multithreaded optimizations: On
23:08:21: Base resolution: 1920x1080
23:08:21: Output resolution: 1280x720
23:08:21: ------------------------------------------
23:08:21: Loading up D3D10 on NVIDIA GeForce GTX 660...
23:08:21: ------------------------------------------
23:08:21: Audio Format: 48000hz
23:08:21: Playback device Default
23:08:21: ------------------------------------------
23:08:21: Using desktop audio input: Speakers (Realtek High Definition Audio)
23:08:21: ------------------------------------------
23:08:21: Using auxilary audio input: Microphone (Realtek High Definition Audio)
23:08:21: ------------------------------------------
23:08:21: Audio Encoding: AAC
23:08:21: bitrate: 128
23:08:21: Using graphics capture
23:08:21: Scene buffering time set to 400
23:08:21: ------------------------------------------
23:08:21: Video Encoding: x264
23:08:21: fps: 30
23:08:21: width: 1280, height: 720
23:08:21: preset: veryfast
23:08:21: profile: high
23:08:21: keyint: 60
23:08:21: CBR: yes
23:08:21: CFR: yes
23:08:21: max bitrate: 2500
23:08:21: buffer size: 2500
23:08:21: ------------------------------------------
23:08:21: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
23:08:21: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
23:08:30: Total frames encoded: 256, total frames duplicated: 0 (0.00%)
23:08:30: Total frames rendered: 261, number of late frames: 1 (0.38%) (it's okay for some frames to be late)
23:08:30:
23:08:30: Profiler time results:
23:08:30:
23:08:30: ==============================================================
23:08:30: video thread frame - [100%] [avg time: 1.04 ms] [children: 7.88%] [unaccounted: 92.1%]
23:08:30: | scene->Preprocess - [0.0962%] [avg time: 0.001 ms]
23:08:30: | GPU download and conversion - [7.79%] [avg time: 0.081 ms] [children: 7.31%] [unaccounted: 0.481%]
23:08:30: | | flush - [5.1%] [avg time: 0.053 ms]
23:08:30: | | CopyResource - [2.02%] [avg time: 0.021 ms]
23:08:30: | | conversion to 4:2:0 - [0.192%] [avg time: 0.002 ms]
23:08:30: Convert444Threads - [100%] [avg time: 0.452 ms] [children: 99.1%] [unaccounted: 0.885%]
23:08:30: | Convert444toNV12 - [99.1%] [avg time: 0.448 ms]
23:08:30: encoder thread frame - [100%] [avg time: 0.996 ms]
23:08:30: ==============================================================
23:08:30:
23:08:30:
23:08:30: Profiler CPU results:
23:08:30:
23:08:30: ==============================================================
23:08:30: video thread frame - [cpu time: avg 0.358 ms, total 93.6 ms] [avg calls per frame: 1]
23:08:30: | scene->Preprocess - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
23:08:30: | GPU download and conversion - [cpu time: avg 0.059 ms, total 15.6 ms] [avg calls per frame: 1]
23:08:30: | | flush - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
23:08:30: | | CopyResource - [cpu time: avg 0.063 ms, total 15.6 ms] [avg calls per frame: 1]
23:08:30: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
23:08:30: Convert444Threads - [cpu time: avg 0.477 ms, total 234 ms] [avg calls per frame: 2]
23:08:30: | Convert444toNV12 - [cpu time: avg 0.477 ms, total 234 ms] [avg calls per frame: 2]
23:08:30: encoder thread frame - [cpu time: avg 0.575 ms, total 140.4 ms] [avg calls per frame: 1]
23:08:30: ==============================================================
23:08:30:
23:08:30: =====Stream End: 2013-12-09, 23:08:30=================================================


Last game capture log:
2013-12-09, 22:45:01: we're booting up:
22:45:01: D3D9 Present
22:45:01: (half life scientist) everything.. seems to be in order
22:45:01: D3D9EndScene called
22:45:01: D3DPRESENT_PARAMETERS {
22:45:01: BackBufferWidth: 1920
22:45:01: BackBufferHeight: 1080
22:45:01: BackBufferFormat: D3DFMT_A8R8G8B8
22:45:01: BackBufferCount: 1
22:45:01: MultiSampleType: D3DMULTISAMPLE_NONE
22:45:01: MultiSampleQuality: 0
22:45:01: SwapEffect: D3DSWAPEFFECT_DISCARD
22:45:01: hDeviceWindow: 3737914
22:45:01: Windowed: false
22:45:01: EnableAutoDepthStencil: false
22:45:01: AutoDepthStencilFormat: D3DFMT_UNKNOWN
22:45:01: Flags: None
22:45:01: FullScreen_RefreshRateInHz: 59
22:45:01: PresentationInterval: 2147483648
22:45:01: };
22:45:01: successfully set up d3d9 hooks
22:45:01: D3D9SwapPresent called
22:45:01: DoD3D9GPUHook: success
22:45:02: D3DSURFACE_DESC {
22:45:02: Format: D3DFMT_A8R8G8B8
22:45:02: Type: D3DRTYPE_SURFACE
22:45:02: Usage: D3DUSAGE_RENDERTARGET
22:45:02: Pool: D3DPOOL_DEFAULT
22:45:02: MultiSampleType: D3DMULTISAMPLE_NONE
22:45:02: MultiSampleQuality: 0
22:45:02: Width: 1920
22:45:02: Height: 1080
22:45:02: };
22:45:02: successfully capturing d3d9 frames via GPU
22:45:48: D3D9Reset called
22:45:48: ---------------------- Cleared D3D9 Capture ----------------------
22:45:48: successfully set up d3d9 hooks
22:45:48: D3D9Reset called
22:45:48: ---------------------- Cleared D3D9 Capture ----------------------
22:45:48: successfully set up d3d9 hooks
22:45:48: D3D9EndScene called
22:45:48: D3D9SwapPresent called
22:45:48: DoD3D9GPUHook: success
22:45:48: D3DSURFACE_DESC {
22:45:48: Format: D3DFMT_A8R8G8B8
22:45:48: Type: D3DRTYPE_SURFACE
22:45:48: Usage: D3DUSAGE_RENDERTARGET
22:45:48: Pool: D3DPOOL_DEFAULT
22:45:48: MultiSampleType: D3DMULTISAMPLE_NONE
22:45:48: MultiSampleQuality: 0
22:45:48: Width: 1920
22:45:48: Height: 1080
22:45:48: };
22:45:48: successfully capturing d3d9 frames via GPU
22:46:18: D3D9Reset called
22:46:18: ---------------------- Cleared D3D9 Capture ----------------------
22:46:18: successfully set up d3d9 hooks
22:46:18: D3D9Reset called
22:46:18: ---------------------- Cleared D3D9 Capture ----------------------
22:46:18: successfully set up d3d9 hooks
22:46:18: D3D9EndScene called
22:46:18: D3D9SwapPresent called
22:46:18: DoD3D9GPUHook: success
22:46:18: D3DSURFACE_DESC {
22:46:18: Format: D3DFMT_A8R8G8B8
22:46:18: Type: D3DRTYPE_SURFACE
22:46:18: Usage: D3DUSAGE_RENDERTARGET
22:46:18: Pool: D3DPOOL_DEFAULT
22:46:18: MultiSampleType: D3DMULTISAMPLE_NONE
22:46:18: MultiSampleQuality: 0
22:46:18: Width: 1920
22:46:18: Height: 1080
22:46:18: };
22:46:18: successfully capturing d3d9 frames via GPU
22:46:55: D3D9Reset called
22:46:55: ---------------------- Cleared D3D9 Capture ----------------------
22:46:55: successfully set up d3d9 hooks
22:46:55: D3D9Reset called
22:46:55: ---------------------- Cleared D3D9 Capture ----------------------
22:46:55: successfully set up d3d9 hooks
22:46:55: D3D9EndScene called
22:46:55: D3D9SwapPresent called
22:46:55: DoD3D9GPUHook: success
22:46:55: D3DSURFACE_DESC {
22:46:55: Format: D3DFMT_A8R8G8B8
22:46:55: Type: D3DRTYPE_SURFACE
22:46:55: Usage: D3DUSAGE_RENDERTARGET
22:46:55: Pool: D3DPOOL_DEFAULT
22:46:55: MultiSampleType: D3DMULTISAMPLE_NONE
22:46:55: MultiSampleQuality: 0
22:46:55: Width: 1920
22:46:55: Height: 1080
22:46:55: };
22:46:55: successfully capturing d3d9 frames via GPU
22:57:12: D3D9Reset called
22:57:13: ---------------------- Cleared D3D9 Capture ----------------------
22:57:13: successfully set up d3d9 hooks
22:57:13: D3D9Reset called
22:57:13: ---------------------- Cleared D3D9 Capture ----------------------
22:57:13: successfully set up d3d9 hooks
22:57:14: D3D9EndScene called
22:57:14: D3D9SwapPresent called
22:57:14: DoD3D9GPUHook: success
22:57:14: D3DSURFACE_DESC {
22:57:14: Format: D3DFMT_A8R8G8B8
22:57:14: Type: D3DRTYPE_SURFACE
22:57:14: Usage: D3DUSAGE_RENDERTARGET
22:57:14: Pool: D3DPOOL_DEFAULT
22:57:14: MultiSampleType: D3DMULTISAMPLE_NONE
22:57:14: MultiSampleQuality: 0
22:57:14: Width: 1920
22:57:14: Height: 1080
22:57:14: };
22:57:14: successfully capturing d3d9 frames via GPU
23:07:58: ---------------------- Cleared D3D9 Capture ----------------------
23:07:58: D3D9EndScene called
23:07:58: D3D9SwapPresent called
 
I

Icenine63

New Member
What kind of internet do you have, what is your bitrate set at?

OBS Log Analyzer

Multiple video cards detected
If you are having problems and are using a laptop, see this thread for advice.

If you are using SLI or Crossfire, you may need to disable it for compatibility with OBS.

Dropped frames detected
21% of your frames were dropped due to poor network conditions. Frames are dropped when data can not be sent fast enough to the server you have selected. This is caused by trying to stream at too high of a bitrate, or by the streaming server you selected not being able to accept the data at the rate you are sending.

Try switching servers, especially if you are using twitch.tv. As a test, you could also try streaming to a different provider to check whether the problem is on your end or not.

Note that some ISPs will temporarily increase your upload speed at the start of a transfer - if you only start to drop frames after 30 - 60 seconds, your ISP is likely doing this and you will need to use a lower bitrate.

Finally, if you are using a wireless connection, keep in mind that interference from other radio sources can cause your connection to stutter and drop frames. A wired connection is strongly recommended when streaming.

2 issues found (1 major, 1 minor).
 
P

p4ck3tl055

New Member
My Internet connection is 20mb down/2mb up cable with TimeWarner. I used "jtvping" to determine the best server. But not tried any others. I've set my bitrate to 2500 as suggested by Twitch for the 720p stream.

Last night was the very first time that I've streamed, so I just used what I found for settings. My concern is that the 2mb up speed is the primary problem. If it is, then I'm probably done streaming as the next step up in speed from TimeWarner is out of my budget reach.
 
ThoNohT

ThoNohT

Developer
2500 is more than 2mb, that's 2.5mb. So your connection should not be able to handle that. You always want to stay a bit below what your connection can handle, definitely not above it.

720p should still be possible if you set it to around 1500kbps in stead. Depending on what game you are playing. If it doesn't look good, you could downscale a bit more, and just stream at a lower resolution.
 
P

p4ck3tl055

New Member
So tonight I dropped my bitrate to 1800 and, as far as I can tell, had 0 dropped frames. I did however experience two weird things:

1). When I first start the stream, the game (Starcraft 2) minimizes itself. It's still running, I can switch back and everything is fine...except for the 20-30 seconds of black screen at the beginning of the stream. (This is not a big issue for me. Just wanted to bring it to the developer's attention. Because it happens everytime I start to stream.)

2). The one issue I do have is that about 10 minutes into the stream (time varies), the stream crashes. OBS recovers, but it lags my computer out and breaks the stream. After the initial crash, the stream was solid and, to my eyes, worked very well.

Here is the entire log from tonight's sessions: (I started and restarted a few times just adjusting things, but I started to stream non-stop around 9pm eastern time.)

18:13:26: Open Broadcaster Software v0.584b - 64bit (　^ω^)
18:13:26: -------------------------------
18:13:26: CPU Name: Intel(R) Core(TM) i5-3570K CPU @ 3.40GHz
18:13:26: CPU Speed: 3400MHz
18:13:26: Physical Memory: 16269MB Total, 12443MB Free
18:13:26: stepping id: 9, model 58, family 6, type 0, extmodel 1, extfamily 0, HTT 1, logical cores 4, total cores 4
18:13:26: monitor 1: pos={0, 0}, size={1920, 1080}
18:13:26: monitor 2: pos={1920, 0}, size={1920, 1200}
18:13:26: Windows Version: 6.1 Build 7601 S
18:13:26: Aero is Enabled
18:13:26: -------------------------------
18:13:26: OBS Modules:
18:13:26: Base Address Module
18:13:26: 000000003F3E0000 OBS.exe
18:13:26: 00000000E4670000 OBSApi.dll
18:13:26: 00000000F6930000 DShowPlugin.dll
18:13:26: 00000000F5670000 GraphicsCapture.dll
18:13:26: 00000000F6990000 NoiseGate.dll
18:13:26: 00000000F5650000 PSVPlugin.dll
18:13:26: ------------------------------------------
18:13:26: Adapter 1
18:13:26: Video Adapter: NVIDIA GeForce GTX 660
18:13:26: Video Adapter Dedicated Video Memory: 2086469632
18:13:26: Video Adapter Shared System Memory: 2147807232
18:13:26: Video Adapter Output 1: pos={0, 0}, size={1920, 1080}, attached=true
18:13:26: Video Adapter Output 2: pos={1920, 0}, size={1920, 1200}, attached=true
18:13:26: ------------------------------------------
18:13:26: Adapter 2
18:13:26: Video Adapter: Intel(R) HD Graphics 4000
18:13:26: Video Adapter Dedicated Video Memory: 67108864
18:13:26: Video Adapter Shared System Memory: 1711276032
18:13:26: =====Stream Start: 2013-12-10, 18:13:26===============================================
18:13:26: Multithreaded optimizations: On
18:13:26: Base resolution: 1920x1080
18:13:26: Output resolution: 1280x720
18:13:26: ------------------------------------------
18:13:26: Loading up D3D10 on NVIDIA GeForce GTX 660...
18:13:27: ------------------------------------------
18:13:27: Audio Format: 48000hz
18:13:27: Playback device Default
18:13:27: ------------------------------------------
18:13:27: Using desktop audio input: Speakers (Realtek High Definition Audio)
18:13:27: ------------------------------------------
18:13:27: Using auxilary audio input: Microphone (Realtek High Definition Audio)
18:13:27: ------------------------------------------
18:13:27: Audio Encoding: AAC
18:13:27: bitrate: 128
18:13:27: ------------------------------------------
18:13:27: device: Logitech HD Pro Webcam C910,
18:13:27: device id \\?\usb#vid_046d&pid_0821&mi_02#8&1f9d81a6&0&0002#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
18:13:27: chosen type: I420, usingFourCC: false, res: 960x720 - 960x720, frameIntervals: 333333-2000000
18:13:27: use buffering: false - 0, fourCC: 'I420'
18:13:27: audio device: Disable,
18:13:27: audio device id Disabled,
18:13:27:
18:13:27: Using directshow input
18:13:27: Using graphics capture
18:13:28: Scene buffering time set to 400
18:13:28: ------------------------------------------
18:13:28: Video Encoding: x264
18:13:28: fps: 30
18:13:28: width: 1280, height: 720
18:13:28: preset: veryfast
18:13:28: profile: high
18:13:28: keyint: 60
18:13:28: CBR: yes
18:13:28: CFR: yes
18:13:28: max bitrate: 1800
18:13:28: buffer size: 1800
18:13:28: ------------------------------------------
18:13:28: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
18:13:28: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
18:13:50: ------------------------------------------
18:13:50: device: Logitech HD Pro Webcam C910,
18:13:50: device id \\?\usb#vid_046d&pid_0821&mi_02#8&1f9d81a6&0&0002#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
18:13:50: chosen type: I420, usingFourCC: false, res: 960x720 - 960x720, frameIntervals: 333333-2000000
18:13:50: use buffering: false - 0, fourCC: 'I420'
18:13:50: audio device: Disable,
18:13:50: audio device id Disabled,
18:13:50:
18:13:55: Total frames encoded: 803, total frames duplicated: 22 (2.74%)
18:13:55: Total frames rendered: 786, number of late frames: 1 (0.13%) (it's okay for some frames to be late)
18:13:55:
18:13:55: Profiler time results:
18:13:55:
18:13:55: ==============================================================
18:13:55: video thread frame - [100%] [avg time: 2.015 ms] [children: 21%] [unaccounted: 79%]
18:13:55: | scene->Preprocess - [16.2%] [avg time: 0.327 ms]
18:13:55: | GPU download and conversion - [4.81%] [avg time: 0.097 ms] [children: 3.57%] [unaccounted: 1.24%]
18:13:55: | | flush - [2.48%] [avg time: 0.05 ms]
18:13:55: | | CopyResource - [0.993%] [avg time: 0.02 ms]
18:13:55: | | conversion to 4:2:0 - [0.0993%] [avg time: 0.002 ms]
18:13:55: Convert444Threads - [100%] [avg time: 0.43 ms] [children: 99.3%] [unaccounted: 0.698%]
18:13:55: | Convert444toNV12 - [99.3%] [avg time: 0.427 ms]
18:13:55: encoder thread frame - [100%] [avg time: 0.923 ms]
18:13:55: ==============================================================
18:13:55:
18:13:55:
18:13:55: Profiler CPU results:
18:13:55:
18:13:55: ==============================================================
18:13:55: video thread frame - [cpu time: avg 0.615 ms, total 483.603 ms] [avg calls per frame: 1]
18:13:55: | scene->Preprocess - [cpu time: avg 0.059 ms, total 46.8 ms] [avg calls per frame: 1]
18:13:55: | GPU download and conversion - [cpu time: avg 0.039 ms, total 31.201 ms] [avg calls per frame: 1]
18:13:55: | | flush - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
18:13:55: | | CopyResource - [cpu time: avg 0.02 ms, total 15.6 ms] [avg calls per frame: 1]
18:13:55: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
18:13:55: Convert444Threads - [cpu time: avg 0.333 ms, total 514.802 ms] [avg calls per frame: 2]
18:13:55: | Convert444toNV12 - [cpu time: avg 0.333 ms, total 514.802 ms] [avg calls per frame: 2]
18:13:55: encoder thread frame - [cpu time: avg 0.354 ms, total 280.801 ms] [avg calls per frame: 1]
18:13:55: ==============================================================
18:13:55:
18:13:55: =====Stream End: 2013-12-10, 18:13:55=================================================
18:16:37: =====Stream Start: 2013-12-10, 18:16:37===============================================
18:16:37: Multithreaded optimizations: On
18:16:37: Base resolution: 1920x1080
18:16:37: Output resolution: 1280x720
18:16:37: ------------------------------------------
18:16:37: Loading up D3D10 on NVIDIA GeForce GTX 660...
18:16:37: ------------------------------------------
18:16:37: Audio Format: 48000hz
18:16:37: Playback device Default
18:16:37: ------------------------------------------
18:16:37: Using desktop audio input: Speakers (Realtek High Definition Audio)
18:16:37: ------------------------------------------
18:16:37: Using auxilary audio input: Microphone (Realtek High Definition Audio)
18:16:37: ------------------------------------------
18:16:37: Audio Encoding: AAC
18:16:37: bitrate: 128
18:16:37: ------------------------------------------
18:16:37: device: Logitech HD Pro Webcam C910,
18:16:37: device id \\?\usb#vid_046d&pid_0821&mi_02#8&1f9d81a6&0&0002#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
18:16:37: chosen type: I420, usingFourCC: false, res: 960x720 - 960x720, frameIntervals: 333333-2000000
18:16:37: use buffering: false - 0, fourCC: 'I420'
18:16:37: audio device: Disable,
18:16:37: audio device id Disabled,
18:16:37:
18:16:37: Using directshow input
18:16:37: Using graphics capture
18:16:38: Scene buffering time set to 400
18:16:38: ------------------------------------------
18:16:38: Video Encoding: x264
18:16:38: fps: 30
18:16:38: width: 1280, height: 720
18:16:38: preset: veryfast
18:16:38: profile: high
18:16:38: keyint: 60
18:16:38: CBR: yes
18:16:38: CFR: yes
18:16:38: max bitrate: 1800
18:16:38: buffer size: 1800
18:16:38: ------------------------------------------
18:16:38: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
18:16:38: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
18:16:39: Using RTMP service: Twitch / Justin.tv
18:16:39: Server selection: rtmp://live-ord.justin.tv/app
18:16:39: Interface: Broadcom NetLink (TM) Gigabit Ethernet (ethernet, 100 mbps)
18:16:40: Completed handshake with rtmp://live-ord.justin.tv/app in 188 ms.
18:16:40: SO_SNDBUF was at 8192
18:16:40: SO_SNDBUF is now 65536
18:16:43: SharedTexCapture hooked
18:16:44: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 0 / 246784)
18:24:34: RTMPPublisher::SocketLoop: Received FD_CLOSE, 5032 ms since last send (buffer: 245026 / 246784)
18:24:34: RTMPPublisher::SocketLoop: Aborting due to FD_CLOSE, error 0
18:24:35: Total frames encoded: 14290, total frames duplicated: 6 (0.04%)
18:24:35: Total frames rendered: 14295, number of late frames: 1 (0.01%) (it's okay for some frames to be late)
18:24:35: Average send payload: 7802 bytes, average send interval: 32 ms
18:24:35: Number of times waited to send: 2, Waited for a total of 8208 bytes
18:24:35: Number of b-frames dropped: 27 (0.19%), Number of p-frames dropped: 27 (0.19%), Total 54 (0.38%)
18:24:35: Number of bytes sent: 113138309
18:24:35:
18:24:35: Profiler time results:
18:24:35:
18:24:35: ==============================================================
18:24:35: video thread frame - [100%] [avg time: 0.974 ms] [children: 39.2%] [unaccounted: 60.8%]
18:24:35: | scene->Preprocess - [24%] [avg time: 0.234 ms]
18:24:35: | GPU download and conversion - [15.2%] [avg time: 0.148 ms] [children: 11.4%] [unaccounted: 3.8%]
18:24:35: | | flush - [8.52%] [avg time: 0.083 ms]
18:24:35: | | CopyResource - [2.77%] [avg time: 0.027 ms]
18:24:35: | | conversion to 4:2:0 - [0.103%] [avg time: 0.001 ms]
18:24:35: Convert444Threads - [100%] [avg time: 0.379 ms] [children: 99.2%] [unaccounted: 0.792%]
18:24:35: | Convert444toNV12 - [99.2%] [avg time: 0.376 ms]
18:24:35: encoder thread frame - [100%] [avg time: 0.739 ms]
18:24:35: ==============================================================
18:24:35:
18:24:35:
18:24:35: Profiler CPU results:
18:24:35:
18:24:35: ==============================================================
18:24:35: video thread frame - [cpu time: avg 0.302 ms, total 4321.23 ms] [avg calls per frame: 1]
18:24:35: | scene->Preprocess - [cpu time: avg 0.005 ms, total 78 ms] [avg calls per frame: 1]
18:24:35: | GPU download and conversion - [cpu time: avg 0.051 ms, total 733.205 ms] [avg calls per frame: 1]
18:24:35: | | flush - [cpu time: avg 0.016 ms, total 234 ms] [avg calls per frame: 1]
18:24:35: | | CopyResource - [cpu time: avg 0.017 ms, total 249.602 ms] [avg calls per frame: 1]
18:24:35: | | conversion to 4:2:0 - [cpu time: avg 0.002 ms, total 31.201 ms] [avg calls per frame: 1]
18:24:35: Convert444Threads - [cpu time: avg 0.184 ms, total 5257.23 ms] [avg calls per frame: 2]
18:24:35: | Convert444toNV12 - [cpu time: avg 0.182 ms, total 5226.03 ms] [avg calls per frame: 2]
18:24:35: encoder thread frame - [cpu time: avg 0.053 ms, total 764.405 ms] [avg calls per frame: 1]
18:24:35: ==============================================================
18:24:35:
18:24:35: =====Stream End: 2013-12-10, 18:24:35=================================================
18:24:45: =====Stream Start: 2013-12-10, 18:24:45===============================================
18:24:45: Multithreaded optimizations: On
18:24:45: Base resolution: 1920x1080
18:24:45: Output resolution: 1280x720
18:24:45: ------------------------------------------
18:24:45: Loading up D3D10 on NVIDIA GeForce GTX 660...
18:24:45: ------------------------------------------
18:24:45: Audio Format: 48000hz
18:24:45: Playback device Default
18:24:45: ------------------------------------------
18:24:45: Using desktop audio input: Speakers (Realtek High Definition Audio)
18:24:45: ------------------------------------------
18:24:45: Using auxilary audio input: Microphone (Realtek High Definition Audio)
18:24:45: ------------------------------------------
18:24:45: Audio Encoding: AAC
18:24:45: bitrate: 128
18:24:45: ------------------------------------------
18:24:45: device: Logitech HD Pro Webcam C910,
18:24:45: device id \\?\usb#vid_046d&pid_0821&mi_02#8&1f9d81a6&0&0002#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
18:24:45: chosen type: I420, usingFourCC: false, res: 960x720 - 960x720, frameIntervals: 333333-2000000
18:24:45: use buffering: false - 0, fourCC: 'I420'
18:24:45: audio device: Disable,
18:24:45: audio device id Disabled,
18:24:45:
18:24:45: Using directshow input
18:24:45: Using graphics capture
18:24:46: Scene buffering time set to 400
18:24:46: ------------------------------------------
18:24:46: Video Encoding: x264
18:24:46: fps: 30
18:24:46: width: 1280, height: 720
18:24:46: preset: veryfast
18:24:46: profile: high
18:24:46: keyint: 60
18:24:46: CBR: yes
18:24:46: CFR: yes
18:24:46: max bitrate: 1800
18:24:46: buffer size: 1800
18:24:46: ------------------------------------------
18:24:46: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
18:24:46: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
18:24:46: SharedTexCapture hooked
18:24:47: Using RTMP service: Twitch / Justin.tv
18:24:47: Server selection: rtmp://live-ord.justin.tv/app
18:24:47: Interface: Broadcom NetLink (TM) Gigabit Ethernet (ethernet, 100 mbps)
18:24:47: Completed handshake with rtmp://live-ord.justin.tv/app in 172 ms.
18:24:48: SO_SNDBUF was at 8192
18:24:48: SO_SNDBUF is now 65536
18:24:50: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 17247 / 246784)
18:24:50: GraphicsCaptureSource::NewCapture: eliminating old capture
18:24:50: SharedTexCapture hooked
18:47:53: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 262144 (buffer: 11978 / 246784)
19:03:05: Total frames encoded: 68951, total frames duplicated: 11 (0.02%)
19:03:05: Total frames rendered: 68954, number of late frames: 2 (0.00%) (it's okay for some frames to be late)
19:03:05: RTMPPublisher::SocketLoop: Graceful loop exit
19:03:05: Average send payload: 7494 bytes, average send interval: 30 ms
19:03:05: Number of times waited to send: 0, Waited for a total of 0 bytes
19:03:05: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
19:03:05: Number of bytes sent: 555330576
19:03:05:
19:03:05: Profiler time results:
19:03:05:
19:03:05: ==============================================================
19:03:05: video thread frame - [100%] [avg time: 1.015 ms] [children: 41.2%] [unaccounted: 58.8%]
19:03:05: | scene->Preprocess - [23.6%] [avg time: 0.24 ms]
19:03:05: | GPU download and conversion - [17.5%] [avg time: 0.178 ms] [children: 14%] [unaccounted: 3.55%]
19:03:05: | | flush - [10.1%] [avg time: 0.103 ms]
19:03:05: | | CopyResource - [3.74%] [avg time: 0.038 ms]
19:03:05: | | conversion to 4:2:0 - [0.0985%] [avg time: 0.001 ms]
19:03:05: Convert444Threads - [100%] [avg time: 0.398 ms] [children: 99.2%] [unaccounted: 0.754%]
19:03:05: | Convert444toNV12 - [99.2%] [avg time: 0.395 ms]
19:03:05: encoder thread frame - [100%] [avg time: 0.758 ms]
19:03:05: ==============================================================
19:03:05:
19:03:05:
19:03:05: Profiler CPU results:
19:03:05:
19:03:05: ==============================================================
19:03:05: video thread frame - [cpu time: avg 0.334 ms, total 23088.1 ms] [avg calls per frame: 1]
19:03:05: | scene->Preprocess - [cpu time: avg 0.015 ms, total 1060.81 ms] [avg calls per frame: 1]
19:03:05: | GPU download and conversion - [cpu time: avg 0.054 ms, total 3775.22 ms] [avg calls per frame: 1]
19:03:05: | | flush - [cpu time: avg 0.021 ms, total 1482.01 ms] [avg calls per frame: 1]
19:03:05: | | CopyResource - [cpu time: avg 0.015 ms, total 1076.4 ms] [avg calls per frame: 1]
19:03:05: | | conversion to 4:2:0 - [cpu time: avg 0.001 ms, total 93.601 ms] [avg calls per frame: 1]
19:03:05: Convert444Threads - [cpu time: avg 0.243 ms, total 33633.8 ms] [avg calls per frame: 2]
19:03:05: | Convert444toNV12 - [cpu time: avg 0.242 ms, total 33493.4 ms] [avg calls per frame: 2]
19:03:05: encoder thread frame - [cpu time: avg 0.088 ms, total 6099.64 ms] [avg calls per frame: 1]
19:03:05: ==============================================================
19:03:05:
19:03:05: =====Stream End: 2013-12-10, 19:03:05=================================================
20:52:32: =====Stream Start: 2013-12-10, 20:52:32===============================================
20:52:32: Multithreaded optimizations: On
20:52:32: Base resolution: 1920x1080
20:52:32: Output resolution: 1280x720
20:52:32: ------------------------------------------
20:52:32: Loading up D3D10 on NVIDIA GeForce GTX 660...
20:52:32: ------------------------------------------
20:52:32: Audio Format: 48000hz
20:52:32: Playback device Default
20:52:32: ------------------------------------------
20:52:32: Using desktop audio input: Speakers (Realtek High Definition Audio)
20:52:32: ------------------------------------------
20:52:32: Using auxilary audio input: Microphone (Realtek High Definition Audio)
20:52:32: ------------------------------------------
20:52:32: Audio Encoding: AAC
20:52:32: bitrate: 128
20:52:32: ------------------------------------------
20:52:32: device: Logitech HD Pro Webcam C910,
20:52:32: device id \\?\usb#vid_046d&pid_0821&mi_02#8&1f9d81a6&0&0002#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
20:52:32: chosen type: I420, usingFourCC: false, res: 960x720 - 960x720, frameIntervals: 333333-2000000
20:52:32: use buffering: false - 0, fourCC: 'I420'
20:52:32: audio device: Disable,
20:52:32: audio device id Disabled,
20:52:32:
20:52:32: Using directshow input
20:52:32: Using graphics capture
20:52:33: Scene buffering time set to 400
20:52:33: ------------------------------------------
20:52:33: Video Encoding: x264
20:52:33: fps: 30
20:52:33: width: 1280, height: 720
20:52:33: preset: veryfast
20:52:33: profile: high
20:52:33: keyint: 60
20:52:33: CBR: yes
20:52:33: CFR: yes
20:52:33: max bitrate: 1800
20:52:33: buffer size: 1800
20:52:33: ------------------------------------------
20:52:33: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
20:52:33: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
20:52:33: SharedTexCapture hooked
20:52:37: Total frames encoded: 97, total frames duplicated: 0 (0.00%)
20:52:37: Total frames rendered: 102, number of late frames: 1 (0.98%) (it's okay for some frames to be late)
20:52:37:
20:52:37: Profiler time results:
20:52:37:
20:52:37: ==============================================================
20:52:37: video thread frame - [100%] [avg time: 1.482 ms] [children: 26.7%] [unaccounted: 73.3%]
20:52:37: | scene->Preprocess - [18.7%] [avg time: 0.277 ms]
20:52:37: | GPU download and conversion - [8.03%] [avg time: 0.119 ms] [children: 7.02%] [unaccounted: 1.01%]
20:52:37: | | flush - [5.13%] [avg time: 0.076 ms]
20:52:37: | | CopyResource - [1.21%] [avg time: 0.018 ms]
20:52:37: | | conversion to 4:2:0 - [0.675%] [avg time: 0.01 ms]
20:52:37: Convert444Threads - [100%] [avg time: 0.442 ms] [children: 99.1%] [unaccounted: 0.905%]
20:52:37: | Convert444toNV12 - [99.1%] [avg time: 0.438 ms]
20:52:37: encoder thread frame - [100%] [avg time: 1.092 ms]
20:52:37: ==============================================================
20:52:37:
20:52:37:
20:52:37: Profiler CPU results:
20:52:37:
20:52:37: ==============================================================
20:52:37: video thread frame - [cpu time: avg 1.07 ms, total 109.2 ms] [avg calls per frame: 1]
20:52:37: | scene->Preprocess - [cpu time: avg 0.152 ms, total 15.6 ms] [avg calls per frame: 1]
20:52:37: | GPU download and conversion - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
20:52:37: | | flush - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
20:52:37: | | CopyResource - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
20:52:37: | | conversion to 4:2:0 - [cpu time: avg 0 ms, total 0 ms] [avg calls per frame: 1]
20:52:37: Convert444Threads - [cpu time: avg 0.362 ms, total 62.4 ms] [avg calls per frame: 2]
20:52:37: | Convert444toNV12 - [cpu time: avg 0.362 ms, total 62.4 ms] [avg calls per frame: 2]
20:52:37: encoder thread frame - [cpu time: avg 0.367 ms, total 31.2 ms] [avg calls per frame: 1]
20:52:37: ==============================================================
20:52:37:
20:52:37: =====Stream End: 2013-12-10, 20:52:37=================================================
20:58:40: =====Stream Start: 2013-12-10, 20:58:40===============================================
20:58:40: Multithreaded optimizations: On
20:58:40: Base resolution: 1920x1080
20:58:40: Output resolution: 1280x720
20:58:40: ------------------------------------------
20:58:40: Loading up D3D10 on NVIDIA GeForce GTX 660...
20:58:40: ------------------------------------------
20:58:40: Audio Format: 48000hz
20:58:40: Playback device Default
20:58:40: ------------------------------------------
20:58:40: Using desktop audio input: Speakers (Realtek High Definition Audio)
20:58:40: ------------------------------------------
20:58:40: Using auxilary audio input: Microphone (Realtek High Definition Audio)
20:58:40: ------------------------------------------
20:58:40: Audio Encoding: AAC
20:58:40: bitrate: 128
20:58:40: ------------------------------------------
20:58:40: device: Logitech HD Pro Webcam C910,
20:58:40: device id \\?\usb#vid_046d&pid_0821&mi_02#8&1f9d81a6&0&0002#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
20:58:40: chosen type: I420, usingFourCC: false, res: 960x720 - 960x720, frameIntervals: 333333-2000000
20:58:40: use buffering: false - 0, fourCC: 'I420'
20:58:40: audio device: Disable,
20:58:40: audio device id Disabled,
20:58:40:
20:58:40: Using directshow input
20:58:40: Using graphics capture
20:58:41: Scene buffering time set to 400
20:58:41: ------------------------------------------
20:58:41: Video Encoding: x264
20:58:41: fps: 30
20:58:41: width: 1280, height: 720
20:58:41: preset: veryfast
20:58:41: profile: high
20:58:41: keyint: 60
20:58:41: CBR: yes
20:58:41: CFR: yes
20:58:41: max bitrate: 1800
20:58:41: buffer size: 1800
20:58:41: ------------------------------------------
20:58:41: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
20:58:41: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
20:58:43: Using RTMP service: Twitch / Justin.tv
20:58:43: Server selection: rtmp://live-ord.justin.tv/app
20:58:43: Interface: Broadcom NetLink (TM) Gigabit Ethernet (ethernet, 100 mbps)
20:58:43: Completed handshake with rtmp://live-ord.justin.tv/app in 167 ms.
20:58:44: SO_SNDBUF was at 8192
20:58:44: SO_SNDBUF is now 65536
20:58:47: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 0 / 246784)
21:01:27: SharedTexCapture hooked
21:07:19: RTMPPublisher::SocketLoop: Received FD_CLOSE, 4679 ms since last send (buffer: 245726 / 246784)
21:07:19: RTMPPublisher::SocketLoop: Aborting due to FD_CLOSE, error 0
21:07:20: Total frames encoded: 15554, total frames duplicated: 12 (0.08%)
21:07:20: Total frames rendered: 15552, number of late frames: 2 (0.01%) (it's okay for some frames to be late)
21:07:21: Average send payload: 7644 bytes, average send interval: 31 ms
21:07:21: Number of times waited to send: 2, Waited for a total of 8194 bytes
21:07:21: Number of b-frames dropped: 25 (0.16%), Number of p-frames dropped: 30 (0.19%), Total 55 (0.36%)
21:07:21: Number of bytes sent: 123303291
21:07:21:
21:07:21: Profiler time results:
21:07:21:
21:07:21: ==============================================================
21:07:21: video thread frame - [100%] [avg time: 1.043 ms] [children: 42.3%] [unaccounted: 57.7%]
21:07:21: | scene->Preprocess - [25.3%] [avg time: 0.264 ms]
21:07:21: | GPU download and conversion - [17%] [avg time: 0.177 ms] [children: 13.2%] [unaccounted: 3.74%]
21:07:21: | | flush - [9.97%] [avg time: 0.104 ms]
21:07:21: | | CopyResource - [3.07%] [avg time: 0.032 ms]
21:07:21: | | conversion to 4:2:0 - [0.192%] [avg time: 0.002 ms]
21:07:21: Convert444Threads - [100%] [avg time: 0.396 ms] [children: 99%] [unaccounted: 1.01%]
21:07:21: | Convert444toNV12 - [99%] [avg time: 0.392 ms]
21:07:21: encoder thread frame - [100%] [avg time: 0.773 ms]
21:07:21: ==============================================================
21:07:21:
21:07:21:
21:07:21: Profiler CPU results:
21:07:21:
21:07:21: ==============================================================
21:07:21: video thread frame - [cpu time: avg 0.35 ms, total 5444.43 ms] [avg calls per frame: 1]
21:07:21: | scene->Preprocess - [cpu time: avg 0.014 ms, total 218.403 ms] [avg calls per frame: 1]
21:07:21: | GPU download and conversion - [cpu time: avg 0.052 ms, total 811.204 ms] [avg calls per frame: 1]
21:07:21: | | flush - [cpu time: avg 0.024 ms, total 374.401 ms] [avg calls per frame: 1]
21:07:21: | | CopyResource - [cpu time: avg 0.015 ms, total 234.003 ms] [avg calls per frame: 1]
21:07:21: | | conversion to 4:2:0 - [cpu time: avg 0.002 ms, total 31.2 ms] [avg calls per frame: 1]
21:07:21: Convert444Threads - [cpu time: avg 0.251 ms, total 7800.05 ms] [avg calls per frame: 2]
21:07:21: | Convert444toNV12 - [cpu time: avg 0.248 ms, total 7722.05 ms] [avg calls per frame: 2]
21:07:21: encoder thread frame - [cpu time: avg 0.098 ms, total 1528.81 ms] [avg calls per frame: 1]
21:07:21: ==============================================================
21:07:21:
21:07:21: =====Stream End: 2013-12-10, 21:07:21=================================================
21:07:31: =====Stream Start: 2013-12-10, 21:07:31===============================================
21:07:31: Multithreaded optimizations: On
21:07:31: Base resolution: 1920x1080
21:07:31: Output resolution: 1280x720
21:07:31: ------------------------------------------
21:07:31: Loading up D3D10 on NVIDIA GeForce GTX 660...
21:07:31: ------------------------------------------
21:07:31: Audio Format: 48000hz
21:07:31: Playback device Default
21:07:31: ------------------------------------------
21:07:31: Using desktop audio input: Speakers (Realtek High Definition Audio)
21:07:31: ------------------------------------------
21:07:31: Using auxilary audio input: Microphone (Realtek High Definition Audio)
21:07:31: ------------------------------------------
21:07:31: Audio Encoding: AAC
21:07:31: bitrate: 128
21:07:31: ------------------------------------------
21:07:31: device: Logitech HD Pro Webcam C910,
21:07:31: device id \\?\usb#vid_046d&pid_0821&mi_02#8&1f9d81a6&0&0002#{65e8773d-8f56-11d0-a3b9-00a0c9223196}\{bbefb6c7-2fc4-4139-bb8b-a58bba724083},
21:07:31: chosen type: I420, usingFourCC: false, res: 960x720 - 960x720, frameIntervals: 333333-2000000
21:07:31: use buffering: false - 0, fourCC: 'I420'
21:07:31: audio device: Disable,
21:07:31: audio device id Disabled,
21:07:31:
21:07:31: Using directshow input
21:07:31: Using graphics capture
21:07:32: Scene buffering time set to 400
21:07:32: ------------------------------------------
21:07:32: Video Encoding: x264
21:07:32: fps: 30
21:07:32: width: 1280, height: 720
21:07:32: preset: veryfast
21:07:32: profile: high
21:07:32: keyint: 60
21:07:32: CBR: yes
21:07:32: CFR: yes
21:07:32: max bitrate: 1800
21:07:32: buffer size: 1800
21:07:32: ------------------------------------------
21:07:32: MMDeviceAudioSource: Frequency for device 'Speakers (Realtek High Definition Audio)' is 384000, samples per sec is 48000
21:07:32: MMDeviceAudioSource: Frequency for device 'Microphone (Realtek High Definition Audio)' is 352800, samples per sec is 44100
21:07:32: SharedTexCapture hooked
21:07:33: Using RTMP service: Twitch / Justin.tv
21:07:33: Server selection: rtmp://live-ord.justin.tv/app
21:07:33: Interface: Broadcom NetLink (TM) Gigabit Ethernet (ethernet, 100 mbps)
21:07:33: Completed handshake with rtmp://live-ord.justin.tv/app in 180 ms.
21:07:34: SO_SNDBUF was at 8192
21:07:34: SO_SNDBUF is now 65536
21:07:36: RTMPPublisher::SocketLoop: Increasing send buffer to ISB 131072 (buffer: 97980 / 246784)
21:07:37: GraphicsCaptureSource::NewCapture: eliminating old capture
21:07:37: SharedTexCapture hooked
21:46:04: GraphicsCaptureSource::NewCapture: eliminating old capture
21:46:04: SharedTexCapture hooked
22:15:40: Total frames encoded: 122622, total frames duplicated: 50 (0.04%)
22:15:40: Total frames rendered: 122606, number of late frames: 8 (0.01%) (it's okay for some frames to be late)
22:15:40: RTMPPublisher::SocketLoop: Graceful loop exit
22:15:40: Average send payload: 7631 bytes, average send interval: 31 ms
22:15:40: Number of times waited to send: 4, Waited for a total of 16402 bytes
22:15:40: Number of b-frames dropped: 0 (0%), Number of p-frames dropped: 0 (0%), Total 0 (0%)
22:15:40: Number of bytes sent: 987999325
22:15:40:
22:15:40: Profiler time results:
22:15:40:
22:15:40: ==============================================================
22:15:40: video thread frame - [100%] [avg time: 0.992 ms] [children: 39.8%] [unaccounted: 60.2%]
22:15:40: | scene->Preprocess - [24.1%] [avg time: 0.239 ms]
22:15:40: | GPU download and conversion - [15.7%] [avg time: 0.156 ms] [children: 12.2%] [unaccounted: 3.53%]
22:15:40: | | flush - [8.97%] [avg time: 0.089 ms]
22:15:40: | | CopyResource - [3.13%] [avg time: 0.031 ms]
22:15:40: | | conversion to 4:2:0 - [0.101%] [avg time: 0.001 ms]
22:15:40: Convert444Threads - [100%] [avg time: 0.395 ms] [children: 99.2%] [unaccounted: 0.759%]
22:15:40: | Convert444toNV12 - [99.2%] [avg time: 0.392 ms]
22:15:40: encoder thread frame - [100%] [avg time: 0.747 ms]
22:15:40: ==============================================================
22:15:40:
22:15:40:
22:15:40: Profiler CPU results:
22:15:40:
22:15:40: ==============================================================
22:15:40: video thread frame - [cpu time: avg 0.346 ms, total 42494.7 ms] [avg calls per frame: 1]
22:15:40: | scene->Preprocess - [cpu time: avg 0.013 ms, total 1638.01 ms] [avg calls per frame: 1]
22:15:40: | GPU download and conversion - [cpu time: avg 0.057 ms, total 7066.84 ms] [avg calls per frame: 1]
22:15:40: | | flush - [cpu time: avg 0.023 ms, total 2839.21 ms] [avg calls per frame: 1]
22:15:40: | | CopyResource - [cpu time: avg 0.015 ms, total 1840.81 ms] [avg calls per frame: 1]
22:15:40: | | conversion to 4:2:0 - [cpu time: avg 0.001 ms, total 202.802 ms] [avg calls per frame: 1]
22:15:40: Convert444Threads - [cpu time: avg 0.239 ms, total 58718.8 ms] [avg calls per frame: 2]
22:15:40: | Convert444toNV12 - [cpu time: avg 0.237 ms, total 58313.2 ms] [avg calls per frame: 2]
22:15:40: encoder thread frame - [cpu time: avg 0.079 ms, total 9796.86 ms] [avg calls per frame: 1]
22:15:40: ==============================================================
22:15:40:
22:15:40: =====Stream End: 2013-12-10, 22:15:40=================================================


Last game capture log:
2013-12-10, 18:16:37: we're booting up:
18:16:38: D3D9 Present
18:16:38: (half life scientist) everything.. seems to be in order
18:16:43: D3D9EndScene called
18:16:43: D3DPRESENT_PARAMETERS {
18:16:43: BackBufferWidth: 1920
18:16:43: BackBufferHeight: 1080
18:16:43: BackBufferFormat: D3DFMT_A8R8G8B8
18:16:43: BackBufferCount: 1
18:16:43: MultiSampleType: D3DMULTISAMPLE_NONE
18:16:43: MultiSampleQuality: 0
18:16:43: SwapEffect: D3DSWAPEFFECT_DISCARD
18:16:43: hDeviceWindow: 1050440
18:16:43: Windowed: false
18:16:43: EnableAutoDepthStencil: false
18:16:43: AutoDepthStencilFormat: D3DFMT_UNKNOWN
18:16:43: Flags: None
18:16:43: FullScreen_RefreshRateInHz: 59
18:16:43: PresentationInterval: 2147483648
18:16:43: };
18:16:43: successfully set up d3d9 hooks
18:16:43: D3D9SwapPresent called
18:16:43: DoD3D9GPUHook: success
18:16:43: D3DSURFACE_DESC {
18:16:43: Format: D3DFMT_A8R8G8B8
18:16:43: Type: D3DRTYPE_SURFACE
18:16:43: Usage: D3DUSAGE_RENDERTARGET
18:16:43: Pool: D3DPOOL_DEFAULT
18:16:43: MultiSampleType: D3DMULTISAMPLE_NONE
18:16:43: MultiSampleQuality: 0
18:16:43: Width: 1920
18:16:43: Height: 1080
18:16:43: };
18:16:43: successfully capturing d3d9 frames via GPU
18:24:35: ---------------------- Cleared D3D9 Capture ----------------------
18:24:35: received restart event, capturing
18:24:35: DoD3D9GPUHook: success
18:24:35: D3D9EndScene called
18:24:35: D3D9SwapPresent called
18:24:46: D3DSURFACE_DESC {
18:24:46: Format: D3DFMT_A8R8G8B8
18:24:46: Type: D3DRTYPE_SURFACE
18:24:46: Usage: D3DUSAGE_RENDERTARGET
18:24:46: Pool: D3DPOOL_DEFAULT
18:24:46: MultiSampleType: D3DMULTISAMPLE_NONE
18:24:46: MultiSampleQuality: 0
18:24:46: Width: 1920
18:24:46: Height: 1080
18:24:46: };
18:24:46: successfully capturing d3d9 frames via GPU
18:24:48: D3D9Reset called
18:24:48: ---------------------- Cleared D3D9 Capture ----------------------
18:24:48: successfully set up d3d9 hooks
18:24:48: D3D9Reset called
18:24:48: ---------------------- Cleared D3D9 Capture ----------------------
18:24:49: successfully set up d3d9 hooks
18:24:50: D3D9EndScene called
18:24:50: D3D9SwapPresent called
18:24:50: DoD3D9GPUHook: success
18:24:50: D3DSURFACE_DESC {
18:24:50: Format: D3DFMT_A8R8G8B8
18:24:50: Type: D3DRTYPE_SURFACE
18:24:50: Usage: D3DUSAGE_RENDERTARGET
18:24:50: Pool: D3DPOOL_DEFAULT
18:24:50: MultiSampleType: D3DMULTISAMPLE_NONE
18:24:50: MultiSampleQuality: 0
18:24:50: Width: 1920
18:24:50: Height: 1080
18:24:50: };
18:24:50: successfully capturing d3d9 frames via GPU
19:03:05: ---------------------- Cleared D3D9 Capture ----------------------
19:03:05: received restart event, capturing
19:03:05: DoD3D9GPUHook: success
19:03:05: D3D9EndScene called
19:03:05: D3D9SwapPresent called
19:37:55: D3D9Reset called
19:37:55: ---------------------- Cleared D3D9 Capture ----------------------
19:37:56: successfully set up d3d9 hooks
19:37:56: D3D9Reset called
19:37:56: ---------------------- Cleared D3D9 Capture ----------------------
19:37:56: successfully set up d3d9 hooks
19:37:56: D3D9EndScene called
19:37:56: D3D9SwapPresent called
19:37:56: DoD3D9GPUHook: success
21:01:26: D3D9Reset called
21:01:26: ---------------------- Cleared D3D9 Capture ----------------------
21:01:26: successfully set up d3d9 hooks
21:01:26: D3D9Reset called
21:01:26: ---------------------- Cleared D3D9 Capture ----------------------
21:01:27: successfully set up d3d9 hooks
21:01:27: D3D9EndScene called
21:01:27: D3D9SwapPresent called
21:01:27: ---------------------- Cleared D3D9 Capture ----------------------
21:01:27: received restart event, capturing
21:01:27: DoD3D9GPUHook: success
21:01:27: D3D9EndScene called
21:01:27: D3D9SwapPresent called
21:01:27: D3DSURFACE_DESC {
21:01:27: Format: D3DFMT_A8R8G8B8
21:01:27: Type: D3DRTYPE_SURFACE
21:01:27: Usage: D3DUSAGE_RENDERTARGET
21:01:27: Pool: D3DPOOL_DEFAULT
21:01:27: MultiSampleType: D3DMULTISAMPLE_NONE
21:01:27: MultiSampleQuality: 0
21:01:27: Width: 1920
21:01:27: Height: 1080
21:01:27: };
21:01:27: successfully capturing d3d9 frames via GPU
21:07:21: ---------------------- Cleared D3D9 Capture ----------------------
21:07:21: received restart event, capturing
21:07:21: DoD3D9GPUHook: success
21:07:21: D3D9EndScene called
21:07:21: D3D9SwapPresent called
21:07:32: D3DSURFACE_DESC {
21:07:32: Format: D3DFMT_A8R8G8B8
21:07:32: Type: D3DRTYPE_SURFACE
21:07:32: Usage: D3DUSAGE_RENDERTARGET
21:07:32: Pool: D3DPOOL_DEFAULT
21:07:32: MultiSampleType: D3DMULTISAMPLE_NONE
21:07:32: MultiSampleQuality: 0
21:07:32: Width: 1920
21:07:32: Height: 1080
21:07:32: };
21:07:32: successfully capturing d3d9 frames via GPU
21:07:35: D3D9Reset called
21:07:35: ---------------------- Cleared D3D9 Capture ----------------------
21:07:36: successfully set up d3d9 hooks
21:07:36: D3D9Reset called
21:07:36: ---------------------- Cleared D3D9 Capture ----------------------
21:07:36: successfully set up d3d9 hooks
21:07:37: D3D9EndScene called
21:07:37: D3D9SwapPresent called
21:07:37: DoD3D9GPUHook: success
21:07:37: D3DSURFACE_DESC {
21:07:37: Format: D3DFMT_A8R8G8B8
21:07:37: Type: D3DRTYPE_SURFACE
21:07:37: Usage: D3DUSAGE_RENDERTARGET
21:07:37: Pool: D3DPOOL_DEFAULT
21:07:37: MultiSampleType: D3DMULTISAMPLE_NONE
21:07:37: MultiSampleQuality: 0
21:07:37: Width: 1920
21:07:37: Height: 1080
21:07:37: };
21:07:37: successfully capturing d3d9 frames via GPU
21:46:03: D3D9Reset called
21:46:03: ---------------------- Cleared D3D9 Capture ----------------------
21:46:03: successfully set up d3d9 hooks
21:46:03: D3D9Reset called
21:46:03: ---------------------- Cleared D3D9 Capture ----------------------
21:46:03: successfully set up d3d9 hooks
21:46:04: D3D9EndScene called
21:46:04: D3D9SwapPresent called
21:46:04: DoD3D9GPUHook: success
21:46:04: D3DSURFACE_DESC {
21:46:04: Format: D3DFMT_A8R8G8B8
21:46:04: Type: D3DRTYPE_SURFACE
21:46:04: Usage: D3DUSAGE_RENDERTARGET
21:46:04: Pool: D3DPOOL_DEFAULT
21:46:04: MultiSampleType: D3DMULTISAMPLE_NONE
21:46:04: MultiSampleQuality: 0
21:46:04: Width: 1920
21:46:04: Height: 1080
21:46:04: };
21:46:04: successfully capturing d3d9 frames via GPU
22:15:40: ---------------------- Cleared D3D9 Capture ----------------------
22:15:40: received restart event, capturing
22:15:40: DoD3D9GPUHook: success
22:15:40: D3D9EndScene called
22:15:40: D3D9SwapPresent called

Anything that I can do to prevent the cut-out, just let me know.

Thanks again for the help!
 
ThoNohT

ThoNohT

Developer
1. How do you start the stream exactly? That generally should not happen. But if you for example have OBS sitting on a second screen, and you click the start streaming button, then yes, you are clicking outside of SC2, and it will minimize itself. In that case, you could consider using a start/stop stream hotkey, so you don't have to exit the game to start/stop the stream. If you are already using the hotkey, then I don't really know why that would happen.

2. What do you mean by crashes? Does OBS crash, meaning it closes with an error message, this is generally what we refer to as crashing. Then you would have multiple logs. Or does the stream disconnect, meaning it just stops streaming and starts reconnecting? This might have several causes, but is usually related to connection issues. Or is it something else? The log you posted doesn't show anything related to a stream stopping unexpectedly, or any connection issues.
 
P

p4ck3tl055

New Member
ThoNohT said:
1. How do you start the stream exactly? That generally should not happen. But if you for example have OBS sitting on a second screen, and you click the start streaming button, then yes, you are clicking outside of SC2, and it will minimize itself. In that case, you could consider using a start/stop stream hotkey, so you don't have to exit the game to start/stop the stream. If you are already using the hotkey, then I don't really know why that would happen.
Click to expand...
I have SC2 running fullscreen on my left monitor. I have OBS and a few other things, like a browser, etc., open on my right monitor. I have OBS setup to start/stop streaming when I hit the F11 key. I will be in SC2, getting ready to start a mission or something and hit F11. SC2 will minimize, OBS with start the stream. The webcam source will start, The "Game Capture" source will be black. I switch back to SC2 and then the game capture source will show SC2 and all is well.


ThoNohT said:
2. What do you mean by crashes? Does OBS crash, meaning it closes with an error message, this is generally what we refer to as crashing. Then you would have multiple logs. Or does the stream disconnect, meaning it just stops streaming and starts reconnecting? This might have several causes, but is usually related to connection issues. Or is it something else? The log you posted doesn't show anything related to a stream stopping unexpectedly, or any connection issues.
Click to expand...
What I mean by crash is the stream will stop. It's almost like I hit the start/stop stream hot key twice several seconds apart. Nothing actually crashes, in fact, given a few seconds (15 or so) OBS will start streaming again on its own. During the "recovery", my computer lags very badly - so badly that all of the action on SC2 will stop until the stream is once again running. After the recovery the stream runs perfectly until hit the start/stop stream hot key.

To be honest, outside of these minor hiccups, I'm quite pleased with OBS. When I reduced the encoding bitrate yesterday I was worried that my stream would look awful. I'm very happy to report it looks awesome. After the stream did it's start/stop "crash", everything was flawless for more than an hour.

Thanks for your attention and time. And thanks to all the developers for such a wonderful app!
 
You must log in or register to reply here.
Top