Thanks for your prompt reply. That is what exactly its happening. It is not able to read the file properly. Actually i tried the same logic for reading the excel data as a java program where it is running properly. I don't know why it is happening.
here is the log file details:
03-01 11:54:02.810: INFO/ActivityThread(165): Publishing provider contacts;com.android.contacts: com.android.providers.contacts.ContactsProvider2
03-01 11:54:02.861: DEBUG/OtaStartupReceiver(124): Not a CDMA phone, no need to process OTA
03-01 11:54:03.501: INFO/SearchManagerService(62): Building list of searchable activities
03-01 11:54:04.571: DEBUG/MobileDataStateTracker(62): default Received state= DISCONNECTED, old= DISCONNECTED, reason= radioTurnedOff, apnTypeList= default
03-01 11:54:04.991: DEBUG/MobileDataStateTracker(62): default Received state= DISCONNECTED, old= DISCONNECTED, reason= gprsDetached, apnTypeList= default
03-01 11:54:06.051: DEBUG/dalvikvm(124): GC_FOR_MALLOC freed 3621 objects / 220880 bytes in 1171ms
03-01 11:54:07.041: DEBUG/dalvikvm(62): GREF has increased to 201
03-01 11:54:07.350: INFO/ActivityManager(62): Start proc android.process.media for broadcast com.android.providers.downloads/.DownloadReceiver: pid=180 uid=10002 gids={1015, 1006, 2001, 3003}
03-01 11:54:07.541: INFO/WindowManager(62): Timeout waiting for wallpaper to offset: Window{43f8e3c0 com.android.internal.service.wallpaper.ImageWallpaper paused=false}
03-01 11:54:08.701: INFO/RecoverySystem(62): No recovery log file
03-01 11:54:13.783: DEBUG/MobileDataStateTracker(62): default Received state= DISCONNECTED, old= DISCONNECTED, reason= (unspecified), apnTypeList= default
03-01 11:54:14.361: DEBUG/MccTable(124): updateMccMncConfiguration: mcc=310, mnc=260
03-01 11:54:14.361: DEBUG/MccTable(124): locale set to en_us
03-01 11:54:14.361: DEBUG/MccTable(124): WIFI_NUM_ALLOWED_CHANNELS set to 11
03-01 11:54:14.481: INFO/WifiService(62): WifiService trying to setNumAllowed to 11 with persist set to true
03-01 11:54:15.281: INFO/ActivityManager(62): Config changed: { scale=1.0 imsi=310/260 loc=en_US touch=3 keys=2/1/2 nav=3/1 orien=1 layout=18 uiMode=17 seq=3}
03-01 11:54:15.681: INFO/UsageStats(62): Unexpected resume of com.android.launcher while already resumed in com.android.launcher
03-01 11:54:16.202: INFO/ActivityManager(62): Start proc com.android.defcontainer for service com.android.defcontainer/.DefaultContainerService: pid=189 uid=10010 gids={1015, 2001}
03-01 11:54:16.452: INFO/ActivityThread(180): Publishing provider drm: com.android.providers.drm.DrmProvider
03-01 11:54:16.581: WARN/ActivityManager(62): Timeout of broadcast BroadcastRecord{43fce9b0 android.intent.action.BOOT_COMPLETED} - receiver=android.os.BinderProxy@43f7e8d8
03-01 11:54:16.581: WARN/ActivityManager(62): Receiver during timeout: ResolveInfo{43fc3cc8 com.android.providers.downloads.DownloadReceiver p=0 o=0 m=0x108000}
03-01 11:54:16.852: INFO/Process(62): Sending signal. PID: 180 SIG: 3
03-01 11:54:16.852: INFO/dalvikvm(180): threadid=3: reacting to signal 3
03-01 11:54:17.131: INFO/Process(62): Sending signal. PID: 62 SIG: 3
03-01 11:54:17.131: INFO/dalvikvm(62): threadid=3: reacting to signal 3
03-01 11:54:17.311: INFO/dalvikvm(180): Wrote stack traces to '/data/anr/traces.txt'
03-01 11:54:17.891: INFO/ActivityThread(180): Publishing provider media: com.android.providers.media.MediaProvider
03-01 11:54:18.311: WARN/dalvikvm(62): threadid=3: spin on suspend #1 threadid=34 (pcf=0)
03-01 11:54:18.311: DEBUG/dalvikvm(62): Temporarily moving tid 119 to fg (was 0)
03-01 11:54:18.311: DEBUG/dalvikvm(62): Temporarily raised priority on tid 119 (10 -> 0)
03-01 11:54:18.351: WARN/dalvikvm(62): threadid=3: spin on suspend resolved in 1041 msec
03-01 11:54:18.351: DEBUG/dalvikvm(62): Restored policy of 119 to 0
03-01 11:54:18.351: DEBUG/dalvikvm(62): Restored priority on 119 to 10
03-01 11:54:19.251: INFO/Process(62): Sending signal. PID: 118 SIG: 3
03-01 11:54:19.251: INFO/dalvikvm(118): threadid=3: reacting to signal 3
03-01 11:54:19.471: INFO/Process(62): Sending signal. PID: 127 SIG: 3
03-01 11:54:19.471: INFO/dalvikvm(127): threadid=3: reacting to signal 3
03-01 11:54:19.542: INFO/dalvikvm(62): Wrote stack traces to '/data/anr/traces.txt'
03-01 11:54:19.542: INFO/Process(62): Sending signal. PID: 124 SIG: 3
03-01 11:54:19.542: INFO/dalvikvm(124): threadid=3: reacting to signal 3
03-01 11:54:19.741: INFO/dalvikvm(118): Wrote stack traces to '/data/anr/traces.txt'
03-01 11:54:19.741: INFO/Process(62): Sending signal. PID: 165 SIG: 3
03-01 11:54:19.751: INFO/dalvikvm(165): threadid=3: reacting to signal 3
03-01 11:54:19.951: INFO/Process(62): Sending signal. PID: 131 SIG: 3
03-01 11:54:20.291: ERROR/ActivityManager(62): ANR in android.process.media
03-01 11:54:20.291: ERROR/ActivityManager(62): Reason: Broadcast of Intent { act=android.intent.action.BOOT_COMPLETED cmp=com.android.providers.downloads/.DownloadReceiver }
03-01 11:54:20.291: ERROR/ActivityManager(62): Load: 4.88 / 1.36 / 0.46
03-01 11:54:20.291: ERROR/ActivityManager(62): CPU usage from 9588ms to 4464ms ago:
03-01 11:54:20.291: ERROR/ActivityManager(62): system_server: 42% = 24% user + 17% kernel / faults: 609 minor
03-01 11:54:20.291: ERROR/ActivityManager(62): zygote: 16% = 5% user + 11% kernel / faults: 2454 minor 2 major
03-01 11:54:20.291: ERROR/ActivityManager(62): m.android.phone: 12% = 6% user + 5% kernel / faults: 185 minor
03-01 11:54:20.291: ERROR/ActivityManager(62): d.process.acore: 10% = 9% user + 1% kernel / faults: 289 minor
03-01 11:54:20.291: ERROR/ActivityManager(62): app_process: 7% = 4% user + 2% kernel / faults: 487 minor 1 major
03-01 11:54:20.291: ERROR/ActivityManager(62): bootanimation: 5% = 3% user + 2% kernel
03-01 11:54:20.291: ERROR/ActivityManager(62): ndroid.launcher: 5% = 4% user + 1% kernel / faults: 210 minor 3 major
03-01 11:54:20.291: ERROR/ActivityManager(62): rild: 2% = 0% user + 1% kernel
03-01 11:54:20.291: ERROR/ActivityManager(62): qemud: 1% = 0% user + 1% kernel
03-01 11:54:20.291: ERROR/ActivityManager(62): ronsoft.openwnn: 1% = 0% user + 0% kernel / faults: 232 minor
03-01 11:54:20.291: ERROR/ActivityManager(62): zygote: 0% = 0% user + 0% kernel / faults: 87 minor
03-01 11:54:20.291: ERROR/ActivityManager(62): ndroid.settings: 0% = 0% user + 0% kernel / faults: 153 minor
03-01 11:54:20.291: ERROR/ActivityManager(62): init: 0% = 0% user + 0% kernel
03-01 11:54:20.291: ERROR/ActivityManager(62): kswapd0: 0% = 0% user + 0% kernel
03-01 11:54:20.291: ERROR/ActivityManager(62): adbd: 0% = 0% user + 0% kernel / faults: 8 minor
03-01 11:54:20.291: ERROR/ActivityManager(62): events/0: 0% = 0% user + 0% kernel
03-01 11:54:20.291: ERROR/ActivityManager(62): servicemanager: 0% = 0% user + 0% kernel / faults: 4 minor
03-01 11:54:20.291: ERROR/ActivityManager(62): TOTAL: 100% = 58% user + 41% kernel + 0% irq
03-01 11:54:20.321: INFO/dalvikvm(124): Wrote stack traces to '/data/anr/traces.txt'
03-01 11:54:20.470: WARN/dalvikvm(127): threadid=3: spin on suspend #1 threadid=7 (pcf=0)
03-01 11:54:20.482: DEBUG/dalvikvm(127): Temporarily moving tid 177 to fg (was 0)
03-01 11:54:20.482: DEBUG/dalvikvm(127): Temporarily raised priority on tid 177 (10 -> 0)
03-01 11:54:20.492: INFO/Process(62): Sending signal. PID: 180 SIG: 9
03-01 11:54:20.551: WARN/dalvikvm(127): threadid=3: spin on suspend resolved in 1083 msec
03-01 11:54:20.551: DEBUG/dalvikvm(127): Restored policy of 177 to 0
03-01 11:54:20.551: DEBUG/dalvikvm(127): Restored priority on 177 to 10
03-01 11:54:20.572: WARN/WindowManager(62): App freeze timeout expired.
03-01 11:54:20.572: WARN/WindowManager(62): Force clearing freeze: AppWindowToken{43fb7250 token=HistoryRecord{43fb36b0 com.android.launcher/com.android.launcher2.Launcher}}
03-01 11:54:20.692: INFO/dalvikvm(127): Wrote stack traces to '/data/anr/traces.txt'
03-01 11:54:20.757: WARN/dalvikvm(165): threadid=3: spin on suspend #1 threadid=7 (pcf=0)
03-01 11:54:20.757: DEBUG/dalvikvm(165): Temporarily moving tid 173 to fg (was 0)
03-01 11:54:20.761: DEBUG/dalvikvm(165): Temporarily raised priority on tid 173 (10 -> 0)
03-01 11:54:20.792: WARN/dalvikvm(165): threadid=3: spin on suspend resolved in 1042 msec
03-01 11:54:20.792: DEBUG/dalvikvm(165): Restored policy of 173 to 0
03-01 11:54:20.792: DEBUG/dalvikvm(165): Restored priority on 173 to 10
03-01 11:54:20.882: INFO/dalvikvm(165): Wrote stack traces to '/data/anr/traces.txt'
03-01 11:54:20.971: INFO/dalvikvm(131): threadid=3: reacting to signal 3
03-01 11:54:21.231: INFO/ActivityThread(165): Publishing provider call_log: com.android.providers.contacts.CallLogProvider
03-01 11:54:21.241: INFO/ActivityThread(165): Publishing provider user_dictionary: com.android.providers.userdictionary.UserDictionaryProvider
03-01 11:54:21.380: INFO/dalvikvm(131): Wrote stack traces to '/data/anr/traces.txt'
03-01 11:54:21.800: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 5681 objects / 321656 bytes in 1189ms
03-01 11:54:22.291: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 311 objects / 147640 bytes in 358ms
03-01 11:54:23.113: DEBUG/TelephonyProvider(124): Setting numeric '310260' to be the current operator
03-01 11:54:23.661: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 411 objects / 122536 bytes in 1066ms
03-01 11:54:23.671: DEBUG/dalvikvm(32): GC_EXPLICIT freed 268 objects / 10144 bytes in 1014ms
03-01 11:54:24.171: DEBUG/dalvikvm(62): GC_EXPLICIT freed 96 objects / 4352 bytes in 506ms
03-01 11:54:24.192: INFO/ActivityManager(62): Start proc com.android.alarmclock for broadcast com.android.alarmclock/.AlarmInitReceiver: pid=202 uid=10009 gids={}
03-01 11:54:24.192: INFO/ActivityManager(62): Process android.process.media (pid 180) has died.
03-01 11:54:25.532: DEBUG/dalvikvm(32): GC_EXPLICIT freed 40 objects / 1768 bytes in 1703ms
03-01 11:54:26.131: DEBUG/dalvikvm(32): GC_EXPLICIT freed 2 objects / 48 bytes in 417ms
03-01 11:54:26.581: INFO/ActivityThread(202): Publishing provider com.android.alarmclock: com.android.alarmclock.AlarmProvider
03-01 11:54:27.171: INFO/ActivityManager(62): Start proc android.process.media for content provider com.android.providers.downloads/.DownloadProvider: pid=211 uid=10002 gids={1015, 1006, 2001, 3003}
03-01 11:54:29.193: INFO/ActivityThread(211): Publishing provider drm: com.android.providers.drm.DrmProvider
03-01 11:54:29.782: INFO/ActivityThread(211): Publishing provider media: com.android.providers.media.MediaProvider
03-01 11:54:29.900: DEBUG/MobileDataStateTracker(62): default Received state= CONNECTING, old= DISCONNECTED, reason= simLoaded, apnTypeList= *
03-01 11:54:29.900: DEBUG/NetworkStateTracker(62): setDetailed state, old =IDLE and new state=CONNECTING
03-01 11:54:29.951: DEBUG/ConnectivityService(62): ConnectivityChange for mobile: CONNECTING/CONNECTING
03-01 11:54:30.050: DEBUG/MobileDataStateTracker(62): replacing old mInterfaceName (null) with /dev/omap_csmi_tty1 for hipri
03-01 11:54:30.050: DEBUG/MobileDataStateTracker(62): replacing old mInterfaceName (null) with /dev/omap_csmi_tty1 for supl
03-01 11:54:30.062: DEBUG/MobileDataStateTracker(62): replacing old mInterfaceName (null) with /dev/omap_csmi_tty1 for mms
03-01 11:54:30.082: DEBUG/MobileDataStateTracker(62): default Received state= CONNECTED, old= CONNECTING, reason= simLoaded, apnTypeList= *
03-01 11:54:30.082: DEBUG/NetworkStateTracker(62): setDetailed state, old =CONNECTING and new state=CONNECTED
03-01 11:54:30.082: DEBUG/ConnectivityService(62): ConnectivityChange for mobile: CONNECTED/CONNECTED
03-01 11:54:30.180: VERBOSE/NetworkStateTracker(62): Setting TCP values: [4094,87380,110208,4096,16384,110208] which comes from [net.tcp.buffersize.umts]
03-01 11:54:30.730: DEBUG/ConnectivityService(62): adding dns 10.0.2.3 for mobile
03-01 11:54:30.812: DEBUG/ConnectivityService(62): adding dns 10.0.2.4 for mobile
03-01 11:54:30.822: DEBUG/ConnectivityService(62): adding dns 10.0.2.5 for mobile
03-01 11:54:30.851: VERBOSE/MediaProvider(211): Attached volume: internal
03-01 11:54:31.023: DEBUG/Tethering(62): Tethering got CONNECTIVITY_ACTION
03-01 11:54:31.061: DEBUG/Tethering(62): MasterInitialState.processMessage what=3
03-01 11:54:31.061: ERROR/HierarchicalStateMachine(62): TetherMaster - unhandledMessage: msg.what=3
03-01 11:54:31.211: INFO/ActivityThread(211): Publishing provider downloads: com.android.providers.downloads.DownloadProvider
03-01 11:54:32.042: INFO/ActivityManager(62): Start proc com.android.mms for broadcast com.android.mms/.transaction.MmsSystemEventReceiver: pid=223 uid=10015 gids={3003, 1015}
03-01 11:54:34.451: DEBUG/MediaScannerService(211): start scanning volume internal
03-01 11:54:34.800: INFO/ActivityThread(223): Publishing provider com.android.mms.SuggestionsProvider: com.android.mms.SuggestionsProvider
03-01 11:54:38.252: WARN/dalvikvm(127): threadid=1: spin on suspend #1 threadid=7 (pcf=0)
03-01 11:54:38.252: DEBUG/dalvikvm(127): Temporarily moving tid 229 to fg (was 0)
03-01 11:54:38.252: DEBUG/dalvikvm(127): Temporarily raised priority on tid 229 (10 -> 0)
03-01 11:54:38.291: WARN/dalvikvm(127): threadid=1: spin on suspend resolved in 1038 msec
03-01 11:54:38.291: DEBUG/dalvikvm(127): Restored policy of 229 to 0
03-01 11:54:38.291: DEBUG/dalvikvm(127): Restored priority on 229 to 10
03-01 11:54:38.841: INFO/ActivityManager(62): Start proc com.android.email for broadcast com.android.email/com.android.exchange.BootReceiver: pid=239 uid=10030 gids={3003, 1015}
03-01 11:54:39.170: DEBUG/dalvikvm(127): GC_EXPLICIT freed 3411 objects / 198232 bytes in 1918ms
03-01 11:54:42.241: INFO/ActivityThread(239): Publishing provider com.android.email.provider: com.android.email.provider.EmailProvider
03-01 11:54:42.451: INFO/ActivityThread(239): Publishing provider com.android.exchange.provider: com.android.exchange.provider.ExchangeProvider
03-01 11:54:42.492: INFO/ActivityThread(239): Publishing provider com.android.email.attachmentprovider: com.android.email.provider.AttachmentProvider
03-01 11:54:43.311: DEBUG/Exchange(239): BootReceiver onReceive
03-01 11:54:43.661: DEBUG/EAS SyncManager(239): !!! EAS SyncManager, onCreate
03-01 11:54:44.451: INFO/ActivityManager(62): Start proc com.android.protips for broadcast com.android.protips/.ProtipWidget: pid=248 uid=10007 gids={}
03-01 11:54:45.741: INFO/SurfaceFlinger(62): Boot is finished (94879 ms)
03-01 11:54:45.872: INFO/ARMAssembler(62): generated scanline__00000177:03515104_00000001_00000000 [ 73 ipp] (95 ins) at [0x2d95e8:0x2d9764] in 17460881 ns
03-01 11:54:46.472: DEBUG/EAS SyncManager(239): !!! EAS SyncManager, onStartCommand
03-01 11:54:46.761: DEBUG/EAS SyncManager(239): !!! EAS SyncManager, stopping self
03-01 11:54:47.391: DEBUG/Eas Debug(239): Logging:
03-01 11:54:47.642: DEBUG/EAS SyncManager(239): !!! EAS SyncManager, onDestroy
03-01 11:54:48.491: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 11:54:48.841: DEBUG/dalvikvm(189): GC_EXPLICIT freed 795 objects / 56496 bytes in 301ms
03-01 11:54:49.191: INFO/ActivityManager(62): Start proc com.android.quicksearchbox for broadcast com.android.quicksearchbox/.SearchWidgetProvider: pid=257 uid=10012 gids={3003}
03-01 11:54:50.832: INFO/ActivityThread(257): Publishing provider
com.android.quicksearchbox.google: com.android.quicksearchbox.google.GoogleSuggestionProvider
03-01 11:54:51.431: INFO/ActivityManager(62): Start proc com.android.music for broadcast com.android.music/.MediaAppWidgetProvider: pid=264 uid=10022 gids={3003, 1015}
03-01 11:54:56.311: DEBUG/PackageParser(62): Scanning package: /data/app/vmdl43686.tmp
03-01 11:54:57.890: DEBUG/MediaScanner(211): prescan time: 5887ms
03-01 11:54:57.890: DEBUG/MediaScanner(211): scan time: 154ms
03-01 11:54:57.890: DEBUG/MediaScanner(211): postscan time: 3ms
03-01 11:54:57.890: DEBUG/MediaScanner(211): total time: 6044ms
03-01 11:54:58.042: DEBUG/MediaScannerService(211): done scanning volume internal
03-01 11:54:59.771: DEBUG/dalvikvm(165): GC_FOR_MALLOC freed 3861 objects / 234488 bytes in 263ms
03-01 11:55:01.191: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 8081 objects / 660776 bytes in 303ms
03-01 11:55:02.812: INFO/PackageManager(62): Removing non-system package:de.vogella.android.temperature.test
03-01 11:55:02.831: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature.test uid=10046
03-01 11:55:04.283: DEBUG/dalvikvm(127): GC_EXPLICIT freed 12936 objects / 627624 bytes in 225ms
03-01 11:55:05.734: DEBUG/PackageManager(62): Scanning package de.vogella.android.temperature.test
03-01 11:55:05.811: INFO/PackageManager(62): Package de.vogella.android.temperature.test codePath changed from /data/app/de.vogella.android.temperature.test-2.apk to /data/app/de.vogella.android.temperature.test-1.apk; Retaining data and using new
03-01 11:55:05.821: INFO/PackageManager(62): /data/app/de.vogella.android.temperature.test-1.apk changed; unpacking
03-01 11:55:06.022: DEBUG/installd(34): DexInv: --- BEGIN '/data/app/de.vogella.android.temperature.test-1.apk' ---
03-01 11:55:12.971: DEBUG/dalvikvm(271): DexOpt: load 138ms, verify 4934ms, opt 14ms
03-01 11:55:13.226: DEBUG/installd(34): DexInv: --- END '/data/app/de.vogella.android.temperature.test-1.apk' (success) ---
03-01 11:55:13.242: WARN/PackageManager(62): Code path for pkg : de.vogella.android.temperature.test changing from /data/app/de.vogella.android.temperature.test-2.apk to /data/app/de.vogella.android.temperature.test-1.apk
03-01 11:55:13.265: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature.test uid=10046
03-01 11:55:13.291: WARN/PackageManager(62): Resource path for pkg : de.vogella.android.temperature.test changing from /data/app/de.vogella.android.temperature.test-2.apk to /data/app/de.vogella.android.temperature.test-1.apk
03-01 11:55:13.441: DEBUG/PackageManager(62): Instrumentation: android.test.InstrumentationTestRunner
03-01 11:55:14.692: INFO/installd(34): move /data/dalvik-cache/data@app@de.vogella.android.t...@classes.dex -> /data/dalvik-cache/data@app@de.vogella.android.t...@classes.dex
03-01 11:55:14.721: DEBUG/PackageManager(62): New package installed in /data/app/de.vogella.android.temperature.test-1.apk
03-01 11:55:15.751: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature.test uid=10046
03-01 11:55:16.850: INFO/ActivityManager(62): Start proc com.svox.pico for broadcast com.svox.pico/.VoiceDataInstallerReceiver: pid=272 uid=10028 gids={}
03-01 11:55:18.062: DEBUG/dalvikvm(62): GC_EXPLICIT freed 6781 objects / 436256 bytes in 788ms
03-01 11:55:18.952: WARN/RecognitionManagerService(62): no available voice recognition services found
03-01 11:55:19.661: INFO/ActivityThread(272): Publishing provider com.svox.pico.providers.SettingsProvider: com.svox.pico.providers.SettingsProvider
03-01 11:55:20.131: INFO/installd(34): unlink /data/dalvik-cache/data@app@de.vogella.android.t...@classes.dex
03-01 11:55:20.460: DEBUG/AndroidRuntime(128): Shutting down VM
03-01 11:55:20.492: DEBUG/jdwp(128): adbd disconnected
03-01 11:55:20.501: INFO/AndroidRuntime(128): NOTE: attach of thread 'Binder Thread #3' failed
03-01 11:55:25.725: DEBUG/AndroidRuntime(283): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 11:55:25.725: DEBUG/AndroidRuntime(283): CheckJNI is ON
03-01 11:55:27.251: DEBUG/AndroidRuntime(283): --- registering native functions ---
03-01 11:55:29.003: DEBUG/KeyguardViewMediator(62): pokeWakelock(5000)
03-01 11:55:30.311: DEBUG/KeyguardViewMediator(62): pokeWakelock(5000)
03-01 11:55:31.272: WARN/KeyCharacterMap(62): No keyboard for id 0
03-01 11:55:31.272: WARN/KeyCharacterMap(62): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
03-01 11:55:31.272: DEBUG/KeyguardViewMediator(62): pokeWakelock(5000)
03-01 11:55:32.471: INFO/ActivityManager(62): Displayed activity com.android.launcher/com.android.launcher2.Launcher: 115505 ms (total 115505 ms)
03-01 11:55:35.591: DEBUG/dalvikvm(189): GC_EXPLICIT freed 288 objects / 18352 bytes in 145ms
03-01 11:55:35.811: DEBUG/PackageParser(62): Scanning package: /data/app/vmdl43687.tmp
03-01 11:55:36.191: INFO/PackageManager(62): Removing non-system package:de.vogella.android.temperature
03-01 11:55:36.201: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 11:55:36.812: DEBUG/PackageManager(62): Scanning package de.vogella.android.temperature
03-01 11:55:36.834: INFO/PackageManager(62): Package de.vogella.android.temperature codePath changed from /data/app/de.vogella.android.temperature-2.apk to /data/app/de.vogella.android.temperature-1.apk; Retaining data and using new
03-01 11:55:36.861: INFO/PackageManager(62): /data/app/de.vogella.android.temperature-1.apk changed; unpacking
03-01 11:55:36.901: DEBUG/installd(34): DexInv: --- BEGIN '/data/app/de.vogella.android.temperature-1.apk' ---
03-01 11:55:37.581: DEBUG/dalvikvm(290): DexOpt: load 106ms, verify 114ms, opt 5ms
03-01 11:55:37.602: DEBUG/installd(34): DexInv: --- END '/data/app/de.vogella.android.temperature-1.apk' (success) ---
03-01 11:55:37.630: WARN/PackageManager(62): Code path for pkg : de.vogella.android.temperature changing from /data/app/de.vogella.android.temperature-2.apk to /data/app/de.vogella.android.temperature-1.apk
03-01 11:55:37.630: WARN/PackageManager(62): Resource path for pkg : de.vogella.android.temperature changing from /data/app/de.vogella.android.temperature-2.apk to /data/app/de.vogella.android.temperature-1.apk
03-01 11:55:37.640: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 11:55:37.653: DEBUG/PackageManager(62): Activities: de.vogella.android.temperature.Convert
03-01 11:55:38.281: INFO/installd(34): move /data/dalvik-cache/data@app@de.vogella.android...@classes.dex -> /data/dalvik-cache/data@app@de.vogella.android...@classes.dex
03-01 11:55:38.310: DEBUG/PackageManager(62): New package installed in /data/app/de.vogella.android.temperature-1.apk
03-01 11:55:39.011: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 8438 objects / 559176 bytes in 305ms
03-01 11:55:39.760: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 11:55:40.261: DEBUG/dalvikvm(127): GC_EXPLICIT freed 2247 objects / 126976 bytes in 227ms
03-01 11:55:40.991: WARN/RecognitionManagerService(62): no available voice recognition services found
03-01 11:55:41.812: DEBUG/dalvikvm(62): GC_EXPLICIT freed 4216 objects / 265936 bytes in 238ms
03-01 11:55:41.973: DEBUG/dalvikvm(165): GC_EXPLICIT freed 3797 objects / 207008 bytes in 1682ms
03-01 11:55:42.092: INFO/installd(34): unlink /data/dalvik-cache/data@app@de.vogella.android...@classes.dex
03-01 11:55:42.221: DEBUG/AndroidRuntime(283): Shutting down VM
03-01 11:55:42.232: DEBUG/jdwp(283): adbd disconnected
03-01 11:55:42.291: INFO/AndroidRuntime(283): NOTE: attach of thread 'Binder Thread #3' failed
03-01 11:55:46.322: DEBUG/dalvikvm(189): GC_EXPLICIT freed 112 objects / 9200 bytes in 514ms
03-01 11:55:49.511: DEBUG/AndroidRuntime(295): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 11:55:49.511: DEBUG/AndroidRuntime(295): CheckJNI is ON
03-01 11:55:50.302: DEBUG/AndroidRuntime(295): --- registering native functions ---
03-01 11:55:53.012: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 11:55:53.072: INFO/ActivityManager(62): Start proc de.vogella.android.temperature for added application de.vogella.android.temperature: pid=301 uid=10033 gids={}
03-01 11:55:55.521: INFO/TestRunner(301): started: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:55:55.582: INFO/TestRunner(301): finished: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:55:55.591: INFO/TestRunner(301): passed: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:55:55.591: INFO/TestRunner(301): started: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:55:55.611: INFO/TestRunner(301): finished: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:55:55.632: INFO/TestRunner(301): passed: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:55:55.692: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 11:55:55.692: INFO/Process(62): Sending signal. PID: 301 SIG: 9
03-01 11:55:57.290: DEBUG/AndroidRuntime(295): Shutting down VM
03-01 11:55:57.352: DEBUG/jdwp(295): adbd disconnected
03-01 11:55:58.721: DEBUG/AndroidRuntime(310): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 11:55:58.721: DEBUG/AndroidRuntime(310): CheckJNI is ON
03-01 11:55:59.502: DEBUG/AndroidRuntime(310): --- registering native functions ---
03-01 11:56:04.101: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 11:56:04.162: INFO/ActivityManager(62): Start proc de.vogella.android.temperature for added application de.vogella.android.temperature: pid=317 uid=10033 gids={}
03-01 11:56:05.790: INFO/TestRunner(317): started: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:56:07.911: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN flg=0x10000000 cmp=de.vogella.android.temperature/.Convert }
03-01 11:56:08.581: WARN/ActivityManager(62): Activity pause timeout for HistoryRecord{43fb36b0 com.android.launcher/com.android.launcher2.Launcher}
03-01 11:56:15.822: INFO/ActivityManager(62): Displayed activity de.vogella.android.temperature/.Convert: 7241 ms (total 7241 ms)
03-01 11:56:16.051: INFO/ARMAssembler(62): generated scanline__00000077:03545404_00000004_00000000 [ 47 ipp] (67 ins) at [0x29b8f8:0x29ba04] in 14809426 ns
03-01 11:56:19.731: DEBUG/dalvikvm(317): GC_FOR_MALLOC freed 5314 objects / 326752 bytes in 179ms
03-01 11:56:19.772: WARN/ActivityManager(62): Activity pause timeout for HistoryRecord{43e8ada8 de.vogella.android.temperature/.Convert}
03-01 11:56:20.142: WARN/InputManagerService(62): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@43e696a8 (uid=10033 pid=317)
03-01 11:56:20.591: WARN/ActivityManager(62): Duplicate finish request for HistoryRecord{43e8ada8 de.vogella.android.temperature/.Convert}
03-01 11:56:20.751: WARN/WindowManager(62): Permission denied: injecting key event from pid 317 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 11:56:20.772: WARN/ActivityManager(62): Duplicate finish request for HistoryRecord{43e8ada8 de.vogella.android.temperature/.Convert}
03-01 11:56:20.791: WARN/ActivityManager(62): Duplicate finish request for HistoryRecord{43e8ada8 de.vogella.android.temperature/.Convert}
03-01 11:56:20.960: DEBUG/dalvikvm(317): GC_EXPLICIT freed 1736 objects / 93368 bytes in 169ms
03-01 11:56:21.620: WARN/WindowManager(62): Permission denied: injecting key event from pid 317 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 11:56:22.170: WARN/WindowManager(62): Permission denied: injecting key event from pid 317 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 11:56:22.392: DEBUG/dalvikvm(317): GC_EXPLICIT freed 55 objects / 2416 bytes in 207ms
03-01 11:56:22.392: INFO/TestRunner(317): failed: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:56:22.392: INFO/TestRunner(317): ----- begin exception -----
03-01 11:56:22.740: INFO/TestRunner(317): java.lang.IllegalMonitorStateException: object not locked by thread before wait()
03-01 11:56:22.740: INFO/TestRunner(317): at java.lang.Object.wait(Native Method)
03-01 11:56:22.740: INFO/TestRunner(317): at java.lang.Object.wait(Object.java:326)
03-01 11:56:22.740: INFO/TestRunner(317): at de.vogella.android.temperature.test.ExampleTestRobotium.testConvert(ExampleTestRobotium.java:40)
03-01 11:56:22.740: INFO/TestRunner(317): at java.lang.reflect.Method.invokeNative(Native Method)
03-01 11:56:22.740: INFO/TestRunner(317): at java.lang.reflect.Method.invoke(Method.java:521)
03-01 11:56:22.740: INFO/TestRunner(317): at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:204)
03-01 11:56:22.740: INFO/TestRunner(317): at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:194)
03-01 11:56:22.740: INFO/TestRunner(317): at android.test.ActivityInstrumentationTestCase2.runTest(ActivityInstrumentationTestCase2.java:186)
03-01 11:56:22.740: INFO/TestRunner(317): at junit.framework.TestCase.runBare(TestCase.java:127)
03-01 11:56:22.740: INFO/TestRunner(317): at junit.framework.TestResult$1.protect(TestResult.java:106)
03-01 11:56:22.740: INFO/TestRunner(317): at junit.framework.TestResult.runProtected(TestResult.java:124)
03-01 11:56:22.740: INFO/TestRunner(317): at junit.framework.TestResult.run(TestResult.java:109)
03-01 11:56:22.740: INFO/TestRunner(317): at junit.framework.TestCase.run(TestCase.java:118)
03-01 11:56:22.740: INFO/TestRunner(317): at android.test.AndroidTestRunner.runTest(AndroidTestRunner.java:169)
03-01 11:56:22.740: INFO/TestRunner(317): at android.test.AndroidTestRunner.runTest(AndroidTestRunner.java:154)
03-01 11:56:22.740: INFO/TestRunner(317): at android.test.InstrumentationTestRunner.onStart(InstrumentationTestRunner.java:520)
03-01 11:56:22.740: INFO/TestRunner(317): at android.app.Instrumentation$InstrumentationThread.run(Instrumentation.java:1447)
03-01 11:56:22.740: INFO/TestRunner(317): ----- end exception -----
03-01 11:56:22.812: INFO/TestRunner(317): finished: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:56:22.881: INFO/TestRunner(317): started: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:56:22.981: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN flg=0x10000000 cmp=de.vogella.android.temperature/.Convert }
03-01 11:56:25.481: INFO/ActivityManager(62): Displayed activity de.vogella.android.temperature/.Convert: 2354 ms (total 2354 ms)
03-01 11:56:30.761: WARN/ActivityManager(62): Duplicate finish request for HistoryRecord{43f910f8 de.vogella.android.temperature/.Convert}
03-01 11:56:30.781: WARN/WindowManager(62): Permission denied: injecting key event from pid 317 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 11:56:30.821: WARN/ActivityManager(62): Duplicate finish request for HistoryRecord{43f910f8 de.vogella.android.temperature/.Convert}
03-01 11:56:30.830: WARN/ActivityManager(62): Duplicate finish request for HistoryRecord{43f910f8 de.vogella.android.temperature/.Convert}
03-01 11:56:31.071: DEBUG/dalvikvm(317): GC_EXPLICIT freed 3284 objects / 262752 bytes in 234ms
03-01 11:56:31.681: WARN/WindowManager(62): Permission denied: injecting key event from pid 317 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 11:56:32.232: WARN/WindowManager(62): Permission denied: injecting key event from pid 317 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 11:56:32.392: DEBUG/dalvikvm(317): GC_EXPLICIT freed 399 objects / 24464 bytes in 129ms
03-01 11:56:32.392: INFO/TestRunner(317): finished: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:56:32.392: INFO/TestRunner(317): passed: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 11:56:32.481: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 11:56:32.481: INFO/Process(62): Sending signal. PID: 317 SIG: 9
03-01 11:56:33.012: DEBUG/AndroidRuntime(310): Shutting down VM
03-01 11:56:33.052: INFO/AndroidRuntime(310): NOTE: attach of thread 'Binder Thread #4' failed
03-01 11:56:33.071: DEBUG/jdwp(310): adbd disconnected
03-01 11:59:48.501: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 12:01:54.422: DEBUG/AndroidRuntime(328): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 12:01:54.422: DEBUG/AndroidRuntime(328): CheckJNI is ON
03-01 12:01:55.142: DEBUG/AndroidRuntime(328): --- registering native functions ---
03-01 12:01:58.681: DEBUG/dalvikvm(189): GC_EXPLICIT freed 123 objects / 5984 bytes in 135ms
03-01 12:01:59.211: DEBUG/PackageParser(62): Scanning package: /data/app/vmdl43688.tmp
03-01 12:01:59.572: INFO/PackageManager(62): Removing non-system package:de.vogella.android.temperature.test
03-01 12:01:59.572: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature.test uid=10046
03-01 12:02:00.371: DEBUG/PackageManager(62): Scanning package de.vogella.android.temperature.test
03-01 12:02:00.390: INFO/PackageManager(62): Package de.vogella.android.temperature.test codePath changed from /data/app/de.vogella.android.temperature.test-1.apk to /data/app/de.vogella.android.temperature.test-2.apk; Retaining data and using new
03-01 12:02:00.402: INFO/PackageManager(62): /data/app/de.vogella.android.temperature.test-2.apk changed; unpacking
03-01 12:02:00.431: DEBUG/installd(34): DexInv: --- BEGIN '/data/app/de.vogella.android.temperature.test-2.apk' ---
03-01 12:02:01.761: DEBUG/dalvikvm(335): DexOpt: load 48ms, verify 663ms, opt 11ms
03-01 12:02:01.911: DEBUG/installd(34): DexInv: --- END '/data/app/de.vogella.android.temperature.test-2.apk' (success) ---
03-01 12:02:01.922: WARN/PackageManager(62): Code path for pkg : de.vogella.android.temperature.test changing from /data/app/de.vogella.android.temperature.test-1.apk to /data/app/de.vogella.android.temperature.test-2.apk
03-01 12:02:01.922: WARN/PackageManager(62): Resource path for pkg : de.vogella.android.temperature.test changing from /data/app/de.vogella.android.temperature.test-1.apk to /data/app/de.vogella.android.temperature.test-2.apk
03-01 12:02:01.931: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature.test uid=10046
03-01 12:02:01.961: DEBUG/PackageManager(62): Instrumentation: android.test.InstrumentationTestRunner
03-01 12:02:02.617: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 7701 objects / 446296 bytes in 259ms
03-01 12:02:02.973: INFO/installd(34): move /data/dalvik-cache/data@app@de.vogella.android.t...@classes.dex -> /data/dalvik-cache/data@app@de.vogella.android.t...@classes.dex
03-01 12:02:02.982: DEBUG/PackageManager(62): New package installed in /data/app/de.vogella.android.temperature.test-2.apk
03-01 12:02:03.602: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature.test uid=10046
03-01 12:02:04.430: WARN/RecognitionManagerService(62): no available voice recognition services found
03-01 12:02:04.961: DEBUG/dalvikvm(62): GC_EXPLICIT freed 4568 objects / 305056 bytes in 247ms
03-01 12:02:05.320: INFO/installd(34): unlink /data/dalvik-cache/data@app@de.vogella.android.t...@classes.dex
03-01 12:02:05.432: DEBUG/AndroidRuntime(328): Shutting down VM
03-01 12:02:05.456: DEBUG/dalvikvm(328): Debugger has detached; object registry had 1 entries
03-01 12:02:05.482: INFO/AndroidRuntime(328): NOTE: attach of thread 'Binder Thread #3' failed
03-01 12:02:07.462: DEBUG/AndroidRuntime(340): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 12:02:07.462: DEBUG/AndroidRuntime(340): CheckJNI is ON
03-01 12:02:08.650: DEBUG/AndroidRuntime(340): --- registering native functions ---
03-01 12:02:37.055: DEBUG/AndroidRuntime(340): Shutting down VM
03-01 12:02:37.952: DEBUG/dalvikvm(340): Debugger has detached; object registry had 1 entries
03-01 12:02:45.841: DEBUG/AndroidRuntime(348): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 12:02:45.863: DEBUG/AndroidRuntime(348): CheckJNI is ON
03-01 12:02:47.012: DEBUG/AndroidRuntime(348): --- registering native functions ---
03-01 12:02:48.641: DEBUG/dalvikvm(272): GC_EXPLICIT freed 835 objects / 58384 bytes in 39211ms
03-01 12:03:06.801: DEBUG/dalvikvm(189): GC_EXPLICIT freed 91 objects / 8224 bytes in 1879ms
03-01 12:03:08.233: DEBUG/dalvikvm(189): GC_EXPLICIT freed 79 objects / 3992 bytes in 185ms
03-01 12:03:18.591: DEBUG/PackageParser(62): Scanning package: /data/app/vmdl43689.tmp
03-01 12:03:25.272: DEBUG/dalvikvm(189): GC_EXPLICIT freed 88 objects / 8232 bytes in 304ms
03-01 12:03:25.282: INFO/PackageManager(62): Removing non-system package:de.vogella.android.temperature
03-01 12:03:25.291: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 12:03:26.082: DEBUG/PackageManager(62): Scanning package de.vogella.android.temperature
03-01 12:03:26.092: INFO/PackageManager(62): Package de.vogella.android.temperature codePath changed from /data/app/de.vogella.android.temperature-1.apk to /data/app/de.vogella.android.temperature-2.apk; Retaining data and using new
03-01 12:03:26.102: INFO/PackageManager(62): /data/app/de.vogella.android.temperature-2.apk changed; unpacking
03-01 12:03:26.141: DEBUG/installd(34): DexInv: --- BEGIN '/data/app/de.vogella.android.temperature-2.apk' ---
03-01 12:03:26.831: DEBUG/dalvikvm(356): DexOpt: load 95ms, verify 123ms, opt 5ms
03-01 12:03:26.880: DEBUG/installd(34): DexInv: --- END '/data/app/de.vogella.android.temperature-2.apk' (success) ---
03-01 12:03:26.880: WARN/PackageManager(62): Code path for pkg : de.vogella.android.temperature changing from /data/app/de.vogella.android.temperature-1.apk to /data/app/de.vogella.android.temperature-2.apk
03-01 12:03:26.892: WARN/PackageManager(62): Resource path for pkg : de.vogella.android.temperature changing from /data/app/de.vogella.android.temperature-1.apk to /data/app/de.vogella.android.temperature-2.apk
03-01 12:03:26.901: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 12:03:26.901: DEBUG/PackageManager(62): Activities: de.vogella.android.temperature.Convert
03-01 12:03:27.521: INFO/installd(34): move /data/dalvik-cache/data@app@de.vogella.android...@classes.dex -> /data/dalvik-cache/data@app@de.vogella.android...@classes.dex
03-01 12:03:27.531: DEBUG/PackageManager(62): New package installed in /data/app/de.vogella.android.temperature-2.apk
03-01 12:03:28.170: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 12:03:28.441: DEBUG/dalvikvm(62): GC_EXPLICIT freed 7245 objects / 475016 bytes in 249ms
03-01 12:03:28.852: DEBUG/dalvikvm(127): GC_EXPLICIT freed 1997 objects / 113912 bytes in 305ms
03-01 12:03:29.290: DEBUG/dalvikvm(165): GC_EXPLICIT freed 4193 objects / 214672 bytes in 364ms
03-01 12:03:29.721: WARN/RecognitionManagerService(62): no available voice recognition services found
03-01 12:03:30.452: DEBUG/dalvikvm(62): GC_EXPLICIT freed 3429 objects / 200496 bytes in 236ms
03-01 12:03:30.621: INFO/installd(34): unlink /data/dalvik-cache/data@app@de.vogella.android...@classes.dex
03-01 12:03:30.721: DEBUG/AndroidRuntime(348): Shutting down VM
03-01 12:03:30.742: DEBUG/dalvikvm(348): Debugger has detached; object registry had 1 entries
03-01 12:03:30.774: INFO/AndroidRuntime(348): NOTE: attach of thread 'Binder Thread #3' failed
03-01 12:03:33.612: DEBUG/AndroidRuntime(361): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 12:03:33.612: DEBUG/AndroidRuntime(361): CheckJNI is ON
03-01 12:03:34.881: DEBUG/AndroidRuntime(361): --- registering native functions ---
03-01 12:03:37.931: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 12:03:37.982: INFO/ActivityManager(62): Start proc de.vogella.android.temperature for added application de.vogella.android.temperature: pid=367 uid=10033 gids={}
03-01 12:03:39.571: INFO/TestRunner(367): started: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:03:39.630: INFO/TestRunner(367): finished: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:03:39.630: INFO/TestRunner(367): passed: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:03:39.642: INFO/TestRunner(367): started: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:03:39.670: INFO/TestRunner(367): finished: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:03:39.680: INFO/TestRunner(367): passed: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:03:39.781: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 12:03:39.781: INFO/Process(62): Sending signal. PID: 367 SIG: 9
03-01 12:03:40.332: DEBUG/dalvikvm(272): GC_EXPLICIT freed 249 objects / 11912 bytes in 5175ms
03-01 12:03:40.912: DEBUG/AndroidRuntime(361): Shutting down VM
03-01 12:03:40.956: DEBUG/dalvikvm(361): Debugger has detached; object registry had 0 entries
03-01 12:03:41.012: INFO/AndroidRuntime(361): NOTE: attach of thread 'Binder Thread #3' failed
03-01 12:03:42.511: DEBUG/AndroidRuntime(376): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 12:03:42.511: DEBUG/AndroidRuntime(376): CheckJNI is ON
03-01 12:03:43.300: DEBUG/AndroidRuntime(376): --- registering native functions ---
03-01 12:03:46.022: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 12:03:46.122: INFO/ActivityManager(62): Start proc de.vogella.android.temperature for added application de.vogella.android.temperature: pid=383 uid=10033 gids={}
03-01 12:03:46.481: DEBUG/dalvikvm(32): GC_EXPLICIT freed 257 objects / 9792 bytes in 340ms
03-01 12:03:46.771: DEBUG/dalvikvm(32): GC_EXPLICIT freed 27 objects / 1184 bytes in 235ms
03-01 12:03:47.051: DEBUG/dalvikvm(32): GC_EXPLICIT freed 2 objects / 64 bytes in 226ms
03-01 12:03:48.130: INFO/TestRunner(383): started: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:03:48.272: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN flg=0x10000000 cmp=de.vogella.android.temperature/.Convert }
03-01 12:03:50.982: INFO/ActivityManager(62): Displayed activity de.vogella.android.temperature/.Convert: 2560 ms (total 2560 ms)
03-01 12:03:54.652: DEBUG/dalvikvm(383): GC_FOR_MALLOC freed 5381 objects / 329296 bytes in 150ms
03-01 12:03:56.351: WARN/WindowManager(62): Permission denied: injecting key event from pid 383 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 12:03:56.670: DEBUG/dalvikvm(383): GC_EXPLICIT freed 1934 objects / 107952 bytes in 278ms
03-01 12:03:57.201: WARN/WindowManager(62): Permission denied: injecting key event from pid 383 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 12:03:57.731: WARN/WindowManager(62): Permission denied: injecting key event from pid 383 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 12:03:57.870: DEBUG/dalvikvm(383): GC_EXPLICIT freed 99 objects / 4512 bytes in 125ms
03-01 12:03:57.870: INFO/TestRunner(383): finished: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:03:57.870: INFO/TestRunner(383): passed: testConvert(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:03:57.912: INFO/TestRunner(383): started: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:03:58.021: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN flg=0x10000000 cmp=de.vogella.android.temperature/.Convert }
03-01 12:03:59.711: WARN/InputManagerService(62): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@43fd54a0 (uid=10025 pid=127)
03-01 12:03:59.971: WARN/InputManagerService(62): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@43fd54a0 (uid=10025 pid=127)
03-01 12:04:00.181: INFO/ActivityManager(62): Displayed activity de.vogella.android.temperature/.Convert: 1813 ms (total 1813 ms)
03-01 12:04:05.410: WARN/WindowManager(62): Permission denied: injecting key event from pid 383 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 12:04:05.693: DEBUG/dalvikvm(383): GC_EXPLICIT freed 2371 objects / 153536 bytes in 232ms
03-01 12:04:06.210: WARN/WindowManager(62): Permission denied: injecting key event from pid 383 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 12:04:06.761: WARN/WindowManager(62): Permission denied: injecting key event from pid 383 uid 10033 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 12:04:06.912: DEBUG/dalvikvm(383): GC_EXPLICIT freed 438 objects / 26176 bytes in 118ms
03-01 12:04:06.912: INFO/TestRunner(383): finished: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:04:06.912: INFO/TestRunner(383): passed: testConvertCel(de.vogella.android.temperature.test.ExampleTestRobotium)
03-01 12:04:07.040: INFO/ActivityManager(62): Force stopping package de.vogella.android.temperature uid=10033
03-01 12:04:07.051: INFO/Process(62): Sending signal. PID: 383 SIG: 9
03-01 12:04:07.420: DEBUG/AndroidRuntime(376): Shutting down VM
03-01 12:04:07.461: DEBUG/dalvikvm(376): Debugger has detached; object registry had 1 entries
03-01 12:04:07.513: INFO/AndroidRuntime(376): NOTE: attach of thread 'Binder Thread #4' failed
03-01 12:04:48.512: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 12:05:34.651: DEBUG/AndroidRuntime(394): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 12:05:34.651: DEBUG/AndroidRuntime(394): CheckJNI is ON
03-01 12:05:35.681: DEBUG/AndroidRuntime(394): --- registering native functions ---
03-01 12:05:40.071: DEBUG/dalvikvm(189): GC_EXPLICIT freed 82 objects / 4064 bytes in 153ms
03-01 12:05:40.590: DEBUG/PackageParser(62): Scanning package: /data/app/vmdl43690.tmp
03-01 12:05:41.910: INFO/PackageManager(62): Removing non-system package:com.example.android.notepad
03-01 12:05:41.910: INFO/ActivityManager(62): Force stopping package com.example.android.notepad uid=10052
03-01 12:05:42.642: DEBUG/PackageManager(62): Scanning package com.example.android.notepad
03-01 12:05:42.652: INFO/PackageManager(62): Package com.example.android.notepad codePath changed from /data/app/com.example.android.notepad-2.apk to /data/app/com.example.android.notepad-1.apk; Retaining data and using new
03-01 12:05:42.721: INFO/PackageManager(62): /data/app/com.example.android.notepad-1.apk changed; unpacking
03-01 12:05:42.762: DEBUG/installd(34): DexInv: --- BEGIN '/data/app/com.example.android.notepad-1.apk' ---
03-01 12:05:44.192: DEBUG/dalvikvm(401): DexOpt: load 323ms, verify 513ms, opt 4ms
03-01 12:05:44.244: DEBUG/installd(34): DexInv: --- END '/data/app/com.example.android.notepad-1.apk' (success) ---
03-01 12:05:44.271: INFO/ActivityManager(62): Force stopping package com.example.android.notepad uid=10052
03-01 12:05:44.282: WARN/PackageManager(62): Code path for pkg : com.example.android.notepad changing from /data/app/com.example.android.notepad-2.apk to /data/app/com.example.android.notepad-1.apk
03-01 12:05:44.431: WARN/PackageManager(62): Resource path for pkg : com.example.android.notepad changing from /data/app/com.example.android.notepad-2.apk to /data/app/com.example.android.notepad-1.apk
03-01 12:05:44.452: DEBUG/PackageManager(62): Registered content provider: com.google.provider.NotePad, className = com.example.android.notepad.NotePadProvider, isSyncable = false
03-01 12:05:44.461: DEBUG/PackageManager(62): Providers: com.example.android.notepad.NotePadProvider
03-01 12:05:44.461: DEBUG/PackageManager(62): Activities: com.example.android.notepad.NotesList com.example.android.notepad.NoteEditor com.example.android.notepad.TitleEditor com.example.android.notepad.NotesLiveFolder
03-01 12:05:45.012: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 6847 objects / 424312 bytes in 258ms
03-01 12:05:45.612: DEBUG/dalvikvm(189): GC_EXPLICIT freed 84 objects / 7800 bytes in 151ms
03-01 12:05:45.960: INFO/installd(34): move /data/dalvik-cache/data@app@com.example.andr...@classes.dex -> /data/dalvik-cache/data@app@com.example.andr...@classes.dex
03-01 12:05:45.960: DEBUG/PackageManager(62): New package installed in /data/app/com.example.android.notepad-1.apk
03-01 12:05:46.651: INFO/ActivityManager(62): Force stopping package com.example.android.notepad uid=10052
03-01 12:05:46.882: DEBUG/dalvikvm(127): GC_EXPLICIT freed 1220 objects / 68248 bytes in 205ms
03-01 12:05:47.661: WARN/RecognitionManagerService(62): no available voice recognition services found
03-01 12:05:48.021: DEBUG/dalvikvm(165): GC_EXPLICIT freed 2580 objects / 130736 bytes in 1050ms
03-01 12:05:48.482: DEBUG/dalvikvm(62): GC_EXPLICIT freed 5565 objects / 356016 bytes in 253ms
03-01 12:05:48.790: INFO/installd(34): unlink /data/dalvik-cache/data@app@com.example.andr...@classes.dex
03-01 12:05:48.870: DEBUG/AndroidRuntime(394): Shutting down VM
03-01 12:05:48.890: DEBUG/dalvikvm(394): Debugger has detached; object registry had 1 entries
03-01 12:05:48.964: INFO/AndroidRuntime(394): NOTE: attach of thread 'Binder Thread #3' failed
03-01 12:05:51.031: DEBUG/AndroidRuntime(406): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 12:05:51.031: DEBUG/AndroidRuntime(406): CheckJNI is ON
03-01 12:05:51.962: DEBUG/AndroidRuntime(406): --- registering native functions ---
03-01 12:05:54.861: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10000000 cmp=com.example.android.notepad/.NotesList }
03-01 12:05:55.061: DEBUG/AndroidRuntime(406): Shutting down VM
03-01 12:05:55.091: INFO/AndroidRuntime(406): NOTE: attach of thread 'Binder Thread #3' failed
03-01 12:05:55.091: DEBUG/dalvikvm(406): Debugger has detached; object registry had 1 entries
03-01 12:05:55.240: INFO/ActivityManager(62): Start proc com.example.android.notepad for activity com.example.android.notepad/.NotesList: pid=413 uid=10052 gids={}
03-01 12:05:56.762: INFO/ActivityThread(413): Publishing provider com.google.provider.NotePad: com.example.android.notepad.NotePadProvider
03-01 12:05:58.231: INFO/ActivityManager(62): Displayed activity com.example.android.notepad/.NotesList: 3238 ms (total 3238 ms)
03-01 12:05:58.721: DEBUG/dalvikvm(272): GC_EXPLICIT freed 46 objects / 2248 bytes in 4963ms
03-01 12:06:05.210: DEBUG/dalvikvm(127): GC_EXPLICIT freed 959 objects / 55640 bytes in 150ms
03-01 12:09:48.532: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 12:11:08.241: WARN/KeyCharacterMap(413): No keyboard for id 0
03-01 12:11:08.241: WARN/KeyCharacterMap(413): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
03-01 12:11:08.972: INFO/ARMAssembler(62): generated scanline__00000177:03515104_00001001_00000000 [ 91 ipp] (114 ins) at [0x299ff8:0x29a1c0] in 16424435 ns
03-01 12:11:11.880: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.INSERT dat=content://com.google.provider.NotePad/notes cmp=com.example.android.notepad/.NoteEditor }
03-01 12:11:12.981: INFO/ActivityManager(62): Displayed activity com.example.android.notepad/.NoteEditor: 982 ms (total 982 ms)
03-01 12:11:40.653: DEBUG/dalvikvm(118): GC_FOR_MALLOC freed 1893 objects / 225952 bytes in 198ms
03-01 12:11:43.402: WARN/KeyCharacterMap(118): No keyboard for id 0
03-01 12:11:43.411: WARN/KeyCharacterMap(118): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
03-01 12:11:44.517: DEBUG/dalvikvm(118): GC_EXTERNAL_ALLOC freed 2056 objects / 139848 bytes in 648ms
03-01 12:14:48.541: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 12:15:54.671: WARN/InputManagerService(62): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@43e6a010
03-01 12:15:56.900: WARN/KeyCharacterMap(118): No keyboard for id 0
03-01 12:15:56.900: WARN/KeyCharacterMap(118): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
03-01 12:15:58.471: WARN/InputManagerService(62): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@43ed7040
03-01 12:16:06.442: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.android.launcher/com.android.launcher2.Launcher }
03-01 12:16:07.171: WARN/InputManagerService(62): Ignoring hideSoftInput of: com.android.internal.view.IInputMethodClient$Stub$Proxy@43ebfb80
03-01 12:16:07.921: WARN/IInputConnectionWrapper(413): showStatusIcon on inactive InputConnection
03-01 12:16:13.997: DEBUG/dalvikvm(131): GC_EXPLICIT freed 1203 objects / 86896 bytes in 341ms
03-01 12:16:18.913: DEBUG/dalvikvm(413): GC_EXPLICIT freed 2063 objects / 116184 bytes in 247ms
03-01 12:16:31.072: WARN/KeyCharacterMap(127): No keyboard for id 0
03-01 12:16:31.072: WARN/KeyCharacterMap(127): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
03-01 12:16:31.561: DEBUG/dalvikvm(62): GREF has increased to 301
03-01 12:16:37.311: WARN/InputManagerService(62): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@43e32e30
03-01 12:16:41.580: DEBUG/dalvikvm(127): GC_EXTERNAL_ALLOC freed 502 objects / 27960 bytes in 157ms
03-01 12:16:45.551: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=de.vogella.android.view/.ListView }
03-01 12:16:45.831: INFO/ActivityManager(62): Start proc de.vogella.android.view for activity de.vogella.android.view/.ListView: pid=420 uid=10035 gids={}
03-01 12:16:47.811: DEBUG/AndroidRuntime(420): Shutting down VM
03-01 12:16:47.821: WARN/dalvikvm(420): threadid=1: thread exiting with uncaught exception (group=0x4001d800)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): FATAL EXCEPTION: main
03-01 12:16:48.011: ERROR/AndroidRuntime(420): java.lang.RuntimeException: Unable to start activity ComponentInfo{de.vogella.android.view/de.vogella.android.view.ListView}: java.lang.NullPointerException
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:2663)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at android.app.ActivityThread.handleLaunchActivity(ActivityThread.java:2679)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at android.app.ActivityThread.access$2300(ActivityThread.java:125)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at android.app.ActivityThread$H.handleMessage(ActivityThread.java:2033)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at android.os.Handler.dispatchMessage(Handler.java:99)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at android.os.Looper.loop(Looper.java:123)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at android.app.ActivityThread.main(ActivityThread.java:4627)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at java.lang.reflect.Method.invokeNative(Native Method)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at java.lang.reflect.Method.invoke(Method.java:521)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:868)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:626)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at dalvik.system.NativeStart.main(Native Method)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): Caused by: java.lang.NullPointerException
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at de.vogella.android.view.ListView.onCreate(ListView.java:22)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at android.app.Instrumentation.callActivityOnCreate(Instrumentation.java:1047)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:2627)
03-01 12:16:48.011: ERROR/AndroidRuntime(420): ... 11 more
03-01 12:16:48.251: WARN/ActivityManager(62): Force finishing activity de.vogella.android.view/.ListView
03-01 12:16:49.022: WARN/ActivityManager(62): Activity pause timeout for HistoryRecord{44018ca0 de.vogella.android.view/.ListView}
03-01 12:16:49.142: INFO/ARMAssembler(62): generated scanline__00000077:03515104_00000000_00000000 [ 33 ipp] (47 ins) at [0x2f6d88:0x2f6e44] in 2417905 ns
03-01 12:16:53.460: INFO/Process(420): Sending signal. PID: 420 SIG: 9
03-01 12:16:53.511: INFO/ActivityManager(62): Process de.vogella.android.view (pid 420) has died.
03-01 12:16:53.602: WARN/InputManagerService(62): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@4405a628
03-01 12:16:56.780: WARN/KeyCharacterMap(62): No keyboard for id 0
03-01 12:16:56.780: WARN/KeyCharacterMap(62): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
03-01 12:16:56.811: WARN/KeyCharacterMap(127): No keyboard for id 0
03-01 12:16:56.811: WARN/KeyCharacterMap(127): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
03-01 12:16:57.102: INFO/ActivityManager(62): Starting activity: Intent { act=android.search.action.GLOBAL_SEARCH flg=0x10000000 cmp=com.android.quicksearchbox/.SearchActivity (has extras) }
03-01 12:17:01.233: WARN/ActivityManager(62): Activity destroy timeout for HistoryRecord{44018ca0 de.vogella.android.view/.ListView}
03-01 12:17:02.252: DEBUG/dalvikvm(257): GC_FOR_MALLOC freed 4470 objects / 300160 bytes in 194ms
03-01 12:17:02.721: INFO/ActivityManager(62): Displayed activity com.android.quicksearchbox/.SearchActivity: 4938 ms (total 17024 ms)
03-01 12:17:05.892: WARN/KeyCharacterMap(257): No keyboard for id 0
03-01 12:17:05.892: WARN/KeyCharacterMap(257): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
03-01 12:17:12.042: DEBUG/dalvikvm(127): GC_EXPLICIT freed 657 objects / 34048 bytes in 179ms
03-01 12:17:12.432: WARN/InputManagerService(62): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@43fee000
03-01 12:17:12.721: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.android.launcher/com.android.launcher2.Launcher }
03-01 12:17:12.941: WARN/InputManagerService(62): Ignoring hideSoftInput of: com.android.internal.view.IInputMethodClient$Stub$Proxy@43fefc30
03-01 12:17:14.514: WARN/InputManagerService(62): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@440170d0 (uid=10012 pid=257)
03-01 12:17:14.522: WARN/IInputConnectionWrapper(257): showStatusIcon on inactive InputConnection
03-01 12:17:14.972: DEBUG/dalvikvm(118): GC_EXTERNAL_ALLOC freed 824 objects / 45648 bytes in 323ms
03-01 12:17:19.961: DEBUG/dalvikvm(165): GC_EXPLICIT freed 2703 objects / 141256 bytes in 291ms
03-01 12:17:21.972: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.android.launcher/com.android.launcher2.Launcher }
03-01 12:17:27.191: DEBUG/dalvikvm(257): GC_EXPLICIT freed 3571 objects / 210440 bytes in 157ms
03-01 12:17:32.170: WARN/KeyCharacterMap(127): No keyboard for id 0
03-01 12:17:32.170: WARN/KeyCharacterMap(127): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
03-01 12:17:33.091: DEBUG/dalvikvm(131): GC_EXPLICIT freed 155 objects / 7904 bytes in 1063ms
03-01 12:17:36.721: INFO/ActivityManager(62): Starting activity: Intent { act=android.search.action.GLOBAL_SEARCH flg=0x10000000 cmp=com.android.quicksearchbox/.SearchActivity (has extras) }
03-01 12:17:37.261: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 9548 objects / 465864 bytes in 264ms
03-01 12:17:37.281: WARN/InputManagerService(62): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@440170d0 (uid=10012 pid=257)
03-01 12:17:41.251: WARN/KeyCharacterMap(118): No keyboard for id 0
03-01 12:17:41.251: WARN/KeyCharacterMap(118): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
03-01 12:17:41.251: WARN/KeyCharacterMap(257): No keyboard for id 0
03-01 12:17:41.261: WARN/KeyCharacterMap(257): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
03-01 12:17:50.441: WARN/InputManagerService(62): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@43edcea0
03-01 12:17:53.282: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.android.launcher/com.android.launcher2.Launcher }
03-01 12:17:53.421: WARN/InputManagerService(62): Ignoring hideSoftInput of: com.android.internal.view.IInputMethodClient$Stub$Proxy@43eb62d8
03-01 12:17:55.511: WARN/InputManagerService(62): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@440170d0 (uid=10012 pid=257)
03-01 12:17:55.522: WARN/IInputConnectionWrapper(257): showStatusIcon on inactive InputConnection
03-01 12:17:57.012: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.android.launcher/com.android.launcher2.Launcher }
03-01 12:18:06.150: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.android.launcher/com.android.launcher2.Launcher }
03-01 12:18:18.400: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.HOME] flg=0x10200000 cmp=com.android.launcher/com.android.launcher2.Launcher }
03-01 12:18:24.802: WARN/InputManagerService(62): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@43f92d78
03-01 12:18:31.022: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=de.vogella.android.view/.ListView }
03-01 12:18:31.471: INFO/ActivityManager(62): Start proc de.vogella.android.view for activity de.vogella.android.view/.ListView: pid=435 uid=10035 gids={}
03-01 12:18:32.961: DEBUG/AndroidRuntime(435): Shutting down VM
03-01 12:18:32.961: WARN/dalvikvm(435): threadid=1: thread exiting with uncaught exception (group=0x4001d800)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): FATAL EXCEPTION: main
03-01 12:18:33.002: ERROR/AndroidRuntime(435): java.lang.RuntimeException: Unable to start activity ComponentInfo{de.vogella.android.view/de.vogella.android.view.ListView}: java.lang.NullPointerException
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:2663)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at android.app.ActivityThread.handleLaunchActivity(ActivityThread.java:2679)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at android.app.ActivityThread.access$2300(ActivityThread.java:125)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at android.app.ActivityThread$H.handleMessage(ActivityThread.java:2033)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at android.os.Handler.dispatchMessage(Handler.java:99)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at android.os.Looper.loop(Looper.java:123)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at android.app.ActivityThread.main(ActivityThread.java:4627)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at java.lang.reflect.Method.invokeNative(Native Method)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at java.lang.reflect.Method.invoke(Method.java:521)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:868)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:626)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at dalvik.system.NativeStart.main(Native Method)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): Caused by: java.lang.NullPointerException
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at de.vogella.android.view.ListView.onCreate(ListView.java:22)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at android.app.Instrumentation.callActivityOnCreate(Instrumentation.java:1047)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): at android.app.ActivityThread.performLaunchActivity(ActivityThread.java:2627)
03-01 12:18:33.002: ERROR/AndroidRuntime(435): ... 11 more
03-01 12:18:33.041: WARN/ActivityManager(62): Force finishing activity de.vogella.android.view/.ListView
03-01 12:18:33.602: WARN/ActivityManager(62): Activity pause timeout for HistoryRecord{43fe40b8 de.vogella.android.view/.ListView}
03-01 12:18:34.911: INFO/ActivityManager(62): Process android.process.acore (pid 165) has died.
03-01 12:18:35.691: WARN/InputManagerService(62): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@43eda150
03-01 12:18:35.741: INFO/Process(435): Sending signal. PID: 435 SIG: 9
03-01 12:18:36.191: INFO/ActivityManager(62): Process de.vogella.android.view (pid 435) has died.
03-01 12:18:45.379: WARN/ActivityManager(62): Activity destroy timeout for HistoryRecord{43fe40b8 de.vogella.android.view/.ListView}
03-01 12:19:48.551: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 12:24:48.562: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 12:30:26.230: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 12:35:26.234: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 12:40:04.073: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 12123 objects / 568840 bytes in 3970ms
03-01 12:40:26.802: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 12:45:26.860: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 12:50:26.870: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 12:55:26.881: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:00:26.893: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:05:13.120: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 9045 objects / 399408 bytes in 396ms
03-01 13:05:26.902: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:10:26.911: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:12:22.399: DEBUG/dalvikvm(124): GC_FOR_MALLOC freed 9923 objects / 475288 bytes in 2524ms
03-01 13:15:26.920: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:20:26.932: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:25:26.940: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:30:26.951: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:35:13.142: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 9365 objects / 415184 bytes in 341ms
03-01 13:35:26.973: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:40:27.002: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:45:27.022: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:50:27.022: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 13:55:27.033: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 14:00:27.042: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 14:05:13.231: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 9887 objects / 435448 bytes in 301ms
03-01 14:05:27.054: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 14:10:27.201: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 14:15:27.212: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 14:20:27.220: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 14:21:22.572: DEBUG/AndroidRuntime(447): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 14:21:22.692: DEBUG/AndroidRuntime(447): CheckJNI is ON
03-01 14:21:36.407: DEBUG/AndroidRuntime(447): --- registering native functions ---
03-01 14:22:04.243: DEBUG/dalvikvm(189): GC_EXPLICIT freed 82 objects / 4024 bytes in 1935ms
03-01 14:22:05.207: DEBUG/PackageParser(62): Scanning package: /data/app/vmdl43691.tmp
03-01 14:22:07.851: INFO/PackageManager(62): Removing non-system package:com.calculator
03-01 14:22:07.860: INFO/ActivityManager(62): Force stopping package com.calculator uid=10049
03-01 14:22:12.341: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 7247 objects / 355976 bytes in 4381ms
03-01 14:22:13.127: INFO/ActivityManager(62): Process com.android.email (pid 239) has died.
03-01 14:22:14.381: DEBUG/PackageManager(62): Scanning package com.calculator
03-01 14:22:14.381: INFO/PackageManager(62): Package com.calculator codePath changed from /data/app/com.calculator-1.apk to /data/app/com.calculator-2.apk; Retaining data and using new
03-01 14:22:14.452: INFO/PackageManager(62): /data/app/com.calculator-2.apk changed; unpacking
03-01 14:22:14.764: DEBUG/installd(34): DexInv: --- BEGIN '/data/app/com.calculator-2.apk' ---
03-01 14:22:21.211: DEBUG/dalvikvm(455): DexOpt: load 1921ms, verify 591ms, opt 56ms
03-01 14:22:21.457: DEBUG/installd(34): DexInv: --- END '/data/app/com.calculator-2.apk' (success) ---
03-01 14:22:21.562: WARN/PackageManager(62): Code path for pkg : com.calculator changing from /data/app/com.calculator-1.apk to /data/app/com.calculator-2.apk
03-01 14:22:21.562: WARN/PackageManager(62): Resource path for pkg : com.calculator changing from /data/app/com.calculator-1.apk to /data/app/com.calculator-2.apk
03-01 14:22:21.582: INFO/ActivityManager(62): Force stopping package com.calculator uid=10049
03-01 14:22:21.590: DEBUG/PackageManager(62): Activities: com.calculator.Main
03-01 14:22:21.841: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 2895 objects / 187104 bytes in 243ms
03-01 14:22:22.441: INFO/installd(34): move /data/dalvik-cache/data@app@com.calcul...@classes.dex -> /data/dalvik-cache/data@app@com.calcul...@classes.dex
03-01 14:22:22.441: DEBUG/PackageManager(62): New package installed in /data/app/com.calculator-2.apk
03-01 14:22:22.760: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 1775 objects / 119560 bytes in 304ms
03-01 14:22:23.522: INFO/ActivityManager(62): Force stopping package com.calculator uid=10049
03-01 14:22:30.530: DEBUG/dalvikvm(127): GC_EXPLICIT freed 2723 objects / 147096 bytes in 4937ms
03-01 14:22:35.411: DEBUG/dalvikvm(62): GC_EXPLICIT freed 2208 objects / 135440 bytes in 998ms
03-01 14:22:36.944: INFO/installd(34): unlink /data/dalvik-cache/data@app@com.calcul...@classes.dex
03-01 14:22:37.132: WARN/RecognitionManagerService(62): no available voice recognition services found
03-01 14:22:37.421: DEBUG/AndroidRuntime(447): Shutting down VM
03-01 14:22:37.461: INFO/AndroidRuntime(447): NOTE: attach of thread 'Binder Thread #4' failed
03-01 14:22:37.543: DEBUG/dalvikvm(447): Debugger has detached; object registry had 1 entries
03-01 14:22:46.273: DEBUG/AndroidRuntime(460): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 14:22:46.273: DEBUG/AndroidRuntime(460): CheckJNI is ON
03-01 14:22:49.062: DEBUG/AndroidRuntime(460): --- registering native functions ---
03-01 14:22:57.601: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10000000 cmp=com.calculator/.Main }
03-01 14:22:59.442: DEBUG/AndroidRuntime(460): Shutting down VM
03-01 14:22:59.460: INFO/AndroidRuntime(460): NOTE: attach of thread 'Binder Thread #3' failed
03-01 14:22:59.472: DEBUG/dalvikvm(460): Debugger has detached; object registry had 1 entries
03-01 14:22:59.802: WARN/ActivityManager(62): Activity pause timeout for HistoryRecord{43fb36b0 com.android.launcher/com.android.launcher2.Launcher}
03-01 14:23:02.422: INFO/ActivityManager(62): Start proc com.calculator for activity com.calculator/.Main: pid=467 uid=10049 gids={}
03-01 14:23:09.283: WARN/ActivityManager(62): Launch timeout has expired, giving up wake lock!
03-01 14:23:12.081: INFO/ActivityManager(62): Displayed activity com.calculator/.Main: 11330 ms (total 7480635 ms)
03-01 14:23:16.191: DEBUG/dalvikvm(272): GC_EXPLICIT freed 46 objects / 2192 bytes in 28653ms
03-01 14:23:18.931: DEBUG/dalvikvm(127): GC_EXPLICIT freed 1372 objects / 75832 bytes in 246ms
03-01 14:24:22.061: DEBUG/AndroidRuntime(475): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 14:24:22.061: DEBUG/AndroidRuntime(475): CheckJNI is ON
03-01 14:24:28.836: DEBUG/AndroidRuntime(475): --- registering native functions ---
03-01 14:24:38.691: DEBUG/dalvikvm(189): GC_EXPLICIT freed 143 objects / 10840 bytes in 212ms
03-01 14:24:39.031: DEBUG/PackageParser(62): Scanning package: /data/app/vmdl43692.tmp
03-01 14:24:40.242: INFO/PackageManager(62): Removing non-system package:com.testcalculator
03-01 14:24:40.242: INFO/ActivityManager(62): Force stopping package com.testcalculator uid=10053
03-01 14:24:40.962: DEBUG/dalvikvm(62): GC_FOR_MALLOC freed 4526 objects / 275408 bytes in 665ms
03-01 14:24:41.850: DEBUG/PackageManager(62): Scanning package com.testcalculator
03-01 14:24:41.900: INFO/PackageManager(62): Package com.testcalculator codePath changed from /data/app/com.testcalculator-1.apk to /data/app/com.testcalculator-2.apk; Retaining data and using new
03-01 14:24:41.974: INFO/PackageManager(62): /data/app/com.testcalculator-2.apk changed; unpacking
03-01 14:24:42.061: DEBUG/installd(34): DexInv: --- BEGIN '/data/app/com.testcalculator-2.apk' ---
03-01 14:24:45.092: INFO/ActivityManager(62): Process com.android.mms (pid 223) has died.
03-01 14:24:50.611: DEBUG/dalvikvm(189): GC_EXPLICIT freed 113 objects / 9304 bytes in 4322ms
03-01 14:24:54.711: DEBUG/dalvikvm(490): DexOpt: load 693ms, verify 8160ms, opt 210ms
03-01 14:24:56.261: DEBUG/installd(34): DexInv: --- END '/data/app/com.testcalculator-2.apk' (success) ---
03-01 14:24:56.270: WARN/PackageManager(62): Code path for pkg : com.testcalculator changing from /data/app/com.testcalculator-1.apk to /data/app/com.testcalculator-2.apk
03-01 14:24:56.270: WARN/PackageManager(62): Resource path for pkg : com.testcalculator changing from /data/app/com.testcalculator-1.apk to /data/app/com.testcalculator-2.apk
03-01 14:24:56.311: INFO/ActivityManager(62): Force stopping package com.testcalculator uid=10053
03-01 14:24:56.342: DEBUG/PackageManager(62): Instrumentation: android.test.InstrumentationTestRunner
03-01 14:24:56.927: INFO/installd(34): move /data/dalvik-cache/data@app@com.testcalc...@classes.dex -> /data/dalvik-cache/data@app@com.testcalc...@classes.dex
03-01 14:24:56.941: DEBUG/PackageManager(62): New package installed in /data/app/com.testcalculator-2.apk
03-01 14:24:56.972: WARN/PackageManager(62): Not granting permission android.permission.CALL_PRIVILEGED to package com.testcalculator (protectionLevel=3 flags=0xbe44)
03-01 14:24:56.972: WARN/PackageManager(62): Not granting permission android.permission.CONTROL_LOCATION_UPDATES to package com.testcalculator (protectionLevel=3 flags=0xbe44)
03-01 14:24:57.003: WARN/PackageManager(62): Unknown permission android.permission.ACCESS_COARSE_UPDATES in package com.testcalculator
03-01 14:24:57.690: INFO/ActivityManager(62): Force stopping package com.testcalculator uid=10053
03-01 14:24:59.441: WARN/RecognitionManagerService(62): no available voice recognition services found
03-01 14:24:59.821: DEBUG/dalvikvm(62): GC_EXPLICIT freed 6804 objects / 422464 bytes in 327ms
03-01 14:25:01.332: INFO/installd(34): unlink /data/dalvik-cache/data@app@com.testcalc...@classes.dex
03-01 14:25:01.400: DEBUG/AndroidRuntime(475): Shutting down VM
03-01 14:25:01.482: INFO/AndroidRuntime(475): NOTE: attach of thread 'Binder Thread #3' failed
03-01 14:25:01.520: DEBUG/dalvikvm(475): Debugger has detached; object registry had 1 entries
03-01 14:25:05.601: DEBUG/dalvikvm(272): GC_EXPLICIT freed 19 objects / 736 bytes in 139ms
03-01 14:25:09.102: DEBUG/AndroidRuntime(503): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 14:25:09.102: DEBUG/AndroidRuntime(503): CheckJNI is ON
03-01 14:25:09.951: DEBUG/AndroidRuntime(503): --- registering native functions ---
03-01 14:25:13.684: DEBUG/AndroidRuntime(503): Shutting down VM
03-01 14:25:13.946: DEBUG/dalvikvm(503): Debugger has detached; object registry had 0 entries
03-01 14:25:16.571: DEBUG/AndroidRuntime(513): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 14:25:16.571: DEBUG/AndroidRuntime(513): CheckJNI is ON
03-01 14:25:17.841: DEBUG/AndroidRuntime(513): --- registering native functions ---
03-01 14:25:20.521: INFO/ActivityManager(62): Force stopping package com.calculator uid=10049
03-01 14:25:20.611: INFO/Process(62): Sending signal. PID: 467 SIG: 9
03-01 14:25:20.752: INFO/WindowManager(62): WIN DEATH: Window{4401d0c0 com.calculator/com.calculator.Main paused=false}
03-01 14:25:20.973: INFO/UsageStats(62): Unexpected resume of com.android.launcher while already resumed in com.calculator
03-01 14:25:21.280: INFO/ActivityManager(62): Start proc com.calculator for added application com.calculator: pid=521 uid=10049 gids={}
03-01 14:25:22.542: WARN/InputManagerService(62): Got RemoteException sending setActive(false) notification to pid 467 uid 10049
03-01 14:25:26.161: DEBUG/dalvikvm(521): GC_FOR_MALLOC freed 8392 objects / 479584 bytes in 223ms
03-01 14:25:27.550: DEBUG/dalvikvm(521): GC_FOR_MALLOC freed 9035 objects / 538784 bytes in 223ms
03-01 14:25:28.280: DEBUG/SntpClient(62): request time failed: java.net.SocketException: Address family not supported by protocol
03-01 14:25:29.830: DEBUG/dalvikvm(521): GC_FOR_MALLOC freed 7883 objects / 473640 bytes in 165ms
03-01 14:25:30.051: INFO/TestRunner(521): started: testDisplayBlackBox(com.testcalculator.TestCalculatorApk)
03-01 14:25:30.132: INFO/TestRunner(521): finished: testDisplayBlackBox(com.testcalculator.TestCalculatorApk)
03-01 14:25:30.132: INFO/TestRunner(521): passed: testDisplayBlackBox(com.testcalculator.TestCalculatorApk)
03-01 14:25:30.242: INFO/ActivityManager(62): Force stopping package com.calculator uid=10049
03-01 14:25:30.242: INFO/Process(62): Sending signal. PID: 521 SIG: 9
03-01 14:25:30.781: DEBUG/AndroidRuntime(513): Shutting down VM
03-01 14:25:30.812: DEBUG/dalvikvm(513): Debugger has detached; object registry had 1 entries
03-01 14:25:30.892: INFO/AndroidRuntime(513): NOTE: attach of thread 'Binder Thread #3' failed
03-01 14:25:32.700: DEBUG/AndroidRuntime(532): >>>>>>>>>>>>>> AndroidRuntime START <<<<<<<<<<<<<<
03-01 14:25:32.713: DEBUG/AndroidRuntime(532): CheckJNI is ON
03-01 14:25:33.461: DEBUG/AndroidRuntime(532): --- registering native functions ---
03-01 14:25:36.142: INFO/ActivityManager(62): Force stopping package com.calculator uid=10049
03-01 14:25:36.251: INFO/ActivityManager(62): Start proc com.calculator for added application com.calculator: pid=540 uid=10049 gids={}
03-01 14:25:39.112: DEBUG/dalvikvm(540): GC_FOR_MALLOC freed 8412 objects / 480352 bytes in 623ms
03-01 14:25:40.432: DEBUG/dalvikvm(540): GC_FOR_MALLOC freed 9035 objects / 538808 bytes in 163ms
03-01 14:25:42.692: DEBUG/dalvikvm(540): GC_FOR_MALLOC freed 7886 objects / 473664 bytes in 513ms
03-01 14:25:43.011: INFO/TestRunner(540): started: testDisplayBlackBox(com.testcalculator.TestCalculatorApk)
03-01 14:25:43.121: INFO/ActivityManager(62): Starting activity: Intent { act=android.intent.action.MAIN flg=0x10000000 cmp=com.calculator/.Main }
03-01 14:25:43.680: WARN/ActivityManager(62): Activity pause timeout for HistoryRecord{43fb36b0 com.android.launcher/com.android.launcher2.Launcher}
03-01 14:25:46.632: INFO/ActivityManager(62): Displayed activity com.calculator/.Main: 2952 ms (total 2952 ms)
03-01 14:25:47.571: WARN/System.err(540): java.io.FileNotFoundException: /data/data/com.calculator/files/TestData.csv (No such file or directory)
03-01 14:25:47.842: WARN/System.err(540): at org.apache.harmony.luni.platform.OSFileSystem.openImpl(Native Method)
03-01 14:25:47.842: WARN/System.err(540): at org.apache.harmony.luni.platform.OSFileSystem.open(OSFileSystem.java:152)
03-01 14:25:47.874: WARN/System.err(540): at java.io.FileInputStream.<init>(FileInputStream.java:82)
03-01 14:25:47.874: WARN/System.err(540): at android.app.ContextImpl.openFileInput(ContextImpl.java:400)
03-01 14:25:47.892: WARN/System.err(540): at android.content.ContextWrapper.openFileInput(ContextWrapper.java:152)
03-01 14:25:47.892: WARN/System.err(540): at com.testcalculator.TestCalculatorApk.getTestDataFile(TestCalculatorApk.java:203)
03-01 14:25:47.901: WARN/System.err(540): at com.testcalculator.TestCalculatorApk.testDisplayBlackBox(TestCalculatorApk.java:70)
03-01 14:25:47.901: WARN/System.err(540): at java.lang.reflect.Method.invokeNative(Native Method)
03-01 14:25:47.901: WARN/System.err(540): at java.lang.reflect.Method.invoke(Method.java:521)
03-01 14:25:47.901: WARN/System.err(540): at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:204)
03-01 14:25:47.901: WARN/System.err(540): at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:194)
03-01 14:25:47.901: WARN/System.err(540): at android.test.ActivityInstrumentationTestCase2.runTest(ActivityInstrumentationTestCase2.java:186)
03-01 14:25:47.912: WARN/System.err(540): at junit.framework.TestCase.runBare(TestCase.java:127)
03-01 14:25:47.912: WARN/System.err(540): at junit.framework.TestResult$1.protect(TestResult.java:106)
03-01 14:25:47.912: WARN/System.err(540): at junit.framework.TestResult.runProtected(TestResult.java:124)
03-01 14:25:47.912: WARN/System.err(540): at junit.framework.TestResult.run(TestResult.java:109)
03-01 14:25:47.912: WARN/System.err(540): at junit.framework.TestCase.run(TestCase.java:118)
03-01 14:25:47.912: WARN/System.err(540): at android.test.AndroidTestRunner.runTest(AndroidTestRunner.java:169)
03-01 14:25:47.912: WARN/System.err(540): at android.test.AndroidTestRunner.runTest(AndroidTestRunner.java:154)
03-01 14:25:47.912: WARN/System.err(540): at android.test.InstrumentationTestRunner.onStart(InstrumentationTestRunner.java:520)
03-01 14:25:47.912: WARN/System.err(540): at android.app.Instrumentation$InstrumentationThread.run(Instrumentation.java:1447)
03-01 14:25:48.781: WARN/WindowManager(62): Permission denied: injecting key event from pid 540 uid 10049 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 14:25:49.281: WARN/ActivityManager(62): Duplicate finish request for HistoryRecord{43f591a0 com.calculator/.Main}
03-01 14:25:49.346: WARN/ActivityManager(62): Duplicate finish request for HistoryRecord{43f591a0 com.calculator/.Main}
03-01 14:25:49.602: WARN/ActivityManager(62): Duplicate finish request for HistoryRecord{43f591a0 com.calculator/.Main}
03-01 14:25:49.633: DEBUG/dalvikvm(540): GC_EXPLICIT freed 1592 objects / 83760 bytes in 225ms
03-01 14:25:49.642: WARN/InputManagerService(62): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@43f24c70 (uid=10049 pid=540)
03-01 14:25:49.702: WARN/IInputConnectionWrapper(540): showStatusIcon on inactive InputConnection
03-01 14:25:50.652: WARN/WindowManager(62): Permission denied: injecting key event from pid 540 uid 10049 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 14:25:51.362: WARN/WindowManager(62): Permission denied: injecting key event from pid 540 uid 10049 to window Window{4400cda8 com.android.launcher/com.android.launcher2.Launcher paused=false} owned by uid 10025
03-01 14:25:51.531: DEBUG/dalvikvm(540): GC_EXPLICIT freed 249 objects / 10616 bytes in 130ms
03-01 14:25:51.561: INFO/TestRunner(540): failed: testDisplayBlackBox(com.testcalculator.TestCalculatorApk)
03-01 14:25:51.561: INFO/TestRunner(540): ----- begin exception -----
03-01 14:25:51.620: INFO/TestRunner(540): java.lang.NullPointerException
03-01 14:25:51.620: INFO/TestRunner(540): at com.testcalculator.TestCalculatorApk.getTestDataFile(TestCalculatorApk.java:213)
03-01 14:25:51.620: INFO/TestRunner(540): at com.testcalculator.TestCalculatorApk.testDisplayBlackBox(TestCalculatorApk.java:70)
03-01 14:25:51.620: INFO/TestRunner(540): at java.lang.reflect.Method.invokeNative(Native Method)
03-01 14:25:51.620: INFO/TestRunner(540): at java.lang.reflect.Method.invoke(Method.java:521)
03-01 14:25:51.620: INFO/TestRunner(540): at android.test.InstrumentationTestCase.runMethod(InstrumentationTestCase.java:204)
03-01 14:25:51.620: INFO/TestRunner(540): at android.test.InstrumentationTestCase.runTest(InstrumentationTestCase.java:194)
03-01 14:25:51.620: INFO/TestRunner(540): at android.test.ActivityInstrumentationTestCase2.runTest(ActivityInstrumentationTestCase2.java:186)
03-01 14:25:51.620: INFO/TestRunner(540): at junit.framework.TestCase.runBare(TestCase.java:127)
03-01 14:25:51.620: INFO/TestRunner(540): at junit.framework.TestResult$1.protect(TestResult.java:106)
03-01 14:25:51.620: INFO/TestRunner(540): at junit.framework.TestResult.runProtected(TestResult.java:124)
03-01 14:25:51.620: INFO/TestRunner(540): at junit.framework.TestResult.run(TestResult.java:109)
03-01 14:25:51.620: INFO/TestRunner(540): at junit.framework.TestCase.run(TestCase.java:118)
03-01 14:25:51.620: INFO/TestRunner(540): at android.test.AndroidTestRunner.runTest(AndroidTestRunner.java:169)
03-01 14:25:51.620: INFO/TestRunner(540): at android.test.AndroidTestRunner.runTest(AndroidTestRunner.java:154)
03-01 14:25:51.620: INFO/TestRunner(540): at android.test.InstrumentationTestRunner.onStart(InstrumentationTestRunner.java:520)
03-01 14:25:51.620: INFO/TestRunner(540): at android.app.Instrumentation$InstrumentationThread.run(Instrumentation.java:1447)
03-01 14:25:51.635: INFO/TestRunner(540): ----- end exception -----
03-01 14:25:51.692: INFO/TestRunner(540): finished: testDisplayBlackBox(com.testcalculator.TestCalculatorApk)
03-01 14:25:51.811: INFO/ActivityManager(62): Force stopping package com.calculator uid=10049
03-01 14:25:51.811: INFO/Process(62): Sending signal. PID: 540 SIG: 9
03-01 14:25:52.431: DEBUG/AndroidRuntime(532): Shutting down VM
03-01 14:25:52.471: DEBUG/dalvikvm(532): Debugger has detached; object registry had 0 entries
03-01 14:25:52.513: INFO/AndroidRuntime(532): NOTE: attach of thread 'Binder Thread #3' failed
Regards
Suman