--------- beginning of /dev/log/system
02-07 11:03:07.436 D/LAB126  ( 1441): got back button softkey click!
02-07 11:03:07.436 D/LAB126  ( 1441): collapse because of back button
--------- beginning of /dev/log/main
02-07 11:03:07.436 W/KeyCharacterMap( 3099): No keyboard for id 0
02-07 11:03:07.436 W/KeyCharacterMap( 3099): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
02-07 11:03:07.436 D/LAB126  ( 1441): collapse softkeys
02-07 11:03:07.444 I/MSV     ( 3099):  WebUtils futureTask is done
02-07 11:03:07.444 I/MSV     ( 3099):  WebUtils futureTask is null
02-07 11:03:07.444 I/MSV     ( 3099):  WebUtils futureTask is null
02-07 11:03:07.444 V/MSV     ( 3099):  WebUtils shutdownNow awaiting tasks: 0
02-07 11:03:07.452 D/vzAnalytics( 3099): Scheduling db and net save task
02-07 11:03:07.452 V/MSV     ( 3099):  TVCategoryListActivity onResume--CategList
02-07 11:03:07.452 V/MSV     ( 3099):  CategoryListAdapter contents size - 9
02-07 11:03:07.561 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:07.561 I/LAB126  ( 1441):  window changed
02-07 11:03:08.749 D/LAB126  ( 1441): got back button softkey click!
02-07 11:03:08.749 D/LAB126  ( 1441): collapse because of back button
02-07 11:03:08.749 D/LAB126  ( 1441): collapse softkeys
02-07 11:03:08.975 I/MSV     ( 3099):  WebUtils futureTask is done
02-07 11:03:09.014 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:09.014 I/LAB126  ( 1441):  window changed
02-07 11:03:09.014 I/LAB126  ( 1441): don't set softkey config for 'Starting...' window
02-07 11:03:09.053 W/PhoneWindow( 3099): Previously focused view reported id 16908298 during save, but can't be found during restore.
02-07 11:03:09.053 V/MSV     ( 3099):  TVShowHomeCategoryListActivity onResume--CategList
02-07 11:03:09.061 V/MSV     ( 3099):  WebUtils url:https://www36.verizon.com/MSVAppServices/Anonymous/POX/CatalogXmlServices.asmx/MSVAppRequest?
02-07 11:03:09.061 V/MSV     ( 3099):  WebUtils body:strInputXML=<MSVApp><Event>GETCATEGORIES</Event><User><strUserID></strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo></MSVApp>
02-07 11:03:09.217 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/.ui.TabMainActivity: +244ms
02-07 11:03:09.225 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:09.225 I/LAB126  ( 1441):  window changed
02-07 11:03:09.327 V/MSV     ( 3099):  CategoryListActivity onDestroy--CategList
02-07 11:03:11.100 D/LAB126  ( 1441): got back button softkey click!
02-07 11:03:11.100 D/LAB126  ( 1441): collapse because of back button
02-07 11:03:11.100 D/LAB126  ( 1441): collapse softkeys
02-07 11:03:11.100 I/MSV     ( 3099):  WebUtils trying to cancel futureTask...
02-07 11:03:11.100 I/MSV     ( 3099):  WebUtils futureTask cancelled successfully!
02-07 11:03:11.139 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:11.139 I/LAB126  ( 1441):  window changed
02-07 11:03:11.139 I/LAB126  ( 1441): don't set softkey config for 'Starting...' window
02-07 11:03:11.241 D/dalvikvm( 3099): GC_EXTERNAL_ALLOC freed 1051K, 48% free 5805K/11015K, external 6351K/6883K, paused 44ms
02-07 11:03:11.374 V/MSV     ( 3099):  TVShowHomeCategoryListActivity onDestroy--CategList
02-07 11:03:11.374 V/MSV     ( 3099):  MovieHomeCategoryListActivity onDestroy--CategList
02-07 11:03:11.374 V/MSVAppData( 3099): clearGlobalListDataExceptWatchListAndPurchaseList()...
02-07 11:03:11.491 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/.ui.MainActivity: +389ms
02-07 11:03:11.499 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:11.499 I/LAB126  ( 1441):  window changed
02-07 11:03:11.639 D/dalvikvm( 1373): GC_CONCURRENT freed 1457K, 52% free 5433K/11207K, external 3310K/4990K, paused 3ms+7ms
02-07 11:03:11.866 V/MSV     ( 3099):   finished http post call
02-07 11:03:12.131 D/skia    ( 3099): Loading ARM decoder...
02-07 11:03:12.171 D/skia    ( 3099): Loading ARM decoder...
02-07 11:03:12.202 D/dalvikvm( 3099): GC_CONCURRENT freed 2863K, 56% free 4893K/11015K, external 6303K/6477K, paused 1ms+3ms
02-07 11:03:12.249 D/dalvikvm( 3099): GC_EXTERNAL_ALLOC freed 3K, 56% free 4890K/11015K, external 6303K/6477K, paused 35ms
02-07 11:03:12.538 D/skia    ( 3099): Loading ARM decoder...
02-07 11:03:12.546 D/skia    ( 3099): Loading ARM decoder...
02-07 11:03:12.608 D/skia    ( 3099): Loading ARM decoder...
02-07 11:03:12.702 D/ActivityManager( 1373): Starting: Intent { act=android.intent.action.VIEW dat=app://com.verizon.ams.tesla/mymusic cmp=com.verizon.ams.tesla/com.verizon.mediamanager.AudioAlbumList } from pid 3099
02-07 11:03:13.053 D/mediamanager( 3099): isAuthenticated:false. SsoService.isLoggedIn:true, FVApplication.userInfo.ssoUserId:, deviceRegistration:false
02-07 11:03:13.116 D/mediamanager( 3099): validation started. setting up SSO.
02-07 11:03:13.225 V/SSOWebUtils( 3099): PrepareSSO() Start
02-07 11:03:13.335 V/SSOWebUtils( 3099): PrepareSSO() VALID COOKIE AVAILABLE
02-07 11:03:13.335 V/MSV     ( 3099):  WebUtils finished http post call
02-07 11:03:13.358 I/UrlComposer( 3099): >>>>>> GETTERMSOFSERVICE <<<<<<
02-07 11:03:13.358 V/SSOWebUtils( 3099): FetchTOS url = https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 11:03:13.358 V/SSOWebUtils( 3099): FetchTOS postData = strInputXML=<MSVApp><Event>GETUSERTOS</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo></MSVApp>
02-07 11:03:13.358 V/MSV     ( 3099):  WebUtils url:https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 11:03:13.358 V/MSV     ( 3099):  WebUtils body:strInputXML=<MSVApp><Event>GETUSERTOS</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo></MSVApp>
02-07 11:03:13.475 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:13.475 I/LAB126  ( 1441):  window changed
02-07 11:03:13.702 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/com.verizon.mediamanager.AudioAlbumList: +962ms
02-07 11:03:14.975 I/SSOWebUtils( 3099): validationResponseHandler.GET_TOS_REQUEST ...
02-07 11:03:14.975 V/MSV_TOS ( 3099): TOS CREATED
02-07 11:03:14.975 V/MSV     ( 3099):  WebUtils finished http post call
02-07 11:03:15.303 D/mediamanager( 3099): HTTP get http://www22.verizon.com/M3/svc/auth/mediaservice.svc/com/users/ironman1058/userinfo?fmt=xml
02-07 11:03:16.452 W/ResponseProcessCookies( 3099): Cookie rejected: "BasicClientCookie[version=0,name=ak-sf,domain=verizon.com,path=/m3/,expiry=Tue Feb 07 11:08:16 CST 2012]". Illegal path attribute "/m3/". Path of origin: "/M3/svc/auth/mediaservice.svc/com/users/ironman1058/userinfo"
02-07 11:03:16.467 D/mediamanager( 3099): TOKEN REFRESHED
02-07 11:03:16.616 D/mediamanager( 3099): received message from sso. msg.arg1:0
02-07 11:03:16.616 D/mediamanager( 3099): checking device registration.
02-07 11:03:16.616 E/DeviceIdentity( 3099): readPhoneNumberFile()
02-07 11:03:16.616 E/DeviceIdentity( 3099): java.io.FileNotFoundException: /data/data/com.verizon.ams.tesla/files/wtn.txt (No such file or directory)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at org.apache.harmony.luni.platform.OSFileSystem.open(Native Method)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at dalvik.system.BlockGuard$WrappedFileSystem.open(BlockGuard.java:232)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at java.io.RandomAccessFile.<init>(RandomAccessFile.java:132)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at com.verizon.ams.tesla.device.DeviceIdentity.readPhoneNumberFile(DeviceIdentity.java:87)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at com.verizon.ams.tesla.device.DeviceIdentity.getPhoneNumber(DeviceIdentity.java:54)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at com.verizon.ams.tesla.device.DeviceIdentity.getDeviceLabel(DeviceIdentity.java:42)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at com.verizon.ams.tesla.msv.data.Device.Init(Device.java:27)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at com.verizon.ams.tesla.msv.data.Device.<init>(Device.java:21)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at com.verizon.ams.tesla.device.DeviceManager.checkAndRegisterDevice(DeviceManager.java:286)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at com.verizon.mediamanager.ProtectedActivity.checkAndRegisterDevice(ProtectedActivity.java:239)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at com.verizon.mediamanager.ProtectedActivity.access$1(ProtectedActivity.java:232)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at com.verizon.mediamanager.ProtectedActivity$1.handleMessage(ProtectedActivity.java:208)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at android.os.Handler.dispatchMessage(Handler.java:99)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at android.os.Looper.loop(Looper.java:130)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at android.app.ActivityThread.main(ActivityThread.java:3683)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at java.lang.reflect.Method.invokeNative(Native Method)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at java.lang.reflect.Method.invoke(Method.java:507)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:850)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:608)
02-07 11:03:16.616 E/DeviceIdentity( 3099): 	at dalvik.system.NativeStart.main(Native Method)
02-07 11:03:16.616 V/SSOWebUtils( 3099): PrepareSSO() Start
02-07 11:03:16.741 V/SSOWebUtils( 3099): PrepareSSO() VALID COOKIE AVAILABLE
02-07 11:03:16.749 I/UrlComposer( 3099): >>>>>> GETTERMSOFSERVICE <<<<<<
02-07 11:03:16.749 V/SSOWebUtils( 3099): FetchTOS url = https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 11:03:16.749 V/SSOWebUtils( 3099): FetchTOS postData = strInputXML=<MSVApp><Event>GETUSERTOS</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo></MSVApp>
02-07 11:03:16.749 V/MSV     ( 3099):  WebUtils url:https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 11:03:16.749 V/MSV     ( 3099):  WebUtils body:strInputXML=<MSVApp><Event>GETUSERTOS</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo></MSVApp>
02-07 11:03:17.178 I/SSOWebUtils( 3099): validationResponseHandler.GET_TOS_REQUEST ...
02-07 11:03:17.178 V/MSV_TOS ( 3099): TOS CREATED
02-07 11:03:17.178 V/MSV     ( 3099):  >>>> SSO HANDLER. Response MSG =0/0
02-07 11:03:17.178 V/MSV     ( 3099):  WebUtils finished http post call
02-07 11:03:17.186 V/DeviceManager( 3099):  url: https://www36.verizon.com/MSVAppServices/Authenticated/POX/DeviceXmlServices.asmx/MSVAppRequest?
02-07 11:03:17.186 V/DeviceManager( 3099):  body: strInputXML=<MSVApp><Event>GETALLDEVICES</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo><isActiveChild>Y</isActiveChild></MSVApp>
02-07 11:03:17.186 V/MSV     ( 3099):  WebUtils url:https://www36.verizon.com/MSVAppServices/Authenticated/POX/DeviceXmlServices.asmx/MSVAppRequest?
02-07 11:03:17.186 V/MSV     ( 3099):  WebUtils body:strInputXML=<MSVApp><Event>GETALLDEVICES</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo><isActiveChild>Y</isActiveChild></MSVApp>
02-07 11:03:17.475 D/dalvikvm( 3099): GC_CONCURRENT freed 1471K, 51% free 5429K/11015K, external 7266K/8141K, paused 2ms+5ms
02-07 11:03:17.631 V/MSV     ( 3099):  WebUtils finished http post call
02-07 11:03:17.663 D/mediamanager( 3099): handlerDeviceMgr(): got 11110000:11110007
02-07 11:03:17.663 D/mediamanager( 3099): Device registration succeeded
02-07 11:03:17.663 D/mediamanager( 3099): Audio album list onValidated.
02-07 11:03:17.678 W/InputManagerService( 1373): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@4073a758
02-07 11:03:17.756 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:17.756 I/LAB126  ( 1441):  window changed
02-07 11:03:17.921 D/mediamanager( 3099): HTTP get http://www22.verizon.com/M3/svc/auth/mediaservice.svc/com/users/UserName/albums/type/AudioAlbum?fmt=xml&sortorder=ASC&SortBy=Title&dojo.preventCache=1264380228170
02-07 11:03:18.241 D/dalvikvm( 1373): GC_CONCURRENT freed 1147K, 49% free 5802K/11207K, external 3310K/4990K, paused 2ms+8ms
02-07 11:03:18.374 D/dalvikvm( 1373): GC_CONCURRENT freed 1995K, 52% free 5414K/11207K, external 3310K/4990K, paused 2ms+4ms
02-07 11:03:18.499 D/dalvikvm( 1373): GC_CONCURRENT freed 1510K, 52% free 5415K/11207K, external 3310K/4990K, paused 3ms+5ms
02-07 11:03:18.585 W/ResponseProcessCookies( 3099): Cookie rejected: "BasicClientCookie[version=0,name=ak-sf,domain=verizon.com,path=/m3/,expiry=Tue Feb 07 11:08:18 CST 2012]". Illegal path attribute "/m3/". Path of origin: "/M3/svc/auth/mediaservice.svc/com/users/UserName/albums/type/AudioAlbum"
02-07 11:03:18.639 D/dalvikvm( 1373): GC_CONCURRENT freed 1510K, 52% free 5415K/11207K, external 3310K/4990K, paused 2ms+5ms
02-07 11:03:18.647 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:18.647 I/LAB126  ( 1441):  window changed
02-07 11:03:18.796 D/dalvikvm( 1373): GC_CONCURRENT freed 1510K, 52% free 5416K/11207K, external 3310K/4990K, paused 2ms+5ms
02-07 11:03:18.967 D/dalvikvm( 1373): GC_CONCURRENT freed 1513K, 52% free 5414K/11207K, external 3310K/4990K, paused 3ms+5ms
02-07 11:03:19.085 D/dalvikvm( 1373): GC_CONCURRENT freed 1511K, 52% free 5413K/11207K, external 3310K/4990K, paused 3ms+5ms
02-07 11:03:19.210 D/dalvikvm( 1373): GC_CONCURRENT freed 1508K, 52% free 5415K/11207K, external 3310K/4990K, paused 2ms+4ms
02-07 11:03:19.296 D/dalvikvm( 1373): GC_CONCURRENT freed 1513K, 52% free 5410K/11207K, external 3310K/4990K, paused 3ms+5ms
02-07 11:03:19.366 D/dalvikvm( 1373): GC_CONCURRENT freed 1479K, 52% free 5430K/11207K, external 3310K/4990K, paused 2ms+4ms
02-07 11:03:19.436 D/dalvikvm( 1373): GC_CONCURRENT freed 1498K, 52% free 5446K/11207K, external 3310K/4990K, paused 2ms+4ms
02-07 11:03:20.405 D/ActivityManager( 1373): Starting: Intent { cmp=com.verizon.ams.tesla/com.verizon.mediamanager.AudioItemList (has extras) } from pid 3099
02-07 11:03:20.835 D/mediamanager( 3099): start getting album items pageNo #1
02-07 11:03:20.928 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:20.928 I/LAB126  ( 1441):  window changed
02-07 11:03:21.131 D/mediamanager( 3099): HTTP get http://www22.verizon.com/M3/svc/auth/mediaservice.svc/com/users/UserName/albums/05f16538-62aa-476e-8afd-9e2bf19aa742?bGetAlbums=false&fmt=xml&ftype=3&sortorder=DESC&SortBy=UploadDate&pageNo=1&pageSize=250&nonull=true&Enc=1&dojo.preventCache=1264392598150
02-07 11:03:21.171 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/com.verizon.mediamanager.AudioItemList: +762ms
02-07 11:03:21.210 D/dalvikvm( 3099): GC_FOR_MALLOC freed 1210K, 56% free 4943K/11015K, external 6508K/8076K, paused 33ms
02-07 11:03:21.538 W/ResponseProcessCookies( 3099): Cookie rejected: "BasicClientCookie[version=0,name=ak-sf,domain=verizon.com,path=/m3/,expiry=Tue Feb 07 11:08:21 CST 2012]". Illegal path attribute "/m3/". Path of origin: "/M3/svc/auth/mediaservice.svc/com/users/UserName/albums/05f16538-62aa-476e-8afd-9e2bf19aa742"
02-07 11:03:21.717 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:21.717 I/LAB126  ( 1441):  window changed
02-07 11:03:24.811 W/ProcessStats( 1373): Skipping unknown process pid 3527
02-07 11:03:24.928 D/dalvikvm( 3099): GC_EXTERNAL_ALLOC freed 563K, 56% free 4877K/11015K, external 7971K/8033K, paused 41ms
02-07 11:03:25.546 V/DeviceStorageMonitorService( 1373): mTotalMemory is 11734999
02-07 11:03:27.186 D/mediamanager( 3099): Playing 03 Billie Jean (Single Version).wav
02-07 11:03:27.186 D/ActivityManager( 1373): Starting: Intent { cmp=com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer } from pid 3099
02-07 11:03:27.241 D/mediamanager( 3099): intent received com.verizon.flexview.mediamanager.action_audio_play
02-07 11:03:27.342 D/dalvikvm( 3099): GC_EXTERNAL_ALLOC freed 294K, 58% free 4655K/11015K, external 8871K/9556K, paused 38ms
02-07 11:03:27.514 D/vzAnalytics( 3099): Moved 11 events from thread 1 to bg thread. bg thread pending events 11
02-07 11:03:27.514 D/vzAnalytics( 3099): Saving log to db on thread 11 for 11 events
02-07 11:03:27.639 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:27.639 I/LAB126  ( 1441):  window changed
02-07 11:03:27.811 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer: +569ms
02-07 11:03:27.842 D/vzAnalytics( 3099): Scheduling db and net save task
02-07 11:03:27.842 D/mediamanager( 3099): AudioPlayerService Playing : http://fvccd.verizon.net/m3/svc/dl/sec/med/dl2.dl?cxt=uU9Lc96P4fctoVe%2flHfzInW5PRjNldG%2f3cD5FGQmBte%2bTV6m6dLxxLAXcD2ZnPkCjCsaJxfxRr6zC5HD3hnTmRJOQzq9B%2fddzSnLHrHwGLw%3d&tt=14x3upyS%2fZZS1MSyJf1jkotyHjg0dNl4nGeks1bI0aaa4x3erPc4wmyEXBv6J%2ffXLmGM%2f9FYwl2FDzHrAx7ABA%3d%3d&HTTP_ACCESSPOINTID=MP007&HTTP_OS=Android&HTTP_VERSION=2.6.35.7+&HTTP_MM_APP_MEDIA=com.verizon.mediamanager&HTTP_MM_APP_VERSION=1.5.0&HTTP_HARDWARE_MODEL=Kindle_Fire&HTTP_HARDWARE_MAKE=Amazon&
02-07 11:03:27.842 W/ASFDummyExtractor( 1293): ASF parser is not available
02-07 11:03:27.842 D/AwesomePlayer( 1293): setDataSource_l(http://fvccd.verizon.net/m3/svc/dl/sec/med/dl2.dl?cxt=uU9Lc96P4fctoVe%2flHfzInW5PRjNldG%2f3cD5FGQmBte%2bTV6m6dLxxLAXcD2ZnPkCjCsaJxfxRr6zC5HD3hnTmRJOQzq9B%2fddzSnLHrHwGLw%3d&tt=14x3upyS%2fZZS1MSyJf1jkotyHjg0dNl4nGeks1bI0aaa4x3erPc4wmyEXBv6J%2ffXLmGM%2f9FYwl2FDzHrAx7ABA%3d%3d&HTTP_ACCESSPOINTID=MP007&HTTP_OS=Android&HTTP_VERSION=2.6.35.7+&HTTP_MM_APP_MEDIA=com.verizon.mediamanager&HTTP_MM_APP_VERSION=1.5.0&HTTP_HARDWARE_MODEL=Kindle_Fire&HTTP_HARDWARE_MAKE=Amazon&)
02-07 11:03:28.335 D/vzAnalytics( 3099): WiFi:true, CellData:false
02-07 11:03:28.335 D/vzAnalytics( 3099): Enqueuing server log task.
02-07 11:03:28.335 D/vzAnalytics( 3099): Running server log task on thread 11 for 11 events. url :http://www22.verizon.com/clickStream/Tracker.svc/xml/async/postmetrics
02-07 11:03:28.514 D/vzAnalytics( 3099): deleting events after server log.
02-07 11:03:28.889 E/MPEG4Extractor( 1293): both mdat,ftyp not found
02-07 11:03:29.006 D/mediamanager( 3099): intent received com.verizon.flexview.mediamanager.action_audio_play
02-07 11:03:29.139 I/vzAnalytics( 3099): complete server log task. success :true
02-07 11:03:29.913 D/Omap4ALSA( 1293): open called for devices 00000002 in mode 0 channels 00000000...
02-07 11:03:29.921 I/Omap4ALSA( 1293): Using ping-pong!
02-07 11:03:29.921 I/Omap4ALSA( 1293): Buffer size: 4096
02-07 11:03:29.921 I/Omap4ALSA( 1293): Latency: 92879
02-07 11:03:29.975 I/Omap4ALSA( 1293): Initialized ALSA PLAYBACK device 'plughw:0,0'
02-07 11:03:29.975 E/AudioHardwareALSA( 1293): RE-OPEN AFTER STANDBY:: took 65 msecs
02-07 11:03:30.522 D/IconMerger( 1441): notification for com.verizon.ams.tesla (1)
02-07 11:03:30.522 D/IconMerger( 1441): notification for com.android.systemui (1)
02-07 11:03:30.522 D/IconMerger( 1441): sum of notifications: 2
02-07 11:03:30.530 D/mediamanager( 3099): intent received com.verizon.flexview.mediamanager.action_audio_pause
02-07 11:03:30.553 D/IconMerger( 1441): notification for com.android.systemui (1)
02-07 11:03:30.553 D/IconMerger( 1441): sum of notifications: 1
02-07 11:03:31.616 D/LAB126  ( 1441): got back button softkey click!
02-07 11:03:31.616 D/LAB126  ( 1441): collapse because of back button
02-07 11:03:31.616 W/KeyCharacterMap( 3099): No keyboard for id 0
02-07 11:03:31.616 W/KeyCharacterMap( 3099): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
02-07 11:03:31.616 D/LAB126  ( 1441): collapse softkeys
02-07 11:03:31.803 D/dalvikvm( 1373): GC_CONCURRENT freed 1285K, 51% free 5588K/11207K, external 3310K/4990K, paused 2ms+6ms
02-07 11:03:32.452 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:32.452 I/LAB126  ( 1441):  window changed
02-07 11:03:33.639 D/mediamanager( 3099): Playing 03-NaKoiDilMeinSamaya.wma
02-07 11:03:33.639 D/ActivityManager( 1373): Starting: Intent { cmp=com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer } from pid 3099
02-07 11:03:33.663 D/mediamanager( 3099): intent received com.verizon.flexview.mediamanager.action_audio_play
02-07 11:03:33.710 E/Omap4ALSA( 1293): called drain&close
02-07 11:03:33.874 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:33.881 I/LAB126  ( 1441):  window changed
02-07 11:03:33.991 I/NuCachedSource2( 1293): ERROR_END_OF_STREAM
02-07 11:03:34.046 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer: +382ms
02-07 11:03:34.264 W/TimedEventQueue( 1293): Event 7 was not found in the queue, already cancelled?
02-07 11:03:34.264 D/mediamanager( 3099): AudioPlayerService Playing : http://fvccd.verizon.net/m3/svc/dl/sec/med/dl2.dl?cxt=qLvisg6an2u3W4lGZAw35DXZEVjn4bCxBrOjSFbNB5%2bMrGw6Cviq9MK7g2DWTeiSP0VT0TPTb2hF5OtVOblF9%2fdvMo5LJVa5g85p2a5hwyA%3d&tt=14x3upyS%2fZZS1MSyJf1jkotyHjg0dNl4nGeks1bI0aaa4x3erPc4wmyEXBv6J%2ffXLmGM%2f9FYwl2FDzHrAx7ABA%3d%3d&HTTP_ACCESSPOINTID=MP007&HTTP_OS=Android&HTTP_VERSION=2.6.35.7+&HTTP_MM_APP_MEDIA=com.verizon.mediamanager&HTTP_MM_APP_VERSION=1.5.0&HTTP_HARDWARE_MODEL=Kindle_Fire&HTTP_HARDWARE_MAKE=Amazon&
02-07 11:03:34.264 W/ASFDummyExtractor( 1293): ASF parser is not available
02-07 11:03:34.264 D/AwesomePlayer( 1293): setDataSource_l(http://fvccd.verizon.net/m3/svc/dl/sec/med/dl2.dl?cxt=qLvisg6an2u3W4lGZAw35DXZEVjn4bCxBrOjSFbNB5%2bMrGw6Cviq9MK7g2DWTeiSP0VT0TPTb2hF5OtVOblF9%2fdvMo5LJVa5g85p2a5hwyA%3d&tt=14x3upyS%2fZZS1MSyJf1jkotyHjg0dNl4nGeks1bI0aaa4x3erPc4wmyEXBv6J%2ffXLmGM%2f9FYwl2FDzHrAx7ABA%3d%3d&HTTP_ACCESSPOINTID=MP007&HTTP_OS=Android&HTTP_VERSION=2.6.35.7+&HTTP_MM_APP_MEDIA=com.verizon.mediamanager&HTTP_MM_APP_VERSION=1.5.0&HTTP_HARDWARE_MODEL=Kindle_Fire&HTTP_HARDWARE_MAKE=Amazon&)
02-07 11:03:36.788 D/IconMerger( 1441): notification for com.verizon.ams.tesla (1)
02-07 11:03:36.788 D/IconMerger( 1441): notification for com.android.systemui (1)
02-07 11:03:36.788 D/IconMerger( 1441): sum of notifications: 2
02-07 11:03:37.866 D/LAB126  ( 1441): got back button softkey click!
02-07 11:03:37.866 D/LAB126  ( 1441): collapse because of back button
02-07 11:03:37.866 D/LAB126  ( 1441): collapse softkeys
02-07 11:03:38.147 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:38.147 I/LAB126  ( 1441):  window changed
02-07 11:03:39.514 D/mediamanager( 3099): Playing 03 Billie Jean (Single Version).wav
02-07 11:03:39.514 D/ActivityManager( 1373): Starting: Intent { cmp=com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer } from pid 3099
02-07 11:03:39.569 D/mediamanager( 3099): intent received com.verizon.flexview.mediamanager.action_audio_play
02-07 11:03:40.077 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:40.077 I/LAB126  ( 1441):  window changed
02-07 11:03:40.233 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer: +654ms
02-07 11:03:41.725 D/mediamanager( 3099): intent received com.verizon.flexview.mediamanager.action_audio_pause
02-07 11:03:41.725 E/MediaPlayer( 3099): pause called in state 4
02-07 11:03:41.725 E/MediaPlayer( 3099): error (-38, 0)
02-07 11:03:41.733 E/MediaPlayer( 3099): Error (-38,0)
02-07 11:03:41.741 I/AwesomePlayer( 1293): interrupting the connection process
02-07 11:03:42.842 D/IconMerger( 1441): notification for com.verizon.ams.tesla (1)
02-07 11:03:42.842 D/IconMerger( 1441): notification for com.android.systemui (1)
02-07 11:03:42.842 D/IconMerger( 1441): sum of notifications: 2
02-07 11:03:47.421 I/InputDispatcher( 1373): Application is not responding: Window{40742dc0 com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer paused=false}.  5006.6ms since event, 5005.3ms since wait started
02-07 11:03:47.421 I/WindowManager( 1373): Input event dispatching timed out sending to com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer
02-07 11:03:47.421 I/Process ( 1373): Sending signal. PID: 3099 SIG: 3
02-07 11:03:47.421 I/dalvikvm( 3099): threadid=4: reacting to signal 3
02-07 11:03:47.436 I/dalvikvm( 3099): Wrote stack traces to '/data/anr/traces.txt'
02-07 11:03:47.436 I/Process ( 1373): Sending signal. PID: 1373 SIG: 3
02-07 11:03:47.436 I/dalvikvm( 1373): threadid=4: reacting to signal 3
02-07 11:03:47.475 I/dalvikvm( 1373): Wrote stack traces to '/data/anr/traces.txt'
02-07 11:03:47.475 I/Process ( 1373): Sending signal. PID: 1441 SIG: 3
02-07 11:03:47.475 I/dalvikvm( 1441): threadid=4: reacting to signal 3
02-07 11:03:47.483 I/dalvikvm( 1441): Wrote stack traces to '/data/anr/traces.txt'
02-07 11:03:47.928 D/dalvikvm( 1373): GC_EXPLICIT freed 1272K, 50% free 5687K/11207K, external 3310K/4990K, paused 130ms
02-07 11:03:48.522 D/InputDispatcher( 1373): channel '40742dc0 com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer (server)' ~ Synthesized 1 cancelation events to bring channel back in sync with reality: application not responding, options=0.
02-07 11:03:48.522 I/InputDispatcher( 1373): Dropping event because the pointer is not down.
02-07 11:03:48.522 I/InputDispatcher( 1373): Dropping event because the pointer is not down.
02-07 11:03:48.522 I/InputDispatcher( 1373): Dropping event because the pointer is not down.
02-07 11:03:48.522 E/ActivityManager( 1373): ANR in com.verizon.ams.tesla (com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer)
02-07 11:03:48.522 E/ActivityManager( 1373): Reason: keyDispatchingTimedOut
02-07 11:03:48.522 E/ActivityManager( 1373): Load: 1.22 / 0.74 / 0.54
02-07 11:03:48.522 E/ActivityManager( 1373): CPU usage from 7568ms to 2495ms ago:
02-07 11:03:48.522 E/ActivityManager( 1373):   4.9% 1441/com.android.systemui: 3.3% user + 1.5% kernel / faults: 1728 minor
02-07 11:03:48.522 E/ActivityManager( 1373):   4.3% 1373/system_server: 1.9% user + 2.3% kernel / faults: 596 minor
02-07 11:03:48.522 E/ActivityManager( 1373):   2.9% 3099/com.verizon.ams.tesla: 2.5% user + 0.3% kernel / faults: 578 minor
02-07 11:03:48.522 E/ActivityManager( 1373):   1.7% 2631/com.amazon.kindle.otter: 1.3% user + 0.3% kernel / faults: 22 minor
02-07 11:03:48.522 E/ActivityManager( 1373):   1.5% 1531/com.amazon.dcp: 1.1% user + 0.3% kernel / faults: 77 minor
02-07 11:03:48.522 E/ActivityManager( 1373):   1.1% 3/ksoftirqd/0: 0% user + 1.1% kernel
02-07 11:03:48.522 E/ActivityManager( 1373):   0.3% 1330/pvr_workqueue: 0% user + 0.3% kernel
02-07 11:03:48.522 E/ActivityManager( 1373):   0.3% 1385/pvr_display_syn: 0% user + 0.3% kernel
02-07 11:03:48.522 E/ActivityManager( 1373):   0.3% 1530/com.amazon.gardemanger: 0.1% user + 0.1% kernel / faults: 32 minor
02-07 11:03:48.522 E/ActivityManager( 1373):   0.1% 7/events/0: 0% user + 0.1% kernel
02-07 11:03:48.522 E/ActivityManager( 1373):   0.1% 8/events/1: 0% user + 0.1% kernel
02-07 11:03:48.522 E/ActivityManager( 1373):   0% 356/battery: 0% user + 0% kernel
02-07 11:03:48.522 E/ActivityManager( 1373):   0% 771/mmcqd: 0% user + 0% kernel
02-07 11:03:48.522 E/ActivityManager( 1373):   0% 1279/jbd2/mmcblk0p10: 0% user + 0% kernel
02-07 11:03:48.522 E/ActivityManager( 1373):   0% 1386/flush-179:0: 0% user + 0% kernel
02-07 11:03:48.522 E/ActivityManager( 1373):   0.1% 1593/com.amazon.venezia: 0.1% user + 0% kernel / faults: 24 minor
02-07 11:03:48.522 E/ActivityManager( 1373):   0% 1626/logcat: 0% user + 0% kernel
02-07 11:03:48.522 E/ActivityManager( 1373): 10% TOTAL: 5.7% user + 4% kernel + 0.8% iowait + 0% softirq
02-07 11:03:48.522 E/ActivityManager( 1373): CPU usage from 514ms to 1051ms later:
02-07 11:03:48.522 E/ActivityManager( 1373):   5.6% 1373/system_server: 0% user + 5.6% kernel
02-07 11:03:48.522 E/ActivityManager( 1373):     7.5% 1415/InputDispatcher: 0% user + 7.5% kernel
02-07 11:03:48.522 E/ActivityManager( 1373): 5.5% TOTAL: 0.9% user + 4.5% kernel
02-07 11:03:49.178 D/dalvikvm( 1373): GC_FOR_MALLOC freed 1284K, 49% free 5790K/11207K, external 3528K/4990K, paused 49ms
02-07 11:03:49.225 D/dalvikvm( 1373): GC_FOR_MALLOC freed 357K, 47% free 5964K/11207K, external 3524K/4401K, paused 40ms
02-07 11:03:49.272 D/dalvikvm( 1373): GC_FOR_MALLOC freed 0K, 43% free 6392K/11207K, external 3524K/4401K, paused 38ms
02-07 11:03:49.272 I/dalvikvm-heap( 1373): Grow heap (frag case) to 12.273MB for 219034-byte allocation
02-07 11:03:49.327 D/dalvikvm( 1373): GC_FOR_MALLOC freed 0K, 43% free 6606K/11463K, external 3524K/4401K, paused 39ms
02-07 11:03:52.374 W/ActivityManager( 1373):   Force finishing activity com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer
02-07 11:03:52.374 I/Process ( 1373): Sending signal. PID: 3099 SIG: 9
02-07 11:03:52.374 I/ActivityManager( 1373): Killing com.verizon.ams.tesla (pid=3099): user's request
02-07 11:03:52.428 E/InputDispatcher( 1373): channel '406efaf0 com.verizon.ams.tesla/com.verizon.mediamanager.AudioAlbumList (server)' ~ Consumer closed input channel or an error occurred.  events=0x8
02-07 11:03:52.428 E/InputDispatcher( 1373): channel '406efaf0 com.verizon.ams.tesla/com.verizon.mediamanager.AudioAlbumList (server)' ~ Channel is unrecoverably broken and will be disposed!
02-07 11:03:52.428 E/InputDispatcher( 1373): channel '4081de28 com.verizon.ams.tesla/com.verizon.ams.tesla.ui.MainActivity (server)' ~ Consumer closed input channel or an error occurred.  events=0x8
02-07 11:03:52.428 E/InputDispatcher( 1373): channel '4081de28 com.verizon.ams.tesla/com.verizon.ams.tesla.ui.MainActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
02-07 11:03:52.428 I/WindowManager( 1373): WINDOW DIED Window{406efaf0 com.verizon.ams.tesla/com.verizon.mediamanager.AudioAlbumList paused=false}
02-07 11:03:52.428 I/ActivityManager( 1373): Process com.verizon.ams.tesla (pid 3099) has died.
02-07 11:03:52.428 W/ActivityManager( 1373): Service crashed 2 times, stopping: ServiceRecord{406ec978 com.verizon.ams.tesla/.service.download.MetaDataSyncService}
02-07 11:03:52.428 W/ActivityManager( 1373): Scheduling restart of crashed service com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayerService in 5000ms
02-07 11:03:52.428 W/ActivityManager( 1373): Service crashed 2 times, stopping: ServiceRecord{406ebfa0 com.verizon.ams.tesla/.service.download.DownloadService}
02-07 11:03:52.428 I/WindowManager( 1373): WINDOW DIED Window{4081de28 com.verizon.ams.tesla/com.verizon.ams.tesla.ui.MainActivity paused=false}
02-07 11:03:52.436 E/InputDispatcher( 1373): channel '40742dc0 com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer (server)' ~ Consumer closed input channel or an error occurred.  events=0x8
02-07 11:03:52.436 E/InputDispatcher( 1373): channel '40742dc0 com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer (server)' ~ Channel is unrecoverably broken and will be disposed!
02-07 11:03:52.436 E/InputDispatcher( 1373): channel '4074e3a8 com.verizon.ams.tesla/com.verizon.mediamanager.AudioItemList (server)' ~ Consumer closed input channel or an error occurred.  events=0x8
02-07 11:03:52.436 E/InputDispatcher( 1373): channel '4074e3a8 com.verizon.ams.tesla/com.verizon.mediamanager.AudioItemList (server)' ~ Channel is unrecoverably broken and will be disposed!
02-07 11:03:52.436 I/WindowManager( 1373): WINDOW DIED Window{40742dc0 com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer paused=true}
02-07 11:03:52.436 I/WindowManager( 1373): WINDOW DIED Window{4074e3a8 com.verizon.ams.tesla/com.verizon.mediamanager.AudioItemList paused=false}
02-07 11:03:52.436 I/WindowManager( 1373): WIN DEATH: Window{40742dc0 com.verizon.ams.tesla/com.verizon.mediamanager.AudioPlayer paused=true}
02-07 11:03:52.444 W/WindowManager( 1373): Failed looking up window
02-07 11:03:52.444 W/WindowManager( 1373): java.lang.IllegalArgumentException: Requested window android.os.BinderProxy@409a26f8 does not exist
02-07 11:03:52.444 W/WindowManager( 1373): 	at com.android.server.WindowManagerService.windowForClientLocked(WindowManagerService.java:8177)
02-07 11:03:52.444 W/WindowManager( 1373): 	at com.android.server.WindowManagerService.windowForClientLocked(WindowManagerService.java:8168)
02-07 11:03:52.444 W/WindowManager( 1373): 	at com.android.server.WindowManagerService$WindowState$DeathRecipient.binderDied(WindowManagerService.java:7027)
02-07 11:03:52.444 W/WindowManager( 1373): 	at android.os.BinderProxy.sendDeathNotice(Binder.java:381)
02-07 11:03:52.444 W/WindowManager( 1373): 	at dalvik.system.NativeStart.run(Native Method)
02-07 11:03:52.444 I/WindowManager( 1373): WIN DEATH: null
02-07 11:03:52.444 I/ActivityManager( 1373): Start proc com.verizon.ams.tesla for activity com.verizon.ams.tesla/com.verizon.mediamanager.AudioItemList: pid=3553 uid=10028 gids={3003, 1015}
02-07 11:03:52.506 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:52.506 I/LAB126  ( 1441):  window changed
02-07 11:03:52.506 I/LAB126  ( 1441): don't set softkey config for 'Starting...' window
02-07 11:03:52.553 I/ActivityThread( 3553): Pub com.verizon.mediamanager.SearchSuggestion: com.verizon.mediamanager.SearchSuggestion
02-07 11:03:52.553 D/ContentProvider( 3553): Videos folder exist
02-07 11:03:52.553 D/ContentProvider( 3553): Pictures folder exists
02-07 11:03:52.561 I/MSV     ( 3553): FiosTV Remote DVR Configuration
02-07 11:03:52.561 I/MSV     ( 3553): ===============================
02-07 11:03:52.561 I/MSV     ( 3553): Config: production
02-07 11:03:52.561 I/MSV     ( 3553): Device Model: Kindle Fire
02-07 11:03:52.561 I/MSV     ( 3553): Proxy URL: https://www32.verizon.com/vvmapp2/VVM_LAB.aspx?URL=
02-07 11:03:52.561 I/MSV     ( 3553): Network Timeout: 25000 ms
02-07 11:03:52.561 I/MSV     ( 3553): ===============================
02-07 11:03:52.577 V/MSVAppData( 3553): init MSV data
02-07 11:03:52.577 V/MSVAppData( 3553): ********* DEVICEID:4f631457dd1d2ab
02-07 11:03:52.577 D/mediamanager( 3553): APP CONTEXT RECYCLING
02-07 11:03:52.585 D/mediamanager( 3553): setting environment for mmol : PRODUCTION
02-07 11:03:53.030 D/mediamanager( 3553): isAuthenticated:false. SsoService.isLoggedIn:true, FVApplication.userInfo.ssoUserId:ironman1058, deviceRegistration:false
02-07 11:03:53.030 D/mediamanager( 3553): Auto quiting com.verizon.mediamanager.AudioItemList in protected base. starting home activity
02-07 11:03:53.030 D/ActivityManager( 1373): Starting: Intent { flg=0x4000000 cmp=com.verizon.ams.tesla/.ui.MainActivity } from pid 3553
02-07 11:03:53.030 W/ActivityManager( 1373): Duplicate finish request for HistoryRecord{406a5670 com.verizon.ams.tesla/com.verizon.mediamanager.AudioItemList}
02-07 11:03:53.069 D/dalvikvm( 3553): GC_CONCURRENT freed 367K, 48% free 3112K/5959K, external 1091K/1181K, paused 1ms+2ms
02-07 11:03:53.100 D/dalvikvm( 3553): GC_EXTERNAL_ALLOC freed <1K, 48% free 3111K/5959K, external 1091K/1181K, paused 25ms
02-07 11:03:53.171 D/dalvikvm( 3553): GC_EXTERNAL_ALLOC freed 33K, 49% free 3079K/5959K, external 4841K/6045K, paused 25ms
02-07 11:03:53.530 W/ActivityManager( 1373): Activity pause timeout for HistoryRecord{406a5670 com.verizon.ams.tesla/com.verizon.mediamanager.AudioItemList}
02-07 11:03:53.897 D/mediamanager( 3553): isAuthenticated:false. SsoService.isLoggedIn:true, FVApplication.userInfo.ssoUserId:ironman1058, deviceRegistration:false
02-07 11:03:53.905 D/vzAnalytics( 3553): WiFi:true, CellData:false
02-07 11:03:53.905 D/vzAnalytics( 3553): Initializing session 1328634233910-9VPM58M
02-07 11:03:53.913 D/vzAnalytics( 3553): Started network thread 1328634233915
02-07 11:03:53.913 D/vzAnalytics( 3553): Scheduling db and net save task
02-07 11:03:53.913 I/vzAnalytics( 3553): Initialized vz analytics. version 2.0.2
02-07 11:03:53.975 D/dalvikvm( 3553): GC_EXTERNAL_ALLOC freed 153K, 47% free 3211K/5959K, external 2806K/3467K, paused 28ms
02-07 11:03:54.100 D/dalvikvm( 3553): GC_CONCURRENT freed 160K, 43% free 3481K/6087K, external 3484K/4525K, paused 1ms+2ms
02-07 11:03:54.163 W/InputManagerService( 1373): Got RemoteException sending setActive(false) notification to pid 3099 uid 10028
02-07 11:03:54.171 D/vzAnalytics( 3553): Loaded 0 config keys
02-07 11:03:54.241 V/DesEncrypter( 3553): error while decrypt: javax.crypto.IllegalBlockSizeException: last block incomplete in decryption
02-07 11:03:54.241 I/System.out( 3553): Account Migration Exception : java.lang.NullPointerException
02-07 11:03:54.264 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 11:03:54.264 I/LAB126  ( 1441):  window changed
02-07 11:03:54.288 V/DRMManager( 3553): PV Lib not linked
02-07 11:03:54.288 E/FVApplication( 3553): TRY MOTO DRM
02-07 11:03:54.288 E/FVApplication( 3553): SUCCESS bind to Janus DRM API
02-07 11:03:54.288 V/DeviceDRMInfoManager( 3553): fetchDeviceDRMInfo() :: url = http://www98-west.verizon.com/mobilesvc/adLibSvc/adLibRestSvc/Devicelist?Model=Kindle+Fire&firmware=default&ostype=android&osversion=10&appname=MM&appversion=1.5.0&format=xml
02-07 11:03:54.288 V/MSV     ( 3553):  WebUtils url:http://www98-west.verizon.com/mobilesvc/adLibSvc/adLibRestSvc/Devicelist?Model=Kindle+Fire&firmware=default&ostype=android&osversion=10&appname=MM&appversion=1.5.0&format=xml
02-07 11:03:54.288 V/MetaDataSyncService( 3553): getMediaIds(): 
02-07 11:03:54.288 W/ActivityManager( 1373): Unable to start service Intent { act=com.motorola.android.wmdrm.IWmdrmService }: not found
02-07 11:03:54.389 V/MSV     ( 3553):  WebUtils finished http get call
02-07 11:03:54.444 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/.ui.MainActivity: +911ms (total +1s998ms)
02-07 11:03:54.553 D/dalvikvm( 3553): GC_CONCURRENT freed 833K, 46% free 3977K/7303K, external 3839K/4525K, paused 1ms+2ms
02-07 11:03:54.624 V/MetaDataSyncService( 3553): downloadPurchaseList() :: url = https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 11:03:54.624 V/MetaDataSyncService( 3553): downloadPurchaseList() :: postData = strInputXML=<MSVApp><Event>GETPURCHASEDTITLES</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo><activePurchases>Y</activePurchases><pageDetails><sortOrderType>DESC</sortOrderType><sortColumn>product_purchasedDate</sortColumn><MediaFilterTypes><mediaFormatFilter>ALL</mediaFormatFilter><ratingType>AverageRating</ratingType><ratingValue></ratingValue><filterRatingMPAA>ALL</filterRatingMPAA><filterRatingTV>ALL</filterRatingTV></MediaFilterTypes></pageDetails></MSVApp>
02-07 11:03:54.624 V/MSV     ( 3553):  WebUtils url:https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 11:03:54.624 V/MSV     ( 3553):  WebUtils body:strInputXML=<MSVApp><Event>GETPURCHASEDTITLES</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo><activePurchases>Y</activePurchases><pageDetails><sortOrderType>DESC</sortOrderType><sortColumn>product_purchasedDate</sortColumn><MediaFilterTypes><mediaFormatFilter>ALL</mediaFormatFilter><ratingType>AverageRating</ratingType><ratingValue></ratingValue><filterRatingMPAA>ALL</filterRatingMPAA><filterRatingTV>ALL</filterRatingTV></MediaFilterTypes></pageDetails></MSVApp>
02-07 11:03:54.639 V/MetaDataSyncService( 3553): downloadWatchList() :: url = https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 11:03:54.647 V/MetaDataSyncService( 3553): downloadWatchList() :: postData = strInputXML=<MSVApp><Event>GETWATCHLIST</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo><pageDetails><sortOrderType>DESC</sortOrderType><sortColumn>product_dtmcreateDate</sortColumn><MediaFilterTypes><mediaFormatFilter>ALL</mediaFormatFilter><ratingType>AverageRating</ratingType><ratingValue></ratingValue><filterRatingMPAA>ALL</filterRatingMPAA><filterRatingTV>ALL</filterRatingTV></MediaFilterTypes></pageDetails></MSVApp>
02-07 11:03:54.647 V/MSV     ( 3553):  WebUtils url:https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 11:03:54.647 V/MSV     ( 3553):  WebUtils body:strInputXML=<MSVApp><Event>GETWATCHLIST</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo><pageDetails><sortOrderType>DESC</sortOrderType><sortColumn>product_dtmcreateDate</sortColumn><MediaFilterTypes><mediaFormatFilter>ALL</mediaFormatFilter><ratingType>AverageRating</ratingType><ratingValue></ratingValue><filterRatingMPAA>ALL</filterRatingMPAA><filterRatingTV>ALL</filterRatingTV></MediaFilterTypes></pageDetails></MSVApp>
02-07 11:03:54.741 V/MSV     ( 3553):   finished http post call
02-07 11:03:54.850 V/MSV     ( 3553):  WebUtils url:https://www36.verizon.com/MSVAppServices/Authenticated/POX/CatalogXmlServices.asmx/MSVAppRequest?
02-07 11:03:54.866 V/MSV     ( 3553):  WebUtils body:strInputXML=<MSVApp><Event>GETUSERRATINGS</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo></MSVApp>
02-07 11:03:54.866 V/MetaDataSyncService( 3553): getContentItemIds(): 
02-07 11:03:54.866 I/DeviceDRMInfoManager( 3553): deviceDRMHandler..
02-07 11:03:54.889 V/DeviceDRMInfoManager( 3553): DRM FOR THE DEVICE: [SM]
02-07 11:03:54.967 D/dalvikvm( 3553): GC_CONCURRENT freed 1635K, 51% free 3965K/8071K, external 3839K/4525K, paused 2ms+2ms
02-07 11:03:55.327 D/skia    ( 3553): Loading ARM decoder...
02-07 11:03:55.335 D/skia    ( 3553): Loading ARM decoder...
02-07 11:03:55.335 D/skia    ( 3553): sk_fill_input_buffer():54:: !!!Premature end of JPEG file. Sending dummy EOI. 
02-07 11:03:55.335 D/skia    ( 3553): --- decoder->decode returned false
02-07 11:03:55.335 I/System.out( 3553): resolveUri failed on bad bitmap uri: /data/data/com.verizon.ams.tesla/cache/1660802411.cachefile
02-07 11:03:55.413 D/skia    ( 3553): Loading ARM decoder...
02-07 11:03:55.444 D/dalvikvm( 3553): GC_EXTERNAL_ALLOC freed 224K, 49% free 4183K/8071K, external 4309K/4525K, paused 32ms
02-07 11:03:55.491 D/skia    ( 3553): Loading ARM decoder...
02-07 11:03:55.499 D/skia    ( 3553): sk_fill_input_buffer():54:: !!!Premature end of JPEG file. Sending dummy EOI. 
02-07 11:03:55.499 W/System.err( 3553): java.io.IOException: Mark has been invalidated.
02-07 11:03:55.499 W/System.err( 3553): 	at java.io.BufferedInputStream.reset(BufferedInputStream.java:371)
02-07 11:03:55.499 W/System.err( 3553): 	at android.graphics.BitmapFactory.nativeDecodeStream(Native Method)
02-07 11:03:55.499 W/System.err( 3553): 	at android.graphics.BitmapFactory.decodeStream(BitmapFactory.java:470)
02-07 11:03:55.499 W/System.err( 3553): 	at android.graphics.BitmapFactory.decodeFile(BitmapFactory.java:284)
02-07 11:03:55.499 W/System.err( 3553): 	at android.graphics.BitmapFactory.decodeFile(BitmapFactory.java:309)
02-07 11:03:55.499 W/System.err( 3553): 	at android.graphics.drawable.Drawable.createFromPath(Drawable.java:800)
02-07 11:03:55.499 W/System.err( 3553): 	at android.widget.ImageView.resolveUri(ImageView.java:528)
02-07 11:03:55.499 W/System.err( 3553): 	at android.widget.ImageView.setImageURI(ImageView.java:305)
02-07 11:03:55.499 W/System.err( 3553): 	at com.verizon.util.BitmapManager.tryFileCache(BitmapManager.java:145)
02-07 11:03:55.499 W/System.err( 3553): 	at com.verizon.util.BitmapManager.setBitmap(BitmapManager.java:129)
02-07 11:03:55.499 W/System.err( 3553): 	at com.verizon.util.BitmapManager.setBitmap(BitmapManager.java:113)
02-07 11:03:55.499 W/System.err( 3553): 	at com.verizon.ams.tesla.ads.MovieAdGallery.fillView(MovieAdGallery.java:161)
02-07 11:03:55.499 W/System.err( 3553): 	at com.verizon.ams.tesla.ads.MovieAdGallery.access$3(MovieAdGallery.java:160)
02-07 11:03:55.499 W/System.err( 3553): 	at com.verizon.ams.tesla.ads.MovieAdGallery$GalleryAdapter.getView(MovieAdGallery.java:153)
02-07 11:03:55.499 W/System.err( 3553): 	at android.widget.AbsSpinner.onMeasure(AbsSpinner.java:192)
02-07 11:03:55.499 W/System.err( 3553): 	at android.view.View.measure(View.java:8313)
02-07 11:03:55.499 W/System.err( 3553): 	at android.widget.RelativeLayout.measureChildHorizontal(RelativeLayout.java:581)
02-07 11:03:55.506 W/System.err( 3553): 	at android.widget.RelativeLayout.onMeasure(RelativeLayout.java:365)
02-07 11:03:55.506 W/System.err( 3553): 	at android.view.View.measure(View.java:8313)
02-07 11:03:55.506 W/System.err( 3553): 	at android.view.ViewGroup.measureChildWithMargins(ViewGroup.java:3138)
02-07 11:03:55.506 W/System.err( 3553): 	at android.widget.FrameLayout.onMeasure(FrameLayout.java:250)
02-07 11:03:55.506 W/System.err( 3553): 	at android.view.View.measure(View.java:8313)
02-07 11:03:55.506 W/System.err( 3553): 	at android.view.ViewGroup.measureChildWithMargins(ViewGroup.java:3138)
02-07 11:03:55.506 W/System.err( 3553): 	at android.widget.FrameLayout.onMeasure(FrameLayout.java:250)
02-07 11:03:55.506 W/System.err( 3553): 	at android.view.View.measure(View.java:8313)
02-07 11:03:55.506 W/System.err( 3553): 	at android.view.ViewRoot.performTraversals(ViewRoot.java:839)
02-07 11:03:55.506 W/System.err( 3553): 	at android.view.ViewRoot.handleMessage(ViewRoot.java:1859)
02-07 11:03:55.506 W/System.err( 3553): 	at android.os.Handler.dispatchMessage(Handler.java:99)
02-07 11:03:55.506 W/System.err( 3553): 	at android.os.Looper.loop(Looper.java:130)
02-07 11:03:55.506 W/System.err( 3553): 	at android.app.ActivityThread.main(ActivityThread.java:3683)
02-07 11:03:55.506 W/System.err( 3553): 	at java.lang.reflect.Method.invokeNative(Native Method)
02-07 11:03:55.506 W/System.err( 3553): 	at java.lang.reflect.Method.invoke(Method.java:507)
02-07 11:03:55.506 W/System.err( 3553): 	at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:850)
02-07 11:03:55.506 W/System.err( 3553): 	at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:608)
02-07 11:03:55.506 W/System.err( 3553): 	at dalvik.system.NativeStart.main(Native Method)
02-07 11:03:55.506 D/skia    ( 3553): ------- reset threw an exception
02-07 11:03:55.506 D/skia    ( 3553): xxxxxxxxxxxxxx failure to rewind
02-07 11:03:55.506 D/skia    ( 3553): --- decoder->decode returned false
02-07 11:03:55.506 I/System.out( 3553): resolveUri failed on bad bitmap uri: /data/data/com.verizon.ams.tesla/cache/1660802411.cachefile
02-07 11:03:55.514 D/skia    ( 3553): Loading ARM decoder...
02-07 11:03:55.546 D/skia    ( 3553): Loading ARM decoder...
02-07 11:03:55.600 D/skia    ( 3553): Loading ARM decoder...
02-07 11:03:55.913 I/MetaDataSyncService( 3553): getting purchaselist successful!
02-07 11:03:55.913 V/MSV     ( 3553):  WebUtils finished http post call
02-07 11:03:56.092 I/MetaDataSyncService( 3553): purchaselistIndex  size bobby:0
02-07 11:03:56.092 I/MetaDataSyncService( 3553): purchaselistIndex  size bobby:0
02-07 11:03:56.092 I/MetaDataSyncService( 3553): Purchasehistory list Parsing successfully
02-07 11:03:56.538 V/MSV     ( 3553): Silent request done...
02-07 11:03:56.538 V/MSV     ( 3553): getting watchlist successful!
02-07 11:03:56.546 V/MSV     ( 3553):  WebUtils finished http post call
02-07 11:03:56.546 V/MSV     ( 3553):  WebUtils finished http post call
02-07 11:03:56.608 V/MSV     ( 3553): watchlist index created!6
02-07 11:03:56.608 I/MSV     ( 3553): Watchlist Parsing successfully