[原创]AC In/Out OS Slow Response

peterhu

AC In/Out OS Slow Response

8 U2 t+ o) H/ ]

• Phenomenon
  

+ m9 d/ K$ H# \; [0 ~* \; K手上一个超薄NB的案子DQA报了这样一条bug：频繁的插拔AC，vista右下角的power icon有时反应很慢，AC插拔过后有时需要等几秒或十几秒才发现power icon有变化。Power icon指的是下图红色圆圈标出的部分：
  d" L0 d& Y2 e& t% a

图 1

• Why???
  

4 i! z& Z% O  E+ R( A6 ]- M! g
刚看到这条bug时，我有点不以为然，因为有些机种也有这样的状况，所以我以为这个有可能是不同的测试人员认知上差异。而且超薄NB为了解决好功耗、导热的问题都使用比较低的配置，我最初还觉得可能跟配置有关。但是他们找了个相同chipset的机器去试，反应很流畅没有这样的现象L!我的猜测站不住脚了，这时我觉得应该是FW有些地方没有处理好导致的了。随后我们开始debug，首先我们要理清AC in/out 过程中EC、BIOS、OS都做了哪些动作,我所知道的状况是这样：1. EC检测到AC in/out的中断，更新EC ram中的AC状态并引发SCI IRQ通知OS。2.OS收到SCI IRQ后调用BIOS中的_Q method并通过Notify function通知OS power source change。3.OS调用_PSR function获取AC的状态并据此更新power icon显示。上述過程sample code 如下述所示：
" r9 j1 {" q4 t1 D: N// AC Change event
! v; c! |: `, A  ~6 i
$ h" [  x8 K# i# [: JMethod(_QXX)
! D3 @1 e: @2 g6 ?
{
' Q1 x1 B/ h9 ?* K# U% N% ~2 Z( G- M
Store(0x09, DBG8)
- C! k3 @- R! ^. h7 b2 J3 s
% E, I; p) A; M' HNotify(\_SB. ADP,0x80)
& X( Q$ W1 R7 K# E; k! H//Power Source status changed

  M) m+ ~- M* bStore(0x0A, DBG8)
  ~; L9 n( T; P* k' L3 z& ?$ b& {4 }
& d, q/ T2 e7 D6 H5 _3 F) }/ F
# `' J; t( @. s7 C5 o6 X}



Method(_PSR,0)


{
7 S* B! {" O. i) I
" b6 f% r7 W8 [& Z" w+ _
Store(0x0B, DBG8)

- X# _8 k6 ?/ s' R0 L. v
# [% A  H7 h; u: F8 F- YIf(ACST)
6 Z2 r* {$ u9 o  E0 W* d* e//check AC status
9 S8 u5 w% ^* u& J) e+ ~+ e
{


return(One)
+ ?/ l8 n2 b! m: t- K+ Y8 q// AC Present

}
  \5 `4 M, n2 N% R
else
/ I9 t" y' X9 l
{
& U' K% z  m  \! V/ J2 J8 R
return(Zero)
" I( i6 d  z8 y2 C% [// AC Not Present
& v; _( b. @8 h4 _( N5 n! o/ c( r2 v
5 N% g9 e: y* z( v& X}

; h" C# o# f! U* p0 NStore(0x0C, DBG8)

}

% C2 P% i; @) C+ Z# y
$ X7 i/ Y/ b: ^3 c/ H- O我能猜到的大概的流程应该就是这样了。那我们就从头开始追，先在AC change qevent中抛点，可是发现AC change对应的_Q method反应很快，一旦AC in/out debug card马上就会有显示。那么说明什么呢？跟EC没有关系吗？接着抛，又发现有时停在’0x0A’比较久才会出现，有时’0x0C’比较久。
状况不太一致；没感觉就把网撒大点，在几乎所有的ACPI method中都抛上点然后再try，试了几个回合以后有感觉了，我们发现一旦现象出现在Device Battery _BST method中停的久的几率非常高，也就是说AC in/out OS还会更新battery的信息。这段代码最明显的特征就是它会从EC ram中获取非常多的电池信息，sample code如下所示：
4 d% [9 |/ s1 T- \9 r9 EMethod(_BST)
{

Store(BSTS,Local0)


) \: L# }3 S0 p! U+ |5 mIf(LEqual(Local0,1)) //Check Battery Present Bit
. g5 f- T$ y3 n6 K3 z/ x
{
9 {0 T4 ?5 k  L
$ b* S' N: r9 A


7 B# w! ]" M  p/ z
7 G  }3 |, @2 S; T" [( V//Read Battery information from EC

… …
2 C% v, j+ r/ k1 I2 ]) w0 x

6 V8 z4 Z+ q0 e( `}
, W; v6 K# _: R) U; }# W
" N9 Y! d; e8 f9 RStore(0x0D, DBG8)
}
& X0 y: D( ?' N2 k那么问题好像是由读EC ram导致的，ACPI中读取EC内容的方式是发0x80 cmd到ox66 port，随后EC产生一个SCI通知OS，接着OS将EC ram index发给0x62 port，EC将数据送给0x62 port再产生一个SCI通知0S，接着OS读0x62 port就获得了EC ram指定位置的数据了。我在EC 端加入debug信息，发现出现状况时0x80 cmd EC很晚才收到，0x80 cmd是OS发的，所以貌似和EC也没什么关系吗？继续思考，EC产生一个SCI的目的应该是产生一个IRQ让ACPI driver获悉前面的指令已经完成，ACPI driver可以继续送指令下来了。如果某一条指令慢则有可能是前一个SCI IRQ通知 ACPI drive而 driver还没有处理好导致，也有可能ACPI driver已经处理好但是EC没有ready所致。
+ `7 C# f1 Q6 G3 e4 X. |那么SCI中断机制是怎样的呢？EC SCICFG register通常将SCI IRQ配置成HLH的pulse trigger，而且L的时间通常设置成64us，如下图2所示：
7 Z% _; _. J9 d$ t

而BIOS对SB SCI pin通常配置成low edge trig， SCI的pulse trig有个优点就是它能够自动复位，产生一个中断后SCI pin会pull high。可是因为BIOS是下降沿触发，所以EC SCI保持64us低电平会不会太长呢？会不会导致ACPI driver收到IRQ后下命令给EC,而EC SCI pin还没有复位而太久才收到？又或者说EC SCI pin保持低会影响到ACPI driver IRQ latency？有了这个想法以后，我就开始放大它，修改EC SCICFG将SCI IRQ配置成128 us pulse trig，然后再做AC in/out的实验，嘿嘿病情加重了，fail率接近了80%之前只有10%；那我再将pulse width调整为16us再试，结果200次竟然没有一次出现症状J.
* Z$ k' C3 r+ w

• Solution

6 C$ K5 {9 l( P+ O4 Y
经过上面的分析，大概的原因已经清楚了。所以解决问题的方法应该是调整SCI IRQ pulse width，将保持低电平的时间调短，这样就可以有效的避免这条bug。通过这条bug我发现在分析问题的过程中需要理清问题的各个环节，并且对各个环节所涉及到的细节也要深入分析。不能够看到现象就轻易的下结论，更不能想当然，正确的态度是不放过任何蛛丝马迹，大胆假设多方求证！


1 V- J0 h. n8 e% ^: `5 R

That’s all!
9 P! ]8 F( H& j. s6 ], h
* U+ e1 r- m  i" \Peter

xtdumpling

原来如此！！！
3 l1 _  r" Q- D2 E& R+ K! y5 F
谢谢！

winbondowen

Bug起因为本

蓝色永恒

好帖，学习了 谢谢！！！！！

zhanghmjm

感谢分享！真的很有用，以前我也遇到这个问题，还以为是OS的问题呢！真的好贴啊！
我看了您的分析代码，好像不是EC的代码吧！我现在就是OS-BIOS-EC三者的关系有点迷糊，版主能否指点一下！谢谢

peterhu

hehe...
很高心这篇文章能够对你有帮助。
* M- A- s6 Z/ c* j. i上述代码是BIOS中的ASL code，理清OS-BIOS-EC之间的关系的最好途径就是
$ C% j: t# A& hACPI spec，没事翻翻ACPI spec会有不少收获的。

zhanghmjm

感谢指导！谢谢！有时间经常关注你帖子。

zhanghmjm

您好！我现在手上有一个小本项目！用的是华邦的代码！我发现在oemmain.c中的几毫秒中断中是不是不能添加太多的代码啊！打个比方我就在一毫秒中断里加的代码，而这些代码是执行时间加入超过了一毫秒，是不是会造成EC死掉啊！因为在我修改后的代码发现有时很不稳定！我想了想是不是问题出现在这！请指教一下

peterhu

中断的处理通常分顶半部和底半部,很多driver都是这样处理的.
) f4 N$ p% f$ i. Z5 m* ~2 C简单来讲就是在中断到来时置flag,后续再处理(DPC).

zhanghmjm

谢谢了！刚才我又仔细的查看了一下我的代码！终于找到了！EC死掉的原因了，就是我在上电时序那加了一个类似看门狗的小程序！来保证开机的效率。结果硬件始终有一个S电没有上来才导致我EC死在那里。
( z$ d! q% x, D+ a" A% e) P& s对于您的解释我还是有点迷糊！对winbond的EC他的oemmain.c中的1MS，10MS，100MS，500MS，1000MS。它用的是中断还是轮询！！中断和轮询是不是没有什么太大的区别啊！我现在就是担心我在比如1MS的函数里加的代码太多，会不会出现在这段代码执行一半的时候，1MS的中断又来了。那代码不就不能完全执行了吗？

蓝色永恒

oemmain.c的是service，是具体的执行处理过程，而实际的中断呢，是由Timer 来触发的（有定时1ms），只要不在中断的Routine 里加太多东西，在 service 里加，应该没事。个人看法，呵呵

zhanghmjm

谢谢了！明天有时间我做个小的实验！我想就应该清楚了，到时与您分享！呵呵

amty.wang

为啥你们的是C，我的是汇编啊，

June

用汇编写才牛呢，呵呵

conolzhu

文章很精采,分析很透彻!

peterhu

conol你也來這里了
( M4 K9 p8 I. s2 J, t3 `' z, S呵呵...

zhanghmjm

您好！
     不好意思又打扰你了，我现在遇到一个问题就是在重启电脑时EC为什么会几率性的死掉！在重启的时候我们EC都做什么啊！现在真的有点头痛了！！！

peterhu

之前有追过reboot它的大致过程是这样的：
, q/ O9 v! Q! N! n" ?# x" F) ^1.BIOS发FE给KBC,KBC pull low KBRST#一段时间，然后sb会将init# pin pull low 16个pci clock
chipset reset pci reset系统重启。
2 m% e% I3 X9 O3 z$ p1 V9 a4 z+ j0 ~2.一旦重启后面的动作看上去正常开机没多少差别，对ec来讲无非是keyboard init、进出idle（update escd）
等等一些琐碎的动作。
+ S; a+ n4 t3 n. h0 |/ r" P8 ~2 B# h之前碰到问题比较多的地方就在idle这部分了。
你所说的EC死掉指的是所有的function 都失效吗？keyboard能不能用，hot key能用吗，四秒关机呢...
0 |4 |9 I1 S5 _. C0 T3 [8 u( Z还有如果单台fail几率比较高，建议你接串口debug去看EC死在哪里。
9 H2 \7 ]! p; }" Z3 e$ z6 t1 y. h7 I以上希望对你有所帮助。

zhanghmjm

谢谢您的答复！
    我在做重启的时候EC是死掉的，四秒不能关机。键盘和热键无效！至于死机的原因真的很难找的。因为串口debug调试的功能我还没有弄呢！
     对了您说的BIOS发ＦＥ给我们ＥＣ应该是通过SCI吧！请指教一下！

peterhu

to zhanghmjm:
BIOS发FE不是通过SCI,而是透过60h，64h port。
: q! ?3 @( P  A5 r. o4 _% G) Z4 TBIOS应该没有办法发SCI给EC，而EC是可以发SCI给BIOS的。