Hi, I have problem with Nexus 9 that belongs to my parents. Device was working without problems for over 2 years but after update to 7.1 something really bad happened. Device cannot play any video in youtube app, and there is some problem with sound - for example I cannot play any music in google play music. There are some other troubles as well - for example voice search doesn't work at all - when I try to run voice search there is a message "Device cannot connect to Google". Firstly I thought that something happened in 7.1 and even flashed CM 14.1 but everything was the same, then I tried stock image of android 6 but without success, still same situation. Now I returned to stock 7.1. Today connected logcat and below is sample log of what happens when I try to play some video in YT app:
01-05 15:14:20.147 19721 19769 W YouTube : Pinging https://s.youtube.com/api/stats/qoe...ps=32.223:N&fmt=136&cache_bytes=30.001:235719
01-05 15:14:20.226 11930 22191 V Avrcp : Active sessions changed, 1 sessions
01-05 15:14:20.226 11930 22191 V Avrcp : Updating media controller to [email protected]
01-05 15:14:20.233 11930 22191 V Avrcp : Updated [MediaAttributes: UK - kierowca autobusu to Polak - by switcher44 (0/0) ] but no change!
01-05 15:14:20.293 256 12530 I MediaPlayerService: MediaPlayerService::getOMX
01-05 15:14:20.294 19721 21432 I OMXClient: MuxOMX ctor
01-05 15:14:20.295 253 26224 I OMXMaster: makeComponentInstance(OMX.google.aac.decoder) in mediacodec process
01-05 15:14:20.327 253 21433 I SoftAAC2: Reconfiguring decoder: 0->44100 Hz, 0->2 channels
01-05 15:14:20.334 19721 19726 I art : Do full code cache collection, code=505KB, data=440KB
01-05 15:14:20.359 19721 19726 I art : Starting a blocking GC JitCodeCache
01-05 15:14:20.359 19721 19726 I art : After code cache collection, code=386KB, data=332KB
01-05 15:14:20.371 256 12529 I MediaPlayerService: MediaPlayerService::getOMX
01-05 15:14:20.371 19721 21436 I OMXClient: MuxOMX ctor
01-05 15:14:20.372 253 1377 I OMXMaster: makeComponentInstance(OMX.Nvidia.h264.decode) in mediacodec process
01-05 15:14:20.381 19721 21435 I MediaCodec: [OMX.Nvidia.h264.decode] setting surface generation to 20194313
01-05 15:14:20.384 253 1377 E OMXNodeInstance: getConfig(fd008f:Nvidia.h264.decode, ConfigCommonOutputCrop(0x700000f)) ERROR: BadParameter(0x80001005)
01-05 15:14:20.390 19721 21436 D SurfaceUtils: set up nativeWindow 0x7a42b8da10 for 1280x720, color 0x106, rotation 0, usage 0x2b00
01-05 15:14:20.393 253 21437 D NvOsDebugPrintf: NvMMLiteOpen : Block : BlockType = 261
01-05 15:14:20.393 253 21437 D NvOsDebugPrintf: TVMR: NvMMLiteTVMRDecBlockOpen: 5008: NvMMLiteBlockOpen
01-05 15:14:20.402 253 21437 D NvOsDebugPrintf: NvMMLiteBlockCreate : Block : BlockType = 261
01-05 15:14:20.424 248 248 W APM_AudioPolicyManager: getOutput() could not find output for stream 3, samplingRate 0,format 0, channels 3, flags 0
01-05 15:14:20.424 19721 21428 E AudioTrack: Unable to query output sample rate for stream type -1; status -1
01-05 15:14:20.424 19721 21428 E AudioTrack-JNI: AudioTrack::getMinFrameCount() for sample rate 44100 failed with status -1
01-05 15:14:20.425 19721 21428 E android.media.AudioTrack: getMinBufferSize(): error querying hardware
01-05 15:14:20.426 248 18502 W APM_AudioPolicyManager: getOutput() could not find output for stream 3, samplingRate 44100,format 1, channels 3, flags 0
01-05 15:14:20.426 19721 21428 E AudioTrack: Could not get audio output for session 16305, stream type -1, usage 1, sample rate 44100, format 0x1, channel mask 0x3, flags 0
01-05 15:14:20.427 19721 21428 E AudioTrack-JNI: Error -22 initializing AudioTrack
01-05 15:14:20.427 19721 21428 E android.media.AudioTrack: Error code -20 when initializing AudioTrack.
01-05 15:14:20.429 19721 19721 E YouTube : Error with ExoPlayer audio track initialization.
01-05 15:14:20.429 19721 19721 E YouTube : hgx: AudioTrack init failed: 0, Config(44100, 12, 44100)
01-05 15:14:20.429 19721 19721 E YouTube : at hgs.a(SourceFile:2930)
01-05 15:14:20.429 19721 19721 E YouTube : at hfe.a(SourceFile:3453)
01-05 15:14:20.429 19721 19721 E YouTube : at hfl.a(SourceFile:12954)
01-05 15:14:20.429 19721 19721 E YouTube : at hgj.a(SourceFile:128)
01-05 15:14:20.429 19721 19721 E YouTube : at hfa.handleMessage(SourceFile:1432)
01-05 15:14:20.429 19721 19721 E YouTube : at android.os.Handler.dispatchMessage(Handler.java:98)
01-05 15:14:20.429 19721 19721 E YouTube : at android.os.Looper.loop(Looper.java:154)
01-05 15:14:20.429 19721 19721 E YouTube : at android.os.HandlerThread.run(HandlerThread.java:61)
01-05 15:14:20.429 19721 19721 E YouTube : at hsu.run(SourceFile:40)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: Internal track renderer error.
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: het: hgx: AudioTrack init failed: 0, Config(44100, 12, 44100)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: at hfe.a(SourceFile:395)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: at hfl.a(SourceFile:12954)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: at hgj.a(SourceFile:128)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: at hfa.handleMessage(SourceFile:1432)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: at android.os.Handler.dispatchMessage(Handler.java:98)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: at android.os.Looper.loop(Looper.java:154)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: at android.os.HandlerThread.run(HandlerThread.java:61)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: at hsu.run(SourceFile:40)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: Caused by: hgx: AudioTrack init failed: 0, Config(44100, 12, 44100)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: at hgs.a(SourceFile:2930)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: at hfe.a(SourceFile:3453)
01-05 15:14:20.429 19721 21428 E ExoPlayerImplInternal: ... 7 more
01-05 15:14:20.444 11930 22191 V Avrcp : MediaController playback changed: PlaybackState {state=7, position=0, buffered position=0, speed=1.0, updated=65833230, actions=262, custom actions=[], active item id=-1, error=null}
01-05 15:14:20.454 253 21439 D NvOsDebugPrintf: TVMR: cbBeginSequence: 655: BeginSequence 1280x720, bVPR = 0
01-05 15:14:20.454 253 21439 D NvOsDebugPrintf: TVMR: cbBeginSequence: 918: DecodeBuffers = 4
01-05 15:14:20.457 253 21439 D NvOsDebugPrintf: TVMR: cbBeginSequence: 938: Display Resolution : (1280x720)
01-05 15:14:20.457 253 21439 D NvOsDebugPrintf: TVMR: cbBeginSequence: 939: Display Aspect Ratio : (1280x720)
01-05 15:14:20.457 253 21439 D NvOsDebugPrintf: TVMR: cbBeginSequence: 1041: SurfaceLayout = 3
01-05 15:14:20.457 253 21439 D NvOsDebugPrintf: TVMR: cbBeginSequence: 1071: NumOfSurfaces = 8, InteraceStream = 0, InterlaceEnabled = 0, bSecure = 0, MVC = 0 Semiplanar = 1, bReinit = 1
01-05 15:14:20.457 253 21439 D NvOsDebugPrintf: Allocating new output: 1280x720 (x 10), ThumbnailMode = 0
01-05 15:14:20.465 19721 21436 D SurfaceUtils: set up nativeWindow 0x7a42b8da10 for 1280x720, color 0x106, rotation 0, usage 0x2b00
01-05 15:14:20.466 253 26224 E OMXNodeInstance: setParameter(fd008f:Nvidia.h264.decode, ParamPortDefinition(0x2000001)) ERROR: UnsupportedSetting(0x80001019)
01-05 15:14:20.466 19721 21436 W ACodec : [OMX.Nvidia.h264.decode] setting nBufferCountActual to 14 failed: -1010
01-05 15:14:20.466 253 19218 E OMXNodeInstance: setParameter(fd008f:Nvidia.h264.decode, ParamPortDefinition(0x2000001)) ERROR: UnsupportedSetting(0x80001019)
01-05 15:14:20.466 19721 21436 W ACodec : [OMX.Nvidia.h264.decode] setting nBufferCountActual to 13 failed: -1010
01-05 15:14:20.509 253 21440 D NvOsDebugPrintf: TVMR: TVMRFrameDelivery: 3741: Closing TVMR Frame Delivery Thread -------------
01-05 15:14:20.513 253 21437 D NvOsDebugPrintf: TVMR: NvMMDecTVMRDestroyParser: 4224: NvAvpClose
01-05 15:14:20.513 253 21437 D NvOsDebugPrintf: TVMR: NvMMLiteTVMRDecBlockClose: 5163: Done
01-05 15:14:20.540 19721 19742 W YouTube : Pinging https://s.youtube.com/api/stats/qoe...,0.037:B,0.252:ER&fmt=136&view=0.158:1536:864
01-05 15:14:20.626 254 254 W mediadrmserver: type=1400 audit(0.0:478): avc: denied { read write } for name="nvmap" dev="tmpfs" ino=9815 scontext=u:r:mediadrmserver:s0 tcontext=ubject_r:gpu_device:s0 tclass=chr_file permissive=0
01-05 15:14:20.606 254 3645 D WVCdm : Instantiating CDM.
01-05 15:14:20.608 254 254 I WVCdm : CdmEngine:penSession
01-05 15:14:20.608 254 254 I WVCdm : Level3 Library 4445 Sep 10 2016 21:30:01
01-05 15:14:20.632 254 254 D NvOsDebugPrintf:
01-05 15:14:20.632 254 254 D NvOsDebugPrintf:
01-05 15:14:20.632 254 254 D NvOsDebugPrintf:
01-05 15:14:20.632 254 254 D NvOsDebugPrintf: ****NvRmMemInit failed****
01-05 15:14:20.632 254 254 D NvOsDebugPrintf:
01-05 15:14:20.632 254 254 D NvOsDebugPrintf:
01-05 15:14:20.632 254 254 D oemcrypto_cenc: >> OEMCrypto_Initialize: modular drm 6.00
01-05 15:14:20.633 254 254 D oemcrypto_cenc: << OEMCrypto_Initialize
01-05 15:14:20.633 254 254 E oemcrypto_cenc: OEMCrypto_APIVersion: 11
01-05 15:14:20.633 254 254 D oemcrypto_cenc: >> OEMCrypto_IsKeyboxValid
01-05 15:14:20.633 254 254 D oemcrypto_cenc: << OEMCrypto_IsKeyboxValid
01-05 15:14:20.634 254 254 D WVCdm : OEMCrypto_Initialize Level 1 success. I will use level 1.
01-05 15:14:20.634 254 254 D oemcrypto_cenc: >> OEMCryptpenSession
01-05 15:14:20.634 254 254 D oemcrypto_cenc: bool AddSessionHandle(OEMCrypto_SESSION): session:0xee394570, status: 1
01-05 15:14:20.634 254 254 D oemcrypto_cenc: << OEMCryptpenSession
01-05 15:14:20.634 254 254 D oemcrypto_cenc: >> OEMCrypto_GetRandom
01-05 15:14:20.634 254 254 D oemcrypto_cenc: << OEMCrypto_GetRandom
01-05 15:14:20.634 254 254 E oemcrypto_cenc: OEMCrypto_SecurityLevel
01-05 15:14:20.635 254 254 D oemcrypto_cenc: >> OEMCrypto_LoadDeviceRSAKey
01-05 15:14:20.635 254 254 D oemcrypto_cenc: << OEMCrypto_LoadDeviceRSAKey
01-05 15:14:20.635 254 254 D oemcrypto_cenc: >> OEMCrypto_GetRandom
01-05 15:14:20.635 254 254 D oemcrypto_cenc: << OEMCrypto_GetRandom
01-05 15:14:20.635 254 254 I WVCdm : CdmEngine::QueryKeyControlInfo
01-05 15:14:20.636 254 16171 I WVCdm : CdmEngine::GenerateKeyRequest
01-05 15:14:20.636 254 16171 D oemcrypto_cenc: >> OEMCrypto_GetDeviceID
01-05 15:14:20.636 254 16171 D oemcrypto_cenc: << OEMCrypto_GetDeviceID
01-05 15:14:20.636 254 16171 D oemcrypto_cenc: >> OEMCrypto_SupportsUsageTable
01-05 15:14:20.660 254 16171 D oemcrypto_cenc: << OEMCrypto_SupportsUsageTable
01-05 15:14:20.660 254 16171 E oemcrypto_cenc: OEMCrypto_APIVersion: 11
01-05 15:14:20.660 254 16171 D oemcrypto_cenc: OEMCrypto_GetHDCPCapability
01-05 15:14:20.660 254 16171 D oemcrypto_cenc: >> OEMCrypto_GenerateNonce
01-05 15:14:20.660 254 16171 D oemcrypto_cenc: << OEMCrypto_GenerateNonce
01-05 15:14:20.660 254 16171 D WVCdm : PrepareKeyRequest: nonce=749983962
01-05 15:14:20.660 254 16171 D oemcrypto_cenc: >> OEMCrypto_GenerateRSASignature
01-05 15:14:20.714 5588 5612 W Herrevad: Invalid mccmnc
01-05 15:14:20.719 254 16171 D oemcrypto_cenc: << OEMCrypto_GenerateRSASignature
01-05 15:14:20.720 254 3644 I WVCdm : CdmEngine::CloseSession
01-05 15:14:20.721 254 3644 D oemcrypto_cenc: >> OEMCrypto_CloseSession
01-05 15:14:20.721 254 3644 D oemcrypto_cenc: bool RemoveSessionHandle(OEMCrypto_SESSION): session: 0xee394570, status: 1
01-05 15:14:20.723 254 3644 D oemcrypto_cenc: << OEMCrypto_CloseSession
01-05 15:14:20.723 254 3644 D oemcrypto_cenc: >> OEMCrypto_Terminate
01-05 15:14:20.724 254 3644 D oemcrypto_cenc: << OEMCrypto_Terminate
01-05 15:14:20.757 5588 5612 W Herrevad: Invalid mccmnc
01-05 15:14:20.854 19721 19788 I qtaguid : Tagging socket -1 with tag 0(0) for uid -1 failed errno=-9
01-05 15:14:20.854 19721 19788 I NetworkManagementSocketTagger: tagSocketFd(-1, 0, -1) failed with errno-9
01-05 15:14:20.876 19721 19787 I qtaguid : Tagging socket -1 with tag 0(0) for uid -1 failed errno=-9
01-05 15:14:20.877 19721 19787 I NetworkManagementSocketTagger: tagSocketFd(-1, 0, -1) failed with errno-9
01-05 15:14:20.950 19721 19788 I qtaguid : Untagging socket -1 failed errno=-9
01-05 15:14:20.950 19721 19788 W NetworkManagementSocketTagger: untagSocket(-1) failed with errno -9
01-05 15:14:20.975 19721 19787 I qtaguid : Untagging socket -1 failed errno=-9
01-05 15:14:20.975 19721 19787 W NetworkManagementSocketTagger: untagSocket(-1) failed with errno -9
01-05 15:14:21.538 11930 22177 D HeadsetPhoneState: sendDeviceStateChanged. mService=0 mSignal=0 mRoam=0 mBatteryCharge=2
01-05 15:14:21.574 1212 1212 E PhoneInterfaceManager: [PhoneIntfMgr] queryModemActivityInfo: Empty response
01-05 15:14:21.606 596 624 E BatteryStatsService: power: Missing API
01-05 15:14:21.622 596 624 E BatteryStatsService: modem info is invalid: ModemActivityInfo{ mTimestamp=0 mSleepTimeMs=0 mIdleTimeMs=0 mTxTimeMs[]=[0, 0, 0, 0, 0] mRxTimeMs=0 mEnergyUsed=0}
01-05 15:14:22.170 21227 21233 I art : Do partial code cache collection, code=30KB, data=25KB
01-05 15:14:22.172 21227 21233 I art : After code cache collection, code=30KB, data=25KB
01-05 15:14:22.172 21227 21233 I art : Increasing code cache capacity to 128KB
Can someone point me what might be wrong with device? This might be hardware malfunction?
Related
Log story short.
RE-SIGNING the original quickpic 4.5.2 from the original developers website solves the updating issue on the playstore BUT also makes google drive cloud backup unusable. This is the logcat:
Code:
01-05 16:52:26.289 I/ActivityManager(797): START u0 {dat=content://com.alensw.PicFolder.CloudProvider/document/[email protected]:root cmp=com.alensw.PicFolder/com.alensw.cloud.CloudConfigActivity (has extras)} from uid 10141 on display 0
01-05 16:52:26.297 I/art (4767): Background sticky concurrent mark sweep GC freed 24503(2MB) AllocSpace objects, 33(2MB) LOS objects, 23% free, 16MB/21MB, paused 7.549ms total 61.083ms
01-05 16:52:26.345 W/InputMethodManagerService(797): Starting input on non-focused client [email protected] (uid=10141 pid=4767)
01-05 16:52:26.368 E/SQLiteLog(4767): (1) no such table: nodes
01-05 16:52:26.396 V/GLSActivity(1688): AuthDelegateWrapperCreated with selected intent: Intent { cmp=com.google.android.gms/.auth.DefaultAuthDelegateService }
01-05 16:52:26.398 V/GLSActivity(1688): AuthDelegateWrapperCreated with selected intent: Intent { cmp=com.google.android.gms/.auth.DefaultAuthDelegateService }
01-05 16:52:26.441 I/ActivityManager(797): Displayed com.alensw.PicFolder/com.alensw.cloud.CloudConfigActivity: +109ms
01-05 16:52:26.940 E/CloudProvider(4767): query failed:
01-05 16:52:26.940 E/CloudProvider(4767): java.net.ProtocolException: {
01-05 16:52:26.940 E/CloudProvider(4767): "error": {
01-05 16:52:26.940 E/CloudProvider(4767): "errors": [
01-05 16:52:26.940 E/CloudProvider(4767): {
01-05 16:52:26.940 E/CloudProvider(4767): "domain": "usageLimits",
01-05 16:52:26.940 E/CloudProvider(4767): "reason": "accessNotConfigured",
01-05 16:52:26.940 E/CloudProvider(4767): "message": "Access Not Configured. The API (Drive API) is not enabled for your project. Please use the Google Developers Console to update your configuration.",
01-05 16:52:26.940 E/CloudProvider(4767): "extendedHelp": "https://console.developers.google.com"
01-05 16:52:26.940 E/CloudProvider(4767): }
01-05 16:52:26.940 E/CloudProvider(4767): ],
01-05 16:52:26.940 E/CloudProvider(4767): "code": 403,
01-05 16:52:26.940 E/CloudProvider(4767): "message": "Access Not Configured. The API (Drive API) is not enabled for your project. Please use the Google Developers Console to update your configuration."
01-05 16:52:26.940 E/CloudProvider(4767): }
01-05 16:52:26.940 E/CloudProvider(4767): }
01-05 16:52:26.940 E/CloudProvider(4767):
01-05 16:52:26.940 E/CloudProvider(4767): at com.alensw.cloud.a.am.a(Unknown Source)
01-05 16:52:26.940 E/CloudProvider(4767): at com.alensw.cloud.a.by.a(Unknown Source)
01-05 16:52:26.940 E/CloudProvider(4767): at com.alensw.b.e.g.a(Unknown Source)
01-05 16:52:26.940 E/CloudProvider(4767): at com.alensw.b.e.g.a(Unknown Source)
01-05 16:52:26.940 E/CloudProvider(4767): at com.alensw.b.e.b.a(Unknown Source)
01-05 16:52:26.940 E/CloudProvider(4767): at com.alensw.cloud.a.am.a(Unknown Source)
01-05 16:52:26.940 E/CloudProvider(4767): at com.alensw.PicFolder.h.c(Unknown Source)
01-05 16:52:26.940 E/CloudProvider(4767): at com.alensw.PicFolder.h.call(Unknown Source)
01-05 16:52:26.940 E/CloudProvider(4767): at java.util.concurrent.FutureTask.run(FutureTask.java:237)
01-05 16:52:26.940 E/CloudProvider(4767): at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1113)
01-05 16:52:26.940 E/CloudProvider(4767): at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:588)
01-05 16:52:26.940 E/CloudProvider(4767): at java.lang.Thread.run(Thread.java:818)
01-05 16:52:26.940 E/CloudProvider(4767): at com.alensw.b.k.j.run(Unknown Source)
01-05 16:52:27.065 V/GLSActivity(1688): AuthDelegateWrapperCreated with selected intent: Intent { cmp=com.google.android.gms/.auth.DefaultAuthDelegateService }
01-05 16:52:27.069 V/GLSActivity(1688): AuthDelegateWrapperCreated with selected intent: Intent { cmp=com.google.android.gms/.auth.DefaultAuthDelegateService }
01-05 16:52:27.764 E/CloudProvider(4767): query failed:
01-05 16:52:27.764 E/CloudProvider(4767): java.net.ProtocolException: {
01-05 16:52:27.764 E/CloudProvider(4767): "error": {
01-05 16:52:27.764 E/CloudProvider(4767): "errors": [
01-05 16:52:27.764 E/CloudProvider(4767): {
01-05 16:52:27.764 E/CloudProvider(4767): "domain": "usageLimits",
01-05 16:52:27.764 E/CloudProvider(4767): "reason": "accessNotConfigured",
01-05 16:52:27.764 E/CloudProvider(4767): "message": "Access Not Configured. The API (Drive API) is not enabled for your project. Please use the Google Developers Console to update your configuration.",
01-05 16:52:27.764 E/CloudProvider(4767): "extendedHelp": "https://console.developers.google.com"
01-05 16:52:27.764 E/CloudProvider(4767): }
01-05 16:52:27.764 E/CloudProvider(4767): ],
01-05 16:52:27.764 E/CloudProvider(4767): "code": 403,
01-05 16:52:27.764 E/CloudProvider(4767): "message": "Access Not Configured. The API (Drive API) is not enabled for your project. Please use the Google Developers Console to update your configuration."
01-05 16:52:27.764 E/CloudProvider(4767): }
01-05 16:52:27.764 E/CloudProvider(4767): }
01-05 16:52:27.764 E/CloudProvider(4767):
01-05 16:52:27.764 E/CloudProvider(4767): at com.alensw.cloud.a.am.a(Unknown Source)
01-05 16:52:27.764 E/CloudProvider(4767): at com.alensw.cloud.a.by.a(Unknown Source)
01-05 16:52:27.764 E/CloudProvider(4767): at com.alensw.b.e.g.a(Unknown Source)
01-05 16:52:27.764 E/CloudProvider(4767): at com.alensw.b.e.g.a(Unknown Source)
01-05 16:52:27.764 E/CloudProvider(4767): at com.alensw.b.e.b.a(Unknown Source)
01-05 16:52:27.764 E/CloudProvider(4767): at com.alensw.cloud.a.am.a(Unknown Source)
01-05 16:52:27.764 E/CloudProvider(4767): at com.alensw.PicFolder.h.c(Unknown Source)
01-05 16:52:27.764 E/CloudProvider(4767): at com.alensw.PicFolder.h.call(Unknown Source)
01-05 16:52:27.764 E/CloudProvider(4767): at java.util.concurrent.FutureTask.run(FutureTask.java:237)
01-05 16:52:27.764 E/CloudProvider(4767): at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1113)
01-05 16:52:27.764 E/CloudProvider(4767): at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:588)
01-05 16:52:27.764 E/CloudProvider(4767): at java.lang.Thread.run(Thread.java:818)
01-05 16:52:27.764 E/CloudProvider(4767): at com.alensw.b.k.j.run(Unknown Source)
can anyone provide the steps (in detail) to solve this issue?
Code:
"message": "Access Not Configured. The API (Drive API) is not enabled for your project. Please use the Google Developers Console to update your configuration.",
I'm sure this is the problem, but how to solve it has become a nightmare for me.
original quickpic 4.5.2
The thing is you can't. Without the source code for the app the best you can do is hack around the smali code.
---Edit---
Added logcat information
------
Hello everyone,
Facing issues with Wi-Fi in my HTC desire 820 dual sim phone.
I have already reset my phone three times but to no avail.
The details of phone are as follows:
Model; ; HTC desire 820 dual sim (India)
Android version : 6.0.1
Software number : 3.17.720.3
Kernel Version : 3.10.49
Build : 3.17.720.3
The phone is not rooted and has stock recovery (which i could not access to clear dalvik cache).
---ISSUE ---
When I turn on Wi-Fi, the phone does not connect to my SSID.
When I click on connect to SSID, it tries to connect and after a fraction of seconds, the status of SSID goes to saved.
Removed the SSID, cleared all cache apps, and scanned for SSID.
Once found, entered the password to connect, but then again it just goes to Saved. Even after using Static IP configuration it does not conenct.
However, intermittently ,the phone connects to the SSID and then disconnects on its own.
There is no time pattern for this. sometimes it may connect for hours, while sometimes it may connect for a few seconds and then disconnect . Every time the SSID status goes to saved.
---TROUBLESHOOTING DONE SO FAR- ----
I dialed the code *#*#4636#*#* and went to wifi information
1. Wi-Fi App --> disconnect, getconfiguredNetworks, getConnectionInfo options do not work. oOnly disableNetwork and enableNetwork work. Tried entering my SSIS for enableNetwork, but did not work.
2. Under Wi-Fi config, it shows my earlier SSID, which is not in use now, and also the multicast SSID which i got while configuring my streaming device.
Under my existing SSID, it shows disable ID : 4
The old SSID's do not even show up while scanning anymore but are listed above..
I have reset my phone three times but still the issue persists..
---POSSIBLE CAUSES / FIRST TIME OCCURRENCE OF ISSUE---
I can recollect that this issue started coming after there was an issue with Exchange Services , google play services and Gmail application (cannot remember the exact issue now), where they were giving continuous pop -ups that the service has crashed.. I cleared cache for play services ,exchange services and gmail , disabled all of them after which the pop-ups disappeared.
After phone reset and upgrades, there were no pop-ups from these services but wifi started giving problems.
Sorry for the long post, but I wanted to describe things in detail .
Thanks in advance for helping.
-----------------------LOGCAT INFORMATION------------------------
06-24 00:10:57.850 1463 1463 D wpa_supplicant: nl80211: Drv Event 46 (NL80211_CMD_CONNECT) received for wlan0
06-24 00:10:57.850 1463 1463 D wpa_supplicant: nl80211: Connect event (status=1 ignore_next_local_disconnect=0)
06-24 00:10:57.850 1463 1463 D wpa_supplicant: wlan0: Event ASSOC_REJECT (13) received
06-24 00:10:57.850 1463 1463 I wpa_supplicant: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:1e:a6:7d:25:ec status_code=1
06-24 00:10:57.850 1463 1463 D wpa_supplicant: CTRL_IFACE monitor sent successfully to /data/misc/wifi/sockets/wpa_ctrl_1090-2\x00
06-24 00:10:57.850 1463 1463 D wpa_supplicant: wlan0: Radio work 'connect'@0x55c1bb8630 done in 1.114734 seconds
06-24 00:10:57.850 1463 1463 D wpa_supplicant: Added BSSID 00:1e:a6:7d:25:ec into blacklist
06-24 00:10:57.850 1463 1463 D wpa_supplicant: Continuous association failures - consider temporary network disabling
06-24 00:10:57.850 1463 1463 I wpa_supplicant: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=5 ssid="spawn" auth_failures=1 duration=10 reason=CONN_FAILED
06-24 00:10:57.850 1463 1463 D wpa_supplicant: CTRL_IFACE monitor sent successfully to /data/misc/wifi/sockets/wpa_ctrl_1090-2\x00
06-24 00:10:57.850 1463 1463 D wpa_supplicant: wlan0: Blacklist count 10 --> request scan in 10000 ms
06-24 00:10:57.850 1463 1463 D wpa_supplicant: wlan0: Setting scan request: 10.000000 sec
06-24 00:10:57.850 1463 1463 D wpa_supplicant: wlan0: State: ASSOCIATING -> DISCONNECTED
06-24 00:10:57.850 1463 1463 D wpa_supplicant: nl80211: Set wlan0 operstate 0->0 (DORMANT)
06-24 00:10:57.850 1463 1463 D wpa_supplicant: netlink: Operstate: ifindex=16 linkmode=-1 (no change), operstate=5 (IF_OPER_DORMANT)
06-24 00:10:57.850 1463 1463 D wpa_supplicant: CTRL_IFACE monitor sent successfully to /data/misc/wifi/sockets/wpa_ctrl_1090-2\x00
06-24 00:10:57.850 1463 1463 D wpa_supplicant: EAPOL: External notification - portEnabled=0
06-24 00:10:57.860 1090 1250 D WifiStateMachine: prevSupplicantState = ASSOCIATING newSupplicantState = DISCONNECTED
06-24 00:10:57.850 1463 1463 D wpa_supplicant: EAPOL: External notification - portValid=0
06-24 00:10:57.860 1090 1250 D WifiStateMachine: Driver Roaming resets flag.
06-24 00:10:57.850 1463 1463 D wpa_supplicant: EAPOL: External notification - EAP success=0
06-24 00:10:57.850 1090 1661 D WifiMonitor: Event [IFNAME=wlan0 CTRL-EVENT-ASSOC-REJECT bssid=00:1e:a6:7d:25:ec status_code=1]
06-24 00:10:57.850 1090 1661 E WifiMonitor: WifiMonitor:wlan0 cnt=739 dispatchEvent: CTRL-EVENT-ASSOC-REJECT bssid=00:1e:a6:7d:25:ec status_code=1
06-24 00:10:57.850 1090 1661 D WifiMonitor: Event [IFNAME=wlan0 CTRL-EVENT-SSID-TEMP-DISABLED id=5 ssid="spawn" auth_failures=1 duration=10 reason=CONN_FAILED]
06-24 00:10:57.850 1090 1661 E WifiMonitor: WifiMonitor:wlan0 cnt=740 dispatchEvent: CTRL-EVENT-SSID-TEMP-DISABLED id=5 ssid="spawn" auth_failures=1 duration=10 reason=CONN_FAILED
06-24 00:10:57.850 1090 1661 D WifiMonitor: Event [IFNAME=wlan0 CTRL-EVENT-STATE-CHANGE id=5 state=0 BSSID=00:00:00:00:00:00 SSID=spawn]
06-24 00:10:57.850 1090 1250 D WifiStateMachine: DisconnectedState !ASSOCIATION_REJECTION_EVENT rt=3168136/3692213 739 1 00:1e:a6:7d:25:ec blacklist=true
06-24 00:10:57.850 1090 1661 E WifiMonitor: WifiMonitor:wlan0 cnt=741 dispatchEvent: CTRL-EVENT-STATE-CHANGE id=5 state=0 BSSID=00:00:00:00:00:00 SSID=spawn
06-24 00:10:57.850 1090 1250 D WifiStateMachine: ConnectModeState !ASSOCIATION_REJECTION_EVENT rt=3168137/3692213 739 1 00:1e:a6:7d:25:ec blacklist=true
06-24 00:10:57.850 1090 1250 D WifiStateMachine: ASSOC_REJECT status_code=1
06-24 00:10:57.850 1090 1250 D WifiStateMachine: DisconnectedState !SSID_TEMP_DISABLED rt=3168138/3692215 nid=5 id=5 ssid="spawn" auth_failures=1 duration=10 reason=CONN_FAILED
06-24 00:10:57.850 1090 1250 D WifiStateMachine: ConnectModeState !SSID_TEMP_DISABLED rt=3168138/3692215 nid=5 id=5 ssid="spawn" auth_failures=1 duration=10 reason=CONN_FAILED
06-24 00:10:57.850 1090 1250 D WifiStateMachine: ConnectModeState SSID state=temp-disabled nid=5 [id=5 ssid="spawn" auth_failures=1 duration=10 reason=CONN_FAILED]
06-24 00:10:57.850 1090 1250 E WifiConfigStore: SSID temp disabled for "spawn"WPA_PSK had autoJoinStatus=0 self added false ephemeral false
06-24 00:10:57.850 1090 1250 E WifiConfigStore: message=id=5 ssid="spawn" auth_failures=1 duration=10 reason=CONN_FAILED
06-24 00:10:57.860 1090 1250 D WifiStateMachine: DisconnectedState !SUPPLICANT_STATE_CHANGE_EVENT rt=3168139/3692216 741 0 SSID: spawn BSSID: 00:00:00:00:00:00 nid: 5 state: DISCONNECTED
06-24 00:10:57.860 1090 1250 D WifiStateMachine: SUPPLICANT_STATE_CHANGE_EVENT state=DISCONNECTED -> state= DISCONNECTED debouncing=false
06-24 00:10:57.860 1090 1250 D WifiStateMachine: setDetailed state, old =CONNECTING and new state=DISCONNECTED hidden=false
06-24 00:10:57.860 1090 1250 D WifiStateMachine: [sendNetworkStateChangeBroadcast] NetworkInfo state =DISCONNECTED wifi info = SSID: spawn, BSSID: 00:00:00:00:00:00, Supplicant state: ASSOCIATING, RSSI: -127, Link speed: -1Mbps, Frequency: -1MHz, Net ID: 5, Metered hint: false, score: 0
06-24 00:10:57.860 1090 1250 D WifiStateMachine: ConnectModeState !SUPPLICANT_STATE_CHANGE_EVENT rt=3168142/3692219 741 0 SSID: spawn BSSID: 00:00:00:00:00:00 nid: 5 state: DISCONNECTED
06-24 00:10:57.860 1513 1513 D NetworkController: updateWifiState: type=1 connected=false
06-24 00:10:57.860 17140 17140 D HtcWifiTracker: onReceive(), action:android.net.wifi.STATE_CHANGE
06-24 00:10:57.860 1513 1794 I IntentController: receive(android.net.wifi.STATE_CHANGE,1,false)
06-24 00:10:57.860 1090 1250 D SupplicantStateTracker: HandshakeState{ when=-10ms what=147499 target=com.android.internal.util.StateMachine$SmHandler }
06-24 00:10:57.860 1090 1250 D SupplicantStateTracker: DefaultState{ when=-11ms what=147499 target=com.android.internal.util.StateMachine$SmHandler }
06-24 00:10:57.860 1090 1250 D SupplicantStateTracker: HandshakeState{ when=-3ms what=147462 arg1=741 obj= SSID: spawn BSSID: 00:00:00:00:00:00 nid: 5 state: DISCONNECTED target=com.android.internal.util.StateMachine$SmHandler }
06-24 00:10:57.860 17140 30742 D Settings:HtcWifiWidgetEnabler: get debug: spawn , state=DISCONNECTED
06-24 00:10:57.860 1090 1250 D SupplicantStateTracker: DefaultState{ when=-3ms what=147462 arg1=741 obj= SSID: spawn BSSID: 00:00:00:00:00:00 nid: 5 state: DISCONNECTED target=com.android.internal.util.StateMachine$SmHandler }
06-24 00:10:57.870 1090 1250 D SupplicantStateTracker: Supplicant state: DISCONNECTED
06-24 00:10:57.870 1090 1250 D SupplicantStateTracker: DisconnectedState
06-24 00:10:57.870 1513 1513 D SignalClusterView: vpn: GONE
06-24 00:10:57.870 1090 1250 D WifiStateMachine: DisconnectedState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168154/3692231 1000 0 num=7
06-24 00:10:57.870 1090 1250 D WifiStateMachine: ConnectModeState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168154/3692231 1000 0 num=7
06-24 00:10:57.870 17140 17140 D HtcWifiTracker: onReceive(), action:android.net.wifi.supplicant.STATE_CHANGE
06-24 00:10:57.870 1513 1513 D SignalClusterView: wifi=G,stat_sys_wifi_signal_connected_0 air=G,stat_sys_signal_flightmode data[0]=G,(null) sig[0]=V,cdma_stat_sys_s1_5signal_5 data[1]=G,(null) sig[1]=V,cdma_stat_sys_s2_5signal_null
06-24 00:10:57.870 1513 1513 D SignalClusterView: vpn: GONE
06-24 00:10:57.870 17140 17140 D WifiManagerWrapper: Lookup string definition:"EXTRA_NETWORK_ID", result:"networkID"
06-24 00:10:57.870 1513 1513 D SignalClusterView: wifi=G,stat_sys_wifi_signal_connected_0 air=G,stat_sys_signal_flightmode data[0]=G,(null) sig[0]=V,cdma_stat_sys_s1_5signal_5 data[1]=G,(null) sig[1]=V,cdma_stat_sys_s2_5signal_null
06-24 00:10:57.870 17140 30742 D Settings:HtcWifiWidgetEnabler: get debug: spawn , state=DISCONNECTED
06-24 00:10:57.870 17140 30818 D WISPrService: >>>>>WISPrService start isConnected = false <<<<< action = android.net.wifi.STATE_CHANGE
06-24 00:10:57.870 17140 30818 D WISPrService: not CONNECTIVITY_ACTION>
06-24 00:10:57.880 1090 1250 D WifiStateMachine: DisconnectedState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168163/3692239 1000 0 num=7
06-24 00:10:57.880 1090 1250 D WifiStateMachine: ConnectModeState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168163/3692240 1000 0 num=7
06-24 00:10:57.880 29640 29640 D HtcNLPSwitchReceiver: onReceive(): android.net.wifi.STATE_CHANGE
06-24 00:10:57.880 17140 30744 D HtcAccessPoint: ssid:a1601, bssid:null, security:2, networkid:4, signIn:2
06-24 00:10:57.880 17140 30744 D HtcAccessPoint: ssid:A1601, bssid:null, security:2, networkid:1, signIn:2
06-24 00:10:57.880 17140 30744 D HtcAccessPoint: ssid:AndroidAP, bssid:null, security:2, networkid:0, signIn:2
06-24 00:10:57.880 17140 30744 D HtcAccessPoint: ssid:RailWire Wi-Fi, bssid:null, security:0, networkid:6, signIn:2
06-24 00:10:57.880 17140 30744 D HtcAccessPoint: ssid:spawn, bssid:any, security:2, networkid:5, signIn:2
06-24 00:10:57.890 17140 30744 D AccessPointPreference: summary : spawn, Connecting… f=-1 00:00:00:00:00:00 rssi=-127 score=0 tx=0.0,0.0,0.0 rx=0.0 [(1);!1] cf=1
06-24 00:10:57.890 17140 30744 D HtcAccessPoint: ssid:teewe4560, bssid:null, security:0, networkid:3, signIn:2
06-24 00:10:57.890 17140 30744 D HtcAccessPoint: ssid:dlink, bssid:null, security:2, networkid:2, signIn:2
06-24 00:10:57.890 17140 30744 D WifiManager: getScanResults: Base Package Name=com.android.settings, uid=1000
06-24 00:10:57.890 1090 1558 D PackageManager: getInstalledApplications took 3 ms, CallingUid=10042, CallingPid=29640, mPackages={com.htc.htccompressviewer=Package{fc239c7 com.htc.htccompressviewer}, com.google.android.youtube=Package{a376bf4 com.google.android.youtube}, com.htc.dialerservice=Package{f357f1d com.htc.dialerservice}, com.htc.widget.autorotate=Package{3f02592 com.htc.widget.autorotate}, com.android.providers.telephony=Package{99eab63 com.android.providers.telephony}, com.google.android.googlequicksearchbox=Package{2595360 com.google.android.googlequicksearchbox}, com.android.providers.calendar=Package{3aff019 com.android.providers.calendar}, com.htc.CustomizationSetup=Package{96708de com.htc.CustomizationSetup}, com.htc.rosiewidgets.backgrounddata=Package{f469abf com.htc.rosiewidgets.backgrounddata}, com.htc.android.qxdm2sd=Package{2f0458c com.htc.android.qxdm2sd}, com.android.providers.media=Package{bc674d5 com.android.providers.media}, com.google.android.onetimeinitializer=Package{cd6d4ea com.google.android.onetimeinitializer}, com.htc.mms.backupagent=Package{35423db com.htc.mms.backupagent}, com.htc.backup=Package{4222e78 com.htc.backup}, com.htc.camera=Package{5868951 com.htc.camera}, com.android.wallpapercropper=Package{dc555b6 com.android.wallpapercropper}, com.htc.lmw=Package{de722b7 com.htc.lmw}, com.htc.ptg=Package{887ba24 com.htc.ptg}, com.htc.sdm=Package{859698d com.htc.sdm}, com.quicinc.cne.CNEService=Package{c491742 com.quicinc.cne.CNEService}, com.htc.cs.pns=Package{f413353 com.htc.cs.pns}, com.htc.powersavinglauncher=Package{1985490 com.htc.powersavinglauncher}, com.htc.wifidisplay=Package{f001189 com.htc.wifidisplay}, com.htc.oobe.advantage=Package{155658e com.htc.oobe.advantage}, com.htc.launcher=Package{21b1af com.htc.launcher}, com.htc.sense.browser=Package{ed629bc com.htc.sense.browser}, com.htc.contacts.frisbee=Package{54f3d45 com.htc.contacts.frisbee}, com.htc.htcmobilenetworkwidget=Package{fc64c9a com.htc.htcmobilenetworkwidget}, com.htc.android.locationpicker=Package{be1b9cb com.htc.android.locationpicker}, com.htc.android.htcloglevel=Package{3ba25a8 com.htc.android.htcloglevel}, org.simalliance.openmobileapi.service=Package{5ab68c1 org.simalliance.openmobileapi.service}, com.android.documentsui=Package{a2c9866 com.android.documentsui}, com.android.externalstorage=Package{5027a7 com.android.externalstorage}, com.htc.htccontactwidgets=Package{5ff454 com.htc.htccontactwidgets}, com.google.android.apps.enterprise.dmagent=Package{244cffd com.google.android.apps.enterprise.dmagent}, com.android.htmlviewer=Package{959d4f2 com.android.htmlviewer}, com.whatsapp=Package{f4d9743 com.whatsapp}, com.resun.chantingvedas=Package{8f201c0 com.resun.chantingvedas}, com.android.mms.service=Package{6136ef9 com.android.mms.service}, com.htc.autobot=Package{fac4e3e com.htc.autobot}, com.photofunia.android=Package{e28649f com.photofunia.android}, com.android.providers.downloads=Package{7d579ec com.android.providers.downloads}, com.google.android.apps.genie.geniewidget=Package{99301b5 com.google.android.apps.genie.geniewidget}, com.oxigen.futurepay=Package{51b104a com.oxigen.futurepay}, com.htc.mirrorlinkserver=Package{eb8abbb com.htc.mirrorlinkserver}, com.lavakusa.ramayan=Package{69648d8 com.lavakusa.ramayan}, com.htc.dnatransfer=Package{73f0431 com.htc.dnatransfer}, com.htc.task.gtask=Package{801e716 com.htc.task.gtask}, com.google.android.configupdater=Package{e3c4897 com.google.android.configupdater}, in.amazon.mShop.android.shopping=Package{9931a84 in.amazon.mShop.android.shopping}, com.htc.soundrecorder=Package{bceb26d com.htc.soundrecorder}, com.htc.htcwifiwidget=Package{ead5ea2 com.htc.htcwifiwidget}, com.android.defcontainer=Package{5f2d733 com.android.defcontainer}, com.htc.updater=Package{a695af0 com.htc.updater}, com.apalon.relaxing.sounds.sleep.timer=Package{e310869 com.apalon.relaxing.sounds.sleep.timer}, com.android.providers.downloads.ui=Package{5a6c2ee com.android.providers.downloads.ui}, com.android.vending=Package{979b38f com.android.vending}, com.android.pacprocessor=Package{d21361c com.android.
06-24 00:10:57.900 17140 30744 D AccessPointPreference: summary : spawn, Connecting… f=-1 00:00:00:00:00:00 rssi=-127 score=0 tx=0.0,0.0,0.0 rx=0.0 [(1);!1] cf=1
06-24 00:10:57.900 17140 30744 D AccessPointPreference: summary : spawn, Connecting… f=-1 00:00:00:00:00:00 rssi=-127 score=0 tx=0.0,0.0,0.0 rx=0.0 [(1);!1] cf=1
06-24 00:10:57.900 17140 30744 D HtcWifiTracker: connection info-SSID: spawn, BSSID: 00:00:00:00:00:00, Supplicant state: DISCONNECTED, RSSI: -127, Link speed: -1Mbps, Frequency: -1MHz, Net ID: -1, Metered hint: false, score: 0
06-24 00:10:57.900 1090 1250 D WifiStateMachine: DisconnectedState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168185/3692261 1000 0 num=7
06-24 00:10:57.900 1090 1250 D WifiStateMachine: ConnectModeState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168185/3692262 1000 0 num=7
06-24 00:10:57.910 17140 30744 D AccessPointPreference: summary : spawn, Saved [(1);!1] cf=1
06-24 00:10:57.910 17140 17140 D WifiManager: getVerboseLoggingLevel: Base Package Name=com.android.settings, uid=1000
06-24 00:10:57.910 1090 1796 D WifiStateMachine: getVerboseLoggingLevel: mVerboseLoggingLevel= 1
06-24 00:10:57.910 17140 17140 E HtcPreference: [removeAll]:before size= 1
06-24 00:10:57.910 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
06-24 00:10:57.910 17140 17140 E HtcPreference: [removeAll]:after size= 0
06-24 00:10:57.910 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
06-24 00:10:57.910 17140 17140 E HtcPreference: [addPreference]:before size= 0
06-24 00:10:57.910 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
06-24 00:10:57.910 17140 17140 E HtcPreference: [addPreference]:after size= 1
06-24 00:10:57.910 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
06-24 00:10:57.910 1090 1250 D WifiStateMachine: DisconnectedState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168197/3692274 1000 0 num=7
06-24 00:10:57.910 1090 1250 D WifiStateMachine: ConnectModeState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168198/3692275 1000 0 num=7
06-24 00:10:57.910 1513 1513 I QuickSettingWifi: receive.wifiConnect:false wifiAPname:null elapse:1
06-24 00:10:57.920 1090 1250 D WifiStateMachine: DisconnectedState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168203/3692279 1000 0 num=7
06-24 00:10:57.920 1090 1250 D WifiStateMachine: ConnectModeState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168203/3692280 1000 0 num=7
06-24 00:10:57.920 17140 30744 D HtcAccessPoint: ssid:a1601, bssid:null, security:2, networkid:4, signIn:2
06-24 00:10:57.920 17140 30744 D HtcAccessPoint: ssid:A1601, bssid:null, security:2, networkid:1, signIn:2
06-24 00:10:57.920 17140 30744 D HtcAccessPoint: ssid:AndroidAP, bssid:null, security:2, networkid:0, signIn:2
06-24 00:10:57.920 17140 30744 D HtcAccessPoint: ssid:RailWire Wi-Fi, bssid:null, security:0, networkid:6, signIn:2
06-24 00:10:57.930 17140 30744 D HtcAccessPoint: ssid:spawn, bssid:any, security:2, networkid:5, signIn:2
06-24 00:10:57.930 17140 30744 D HtcAccessPoint: ssid:teewe4560, bssid:null, security:0, networkid:3, signIn:2
06-24 00:10:57.930 17140 30744 D HtcAccessPoint: ssid:dlink, bssid:null, security:2, networkid:2, signIn:2
06-24 00:10:57.930 17140 30744 D WifiManager: getScanResults: Base Package Name=com.android.settings, uid=1000
06-24 00:10:57.930 29640 30821 D AutoSettingApp: Util - no network available! active network = null
06-24 00:10:57.930 29640 30821 D HtcNLPSwitchReceiver: No info or Not connected
06-24 00:10:57.930 28392 28392 D HtcNLPSwitchReceiver: onReceive() isWeatherAppMigrate is true
06-24 00:10:57.930 17140 30744 D AccessPointPreference: summary : spawn, Saved [(1);!1] cf=1
06-24 00:10:57.930 17140 30744 D HtcWifiTracker: connection info-SSID: spawn, BSSID: 00:00:00:00:00:00, Supplicant state: DISCONNECTED, RSSI: -127, Link speed: -1Mbps, Frequency: -1MHz, Net ID: -1, Metered hint: false, score: 0
06-24 00:10:57.930 1090 1250 D WifiStateMachine: DisconnectedState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168217/3692294 1000 0 num=7
06-24 00:10:57.930 1090 1250 D WifiStateMachine: ConnectModeState !CMD_GET_CONFIGURED_NETWORKS uid=1000 rt=3168218/3692295 1000 0 num=7
06-24 00:10:57.940 17140 17140 D WifiManager: getVerboseLoggingLevel: Base Package Name=com.android.settings, uid=1000
06-24 00:10:57.940 1090 1847 D WifiStateMachine: getVerboseLoggingLevel: mVerboseLoggingLevel= 1
06-24 00:10:57.940 17140 17140 E HtcPreference: [removeAll]:before size= 1
06-24 00:10:57.940 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
06-24 00:10:57.940 17140 17140 E HtcPreference: [removeAll]:after size= 0
06-24 00:10:57.940 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
06-24 00:10:57.940 17140 17140 E HtcPreference: [addPreference]:before size= 0
06-24 00:10:57.940 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
06-24 00:10:57.940 17140 17140 E HtcPreference: [addPreference]:after size= 1
06-24 00:10:57.940 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
06-24 00:10:57.940 17140 17140 D WifiManager: getVerboseLoggingLevel: Base Package Name=com.android.settings, uid=1000
06-24 00:10:57.940 17140 17140 E HtcPreference: [removeAll]:before size= 1
06-24 00:10:57.940 1090 1112 D WifiStateMachine: getVerboseLoggingLevel: mVerboseLoggingLevel= 1
06-24 00:10:57.940 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
06-24 00:10:57.940 17140 17140 E HtcPreference: [removeAll]:after size= 0
06-24 00:10:57.940 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
06-24 00:10:57.940 17140 17140 E HtcPreference: [addPreference]:before size= 0
06-24 00:10:57.940 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
06-24 00:10:57.940 17140 17140 E HtcPreference: [addPreference]:after size= 1
06-24 00:10:57.940 17140 17140 E HtcPreference: Thread =Thread[main,5,main]
-------------------------------------END OF LOGCAT---------------
Regards
Hi,
So I'm terrorized by audio stream cutout after 5 minutes while screen is off.
This happens while streaming thru browser also with MX Player Pro streams cuts off,
and does not return until screen is powered on..
I tried ServeStream and while it works, it to suffers from 10-15sec of audio cutout every 5min blaming buffer is empty..
So I tried setting:
Wifi network : Not metered
Unrestricted data usage: Browser (NBP), Media (MTP Host), ServeStream
Battery Not optimized : Browser (NBP), Media Storage, MTP Host, MX Player Pro, ServeStream
(just for oldschool times; adb shell settings put global wifi_sleep_policy 2)
But nothing gives, what else is there to do?
I'm trying practise playing along with a buddy of mine and this utter madness is ruining it.
Captured from logcat what occurse every time streaming thru browser.
HTML:
.
.
W chromium: [WARNING:audio_sync_reader.cc(193)] AudioSyncReader::Read timed out, audio glitch count=30
.
.
D : PlayerBase::stop() from IPlayer
D AudioTrack: stop() called with 19371008 frames delivered
E AudioAttributes: Illegal value unmarshalling AudioAttributes, can't initialize bundle
E AudioService.PlaybackActivityMonitor: Error updating audio attributes
D : PlayerBase::stop() from IPlayer
W AudioFlinger: moveEffectChain_l() effect chain for session 0 not on source thread 0xadc039c0
W BroadcastQueue: Background execution not allowed: receiving Intent { act=lineageos.intent.action.ACTION_AUDIO_SESSIONS_CHANGED flg=0x10000010 (has extras) } to org.lineageos.audiofx/.receiver.ServiceDispatcher
D audio_hw_primary: out_standby: enter: stream (0xaeebd800) usecase(0: deep-buffer-playback)
D hardware_info: hw_info_append_hw_type : device_name = speaker
D : TrackPlayerBase::~TrackPlayerBase()
: PlayerBase::~PlayerBase()
.
.
I WifiService: requestActivityInfo uid=1000
I WifiService: reportActivityInfo uid=1000
I WifiService: getSupportedFeatures uid=1000
D WifiHAL : In DebugCommand::handleResponse
D WifiHAL : len = 4, expected len = 4
D lights.msm8974: led [solid] = ff0d0200
D WifiHAL : In DebugCommand::handleResponse
D WifiHAL : len = 4, expected len = 4
E BatteryExternalStatsWorker: no controller energy info supplied for wifi
E BatteryExternalStatsWorker: no controller energy info supplied for bluetooth
D lights.msm8974: led [solid] = ff0d0200
E BatteryExternalStatsWorker: modem info is invalid: ModemActivityInfo{ mTimestamp=0 mSleepTimeMs=0 mIdleTimeMs=0 mTxTimeMs[]=[0, 0, 0, 0, 0] mRxTimeMs=0 mEnergyUsed=0}
.
.
Current rom AICP 13.1
I'm having problems with my phone, on my Mate SE I have Magisk, the modules I installed are 1Controller, AdguardDNS AdBlocker, Busybox for android NDK, Exo2 Font, Global Optimized GPS File Replacer, Greenify4Magisk, and iOS12.2 Emoji.
Apps I have that also may cause this error. Substratum, VPN, Lucky Patcher, Google Maps, Modded Playstore, Magisk Manager, etc.
ROM: Open kirin Resurrection Remix OS beta 3
Kernel: Elemental v5.8 (2018-10-16)
Error: Every GPS app I have can't detect my location. I have root, and high accuracy on. I tried changing the gps.conf file with Global Optimized GPS File Replacer but no luck. I press the view my location button and nothing happens. Maybe the root apps or modules I have don't work with maps. Also before this error occurred, it got stuck on finding best route.
Logcat:
--------- beginning of main
12-02 00:28:02.773 1808 1808 W ChimeraUtils: Non Chimera context
12-02 00:28:02.773 1808 1808 W ChimeraUtils: Non Chimera context
12-02 00:28:03.105 8464 8474 I zygote64: Background concurrent copying GC freed 379279(15MB) AllocSpace objects, 91(4MB) LOS objects, 50% free, 11MB/23MB, paused 164us total 195.122ms
12-02 00:28:13.735 1036 1268 D AudioService: Stream muted, skip playback
12-02 00:28:13.759 1036 1833 I WifiService: getWifiEnabledState uid=10022
12-02 00:28:13.759 1036 1833 I WifiService: isScanAlwaysAvailable uid=10022
12-02 00:28:14.452 1036 1268 D AudioService: Stream muted, skip playback
12-02 00:28:14.468 1036 1611 I WifiService: getWifiEnabledState uid=10022
12-02 00:28:14.470 1036 1611 I WifiService: isScanAlwaysAvailable uid=10022
12-02 00:28:15.075 1036 1268 D AudioService: Stream muted, skip playback
12-02 00:28:15.100 1036 1833 I WifiService: getWifiEnabledState uid=10022
12-02 00:28:15.101 1036 1833 I WifiService: isScanAlwaysAvailable uid=10022
12-02 00:28:15.589 1036 1268 D AudioService: Stream muted, skip playback
12-02 00:28:15.605 1036 1611 I WifiService: getWifiEnabledState uid=10022
12-02 00:28:15.606 1036 1611 I WifiService: isScanAlwaysAvailable uid=10022
12-02 00:28:16.060 1036 1268 D AudioService: Stream muted, skip playback
12-02 00:28:16.086 1036 1611 I WifiService: getWifiEnabledState uid=10022
12-02 00:28:16.086 1036 1611 I WifiService: isScanAlwaysAvailable uid=10022
12-02 00:28:16.125 537 537 I GRALLOC : shrFd=10,fmt=0x1,intFmt=0x200000001,btStrd=4352,size=9547776,pid=537
12-02 00:28:16.125 537 537 I GRALLOC : yuv=2,w=1080,h=2160,Stride u=0 v=0,offset u=0 v=0
12-02 00:28:16.125 537 537 I GRALLOC : iova_size=9547776,conUsg=0xb00,proUsg=0xb00, strd=1088,[afbc]HdrStrd=1088 PyldStrd=69632 Scrmbl=0,ionhnd = 1
--------- beginning of system
12-02 00:28:19.724 1036 1068 E BatteryExternalStatsWorker: modem info is invalid: ModemActivityInfo{ mTimestamp=0 mSleepTimeMs=0 mIdleTimeMs=0 mTxTimeMs[]=[0, 0, 0, 0, 0] mRxTimeMs=0 mEnergyUsed=0}
12-02 00:28:25.570 1374 1374 D HeadsetPhoneState: sendDeviceStateChanged. mService=1 mIsSimStateLoaded=true mSignal=5 mRoam=0 mBatteryCharge=5
12-02 00:28:27.211 6711 6711 I .android.chrome: type=1400 audit(0.0:566): avc: denied { read } for name="vmstat" dev="proc" ino=4026532162 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=ubject_rroc:s0 tclass=file permissive=1
12-02 00:28:27.211 6711 6711 I .android.chrome: type=1400 audit(0.0:567): avc: denied { open } for path="/proc/vmstat" dev="proc" ino=4026532162 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=ubject_rroc:s0 tclass=file permissive=1
12-02 00:28:27.211 6711 6711 I .android.chrome: type=1400 audit(0.0:568): avc: denied { getattr } for path="/proc/vmstat" dev="proc" ino=4026532162 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=ubject_rroc:s0 tclass=file permissive=1
12-02 00:28:29.917 1374 1374 D HeadsetPhoneState: sendDeviceStateChanged. mService=1 mIsSimStateLoaded=true mSignal=4 mRoam=0 mBatteryCharge=5
12-02 00:28:44.574 12097 12114 I Finsky : [111] com.google.android.finsky.bo.ad.run(6): Stats for Executor: BlockingExecutor [email protected][Running, pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 7]
12-02 00:28:44.575 12097 12114 I Finsky : [111] com.google.android.finsky.bo.ad.run(6): Stats for Executor: LightweightExecutor [email protected][Running, pool size = 4, active threads = 0, queued tasks = 0, completed tasks = 44]
12-02 00:28:44.697 12097 12114 I Finsky : [111] com.google.android.finsky.bo.ad.run(6): Stats for Executor: bgExecutor [email protected][Running, pool size = 4, active threads = 0, queued tasks = 0, completed tasks = 10]
bump, please someone help
Hello,
I just have a question, my Xperia 1 was unlocked and rooted (magisk) on Android 10.
Yesterday, I decided to lock the bootloader, everything was erased from the phone after that. The new Android installation was buggy so I tried to restore the phone using Xperia Companion.
After the restore using Xperia Companion, Now everything is working fine and I was really surprised, my DRM keys are back, I have "L1" using the DRM info app and I can watch Netflix HD content and Amazon Prime Video HD content.
How is that possible ? I thought that by unlocking the bootloader, the DRM keys are lost forever ?
Hmmm do you have any proof?
Hello,
Yes, please see my old messages, I succesfully unlocked ans rooted the device. Now see the screenshot below.
https://ibb.co/7RH2ZdG
Check with *#*#7378423#*#*
Then service info>security
Then see if any ........XXXXX error and share the screenshot.
Thanks
Hello, thanks for your Reply.
It seems that there is No error, but I have confirmation that thé device has already be unlocked
https://imgshare.io/image/screenshot-20200412-1650532.4yP8t
By thé way, i also recieved an OTAsoftware uppgrade. So this is now working too.
titigunner01 said:
By thé way, i also recieved an OTAsoftware uppgrade. So this is now working too.
Click to expand...
Click to collapse
You can receive OTA if you have just locked the bootloader.
But the things in Screenshot looks great. It was a previous way of checking the DRM keys and I don't know if only these things verify the DRM keys in latest versions too.
Is it a matter that the phone restores the DRM under locked bootloader again in Sony or did they remove the DRMs?
But what it matters is you are using apps and things like you have the DRM so may be thats good.:good:
So, after you restored stock ROM, also the boot message "can't be checked for corruption" is gone?
Yes, no message when booting.
Very strange, i wanted to know if everyone else noticed thé same thing.
titigunner01 said:
Yes, no message when booting.
Very strange, i wanted to know if everyone else noticed thé same thing.
Click to expand...
Click to collapse
Eventually I will try on my Xperia 10 II. Hope I have the same luck, thanks!
titigunner01 said:
Hello,
I just have a question, my Xperia 1 was unlocked and rooted (magisk) on Android 10.
Yesterday, I decided to lock the bootloader, everything was erased from the phone after that. The new Android installation was buggy so I tried to restore the phone using Xperia Companion.
After the restore using Xperia Companion, Now everything is working fine and I was really surprised, my DRM keys are back, I have "L1" using the DRM info app and I can watch Netflix HD content and Amazon Prime Video HD content.
How is that possible ? I thought that by unlocking the bootloader, the DRM keys are lost forever ?
Click to expand...
Click to collapse
did you lock the bootloader with flashtool?
I just want to do it too, but can`t I find a guide for xperia 1
No i locked the bootloader using command lines.
Maybe this will work also using Flashtool, Im not sure.
titigunner01 said:
No i locked the bootloader using command lines.
Maybe this will work also using Flashtool, Im not sure.
Click to expand...
Click to collapse
you using this commands?
fastboot oem lock
fastboot flashing lock
fastboot oem relock
fastboot reboot
if not, can you describe step by step how you did it?
I will
thankful to you!
Hello,
Yes, if I remember well, on fastboot mode, i used fastboot oem lock.
After the reboot of the phone, everything was reased. The new installation was really buggy so after that I recovered using Xperia Companion.
interesting - I am wondering if sony still uses the device key in TA 66667 unit and if it gets erased with the first unlock or not.
Deleted
Relock the bootloader, repair with xperia companion and drm keys are back.
Only on xperia 1, 5 and up !
Beware: even though it may look all keys are back, it is still questionable if some function/feature is not permanently missing.
I did some research and it seems xperia 1 bootloader ABL does erase device key, i.e. TA 66667 (0x1046b) unit, on unlock.
So in my opinion even though you can relock and everything looks normal, the device key gets never back.
The question is what (drm) functions are connected to it.
Here more details:
Just extracted abl from J9110_10_55.1.A.0.748_PLUSPL, posted it here:
xperia-1-J9110-55.1.A.0.748-LA2_0_Q_114-ABL-LinuxLoader.zip
Just observing the strings in it, I am not trusting SONY at all with the re-lock of xperia-1:
Code:
$ strings -a LA2_0_Q_114-ABL-LinuxLoader.pe | grep -i 'device key\|[ _]dk'
Size of device key is too large (%d > %d)
Device key is not set, setting to zero
get_dk returned err=%d
Unable to delete dk
get_hwconf_dk returned err=%d
Device Key MiscTA unit size is zero
Failed to allocate memory for Device Key
Device keys not of equal length!
hwconf_x_parser_get_hwc_dk returned err=%d
Device Key length in HWConfig is zero
Failed to get size of TA_DK_NUMBER_UNIT
Failed to delete DK
This looks very similar to stuff implemented in xz1c ABL related to unlock and TA unit 66667 (0x1046b) containing the device key erased with bootloader unlock!
You may also observe if the message "Device key is not set, setting to zero" is present in bootloader log that is stored in 0x802 TA unit (and few other following units containing older boots).
It would be interesting to test TA backup, unlock, relock, TA restore, so that device key would be back.
This tells everything:
From i d a can't see 1046b but see the same function at the bottom (ghidra output)
Code:
void sub_4DDE4()
{
int v0; // w0
__int64 v1; // x3
__int64 v2; // x4
__int64 v3; // x5
__int64 v4; // x6
__int64 v5; // x7
__int64 v6; // x0
__int64 v7; // x1
const char *v8; // x0
__int64 v9; // x2
__int64 v10; // x0
char v11; // zf
int v12; // w0
__int64 v13; // x0
__int64 v14; // x0
unsigned int v15; // w1
__int64 v16; // x2
__int64 v17; // x3
_DWORD *v18; // x4
__int64 v19; // x5
__int64 v20; // x6
__int64 v21; // x7
signed int v22; // [xsp+4h] [xbp-2Ch]
sub_440B4();
if ( v0 )
{
sub_4DF70();
v7 = v6;
v8 = "[ERROR @ %s:%d]:\nFailed to get size of TA_DK_NUMBER_UNIT\n";
v9 = 303i64;
}
else
{
if ( v22 < 1 )
goto LABEL_4;
sub_44318();
if ( !v12 )
goto LABEL_4;
sub_4DF70();
v7 = v13;
v8 = "[ERROR @ %s:%d]:\nFailed to delete DK\n";
v9 = 310i64;
}
sub_589A0(v8, v7, v9, v1, v2, v3, v4, v5);
LABEL_4:
sub_4DF5C();
if ( !v11 )
{
sub_14468(v10);
sub_4DE94(v14, v15, v16, v17, v18, v19, v20, v21);
}
}
Code:
sub_4110C();
[B][COLOR="Red"]sub_4DDE4();[/COLOR][/B]
if ( v0 )
{
sub_41100();
sub_589A0("[ERROR @ %s:%d]:\nUnable to delete dk\n", v1, 1438i64, v2, v3, v4, v5, v6);
goto LABEL_10;
}
sub_3ED48();
if ( !v7 )
{
sub_41100();
sub_589A0("[ERROR @ %s:%d]:\nFailed to delete user sensitive partitions\n", v18, 1443i64, v19, v20, v21, v22, v23);
goto LABEL_10;
}
sub_3EE20();
if ( v8 )
{
sub_41100();
v15 = v14;
v16 = "[ERROR @ %s:%d]:\nFailed to reset rollback counters, error:%d\n";
v17 = 1451i64;
}
else
{
sub_3EDF0();
if ( !v24 )
goto LABEL_10;
sub_41100();
v15 = v25;
v16 = "[ERROR @ %s:%d]:\n[B][COLOR="Red"]Failed to lock the bootloader: [/COLOR][/B]%d\n";
v17 = 1457i64;
}
ghidra
Code:
ulonglong FUN_0005dde4(void)
{
bool in_ZR;
undefined uVar1;
ulonglong uVar2;
undefined8 extraout_x0;
undefined8 local_28;
undefined8 extraout_x0_00;
undefined8 uVar3;
undefined *puVar4;
undefined uVar5;
undefined8 in_x3;
undefined7 uVar6;
undefined uVar7;
undefined8 in_x4;
undefined7 uVar8;
undefined uVar9;
undefined8 in_x5;
undefined7 uVar10;
undefined uVar11;
undefined8 in_x6;
undefined7 uVar12;
undefined uVar13;
undefined8 in_x7;
undefined7 uVar14;
ulonglong uVar15;
undefined in_stack_ffffffffffffffd0;
undefined uVar16;
int local_2c;
uVar14 = (undefined7)((ulonglong)in_x7 >> 8);
uVar13 = (undefined)in_x7;
uVar12 = (undefined7)((ulonglong)in_x6 >> 8);
uVar11 = (undefined)in_x6;
uVar10 = (undefined7)((ulonglong)in_x5 >> 8);
uVar9 = (undefined)in_x5;
uVar8 = (undefined7)((ulonglong)in_x4 >> 8);
uVar7 = (undefined)in_x4;
uVar6 = (undefined7)((ulonglong)in_x3 >> 8);
uVar5 = (undefined)in_x3;
puVar4 = &stack0xffffffffffffffd4;
uVar3 = 0x1046b;
local_28 = DAT_000a90c0;
uVar2 = FUN_000540b4(2);
uVar16 = (undefined)local_2c;
uVar1 = (undefined)uVar2;
if ((int)uVar2 == 0) {
in_ZR = local_2c == 1;
if (local_2c < 1) {
uVar15 = 0;
goto LAB_0005de34;
}
[COLOR="Blue"][B] uVar3 = 0x1046b; // drm key unit[/B][/COLOR]
[COLOR="Red"] uVar2 = FUN_00054318(2); // partition 2
uVar1 = (undefined)uVar2;
uVar15 = uVar2 & 0xffffffff;
if ((int)uVar2 == 0) goto LAB_0005de34;
FUN_0005df70(uVar2,uVar3,puVar4,CONCAT71(uVar6,uVar5),CONCAT71(uVar8,uVar7),
CONCAT71(uVar10,uVar9),CONCAT71(uVar12,uVar11),CONCAT71(uVar14,uVar13));
_uVar1 = "[ERROR @ %s:%d]:\nFailed to delete DK\n";[/COLOR]
puVar4 = (undefined *)0x136;
uVar3 = extraout_x0_00;
}
else {
uVar15 = uVar2 & 0xffffffff;
FUN_0005df70(uVar2,uVar3,puVar4,CONCAT71(uVar6,uVar5),CONCAT71(uVar8,uVar7),
CONCAT71(uVar10,uVar9),CONCAT71(uVar12,uVar11),CONCAT71(uVar14,uVar13));
_uVar1 = "[ERROR @ %s:%d]:\nFailed to get size of TA_DK_NUMBER_UNIT\n";
puVar4 = (undefined *)0x12f;
uVar3 = extraout_x0;
}
uVar1 = FUN_000689a0(_uVar1,uVar3,puVar4,CONCAT71(uVar6,uVar5),CONCAT71(uVar8,uVar7),
CONCAT71(uVar10,uVar9),CONCAT71(uVar12,uVar11),CONCAT71(uVar14,uVar13));
LAB_0005de34:
local_28 = FUN_0005df5c(uVar1,(char)uVar3,(char)puVar4,uVar5,uVar7,uVar9,uVar11,uVar13,
in_stack_ffffffffffffffd0,uVar16,local_28);
if (in_ZR) {
return uVar15;
}
// WARNING: Subroutine does not return
FUN_00024468(local_28,uVar3,puVar4,CONCAT71(uVar6,uVar5),CONCAT71(uVar8,uVar7),
CONCAT71(uVar10,uVar9),CONCAT71(uVar12,uVar11),CONCAT71(uVar14,uVar13));
}
Its very evidently that function sub_4DDE4 is called at the start of lock function, I can tell that drm key is bye bye after you unlock phone, curently I'm unable to figure out what is done with oem lock command & why widevine keys is back but definitelly drm key is lost forever, indication for that is message inside service menu "is even unlocked = yes" !
So how lock is done, in short:
1. drm key bye bye
2. user sensitive partitions deleted (thats why device no more boot & must use sony pc companion in order to repair)
3. rollback counter reset
4. bootloader locked
Some good news for bootloader unlocked xperia 10 owners! I'm managed to get all back after patching secd
Code:
07-25 17:10:29.745 8470 8471 I [email protected]: start init_thread
07-25 17:10:29.745 8470 8471 I [email protected]: listeners registered
07-25 17:10:29.745 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0x200
07-25 17:10:29.746 8470 8471 D QSEECOMAPI: App is already loaded QSEE and app id = 131074
07-25 17:10:29.746 579 579 I SELinux : avc: received setenforce notice (enforcing=0)
07-25 17:10:29.747 579 579 W hwservicemanager: Detected instance of [email protected]::IDeviceSecurity (pid: 8470) registering over instance of or with base of [email protected]::IDeviceSecurity (pid: 879).
07-25 17:10:29.751 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:29.751 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 131074
07-25 17:10:29.752 8470 8471 I libdevice_security_static: get_rooting_status.cpp:80 rooting_status 0
07-25 17:10:29.752 8470 8471 I [email protected]: the bootloader is OK, try to init suntory
07-25 17:10:29.752 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2022
07-25 17:10:29.754 8470 8471 I libsuntory_static: utils_blob.cpp:497 found blob CKB
07-25 17:10:29.754 8470 8471 I libsuntory_static: utils_blob.cpp:521 match found at index 0
07-25 17:10:29.755 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0x4100
07-25 17:10:29.755 8470 8471 D QSEECOMAPI: App is not loaded in QSEE
07-25 17:10:29.755 8470 8471 D QSEECOMAPI: app_arch = 2, total_files = 9
07-25 17:10:29.788 8470 8471 D QSEECOMAPI: Loaded image: APP id = 1179652
07-25 17:10:29.789 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0xc00
07-25 17:10:29.789 8470 8471 D QSEECOMAPI: App is already loaded QSEE and app id = 131074
07-25 17:10:29.793 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:29.793 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 131074
07-25 17:10:29.798 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:29.798 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 1179652
07-25 17:10:29.798 8470 8471 I libsuntory_static: utils_blob.cpp:121 blob verisfication status: Blob OK
07-25 17:10:29.798 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2023
07-25 17:10:29.801 8470 8471 I libsuntory_static: utils_blob.cpp:497 found blob WIDEVINE
07-25 17:10:29.801 8470 8471 I libsuntory_static: utils_blob.cpp:521 match found at index 1
07-25 17:10:29.801 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0x4100
07-25 17:10:29.801 8470 8471 D QSEECOMAPI: App is not loaded in QSEE
07-25 17:10:29.801 8470 8471 D QSEECOMAPI: app_arch = 2, total_files = 9
07-25 17:10:29.835 8470 8471 D QSEECOMAPI: Loaded image: APP id = 1245188
07-25 17:10:29.835 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0xc00
07-25 17:10:29.835 8470 8471 D QSEECOMAPI: App is already loaded QSEE and app id = 131074
07-25 17:10:29.838 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:29.838 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 131074
07-25 17:10:29.843 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:29.843 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 1245188
07-25 17:10:29.844 8470 8471 I libsuntory_static: utils_blob.cpp:121 blob verisfication status: Blob OK
07-25 17:10:29.844 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2024
07-25 17:10:29.846 8470 8471 E libsuntory_static: utils_blob.cpp:477 invalid blob size 1
07-25 17:10:29.846 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2025
07-25 17:10:29.848 8470 8471 E libsuntory_static: utils_blob.cpp:477 invalid blob size 0
07-25 17:10:29.848 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2026
07-25 17:10:29.849 8470 8471 E libsuntory_static: utils_blob.cpp:477 invalid blob size 0
07-25 17:10:29.849 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2027
07-25 17:10:29.850 8470 8471 E libsuntory_static: utils_blob.cpp:477 invalid blob size 0
07-25 17:10:29.850 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2028
07-25 17:10:29.851 8470 8471 E libsuntory_static: utils_blob.cpp:477 invalid blob size 0
07-25 17:10:29.851 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2029
07-25 17:10:29.852 8470 8471 E libsuntory_static: utils_blob.cpp:477 invalid blob size 0
07-25 17:10:29.852 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2030
07-25 17:10:29.853 8470 8471 E libsuntory_static: utils_blob.cpp:477 invalid blob size 0
07-25 17:10:29.853 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2031
07-25 17:10:29.855 8470 8471 E libsuntory_static: utils_blob.cpp:477 invalid blob size 0
07-25 17:10:29.855 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2032
07-25 17:10:29.856 8470 8471 E libsuntory_static: utils_blob.cpp:477 invalid blob size 0
07-25 17:10:29.856 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2033
07-25 17:10:29.857 8470 8471 E libsuntory_static: utils_blob.cpp:477 invalid blob size 0
07-25 17:10:29.857 8470 8471 I libsuntory_static: utils_blob.cpp:462 process miscTA unit 2034
07-25 17:10:29.858 8470 8471 E libsuntory_static: utils_blob.cpp:477 invalid blob size 0
07-25 17:10:29.858 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0xa000
07-25 17:10:29.858 8470 8471 D QSEECOMAPI: App is already loaded QSEE and app id = 65537
07-25 17:10:29.862 8470 8471 E KeymasterUtils: TA API Major Version: 4
07-25 17:10:29.862 8470 8471 E KeymasterUtils: TA API Minor Version: 0
07-25 17:10:29.862 8470 8471 E KeymasterUtils: TA Major Version: 4
07-25 17:10:29.862 8470 8471 E KeymasterUtils: TA Minor Version: 162
07-25 17:10:29.866 622 628 D DrmLibTime: got the req here! ret=0
07-25 17:10:29.866 622 628 D DrmLibTime: command id, time_cmd_id = 770
07-25 17:10:29.866 622 628 D DrmLibTime: time_getutcsec starts!
07-25 17:10:29.866 622 628 D DrmLibTime: QSEE Time Listener: time_getutcsec
07-25 17:10:29.866 622 628 D DrmLibTime: QSEE Time Listener: get_utc_seconds
07-25 17:10:29.866 622 628 D DrmLibTime: QSEE Time Listener: time_get_modem_time
07-25 17:10:29.866 622 628 D DrmLibTime: QSEE Time Listener: Checking if ATS_MODEM is set or not.
07-25 17:10:29.866 622 628 D QC-time-services: Lib:time_genoff_operation: pargs->base = 13
07-25 17:10:29.866 622 628 D QC-time-services: Lib:time_genoff_operation: pargs->operation = 2
07-25 17:10:29.866 622 628 D QC-time-services: Lib:time_genoff_operation: pargs->ts_val = 0
07-25 17:10:29.866 622 628 D QC-time-services: Lib:time_genoff_operation: Send to server passed!!
07-25 17:10:29.866 792 800 D QC-time-services: Daemon: Connection accepted:time_genoff
07-25 17:10:29.867 792 8472 D QC-time-services: Daemon:Received base = 13, unit = 1, operation = 2,value = 0
07-25 17:10:29.867 792 8472 D QC-time-services: Daemon:genoff_opr: Base = 13, val = 0, operation = 2
07-25 17:10:29.867 792 8472 D QC-time-services: offset is: 1 for base: 13
07-25 17:10:29.867 622 628 E QC-time-services: Receive Passed == base = 13, unit = 1, operation = 2, result = 0
07-25 17:10:29.867 622 628 D DrmLibTime: QSEE Time Listener: ATS_MODEM is set. Try to retrieve it.
07-25 17:10:29.867 792 800 E QC-time-services: Daemon: Time-services: Waiting to acceptconnection
07-25 17:10:29.867 792 800 D QC-time-services: Daemon: Connection accepted:time_genoff
07-25 17:10:29.867 792 8473 D QC-time-services: Daemon:Received base = 13, unit = 1, operation = 1,value = 0
07-25 17:10:29.868 792 8473 D QC-time-services: Daemon:genoff_opr: Base = 13, val = 0, operation = 1
07-25 17:10:29.868 792 8473 D QC-time-services: Daemon: genoff get for 13
07-25 17:10:29.868 792 8473 D QC-time-services: Daemon:Value read from QTimer mseconds = 1307648
07-25 17:10:29.868 792 8473 D QC-time-services: Daemon:Value read from RTC mseconds on boot = 48462179000
07-25 17:10:29.868 792 8473 D QC-time-services: Daemon:Value read from QTimer mseconds = 1307648
07-25 17:10:29.868 792 8473 D QC-time-services: Daemon:Value read from generic offset = 1547226365549
07-25 17:10:29.868 792 8473 D QC-time-services: Daemon:Delta read on boot mseconds = 48462155118
07-25 17:10:29.868 792 8473 D QC-time-services: Daemon:Final Time = 1595689828315
07-25 17:10:29.868 622 628 D DrmLibTime: QSEE Time Listener: Time GenOff - seconds: 1595689828
07-25 17:10:29.868 622 628 D DrmLibTime: time_getutcsec returns 0, sec = 1595689828; nsec = 0
07-25 17:10:29.868 622 628 D DrmLibTime: time_getutcsec finished!
07-25 17:10:29.868 622 628 D DrmLibTime: iotcl_continue_command finished! and return 0
07-25 17:10:29.868 622 628 D DrmLibTime: before calling ioctl to read the next time_cmd
07-25 17:10:29.868 792 800 E QC-time-services: Daemon: Time-services: Waiting to acceptconnection
07-25 17:10:29.887 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0x200
07-25 17:10:29.888 8470 8471 D QSEECOMAPI: App is already loaded QSEE and app id = 131074
07-25 17:10:29.889 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:29.889 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 131074
07-25 17:10:29.889 8470 8471 I libdevice_security_static: get_imei.cpp:180 imei STR munjeni edited, size 15
07-25 17:10:29.899 8470 8471 E KeyMasterHalDevice: Attest key send cmd failed
07-25 17:10:29.899 8470 8471 E KeyMasterHalDevice: ret: 0
07-25 17:10:29.899 8470 8471 E KeyMasterHalDevice: resp->status: -10003
07-25 17:10:29.906 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:29.906 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 65537
07-25 17:10:29.906 8470 8471 I [email protected]: key id ANDROID_ATTEST status PROVISIONED
07-25 17:10:29.907 587 587 I tad : MiscTA Unit 2021:
07-25 17:10:29.907 587 587 I tad : WRITTEN (Size 20)
07-25 17:10:29.930 587 587 I tad : Actual erase/write to flash done (count 4, time 1595689829).
07-25 17:10:29.930 587 587 I tad : MiscTA: Write of unit 2021 completed - OK
07-25 17:10:29.930 8470 8471 I [email protected]: suntory initialized
07-25 17:10:29.930 8470 8471 I [email protected]: wait for post_fs proprty
07-25 17:10:29.930 8470 8471 I [email protected]: post_fs property triggered
07-25 17:10:29.930 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0x200
07-25 17:10:29.930 8470 8471 D QSEECOMAPI: App is already loaded QSEE and app id = 131074
07-25 17:10:29.932 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:29.932 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 131074
07-25 17:10:29.932 8470 8471 I libdevice_security_static: get_rooting_status.cpp:80 rooting_status 2
07-25 17:10:29.935 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0x200
07-25 17:10:29.935 8470 8471 D QSEECOMAPI: App is already loaded QSEE and app id = 131074
07-25 17:10:29.936 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:29.936 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 131074
07-25 17:10:29.936 8470 8471 I libdevice_security_static: get_security_config.cpp:68 security configuration 1
07-25 17:10:29.936 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0x83c0
07-25 17:10:29.936 8470 8471 D QSEECOMAPI: App is not loaded in QSEE
07-25 17:10:29.936 8470 8471 D QSEECOMAPI: app_arch = 2, total_files = 9
07-25 17:10:29.973 8470 8471 D QSEECOMAPI: Loaded image: APP id = 1310724
07-25 17:10:29.974 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0xc00
07-25 17:10:29.974 8470 8471 D QSEECOMAPI: App is already loaded QSEE and app id = 131074
07-25 17:10:29.977 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:29.977 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 131074
07-25 17:10:29.980 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:29.980 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 1310724
07-25 17:10:29.982 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0x83c0
07-25 17:10:29.982 8470 8471 D QSEECOMAPI: App is not loaded in QSEE
07-25 17:10:29.982 8470 8471 D QSEECOMAPI: app_arch = 2, total_files = 9
07-25 17:10:30.016 8470 8471 D QSEECOMAPI: Loaded image: APP id = 1376260
07-25 17:10:30.016 8470 8471 D QSEECOMAPI: QSEECom_get_handle sb_length = 0xc00
07-25 17:10:30.016 8470 8471 D QSEECOMAPI: App is already loaded QSEE and app id = 131074
07-25 17:10:30.020 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:30.020 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 131074
07-25 17:10:30.023 8470 8471 D QSEECOMAPI: QSEECom_dealloc_memory
07-25 17:10:30.023 8470 8471 D QSEECOMAPI: QSEECom_shutdown_app, app_id = 1376260
07-25 17:10:30.024 8470 8471 I [email protected]: credmgr initialized
07-25 17:10:30.025 8470 8471 I [email protected]: "vendor.keyprovd.suntory.prov" property set
07-25 17:10:33.798 853 853 I [email protected]: type=1400 audit(0.0:2107): avc: denied { search } for name="kgsl" dev="sysfs" ino=28936 scontext=u:r:hal_memtrack_default:s0 tcontext=u:object_r:sysfs_kgsl:s0 tclass=dir permissive=1 ppid=1 pcomm="init" pgid=1 pgcomm="init"
07-25 17:10:36.689 8372 8372 W adbd : timeout expired while flushing socket, closing
Edit:
Now all ready https://forum.xda-developers.com/xp...m-fix-drm-fix-unlocked-bootloader-53-t4138269