Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Call log calendar events not created - Kitkat #414

Closed
maxraddop opened this issue Dec 24, 2013 · 2 comments
Closed

Call log calendar events not created - Kitkat #414

maxraddop opened this issue Dec 24, 2013 · 2 comments
Labels
v1.5.6 reported against version 1.5.6

Comments

@maxraddop
Copy link

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:

BackupState(currentSyncedItems=1,itemsToSync=1,backupType=MANUAL,exception=null,state=FINISHED_BACUP)
Backup finished

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
Copy link

Seems to be a duplicate of issue #413

@maxraddop
Copy link
Author

Negative. #413 is for call log RESTORE. This #414, is for call log CALENDAR events creation.

@kurahaupo kurahaupo added the v1.5.6 reported against version 1.5.6 label Apr 26, 2020
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
v1.5.6 reported against version 1.5.6
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@devurandom @kurahaupo @maxraddop