--------- beginning of /dev/log/system
02-07 16:00:33.684 D/VoldCmdListener( 1289): volume unshare /mnt/sdcard ums
--------- beginning of /dev/log/main
02-07 16:00:33.700 I/PackageManager( 1373): Updating external media status from unmounted to unmounted
02-07 16:00:33.700 D/Vold    ( 1289): Volume sdcard state changing 7 (Shared-Unmounted) -> 1 (Idle-Unmounted)
02-07 16:00:33.708 I/AmazonEmail( 1750): storage path "/mnt/sdcard" unmounted
02-07 16:00:33.708 D/Tethering( 1373): sendTetherStateChangedBroadcast 1, 0, 0
02-07 16:00:33.708 D/Tethering( 1373): interfaceAdded :usb0
02-07 16:00:33.716 I/WindowManager( 1373): Setting rotation to 1, animFlags=1
02-07 16:00:33.731 I/ActivityManager( 1373): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=2 layout=268435491 uiMode=17 seq=11}
02-07 16:00:33.755 D/VoldCmdListener( 1289): volume mount /mnt/sdcard
02-07 16:00:33.755 I/Vold    ( 1289): /dev/block/vold/179:12 being considered for volume sdcard
02-07 16:00:33.755 D/Vold    ( 1289): Volume sdcard state changing 1 (Idle-Unmounted) -> 3 (Checking)
02-07 16:00:33.763 I/StorageNotification( 1441): Media state changed from {shared} -> {unmounted}
02-07 16:00:33.770 D/MediaPlayer( 6881): Couldn't open file on client side, trying server side
02-07 16:00:33.770 W/ASFDummyExtractor( 1293): ASF parser is not available
02-07 16:00:33.770 D/AwesomePlayer( 1293): setDataSource_l(http://download.contentdistribution.verizon.net/bt/fa44621be71fae3ad601f02787726aadc7a5611f)
02-07 16:00:33.825 D/dalvikvm( 1449): GC_EXTERNAL_ALLOC freed 131K, 52% free 2978K/6087K, external 2679K/2689K, paused 50ms
02-07 16:00:33.833 D/LatinKeyboard( 1449): Setting IME options
02-07 16:00:33.849 D/android.widget.MediaController( 6881): adjusting bottom margin for bottom controls container
02-07 16:00:33.849 D/MediaController( 6881): show()
02-07 16:00:33.849 D/MediaController( 6881): show()3000
02-07 16:00:33.849 D/VideoView( 6881): getBufferPercentage. buffer%:0
02-07 16:00:33.849 D/MediaController( 6881): percent downloaded = 0
02-07 16:00:33.864 I//system/bin/fsck_msdos( 1289): ** /dev/block/vold/179:12
02-07 16:00:33.864 I//system/bin/fsck_msdos( 1289): ** Phase 1 - Read FAT (compare skipped)
02-07 16:00:33.864 I//system/bin/fsck_msdos( 1289): Attempting to allocate 5121 KB for FAT
02-07 16:00:33.903 D/VideoView( 6881): getBufferPercentage. buffer%:0
02-07 16:00:33.903 D/VideoView( 6881): getBufferPercentage. buffer%:0
02-07 16:00:33.903 D/MediaController( 6881): updatePercentageDownload. buffer% = 0
02-07 16:00:33.903 D/VideoView( 6881): getBufferPercentage. buffer%:0
02-07 16:00:33.903 D/MediaController( 6881): percent downloaded = 0
02-07 16:00:33.911 D/IconMerger( 1441): notification for com.android.systemui (1)
02-07 16:00:33.911 D/IconMerger( 1441): sum of notifications: 1
02-07 16:00:34.013 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 16:00:34.013 I/LAB126  ( 1441):  window changed
02-07 16:00:34.474 I//system/bin/fsck_msdos( 1289): ** Phase 2 - Check Cluster Chains
02-07 16:00:34.684 I//system/bin/fsck_msdos( 1289): ** Phase 3 - Checking Directories
02-07 16:00:34.817 I//system/bin/fsck_msdos( 1289): /.Spotlight-V100/Store-V1/Stores/FBC5D681-46B7-46E6-B2DB-16E729ADB61E/PSID.DB has too many clusters allocated
02-07 16:00:34.817 I//system/bin/fsck_msdos( 1289): FIXED
02-07 16:00:34.856 I//system/bin/fsck_msdos( 1289): ** Phase 4 - Checking for Lost Files
02-07 16:00:34.903 I//system/bin/fsck_msdos( 1289): Free space in FSInfo block (108819) not correct (108785)
02-07 16:00:34.903 I//system/bin/fsck_msdos( 1289): FIXED
02-07 16:00:34.903 I//system/bin/fsck_msdos( 1289): Next free cluster in FSInfo block (708203) not free
02-07 16:00:34.903 I//system/bin/fsck_msdos( 1289): FIXED
02-07 16:00:34.903 I//system/bin/fsck_msdos( 1289): FIXED
02-07 16:00:34.919 I//system/bin/fsck_msdos( 1289): Attempting to allocate 5121 KB for FAT
02-07 16:00:35.083 I//system/bin/fsck_msdos( 1289): 1023 files, 435140 free (108785 clusters)
02-07 16:00:35.083 I//system/bin/fsck_msdos( 1289): FIXED
02-07 16:00:35.083 I//system/bin/fsck_msdos( 1289): MARKING FILE SYSTEM CLEAN
02-07 16:00:35.919 D/dalvikvm( 1373): GC_EXPLICIT freed 391K, 49% free 5889K/11463K, external 5353K/6685K, paused 58ms
02-07 16:00:36.192 V/DeviceStorageMonitorService( 1373): mTotalMemory is 11734999
02-07 16:00:36.849 D/MediaController( 6881): hide()
02-07 16:00:36.864 W/IInputConnectionWrapper( 1441): showStatusIcon on inactive InputConnection
02-07 16:00:38.364 D/devicestoragemonitor( 1373): internal storage not mounted
02-07 16:00:38.403 D/vzAnalytics( 6881): Moved 2 events from thread 1 to bg thread. bg thread pending events 2
02-07 16:00:38.403 D/vzAnalytics( 6881): Saving log to db on thread 11 for 2 events
02-07 16:00:39.145 I//system/bin/fsck_msdos( 1289): ***** FILE SYSTEM WAS MODIFIED *****
02-07 16:00:39.145 I/logwrapper( 1289): /system/bin/fsck_msdos terminated by exit(4)
02-07 16:00:39.145 I/PackageManager( 1373): Updating external media status from unmounted to mounted
02-07 16:00:39.145 W/Vold    ( 1289): Filesystem modified - rechecking (pass 2)
02-07 16:00:39.145 I/Vold    ( 1289): Device /dev/block/vold/179:12, target /mnt/sdcard mounted @ /mnt/secure/staging
02-07 16:00:39.145 D/Vold    ( 1289): Volume sdcard state changing 3 (Checking) -> 4 (Mounted)
02-07 16:00:39.153 D/VoldCmdListener( 1289): volume shared /mnt/sdcard ums
02-07 16:00:39.161 I/StorageNotification( 1441): Media state changed from {unmounted} -> {checking}
02-07 16:00:39.169 I/BootReceiver( 9422): Got intent with action android.intent.action.MEDIA_MOUNTED
02-07 16:00:39.169 D/VoldCmdListener( 1289): asec list
02-07 16:00:39.177 I/StorageNotification( 1441): Media state changed from {checking} -> {mounted}
02-07 16:00:39.192 D/VoldCmdListener( 1289): volume unshare /mnt/sdcard ums
02-07 16:00:39.192 W/Vold    ( 1289): Returning OperationFailed - no handler for errno 22
02-07 16:00:39.200 E/MountService( 1373): Failed to share/unshare
02-07 16:00:39.200 E/MountService( 1373): com.android.server.NativeDaemonConnectorException: Cmd {volume unshare /mnt/sdcard ums} failed with code 400 : {volume operation failed (Invalid argument)}
02-07 16:00:39.200 E/MountService( 1373): 	at com.android.server.NativeDaemonConnector.doCommand(NativeDaemonConnector.java:259)
02-07 16:00:39.200 E/MountService( 1373): 	at com.android.server.MountService.doShareUnshareVolume(MountService.java:508)
02-07 16:00:39.200 E/MountService( 1373): 	at com.android.server.MountService.setUsbMassStorageEnabled(MountService.java:1231)
02-07 16:00:39.200 E/MountService( 1373): 	at android.os.storage.IMountService$Stub.onTransact(IMountService.java:683)
02-07 16:00:39.200 E/MountService( 1373): 	at android.os.Binder.execTransact(Binder.java:320)
02-07 16:00:39.200 E/MountService( 1373): 	at dalvik.system.NativeStart.run(Native Method)
02-07 16:00:39.200 D/VoldCmdListener( 1289): volume mount /mnt/sdcard
02-07 16:00:39.200 I/PackageManager( 1373): No secure containers on sdcard
02-07 16:00:39.200 E/MountService( 1373): Failed to remount /mnt/sdcard after disabling share method ums
02-07 16:00:39.200 W/PackageManager( 1373): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.imdb.mobile (protectionLevel=2 flags=0x8be45)
02-07 16:00:39.200 W/PackageManager( 1373): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.mail in package com.android.contacts
02-07 16:00:39.208 W/PackageManager( 1373): Unknown permission android.permission.DEVICE_ADMIN in package com.lab126.otter
02-07 16:00:39.208 W/PackageManager( 1373): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.providers.calendar
02-07 16:00:39.208 W/PackageManager( 1373): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.cl in package com.android.providers.calendar
02-07 16:00:39.208 W/PackageManager( 1373): Unknown permission org.thialfihar.android.apg.permission.READ_KEY_DETAILS in package com.amazon.email
02-07 16:00:39.216 W/PackageManager( 1373): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.cooliris.media (protectionLevel=2 flags=0x8bc45)
02-07 16:00:39.216 W/PackageManager( 1373): Unknown permission com.google.android.c2dm.permission.RECEIVE in package com.ebay.mobile
02-07 16:00:39.216 W/PackageManager( 1373): Not granting permission android.permission.ACCESS_DRM to package com.verizon.ams.tesla (protectionLevel=2 flags=0x8be46)
02-07 16:00:39.216 W/PackageManager( 1373): Not granting permission android.permission.WRITE_SECURE_SETTINGS to package com.verizon.ams.tesla (protectionLevel=3 flags=0x8be46)
02-07 16:00:39.216 W/PackageManager( 1373): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.providers.contacts
02-07 16:00:39.216 W/PackageManager( 1373): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH.cp in package com.android.providers.contacts
02-07 16:00:39.216 W/PackageManager( 1373): Unknown permission com.google.android.gm.permission.WRITE_GMAIL in package com.android.settings
02-07 16:00:39.216 W/PackageManager( 1373): Unknown permission com.google.android.gm.permission.READ_GMAIL in package com.android.settings
02-07 16:00:39.216 W/PackageManager( 1373): Unknown permission com.google.android.googleapps.permission.GOOGLE_AUTH in package com.android.settings
02-07 16:00:39.216 W/PackageManager( 1373): Unknown permission com.android.launcher.permission.READ_SETTINGS in package com.android.settings
02-07 16:00:39.216 W/PackageManager( 1373): Unknown permission com.android.launcher.permission.WRITE_SETTINGS in package com.android.settings
02-07 16:00:39.216 W/PackageManager( 1373): Unknown permission com.android.launcher.permission.INSTALL_SHORTCUT in package com.amazon.cloud9
02-07 16:00:39.224 W/PackageManager( 1373): Unknown permission android.permission.STORAGE in package uk.co.economist
02-07 16:00:39.224 W/PackageManager( 1373): Unknown permission com.android.vending.BILLING in package uk.co.economist
02-07 16:00:39.224 W/PackageManager( 1373): Unknown permission android.webkit.permission.PLUGIN in package com.adobe.flashplayer
02-07 16:00:39.224 W/PackageManager( 1373): Unknown permission com.google.android.providers.gmail.permission.WRITE_GMAIL in package com.qo.android.oemvc
02-07 16:00:39.224 W/PackageManager( 1373): Unknown permission com.google.android.providers.gmail.permission.READ_GMAIL in package com.qo.android.oemvc
02-07 16:00:39.224 W/PackageManager( 1373): Unknown permission com.google.android.gm.permission.READ_GMAIL in package com.qo.android.oemvc
02-07 16:00:39.224 W/PackageManager( 1373): Unknown permission com.google.android.gm.permission.WRITE_GMAIL in package com.qo.android.oemvc
02-07 16:00:39.224 W/PackageManager( 1373): Unknown permission android.permission.READ_OWNER_DATA in package com.qo.android.oemvc
02-07 16:00:39.224 W/PackageManager( 1373): Unknown permission com.android.email.permission.ACCESS_PROVIDER in package com.qo.android.oemvc
02-07 16:00:39.224 W/PackageManager( 1373): Not granting permission com.amazon.dcp.metrics.permission.METRICS_PERMISSION to package com.alphonso.pulse (protectionLevel=2 flags=0x8be45)
02-07 16:00:39.278 D/MediaScannerService( 1761): start scanning volume external
02-07 16:00:40.263 I/AmazonEmail( 1750): storage path "/mnt/sdcard" mounted readOnly=false
02-07 16:00:40.317 V/MediaProvider( 1761): /mnt/sdcard volume ID: -1954342653
02-07 16:00:40.325 D/dalvikvm( 1441): GC_EXTERNAL_ALLOC freed 680K, 50% free 3542K/7047K, external 2926K/2950K, paused 44ms
02-07 16:00:40.325 D/vzAnalytics( 6881): WiFi:true, CellData:false
02-07 16:00:40.325 D/vzAnalytics( 6881): Enqueuing server log task.
02-07 16:00:40.325 D/vzAnalytics( 6881): Running server log task on thread 11 for 2 events. url :http://www22.verizon.com/clickStream/Tracker.svc/xml/async/postmetrics
02-07 16:00:40.349 V/MediaProvider( 1761): Attached volume: external
02-07 16:00:40.411 D/MediaScanner( 1761): found .nomedia, skipping directory
02-07 16:00:40.458 D/MediaScanner( 1761): found .nomedia, skipping directory
02-07 16:00:40.513 D/MediaScanner( 1761): found .nomedia, skipping directory
02-07 16:00:40.559 V/MediaScanner( 1761): pruneDeadThumbnailFiles... android.database.sqlite.SQLiteCursor@405317d8
02-07 16:00:40.559 V/MediaScanner( 1761): /pruneDeadThumbnailFiles... android.database.sqlite.SQLiteCursor@405317d8
02-07 16:00:40.559 D/MediaScanner( 1761):  prescan time: 26ms
02-07 16:00:40.559 D/MediaScanner( 1761):     scan time: 180ms
02-07 16:00:40.559 D/MediaScanner( 1761): postscan time: 5ms
02-07 16:00:40.559 D/MediaScanner( 1761):    total time: 211ms
02-07 16:00:40.567 I/BootReceiver( 9422): Got intent with action android.intent.action.MEDIA_SCANNER_FINISHED
02-07 16:00:40.567 D/MediaScannerService( 1761): done scanning volume external
02-07 16:00:40.606 D/MPEG4Extractor( 1293): Atom found: ftyp with size = 18
02-07 16:00:40.606 D/MPEG4Extractor( 1293): Atom found: moov with size = 9d41
02-07 16:00:40.606 D/MPEG4Extractor( 1293): Atom found: mvhd with size = 6c
02-07 16:00:40.606 D/MPEG4Extractor( 1293): Atom found: iods with size = 21
02-07 16:00:40.606 D/MPEG4Extractor( 1293): Atom found: trak with size = 3860
02-07 16:00:40.606 D/MPEG4Extractor( 1293): Atom found: tkhd with size = 5c
02-07 16:00:40.606 D/MPEG4Extractor( 1293): Atom found: mdia with size = 37fc
02-07 16:00:40.606 D/MPEG4Extractor( 1293): Atom found: mdhd with size = 20
02-07 16:00:40.606 D/MPEG4Extractor( 1293): Atom found: hdlr with size = 44
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: ftyp
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: moov
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: mvhd
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: iods
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: trak
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: tkhd
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: mdia
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: mdhd
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: hdlr
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: minf
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: vmhd
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: dinf
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: dref
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: stbl
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: stsd
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: avc1
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: avcC
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: stts
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: stsc
02-07 16:00:40.614 E/MPEG4Extractor( 1293): Chunk: stsz
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: stco
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: stss
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: trak
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: tkhd
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: mdia
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: mdhd
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: hdlr
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: minf
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: smhd
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: dinf
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: dref
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: stbl
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: stsd
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: mp4a
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: esds
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: stts
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: stsc
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: stsz
02-07 16:00:40.622 E/MPEG4Extractor( 1293): Chunk: stco
02-07 16:00:40.622 E/SEI_TI_Parser( 1293): Not Supported, SEI messages 0x0 
02-07 16:00:40.622 D/AwesomePlayer( 1293): AwesomePlayer Not VPX decoder = **video/avc** and video is = 720X404
02-07 16:00:40.630 D/OMX_CORE( 1293): TIOMX_GetHandle
02-07 16:00:40.630 E/OMX_PROXYDEC( 1293): ___INSISDE VIDEO DECODER PROXY WRAPPER__
02-07 16:00:40.817 D/OMXCodec( 1293): Flash Clip: Profile: 66, Level: 31, Interlaced: 0, RefFrames: 2
02-07 16:00:40.817 D/OMXCodec( 1293): Updated. H264 Component profile 1 level 512 NRefFrames 2
02-07 16:00:40.825 D/OMXCodec( 1293): initOutputFormat WxH 720x404 Padded 896x512 
02-07 16:00:40.825 D/AwesomePlayer( 1293):  initRenderer_l 896x512
02-07 16:00:40.825 D/AwesomePlayer( 1293):  initRenderer_l 720x404
02-07 16:00:40.825 D/OMXCodec( 1293): CodecRecommended O/P BufferCnt[7]
02-07 16:00:40.825 D/AwesomePlayer( 1293): Codec Recommended outputBuffer count 7
02-07 16:00:40.825 D/TIOverlay( 1373): Enabling the OVERLAY[0]
02-07 16:00:40.825 I/Overlay-V4L2( 1373): Openning /dev/video1
02-07 16:00:40.825 D/TIOverlay( 1373): Creating overlay from W896/H512/FMT33 ...
02-07 16:00:40.825 D/TIOverlay( 1373): mZorderUsage[0] is assigned to 0
02-07 16:00:40.825 I/TIOverlay( 1373): Setting position X0/Y3/W1024/H574
02-07 16:00:40.825 D/TIOverlay( 1373): REQUEST FOR LCD1
02-07 16:00:40.825 D/TIOverlay( 1373): found Panel Id @ [0], displayname [lcd2]
02-07 16:00:40.825 D/TIOverlay( 1373): found Display Manager @ [2], managername [2lcd]
02-07 16:00:40.825 I/TIOverlay( 1373): Position/X0/Y3/W1024/H574/R0/A255/Z1
02-07 16:00:40.825 I/TIOverlay( 1373): Adjusted Position/X0/Y3/W1024/H574
02-07 16:00:40.825 D/TIOverlay( 1293): Num of Buffers = 2
02-07 16:00:40.825 D/TIOverlay( 1293): LCD[0] NAME[lcd2] 
02-07 16:00:40.825 D/TIOverlay( 1293): LCD[0] PATH[/sys/devices/platform/omapdss/display0/enabled] 
02-07 16:00:40.825 D/TIOverlay( 1293): LCD[0] timings[46000,1024/160/150/10,600/12/20/3
02-07 16:00:40.825 D/TIOverlay( 1293): ] 
02-07 16:00:40.825 E/TIOverlay( 1293): Can't open the file[/sys/devices/platform/omapdss/display1/name]
02-07 16:00:40.825 D/TIOverlay( 1293): lcd name get failed (maybe because device has less displays than max allowed)
02-07 16:00:40.825 D/TIOverlay( 1293): MANAGER[0] NAME[lcd] 
02-07 16:00:40.825 D/TIOverlay( 1293): MANAGER[1] NAME[tv] 
02-07 16:00:40.825 D/TIOverlay( 1293): MANAGER[2] NAME[2lcd] 
02-07 16:00:40.825 D/TIHardwareRenderer( 1293): Overlay Buffer Count [as recommneded] 7
02-07 16:00:40.825 D/TIOverlay( 1293): overlay_resizeInput 896x512 7
02-07 16:00:40.833 I/OMXCodec( 1293): [OMX.TI.DUCATI1.VIDEO.DECODER] allocating 4 buffers of size 299520 on input port
02-07 16:00:40.864 I/OMXCodec( 1293): [OMX.TI.DUCATI1.VIDEO.DECODER] allocating 7 buffers of size 3145728 on output port
02-07 16:00:41.872 D/VideoView( 6881): onBufferingUpdate. percent:2
02-07 16:00:42.184 D/IconMerger( 1441): notification for com.android.systemui (1)
02-07 16:00:42.192 D/IconMerger( 1441): sum of notifications: 1
02-07 16:00:42.872 D/VideoView( 6881): onBufferingUpdate. percent:2
02-07 16:00:43.005 D/vzAnalytics( 6881): deleting events after server log.
02-07 16:00:43.145 I/vzAnalytics( 6881): complete server log task. success :true
02-07 16:00:43.872 D/VideoView( 6881): onBufferingUpdate. percent:2
02-07 16:00:44.872 D/VideoView( 6881): onBufferingUpdate. percent:3
02-07 16:00:45.872 D/VideoView( 6881): onBufferingUpdate. percent:3
02-07 16:00:46.872 D/VideoView( 6881): onBufferingUpdate. percent:3
02-07 16:00:47.872 D/VideoView( 6881): onBufferingUpdate. percent:3
02-07 16:00:48.872 D/VideoView( 6881): onBufferingUpdate. percent:3
02-07 16:00:49.872 D/VideoView( 6881): onBufferingUpdate. percent:3
02-07 16:00:49.989 D/dalvikvm( 1373): GC_CONCURRENT freed 1967K, 48% free 5962K/11463K, external 5353K/6685K, paused 2ms+4ms
02-07 16:00:50.161 D/dalvikvm( 1373): GC_CONCURRENT freed 2068K, 49% free 5941K/11463K, external 5353K/6685K, paused 2ms+4ms
02-07 16:00:50.333 D/dalvikvm( 1373): GC_CONCURRENT freed 2055K, 49% free 5934K/11463K, external 5353K/6685K, paused 3ms+4ms
02-07 16:00:50.497 D/dalvikvm( 1373): GC_CONCURRENT freed 2050K, 49% free 5932K/11463K, external 5353K/6685K, paused 2ms+3ms
02-07 16:00:50.661 D/dalvikvm( 1373): GC_CONCURRENT freed 2024K, 49% free 5940K/11463K, external 5353K/6685K, paused 3ms+4ms
02-07 16:00:50.817 D/dalvikvm( 1373): GC_CONCURRENT freed 2055K, 49% free 5932K/11463K, external 5353K/6685K, paused 3ms+4ms
02-07 16:00:50.872 D/VideoView( 6881): onBufferingUpdate. percent:3
02-07 16:00:50.966 D/dalvikvm( 1373): GC_CONCURRENT freed 2011K, 48% free 5968K/11463K, external 5353K/6685K, paused 2ms+4ms
02-07 16:00:51.028 D/dalvikvm( 1373): GC_FOR_MALLOC freed 1513K, 49% free 5924K/11463K, external 5353K/6685K, paused 49ms
02-07 16:00:51.091 D/dalvikvm( 1373): GC_FOR_MALLOC freed 1421K, 49% free 5899K/11463K, external 5353K/6685K, paused 45ms
02-07 16:00:51.255 D/dalvikvm( 1794): GC_EXPLICIT freed 84K, 53% free 3071K/6407K, external 847K/1181K, paused 31ms
02-07 16:00:51.872 D/VideoView( 6881): onBufferingUpdate. percent:4
02-07 16:00:52.872 D/VideoView( 6881): onBufferingUpdate. percent:4
02-07 16:00:53.872 D/VideoView( 6881): onBufferingUpdate. percent:4
02-07 16:00:54.872 D/VideoView( 6881): onBufferingUpdate. percent:4
02-07 16:00:55.872 D/VideoView( 6881): onBufferingUpdate. percent:4
02-07 16:00:56.286 D/dalvikvm( 1761): GC_EXPLICIT freed 85K, 50% free 2831K/5639K, external 847K/1181K, paused 33ms
02-07 16:00:56.872 D/VideoView( 6881): onBufferingUpdate. percent:6
02-07 16:00:56.872 D/MediaPlayer( 6881): getMetadata
02-07 16:00:56.880 D/MediaController( 6881): show()
02-07 16:00:56.880 D/MediaController( 6881): show()3000
02-07 16:00:56.880 D/VideoView( 6881): getBufferPercentage. buffer%:6
02-07 16:00:56.880 D/MediaController( 6881): percent downloaded = 6
02-07 16:00:56.895 E/VideoView( 6881): VideoPlaybackBroadcastReceiver intent is NULL!
02-07 16:00:56.895 D/MediaController( 6881): show()
02-07 16:00:56.895 D/MediaController( 6881): show()3000
02-07 16:00:56.919 D/VideoView( 6881): getBufferPercentage. buffer%:6
02-07 16:00:56.919 D/VideoView( 6881): getBufferPercentage. buffer%:6
02-07 16:00:56.919 D/MediaController( 6881): updatePercentageDownload. buffer% = 6
02-07 16:00:56.919 D/VideoView( 6881): getBufferPercentage. buffer%:6
02-07 16:00:56.919 D/MediaController( 6881): percent downloaded = 6
02-07 16:00:56.927 D/TIOverlay( 1293): Crop Win/X32/Y24/W720/H404
02-07 16:00:56.927 D/TIOverlay( 1293): REQUEST FOR LCD1
02-07 16:00:56.927 D/TIOverlay( 1293): found Panel Id @ [0], displayname [lcd2]
02-07 16:00:56.927 D/TIOverlay( 1293): found Display Manager @ [2], managername [2lcd]
02-07 16:00:56.942 D/AudioResampler( 1293): forcing AudioResampler quality to 2
02-07 16:00:56.942 D/Omap4ALSA( 1293): open called for devices 00000002 in mode 0 channels 00000000...
02-07 16:00:56.958 I/Omap4ALSA( 1293): Using ping-pong!
02-07 16:00:56.958 I/Omap4ALSA( 1293): Buffer size: 4096
02-07 16:00:56.958 I/Omap4ALSA( 1293): Latency: 92879
02-07 16:00:57.020 I/Omap4ALSA( 1293): Initialized ALSA PLAYBACK device 'plughw:0,0'
02-07 16:00:57.020 E/AudioHardwareALSA( 1293): RE-OPEN AFTER STANDBY:: took 76 msecs
02-07 16:00:57.380 D/VideoView( 6881): getBufferPercentage. buffer%:6
02-07 16:00:57.380 D/VideoView( 6881): getBufferPercentage. buffer%:6
02-07 16:00:57.380 D/MediaController( 6881): updatePercentageDownload. buffer% = 6
02-07 16:00:57.380 D/VideoView( 6881): getBufferPercentage. buffer%:6
02-07 16:00:57.380 D/MediaController( 6881): percent downloaded = 6
02-07 16:00:57.872 I/AwesomePlayer( 1293): cache is running low (0.46 secs) , pausing.
02-07 16:00:57.872 W/MediaPlayer( 6881): info/warning (701, 0)
02-07 16:00:57.872 D/VideoView( 6881): onBufferingUpdate. percent:7
02-07 16:00:57.872 I/MediaPlayer( 6881): Info (701,0)
02-07 16:00:58.333 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:58.333 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:58.333 D/MediaController( 6881): updatePercentageDownload. buffer% = 7
02-07 16:00:58.333 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:58.333 D/MediaController( 6881): percent downloaded = 7
02-07 16:00:58.786 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:58.786 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:58.786 D/MediaController( 6881): updatePercentageDownload. buffer% = 7
02-07 16:00:58.786 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:58.786 D/MediaController( 6881): percent downloaded = 7
02-07 16:00:58.872 D/VideoView( 6881): onBufferingUpdate. percent:7
02-07 16:00:59.239 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:59.239 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:59.239 D/MediaController( 6881): updatePercentageDownload. buffer% = 7
02-07 16:00:59.239 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:59.239 D/MediaController( 6881): percent downloaded = 7
02-07 16:00:59.692 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:59.692 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:59.692 D/MediaController( 6881): updatePercentageDownload. buffer% = 7
02-07 16:00:59.692 D/VideoView( 6881): getBufferPercentage. buffer%:7
02-07 16:00:59.692 D/MediaController( 6881): percent downloaded = 7
02-07 16:00:59.872 D/VideoView( 6881): onBufferingUpdate. percent:8
02-07 16:00:59.880 D/MediaController( 6881): hide()
02-07 16:00:59.888 W/InputManagerService( 1373): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@40739498
02-07 16:01:00.145 D/VideoView( 6881): getBufferPercentage. buffer%:8
02-07 16:01:00.145 D/VideoView( 6881): getBufferPercentage. buffer%:8
02-07 16:01:00.145 D/MediaController( 6881): updatePercentageDownload. buffer% = 8
02-07 16:01:00.145 D/VideoView( 6881): getBufferPercentage. buffer%:8
02-07 16:01:00.145 D/MediaController( 6881): percent downloaded = 8
02-07 16:01:00.872 D/VideoView( 6881): onBufferingUpdate. percent:8
02-07 16:01:01.044 D/VideoView( 6881): toggleMediaControlsVisibility
02-07 16:01:01.044 D/MediaController( 6881): show()
02-07 16:01:01.044 D/MediaController( 6881): show()3000
02-07 16:01:01.044 D/VideoView( 6881): getBufferPercentage. buffer%:8
02-07 16:01:01.044 D/MediaController( 6881): percent downloaded = 8
02-07 16:01:01.059 D/VideoView( 6881): getBufferPercentage. buffer%:8
02-07 16:01:01.059 D/VideoView( 6881): getBufferPercentage. buffer%:8
02-07 16:01:01.067 D/MediaController( 6881): updatePercentageDownload. buffer% = 8
02-07 16:01:01.067 D/VideoView( 6881): getBufferPercentage. buffer%:8
02-07 16:01:01.067 D/MediaController( 6881): percent downloaded = 8
02-07 16:01:01.122 E/Omap4ALSA( 1293): called drain&close
02-07 16:01:01.520 D/VideoView( 6881): getBufferPercentage. buffer%:8
02-07 16:01:01.520 D/VideoView( 6881): getBufferPercentage. buffer%:8
02-07 16:01:01.520 D/MediaController( 6881): updatePercentageDownload. buffer% = 8
02-07 16:01:01.520 D/VideoView( 6881): getBufferPercentage. buffer%:8
02-07 16:01:01.520 D/MediaController( 6881): percent downloaded = 8
02-07 16:01:01.872 D/VideoView( 6881): onBufferingUpdate. percent:9
02-07 16:01:01.974 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:01.974 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:01.974 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:01.974 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:01.974 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:02.427 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:02.427 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:02.427 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:02.427 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:02.427 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:02.536 D/MediaController( 6881): show()3600000
02-07 16:01:02.583 D/Omap4ALSA( 1293): open called for devices 00000002 in mode 0 channels 00000000...
02-07 16:01:02.591 I/Omap4ALSA( 1293): Using ping-pong!
02-07 16:01:02.591 I/Omap4ALSA( 1293): Buffer size: 4096
02-07 16:01:02.591 I/Omap4ALSA( 1293): Latency: 92879
02-07 16:01:02.661 I/Omap4ALSA( 1293): Initialized ALSA PLAYBACK device 'plughw:0,0'
02-07 16:01:02.661 E/AudioHardwareALSA( 1293): RE-OPEN AFTER STANDBY:: took 80 msecs
02-07 16:01:02.708 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:02.716 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:02.716 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:02.716 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:02.716 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:02.716 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:03.302 I/NuCachedSource2( 1293): new range: offset= 10565775
02-07 16:01:03.669 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:03.669 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:03.669 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:03.669 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:03.669 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:04.614 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:04.614 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:04.614 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:04.614 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:04.614 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:05.567 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:05.567 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:05.567 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:05.567 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:05.567 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:05.739 E/Omap4ALSA( 1293): called drain&close
02-07 16:01:06.317 D/dalvikvm( 1750): GC_EXPLICIT freed 27K, 50% free 2934K/5831K, external 847K/1181K, paused 31ms
02-07 16:01:06.513 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:06.513 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:06.513 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:06.513 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:06.513 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:07.466 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:07.466 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:07.466 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:07.466 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:07.466 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:07.692 D/MediaController( 6881): hide()
02-07 16:01:07.700 W/InputManagerService( 1373): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@40688878
02-07 16:01:08.411 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:08.411 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:08.411 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:08.411 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:08.411 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:09.013 D/VideoView( 6881): toggleMediaControlsVisibility
02-07 16:01:09.013 D/MediaController( 6881): show()
02-07 16:01:09.013 D/MediaController( 6881): show()3000
02-07 16:01:09.013 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:09.013 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:09.028 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:09.028 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:09.028 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:09.028 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:09.028 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:09.888 D/MediaController( 6881): show()3600000
02-07 16:01:10.028 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:10.036 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:10.036 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:10.036 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:10.036 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:10.036 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:10.825 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:10.825 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:10.825 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:10.825 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:10.825 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:11.622 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:11.622 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:11.622 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:11.622 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:11.622 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:12.411 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:12.411 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:12.411 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:12.411 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:12.411 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:13.200 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:13.200 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:13.200 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:13.200 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:13.200 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:13.997 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:13.997 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:13.997 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:13.997 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:13.997 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:14.786 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:14.786 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:14.786 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:14.786 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:14.786 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:15.013 D/MediaController( 6881): hide()
02-07 16:01:15.020 W/InputManagerService( 1373): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@407345c0
02-07 16:01:15.575 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:15.575 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:15.575 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:15.575 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:15.575 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:19.606 D/VideoView( 6881): toggleMediaControlsVisibility
02-07 16:01:19.606 D/MediaController( 6881): show()
02-07 16:01:19.606 D/MediaController( 6881): show()3000
02-07 16:01:19.606 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:19.606 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:19.622 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:19.622 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:19.622 D/MediaController( 6881): updatePercentageDownload. buffer% = 9
02-07 16:01:19.622 D/VideoView( 6881): getBufferPercentage. buffer%:9
02-07 16:01:19.622 D/MediaController( 6881): percent downloaded = 9
02-07 16:01:19.966 I/AwesomePlayer( 1293): cache is running low (1.62 secs) , pausing.
02-07 16:01:19.966 W/MediaPlayer( 6881): info/warning (701, 0)
02-07 16:01:19.966 D/VideoView( 6881): onBufferingUpdate. percent:62
02-07 16:01:19.966 I/MediaPlayer( 6881): Info (701,0)
02-07 16:01:20.013 D/Omap4ALSA( 1293): open called for devices 00000002 in mode 0 channels 00000000...
02-07 16:01:20.020 I/Omap4ALSA( 1293): Using ping-pong!
02-07 16:01:20.020 I/Omap4ALSA( 1293): Buffer size: 4096
02-07 16:01:20.020 I/Omap4ALSA( 1293): Latency: 92879
02-07 16:01:20.075 I/Omap4ALSA( 1293): Initialized ALSA PLAYBACK device 'plughw:0,0'
02-07 16:01:20.075 E/AudioHardwareALSA( 1293): RE-OPEN AFTER STANDBY:: took 65 msecs
02-07 16:01:20.411 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:20.411 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:20.411 D/MediaController( 6881): updatePercentageDownload. buffer% = 62
02-07 16:01:20.411 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:20.411 D/MediaController( 6881): percent downloaded = 62
02-07 16:01:21.208 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:21.208 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:21.208 D/MediaController( 6881): updatePercentageDownload. buffer% = 62
02-07 16:01:21.208 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:21.208 D/MediaController( 6881): percent downloaded = 62
02-07 16:01:21.224 I/NuCachedSource2( 1293): new range: offset= 1658955
02-07 16:01:21.997 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:21.997 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:21.997 D/MediaController( 6881): updatePercentageDownload. buffer% = 62
02-07 16:01:21.997 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:21.997 D/MediaController( 6881): percent downloaded = 62
02-07 16:01:22.606 D/MediaController( 6881): hide()
02-07 16:01:22.614 W/InputManagerService( 1373): Window already focused, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@408ad748
02-07 16:01:22.786 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:22.786 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:22.786 D/MediaController( 6881): updatePercentageDownload. buffer% = 62
02-07 16:01:22.786 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:22.786 D/MediaController( 6881): percent downloaded = 62
02-07 16:01:23.247 E/Omap4ALSA( 1293): called drain&close
02-07 16:01:24.052 D/VideoView( 6881): toggleMediaControlsVisibility
02-07 16:01:24.052 D/MediaController( 6881): show()
02-07 16:01:24.052 D/MediaController( 6881): show()3000
02-07 16:01:24.052 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:24.052 D/MediaController( 6881): percent downloaded = 62
02-07 16:01:24.067 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:24.067 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:24.075 D/MediaController( 6881): updatePercentageDownload. buffer% = 62
02-07 16:01:24.075 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:24.075 D/MediaController( 6881): percent downloaded = 62
02-07 16:01:24.864 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:24.864 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:24.864 D/MediaController( 6881): updatePercentageDownload. buffer% = 62
02-07 16:01:24.864 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:24.864 D/MediaController( 6881): percent downloaded = 62
02-07 16:01:31.442 D/dalvikvm( 1373): GC_FOR_MALLOC freed 1768K, 49% free 5903K/11463K, external 5353K/6685K, paused 48ms
02-07 16:01:33.052 I/InputDispatcher( 1373): Application is not responding: Window{4097e080 Panel:com.verizon.ams.tesla/com.verizon.ams.tesla.msv.PreviewActivity paused=false}.  5011.1ms since event, 5002.1ms since wait started
02-07 16:01:33.052 I/WindowManager( 1373): Input event dispatching timed out sending to Panel:com.verizon.ams.tesla/com.verizon.ams.tesla.msv.PreviewActivity
02-07 16:01:33.067 I/Process ( 1373): Sending signal. PID: 6881 SIG: 3
02-07 16:01:33.067 I/dalvikvm( 6881): threadid=4: reacting to signal 3
02-07 16:01:33.083 I/dalvikvm( 6881): Wrote stack traces to '/data/anr/traces.txt'
02-07 16:01:33.083 I/Process ( 1373): Sending signal. PID: 1373 SIG: 3
02-07 16:01:33.083 I/dalvikvm( 1373): threadid=4: reacting to signal 3
02-07 16:01:33.099 I/dalvikvm( 1373): Wrote stack traces to '/data/anr/traces.txt'
02-07 16:01:33.099 I/Process ( 1373): Sending signal. PID: 1441 SIG: 3
02-07 16:01:33.099 I/dalvikvm( 1441): threadid=4: reacting to signal 3
02-07 16:01:33.099 I/dalvikvm( 1441): Wrote stack traces to '/data/anr/traces.txt'
02-07 16:01:33.286 D/dalvikvm( 1373): GC_EXPLICIT freed 733K, 47% free 6151K/11463K, external 5353K/6685K, paused 60ms
02-07 16:01:33.325 I/AwesomePlayer( 1293): cache is running low (0.95 secs) , pausing.
02-07 16:01:33.325 D/MediaController( 6881): hide()
02-07 16:01:33.333 W/MediaPlayer( 6881): info/warning (701, 0)
02-07 16:01:33.333 D/MediaController( 6881): show()
02-07 16:01:33.333 D/MediaController( 6881): show()3000
02-07 16:01:33.333 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:33.333 D/MediaController( 6881): percent downloaded = 62
02-07 16:01:33.333 D/MediaController( 6881): show()3000
02-07 16:01:33.333 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:33.333 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:33.333 D/MediaController( 6881): updatePercentageDownload. buffer% = 62
02-07 16:01:33.333 D/VideoView( 6881): getBufferPercentage. buffer%:62
02-07 16:01:33.333 D/MediaController( 6881): percent downloaded = 62
02-07 16:01:33.341 D/VideoView( 6881): onBufferingUpdate. percent:13
02-07 16:01:33.341 I/MediaPlayer( 6881): Info (701,0)
02-07 16:01:33.372 D/Omap4ALSA( 1293): open called for devices 00000002 in mode 0 channels 00000000...
02-07 16:01:33.380 I/Omap4ALSA( 1293): Using ping-pong!
02-07 16:01:33.380 I/Omap4ALSA( 1293): Buffer size: 4096
02-07 16:01:33.380 I/Omap4ALSA( 1293): Latency: 92879
02-07 16:01:33.411 D/VideoView( 6881): getBufferPercentage. buffer%:13
02-07 16:01:33.411 D/VideoView( 6881): getBufferPercentage. buffer%:13
02-07 16:01:33.411 D/MediaController( 6881): updatePercentageDownload. buffer% = 13
02-07 16:01:33.411 D/VideoView( 6881): getBufferPercentage. buffer%:13
02-07 16:01:33.411 D/MediaController( 6881): percent downloaded = 13
02-07 16:01:33.442 I/Omap4ALSA( 1293): Initialized ALSA PLAYBACK device 'plughw:0,0'
02-07 16:01:33.442 E/AudioHardwareALSA( 1293): RE-OPEN AFTER STANDBY:: took 73 msecs
02-07 16:01:33.825 I/InputDispatcher( 1373): Dropping event because the pointer is not down.
02-07 16:01:33.825 I/InputDispatcher( 1373): Dropping event because the pointer is not down.
02-07 16:01:33.825 I/InputDispatcher( 1373): Dropping event because the pointer is not down.
02-07 16:01:33.825 E/ActivityManager( 1373): ANR in com.verizon.ams.tesla (com.verizon.ams.tesla/.msv.PreviewActivity)
02-07 16:01:33.825 E/ActivityManager( 1373): Reason: keyDispatchingTimedOut
02-07 16:01:33.825 E/ActivityManager( 1373): Load: 0.5 / 0.3 / 0.23
02-07 16:01:33.825 E/ActivityManager( 1373): CPU usage from 6705ms to 1673ms ago:
02-07 16:01:33.825 E/ActivityManager( 1373):   1.3% 3/ksoftirqd/0: 0% user + 1.3% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):   0.9% 1432/tiwlan_wq: 0% user + 0.9% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):   0.7% 1373/system_server: 0.7% user + 0% kernel / faults: 14 minor
02-07 16:01:33.825 E/ActivityManager( 1373):   0.7% 2631/com.amazon.kindle.otter: 0.7% user + 0% kernel / faults: 3 minor
02-07 16:01:33.825 E/ActivityManager( 1373):   0.3% 7/events/0: 0% user + 0.3% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):   0.1% 356/battery: 0% user + 0.1% kernel
02-07 16:01:33.825 E/ActivityManager( 1373): 2.5% TOTAL: 0.4% user + 1.6% kernel + 0.3% softirq
02-07 16:01:33.825 E/ActivityManager( 1373): CPU usage from 233ms to 750ms later:
02-07 16:01:33.825 E/ActivityManager( 1373):   10% 1293/mediaserver: 0% user + 10% kernel / faults: 9 minor
02-07 16:01:33.825 E/ActivityManager( 1373):     8.9% 1369/Playback Thread: 0% user + 8.9% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):     1.4% 9448/NuCachedSource2: 0% user + 1.4% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):   8.3% 6881/com.verizon.ams.tesla: 5% user + 3.3% kernel / faults: 594 minor
02-07 16:01:33.825 E/ActivityManager( 1373):     6.6% 6881/rizon.ams.tesla: 5% user + 1.6% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):     1.6% 6886/Compiler: 1.6% user + 0% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):   7.6% 1373/system_server: 1.9% user + 5.7% kernel / faults: 587 minor
02-07 16:01:33.825 E/ActivityManager( 1373):     3.8% 1380/SurfaceFlinger: 3.8% user + 0% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):     1.9% 1378/Binder Thread #: 1.9% user + 0% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):     1.9% 1415/InputDispatcher: 0% user + 1.9% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):     1.9% 1494/Binder Thread #: 1.9% user + 0% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):     1.9% 1521/Binder Thread #: 0% user + 1.9% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):     1.9% 1525/Binder Thread #: 0% user + 1.9% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):     1.9% 1526/Binder Thread #: 1.9% user + 0% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):   1.4% 7/events/0: 0% user + 1.4% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):   1.5% 1303/adbd: 0% user + 1.5% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):     1.5% 1303/adbd: 0% user + 1.5% kernel
02-07 16:01:33.825 E/ActivityManager( 1373):   1.9% 1432/tiwlan_wq: 0% user + 1.9% kernel
02-07 16:01:33.825 E/ActivityManager( 1373): 18% TOTAL: 6.7% user + 11% kernel
02-07 16:01:33.880 D/dalvikvm( 1373): GC_FOR_MALLOC freed 652K, 48% free 5963K/11463K, external 5357K/6685K, paused 49ms
02-07 16:01:33.880 I/dalvikvm-heap( 1373): Grow heap (frag case) to 13.563MB for 134338-byte allocation
02-07 16:01:33.934 D/dalvikvm( 1373): GC_FOR_MALLOC freed 0K, 48% free 6095K/11655K, external 5357K/6685K, paused 44ms
02-07 16:01:34.255 D/dalvikvm( 1373): GC_FOR_MALLOC freed 117K, 49% free 6054K/11655K, external 5571K/6685K, paused 50ms
02-07 16:01:34.255 I/dalvikvm-heap( 1373): Grow heap (frag case) to 13.925MB for 201502-byte allocation
02-07 16:01:34.309 D/dalvikvm( 1373): GC_FOR_MALLOC freed <1K, 48% free 6250K/11911K, external 5571K/6685K, paused 46ms
02-07 16:01:34.325 D/VideoView( 6881): onBufferingUpdate. percent:14
02-07 16:01:34.364 D/dalvikvm( 1373): GC_FOR_MALLOC freed 132K, 49% free 6118K/11911K, external 5567K/6685K, paused 48ms
02-07 16:01:34.364 I/dalvikvm-heap( 1373): Grow heap (frag case) to 14.080MB for 302248-byte allocation
02-07 16:01:34.419 D/dalvikvm( 1373): GC_FOR_MALLOC freed 0K, 48% free 6413K/12231K, external 5567K/6685K, paused 46ms
02-07 16:01:34.520 D/dalvikvm( 1373): GC_FOR_MALLOC freed 220K, 50% free 6225K/12231K, external 5567K/6685K, paused 47ms
02-07 16:01:34.528 I/dalvikvm-heap( 1373): Grow heap (frag case) to 14.329MB for 453368-byte allocation
02-07 16:01:34.583 D/dalvikvm( 1373): GC_FOR_MALLOC freed 0K, 48% free 6668K/12679K, external 5567K/6685K, paused 46ms
02-07 16:01:34.630 D/dalvikvm( 1373): GC_FOR_MALLOC freed 295K, 50% free 6373K/12679K, external 5567K/6685K, paused 45ms
02-07 16:01:34.684 D/dalvikvm( 1373): GC_FOR_MALLOC freed 442K, 48% free 6594K/12679K, external 5567K/6685K, paused 46ms
02-07 16:01:34.731 D/dalvikvm( 1373): GC_FOR_MALLOC freed <1K, 44% free 7114K/12679K, external 5567K/6685K, paused 44ms
02-07 16:01:34.731 I/dalvikvm-heap( 1373): Grow heap (frag case) to 15.019MB for 266570-byte allocation
02-07 16:01:34.786 D/dalvikvm( 1373): GC_FOR_MALLOC freed 0K, 44% free 7375K/12999K, external 5567K/6685K, paused 45ms
02-07 16:01:35.325 D/VideoView( 6881): onBufferingUpdate. percent:15
02-07 16:01:36.192 V/DeviceStorageMonitorService( 1373): mTotalMemory is 11734999
02-07 16:01:36.325 D/VideoView( 6881): onBufferingUpdate. percent:16
02-07 16:01:36.333 D/MediaController( 6881): hide()
02-07 16:01:36.528 E/Omap4ALSA( 1293): called drain&close
02-07 16:01:37.325 D/VideoView( 6881): onBufferingUpdate. percent:17
02-07 16:01:38.325 D/VideoView( 6881): onBufferingUpdate. percent:18
02-07 16:01:38.903 W/ActivityManager( 1373):   Force finishing activity com.verizon.ams.tesla/.msv.PreviewActivity
02-07 16:01:38.903 I/Process ( 1373): Sending signal. PID: 6881 SIG: 9
02-07 16:01:38.903 I/ActivityManager( 1373): Killing com.verizon.ams.tesla (pid=6881): user's request
02-07 16:01:39.388 E/InputDispatcher( 1373): channel '406dab00 com.verizon.ams.tesla/com.verizon.ams.tesla.ui.MainActivity (server)' ~ Consumer closed input channel or an error occurred.  events=0x8
02-07 16:01:39.388 E/InputDispatcher( 1373): channel '406dab00 com.verizon.ams.tesla/com.verizon.ams.tesla.ui.MainActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
02-07 16:01:39.388 W/TimedEventQueue( 1293): Event 85 was not found in the queue, already cancelled?
02-07 16:01:39.388 I/WindowManager( 1373): WINDOW DIED Window{406dab00 com.verizon.ams.tesla/com.verizon.ams.tesla.ui.MainActivity paused=false}
02-07 16:01:39.388 I/ActivityManager( 1373): Process com.verizon.ams.tesla (pid 6881) has died.
02-07 16:01:39.388 W/ActivityManager( 1373): Scheduling restart of crashed service com.verizon.ams.tesla/com.verizon.mediamanager.queue.QueueService in 5000ms
02-07 16:01:39.388 W/ActivityManager( 1373): Scheduling restart of crashed service com.verizon.ams.tesla/.service.download.MetaDataSyncService in 15000ms
02-07 16:01:39.388 W/ActivityManager( 1373): Scheduling restart of crashed service com.verizon.ams.tesla/.service.download.DownloadService in 25000ms
02-07 16:01:39.395 E/InputDispatcher( 1373): channel '40ab4848 com.verizon.ams.tesla/com.verizon.ams.tesla.ui.TabMainActivity (server)' ~ Consumer closed input channel or an error occurred.  events=0x8
02-07 16:01:39.395 E/InputDispatcher( 1373): channel '40ab4848 com.verizon.ams.tesla/com.verizon.ams.tesla.ui.TabMainActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
02-07 16:01:39.395 E/InputDispatcher( 1373): channel '409ba860 com.verizon.ams.tesla/com.verizon.ams.tesla.msv.PreviewActivity (server)' ~ Consumer closed input channel or an error occurred.  events=0x8
02-07 16:01:39.395 E/InputDispatcher( 1373): channel '409ba860 com.verizon.ams.tesla/com.verizon.ams.tesla.msv.PreviewActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
02-07 16:01:39.395 I/WindowManager( 1373): WINDOW DIED Window{40ab4848 com.verizon.ams.tesla/com.verizon.ams.tesla.ui.TabMainActivity paused=false}
02-07 16:01:39.395 I/WindowManager( 1373): WIN DEATH: Window{409b6280 com.verizon.ams.tesla/com.verizon.ams.tesla.msv.DetailedProgActivity paused=false}
02-07 16:01:39.403 I/WindowManager( 1373): WIN DEATH: Window{409f76e8 SurfaceView paused=false}
02-07 16:01:39.403 W/ActivityManager( 1373): Activity pause timeout for HistoryRecord{406a34a0 com.verizon.ams.tesla/.msv.PreviewActivity}
02-07 16:01:39.403 I/WindowManager( 1373): WIN DEATH: Window{4074ed10 com.verizon.ams.tesla/com.verizon.ams.tesla.msv.MovieListActivity paused=false}
02-07 16:01:39.403 W/WindowManager( 1373): Failed looking up window
02-07 16:01:39.403 W/WindowManager( 1373): java.lang.IllegalArgumentException: Requested window android.os.BinderProxy@40962aa8 does not exist
02-07 16:01:39.403 W/WindowManager( 1373): 	at com.android.server.WindowManagerService.windowForClientLocked(WindowManagerService.java:8177)
02-07 16:01:39.403 W/WindowManager( 1373): 	at com.android.server.WindowManagerService.windowForClientLocked(WindowManagerService.java:8168)
02-07 16:01:39.403 W/WindowManager( 1373): 	at com.android.server.WindowManagerService$WindowState$DeathRecipient.binderDied(WindowManagerService.java:7027)
02-07 16:01:39.403 W/WindowManager( 1373): 	at android.os.BinderProxy.sendDeathNotice(Binder.java:381)
02-07 16:01:39.403 W/WindowManager( 1373): 	at dalvik.system.NativeStart.run(Native Method)
02-07 16:01:39.403 I/WindowManager( 1373): WIN DEATH: null
02-07 16:01:39.411 E/InputDispatcher( 1373): Received spurious receive callback for unknown input channel.  fd=263, events=0x8
02-07 16:01:39.411 E/InputDispatcher( 1373): Received spurious receive callback for unknown input channel.  fd=270, events=0x8
02-07 16:01:39.411 I/WindowManager( 1373): WINDOW DIED Window{409ba860 com.verizon.ams.tesla/com.verizon.ams.tesla.msv.PreviewActivity paused=true}
02-07 16:01:39.411 I/WindowManager( 1373): WIN DEATH: Window{409ba860 com.verizon.ams.tesla/com.verizon.ams.tesla.msv.PreviewActivity paused=true}
02-07 16:01:39.419 D/OMX_CORE( 1293): TIOMX_FreeHandle
02-07 16:01:39.419 I/ActivityManager( 1373): Start proc com.verizon.ams.tesla for activity com.verizon.ams.tesla/.msv.DetailedProgActivity: pid=9483 uid=10028 gids={3003, 1015}
02-07 16:01:39.434 I/TIOverlay( 1373): Destroying overlay/fd=169/obj=47410000
02-07 16:01:39.434 D/TIOverlay( 1373): mZorderUsage[0] = 0 should be removed
02-07 16:01:39.450 I/WindowManager( 1373): Setting rotation to 0, animFlags=1
02-07 16:01:39.450 I/ActivityManager( 1373): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=1 layout=268435491 uiMode=17 seq=12}
02-07 16:01:39.489 D/LatinKeyboard( 1449): Setting IME options
02-07 16:01:39.520 D/IconMerger( 1441): notification for com.android.systemui (1)
02-07 16:01:39.520 D/IconMerger( 1441): sum of notifications: 1
02-07 16:01:39.536 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 16:01:39.536 I/LAB126  ( 1441):  window changed
02-07 16:01:39.536 I/LAB126  ( 1441): don't set softkey config for 'Starting...' window
02-07 16:01:39.575 I/ActivityThread( 9483): Pub com.verizon.mediamanager.SearchSuggestion: com.verizon.mediamanager.SearchSuggestion
02-07 16:01:39.575 D/ContentProvider( 9483): Videos folder exist
02-07 16:01:39.583 D/ContentProvider( 9483): Pictures folder exists
02-07 16:01:39.583 I/MSV     ( 9483): FiosTV Remote DVR Configuration
02-07 16:01:39.583 I/MSV     ( 9483): ===============================
02-07 16:01:39.591 I/MSV     ( 9483): Config: production
02-07 16:01:39.591 I/MSV     ( 9483): Device Model: Kindle Fire
02-07 16:01:39.591 I/MSV     ( 9483): Proxy URL: https://www32.verizon.com/vvmapp2/VVM_LAB.aspx?URL=
02-07 16:01:39.591 I/MSV     ( 9483): Network Timeout: 25000 ms
02-07 16:01:39.591 I/MSV     ( 9483): ===============================
02-07 16:01:39.614 W/libutils.threads( 1293): Thread (this=0x11f228): don't call waitForExit() from this Thread object's thread. It's a guaranteed deadlock!
02-07 16:01:39.614 V/MSVAppData( 9483): init MSV data
02-07 16:01:39.614 V/MSVAppData( 9483): ********* DEVICEID:4f631457dd1d2ab
02-07 16:01:39.622 D/mediamanager( 9483): APP CONTEXT RECYCLING
02-07 16:01:39.622 D/mediamanager( 9483): setting environment for mmol : PRODUCTION
02-07 16:01:40.317 D/dalvikvm( 9483): GC_CONCURRENT freed 368K, 48% free 3108K/5959K, external 933K/1181K, paused 1ms+1ms
02-07 16:01:40.356 D/dalvikvm( 9483): GC_EXTERNAL_ALLOC freed 23K, 49% free 3085K/5959K, external 933K/1181K, paused 25ms
02-07 16:01:40.419 D/dalvikvm( 9483): GC_EXTERNAL_ALLOC freed <1K, 49% free 3085K/5959K, external 4683K/5848K, paused 25ms
02-07 16:01:40.591 D/dalvikvm( 9483): GC_CONCURRENT freed 214K, 45% free 3403K/6087K, external 3255K/3507K, paused 1ms+2ms
02-07 16:01:40.614 E/DetailedProgActivity( 9483): content ID is null
02-07 16:01:40.614 D/vzAnalytics( 9483): WiFi:true, CellData:false
02-07 16:01:40.622 D/vzAnalytics( 9483): Initializing session 1328652100625-N4MUNGQ
02-07 16:01:40.622 D/vzAnalytics( 9483): Started network thread 1328652100630
02-07 16:01:40.622 D/vzAnalytics( 9483): Scheduling db and net save task
02-07 16:01:40.622 I/vzAnalytics( 9483): Initialized vz analytics. version 2.0.2
02-07 16:01:40.630 E/DetailedProgActivity( 9483): content ID is null
02-07 16:01:40.677 V/DesEncrypter( 9483): error while decrypt: javax.crypto.IllegalBlockSizeException: last block incomplete in decryption
02-07 16:01:40.677 I/System.out( 9483): Account Migration Exception : java.lang.NullPointerException
02-07 16:01:40.692 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/.msv.DetailedProgActivity: +1s279ms
02-07 16:01:40.724 V/DRMManager( 9483): PV Lib not linked
02-07 16:01:40.724 E/FVApplication( 9483): TRY MOTO DRM
02-07 16:01:40.724 E/FVApplication( 9483): SUCCESS bind to Janus DRM API
02-07 16:01:40.724 V/DeviceDRMInfoManager( 9483): 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 16:01:40.724 V/MSV     ( 9483):  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 16:01:40.724 V/MetaDataSyncService( 9483): getMediaIds(): 
02-07 16:01:40.724 W/ActivityManager( 1373): Unable to start service Intent { act=com.motorola.android.wmdrm.IWmdrmService }: not found
02-07 16:01:40.747 W/InputManagerService( 1373): Got RemoteException sending setActive(false) notification to pid 6881 uid 10028
02-07 16:01:40.833 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 16:01:40.833 I/LAB126  ( 1441):  window changed
02-07 16:01:41.208 D/vzAnalytics( 9483): Loaded 0 config keys
02-07 16:01:41.809 V/MSV     ( 9483):  WebUtils finished http get call
02-07 16:01:41.856 V/MetaDataSyncService( 9483): downloadPurchaseList() :: url = https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 16:01:41.856 V/MetaDataSyncService( 9483): 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 16:01:41.856 V/MSV     ( 9483):  WebUtils url:https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 16:01:41.856 V/MSV     ( 9483):  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 16:01:41.856 V/MetaDataSyncService( 9483): downloadWatchList() :: url = https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 16:01:41.856 V/MetaDataSyncService( 9483): 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 16:01:41.856 V/MSV     ( 9483):  WebUtils url:https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 16:01:41.856 V/MSV     ( 9483):  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 16:01:42.052 V/MSV     ( 9483):  WebUtils url:https://www36.verizon.com/MSVAppServices/Authenticated/POX/CatalogXmlServices.asmx/MSVAppRequest?
02-07 16:01:42.052 V/MSV     ( 9483):  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 16:01:42.052 V/MetaDataSyncService( 9483): getContentItemIds(): 
02-07 16:01:42.052 I/DeviceDRMInfoManager( 9483): deviceDRMHandler..
02-07 16:01:42.075 V/DeviceDRMInfoManager( 9483): DRM FOR THE DEVICE: [SM]
02-07 16:01:42.825 D/dalvikvm( 9483): GC_CONCURRENT freed 707K, 45% free 3980K/7175K, external 3255K/3507K, paused 1ms+2ms
02-07 16:01:42.895 D/dalvikvm( 1373): GC_EXPLICIT freed 1865K, 54% free 6068K/12999K, external 5567K/6685K, paused 65ms
02-07 16:01:43.122 D/GetUserAlerts( 1806): Making GetUserAlertsRequest
02-07 16:01:43.130 D/GetUserAlerts( 1806): getRequestURL=http://clientalerts.ebay.com/ws/ecasvc/ClientAlerts?callname=GetUserAlerts&SessionID=AQAAATU7XFAAAA0xfDE5MTA4NTI3fDEyNjk4NTU5fDQ5MTIyfDEzMjg3MTU3MDIzNzaKPUCB9etnOqKd7gVVjuSd86dBnA%3D%3D&SessionData=AQAAATU7XFAAAA1TSUQ9MTkxMDg1Mjd8U1Q9MXwxfExBQ1RWPTEzMjg2NTE3NDM0OTB8RUhXTT0zNjY5NTY3OTA0fFRJRFg9MXxMSVVQPTEzMjg2MjkzMDIzNDV8UExIUz1bXYMfen0t23IF07UnF1DOVf%2FtYl0Q
02-07 16:01:43.614 D/GetUserAlerts( 1806): Parsing JSON=
02-07 16:01:43.614 D/GetUserAlerts( 1806): {"Timestamp":"2012-02-07T22:01:43.769Z","Ack":"Success","Build":"E745_CORE_BUNDLED_14006276_R1","Version":"745","SessionData":"AQAAATU7XFAAAA1TSUQ9MTkxMDg1Mjd8U1Q9MXwxfExBQ1RWPTEzMjg2NTIxMDM3NTN8RUhXTT0zNjY5NTY3OTA0fFRJRFg9MXxMSVVQPTEzMjg2MjkzMDIzNDV8UExIUz1bXWXseYqPmi6+ilrCpggg/nuFf7LQ"}
02-07 16:01:43.614 D/GetUserAlerts( 1806): Call was success but no alerts
02-07 16:01:43.614 D/GetUserAlerts( 1806): Got response ackCode=1
02-07 16:01:43.614 D/GetUserAlerts( 1806): Ack Success, session data=AQAAATU7XFAAAA1TSUQ9MTkxMDg1Mjd8U1Q9MXwxfExBQ1RWPTEzMjg2NTIxMDM3NTN8RUhXTT0zNjY5NTY3OTA0fFRJRFg9MXxMSVVQPTEzMjg2MjkzMDIzNDV8UExIUz1bXWXseYqPmi6+ilrCpggg/nuFf7LQ
02-07 16:01:45.020 I/MetaDataSyncService( 9483): getting purchaselist successful!
02-07 16:01:45.020 V/MSV     ( 9483):  WebUtils finished http post call
02-07 16:01:46.013 I/MetaDataSyncService( 9483): purchaselistIndex  size bobby:0
02-07 16:01:46.013 I/MetaDataSyncService( 9483): purchaselistIndex  size bobby:0
02-07 16:01:46.013 I/MetaDataSyncService( 9483): Purchasehistory list Parsing successfully
02-07 16:01:46.591 V/MSV     ( 9483): Silent request done...
02-07 16:01:46.591 V/MSV     ( 9483): getting watchlist successful!
02-07 16:01:46.591 V/MSV     ( 9483):  WebUtils finished http post call
02-07 16:01:46.591 V/MSV     ( 9483):  WebUtils finished http post call
02-07 16:01:46.895 V/MSV     ( 9483): watchlist index created!8
02-07 16:01:46.895 I/MSV     ( 9483): Watchlist Parsing successfully
02-07 16:01:51.294 D/dalvikvm( 1373): GC_CONCURRENT freed 2149K, 55% free 5966K/12999K, external 5567K/6685K, paused 2ms+4ms
02-07 16:01:51.474 D/dalvikvm( 1373): GC_CONCURRENT freed 2082K, 55% free 5932K/12999K, external 5567K/6685K, paused 2ms+4ms
02-07 16:01:51.645 D/dalvikvm( 1373): GC_CONCURRENT freed 2006K, 55% free 5973K/12999K, external 5567K/6685K, paused 2ms+4ms
02-07 16:01:51.802 D/dalvikvm( 1373): GC_CONCURRENT freed 2083K, 55% free 5937K/12999K, external 5567K/6685K, paused 3ms+4ms
02-07 16:01:51.958 D/dalvikvm( 1373): GC_CONCURRENT freed 2047K, 55% free 5937K/12999K, external 5567K/6685K, paused 3ms+4ms
02-07 16:01:52.114 D/dalvikvm( 1373): GC_CONCURRENT freed 2057K, 55% free 5922K/12999K, external 5567K/6685K, paused 3ms+4ms
02-07 16:01:52.231 D/dalvikvm( 1373): GC_CONCURRENT freed 2022K, 55% free 5944K/12999K, external 5567K/6685K, paused 2ms+3ms
02-07 16:01:52.309 D/dalvikvm( 1373): GC_CONCURRENT freed 2025K, 55% free 5959K/12999K, external 5567K/6685K, paused 2ms+4ms
02-07 16:02:00.630 D/vzAnalytics( 9483): Moved 2 events from thread 1 to bg thread. bg thread pending events 2
02-07 16:02:00.630 D/vzAnalytics( 9483): Saving log to db on thread 11 for 2 events
02-07 16:02:00.763 D/vzAnalytics( 9483): WiFi:true, CellData:false
02-07 16:02:00.763 D/vzAnalytics( 9483): Enqueuing server log task.
02-07 16:02:00.763 D/vzAnalytics( 9483): Running server log task on thread 11 for 1 events. url :http://www22.verizon.com/clickStream/Tracker.svc/xml/async/postmetrics
02-07 16:02:01.036 D/vzAnalytics( 9483): deleting events after server log.
02-07 16:02:01.091 I/vzAnalytics( 9483): complete server log task. success :true
02-07 16:02:01.091 D/vzAnalytics( 9483): Scheduling db and net save task
02-07 16:02:08.630 D/LAB126  ( 1441): got back button softkey click!
02-07 16:02:08.630 D/LAB126  ( 1441): collapse because of back button
02-07 16:02:08.630 D/LAB126  ( 1441): collapse softkeys
02-07 16:02:08.638 W/KeyCharacterMap( 9483): No keyboard for id 0
02-07 16:02:08.638 W/KeyCharacterMap( 9483): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
02-07 16:02:08.645 I/MSV     ( 9483):  WebUtils futureTask is null
02-07 16:02:08.653 I/MSV     ( 9483):  WebUtils futureTask is null
02-07 16:02:08.653 I/MSV     ( 9483):  WebUtils futureTask is null
02-07 16:02:08.653 I/MSV     ( 9483):  WebUtils futureTask is null
02-07 16:02:08.653 I/MSV     ( 9483):  WebUtils futureTask is null
02-07 16:02:08.755 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 16:02:08.755 I/LAB126  ( 1441):  window changed
02-07 16:02:08.755 I/LAB126  ( 1441): don't set softkey config for 'Starting...' window
02-07 16:02:08.950 D/dalvikvm( 9483): GC_EXTERNAL_ALLOC freed 913K, 44% free 4367K/7751K, external 3494K/3507K, paused 87ms
02-07 16:02:08.974 I/System.out( 9483): Current web string ::ALL
02-07 16:02:08.974 V/MovieListActivity( 9483): Generic list, size:0
02-07 16:02:08.981 V/MovieListActivity( 9483): downloadGenericList() :: url = https://www36.verizon.com/MSVAppServices/Anonymous/POX/CatalogXmlServices.asmx/MSVAppRequest?
02-07 16:02:08.981 V/MovieListActivity( 9483): downloadGenericList() :: postData = strInputXML=<MSVApp><Event>GETALLCONTENTLISTBYCATEGORYID</Event><User><strUserID></strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo><pageDetails><PageIndex>1</PageIndex><PageCount>40</PageCount><sortOrderType>DESC</sortOrderType><sortColumn>product_releaseDate</sortColumn></pageDetails><categoryID>25</categoryID><MediaFilterTypes><mediaFormatFilter>ALL</mediaFormatFilter><ratingType>AverageRating</ratingType><ratingValue></ratingValue><filterRatingMPAA>ALL</filterRatingMPAA><filterRatingTV>ALL</filterRatingTV></MediaFilterTypes><ContentType>MOV</ContentType><ChannelID></ChannelID></MSVApp>
02-07 16:02:08.981 V/MSV     ( 9483):  WebUtils url:https://www36.verizon.com/MSVAppServices/Anonymous/POX/CatalogXmlServices.asmx/MSVAppRequest?
02-07 16:02:08.981 V/MSV     ( 9483):  WebUtils body:strInputXML=<MSVApp><Event>GETALLCONTENTLISTBYCATEGORYID</Event><User><strUserID></strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo><pageDetails><PageIndex>1</PageIndex><PageCount>40</PageCount><sortOrderType>DESC</sortOrderType><sortColumn>product_releaseDate</sortColumn></pageDetails><categoryID>25</categoryID><MediaFilterTypes><mediaFormatFilter>ALL</mediaFormatFilter><ratingType>AverageRating</ratingType><ratingValue></ratingValue><filterRatingMPAA>ALL</filterRatingMPAA><filterRatingTV>ALL</filterRatingTV></MediaFilterTypes><ContentType>MOV</ContentType><ChannelID></ChannelID></MSVApp>
02-07 16:02:08.981 V/MSV     ( 9483):  WebUtils finished http post call
02-07 16:02:09.013 V/MovieListActivity( 9483): received response msg:999
02-07 16:02:09.013 V/SSOWebUtils( 9483): PrepareSSO() Start
02-07 16:02:09.114 V/SSOWebUtils( 9483): PrepareSSO() VALID COOKIE AVAILABLE
02-07 16:02:09.122 I/UrlComposer( 9483): >>>>>> GETUSERPROFILE <<<<<<
02-07 16:02:09.122 V/SSOWebUtils( 9483): fetchUserProfile() :: url = https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 16:02:09.122 V/SSOWebUtils( 9483): fetchUserProfile() :: postData = strInputXML=<MSVApp><Event>GETMSVPROFILE</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo></MSVApp>
02-07 16:02:09.122 V/MSV     ( 9483):  WebUtils url:https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 16:02:09.122 V/MSV     ( 9483):  WebUtils body:strInputXML=<MSVApp><Event>GETMSVPROFILE</Event><User><strUserID>ironman1058</strUserID><strDomain>DNET</strDomain></User><TransactionInfo><strTransactionID>trans_12</strTransactionID><strAccessPoint>BB001</strAccessPoint></TransactionInfo></MSVApp>
02-07 16:02:09.122 E/MovieListActivity( 9483): handle generic
02-07 16:02:09.239 V/MSV     ( 9483): PURCHASELIST IDs:[WBTP1328107094680477, SONY0010474301127850, TVNX0010860801141870, TVNX0011209401152270, WBTP1323116595527397, SONY0010651101133520, WBTP1317061145235690, TVNX0009593701098380, PMTP0001261122421053, TVNX0009376200912750, TVNX0010055601110700, TVNX0010786701137970, WBTP1316201044662793, WBTP1310991461084205, WBTP1310991433020613, NUTP1312900667299100, LGPG1309960083414352, PMTP0001305035883654, LGPG1283276977198981]
02-07 16:02:09.263 V/MSV     ( 9483):  WebUtils url:http://www36.verizon.com/MSVAppServices/anonymous/Images/Drive__HD__HD_128x192_bc.jpg
02-07 16:02:09.263 V/MSV     ( 9483):  WebUtils url:http://www36.verizon.com/MSVAppServices/anonymous/Images/Drive__HD__HD_128x192_bc.jpg
02-07 16:02:09.270 V/MSV     ( 9483):  WebUtils finished http get call
02-07 16:02:09.270 V/MSV     ( 9483):  WebUtils finished http get call
02-07 16:02:09.380 V/MSV     ( 9483):  WebUtils url:http://www36.verizon.com/MSVAppServices/anonymous/Images/Drive__HD__HD_128x192_bc.jpg
02-07 16:02:09.380 V/MSV     ( 9483):  WebUtils finished http get call
02-07 16:02:09.481 V/MSV     ( 9483):  WebUtils url:http://www36.verizon.com/MSVAppServices/anonymous/Images/In_Time__HD__HD_128x192_bc.jpg
02-07 16:02:09.489 V/MSV     ( 9483):  WebUtils finished http get call
02-07 16:02:09.583 V/MSV     ( 9483):  WebUtils url:http://www36.verizon.com/MSVAppServices/anonymous/Images/Moneyball__HD__HD_128x192_bc.jpg
02-07 16:02:09.583 V/MSV     ( 9483):  WebUtils finished http get call
02-07 16:02:09.692 V/MSV     ( 9483):  WebUtils url:http://www36.verizon.com/MSVAppServices/anonymous/Images/Real_Steel__HD__HD_128x192_bc.jpg
02-07 16:02:09.708 V/MSV     ( 9483):  WebUtils finished http get call
02-07 16:02:09.802 V/MSV     ( 9483):  WebUtils url:http://www36.verizon.com/MSVAppServices/anonymous/Images/Dream_House__HD__HD_128x192_bc.jpg
02-07 16:02:09.802 V/MSV     ( 9483):  WebUtils finished http get call
02-07 16:02:09.880 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/.msv.MovieListActivity: +1s221ms
02-07 16:02:09.880 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 16:02:09.880 I/LAB126  ( 1441):  window changed
02-07 16:02:09.888 D/skia    ( 9483): Loading ARM decoder...
02-07 16:02:09.895 V/ MovieGridAdapter ( 9483): set view at position 0
02-07 16:02:09.895 V/ MovieGridAdapter ( 9483): update bitmap at position 0
02-07 16:02:09.895 D/skia    ( 9483): Loading ARM decoder...
02-07 16:02:09.895 V/ MovieGridAdapter ( 9483): set view at position 0
02-07 16:02:09.895 V/ MovieGridAdapter ( 9483): update bitmap at position 0
02-07 16:02:09.895 D/skia    ( 9483): Loading ARM decoder...
02-07 16:02:09.927 D/skia    ( 9483): Loading ARM decoder...
02-07 16:02:09.974 D/dalvikvm( 9483): GC_CONCURRENT freed 1017K, 44% free 4471K/7943K, external 3778K/4397K, paused 2ms+2ms
02-07 16:02:09.974 D/skia    ( 9483): Loading ARM decoder...
02-07 16:02:09.989 D/skia    ( 9483): Loading ARM decoder...
02-07 16:02:09.997 D/skia    ( 9483): Loading ARM decoder...
02-07 16:02:10.005 D/skia    ( 9483): Loading ARM decoder...
02-07 16:02:10.005 D/skia    ( 9483): Loading ARM decoder...
02-07 16:02:10.950 I/SSOWebUtils( 9483): validationResponseHandler.GET_MSV_PROFILE_REQUEST..
02-07 16:02:10.950 V/MSV     ( 9483):  WebUtils finished http post call
02-07 16:02:10.966 V/SSOWebUtils( 9483): User Profile: [userId:reswio0m][domain:DNET][userType:A][subscriptionAvailable:false][timeOffset:0]
02-07 16:02:10.974 I/UrlComposer( 9483): >>>>>> GETTERMSOFSERVICE <<<<<<
02-07 16:02:10.974 V/SSOWebUtils( 9483): FetchTOS url = https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 16:02:10.974 V/SSOWebUtils( 9483): 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 16:02:10.974 V/MSV     ( 9483):  WebUtils url:https://www36.verizon.com/MSVAppServices/Authenticated/POX/AccountMgrXmlServices.asmx/MSVAppRequest?
02-07 16:02:10.974 V/MSV     ( 9483):  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 16:02:12.700 I/SSOWebUtils( 9483): validationResponseHandler.GET_TOS_REQUEST ...
02-07 16:02:12.700 V/MSV_TOS ( 9483): TOS CREATED
02-07 16:02:12.708 V/MSV     ( 9483):  >>>> SSO HANDLER. Response MSG =0/0
02-07 16:02:12.708 V/MSV     ( 9483):  WebUtils finished http post call
02-07 16:02:12.981 V/MovieListActivity( 9483): select video :TVNX0011286001154030
02-07 16:02:12.981 I/MSV     ( 9483):  WebUtils futureTask is done
02-07 16:02:12.981 I/MSV     ( 9483):  WebUtils futureTask is null
02-07 16:02:12.981 I/MSV     ( 9483):  WebUtils futureTask is null
02-07 16:02:12.981 V/MSV     ( 9483):  WebUtils shutdownNow awaiting tasks: 0
02-07 16:02:12.981 D/ActivityManager( 1373): Starting: Intent { cmp=com.verizon.ams.tesla/.msv.DetailedProgActivity } from pid 9483
02-07 16:02:13.013 V/DetailedProgActivity( 9483): >>>>>> onCreate = 1
02-07 16:02:13.013 I/DetailedProgActivity( 9483): contentID=TVNX0011286001154030
02-07 16:02:13.013 V/DetailedProgActivity( 9483): >>>>>> onCreate = 1
02-07 16:02:13.013 I/DetailedProgActivity( 9483): contentID=TVNX0011286001154030
02-07 16:02:13.013 I/DetailedProgActivity( 9483): updateUI...
02-07 16:02:13.013 V/DetailedProgActivity( 9483): >>>>> onResume():: mMediaId = 
02-07 16:02:13.013 V/ITEM-DETAIL( 9483): Prod_ID= 220609 transID= 
02-07 16:02:13.013 D/skia    ( 9483): Loading ARM decoder...
02-07 16:02:13.020 V/MSV     ( 9483):  WebUtils url:http://www36.verizon.com/MSVAppServices/anonymous/Images/Drive__HD__HD_272x408_po.jpg
02-07 16:02:13.106 D/dalvikvm( 1373): GC_CONCURRENT freed 1769K, 53% free 6139K/12999K, external 5567K/6685K, paused 3ms+8ms
02-07 16:02:13.208 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 16:02:13.208 I/LAB126  ( 1441):  window changed
02-07 16:02:13.380 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/.msv.DetailedProgActivity: +396ms
02-07 16:02:14.802 V/MSV     ( 9483):  WebUtils finished http get call
02-07 16:02:14.802 D/skia    ( 9483): Loading ARM decoder...
02-07 16:02:14.841 D/dalvikvm( 9483): GC_CONCURRENT freed 1040K, 41% free 5197K/8711K, external 4244K/4397K, paused 2ms+3ms
02-07 16:02:15.786 D/ActivityManager( 1373): Starting: Intent { cmp=com.verizon.ams.tesla/.msv.PreviewActivity (has extras) } from pid 9483
02-07 16:02:15.794 I/MSV     ( 9483):  WebUtils futureTask is done
02-07 16:02:15.794 I/MSV     ( 9483):  WebUtils futureTask is null
02-07 16:02:15.794 I/MSV     ( 9483):  WebUtils futureTask is null
02-07 16:02:15.794 I/MSV     ( 9483):  WebUtils futureTask is null
02-07 16:02:15.794 I/MSV     ( 9483):  WebUtils futureTask is null
02-07 16:02:15.794 I/WindowManager( 1373): Setting rotation to 1, animFlags=1
02-07 16:02:15.794 I/ActivityManager( 1373): Config changed: { scale=1.0 imsi=0/0 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=2 layout=268435491 uiMode=17 seq=13}
02-07 16:02:15.817 D/LatinKeyboard( 1449): Setting IME options
02-07 16:02:15.841 I/Preview ( 9483): PreviewActivity started!
02-07 16:02:15.919 D/IconMerger( 1441): notification for com.android.systemui (1)
02-07 16:02:15.919 D/mediamanager( 9483): intent received com.verizon.flexview.mediamanager.action_audio_pause
02-07 16:02:15.919 E/MediaPlayer( 9483): pause called in state 1
02-07 16:02:15.919 E/MediaPlayer( 9483): error (-38, 0)
02-07 16:02:15.919 D/IconMerger( 1441): sum of notifications: 1
02-07 16:02:15.934 I/ActivityManager( 1373): Displayed com.verizon.ams.tesla/.msv.PreviewActivity: +136ms
02-07 16:02:15.950 E/MediaPlayer( 9483): Error (-38,0)
02-07 16:02:15.989 I/LAB126  ( 1441): StatusBarService hears intent. action: com.lab126.intent.TOP_WINDOW_CHANGED
02-07 16:02:15.989 I/LAB126  ( 1441):  window changed
02-07 16:02:16.013 D/MediaPlayer( 9483): Couldn't open file on client side, trying server side
02-07 16:02:16.013 W/ASFDummyExtractor( 1293): ASF parser is not available
02-07 16:02:16.013 D/AwesomePlayer( 1293): setDataSource_l(http://download.contentdistribution.verizon.net/bt/1f1789e379ae4c3b1be6b53428062bae16608a7b)
02-07 16:02:16.044 D/dalvikvm( 9483): GC_EXTERNAL_ALLOC freed 628K, 46% free 4713K/8711K, external 4085K/4397K, paused 36ms
02-07 16:02:16.083 D/android.widget.MediaController( 9483): adjusting bottom margin for bottom controls container
02-07 16:02:16.099 D/mediamanager( 9483): audio player unknown error, player status :false
02-07 16:02:18.153 D/dalvikvm( 1373): GC_EXPLICIT freed 489K, 55% free 5895K/12999K, external 5567K/6685K, paused 58ms
02-07 16:02:18.489 D/MPEG4Extractor( 1293): Atom found: ftyp with size = 18
02-07 16:02:18.489 D/MPEG4Extractor( 1293): Atom found: moov with size = d742
02-07 16:02:18.489 D/MPEG4Extractor( 1293): Atom found: mvhd with size = 6c
02-07 16:02:18.489 D/MPEG4Extractor( 1293): Atom found: iods with size = 21
02-07 16:02:18.489 D/MPEG4Extractor( 1293): Atom found: trak with size = 4d09
02-07 16:02:18.489 D/MPEG4Extractor( 1293): Atom found: tkhd with size = 5c
02-07 16:02:18.489 D/MPEG4Extractor( 1293): Atom found: mdia with size = 4ca5
02-07 16:02:18.489 D/MPEG4Extractor( 1293): Atom found: mdhd with size = 20
02-07 16:02:18.489 D/MPEG4Extractor( 1293): Atom found: hdlr with size = 44
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: ftyp
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: moov
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: mvhd
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: iods
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: trak
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: tkhd
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: mdia
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: mdhd
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: hdlr
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: minf
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: vmhd
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: dinf
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: dref
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stbl
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stsd
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: avc1
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: avcC
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stts
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stsc
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stsz
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stco
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stss
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: trak
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: tkhd
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: mdia
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: mdhd
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: hdlr
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: minf
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: smhd
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: dinf
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: dref
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stbl
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stsd
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: mp4a
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: esds
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stts
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stsc
02-07 16:02:18.497 E/MPEG4Extractor( 1293): Chunk: stsz
02-07 16:02:18.505 E/MPEG4Extractor( 1293): Chunk: stco
02-07 16:02:18.505 E/SEI_TI_Parser( 1293): Not Supported, SEI messages 0x0 
02-07 16:02:18.505 D/AwesomePlayer( 1293): AwesomePlayer Not VPX decoder = **video/avc** and video is = 720X404
02-07 16:02:18.505 D/OMX_CORE( 1293): TIOMX_GetHandle
02-07 16:02:18.505 E/OMX_PROXYDEC( 1293): ___INSISDE VIDEO DECODER PROXY WRAPPER__
02-07 16:02:18.677 D/OMXCodec( 1293): Flash Clip: Profile: 66, Level: 30, Interlaced: 0, RefFrames: 2
02-07 16:02:18.684 D/OMXCodec( 1293): Updated. H264 Component profile 1 level 256 NRefFrames 2
02-07 16:02:18.684 D/OMXCodec( 1293): initOutputFormat WxH 720x404 Padded 896x512 
02-07 16:02:18.684 D/AwesomePlayer( 1293):  initRenderer_l 896x512
02-07 16:02:18.684 D/AwesomePlayer( 1293):  initRenderer_l 720x404
02-07 16:02:18.684 D/OMXCodec( 1293): CodecRecommended O/P BufferCnt[7]
02-07 16:02:18.684 D/AwesomePlayer( 1293): Codec Recommended outputBuffer count 7
02-07 16:02:18.684 D/TIOverlay( 1373): Enabling the OVERLAY[0]
02-07 16:02:18.684 I/Overlay-V4L2( 1373): Openning /dev/video1
02-07 16:02:18.684 D/TIOverlay( 1373): Creating overlay from W896/H512/FMT33 ...
02-07 16:02:18.684 D/TIOverlay( 1373): mZorderUsage[0] is assigned to 0
02-07 16:02:18.684 I/TIOverlay( 1373): Setting position X0/Y0/W1024/H580
02-07 16:02:18.684 D/TIOverlay( 1373): REQUEST FOR LCD1
02-07 16:02:18.684 D/TIOverlay( 1373): found Panel Id @ [0], displayname [lcd2]
02-07 16:02:18.684 D/TIOverlay( 1373): found Display Manager @ [2], managername [2lcd]
02-07 16:02:18.684 I/TIOverlay( 1373): Position/X0/Y0/W1024/H580/R0/A255/Z1
02-07 16:02:18.684 I/TIOverlay( 1373): Adjusted Position/X0/Y0/W1024/H580
02-07 16:02:18.684 D/TIOverlay( 1293): Num of Buffers = 2
02-07 16:02:18.692 D/TIOverlay( 1293): LCD[0] NAME[lcd2] 
02-07 16:02:18.692 D/TIOverlay( 1293): LCD[0] PATH[/sys/devices/platform/omapdss/display0/enabled] 
02-07 16:02:18.692 D/TIOverlay( 1293): LCD[0] timings[46000,1024/160/150/10,600/12/20/3
02-07 16:02:18.692 D/TIOverlay( 1293): ] 
02-07 16:02:18.692 E/TIOverlay( 1293): Can't open the file[/sys/devices/platform/omapdss/display1/name]
02-07 16:02:18.692 D/TIOverlay( 1293): lcd name get failed (maybe because device has less displays than max allowed)
02-07 16:02:18.692 D/TIOverlay( 1293): MANAGER[0] NAME[lcd] 
02-07 16:02:18.692 D/TIOverlay( 1293): MANAGER[1] NAME[tv] 
02-07 16:02:18.692 D/TIOverlay( 1293): MANAGER[2] NAME[2lcd] 
02-07 16:02:18.692 D/TIHardwareRenderer( 1293): Overlay Buffer Count [as recommneded] 7
02-07 16:02:18.692 D/TIOverlay( 1293): overlay_resizeInput 896x512 7
02-07 16:02:18.700 I/OMXCodec( 1293): [OMX.TI.DUCATI1.VIDEO.DECODER] allocating 4 buffers of size 299520 on input port
02-07 16:02:18.731 I/OMXCodec( 1293): [OMX.TI.DUCATI1.VIDEO.DECODER] allocating 7 buffers of size 3145728 on output port
02-07 16:02:19.739 D/VideoView( 9483): onBufferingUpdate. percent:1