[Touch CDMA Android Development] kallt_kaffe:
last_kmsg after sleep freeze (black screen after I pulled it out of my pocket and refuses to wake up)

[ 292.394175] RTC Resume: Current time=16:3:43
[ 292.394693] Slept for 26 seconds
[ 292.395125] msmrtc_resume: alarm=1278864355, now=1278864223
[ 292.400458] msm_i2c msm_i2c.0: Error during data xfer (-5)
[ 292.400550] SDCC Resume
[ 292.410350] msm_i2c msm_i2c.0: Error during data xfer (-5)
[ 292.411106] SDCC Resume
[ 292.411156] set sdcc vdd to 16
[ 292.472236] clk_set_rate 21:144000
[ 292.474278] set sd clock - 0 20001
[ 292.650340] clk_set_rate 21:32000000
[ 292.652383] set sd clock - 0 20001
[ 292.755170] Restarting tasks ... done.
[ 292.876437] android_power_suspend: exit suspend, ret = 0 (2010-07-11 16:03:43.632353333 UTC)
[ 292.880737] active wake lock tiwlan_rx_wake, time left 36
[ 293.030735] android_power_suspend: enter suspend
[ 293.040333] PM: Syncing filesystems ... done.
[ 293.086363] Freezing user space processes ... (elapsed 0.00 seconds) done.
[ 293.096630] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done.
[ 293.097580] Suspending console(s)
[ 293.101878] set sdcc vdd to 0
[ 293.103323] RTC Suspend: Current time=16:3:44
[ 293.104650] Wake up in 131 seconds
[ 293.104650] timer 0: val=3eed, alarm=d, enable=1
[ 293.104650] timer 1: val=1580020, alarm=158ad60, enable=1
[ 293.104650] msm_pm_collapse(): returned 1
[ 293.104650] timer restore 0 val=16109 vtime=13 sleep_time=0
[ 293.104650] timer restore 1 val=22544416 vtime=22588768 sleep_time=0
[ 293.104650] msm_gpio_sleep_int handle_irq(29)
[ 293.104705] Modem Status:
[ 293.105045] RTC Resume: Current time=16:4:6
[ 293.106823] Slept for 22 seconds
[ 293.107277] msmrtc_resume: alarm=1278864355, now=1278864246
[ 293.120325] SDCC Resume
[ 293.130282] SDCC Resume
[ 293.130320] set sdcc vdd to 16
[ 293.184592] clk_set_rate 21:144000
[ 293.186627] set sd clock - 0 20001
[ 293.400250] clk_set_rate 21:32000000
[ 293.400250] set sd clock - 0 20001
[ 293.494938] Restarting tasks ... done.
[ 293.602485] ds2746: 3833mV -147mA charge: 73/100 (3166 units)
[ 293.602520] aux0: 218 (1185) aux1: 17 (80)
[ 293.720938] android_power_suspend: exit suspend, ret = 0 (2010-07-11 16:04:06.727176666 UTC)
[ 293.740815] active wake lock PowerManagerService
[ 293.750250] active wake lock tiwlan_rx_wake, time left 25
[ 294.400628] save exit: isCheckpointed 1
[ 294.410588] android_power_suspend: enter suspend
[ 294.420028] PM: Syncing filesystems ... done.
[ 294.466428] Freezing user space processes ... (elapsed 0.00 seconds) done.
[ 294.476722] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done.
[ 294.477692] Suspending console(s)
[ 294.480353] set sdcc vdd to 0
[ 294.481722] RTC Suspend: Current time=16:4:8
[ 294.483030] Wake up in 108 seconds
[ 294.483030] timer 0: val=a96e, alarm=d, enable=1
[ 294.483030] timer 1: val=1ce8980, alarm=1d01dc0, enable=1
[ 294.483030] msm_pm_collapse(): returned 1
[ 294.483030] timer restore 0 val=43374 vtime=13 sleep_time=0
[ 294.483030] timer restore 1 val=30312832 vtime=30416320 sleep_time=0
[ 294.483030] msm_gpio_sleep_int handle_irq(29)
[ 294.483083] Modem Status:
[ 294.483367] RTC Resume: Current time=16:4:14
[ 294.484053] Slept for 6 seconds
[ 294.484483] msmrtc_resume: alarm=1278864356, now=1278864254
[ 294.490338] SDCC Resume
[ 294.500813] SDCC Resume
[ 294.500867] set sdcc vdd to 16
[ 294.560767] clk_set_rate 21:144000
[ 294.562805] set sd clock - 0 20001
[ 294.750343] clk_set_rate 21:32000000
[ 294.752385] set sd clock - 0 20001
[ 294.860560] Restarting tasks ... done.
[ 294.902727] ds2746: 3840mV -136mA charge: 73/100 (3166 units)
[ 294.902758] aux0: 218 (1185) aux1: 17 (80)
[ 295.016655] android_power_suspend: exit suspend, ret = 0 (2010-07-11 16:04:14.656950000 UTC)
[ 295.020373] active wake lock tiwlan_rx_wake, time left 36
[ 295.231803] android_power_suspend: enter suspend
[ 295.240557] PM: Syncing filesystems ... done.
[ 295.356217] Freezing user space processes ... (elapsed 0.01 seconds) done.
[ 295.366795] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done.
[ 295.367897] Suspending console(s)
[ 295.370933] set sdcc vdd to 0
[ 295.372635] RTC Suspend: Current time=16:4:15
[ 295.373930] Wake up in 100 seconds
[ 295.373930] timer 0: val=53fb, alarm=d, enable=1
[ 295.373930] timer 1: val=16063e0, alarm=161ae20, enable=1
[ 295.373930] msm_pm_collapse(): returned 1
[ 295.373930] timer restore 0 val=21499 vtime=13 sleep_time=0
[ 295.373930] timer restore 1 val=23094240 vtime=23178784 sleep_time=0
[ 295.373930] msm_gpio_sleep_int handle_irq(29)
[ 295.373983] Modem Status:
[ 295.374268] RTC Resume: Current time=16:4:45
[ 295.374843] Slept for 30 seconds
[ 295.375275] msmrtc_resume: alarm=1278864355, now=1278864285
[ 295.380383] msm_i2c msm_i2c.0: Error during data xfer (-5)
[ 295.381032] SDCC Resume
[ 295.390472] SDCC Resume
[ 295.390518] set sdcc vdd to 16
[ 295.455470] clk_set_rate 21:144000
[ 295.457512] set sd clock - 0 20001
[ 295.720497] clk_set_rate 21:32000000
[ 295.722588] set sd clock - 0 20001
[ 295.830570] Restarting tasks ... done.
[ 295.907538] ds2746: 3857mV -58mA charge: 73/100 (3165 units)
[ 295.907572] aux0: 220 (1198) aux1: 15 (70)
[ 296.040772] android_power_suspend: exit suspend, ret = 0 (2010-07-11 16:04:45.711281666 UTC)
[ 296.064983] active wake lock tiwlan_rx_wake, time left 33
[ 296.070250] active wake lock evdev, time left 468
[ 296.425535] android_power_suspend: enter suspend
[ 296.431233] PM: Syncing filesystems ... done.
[ 296.497082] Freezing user space processes ...
[ 296.507258] Freezing of user space aborted
[ 296.507820]
[ 296.507865] Restarting tasks ... done.
[ 296.626460] android_power_suspend: exit suspend, ret = -11 (2010-07-11 16:04:46.356883333 UTC)
[ 296.630747] android_power_suspend: enter suspend
[ 296.640333] PM: Syncing filesystems ... done.
[ 296.756277] Freezing user space processes ... (elapsed 0.01 seconds) done.
[ 296.766735] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done.
[ 296.767880] Suspending console(s)
[ 296.770935] set sdcc vdd to 0
[ 296.772602] RTC Suspend: Current time=16:4:46
[ 296.773888] Wake up in 69 seconds
[ 296.773888] timer 0: val=71ee, alarm=d, enable=1
[ 296.773888] timer 1: val=1c6a420, alarm=1c7f4c0, enable=1
[ 296.773888] msm_pm_collapse(): returned 1
[ 296.773888] timer restore 0 val=29166 vtime=13 sleep_time=0
[ 296.773888] timer restore 1 val=29795360 vtime=29881536 sleep_time=0
[ 296.773888] msm_gpio_sleep_int handle_irq(29)
[ 296.773940] Modem Status:
[ 296.774247] RTC Resume: Current time=16:5:16
[ 296.774918] Slept for 30 seconds
[ 296.775350] msmrtc_resume: alarm=1278864355, now=1278864316
[ 296.780450] msm_i2c msm_i2c.0: Error during data xfer (-5)
[ 296.781225] SDCC Resume
[ 296.791213] SDCC Resume
[ 296.791260] set sdcc vdd to 16
[ 296.852477] clk_set_rate 21:144000
[ 296.854510] set sd clock - 0 20001
[ 297.110142] clk_set_rate 21:32000000
[ 297.112310] set sd clock - 0 20001
[ 297.215100] Restarting tasks ... done.
[ 297.355683] android_power: wakeup (2->0) at 535345491528 (2010-07-11 16:05:16.641803333 UTC)
[ 300.510376] <3>mddi_wait_interrupt 235, timeout waiting for 8000, INT = 234000, STAT = 808454 gotint = 26004
[ 300.741832] android_power: sleep (0->2) at 540681528194 (2010-07-11 16:05:21.977838333 UTC)
[ 300.787711] VIBRATE 0
[ 308.690324] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 319.160255] RTC Update
[ 320.270319] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 331.390325] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 342.172913] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 352.920401] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 364.320541] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 375.070452] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 385.910343] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 397.610336] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 409.120354] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 420.650353] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 432.010361] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 442.780359] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 453.540361] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 465.210366] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 476.790370] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 488.310369] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 500.100372] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 511.600410] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 523.130369] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 534.830372] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 546.340433] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 557.810417] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 569.710420] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 581.300398] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 592.800397] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 604.050393] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 614.810401] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 625.610406] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 625.610679] ds2746: -588mV -602mA charge: 100/100 (-3856 units)
[ 625.610699] aux0: 3855 (-21325) aux1: 3855 (-21325)
[ 628.400630] <3>mddi_wait_interrupt 235, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 628.401401] android_power: wakeup (2->0) at 1119121133194 (2010-07-11 16:15:00.417444999 UTC)
[ 629.780447] <3>mddi_wait_interrupt 234, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 629.850655] <3>mddi_wait_interrupt 235, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 629.852490] android_power: wakeup (0->0) at 1121232093195 (2010-07-11 16:15:02.528401667 UTC)
[ 629.917662] VIBRATE 0
[ 634.700836] <3>mddi_wait_interrupt 235, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 634.780465] <3>mddi_wait_interrupt 236, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 636.710705] <3>mddi_wait_interrupt 234, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 636.946133] android_power: sleep (0->2) at 1130745809861 (2010-07-11 16:15:12.042121666 UTC)
[ 636.987005] VIBRATE 0
[ 637.060660] <3>mddi_wait_interrupt 236, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 637.061461] android_power: wakeup (2->0) at 1130861184861 (2010-07-11 16:15:12.157496666 UTC)
[ 637.820595] <3>mddi_wait_interrupt 234, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 639.407101] android_power: sleep (0->2) at 1133206828195 (2010-07-11 16:15:14.503135000 UTC)
[ 639.793740] VIBRATE 0
[ 640.930661] <3>mddi_wait_interrupt 234, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 640.931471] android_power: wakeup (2->0) at 1134731201528 (2010-07-11 16:15:16.027513333 UTC)
[ 641.190578] msm_i2c msm_i2c.0: Error waiting for notbusy
[ 647.330613] <3>mddi_wait_interrupt 234, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 647.583942] android_power: sleep (0->2) at 1141403651528 (2010-07-11 16:15:22.699965000 UTC)
[ 647.780642] <3>mddi_wait_interrupt 236, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 647.781413] android_power: wakeup (2->0) at 1141601154861 (2010-07-11 16:15:22.897466666 UTC)
[ 647.788107] VIBRATE 0
[ 648.171202] Audio Open
[ 648.177577] audio_ioctl 80046103
[ 648.177863] audio_ioctl 40046104
[ 648.178360] audio_enable()
[ 648.181493] audmgr_rpc_thread() start
[ 648.189007] audmgr_enable: wait for enable
[ 648.202632] audmgr: rpc READY handle=0xc09bae00
[ 648.250165] audmgr: rpc CODEC_CONFIG volume=0x00ae9bc0
[ 648.250485] audmgr_enable: enabled
[ 648.250570] 7200 Audio: Play sound through speaker
[ 648.250683] snd_set_device 1 1 1
[ 648.252325] [RR] ERROR no local ept for prog 02000031 replying anyway!!
[ 648.270583] audpp: enable(-1)
[ 648.275813] adsp: waiting for DSP write ready
[ 648.277025] adsp: waiting for DSP write ready
[ 648.301490] audio_ioctl 40046100
[ 648.301687] audio_enable()
[ 648.354848] audpp: DMA missed
[ 648.402207] audpp: DMA missed
[ 648.452005] audpp: DMA missed
[ 648.502882] audpp: DMA missed
[ 648.550817] audpp: DMA missed
[ 648.611848] audpp: DMA missed
[ 648.710510] audpp: DMA missed
[ 648.759190] audpp: DMA missed
[ 648.858842] audpp: DMA missed
[ 648.913798] audpp: DMA missed
[ 648.964795] audpp: DMA missed
[ 649.012025] audpp: DMA missed
[ 649.063205] audpp: DMA missed
[ 649.113930] audpp: DMA missed
[ 649.162708] audpp: DMA missed
[ 649.208835] audpp: DMA missed
[ 649.310850] audpp: DMA missed
[ 649.360847] audpp: DMA missed
[ 649.410820] audpp: DMA missed
[ 649.420888] <3>mddi_wait_interrupt 234, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 649.458833] audpp: DMA missed
[ 649.507132] audpp: DMA missed
[ 649.558827] audpp: DMA missed
[ 649.610503] audpp: DMA missed
[ 649.658818] audpp: DMA missed
[ 649.665407] android_power: sleep (0->2) at 1143485521528 (2010-07-11 16:15:24.781833333 UTC)
[ 649.712868] audpp: DMA missed
[ 649.726068] VIBRATE 0
[ 649.760833] audpp: DMA missed
[ 649.810865] audpp: DMA missed
[ 649.863142] audpp: DMA missed
[ 649.912847] audpp: DMA missed
[ 649.962355] audpp: DMA missed
[ 650.060807] audpp: DMA missed
[ 650.111618] audpp: DMA missed
[ 650.162152] audpp: DMA missed
[ 650.210778] audpp: DMA missed
[ 650.230678] <3>mddi_wait_interrupt 235, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 650.231458] android_power: wakeup (2->0) at 1144051209861 (2010-07-11 16:15:25.347521667 UTC)
[ 650.263490] audpp: DMA missed
[ 650.316837] audpp: DMA missed
[ 650.374798] audpp: DMA missed
[ 650.422852] audpp: DMA missed
[ 650.483113] audpp: DMA missed
[ 650.531558] audpp: DMA missed
[ 650.582168] audpp: DMA missed
[ 650.680820] audpp: DMA missed
[ 650.730830] audpp: DMA missed
[ 650.830460] audpp: DMA missed
[ 650.880807] audpp: DMA missed
[ 650.976848] audpp: DMA missed
[ 651.032993] audpp: DMA missed
[ 651.084047] audpp: DMA missed
[ 651.132760] audpp: DMA missed
[ 651.180512] audpp: DMA missed
[ 651.232727] audpp: DMA missed
[ 651.281847] audpp: DMA missed
[ 651.283498] audio_disable()
[ 651.283610] 7200 Audio: Idle: using speaker.
[ 651.283732] snd_set_device 1 1 1
[ 651.295940] [RR] ERROR no local ept for prog 02000031 replying anyway!!
[ 651.311613] audmgr_disable
[ 651.316555] audmgr_disable: wait for disable
[ 651.318847] audpp: DMA missed
[ 651.344198] audmgr: DISABLED
[ 651.344492] audmgr_disable: disabled
[ 652.620448] <3>mddi_wait_interrupt 234, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 652.854240] android_power: sleep (0->2) at 1146703853195 (2010-07-11 16:15:28.000163333 UTC)
[ 652.907832] VIBRATE 0
[ 652.960472] <3>mddi_wait_interrupt 235, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 652.961222] android_power: wakeup (2->0) at 1146840839861 (2010-07-11 16:15:28.137150000 UTC)
[ 653.860360] audio timer expired
[ 656.030451] <3>mddi_wait_interrupt 235, timeout waiting for 8000, INT = 234200, STAT = 808454 gotint = 26004
[ 656.263469] android_power: sleep (0->2) at 1152173188194 (2010-07-11 16:15:33.469496666 UTC)
[ 656.319866] VIBRATE 0

Using froyo (NAND) and a kernel I compiled today (240x320 panel1). Seems like some i2c stuff goes bad before the screen starts refusing to power on. I dzo can get some clues from this. Compcache enabled.