?:??: W/?(?): --------- beginning of /dev/log/system 03-30 14:57:58.539: I/Vold(1285): Vold 2.1 (the revenge) firing up 03-30 14:57:58.546: D/Vold(1285): Volume sdcard state changing -1 (Initializing) -> 0 (No-Media) 03-30 14:57:58.562: D/Vold(1285): Volume sdcard state changing 0 (No-Media) -> 2 (Pending) 03-30 14:57:58.570: D/Vold(1285): Volume sdcard state changing 2 (Pending) -> 1 (Idle-Unmounted) 03-30 14:57:58.570: W/Vold(1285): Duplicate state (1) 03-30 14:57:58.570: W/Vold(1285): Duplicate state (1) 03-30 14:57:58.570: W/Vold(1285): Duplicate state (1) 03-30 14:57:58.570: W/Vold(1285): Duplicate state (1) 03-30 14:57:58.570: W/Vold(1285): Duplicate state (1) 03-30 14:57:58.570: W/Vold(1285): --------- beginning of /dev/log/main 03-30 14:57:58.734: D/SYSLINKD(1295): MultiProc_getId remoteId: [0x1] 03-30 14:57:58.734: D/SYSLINKD(1295): MultiProc_getId procId: [0x2] 03-30 14:57:58.984: D/AndroidRuntime(1288): >>>>>> AndroidRuntime START com.android.internal.os.ZygoteInit <<<<<< 03-30 14:57:58.984: D/AndroidRuntime(1288): CheckJNI is OFF 03-30 14:57:59.015: D/dalvikvm(1288): creating instr width table 03-30 14:57:59.023: I/(1289): ServiceManager: 0xada8 03-30 14:57:59.031: E/ALSALib(1289): external/alsa-lib/src/control/control.c:902:(snd_ctl_open_noupdate) Invalid CTL AndroidOut 03-30 14:57:59.031: W/AudioHardwareALSA(1289): Unable to attach mixer to device AndroidOut: No such file or directory 03-30 14:57:59.078: E/ALSALib(1289): external/alsa-lib/src/control/control.c:902:(snd_ctl_open_noupdate) Invalid CTL AndroidIn 03-30 14:57:59.078: W/AudioHardwareALSA(1289): Unable to attach mixer to device AndroidIn: No such file or directory 03-30 14:57:59.140: D/Omap4ALSA(1289): OMAP4 ALSA module opened 03-30 14:57:59.140: D/Omap4ALSA(1289): Initializing devices for OMAP4 ALSA module 03-30 14:57:59.140: D/Omap4ALSAModem(1289): Initializing devices for Modem OMAP4 ALSA module 03-30 14:57:59.140: W/Omap4ALSAModem(1289): Use generic Modem interface 03-30 14:57:59.140: V/AudioModemGeneric(1289): AudioModemInterfaceGeneric 03-30 14:57:59.140: V/AudioModemGeneric(1289): Build date: Mar 21 2012 time: 19:38:07 03-30 14:57:59.140: V/AudioModemGeneric(1289): initCheck 03-30 14:57:59.140: I/CameraService(1289): CameraService started (pid=1289) 03-30 14:57:59.140: D/AudioHardwareALSA(1289): openOutputStream called for devices: 0x00000002 03-30 14:57:59.140: D/Omap4ALSA(1289): open called for devices 00000002 in mode 0 channels 00000000... 03-30 14:57:59.164: I/Omap4ALSA(1289): Using ping-pong! 03-30 14:57:59.164: I/Omap4ALSA(1289): Buffer size: 4096 03-30 14:57:59.164: I/Omap4ALSA(1289): Latency: 92879 03-30 14:57:59.210: I/Omap4ALSA(1289): Initialized ALSA PLAYBACK device 'plughw:0,0' 03-30 14:57:59.210: I/AudioHardwareALSA(1289): buffer size (bytes) to AF = 16384 03-30 14:57:59.210: I/AudioFlinger(1289): AudioFlinger's thread 0x57c38 ready to run 03-30 14:57:59.265: D/Omap4ALSA(1289): route called for devices 00000002 in mode 0... 03-30 14:57:59.265: D/SYSLINKD(1295): ProcMgr_open Status [0xca11000] 03-30 14:57:59.273: D/SYSLINKD(1295): ProcMgr_attach status: [0x97d2000] 03-30 14:57:59.273: D/SYSLINKD(1295): After attach: ProcMgr_getState 03-30 14:57:59.273: D/SYSLINKD(1295): state [0x97d2000] 03-30 14:57:59.273: D/SYSLINKD(1295): MultiProc_getId procId: [0x1] 03-30 14:57:59.273: D/SYSLINKD(1295): ProcMgr_open Status [0xca11000] 03-30 14:57:59.273: E/Omap4ALSA(1289): called drain&close 03-30 14:57:59.289: D/SYSLINKD(1295): ProcMgr_attach status: [0x97d2000] 03-30 14:57:59.289: D/SYSLINKD(1295): After attach: ProcMgr_getState 03-30 14:57:59.289: D/SYSLINKD(1295): state [0x97d2000] 03-30 14:57:59.289: D/SYSLINKD(1295): SysM3 Load: loading the SysM3 image /system/lib/ducati/base_image_sys_m3.xem3 03-30 14:57:59.312: D/SYSLINKD(1295): Starting ProcMgr for procID = 2 03-30 14:57:59.531: D/SYSLINKD(1295): AppM3 Load: loading the AppM3 image /system/lib/ducati/base_image_app_m3.xem3 03-30 14:58:00.031: D/SYSLINKD(1295): Starting ProcMgr for procID = 1 03-30 14:58:00.039: I/SamplingProfilerIntegration(1288): Profiler is disabled. 03-30 14:58:00.046: I/Zygote(1288): Preloading classes... 03-30 14:58:00.046: E/Zygote(1288): setreuid() failed. errno: 2 03-30 14:58:00.054: D/dalvikvm(1288): GC_EXPLICIT freed 47K, 77% free 236K/1024K, external 0K/0K, paused 2ms 03-30 14:58:00.101: D/dalvikvm(1288): No JNI_OnLoad found in /system/lib/libidme.so 0x0, skipping init 03-30 14:58:00.210: D/SYSLINKD(1295): SysM3: Creating Ducati DMM pool of size 0x10000000 03-30 14:58:00.210: D/SYSLINKD(1295): SharedRegion_getNumRegions = 4 03-30 14:58:00.210: D/SYSLINKD(1295): SharedRegion_entry #0: base = 0x40d89000 len = 0x54000 ownerProcId = 3 isValid = 1 cacheEnable = 0 cacheLineSize = 0x80 createHeap = 1 name = (null) 03-30 14:58:00.210: D/SYSLINKD(1295): SharedRegion_entry #1: base = 0x40ddd000 len = 0xac000 ownerProcId = 3 isValid = 1 cacheEnable = 0 cacheLineSize = 0x80 createHeap = 1 name = (null) 03-30 14:58:00.210: D/SYSLINKD(1295): SharedRegion_entry #2: base = 0x0 len = 0x0 ownerProcId = 0 isValid = 0 cacheEnable = 1 cacheLineSize = 0x80 createHeap = 0 name = (null) 03-30 14:58:00.210: D/SYSLINKD(1295): SharedRegion_entry #3: base = 0x0 len = 0x0 ownerProcId = 0 isValid = 0 cacheEnable = 1 cacheLineSize = 0x80 createHeap = 0 name = (null) 03-30 14:58:00.210: D/SYSLINKD(1295): heapSize = 0x8100 03-30 14:58:00.210: D/SYSLINKD(1295): Before Memory_alloc = 0x11460 03-30 14:58:00.210: D/SYSLINKD(1295): Before HeapBufMP_Create: [0x40ddd080] 03-30 14:58:00.210: D/SYSLINKD(1295): heapSize1 = 0x18100 03-30 14:58:00.210: D/SYSLINKD(1295): Before HeapBufMP_Create: [0x40de5180] 03-30 14:58:00.210: D/SYSLINKD(1295): === SysLink-IPC setup completed successfully!=== 03-30 14:58:00.210: D/SYSLINKD(1295): ipcSetup succeeded! 03-30 14:58:00.210: D/SYSLINKD(1295): Create SysM3 event handler thread 03-30 14:58:00.210: D/SYSLINKD(1295): Create AppM3 event handler thread 03-30 14:58:00.828: W/Zygote(1288): Class not found for preloading: android.widget.TextView$SelectionModifierCursorController$1 03-30 14:58:01.265: D/dalvikvm(1288): GC_FOR_MALLOC freed 2935K, 58% free 2188K/5123K, external 0K/0K, paused 45ms 03-30 14:58:01.515: D/dalvikvm(1288): GC_FOR_MALLOC freed 2653K, 52% free 2466K/5123K, external 0K/0K, paused 31ms 03-30 14:58:02.359: I/Zygote(1288): ...preloaded 1829 classes in 2306ms. 03-30 14:58:02.359: E/Zygote(1288): setreuid() failed. errno: 17 03-30 14:58:02.382: D/dalvikvm(1288): GC_EXPLICIT freed 850K, 49% free 2657K/5123K, external 0K/0K, paused 27ms 03-30 14:58:02.382: I/Zygote(1288): Preloading resources... 03-30 14:58:02.414: D/dalvikvm(1288): GC_EXTERNAL_ALLOC freed 25K, 49% free 2634K/5123K, external 0K/0K, paused 21ms 03-30 14:58:02.421: W/Zygote(1288): Preloaded drawable resource #0x1080093 (res/drawable-mdpi/sym_def_app_icon.png) that varies with configuration!! 03-30 14:58:02.421: W/Zygote(1288): Preloaded drawable resource #0x1080002 (res/drawable-mdpi/arrow_down_float.png) that varies with configuration!! 03-30 14:58:02.429: W/Zygote(1288): Preloaded drawable resource #0x10800b7 (res/drawable/btn_check.xml) that varies with configuration!! 03-30 14:58:02.429: W/Zygote(1288): Preloaded drawable resource #0x10800ba (res/drawable-mdpi/btn_check_label_background.9.png) that varies with configuration!! 03-30 14:58:02.429: W/Zygote(1288): Preloaded drawable resource #0x10800bb (res/drawable-mdpi/btn_check_off.png) that varies with configuration!! 03-30 14:58:02.429: W/Zygote(1288): Preloaded drawable resource #0x10800c0 (res/drawable-mdpi/btn_check_on.png) that varies with configuration!! 03-30 14:58:02.437: W/Zygote(1288): Preloaded drawable resource #0x1080004 (res/drawable/btn_default.xml) that varies with configuration!! 03-30 14:58:02.437: W/Zygote(1288): Preloaded drawable resource #0x1080005 (res/drawable/btn_default_small.xml) that varies with configuration!! 03-30 14:58:02.445: W/Zygote(1288): Preloaded drawable resource #0x1080006 (res/drawable/btn_dropdown.xml) that varies with configuration!! 03-30 14:58:02.453: W/Zygote(1288): Preloaded drawable resource #0x1080008 (res/drawable/btn_plus.xml) that varies with configuration!! 03-30 14:58:02.453: W/Zygote(1288): Preloaded drawable resource #0x1080007 (res/drawable/btn_minus.xml) that varies with configuration!! 03-30 14:58:02.460: W/Zygote(1288): Preloaded drawable resource #0x1080009 (res/drawable/btn_radio.xml) that varies with configuration!! 03-30 14:58:02.460: W/Zygote(1288): Preloaded drawable resource #0x108000a (res/drawable/btn_star.xml) that varies with configuration!! 03-30 14:58:02.468: W/Zygote(1288): Preloaded drawable resource #0x1080142 (res/drawable/btn_toggle.xml) that varies with configuration!! 03-30 14:58:02.468: W/Zygote(1288): Preloaded drawable resource #0x10801ac (res/drawable-mdpi/ic_emergency.png) that varies with configuration!! 03-30 14:58:02.468: W/Zygote(1288): Preloaded drawable resource #0x1080012 (res/drawable-mdpi/divider_horizontal_bright.9.png) that varies with configuration!! 03-30 14:58:02.468: W/Zygote(1288): Preloaded drawable resource #0x1080014 (res/drawable-mdpi/divider_horizontal_dark.9.png) that varies with configuration!! 03-30 14:58:02.468: W/Zygote(1288): Preloaded drawable resource #0x1080016 (res/drawable/edit_text.xml) that varies with configuration!! 03-30 14:58:02.468: W/Zygote(1288): Preloaded drawable resource #0x1080185 (res/drawable/expander_group.xml) that varies with configuration!! 03-30 14:58:02.476: W/Zygote(1288): Preloaded drawable resource #0x1080062 (res/drawable/list_selector_background.xml) that varies with configuration!! 03-30 14:58:02.476: W/Zygote(1288): Preloaded drawable resource #0x1080249 (res/drawable-mdpi/menu_background.9.png) that varies with configuration!! 03-30 14:58:02.476: W/Zygote(1288): Preloaded drawable resource #0x108024a (res/drawable-mdpi/menu_background_fill_parent_width.9.png) that varies with configuration!! 03-30 14:58:02.484: W/Zygote(1288): Preloaded drawable resource #0x108024b (res/drawable/menu_selector.xml) that varies with configuration!! 03-30 14:58:02.484: W/Zygote(1288): Preloaded drawable resource #0x108025a (res/drawable-mdpi/panel_background.9.png) that varies with configuration!! 03-30 14:58:02.484: W/Zygote(1288): Preloaded drawable resource #0x1080262 (res/drawable-mdpi/popup_bottom_bright.9.png) that varies with configuration!! 03-30 14:58:02.484: W/Zygote(1288): Preloaded drawable resource #0x1080263 (res/drawable-mdpi/popup_bottom_dark.9.png) that varies with configuration!! 03-30 14:58:02.484: W/Zygote(1288): Preloaded drawable resource #0x1080264 (res/drawable-mdpi/popup_bottom_medium.9.png) that varies with configuration!! 03-30 14:58:02.484: W/Zygote(1288): Preloaded drawable resource #0x1080265 (res/drawable-mdpi/popup_center_bright.9.png) that varies with configuration!! 03-30 14:58:02.484: W/Zygote(1288): Preloaded drawable resource #0x1080266 (res/drawable-mdpi/popup_center_dark.9.png) that varies with configuration!! 03-30 14:58:02.484: W/Zygote(1288): Preloaded drawable resource #0x1080269 (res/drawable-mdpi/popup_full_dark.9.png) that varies with configuration!! 03-30 14:58:02.507: D/dalvikvm(1288): GC_EXTERNAL_ALLOC freed 45K, 48% free 2690K/5123K, external 662K/668K, paused 23ms 03-30 14:58:02.507: W/Zygote(1288): Preloaded drawable resource #0x108026c (res/drawable-mdpi/popup_top_bright.9.png) that varies with configuration!! 03-30 14:58:02.507: W/Zygote(1288): Preloaded drawable resource #0x108026d (res/drawable-mdpi/popup_top_dark.9.png) that varies with configuration!! 03-30 14:58:02.515: W/Zygote(1288): Preloaded drawable resource #0x108006d (res/drawable/progress_indeterminate_horizontal.xml) that varies with configuration!! 03-30 14:58:02.515: W/Zygote(1288): Preloaded drawable resource #0x1080273 (res/drawable/progress_small.xml) that varies with configuration!! 03-30 14:58:02.515: W/Zygote(1288): Preloaded drawable resource #0x1080274 (res/drawable/progress_small_titlebar.xml) that varies with configuration!! 03-30 14:58:02.515: W/Zygote(1288): Preloaded drawable resource #0x1080294 (res/drawable-mdpi/scrollbar_handle_horizontal.9.png) that varies with configuration!! 03-30 14:58:02.515: W/Zygote(1288): Preloaded drawable resource #0x1080295 (res/drawable-mdpi/scrollbar_handle_vertical.9.png) that varies with configuration!! 03-30 14:58:02.515: W/Zygote(1288): Preloaded drawable resource #0x1080071 (res/drawable/spinner_dropdown_background.xml) that varies with configuration!! 03-30 14:58:02.515: W/Zygote(1288): Preloaded drawable resource #0x108033c (res/drawable-mdpi/text_select_handle_left.png) that varies with configuration!! 03-30 14:58:02.515: W/Zygote(1288): Preloaded drawable resource #0x108033d (res/drawable-mdpi/text_select_handle_middle.png) that varies with configuration!! 03-30 14:58:02.515: W/Zygote(1288): Preloaded drawable resource #0x108033e (res/drawable-mdpi/text_select_handle_right.png) that varies with configuration!! 03-30 14:58:02.523: W/Zygote(1288): Preloaded drawable resource #0x108035f (res/drawable-mdpi/title_bar_shadow.9.png) that varies with configuration!! 03-30 14:58:02.523: W/Zygote(1288): Preloaded drawable resource #0x10801ee (res/drawable-mdpi/indicator_code_lock_drag_direction_green_up.png) that varies with configuration!! 03-30 14:58:02.523: W/Zygote(1288): Preloaded drawable resource #0x10801ef (res/drawable-mdpi/indicator_code_lock_drag_direction_red_up.png) that varies with configuration!! 03-30 14:58:02.523: W/Zygote(1288): Preloaded drawable resource #0x10801f0 (res/drawable-mdpi/indicator_code_lock_point_area_default.png) that varies with configuration!! 03-30 14:58:02.523: W/Zygote(1288): Preloaded drawable resource #0x10801f1 (res/drawable-mdpi/indicator_code_lock_point_area_green.png) that varies with configuration!! 03-30 14:58:02.523: W/Zygote(1288): Preloaded drawable resource #0x10801f2 (res/drawable-mdpi/indicator_code_lock_point_area_red.png) that varies with configuration!! 03-30 14:58:02.523: I/Zygote(1288): ...preloaded 51 resources in 144ms. 03-30 14:58:02.531: I/Zygote(1288): ...preloaded 15 resources in 4ms. 03-30 14:58:02.554: D/dalvikvm(1288): GC_EXPLICIT freed 27K, 48% free 2710K/5123K, external 847K/1181K, paused 22ms 03-30 14:58:02.578: D/dalvikvm(1288): GC_EXPLICIT freed 12K, 48% free 2698K/5123K, external 847K/1181K, paused 21ms 03-30 14:58:02.601: D/dalvikvm(1288): GC_EXPLICIT freed 1K, 48% free 2697K/5123K, external 847K/1181K, paused 22ms 03-30 14:58:02.601: I/dalvikvm(1288): System server process 1386 has been created 03-30 14:58:02.601: I/Zygote(1288): Accepting command socket connections 03-30 14:58:02.671: I/sysproc(1386): Entered system_init() 03-30 14:58:02.671: I/sysproc(1386): ServiceManager: 0x126888 03-30 14:58:02.671: I/SurfaceFlinger(1386): SurfaceFlinger is starting 03-30 14:58:02.671: I/SurfaceFlinger(1386): SurfaceFlinger's main thread ready to run. Initializing graphics H/W... 03-30 14:58:02.671: E/SurfaceFlinger(1386): Couldn't open /sys/power/wait_for_fb_sleep or /sys/power/wait_for_fb_wake 03-30 14:58:02.718: E/FramebufferNativeWindow(1386): 2 buffers flip-chain implementation enabled 03-30 14:58:02.718: D/TIOverlay(1386): LCD[0] NAME[lcd2] 03-30 14:58:02.718: D/TIOverlay(1386): LCD[0] PATH[/sys/devices/platform/omapdss/display0/enabled] 03-30 14:58:02.718: D/TIOverlay(1386): LCD[0] timings[46000,1024/160/150/10,600/12/20/3 03-30 14:58:02.718: D/TIOverlay(1386): ] 03-30 14:58:02.718: E/TIOverlay(1386): Can't open the file[/sys/devices/platform/omapdss/display1/name] 03-30 14:58:02.718: D/TIOverlay(1386): lcd name get failed (maybe because device has less displays than max allowed) 03-30 14:58:02.718: D/TIOverlay(1386): MANAGER[0] NAME[lcd] 03-30 14:58:02.718: D/TIOverlay(1386): MANAGER[1] NAME[tv] 03-30 14:58:02.718: D/TIOverlay(1386): MANAGER[2] NAME[2lcd] 03-30 14:58:02.726: D/libEGL(1386): loaded /system/lib/egl/libGLES_android.so 03-30 14:58:02.734: D/libEGL(1386): loaded /vendor/lib/egl/libEGL_POWERVR_SGX540_120.so 03-30 14:58:02.757: D/libEGL(1386): loaded /vendor/lib/egl/libGLESv1_CM_POWERVR_SGX540_120.so 03-30 14:58:02.765: D/libEGL(1386): loaded /vendor/lib/egl/libGLESv2_POWERVR_SGX540_120.so 03-30 14:58:02.804: E/libEGL(1386): eglSetSwapRectangleANDROID:1844 error 3008 (EGL_BAD_DISPLAY) 03-30 14:58:02.804: I/SurfaceFlinger(1386): EGL informations: 03-30 14:58:02.804: I/SurfaceFlinger(1386): # of configs : 36 03-30 14:58:02.804: I/SurfaceFlinger(1386): vendor : Android 03-30 14:58:02.804: I/SurfaceFlinger(1386): version : 1.4 Android META-EGL 03-30 14:58:02.804: I/SurfaceFlinger(1386): extensions: EGL_KHR_image EGL_KHR_image_base EGL_KHR_image_pixmap EGL_ANDROID_image_native_buffer EGL_ANDROID_swap_rectangle 03-30 14:58:02.804: I/SurfaceFlinger(1386): Client API: OpenGL ES 03-30 14:58:02.804: I/SurfaceFlinger(1386): EGLSurface: 8-8-8-8, config=0x1 03-30 14:58:02.804: I/SurfaceFlinger(1386): OpenGL informations: 03-30 14:58:02.804: I/SurfaceFlinger(1386): vendor : Imagination Technologies 03-30 14:58:02.804: I/SurfaceFlinger(1386): renderer : PowerVR SGX 540 03-30 14:58:02.804: I/SurfaceFlinger(1386): version : OpenGL ES-CM 1.1 03-30 14:58:02.804: I/SurfaceFlinger(1386): extensions: GL_OES_byte_coordinates GL_OES_fixed_point GL_OES_single_precision GL_OES_matrix_get GL_OES_read_format GL_OES_compressed_paletted_texture GL_OES_point_sprite GL_OES_point_size_array GL_OES_matrix_palette GL_OES_draw_texture GL_OES_query_matrix GL_OES_texture_env_crossbar GL_OES_texture_mirrored_repeat GL_OES_texture_cube_map GL_OES_blend_subtract GL_OES_blend_func_separate GL_OES_blend_equation_separate GL_OES_stencil_wrap GL_OES_extended_matrix_palette GL_OES_framebuffer_object GL_OES_rgb8_rgba8 GL_OES_depth24 GL_OES_stencil8 GL_OES_compressed_ETC1_RGB8_texture GL_OES_mapbuffer GL_OES_EGL_image GL_EXT_multi_draw_arrays GL_OES_required_internalformat GL_IMG_read_format GL_IMG_texture_compression_pvrtc GL_IMG_texture_format_BGRA8888 GL_EXT_texture_format_BGRA8888 GL_IMG_texture_stream GL_OES_egl_sync GL_IMG_vertex_array_object 03-30 14:58:02.804: I/SurfaceFlinger(1386): GL_MAX_TEXTURE_SIZE = 2048 03-30 14:58:02.804: I/SurfaceFlinger(1386): GL_MAX_VIEWPORT_DIMS = 2048 03-30 14:58:02.804: I/SurfaceFlinger(1386): flags = 00010000 03-30 14:58:02.804: D/SensorService(1386): nuSensorService starting... 03-30 14:58:02.835: D/libEGL(1399): loaded /system/lib/egl/libGLES_android.so 03-30 14:58:02.835: D/libEGL(1399): loaded /vendor/lib/egl/libEGL_POWERVR_SGX540_120.so 03-30 14:58:02.835: D/libEGL(1399): loaded /vendor/lib/egl/libGLESv1_CM_POWERVR_SGX540_120.so 03-30 14:58:02.835: D/libEGL(1399): loaded /vendor/lib/egl/libGLESv2_POWERVR_SGX540_120.so 03-30 14:58:03.351: W/zipro(1399): Unable to open zip '/data/local/bootanimation.zip': No such file or directory 03-30 14:58:03.421: E/SurfaceFlinger(1386): eglSwapBuffers: EGL error 0x3008 (EGL_BAD_DISPLAY) 03-30 14:58:03.625: E/Sensors(1386): couldn't find 'detect' input device 03-30 14:58:03.656: I/SensorService(1386): BMA250 3-axis Accelerometer 03-30 14:58:03.656: D/SensorService(1386): nuSensorService thread starting... 03-30 14:58:03.656: I/sysproc(1386): System server: starting Android runtime. 03-30 14:58:03.656: I/sysproc(1386): System server: starting Android services. 03-30 14:58:03.656: I/sysproc(1386): System server: entering thread pool. 03-30 14:58:03.656: I/SystemServer(1386): Entered the Android system server! 03-30 14:58:03.656: I/SystemServer(1386): Entropy Service 03-30 14:58:04.203: I/SystemServer(1386): Power Manager 03-30 14:58:04.218: I/SystemServer(1386): Activity Manager 03-30 14:58:04.242: I/ActivityManager(1386): Memory class: 64 03-30 14:58:04.429: D/dalvikvm(1386): GC_CONCURRENT freed 53K, 45% free 3072K/5575K, external 847K/1181K, paused 4ms+6ms 03-30 14:58:04.859: I/SystemServer(1386): Telephony Registry 03-30 14:58:04.859: I/SystemServer(1386): Package Manager 03-30 14:58:05.976: I/Installer(1386): connecting... 03-30 14:58:05.984: I/installd(1291): new connection 03-30 14:58:06.046: D/dalvikvm(1386): GC_CONCURRENT freed 335K, 47% free 3249K/6023K, external 847K/1181K, paused 6ms+6ms 03-30 14:58:06.468: D/dalvikvm(1386): GC_CONCURRENT freed 383K, 47% free 3349K/6215K, external 847K/1181K, paused 5ms+17ms 03-30 14:58:06.640: W/ResourceType(1386): Failure getting entry for 0x7f020086 (t=1 e=134) in package 0 (error -75) 03-30 14:58:06.664: W/PackageManager(1386): Permission com.amazon.permission.GLOBAL_SYNC from package com.amazon.mp3 ignored: original from com.lab126.otter 03-30 14:58:06.679: I/PackageManager(1386): removed obsolete native libraries for system package /system/app/air_runtime.apk 03-30 14:58:06.687: D/szipinf(1386): Initializing inflate state 03-30 14:58:06.976: D/dalvikvm(1386): GC_CONCURRENT freed 153K, 42% free 3675K/6279K, external 847K/1181K, paused 1ms+4ms 03-30 14:58:07.117: I/PackageParser(1386): com.amazon.kindle.otter.oobe: compat added android.permission.WRITE_EXTERNAL_STORAGE android.permission.READ_PHONE_STATE 03-30 14:58:07.289: D/szipinf(1386): Initializing inflate state 03-30 14:58:07.320: W/ResourceType(1386): Failure getting entry for 0x7f0e00b7 (t=13 e=183) in package 0 (error -75) 03-30 14:58:07.500: D/dalvikvm(1386): GC_CONCURRENT freed 239K, 41% free 3911K/6599K, external 847K/1181K, paused 3ms+14ms 03-30 14:58:07.734: D/szipinf(1386): Initializing inflate state 03-30 14:58:07.859: W/PackageParser(1386): Unknown element under : permission at /system/app/AmazonVenezia.apk Binary XML file line #40 03-30 14:58:07.914: D/szipinf(1386): Initializing inflate state 03-30 14:58:07.953: D/PackageManager(1386): No files in app dir /vendor/app 03-30 14:58:07.968: I/PackageManager(1386): Unpacking native libraries for package com.appcelerator.kitchensinknook 03-30 14:58:08.015: D/dalvikvm(1386): GC_CONCURRENT freed 242K, 39% free 4232K/6919K, external 847K/1181K, paused 2ms+5ms 03-30 14:58:10.367: I/PackageManager(1386): Unpacking native libraries for package com.appcelerator.analyticsTest 03-30 14:58:12.625: I/PackageManager(1386): Unpacking native libraries for package com.aaa 03-30 14:58:12.656: D/szipinf(1386): Initializing inflate state 03-30 14:58:12.703: I/PackageManager(1386): Unpacking native libraries for package com.estrongs.android.pop 03-30 14:58:12.781: I/PackageManager(1386): Time to scan packages: 6.444 seconds 03-30 14:58:12.781: W/PackageManager(1386): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.imdb.mobile (protectionLevel=2 flags=0x8be45) 03-30 14:58:12.781: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.mail in package com.android.contacts 03-30 14:58:12.796: W/PackageManager(1386): Unknown permission android.permission.DEVICE_ADMIN in package com.lab126.otter 03-30 14:58:12.796: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.providers.calendar 03-30 14:58:12.796: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.cl in package com.android.providers.calendar 03-30 14:58:12.796: W/PackageManager(1386): Unknown permission org.thialfihar.android.apg.permission.READ_KEY_DETAILS in package com.amazon.email 03-30 14:58:12.796: W/PackageManager(1386): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.cooliris.media (protectionLevel=2 flags=0x8bc45) 03-30 14:58:12.804: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.providers.contacts 03-30 14:58:12.804: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.cp in package com.android.providers.contacts 03-30 14:58:12.804: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.WRITE_GMAIL in package com.android.settings 03-30 14:58:12.804: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.READ_GMAIL in package com.android.settings 03-30 14:58:12.804: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.settings 03-30 14:58:12.812: W/PackageManager(1386): Unknown permission com.android.launcher.permission.READ_SETTINGS in package com.android.settings 03-30 14:58:12.812: W/PackageManager(1386): Unknown permission com.android.launcher.permission.WRITE_SETTINGS in package com.android.settings 03-30 14:58:12.812: W/PackageManager(1386): Unknown permission com.android.launcher.permission.INSTALL_SHORTCUT in package com.amazon.cloud9 03-30 14:58:12.820: W/PackageManager(1386): Unknown permission android.webkit.permission.PLUGIN in package com.adobe.flashplayer 03-30 14:58:12.820: W/PackageManager(1386): Unknown permission com.google.android.providers.gmail.permission.WRITE_GMAIL in package com.qo.android.oemvc 03-30 14:58:12.820: W/PackageManager(1386): Unknown permission com.google.android.providers.gmail.permission.READ_GMAIL in package com.qo.android.oemvc 03-30 14:58:12.820: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.READ_GMAIL in package com.qo.android.oemvc 03-30 14:58:12.820: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.WRITE_GMAIL in package com.qo.android.oemvc 03-30 14:58:12.820: W/PackageManager(1386): Unknown permission android.permission.READ_OWNER_DATA in package com.qo.android.oemvc 03-30 14:58:12.820: W/PackageManager(1386): Unknown permission com.android.email.permission.ACCESS_PROVIDER in package com.qo.android.oemvc 03-30 14:58:12.820: W/PackageManager(1386): Unknown permission com.android.launcher.permission.INSTALL_SHORTCUT in package com.estrongs.android.pop 03-30 14:58:12.820: W/PackageManager(1386): Unknown permission com.android.launcher.permission.UNINSTALL_SHORTCUT in package com.estrongs.android.pop 03-30 14:58:12.820: W/PackageManager(1386): Unknown permission com.estrongs.android.pop.PERMISSION in package com.estrongs.android.pop 03-30 14:58:12.820: W/PackageManager(1386): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.alphonso.pulse (protectionLevel=2 flags=0x8be45) 03-30 14:58:12.929: D/dalvikvm(1386): GC_CONCURRENT freed 410K, 40% free 4454K/7303K, external 847K/1181K, paused 6ms+11ms 03-30 14:58:13.289: D/dalvikvm(1386): GC_EXPLICIT freed 410K, 44% free 4099K/7303K, external 847K/1181K, paused 94ms 03-30 14:58:13.296: I/SystemServer(1386): Account Manager 03-30 14:58:13.390: I/SystemServer(1386): Content Manager 03-30 14:58:13.484: I/SystemServer(1386): System Content Providers 03-30 14:58:13.492: I/ActivityThread(1386): Pub settings: com.android.providers.settings.SettingsProvider 03-30 14:58:13.500: D/ContentProvider(1386): Error creating Video folder. 03-30 14:58:13.500: D/ContentProvider(1386): Error creating Pictures folder. 03-30 14:58:13.515: I/SystemServer(1386): Battery Service 03-30 14:58:13.523: D/SettingsProvider(1386): cache for settings table 'secure' rows=25; fullycached=true 03-30 14:58:13.539: D/SettingsProvider(1386): cache for settings table 'system' rows=47; fullycached=true 03-30 14:58:13.546: I/SystemServer(1386): Lights Service 03-30 14:58:13.554: I/SystemServer(1386): Vibrator Service 03-30 14:58:13.570: I/SystemServer(1386): Alarm Manager 03-30 14:58:13.578: I/SystemServer(1386): Init Watchdog 03-30 14:58:13.578: I/SystemServer(1386): Window Manager 03-30 14:58:13.585: I/InputManager(1386): Initializing input manager 03-30 14:58:13.593: D/KeyguardUpdateMonitor(1386): DEVICE_PROVISIONED was true during init 03-30 14:58:13.617: I/InputManager(1386): Starting input manager 03-30 14:58:13.617: I/SystemServer(1386): Bluetooth Service 03-30 14:58:13.625: I/BluetoothProfileState(1386): Message:Entering Stable State 03-30 14:58:13.625: I/BluetoothProfileState(1386): Message:Entering Stable State 03-30 14:58:13.632: I/SystemServer(1386): Device Policy 03-30 14:58:13.632: I/SystemServer(1386): Status Bar 03-30 14:58:13.640: I/SystemServer(1386): Clipboard Service 03-30 14:58:13.640: I/SystemServer(1386): Input Method Service 03-30 14:58:13.648: I/InputManagerService(1386): Enabled input methods: com.android.inputmethod.latin/.LatinIME 03-30 14:58:13.648: I/SystemServer(1386): NetStat Service 03-30 14:58:13.648: I/SystemServer(1386): NetworkManagement Service 03-30 14:58:13.648: I/SystemServer(1386): Connectivity Service 03-30 14:58:13.679: I/WifiService(1386): WifiService starting up with Wi-Fi enabled 03-30 14:58:13.687: I/EventHub(1386): New device: path=/dev/input/event3 name=OMAP4_KC1-ABE Headset Jack id=0x20000 (of 0x1) index=1 fd=97 classes=0x80 03-30 14:58:13.687: D/NetworkManagmentService(1386): Registering observer 03-30 14:58:13.695: I/SystemServer(1386): Throttle Service 03-30 14:58:13.703: I/SystemServer(1386): Thermal Observer 03-30 14:58:13.703: I/SystemServer(1386): Accessibility Manager 03-30 14:58:13.710: I/SystemServer(1386): Mount Service 03-30 14:58:13.718: I/EventHub(1386): New keyboard: device->id=0x10001 devname='ilitek_i2c' propName='hw.keyboards.65537.devname' keylayout='/system/usr/keylayout/qwerty.kl' 03-30 14:58:13.718: I/EventHub(1386): New device: path=/dev/input/event1 name=ilitek_i2c id=0x10001 (of 0x2) index=2 fd=101 classes=0x15 03-30 14:58:13.718: I/SystemServer(1386): Notification Manager 03-30 14:58:13.726: I/PackageManager(1386): Updating external media status from unmounted to unmounted 03-30 14:58:13.726: I/SystemServer(1386): Device Storage Monitor 03-30 14:58:13.726: D/VoldCmdListener(1285): volume list 03-30 14:58:13.726: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 14:58:13.726: D/devicestoragemonitor(1386): starting bg thread to monitor internal storage usage 03-30 14:58:13.734: D/VoldCmdListener(1285): share status ums 03-30 14:58:13.734: I/SystemServer(1386): Location Manager 03-30 14:58:13.734: D/devicestoragemonitor(1386): internal storage not mounted 03-30 14:58:13.734: I/SystemServer(1386): Search Service 03-30 14:58:13.742: I/EventHub(1386): New keyboard: device->id=0x10002 devname='twl4030_pwrbutton' propName='hw.keyboards.65538.devname' keylayout='/system/usr/keylayout/qwerty.kl' 03-30 14:58:13.742: I/EventHub(1386): New device: path=/dev/input/event2 name=twl4030_pwrbutton id=0x10002 (of 0x3) index=3 fd=106 classes=0x1 03-30 14:58:13.757: I/InputReader(1386): Device added: id=0x10002, name=twl4030_pwrbutton, sources=00000101 03-30 14:58:13.757: I/InputReader(1386): Device added: id=0x0, name=ilitek_i2c, sources=00001103 03-30 14:58:13.757: I/InputReader(1386): Device added: id=0x20000, name=OMAP4_KC1-ABE Headset Jack, sources=00000000 03-30 14:58:13.757: I/InputManager-Callbacks(1386): No input device calibration properties found for device twl4030_pwrbutton. 03-30 14:58:13.757: I/InputManager-Callbacks(1386): No input device calibration properties found for device ilitek_i2c. 03-30 14:58:13.757: I/InputManager-Callbacks(1386): No input device calibration properties found for device OMAP4_KC1-ABE Headset Jack. 03-30 14:58:13.757: I/SystemServer(1386): DropBox Service 03-30 14:58:13.757: I/SystemServer(1386): Wallpaper Service 03-30 14:58:13.867: I/SystemServer(1386): Audio Service 03-30 14:58:13.921: D/dalvikvm(1386): GC_CONCURRENT freed 151K, 40% free 4435K/7303K, external 847K/1181K, paused 7ms+8ms 03-30 14:58:13.953: W/AudioPolicyManagerBase(1289): setPhoneState() setting same state 0 03-30 14:58:13.960: E/BluetoothHeadset(1386): Could not bind to Bluetooth Headset Service 03-30 14:58:13.960: W/ActivityManager(1386): Unable to start service Intent { act=android.bluetooth.IBluetoothHeadset }: not found 03-30 14:58:13.968: I/SystemServer(1386): Headset Observer 03-30 14:58:13.968: I/SystemServer(1386): HDMI Observer 03-30 14:58:13.968: W/HDMIObserver(1386): This kernel does not have hdmi support 03-30 14:58:13.968: I/SystemServer(1386): Dock Observer 03-30 14:58:13.968: W/DockObserver(1386): This kernel does not have dock station support 03-30 14:58:13.968: I/SystemServer(1386): USB Service 03-30 14:58:13.976: W/UsbDeviceSettingsManager(1386): settings file not found 03-30 14:58:13.976: I/SystemServer(1386): UI Mode Manager Service 03-30 14:58:13.984: I/SystemServer(1386): Backup Service 03-30 14:58:14.000: V/BackupManagerService(1386): No ancestral data 03-30 14:58:14.078: D/Tethering(1386): tiwlan0 is not a tetherable iface, ignoring 03-30 14:58:14.132: I/BackupManagerService(1386): Found stale backup journal, scheduling 03-30 14:58:14.140: I/BackupManagerService(1386): com.android.inputmethod.latin 03-30 14:58:14.140: I/BackupManagerService(1386): com.android.providers.userdictionary 03-30 14:58:14.140: I/BackupManagerService(1386): android 03-30 14:58:14.140: I/BackupManagerService(1386): com.android.providers.settings 03-30 14:58:14.140: I/BackupManagerService(1386): Backup enabled => false 03-30 14:58:14.140: I/SystemServer(1386): AppWidget Service 03-30 14:58:14.148: I/SystemServer(1386): Recognition Service 03-30 14:58:14.148: I/SystemServer(1386): DiskStats Service 03-30 14:58:14.148: I/SystemServer(1386): TimeService Service 03-30 14:58:14.156: I/SystemServer(1386): CaptiveWifiService Service 03-30 14:58:14.164: I/SystemServer(1386): ResourceMonitor Service 03-30 14:58:14.171: I/SystemServer(1386): ChargeProtectionService Service 03-30 14:58:14.656: I/ChargeProtectionService(1386): Starting charge protection service... 03-30 14:58:14.656: I/SystemServer(1386): WakelogDebugService Service 03-30 14:58:14.656: I/SystemServer(1386): UiCloningService 03-30 14:58:14.671: I/WindowManager(1386): SAFE MODE not enabled 03-30 14:58:14.671: D/dalvikvm(1386): JIT started for system_server 03-30 14:58:14.687: I/power(1386): *** set_screen_state 1 03-30 14:58:14.695: D/PowerManagerService(1386): system ready! 03-30 14:58:14.695: I/ActivityManager(1386): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=1 layout=268435491 uiMode=0 seq=1} 03-30 14:58:14.703: I/ActivityManager(1386): System now ready 03-30 14:58:14.710: I/Zygote(1386): Process: zygote socket opened 03-30 14:58:14.710: I/SystemServer(1386): Making services ready 03-30 14:58:14.710: I/StatusBarManagerService(1386): Starting service: ComponentInfo{com.android.systemui/com.android.systemui.statusbar.StatusBarService} 03-30 14:58:14.726: I/ActivityManager(1386): Start proc com.android.systemui for service com.android.systemui/.statusbar.StatusBarService: pid=1448 uid=1000 gids={3003} 03-30 14:58:14.726: I/ActivityManager(1386): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=1 layout=268435491 uiMode=17 seq=2} 03-30 14:58:14.726: W/RecognitionManagerService(1386): no available voice recognition services found 03-30 14:58:14.734: E/LockScreen(1386): drawable resources >>> android 03-30 14:58:14.812: D/szipinf(1386): Initializing inflate state 03-30 14:58:14.882: D/dalvikvm(1386): GC_CONCURRENT freed 369K, 38% free 4751K/7559K, external 847K/1181K, paused 2ms+3ms 03-30 14:58:14.898: I/ActivityManager(1386): Start proc com.android.inputmethod.latin for service com.android.inputmethod.latin/.LatinIME: pid=1456 uid=10015 gids={} 03-30 14:58:14.914: D/NetworkManagmentService(1386): Registering observer 03-30 14:58:14.929: D/ActivityManager(1386): Starting: Intent { act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10000000 cmp=com.amazon.kindle.otter/.Launcher } from pid 0 03-30 14:58:14.937: D/SntpClient(1386): request time failed: java.net.UnknownHostException: ntp-g7g.amazon.com 03-30 14:58:14.937: D/SntpClient(1386): request time failed: java.net.UnknownHostException: ntp-g7g.amazon.com 03-30 14:58:14.937: I/ActivityManager(1386): Start proc com.amazon.kindle.otter for activity com.amazon.kindle.otter/.Launcher: pid=1462 uid=32009 gids={3003, 1015} 03-30 14:58:14.968: I/ChargeProtectionService(1386): Battery discharging, resuming charging 03-30 14:58:14.984: E/LockScreen(1386): res=17302374, name='wallpaper_01_2422' 03-30 14:58:14.984: E/LockScreen(1386): res=17302375, name='wallpaper_02_1953' 03-30 14:58:14.984: E/LockScreen(1386): res=17302376, name='wallpaper_03_6474' 03-30 14:58:14.984: E/LockScreen(1386): res=17302377, name='wallpaper_04_5588' 03-30 14:58:14.984: E/LockScreen(1386): res=17302378, name='wallpaper_06_6043' 03-30 14:58:14.984: E/LockScreen(1386): res=17302379, name='wallpaper_07_5751' 03-30 14:58:14.984: E/LockScreen(1386): res=17302380, name='wallpaper_08_1905' 03-30 14:58:14.984: E/LockScreen(1386): res=17302381, name='wallpaper_09_2283' 03-30 14:58:14.984: E/LockScreen(1386): res=17302382, name='wallpaper_10_5683' 03-30 14:58:14.984: E/LockScreen(1386): res=17302383, name='wallpaper_11_5335' 03-30 14:58:14.984: W/ActivityManager(1386): Unable to start service Intent { act=@0 }: not found 03-30 14:58:14.984: W/ActivityManager(1386): Unable to start service Intent { act=@0 }: not found 03-30 14:58:14.992: E/LockScreen(1386): res=17302384, name='wallpaper_12_5866' 03-30 14:58:14.992: E/LockScreen(1386): res=17302385, name='wallpaper_13_3664' 03-30 14:58:14.992: E/LockScreen(1386): res=17302386, name='wallpaper_14_6752' 03-30 14:58:14.992: E/LockScreen(1386): res=17302387, name='wallpaper_15_2429' 03-30 14:58:15.000: E/LockScreen(1386): res=17302388, name='wallpaper_16_5737' 03-30 14:58:15.000: E/LockScreen(1386): res=17302389, name='wallpaper_17_6712' 03-30 14:58:15.000: E/LockScreen(1386): res=17302390, name='wallpaper_18_3613' 03-30 14:58:15.000: E/LockScreen(1386): res=17302391, name='wallpaper_19_5507' 03-30 14:58:15.007: E/LockScreen(1386): res=17302392, name='wallpaper_20_6562' 03-30 14:58:15.007: E/LockScreen(1386): res=17302393, name='wallpaper_21_3622' 03-30 14:58:15.007: E/LockScreen(1386): res=17302394, name='wallpaper_22_6413' 03-30 14:58:15.007: E/LockScreen(1386): drawable resources <<< android 03-30 14:58:15.015: E/LockScreen(1386): current=1, maximum=21 03-30 14:58:15.015: E/ApplicationContext(1386): Couldn't create directory for SharedPreferences file 03-30 14:58:15.054: D/szipinf(1456): Initializing inflate state 03-30 14:58:15.070: D/dalvikvm(1386): GC_CONCURRENT freed 767K, 41% free 4731K/7943K, external 847K/1181K, paused 3ms+8ms 03-30 14:58:15.078: D/szipinf(1448): Initializing inflate state 03-30 14:58:15.093: D/dalvikvm(1456): GC_EXTERNAL_ALLOC freed 74K, 49% free 2785K/5379K, external 847K/1181K, paused 36ms 03-30 14:58:15.117: D/dalvikvm(1456): GC_FOR_MALLOC freed <1K, 49% free 2784K/5379K, external 1512K/2024K, paused 22ms 03-30 14:58:15.117: I/dalvikvm-heap(1456): Grow heap (frag case) to 7.223MB for 681570-byte allocation 03-30 14:58:15.117: I/StatusBarManagerService(1386): registerStatusBar bar=com.android.internal.statusbar.IStatusBar$Stub$Proxy@4068d440 03-30 14:58:15.148: D/dalvikvm(1456): GC_FOR_MALLOC freed <1K, 44% free 3450K/6087K, external 1512K/2024K, paused 19ms 03-30 14:58:15.164: D/szipinf(1456): Initializing zlib to inflate 03-30 14:58:15.164: D/VoldCmdListener(1285): share status ums 03-30 14:58:15.171: D/StorageNotification(1448): Startup with UMS connection false (media state unmounted) 03-30 14:58:15.179: I/StorageNotification(1448): UMS connection changed to false (media state unmounted) 03-30 14:58:15.179: I/StorageNotification(1448): In onUsbMassStorageConnectionChangedAsync, POP_UMS_ACTIVITY_ON_CONNECT=false 03-30 14:58:15.234: D/dalvikvm(1456): GC_CONCURRENT freed <1K, 44% free 3449K/6087K, external 1512K/2024K, paused 1ms+2ms 03-30 14:58:15.273: D/IconMerger(1448): sum of notifications: 0 03-30 14:58:15.296: I/ActivityManager(1386): Start proc android.process.acore for content provider com.android.providers.userdictionary/.UserDictionaryProvider: pid=1481 uid=10003 gids={3003, 1015} 03-30 14:58:15.351: E/SlidingBand(1386): align right 03-30 14:58:15.359: D/szipinf(1448): Initializing inflate state 03-30 14:58:15.359: D/skia(1386): Loading ARM decoder... 03-30 14:58:15.429: D/dalvikvm(1448): GC_CONCURRENT freed 150K, 48% free 2954K/5575K, external 1176K/1181K, paused 2ms+9ms 03-30 14:58:15.460: D/dalvikvm(1386): GC_EXTERNAL_ALLOC freed 256K, 42% free 4660K/7943K, external 1054K/1181K, paused 65ms 03-30 14:58:15.460: D/dalvikvm(1448): GC_EXTERNAL_ALLOC freed 6K, 48% free 2948K/5575K, external 1176K/1181K, paused 28ms 03-30 14:58:15.476: I/ActivityThread(1481): Pub user_dictionary: com.android.providers.userdictionary.UserDictionaryProvider 03-30 14:58:15.476: D/ContentProvider(1481): Error creating Video folder. 03-30 14:58:15.476: D/ContentProvider(1481): Error creating Pictures folder. 03-30 14:58:15.476: I/ActivityThread(1481): Pub com.android.social: com.android.providers.contacts.SocialProvider 03-30 14:58:15.523: D/ContentProvider(1481): Error creating Video folder. 03-30 14:58:15.523: D/ContentProvider(1481): Error creating Pictures folder. 03-30 14:58:15.531: I/ActivityThread(1481): Pub applications: com.android.providers.applications.ApplicationsProvider 03-30 14:58:15.531: D/ContentProvider(1481): Error creating Video folder. 03-30 14:58:15.531: D/ContentProvider(1481): Error creating Pictures folder. 03-30 14:58:15.609: I/ActivityThread(1481): Pub contacts;com.android.contacts: com.android.providers.contacts.ContactsProvider2 03-30 14:58:15.617: D/ContentProvider(1481): Error creating Video folder. 03-30 14:58:15.617: D/ContentProvider(1481): Error creating Pictures folder. 03-30 14:58:15.679: I//system/bin/tc(1286): Cannot find device "rmnet0" 03-30 14:58:15.679: I/logwrapper(1286): /system/bin/tc terminated by exit(1) 03-30 14:58:15.726: I//system/bin/tc(1286): Cannot find device "rmnet0" 03-30 14:58:15.726: I/logwrapper(1286): /system/bin/tc terminated by exit(1) 03-30 14:58:15.742: D/Sensors(1386): newState = 0 03-30 14:58:15.789: I//system/bin/tc(1286): Cannot find device "ifb0" 03-30 14:58:15.789: I/logwrapper(1286): /system/bin/tc terminated by exit(1) 03-30 14:58:15.804: D/SntpClient(1386): request time failed: java.net.UnknownHostException: ntp-g7g.amazon.com 03-30 14:58:15.804: D/SntpClient(1386): request time failed: java.net.UnknownHostException: ntp-g7g.amazon.com 03-30 14:58:15.890: D/dalvikvm(1448): GC_EXTERNAL_ALLOC freed 14K, 44% free 3164K/5639K, external 1691K/1702K, paused 52ms 03-30 14:58:16.023: D/IconMerger(1448): sum of notifications: 0 03-30 14:58:16.171: I/ActivityManager(1386): Start proc com.amazon.dcp for service com.amazon.dcp/.metrics.MetricsService: pid=1526 uid=32000 gids={2001, 3003, 1015, 1007, 1026} 03-30 14:58:16.187: I/ActivityManager(1386): Start proc com.amazon.kindle for service com.amazon.kindle/com.amazon.kcp.service.ContentActionService: pid=1527 uid=32010 gids={3003, 1015} 03-30 14:58:16.218: I/ActivityManager(1386): Start proc com.android.settings for broadcast com.android.settings/.widget.SettingsAppWidgetProvider: pid=1532 uid=1000 gids={3003} 03-30 14:58:16.312: I/ActivityThread(1481): Pub call_log: com.android.providers.contacts.CallLogProvider 03-30 14:58:16.312: D/ContentProvider(1481): Error creating Video folder. 03-30 14:58:16.312: D/ContentProvider(1481): Error creating Pictures folder. 03-30 14:58:16.851: D/dalvikvm(1481): GC_CONCURRENT freed 159K, 48% free 2929K/5575K, external 847K/1181K, paused 2ms+9ms 03-30 14:58:16.945: I/ActivityManager(1386): Displayed com.amazon.kindle.otter/.Launcher: +2s18ms 03-30 14:58:16.992: E/Tethering(1386): attempting to remove unknown iface (usb0), ignoring 03-30 14:58:16.992: D/PowerManagerService(1386): bootCompleted 03-30 14:58:17.000: I/SurfaceFlinger(1386): Boot is finished (14322 ms) 03-30 14:58:17.000: D/VoldCmdListener(1285): volume mount /mnt/sdcard 03-30 14:58:17.000: I/Vold(1285): /dev/block/vold/179:12 being considered for volume sdcard 03-30 14:58:17.000: D/Vold(1285): Volume sdcard state changing 1 (Idle-Unmounted) -> 3 (Checking) 03-30 14:58:17.007: I/StorageNotification(1448): Media state changed from {unmounted} -> {checking} 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_Init 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: D/OMX_CORE(1289): TIOMX_ComponentNameEnum 03-30 14:58:17.085: W/ASFDummyExtractor(1289): ASF parser is not available 03-30 14:58:17.085: E/MPEG4Extractor(1289): both mdat,ftyp not found 03-30 14:58:17.140: E/BluetoothHeadset(1386): Could not bind to Bluetooth Headset Service 03-30 14:58:17.140: W/ActivityManager(1386): Unable to start service Intent { act=android.bluetooth.IBluetoothHeadset }: not found 03-30 14:58:17.148: V/WifiStateTracker(1386): Connection to supplicant established, state=DISCONNECTED 03-30 14:58:17.148: W/MobileDataStateTracker(1386): Ignoring feature request because could not acquire PhoneService 03-30 14:58:17.148: W/MobileDataStateTracker(1386): Could not enable APN type "default" 03-30 14:58:17.148: D/Tethering(1386): MasterInitialState.processMessage what=3 03-30 14:58:17.156: D/CaptiveWifiService(1386): SSID is null 03-30 14:58:17.156: I/CaptiveWifiService(1386): Connectivity action change network 03-30 14:58:17.156: W/ASFDummyExtractor(1289): ASF parser is not available 03-30 14:58:17.156: E/MPEG4Extractor(1289): both mdat,ftyp not found 03-30 14:58:17.179: D/dalvikvm(1448): GC_CONCURRENT freed 106K, 44% free 3374K/5959K, external 2008K/2217K, paused 2ms+2ms 03-30 14:58:17.187: I/StatusBarPolicy(1448): updateConnectivity: inetCondition = 0 03-30 14:58:17.203: W/ASFDummyExtractor(1289): ASF parser is not available 03-30 14:58:17.203: E/MPEG4Extractor(1289): both mdat,ftyp not found 03-30 14:58:17.210: V/WifiMonitor(1386): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=2 BSSID=00:00:00:00:00:00] 03-30 14:58:17.210: V/WifiStateTracker(1386): Changing supplicant state: DISCONNECTED ==> SCANNING 03-30 14:58:17.210: I/ActivityManager(1386): Start proc com.amazon.cloud9 for content provider com.amazon.cloud9/.provider.BrowserProvider: pid=1596 uid=32013 gids={3003, 1015} 03-30 14:58:17.218: I/SearchManagerService(1386): Building list of searchable activities 03-30 14:58:17.226: D/szipinf(1386): Initializing inflate state 03-30 14:58:17.257: W/ASFDummyExtractor(1289): ASF parser is not available 03-30 14:58:17.257: E/MPEG4Extractor(1289): both mdat,ftyp not found 03-30 14:58:17.281: D/szipinf(1481): Initializing inflate state 03-30 14:58:17.281: D/szipinf(1481): Initializing inflate state 03-30 14:58:17.296: W/ASFDummyExtractor(1289): ASF parser is not available 03-30 14:58:17.296: E/MPEG4Extractor(1289): both mdat,ftyp not found 03-30 14:58:17.320: D/szipinf(1481): Initializing inflate state 03-30 14:58:17.343: D/szipinf(1481): Initializing inflate state 03-30 14:58:17.367: I//system/bin/fsck_msdos(1285): ** /dev/block/vold/179:12 03-30 14:58:17.367: I//system/bin/fsck_msdos(1285): ** Phase 1 - Read FAT (compare skipped) 03-30 14:58:17.367: I//system/bin/fsck_msdos(1285): Attempting to allocate 10242 KB for FAT 03-30 14:58:17.398: D/szipinf(1481): Initializing inflate state 03-30 14:58:17.515: D/szipinf(1386): Initializing inflate state 03-30 14:58:17.554: D/szipinf(1386): Initializing inflate state 03-30 14:58:17.960: D/szipinf(1386): Initializing inflate state 03-30 14:58:18.039: V/WifiMonitor(1386): Event [Trying to associate with 00:00:00:00:cd:d4 (SSID='0559d0588453b2151697f6b0ab607b31' freq=2412 MHz rssi=-67)] 03-30 14:58:18.039: V/WifiMonitor(1386): Event [CTRL-EVENT-STATE-CHANGE id=-1 state=3 BSSID=00:00:00:00:cd:d4] 03-30 14:58:18.039: V/WifiStateTracker(1386): Changing supplicant state: SCANNING ==> ASSOCIATING 03-30 14:58:18.429: I//system/bin/fsck_msdos(1285): ** Phase 2 - Check Cluster Chains 03-30 14:58:18.851: I//system/bin/fsck_msdos(1285): ** Phase 3 - Checking Directories 03-30 14:58:19.960: I/ActivityManager(1386): Start proc com.amazon.avod for content provider com.amazon.avod/.provider.ExternalSearchProvider: pid=1614 uid=32016 gids={3003, 1015} 03-30 14:58:20.023: D/dalvikvm(1288): GC_EXPLICIT freed 11K, 50% free 2709K/5379K, external 847K/1181K, paused 61ms 03-30 14:58:20.101: D/dalvikvm(1288): GC_EXPLICIT freed <1K, 50% free 2709K/5379K, external 847K/1181K, paused 78ms 03-30 14:58:20.132: V/WifiMonitor(1386): Event [CTRL-EVENT-STATE-CHANGE id=1 state=4 BSSID=00:00:00:00:cd:d4] 03-30 14:58:20.132: V/WifiStateTracker(1386): Changing supplicant state: ASSOCIATING ==> ASSOCIATED 03-30 14:58:20.132: V/WifiMonitor(1386): Event [Associated with 00:00:00:00:cd:d4] 03-30 14:58:20.132: V/WifiMonitor(1386): Event [CTRL-EVENT-STATE-CHANGE id=1 state=5 BSSID=00:00:00:00:00:00] 03-30 14:58:20.132: V/WifiStateTracker(1386): Changing supplicant state: ASSOCIATED ==> FOUR_WAY_HANDSHAKE 03-30 14:58:20.140: V/WifiMonitor(1386): Event [CTRL-EVENT-STATE-CHANGE id=1 state=5 BSSID=00:00:00:00:00:00] 03-30 14:58:20.140: V/WifiStateTracker(1386): Changing supplicant state: FOUR_WAY_HANDSHAKE ==> FOUR_WAY_HANDSHAKE 03-30 14:58:20.140: V/WifiMonitor(1386): Event [CTRL-EVENT-STATE-CHANGE id=1 state=6 BSSID=00:00:00:00:00:00] 03-30 14:58:20.140: V/WifiStateTracker(1386): Changing supplicant state: FOUR_WAY_HANDSHAKE ==> GROUP_HANDSHAKE 03-30 14:58:20.140: V/WifiMonitor(1386): Event [WPA: Key negotiation completed with 00:00:00:00:cd:d4 [PTK=CCMP GTK=CCMP]] 03-30 14:58:20.140: V/WifiMonitor(1386): Event [CTRL-EVENT-STATE-CHANGE id=1 state=7 BSSID=00:00:00:00:00:00] 03-30 14:58:20.140: V/WifiMonitor(1386): Event [CTRL-EVENT-CONNECTED - Connection to 00:00:00:00:cd:d4 completed (auth) [id=1 id_str=]] 03-30 14:58:20.140: V/WifiStateTracker(1386): Changing supplicant state: GROUP_HANDSHAKE ==> COMPLETED 03-30 14:58:20.140: V/WifiStateTracker(1386): New network state is CONNECTED 03-30 14:58:20.148: W/BluetoothHeadset(1386): Proxy not attached to service 03-30 14:58:20.148: W/BluetoothHeadset(1386): Proxy not attached to service 03-30 14:58:20.148: D/IconMerger(1448): notification for com.android.systemui (1) 03-30 14:58:20.148: D/IconMerger(1448): sum of notifications: 1 03-30 14:58:20.187: D/dalvikvm(1288): GC_EXPLICIT freed <1K, 50% free 2709K/5379K, external 847K/1181K, paused 84ms 03-30 14:58:20.273: D/WifiStateTracker(1386): DHCP request started 03-30 14:58:20.929: I//system/bin/fsck_msdos(1285): ** Phase 4 - Checking for Lost Files 03-30 14:58:21.031: W/ActivityManager(1386): Unable to start service Intent { act=appStartup }: not found 03-30 14:58:21.101: I/RecoverySystem(1386): No recovery log file 03-30 14:58:21.101: I/RecoverySystem(1386): No recovery log file to get OTA operation result 03-30 14:58:21.109: W/DropBoxManagerService(1386): Unrecognized file: /dropbox/recovery 03-30 14:58:21.156: I/ActivityManager(1386): Start proc android.process.media for content provider com.android.providers.downloads/.DownloadProvider: pid=1637 uid=10011 gids={1015, 2001, 3003} 03-30 14:58:21.218: I/ActivityThread(1637): Pub media: com.android.providers.media.MediaProvider 03-30 14:58:21.351: I//system/bin/fsck_msdos(1285): Next free cluster in FSInfo block (1155) not free 03-30 14:58:21.351: I//system/bin/fsck_msdos(1285): FIXED 03-30 14:58:21.351: I//system/bin/fsck_msdos(1285): 1059 files, 1019286 free (2606795 clusters) 03-30 14:58:21.617: D/ContentProvider(1637): Error creating Video folder. 03-30 14:58:21.617: D/ContentProvider(1637): Error creating Pictures folder. 03-30 14:58:21.617: V/MediaProvider(1637): Attached volume: internal 03-30 14:58:21.625: I/ActivityThread(1637): Pub downloads: com.android.providers.downloads.DownloadProvider 03-30 14:58:21.632: I/Vold(1285): Filesystem check completed OK 03-30 14:58:21.671: D/ContentProvider(1637): Error creating Video folder. 03-30 14:58:21.671: D/ContentProvider(1637): Error creating Pictures folder. 03-30 14:58:21.671: I/ActivityThread(1637): Pub drm: com.android.providers.drm.DrmProvider 03-30 14:58:21.671: D/ContentProvider(1637): Error creating Video folder. 03-30 14:58:21.671: D/ContentProvider(1637): Error creating Pictures folder. 03-30 14:58:21.671: I/Vold(1285): Device /dev/block/vold/179:12, target /mnt/sdcard mounted @ /mnt/secure/staging 03-30 14:58:21.679: I/PackageManager(1386): Updating external media status from unmounted to mounted 03-30 14:58:21.679: D/Vold(1285): Volume sdcard state changing 3 (Checking) -> 4 (Mounted) 03-30 14:58:21.679: I/StorageNotification(1448): Media state changed from {checking} -> {mounted} 03-30 14:58:21.679: D/IconMerger(1448): sum of notifications: 0 03-30 14:58:21.695: I/PackageManager(1386): No secure containers on sdcard 03-30 14:58:21.695: D/VoldCmdListener(1285): asec list 03-30 14:58:21.703: W/PackageManager(1386): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.imdb.mobile (protectionLevel=2 flags=0x8be45) 03-30 14:58:21.703: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.mail in package com.android.contacts 03-30 14:58:21.796: D/dalvikvm(1386): GC_CONCURRENT freed 459K, 39% free 4874K/7943K, external 2732K/3412K, paused 3ms+5ms 03-30 14:58:21.804: W/PackageManager(1386): Unknown permission android.permission.DEVICE_ADMIN in package com.lab126.otter 03-30 14:58:21.812: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.providers.calendar 03-30 14:58:21.812: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.cl in package com.android.providers.calendar 03-30 14:58:21.812: W/PackageManager(1386): Unknown permission org.thialfihar.android.apg.permission.READ_KEY_DETAILS in package com.amazon.email 03-30 14:58:21.812: W/PackageManager(1386): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.cooliris.media (protectionLevel=2 flags=0x8bc45) 03-30 14:58:21.820: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.providers.contacts 03-30 14:58:21.820: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.cp in package com.android.providers.contacts 03-30 14:58:21.820: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.WRITE_GMAIL in package com.android.settings 03-30 14:58:21.820: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.READ_GMAIL in package com.android.settings 03-30 14:58:21.820: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.settings 03-30 14:58:21.820: W/PackageManager(1386): Unknown permission com.android.launcher.permission.READ_SETTINGS in package com.android.settings 03-30 14:58:21.820: W/PackageManager(1386): Unknown permission com.android.launcher.permission.WRITE_SETTINGS in package com.android.settings 03-30 14:58:21.828: W/PackageManager(1386): Unknown permission com.android.launcher.permission.INSTALL_SHORTCUT in package com.amazon.cloud9 03-30 14:58:21.843: W/PackageManager(1386): Unknown permission android.webkit.permission.PLUGIN in package com.adobe.flashplayer 03-30 14:58:21.843: W/PackageManager(1386): Unknown permission com.google.android.providers.gmail.permission.WRITE_GMAIL in package com.qo.android.oemvc 03-30 14:58:21.843: W/PackageManager(1386): Unknown permission com.google.android.providers.gmail.permission.READ_GMAIL in package com.qo.android.oemvc 03-30 14:58:21.843: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.READ_GMAIL in package com.qo.android.oemvc 03-30 14:58:21.843: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.WRITE_GMAIL in package com.qo.android.oemvc 03-30 14:58:21.843: W/PackageManager(1386): Unknown permission android.permission.READ_OWNER_DATA in package com.qo.android.oemvc 03-30 14:58:21.843: W/PackageManager(1386): Unknown permission com.android.email.permission.ACCESS_PROVIDER in package com.qo.android.oemvc 03-30 14:58:21.843: W/PackageManager(1386): Unknown permission com.android.launcher.permission.INSTALL_SHORTCUT in package com.estrongs.android.pop 03-30 14:58:21.843: W/PackageManager(1386): Unknown permission com.android.launcher.permission.UNINSTALL_SHORTCUT in package com.estrongs.android.pop 03-30 14:58:21.843: W/PackageManager(1386): Unknown permission com.estrongs.android.pop.PERMISSION in package com.estrongs.android.pop 03-30 14:58:21.843: W/PackageManager(1386): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.alphonso.pulse (protectionLevel=2 flags=0x8be45) 03-30 14:58:22.250: I/LAB126(1448): StatusBarService hears intent. action: com.amazon.dcp.sso.action.AmazonAccountPropertyService.property.changed 03-30 14:58:22.320: I/LAB126(1448): StatusBarService hears intent. action: com.amazon.dcp.sso.action.AmazonAccountPropertyService.property.changed 03-30 14:58:22.328: D/IconMerger(1448): sum of notifications: 0 03-30 14:58:22.328: I/ActivityManager(1386): Start proc com.amazon.dcp:OTAService for broadcast com.amazon.dcp/.ota.OTAService$OTABootTimeReceiver: pid=1661 uid=32000 gids={2001, 3003, 1015, 1007, 1026} 03-30 14:58:22.468: W/ActivityManager(1386): Unable to start service Intent { act=appStartup }: not found 03-30 14:58:22.476: I/ActivityManager(1386): Start proc com.amazon.email for broadcast com.amazon.email/.service.BootReceiver: pid=1676 uid=10019 gids={3003, 1015} 03-30 14:58:22.578: D/MediaScannerService(1637): start scanning volume internal 03-30 14:58:22.609: I/ActivityManager(1386): Start proc com.amazon.gardemanger for content provider com.amazon.gardemanger/.provider.GardeProvider: pid=1728 uid=32004 gids={} 03-30 14:58:22.640: I/ActivityThread(1676): Pub com.amazon.email.messageprovider: com.amazon.email.provider.MessageProvider 03-30 14:58:22.648: D/ContentProvider(1676): Videos folder exist 03-30 14:58:22.648: D/ContentProvider(1676): Pictures folder exists 03-30 14:58:22.664: I/ActivityThread(1676): Pub com.amazon.email.attachmentprovider: com.amazon.email.provider.AttachmentProvider 03-30 14:58:22.664: D/ContentProvider(1676): Videos folder exist 03-30 14:58:22.664: D/ContentProvider(1676): Pictures folder exists 03-30 14:58:22.671: I/com.amazon.dcp.metrics.CrashDetectionHelper(1676): Setting up crash detector. 03-30 14:58:22.671: I/AmazonEmail(1676): Loading preferences from DB into Storage 03-30 14:58:22.726: I/AmazonEmail(1676): Preferences load took 56ms 03-30 14:58:22.742: I/ActivityManager(1386): Start proc com.amazon.venezia for content provider com.amazon.venezia/com.amazon.mas.client.contentprovider.ContentProviderApps: pid=1742 uid=32015 gids={3003, 1015} 03-30 14:58:22.796: I/AmazonEmail(1676): Registered: unmount receiver 03-30 14:58:22.796: I/AmazonEmail(1676): Registered: shutdown receiver 03-30 14:58:22.812: V/AmazonEmail(1676): Registering content resolver notifier 03-30 14:58:22.820: I/MailService(1676): connected: AutoSync help is available, autoSync = true 03-30 14:58:22.828: I/MailService(1676): connected: final hasConnectivity is false 03-30 14:58:22.828: I/MailService(1676): reset next check to -1. 03-30 14:58:22.828: I/MailService(1676): MailService.onStart(Intent { act=com.amazon.email.intent.action.MAIL_SERVICE_RESET cmp=com.amazon.email/.service.MailService (has extras) }, 1), hasConnectivity = false, doBackground = true 03-30 14:58:22.828: I/ActivityManager(1386): Start proc com.android.providers.calendar for broadcast com.android.providers.calendar/.CalendarReceiver: pid=1751 uid=10022 gids={3003} 03-30 14:58:22.843: I/MailService(1676): connected: AutoSync help is available, autoSync = true 03-30 14:58:22.843: I/MailService(1676): connected: final hasConnectivity is false 03-30 14:58:22.843: I/MailService(1676): reset next check to -1. 03-30 14:58:22.843: I/MailService(1676): MailService.onStart(Intent { act=com.amazon.email.intent.action.MAIL_SERVICE_CONNECTIVITY_CHANGE cmp=com.amazon.email/.service.MailService }, 2), hasConnectivity = false, doBackground = true 03-30 14:58:22.890: I/ActivityThread(1751): Pub com.android.calendar: com.android.providers.calendar.CalendarProvider2 03-30 14:58:22.906: D/ContentProvider(1751): Videos folder exist 03-30 14:58:22.906: D/ContentProvider(1751): Pictures folder exists 03-30 14:58:22.921: D/MediaScanner(1637): prescan time: 277ms 03-30 14:58:22.921: D/MediaScanner(1637): scan time: 21ms 03-30 14:58:22.921: D/MediaScanner(1637): postscan time: 0ms 03-30 14:58:22.921: D/MediaScanner(1637): total time: 298ms 03-30 14:58:22.921: D/MediaScannerService(1637): done scanning volume internal 03-30 14:58:23.023: D/Calendar(1751): missed alarms found: 0 03-30 14:58:23.023: I/ActivityManager(1386): Start proc com.audible.application for broadcast com.audible.application/.BootReceiver: pid=1764 uid=10023 gids={} 03-30 14:58:23.054: D/AudibleStubService(1764): Binding to service 03-30 14:58:23.062: I/ActivityManager(1386): Start proc com.audible.application.kindle for service com.audible.application.kindle/com.audible.application.stubservice.StubReceiverService: pid=1772 uid=32018 gids={3003, 1015, 3002} 03-30 14:58:24.351: D/WifiStateTracker(1386): DHCP succeeded with lease: 86400 03-30 14:58:24.359: V/WifiStateTracker(1386): IP configuration: ipaddr 0ddb79c0bf214cafc6b350e1b9631079 gateway baf0980d833047899d34e10305521d0f netmask 48ac8929ffdc78a66090d179ff1237d5 dns1 e6e9274b7e2cbf00caf7cfd7db86f807 dns2 cfcd208495d565ef66e7dff9f98764da DHCP server 4f2b2c06edc7e399fd159618da8a75c7 lease 86400 seconds 03-30 14:58:24.367: I/TimeService(1386): updating system time 03-30 14:58:24.367: D/Tethering(1386): MasterInitialState.processMessage what=3 03-30 14:58:24.367: I/StatusBarPolicy(1448): updateConnectivity: inetCondition = 0 03-30 14:58:24.367: D/WifiWatchdogService(1386): (android.server.ServerThread) 00:00:00:00:cd:d4 does not require the watchdog 03-30 14:58:24.375: I/CaptiveWifiService(1386): Connectivity action new network 03-30 14:58:24.429: D/AudibleStubService(1764): onServiceConnected, copying files 03-30 14:58:24.429: D/AudibleStubService(1764): copyAllFiles 03-30 14:58:24.445: I/ActivityManager(1386): Start proc com.amazon.mp3 for content provider com.amazon.mp3/.library.provider.ExternalProvider: pid=1809 uid=32001 gids={3003, 1007, 1015} 03-30 14:58:24.453: D/AudibleStubService(1764): copyAllFiles finished 03-30 14:58:24.562: I/TimeService(1386): NTP query, time result=1333144705117 03-30 14:58:24.562: D/SystemClock(1386): Setting time of day to sec=1333144705 03-30 14:58:25.382: I/ActivityManager(1386): Start proc com.amazon.dcp:TPHService for broadcast com.amazon.dcp/.tph.TPHService$WifiStatusChangeReceiver: pid=1826 uid=32000 gids={2001, 3003, 1015, 1007, 1026} 03-30 14:58:25.499: I/CaptiveWifiService(1386): Connected to Internet 03-30 14:58:25.554: I/MailService(1676): connected: network state is CONNECTED, is available is true 03-30 14:58:25.554: I/MailService(1676): connected: AutoSync help is available, autoSync = true 03-30 14:58:25.562: I/MailService(1676): connected: wifi -75 03-30 14:58:25.562: I/MailService(1676): connected: final hasConnectivity is true 03-30 14:58:25.562: I/MailService(1676): MailService.onStart(Intent { act=com.amazon.email.intent.action.MAIL_SERVICE_CONNECTIVITY_CHANGE cmp=com.amazon.email/.service.MailService (has extras) }, 3), hasConnectivity = true, doBackground = true 03-30 14:58:25.695: E/AmazonEmail(1676): isKeyInvalid: key is valid. 03-30 14:58:25.718: I/ActivityManager(1386): Start proc com.amazon.dcp:UpdatesLookupService for broadcast com.amazon.dcp/.ota.UpdatesLookupService$MountStatusChangedReceiver: pid=1845 uid=32000 gids={2001, 3003, 1015, 1007, 1026} 03-30 14:58:25.765: D/dalvikvm(1288): GC_EXPLICIT freed 11K, 50% free 2709K/5379K, external 847K/1181K, paused 50ms 03-30 14:58:25.796: D/dalvikvm(1288): GC_EXPLICIT freed <1K, 50% free 2709K/5379K, external 847K/1181K, paused 33ms 03-30 14:58:25.913: D/dalvikvm(1288): GC_EXPLICIT freed <1K, 50% free 2709K/5379K, external 847K/1181K, paused 115ms 03-30 14:58:25.937: D/dalvikvm(1386): GC_CONCURRENT freed 1008K, 42% free 5024K/8519K, external 2732K/3412K, paused 3ms+5ms 03-30 14:58:25.945: I/ActivityManager(1386): Start proc com.cooliris.media for broadcast com.cooliris.media/com.cooliris.cache.BootReceiver: pid=1860 uid=10018 gids={1015, 3003} 03-30 14:58:25.999: I/ConnectivityService(1386): Sending INET_CONDITION_ACTION broadcast 03-30 14:58:25.999: W/ProcessStats(1386): Skipping unknown process pid 1851 03-30 14:58:26.070: I/StatusBarPolicy(1448): updateConnectivity: inetCondition = 1 03-30 14:58:26.132: I/ActivityThread(1860): Pub com.cooliris.picasa.contentprovider: com.cooliris.picasa.PicasaContentProvider 03-30 14:58:26.140: D/ContentProvider(1860): Videos folder exist 03-30 14:58:26.140: D/ContentProvider(1860): Pictures folder exists 03-30 14:58:26.171: D/MediaScannerService(1637): start scanning volume external 03-30 14:58:26.304: I/com.amazon.dcp.metrics.CrashDetectionHelper(1860): Setting up crash detector. 03-30 14:58:26.304: I/BootReceiver(1860): Got intent with action android.intent.action.MEDIA_MOUNTED 03-30 14:58:26.304: V/MediaProvider(1637): /mnt/sdcard volume ID: 252718362 03-30 14:58:26.367: I/AmazonEmail(1676): storage path "/mnt/sdcard" mounted readOnly=false 03-30 14:58:26.382: E/AmazonEmail(1676): isKeyInvalid: key is valid. 03-30 14:58:26.398: I/MailService(1676): connected: network state is CONNECTED, is available is true 03-30 14:58:26.398: I/MailService(1676): connected: AutoSync help is available, autoSync = true 03-30 14:58:26.413: I/MailService(1676): connected: wifi -70 03-30 14:58:26.413: I/MailService(1676): connected: final hasConnectivity is true 03-30 14:58:26.413: I/MailService(1676): MailService.onStart(Intent { act=com.amazon.email.intent.action.MAIL_SERVICE_RESET cmp=com.amazon.email/.service.MailService (has extras) }, 1), hasConnectivity = true, doBackground = true 03-30 14:58:26.492: I/BootReceiver(1860): Got intent with action android.intent.action.MEDIA_SCANNER_FINISHED 03-30 14:58:26.695: D/dalvikvm(1676): GC_CONCURRENT freed 428K, 49% free 3039K/5895K, external 847K/1181K, paused 1ms+2ms 03-30 14:58:26.702: I/MailService(1676): connected: network state is CONNECTED, is available is true 03-30 14:58:26.702: I/MailService(1676): connected: AutoSync help is available, autoSync = true 03-30 14:58:26.710: I/MailService(1676): connected: wifi -69 03-30 14:58:26.710: I/MailService(1676): connected: final hasConnectivity is true 03-30 14:58:26.710: I/MailService(1676): MailService.onStart(Intent { act=com.amazon.email.intent.action.MAIL_SERVICE_CONNECTIVITY_CHANGE cmp=com.amazon.email/.service.MailService (has extras) }, 1), hasConnectivity = true, doBackground = true 03-30 14:58:26.710: E/Database(1676): close() was never explicitly called on database 03-30 14:58:26.710: E/Database(1676): android.database.sqlite.DatabaseObjectNotClosedException: Application did not close the cursor or database object that was opened here 03-30 14:58:26.710: E/Database(1676): at android.database.sqlite.SQLiteDatabase.(SQLiteDatabase.java:1872) 03-30 14:58:26.710: E/Database(1676): at android.database.sqlite.SQLiteDatabase.openDatabase(SQLiteDatabase.java:824) 03-30 14:58:26.710: E/Database(1676): at android.database.sqlite.SQLiteDatabase.openOrCreateDatabase(SQLiteDatabase.java:861) 03-30 14:58:26.710: E/Database(1676): at android.database.sqlite.SQLiteDatabase.openOrCreateDatabase(SQLiteDatabase.java:854) 03-30 14:58:26.710: E/Database(1676): at com.amazon.email.mail.store.LockableDatabase.openOrCreateDataspace(LockableDatabase.java:412) 03-30 14:58:26.710: E/Database(1676): at com.amazon.email.mail.store.LockableDatabase.open(LockableDatabase.java:394) 03-30 14:58:26.710: E/Database(1676): at com.amazon.email.mail.store.LocalStore.(LocalStore.java:188) 03-30 14:58:26.710: E/Database(1676): at com.amazon.email.mail.Store.getLocalInstance(Store.java:85) 03-30 14:58:26.710: E/Database(1676): at com.amazon.email.Account.getLocalStore(Account.java:1154) 03-30 14:58:26.710: E/Database(1676): at com.amazon.email.controller.MessagingController.setupPushing(MessagingController.java:5033) 03-30 14:58:26.710: E/Database(1676): at com.amazon.email.service.MailService$4.run(MailService.java:400) 03-30 14:58:26.710: E/Database(1676): at com.amazon.email.service.CoreService$1.run(CoreService.java:105) 03-30 14:58:26.710: E/Database(1676): at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1088) 03-30 14:58:26.710: E/Database(1676): at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:581) 03-30 14:58:26.710: E/Database(1676): at java.lang.Thread.run(Thread.java:1019) 03-30 14:58:26.781: I/ActivityManager(1386): Start proc com.alphonso.pulse for broadcast com.alphonso.pulse/.background.OnTimeChangedReceiver: pid=1891 uid=10007 gids={3003, 1015} 03-30 14:58:26.976: V/AlarmManager(1386): alarms: 1 type: RTC_WAKEUP 03-30 14:58:26.984: V/AlarmManager(1386): 0: Mar 30 04:55:52 pm com.amazon.venezia 03-30 14:58:27.023: I/ActivityThread(1891): Pub com.alphonso.pulse.otter.pulseprovider: com.alphonso.pulse.amazon.PulseProvider 03-30 14:58:27.031: D/ContentProvider(1891): Videos folder exist 03-30 14:58:27.031: D/ContentProvider(1891): Pictures folder exists 03-30 14:58:27.038: V/MediaProvider(1637): Attached volume: external 03-30 14:58:27.077: I/AudioService(1386): Remote Control registerMediaButtonEventReceiver() for ComponentInfo{com.amazon.mp3/com.amazon.mp3.playback.service.HeadsetControlsReceiver} 03-30 14:58:27.093: I/AudioService(1386): AudioFocus abandonAudioFocus() 03-30 14:58:27.093: I/AudioService(1386): Remote Control unregisterMediaButtonEventReceiver() for ComponentInfo{com.amazon.mp3/com.amazon.mp3.playback.service.HeadsetControlsReceiver} 03-30 14:58:27.109: I/com.amazon.dcp.metrics.CrashDetectionHelper(1891): Setting up crash detector. 03-30 14:58:27.187: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 14:58:27.218: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 14:58:27.288: D/MediaScanner(1637): prescan time: 44ms 03-30 14:58:27.288: D/MediaScanner(1637): scan time: 202ms 03-30 14:58:27.288: D/MediaScanner(1637): postscan time: 0ms 03-30 14:58:27.288: D/MediaScanner(1637): total time: 246ms 03-30 14:58:27.296: I/BootReceiver(1860): Got intent with action android.intent.action.MEDIA_SCANNER_FINISHED 03-30 14:58:27.296: D/MediaScannerService(1637): done scanning volume external 03-30 14:58:28.210: I/InputReader(1386): Device reconfigured: id=0x0, name=ilitek_i2c, display size is now 600x1024 03-30 14:58:28.210: I/InputManager-Callbacks(1386): No virtual keys found for device ilitek_i2c. 03-30 14:58:28.476: I/StorageNotification(1448): LockScreen: OnReceive 03-30 14:58:28.671: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 14:58:28.671: I/LAB126(1448): window changed 03-30 14:58:28.898: V/AlarmManager(1386): alarms: 2 type: RTC_WAKEUP 03-30 14:58:28.898: V/AlarmManager(1386): 0: Mar 30 04:55:52 pm com.amazon.venezia 03-30 14:58:28.898: V/AlarmManager(1386): 1: Mar 31 12:59:28 pm com.android.providers.calendar 03-30 14:58:29.554: I/ActivityManager(1386): No longer want com.android.settings (pid 1532): hidden #16 03-30 14:58:33.999: I/WindowManager(1386): Setting rotation to 3, animFlags=0 03-30 14:58:34.023: I/ActivityManager(1386): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=2 layout=268435491 uiMode=17 seq=3} 03-30 14:58:34.038: D/szipinf(1386): Initializing inflate state 03-30 14:58:34.124: D/IconMerger(1448): sum of notifications: 0 03-30 14:58:34.929: I/WindowManager(1386): Setting rotation to 0, animFlags=0 03-30 14:58:34.952: I/ActivityManager(1386): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=1 layout=268435491 uiMode=17 seq=4} 03-30 14:58:35.023: D/IconMerger(1448): sum of notifications: 0 03-30 14:58:36.960: D/ActivityManager(1386): Starting: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 pkg=com.appcelerator.kitchensinknook cmp=com.appcelerator.kitchensinknook/.KitchensinkNookActivity } from pid 1462 03-30 14:58:37.046: D/dalvikvm(1386): GC_EXTERNAL_ALLOC freed 876K, 41% free 5055K/8519K, external 2732K/3412K, paused 82ms 03-30 14:58:37.070: I/ActivityManager(1386): Start proc com.appcelerator.kitchensinknook for activity com.appcelerator.kitchensinknook/.KitchensinkNookActivity: pid=1914 uid=10027 gids={1015, 3003} 03-30 14:58:37.242: I/TiApplication(1914): (main) [0,0] checkpoint, app created. 03-30 14:58:37.281: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 14:58:37.281: I/LAB126(1448): window changed 03-30 14:58:37.281: I/LAB126(1448): don't set softkey config for 'Starting...' window 03-30 14:58:37.320: D/dalvikvm(1914): GC_CONCURRENT freed 370K, 48% free 3116K/5959K, external 847K/1181K, paused 2ms+2ms 03-30 14:58:37.390: D/dalvikvm(1914): GC_CONCURRENT freed 343K, 46% free 3309K/6087K, external 847K/1181K, paused 1ms+3ms 03-30 14:58:37.492: D/dalvikvm(1914): GC_CONCURRENT freed 189K, 43% free 3642K/6279K, external 847K/1181K, paused 1ms+2ms 03-30 14:58:37.507: I/TiApplication(1914): (main) [266,266] Titanium 2.0.0 (2012/03/29 19:23 1fbf18c) 03-30 14:58:37.554: D/dalvikvm(1386): GC_EXPLICIT freed 135K, 42% free 4946K/8519K, external 3398K/4898K, paused 45ms 03-30 14:58:37.609: D/dalvikvm(1914): Trying to load lib /data/data/com.appcelerator.kitchensinknook/lib/libstlport_shared.so 0x40513578 03-30 14:58:37.609: I/TiApplication(1914): (main) [106,372] Titanium Javascript runtime: v8 03-30 14:58:37.609: D/dalvikvm(1914): Added shared lib /data/data/com.appcelerator.kitchensinknook/lib/libstlport_shared.so 0x40513578 03-30 14:58:37.609: D/dalvikvm(1914): No JNI_OnLoad found in /data/data/com.appcelerator.kitchensinknook/lib/libstlport_shared.so 0x40513578, skipping init 03-30 14:58:37.609: D/dalvikvm(1914): Trying to load lib /data/data/com.appcelerator.kitchensinknook/lib/libkroll-v8.so 0x40513578 03-30 14:58:37.617: I/TiRootActivity(1914): (main) [0,0] checkpoint, on root activity create, savedInstanceState: null 03-30 14:58:37.624: D/dalvikvm(1914): Added shared lib /data/data/com.appcelerator.kitchensinknook/lib/libkroll-v8.so 0x40513578 03-30 14:58:37.968: E/TiApplication(1914): (KrollRuntimeThread) [344,344] APP PROXY: ti.modules.titanium.app.AppModule@40655640 03-30 14:58:37.984: W/V8Object(1914): Runtime disposed, cannot set property 'userAgent' 03-30 14:58:38.327: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/ti.modules.titanium.ui.TiTabActivity (has extras) } from pid 1914 03-30 14:58:38.398: D/dalvikvm(1914): GC_CONCURRENT freed 428K, 44% free 3743K/6663K, external 847K/1181K, paused 2ms+3ms 03-30 14:58:38.437: D/dalvikvm(1914): GC_EXTERNAL_ALLOC freed 28K, 45% free 3715K/6663K, external 847K/1181K, paused 40ms 03-30 14:58:38.640: D/dalvikvm(1914): GC_EXTERNAL_ALLOC freed <1K, 45% free 3714K/6663K, external 2347K/2931K, paused 90ms 03-30 14:58:38.702: I/TiRootActivity(1914): (main) [0,0] checkpoint, on root activity resume. activity = com.appcelerator.kitchensinknook.KitchensinkNookActivity@4063e968 03-30 14:58:38.820: W/TiTabActivity(1914): (main) [114,114] Notifying TiTabGroup, activity is created 03-30 14:58:39.156: D/TiUIView(1914): (main) [339,453] Nativeview is null 03-30 14:58:39.163: D/Window(1914): Loading window with URL: main_windows/base_ui.js 03-30 14:58:39.234: D/Module(1914): Loading module: main_windows/base_ui -> Resources/main_windows/base_ui.js 03-30 14:58:39.968: D/dalvikvm(1914): GC_CONCURRENT freed 443K, 42% free 3977K/6855K, external 1702K/3013K, paused 5ms+8ms 03-30 14:58:40.117: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/ti.modules.titanium.ui.TiTabActivity: +1s386ms (total +3s59ms) 03-30 14:58:40.117: D/TiUIView(1914): (main) [957,1410] Nativeview is null 03-30 14:58:40.124: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 14:58:40.124: I/LAB126(1448): window changed 03-30 14:58:40.601: W/Vold(1285): Ignoring unknown switch 'usb_connected' 03-30 14:58:40.617: D/Tethering(1386): sendTetherStateChangedBroadcast 1, 0, 0 03-30 14:58:40.617: D/Tethering(1386): interfaceAdded :usb0 03-30 14:58:41.062: W/Vold(1285): Ignoring unknown switch 'usb_mass_storage' 03-30 14:58:41.062: D/Vold(1285): USB connected 03-30 14:58:41.062: D/Vold(1285): Share method ums now available 03-30 14:58:41.062: I/StorageNotification(1448): UMS connection changed to true (media state mounted) 03-30 14:58:41.062: I/StorageNotification(1448): In onUsbMassStorageConnectionChangedAsync, POP_UMS_ACTIVITY_ON_CONNECT=true 03-30 14:58:41.070: E/Tethering(1386): active iface (usb0) reported as added, ignoring 03-30 14:58:41.070: D/StatusBarService(1448): Notification has fullScreenIntent; sending fullScreenIntent 03-30 14:58:41.070: D/ActivityManager(1386): Starting: Intent { flg=0x10000000 cmp=com.android.systemui/.usb.UsbStorageActivity } from pid -1 03-30 14:58:41.085: I/ActivityManager(1386): No longer want android.process.acore (pid 1481): hidden #16 03-30 14:58:41.187: D/dalvikvm(1448): GC_EXTERNAL_ALLOC freed 131K, 44% free 3427K/6023K, external 2023K/2217K, paused 33ms 03-30 14:58:41.210: I/PackageManager(1386): Updating external media status from mounted to unmounted 03-30 14:58:41.210: D/VoldCmdListener(1285): volume shared /mnt/sdcard ums 03-30 14:58:41.218: I/PackageManager(1386): No secure containers on sdcard 03-30 14:58:41.218: D/VoldCmdListener(1285): asec list 03-30 14:58:41.218: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 14:58:41.218: I/LAB126(1448): window changed 03-30 14:58:41.218: I/LAB126(1448): don't set softkey config for 'Starting...' window 03-30 14:58:41.218: D/IconMerger(1448): notification for com.android.systemui (1) 03-30 14:58:41.218: D/IconMerger(1448): sum of notifications: 1 03-30 14:58:41.234: D/VoldCmdListener(1285): volume shared /mnt/sdcard ums 03-30 14:58:41.820: D/VoldCmdListener(1285): storage users /mnt/sdcard 03-30 14:58:41.929: I/ActivityManager(1386): Displayed com.android.systemui/.usb.UsbStorageActivity: +838ms 03-30 14:58:41.968: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 14:58:41.968: I/LAB126(1448): window changed 03-30 14:58:41.992: W/InputManagerService(1386): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@4072da68 (uid=10027 pid=1914) 03-30 14:58:42.296: W/ActivityManager(1386): Killing processes unmount media at adjustment 7 03-30 14:58:42.296: W/ActivityManager(1386): Killing ProcessRecord{407b6928 1527:com.amazon.kindle/32010} (adj 10): unmount media 03-30 14:58:42.296: W/ActivityManager(1386): Killing ProcessRecord{4070db58 1676:com.amazon.email/10019} (adj 10): unmount media 03-30 14:58:42.296: W/ActivityManager(1386): Killing ProcessRecord{406997c0 1860:com.cooliris.media/10018} (adj 9): unmount media 03-30 14:58:42.320: D/VoldCmdListener(1285): storage users /mnt/sdcard 03-30 14:58:42.624: D/VoldCmdListener(1285): storage users /mnt/sdcard 03-30 14:58:42.859: D/dalvikvm(1386): GC_EXPLICIT freed 750K, 43% free 5006K/8647K, external 3398K/4898K, paused 45ms 03-30 14:58:42.859: I/PackageManager(1386): Updating external media status from unmounted to unmounted 03-30 14:58:42.859: D/VoldCmdListener(1285): volume unmount /mnt/sdcard force 03-30 14:58:42.859: D/Vold(1285): Volume sdcard state changing 4 (Mounted) -> 5 (Unmounting) 03-30 14:58:42.867: V/MediaProvider(1637): Detached volume: external 03-30 14:58:42.867: I/ActivityManager(1386): Start proc com.cooliris.media for broadcast com.cooliris.media/com.cooliris.cache.BootReceiver: pid=1941 uid=10018 gids={1015, 3003} 03-30 14:58:42.906: I/ActivityThread(1941): Pub com.cooliris.picasa.contentprovider: com.cooliris.picasa.PicasaContentProvider 03-30 14:58:42.906: D/ContentProvider(1941): Videos folder exist 03-30 14:58:42.906: D/ContentProvider(1941): Pictures folder exists 03-30 14:58:42.945: I/com.amazon.dcp.metrics.CrashDetectionHelper(1941): Setting up crash detector. 03-30 14:58:42.945: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_EJECT 03-30 14:58:43.851: I/Vold(1285): /mnt/secure/staging/.android_secure sucessfully unmounted 03-30 14:58:43.851: I/Vold(1285): /mnt/secure/asec sucessfully unmounted 03-30 14:58:43.945: I/PackageManager(1386): Updating external media status from unmounted to unmounted 03-30 14:58:43.945: I/Vold(1285): /mnt/secure/staging sucessfully unmounted 03-30 14:58:43.945: I/Vold(1285): /mnt/sdcard unmounted sucessfully 03-30 14:58:43.945: D/Vold(1285): Volume sdcard state changing 5 (Unmounting) -> 1 (Idle-Unmounted) 03-30 14:58:43.945: I/StorageNotification(1448): Media state changed from {mounted} -> {unmounted} 03-30 14:58:43.952: D/VoldCmdListener(1285): volume share /mnt/sdcard ums 03-30 14:58:43.952: D/Vold(1285): Volume sdcard state changing 1 (Idle-Unmounted) -> 7 (Shared-Unmounted) 03-30 14:58:43.952: W/MountService(1386): Duplicate state transition (unmounted -> unmounted) 03-30 14:58:43.968: I/TiApplication(1914): (main) [3853,5263] SD card has been unmounted. Disabling cache for http responses. 03-30 14:58:43.976: D/Tethering(1386): InitialState.processMessage what=4 03-30 14:58:43.976: D/Tethering(1386): sendTetherStateChangedBroadcast 0, 0, 0 03-30 14:58:43.992: I/TiApplication(1914): (main) [24,5287] SD card has been unmounted. Disabling cache for http responses. 03-30 14:58:44.023: D/VoldCmdListener(1285): volume share /mnt/sdcard ums 03-30 14:58:44.038: E/MountService(1386): Failed to share/unshare 03-30 14:58:44.038: E/MountService(1386): com.android.server.NativeDaemonConnectorException: Cmd {volume share /mnt/sdcard ums} failed with code 405 : {volume operation failed (Device or resource busy)} 03-30 14:58:44.038: E/MountService(1386): at com.android.server.NativeDaemonConnector.doCommand(NativeDaemonConnector.java:259) 03-30 14:58:44.038: E/MountService(1386): at com.android.server.MountService.doShareUnshareVolume(MountService.java:508) 03-30 14:58:44.038: E/MountService(1386): at com.android.server.MountService.access$200(MountService.java:76) 03-30 14:58:44.038: E/MountService(1386): at com.android.server.MountService$UmsEnableCallBack.handleFinished(MountService.java:309) 03-30 14:58:44.038: E/MountService(1386): at com.android.server.MountService$MountServiceHandler.handleMessage(MountService.java:412) 03-30 14:58:44.038: E/MountService(1386): at android.os.Handler.dispatchMessage(Handler.java:99) 03-30 14:58:44.038: E/MountService(1386): at android.os.Looper.loop(Looper.java:130) 03-30 14:58:44.038: E/MountService(1386): at android.os.HandlerThread.run(HandlerThread.java:60) 03-30 14:58:44.085: D/dalvikvm(1386): GC_FOR_MALLOC freed 319K, 42% free 5137K/8775K, external 2732K/3412K, paused 46ms 03-30 14:58:44.085: I/dalvikvm-heap(1386): Grow heap (frag case) to 10.232MB for 176734-byte allocation 03-30 14:58:44.124: D/dalvikvm(1386): GC_FOR_MALLOC freed 120K, 43% free 5189K/8967K, external 2732K/3412K, paused 38ms 03-30 14:58:44.171: D/dalvikvm(1386): GC_FOR_MALLOC freed 197K, 41% free 5309K/8967K, external 2732K/3412K, paused 35ms 03-30 14:58:44.171: I/dalvikvm-heap(1386): Grow heap (frag case) to 10.400MB for 175574-byte allocation 03-30 14:58:44.218: D/dalvikvm(1386): GC_FOR_MALLOC freed <1K, 41% free 5481K/9159K, external 2732K/3412K, paused 35ms 03-30 14:58:44.218: D/VoldCmdListener(1285): volume shared /mnt/sdcard ums 03-30 14:58:44.265: D/dalvikvm(1386): GC_FOR_MALLOC freed 115K, 42% free 5366K/9159K, external 2732K/3412K, paused 34ms 03-30 14:58:44.320: D/dalvikvm(1386): GC_FOR_MALLOC freed <1K, 39% free 5625K/9159K, external 2732K/3412K, paused 35ms 03-30 14:58:44.320: I/StorageNotification(1448): Media state changed from {unmounted} -> {shared} 03-30 14:58:44.320: D/IconMerger(1448): sum of notifications: 0 03-30 14:58:44.421: D/dalvikvm(1386): GC_FOR_MALLOC freed 377K, 42% free 5552K/9479K, external 2732K/3412K, paused 41ms 03-30 14:58:44.421: I/dalvikvm-heap(1386): Grow heap (frag case) to 10.846MB for 395030-byte allocation 03-30 14:58:44.468: D/dalvikvm(1386): GC_FOR_MALLOC freed 0K, 41% free 5938K/9927K, external 2732K/3412K, paused 37ms 03-30 14:58:44.515: D/dalvikvm(1386): GC_FOR_MALLOC freed 279K, 43% free 5684K/9927K, external 2732K/3412K, paused 36ms 03-30 14:58:44.562: D/dalvikvm(1386): GC_FOR_MALLOC freed 1K, 39% free 6071K/9927K, external 2732K/3412K, paused 34ms 03-30 14:58:44.562: I/dalvikvm-heap(1386): Grow heap (frag case) to 11.270MB for 308450-byte allocation 03-30 14:58:44.609: D/dalvikvm(1386): GC_FOR_MALLOC freed 258K, 41% free 6113K/10247K, external 2732K/3412K, paused 34ms 03-30 14:58:44.648: D/dalvikvm(1386): GC_FOR_MALLOC freed <1K, 39% free 6264K/10247K, external 2732K/3412K, paused 36ms 03-30 14:58:44.648: I/dalvikvm-heap(1386): Grow heap (frag case) to 11.457MB for 306098-byte allocation 03-30 14:58:44.687: D/dalvikvm(1386): GC_FOR_MALLOC freed 0K, 38% free 6563K/10567K, external 2732K/3412K, paused 34ms 03-30 14:58:47.374: D/IconMerger(1448): notification for com.android.systemui (1) 03-30 14:58:47.374: D/IconMerger(1448): sum of notifications: 1 03-30 14:58:51.109: D/VoldCmdListener(1285): volume unshare /mnt/sdcard ums 03-30 14:58:51.210: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 14:58:51.210: I/LAB126(1448): window changed 03-30 14:58:52.999: D/TiUIView(1914): (main) [9006,14293] Nativeview is null 03-30 14:58:53.054: D/Window(1914): Loading window with URL: main_windows/platform.js 03-30 14:58:53.054: D/Module(1914): Loading module: main_windows/platform -> Resources/main_windows/platform.js 03-30 14:58:53.320: D/TiUIView(1914): (main) [327,14620] Nativeview is null 03-30 14:58:53.531: I/PackageManager(1386): Updating external media status from unmounted to unmounted 03-30 14:58:53.531: D/Vold(1285): Volume sdcard state changing 7 (Shared-Unmounted) -> 1 (Idle-Unmounted) 03-30 14:58:53.538: I/TiApplication(1914): (main) [211,14831] SD card has been unmounted. Disabling cache for http responses. 03-30 14:58:53.538: I/StorageNotification(1448): Media state changed from {shared} -> {unmounted} 03-30 14:58:53.546: D/Tethering(1386): sendTetherStateChangedBroadcast 1, 0, 0 03-30 14:58:53.546: D/Tethering(1386): interfaceAdded :usb0 03-30 14:58:53.570: D/VoldCmdListener(1285): volume mount /mnt/sdcard 03-30 14:58:53.570: I/Vold(1285): /dev/block/vold/179:12 being considered for volume sdcard 03-30 14:58:53.570: D/Vold(1285): Volume sdcard state changing 1 (Idle-Unmounted) -> 3 (Checking) 03-30 14:58:53.585: I//system/bin/fsck_msdos(1285): ** /dev/block/vold/179:12 03-30 14:58:54.577: I//system/bin/fsck_msdos(1285): ** Phase 1 - Read FAT (compare skipped) 03-30 14:58:54.577: I//system/bin/fsck_msdos(1285): Attempting to allocate 10242 KB for FAT 03-30 14:58:55.156: I//system/bin/fsck_msdos(1285): ** Phase 2 - Check Cluster Chains 03-30 14:58:55.343: I//system/bin/fsck_msdos(1285): ** Phase 3 - Checking Directories 03-30 14:58:55.617: I//system/bin/fsck_msdos(1285): ** Phase 4 - Checking for Lost Files 03-30 14:58:55.718: I//system/bin/fsck_msdos(1285): Next free cluster in FSInfo block (985) not free 03-30 14:58:55.718: I//system/bin/fsck_msdos(1285): FIXED 03-30 14:58:55.718: I//system/bin/fsck_msdos(1285): 1060 files, 1019284 free (2606794 clusters) 03-30 14:58:55.718: I//system/bin/fsck_msdos(1285): FIXED 03-30 14:58:55.718: I//system/bin/fsck_msdos(1285): MARKING FILE SYSTEM CLEAN 03-30 14:58:58.890: I/Vold(1285): Filesystem check completed OK 03-30 14:58:58.898: I/Vold(1285): Device /dev/block/vold/179:12, target /mnt/sdcard mounted @ /mnt/secure/staging 03-30 14:58:58.906: I/PackageManager(1386): Updating external media status from unmounted to mounted 03-30 14:58:58.906: D/Vold(1285): Volume sdcard state changing 3 (Checking) -> 4 (Mounted) 03-30 14:58:58.921: D/VoldCmdListener(1285): volume shared /mnt/sdcard ums 03-30 14:58:58.937: I/StorageNotification(1448): Media state changed from {unmounted} -> {checking} 03-30 14:58:58.945: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_MOUNTED 03-30 14:58:58.952: I/TiApplication(1914): (main) [5409,20240] SD card has been mounted. Enabling cache for http responses. 03-30 14:58:58.960: I/StorageNotification(1448): Media state changed from {checking} -> {mounted} 03-30 14:58:58.976: D/VoldCmdListener(1285): asec list 03-30 14:58:59.062: I/ActivityManager(1386): Start proc com.amazon.email for broadcast com.amazon.email/.service.StorageReceiver: pid=1971 uid=10019 gids={3003, 1015} 03-30 14:58:59.226: I/ActivityThread(1971): Pub com.amazon.email.messageprovider: com.amazon.email.provider.MessageProvider 03-30 14:58:59.226: D/ContentProvider(1971): Videos folder exist 03-30 14:58:59.226: D/ContentProvider(1971): Pictures folder exists 03-30 14:58:59.234: I/ActivityThread(1971): Pub com.amazon.email.attachmentprovider: com.amazon.email.provider.AttachmentProvider 03-30 14:58:59.234: D/ContentProvider(1971): Videos folder exist 03-30 14:58:59.234: D/ContentProvider(1971): Pictures folder exists 03-30 14:58:59.242: I/com.amazon.dcp.metrics.CrashDetectionHelper(1971): Setting up crash detector. 03-30 14:58:59.242: I/AmazonEmail(1971): Loading preferences from DB into Storage 03-30 14:58:59.249: D/VoldCmdListener(1285): volume unshare /mnt/sdcard ums 03-30 14:58:59.249: W/Vold(1285): Returning OperationFailed - no handler for errno 22 03-30 14:58:59.257: I/PackageManager(1386): No secure containers on sdcard 03-30 14:58:59.257: I/AmazonEmail(1971): Preferences load took 19ms 03-30 14:58:59.257: E/MountService(1386): Failed to share/unshare 03-30 14:58:59.257: E/MountService(1386): com.android.server.NativeDaemonConnectorException: Cmd {volume unshare /mnt/sdcard ums} failed with code 400 : {volume operation failed (Invalid argument)} 03-30 14:58:59.257: E/MountService(1386): at com.android.server.NativeDaemonConnector.doCommand(NativeDaemonConnector.java:259) 03-30 14:58:59.257: E/MountService(1386): at com.android.server.MountService.doShareUnshareVolume(MountService.java:508) 03-30 14:58:59.257: E/MountService(1386): at com.android.server.MountService.setUsbMassStorageEnabled(MountService.java:1231) 03-30 14:58:59.257: E/MountService(1386): at android.os.storage.IMountService$Stub.onTransact(IMountService.java:683) 03-30 14:58:59.257: E/MountService(1386): at android.os.Binder.execTransact(Binder.java:320) 03-30 14:58:59.257: E/MountService(1386): at dalvik.system.NativeStart.run(Native Method) 03-30 14:58:59.257: D/VoldCmdListener(1285): volume mount /mnt/sdcard 03-30 14:58:59.257: E/MountService(1386): Failed to remount /mnt/sdcard after disabling share method ums 03-30 14:58:59.257: W/PackageManager(1386): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.imdb.mobile (protectionLevel=2 flags=0x8be45) 03-30 14:58:59.257: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.mail in package com.android.contacts 03-30 14:58:59.265: W/PackageManager(1386): Unknown permission android.permission.DEVICE_ADMIN in package com.lab126.otter 03-30 14:58:59.265: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.providers.calendar 03-30 14:58:59.265: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.cl in package com.android.providers.calendar 03-30 14:58:59.265: W/PackageManager(1386): Unknown permission org.thialfihar.android.apg.permission.READ_KEY_DETAILS in package com.amazon.email 03-30 14:58:59.265: W/PackageManager(1386): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.cooliris.media (protectionLevel=2 flags=0x8bc45) 03-30 14:58:59.296: D/MediaScannerService(1637): start scanning volume external 03-30 14:58:59.296: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.providers.contacts 03-30 14:58:59.304: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.cp in package com.android.providers.contacts 03-30 14:58:59.304: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.WRITE_GMAIL in package com.android.settings 03-30 14:58:59.304: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.READ_GMAIL in package com.android.settings 03-30 14:58:59.304: W/PackageManager(1386): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.settings 03-30 14:58:59.304: W/PackageManager(1386): Unknown permission com.android.launcher.permission.READ_SETTINGS in package com.android.settings 03-30 14:58:59.304: W/PackageManager(1386): Unknown permission com.android.launcher.permission.WRITE_SETTINGS in package com.android.settings 03-30 14:58:59.312: W/PackageManager(1386): Unknown permission com.android.launcher.permission.INSTALL_SHORTCUT in package com.amazon.cloud9 03-30 14:58:59.320: I/dalvikvm(1386): Jit: resizing JitTable from 4096 to 8192 03-30 14:58:59.374: D/dalvikvm(1386): GC_FOR_MALLOC freed 2352K, 52% free 5137K/10567K, external 2732K/3412K, paused 45ms 03-30 14:58:59.390: W/PackageManager(1386): Unknown permission android.webkit.permission.PLUGIN in package com.adobe.flashplayer 03-30 14:58:59.398: W/PackageManager(1386): Unknown permission com.google.android.providers.gmail.permission.WRITE_GMAIL in package com.qo.android.oemvc 03-30 14:58:59.398: W/PackageManager(1386): Unknown permission com.google.android.providers.gmail.permission.READ_GMAIL in package com.qo.android.oemvc 03-30 14:58:59.398: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.READ_GMAIL in package com.qo.android.oemvc 03-30 14:58:59.398: W/PackageManager(1386): Unknown permission com.google.android.gm.permission.WRITE_GMAIL in package com.qo.android.oemvc 03-30 14:58:59.398: W/PackageManager(1386): Unknown permission android.permission.READ_OWNER_DATA in package com.qo.android.oemvc 03-30 14:58:59.398: W/PackageManager(1386): Unknown permission com.android.email.permission.ACCESS_PROVIDER in package com.qo.android.oemvc 03-30 14:58:59.398: W/PackageManager(1386): Unknown permission com.android.launcher.permission.INSTALL_SHORTCUT in package com.estrongs.android.pop 03-30 14:58:59.398: W/PackageManager(1386): Unknown permission com.android.launcher.permission.UNINSTALL_SHORTCUT in package com.estrongs.android.pop 03-30 14:58:59.398: W/PackageManager(1386): Unknown permission com.estrongs.android.pop.PERMISSION in package com.estrongs.android.pop 03-30 14:58:59.406: W/PackageManager(1386): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.alphonso.pulse (protectionLevel=2 flags=0x8be45) 03-30 14:58:59.476: D/dalvikvm(1386): GC_CONCURRENT freed 669K, 46% free 5764K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 14:59:00.460: V/MediaProvider(1637): /mnt/sdcard volume ID: 252718362 03-30 14:59:00.476: I/AmazonEmail(1971): Registered: unmount receiver 03-30 14:59:00.476: I/AmazonEmail(1971): Registered: shutdown receiver 03-30 14:59:00.499: V/AmazonEmail(1971): Registering content resolver notifier 03-30 14:59:00.499: I/AmazonEmail(1971): storage path "/mnt/sdcard" mounted readOnly=false 03-30 14:59:00.507: V/MediaProvider(1637): Attached volume: external 03-30 14:59:00.515: I/MailService(1971): connected: network state is CONNECTED, is available is true 03-30 14:59:00.523: I/MailService(1971): connected: AutoSync help is available, autoSync = true 03-30 14:59:00.538: I/MailService(1971): connected: wifi -72 03-30 14:59:00.538: I/MailService(1971): connected: final hasConnectivity is true 03-30 14:59:00.538: I/MailService(1971): MailService.onStart(Intent { act=com.amazon.email.intent.action.MAIL_SERVICE_RESET cmp=com.amazon.email/.service.MailService (has extras) }, 1), hasConnectivity = true, doBackground = true 03-30 14:59:00.554: I/MailService(1971): connected: network state is CONNECTED, is available is true 03-30 14:59:00.562: I/MailService(1971): connected: AutoSync help is available, autoSync = true 03-30 14:59:00.562: I/MailService(1971): connected: wifi -72 03-30 14:59:00.562: I/MailService(1971): connected: final hasConnectivity is true 03-30 14:59:00.562: I/MailService(1971): MailService.onStart(Intent { act=com.amazon.email.intent.action.MAIL_SERVICE_RESET cmp=com.amazon.email/.service.MailService (has extras) }, 2), hasConnectivity = true, doBackground = true 03-30 14:59:00.570: I/MailService(1971): connected: network state is CONNECTED, is available is true 03-30 14:59:00.570: I/MailService(1971): connected: AutoSync help is available, autoSync = true 03-30 14:59:00.585: I/MailService(1971): connected: wifi -72 03-30 14:59:00.585: I/MailService(1971): connected: final hasConnectivity is true 03-30 14:59:00.585: I/MailService(1971): MailService.onStart(Intent { act=com.amazon.email.intent.action.MAIL_SERVICE_CONNECTIVITY_CHANGE cmp=com.amazon.email/.service.MailService }, 3), hasConnectivity = true, doBackground = true 03-30 14:59:00.632: E/AmazonEmail(1971): isKeyInvalid: key is valid. 03-30 14:59:00.648: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 14:59:00.734: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 14:59:00.749: D/MediaScanner(1637): prescan time: 53ms 03-30 14:59:00.749: D/MediaScanner(1637): scan time: 178ms 03-30 14:59:00.749: D/MediaScanner(1637): postscan time: 0ms 03-30 14:59:00.749: D/MediaScanner(1637): total time: 231ms 03-30 14:59:00.757: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_SCANNER_FINISHED 03-30 14:59:00.757: D/MediaScannerService(1637): done scanning volume external 03-30 14:59:00.773: D/dalvikvm(1971): GC_CONCURRENT freed 461K, 50% free 3012K/5959K, external 847K/1181K, paused 1ms+2ms 03-30 14:59:01.312: D/skia(1941): Loading ARM decoder... 03-30 14:59:01.320: D/skia(1941): Loading ARM encoder... 03-30 14:59:02.023: D/IconMerger(1448): notification for com.android.systemui (1) 03-30 14:59:02.023: D/IconMerger(1448): sum of notifications: 1 03-30 14:59:07.742: W/TiAnalyticsSvc(1914): (Thread-12) [8792,29032] Analytics Service Started 03-30 14:59:07.765: I/TiAnalyticsSvc(1914): (Thread-12) [21,29053] Sending 2 analytics events. 03-30 14:59:08.351: D/dalvikvm(1914): GC_CONCURRENT freed 648K, 42% free 4317K/7431K, external 1196K/1695K, paused 2ms+2ms 03-30 14:59:08.452: I/dalvikvm(1914): Total arena pages for JIT: 11 03-30 14:59:08.757: W/TiAnalyticsSvc(1914): (Thread-12) [995,30048] Stopping Analytics Service 03-30 14:59:14.288: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 14:59:15.070: D/dalvikvm(1386): GC_CONCURRENT freed 2063K, 52% free 5098K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 14:59:15.468: D/dalvikvm(1386): GC_CONCURRENT freed 1285K, 52% free 5106K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 14:59:15.718: D/dalvikvm(1386): GC_CONCURRENT freed 1277K, 52% free 5118K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 14:59:15.843: D/dalvikvm(1386): GC_CONCURRENT freed 1339K, 53% free 5070K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 14:59:15.952: D/dalvikvm(1386): GC_CONCURRENT freed 1276K, 52% free 5072K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 14:59:16.077: D/dalvikvm(1386): GC_CONCURRENT freed 1278K, 52% free 5075K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 14:59:16.202: D/dalvikvm(1386): GC_CONCURRENT freed 1278K, 52% free 5078K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 14:59:16.343: D/dalvikvm(1386): GC_CONCURRENT freed 1300K, 53% free 5052K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 14:59:16.484: D/dalvikvm(1386): GC_CONCURRENT freed 1211K, 52% free 5115K/10567K, external 2732K/3412K, paused 3ms+5ms 03-30 14:59:16.593: D/dalvikvm(1386): GC_CONCURRENT freed 1276K, 52% free 5117K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 14:59:16.695: D/dalvikvm(1386): GC_CONCURRENT freed 1273K, 52% free 5133K/10567K, external 2732K/3412K, paused 3ms+5ms 03-30 14:59:16.796: D/dalvikvm(1386): GC_CONCURRENT freed 1315K, 52% free 5106K/10567K, external 2732K/3412K, paused 3ms+5ms 03-30 14:59:23.054: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 14:59:23.070: D/Window(1914): Loading window with URL: ../examples/app_data.js 03-30 14:59:23.070: D/Module(1914): Loading module: ../examples/app_data -> Resources/examples/app_data.js 03-30 14:59:23.195: D/TiUIView(1914): (main) [14446,44494] Nativeview is null 03-30 14:59:23.218: D/TiUIView(1914): (main) [21,44515] Nativeview is null 03-30 14:59:23.257: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 14:59:23.257: I/LAB126(1448): window changed 03-30 14:59:23.437: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +380ms 03-30 14:59:46.773: D/dalvikvm(1386): GC_CONCURRENT freed 1208K, 52% free 5121K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:00:14.288: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:00:17.007: D/dalvikvm(1386): GC_CONCURRENT freed 1262K, 52% free 5151K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:00:17.124: D/dalvikvm(1386): GC_CONCURRENT freed 1314K, 52% free 5137K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:00:17.249: D/dalvikvm(1386): GC_CONCURRENT freed 1246K, 51% free 5187K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:00:17.359: D/dalvikvm(1386): GC_CONCURRENT freed 1359K, 52% free 5137K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:00:17.468: D/dalvikvm(1386): GC_CONCURRENT freed 1297K, 52% free 5137K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:00:17.577: D/dalvikvm(1386): GC_CONCURRENT freed 1295K, 52% free 5137K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:00:17.687: D/dalvikvm(1386): GC_CONCURRENT freed 1296K, 52% free 5138K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:00:17.788: D/dalvikvm(1386): GC_CONCURRENT freed 1277K, 52% free 5157K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:00:17.882: D/dalvikvm(1386): GC_CONCURRENT freed 1350K, 52% free 5107K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:00:17.968: D/dalvikvm(1386): GC_CONCURRENT freed 1256K, 52% free 5137K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:00:18.046: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 52% free 5154K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:00:18.124: D/dalvikvm(1386): GC_CONCURRENT freed 1310K, 52% free 5138K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:01:14.281: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:01:18.343: D/dalvikvm(1386): GC_CONCURRENT freed 1275K, 52% free 5159K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:01:18.656: D/dalvikvm(1386): GC_CONCURRENT freed 1318K, 52% free 5132K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:01:18.952: D/dalvikvm(1386): GC_CONCURRENT freed 1287K, 52% free 5140K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:01:19.249: D/dalvikvm(1386): GC_CONCURRENT freed 1291K, 52% free 5132K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:01:19.538: D/dalvikvm(1386): GC_CONCURRENT freed 1287K, 52% free 5140K/10567K, external 2732K/3412K, paused 7ms+10ms 03-30 15:01:19.843: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 52% free 5157K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:01:20.148: D/dalvikvm(1386): GC_CONCURRENT freed 1319K, 52% free 5140K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:01:20.445: D/dalvikvm(1386): GC_CONCURRENT freed 1297K, 52% free 5140K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:01:20.656: D/dalvikvm(1386): GC_CONCURRENT freed 1275K, 52% free 5162K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:01:20.882: D/dalvikvm(1386): GC_CONCURRENT freed 1320K, 52% free 5145K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:01:20.960: D/dalvikvm(1386): GC_CONCURRENT freed 1309K, 52% free 5132K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:01:21.023: D/dalvikvm(1386): GC_CONCURRENT freed 1303K, 52% free 5124K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:01:27.554: D/dalvikvm(1386): GC_CONCURRENT freed 1206K, 52% free 5097K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:01:28.054: D/LAB126(1448): collapse softkeys 03-30 15:01:28.070: D/ActivityManager(1386): Starting: Intent { act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.amazon.kindle.otter/.Launcher } from pid 1386 03-30 15:01:28.187: I/ActivityManager(1386): Start proc com.amazon.kindle for broadcast com.amazon.kindle/.PrimeAppReceiver: pid=2021 uid=32010 gids={3003, 1015} 03-30 15:01:28.656: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:01:28.656: I/LAB126(1448): window changed 03-30 15:01:28.913: D/LAB126(1448): got back button softkey click! 03-30 15:01:28.913: D/LAB126(1448): collapse because of back button 03-30 15:01:28.913: D/LAB126(1448): collapse softkeys 03-30 15:01:29.249: W/ActivityManager(1386): Unable to start service Intent { act=appStartup }: not found 03-30 15:01:29.351: I/LAB126(1448): StatusBarService hears intent. action: com.amazon.dcp.sso.action.AmazonAccountPropertyService.property.changed 03-30 15:01:29.749: D/ActivityManager(1386): Starting: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 pkg=com.appcelerator.kitchensinknook cmp=com.appcelerator.kitchensinknook/.KitchensinkNookActivity } from pid 1462 03-30 15:01:29.835: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:01:29.835: I/LAB126(1448): window changed 03-30 15:02:07.593: D/LAB126(1448): got back button softkey click! 03-30 15:02:07.593: D/LAB126(1448): collapse because of back button 03-30 15:02:07.593: D/LAB126(1448): collapse softkeys 03-30 15:02:07.609: W/KeyCharacterMap(1914): No keyboard for id 0 03-30 15:02:07.609: W/KeyCharacterMap(1914): Using default keymap: /system/usr/keychars/qwerty.kcm.bin 03-30 15:02:07.788: W/ProcessStats(1386): Skipping unknown process pid 2057 03-30 15:02:07.913: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:02:07.913: I/LAB126(1448): window changed 03-30 15:02:08.101: E/TiBaseActivity(1914): (main) [164874,209389] Layout cleanup. 03-30 15:02:09.288: D/TiUIView(1914): (main) [1194,210583] Nativeview is null 03-30 15:02:09.296: D/Window(1914): Loading window with URL: main_windows/phone.js 03-30 15:02:09.320: D/Module(1914): Loading module: main_windows/phone -> Resources/main_windows/phone.js 03-30 15:02:09.742: D/TiUIView(1914): (main) [451,211034] Nativeview is null 03-30 15:02:14.288: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:02:21.202: D/dalvikvm(1386): GC_CONCURRENT freed 1176K, 51% free 5207K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:02:21.335: D/dalvikvm(1386): GC_CONCURRENT freed 1364K, 52% free 5145K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:02:21.437: D/dalvikvm(1386): GC_CONCURRENT freed 1291K, 52% free 5153K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:02:21.546: D/dalvikvm(1386): GC_CONCURRENT freed 1282K, 52% free 5171K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:02:21.656: D/dalvikvm(1386): GC_CONCURRENT freed 1323K, 52% free 5153K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:02:21.765: D/dalvikvm(1386): GC_CONCURRENT freed 1282K, 52% free 5171K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:02:21.874: D/dalvikvm(1386): GC_CONCURRENT freed 1323K, 52% free 5153K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:02:21.976: D/dalvikvm(1386): GC_CONCURRENT freed 1300K, 52% free 5153K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:02:22.179: D/dalvikvm(1386): GC_CONCURRENT freed 1298K, 52% free 5151K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:02:22.437: D/dalvikvm(1386): GC_CONCURRENT freed 1283K, 52% free 5164K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:02:22.585: D/dalvikvm(1386): GC_CONCURRENT freed 1329K, 52% free 5130K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:02:22.742: D/dalvikvm(1386): GC_CONCURRENT freed 1254K, 52% free 5170K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:02:22.921: D/dalvikvm(1386): GC_CONCURRENT freed 1365K, 52% free 5110K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:02:57.351: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:02:57.359: D/Window(1914): Loading window with URL: ../examples/movie_local.js 03-30 15:02:57.367: D/Module(1914): Loading module: ../examples/movie_local -> Resources/examples/movie_local.js 03-30 15:02:57.484: D/TiUIView(1914): (main) [47744,258778] Nativeview is null 03-30 15:02:57.484: W/VideoPlayerProxy(1914): (main) [0,258778] Player action ignored; player has not been created. 03-30 15:02:57.499: D/TiUIView(1914): (main) [13,258791] Nativeview is null 03-30 15:02:57.523: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:02:57.523: I/LAB126(1448): window changed 03-30 15:02:57.702: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +351ms 03-30 15:03:14.288: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:03:18.163: I/ChargeProtectionService(1386): Battery discharging, resuming charging 03-30 15:03:23.038: D/dalvikvm(1386): GC_CONCURRENT freed 1212K, 51% free 5187K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:03:23.148: D/dalvikvm(1386): GC_CONCURRENT freed 1338K, 52% free 5158K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:03:23.273: D/dalvikvm(1386): GC_CONCURRENT freed 1299K, 52% free 5161K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:03:23.382: D/dalvikvm(1386): GC_CONCURRENT freed 1321K, 52% free 5135K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:03:23.492: D/dalvikvm(1386): GC_CONCURRENT freed 1272K, 52% free 5159K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:03:23.593: D/dalvikvm(1386): GC_CONCURRENT freed 1309K, 52% free 5152K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:03:23.702: D/dalvikvm(1386): GC_CONCURRENT freed 1293K, 52% free 5159K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:03:23.812: D/dalvikvm(1386): GC_CONCURRENT freed 1301K, 52% free 5160K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:03:23.898: D/dalvikvm(1386): GC_CONCURRENT freed 1285K, 52% free 5173K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:03:23.992: D/dalvikvm(1386): GC_CONCURRENT freed 1341K, 52% free 5130K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:03:24.062: D/dalvikvm(1386): GC_CONCURRENT freed 1257K, 52% free 5160K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:03:24.132: D/dalvikvm(1386): GC_CONCURRENT freed 1297K, 52% free 5160K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:03:24.195: D/dalvikvm(1386): GC_CONCURRENT freed 1301K, 52% free 5160K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:03:35.859: D/LAB126(1448): got back button softkey click! 03-30 15:03:35.859: D/LAB126(1448): collapse because of back button 03-30 15:03:35.859: D/LAB126(1448): collapse softkeys 03-30 15:03:35.882: W/VideoPlayerProxy(1914): (main) [38386,297177] Player action ignored; player has not been created. 03-30 15:03:36.304: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:03:36.304: I/LAB126(1448): window changed 03-30 15:03:36.484: E/TiBaseActivity(1914): (main) [599,297776] Layout cleanup. 03-30 15:03:39.593: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:03:39.617: D/Window(1914): Loading window with URL: ../examples/movie_local.js 03-30 15:03:39.617: D/Module(1914): Loading module: ../examples/movie_local -> Resources/examples/movie_local.js 03-30 15:03:39.945: D/TiUIView(1914): (main) [3462,301238] Nativeview is null 03-30 15:03:39.945: W/VideoPlayerProxy(1914): (main) [1,301239] Player action ignored; player has not been created. 03-30 15:03:39.976: D/TiUIView(1914): (main) [25,301264] Nativeview is null 03-30 15:03:40.031: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:03:40.031: I/LAB126(1448): window changed 03-30 15:03:40.210: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +611ms 03-30 15:03:55.468: D/LAB126(1448): got back button softkey click! 03-30 15:03:55.468: D/LAB126(1448): collapse because of back button 03-30 15:03:55.468: D/LAB126(1448): collapse softkeys 03-30 15:03:55.499: W/VideoPlayerProxy(1914): (main) [15522,316786] Player action ignored; player has not been created. 03-30 15:03:55.648: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:03:55.648: I/LAB126(1448): window changed 03-30 15:03:55.921: E/TiBaseActivity(1914): (main) [428,317214] Layout cleanup. 03-30 15:03:57.687: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:03:57.702: D/Window(1914): Loading window with URL: ../examples/sound.js 03-30 15:03:57.702: D/Module(1914): Loading module: ../examples/sound -> Resources/examples/sound.js 03-30 15:03:57.874: D/dalvikvm(1914): GC_CONCURRENT freed 601K, 40% free 4613K/7687K, external 1196K/1695K, paused 1ms+3ms 03-30 15:03:57.999: D/TiUIView(1914): (main) [2082,319296] Nativeview is null 03-30 15:03:58.023: D/TiUIView(1914): (main) [27,319323] Nativeview is null 03-30 15:03:58.062: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:03:58.062: I/LAB126(1448): window changed 03-30 15:03:58.234: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +545ms 03-30 15:04:01.156: D/LAB126(1448): got back button softkey click! 03-30 15:04:01.156: D/LAB126(1448): collapse because of back button 03-30 15:04:01.156: W/KeyCharacterMap(1914): No keyboard for id 0 03-30 15:04:01.156: W/KeyCharacterMap(1914): Using default keymap: /system/usr/keychars/qwerty.kcm.bin 03-30 15:04:01.156: D/LAB126(1448): collapse softkeys 03-30 15:04:01.226: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:04:01.226: I/LAB126(1448): window changed 03-30 15:04:01.437: E/TiBaseActivity(1914): (main) [3408,322731] Layout cleanup. 03-30 15:04:02.445: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:04:02.460: D/Window(1914): Loading window with URL: ../examples/movie_local.js 03-30 15:04:02.468: D/Module(1914): Loading module: ../examples/movie_local -> Resources/examples/movie_local.js 03-30 15:04:02.640: D/TiUIView(1914): (main) [1197,323928] Nativeview is null 03-30 15:04:02.640: W/VideoPlayerProxy(1914): (main) [0,323928] Player action ignored; player has not been created. 03-30 15:04:02.671: D/TiUIView(1914): (main) [35,323963] Nativeview is null 03-30 15:04:02.710: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:04:02.710: I/LAB126(1448): window changed 03-30 15:04:02.882: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +424ms 03-30 15:04:14.296: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:04:14.304: D/LAB126(1448): got back button softkey click! 03-30 15:04:14.304: D/LAB126(1448): collapse because of back button 03-30 15:04:14.304: D/LAB126(1448): collapse softkeys 03-30 15:04:14.320: W/VideoPlayerProxy(1914): (main) [11647,335610] Player action ignored; player has not been created. 03-30 15:04:14.452: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:04:14.452: I/LAB126(1448): window changed 03-30 15:04:14.570: D/dalvikvm(1386): GC_CONCURRENT freed 1174K, 52% free 5162K/10567K, external 2732K/3412K, paused 4ms+6ms 03-30 15:04:14.679: E/TiBaseActivity(1914): (main) [367,335977] Layout cleanup. 03-30 15:04:24.562: D/dalvikvm(1386): GC_CONCURRENT freed 1281K, 51% free 5184K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:04:24.820: D/dalvikvm(1386): GC_CONCURRENT freed 1313K, 51% free 5179K/10567K, external 2732K/3412K, paused 7ms+3ms 03-30 15:04:24.929: D/dalvikvm(1386): GC_CONCURRENT freed 1288K, 51% free 5197K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:04:25.031: D/dalvikvm(1386): GC_CONCURRENT freed 1329K, 51% free 5179K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:04:25.148: D/dalvikvm(1386): GC_CONCURRENT freed 1321K, 52% free 5163K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:04:25.273: D/dalvikvm(1386): GC_CONCURRENT freed 1287K, 51% free 5179K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:04:25.413: D/dalvikvm(1386): GC_CONCURRENT freed 1297K, 51% free 5188K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:04:25.554: D/dalvikvm(1386): GC_CONCURRENT freed 1338K, 52% free 5156K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:04:25.663: D/dalvikvm(1386): GC_CONCURRENT freed 1285K, 52% free 5166K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:04:25.757: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 52% free 5162K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:04:25.835: D/dalvikvm(1386): GC_CONCURRENT freed 1278K, 51% free 5179K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:04:25.913: D/dalvikvm(1386): GC_CONCURRENT freed 1294K, 51% free 5180K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:04:41.507: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:04:41.515: D/Window(1914): Loading window with URL: ../examples/movie_local.js 03-30 15:04:41.515: D/Module(1914): Loading module: ../examples/movie_local -> Resources/examples/movie_local.js 03-30 15:04:41.671: D/TiUIView(1914): (main) [26993,362970] Nativeview is null 03-30 15:04:41.671: W/VideoPlayerProxy(1914): (main) [0,362970] Player action ignored; player has not been created. 03-30 15:04:41.687: D/TiUIView(1914): (main) [14,362984] Nativeview is null 03-30 15:04:41.718: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:04:41.718: I/LAB126(1448): window changed 03-30 15:04:41.898: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +385ms 03-30 15:05:09.351: D/dalvikvm(1386): GC_CONCURRENT freed 1253K, 52% free 5150K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:05:14.296: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:05:15.093: D/LAB126(1448): got back button softkey click! 03-30 15:05:15.093: D/LAB126(1448): collapse because of back button 03-30 15:05:15.093: D/LAB126(1448): collapse softkeys 03-30 15:05:15.109: W/VideoPlayerProxy(1914): (main) [33413,396397] Player action ignored; player has not been created. 03-30 15:05:15.171: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:05:15.171: I/LAB126(1448): window changed 03-30 15:05:15.663: E/TiBaseActivity(1914): (main) [560,396957] Layout cleanup. 03-30 15:05:18.124: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:05:18.156: D/Window(1914): Loading window with URL: ../examples/sound.js 03-30 15:05:18.163: D/Module(1914): Loading module: ../examples/sound -> Resources/examples/sound.js 03-30 15:05:18.507: D/TiUIView(1914): (main) [2847,399804] Nativeview is null 03-30 15:05:18.538: D/TiUIView(1914): (main) [27,399831] Nativeview is null 03-30 15:05:18.570: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:05:18.570: I/LAB126(1448): window changed 03-30 15:05:18.734: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +591ms 03-30 15:05:25.070: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:05:25.085: D/Window(1914): Loading window with URL: ../examples/sound_local.js 03-30 15:05:25.085: D/Module(1914): Loading module: ../examples/sound_local -> Resources/examples/sound_local.js 03-30 15:05:25.609: D/TiUIView(1914): (main) [7069,406900] Nativeview is null 03-30 15:05:25.617: D/TiUIView(1914): (main) [16,406916] Nativeview is null 03-30 15:05:25.656: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:05:25.656: I/LAB126(1448): window changed 03-30 15:05:25.827: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +743ms 03-30 15:05:26.171: D/dalvikvm(1386): GC_CONCURRENT freed 1253K, 51% free 5197K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:05:26.390: D/dalvikvm(1386): GC_CONCURRENT freed 1283K, 51% free 5210K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:05:26.499: D/dalvikvm(1386): GC_CONCURRENT freed 1348K, 52% free 5176K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:05:26.617: D/dalvikvm(1386): GC_CONCURRENT freed 1289K, 51% free 5194K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:05:26.726: D/dalvikvm(1386): GC_CONCURRENT freed 1328K, 52% free 5177K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:05:26.843: D/dalvikvm(1386): GC_CONCURRENT freed 1284K, 51% free 5185K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:05:26.968: D/dalvikvm(1386): GC_CONCURRENT freed 1317K, 52% free 5176K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:05:27.070: D/dalvikvm(1386): GC_CONCURRENT freed 1333K, 52% free 5145K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:05:27.171: D/dalvikvm(1386): GC_CONCURRENT freed 1213K, 51% free 5230K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:05:27.257: D/dalvikvm(1386): GC_CONCURRENT freed 1379K, 52% free 5158K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:05:27.327: D/dalvikvm(1386): GC_CONCURRENT freed 1277K, 52% free 5177K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:05:27.406: D/dalvikvm(1386): GC_CONCURRENT freed 1278K, 51% free 5193K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:05:31.976: W/ASFDummyExtractor(1289): ASF parser is not available 03-30 15:05:31.976: E/MPEG4Extractor(1289): both mdat,ftyp not found 03-30 15:05:32.015: D/AudioResampler(1289): forcing AudioResampler quality to 2 03-30 15:05:32.015: D/Omap4ALSA(1289): open called for devices 00000002 in mode 0 channels 00000000... 03-30 15:05:32.023: I/Omap4ALSA(1289): Using ping-pong! 03-30 15:05:32.023: I/Omap4ALSA(1289): Buffer size: 4096 03-30 15:05:32.023: I/Omap4ALSA(1289): Latency: 92879 03-30 15:05:32.070: I/Omap4ALSA(1289): Initialized ALSA PLAYBACK device 'plughw:0,0' 03-30 15:05:32.070: E/AudioHardwareALSA(1289): RE-OPEN AFTER STANDBY:: took 60 msecs 03-30 15:05:32.226: I/TiAPI(1914): time 93 03-30 15:05:32.734: I/TiAPI(1914): time 651 03-30 15:05:33.234: I/TiAPI(1914): time 1486 03-30 15:05:33.726: I/TiAPI(1914): time 1672 03-30 15:05:34.234: I/TiAPI(1914): time 2230 03-30 15:05:34.734: I/TiAPI(1914): time 2972 03-30 15:05:35.234: I/TiAPI(1914): time 3158 03-30 15:05:35.734: I/TiAPI(1914): time 3716 03-30 15:05:36.226: I/TiAPI(1914): time 4458 03-30 15:05:36.734: I/TiAPI(1914): time 4737 03-30 15:05:37.234: I/TiAPI(1914): time 5202 03-30 15:05:37.382: I/WindowManager(1386): Setting rotation to 1, animFlags=0 03-30 15:05:37.390: I/ActivityManager(1386): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=2 layout=268435491 uiMode=17 seq=5} 03-30 15:05:37.663: D/IconMerger(1448): notification for com.android.systemui (1) 03-30 15:05:37.663: D/IconMerger(1448): sum of notifications: 1 03-30 15:05:37.734: I/TiAPI(1914): time 5944 03-30 15:05:38.093: I/WindowManager(1386): Setting rotation to 3, animFlags=0 03-30 15:05:38.234: I/TiAPI(1914): time 6223 03-30 15:05:38.734: I/TiAPI(1914): time 6688 03-30 15:05:39.398: D/dalvikvm(1386): GC_EXPLICIT freed 1173K, 52% free 5123K/10567K, external 2732K/3412K, paused 45ms 03-30 15:05:39.398: I/WindowManager(1386): Setting rotation to 0, animFlags=0 03-30 15:05:39.421: I/ActivityManager(1386): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=1 layout=268435491 uiMode=17 seq=6} 03-30 15:05:39.499: D/IconMerger(1448): notification for com.android.systemui (1) 03-30 15:05:39.499: D/IconMerger(1448): sum of notifications: 1 03-30 15:05:40.734: I/TiAPI(1914): time 0 03-30 15:05:41.234: I/TiAPI(1914): time 370 03-30 15:05:41.562: D/dalvikvm(1386): GC_EXPLICIT freed 88K, 52% free 5111K/10567K, external 2732K/3412K, paused 45ms 03-30 15:05:41.734: I/TiAPI(1914): time 835 03-30 15:05:42.234: I/TiAPI(1914): time 1486 03-30 15:05:42.734: I/TiAPI(1914): time 1858 03-30 15:05:43.234: I/TiAPI(1914): time 2415 03-30 15:05:43.734: I/TiAPI(1914): time 2972 03-30 15:05:44.234: I/TiAPI(1914): time 3344 03-30 15:05:44.734: I/TiAPI(1914): time 3901 03-30 15:05:45.242: I/TiAPI(1914): time 4458 03-30 15:05:45.734: I/TiAPI(1914): time 4923 03-30 15:05:46.242: I/TiAPI(1914): time 5387 03-30 15:05:46.742: I/TiAPI(1914): time 5944 03-30 15:05:47.234: I/TiAPI(1914): time 6409 03-30 15:05:51.241: I/TiAPI(1914): time 369 03-30 15:05:51.742: I/TiAPI(1914): time 833 03-30 15:05:52.234: I/TiAPI(1914): time 1486 03-30 15:05:52.734: I/TiAPI(1914): time 1855 03-30 15:05:53.242: I/TiAPI(1914): time 2319 03-30 15:05:53.742: I/TiAPI(1914): time 2972 03-30 15:05:54.241: I/TiAPI(1914): time 3341 03-30 15:05:54.742: I/TiAPI(1914): time 3898 03-30 15:05:55.242: I/TiAPI(1914): time 4458 03-30 15:05:55.749: I/TiAPI(1914): time 4827 03-30 15:05:56.249: I/TiAPI(1914): time 5384 03-30 15:05:56.749: I/TiAPI(1914): time 5944 03-30 15:05:58.749: I/TiAPI(1914): time 6592 03-30 15:06:01.257: I/TiAPI(1914): time 92 03-30 15:06:01.757: I/TiAPI(1914): time 556 03-30 15:06:02.249: I/TiAPI(1914): time 1486 03-30 15:06:04.757: I/TiAPI(1914): time 1951 03-30 15:06:05.257: I/TiAPI(1914): time 2972 03-30 15:06:05.757: I/TiAPI(1914): time 2973 03-30 15:06:06.257: I/TiAPI(1914): time 3530 03-30 15:06:06.757: I/TiAPI(1914): time 4458 03-30 15:06:08.757: I/TiAPI(1914): time 93 03-30 15:06:09.257: I/TiAPI(1914): time 651 03-30 15:06:09.757: I/TiAPI(1914): time 1486 03-30 15:06:10.249: I/TiAPI(1914): time 1765 03-30 15:06:10.749: I/TiAPI(1914): time 2230 03-30 15:06:11.249: I/TiAPI(1914): time 0 03-30 15:06:11.757: I/TiAPI(1914): time 372 03-30 15:06:12.257: I/TiAPI(1914): time 0 03-30 15:06:12.757: I/TiAPI(1914): time 279 03-30 15:06:13.257: I/TiAPI(1914): time 836 03-30 15:06:13.749: I/TiAPI(1914): time 1486 03-30 15:06:14.304: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:06:16.859: E/Omap4ALSA(1289): called drain&close 03-30 15:06:27.679: D/dalvikvm(1386): GC_CONCURRENT freed 1180K, 51% free 5221K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:06:27.921: D/dalvikvm(1386): GC_CONCURRENT freed 1330K, 51% free 5208K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:06:28.031: D/dalvikvm(1386): GC_CONCURRENT freed 1348K, 52% free 5174K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:06:28.140: D/dalvikvm(1386): GC_CONCURRENT freed 1305K, 52% free 5175K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:06:28.281: D/dalvikvm(1386): GC_CONCURRENT freed 1322K, 52% free 5158K/10567K, external 2732K/3412K, paused 4ms+5ms 03-30 15:06:28.445: D/dalvikvm(1386): GC_CONCURRENT freed 1285K, 52% free 5175K/10567K, external 2732K/3412K, paused 4ms+5ms 03-30 15:06:28.617: D/dalvikvm(1386): GC_CONCURRENT freed 1302K, 52% free 5166K/10567K, external 2732K/3412K, paused 3ms+5ms 03-30 15:06:28.781: D/dalvikvm(1386): GC_CONCURRENT freed 1296K, 52% free 5174K/10567K, external 2732K/3412K, paused 3ms+6ms 03-30 15:06:28.906: D/dalvikvm(1386): GC_CONCURRENT freed 1301K, 51% free 5178K/10567K, external 2732K/3412K, paused 3ms+5ms 03-30 15:06:29.046: D/dalvikvm(1386): GC_CONCURRENT freed 1310K, 52% free 5170K/10567K, external 2732K/3412K, paused 4ms+5ms 03-30 15:06:29.148: D/dalvikvm(1386): GC_CONCURRENT freed 1314K, 52% free 5159K/10567K, external 2732K/3412K, paused 4ms+5ms 03-30 15:06:29.242: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 52% free 5175K/10567K, external 2732K/3412K, paused 3ms+5ms 03-30 15:06:29.343: D/dalvikvm(1386): GC_CONCURRENT freed 1221K, 52% free 5167K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:06:40.788: D/LAB126(1448): got back button softkey click! 03-30 15:06:40.788: D/LAB126(1448): collapse because of back button 03-30 15:06:40.788: D/LAB126(1448): collapse softkeys 03-30 15:06:40.867: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:06:40.867: I/LAB126(1448): window changed 03-30 15:06:41.038: E/TiBaseActivity(1914): (main) [75419,482335] Layout cleanup. 03-30 15:06:43.109: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:06:43.132: D/Window(1914): Loading window with URL: ../examples/sound_file.js 03-30 15:06:43.140: D/Module(1914): Loading module: ../examples/sound_file -> Resources/examples/sound_file.js 03-30 15:06:43.937: D/TiUIView(1914): (main) [2896,485231] Nativeview is null 03-30 15:06:43.968: D/TiUIView(1914): (main) [34,485265] Nativeview is null 03-30 15:06:44.077: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:06:44.077: I/LAB126(1448): window changed 03-30 15:06:44.234: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +1s121ms 03-30 15:07:03.296: W/ASFDummyExtractor(1289): ASF parser is not available 03-30 15:07:03.296: E/MPEG4Extractor(1289): both mdat,ftyp not found 03-30 15:07:03.351: D/AudioResampler(1289): forcing AudioResampler quality to 2 03-30 15:07:03.351: D/Omap4ALSA(1289): open called for devices 00000002 in mode 0 channels 00000000... 03-30 15:07:03.374: I/Omap4ALSA(1289): Using ping-pong! 03-30 15:07:03.374: I/Omap4ALSA(1289): Buffer size: 4096 03-30 15:07:03.374: I/Omap4ALSA(1289): Latency: 92879 03-30 15:07:03.374: I/TiAPI(1914): time 0 03-30 15:07:03.460: I/Omap4ALSA(1289): Initialized ALSA PLAYBACK device 'plughw:0,0' 03-30 15:07:03.460: E/AudioHardwareALSA(1289): RE-OPEN AFTER STANDBY:: took 105 msecs 03-30 15:07:03.882: I/TiAPI(1914): time 372 03-30 15:07:04.382: I/TiAPI(1914): time 836 03-30 15:07:04.882: I/TiAPI(1914): time 1486 03-30 15:07:04.898: I/WindowManager(1386): Setting rotation to 1, animFlags=0 03-30 15:07:04.913: I/ActivityManager(1386): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=2 layout=268435491 uiMode=17 seq=7} 03-30 15:07:05.187: D/IconMerger(1448): notification for com.android.systemui (1) 03-30 15:07:05.187: D/IconMerger(1448): sum of notifications: 1 03-30 15:07:05.382: I/TiAPI(1914): time 1951 03-30 15:07:05.390: I/WindowManager(1386): Setting rotation to 0, animFlags=0 03-30 15:07:05.406: I/ActivityManager(1386): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=1 layout=268435491 uiMode=17 seq=8} 03-30 15:07:05.624: D/IconMerger(1448): notification for com.android.systemui (1) 03-30 15:07:05.624: D/IconMerger(1448): sum of notifications: 1 03-30 15:07:05.882: I/TiAPI(1914): time 2972 03-30 15:07:06.382: I/TiAPI(1914): time 2973 03-30 15:07:06.890: I/TiAPI(1914): time 3437 03-30 15:07:07.390: I/TiAPI(1914): time 4458 03-30 15:07:07.773: D/dalvikvm(1386): GC_EXPLICIT freed 734K, 52% free 5142K/10567K, external 2732K/3412K, paused 107ms 03-30 15:07:07.890: I/TiAPI(1914): time 4459 03-30 15:07:09.390: I/TiAPI(1914): time 0 03-30 15:07:09.882: I/TiAPI(1914): time 279 03-30 15:07:10.390: I/TiAPI(1914): time 743 03-30 15:07:10.890: I/TiAPI(1914): time 1486 03-30 15:07:11.390: I/TiAPI(1914): time 1858 03-30 15:07:11.890: I/TiAPI(1914): time 2322 03-30 15:07:12.382: I/TiAPI(1914): time 2972 03-30 15:07:13.890: I/TiAPI(1914): time 3716 03-30 15:07:14.296: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:07:14.390: I/TiAPI(1914): time 4458 03-30 15:07:14.890: I/TiAPI(1914): time 4644 03-30 15:07:15.398: I/TiAPI(1914): time 5202 03-30 15:07:17.398: I/TiAPI(1914): time 5944 03-30 15:07:17.898: I/TiAPI(1914): time 6130 03-30 15:07:18.398: I/TiAPI(1914): time 6595 03-30 15:07:21.960: E/Omap4ALSA(1289): called drain&close 03-30 15:07:21.960: I/TiAPI(1914): time 0 03-30 15:07:22.015: D/Omap4ALSA(1289): open called for devices 00000002 in mode 0 channels 00000000... 03-30 15:07:22.023: I/Omap4ALSA(1289): Using ping-pong! 03-30 15:07:22.023: I/Omap4ALSA(1289): Buffer size: 4096 03-30 15:07:22.023: I/Omap4ALSA(1289): Latency: 92879 03-30 15:07:22.085: I/Omap4ALSA(1289): Initialized ALSA PLAYBACK device 'plughw:0,0' 03-30 15:07:22.085: E/AudioHardwareALSA(1289): RE-OPEN AFTER STANDBY:: took 75 msecs 03-30 15:07:22.468: I/TiAPI(1914): time 463 03-30 15:07:22.968: I/TiAPI(1914): time 928 03-30 15:07:23.468: I/TiAPI(1914): time 1486 03-30 15:07:23.960: I/TiAPI(1914): time 0 03-30 15:07:24.468: I/TiAPI(1914): time 370 03-30 15:07:24.968: I/TiAPI(1914): time 928 03-30 15:07:25.476: I/TiAPI(1914): time 1486 03-30 15:07:25.968: I/TiAPI(1914): time 1856 03-30 15:07:26.468: I/TiAPI(1914): time 2414 03-30 15:07:26.976: I/TiAPI(1914): time 2972 03-30 15:07:27.476: I/TiAPI(1914): time 3343 03-30 15:07:27.851: D/LAB126(1448): got back button softkey click! 03-30 15:07:27.851: D/LAB126(1448): collapse because of back button 03-30 15:07:27.851: D/LAB126(1448): collapse softkeys 03-30 15:07:27.929: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:07:27.929: I/LAB126(1448): window changed 03-30 15:07:27.952: D/dalvikvm(1914): GC_CONCURRENT freed 914K, 43% free 4671K/8071K, external 1196K/1695K, paused 2ms+4ms 03-30 15:07:28.109: E/TiBaseActivity(1914): (main) [44139,529404] Layout cleanup. 03-30 15:07:29.499: D/dalvikvm(1386): GC_CONCURRENT freed 1262K, 52% free 5178K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:07:29.554: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:07:29.570: D/Window(1914): Loading window with URL: ../examples/sound_file_url.js 03-30 15:07:29.570: D/Module(1914): Loading module: ../examples/sound_file_url -> Resources/examples/sound_file_url.js 03-30 15:07:29.656: D/dalvikvm(1386): GC_CONCURRENT freed 1238K, 52% free 5162K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:07:29.781: D/dalvikvm(1386): GC_CONCURRENT freed 1302K, 52% free 5162K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:07:29.906: D/dalvikvm(1386): GC_CONCURRENT freed 1303K, 52% free 5162K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:07:30.015: D/dalvikvm(1386): GC_CONCURRENT freed 1284K, 51% free 5180K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:07:30.140: D/dalvikvm(1386): GC_CONCURRENT freed 1291K, 51% free 5196K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:07:30.195: D/TiUIView(1914): (main) [2090,531494] Nativeview is null 03-30 15:07:30.218: D/TiUIView(1914): (main) [17,531511] Nativeview is null 03-30 15:07:30.257: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:07:30.257: I/LAB126(1448): window changed 03-30 15:07:30.374: D/dalvikvm(1386): GC_CONCURRENT freed 1251K, 52% free 5168K/10567K, external 2732K/3412K, paused 3ms+10ms 03-30 15:07:30.437: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +871ms 03-30 15:07:30.726: D/dalvikvm(1386): GC_CONCURRENT freed 1305K, 52% free 5168K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:07:30.827: D/dalvikvm(1386): GC_CONCURRENT freed 1302K, 52% free 5170K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:07:30.929: D/dalvikvm(1386): GC_CONCURRENT freed 1284K, 52% free 5178K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:07:30.999: D/dalvikvm(1386): GC_CONCURRENT freed 1314K, 52% free 5166K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:07:31.070: D/dalvikvm(1386): GC_CONCURRENT freed 1310K, 52% free 5150K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:07:31.109: E/Omap4ALSA(1289): called drain&close 03-30 15:07:31.171: D/dalvikvm(1386): GC_CONCURRENT freed 1205K, 52% free 5158K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:07:34.695: D/LAB126(1448): got back button softkey click! 03-30 15:07:34.695: D/LAB126(1448): collapse because of back button 03-30 15:07:34.695: W/KeyCharacterMap(1914): No keyboard for id 0 03-30 15:07:34.695: W/KeyCharacterMap(1914): Using default keymap: /system/usr/keychars/qwerty.kcm.bin 03-30 15:07:34.695: D/LAB126(1448): collapse softkeys 03-30 15:07:34.851: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:07:34.851: I/LAB126(1448): window changed 03-30 15:07:35.031: E/TiBaseActivity(1914): (main) [4811,536322] Layout cleanup. 03-30 15:07:36.281: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:07:36.312: D/Window(1914): Loading window with URL: ../examples/sound_file_url.js 03-30 15:07:36.312: D/Module(1914): Loading module: ../examples/sound_file_url -> Resources/examples/sound_file_url.js 03-30 15:07:37.077: D/TiUIView(1914): (main) [2043,538365] Nativeview is null 03-30 15:07:37.124: D/TiUIView(1914): (main) [56,538421] Nativeview is null 03-30 15:07:37.218: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:07:37.218: I/LAB126(1448): window changed 03-30 15:07:37.390: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +1s100ms 03-30 15:07:38.281: W/ASFDummyExtractor(1289): ASF parser is not available 03-30 15:07:38.281: E/MPEG4Extractor(1289): both mdat,ftyp not found 03-30 15:07:38.304: D/AudioResampler(1289): forcing AudioResampler quality to 2 03-30 15:07:38.304: D/Omap4ALSA(1289): open called for devices 00000002 in mode 0 channels 00000000... 03-30 15:07:38.327: I/Omap4ALSA(1289): Using ping-pong! 03-30 15:07:38.327: I/Omap4ALSA(1289): Buffer size: 4096 03-30 15:07:38.327: I/Omap4ALSA(1289): Latency: 92879 03-30 15:07:38.413: I/Omap4ALSA(1289): Initialized ALSA PLAYBACK device 'plughw:0,0' 03-30 15:07:38.413: E/AudioHardwareALSA(1289): RE-OPEN AFTER STANDBY:: took 105 msecs 03-30 15:07:38.570: I/TiAPI(1914): time 0 03-30 15:07:39.070: I/TiAPI(1914): time 186 03-30 15:07:39.577: I/TiAPI(1914): time 743 03-30 15:07:40.070: I/TiAPI(1914): time 1486 03-30 15:07:40.570: I/TiAPI(1914): time 1765 03-30 15:07:41.070: I/TiAPI(1914): time 2230 03-30 15:07:41.570: I/TiAPI(1914): time 2972 03-30 15:07:42.062: I/TiAPI(1914): time 3251 03-30 15:07:42.577: I/TiAPI(1914): time 0 03-30 15:07:43.163: I/TiAPI(1914): time 186 03-30 15:07:43.679: I/TiAPI(1914): time 651 03-30 15:07:44.202: I/TiAPI(1914): time 1486 03-30 15:07:45.796: I/TiAPI(1914): time 2044 03-30 15:07:46.304: I/TiAPI(1914): time 2972 03-30 15:07:46.859: I/TiAPI(1914): time 3065 03-30 15:07:47.374: I/TiAPI(1914): time 3623 03-30 15:07:49.437: I/TiAPI(1914): time 0 03-30 15:07:49.952: I/TiAPI(1914): time 558 03-30 15:07:52.624: D/LAB126(1448): got back button softkey click! 03-30 15:07:52.624: D/LAB126(1448): collapse because of back button 03-30 15:07:52.624: D/LAB126(1448): collapse softkeys 03-30 15:07:52.804: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:07:52.804: I/LAB126(1448): window changed 03-30 15:07:52.976: E/TiBaseActivity(1914): (main) [15855,554276] Layout cleanup. 03-30 15:07:53.484: E/Omap4ALSA(1289): called drain&close 03-30 15:08:14.304: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:08:20.992: I/ChargeProtectionService(1386): Battery discharging, resuming charging 03-30 15:08:31.335: D/dalvikvm(1386): GC_CONCURRENT freed 1252K, 51% free 5208K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:08:31.577: D/dalvikvm(1386): GC_CONCURRENT freed 1362K, 52% free 5161K/10567K, external 2732K/3412K, paused 7ms+4ms 03-30 15:08:31.687: D/dalvikvm(1386): GC_CONCURRENT freed 1302K, 52% free 5161K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:08:31.796: D/dalvikvm(1386): GC_CONCURRENT freed 1302K, 52% free 5161K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:08:31.898: D/dalvikvm(1386): GC_CONCURRENT freed 1302K, 52% free 5161K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:08:32.007: D/dalvikvm(1386): GC_CONCURRENT freed 1302K, 52% free 5161K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:08:32.117: D/dalvikvm(1386): GC_CONCURRENT freed 1318K, 52% free 5145K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:08:32.218: D/dalvikvm(1386): GC_CONCURRENT freed 1283K, 52% free 5161K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:08:32.312: D/dalvikvm(1386): GC_CONCURRENT freed 1329K, 52% free 5132K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:08:32.406: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 52% free 5122K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:08:32.484: D/dalvikvm(1386): GC_CONCURRENT freed 1231K, 52% free 5177K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:08:32.585: D/dalvikvm(1386): GC_CONCURRENT freed 1295K, 52% free 5178K/10567K, external 2732K/3412K, paused 2ms+9ms 03-30 15:08:32.742: D/dalvikvm(1386): GC_CONCURRENT freed 1310K, 52% free 5162K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:09:14.304: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:09:32.976: D/dalvikvm(1386): GC_CONCURRENT freed 1229K, 51% free 5206K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:09:33.281: D/dalvikvm(1386): GC_CONCURRENT freed 1356K, 52% free 5163K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:09:33.577: D/dalvikvm(1386): GC_CONCURRENT freed 1303K, 52% free 5163K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:09:33.898: D/dalvikvm(1386): GC_CONCURRENT freed 1269K, 51% free 5197K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:09:34.031: D/dalvikvm(1386): GC_CONCURRENT freed 1346K, 52% free 5163K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:09:34.148: D/dalvikvm(1386): GC_CONCURRENT freed 1302K, 52% free 5164K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:09:34.257: D/dalvikvm(1386): GC_CONCURRENT freed 1303K, 52% free 5164K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:09:34.374: D/dalvikvm(1386): GC_CONCURRENT freed 1303K, 52% free 5164K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:09:34.476: D/dalvikvm(1386): GC_CONCURRENT freed 1271K, 51% free 5184K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:09:34.585: D/dalvikvm(1386): GC_CONCURRENT freed 1309K, 51% free 5183K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:09:34.656: D/dalvikvm(1386): GC_CONCURRENT freed 1347K, 52% free 5140K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:09:34.718: D/dalvikvm(1386): GC_CONCURRENT freed 1280K, 52% free 5156K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:09:34.781: D/dalvikvm(1386): GC_CONCURRENT freed 1310K, 52% free 5140K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:10:14.312: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:10:34.906: D/dalvikvm(1386): GC_CONCURRENT freed 1225K, 51% free 5212K/10567K, external 2732K/3412K, paused 2ms+10ms 03-30 15:10:35.218: D/dalvikvm(1386): GC_CONCURRENT freed 1360K, 52% free 5166K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:10:35.531: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 52% free 5166K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:10:35.835: D/dalvikvm(1386): GC_CONCURRENT freed 1286K, 51% free 5184K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:10:36.109: D/dalvikvm(1386): GC_CONCURRENT freed 1325K, 52% free 5168K/10567K, external 2732K/3412K, paused 6ms+4ms 03-30 15:10:36.226: D/dalvikvm(1386): GC_CONCURRENT freed 1305K, 52% free 5167K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:10:36.335: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 52% free 5167K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:10:36.437: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 52% free 5167K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:10:36.531: D/dalvikvm(1386): GC_CONCURRENT freed 1293K, 52% free 5177K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:10:36.632: D/dalvikvm(1386): GC_CONCURRENT freed 1334K, 52% free 5145K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:10:36.695: D/dalvikvm(1386): GC_CONCURRENT freed 1282K, 52% free 5159K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:10:36.757: D/dalvikvm(1386): GC_CONCURRENT freed 1310K, 52% free 5143K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:10:36.812: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 52% free 5159K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:11:14.312: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:11:37.007: D/dalvikvm(1386): GC_CONCURRENT freed 1244K, 51% free 5217K/10567K, external 2732K/3412K, paused 7ms+10ms 03-30 15:11:37.335: D/dalvikvm(1386): GC_CONCURRENT freed 1334K, 51% free 5200K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:11:37.663: D/dalvikvm(1386): GC_CONCURRENT freed 1342K, 52% free 5170K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:11:37.663: D/LAB126(1448): got back button softkey click! 03-30 15:11:37.663: D/LAB126(1448): collapse because of back button 03-30 15:11:37.663: D/LAB126(1448): collapse softkeys 03-30 15:11:37.906: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:11:37.906: I/LAB126(1448): window changed 03-30 15:11:38.171: E/TiBaseActivity(1914): (main) [225184,779460] Layout cleanup. 03-30 15:11:38.179: D/dalvikvm(1386): GC_CONCURRENT freed 1269K, 51% free 5185K/10567K, external 2732K/3412K, paused 2ms+5ms 03-30 15:11:38.320: D/dalvikvm(1386): GC_CONCURRENT freed 1289K, 51% free 5205K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:11:38.437: D/dalvikvm(1386): GC_CONCURRENT freed 1349K, 52% free 5169K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:11:38.554: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 52% free 5169K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:11:38.671: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 52% free 5169K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:11:38.773: D/dalvikvm(1386): GC_CONCURRENT freed 1313K, 52% free 5153K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:11:38.874: D/dalvikvm(1386): GC_CONCURRENT freed 1265K, 51% free 5188K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:11:38.952: D/dalvikvm(1386): GC_CONCURRENT freed 1307K, 51% free 5185K/10567K, external 2732K/3412K, paused 2ms+13ms 03-30 15:11:39.038: D/dalvikvm(1386): GC_CONCURRENT freed 1326K, 52% free 5153K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:11:39.109: D/dalvikvm(1386): GC_CONCURRENT freed 1280K, 52% free 5169K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:11:43.531: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:11:43.663: D/Window(1914): Loading window with URL: ../examples/photo_gallery.js 03-30 15:11:43.671: D/Module(1914): Loading module: ../examples/photo_gallery -> Resources/examples/photo_gallery.js 03-30 15:11:43.890: D/ActivityManager(1386): Starting: Intent { act=android.intent.action.PICK cat=[android.intent.category.DEFAULT] typ=image/* cmp=com.cooliris.media/.Gallery (has extras) } from pid 1914 03-30 15:11:43.890: W/ActivityManager(1386): Activity is launching as a new task, so cancelling activity result. 03-30 15:11:44.093: D/TiUIView(1914): (main) [5926,785386] Nativeview is null 03-30 15:11:44.093: E/TiMedia(1914): (main) [1,785387] OnResult called: 0 03-30 15:11:44.101: I/Gallery3D(1941): sending softkey config intent, config: 2, key com.cooliris.media/com.cooliris.media.Gallery 03-30 15:11:44.101: I/LAB126(1448): StatusBarService hears softkey intent. action: com.lab126.intent.ACTION_CONFIG_SOFTKEYS 03-30 15:11:44.124: D/TiUIView(1914): (main) [32,785419] Nativeview is null 03-30 15:11:44.156: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:11:44.156: I/LAB126(1448): window changed 03-30 15:11:44.296: E/GridDrawManager(1941): There are 3072 display items. 03-30 15:11:44.343: D/dalvikvm(1941): GC_CONCURRENT freed 482K, 50% free 3035K/5959K, external 1178K/1181K, paused 1ms+2ms 03-30 15:11:44.367: D/dalvikvm(1941): GC_EXTERNAL_ALLOC freed 9K, 50% free 3026K/5959K, external 1154K/1181K, paused 24ms 03-30 15:11:44.398: D/dalvikvm(1941): GC_EXTERNAL_ALLOC freed <1K, 50% free 3027K/5959K, external 1169K/1181K, paused 24ms 03-30 15:11:44.406: E/GridDrawManager(1941): There are 3072 display items. 03-30 15:11:44.406: I/Gallery(1941): onCreate 03-30 15:11:44.406: I/Gallery(1941): request media scan 03-30 15:11:44.406: I/TiApplication(1914): (main) [280,785699] SD card has been mounted. Enabling cache for http responses. 03-30 15:11:44.413: D/Gallery(1941): onStart 03-30 15:11:44.413: D/Gallery(1941): onResume 03-30 15:11:44.437: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_MOUNTED 03-30 15:11:44.437: D/Gallery(1941): initializeDataSource 03-30 15:11:44.437: I/AmazonEmail(1971): storage path "/mnt/sdcard" mounted readOnly=true 03-30 15:11:44.452: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:11:44.499: D/libEGL(1941): loaded /system/lib/egl/libGLES_android.so 03-30 15:11:44.507: D/libEGL(1941): loaded /vendor/lib/egl/libEGL_POWERVR_SGX540_120.so 03-30 15:11:44.515: D/libEGL(1941): loaded /vendor/lib/egl/libGLESv1_CM_POWERVR_SGX540_120.so 03-30 15:11:44.523: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:11:44.523: I/LAB126(1448): window changed 03-30 15:11:44.531: D/MediaScannerService(1637): start scanning volume external 03-30 15:11:44.531: D/libEGL(1941): loaded /vendor/lib/egl/libGLESv2_POWERVR_SGX540_120.so 03-30 15:11:44.648: I/RenderView(1941): First Draw 03-30 15:11:44.695: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +1s145ms 03-30 15:11:44.695: I/ActivityManager(1386): Displayed com.cooliris.media/.Gallery: +598ms 03-30 15:11:44.718: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 15:11:44.726: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 15:11:44.765: D/MediaScanner(1637): prescan time: 24ms 03-30 15:11:44.765: D/MediaScanner(1637): scan time: 119ms 03-30 15:11:44.765: D/MediaScanner(1637): postscan time: 0ms 03-30 15:11:44.773: D/MediaScanner(1637): total time: 143ms 03-30 15:11:44.773: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_SCANNER_FINISHED 03-30 15:11:44.773: D/MediaScannerService(1637): done scanning volume external 03-30 15:11:44.921: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:11:44.921: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.001, getAccountsByTypeAndFeatures, service_lh2 03-30 15:11:45.163: I/MediaFeed(1941): Replacing media set 208900344 03-30 15:11:45.796: I/GridLayer(1941): Slot changing from -1 to -1 03-30 15:11:45.827: I/MediaFeed(1941): Replacing media set 208900344 03-30 15:11:46.179: I/GridLayer(1941): Slot changing from -1 to -1 03-30 15:11:46.195: D/skia(1941): Loading ARM decoder... 03-30 15:11:51.406: D/dalvikvm(1941): GC_EXTERNAL_ALLOC freed 151K, 48% free 3152K/5959K, external 1681K/1695K, paused 61ms 03-30 15:11:51.406: I/GridLayer(1941): Slot changing from 0 to 0 03-30 15:11:57.296: D/dalvikvm(1637): GC_EXPLICIT freed 282K, 49% free 2930K/5639K, external 847K/1181K, paused 44ms 03-30 15:12:00.234: D/Gallery(1941): onPause 03-30 15:12:00.304: I/RenderView(1941): OnPause RenderView com.cooliris.media.RenderView@405c53c8 03-30 15:12:00.320: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:12:00.320: I/LAB126(1448): window changed 03-30 15:12:00.335: D/Gallery(1941): onStop 03-30 15:12:00.351: I/Gallery(1941): onDestroy 03-30 15:12:02.343: D/dalvikvm(1386): GC_CONCURRENT freed 1196K, 51% free 5182K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:12:13.156: D/LAB126(1448): got back button softkey click! 03-30 15:12:13.156: D/LAB126(1448): collapse because of back button 03-30 15:12:13.156: D/LAB126(1448): collapse softkeys 03-30 15:12:13.468: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:12:13.468: I/LAB126(1448): window changed 03-30 15:12:13.781: E/TiBaseActivity(1914): (main) [29372,815071] Layout cleanup. 03-30 15:12:14.312: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:12:16.007: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:12:16.023: D/Window(1914): Loading window with URL: ../examples/photo_gallery.js 03-30 15:12:16.023: D/Module(1914): Loading module: ../examples/photo_gallery -> Resources/examples/photo_gallery.js 03-30 15:12:16.132: D/ActivityManager(1386): Starting: Intent { act=android.intent.action.PICK cat=[android.intent.category.DEFAULT] typ=image/* cmp=com.cooliris.media/.Gallery (has extras) } from pid 1914 03-30 15:12:16.132: W/ActivityManager(1386): Activity is launching as a new task, so cancelling activity result. 03-30 15:12:16.398: D/TiUIView(1914): (main) [2624,817695] Nativeview is null 03-30 15:12:16.398: E/TiMedia(1914): (main) [1,817696] OnResult called: 0 03-30 15:12:16.406: I/Gallery3D(1941): sending softkey config intent, config: 2, key com.cooliris.media/com.cooliris.media.Gallery 03-30 15:12:16.406: I/LAB126(1448): StatusBarService hears softkey intent. action: com.lab126.intent.ACTION_CONFIG_SOFTKEYS 03-30 15:12:16.445: D/TiUIView(1914): (main) [43,817739] Nativeview is null 03-30 15:12:16.452: E/GridDrawManager(1941): There are 3072 display items. 03-30 15:12:16.499: E/GridDrawManager(1941): There are 3072 display items. 03-30 15:12:16.507: I/Gallery(1941): onCreate 03-30 15:12:16.507: I/Gallery(1941): request media scan 03-30 15:12:16.507: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:12:16.507: I/LAB126(1448): window changed 03-30 15:12:16.554: D/Gallery(1941): onStart 03-30 15:12:16.554: D/Gallery(1941): onResume 03-30 15:12:16.617: D/Gallery(1941): initializeDataSource 03-30 15:12:16.632: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:12:16.656: I/TiApplication(1914): (main) [211,817950] SD card has been mounted. Enabling cache for http responses. 03-30 15:12:16.710: D/MediaScannerService(1637): start scanning volume external 03-30 15:12:16.757: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:12:16.757: I/LAB126(1448): window changed 03-30 15:12:16.773: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_MOUNTED 03-30 15:12:16.804: I/RenderView(1941): First Draw 03-30 15:12:16.812: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 15:12:16.843: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 15:12:16.843: D/dalvikvm(1941): GC_EXTERNAL_ALLOC freed 123K, 46% free 3294K/6023K, external 1988K/2031K, paused 30ms 03-30 15:12:16.882: D/MediaScanner(1637): prescan time: 48ms 03-30 15:12:16.882: D/MediaScanner(1637): scan time: 80ms 03-30 15:12:16.882: D/MediaScanner(1637): postscan time: 0ms 03-30 15:12:16.882: D/MediaScanner(1637): total time: 128ms 03-30 15:12:16.882: D/MediaScannerService(1637): done scanning volume external 03-30 15:12:16.929: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +912ms 03-30 15:12:16.937: I/ActivityManager(1386): Displayed com.cooliris.media/.Gallery: +525ms 03-30 15:12:16.960: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:12:16.960: I/AmazonEmail(1971): storage path "/mnt/sdcard" mounted readOnly=true 03-30 15:12:16.968: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:12:17.007: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_SCANNER_FINISHED 03-30 15:12:17.288: I/GridLayer(1941): Slot changing from 0 to -1 03-30 15:12:17.320: D/skia(1941): Loading ARM decoder... 03-30 15:12:18.304: I/GridLayer(1941): Slot changing from 0 to 0 03-30 15:12:22.367: D/dalvikvm(1971): GC_EXPLICIT freed 32K, 50% free 2988K/5959K, external 847K/1181K, paused 26ms 03-30 15:12:27.421: D/dalvikvm(1448): GC_CONCURRENT freed 700K, 48% free 3465K/6663K, external 2484K/3027K, paused 1ms+2ms 03-30 15:12:39.437: D/dalvikvm(1386): GC_CONCURRENT freed 1244K, 51% free 5240K/10567K, external 2732K/3412K, paused 6ms+13ms 03-30 15:12:39.835: D/dalvikvm(1386): GC_CONCURRENT freed 1377K, 51% free 5186K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:12:40.140: D/dalvikvm(1386): GC_CONCURRENT freed 1309K, 51% free 5186K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:12:40.437: D/dalvikvm(1386): GC_CONCURRENT freed 1291K, 51% free 5204K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:12:40.577: D/dalvikvm(1386): GC_CONCURRENT freed 1330K, 51% free 5186K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:12:40.687: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5187K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:12:40.796: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5187K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:12:40.898: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5187K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:12:41.007: D/dalvikvm(1386): GC_CONCURRENT freed 1276K, 51% free 5214K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:12:41.117: D/dalvikvm(1386): GC_CONCURRENT freed 1324K, 51% free 5206K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:12:41.179: D/dalvikvm(1386): GC_CONCURRENT freed 1349K, 52% free 5163K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:12:41.242: D/dalvikvm(1386): GC_CONCURRENT freed 1280K, 51% free 5179K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:12:41.312: D/dalvikvm(1386): GC_CONCURRENT freed 1311K, 52% free 5171K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:12:47.484: W/ProcessStats(1386): Skipping unknown process pid 2304 03-30 15:12:47.687: D/dalvikvm(1941): GC_CONCURRENT freed 136K, 45% free 3325K/6023K, external 2153K/2485K, paused 5ms+6ms 03-30 15:13:14.304: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:13:22.624: I/ChargeProtectionService(1386): Battery discharging, resuming charging 03-30 15:13:41.507: D/dalvikvm(1386): GC_CONCURRENT freed 1268K, 51% free 5197K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:13:41.773: D/dalvikvm(1386): GC_CONCURRENT freed 1330K, 51% free 5179K/10567K, external 2732K/3412K, paused 6ms+3ms 03-30 15:13:41.913: D/dalvikvm(1386): GC_CONCURRENT freed 1281K, 51% free 5197K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:13:42.046: D/dalvikvm(1386): GC_CONCURRENT freed 1328K, 51% free 5179K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:13:42.187: D/dalvikvm(1386): GC_CONCURRENT freed 1273K, 51% free 5213K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:13:42.327: D/dalvikvm(1386): GC_CONCURRENT freed 1349K, 51% free 5180K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:13:42.452: D/dalvikvm(1386): GC_CONCURRENT freed 1306K, 52% free 5172K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:13:42.593: D/dalvikvm(1386): GC_CONCURRENT freed 1298K, 51% free 5179K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:13:42.726: D/dalvikvm(1386): GC_CONCURRENT freed 1287K, 51% free 5199K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:13:42.835: D/dalvikvm(1386): GC_CONCURRENT freed 1303K, 51% free 5204K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:13:42.945: D/dalvikvm(1386): GC_CONCURRENT freed 1332K, 52% free 5177K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:13:43.015: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 52% free 5164K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:13:43.101: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 51% free 5180K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:13:52.820: D/dalvikvm(1386): GC_CONCURRENT freed 1251K, 52% free 5128K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:14:14.312: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:14:17.210: I/GridLayer(1941): Slot changing from 0 to 0 03-30 15:14:18.984: D/Gallery(1941): onPause 03-30 15:14:19.054: I/RenderView(1941): OnPause RenderView com.cooliris.media.RenderView@40584170 03-30 15:14:19.109: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:14:19.109: I/LAB126(1448): window changed 03-30 15:14:19.156: D/Gallery(1941): onStop 03-30 15:14:19.179: I/Gallery(1941): onDestroy 03-30 15:14:28.007: D/dalvikvm(1941): GC_EXPLICIT freed 234K, 46% free 3282K/6023K, external 2129K/2485K, paused 74ms 03-30 15:14:43.288: D/dalvikvm(1386): GC_CONCURRENT freed 1190K, 51% free 5232K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:14:43.406: D/dalvikvm(1386): GC_CONCURRENT freed 1379K, 52% free 5167K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:14:43.515: D/dalvikvm(1386): GC_CONCURRENT freed 1297K, 52% free 5174K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:14:43.624: D/dalvikvm(1386): GC_CONCURRENT freed 1271K, 51% free 5208K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:14:43.734: D/dalvikvm(1386): GC_CONCURRENT freed 1348K, 52% free 5174K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:14:43.835: D/dalvikvm(1386): GC_CONCURRENT freed 1305K, 52% free 5174K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:14:43.945: D/dalvikvm(1386): GC_CONCURRENT freed 1306K, 52% free 5174K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:14:44.054: D/dalvikvm(1386): GC_CONCURRENT freed 1305K, 52% free 5174K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:14:44.140: D/dalvikvm(1386): GC_CONCURRENT freed 1277K, 51% free 5186K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:14:44.234: D/dalvikvm(1386): GC_CONCURRENT freed 1342K, 52% free 5153K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:14:44.304: D/dalvikvm(1386): GC_CONCURRENT freed 1264K, 52% free 5174K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:14:44.359: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 51% free 5191K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:14:44.437: D/dalvikvm(1386): GC_CONCURRENT freed 1338K, 52% free 5151K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:15:14.312: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:15:19.077: D/LAB126(1448): got back button softkey click! 03-30 15:15:19.077: D/LAB126(1448): collapse because of back button 03-30 15:15:19.077: D/LAB126(1448): collapse softkeys 03-30 15:15:19.265: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:15:19.265: I/LAB126(1448): window changed 03-30 15:15:19.867: E/TiBaseActivity(1914): (main) [183216,1001166] Layout cleanup. 03-30 15:15:44.656: D/dalvikvm(1386): GC_CONCURRENT freed 1251K, 51% free 5200K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:15:44.960: D/dalvikvm(1386): GC_CONCURRENT freed 1341K, 52% free 5171K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:15:45.265: D/dalvikvm(1386): GC_CONCURRENT freed 1287K, 51% free 5189K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:15:45.570: D/dalvikvm(1386): GC_CONCURRENT freed 1326K, 52% free 5171K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:15:45.874: D/dalvikvm(1386): GC_CONCURRENT freed 1287K, 51% free 5189K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:15:46.171: D/dalvikvm(1386): GC_CONCURRENT freed 1331K, 52% free 5165K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:15:46.468: D/dalvikvm(1386): GC_CONCURRENT freed 1278K, 51% free 5189K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:15:46.765: D/dalvikvm(1386): GC_CONCURRENT freed 1327K, 52% free 5172K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:15:46.999: D/dalvikvm(1386): GC_CONCURRENT freed 1309K, 52% free 5168K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:15:47.273: D/dalvikvm(1386): GC_CONCURRENT freed 1292K, 52% free 5166K/10567K, external 2732K/3412K, paused 7ms+8ms 03-30 15:15:47.421: D/dalvikvm(1386): GC_CONCURRENT freed 1298K, 52% free 5172K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:15:47.577: D/dalvikvm(1386): GC_CONCURRENT freed 1294K, 52% free 5172K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:15:47.726: D/dalvikvm(1386): GC_CONCURRENT freed 1313K, 52% free 5163K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:16:14.312: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:16:47.999: D/dalvikvm(1386): GC_CONCURRENT freed 1263K, 51% free 5202K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:16:48.312: D/dalvikvm(1386): GC_CONCURRENT freed 1327K, 51% free 5188K/10567K, external 2732K/3412K, paused 6ms+8ms 03-30 15:16:48.617: D/dalvikvm(1386): GC_CONCURRENT freed 1326K, 52% free 5170K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:16:48.913: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 52% free 5170K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:16:49.218: D/dalvikvm(1386): GC_CONCURRENT freed 1305K, 52% free 5170K/10567K, external 2732K/3412K, paused 7ms+10ms 03-30 15:16:49.468: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 52% free 5171K/10567K, external 2732K/3412K, paused 6ms+3ms 03-30 15:16:49.577: D/dalvikvm(1386): GC_CONCURRENT freed 1306K, 52% free 5170K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:16:49.687: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 52% free 5171K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:16:49.773: D/dalvikvm(1386): GC_CONCURRENT freed 1267K, 51% free 5208K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:16:49.882: D/dalvikvm(1386): GC_CONCURRENT freed 1378K, 52% free 5142K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:16:49.952: D/dalvikvm(1386): GC_CONCURRENT freed 1257K, 52% free 5171K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:16:50.023: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 51% free 5187K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:16:50.109: D/dalvikvm(1386): GC_CONCURRENT freed 1312K, 52% free 5164K/10567K, external 2732K/3412K, paused 3ms+5ms 03-30 15:16:56.429: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:16:56.460: D/Window(1914): Loading window with URL: ../examples/photo_gallery.js 03-30 15:16:56.468: D/Module(1914): Loading module: ../examples/photo_gallery -> Resources/examples/photo_gallery.js 03-30 15:16:56.577: D/ActivityManager(1386): Starting: Intent { act=android.intent.action.PICK cat=[android.intent.category.DEFAULT] typ=image/* cmp=com.cooliris.media/.Gallery (has extras) } from pid 1914 03-30 15:16:56.577: W/ActivityManager(1386): Activity is launching as a new task, so cancelling activity result. 03-30 15:16:56.671: D/TiUIView(1914): (main) [96805,1097971] Nativeview is null 03-30 15:16:56.843: E/TiMedia(1914): (main) [172,1098143] OnResult called: 0 03-30 15:16:56.851: I/Gallery3D(1941): sending softkey config intent, config: 2, key com.cooliris.media/com.cooliris.media.Gallery 03-30 15:16:56.859: I/LAB126(1448): StatusBarService hears softkey intent. action: com.lab126.intent.ACTION_CONFIG_SOFTKEYS 03-30 15:16:56.867: D/TiUIView(1914): (main) [22,1098165] Nativeview is null 03-30 15:16:56.874: E/GridDrawManager(1941): There are 3072 display items. 03-30 15:16:56.890: E/GridDrawManager(1941): There are 3072 display items. 03-30 15:16:56.890: I/Gallery(1941): onCreate 03-30 15:16:56.898: I/Gallery(1941): request media scan 03-30 15:16:56.906: D/Gallery(1941): onStart 03-30 15:16:56.906: D/Gallery(1941): onResume 03-30 15:16:56.906: I/TiApplication(1914): (main) [40,1098205] SD card has been mounted. Enabling cache for http responses. 03-30 15:16:56.906: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:16:56.906: I/LAB126(1448): window changed 03-30 15:16:56.937: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_MOUNTED 03-30 15:16:56.937: D/Gallery(1941): initializeDataSource 03-30 15:16:56.945: I/AmazonEmail(1971): storage path "/mnt/sdcard" mounted readOnly=true 03-30 15:16:56.945: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:16:57.023: D/MediaScannerService(1637): start scanning volume external 03-30 15:16:57.046: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:16:57.046: I/LAB126(1448): window changed 03-30 15:16:57.085: I/RenderView(1941): First Draw 03-30 15:16:57.117: D/dalvikvm(1941): GC_EXTERNAL_ALLOC freed 45K, 43% free 3470K/6087K, external 2251K/2472K, paused 32ms 03-30 15:16:57.210: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +771ms 03-30 15:16:57.210: I/ActivityManager(1386): Displayed com.cooliris.media/.Gallery: +360ms 03-30 15:16:57.234: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 15:16:57.234: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 15:16:57.242: D/MediaScanner(1637): prescan time: 49ms 03-30 15:16:57.242: D/MediaScanner(1637): scan time: 95ms 03-30 15:16:57.242: D/MediaScanner(1637): postscan time: 0ms 03-30 15:16:57.242: D/MediaScanner(1637): total time: 144ms 03-30 15:16:57.249: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_SCANNER_FINISHED 03-30 15:16:57.249: D/MediaScannerService(1637): done scanning volume external 03-30 15:16:57.421: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:16:57.429: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.001, getAccountsByTypeAndFeatures, service_lh2 03-30 15:16:57.663: I/GridLayer(1941): Slot changing from 0 to -1 03-30 15:16:57.695: D/skia(1941): Loading ARM decoder... 03-30 15:16:58.687: I/GridLayer(1941): Slot changing from 0 to 0 03-30 15:17:01.992: I/GridLayer(1941): Slot changing from 0 to 0 03-30 15:17:05.007: D/Gallery(1941): onPause 03-30 15:17:05.085: I/RenderView(1941): OnPause RenderView com.cooliris.media.RenderView@40566b90 03-30 15:17:05.132: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:17:05.132: I/LAB126(1448): window changed 03-30 15:17:05.195: D/Gallery(1941): onStop 03-30 15:17:05.218: I/Gallery(1941): onDestroy 03-30 15:17:14.320: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:17:24.210: D/dalvikvm(1637): GC_EXPLICIT freed 199K, 49% free 2898K/5639K, external 847K/1181K, paused 31ms 03-30 15:17:39.335: D/dalvikvm(1971): GC_EXPLICIT freed 10K, 50% free 2980K/5959K, external 847K/1181K, paused 70ms 03-30 15:17:44.374: D/dalvikvm(1941): GC_EXPLICIT freed 121K, 43% free 3500K/6087K, external 2826K/3111K, paused 85ms 03-30 15:17:49.452: D/LAB126(1448): got back button softkey click! 03-30 15:17:49.452: D/LAB126(1448): collapse because of back button 03-30 15:17:49.452: D/LAB126(1448): collapse softkeys 03-30 15:17:49.632: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:17:49.632: I/LAB126(1448): window changed 03-30 15:17:50.304: E/TiBaseActivity(1914): (main) [53393,1151598] Layout cleanup. 03-30 15:17:50.351: D/dalvikvm(1386): GC_CONCURRENT freed 1120K, 51% free 5246K/10567K, external 2732K/3412K, paused 7ms+11ms 03-30 15:17:50.577: D/dalvikvm(1386): GC_CONCURRENT freed 1392K, 52% free 5177K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:17:50.687: D/dalvikvm(1386): GC_CONCURRENT freed 1306K, 52% free 5177K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:17:50.867: D/dalvikvm(1386): GC_CONCURRENT freed 1288K, 51% free 5195K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:17:51.007: D/dalvikvm(1386): GC_CONCURRENT freed 1329K, 52% free 5177K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:17:51.117: D/dalvikvm(1386): GC_CONCURRENT freed 1306K, 52% free 5177K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:17:51.218: D/dalvikvm(1386): GC_CONCURRENT freed 1307K, 52% free 5177K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:17:51.327: D/dalvikvm(1386): GC_CONCURRENT freed 1305K, 52% free 5177K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:17:51.421: D/dalvikvm(1386): GC_CONCURRENT freed 1310K, 52% free 5163K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:17:51.523: D/dalvikvm(1386): GC_CONCURRENT freed 1298K, 52% free 5155K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:17:51.585: D/dalvikvm(1386): GC_CONCURRENT freed 1301K, 52% free 5153K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:17:51.640: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 52% free 5169K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:17:51.710: D/dalvikvm(1386): GC_CONCURRENT freed 1294K, 51% free 5178K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:18:14.320: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:18:19.757: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:18:19.773: D/Window(1914): Loading window with URL: ../examples/photo_gallery.js 03-30 15:18:19.773: D/Module(1914): Loading module: ../examples/photo_gallery -> Resources/examples/photo_gallery.js 03-30 15:18:19.882: D/ActivityManager(1386): Starting: Intent { act=android.intent.action.PICK cat=[android.intent.category.DEFAULT] typ=image/* cmp=com.cooliris.media/.Gallery (has extras) } from pid 1914 03-30 15:18:19.882: W/ActivityManager(1386): Activity is launching as a new task, so cancelling activity result. 03-30 15:18:19.929: D/TiUIView(1914): (main) [29630,1181228] Nativeview is null 03-30 15:18:19.929: E/TiMedia(1914): (main) [1,1181229] OnResult called: 0 03-30 15:18:20.179: I/Gallery3D(1941): sending softkey config intent, config: 2, key com.cooliris.media/com.cooliris.media.Gallery 03-30 15:18:20.179: I/LAB126(1448): StatusBarService hears softkey intent. action: com.lab126.intent.ACTION_CONFIG_SOFTKEYS 03-30 15:18:20.195: D/TiUIView(1914): (main) [257,1181486] Nativeview is null 03-30 15:18:20.202: E/GridDrawManager(1941): There are 3072 display items. 03-30 15:18:20.226: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:18:20.226: I/LAB126(1448): window changed 03-30 15:18:20.242: E/GridDrawManager(1941): There are 3072 display items. 03-30 15:18:20.249: I/Gallery(1941): onCreate 03-30 15:18:20.249: I/Gallery(1941): request media scan 03-30 15:18:20.257: D/Gallery(1941): onStart 03-30 15:18:20.257: D/Gallery(1941): onResume 03-30 15:18:20.265: I/TiApplication(1914): (main) [69,1181555] SD card has been mounted. Enabling cache for http responses. 03-30 15:18:20.273: D/Gallery(1941): initializeDataSource 03-30 15:18:20.281: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:18:20.343: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:18:20.343: I/LAB126(1448): window changed 03-30 15:18:20.351: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_MOUNTED 03-30 15:18:20.367: D/MediaScannerService(1637): start scanning volume external 03-30 15:18:20.398: I/RenderView(1941): First Draw 03-30 15:18:20.413: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 15:18:20.421: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 15:18:20.429: D/MediaScanner(1637): prescan time: 32ms 03-30 15:18:20.429: D/MediaScanner(1637): scan time: 27ms 03-30 15:18:20.429: D/MediaScanner(1637): postscan time: 0ms 03-30 15:18:20.429: D/MediaScanner(1637): total time: 59ms 03-30 15:18:20.429: D/MediaScannerService(1637): done scanning volume external 03-30 15:18:20.499: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +735ms 03-30 15:18:20.499: I/ActivityManager(1386): Displayed com.cooliris.media/.Gallery: +329ms 03-30 15:18:20.546: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:18:20.562: I/AmazonEmail(1971): storage path "/mnt/sdcard" mounted readOnly=true 03-30 15:18:20.585: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:18:20.601: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_SCANNER_FINISHED 03-30 15:18:20.890: I/GridLayer(1941): Slot changing from 0 to -1 03-30 15:18:20.999: D/dalvikvm(1941): GC_EXTERNAL_ALLOC freed 132K, 42% free 3686K/6279K, external 3093K/3111K, paused 41ms 03-30 15:18:21.015: D/skia(1941): Loading ARM decoder... 03-30 15:18:21.327: I/GridLayer(1941): Slot changing from 0 to 0 03-30 15:18:22.835: I/GridLayer(1941): Slot changing from 0 to 0 03-30 15:18:24.499: I/ChargeProtectionService(1386): Battery discharging, resuming charging 03-30 15:18:25.546: D/Gallery(1941): onPause 03-30 15:18:25.624: I/RenderView(1941): OnPause RenderView com.cooliris.media.RenderView@405902a8 03-30 15:18:25.679: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:18:25.679: I/LAB126(1448): window changed 03-30 15:18:25.726: D/Gallery(1941): onStop 03-30 15:18:25.749: I/Gallery(1941): onDestroy 03-30 15:18:25.968: D/dalvikvm(1386): GC_CONCURRENT freed 1191K, 52% free 5171K/10567K, external 2732K/3412K, paused 7ms+10ms 03-30 15:18:52.015: D/dalvikvm(1386): GC_CONCURRENT freed 1281K, 51% free 5195K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:18:52.320: D/dalvikvm(1386): GC_CONCURRENT freed 1322K, 51% free 5184K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:18:52.507: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5185K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:18:52.617: D/dalvikvm(1386): GC_CONCURRENT freed 1309K, 51% free 5184K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:18:52.726: D/dalvikvm(1386): GC_CONCURRENT freed 1300K, 51% free 5193K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:18:52.835: D/dalvikvm(1386): GC_CONCURRENT freed 1319K, 51% free 5185K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:18:52.945: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5185K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:18:53.054: D/dalvikvm(1386): GC_CONCURRENT freed 1309K, 51% free 5184K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:18:53.140: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 51% free 5189K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:18:53.218: D/dalvikvm(1386): GC_CONCURRENT freed 1297K, 51% free 5198K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:18:53.281: D/dalvikvm(1386): GC_CONCURRENT freed 1307K, 51% free 5202K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:18:53.343: D/dalvikvm(1386): GC_CONCURRENT freed 1320K, 51% free 5186K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:18:59.843: D/dalvikvm(1386): GC_CONCURRENT freed 1233K, 52% free 5149K/10567K, external 2732K/3412K, paused 7ms+8ms 03-30 15:19:14.320: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:19:53.499: D/dalvikvm(1386): GC_CONCURRENT freed 1232K, 51% free 5209K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:19:53.781: D/dalvikvm(1386): GC_CONCURRENT freed 1339K, 51% free 5184K/10567K, external 2732K/3412K, paused 6ms+3ms 03-30 15:19:53.890: D/dalvikvm(1386): GC_CONCURRENT freed 1307K, 51% free 5184K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:19:53.999: D/dalvikvm(1386): GC_CONCURRENT freed 1307K, 51% free 5186K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:19:54.109: D/dalvikvm(1386): GC_CONCURRENT freed 1310K, 51% free 5184K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:19:54.249: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 51% free 5202K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:19:54.390: D/dalvikvm(1386): GC_CONCURRENT freed 1331K, 51% free 5184K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:19:54.523: D/dalvikvm(1386): GC_CONCURRENT freed 1307K, 51% free 5184K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:19:54.640: D/dalvikvm(1386): GC_CONCURRENT freed 1283K, 51% free 5206K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:19:54.757: D/dalvikvm(1386): GC_CONCURRENT freed 1345K, 52% free 5163K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:19:54.843: D/dalvikvm(1386): GC_CONCURRENT freed 1282K, 52% free 5177K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:19:54.921: D/dalvikvm(1386): GC_CONCURRENT freed 1310K, 52% free 5169K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:19:54.999: D/dalvikvm(1386): GC_CONCURRENT freed 1313K, 52% free 5159K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:20:14.327: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:20:55.140: D/dalvikvm(1386): GC_CONCURRENT freed 1256K, 51% free 5205K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:20:55.265: D/dalvikvm(1386): GC_CONCURRENT freed 1333K, 51% free 5185K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:20:55.374: D/dalvikvm(1386): GC_CONCURRENT freed 1291K, 51% free 5203K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:20:55.484: D/dalvikvm(1386): GC_CONCURRENT freed 1331K, 51% free 5185K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:20:55.593: D/dalvikvm(1386): GC_CONCURRENT freed 1274K, 51% free 5219K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:20:55.820: D/dalvikvm(1386): GC_CONCURRENT freed 1317K, 51% free 5219K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:20:56.124: D/dalvikvm(1386): GC_CONCURRENT freed 1351K, 51% free 5185K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:20:56.437: D/dalvikvm(1386): GC_CONCURRENT freed 1306K, 51% free 5188K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:20:56.671: D/dalvikvm(1386): GC_CONCURRENT freed 1313K, 51% free 5181K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:20:56.929: D/dalvikvm(1386): GC_CONCURRENT freed 1324K, 52% free 5156K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:20:57.093: D/dalvikvm(1386): GC_CONCURRENT freed 1256K, 51% free 5186K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:20:57.249: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 51% free 5202K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:20:57.398: D/dalvikvm(1386): GC_CONCURRENT freed 1352K, 52% free 5153K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:21:14.320: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:21:46.445: I/dalvikvm(1386): Total arena pages for JIT: 11 03-30 15:21:46.445: I/dalvikvm(1386): Total arena pages for JIT: 12 03-30 15:21:57.617: D/dalvikvm(1386): GC_CONCURRENT freed 1244K, 51% free 5209K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:21:57.913: D/dalvikvm(1386): GC_CONCURRENT freed 1339K, 51% free 5185K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:21:58.218: D/dalvikvm(1386): GC_CONCURRENT freed 1309K, 51% free 5185K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:21:58.523: D/dalvikvm(1386): GC_CONCURRENT freed 1290K, 51% free 5203K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:21:58.648: D/dalvikvm(1386): GC_CONCURRENT freed 1330K, 51% free 5185K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:21:58.757: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5185K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:21:58.867: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5186K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:21:58.968: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5186K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:21:59.062: D/dalvikvm(1386): GC_CONCURRENT freed 1299K, 51% free 5196K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:21:59.163: D/dalvikvm(1386): GC_CONCURRENT freed 1333K, 52% free 5164K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:21:59.218: D/dalvikvm(1386): GC_CONCURRENT freed 1282K, 52% free 5178K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:21:59.288: D/dalvikvm(1386): GC_CONCURRENT freed 1294K, 51% free 5186K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:21:59.359: D/dalvikvm(1386): GC_CONCURRENT freed 1295K, 51% free 5186K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:22:14.320: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:22:59.577: D/dalvikvm(1386): GC_CONCURRENT freed 1288K, 51% free 5206K/10567K, external 2732K/3412K, paused 7ms+10ms 03-30 15:22:59.882: D/dalvikvm(1386): GC_CONCURRENT freed 1334K, 51% free 5186K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:23:00.195: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5187K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:23:00.499: D/dalvikvm(1386): GC_CONCURRENT freed 1292K, 51% free 5204K/10567K, external 2732K/3412K, paused 6ms+8ms 03-30 15:23:00.796: D/dalvikvm(1386): GC_CONCURRENT freed 1330K, 51% free 5186K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:23:01.093: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5187K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:23:01.390: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5187K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:23:01.687: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5187K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:23:01.937: D/dalvikvm(1386): GC_CONCURRENT freed 1298K, 51% free 5197K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:23:02.226: D/dalvikvm(1386): GC_CONCURRENT freed 1331K, 52% free 5175K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:23:02.390: D/dalvikvm(1386): GC_CONCURRENT freed 1278K, 51% free 5187K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:23:02.546: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 51% free 5203K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:23:02.695: D/dalvikvm(1386): GC_CONCURRENT freed 1336K, 51% free 5179K/10567K, external 2732K/3412K, paused 7ms+10ms 03-30 15:23:14.335: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:23:27.101: I/ChargeProtectionService(1386): Battery discharging, resuming charging 03-30 15:24:02.882: D/dalvikvm(1386): GC_CONCURRENT freed 1251K, 51% free 5235K/10567K, external 2732K/3412K, paused 6ms+3ms 03-30 15:24:02.992: D/dalvikvm(1386): GC_CONCURRENT freed 1350K, 51% free 5206K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:24:03.109: D/dalvikvm(1386): GC_CONCURRENT freed 1331K, 51% free 5188K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:24:03.218: D/dalvikvm(1386): GC_CONCURRENT freed 1329K, 52% free 5165K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:24:03.327: D/dalvikvm(1386): GC_CONCURRENT freed 1280K, 51% free 5188K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:24:03.437: D/dalvikvm(1386): GC_CONCURRENT freed 1309K, 51% free 5189K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:24:03.538: D/dalvikvm(1386): GC_CONCURRENT freed 1309K, 51% free 5189K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:24:03.648: D/dalvikvm(1386): GC_CONCURRENT freed 1309K, 51% free 5189K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:24:03.749: D/dalvikvm(1386): GC_CONCURRENT freed 1308K, 51% free 5183K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:24:03.851: D/dalvikvm(1386): GC_CONCURRENT freed 1282K, 51% free 5209K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:24:03.992: D/dalvikvm(1386): GC_CONCURRENT freed 1318K, 51% free 5189K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:24:04.062: D/dalvikvm(1386): GC_CONCURRENT freed 1295K, 51% free 5189K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:24:04.132: D/dalvikvm(1386): GC_CONCURRENT freed 1294K, 51% free 5189K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:24:14.335: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:24:56.249: D/LAB126(1448): got back button softkey click! 03-30 15:24:56.249: D/LAB126(1448): collapse because of back button 03-30 15:24:56.249: D/LAB126(1448): collapse softkeys 03-30 15:24:56.468: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:24:56.468: I/LAB126(1448): window changed 03-30 15:24:56.492: D/dalvikvm(1914): GC_CONCURRENT freed 883K, 42% free 4773K/8135K, external 1344K/1695K, paused 3ms+16ms 03-30 15:24:56.640: E/TiBaseActivity(1914): (main) [396381,1577936] Layout cleanup. 03-30 15:24:58.288: D/ActivityManager(1386): Starting: Intent { cmp=com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity (has extras) } from pid 1914 03-30 15:24:58.288: D/Window(1914): Loading window with URL: ../examples/photo_gallery.js 03-30 15:24:58.304: D/Module(1914): Loading module: ../examples/photo_gallery -> Resources/examples/photo_gallery.js 03-30 15:24:58.406: D/ActivityManager(1386): Starting: Intent { act=android.intent.action.PICK cat=[android.intent.category.DEFAULT] typ=image/* cmp=com.cooliris.media/.Gallery (has extras) } from pid 1914 03-30 15:24:58.406: W/ActivityManager(1386): Activity is launching as a new task, so cancelling activity result. 03-30 15:24:58.460: D/TiUIView(1914): (main) [1817,1579753] Nativeview is null 03-30 15:24:58.523: E/TiMedia(1914): (main) [59,1579812] OnResult called: 0 03-30 15:24:58.710: I/Gallery3D(1941): sending softkey config intent, config: 2, key com.cooliris.media/com.cooliris.media.Gallery 03-30 15:24:58.718: I/LAB126(1448): StatusBarService hears softkey intent. action: com.lab126.intent.ACTION_CONFIG_SOFTKEYS 03-30 15:24:58.726: D/TiUIView(1914): (main) [207,1580019] Nativeview is null 03-30 15:24:58.734: E/GridDrawManager(1941): There are 3072 display items. 03-30 15:24:58.757: E/GridDrawManager(1941): There are 3072 display items. 03-30 15:24:58.757: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:24:58.757: I/LAB126(1448): window changed 03-30 15:24:58.773: I/Gallery(1941): onCreate 03-30 15:24:58.773: I/Gallery(1941): request media scan 03-30 15:24:58.781: D/Gallery(1941): onStart 03-30 15:24:58.781: D/Gallery(1941): onResume 03-30 15:24:58.796: I/TiApplication(1914): (main) [72,1580091] SD card has been mounted. Enabling cache for http responses. 03-30 15:24:58.804: D/Gallery(1941): initializeDataSource 03-30 15:24:58.812: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:24:58.874: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:24:58.874: I/LAB126(1448): window changed 03-30 15:24:58.882: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_MOUNTED 03-30 15:24:58.898: D/MediaScannerService(1637): start scanning volume external 03-30 15:24:58.929: I/RenderView(1941): First Draw 03-30 15:24:58.945: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 15:24:58.968: D/dalvikvm(1941): GC_EXTERNAL_ALLOC freed 123K, 40% free 3846K/6407K, external 3603K/3838K, paused 37ms 03-30 15:24:58.968: D/MediaScanner(1637): found .nomedia, skipping directory 03-30 15:24:58.992: D/MediaScanner(1637): prescan time: 23ms 03-30 15:24:58.992: D/MediaScanner(1637): scan time: 67ms 03-30 15:24:58.992: D/MediaScanner(1637): postscan time: 0ms 03-30 15:24:58.992: D/MediaScanner(1637): total time: 90ms 03-30 15:24:58.999: D/MediaScannerService(1637): done scanning volume external 03-30 15:24:59.038: I/ActivityManager(1386): Displayed com.appcelerator.kitchensinknook/org.appcelerator.titanium.TiActivity: +753ms 03-30 15:24:59.038: I/ActivityManager(1386): Displayed com.cooliris.media/.Gallery: +338ms 03-30 15:24:59.062: I/AmazonEmail(1971): storage path "/mnt/sdcard" mounted readOnly=true 03-30 15:24:59.077: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:24:59.077: D/AccountManagerService(1386): bind attempt failed for Session: expectLaunch false, connected false, stats (0/0/0), lifetime 0.0, getAccountsByTypeAndFeatures, service_lh2 03-30 15:24:59.117: I/BootReceiver(1941): Got intent with action android.intent.action.MEDIA_SCANNER_FINISHED 03-30 15:24:59.179: D/dalvikvm(1386): GC_CONCURRENT freed 1255K, 51% free 5187K/10567K, external 2732K/3412K, paused 2ms+5ms 03-30 15:24:59.429: I/GridLayer(1941): Slot changing from 0 to -1 03-30 15:24:59.452: D/skia(1941): Loading ARM decoder... 03-30 15:25:00.452: I/GridLayer(1941): Slot changing from 0 to 0 03-30 15:25:04.101: D/Gallery(1941): onPause 03-30 15:25:04.163: I/RenderView(1941): OnPause RenderView com.cooliris.media.RenderView@406225d8 03-30 15:25:04.179: I/LAB126(1448): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED 03-30 15:25:04.179: I/LAB126(1448): window changed 03-30 15:25:04.210: D/Gallery(1941): onStop 03-30 15:25:04.218: I/Gallery(1941): onDestroy 03-30 15:25:04.351: D/dalvikvm(1386): GC_CONCURRENT freed 1288K, 51% free 5208K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:25:04.484: D/dalvikvm(1386): GC_CONCURRENT freed 1314K, 51% free 5209K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:25:04.609: D/dalvikvm(1386): GC_CONCURRENT freed 1334K, 51% free 5189K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:25:04.726: D/dalvikvm(1386): GC_CONCURRENT freed 1275K, 51% free 5223K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:25:04.835: D/dalvikvm(1386): GC_CONCURRENT freed 1351K, 51% free 5190K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:25:04.945: D/dalvikvm(1386): GC_CONCURRENT freed 1285K, 51% free 5214K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:25:05.054: D/dalvikvm(1386): GC_CONCURRENT freed 1341K, 51% free 5189K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:25:05.163: D/dalvikvm(1386): GC_CONCURRENT freed 1305K, 51% free 5182K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:25:05.249: D/dalvikvm(1386): GC_CONCURRENT freed 1279K, 51% free 5211K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:25:05.327: D/dalvikvm(1386): GC_CONCURRENT freed 1341K, 51% free 5179K/10567K, external 2732K/3412K, paused 2ms+4ms 03-30 15:25:05.398: D/dalvikvm(1386): GC_CONCURRENT freed 1292K, 51% free 5190K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:25:05.460: D/dalvikvm(1386): GC_CONCURRENT freed 1280K, 51% free 5206K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:25:12.859: D/dalvikvm(1637): GC_EXPLICIT freed 137K, 49% free 2924K/5639K, external 847K/1181K, paused 61ms 03-30 15:25:14.327: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:25:22.874: D/dalvikvm(1971): GC_EXPLICIT freed 5K, 51% free 2979K/5959K, external 847K/1181K, paused 60ms 03-30 15:25:27.921: D/dalvikvm(1941): GC_EXPLICIT freed 118K, 41% free 3865K/6471K, external 3871K/4406K, paused 100ms 03-30 15:25:32.890: W/ProcessStats(1386): Skipping unknown process pid 2503 03-30 15:25:32.976: D/dalvikvm(1386): GC_CONCURRENT freed 1293K, 52% free 5150K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:26:05.835: D/dalvikvm(1386): GC_CONCURRENT freed 1237K, 51% free 5212K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:26:06.140: D/dalvikvm(1386): GC_CONCURRENT freed 1332K, 51% free 5195K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:26:06.429: D/dalvikvm(1386): GC_CONCURRENT freed 1328K, 52% free 5178K/10567K, external 2732K/3412K, paused 7ms+4ms 03-30 15:26:06.538: D/dalvikvm(1386): GC_CONCURRENT freed 1288K, 51% free 5196K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:26:06.640: D/dalvikvm(1386): GC_CONCURRENT freed 1329K, 52% free 5178K/10567K, external 2732K/3412K, paused 2ms+3ms 03-30 15:26:06.757: D/dalvikvm(1386): GC_CONCURRENT freed 1272K, 51% free 5212K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:26:06.890: D/dalvikvm(1386): GC_CONCURRENT freed 1350K, 52% free 5177K/10567K, external 2732K/3412K, paused 3ms+4ms 03-30 15:26:07.015: D/dalvikvm(1386): GC_CONCURRENT freed 1298K, 51% free 5180K/10567K, external 2732K/3412K, paused 3ms+3ms 03-30 15:26:07.140: D/dalvikvm(1386): GC_CONCURRENT freed 1305K, 51% free 5182K/10567K, external 2732K/3412K, paused 4ms+5ms 03-30 15:26:07.257: D/dalvikvm(1386): GC_CONCURRENT freed 1331K, 52% free 5158K/10567K, external 2732K/3412K, paused 3ms+5ms 03-30 15:26:07.343: D/dalvikvm(1386): GC_CONCURRENT freed 1284K, 52% free 5170K/10567K, external 2732K/3412K, paused 3ms+6ms 03-30 15:26:07.429: D/dalvikvm(1386): GC_CONCURRENT freed 1310K, 52% free 5162K/10567K, external 2732K/3412K, paused 3ms+5ms 03-30 15:26:14.335: V/DeviceStorageMonitorService(1386): mTotalMemory is 11734999 03-30 15:26:28.257: D/dalvikvm(1386): GC_CONCURRENT freed 1231K, 52% free 5138K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:27:07.781: D/dalvikvm(1386): GC_CONCURRENT freed 1243K, 51% free 5191K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:27:08.085: D/dalvikvm(1386): GC_CONCURRENT freed 1323K, 51% free 5178K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:27:08.406: D/dalvikvm(1386): GC_CONCURRENT freed 1306K, 51% free 5179K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:27:08.710: D/dalvikvm(1386): GC_CONCURRENT freed 1304K, 51% free 5181K/10567K, external 2732K/3412K, paused 7ms+9ms 03-30 15:27:09.015: D/dalvikvm(1386): GC_CONCURRENT freed 1336K, 52% free 5147K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:27:09.304: D/dalvikvm(1386): GC_CONCURRENT freed 1266K, 51% free 5179K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:27:09.609: D/dalvikvm(1386): GC_CONCURRENT freed 1289K, 51% free 5196K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:27:09.906: D/dalvikvm(1386): GC_CONCURRENT freed 1328K, 51% free 5179K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:27:10.124: D/dalvikvm(1386): GC_CONCURRENT freed 1302K, 51% free 5183K/10567K, external 2732K/3412K, paused 6ms+10ms 03-30 15:27:10.359: D/dalvikvm(1386): GC_CONCURRENT freed 1327K, 52% free 5150K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:27:10.515: D/dalvikvm(1386): GC_CONCURRENT freed 1266K, 51% free 5179K/10567K, external 2732K/3412K, paused 6ms+9ms 03-30 15:27:10.671: D/dalvikvm(1386): GC_CONCURRENT freed 1310K, 52% free 5163K/10567K, external 2732K/3412K, paused 6ms+9ms