hw.acpi.battery.life alway at 100

[Guy Brand]

On 18 avril at 10:09, Nate Lawson wrote:

> >  hw.acpi.battery.time: 94
> 
> You'll have to do more investigating.  There were no MFCs that I can see 
> to acpi between those two dates.  First, compare the output of dmesg 
> between the working and non-working kernels and see if anything has changed.

  OK. So as shown only hw.acpi.battery.life is wrong in sysctl output.
  An other symptom is related to this problem: just after a boot the
  system is weird, the keyboard is reactive (changing ttyv ok, typing
  commands ok) but answers to commands are very very slow. This
  strange state lasts around 5 minutes during which

    hw.acpi.battery.life: -1
    hw.acpi.battery.time: -1
    hw.acpi.battery.state: 7
    hw.acpi.battery.units: 1
    hw.acpi.battery.info_expire: 5

  after this delay, the logs shows a line:

    acpi_cmbat0: battery initialization done, tried 1 times
  
  and the system is responsive as usual, but the life status is wrong
  (sticked to 100) as written in my previous mail.

  I diffed the dmesg outputs, here is it:

--- mm-prerelease	Mon Apr 18 21:14:47 2005
+++ mm-stable	Mon Apr 18 21:17:07 2005
@@ -1,22 +1,22 @@
 kernel: Copyright (c) 1992-2005 The FreeBSD Project.
 kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
 kernel: The Regents of the University of California. All rights reserved.
-kernel: FreeBSD 5.4-PRERELEASE #3: Thu Mar 17 09:54:55 CET 2005
+kernel: FreeBSD 5.4-STABLE #4: Sun Apr 17 01:23:49 CEST 2005
 kernel: root at 6nq.u-strasbg.fr:/usr/obj/usr/src/sys/GENERIC
-kernel: Preloaded elf kernel "/boot/kernel.old/kernel" at 0xc0a57000.
-kernel: Preloaded elf module "/boot/kernel/sound.ko" at 0xc0a571d0.
-kernel: Preloaded elf module "/boot/kernel/snd_ich.ko" at 0xc0a5727c.
-kernel: Preloaded elf module "/boot/kernel/acpi.ko" at 0xc0a57328.
+kernel: Preloaded elf kernel "/boot/kernel/kernel" at 0xc0a60000.
+kernel: Preloaded elf module "/boot/kernel/sound.ko" at 0xc0a601cc.
+kernel: Preloaded elf module "/boot/kernel/snd_ich.ko" at 0xc0a60278.
+kernel: Preloaded elf module "/boot/kernel/acpi.ko" at 0xc0a60368.
 kernel: Table 'FACP' at 0x1f740200
 kernel: Table 'APIC' at 0x1f740300
 kernel: MADT: Found table at 0x1f740300
 kernel: APIC: Using the MADT enumerator.
 kernel: MADT: Found CPU APIC ID 0 ACPI ID 1: enabled
 kernel: ACPI APIC Table: <A M I  OEMAPIC >
-kernel: Calibrating clock(s) ... i8254 clock: 1193178 Hz
+kernel: Calibrating clock(s) ... i8254 clock: 1193180 Hz
 kernel: CLK_USE_I8254_CALIBRATION not specified - using default frequency
 kernel: Timecounter "i8254" frequency 1193182 Hz quality 0
-kernel: Calibrating TSC clock ... TSC clock: 600023526 Hz
+kernel: Calibrating TSC clock ... TSC clock: 600024615 Hz
 kernel: CPU: Intel(R) Pentium(R) M processor 1600MHz (600.02-MHz 686-class CPU)
 kernel: Origin = "GenuineIntel"  Id = 0x695  Stepping = 5
 kernel: Features=0xa7e9fbbf<FPU,VME,DE,PSE,TSC,MSR,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,TM,PBE>
@@ -91,7 +91,7 @@
 kernel: acpi0: Power Button (fixed)
 kernel: acpi_ec0: <Embedded Controller: GPE 0x1c> port 0x66,0x62 on acpi0
 kernel: AcpiOsDerivePciId: bus 0 dev 31 func 0
-kernel: ACPI timer: 1/0 1/1 1/1 1/1 1/1 1/0 1/1 1/1 1/1 1/1 -> 10
+kernel: ACPI timer: 1/1 1/1 1/1 1/1 1/1 1/0 1/1 1/1 1/0 1/1 -> 10
 kernel: Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000
 kernel: acpi_timer0: <24-bit timer at 3.579545MHz> port 0xe408-0xe40a on acpi0
 kernel: cpu0: <ACPI CPU (3 Cx states)> on acpi0
@@ -225,8 +225,6 @@
 kernel: usb0: USB revision 1.0
 kernel: uhub0: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
 kernel: uhub0: 2 ports with 2 removable, self powered
-kernel: ums0: Logitech USB-PS/2 Optical Mouse, rev 2.00/11.10, addr 2, iclass 3/1
-kernel: ums0: 3 buttons and Z dir.
 kernel: uhci1: <Intel 82801DB (ICH4) USB controller USB-B> port 0xd800-0xd81f irq 19 at device 29.1 on pci0
 kernel: uhci1: Reserved 0x20 bytes for rid 0x20 type 4 at 0xd800
 kernel: uhci1: [GIANT-LOCKED]
@@ -392,8 +390,6 @@
 kernel: atapci0: Reserved 0x8 bytes for rid 0x10 type 4 at 0x1f0
 kernel: atapci0: Reserved 0x1 bytes for rid 0x14 type 4 at 0x3f6
 kernel: ata0: reset tp1 mask=03 ostat0=50 ostat1=00
-kernel: ata0-master: stat=0x80 err=0x80 lsb=0x80 msb=0x80
-last message repeated 2 times
 kernel: ata0-master: stat=0x50 err=0x01 lsb=0x00 msb=0x00
 kernel: ata0-slave:  stat=0x00 err=0x01 lsb=0x00 msb=0x00
 kernel: ata0: reset tp2 stat0=50 stat1=00 devices=0x1<ATA_MASTER>
@@ -415,9 +411,9 @@
 kernel: pcm0: <Analog Devices AD1885 AC97 Codec (id = 0x41445360)>
 kernel: pcm0: Codec features headphone, 6 bit master volume, Analog Devices Phat Stereo
 kernel: pcm0: Primary codec extended features variable rate PCM
-kernel: pcm0: sndbuf_setmap 1eb92000, 4000; 0xdd074000 -> 1eb92000
-kernel: pcm0: sndbuf_setmap 1eb8e000, 4000; 0xdd078000 -> 1eb8e000
-kernel: pci0: <simple comms> at device 31.6 (no driver attached)
+kernel: pcm0: sndbuf_setmap 1eb94000, 4000; 0xdd06d000 -> 1eb94000
+kernel: pcm0: sndbuf_setmap 1eb90000, 4000; 0xdd071000 -> 1eb90000
+kernel: pci0: <simple comms, generic modem> at device 31.6 (no driver attached)
 kernel: acpi_button0: <Sleep Button> on acpi0
 kernel: acpi_lid0: <Control Method Lid Switch> on acpi0
 kernel: acpi_tz0: <Thermal Zone> on acpi0
@@ -512,9 +508,11 @@
 kernel: 3d 3e 3f 0c 00 0f 08 00 00 00 00 00 10 0e 00 ff 
 kernel: vt0: not probed (disabled)
 kernel: isa_probe_children: probing PnP devices
+kernel: ums0: Logitech USB-PS/2 Optical Mouse, rev 2.00/11.10, addr 2, iclass 3/1
+kernel: ums0: 3 buttons and Z dir.
 kernel: Device configuration finished.
 kernel: procfs registered
-kernel: Timecounter "TSC" frequency 600023526 Hz quality 800
+kernel: Timecounter "TSC" frequency 600024615 Hz quality 800
 kernel: Timecounters tick every 10.000 msec
 kernel: lo0: bpf attached
 kernel: acpi_acad0: acline initialization start
@@ -532,7 +530,7 @@
 kernel: ad0: 16 secs/int, 1 depth queue, UDMA100
 kernel: GEOM: new disk ad0
 kernel: ar: FreeBSD check1 failed
-kernel: pcm0: measured ac97 link rate at 48007 Hz, will use 48000 Hz
+kernel: pcm0: measured ac97 link rate at 48008 Hz, will use 48000 Hz
 kernel: [0] f:80 typ:165 s(CHS):0/1/1 e(CHS):1023/254/63 s:63 l:117210177
 kernel: [1] f:00 typ:0 s(CHS):0/0/0 e(CHS):0/0/0 s:0 l:0
 kernel: [2] f:00 typ:0 s(CHS):0/0/0 e(CHS):0/0/0 s:0 l:0
@@ -556,14 +554,15 @@
 kernel: [1] f:00 typ:0 s(CHS):0/0/0 e(CHS):0/0/0 s:0 l:0
 kernel: [2] f:00 typ:0 s(CHS):0/0/0 e(CHS):0/0/0 s:0 l:0
 kernel: [3] f:80 typ:165 s(CHS):0/0/1 e(CHS):1023/254/63 s:0 l:50000
+kernel: acpi_ec0: info: new max delay is 100 us
 kernel: acpi_ec0: info: new max delay is 120 us
 kernel: acpi_ec0: info: new max delay is 220 us
-kernel: (probe0:sbp0:0:0:0): error 22
-kernel: (probe0:sbp0:0:0:0): Unretryable Error
 kernel: (probe1:sbp0:0:1:0): error 22
 kernel: (probe1:sbp0:0:1:0): Unretryable Error
 kernel: (probe2:sbp0:0:2:0): error 22
 kernel: (probe2:sbp0:0:2:0): Unretryable Error
+kernel: (probe0:sbp0:0:0:0): error 22
+kernel: (probe0:sbp0:0:0:0): Unretryable Error
 kernel: (probe3:sbp0:0:3:0): error 22
 kernel: (probe3:sbp0:0:3:0): Unretryable Error
 kernel: (probe4:sbp0:0:4:0): error 22
@@ -587,3 +586,9 @@
 kernel: Mounting root from ufs:/dev/ad0s1a
 kernel: start_init: trying /sbin/init
 kernel: splash: image decoder found: logo_saver
+kernel: acpi_ec0: info: new max delay is 610 us
+kernel: acpi_ec0: info: new max delay is 630 us
+kernel: acpi_ec0: info: new max delay is 820 us
+kernel: acpi_cmbat0: battery initialization failed, giving up
+kernel: acpi_ec0: info: new max delay is 930 us

  gb