Skip site navigation (1)Skip section navigation (2)
Date:      Tue, 5 Nov 2013 20:27:49 +0100
From:      Oliver Pinter <oliver.pntr@gmail.com>
To:        Adrian Chadd <adrian@freebsd.org>
Cc:        Davide Italiano <davide@freebsd.org>, Alexander Motin <mav@freebsd.org>, FreeBSD Stable Mailing List <freebsd-stable@freebsd.org>, "current@freebsd.org" <current@freebsd.org>
Subject:   Re: [10-STABLE, 11-CURRENT] something wrong between cam and eventtimer or geom and eventtimer
Message-ID:  <CAPjTQNEhru6xjzum1qBTnJgKgoRCigSbybdi49%2BWoLoq563Sng@mail.gmail.com>
In-Reply-To: <CAPjTQNFEKp=XdT3o9KGhY1c2TWPOEfrAr2VvzFy=0f5_M-onfg@mail.gmail.com>
References:  <CAPjTQNF5Q=sPaTSpjnwpVOjiM9e70T0ve-GQ71Sv0zHx_Az7dg@mail.gmail.com> <CAJ-Vmokx6iLcNqjPzVB%2BHxsQxN4NaLkV1%2BEGREOsW7SyjqFNcw@mail.gmail.com> <CAPjTQNHi_7vLZvGzA_ad_M8e_X_n-EuLzA8dGsX9t9XP8VdwjA@mail.gmail.com> <CAJ-Vmok7uC72-a9g-e-UGHMYADpEUgW%2BH4_MB8eC1MBvT9w83Q@mail.gmail.com> <CAPjTQNFEKp=XdT3o9KGhY1c2TWPOEfrAr2VvzFy=0f5_M-onfg@mail.gmail.com>

next in thread | previous in thread | raw e-mail | index | archive | help

[-- Attachment #1 --]
dmesg corrected

On 11/5/13, Oliver Pinter <oliver.pntr@gmail.com> wrote:
> On 11/5/13, Adrian Chadd <adrian@freebsd.org> wrote:
>> Ok, so it's only hitting C1. It's not going into C2.
>>
>> Is this a dual core CPU with hyperthreading enabled, or a quad core CPU?
>
> quad core, i5-4670
>
>>
>> How about changing the idle loop from acpi to hlt, see if that fixes
>> things? (Without tweaking the event timer logic.)
>
> Now, after reboot, the problem has gone. The other symptom are: on vt
> switching is laggish, and switching the num lock state delayed
> ~0.5sec.
>
> This are reproducible ~ every 10-15th boot.
>
>>
>> I'm worried that what you're seeing here are missed interrupts or
>> interrupts that aren't immediately causing the driver thread to be
>> scheduled (and thus things enter HLT until the next interrupt.) I had
>> to deal with this crap on MIPS for quite some time.
>>
>> sysctl machdep.idle=hlt
>>
>>
>>
>> -adrian
>>
>>
>> On 5 November 2013 09:25, Oliver Pinter <oliver.pntr@gmail.com> wrote:
>>> op@perpetua ~> sysctl dev.cpu
>>> dev.cpu.0.%desc: ACPI CPU
>>> dev.cpu.0.%driver: cpu
>>> dev.cpu.0.%location: handle=\_PR_.CPU0
>>> dev.cpu.0.%pnpinfo: _HID=none _UID=0
>>> dev.cpu.0.%parent: acpi0
>>> dev.cpu.0.coretemp.delta: 59
>>> dev.cpu.0.coretemp.resolution: 1
>>> dev.cpu.0.coretemp.tjmax: 100.0C
>>> dev.cpu.0.coretemp.throttle_log: 0
>>> dev.cpu.0.temperature: 41.0C
>>> dev.cpu.0.freq_levels: 3401/84000 3400/84000 3200/77169 3000/70587
>>> 2800/64262 2700/61182 2500/55201 2300/49464 2100/43946 1900/38654
>>> 1700/34277 1500/29407 1400/27053 1225/23671 1200/22509 1050/19695
>>> 1000/18167 875/15896 800/14031 700/12277 600/10523 500/8769 400/7015
>>> 300/5261 200/3507 100/1753
>>> dev.cpu.0.cx_supported: C1/1/1 C2/2/67
>>> dev.cpu.0.cx_lowest: C1
>>> dev.cpu.0.cx_usage: 100.00% 0.00% last 812us
>>> dev.cpu.1.%desc: ACPI CPU
>>> dev.cpu.1.%driver: cpu
>>> dev.cpu.1.%location: handle=\_PR_.CPU1
>>> dev.cpu.1.%pnpinfo: _HID=none _UID=0
>>> dev.cpu.1.%parent: acpi0
>>> dev.cpu.1.coretemp.delta: 56
>>> dev.cpu.1.coretemp.resolution: 1
>>> dev.cpu.1.coretemp.tjmax: 100.0C
>>> dev.cpu.1.coretemp.throttle_log: 0
>>> dev.cpu.1.temperature: 44.0C
>>> dev.cpu.1.cx_supported: C1/1/1 C2/2/67
>>> dev.cpu.1.cx_lowest: C1
>>> dev.cpu.1.cx_usage: 100.00% 0.00% last 1348us
>>> dev.cpu.2.%desc: ACPI CPU
>>> dev.cpu.2.%driver: cpu
>>> dev.cpu.2.%location: handle=\_PR_.CPU2
>>> dev.cpu.2.%pnpinfo: _HID=none _UID=0
>>> dev.cpu.2.%parent: acpi0
>>> dev.cpu.2.coretemp.delta: 61
>>> dev.cpu.2.coretemp.resolution: 1
>>> dev.cpu.2.coretemp.tjmax: 100.0C
>>> dev.cpu.2.coretemp.throttle_log: 0
>>> dev.cpu.2.temperature: 39.0C
>>> dev.cpu.2.cx_supported: C1/1/1 C2/2/67
>>> dev.cpu.2.cx_lowest: C1
>>> dev.cpu.2.cx_usage: 100.00% 0.00% last 845us
>>> dev.cpu.3.%desc: ACPI CPU
>>> dev.cpu.3.%driver: cpu
>>> dev.cpu.3.%location: handle=\_PR_.CPU3
>>> dev.cpu.3.%pnpinfo: _HID=none _UID=0
>>> dev.cpu.3.%parent: acpi0
>>> dev.cpu.3.coretemp.delta: 62
>>> dev.cpu.3.coretemp.resolution: 1
>>> dev.cpu.3.coretemp.tjmax: 100.0C
>>> dev.cpu.3.coretemp.throttle_log: 0
>>> dev.cpu.3.temperature: 38.0C
>>> dev.cpu.3.cx_supported: C1/1/1 C2/2/67
>>> dev.cpu.3.cx_lowest: C1
>>> dev.cpu.3.cx_usage: 100.00% 0.00% last 1609us
>>>
>>> On 11/5/13, Adrian Chadd <adrian@freebsd.org> wrote:
>>>> Hi!
>>>>
>>>> Can you do 'sysctl dev.cpu' please? I'd like to see what sleep
>>>> state(s) your CPU is entering.
>>>>
>>>> Thanks!
>>>>
>>>>
>>>> -adrian
>>>>
>>>>
>>>> On 5 November 2013 06:07, Oliver Pinter <oliver.pntr@gmail.com> wrote:
>>>>> Hi all!
>>>>>
>>>>> The machine is a Haswell machine, the disc performance was very poor
>>>>> (20-30MByte/sec).
>>>>> When I change the kern.eventtimer.idletick from 0 to 1, the normal
>>>>> performance restored back to normal (70-90MByte/sec).
>>>>>
>>>>> The default eventtimer was LAPIC.
>>>>>
>>>>> On other machine Q9300, this was fully reproducible.
>>>>> _______________________________________________
>>>>> freebsd-current@freebsd.org mailing list
>>>>> http://lists.freebsd.org/mailman/listinfo/freebsd-current
>>>>> To unsubscribe, send any mail to
>>>>> "freebsd-current-unsubscribe@freebsd.org"
>>>>
>>
>

[-- Attachment #2 --]
Copyright (c) 1992-2013 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
	The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 10.0-BETA2 #2 e4e20a2(integrate/10): Fri Nov  1 03:27:43 CET 2013
    root@perpetua.bercsenyi.bme.hu:/usr/obj/usr/src/sys/OP amd64
FreeBSD clang version 3.3 (tags/RELEASE_33/final 183502) 20130610
CPU: Intel(R) Core(TM) i5-4670 CPU @ 3.40GHz (3392.22-MHz K8-class CPU)
  Origin = "GenuineIntel"  Id = 0x306c3  Family = 0x6  Model = 0x3c  Stepping = 3
  Features=0xbfebfbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE>
  Features2=0x7ffafbff<SSE3,PCLMULQDQ,DTES64,MON,DS_CPL,VMX,SMX,EST,TM2,SSSE3,<b11>,FMA,CX16,xTPR,PDCM,PCID,SSE4.1,SSE4.2,x2APIC,MOVBE,POPCNT,TSCDLT,AESNI,XSAVE,OSXSAVE,AVX,F16C,RDRAND>
  AMD Features=0x2c100800<SYSCALL,NX,Page1GB,RDTSCP,LM>
  AMD Features2=0x21<LAHF,ABM>
  Standard Extended Features=0x2fbb<GSFSBASE,TSCADJ,BMI1,HLE,AVX2,SMEP,BMI2,ENHMOVSB,INVPCID,RTM>
  TSC: P-state invariant, performance statistics
real memory  = 8589934592 (8192 MB)
avail memory = 8224169984 (7843 MB)
Event timer "LAPIC" quality 600
ACPI APIC Table: <ALASKA A M I>
FreeBSD/SMP: Multiprocessor System Detected: 4 CPUs
FreeBSD/SMP: 1 package(s) x 4 core(s)
 cpu0 (BSP): APIC ID:  0
 cpu1 (AP): APIC ID:  2
 cpu2 (AP): APIC ID:  4
 cpu3 (AP): APIC ID:  6
ioapic0 <Version 2.0> irqs 0-23 on motherboard
random: <Software, Yarrow> initialized
kbd1 at kbdmux0
aesni0: <AES-CBC,AES-XTS> on motherboard
cryptosoft0: <software crypto> on motherboard
acpi0: <ALASKA A M I> on motherboard
acpi0: Power Button (fixed)
acpi0: reservation of 67, 1 (4) failed
cpu0: <ACPI CPU> on acpi0
cpu1: <ACPI CPU> on acpi0
cpu2: <ACPI CPU> on acpi0
cpu3: <ACPI CPU> on acpi0
hpet0: <High Precision Event Timer> iomem 0xfed00000-0xfed003ff on acpi0
Timecounter "HPET" frequency 14318180 Hz quality 950
Event timer "HPET" frequency 14318180 Hz quality 550
Event timer "HPET1" frequency 14318180 Hz quality 440
Event timer "HPET2" frequency 14318180 Hz quality 440
Event timer "HPET3" frequency 14318180 Hz quality 440
Event timer "HPET4" frequency 14318180 Hz quality 440
atrtc0: <AT realtime clock> port 0x70-0x77 irq 8 on acpi0
atrtc0: Warning: Couldn't map I/O.
Event timer "RTC" frequency 32768 Hz quality 0
attimer0: <AT timer> port 0x40-0x43,0x50-0x53 irq 0 on acpi0
Timecounter "i8254" frequency 1193182 Hz quality 0
Event timer "i8254" frequency 1193182 Hz quality 100
Timecounter "ACPI-fast" frequency 3579545 Hz quality 900
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1808-0x180b on acpi0
pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib0
pcib1: <ACPI PCI-PCI bridge> irq 16 at device 1.0 on pci0
pci1: <ACPI PCI bus> on pcib1
vgapci0: <VGA-compatible display> port 0xe000-0xe0ff mem 0xe0000000-0xefffffff,0xf0020000-0xf003ffff irq 16 at device 0.0 on pci1
hdac0: <ATI RV810 HDA Controller> mem 0xf0040000-0xf0043fff irq 17 at device 0.1 on pci1
xhci0: <Intel Lynx Point USB 3.0 controller> mem 0xf0320000-0xf032ffff irq 16 at device 20.0 on pci0
xhci0: 32 byte context size.
xhci0: Port routing mask set to 0xffffffff
usbus0 on xhci0
pci0: <simple comms> at device 22.0 (no driver attached)
pci0: <simple comms, UART> at device 22.3 (no driver attached)
em0: <Intel(R) PRO/1000 Network Connection 7.3.8> port 0xf040-0xf05f mem 0xf0300000-0xf031ffff,0xf0339000-0xf0339fff irq 20 at device 25.0 on pci0
em0: Using an MSI interrupt
em0: Ethernet address: 94:de:80:xx:xx:xx
ehci0: <EHCI (generic) USB 2.0 controller> mem 0xf0338000-0xf03383ff irq 16 at device 26.0 on pci0
usbus1: EHCI version 1.0
usbus1 on ehci0
hdac1: <Intel Lynx Point HDA Controller> mem 0xf0330000-0xf0333fff irq 22 at device 27.0 on pci0
pcib2: <ACPI PCI-PCI bridge> irq 16 at device 28.0 on pci0
pci2: <ACPI PCI bus> on pcib2
pcib3: <ACPI PCI-PCI bridge> irq 19 at device 28.3 on pci0
pci3: <ACPI PCI bus> on pcib3
pci3: <network, ethernet> at device 0.0 (no driver attached)
pcib4: <ACPI PCI-PCI bridge> irq 16 at device 28.4 on pci0
pci4: <ACPI PCI bus> on pcib4
iwn0: <Intel Centrino Wireless-N 2230> mem 0xf0100000-0xf0101fff irq 16 at device 0.0 on pci4
iwn0: adapter type 12 not supported
iwn0: could not attach device, error 45
device_attach: iwn0 attach returned 45
ehci1: <EHCI (generic) USB 2.0 controller> mem 0xf0337000-0xf03373ff irq 23 at device 29.0 on pci0
usbus2: EHCI version 1.0
usbus2 on ehci1
isab0: <PCI-ISA bridge> at device 31.0 on pci0
isa0: <ISA bus> on isab0
ahci0: <Intel Lynx Point AHCI SATA controller> port 0xf090-0xf097,0xf080-0xf083,0xf070-0xf077,0xf060-0xf063,0xf020-0xf03f mem 0xf0336000-0xf03367ff irq 19 at device 31.2 on pci0
ahci0: AHCI v1.30 with 6 6Gbps ports, Port Multiplier not supported
ahcich0: <AHCI channel> at channel 0 on ahci0
ahcich1: <AHCI channel> at channel 1 on ahci0
ahcich2: <AHCI channel> at channel 2 on ahci0
ahcich3: <AHCI channel> at channel 3 on ahci0
ahcich4: <AHCI channel> at channel 4 on ahci0
ahcich5: <AHCI channel> at channel 5 on ahci0
ahciem0: <AHCI enclosure management bridge> on ahci0
pci0: <serial bus, SMBus> at device 31.3 (no driver attached)
acpi_button0: <Power Button> on acpi0
acpi_tz0: <Thermal Zone> on acpi0
acpi_tz1: <Thermal Zone> on acpi0
uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0
uart0: console (9600,n,8,1)
sc0: <System console> at flags 0x100 on isa0
sc0: VGA <16 virtual consoles, flags=0x300>
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
atkbdc0: <Keyboard controller (i8042)> at port 0x60,0x64 on isa0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
coretemp0: <CPU On-Die Thermal Sensors> on cpu0
est0: <Enhanced SpeedStep Frequency Control> on cpu0
p4tcc0: <CPU Frequency Thermal Control> on cpu0
coretemp1: <CPU On-Die Thermal Sensors> on cpu1
est1: <Enhanced SpeedStep Frequency Control> on cpu1
p4tcc1: <CPU Frequency Thermal Control> on cpu1
coretemp2: <CPU On-Die Thermal Sensors> on cpu2
est2: <Enhanced SpeedStep Frequency Control> on cpu2
p4tcc2: <CPU Frequency Thermal Control> on cpu2
coretemp3: <CPU On-Die Thermal Sensors> on cpu3
est3: <Enhanced SpeedStep Frequency Control> on cpu3
p4tcc3: <CPU Frequency Thermal Control> on cpu3
Timecounters tick every 10.000 msec
ipfw2 (+ipv6) initialized, divert loadable, nat loadable, default to deny, logging disabled
hdacc0: <ATI R6xx HDA CODEC> at cad 0 on hdac0
hdaa0: <ATI R6xx Audio Function Group> at nid 1 on hdacc0
pcm0: <ATI R6xx (HDMI)> at nid 3 on hdaa0
hdacc1: <Realtek ALC892 HDA CODEC> at cad 2 on hdac1
hdaa1: <Realtek ALC892 Audio Function Group> at nid 1 on hdacc1
pcm1: <Realtek ALC892 (Rear Analog 5.1/2.0)> at nid 20,22,21 and 24,26 on hdaa1
pcm2: <Realtek ALC892 (Front Analog)> at nid 27 and 25 on hdaa1
pcm3: <Realtek ALC892 (Onboard Digital)> at nid 17 on hdaa1
pcm4: <Realtek ALC892 (Rear Digital)> at nid 30 on hdaa1
random: unblocking device.
usbus0: 5.0Gbps Super Speed USB v3.0
usbus1: 480Mbps High Speed USB v2.0
ugen0.1: <0x8086> at usbus0
uhub0: <0x8086 XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
ugen1.1: <Intel> at usbus1
uhub1: <Intel EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus1
usbus2: 480Mbps High Speed USB v2.0
ugen2.1: <Intel> at usbus2
uhub2: <Intel EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus2
ses0 at ahciem0 bus 0 scbus6 target 0 lun 0
ses0: <AHCI SGPIO Enclosure 1.00 0001> SEMB S-E-S 2.00 device
ses0: SEMB SES Device
ada0 at ahcich0 bus 0 scbus0 target 0 lun 0
ada0: <Hitachi HDP725050GLA360 GM4OA52A> ATA-8 SATA 2.x device
ada0: Serial Number GEA530RF0KSB4A
ada0: 300.000MB/s transfers (SATA 2.x, UDMA6, PIO 8192bytes)
ada0: Command Queueing enabled
ada0: 476940MB (976773168 512 byte sectors: 16H 63S/T 16383C)
ada0: Previously was known as ad0
ada1 at ahcich1 bus 0 scbus1 target 0 lun 0
ada1: <Hitachi HDP725050GLA360 GM4OA52A> ATA-8 SATA 2.x device
ada1: Serial Number GEA530RF0KKX7A
ada1: 300.000MB/s transfers (SATA 2.x, UDMA6, PIO 8192bytes)
ada1: Command Queueing enabled
ada1: 476940MB (976773168 512 byte sectors: 16H 63S/T 16383C)
ada1: Previously was known as ad1
SMP: AP CPU #3 Launched!
SMP: AP CPU #2 Launched!
SMP: AP CPU #1 Launched!
Timecounter "TSC-low" frequency 1696109148 Hz quality 1000
uhub1: 2 ports with 2 removable, self powered
Root mount waiting for: usbus2 usbus1 usbus0
uhub2: 2 ports with 2 removable, self powered
uhub0: 21 ports with 21 removable, self powered
ugen1.2: <vendor 0x8087> at usbus1
uhub3: <vendor 0x8087 product 0x8008, class 9/0, rev 2.00/0.04, addr 2> on usbus1
xhci0: Port routing mask set to 0x00000000
usb_alloc_device: device init 2 failed (USB_ERR_IOERROR, ignored)
ugen0.2: <Unknown> at usbus0 (disconnected)
Root mount waiting for: usbus2 usbus1 usbus0
uhub_reattach_port: could not allocate new device
uhub3: 6 ports with 6 removable, self powered
ugen2.2: <vendor 0x8087> at usbus2
uhub4: <vendor 0x8087 product 0x8000, class 9/0, rev 2.00/0.04, addr 2> on usbus2
uhub4: 8 ports with 8 removable, self powered
ugen1.3: <Microsoft> at usbus1
ukbd0: <Microsoft Natural Ergonomic Keyboard 4000, class 0/0, rev 2.00/1.73, addr 3> on usbus1
kbd2 at ukbd0
ugen1.4: <Logitech> at usbus1
Root mount waiting for: usbus1
ukbd1: <Logitech USB Receiver, class 0/0, rev 1.10/38.10, addr 4> on usbus1
kbd3 at ukbd1
ums0: <Logitech USB Receiver, class 0/0, rev 1.10/38.10, addr 4> on usbus1
ums0: 10 buttons and [XYZT] coordinates ID=2
ugen1.5: <vendor 0x8087> at usbus1
Root mount waiting for: usbus1
Trying to mount root from ufs:/dev/gpt/perpetuaROOT [rw]...

Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?CAPjTQNEhru6xjzum1qBTnJgKgoRCigSbybdi49%2BWoLoq563Sng>