TBS6285 and VDR high CPU load

[mika]

Hi,
I spent a lot of time to find problem with high cpu load. High CPU load causes problem with IR responses, tuning , ...
When I start VDR with one adapter CPU load rises to 2 and after 5 minutes drops to 0.03. There is no streaming ,no playing.
In the syslog are not any bad messages. When I use all 8 adapters CPU load is between 4 and 12 , never drops.

After problems on production platform I build computer for testing. There is only VDR and drivers. There is no problem with signal quality.

Could I ask what to do next? How check what causing that problem.

Thank you for your advice.
Miloš

Code: Select All Code


# uname -a
Linux streamer 3.2.0-4-amd64 #1 SMP Debian 3.2.57-3+deb7u2 x86_64 GNU/Linux

TBS drivers tbs-linux-drivers_v140425.zip


# top
top - 21:24:54 up  8:51,  2 users,  load average: 5.14, 3.02, 2.50
Tasks:  90 total,   1 running,  89 sleeping,   0 stopped,   0 zombie
%Cpu(s):  0.2 us,  0.7 sy,  0.0 ni, 98.3 id,  0.8 wa,  0.0 hi,  0.0 si,  0.0 st
KiB Mem:   3931580 total,   250052 used,  3681528 free,    16472 buffers
KiB Swap:  9823740 total,        0 used,  9823740 free,   110824 cached

  PID USER      PR  NI  VIRT  RES  SHR S  %CPU %MEM    TIME+  COMMAND
 9966 root      20   0  342m  28m 3332 S   2.3  0.7   0:05.46 vdr
 4333 mika      20   0 71272 1820 1012 S   0.3  0.0   0:00.58 sshd
 8290 root      20   0     0    0    0 S   0.3  0.0   0:00.34 kworker/0:1


 # cat /proc/interrupts
           CPU0       CPU1
  0:         41        108   IO-APIC-edge      timer
  1:          0          2   IO-APIC-edge      i8042
  7:          1          0   IO-APIC-edge
  8:          0          1   IO-APIC-edge      rtc0
  9:          0          0   IO-APIC-fasteoi   acpi
 12:          1          6   IO-APIC-edge      i8042
 14:          0          0   IO-APIC-edge      pata_atiixp
 15:          0          0   IO-APIC-edge      pata_atiixp
 16:          0          1   IO-APIC-fasteoi   ohci_hcd:usb2
 17:          0          2   IO-APIC-fasteoi   ohci_hcd:usb3, ohci_hcd:usb5
 18:          0          2   IO-APIC-fasteoi   ohci_hcd:usb4, ohci_hcd:usb6
 19:          0          0   IO-APIC-fasteoi   ehci_hcd:usb1
 22:         14      27576   IO-APIC-fasteoi   ahci
 43:        183     391691   PCI-MSI-edge      eth0
 44:        369     710371   PCI-MSI-edge      SAA716x Core
 45:        251     566014   PCI-MSI-edge      SAA716x Core
NMI:          5         13   Non-maskable interrupts
LOC:     396566     714959   Local timer interrupts
SPU:          0          0   Spurious interrupts
PMI:          5         13   Performance monitoring interrupts
IWI:          0          0   IRQ work interrupts
RES:     193929     146089   Rescheduling interrupts
CAL:        501        262   Function call interrupts
TLB:       3904       3155   TLB shootdowns
TRM:          0          0   Thermal event interrupts
THR:          0          0   Threshold APIC interrupts
MCE:          0          0   Machine check exceptions
MCP:        108        108   Machine check polls
ERR:          1
MIS:          0

# vmstat
procs -----------memory---------- ---swap-- -----io---- -system-- ----cpu----
 r  b   swpd   free   buff  cache   si   so    bi    bo   in   cs us sy id wa
 0  0      0 3681288  16844 110836    0    0     2     2   50   58  0  0 100  0
 
# iostat
Linux 3.2.0-4-amd64 (streamer)  09/06/14        _x86_64_        (2 CPU)

avg-cpu:  %user   %nice %system %iowait  %steal   %idle
           0.08    0.03    0.15    0.05    0.00   99.70

Device:            tps    kB_read/s    kB_wrtn/s    kB_read    kB_wrtn
sda               0.31         2.05         3.21      66315     103770
sdb               0.29         1.73         3.21      55924     103770
md0               0.44         3.69         3.19     119305     102904

# mpstat
Linux 3.2.0-4-amd64 (streamer)  09/06/14        _x86_64_        (2 CPU)

21:32:56     CPU    %usr   %nice    %sys %iowait    %irq   %soft  %steal  %guest   %idle
21:32:56     all    0.08    0.03    0.14    0.05    0.00    0.00    0.00    0.00   99.70

# uptime
 21:33:01 up  8:59,  2 users,  load average: 5.02, 4.50, 3.45

# lspci -vvvnn
03:00.0 Multimedia controller [0480]: Philips Semiconductors SAA7160 [1131:7160] (rev 02)
       Subsystem: Device [6285:0001]
       Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx+
       Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
       Latency: 0, Cache Line Size: 32 bytes
       Interrupt: pin A routed to IRQ 45
       Region 0: Memory at fdf00000 (64-bit, non-prefetchable) [size=1M]
       Capabilities: [40] MSI: Enable+ Count=1/32 Maskable- 64bit+
               Address: 00000000fee0300c  Data: 4191
       Capabilities: [50] Express (v1) Endpoint, MSI 00
               DevCap: MaxPayload 128 bytes, PhantFunc 0, Latency L0s <256ns, L1 <1us
                       ExtTag- AttnBtn- AttnInd- PwrInd- RBE- FLReset-
               DevCtl: Report errors: Correctable- Non-Fatal- Fatal- Unsupported-
                       RlxdOrd+ ExtTag- PhantFunc- AuxPwr- NoSnoop-
                       MaxPayload 128 bytes, MaxReadReq 128 bytes
               DevSta: CorrErr- UncorrErr- FatalErr- UnsuppReq- AuxPwr- TransPend-
               LnkCap: Port #1, Speed 2.5GT/s, Width x1, ASPM L0s L1, Latency L0 <4us, L1 <64us
                       ClockPM- Surprise- LLActRep- BwNot-
               LnkCtl: ASPM Disabled; RCB 128 bytes Disabled- Retrain- CommClk-
                       ExtSynch- ClockPM- AutWidDis- BWInt- AutBWInt-
               LnkSta: Speed 2.5GT/s, Width x1, TrErr- Train- SlotClk- DLActive- BWMgmt- ABWMgmt-
       Capabilities: [74] Power Management version 2
               Flags: PMEClk- DSI- D1+ D2+ AuxCurrent=0mA PME(D0+,D1+,D2+,D3hot-,D3cold-)
               Status: D0 NoSoftRst- PME-Enable- DSel=0 DScale=0 PME-
       Capabilities: [80] Vendor Specific Information: Len=50 <?>
       Capabilities: [100 v1] Vendor Specific Information: ID=0000 Rev=0 Len=088 <?>
       Kernel driver in use: SAA716x TBS

# lsmod
tbs6982fe              21981  1 saa716x_tbs_dvb
tbs6680fe              17177  1 saa716x_tbs_dvb
tbs6923fe              21981  1 saa716x_tbs_dvb
tbs6985se              17489  1 saa716x_tbs_dvb
tbs6928se              17489  1 saa716x_tbs_dvb
tbs6982se              21981  1 saa716x_tbs_dvb
tbs6991fe              17452  1 saa716x_tbs_dvb
tbs6618fe              17177  1 saa716x_tbs_dvb
saa716x_core           39763  29 saa716x_tbs_dvb
tbs6922fe              21981  1 saa716x_tbs_dvb
tbs6928fe              17452  1 saa716x_tbs_dvb
tbs6991se              17489  1 saa716x_tbs_dvb
tbs6290fe              50137  1 saa716x_tbs_dvb
stv090x                42943  1 saa716x_tbs_dvb
dvb_core               77733  6 saa716x_core,saa716x_tbs_dvb
rc_core                18329  8 ir_nec_decoder,ir_rc5_decoder,ir_rc6_decoder,ir_sony_decoder,ir_mce_kbd_decoder,ir_jvc_decoder,ir_lirc_codec,saa716x_tbs_dvb
i2c_algo_bit           12841  2 saa716x_tbs_dvb,radeon
i2c_core               23876  21  i2c_algo_bit,i2c_piix4,drm,stv090x,tbs6290fe,drm_kms_helper,tbs6991se,tbs6928fe,tbs6922fe,saa716x_core,tbs6618fe,tbs6991fe,tbs6982se,tbs6928se,tbs6985se,tbs6923fe,tbs6680fe,
       


[mika]

I tested it with VLC with the same result. Spent time in the driver is not possible to see and is really big.

[mktime]

Hi,

I have the same problem, with also a TBS6285 and Tvheadend instead of vdr.

Computer is going really slow and erratic.

To install i followed the instructions on linuxtv
http://www.linuxtv.org/wiki/index.php/TBS6285
The installation works ok like explained, the card works but it's very long to change channels (about 5 seconds) and many times my computer disconnect from the tvheadend server due to the server CPU overload.

I use ubuntu server Ubuntu 14.04 LTS (GNU/Linux 3.13.0-24-generic x86_64)

Did you manage to solve your problem?

Best regards

Here is my dmesg: (partial )


[ 172.195732] Code: b6 83 58 09 00 00 8d 50 ff 31 c0 84 d2 88 93 58 09 00 00 75 27 83 3b 03 77 75 f0 ff 43 78 66 0f 1f 84 00 00 00 00 00 48 8b 43 70 <a8> 02 75 f8 0f ae f0 48 89 df e8 0d eb ff ff 31 c0 5 b 41 5c 5d
[ 200.182957] BUG: soft lockup - CPU#7 stuck for 22s! [tvheadend:1309]
[ 200.182996] Modules linked in: lnbp21(OF) stb6100(OF) stb0899(OF) nfsd auth_rpcgss nfs_acl nfs lock d sunrpc fscache tbs62x1fe(POF) radeon rc_tbs_nec(OF) gpio_ich mxm_wmi saa716x_tbs_dvb(OF) tbs6982fe(P OF) ir_lirc_codec(OF) tbs6680fe(POF) snd_hda_codec_hdmi lirc_dev(OF) coretemp tbs6923fe(POF) tbs6985se (POF) ir_mce_kbd_decoder(OF) tbs6928se(POF) kvm_intel tbs6982se(POF) kvm tbs6991fe(POF) ir_sony_decode r(OF) tbs6618fe(POF) saa716x_core(OF) ir_jvc_decoder(OF) ttm snd_hda_codec_realtek tbs6922fe(POF) tbs6 928fe(POF) ir_rc6_decoder(OF) tbs6991se(POF) ir_rc5_decoder(OF) mantis(OF) tbs6290fe(POF) mantis_core( OF) drm_kms_helper stv090x(OF) ir_nec_decoder(OF) serio_raw dvb_core(OF) rc_core(OF) snd_hda_intel snd _hda_codec drm lpc_ich snd_hwdep snd_pcm i2c_algo_bit snd_page_alloc snd_timer snd i7core_edac soundco re edac_core lp parport wmi mac_hid pata_acpi psmouse firewire_ohci firewire_core r8169 crc_itu_t mii pata_jmicron ahci libahci
[ 200.183045] CPU: 7 PID: 1309 Comm: tvheadend Tainted: PF W O 3.13.0-24-generic #47-Ubuntu
[ 200.183047] Hardware name: Gigabyte Technology Co., Ltd. X58A-UD5/X58A-UD5, BIOS Ff1 05/15/2011
[ 200.183049] task: ffff8800360717f0 ti: ffff880035b40000 task.ti: ffff880035b40000
[ 200.183050] RIP: 0010:[<ffffffffa01eb284>] [<ffffffffa01eb284>] mantis_dvb_stop_feed+0x54/0xe0 [ma ntis_core]
[ 200.183057] RSP: 0018:ffff880035b41dc0 EFLAGS: 00000202
[ 200.183059] RAX: 0000000000000003 RBX: ffff88011fcf4440 RCX: 0000000000000001
[ 200.183061] RDX: 0000000000000000 RSI: 00000000ba3cba3a RDI: ffffc90005438000
[ 200.183062] RBP: ffff880035b41dd0 R08: 0000000000000000 R09: 0000000000000000
[ 200.183064] R10: ffff880035a3acf8 R11: ffff8800d7d0cf10 R12: ffff880035b41d48
[ 200.183065] R13: ffff88011943c7d0 R14: ffff88011943c7d0 R15: ffffffff8109df24
[ 200.183067] FS: 00007fed0cff9700(0000) GS:ffff88011fce0000(0000) knlGS:0000000000000000
[ 200.183069] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 200.183070] CR2: 0000000001eca210 CR3: 00000000360ce000 CR4: 00000000000007e0
[ 200.183072] Stack:
[ 200.183073] ffff88011966a4f0 ffffc90005438000 ffff880035b41e08 ffffffffa0228876
[ 200.183076] ffff8800d68b3bc0 ffffc90004c90008 ffffc90004c900b0 ffff8800d7d0cf00
[ 200.183079] ffffc90004c90000 ffff880035b41e28 ffffffffa0225b6a ffff88011966a7e8
[ 200.183082] Call Trace:
[ 200.183091] [<ffffffffa0228876>] dmx_ts_feed_stop_filtering+0x56/0xf0 [dvb_core]
[ 200.183096] [<ffffffffa0225b6a>] dvb_dmxdev_feed_stop+0x7a/0xf0 [dvb_core]
[ 200.183101] [<ffffffffa0225d51>] dvb_dmxdev_filter_stop+0x31/0xe0 [dvb_core]
[ 200.183106] [<ffffffffa022629a>] dvb_demux_release+0x4a/0x280 [dvb_core]
[ 200.183110] [<ffffffff811bb0a4>] __fput+0xe4/0x260
[ 200.183113] [<ffffffff811bb26e>] ____fput+0xe/0x10
[ 200.183117] [<ffffffff81088097>] task_work_run+0xa7/0xe0
[ 200.183120] [<ffffffff81013df7>] do_notify_resume+0x97/0xb0
[ 200.183124] [<ffffffff8172676a>] int_signal+0x12/0x17
[ 200.183126] Code: b6 83 58 09 00 00 8d 50 ff 31 c0 84 d2 88 93 58 09 00 00 75 27 83 3b 03 77 75 f0 ff 43 78 66 0f 1f 84 00 00 00 00 00 48 8b 43 70 <a8> 02 75 f8 0f ae f0 48 89 df e8 0d eb ff ff 31 c0 5 b 41 5c 5d
[/code]