Buffer re-sync / Audio issues

I have a new a1200p with 4 fxo modules installed.
This is in a Dell Optiplex GX280


There is also D210P installed but not being used yet.


The A1200P has it's own IRQ, the D210P is sharing for now.


Asterisk 1.6.0.216
DAHDI 2.2.1
CentOS 5.4


Everything is working fine except for fairly loud random clicking during calls, both inbound and outbound.
These appear to coincide with "buffer re-sync occur from 0 to 3" though not every re-sync message causes a click, there is a message almost immediately after every click.


I have already set the PCI_Latency per recommendations:

---

02:00.0 Ethernet controller: Broadcom Corporation NetXtreme BCM5751 Gigabit Ethernet PCI Express (rev 01)
Subsystem: Dell Optiplex GX280
Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B-
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR-
Latency: 0, Cache Line Size: 64 bytes
Interrupt: pin A routed to IRQ 169
Region 0: Memory at dfcf0000 (64-bit, non-prefetchable) [size=64K]
Expansion ROM at <ignored> [disabled]
Capabilities: [48] Power Management version 2
Flags: PMEClk- DSI- D1- D2- AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot+,D3cold+)
Status: D0 PME-Enable- DSel=0 DScale=1 PME-
Capabilities: [50] Vital Product Data
Capabilities: [58] Message Signalled Interrupts: 64bit+ Queue=0/3 Enable-
Address: cff004ad92896308 Data: 5814
Capabilities: [d0] Express Endpoint IRQ 0
Device: Supported: MaxPayload 128 bytes, PhantFunc 0, ExtTag+
Device: Latency L0s <4us, L1 unlimited
Device: AtnBtn- AtnInd- PwrInd-
Device: Errors: Correctable- Non-Fatal+ Fatal+ Unsupported-
Device: RlxdOrd- ExtTag- PhantFunc- AuxPwr- NoSnoop-
Device: MaxPayload 128 bytes, MaxReadReq 4096 bytes
Link: Supported Speed 2.5Gb/s, Width x1, ASPM L0s, Port 0
Link: Latency L0s <2us, L1 <64us
Link: ASPM Disabled RCB 64 bytes CommClk- ExtSynch-
Link: Speed 2.5Gb/s, Width x1
Capabilities: [100] Advanced Error Reporting
Capabilities: [13c] Virtual Channel




04:01.0 Communication controller: Tiger Jet Network Inc. Tiger3XX Modem/ISDN interface
Subsystem: Unknown device 9100:0003
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B-
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR-
Latency: 64 (250ns min, 32000ns max)
Interrupt: pin A routed to IRQ 177
Region 0: I/O ports at dc00
Region 1: Memory at dfaff000 (32-bit, non-prefetchable) [size=4K]
Capabilities: [40] Power Management version 2
Flags: PMEClk- DSI+ D1- D2+ AuxCurrent=55mA PME(D0+,D1-,D2+,D3hot+,D3cold+)
Status: D0 PME-Enable- DSel=0 DScale=0 PME+


04:02.0 Communication controller: Digium, Inc. Wildcard TE210P dual-span T1/E1/J1 card 3.3V (rev 02)
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B-
Status: Cap- 66MHz- UDF- FastB2B- ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR-
Latency: 32
Interrupt: pin A routed to IRQ 233
Region 0: Memory at dfafef80 (32-bit, non-prefetchable)

---

I also added the following to my /etc/modprobe.d/blacklist:
blacklist isdn
blacklist hisax
blacklist netjetpci


Please advise.


Thanks!!

i] Last edited by fifer at 2010-3-25 02:12 [/i

hello:
have you tried to change to other hardware platform? i think it might be a compatibility issue.

Hi fifer:
if keep flushing those message, then maybe there is a hardware compatibility issue. if only one or two times, you can ignore that.

While I don't mean this as too much of a complaint, just pointing the finger is not going to help all of those who are running into this issue.
I do NOT have another machine I can use that will fair any better and can take a full length PCI slot.


I have already as of just an hour ago made a vast improvement though not be trying anything sugested to anyone in the past on this issue or just not to my request.


I simply moved the card to a diferent PCI slot, one not available before due to an upstruction (now removed with some tin snips) and rather than getting the buffer re-sync messages between 20-60 a min:


Mar 24 15:18:52 asterisk kernel: buffer re-sync occur from 1 to 2
Mar 24 15:18:52 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 24 15:18:53 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:18:53 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 24 15:18:53 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:18:56 asterisk kernel: buffer re-sync occur from 0 to 2
Mar 24 15:18:56 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 24 15:18:57 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:18:57 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 24 15:18:57 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:00 asterisk kernel: buffer re-sync occur from 0 to 2
Mar 24 15:19:02 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 24 15:19:02 asterisk kernel: buffer re-sync occur from 1 to 2
Mar 24 15:19:02 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 24 15:19:03 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:04 asterisk kernel: buffer re-sync occur from 0 to 2
Mar 24 15:19:05 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 24 15:19:06 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:06 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 24 15:19:06 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:08 asterisk kernel: buffer re-sync occur from 0 to 3
Mar 24 15:19:11 asterisk kernel: buffer re-sync occur from 3 to 1
Mar 24 15:19:11 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:13 asterisk kernel: buffer re-sync occur from 0 to 2
Mar 24 15:19:15 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 24 15:19:15 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:15 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 24 15:19:15 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:17 asterisk kernel: buffer re-sync occur from 0 to 2
Mar 24 15:19:17 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 24 15:19:18 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:21 asterisk kernel: buffer re-sync occur from 0 to 3
Mar 24 15:19:27 asterisk kernel: buffer re-sync occur from 3 to 2
Mar 24 15:19:29 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 24 15:19:29 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:32 asterisk kernel: buffer re-sync occur from 0 to 3
Mar 24 15:19:34 asterisk kernel: buffer re-sync occur from 3 to 1
Mar 24 15:19:36 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:36 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 24 15:19:36 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:47 asterisk kernel: buffer re-sync occur from 0 to 3
Mar 24 15:19:52 asterisk kernel: buffer re-sync occur from 3 to 1
Mar 24 15:19:53 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:55 asterisk kernel: buffer re-sync occur from 0 to 3
Mar 24 15:19:56 asterisk kernel: buffer re-sync occur from 3 to 2
Mar 24 15:19:58 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 24 15:19:59 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:59 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 24 15:19:59 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 24 15:19:59 asterisk kernel: buffer re-sync occur from 0 to 3




I now only get them every 1-6 min in groups of 1-6.


Mar 25 09:37:23 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 09:37:23 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 25 09:37:23 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 09:37:30 asterisk kernel: buffer re-sync occur from 0 to 3
Mar 25 09:40:42 asterisk kernel: buffer re-sync occur from 3 to 2
Mar 25 09:40:52 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 25 09:40:52 asterisk kernel: buffer re-sync occur from 1 to 2
Mar 25 09:40:52 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 25 09:41:21 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 09:41:21 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 25 09:41:21 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 09:42:32 asterisk kernel: buffer re-sync occur from 0 to 3
Mar 25 09:43:06 asterisk kernel: buffer re-sync occur from 3 to 2
Mar 25 09:43:51 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 25 09:44:05 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 09:44:05 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 25 09:44:05 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 09:46:09 asterisk kernel: buffer re-sync occur from 0 to 3
Mar 25 09:47:31 asterisk kernel: buffer re-sync occur from 3 to 2
Mar 25 09:47:36 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 25 09:47:37 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 09:47:37 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 25 09:47:37 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 09:49:46 asterisk kernel: buffer re-sync occur from 0 to 2
Mar 25 09:49:48 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 25 09:49:52 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 09:49:52 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 25 09:49:52 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 09:50:20 asterisk kernel: buffer re-sync occur from 0 to 2
Mar 25 09:50:47 asterisk kernel: buffer re-sync occur from 2 to 1
Mar 25 09:50:54 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 09:50:54 asterisk kernel: buffer re-sync occur from 0 to 1
Mar 25 09:50:54 asterisk kernel: buffer re-sync occur from 1 to 0
Mar 25 10:01:30 asterisk kernel: buffer re-sync occur from 0 to 3




I'm not sure if this has fixed the clicking issue as I would have to do enough testing to insure I had spent time in multiple calls during these messages.


I will report back further though on my progress.


That all said, I'm not at all satisfied with this resolution. I had worked card to insure the card did not share an IRQ before but now it does, as does the D210P we also have in this box.


[root@asterisk ~]# cat /proc/interrupts
CPU0
0: 917519 IO-APIC-edge timer
1: 3 IO-APIC-edge i8042
8: 3 IO-APIC-edge rtc
9: 0 IO-APIC-level acpi
12: 4 IO-APIC-edge i8042
14: 7758 IO-APIC-edge ide0
50: 57 IO-APIC-level uhci_hcd:usb5
58: 8305 IO-APIC-level ata_piix
169: 2174 IO-APIC-level eth0, wct2xxp
217: 3 IO-APIC-level ehci_hcd:usb1, uhci_hcd:usb2
225: 0 IO-APIC-level uhci_hcd:usb3
233: 877954 IO-APIC-level uhci_hcd:usb4, opvxa1200
NMI: 0
LOC: 917457
ERR: 0
MIS: 0


Since I have been composing this post, I have watched the messages come in at an average of 2 per minute.


Again, much better then before, but not ideal.


Please advise further!


Thanks!

i] Last edited by fifer at 2010-3-26 01:04 [/i

Hi fifer:
Changed the PCI latency timer of the ethernet card to 0 (down from 64), while leaving the a1200p at 64.