- why does the log not show the alarm intent being FIRED? - why does the stock alarm suffer from the same problem?
Of course I hold my own wake lock as soon as I receive the alarm intent. But the intent never gets fired (on some devices, in some situations). Here's an example one of my users sent me: The alarm is set for 08:45. The user stopped using the device at 02:15. There are some log entries until 02:54, then NOTHING until 11:46 when the screen is turned on. The log entry of the alarm intent being received happens at 11:46:45.319. This is is the first line in my OnReceive. Several users have sent me something like this (I can provide a more complete log) and they all have the same last lines, i.e. wl127x- rfkill.0/rfkill bla bla which seems to come from a device driver. After that, the phone goes into "deep sleep" and no alarm intents are being sent. Martin 03-03 02:31:40.639 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:31:40.663 I/dalvikvm( 2937): Debugger thread not active, ignoring DDM send (t=0x41504e4d l=38) 03-03 02:31:40.678 I/dalvikvm( 2937): Debugger thread not active, ignoring DDM send (t=0x41504e4d l=58) 03-03 02:31:40.749 D/JuiceDefender.Db( 2937): Stats for last 48 hours: 147% 03-03 02:32:48.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:32:48.530 I/usbd ( 1078): main(): call select(...) 03-03 02:33:57.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:33:57.530 I/usbd ( 1078): main(): call select(...) 03-03 02:33:57.647 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:35:05.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:35:05.530 I/usbd ( 1078): main(): call select(...) 03-03 02:36:14.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:36:14.530 I/usbd ( 1078): main(): call select(...) 03-03 02:36:14.538 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:37:22.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:37:22.530 I/usbd ( 1078): main(): call select(...) 03-03 02:38:31.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:38:31.530 I/usbd ( 1078): main(): call select(...) 03-03 02:38:31.546 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:39:39.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:39:39.530 I/usbd ( 1078): main(): call select(...) 03-03 02:40:47.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:40:47.530 I/usbd ( 1078): main(): call select(...) 03-03 02:40:47.546 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:41:56.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:41:56.530 I/usbd ( 1078): main(): call select(...) 03-03 02:41:56.624 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:43:04.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:43:04.530 I/usbd ( 1078): main(): call select(...) 03-03 02:44:13.522 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:44:13.522 I/usbd ( 1078): main(): call select(...) 03-03 02:44:13.546 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:45:21.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:45:21.530 I/usbd ( 1078): main(): call select(...) 03-03 02:46:30.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:46:30.530 I/usbd ( 1078): main(): call select(...) 03-03 02:46:30.538 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:47:38.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:47:38.530 I/usbd ( 1078): main(): call select(...) 03-03 02:48:47.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:48:47.530 I/usbd ( 1078): main(): call select(...) 03-03 02:48:47.538 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:49:55.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:49:55.530 I/usbd ( 1078): main(): call select(...) 03-03 02:49:55.600 W/SingleClientConnManager( 1394): Invalid use of SingleClientConnManager: connection still allocated. 03-03 02:49:55.600 W/SingleClientConnManager( 1394): Make sure to release the connection before allocating another one. 03-03 02:51:04.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:51:04.530 I/usbd ( 1078): main(): call select(...) 03-03 02:51:04.546 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:51:04.616 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:52:12.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:52:12.530 I/usbd ( 1078): main(): call select(...) 03-03 02:53:21.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:53:21.530 I/usbd ( 1078): main(): call select(...) 03-03 02:53:21.585 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 02:54:29.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 02:54:29.530 I/usbd ( 1078): main(): call select(...) 03-03 11:46:44.530 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/wl127x-rfkill.0/rfkill/rfkill0 03-03 11:46:44.530 I/usbd ( 1078): main(): call select(...) 03-03 11:46:44.577 W/BatteryStatsImpl( 1168): Couldn't get kernel wake lock stats 03-03 11:46:44.585 I/usbd ( 1078): process_usb_uevent_message(): buffer = change@/devices/platform/cpcap_battery/power_supply/battery 03-03 11:46:44.585 I/usbd ( 1078): main(): call select(...) 03-03 11:46:44.592 I/power ( 1168): *** set_screen_state 1 03-03 11:46:44.600 D/Sensors ( 1168): using sensors (name=sensors) 03-03 11:46:44.624 W/WindowManager( 1168): No focus window, dropping: KeyEvent{action=0 code=80 repeat=0 meta=0 scancode=211 mFlags=9} 03-03 11:46:44.647 D/WindowManager( 1168): I'm tired mEndcallBehavior=0x2 03-03 11:46:44.647 D/PowerManagerService( 1168): ignoring user activity while turning off screen 03-03 11:46:44.647 D/PowerManagerService( 1168): ignoring user activity while turning off screen 03-03 11:46:44.647 W/WindowManager( 1168): No focus window, dropping: KeyEvent{action=1 code=80 repeat=0 meta=0 scancode=211 mFlags=8} 03-03 11:46:44.663 D/GentleAlarm( 2898): Activity_Nightmode: onResume 03-03 11:46:44.663 E/GentleAlarm( 2898): Activity_Nightmode: register runnable 03-03 11:46:44.663 D/GentleAlarm( 2898): Alarm: loadScheduledAlarmAsCurrent => id=2, type=PRE_ALARM, time=2010.03.03 n. Chr. at 08:45:00, name=mit Vorwecker, playAsTest=false, played=false 03-03 11:46:44.663 D/GentleAlarm( 2898): Alarm: loadAlarmDetails 03-03 11:46:44.663 D/GentleAlarm( 2898): DbAdapter: create 03-03 11:46:44.671 I/power ( 1168): *** set_screen_state 0 03-03 11:46:44.671 D/Sensors ( 1168): using accelerometer (name=accelerometer) 03-03 11:46:44.678 W/UsageStats( 1168): Failed to persist new stats 03-03 11:46:44.788 W/SSM ( 1065): no ack 03-03 11:46:44.850 W/Service ( 2404): setForeground: ignoring old API call on com.wsandroid.Core.BaseService 03-03 11:46:44.905 D/TmWidgetProvider( 1387): Screen On, start to update views 03-03 11:46:44.928 D/ThumbnailIntentReceiver( 1568): received Intent android.intent.action.SCREEN_ON, mGalleryRunning is false 03-03 11:46:44.952 W/SSM ( 1065): no ack 03-03 11:46:45.085 D/SurfaceFlinger( 1168): Screen about to return, flinger = 0x1494c8 03-03 11:46:45.108 D/GentleAlarm( 2898): DbAdapter: close 03-03 11:46:45.124 D/TmWidgetProvider( 1387): updateAppWidget appWidgetId=133 03-03 11:46:45.163 D/SurfaceFlinger( 1168): About to give-up screen, flinger = 0x1494c8 03-03 11:46:45.178 W/ActivityManager( 1168): Activity pause timeout for HistoryRecord{4514b1b0 com.mobitobi.android.gentlealarmtrial/.Activity_Nightmode} 03-03 11:46:45.194 D/dalvikvm( 2898): GC freed 16831 objects / 846152 bytes in 74ms 03-03 11:46:45.194 D/GentleAlarm( 2898): Activity_Nightmode: onPause 03-03 11:46:45.194 E/GentleAlarm( 2898): Activity_Nightmode: unregister runnable 03-03 11:46:45.225 D/TmWidgetProvider( 1387): Screen Off, stop to update views 03-03 11:46:45.264 D/ThumbnailIntentReceiver( 1568): received Intent android.intent.action.SCREEN_OFF, mGalleryRunning is false 03-03 11:46:45.319 D/GentleAlarm( 2898): Receiver_Alarm: onReceive 2010.03.03 n. Chr. at 11:46:45 03-03 11:46:45.319 D/GentleAlarm( 2898): Alarm: constructor 03-03 11:46:45.319 D/GentleAlarm( 2898): Alarm: reset 03-03 11:46:45.327 D/GentleAlarm( 2898): Alarm: loadScheduledAlarmAsCurrent => id=2, type=PRE_ALARM, time=2010.03.03 n. Chr. at 08:45:00, name=mit Vorwecker, playAsTest=false, played=false 03-03 11:46:45.327 D/GentleAlarm( 2898): Alarm: loadAlarmDetails 03-03 11:46:45.327 D/GentleAlarm( 2898): DbAdapter: create 03-03 11:46:45.428 D/GentleAlarm( 2898): DbAdapter: close 03-03 11:46:45.428 D/GentleAlarm( 2898): Util: setAwakeBtn=1 03-03 11:46:45.444 D/GentleAlarm( 2898): Alarm: scheduleNextAlarm 03-03 11:46:45.444 D/GentleAlarm( 2898): Alarm: isSnoozeOrSafeAlarmScheduled no 03-03 11:46:45.444 D/GentleAlarm( 2898): DbAdapter: create 03-03 11:46:45.452 D/GentleAlarm( 2898): DbAdapter: close 03-03 11:46:45.467 D/GentleAlarm( 2898): Alarm: scheduleAlarm _id = 2, type = PRE_ALARM 03-03 11:46:45.467 D/GentleAlarm( 2898): DbAdapter: create 03-03 11:46:45.491 D/GentleAlarm( 2898): Alarm: scheduleAlarm setting alarm to 2010.03.04 n. Chr. at 08:45:00 03-03 11:46:45.514 D/GentleAlarm( 2898): Alarm: storeScheduledAlarm => id=2, type=PRE_ALARM, time=2010.03.04 n. Chr. at 08:45:00, name=mit Vorwecker, playAsTest=false, played=false 03-03 11:46:45.561 D/GentleAlarm( 2898): UtilDateFomat: is24=yes, hasWeekdate=no 03-03 11:46:45.655 D/GentleAlarm( 2898): DbAdapter: close 03-03 11:46:45.663 D/GentleAlarm( 2898): Receiver_Alarm: alarm expired - 2010.03.03 n. Chr. at 08:45:00 -> scheduling next alarm -- You received this message because you are subscribed to the Google Groups "Android Developers" group. To post to this group, send email to android-developers@googlegroups.com To unsubscribe from this group, send email to android-developers+unsubscr...@googlegroups.com For more options, visit this group at http://groups.google.com/group/android-developers?hl=en