Closed tefracky closed 3 years ago
dshokouhi
commented
3 years ago looks like the actual failure is when its trying to finish up the formatting, have you tried another NFC card to see if this one is just corrupt?
at io.homeassistant.companion.android.nfc.NFCUtil.writeMessageToTag(NFCUtil.kt:81)
dshokouhi
commented
3 years ago Also which variable did you print here 2021-03-04 15:43:21.744 25910-25910/io.homeassistant.companion.android.debug D/nDefTag: null
tefracky
commented
3 years ago looks like the actual failure is when its trying to finish up the formatting, have you tried another NFC card to see if this one is just corrupt?
at io.homeassistant.companion.android.nfc.NFCUtil.writeMessageToTag(NFCUtil.kt:81)
I am very sorry. I had to import "Log" and therefore, the line number in my error log is 1 higher than normal. The error occurs in line 80: it.format(nfcMessage)
I tried ~ 15 different tags and the error is allways the same.
Also which variable did you print here
2021-03-04 15:43:21.744 25910-25910/io.homeassistant.companion.android.debug D/nDefTag: null
It is the variable "nDefTag". I used the variable name as Log tag, so the output variables are nfcMessage, fallbackMessage, tag, nDefTag and nDefFormatableTag.
dshokouhi
commented
3 years ago I know some user had to grant the app certain permissions, did you try checking if that is the case here? I am not sure what we can do here since the error is not very clear since its failing on a multi step process.
When you say you tried another tag is it the same brand? do you have another brand or type to try?
BTW if you added a line to import the logger then you had an additional line above it for the actual log message. Double check the line number again to be certain. I would expect 2 lines minimum but you printed a few more before the actual error hit right?
tefracky
commented
3 years ago I am not sure how to grant the permission. I already read the other posts, but I didn't found a detecated "NFC permission" on my device or in the settings. Maybe it deptends on the android version or the device model, I don't know. I also tested it on a Galaxy A71 using Android 11, but the error is the same. My old Galaxy S4 says, that the NFC tag type is not supported, so I cannot test it.
I checked the line and the error occurs at the format command. I added the output lines directly bevor the throwable (lines 84 and later) to change as less as possible. Therefore, I have only the shift from the import. Tomorrow, I can post the code I used to make it clearer.
I only have this type of NFC tag. I already bought some others, but shipping from AliExpress takes some time. I am not that familiar with NFC, but I will make some other tests, maybe it will work somehow. If you have any suggestions or ideas, feel free to tell them :)
dshokouhi
commented
3 years ago Try to do a more global logcat search, go by the timestamp instead of looking for home assistant specifically...we may see a different error since its a multi step process.
The NFC setting is not visible on my Pixel 4 here and I have only seen a user on Xiaomi mention they have it. A lot of these settings are going to be manufacturer specific.
My hunch says something about these cards but honestly not sure, I assume they work in other apps? Personally I have tested this feature with a NTAG215
tefracky
commented
3 years ago Thanks a lot for your idea!
I found one single tag I can write. It is also a NXP Mifare Classic 1k (ISO 1443-3A) NFC tag, but somehow, it works. I made detailled logs for both, the writable and the not writable tag. For both tags, there are two logs, one filtered for home-assistant and one non-filtered.
The files I changed and used are these both:
NFCUtil: https://github.com/tefracky/android/blob/a7b708a3a8f647d92bc245794ba5f695a81091ea/app/src/main/java/io/homeassistant/companion/android/nfc/NFCUtil.kt NfcSetupActivity: https://github.com/tefracky/android/blob/a7b708a3a8f647d92bc245794ba5f695a81091ea/app/src/main/java/io/homeassistant/companion/android/nfc/NfcSetupActivity.kt
It seems, there is somehow an error by the NFC tag. Regarding the log, one important difference is here:
Working tag: tag = TAG: Tech [android.nfc.tech.NfcA, android.nfc.tech.MifareClassic, android.nfc.tech.NdefFormatable] Not working tag: tag = TAG: Tech [android.nfc.tech.NfcA, android.nfc.tech.MifareClassic, android.nfc.tech.Ndef]
Do you have any idea how I can solve this problem?
Not working tag filtered by homeassistant
io.homeassistant.companion.android.debug D/NFC Debug: intent = Intent { act=android.nfc.action.TECH_DISCOVERED flg=0x30000000 cmp=io.homeassistant.companion.android.debug/io.homeassistant.companion.android.nfc.NfcSetupActivity (has extras) }
io.homeassistant.companion.android.debug D/NFC Debug: false
io.homeassistant.companion.android.debug D/NFC Debug: nfcTagToWriteUUID = guten_abend
io.homeassistant.companion.android.debug D/NFC Debug: nfcTagToWriteUUID != null
io.homeassistant.companion.android.debug D/NFC Debug: nfcTagUrl = https://www.home-assistant.io/tag/guten_abend
io.homeassistant.companion.android.debug D/NFC Debug: createNFCMessage
io.homeassistant.companion.android.debug D/NFC Debug: url = https://www.home-assistant.io/tag/guten_abend
io.homeassistant.companion.android.debug D/NFC Debug: intent = Intent { act=android.nfc.action.TECH_DISCOVERED flg=0x30000000 cmp=io.homeassistant.companion.android.debug/io.homeassistant.companion.android.nfc.NfcSetupActivity (has extras) }
io.homeassistant.companion.android.debug V/FA: Recording user engagement, ms: 1741
io.homeassistant.companion.android.debug D/NFC Debug: nfcRecord = NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64
io.homeassistant.companion.android.debug D/NFC Debug: applicationRecord = NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567
io.homeassistant.companion.android.debug D/NFC Debug: nfcMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64, NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567]
io.homeassistant.companion.android.debug D/NFC Debug: nfcFallbackMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64]
io.homeassistant.companion.android.debug D/NFC Debug: Start writing Tag
io.homeassistant.companion.android.debug D/NFC Debug: enableNFCInForeground
io.homeassistant.companion.android.debug V/FA: Activity paused, time: 265537161
io.homeassistant.companion.android.debug D/NFC Debug: nfcMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64, NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567]
io.homeassistant.companion.android.debug D/NFC Debug: fallbackMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64]
io.homeassistant.companion.android.debug D/NFC Debug: tag = TAG: Tech [android.nfc.tech.NfcA, android.nfc.tech.MifareClassic, android.nfc.tech.NdefFormatable]
io.homeassistant.companion.android.debug D/NFC Debug: nDefTag = null
io.homeassistant.companion.android.debug D/NFC Debug: nDefFormatableTag = android.nfc.tech.NdefFormatable@61bc0f1
io.homeassistant.companion.android.debug D/NFC Debug: connected = kotlin.Unit
io.homeassistant.companion.android.debug I/Toast: show: focusDisplayId = 0, isFocusInDesktop = false mCustomDisplayId=-1 isDexDualMode=false
io.homeassistant.companion.android.debug I/Toast: show: isActivityContext = false
io.homeassistant.companion.android.debug E/NfcSetupActivity: Unable to write tag.
java.lang.Exception: Failed to format tag
at io.homeassistant.companion.android.nfc.NFCUtil.writeMessageToTag(NFCUtil.kt:130)
at io.homeassistant.companion.android.nfc.NFCUtil.createNFCMessage(NFCUtil.kt:34)
at io.homeassistant.companion.android.nfc.NfcSetupActivity.onNewIntent(NfcSetupActivity.kt:115)
at android.app.Activity.performNewIntent(Activity.java:8198)
at android.app.Instrumentation.callActivityOnNewIntent(Instrumentation.java:1409)
at android.app.Instrumentation.callActivityOnNewIntent(Instrumentation.java:1422)
at android.app.ActivityThread.deliverNewIntents(ActivityThread.java:4001)
at android.app.ActivityThread.handleNewIntent(ActivityThread.java:4013)
at android.app.servertransaction.NewIntentItem.execute(NewIntentItem.java:53)
at android.app.servertransaction.TransactionExecutor.executeCallbacks(TransactionExecutor.java:135)
at android.app.servertransaction.TransactionExecutor.execute(TransactionExecutor.java:95)
at android.app.ActivityThread$H.handleMessage(ActivityThread.java:2277)
at android.os.Handler.dispatchMessage(Handler.java:106)
at android.os.Looper.loop(Looper.java:246)
at android.app.ActivityThread.main(ActivityThread.java:8425)
at java.lang.reflect.Method.invoke(Native Method)
at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:596)
at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:1130)
Caused by: java.io.IOException
at android.nfc.tech.NdefFormatable.format(NdefFormatable.java:131)
at android.nfc.tech.NdefFormatable.format(NdefFormatable.java:94)
at io.homeassistant.companion.android.nfc.NFCUtil.writeMessageToTag(NFCUtil.kt:123)
at io.homeassistant.companion.android.nfc.NFCUtil.createNFCMessage(NFCUtil.kt:34)
at io.homeassistant.companion.android.nfc.NfcSetupActivity.onNewIntent(NfcSetupActivity.kt:115)
at android.app.Activity.performNewIntent(Activity.java:8198)
at android.app.Instrumentation.callActivityOnNewIntent(Instrumentation.java:1409)
at android.app.Instrumentation.callActivityOnNewIntent(Instrumentation.java:1422)
at android.app.ActivityThread.deliverNewIntents(ActivityThread.java:4001)
at android.app.ActivityThread.handleNewIntent(ActivityThread.java:4013)
at android.app.servertransaction.NewIntentItem.execute(NewIntentItem.java:53)
at android.app.servertransaction.TransactionExecutor.executeCallbacks(TransactionExecutor.java:135)
at android.app.servertransaction.TransactionExecutor.execute(TransactionExecutor.java:95)
at android.app.ActivityThread$H.handleMessage(ActivityThread.java:2277)
at android.os.Handler.dispatchMessage(Handler.java:106)
at android.os.Looper.loop(Looper.java:246)
at android.app.ActivityThread.main(ActivityThread.java:8425)
at java.lang.reflect.Method.invoke(Native Method)
at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:596)
at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:1130) Working tag filtered by homeassistant
io.homeassistant.companion.android.debug D/NFC Debug: intent = Intent { act=android.nfc.action.TECH_DISCOVERED flg=0x30000000 cmp=io.homeassistant.companion.android.debug/io.homeassistant.companion.android.nfc.NfcSetupActivity (has extras) }
io.homeassistant.companion.android.debug D/NFC Debug: false
io.homeassistant.companion.android.debug D/NFC Debug: nfcTagToWriteUUID = guten_abend
io.homeassistant.companion.android.debug D/NFC Debug: nfcTagToWriteUUID != null
io.homeassistant.companion.android.debug D/NFC Debug: nfcTagUrl = https://www.home-assistant.io/tag/guten_abend
io.homeassistant.companion.android.debug D/NFC Debug: createNFCMessage
io.homeassistant.companion.android.debug D/NFC Debug: url = https://www.home-assistant.io/tag/guten_abend
io.homeassistant.companion.android.debug D/NFC Debug: intent = Intent { act=android.nfc.action.TECH_DISCOVERED flg=0x30000000 cmp=io.homeassistant.companion.android.debug/io.homeassistant.companion.android.nfc.NfcSetupActivity (has extras) }
io.homeassistant.companion.android.debug V/FA: Screen exposed for less than 1000 ms. Event not sent. time: 962
io.homeassistant.companion.android.debug V/FA: Connection attempt already in progress
io.homeassistant.companion.android.debug V/FA: Activity paused, time: 265513739
io.homeassistant.companion.android.debug D/NFC Debug: nfcRecord = NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64
io.homeassistant.companion.android.debug D/NFC Debug: applicationRecord = NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567
io.homeassistant.companion.android.debug D/NFC Debug: nfcMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64, NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567]
io.homeassistant.companion.android.debug D/NFC Debug: nfcFallbackMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64]
io.homeassistant.companion.android.debug D/NFC Debug: Start writing Tag
io.homeassistant.companion.android.debug D/NFC Debug: enableNFCInForeground
io.homeassistant.companion.android.debug D/NFC Debug: nfcMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64, NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567]
io.homeassistant.companion.android.debug D/NFC Debug: fallbackMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64]
io.homeassistant.companion.android.debug D/NFC Debug: tag = TAG: Tech [android.nfc.tech.NfcA, android.nfc.tech.MifareClassic, android.nfc.tech.Ndef]
io.homeassistant.companion.android.debug D/NFC Debug: nDefTag = android.nfc.tech.Ndef@ad09021
io.homeassistant.companion.android.debug D/NFC Debug: Start writing nfc tag
io.homeassistant.companion.android.debug D/NFC Debug: connected = kotlin.Unit
io.homeassistant.companion.android.debug D/NFC Debug: messageToWrite = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64, NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567]
io.homeassistant.companion.android.debug D/NFC Debug: it.maxSize = 716
io.homeassistant.companion.android.debug D/NFC Debug: nfcMessage.toByteArray().size = 96
io.homeassistant.companion.android.debug D/NFC Debug: fallbackMessage.toByteArray().size = 38
io.homeassistant.companion.android.debug D/NFC Debug: it.isWritable = true
io.homeassistant.companion.android.debug D/NFC Debug: Tag writable
io.homeassistant.companion.android.debug D/NFC Debug: write = kotlin.Unit
io.homeassistant.companion.android.debug D/NFC Debug: close = kotlin.Unit
io.homeassistant.companion.android.debug D/NFC Debug: ret = true
io.homeassistant.companion.android.debug D/NfcSetupActivity: Wrote nfc tag with url: https://www.home-assistant.io/tag/guten_abend
io.homeassistant.companion.android.debug D/CompatibilityChangeReporter: Compat change id reported: 147798919; UID 10652; state: ENABLED
io.homeassistant.companion.android.debug I/Toast: show: focusDisplayId = 0, isFocusInDesktop = false mCustomDisplayId=-1 isDexDualMode=false
io.homeassistant.companion.android.debug I/Toast: show: isActivityContext = false
io.homeassistant.companion.android.debug D/NFC Debug: viewModel.nfcReadEvent.value = guten_abend
io.homeassistant.companion.android.debug D/NFC Debug: viewModel.nfcWriteTagDoneEvent.value = guten_abend
io.homeassistant.companion.android.debug D/NFC Debug: nfcTagUrl = https://www.home-assistant.io/tag/guten_abend
io.homeassistant.companion.android.debug D/NFC Debug: simpleWrite = true
io.homeassistant.companion.android.debug D/NFC Debug: res = kotlin.UnitNot working tag not filtered
2021-03-05 09:11:09.231 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: intent = Intent { act=android.nfc.action.TECH_DISCOVERED flg=0x30000000 cmp=io.homeassistant.companion.android.debug/io.homeassistant.companion.android.nfc.NfcSetupActivity (has extras) }
2021-03-05 09:11:09.231 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: false
2021-03-05 09:11:09.232 1718-1718/? D/AudioTrack: setVolume(1.000000, 1.000000) pid : 1718
2021-03-05 09:11:09.232 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcTagToWriteUUID = guten_abend
2021-03-05 09:11:09.232 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcTagToWriteUUID != null
2021-03-05 09:11:09.232 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcTagUrl = https://www.home-assistant.io/tag/guten_abend
2021-03-05 09:11:09.232 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: createNFCMessage
2021-03-05 09:11:09.232 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: url = https://www.home-assistant.io/tag/guten_abend
2021-03-05 09:11:09.232 616-4515/? I/AF::Track: setMixerOutConfig expectKey 202
2021-03-05 09:11:09.232 616-4515/? I/AF::Track: setMixerOutConfig select, mixer out f 5, s 48000, thread out f 5, s 48000
2021-03-05 09:11:09.232 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: intent = Intent { act=android.nfc.action.TECH_DISCOVERED flg=0x30000000 cmp=io.homeassistant.companion.android.debug/io.homeassistant.companion.android.nfc.NfcSetupActivity (has extras) }
2021-03-05 09:11:09.232 616-4515/? V/APM_AudioPolicyManager: startOutput portId 178
2021-03-05 09:11:09.232 616-4515/? V/APM_AudioPolicyManager: startOutput() output 29, stream 1, session 2225
2021-03-05 09:11:09.232 616-4515/? V/APM_AudioPolicyManager: setBeaconMute(1) mBeaconMuteRefCount=1 mBeaconPlayingRefCount=0
2021-03-05 09:11:09.232 616-4515/? V/APM_AudioPolicyManager: selectOutputForMusicEffects selected output 13
2021-03-05 09:11:09.232 616-4515/? V/APM_AudioPolicyManager: getNewOutputDevices selected devices {type:0x2,@:}
2021-03-05 09:11:09.232 616-4515/? V/APM_AudioPolicyManager: setOutputDevices device {type:0x2,@:} delayMs 0
2021-03-05 09:11:09.232 616-4515/? V/APM_AudioPolicyManager: setOutputDevices() prevDevice {type:0x2,@:}
2021-03-05 09:11:09.232 616-4515/? V/APM_AudioPolicyManager: setOutputDevices: suppressing checkDeviceMuteStrategies
2021-03-05 09:11:09.232 616-4515/? V/APM_AudioPolicyManager: setOutputDevices setting same device {type:0x2,@:} or null device, force=0, patch handle=29
2021-03-05 09:11:09.232 616-4515/? V/APM_AudioPolicyManager: computeVolume: stream 1, index 0, volume 0.000000, deviceTypes 0x2
2021-03-05 09:11:09.232 616-4515/? I/AudioFlinger: updateStageIndex new -2901
2021-03-05 09:11:09.233 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcRecord = NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64
2021-03-05 09:11:09.233 616-1084/? D/NativeSemDvfsManager: acquire:: timeout = -999 mIsAcquired = 0 mTagName : AudioFlinger
2021-03-05 09:11:09.234 616-1084/? E/NativeCustomFrequencyManager: [NativeCFMS] BpCustomFrequencyManager::acquire()
2021-03-05 09:11:09.234 982-1678/? I/system_server: oneway function results will be dropped but finished with status OK and parcel size 4
2021-03-05 09:11:09.234 616-1084/? I/SoundAlive_SRC384 arch64: SRC384 Destroy
2021-03-05 09:11:09.234 616-1084/? I/SoundAlive_SRC384 arch64: ~SoundAlive_SRC384(): instance 166
2021-03-05 09:11:09.234 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: applicationRecord = NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567
2021-03-05 09:11:09.234 564-604/? I/HYPER-HAL: [RequestManager.cpp]acquire(): Acquired ID : 1307536 [616 / 1000] HINT : NOT_EXIST list : [CPUMinFreq / 8531]
2021-03-05 09:11:09.234 982-1678/? I/system_server: oneway function results will be dropped but finished with status OK and parcel size 4
2021-03-05 09:11:09.234 535-15079/? D/audio_hw_primary: fast_out-out_update_source_metadata: called, but not implemented yet
2021-03-05 09:11:09.234 535-15079/? D/audio_hw_primary: fast_out-out_update_source_metadata: This stream has 1 tracks
2021-03-05 09:11:09.234 535-15079/? D/audio_hw_primary: 1 Track has Usage(13), Content Type(4), Gain(0.000000)
2021-03-05 09:11:09.234 616-1084/? I/SoundAlive_SRC384 arch64: SRC384 Create
2021-03-05 09:11:09.234 616-1084/? I/SoundAlive_SRC384 arch64: SoundAlive_SRC384() ID = 167 GID = 168
2021-03-05 09:11:09.234 616-1084/? I/SoundAlive_SRC384 arch64: SoundAlive_SRC384: Instance 167 Init(outFs 7, InFs 7, chnum 2, outBW 0, inBW 0)
2021-03-05 09:11:09.234 616-1084/? I/Samsung_SoundAlive_SRC arch64: SRC384 version Samsung SoundAlive SRC ver320 arch64 2020.11.26 (Cppref for ARM64, ver.300.c 32bit 07_10_2016 based)
2021-03-05 09:11:09.234 616-1084/? D/SoundAliveResampler: [SoundAliveResampler] Init+++
2021-03-05 09:11:09.234 616-1084/? I/SoundAlive_SRC384 arch64: SoundAlive_SRC384: Instance 167 Init(outFs 8, InFs 7, chnum 2, outBW 3, inBW 3)
2021-03-05 09:11:09.234 616-1084/? I/Samsung_SoundAlive_SRC arch64: SRC384 version Samsung SoundAlive SRC ver320 arch64 2020.11.26 (Cppref for ARM64, ver.300.c 32bit 07_10_2016 based)
2021-03-05 09:11:09.234 616-1084/? I/SoundAlive_SRC384 arch64: instance 167 Exe() size 256 channels 2 input Fs: 44100 IBW: 4 outputFs 48000 OBW:4
2021-03-05 09:11:09.234 564-604/? I/HYPER-HAL: [ResourceManager.cpp]updateResource(): [CPUMinFreq] UpdateResource Request ID : 1307536 Value : 8531
2021-03-05 09:11:09.235 1718-1718/? E/NfcService: TAG Result(or ERROR): 10, PROTOCOL: 11194
2021-03-05 09:11:09.235 535-25691/? I/audio_hw_primary: fast_out-out_write: transited to Ready
2021-03-05 09:11:09.235 535-25691/? D/audio_hw_primary: fast_out-check_and_set_backend_mixer: no need to update backend 2 -> 2, out->backend_mode:2
2021-03-05 09:11:09.235 535-25691/? I/audio_hw_primary: fast_out-out_write: try to route for playback
2021-03-05 09:11:09.235 1718-1874/? D/NfcService: call doGetDefaultMessage
2021-03-05 09:11:09.235 1718-1874/? D/NfcService: add common info
2021-03-05 09:11:09.235 535-25691/? D/audio_route: Apply path: media-dual-speaker
2021-03-05 09:11:09.235 535-25691/? I/audio_route: > audio_route_update_path : "media-dual-speaker" reverse(0)
2021-03-05 09:11:09.235 1718-1874/? D/HWParameter: Send Logs to HWParameter : Skip
2021-03-05 09:11:09.236 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64, NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567]
2021-03-05 09:11:09.236 11057-23235/io.homeassistant.companion.android.debug V/FA: Recording user engagement, ms: 1661
2021-03-05 09:11:09.236 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcFallbackMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64]
2021-03-05 09:11:09.237 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: Start writing Tag
2021-03-05 09:11:09.237 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: enableNFCInForeground
2021-03-05 09:11:09.239 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64, NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567]
2021-03-05 09:11:09.240 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: fallbackMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64]
2021-03-05 09:11:09.240 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: tag = TAG: Tech [android.nfc.tech.NfcA, android.nfc.tech.MifareClassic, android.nfc.tech.NdefFormatable]
2021-03-05 09:11:09.240 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nDefTag = null
2021-03-05 09:11:09.241 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nDefFormatableTag = android.nfc.tech.NdefFormatable@f352e3
2021-03-05 09:11:09.241 1718-26874/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(801)] sendDeactivateSleepCmdForReselect: deactivate to sleep
2021-03-05 09:11:09.242 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:11:09.242 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=4!!
2021-03-05 09:11:09.242 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:11:09.242 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:11:09.242 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.242 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.242 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.242 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.242 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:11:09.242 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:11:09.242 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:11:09.243 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:11:09.244 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.244 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.244 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.244 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.244 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.244 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.244 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.244 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.244 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.244 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:11:09.244 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:11:09.245 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.245 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.245 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.245 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.245 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.245 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.245 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.245 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:11:09.245 1718-12831/? E/libnfc_nci: [ERROR:nfa_dm_discover.cc(2299)] NFA_DM_RF_DEACTIVATE_NTF p_data->nfc_discover.deactivate.reason = 0
2021-03-05 09:11:09.246 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:11:09.246 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=6!!
2021-03-05 09:11:09.246 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:11:09.246 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:11:09.246 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.246 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.246 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.246 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.246 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:11:09.246 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:11:09.246 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:11:09.247 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:11:09.247 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.247 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.248 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.248 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.248 11057-23235/io.homeassistant.companion.android.debug V/FA: Activity paused, time: 266830979
2021-03-05 09:11:09.248 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.248 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.248 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.248 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.248 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:11:09.250 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.250 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.250 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.250 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.251 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.251 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.251 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.251 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.252 1718-12831/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(617)] nativeNfcTag_doConnectStatus: sConnectWaitingForComplete = 0x1
2021-03-05 09:11:09.252 1718-26874/? D/NfcService: connect - remove timer
2021-03-05 09:11:09.252 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: connected = kotlin.Unit
2021-03-05 09:11:09.253 1718-26874/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(801)] sendDeactivateSleepCmdForReselect: deactivate to sleep
2021-03-05 09:11:09.253 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:11:09.253 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=4!!
2021-03-05 09:11:09.253 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:11:09.253 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:11:09.253 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.253 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.253 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.253 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.253 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:11:09.253 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:11:09.254 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:11:09.254 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:11:09.254 535-25691/? I/audio_hw_proxy_9820: proxy-set_route: routed to media-dual-speaker
2021-03-05 09:11:09.254 535-25691/? D/audio_route: Apply path: gain-media-dual-speaker
2021-03-05 09:11:09.254 535-25691/? I/audio_route: > audio_route_update_path : "gain-media-dual-speaker" reverse(0)
2021-03-05 09:11:09.255 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.255 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.255 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.255 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.255 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.255 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.255 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.255 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.255 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.255 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:11:09.256 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.256 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:11:09.256 535-25691/? I/audio_hw_proxy_9820: proxy-set_route: set gain as gain-media-dual-speaker
2021-03-05 09:11:09.256 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.256 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.256 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.256 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.256 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.256 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.257 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:11:09.257 1718-12831/? E/libnfc_nci: [ERROR:nfa_dm_discover.cc(2299)] NFA_DM_RF_DEACTIVATE_NTF p_data->nfc_discover.deactivate.reason = 0
2021-03-05 09:11:09.257 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:11:09.257 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=6!!
2021-03-05 09:11:09.257 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:11:09.257 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:11:09.257 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.257 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.257 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.257 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.257 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:11:09.257 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:11:09.258 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:11:09.258 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:11:09.259 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.259 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.259 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.259 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.259 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.259 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.259 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.259 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.259 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:11:09.262 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.262 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.262 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.262 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.263 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.263 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.263 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.263 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.264 1718-12831/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(617)] nativeNfcTag_doConnectStatus: sConnectWaitingForComplete = 0x1
2021-03-05 09:11:09.264 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:11:09.264 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:11:09.264 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:11:09.264 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.264 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.264 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.264 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.264 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:11:09.264 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:11:09.265 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:11:09.265 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:11:09.276 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.277 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.277 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.277 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.277 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.277 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.277 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.277 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.277 1718-12831/? E/libnfc_nci: [ERROR:phNxpExtns.cpp(123)] Error Sending msg to Extension Thread
2021-03-05 09:11:09.277 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:11:09.277 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=4!!
2021-03-05 09:11:09.277 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:11:09.277 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:11:09.277 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.277 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.277 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.277 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.277 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:11:09.277 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:11:09.278 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:11:09.278 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:11:09.279 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.279 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.279 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.279 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.279 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.279 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.279 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.279 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.279 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.280 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:11:09.280 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:11:09.280 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.280 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.280 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.280 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.280 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.280 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.280 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.280 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:11:09.280 1718-12831/? E/libnfc_nci: [ERROR:nfa_dm_discover.cc(2299)] NFA_DM_RF_DEACTIVATE_NTF p_data->nfc_discover.deactivate.reason = 0
2021-03-05 09:11:09.280 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:11:09.280 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=6!!
2021-03-05 09:11:09.280 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:11:09.280 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:11:09.280 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.280 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.280 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.280 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.280 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:11:09.280 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:11:09.281 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:11:09.281 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:11:09.281 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.281 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.281 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.281 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.281 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.281 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.281 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.281 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.281 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:11:09.281 1718-12831/? E/libnfc_nci: [ERROR:NativeNfcManager.cpp(644)] nfaConnectionCallback: NFA_SELECT_RESULT_EVT error: status = 1
2021-03-05 09:11:09.282 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:11:09.282 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=4!!
2021-03-05 09:11:09.282 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:11:09.282 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:11:09.282 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.282 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.282 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.282 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.282 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:11:09.282 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:11:09.282 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:11:09.282 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:11:09.284 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.284 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.284 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.284 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.285 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.285 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.285 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.285 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.285 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:11:09.285 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:11:09.285 1718-26874/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(1126)] nativeNfcTag_doReconnect: tag already deactivated
2021-03-05 09:11:09.285 1850-1850/? I/SecHAL: nfc_hal_pre_discover: enter;
2021-03-05 09:11:09.285 1850-1850/? I/SecHAL: nfc_hal_pre_discover: exit;
2021-03-05 09:11:09.285 1718-1718/? E/NfcService: TAG Result(or ERROR): 4, PROTOCOL: 32
2021-03-05 09:11:09.285 1718-1874/? D/NfcService: call doGetDefaultMessage
2021-03-05 09:11:09.285 1718-1874/? D/NfcService: add common info
2021-03-05 09:11:09.285 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:11:09.285 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=18!!
2021-03-05 09:11:09.285 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:11:09.285 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:11:09.285 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.285 1718-1874/? D/HWParameter: Send Logs to HWParameter : Skip
2021-03-05 09:11:09.285 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.285 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.285 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.285 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:11:09.285 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:11:09.286 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:11:09.286 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:11:09.287 535-25691/? I/audio_hw_proxy_9820: proxy-enable_spkamp_playback: SPKAMP Playback PCM Device(/dev/snd/pcmC0D7p) with SR(48000) PF(1) CC(4) is opened & started
2021-03-05 09:11:09.290 535-25691/? I/audio_hw_proxy_9820: proxy-enable_erap_in: ERAP In PCM Device(/dev/snd/pcmC0D15c) with SR(48000) PF(1) CC(2) is opened & started
2021-03-05 09:11:09.293 11057-11057/io.homeassistant.companion.android.debug I/Toast: show: focusDisplayId = 0, isFocusInDesktop = false mCustomDisplayId=-1 isDexDualMode=false
2021-03-05 09:11:09.293 11057-11057/io.homeassistant.companion.android.debug I/Toast: show: isActivityContext = false
2021-03-05 09:11:09.293 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:11:09.294 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:11:09.294 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:11:09.294 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:11:09.294 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:11:09.294 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:11:09.294 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:11:09.294 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:11:09.294 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:11:09.294 535-25691/? I/audio_hw_proxy_9820: proxy-enable_spkamp_reference: SPKAMP Reference PCM Device(/dev/snd/pcmC0D16c) with SR(48000) PF(1) CC(4) is opened & started
2021-03-05 09:11:09.294 535-25691/? I/audio_hw_primary: fast_out-adev_set_route-1: routes to device(speaker) for usage(media)
2021-03-05 09:11:09.294 535-25691/? I/audio_hw_proxy_usb: usb-out-proxy_usb_out_reset_config: reset rate[48000] format[0] channels[2]
2021-03-05 09:11:09.294 535-25691/? I/audio_hw_proxy_usb: proxy_usb_out_pick_best_pcmconfig: current config rate[48000] format[0] channels[2]
2021-03-05 09:11:09.295 535-25691/? I/audio_hw_proxy_9820: fast_out-proxy_open_playback_stream: The opened PCM Device is /dev/snd/pcmC0D1p with Sampling_Rate(48000) PCM_Format(0) PCM_start-threshold(384) PCM_stop-threshold(-1)
2021-03-05 09:11:09.295 535-25691/? I/audio_hw_primary: fast_out-out_write: transited to Idle
2021-03-05 09:11:09.296 982-1691/? D/EdgeLightingManager: isCallingUserSupported : callingUserId=0, mUserId=0, isDualAppId=false, isKnoxId=false
2021-03-05 09:11:09.296 982-1691/? D/EdgeLightingManager: showForToast : packageName = io.homeassistant.companion.android.debug
2021-03-05 09:11:09.296 982-1691/? D/EdgeLightingClientManager: isAvailableEdgeLighting: condition=1 mCondition=3 mIsConnected=false0
2021-03-05 09:11:09.297 982-1691/? D/SEP_UNION_CoverManager_CoverManagerAllowLists: isAllowedToUse : cover manager allow lists does not include this App : io.homeassistant.companion.android.debug
2021-03-05 09:11:09.297 982-1691/? W/SEP_UNION_CoverManager_CoverManagerServiceImpl: getCoverStateInternal : caller is invalid
2021-03-05 09:11:09.297 535-25691/? I/audio_hw_primary: fast_out-out_write: transited to Playing
2021-03-05 09:11:09.297 982-1691/? E/CoverManager: getCoverState : coverState is null
2021-03-05 09:11:09.297 982-1691/? D/EdgeLightingPolicyManager: isAcceptableApplication: pkg=io.homeassistant.companion.android.debug , range=512 , includeAllApp=false , userId=0 , infoRange=0 , infoCategory=0
2021-03-05 09:11:09.297 982-1691/? D/EdgeLightingManager: showForToast : return false by isAcceptableApplication.
2021-03-05 09:11:09.298 982-1691/? W/ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcast:1162 com.android.server.notification.sec.DisplayToast.sendIntentForToastDumpLog:156 com.android.server.notification.sec.DisplayToast.outFile:106 com.android.server.notification.sec.DisplayToast.out:62 com.android.server.notification.NotificationManagerService$12.enqueueToastForDex:3454
2021-03-05 09:11:09.298 620-633/? I/SurfaceFlinger: id=43074 createSurf (0x0),-1 flag=80004, WindowToken{ddf6f04 android.os.Binder@26b1f17}#0
2021-03-05 09:11:09.305 1357-1357/? V/ToastPresenter: Text: Gehl in android.widget.ToastPresenter@bdc1f6a
2021-03-05 09:11:09.307 982-1691/? D/InputTransport: Input channel constructed: '7895b3 ', fd=917
2021-03-05 09:11:09.308 982-1691/? D/InputTransport: Input channel constructed: '7895b3 ', fd=918
2021-03-05 09:11:09.308 620-633/? I/SurfaceFlinger: id=43075 createSurf (0x0),-1 flag=80004, 7895b3 Toast#0
2021-03-05 09:11:09.309 982-1691/? D/InputTransport: Input channel destroyed: '7895b3 ', fd=918
2021-03-05 09:11:09.309 982-1023/? D/SurfaceControl: hide : mNativeObject = 533042748544 - sc.mNativeObject = 532505452160 - Surface(name=Input Consumer recents_animation_input_consumer)/@0x47d6029
2021-03-05 09:11:09.309 11057-11057/io.homeassistant.companion.android.debug E/NfcSetupActivity: Unable to write tag.
java.lang.Exception: Failed to format tag
at io.homeassistant.companion.android.nfc.NFCUtil.writeMessageToTag(NFCUtil.kt:130)
at io.homeassistant.companion.android.nfc.NFCUtil.createNFCMessage(NFCUtil.kt:34)
at io.homeassistant.companion.android.nfc.NfcSetupActivity.onNewIntent(NfcSetupActivity.kt:115)
at android.app.Activity.performNewIntent(Activity.java:8198)
at android.app.Instrumentation.callActivityOnNewIntent(Instrumentation.java:1409)
at android.app.Instrumentation.callActivityOnNewIntent(Instrumentation.java:1422)
at android.app.ActivityThread.deliverNewIntents(ActivityThread.java:4001)
at android.app.ActivityThread.handleNewIntent(ActivityThread.java:4013)
at android.app.servertransaction.NewIntentItem.execute(NewIntentItem.java:53)
at android.app.servertransaction.TransactionExecutor.executeCallbacks(TransactionExecutor.java:135)
at android.app.servertransaction.TransactionExecutor.execute(TransactionExecutor.java:95)
at android.app.ActivityThread$H.handleMessage(ActivityThread.java:2277)
at android.os.Handler.dispatchMessage(Handler.java:106)
at android.os.Looper.loop(Looper.java:246)
at android.app.ActivityThread.main(ActivityThread.java:8425)
at java.lang.reflect.Method.invoke(Native Method)
at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:596)
at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:1130)
Caused by: java.io.IOException
at android.nfc.tech.NdefFormatable.format(NdefFormatable.java:131)
at android.nfc.tech.NdefFormatable.format(NdefFormatable.java:94)
at io.homeassistant.companion.android.nfc.NFCUtil.writeMessageToTag(NFCUtil.kt:123)
at io.homeassistant.companion.android.nfc.NFCUtil.createNFCMessage(NFCUtil.kt:34)
at io.homeassistant.companion.android.nfc.NfcSetupActivity.onNewIntent(NfcSetupActivity.kt:115)
at android.app.Activity.performNewIntent(Activity.java:8198)
at android.app.Instrumentation.callActivityOnNewIntent(Instrumentation.java:1409)
at android.app.Instrumentation.callActivityOnNewIntent(Instrumentation.java:1422)
at android.app.ActivityThread.deliverNewIntents(ActivityThread.java:4001)
at android.app.ActivityThread.handleNewIntent(ActivityThread.java:4013)
at android.app.servertransaction.NewIntentItem.execute(NewIntentItem.java:53)
at android.app.servertransaction.TransactionExecutor.executeCallbacks(TransactionExecutor.java:135)
at android.app.servertransaction.TransactionExecutor.execute(TransactionExecutor.java:95)
at android.app.ActivityThread$H.handleMessage(ActivityThread.java:2277)
at android.os.Handler.dispatchMessage(Handler.java:106)
at android.os.Looper.loop(Looper.java:246)
at android.app.ActivityThread.main(ActivityThread.java:8425)
at java.lang.reflect.Method.invoke(Native Method)
at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:596)
at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:1130)
2021-03-05 09:11:09.309 982-1023/? D/SurfaceControl: nativeSetFlags Done : Surface(name=Input Consumer recents_animation_input_consumer)/@0x47d6029
Working tag not filtered
2021-03-05 09:08:42.339 616-21707/? V/APM_AudioPolicyManager: startOutput portId 178
2021-03-05 09:08:42.339 616-21707/? V/APM_AudioPolicyManager: startOutput() output 29, stream 1, session 2225
2021-03-05 09:08:42.339 616-21707/? V/APM_AudioPolicyManager: setBeaconMute(1) mBeaconMuteRefCount=1 mBeaconPlayingRefCount=0
2021-03-05 09:08:42.339 616-21707/? V/APM_AudioPolicyManager: selectOutputForMusicEffects selected output 13
2021-03-05 09:08:42.339 616-21707/? V/APM_AudioPolicyManager: getNewOutputDevices selected devices {type:0x2,@:}
2021-03-05 09:08:42.339 616-21707/? V/APM_AudioPolicyManager: setOutputDevices device {type:0x2,@:} delayMs 0
2021-03-05 09:08:42.339 616-21707/? V/APM_AudioPolicyManager: setOutputDevices() prevDevice {type:0x2,@:}
2021-03-05 09:08:42.339 616-21707/? V/APM_AudioPolicyManager: setOutputDevices: suppressing checkDeviceMuteStrategies
2021-03-05 09:08:42.339 616-21707/? V/APM_AudioPolicyManager: setOutputDevices setting same device {type:0x2,@:} or null device, force=0, patch handle=29
2021-03-05 09:08:42.339 616-21707/? V/APM_AudioPolicyManager: computeVolume: stream 1, index 0, volume 0.000000, deviceTypes 0x2
2021-03-05 09:08:42.339 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: intent = Intent { act=android.nfc.action.TECH_DISCOVERED flg=0x30000000 cmp=io.homeassistant.companion.android.debug/io.homeassistant.companion.android.nfc.NfcSetupActivity (has extras) }
2021-03-05 09:08:42.339 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: false
2021-03-05 09:08:42.339 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcTagToWriteUUID = guten_abend
2021-03-05 09:08:42.339 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcTagToWriteUUID != null
2021-03-05 09:08:42.339 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcTagUrl = https://www.home-assistant.io/tag/guten_abend
2021-03-05 09:08:42.340 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: createNFCMessage
2021-03-05 09:08:42.340 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: url = https://www.home-assistant.io/tag/guten_abend
2021-03-05 09:08:42.340 616-1084/? D/NativeSemDvfsManager: acquire:: timeout = -999 mIsAcquired = 0 mTagName : AudioFlinger
2021-03-05 09:08:42.340 616-1084/? E/NativeCustomFrequencyManager: [NativeCFMS] BpCustomFrequencyManager::acquire()
2021-03-05 09:08:42.340 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: intent = Intent { act=android.nfc.action.TECH_DISCOVERED flg=0x30000000 cmp=io.homeassistant.companion.android.debug/io.homeassistant.companion.android.nfc.NfcSetupActivity (has extras) }
2021-03-05 09:08:42.340 564-604/? I/HYPER-HAL: [RequestManager.cpp]acquire(): Acquired ID : 1307536 [616 / 1000] HINT : NOT_EXIST list : [CPUMinFreq / 8531]
2021-03-05 09:08:42.340 982-3608/? I/system_server: oneway function results will be dropped but finished with status OK and parcel size 4
2021-03-05 09:08:42.340 616-21707/? I/AudioFlinger: updateStageIndex new -2901
2021-03-05 09:08:42.340 564-604/? I/HYPER-HAL: [ResourceManager.cpp]updateResource(): [CPUMinFreq] UpdateResource Request ID : 1307536 Value : 8531
2021-03-05 09:08:42.340 982-3608/? I/system_server: oneway function results will be dropped but finished with status OK and parcel size 4
2021-03-05 09:08:42.340 616-1084/? I/SoundAlive_SRC384 arch64: SRC384 Destroy
2021-03-05 09:08:42.340 616-1084/? I/SoundAlive_SRC384 arch64: ~SoundAlive_SRC384(): instance 165
2021-03-05 09:08:42.341 535-15079/? D/audio_hw_primary: fast_out-out_update_source_metadata: called, but not implemented yet
2021-03-05 09:08:42.341 982-3608/? I/system_server: oneway function results will be dropped but finished with status OK and parcel size 4
2021-03-05 09:08:42.341 535-15079/? D/audio_hw_primary: fast_out-out_update_source_metadata: This stream has 1 tracks
2021-03-05 09:08:42.341 535-15079/? D/audio_hw_primary: 1 Track has Usage(13), Content Type(4), Gain(0.000000)
2021-03-05 09:08:42.342 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcRecord = NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64
2021-03-05 09:08:42.342 616-1084/? I/SoundAlive_SRC384 arch64: SRC384 Create
2021-03-05 09:08:42.342 616-1084/? I/SoundAlive_SRC384 arch64: SoundAlive_SRC384() ID = 166 GID = 167
2021-03-05 09:08:42.342 616-1084/? I/SoundAlive_SRC384 arch64: SoundAlive_SRC384: Instance 166 Init(outFs 7, InFs 7, chnum 2, outBW 0, inBW 0)
2021-03-05 09:08:42.342 616-1084/? I/Samsung_SoundAlive_SRC arch64: SRC384 version Samsung SoundAlive SRC ver320 arch64 2020.11.26 (Cppref for ARM64, ver.300.c 32bit 07_10_2016 based)
2021-03-05 09:08:42.342 616-1084/? D/SoundAliveResampler: [SoundAliveResampler] Init+++
2021-03-05 09:08:42.342 616-1084/? I/SoundAlive_SRC384 arch64: SoundAlive_SRC384: Instance 166 Init(outFs 8, InFs 7, chnum 2, outBW 3, inBW 3)
2021-03-05 09:08:42.342 616-1084/? I/Samsung_SoundAlive_SRC arch64: SRC384 version Samsung SoundAlive SRC ver320 arch64 2020.11.26 (Cppref for ARM64, ver.300.c 32bit 07_10_2016 based)
2021-03-05 09:08:42.342 616-1084/? I/SoundAlive_SRC384 arch64: instance 166 Exe() size 256 channels 2 input Fs: 44100 IBW: 4 outputFs 48000 OBW:4
2021-03-05 09:08:42.342 535-25691/? I/audio_hw_primary: fast_out-out_write: transited to Ready
2021-03-05 09:08:42.342 535-25691/? D/audio_hw_primary: fast_out-check_and_set_backend_mixer: no need to update backend 2 -> 2, out->backend_mode:2
2021-03-05 09:08:42.342 535-25691/? I/audio_hw_primary: fast_out-out_write: try to route for playback
2021-03-05 09:08:42.342 1718-1718/? E/NfcService: TAG Result(or ERROR): 10, PROTOCOL: 11190
2021-03-05 09:08:42.342 535-25691/? D/audio_route: Apply path: media-dual-speaker
2021-03-05 09:08:42.342 535-25691/? I/audio_route: > audio_route_update_path : "media-dual-speaker" reverse(0)
2021-03-05 09:08:42.342 1718-1874/? D/NfcService: call doGetDefaultMessage
2021-03-05 09:08:42.342 1718-1874/? D/NfcService: add common info
2021-03-05 09:08:42.343 1718-1874/? D/HWParameter: Send Logs to HWParameter : Skip
2021-03-05 09:08:42.343 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: applicationRecord = NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567
2021-03-05 09:08:42.343 982-1690/? I/SamsungAlarmManager: setLocked to kernel - T:2 / 20210305T090851, set=266693529, now=266684094
2021-03-05 09:08:42.343 982-1690/? I/SamsungAlarmManager: setLocked to kernel - T:3 / 20210305T090849, set=266691675, now=266684094
2021-03-05 09:08:42.343 982-1690/? D/SamsungAlarmManager: setInexact (T:3/F:0/AC:false) 20210305T090846 now=266684094 - CU:1000/CP:982/L:263ef77:*job.delay*
2021-03-05 09:08:42.343 982-1690/? I/SamsungAlarmManager: setLocked to kernel - T:2 / 20210305T090851, set=266693529, now=266684094
2021-03-05 09:08:42.343 982-1690/? I/SamsungAlarmManager: setLocked to kernel - T:3 / 20210305T090846, set=266688529, now=266684095
2021-03-05 09:08:42.345 11057-22543/io.homeassistant.companion.android.debug V/FA: Recording user engagement, ms: 1684
2021-03-05 09:08:42.345 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64, NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567]
2021-03-05 09:08:42.346 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcFallbackMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64]
2021-03-05 09:08:42.348 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: Start writing Tag
2021-03-05 09:08:42.348 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: enableNFCInForeground
2021-03-05 09:08:42.350 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64, NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567]
2021-03-05 09:08:42.351 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: fallbackMessage = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64]
2021-03-05 09:08:42.351 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: tag = TAG: Tech [android.nfc.tech.NfcA, android.nfc.tech.MifareClassic, android.nfc.tech.Ndef]
2021-03-05 09:08:42.352 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nDefTag = android.nfc.tech.Ndef@54afd9b
2021-03-05 09:08:42.353 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: Start writing nfc tag
2021-03-05 09:08:42.353 1718-17901/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(801)] sendDeactivateSleepCmdForReselect: deactivate to sleep
2021-03-05 09:08:42.353 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.354 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=4!!
2021-03-05 09:08:42.354 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.354 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.354 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.354 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.354 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.354 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.354 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.354 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.355 535-25691/? I/audio_hw_proxy_9820: proxy-set_route: routed to media-dual-speaker
2021-03-05 09:08:42.355 535-25691/? D/audio_route: Apply path: gain-media-dual-speaker
2021-03-05 09:08:42.355 535-25691/? I/audio_route: > audio_route_update_path : "gain-media-dual-speaker" reverse(0)
2021-03-05 09:08:42.355 535-25691/? I/audio_hw_proxy_9820: proxy-set_route: set gain as gain-media-dual-speaker
2021-03-05 09:08:42.357 11057-22543/io.homeassistant.companion.android.debug V/FA: Activity paused, time: 266684084
2021-03-05 09:08:42.358 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.358 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.358 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.358 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.358 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.358 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.359 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.359 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.359 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.359 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.359 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.359 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:08:42.359 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.359 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.359 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:08:42.359 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.359 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.360 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.360 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.360 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.360 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:08:42.360 1718-12831/? E/libnfc_nci: [ERROR:nfa_dm_discover.cc(2299)] NFA_DM_RF_DEACTIVATE_NTF p_data->nfc_discover.deactivate.reason = 0
2021-03-05 09:08:42.360 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.360 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=6!!
2021-03-05 09:08:42.360 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.360 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.360 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.360 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.360 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.360 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.360 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.360 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.361 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.361 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.361 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.362 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.362 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.362 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.362 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.362 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.362 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.362 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.362 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:08:42.365 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.365 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.365 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.365 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.366 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.366 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.366 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.366 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.366 1718-12831/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(617)] nativeNfcTag_doConnectStatus: sConnectWaitingForComplete = 0x1
2021-03-05 09:08:42.366 1718-17901/? D/NfcService: connect - remove timer
2021-03-05 09:08:42.367 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: connected = kotlin.Unit
2021-03-05 09:08:42.368 528-653/? E/Netd: getNetworkForDns: getNetId from enterpriseCtrl is netid 0
2021-03-05 09:08:42.369 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: messageToWrite = NdefMessage [NdefRecord tnf=1 type=55 payload=02686F6D652D617373697374616E742E696F2F7461672F677574656E5F6162656E64, NdefRecord tnf=4 type=616E64726F69642E636F6D3A706B67 payload=696F2E686F6D65617373697374616E742E636F6D70616E696F6E2E616E64726F69642E6465627567]
2021-03-05 09:08:42.369 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: it.maxSize = 716
2021-03-05 09:08:42.370 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcMessage.toByteArray().size = 96
2021-03-05 09:08:42.372 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: fallbackMessage.toByteArray().size = 38
2021-03-05 09:08:42.373 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: it.isWritable = true
2021-03-05 09:08:42.373 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: Tag writable
2021-03-05 09:08:42.374 1718-17901/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(801)] sendDeactivateSleepCmdForReselect: deactivate to sleep
2021-03-05 09:08:42.374 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.374 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=4!!
2021-03-05 09:08:42.374 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.374 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.374 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.374 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.374 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.374 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.374 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.374 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.375 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.375 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.376 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.376 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.376 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.376 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.376 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.376 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.376 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.376 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.376 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:08:42.376 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.376 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:08:42.376 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.376 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.376 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.377 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.377 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.377 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.377 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.377 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:08:42.377 1718-12831/? E/libnfc_nci: [ERROR:nfa_dm_discover.cc(2299)] NFA_DM_RF_DEACTIVATE_NTF p_data->nfc_discover.deactivate.reason = 0
2021-03-05 09:08:42.377 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.377 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=6!!
2021-03-05 09:08:42.378 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.378 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.378 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.378 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.378 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.378 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.378 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.378 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.378 982-982/? I/NotificationService: RuneStone mIsRuneStoneSupported = true, mIsRuneStoneEnabled = false
2021-03-05 09:08:42.378 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.378 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.379 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.379 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.379 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.379 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.379 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.379 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.379 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.379 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.379 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:08:42.380 982-1690/? I/Telecom:SamsungTelecomServiceImpl: getCallState - callingPid : 15458 / processName : sts
2021-03-05 09:08:42.380 15458-22674/? E/NetworkSM: Error getting response from external service
2021-03-05 09:08:42.380 982-3615/? D/NetdEventListenerService: DNS Requested by : 654, 10647
2021-03-05 09:08:42.380 982-982/? W/NotificationHistory: Attempted to add notif for locked/gone/disabled user 0
2021-03-05 09:08:42.381 982-1286/? E/NetdEventListenerService: DNS failed (10647) : 4
2021-03-05 09:08:42.382 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.382 1953-1953/? W/SANotification4O: NotificationListener.onNotificationPosted-Socket is not available
2021-03-05 09:08:42.385 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.385 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.385 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.386 1357-1357/? D/InterruptionStateProvider: No bubble up: not allowed to bubble: 0|io.homeassistant.companion.android|42|null|10647
2021-03-05 09:08:42.386 2483-2534/? I/RequestManager_FLP: Notification for foreground service is posted, from io.homeassistant.companion.android
2021-03-05 09:08:42.386 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.386 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.386 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.386 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.386 1718-12831/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(617)] nativeNfcTag_doConnectStatus: sConnectWaitingForComplete = 0x1
2021-03-05 09:08:42.387 1357-1357/? D/InterruptionStateProvider: no Heads up : edgelighting enabled app. 0|io.homeassistant.companion.android|42|null|10647
2021-03-05 09:08:42.387 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.387 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.387 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.387 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.387 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.387 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.387 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.387 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.387 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.387 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.388 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.389 1953-1953/? W/SANotification4O: NotificationListener.onNotificationPosted-Socket is not available
2021-03-05 09:08:42.389 535-25691/? I/audio_hw_proxy_9820: proxy-enable_spkamp_playback: SPKAMP Playback PCM Device(/dev/snd/pcmC0D7p) with SR(48000) PF(1) CC(4) is opened & started
2021-03-05 09:08:42.391 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.391 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.391 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.391 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.391 1333-2600/? W/TelephonyPermissions: reportAccessDeniedToReadIdentifiers:io.homeassistant.companion.android:getActiveSubscriptionInfoForSimSlotIndex:1
2021-03-05 09:08:42.392 535-25691/? I/audio_hw_proxy_9820: proxy-enable_erap_in: ERAP In PCM Device(/dev/snd/pcmC0D15c) with SR(48000) PF(1) CC(2) is opened & started
2021-03-05 09:08:42.392 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.392 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.392 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.392 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.392 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.392 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.393 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.393 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.393 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.393 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.393 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.393 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.393 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.393 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.393 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.395 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.396 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.396 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.396 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.396 535-25691/? I/audio_hw_proxy_9820: proxy-enable_spkamp_reference: SPKAMP Reference PCM Device(/dev/snd/pcmC0D16c) with SR(48000) PF(1) CC(4) is opened & started
2021-03-05 09:08:42.396 535-25691/? I/audio_hw_primary: fast_out-adev_set_route-1: routes to device(speaker) for usage(media)
2021-03-05 09:08:42.396 535-25691/? I/audio_hw_proxy_usb: usb-out-proxy_usb_out_reset_config: reset rate[48000] format[0] channels[2]
2021-03-05 09:08:42.396 535-25691/? I/audio_hw_proxy_usb: proxy_usb_out_pick_best_pcmconfig: current config rate[48000] format[0] channels[2]
2021-03-05 09:08:42.396 535-25691/? I/audio_hw_proxy_9820: fast_out-proxy_open_playback_stream: The opened PCM Device is /dev/snd/pcmC0D1p with Sampling_Rate(48000) PCM_Format(0) PCM_start-threshold(384) PCM_stop-threshold(-1)
2021-03-05 09:08:42.396 535-25691/? I/audio_hw_primary: fast_out-out_write: transited to Idle
2021-03-05 09:08:42.396 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.396 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.396 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.396 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.397 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.397 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.397 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.397 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.397 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.397 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.397 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.397 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.397 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.397 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.397 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.399 535-25691/? I/audio_hw_primary: fast_out-out_write: transited to Playing
2021-03-05 09:08:42.399 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.400 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.400 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.400 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.400 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.400 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.400 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.400 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.401 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.401 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.401 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.401 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.401 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.401 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.401 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.401 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.401 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.401 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.401 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.404 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.404 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.404 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.404 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.404 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.404 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.404 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.404 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.405 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.405 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.405 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.405 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.405 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.405 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.405 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.405 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.405 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.405 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.405 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.408 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.408 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.408 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.408 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.408 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.408 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.408 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.408 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.408 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.408 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.409 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.409 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.409 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.409 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.409 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.409 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.409 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.409 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.409 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.409 1357-1357/? D/InterruptionStateProvider: No bubble up: not allowed to bubble: 0|io.homeassistant.companion.android|42|null|10647
2021-03-05 09:08:42.409 1357-1357/? D/InterruptionStateProvider: no Heads up : edgelighting enabled app. 0|io.homeassistant.companion.android|42|null|10647
2021-03-05 09:08:42.411 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.412 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.412 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.412 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.412 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.412 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.412 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.412 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.413 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.413 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.413 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.413 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.413 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.413 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.413 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.413 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.413 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.413 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.413 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.416 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.416 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.416 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.416 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.416 616-1084/? D/AudioFlinger: mixer(0x72996d6040) Spend too much time to write: delta 74(effect 0, stage 0)
2021-03-05 09:08:42.417 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.417 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.417 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.417 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.417 1718-17901/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(801)] sendDeactivateSleepCmdForReselect: deactivate to sleep
2021-03-05 09:08:42.417 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.417 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=4!!
2021-03-05 09:08:42.417 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.417 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.417 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.417 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.417 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.417 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.417 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.417 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.417 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.417 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.418 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.418 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.418 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.418 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.418 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.418 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.418 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.418 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.418 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:08:42.419 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:08:42.419 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.419 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.419 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.419 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.419 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.419 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.419 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.419 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.419 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:08:42.419 1718-12831/? E/libnfc_nci: [ERROR:nfa_dm_discover.cc(2299)] NFA_DM_RF_DEACTIVATE_NTF p_data->nfc_discover.deactivate.reason = 0
2021-03-05 09:08:42.420 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.420 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=6!!
2021-03-05 09:08:42.420 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.420 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.420 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.420 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.420 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.420 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.420 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.420 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.420 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.420 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.421 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.422 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.422 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.422 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.422 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.422 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.422 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.422 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.422 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:08:42.424 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.425 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.425 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.425 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.425 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.425 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.425 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.425 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.425 1718-12831/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(617)] nativeNfcTag_doConnectStatus: sConnectWaitingForComplete = 0x1
2021-03-05 09:08:42.426 1333-2600/? W/TelephonyPermissions: reportAccessDeniedToReadIdentifiers:io.homeassistant.companion.android:getActiveSubscriptionInfoForSimSlotIndex:3
2021-03-05 09:08:42.427 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.427 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.427 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.427 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.427 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.427 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.427 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.427 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.427 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.427 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.427 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.430 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.431 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.431 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.431 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.431 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.431 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.431 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.431 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.431 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.431 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.431 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.431 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.431 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.431 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.431 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.431 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.431 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.431 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.431 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.434 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.434 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.434 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.434 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.435 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.435 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.435 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.435 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.435 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.435 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.435 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.435 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.435 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.435 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.435 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.435 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.435 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.435 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.435 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.438 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.438 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.438 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.438 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.438 1357-1357/? E/ExpandableNotifRow: onNotificationUpdated() NSSL is null..
2021-03-05 09:08:42.439 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.439 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.439 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.439 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.439 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.439 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.439 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.439 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.439 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.439 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.439 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.439 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.439 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.439 1357-1357/? D/FaceWidgetNotificationManager: updateFaceWidgetMusicNotificationKey() return : mFaceWidgetMusicNotificationKey is empty
2021-03-05 09:08:42.439 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.440 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.440 1357-1357/? D/FaceWidgetNotificationManager: updateFaceWidgetMusicNotificationKey() return : mFaceWidgetMusicNotificationKey is empty
2021-03-05 09:08:42.442 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.442 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.442 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.442 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.443 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.443 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.443 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.443 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.446 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.447 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.447 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.447 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.447 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.447 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.447 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.447 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.447 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.447 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.447 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.448 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.448 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.448 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.448 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.448 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.448 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.448 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.448 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.449 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.449 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.449 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.449 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.449 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.449 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.449 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.449 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.449 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.449 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.450 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.454 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.455 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.455 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.455 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.455 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.455 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.455 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.455 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.455 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.455 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.456 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.456 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.456 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.456 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.456 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.456 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.456 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.456 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.456 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.457 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.458 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.458 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.458 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.458 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.458 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.458 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.458 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.459 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.459 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.459 14795-22582/? V/FA-SVC: Logging event: origin=auto,name=user_engagement(_e),params=Bundle[{ga_event_origin(_o)=auto, engagement_time_msec(_et)=1684, ga_screen_class(_sc)=NfcSetupActivity, ga_screen_id(_si)=-6783133022308166794}]
2021-03-05 09:08:42.459 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.459 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.459 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.459 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.459 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.459 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.459 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.460 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.460 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.461 14795-22582/? V/FA-SVC: Upload scheduled in approximately ms: 8124
2021-03-05 09:08:42.461 14795-22582/? V/FA-SVC: Unscheduling upload
2021-03-05 09:08:42.461 982-3587/? D/SamsungAlarmManager: Cancel Alarm calling from uid:10044 pid :14795 / OP:PendingIntent{24aa4ff: PendingIntentRecord{44822cc com.google.android.gms/com.google.android.gms.measurement broadcastIntent}}
2021-03-05 09:08:42.463 14795-22582/? V/FA-SVC: Scheduling upload, millis: 8124
2021-03-05 09:08:42.465 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.465 14795-22582/? V/FA-SVC: Background event processing time, ms: 6
2021-03-05 09:08:42.465 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.465 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.465 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.465 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.465 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.465 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.465 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.466 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.466 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.466 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.466 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.466 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.466 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.466 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.466 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.466 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.466 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.466 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.467 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.469 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.469 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.469 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.470 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.470 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.470 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.470 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.470 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.470 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.470 982-3615/? D/SamsungAlarmManager: Cancel Alarm calling from uid:10044 pid :2340 / OP:PendingIntent{2f04191: PendingIntentRecord{4497a1d com.google.android.gms/apkappcontext broadcastIntent}}
2021-03-05 09:08:42.470 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.470 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.470 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.470 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.470 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.470 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.470 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.471 982-3615/? I/SamsungAlarmManager: setLocked to kernel - T:2 / 20210305T090851, set=266693529, now=266684223
2021-03-05 09:08:42.471 982-3615/? I/SamsungAlarmManager: setLocked to kernel - T:3 / 20210305T090846, set=266688529, now=266684223
2021-03-05 09:08:42.472 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.472 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.473 2340-14451/? W/NetworkScheduler: Error inserting flex_time=8000 job_id=-1 period=17000 source=16 requires_charging=0 preferred_network_type=1 target_class=com.google.android.gms.measurement.PackageMeasurementTaskService user_id=0 target_package=com.google.android.gms tag=Measurement.PackageMeasurementTaskService.UPLOAD_TASK_TAG task_type=0 required_idleness_state=0 service_kind=0 source_version=210214000 persistence_level=1 preferred_charging_state=1 required_network_type=0 runtime=1614931722468 retry_strategy={"maximum_backoff_seconds":{"3600":0},"initial_backoff_seconds":{"30":0},"retry_policy":{"0":0}} last_runtime=0, error message: UNIQUE constraint failed: pending_ops.tag, pending_ops.target_class, pending_ops.target_package, pending_ops.user_id (code 2067 SQLITE_CONSTRAINT_UNIQUE[2067]) [CONTEXT service_id=218 ]
2021-03-05 09:08:42.474 616-1084/? D/AudioFlinger: mixer(0x72996d6040) Spend too much time to write: delta 34(effect 0, stage 0)
2021-03-05 09:08:42.475 982-3615/? D/SamsungAlarmManager: setInexact (T:2/F:0/AC:false) 20210305T090911 now=266684226 - CU:10044/CP:2340/OP:PendingIntent{b6c48f6: PendingIntentRecord{4497a1d com.google.android.gms/apkappcontext broadcastIntent}}
2021-03-05 09:08:42.475 982-3615/? I/SamsungAlarmManager: setLocked to kernel - T:2 / 20210305T090851, set=266693529, now=266684227
2021-03-05 09:08:42.475 982-3615/? I/SamsungAlarmManager: setLocked to kernel - T:3 / 20210305T090846, set=266688529, now=266684227
2021-03-05 09:08:42.476 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.476 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.476 982-3587/? I/SamsungAlarmManager: setLocked to kernel - T:2 / 20210305T090851, set=266693529, now=266684228
2021-03-05 09:08:42.476 982-3587/? I/SamsungAlarmManager: setLocked to kernel - T:3 / 20210305T090846, set=266688529, now=266684228
2021-03-05 09:08:42.476 982-3587/? D/SamsungAlarmManager: setInexact (T:2/F:0/AC:false) 20210305T090859 now=266684228 - CU:10044/CP:2340/OP:PendingIntent{f9a34f7: PendingIntentRecord{4497a1d com.google.android.gms/apkappcontext broadcastIntent}}
2021-03-05 09:08:42.477 982-3587/? I/SamsungAlarmManager: setLocked to kernel - T:2 / 20210305T090851, set=266693529, now=266684228
2021-03-05 09:08:42.477 982-3587/? I/SamsungAlarmManager: setLocked to kernel - T:3 / 20210305T090846, set=266688529, now=266684228
2021-03-05 09:08:42.477 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.477 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.478 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.478 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.478 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.478 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.478 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.478 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.479 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.479 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.479 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.479 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.479 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.479 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.479 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.479 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.479 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.481 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.482 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.482 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.482 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.483 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.483 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.483 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.483 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.483 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.483 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.483 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.483 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.483 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.483 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.483 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.483 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.483 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.484 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.484 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.486 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.487 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.487 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.487 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.487 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.488 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.488 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.488 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.488 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.488 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.488 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.488 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.488 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.488 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.488 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.488 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.488 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.488 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.488 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.489 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.489 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.490 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.490 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.490 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.490 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.490 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.490 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.490 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.490 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.490 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.490 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.490 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.490 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.490 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.490 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.490 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.491 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.491 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.493 982-3587/? D/SensorService: Calling batch handle==6 flags=0 rate=200000000 timeout== 0
2021-03-05 09:08:42.493 560-560/? I/Sensors: batch(3) - pressure_sensor try to batching with 200000000
2021-03-05 09:08:42.494 560-560/? I/Sensors: PressureSensor old sensor_state 279041, new sensor_state : 1116691776033 en : 1
2021-03-05 09:08:42.496 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.497 560-560/? I/Sensors: enable:: pressure_sensor(3)
2021-03-05 09:08:42.497 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.497 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.497 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.497 15458-15624/? D/SensorManager: registerListener :: 6, LPS22H Barometer Sensor, 200000, 0, listener = io.homeassistant.companion.android.sensors.PressureSensorManager@dd01981
2021-03-05 09:08:42.497 15458-15624/? D/PressureSensor: Pressure sensor listener registered
2021-03-05 09:08:42.497 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.497 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.497 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.497 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.497 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.497 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.497 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.497 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.497 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.497 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.497 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.497 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.498 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.498 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.498 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.499 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.499 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.499 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.499 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.499 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.499 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.499 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.499 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.499 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.499 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.499 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.499 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.499 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.499 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.499 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.499 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.499 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.500 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.500 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.505 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.505 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.505 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.505 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.505 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.505 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.505 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.505 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.506 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.506 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.506 982-3608/? D/SensorService: Calling batch handle==1600479601 flags=0 rate=200000000 timeout== 0
2021-03-05 09:08:42.506 560-560/? D/Sensors: M requested delay = 1000000, modified delay = 0
2021-03-05 09:08:42.506 560-560/? I/Sensors: batch(22) - call_gesture try to batching with 0
2021-03-05 09:08:42.506 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.506 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.506 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.506 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.506 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.506 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.507 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.507 560-560/? I/Sensors: CallGesture old sensor_state 279073, new sensor_state : 1391569682977 en : 1
2021-03-05 09:08:42.507 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.507 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.508 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.508 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.508 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.508 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.508 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.508 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.508 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.508 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.508 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.508 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.508 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.508 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.508 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.508 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.508 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.508 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.508 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.509 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.509 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.510 560-560/? I/Sensors: enable:: call_gesture(22)
2021-03-05 09:08:42.510 982-3608/? I/SensorService: [PALMSENSE] Enable PalmSense ~
2021-03-05 09:08:42.510 560-560/? I/Sensors: flush call_gesture
2021-03-05 09:08:42.510 560-560/? I/Sensors: MetaEvent:: reportMetaEvent
2021-03-05 09:08:42.510 560-560/? I/Sensors: wakeMessage
2021-03-05 09:08:42.510 560-1126/? E/Sensors: MetaEvent:: 39
2021-03-05 09:08:42.510 560-1126/? E/Sensors: MetaEvent: hasPendingEvent+++(1)
2021-03-05 09:08:42.510 15458-15624/? D/SensorManager: registerListener :: 1600479601, Palm Proximity Sensor, 200000, 0, listener = io.homeassistant.companion.android.sensors.ProximitySensorManager@4265a26
2021-03-05 09:08:42.510 15458-15624/? D/ProximitySensor: Proximity sensor listener registered
2021-03-05 09:08:42.510 982-1135/? W/SensorService: Failed to write wake lock handled
2021-03-05 09:08:42.510 982-1135/? D/SensorService: [PALMSENSE] SENSOR_TYPE_META_DATA 39
2021-03-05 09:08:42.510 982-1135/? D/SensorService: [PALMSENSE] Send meta event for palm proximity
2021-03-05 09:08:42.511 982-1135/? D/SensorService: [EARPROXY_STATUS] palm sensor added
2021-03-05 09:08:42.511 982-2529/? D/MotionRecognitionService: add or remove listener
2021-03-05 09:08:42.512 982-3608/? W/AppOps: Noting op not finished: uid 10647 pkg io.homeassistant.companion.android code 79 startTime of in progress event=1614931722216
2021-03-05 09:08:42.512 982-3608/? W/AppOps: Noting op not finished: uid 10647 pkg io.homeassistant.companion.android code 79 startTime of in progress event=1614931722216
2021-03-05 09:08:42.512 982-3608/? D/SensorService: Calling batch handle==19 flags=0 rate=200000000 timeout== 0
2021-03-05 09:08:42.512 15458-15624/? D/SensorManager: registerListener :: 19, SAMSUNG Step Counter Sensor, 200000, 0, listener = io.homeassistant.companion.android.sensors.StepsSensorManager@3302667
2021-03-05 09:08:42.513 15458-15624/? D/StepsSensor: Steps sensor listener registered
2021-03-05 09:08:42.514 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.514 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.514 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.514 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.514 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.514 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.514 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.514 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.515 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.515 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.515 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.515 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.515 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.515 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.515 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.515 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.515 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.516 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.516 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.518 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.518 15458-15624/? D/StorageSensor: PATHS SD 1
2021-03-05 09:08:42.518 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.519 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.519 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.519 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.519 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.519 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.519 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.519 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.519 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.519 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.519 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.519 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.519 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.520 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.520 15458-15624/? D/StorageSensor: PATH /storage/emulated/0/Android/data/io.homeassistant.companion.android/files is mounted true and removable is false
2021-03-05 09:08:42.520 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.520 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.520 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.520 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.522 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.522 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.522 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.522 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.523 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.523 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.523 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.523 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.523 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.523 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.523 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.523 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.523 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.523 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.523 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.523 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.523 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.524 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.524 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.524 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.525 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.525 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.525 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.525 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.525 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.525 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.525 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.525 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.525 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.525 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.525 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.525 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.525 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.525 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.525 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.525 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.526 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.526 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.531 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.531 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.531 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.531 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.531 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.531 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.531 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.531 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.531 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.532 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.532 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.532 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.532 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.532 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.532 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.532 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.532 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.532 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.532 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.534 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.535 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.535 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.535 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.535 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.535 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.535 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.535 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.535 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.535 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.535 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.535 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.535 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.535 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.535 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.535 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.535 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.536 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.536 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.537 982-982/? E/VibratorService: Vibration finished, cleaning up
2021-03-05 09:08:42.537 982-982/? D/VibratorService: Turning vibrator off.
2021-03-05 09:08:42.537 982-982/? D/VibratorService: Turning vibrator off
2021-03-05 09:08:42.537 579-579/? E/SecVibrator-HAL2.1_B: >> writeNode node:/timed_output/vibrator/enable val:0
2021-03-05 09:08:42.538 579-579/? E/SecVibrator-HAL2.1_B: << writeNode node OK 2
2021-03-05 09:08:42.538 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.538 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.539 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.539 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.539 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.539 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.539 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.539 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.539 982-1135/? E/SensorService: [PALMSENSE] Update the first event
2021-03-05 09:08:42.539 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.539 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.540 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.540 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.540 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.540 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.540 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.540 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.540 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.540 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.540 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.541 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.541 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.541 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.541 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.541 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.541 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.541 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.541 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.541 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.541 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.541 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.541 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.541 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.541 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.541 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.541 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.541 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.542 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.542 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.547 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.547 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.547 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.547 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.547 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.547 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.547 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.547 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.548 1718-17901/? D/NfcService: writeNdef
2021-03-05 09:08:42.548 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: write = kotlin.Unit
2021-03-05 09:08:42.548 1718-17901/? D/NfcService: After 60 secs, send NfcConstants.SecMessage.MSG_TAG_CONNECTION
2021-03-05 09:08:42.548 1718-17901/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(801)] sendDeactivateSleepCmdForReselect: deactivate to sleep
2021-03-05 09:08:42.549 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.549 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=4!!
2021-03-05 09:08:42.549 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.549 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.549 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.549 616-1084/? D/AudioFlinger: mixer(0x72996d6040) Spend too much time to write: delta 74(effect 0, stage 0)
2021-03-05 09:08:42.549 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.549 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.549 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.549 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.549 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.549 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.549 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.550 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.550 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.550 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.550 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.550 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.550 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.550 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.550 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.550 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:08:42.550 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.551 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.551 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.551 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.551 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.551 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:08:42.551 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.551 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.551 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.551 1718-12831/? E/libnfc_nci: [ERROR:nfc_ncif.cc(1487)] nfc_ncif_proc_deactivate - evt_data.deactivate.reason 0, nfc_cb.deact_reason = 0
2021-03-05 09:08:42.551 1718-12831/? E/libnfc_nci: [ERROR:nfa_dm_discover.cc(2299)] NFA_DM_RF_DEACTIVATE_NTF p_data->nfc_discover.deactivate.reason = 0
2021-03-05 09:08:42.552 1850-1850/? I/SecHAL: nfc_hal_write: enter;
2021-03-05 09:08:42.552 1850-1850/? E/SecHAL: nfc_hal_write: [Cmd]Send EVT data_sending_flag = true, return size=6!!
2021-03-05 09:08:42.552 1850-1850/? I/SecHAL: nfc_hal_write: exit;
2021-03-05 09:08:42.552 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_WRITE(3)
2021-03-05 09:08:42.552 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.552 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.552 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.552 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.552 1850-12836/? I/SecHAL: device_write: enter
2021-03-05 09:08:42.552 1850-12836/? I/SecHAL: device_write: before system call
2021-03-05 09:08:42.553 1850-12836/? I/SecHAL: device_write: after system call
2021-03-05 09:08:42.553 1850-12836/? I/SecHAL: device_write: exit
2021-03-05 09:08:42.554 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.554 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.554 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.554 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.554 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.554 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.554 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.554 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.554 1850-12836/? E/SecHAL: nfc_data_callback: [Cmd]Received a response packet : data_sending_flag = false!!
2021-03-05 09:08:42.557 1850-12835/? I/SecHAL: subft_sent_msg_to_Hal_task: subft_sent_msg_to_Hal_task enter
2021-03-05 09:08:42.557 1850-12835/? D/SecHAL: subft_sent_msg_to_Hal_task: Sent message to HAL message task, remind que: 2
2021-03-05 09:08:42.557 1850-12836/? D/SecHAL: nfc_hal_task: Got a event: HAL_EVT_READ(4)
2021-03-05 09:08:42.557 1850-12836/? D/SecHAL: nfc_hal_task: current state: SERVICE
2021-03-05 09:08:42.558 1850-12836/? I/SecHAL: OSI_timer_start: enter,osi_lock
2021-03-05 09:08:42.558 1850-12836/? I/SecHAL: OSI_timer_start: before osi_unlock
2021-03-05 09:08:42.558 1850-12836/? I/SecHAL: OSI_timer_start: exit
2021-03-05 09:08:42.558 1850-12836/? I/SecHAL: nfc_data_callback: !
2021-03-05 09:08:42.558 1718-12831/? E/libnfc_nci: [ERROR:NativeNfcTag.cpp(617)] nativeNfcTag_doConnectStatus: sConnectWaitingForComplete = 0x1
2021-03-05 09:08:42.558 1718-17901/? D/NfcService: reconnect
2021-03-05 09:08:42.558 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: close = kotlin.Unit
2021-03-05 09:08:42.558 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: ret = true
2021-03-05 09:08:42.558 11057-11057/io.homeassistant.companion.android.debug D/NfcSetupActivity: Wrote nfc tag with url: https://www.home-assistant.io/tag/guten_abend
2021-03-05 09:08:42.561 560-1126/? I/Sensors: CallGesture: event = 4, time = 266684306754164
2021-03-05 09:08:42.561 982-1135/? W/SensorService: Failed to write wake lock handled
2021-03-05 09:08:42.563 11057-11057/io.homeassistant.companion.android.debug I/Toast: show: focusDisplayId = 0, isFocusInDesktop = false mCustomDisplayId=-1 isDexDualMode=false
2021-03-05 09:08:42.564 11057-11057/io.homeassistant.companion.android.debug I/Toast: show: isActivityContext = false
2021-03-05 09:08:42.567 982-3615/? D/EdgeLightingManager: isCallingUserSupported : callingUserId=0, mUserId=0, isDualAppId=false, isKnoxId=false
2021-03-05 09:08:42.567 982-3615/? D/EdgeLightingManager: showForToast : packageName = io.homeassistant.companion.android.debug
2021-03-05 09:08:42.567 982-3615/? D/EdgeLightingClientManager: isAvailableEdgeLighting: condition=1 mCondition=3 mIsConnected=false0
2021-03-05 09:08:42.568 982-3615/? D/SEP_UNION_CoverManager_CoverManagerAllowLists: isAllowedToUse : cover manager allow lists does not include this App : io.homeassistant.companion.android.debug
2021-03-05 09:08:42.568 982-3615/? W/SEP_UNION_CoverManager_CoverManagerServiceImpl: getCoverStateInternal : caller is invalid
2021-03-05 09:08:42.568 982-3615/? E/CoverManager: getCoverState : coverState is null
2021-03-05 09:08:42.568 982-3615/? D/EdgeLightingPolicyManager: isAcceptableApplication: pkg=io.homeassistant.companion.android.debug , range=512 , includeAllApp=false , userId=0 , infoRange=0 , infoCategory=0
2021-03-05 09:08:42.568 982-3615/? D/EdgeLightingManager: showForToast : return false by isAcceptableApplication.
2021-03-05 09:08:42.568 982-3615/? W/ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcast:1162 com.android.server.notification.sec.DisplayToast.sendIntentForToastDumpLog:156 com.android.server.notification.sec.DisplayToast.outFile:106 com.android.server.notification.sec.DisplayToast.out:62 com.android.server.notification.NotificationManagerService$12.enqueueToastForDex:3454
2021-03-05 09:08:42.569 620-1998/? I/SurfaceFlinger: id=43029 createSurf (0x0),-1 flag=80004, WindowToken{a8bfe82 android.os.Binder@4665cd}#0
2021-03-05 09:08:42.570 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: viewModel.nfcReadEvent.value = guten_abend
2021-03-05 09:08:42.573 1357-1357/? V/ToastPresenter: Text: OFC- in android.widget.ToastPresenter@805ac71
2021-03-05 09:08:42.574 982-3615/? D/InputTransport: Input channel constructed: '6091c9 ', fd=900
2021-03-05 09:08:42.574 982-3615/? D/InputTransport: Input channel constructed: '6091c9 ', fd=912
2021-03-05 09:08:42.574 620-1998/? I/SurfaceFlinger: id=43030 createSurf (0x0),-1 flag=80004, 6091c9 Toast#0
2021-03-05 09:08:42.575 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: viewModel.nfcWriteTagDoneEvent.value = guten_abend
2021-03-05 09:08:42.575 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: nfcTagUrl = https://www.home-assistant.io/tag/guten_abend
2021-03-05 09:08:42.575 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: simpleWrite = true
2021-03-05 09:08:42.575 11057-11057/io.homeassistant.companion.android.debug D/NFC Debug: res = kotlin.Unit
2021-03-05 09:08:42.575 982-1023/? D/SurfaceControl: hide : mNativeObject = 533042748544 - sc.mNativeObject = 532505452160 - Surface(name=Input Consumer recents_animation_input_consumer)/@0x47d6029
2021-03-05 09:08:42.576 982-1023/? D/SurfaceControl: nativeSetFlags Done : Surface(name=Input Consumer recents_animation_input_consumer)/@0x47d6029
2021-03-05 09:08:42.576 982-3615/? D/InputTransport: Input channel destroyed: '6091c9 ', fd=912
2021-03-05 09:08:42.576 982-3608/? V/WindowManager: Prepare app transition: transit=TRANSIT_ACTIVITY_CLOSE mNextAppTransition=TRANSIT_UNSET alwaysKeepCurrent=false displayId=0 Callers=com.android.server.wm.DisplayContent.prepareAppTransition:5742 com.android.server.wm.DisplayContent.prepareAppTransition:5736 com.android.server.wm.ActivityRecord.finishIfPossible:3115 com.android.server.wm.ActivityTaskManagerService.finishActivity:2416 android.app.IActivityTaskManager$Stub.onTransact:2118
2021-03-05 09:08:42.576 1357-1357/? D/InputTransport: Input channel constructed: '6091c9 ', fd=176
2021-03-05 09:08:42.577 527-532/? E/statsd: Predicate 5980654721335871649 dropping data for dimension key (10)0x2010101->10652[I] (10)0x30000->*launch*[S]
2021-03-05 09:08:42.578 982-3608/? I/ActivityTaskManager: Remove from unknown app
2021-03-05 09:08:42.578 982-1023/? D/SurfaceControl: hide : mNativeObject = 533042748544 - sc.mNativeObject = 532505452160 - Surface(name=Input Consumer recents_animation_input_consumer)/@0x47d6029
2021-03-05 09:08:42.578 982-1023/? D/SurfaceControl: nativeSetFlags Done : Surface(name=Input Consumer recents_animation_input_consumer)/@0x47d6029Nothing really stands out, I wonder if its just a bad card? since you said one works and another doesn't? its quite possible some are defective? I am not sure. The fact that android is reporting the tag is not formattable is probably not a good sign?
tefracky
commented
3 years ago You are right! I tried 15 different cards, but none of them worked. Then, using the Mirafare Classic app, I cloned the working card to the other not working cards and at the end, all cards worked. I am really not sure, what was going wrong, maybe it was something like a "write protection". Sorry for wasting your time, but the error was really confusing!
Home Assistant Android version: Latest GitHub-Version (self installed via Android Studio) and PlayStore Version 2021.3.1-full
Android version: 11
Phone model: Galaxy S10+
Home Assistant version: core-2021.2.3
Last working Home Assistant release (if known):
Description of problem: NXP Mifare Classic 1k (ISO 1443-3A) NFC tag not writable/formattable ("Error while processing nfc tag")
Traceback (if applicable, to get the logs you may refer to: https://companion.home-assistant.io/docs/troubleshooting/faqs/#android-crash-logs):
I added some code to print out the variables in AndroidStudio