mirror of
https://github.com/jberkel/sms-backup-plus.git
synced 2026-04-25 17:05:59 +03:00
[GH-ISSUE #414] Call log calendar events not created - Kitkat #347
Labels
No labels
AM+RCS
FAQ
awaiting response
backup
bespoke
bug
calendar
call log
cannot reproduce
cloudless
device-specific
documentation
dual- & multi-SIM
duplicate
feature-request
fixed in beta
good first issue
half-missing
help wanted
helpful
meta
misattribution
mms
other message sources
pull-request
question
rejuvenation
restore
schedule
security
stale
task
thanks
v1.5.1
v1.5.10
v1.5.11
v1.5.2
v1.5.3
v1.5.3
v1.5.4
v1.5.4
v1.5.5
v1.5.5
v1.5.6
v1.5.7
v1.5.8
v1.5.9
v1.6β
xoauth
~$ bounty $~
No milestone
No project
No assignees
1 participant
Notifications
Due date
No due date set.
Dependencies
No dependencies set.
Reference
starred/sms-backup-plus-jberkel#347
Loading…
Add table
Add a link
Reference in a new issue
No description provided.
Delete branch "%!s()"
Deleting a branch is permanent. Although the deleted branch may continue to exist for a short time before it actually gets removed, it CANNOT be undone in most cases. Continue?
Originally created by @maxraddop on GitHub (Dec 24, 2013).
Original GitHub issue: https://github.com/jberkel/sms-backup-plus/issues/414
Nexus 4
Kitkat 4.4.2 KOT49H
SMS Backup+ 1.5.6 beta
Call log backup is created in gmail, but calendar events are not created. If I open Calendar as the backup is being done, I can see events appear and disappear.
SMS Backup+ permissions from App Ops: Read contacts, Modify contacts, Read call log, Modify call log, Read calendar, Modify calendar, Read SMS, Receive SMS, Write SMS, Post notification, Keep Awake : all are ON.
When I trigger the backup manually, there is a OAUTH error. The second tile I trigger backup, it authenticates correctly (NB: this is not the subject of this issue).
SMS Backup+ log says:
Log entry extracts as below. Name and email address changed for privacy.
12-25 01:37:44.236 I/ActivityManager(602): START u0 {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=com.zegoggles.smssync/.activity.MainActivity bnds=[309,885][459,1050]} from pid 956 12-25 01:37:44.246 D/audio_hw_primary(176): out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2 12-25 01:37:44.256 D/audio_hw_primary(176): select_devices: out_snd_device(2: speaker) in_snd_device(0: ) 12-25 01:37:44.256 D/ACDB-LOADER(176): ACDB -> send_afe_cal 12-25 01:37:44.306 W/Resources(27127): Converting to string: TypedValue{t=0x10/d=0x1c20 a=-1} 12-25 01:37:44.306 W/Resources(27127): Converting to string: TypedValue{t=0x10/d=0x1c20 a=-1} 12-25 01:37:44.306 W/Resources(27127): Converting to string: TypedValue{t=0x10/d=0xb4 a=-1} 12-25 01:37:44.306 W/Resources(27127): Converting to string: TypedValue{t=0x10/d=0xb4 a=-1} 12-25 01:37:44.316 W/Resources(27127): Converting to string: TypedValue{t=0x10/d=0xffffffff a=-1} 12-25 01:37:44.316 W/Resources(27127): Converting to string: TypedValue{t=0x10/d=0xffffffff a=-1} 12-25 01:37:44.316 W/Resources(27127): Converting to string: TypedValue{t=0x10/d=0xffffffff a=-1} 12-25 01:37:44.316 W/Resources(27127): Converting to string: TypedValue{t=0x10/d=0xffffffff a=-1} 12-25 01:37:44.316 W/Resources(27127): Converting to string: TypedValue{t=0x10/d=0xffffffff a=-1} 12-25 01:37:44.316 W/Resources(27127): Converting to string: TypedValue{t=0x10/d=0xffffffff a=-1} 12-25 01:37:44.336 D/SMSBackup+(27127): onResume() 12-25 01:37:44.336 V/PhoneStatusBar(756): setLightsOn(true) 12-25 01:37:44.376 W/ContextImpl(27127): Implicit intents with startService are not safe: Intent { act=com.android.vending.billing.InAppBillingService.BIND } android.content.ContextWrapper.bindService:517 com.github.jberkel.pay.me.IabHelper.startSetup:152 com.zegoggles.smssync.activity.donation.DonationActivity.checkUserHasDonated:244 12-25 01:37:44.386 D/Finsky (23304): [2876] InAppBillingUtils.pickAccount: com.zegoggles.smssync: Account determined from installer data - [4QQzJsKe8aCWKT2BvM3efFKy6ws] 12-25 01:37:44.386 D/Finsky (23304): [2875] InAppBillingUtils.pickAccount: com.zegoggles.smssync: Account determined from installer data - [4QQzJsKe8aCWKT2BvM3efFKy6ws] 12-25 01:37:44.396 D/Finsky (23304): [2853] InAppBillingUtils.pickAccount: com.zegoggles.smssync: Account determined from installer data - [4QQzJsKe8aCWKT2BvM3efFKy6ws] 12-25 01:37:44.406 D/Finsky (23304): [2853] InAppBillingUtils.pickAccount: com.zegoggles.smssync: Account determined from installer data - [4QQzJsKe8aCWKT2BvM3efFKy6ws] 12-25 01:37:44.406 D/Finsky (23304): [2854] InAppBillingUtils.pickAccount: com.zegoggles.smssync: Account determined from installer data - [4QQzJsKe8aCWKT2BvM3efFKy6ws] 12-25 01:37:44.406 D/Finsky (23304): [2854] InAppBillingUtils.pickAccount: com.zegoggles.smssync: Account determined from installer data - [4QQzJsKe8aCWKT2BvM3efFKy6ws] 12-25 01:37:44.506 I/ActivityManager(602): Displayed com.zegoggles.smssync/.activity.MainActivity: +264ms 12-25 01:37:46.458 D/audio_hw_primary(176): out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2 12-25 01:37:46.468 D/SMSBackup+(27127): using new contacts API 12-25 01:37:46.508 D/dalvikvm(27127): GC_CONCURRENT freed 3256K, 25% free 9984K/13272K, paused 2ms+4ms, total 34ms 12-25 01:37:46.559 I/SMSBackup+(27127): Starting backup (1 messages) 12-25 01:37:46.859 D/dalvikvm(27127): GC_CONCURRENT freed 202K, 23% free 10256K/13272K, paused 3ms+4ms, total 30ms 12-25 01:37:48.581 D/dalvikvm(1171): GC_CONCURRENT freed 536K, 7% free 9247K/9868K, paused 2ms+4ms, total 22ms 12-25 01:37:48.581 D/dalvikvm(1171): WAIT_FOR_CONCURRENT_GC blocked 8ms 12-25 01:37:48.681 D/dalvikvm(756): GC_CONCURRENT freed 1356K, 59% free 13558K/32692K, paused 3ms+4ms, total 52ms 12-25 01:37:48.681 D/dalvikvm(756): WAIT_FOR_CONCURRENT_GC blocked 49ms 12-25 01:37:49.081 D/k9 (27127): Untagged response #+# [eyJzdGF0dXMiOiI0MDAiLCJzY2hlbWVzIjoiQmVhcmVyIiwic2NvcGUiOiJodHRwczovL21haWwuZ29vZ2xlLmNvbS8ifQ==] 12-25 01:37:49.392 D/k9 (27127): Untagged response #2# [NO, [ALERT], Invalid, credentials, [Failure]] 12-25 01:37:49.392 E/k9 (27127): Failed to login, closing connection for conn1105954968 12-25 01:37:49.562 W/GLSActivity(1074): [aia] Status from wire: NetworkError status: NETWORK_ERROR 12-25 01:37:49.562 I/GLSUser (1074): GLS error: NetworkError my-gmail-log-account@gmail.com oauth2:https://mail.google.com/ 12-25 01:37:49.562 W/GLSActivity(1074): [aia] Status from wire: NetworkError status: NETWORK_ERROR 12-25 01:37:49.562 W/GLSActivity(1074): java.io.IOException: NetworkError 12-25 01:37:49.562 W/GLSActivity(1074): at com.google.android.gms.auth.GoogleAuthUtil.getToken(Unknown Source) 12-25 01:37:49.562 W/GLSActivity(1074): at com.google.android.gms.auth.GoogleAuthUtil.a(Unknown Source) 12-25 01:37:49.562 W/GLSActivity(1074): at com.google.android.gms.auth.GoogleAuthUtil.getTokenWithNotification(Unknown Source) 12-25 01:37:49.562 W/GLSActivity(1074): at com.google.android.gsf.loginservice.GoogleLoginService$AccountAuthenticatorImpl.getAuthToken(GoogleLoginService.java:296) 12-25 01:37:49.562 W/GLSActivity(1074): at android.accounts.AbstractAccountAuthenticator$Transport.getAuthToken(AbstractAccountAuthenticator.java:196) 12-25 01:37:49.562 W/GLSActivity(1074): at android.accounts.IAccountAuthenticator$Stub.onTransact(IAccountAuthenticator.java:113) 12-25 01:37:49.562 W/GLSActivity(1074): at android.os.Binder.execTransact(Binder.java:404) 12-25 01:37:49.562 W/GLSActivity(1074): at dalvik.system.NativeStart.run(Native Method) 12-25 01:37:49.572 W/SMSBackup+(27127): java.io.IOException: NetworkError 12-25 01:37:49.572 W/SMSBackup+(27127): at android.accounts.AccountManager.convertErrorToException(AccountManager.java:1711) 12-25 01:37:49.572 W/SMSBackup+(27127): at android.accounts.AccountManager.access$400(AccountManager.java:144) 12-25 01:37:49.572 W/SMSBackup+(27127): at android.accounts.AccountManager$AmsTask$Response.onError(AccountManager.java:1572) 12-25 01:37:49.572 W/SMSBackup+(27127): at android.accounts.IAccountManagerResponse$Stub.onTransact(IAccountManagerResponse.java:69) 12-25 01:37:49.572 W/SMSBackup+(27127): at android.os.Binder.execTransact(Binder.java:404) 12-25 01:37:49.572 W/SMSBackup+(27127): at dalvik.system.NativeStart.run(Native Method) 12-25 01:37:50.022 D/dalvikvm(1171): GC_CONCURRENT freed 543K, 7% free 9212K/9868K, paused 4ms+2ms, total 25ms 12-25 01:37:50.022 D/dalvikvm(1171): WAIT_FOR_CONCURRENT_GC blocked 9ms 12-25 01:37:50.072 D/dalvikvm(1171): GC_CONCURRENT freed 289K, 6% free 9338K/9868K, paused 2ms+2ms, total 22ms 12-25 01:37:50.132 D/dalvikvm(1128): GC_CONCURRENT freed 414K, 6% free 10906K/11572K, paused 2ms+3ms, total 32ms 12-25 01:37:50.132 D/dalvikvm(1128): WAIT_FOR_CONCURRENT_GC blocked 15ms 12-25 01:37:50.142 D/dalvikvm(1128): WAIT_FOR_CONCURRENT_GC blocked 17ms 12-25 01:37:51.294 D/SMSBackup+(27127): using new contacts API 12-25 01:37:51.294 D/audio_hw_primary(176): out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2 12-25 01:37:51.314 D/audio_hw_primary(176): select_devices: out_snd_device(2: speaker) in_snd_device(0: ) 12-25 01:37:51.314 D/ACDB-LOADER(176): ACDB -> send_afe_cal 12-25 01:37:51.324 D/dalvikvm(27127): GC_CONCURRENT freed 443K, 24% free 10217K/13272K, paused 3ms+2ms, total 31ms 12-25 01:37:51.344 I/SMSBackup+(27127): Starting backup (1 messages) 12-25 01:37:53.476 D/k9 (27127): Untagged response #+# [eyJzdGF0dXMiOiI0MDAiLCJzY2hlbWVzIjoiQmVhcmVyIiwic2NvcGUiOiJodHRwczovL21haWwuZ29vZ2xlLmNvbS8ifQ==] 12-25 01:37:53.786 D/k9 (27127): Untagged response #2# [NO, [ALERT], Invalid, credentials, [Failure]] 12-25 01:37:53.786 E/k9 (27127): Failed to login, closing connection for conn1109729736 12-25 01:37:54.417 D/dalvikvm(1074): GC_CONCURRENT freed 443K, 6% free 10301K/10904K, paused 6ms+3ms, total 113ms 12-25 01:37:54.477 I/SMSBackup+(27127): Starting backup (1 messages) 12-25 01:37:55.208 D/dalvikvm(27127): GC_CONCURRENT freed 374K, 23% free 10232K/13272K, paused 3ms+2ms, total 70ms 12-25 01:37:56.900 D/k9 (27127): Untagged response #null# [CAPABILITY, IMAP4rev1, UNSELECT, IDLE, NAMESPACE, QUOTA, ID, XLIST, CHILDREN, X-GM-EXT-1, UIDPLUS, COMPRESS=DEFLATE, ENABLE, MOVE, CONDSTORE, ESEARCH] 12-25 01:37:56.900 D/k9 (27127): Untagged response #2# [OK, my-gmail-log-account@gmail.com, M_____, P______, authenticated, [Success]] 12-25 01:37:57.470 D/dalvikvm(27127): GC_CONCURRENT freed 209K, 21% free 10533K/13272K, paused 2ms+5ms, total 53ms 12-25 01:37:59.082 D/dalvikvm(1128): GC_CONCURRENT freed 693K, 7% free 10832K/11572K, paused 3ms+2ms, total 43ms 12-25 01:37:59.082 D/dalvikvm(1128): WAIT_FOR_CONCURRENT_GC blocked 30ms 12-25 01:37:59.833 D/k9 (27127): Untagged response #null# [CAPABILITY, IMAP4rev1, UNSELECT, IDLE, NAMESPACE, QUOTA, ID, XLIST, CHILDREN, X-GM-EXT-1, UIDPLUS, COMPRESS=DEFLATE, ENABLE, MOVE, CONDSTORE, ESEARCH] 12-25 01:37:59.833 D/k9 (27127): Untagged response #2# [OK, my-gmail-log-account@gmail.com, M_____, P______, authenticated, [Success]] 12-25 01:38:00.213 D/dalvikvm(602): GC_EXPLICIT freed 2531K, 20% free 32668K/40804K, paused 13ms+13ms, total 168ms 12-25 01:38:00.233 D/dalvikvm(1171): GC_CONCURRENT freed 490K, 7% free 9276K/9876K, paused 1ms+2ms, total 15ms 12-25 01:38:00.243 D/dalvikvm(1171): WAIT_FOR_CONCURRENT_GC blocked 9ms 12-25 01:38:00.473 D/dalvikvm(27127): GC_CONCURRENT freed 350K, 21% free 10611K/13272K, paused 1ms+3ms, total 25ms 12-25 01:38:00.594 D/dalvikvm(1171): GC_CONCURRENT freed 537K, 7% free 9248K/9876K, paused 3ms+6ms, total 37ms 12-25 01:38:00.594 D/dalvikvm(1171): WAIT_FOR_CONCURRENT_GC blocked 23ms 12-25 01:38:02.095 D/k9 (27127): Untagged response #null# [CAPABILITY, IMAP4rev1, UNSELECT, IDLE, NAMESPACE, QUOTA, ID, XLIST, CHILDREN, X-GM-EXT-1, UIDPLUS, COMPRESS=DEFLATE, ENABLE, MOVE, CONDSTORE, ESEARCH] 12-25 01:38:02.095 D/k9 (27127): Untagged response #2# [OK, my-gmail-log-account@gmail.com, M_____, P______, authenticated, [Success]] 12-25 01:38:05.218 D/dalvikvm(1171): GC_CONCURRENT freed 527K, 7% free 9229K/9876K, paused 3ms+3ms, total 46ms 12-25 01:38:05.218 D/dalvikvm(1171): WAIT_FOR_CONCURRENT_GC blocked 28ms 12-25 01:38:05.258 D/dalvikvm(1171): GC_CONCURRENT freed 307K, 6% free 9321K/9876K, paused 1ms+3ms, total 14ms 12-25 01:38:05.289 D/dalvikvm(756): GC_CONCURRENT freed 1440K, 59% free 13608K/32692K, paused 2ms+6ms, total 30ms 12-25 01:38:06.129 I/CalendarProvider2(27021): Sending notification intent: Intent { act=android.intent.action.PROVIDER_CHANGED dat=content://com.android.calendar } 12-25 01:38:06.129 W/ContentResolver(27021): Failed to get type for: content://com.android.calendar (Unknown URL content://com.android.calendar) 12-25 01:38:06.139 D/AlertReceiver(7657): onReceive: a=android.intent.action.PROVIDER_CHANGED Intent { act=android.intent.action.PROVIDER_CHANGED dat=content://com.android.calendar flg=0x10 cmp=com.google.android.calendar/com.android.calendar.alerts.AlertReceiver } 12-25 01:38:06.179 D/AlertService(7657): 0 Action = android.intent.action.PROVIDER_CHANGED 12-25 01:38:06.350 D/dalvikvm(7657): GC_CONCURRENT freed 387K, 8% free 10576K/11388K, paused 3ms+13ms, total 47ms 12-25 01:38:07.461 D/dalvikvm(27127): GC_FOR_ALLOC freed 270K, 21% free 10556K/13272K, paused 28ms, total 28ms 12-25 01:38:07.491 D/dalvikvm(27127): GC_CONCURRENT freed 12K, 18% free 10940K/13272K, paused 2ms+2ms, total 29ms 12-25 01:38:07.491 D/dalvikvm(27127): WAIT_FOR_CONCURRENT_GC blocked 23ms 12-25 01:38:07.501 I/dalvikvm-heap(27127): Grow heap (frag case) to 11.523MB for 850448-byte allocation 12-25 01:38:07.531 D/dalvikvm(27127): GC_CONCURRENT freed 2K, 12% free 11768K/13272K, paused 2ms+2ms, total 30ms 12-25 01:38:07.531 D/dalvikvm(27127): WAIT_FOR_CONCURRENT_GC blocked 28ms 12-25 01:38:07.551 D/dalvikvm(27127): GC_FOR_ALLOC freed <1K, 6% free 12517K/13272K, paused 19ms, total 19ms 12-25 01:38:07.581 D/dalvikvm(27127): GC_FOR_ALLOC freed <1K, 6% free 12869K/13628K, paused 18ms, total 18ms 12-25 01:38:08.011 D/dalvikvm(1128): GC_CONCURRENT freed 601K, 7% free 10839K/11572K, paused 2ms+3ms, total 35ms 12-25 01:38:08.011 D/dalvikvm(1128): WAIT_FOR_CONCURRENT_GC blocked 26ms 12-25 01:38:09.994 D/audio_hw_primary(176): out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2 12-25 01:38:10.004 D/audio_hw_primary(176): select_devices: out_snd_device(2: speaker) in_snd_device(0: ) 12-25 01:38:10.004 D/ACDB-LOADER(176): ACDB -> send_afe_cal 12-25 01:38:10.074 D/dalvikvm(1171): GC_CONCURRENT freed 495K, 7% free 9275K/9876K, paused 8ms+7ms, total 35ms 12-25 01:38:10.074 D/dalvikvm(1171): WAIT_FOR_CONCURRENT_GC blocked 16ms 12-25 01:38:11.185 D/AlertService(7657): Beginning updateAlertNotification 12-25 01:38:11.195 D/AlertService(7657): No fired or scheduled alerts 12-25 01:38:12.837 D/audio_hw_primary(176): out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2@devurandom commented on GitHub (Mar 20, 2014):
Seems to be a duplicate of issue #413
@maxraddop commented on GitHub (Mar 20, 2014):
Negative. #413 is for call log RESTORE. This #414, is for call log CALENDAR events creation.