Jump to content

How to get the cause of high CPU usage by DPC / Interrupt


Recommended Posts

KA6 is connected on
Intel® ICH10 Family USB Enhanced Host Controller - 3A3A
which shares IRQ channel with
Intel® ICH10 Family USB Universal Host Controller - 3A34
screen.png
Here is ASUS Sabertooth X58 IRQ Assignments

and video demonstration of my problem that I have recorded on Win7 x86 machine (Now I have x64)
http://www.youtube.com/watch?v=oePtCBsHkQE

Edited by JoRJa
Link to comment
Share on other sites


Yes, I have tried all of them but unfortunately with no luck.

I have borrowed RME Babyface from our Music Technology Studio. Removed Komplete Audio 6 from USB Port and connected Babyface. I have run same programs — Gom Player, Mozilla Firefox (also plugin_container.exe), Media Player Classic, Cubase 6 AI. RME Interface work very well, with no crackles or pops in sound @ 1024, 512, 256 buffer settings. Here is a log from xperf testing RME Babyface.
xperf -i babyface_wo_clicks.etl -a dpcisr > results_dpcisr.txt

     CPU 0 Usage      CPU 1 Usage      CPU 2 Usage      CPU 3 Usage      CPU 4 Usage      CPU 5 Usage      CPU 6 Usage      CPU 7 Usage      usec      %      usec      %      usec      %      usec      %      usec      %      usec      %      usec      %      usec      % Module   963793   0.33      2341   0.00   1316073   0.45         0   0.00    687106   0.24  11123628   3.81   1778091   0.61         0   0.00 USBPORT.SYS

Andre, I will send you .etl file. I must know is this PC related issue or KA6.

Sincerely

Edited by JoRJa
Link to comment
Share on other sites

ok, the new trace is better. Highest spikes are between 128 and 256µs

Total = 1759782Elapsed Time, > 0 usecs AND <= 1 usecs, 163767, or 9.31%Elapsed Time, > 1 usecs AND <= 2 usecs, 88972, or 5.06%Elapsed Time, > 2 usecs AND <= 4 usecs, 101402, or 5.76%Elapsed Time, > 4 usecs AND <= 8 usecs, 504360, or 28.66%Elapsed Time, > 8 usecs AND <= 16 usecs, 518167, or 29.44%Elapsed Time, > 16 usecs AND <= 32 usecs, 338942, or 19.26%Elapsed Time, > 32 usecs AND <= 64 usecs, 40948, or 2.33%Elapsed Time, > 64 usecs AND <= 128 usecs, 3195, or 0.18%Elapsed Time, > 128 usecs AND <= 256 usecs, 29, or 0.00%Total, 1759782
Link to comment
Share on other sites

ok, the new trace is better. Highest spikes are between 128 and 256µs

Was the last trace results that high that it might be a reason for crackles in sound?

What do you think, NVIDIA GTS450 driver doesn't works with Komplete Audio 6 driver or here might be some issue with other component driver, for example motherboard driver and ka6 driver? I must change some of them to make it work, so what do you advice?

Edited by JoRJa
Link to comment
Share on other sites

Have rolled back wireless card drivers,updated,Full power options,Upgraded graphics card drivers,Bios drivers latest.

Edit3: New output

_________________________________________________________________________________________________________
CONCLUSION
_________________________________________________________________________________________________________
Your system appears to be having trouble handling real-time audio and other tasks. You are likely to experience buffer underruns appearing as drop outs, clicks or pops. One problem may be related to power management, disable CPU throttling settings in Control Panel and BIOS setup. Check for BIOS updates.
LatencyMon has been analyzing your system for 0:04:38 (h:mm:ss) on processors 0,1,2 and 3.
_________________________________________________________________________________________________________
SYSTEM INFORMATION
_________________________________________________________________________________________________________
Computer name: LEWISKWONG-PC
OS version: Windows 7 , 6.1, build: 7600 (x64)
Hardware: Gigabyte Technology Co., Ltd., X79-UD3
CPU: GenuineIntel Intel® Core i7-3820 CPU @ 3.60GHz
Logical processors: 8
Processor groups: 1
RAM: 16332 MB total
_________________________________________________________________________________________________________
CPU SPEED
_________________________________________________________________________________________________________
Reported CPU speed: 3600.0 MHz
Measured CPU speed: 2252.0 MHz (approx.)
Note: reported execution times may be calculated based on a fixed reported CPU speed. Disable variable speed settings like Intel Speed Step and AMD Cool N Quiet in the BIOS setup for more accurate results.
_________________________________________________________________________________________________________
MEASURED INTERRUPT TO USER PROCESS LATENCIES
_________________________________________________________________________________________________________
The interrupt to process latency reflects the measured interval that a usermode process needed to respond to a hardware request from the moment the interrupt service routine started execution. This includes the scheduling and execution of a DPC routine, the signaling of an event and the waking up of a usermode thread from an idle wait state in response to that event.
Highest measured interrupt to process latency (µs): 4390.043130
Average measured interrupt to process latency (µs): 6.403892
Highest measured interrupt to DPC latency (µs): 4388.620931
Average measured interrupt to DPC latency (µs): 1.231445
_________________________________________________________________________________________________________
REPORTED ISRs
_________________________________________________________________________________________________________
Interrupt service routines are routines installed by the OS and device drivers that execute in response to a hardware interrupt signal.
Highest ISR routine execution time (µs): 644.070
Driver with highest ISR routine execution time: ataport.SYS - ATAPI Driver Extension, Microsoft Corporation
Highest reported total ISR routine time (%): 0.059616
Driver with highest ISR total time: hal.dll - Hardware Abstraction Layer DLL, Microsoft Corporation
Total time spent in ISRs (%) 0.166314
ISR count (execution time <250 µs): 937116
ISR count (execution time 250-500 µs): 0
ISR count (execution time 500-999 µs): 22
ISR count (execution time 1000-1999 µs): 0
ISR count (execution time 2000-3999 µs): 0
ISR count (execution time >=4000 µs): 0
_________________________________________________________________________________________________________
REPORTED DPCs
_________________________________________________________________________________________________________
DPC routines are part of the interrupt servicing dispatch mechanism and disable the possibility for a process to utilize the CPU while it is interrupted until the DPC has finished execution.
Highest DPC routine execution time (µs): 607.768333
Driver with highest DPC routine execution time: USBPORT.SYS - USB 1.1 & 2.0 Port Driver, Microsoft Corporation
Highest reported total DPC routine time (%): 0.056810
Driver with highest DPC total execution time: USBPORT.SYS - USB 1.1 & 2.0 Port Driver, Microsoft Corporation
Total time spent in DPCs (%) 0.190041
DPC count (execution time <250 µs): 1310269
DPC count (execution time 250-500 µs): 0
DPC count (execution time 500-999 µs): 5
DPC count (execution time 1000-1999 µs): 0
DPC count (execution time 2000-3999 µs): 0
DPC count (execution time >=4000 µs): 0
_________________________________________________________________________________________________________
REPORTED HARD PAGEFAULTS
_________________________________________________________________________________________________________
Hard pagefaults are events that get triggered by making use of virtual memory that is not resident in RAM but backed by a memory mapped file on disk. The process of resolving the hard pagefault requires reading in the memory from disk while the process is interrupted and blocked from execution.
NOTE: some processes were hit by hard pagefaults. If these were programs producing audio, they are likely to interrupt the audio stream resulting in dropouts, clicks and pops. Check the Processes tab to see which programs were hit.
Process with highest pagefault count: osu!.exe
Total number of hard pagefaults 8
Hard pagefault count of hardest hit process: 6
Highest hard pagefault resolution time (µs): 33480.581667
Total time spent in hard pagefaults (%): 0.004428
Number of processes hit: 2
_________________________________________________________________________________________________________
PER CPU DATA
_________________________________________________________________________________________________________
CPU 0 Interrupt cycle time (s): 3.536192
CPU 0 ISR highest execution time (µs): 441.203333
CPU 0 ISR total execution time (s): 1.326228
CPU 0 ISR count: 284154
CPU 0 DPC highest execution time (µs): 215.38250
CPU 0 DPC total execution time (s): 1.147852
CPU 0 DPC count: 778739
_________________________________________________________________________________________________________
CPU 1 Interrupt cycle time (s): 1.401502
CPU 1 ISR highest execution time (µs): 0.0
CPU 1 ISR total execution time (s): 0.0
CPU 1 ISR count: 0
CPU 1 DPC highest execution time (µs): 19.446667
CPU 1 DPC total execution time (s): 0.000673
CPU 1 DPC count: 390
_________________________________________________________________________________________________________
CPU 2 Interrupt cycle time (s): 3.237139
CPU 2 ISR highest execution time (µs): 160.958333
CPU 2 ISR total execution time (s): 0.173386
CPU 2 ISR count: 277787
CPU 2 DPC highest execution time (µs): 221.513333
CPU 2 DPC total execution time (s): 1.041002
CPU 2 DPC count: 287776
_________________________________________________________________________________________________________
CPU 3 Interrupt cycle time (s): 5.748659
CPU 3 ISR highest execution time (µs): 644.070
CPU 3 ISR total execution time (s): 2.200240
CPU 3 ISR count: 375197
CPU 3 DPC highest execution time (µs): 607.768333
CPU 3 DPC total execution time (s): 2.038176
CPU 3 DPC count: 243369
_________________________________________________________________________________________________________

Edit2: Rolling back to older drivers does not fix the problem.

Edit: Wireless card causing the problems although it still does jump some but my mouse remains fine.

Hey,

Recently I have been having some problems with my mouse freezing randomly (Win7 64bit) and discovered the about my latency jumps. Can you please help me resolve it?

Old one

_________________________________________________________________________________________________________
CONCLUSION
_________________________________________________________________________________________________________
Your system seems to have difficulty handling real-time audio and other tasks. You may experience drop outs, clicks or pops due to buffer underruns. One problem may be related to power management, disable CPU throttling settings in Control Panel and BIOS setup. Check for BIOS updates.
LatencyMon has been analyzing your system for 0:04:09 (h:mm:ss) on processors 0,1,2 and 3.
_________________________________________________________________________________________________________
SYSTEM INFORMATION
_________________________________________________________________________________________________________
Computer name: LEWISKWONG-PC
OS version: Windows 7 , 6.1, build: 7600 (x64)
Hardware: Gigabyte Technology Co., Ltd., X79-UD3
CPU: GenuineIntel Intel® Core i7-3820 CPU @ 3.60GHz
Logical processors: 8
Processor groups: 1
RAM: 16332 MB total
_________________________________________________________________________________________________________
CPU SPEED
_________________________________________________________________________________________________________
Reported CPU speed: 3600.0 MHz
Measured CPU speed: 2265.0 MHz (approx.)
Note: reported execution times may be calculated based on a fixed reported CPU speed. Disable variable speed settings like Intel Speed Step and AMD Cool N Quiet in the BIOS setup for more accurate results.
_________________________________________________________________________________________________________
MEASURED INTERRUPT TO USER PROCESS LATENCIES
_________________________________________________________________________________________________________
The interrupt to process latency reflects the measured interval that a usermode process needed to respond to a hardware request from the moment the interrupt service routine started execution. This includes the scheduling and execution of a DPC routine, the signaling of an event and the waking up of a usermode thread from an idle wait state in response to that event.
Highest measured interrupt to process latency (µs): 1984.536148
Average measured interrupt to process latency (µs): 6.274649
Highest measured interrupt to DPC latency (µs): 182.610321
Average measured interrupt to DPC latency (µs): 1.046154
_________________________________________________________________________________________________________
REPORTED ISRs
_________________________________________________________________________________________________________
Interrupt service routines are routines installed by the OS and device drivers that execute in response to a hardware interrupt signal.
Highest ISR routine execution time (µs): 610.3750
Driver with highest ISR routine execution time: ataport.SYS - ATAPI Driver Extension, Microsoft Corporation
Highest reported total ISR routine time (%): 0.059101
Driver with highest ISR total time: hal.dll - Hardware Abstraction Layer DLL, Microsoft Corporation
Total time spent in ISRs (%) 0.157820
ISR count (execution time <250 µs): 639840
ISR count (execution time 250-500 µs): 0
ISR count (execution time 500-999 µs): 86
ISR count (execution time 1000-1999 µs): 0
ISR count (execution time 2000-3999 µs): 0
ISR count (execution time >=4000 µs): 0
_________________________________________________________________________________________________________
REPORTED DPCs
_________________________________________________________________________________________________________
DPC routines are part of the interrupt servicing dispatch mechanism and disable the possibility for a process to utilize the CPU while it is interrupted until the DPC has finished execution.
Highest DPC routine execution time (µs): 564.1050
Driver with highest DPC routine execution time: USBPORT.SYS - USB 1.1 & 2.0 Port Driver, Microsoft Corporation
Highest reported total DPC routine time (%): 0.049172
Driver with highest DPC total execution time: USBPORT.SYS - USB 1.1 & 2.0 Port Driver, Microsoft Corporation
Total time spent in DPCs (%) 0.134374
DPC count (execution time <250 µs): 957058
DPC count (execution time 250-500 µs): 0
DPC count (execution time 500-999 µs): 6
DPC count (execution time 1000-1999 µs): 0
DPC count (execution time 2000-3999 µs): 0
DPC count (execution time >=4000 µs): 0
_________________________________________________________________________________________________________
REPORTED HARD PAGEFAULTS
_________________________________________________________________________________________________________
Hard pagefaults are events that get triggered by making use of virtual memory that is not resident in RAM but backed by a memory mapped file on disk. The process of resolving the hard pagefault requires reading in the memory from disk while the process is interrupted and blocked from execution.
NOTE: some processes were hit by hard pagefaults. If these were programs producing audio, they are likely to interrupt the audio stream resulting in dropouts, clicks and pops. Check the Processes tab to see which programs were hit.
Process with highest pagefault count: osu!.exe
Total number of hard pagefaults 96
Hard pagefault count of hardest hit process: 85
Highest hard pagefault resolution time (µs): 37133.794444
Total time spent in hard pagefaults (%): 0.017166
Number of processes hit: 3
_________________________________________________________________________________________________________
PER CPU DATA
_________________________________________________________________________________________________________
CPU 0 Interrupt cycle time (s): 3.123478
CPU 0 ISR highest execution time (µs): 556.37750
CPU 0 ISR total execution time (s): 1.178334
CPU 0 ISR count: 254409
CPU 0 DPC highest execution time (µs): 181.30
CPU 0 DPC total execution time (s): 0.937595
CPU 0 DPC count: 719814
_________________________________________________________________________________________________________
CPU 1 Interrupt cycle time (s): 0.984450
CPU 1 ISR highest execution time (µs): 0.0
CPU 1 ISR total execution time (s): 0.0
CPU 1 ISR count: 0
CPU 1 DPC highest execution time (µs): 234.30
CPU 1 DPC total execution time (s): 0.002614
CPU 1 DPC count: 481
_________________________________________________________________________________________________________
CPU 2 Interrupt cycle time (s): 1.001166
CPU 2 ISR highest execution time (µs): 14.664167
CPU 2 ISR total execution time (s): 0.001173
CPU 2 ISR count: 663
CPU 2 DPC highest execution time (µs): 203.406667
CPU 2 DPC total execution time (s): 0.063621
CPU 2 DPC count: 1489
_________________________________________________________________________________________________________
CPU 3 Interrupt cycle time (s): 4.941607
CPU 3 ISR highest execution time (µs): 610.3750
CPU 3 ISR total execution time (s): 1.967040
CPU 3 ISR count: 384854
CPU 3 DPC highest execution time (µs): 564.1050
CPU 3 DPC total execution time (s): 1.675250
CPU 3 DPC count: 235280
_________________________________________________________________________________________________________
Edited by Patyfatycake
Link to comment
Share on other sites

The only devices which share an IRQ are

IRQ 16 Standard Enhanced PCI to USB Host Controller OK
IRQ 16 Intel® Management Engine Interface OK
IRQ 16 NVIDIA GeForce GT 610 OK
IRQ 16 Standard AHCI 1.0 Serial ATA Controller OK
IRQ 17 High Definition Audio Controller OK
IRQ 17 Standard AHCI 1.0 Serial ATA Controller OK
IRQ 19 Atheros AR9287 Wireless Network Adapter OK
IRQ 19 Standard AHCI 1.0 Serial ATA Controller OK
An overnight log
_________________________________________________________________________________________________________
CONCLUSION
_________________________________________________________________________________________________________
Your system appears to be having trouble handling real-time audio and other tasks. You are likely to experience buffer underruns appearing as drop outs, clicks or pops. One or more DPC routines that belong to a driver running in your system appear to be executing for too long. At least one detected problem appears to be network related. In case you are using a WLAN adapter, try disabling it to get better results. One problem may be related to power management, disable CPU throttling settings in Control Panel and BIOS setup. Check for BIOS updates.
LatencyMon has been analyzing your system for 7:10:16 (h:mm:ss) on processors 0,1,2 and 3.
_________________________________________________________________________________________________________
SYSTEM INFORMATION
_________________________________________________________________________________________________________
Computer name: LEWISKWONG-PC
OS version: Windows 7 , 6.1, build: 7600 (x64)
Hardware: Gigabyte Technology Co., Ltd., X79-UD3
CPU: GenuineIntel Intel® Core i7-3820 CPU @ 3.60GHz
Logical processors: 8
Processor groups: 1
RAM: 16332 MB total
_________________________________________________________________________________________________________
CPU SPEED
_________________________________________________________________________________________________________
Reported CPU speed: 3600.0 MHz
Measured CPU speed: 2305.0 MHz (approx.)
Note: reported execution times may be calculated based on a fixed reported CPU speed. Disable variable speed settings like Intel Speed Step and AMD Cool N Quiet in the BIOS setup for more accurate results.
_________________________________________________________________________________________________________
MEASURED INTERRUPT TO USER PROCESS LATENCIES
_________________________________________________________________________________________________________
The interrupt to process latency reflects the measured interval that a usermode process needed to respond to a hardware request from the moment the interrupt service routine started execution. This includes the scheduling and execution of a DPC routine, the signaling of an event and the waking up of a usermode thread from an idle wait state in response to that event.
Highest measured interrupt to process latency (µs): 14243.036133
Average measured interrupt to process latency (µs): 5.086741
Highest measured interrupt to DPC latency (µs): 14241.613934
Average measured interrupt to DPC latency (µs): 1.217769
_________________________________________________________________________________________________________
REPORTED ISRs
_________________________________________________________________________________________________________
Interrupt service routines are routines installed by the OS and device drivers that execute in response to a hardware interrupt signal.
Highest ISR routine execution time (µs): 657.574167
Driver with highest ISR routine execution time: ataport.SYS - ATAPI Driver Extension, Microsoft Corporation
Highest reported total ISR routine time (%): 0.062222
Driver with highest ISR total time: hal.dll - Hardware Abstraction Layer DLL, Microsoft Corporation
Total time spent in ISRs (%) 0.097536
ISR count (execution time <250 µs): 34988674
ISR count (execution time 250-500 µs): 0
ISR count (execution time 500-999 µs): 614
ISR count (execution time 1000-1999 µs): 0
ISR count (execution time 2000-3999 µs): 0
ISR count (execution time >=4000 µs): 0
_________________________________________________________________________________________________________
REPORTED DPCs
_________________________________________________________________________________________________________
DPC routines are part of the interrupt servicing dispatch mechanism and disable the possibility for a process to utilize the CPU while it is interrupted until the DPC has finished execution.
Highest DPC routine execution time (µs): 14253.13250
Driver with highest DPC routine execution time: ndis.sys - NDIS 6.20 driver, Microsoft Corporation
Highest reported total DPC routine time (%): 0.030304
Driver with highest DPC total execution time: rspLLL64.sys - Resplendence Latency Monitoring and Auxiliary Kernel Library, Resplendence Software Projects Sp.
Total time spent in DPCs (%) 0.082323
DPC count (execution time <250 µs): 78863763
DPC count (execution time 250-500 µs): 0
DPC count (execution time 500-999 µs): 26290
DPC count (execution time 1000-1999 µs): 15
DPC count (execution time 2000-3999 µs): 10
DPC count (execution time >=4000 µs): 0
_________________________________________________________________________________________________________
REPORTED HARD PAGEFAULTS
_________________________________________________________________________________________________________
Hard pagefaults are events that get triggered by making use of virtual memory that is not resident in RAM but backed by a memory mapped file on disk. The process of resolving the hard pagefault requires reading in the memory from disk while the process is interrupted and blocked from execution.
NOTE: some processes were hit by hard pagefaults. If these were programs producing audio, they are likely to interrupt the audio stream resulting in dropouts, clicks and pops. Check the Processes tab to see which programs were hit.
Process with highest pagefault count: svchost.exe
Total number of hard pagefaults 371
Hard pagefault count of hardest hit process: 111
Highest hard pagefault resolution time (µs): 292116.3450
Total time spent in hard pagefaults (%): 0.000679
Number of processes hit: 8
_________________________________________________________________________________________________________
PER CPU DATA
_________________________________________________________________________________________________________
CPU 0 Interrupt cycle time (s): 395.874130
CPU 0 ISR highest execution time (µs): 570.125833
CPU 0 ISR total execution time (s): 128.506695
CPU 0 ISR count: 26417386
CPU 0 DPC highest execution time (µs): 14253.13250
CPU 0 DPC total execution time (s): 96.497211
CPU 0 DPC count: 72219238
_________________________________________________________________________________________________________
CPU 1 Interrupt cycle time (s): 103.057376
CPU 1 ISR highest execution time (µs): 0.0
CPU 1 ISR total execution time (s): 0.0
CPU 1 ISR count: 0
CPU 1 DPC highest execution time (µs): 256.954167
CPU 1 DPC total execution time (s): 0.189743
CPU 1 DPC count: 54182
_________________________________________________________________________________________________________
CPU 2 Interrupt cycle time (s): 159.170990
CPU 2 ISR highest execution time (µs): 14.888333
CPU 2 ISR total execution time (s): 0.032037
CPU 2 ISR count: 12604
CPU 2 DPC highest execution time (µs): 204.529167
CPU 2 DPC total execution time (s): 2.242563
CPU 2 DPC count: 618491
_________________________________________________________________________________________________________
CPU 3 Interrupt cycle time (s): 289.594863
CPU 3 ISR highest execution time (µs): 657.574167
CPU 3 ISR total execution time (s): 72.900627
CPU 3 ISR count: 8559298
CPU 3 DPC highest execution time (µs): 661.170833
CPU 3 DPC total execution time (s): 71.089743
CPU 3 DPC count: 5998177
_________________________________________________________________________________________________________
Edited by Patyfatycake
Link to comment
Share on other sites

Create an account or sign in to comment

You need to be a member in order to leave a comment

Create an account

Sign up for a new account in our community. It's easy!

Register a new account

Sign in

Already have an account? Sign in here.

Sign In Now
  • Recently Browsing   0 members

    • No registered users viewing this page.
×
×
  • Create New...