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>
