[Droid Eris Android Development] bftb0:
Hello all,

Thought I would give EE3.0 a spin, so I did the usual drill (backup, wipe, flash). The install happened without a hitch. Subsequent to the install I shutdown, transferred .apks from my SD/ext partition (to /data/app), and then rebooted. (Rather than fool around trying to figure out what EE3 wants to make a2sd happy)

I encountered a problem, however: failure of Gmail contacts to complete synchronization. I'm not sure it is an EE3 issue, because I don't see anyone in that thread complaining about (Gmail) synchronization.

The significant error that gets thrown (reported by ddms/logcat) is:

06-19 15:56:21.482: ERROR/DatabaseUtils(140): Writing exception to parcel
06-19 15:56:21.482: ERROR/DatabaseUtils(140): android.content.OperationApplicationException: Found value 13 when expected 10 for column version

I'm wondering if anybody has seen these types of synchronization errors before - perhaps resulting from app incompatibilities with the ROM system apps and core class behaviors.

I understand that I will get the usual prescriptive advice, "just start over and reload the ROM from scratch!" - but, I was looking for a little more insight than that. (Otherwise, I would have put this thread in the General forum).

More complete ddms output is below (note the looping behavior of Gmail sync).

bftb0

06-19 15:56:14.122: VERBOSE/SyncManager(78): stopSyncEvent: historyId=33
06-19 15:56:14.132: VERBOSE/SyncManager(78): reportChange 8 to: null
06-19 15:56:14.142: VERBOSE/SyncManager(78): runStateIdle
06-19 15:56:14.152: VERBOSE/ContactsSyncAdapter(128): GDataFeedFetcher thread ended: mForcedClosed is true
06-19 15:56:14.162: VERBOSE/SyncManager(78): runStateIdle: found sync candidate: authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: [] syncSource: 0 when: 385793 delay: 0 key: {authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: []} pendingOperation: android.content.SyncStorageEngine$PendingOperation@4654acf0
06-19 15:56:14.162: VERBOSE/SyncManager(78): runStateIdle: we are going to sync authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: [] syncSource: 0 when: 385793 delay: 0 key: {authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: []} pendingOperation: android.content.SyncStorageEngine$PendingOperation@4654acf0
06-19 15:56:14.162: VERBOSE/SyncManager(78): deleteFromPending: account=Account {name=xxxxxx@gmail.com, type=com.google} auth=com.android.contacts src=0 extras=Bundle[{}]
06-19 15:56:14.172: VERBOSE/SyncManager(78): Truncating /data/system/sync/pending.bin
06-19 15:56:14.172: VERBOSE/SyncManager(78): removing - android.content.SyncStorageEngine$AuthorityInfo@46228e10
06-19 15:56:14.172: VERBOSE/SyncManager(78): no more pending!
06-19 15:56:14.172: VERBOSE/SyncManager(78): reportChange 2 to: null
06-19 15:56:14.182: VERBOSE/SyncManager(78): insertStartSyncEvent: account=Account {name=xxxxxx@gmail.com, type=com.google} auth=com.android.contacts source=0
06-19 15:56:14.182: VERBOSE/SyncManager(78): returning historyId 34
06-19 15:56:14.182: VERBOSE/SyncManager(78): reportChange 8 to: null
06-19 15:56:14.182: VERBOSE/SyncManager(78): setActiveSync: account=Account {name=xxxxxx@gmail.com, type=com.google} auth=com.android.contacts src=0 extras=Bundle[{}]
06-19 15:56:14.192: VERBOSE/SyncManager(78): reportChange 4 to: [android.content.ISyncStatusObserver$Stub$Proxy@46117150]
06-19 15:56:14.192: INFO/SyncControl_Dialer(140): Sync active detected - Account: [xxxxxx@gmail.com/com.google], authority: com.android.contacts
06-19 15:56:16.222: DEBUG/dalvikvm(128): GC freed 31522 objects / 1391256 bytes in 152ms
06-19 15:56:16.952: DEBUG/dalvikvm(140): GC freed 18915 objects / 854912 bytes in 161ms
06-19 15:56:17.502: DEBUG/dalvikvm(128): GC freed 10584 objects / 437504 bytes in 139ms
06-19 15:56:18.802: DEBUG/dalvikvm(78): GC freed 12316 objects / 1239040 bytes in 263ms
06-19 15:56:18.932: WARN/StatusBar(78): updateNetworkNameExt: mSimState = UNKNOWN
06-19 15:56:18.932: DEBUG/KeyguardUpdateMonitor(78): handleCarrierInfoUpdate: plmn = Verizon Wireless, spn = null
06-19 15:56:18.932: INFO/HtcLockScreen(78): -----refreshCarrierInfo plmn=Verizon Wireless,spn=null, service=0
06-19 15:56:19.022: DEBUG/NetworkLocationProvider(78): onCellLocationChanged [9171,492780,-1716404,2,1]
06-19 15:56:19.022: DEBUG/LocationManagerService(78): CdmaCellLocation Available
06-19 15:56:19.922: DEBUG/dalvikvm(128): GC freed 5926 objects / 234968 bytes in 153ms
06-19 15:56:20.192: DEBUG/dalvikvm(140): GC freed 9859 objects / 416712 bytes in 114ms
06-19 15:56:20.882: ERROR/HtcContactsProvider2(140): PhoneDataRowHandler:update. no number/type specified...
06-19 15:56:21.482: ERROR/DatabaseUtils(140): Writing exception to parcel
06-19 15:56:21.482: ERROR/DatabaseUtils(140): android.content.OperationApplicationException: Found value 13 when expected 10 for column version
06-19 15:56:21.482: ERROR/DatabaseUtils(140): at android.content.ContentProviderOperation.apply(ContentProviderOperation.java:244)
06-19 15:56:21.482: ERROR/DatabaseUtils(140): at com.android.providers.contacts.SQLiteContentProvider.applyBatch(SQLiteContentProvider.java:200)
06-19 15:56:21.482: ERROR/DatabaseUtils(140): at com.android.providers.contacts.ContactsProvider2.applyBatch(ContactsProvider2.java:2367)
06-19 15:56:21.482: ERROR/DatabaseUtils(140): at com.android.providers.contacts.CContactsProvider2.applyBatch(CContactsProvider2.java:110)
06-19 15:56:21.482: ERROR/DatabaseUtils(140): at android.content.ContentProvider$Transport.applyBatch(ContentProvider.java:169)
06-19 15:56:21.482: ERROR/DatabaseUtils(140): at android.content.ContentProviderNative.onTransact(ContentProviderNative.java:197)
06-19 15:56:21.482: ERROR/DatabaseUtils(140): at android.os.Binder.execTransact(Binder.java:287)
06-19 15:56:21.482: ERROR/DatabaseUtils(140): at dalvik.system.NativeStart.run(Native Method)
06-19 15:56:21.542: DEBUG/dalvikvm(128): threadid=45 wakeup: interrupted
06-19 15:56:21.542: VERBOSE/ContactsSyncAdapter(128): GDataFeedFetcher thread ended: mForcedClosed is true
06-19 15:56:21.552: DEBUG/dalvikvm(128): threadid=47 wakeup: interrupted
06-19 15:56:21.612: VERBOSE/SyncManager(78): runSyncFinishedOrCanceled
06-19 15:56:21.612: VERBOSE/SyncManager(78): setActiveSync: null
06-19 15:56:21.612: VERBOSE/SyncManager(78): reportChange 4 to: [android.content.ISyncStatusObserver$Stub$Proxy@46117150]
06-19 15:56:21.632: INFO/DumpStateReceiver(78): Added state dump to 1 crashes
06-19 15:56:21.642: VERBOSE/SyncManager(78): runSyncFinishedOrCanceled: is a finished: operation authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: [] syncSource: 0 when: 385793 delay: 0 key: {authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: []} pendingOperation: android.content.SyncStorageEngine$PendingOperation@4654acf0, result SyncResult: stats [ numIoExceptions: 1 numUpdates: 19 numEntries: 20]
06-19 15:56:21.642: VERBOSE/SyncManager(78): insertIntoPending: account=Account {name=xxxxxx@gmail.com, type=com.google} auth=com.android.contacts src=0 extras=Bundle[{}]
06-19 15:56:21.642: VERBOSE/SyncManager(78): Appending to /data/system/sync/pending.bin
06-19 15:56:21.652: VERBOSE/SyncManager(78): reportChange 2 to: null
06-19 15:56:21.652: VERBOSE/SyncManager(78): stopSyncEvent: historyId=34
06-19 15:56:21.652: VERBOSE/SyncManager(78): reportChange 8 to: null
06-19 15:56:21.662: VERBOSE/SyncManager(78): runStateIdle
06-19 15:56:21.662: VERBOSE/SyncManager(78): runStateIdle: found sync candidate: authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: [] syncSource: 0 when: 393342 delay: 0 key: {authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: []} pendingOperation: android.content.SyncStorageEngine$PendingOperation@46063950
06-19 15:56:21.662: VERBOSE/SyncManager(78): runStateIdle: we are going to sync authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: [] syncSource: 0 when: 393342 delay: 0 key: {authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: []} pendingOperation: android.content.SyncStorageEngine$PendingOperation@46063950
06-19 15:56:21.662: VERBOSE/SyncManager(78): deleteFromPending: account=Account {name=xxxxxx@gmail.com, type=com.google} auth=com.android.contacts src=0 extras=Bundle[{}]
06-19 15:56:21.662: VERBOSE/SyncManager(78): Truncating /data/system/sync/pending.bin
06-19 15:56:21.672: VERBOSE/SyncManager(78): removing - android.content.SyncStorageEngine$AuthorityInfo@46228e10
06-19 15:56:21.672: VERBOSE/SyncManager(78): no more pending!
06-19 15:56:21.672: VERBOSE/SyncManager(78): reportChange 2 to: null
06-19 15:56:21.672: VERBOSE/SyncManager(78): insertStartSyncEvent: account=Account {name=xxxxxx@gmail.com, type=com.google} auth=com.android.contacts source=0
06-19 15:56:21.672: VERBOSE/SyncManager(78): returning historyId 35
06-19 15:56:21.672: VERBOSE/SyncManager(78): reportChange 8 to: null
06-19 15:56:21.672: VERBOSE/SyncManager(78): setActiveSync: account=Account {name=xxxxxx@gmail.com, type=com.google} auth=com.android.contacts src=0 extras=Bundle[{}]
06-19 15:56:21.672: VERBOSE/SyncManager(78): reportChange 4 to: [android.content.ISyncStatusObserver$Stub$Proxy@46117150]
06-19 15:56:21.672: INFO/SyncControl_Dialer(140): Sync active detected - Account: [xxxxxx@gmail.com/com.google], authority: com.android.contacts
06-19 15:56:23.392: DEBUG/dalvikvm(128): GC freed 37070 objects / 1624536 bytes in 149ms
06-19 15:56:24.532: DEBUG/dalvikvm(128): GC freed 9191 objects / 380904 bytes in 134ms
06-19 15:56:25.312: DEBUG/dalvikvm(140): GC freed 22766 objects / 1004848 bytes in 146ms
06-19 15:56:25.822: DEBUG/dalvikvm(128): GC freed 9113 objects / 364752 bytes in 138ms
06-19 15:56:26.972: ERROR/HtcContactsProvider2(140): PhoneDataRowHandler:update. no number/type specified...
06-19 15:56:27.512: DEBUG/dalvikvm(140): GC freed 8123 objects / 370128 bytes in 121ms
06-19 15:56:27.722: ERROR/DatabaseUtils(140): Writing exception to parcel
06-19 15:56:27.722: ERROR/DatabaseUtils(140): android.content.OperationApplicationException: Found value 13 when expected 10 for column version
06-19 15:56:27.722: ERROR/DatabaseUtils(140): at android.content.ContentProviderOperation.apply(ContentProviderOperation.java:244)
06-19 15:56:27.722: ERROR/DatabaseUtils(140): at com.android.providers.contacts.SQLiteContentProvider.applyBatch(SQLiteContentProvider.java:200)
06-19 15:56:27.722: ERROR/DatabaseUtils(140): at com.android.providers.contacts.ContactsProvider2.applyBatch(ContactsProvider2.java:2367)
06-19 15:56:27.722: ERROR/DatabaseUtils(140): at com.android.providers.contacts.CContactsProvider2.applyBatch(CContactsProvider2.java:110)
06-19 15:56:27.722: ERROR/DatabaseUtils(140): at android.content.ContentProvider$Transport.applyBatch(ContentProvider.java:169)
06-19 15:56:27.722: ERROR/DatabaseUtils(140): at android.content.ContentProviderNative.onTransact(ContentProviderNative.java:197)
06-19 15:56:27.722: ERROR/DatabaseUtils(140): at android.os.Binder.execTransact(Binder.java:287)
06-19 15:56:27.722: ERROR/DatabaseUtils(140): at dalvik.system.NativeStart.run(Native Method)
06-19 15:56:27.862: INFO/DumpStateReceiver(78): Added state dump to 1 crashes
06-19 15:56:27.932: VERBOSE/ContactsSyncAdapter(128): GDataFeedFetcher thread ended: mForcedClosed is true
06-19 15:56:27.942: VERBOSE/SyncManager(78): runSyncFinishedOrCanceled
06-19 15:56:27.962: VERBOSE/SyncManager(78): setActiveSync: null
06-19 15:56:27.972: VERBOSE/SyncManager(78): reportChange 4 to: [android.content.ISyncStatusObserver$Stub$Proxy@46117150]
06-19 15:56:27.972: VERBOSE/SyncManager(78): runSyncFinishedOrCanceled: is a finished: operation authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: [] syncSource: 0 when: 393342 delay: 0 key: {authority: com.android.contacts account: Account {name=xxxxxx@gmail.com, type=com.google} extras: []} pendingOperation: android.content.SyncStorageEngine$PendingOperation@46063950, result SyncResult: stats [ numIoExceptions: 1 numUpdates: 19 numEntries: 20]