Closed Nexolight closed 7 years ago
Get this so far:
12-27 22:01:16.000 3859 6388 D BrcmNfcJni: nfcManager_doInitialize: enter; ver=NFCDROID-AOSP_M_00.01 nfa=NFA_PI_1.03.66+ NCI_VERSION=0x10
12-27 22:01:16.000 3859 6388 D BrcmNfcJni: PowerSwitch::initialize: level=PS-FULL (1)
12-27 22:01:16.000 3859 6388 D NfcAdaptation: bool CNfcConfig::readConfig(const char*, bool) Opened base config /etc/libnfc-brcm.conf
12-27 22:01:16.005 3859 6388 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found SCREEN_OFF_POWER_STATE=(0x1)
12-27 22:01:16.005 3859 6388 D BrcmNfcJni: PowerSwitch::initialize: desired screen-off state=1
12-27 22:01:16.005 3859 6388 D NfcAdaptation: NfcAdaptation::Initialize: enter
12-27 22:01:16.005 3859 6388 E NfcAdaptation: NfcAdaptation::Initialize: ver=NFCDROID-AOSP_M_00.01 nfa=NFA_PI_1.03.66+
12-27 22:01:16.005 3859 6388 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found NFA_STORAGE=/data/nfc
12-27 22:01:16.005 3859 6388 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found PROTOCOL_TRACE_LEVEL=(0xFFFFFFFF)
12-27 22:01:16.005 3859 6388 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found NFA_MAX_EE_SUPPORTED=(0x2)
12-27 22:01:16.005 3859 6388 D NfcAdaptation: NfcAdaptation::Initialize: Overriding NFA_EE_MAX_EE_SUPPORTED to use 2
12-27 22:01:16.005 3859 6388 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found APPL_TRACE_LEVEL=(0xFF)
12-27 22:01:16.005 3859 6388 D BrcmNfcJni: initializeGlobalAppLogLevel: level=5
12-27 22:01:16.005 3859 6388 D : verify_stack_non_volatile_store
12-27 22:01:16.005 3859 6388 D NfcNciHal: crcChecksumVerifyIntegrity: filename=/data/nfc/nfaStorage.bin1
12-27 22:01:16.005 3859 6388 D NfcNciHal: crcChecksumVerifyIntegrity: filename=/data/nfc/nfaStorage.bin2
12-27 22:01:16.005 3859 6388 D NfcNciHal: crcChecksumVerifyIntegrity: filename=/data/nfc/nfaStorage.bin3
12-27 22:01:16.005 3859 6388 D NfcNciHal: crcChecksumVerifyIntegrity: filename=/data/nfc/nfaStorage.bin4
12-27 22:01:16.005 3859 6388 D NfcNciHal: crcChecksumVerifyIntegrity: filename=/data/nfc/nfaStorage.bin5
12-27 22:01:16.005 3859 6388 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found PRESERVE_STORAGE=(0x1)
12-27 22:01:16.005 3859 6388 D NfcAdaptation: Initialize: preserve stack NV store
12-27 22:01:16.006 3859 6390 D NfcAdaptation: NfcAdaptation::NFCA_TASK: enter
12-27 22:01:16.006 3859 6390 I BrcmNfcNfa: GKI_run(): Start/Stop GKI_timer_update_registered!
12-27 22:01:16.013 3859 6391 D NfcAdaptation: NfcAdaptation::Thread: enter
12-27 22:01:16.014 3859 6392 I BrcmNfcNfa: NFC_TASK started.
12-27 22:01:16.014 3859 6391 D NfcAdaptation: NfcAdaptation::Thread: exit
12-27 22:01:16.014 3859 6388 D NfcAdaptation: NfcAdaptation::InitializeHalDeviceContext: enter
12-27 22:01:16.014 3859 6388 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found NCI_HAL_MODULE=nfc_nci.pn54x
12-27 22:01:16.015 3859 6388 D NxpNfcNciHal: nfc_open: enter; name=nci
12-27 22:01:16.015 3859 6388 D NxpNfcNciHal: nfc_open: exit 0
12-27 22:01:16.015 3859 6388 D NfcAdaptation: NfcAdaptation::InitializeHalDeviceContext: exit
12-27 22:01:16.015 3859 6388 D NfcAdaptation: NfcAdaptation::Initialize: exit
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: NFA_Init ()
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_dm_init ()
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_sys_register () id=1, enable_cplt_mask=0x0
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_p2p_init ()
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_sys_register () id=3, enable_cplt_mask=0x8
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_rw_init ()
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_sys_register () id=6, enable_cplt_mask=0x48
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_ce_init ()
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_sys_register () id=7, enable_cplt_mask=0xc8
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_ee_init ()
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_sys_register () id=2, enable_cplt_mask=0xcc
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_hci_init ()
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: nfa_sys_register () id=8, enable_cplt_mask=0x1cc
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: LLCP - llcp_init ()
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: num_rx_buff = 9, rx_congest_start = 6, rx_congest_end = 4, max_num_ll_rx_buff = 2
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: max_num_tx_buff = 21, max_num_ll_tx_buff = 6
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: LLCP_RegisterServer (): SAP:0x1, link_type:0x2, ServiceName:<urn:nfc:sn:sdp>
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: LLCP_RegisterServer (): Registered SAP = 0x01
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: NFA_Enable ()
12-27 22:01:16.015 3859 6388 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found APPL_TRACE_LEVEL=(0xFF)
12-27 22:01:16.015 3859 6388 D BrcmNfcJni: initializeGlobalAppLogLevel: level=5
12-27 22:01:16.015 3859 6388 I BrcmNfcNfa: NFC_SetTraceLevel () new_level = 5
12-27 22:01:16.016 3859 6392 I BrcmNfcNfa: NFA got event 0x0100
12-27 22:01:16.016 3859 6392 I BrcmNfcNfa: nfa_dm_evt_hdlr event: NFA_DM_API_ENABLE_EVT (0x00)
12-27 22:01:16.016 3859 6392 I BrcmNfcNfa: nfa_dm_enable ()
12-27 22:01:16.016 3859 6392 I BrcmNfcNfa: NFC_Enable ()
12-27 22:01:16.016 3859 6392 I BrcmNfcNfa: nfc_set_state 0 (NONE)->1 (W4_HAL_OPEN)
12-27 22:01:16.016 3859 6392 D NfcAdaptation: NfcAdaptation::HalOpen
12-27 22:01:16.027 3859 6392 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXPLOG_TML_LOGLEVEL=
12-27 22:01:16.027 3859 6392 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXPLOG_FWDNLD_LOGLEVEL=
12-27 22:01:16.027 3859 6392 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXPLOG_NCIX_LOGLEVEL=
12-27 22:01:16.027 3859 6392 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXPLOG_NCIR_LOGLEVEL=
12-27 22:01:16.027 3859 6392 D : phNxpLog_InitializeLogLevel: global =1, Fwdnld =3, extns =3, hal =3, tml =3, ncir =3,
ncix =3
12-27 22:01:16.028 3859 6392 D NxpHal : Entering phNxpNciHal_init_monitor
12-27 22:01:16.028 3859 6392 D NxpHal : Returning with SUCCESS
12-27 22:01:16.028 3859 6392 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_NFC_DEV_NODE=/dev/pn544
12-27 22:01:16.028 3859 6392 D NxpTml : Opening port=/dev/pn544
12-27 22:01:16.028 3859 6392 E NxpTml : _i2c_open() Failed: retval ffffffff
12-27 22:01:16.028 3859 6392 D NxpTml : phTmlNfc_i2c_reset(), VEN level 0
12-27 22:01:16.028 3859 6392 E NxpHal : phTmlNfc_Init Failed
12-27 22:01:16.028 3859 6392 D NfcAdaptation: NfcAdaptation::HalDeviceContextCallback: event=0
12-27 22:01:16.028 3859 6392 I BrcmNfcNfa: nfc_main_hal_cback event: HAL_NFC_OPEN_CPLT_EVT(0x0), status=1
12-27 22:01:16.028 3859 6392 D NxpHal : Failed to deallocate (list empty)
12-27 22:01:16.028 3859 6392 D NxpHal : Node dump:
12-27 22:01:16.028 3859 6392 D NxpHal : Failed to deallocate (list empty)
12-27 22:01:16.028 3859 6392 D NxpHal : Node dump:
12-27 22:01:16.028 3859 6392 I BrcmNfcNfa: nfc_main_handle_hal_evt(): HAL event=0x0
12-27 22:01:16.028 3859 6392 I BrcmNfcNfa: nfc_set_state 1 (W4_HAL_OPEN)->0 (NONE)
12-27 22:01:16.028 3859 6392 I BrcmNfcNfa: nfa_dm_nfc_response_cback () NFC_ENABLE_REVT(0x5000)
12-27 22:01:16.028 3859 6392 D BrcmNfcJni: nfaDeviceManagementCallback: enter; event=0x0
12-27 22:01:16.028 3859 6392 D BrcmNfcJni: nfaDeviceManagementCallback: NFA_DM_ENABLE_EVT; status=0x3
12-27 22:01:16.034 3859 6388 D NxpExtns: const CNxpNfcParam* CNxpNfcConfig::find(const char*) const found NXPLOG_TML_LOGLEVEL=
12-27 22:01:16.034 3859 6388 D NxpExtns: const CNxpNfcParam* CNxpNfcConfig::find(const char*) const found NXPLOG_FWDNLD_LOGLEVEL=
12-27 22:01:16.034 3859 6388 D NxpExtns: const CNxpNfcParam* CNxpNfcConfig::find(const char*) const found NXPLOG_NCIX_LOGLEVEL=
12-27 22:01:16.034 3859 6388 D NxpExtns: const CNxpNfcParam* CNxpNfcConfig::find(const char*) const found NXPLOG_NCIR_LOGLEVEL=
12-27 22:01:16.035 3859 6388 D : phNxpLog_InitializeLogLevel: global =1, Fwdnld =3, extns =3, hal =3, tml =3, ncir =3,
ncix =3
12-27 22:01:16.035 3859 6388 E BrcmNfcJni: nfcManager_doInitialize: fail nfa enable; error=0x0
12-27 22:01:16.035 3859 6388 D NfcAdaptation: NfcAdaptation::Finalize: enter
12-27 22:01:16.119 6243 6394 W FA : Tasks have been queued for a long time
12-27 22:01:16.940 3859 6392 I BrcmNfcNfa: GKI TASK_DEAD received. exit thread 3...
12-27 22:01:17.039 3859 6388 D NfcAdaptation: NfcAdaptation::Finalize: exit
12-27 22:01:17.039 3859 6388 D BrcmNfcJni: nfcManager_doInitialize: exit
12-27 22:01:17.040 3859 6388 W NfcService: Error enabling NFC
12-27 22:01:17.044 3859 6390 D NfcAdaptation: NfcAdaptation::NFCA_TASK: exit
http://www.nxp.com/documents/application_note/AN11690.pdf Chapter 5.1 talks about that
Now I get this:
12-27 22:32:53.994 6501 6516 E NfcService: Watchdog triggered, aborting.
12-27 22:32:53.994 6501 6516 E BrcmNfcJni: nfcManager_doAbort: abort()
12-27 22:32:53.994 6501 6516 F libc : Fatal signal 6 (SIGABRT), code -6 in tid 6516 (enableInternal)
12-27 22:32:53.996 2927 2927 I DEBUG : property debug.db.uid not set; NOT waiting for gdb.
12-27 22:32:53.996 2927 2927 I DEBUG : HINT: adb shell setprop debug.db.uid 100000
12-27 22:32:53.996 2927 2927 I DEBUG : HINT: adb forward tcp:5039 tcp:5039
12-27 22:32:54.048 2927 2927 F DEBUG : *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
12-27 22:32:54.048 2927 2927 F DEBUG : CM Version: '13.0-20161227-UNOFFICIAL-hwgra'
12-27 22:32:54.048 2927 2927 F DEBUG : Build fingerprint: 'HUAWEI/cm_hwgra/hwgra:6.0.1/MOB31K/403f5d4167:userdebug/test-keys'
12-27 22:32:54.048 2927 2927 F DEBUG : Revision: '0'
12-27 22:32:54.048 2927 2927 F DEBUG : ABI: 'arm64'
12-27 22:32:54.048 2927 2927 F DEBUG : pid: 6501, tid: 6516, name: enableInternal >>> com.android.nfc <<<
12-27 22:32:54.049 2927 2927 E DEBUG : AM write failed: Broken pipe
12-27 22:32:54.049 2927 2927 F DEBUG : signal 6 (SIGABRT), code -6 (SI_TKILL), fault addr --------
12-27 22:32:54.074 2927 2927 F DEBUG : x0 0000000000000000 x1 0000000000001974 x2 0000000000000006 x3 0000000000000000
12-27 22:32:54.074 2927 2927 F DEBUG : x4 0000000000000000 x5 0000000000000001 x6 0000000000000000 x7 0000000000000000
12-27 22:32:54.074 2927 2927 F DEBUG : x8 0000000000000083 x9 0000000000000028 x10 0000007f97958a0c x11 0000007f97958a48
12-27 22:32:54.074 2927 2927 F DEBUG : x12 0000007f97958920 x13 000000000000001c x14 0000007f97958b08 x15 0000000000000000
12-27 22:32:54.074 2927 2927 F DEBUG : x16 0000007fae66d560 x17 0000007fae5fed7c x18 0000007faea013e4 x19 0000007f97959500
12-27 22:32:54.074 2927 2927 F DEBUG : x20 0000007f97959440 x21 000000000000006e x22 0000000000000006 x23 0000000000015f90
12-27 22:32:54.074 2927 2927 F DEBUG : x24 0000000000015f90 x25 0000007f979592c8 x26 0000007f97be73c8 x27 0000007fa7938508
12-27 22:32:54.074 2927 2927 F DEBUG : x28 0000007fa6095600 x29 0000007f97958f00 x30 0000007fae5fc518
12-27 22:32:54.074 2927 2927 F DEBUG : sp 0000007f97958f00 pc 0000007fae5fed84 pstate 0000000020000000
12-27 22:32:54.077 2927 2927 F DEBUG :
12-27 22:32:54.077 2927 2927 F DEBUG : backtrace:
12-27 22:32:54.077 2927 2927 F DEBUG : #00 pc 0000000000069d84 /system/lib64/libc.so (tgkill+8)
12-27 22:32:54.077 2927 2927 F DEBUG : #01 pc 0000000000067514 /system/lib64/libc.so (pthread_kill+68)
12-27 22:32:54.077 2927 2927 F DEBUG : #02 pc 0000000000023448 /system/lib64/libc.so (raise+28)
12-27 22:32:54.077 2927 2927 F DEBUG : #03 pc 000000000001dbe8 /system/lib64/libc.so (abort+60)
12-27 22:32:54.077 2927 2927 F DEBUG : #04 pc 00000000000188dc /system/lib64/libnfc_nci_jni.so
12-27 22:32:54.077 2927 2927 F DEBUG : #05 pc 00000000000b33ec /data/dalvik-cache/arm64/system@app@NfcNci@NfcNci.apk@classes.dex (offset
0x68000)
12-27 22:32:54.275 2927 2927 F DEBUG :
12-27 22:32:54.275 2927 2927 F DEBUG : Tombstone written to: /data/tombstones/tombstone_08
12-27 22:32:54.276 3308 3325 I BootReceiver: Copying /data/tombstones/tombstone_08 to DropBox (SYSTEM_TOMBSTONE)
12-27 22:32:54.284 3308 3325 W DropBoxManagerService: Dropping: SYSTEM_TOMBSTONE (10 > 0 bytes)
12-27 22:32:54.285 3308 3322 W BroadcastQueue: Permission Denial: receiving Intent { act=android.intent.action.DROPBOX_ENTRY_ADDED flg=0x10 (has
extras) } to de.amazon.mShop.android/com.amazon.mcc.crashreporter.android.CrashReportBroadcastReceiver requires android.permission.READ_LOGS due
to sender android (uid 1000)
12-27 22:32:54.363 3308 3320 I ActivityManager: Process com.android.nfc (pid 6501) has died
12-27 22:32:54.363 2934 2934 I Zygote : Process 6501 exited due to signal (6)
12-27 22:32:54.363 3308 3320 D ActivityManager: cleanUpApplicationRecord -- 6501
12-27 22:32:54.363 2912 2912 I ServiceManager: service 'nfc' died
12-27 22:32:54.364 3308 3320 W ActivityManager: Re-adding persistent process ProcessRecord{57f906f 6501:com.android.nfc/1027}
12-27 22:32:54.378 3308 3320 I ActivityManager: Start proc 6653:com.android.nfc/1027 for restart com.android.nfc
12-27 22:32:54.425 6653 6653 I NfcService: Starting NFC service
12-27 22:32:54.432 6653 6653 D BrcmNfcJni: JNI_OnLoad: enter
12-27 22:32:54.432 6653 6653 I BrcmNfcJni: NFC Service: loading nci JNI
12-27 22:32:54.432 6653 6653 D BrcmNfcJni: register_com_android_nfc_NativeNfcManager: enter
12-27 22:32:54.432 6653 6653 D BrcmNfcJni: PowerSwitch::initialize: level=PS-UNKNOWN (0)
12-27 22:32:54.432 6653 6653 D NfcAdaptation: bool CNfcConfig::readConfig(const char*, bool) Opened base config /etc/libnfc-brcm.conf
12-27 22:32:54.437 6653 6653 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found SCREEN_OFF_POWER_STATE=(0x1)
12-27 22:32:54.437 6653 6653 D BrcmNfcJni: PowerSwitch::initialize: desired screen-off state=1
12-27 22:32:54.437 6653 6653 D BrcmNfcJni: register_com_android_nfc_NativeNfcManager: exit
12-27 22:32:54.438 6653 6653 D BrcmNfcJni: register_com_android_nfc_NativeNfcTag
12-27 22:32:54.438 6653 6653 D BrcmNfcJni: RoutingManager::RoutingManager(): default route is 0x00
12-27 22:32:54.438 6653 6653 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found AID_MATCHING_MODE=(0x1)
12-27 22:32:54.438 6653 6653 D BrcmNfcJni: RoutingManager::RoutingManager(): mOffHostEe=0xF4
12-27 22:32:54.438 6653 6653 D BrcmNfcJni: RoutingManager::registerJniFunctions
12-27 22:32:54.438 6653 6653 D BrcmNfcJni: JNI_OnLoad: exit
12-27 22:32:54.438 6653 6653 D BrcmNfcJni: nfcManager_initNativeStruc: enter
12-27 22:32:54.438 6653 6653 D BrcmNfcJni: nfcManager_initNativeStruc: exit
12-27 22:32:54.440 3308 3326 D BluetoothManagerService: Message: 20
12-27 22:32:54.440 3308 3326 D BluetoothManagerService: Added callback: android.bluetooth.IBluetoothManagerCallback$Stub$Proxy@d9fb24e:true
12-27 22:32:54.440 6653 6653 W Settings: Setting device_provisioned has moved from android.provider.Settings.Secure to android.provider.Settings
.Global.
12-27 22:32:54.467 6653 6653 W NfceeAccess: could not find /etc/nfcee_access.xml, no NFCEE access allowed
12-27 22:32:54.467 6653 6653 I NfceeAccess: read 0 signature(s) for NFCEE access
12-27 22:32:54.471 6653 6653 W Settings: Setting airplane_mode_radios has moved from android.provider.Settings.System to android.provider.Settin
gs.Global, returning read-only value.
12-27 22:32:54.471 6653 6653 W Settings: Setting airplane_mode_toggleable_radios has moved from android.provider.Settings.System to android.prov
ider.Settings.Global, returning read-only value.
12-27 22:32:54.508 6653 6653 D RegisteredServicesCache: Dynamic AIDs file does not exist.
12-27 22:32:54.512 6653 6667 D NfcService: checking on firmware download
12-27 22:32:54.512 6653 6667 W Settings: Setting airplane_mode_on has moved from android.provider.Settings.System to android.provider.Settings.G
lobal, returning read-only value.
12-27 22:32:54.513 6653 6667 D NfcService: NFC is on. Doing normal stuff
12-27 22:32:54.513 6653 6667 I NfcService: Enabling NFC
12-27 22:32:54.516 6653 6667 D BrcmNfcJni: nfcManager_doInitialize: enter; ver=NFCDROID-AOSP_M_00.01 nfa=NFA_PI_1.03.66+ NCI_VERSION=0x10
12-27 22:32:54.516 6653 6667 D BrcmNfcJni: PowerSwitch::initialize: level=PS-FULL (1)
12-27 22:32:54.516 6653 6667 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found SCREEN_OFF_POWER_STATE=(0x1)
12-27 22:32:54.516 6653 6667 D BrcmNfcJni: PowerSwitch::initialize: desired screen-off state=1
12-27 22:32:54.516 6653 6667 D NfcAdaptation: NfcAdaptation::Initialize: enter
12-27 22:32:54.516 6653 6667 E NfcAdaptation: NfcAdaptation::Initialize: ver=NFCDROID-AOSP_M_00.01 nfa=NFA_PI_1.03.66+
12-27 22:32:54.516 6653 6667 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found NFA_STORAGE=/data/nfc
12-27 22:32:54.516 6653 6667 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found PROTOCOL_TRACE_LEVEL=(0xFFFFFFFF)
12-27 22:32:54.516 6653 6667 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found NFA_MAX_EE_SUPPORTED=(0x2)
12-27 22:32:54.516 6653 6667 D NfcAdaptation: NfcAdaptation::Initialize: Overriding NFA_EE_MAX_EE_SUPPORTED to use 2
12-27 22:32:54.516 6653 6667 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found APPL_TRACE_LEVEL=(0xFF)
12-27 22:32:54.516 6653 6667 D BrcmNfcJni: initializeGlobalAppLogLevel: level=5
12-27 22:32:54.516 6653 6667 D : verify_stack_non_volatile_store
12-27 22:32:54.516 6653 6667 D NfcNciHal: crcChecksumVerifyIntegrity: filename=/data/nfc/nfaStorage.bin1
12-27 22:32:54.516 6653 6667 D NfcNciHal: crcChecksumVerifyIntegrity: filename=/data/nfc/nfaStorage.bin2
12-27 22:32:54.516 6653 6667 D NfcNciHal: crcChecksumVerifyIntegrity: filename=/data/nfc/nfaStorage.bin3
12-27 22:32:54.516 6653 6667 D NfcNciHal: crcChecksumVerifyIntegrity: filename=/data/nfc/nfaStorage.bin4
12-27 22:32:54.516 6653 6667 D NfcNciHal: crcChecksumVerifyIntegrity: filename=/data/nfc/nfaStorage.bin5
12-27 22:32:54.516 6653 6667 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found PRESERVE_STORAGE=(0x1)
12-27 22:32:54.516 6653 6667 D NfcAdaptation: Initialize: preserve stack NV store
12-27 22:32:54.517 6653 6670 D NfcAdaptation: NfcAdaptation::Thread: enter
12-27 22:32:54.517 6653 6671 I BrcmNfcNfa: NFC_TASK started.
12-27 22:32:54.517 6653 6670 D NfcAdaptation: NfcAdaptation::Thread: exit
12-27 22:32:54.517 6653 6667 D NfcAdaptation: NfcAdaptation::InitializeHalDeviceContext: enter
12-27 22:32:54.517 6653 6667 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found NCI_HAL_MODULE=nfc_nci.pn54x
12-27 22:32:54.517 6653 6669 D NfcAdaptation: NfcAdaptation::NFCA_TASK: enter
12-27 22:32:54.517 6653 6669 I BrcmNfcNfa: GKI_run(): Start/Stop GKI_timer_update_registered!
12-27 22:32:54.519 6653 6667 D NxpNfcNciHal: nfc_open: enter; name=nci
12-27 22:32:54.519 6653 6667 D NxpNfcNciHal: nfc_open: exit 0
12-27 22:32:54.519 6653 6667 D NfcAdaptation: NfcAdaptation::InitializeHalDeviceContext: exit
12-27 22:32:54.519 6653 6667 D NfcAdaptation: NfcAdaptation::Initialize: exit
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: nfa_dm_init ()
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: nfa_sys_register () id=1, enable_cplt_mask=0x0
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: nfa_sys_register () id=3, enable_cplt_mask=0x8
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: nfa_rw_init ()
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: nfa_sys_register () id=6, enable_cplt_mask=0x48
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: nfa_ce_init ()
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: nfa_sys_register () id=7, enable_cplt_mask=0xc8
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: nfa_ee_init ()
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: nfa_sys_register () id=2, enable_cplt_mask=0xcc
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: nfa_hci_init ()
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: nfa_sys_register () id=8, enable_cplt_mask=0x1cc
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: LLCP - llcp_init ()
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: num_rx_buff = 9, rx_congest_start = 6, rx_congest_end = 4, max_num_ll_rx_buff = 2
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: max_num_tx_buff = 21, max_num_ll_tx_buff = 6
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: LLCP_RegisterServer (): SAP:0x1, link_type:0x2, ServiceName:<urn:nfc:sn:sdp>
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: LLCP_RegisterServer (): Registered SAP = 0x01
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: NFA_Enable ()
12-27 22:32:54.519 6653 6667 D NfcAdaptation: const CNfcParam* CNfcConfig::find(const char*) const found APPL_TRACE_LEVEL=(0xFF)
12-27 22:32:54.519 6653 6667 D BrcmNfcJni: initializeGlobalAppLogLevel: level=5
12-27 22:32:54.519 6653 6671 I BrcmNfcNfa: NFA got event 0x0100
12-27 22:32:54.519 6653 6667 I BrcmNfcNfa: NFC_SetTraceLevel () new_level = 5
12-27 22:32:54.519 6653 6671 I BrcmNfcNfa: nfa_dm_evt_hdlr event: NFA_DM_API_ENABLE_EVT (0x00)
12-27 22:32:54.519 6653 6671 I BrcmNfcNfa: nfa_dm_enable ()
12-27 22:32:54.519 6653 6671 I BrcmNfcNfa: NFC_Enable ()
12-27 22:32:54.519 6653 6671 I BrcmNfcNfa: nfc_set_state 0 (NONE)->1 (W4_HAL_OPEN)
12-27 22:32:54.519 6653 6671 D NfcAdaptation: NfcAdaptation::HalOpen
12-27 22:32:54.537 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXPLOG_TML_LOGLEVEL=
12-27 22:32:54.537 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXPLOG_FWDNLD_LOGLEVEL=
12-27 22:32:54.537 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXPLOG_NCIX_LOGLEVEL=
12-27 22:32:54.537 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXPLOG_NCIR_LOGLEVEL=
12-27 22:32:54.537 6653 6671 D : phNxpLog_InitializeLogLevel: global =1, Fwdnld =3, extns =3, hal =3, tml =3, ncir =3,
ncix =3
12-27 22:32:54.537 6653 6671 D NxpHal : Entering phNxpNciHal_init_monitor
12-27 22:32:54.537 6653 6671 D NxpHal : Returning with SUCCESS
12-27 22:32:54.537 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_NFC_DEV_NODE=/dev/pn544
12-27 22:32:54.537 6653 6671 D NxpTml : Opening port=/dev/pn544
12-27 22:32:54.537 6653 6671 D NxpTml : phTmlNfc_i2c_reset(), VEN level 0
12-27 22:32:54.622 6653 6671 D NxpTml : phTmlNfc_i2c_reset(), VEN level 1
12-27 22:32:54.652 6653 6671 D NxpTml : phTmlNfc_set_pid(), pid 6653
12-27 22:32:54.652 6653 6673 D NxpTml : PN54X - Tml Reader Thread Started................
12-27 22:32:54.652 6653 6671 D NxpTml : nfc service set pid failed
12-27 22:32:54.652 6653 6674 D NxpTml : PN54X - Tml Writer Thread Started................
12-27 22:32:54.652 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.652 6653 6676 D NxpHal : thread started
12-27 22:32:54.652 6653 6676 D NfcAdaptation: NfcAdaptation::HalDeviceContextCallback: event=0
12-27 22:32:54.652 6653 6676 I BrcmNfcNfa: nfc_main_hal_cback event: HAL_NFC_OPEN_CPLT_EVT(0x0), status=0
12-27 22:32:54.652 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.652 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.652 6653 6671 I BrcmNfcNfa: NFC_TASK got NFC_TASK_EVT_TRANSPORT_READY.
12-27 22:32:54.652 6653 6671 I BrcmNfcNfa: nfc_set_state 1 (W4_HAL_OPEN)->2 (CORE_INIT)
12-27 22:32:54.652 6653 6671 D NfcAdaptation: NfcAdaptation::HalWrite
12-27 22:32:54.652 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found MIFARE_READER_ENABLE=
12-27 22:32:54.653 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.653 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.653 6653 6674 D NxpNciX : len = 4 > 20000101
12-27 22:32:54.653 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.653 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.653 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.653 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.684 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:54.684 6653 6673 D NxpNciR : len = 6 > 400003001001
12-27 22:32:54.684 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:54.685 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:54.685 6653 6676 D NfcAdaptation: NfcAdaptation::HalDeviceContextDataCallback: len=6
12-27 22:32:54.685 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.685 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.685 6653 6671 I BrcmNfcNfa: NFC received rsp gid:0
12-27 22:32:54.685 6653 6671 I BrcmNfcNfa: nci_proc_core_rsp opcode:0x0
12-27 22:32:54.685 6653 6671 D NfcAdaptation: NfcAdaptation::HalWrite
12-27 22:32:54.685 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found MIFARE_READER_ENABLE=
12-27 22:32:54.687 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.687 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.687 6653 6674 D NxpNciX : len = 3 > 200100
12-27 22:32:54.687 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.687 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.687 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.687 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.688 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:54.688 6653 6673 D NxpNciR : len = 26 > 40011700030E03000600010203818202C800FF02000405080125
12-27 22:32:54.688 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:54.688 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:54.688 6653 6676 D NxpHal : NxpNci> FW Version: 8.1.25
12-27 22:32:54.688 6653 6676 D NfcAdaptation: NfcAdaptation::HalDeviceContextDataCallback: len=26
12-27 22:32:54.688 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.688 6653 6671 I BrcmNfcNfa: NFC received rsp gid:0
12-27 22:32:54.688 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.688 6653 6671 I BrcmNfcNfa: nci_proc_core_rsp opcode:0x1
12-27 22:32:54.688 6653 6671 I BrcmNfcNfa: nfc_set_state 2 (CORE_INIT)->3 (W4_POST_INIT_CPLT)
12-27 22:32:54.688 6653 6671 D NfcAdaptation: NfcAdaptation::HalCoreInitialized
12-27 22:32:54.688 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_ACT_PROP_EXTN=/
12-27 22:32:54.689 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.689 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.689 6653 6674 D NxpNciX : len = 3 > 2F0200
12-27 22:32:54.689 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.689 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.689 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.689 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.689 6653 6671 D NxpHal : Response timer started
12-27 22:32:54.689 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:54.689 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:54.689 6653 6673 D NxpNciR : len = 8 > 4F020500000088AF
12-27 22:32:54.689 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:54.689 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:54.689 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:54.689 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.689 6653 6671 D NxpHal : Checking response
12-27 22:32:54.689 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.689 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_CORE_STANDBY=/
12-27 22:32:54.690 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.690 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.690 6653 6674 D NxpNciX : len = 4 > 2F000101
12-27 22:32:54.690 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.690 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.690 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.690 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.690 6653 6671 D NxpHal : Response timer started
12-27 22:32:54.690 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:54.693 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:54.693 6653 6673 D NxpNciR : len = 4 > 4F000100
12-27 22:32:54.693 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:54.694 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:54.694 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:54.694 6653 6671 D NxpHal : Checking response
12-27 22:32:54.694 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.694 6653 6671 D NxpHal : request_EEPROM Enter request_type : 0x01, request_mode : 0x01, bufflen : 0x01
12-27 22:32:54.694 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.694 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.694 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.694 6653 6674 D NxpNciX : len = 6 > 20030301A00F
12-27 22:32:54.694 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.694 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.694 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.694 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.694 6653 6671 D NxpHal : Response timer started
12-27 22:32:54.694 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:54.696 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:54.696 6653 6673 D NxpNciR : len = 40 > 4003250001A00F200001250100000101000000000100000000000000000000000000000000000000
12-27 22:32:54.696 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:54.696 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:54.696 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:54.696 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.696 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:54.696 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.696 6653 6671 D NxpHal : Checking response
12-27 22:32:54.696 6653 6671 D NxpHal : EEPROM_fw_dwnld_flag : 0x01 SetConfigAlways flag : 0x00
12-27 22:32:54.696 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_SYS_CLK_SRC_SEL=
12-27 22:32:54.696 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_SYS_CLK_FREQ_SEL=
12-27 22:32:54.696 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_SYS_CLOCK_TO_CFG=
12-27 22:32:54.696 6653 6671 D NxpFwDnld: gphNxpNciHal_fw_IoctlCtx.bClkSrcVal = 0x2
12-27 22:32:54.696 6653 6671 D NxpFwDnld: gphNxpNciHal_fw_IoctlCtx.bClkFreqVal = 0x2
12-27 22:32:54.696 6653 6671 D NxpFwDnld: gphNxpNciHal_fw_IoctlCtx.bClkFreqVal = 0x1
12-27 22:32:54.696 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.696 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.696 6653 6674 D NxpNciX : len = 10 > 20030703A002A003A004
12-27 22:32:54.696 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.696 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.696 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.696 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.697 6653 6671 D NxpHal : Response timer started
12-27 22:32:54.697 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:54.697 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:54.698 6653 6673 D NxpNciR : len = 17 > 40030E0003A0020100A0030111A0040101
12-27 22:32:54.698 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:54.698 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:54.698 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:54.698 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:54.698 6653 6671 D NxpHal : Checking response
12-27 22:32:54.698 6653 6671 D : int nxp::CNfcConfig::checkTimestamp() file not exist.
12-27 22:32:54.698 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.698 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.698 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.698 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.698 6653 6674 D NxpNciX : len = 12 > 20020902A0030111A0040101
12-27 22:32:54.698 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.698 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.698 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.699 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.699 6653 6671 D NxpHal : Response timer started
12-27 22:32:54.699 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:54.705 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:54.705 6653 6673 D NxpNciR : len = 5 > 4002020000
12-27 22:32:54.705 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:54.705 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:54.705 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:54.705 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:54.705 6653 6671 D NxpHal : Checking response
12-27 22:32:54.705 6653 6671 D NxpHal : phNxpNciHal_check_factory_reset file not present = /data/nfc/nfaStorage.bin1
12-27 22:32:54.705 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.705 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.705 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.705 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.706 6653 6674 D NxpNciX : len = 26 > 20021702A0EA08FFFFFFFFFFFFFFFFA0EB08FFFFFFFFFFFFFFFF
12-27 22:32:54.706 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.706 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.706 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.706 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.706 6653 6671 D NxpHal : Response timer started
12-27 22:32:54.706 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:54.712 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:54.712 6653 6673 D NxpNciR : len = 5 > 4002020000
12-27 22:32:54.712 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:54.712 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:54.712 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:54.712 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:54.712 6653 6671 D NxpHal : Checking response
12-27 22:32:54.713 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_NFC_PROFILE_EXTN= �D
12-27 22:32:54.713 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.713 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.713 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.713 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.713 6653 6674 D NxpNciX : len = 8 > 20020501A0440100
12-27 22:32:54.713 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.713 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.713 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.713 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.713 6653 6671 D NxpHal : Response timer started
12-27 22:32:54.714 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:54.717 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:54.717 6653 6673 D NxpNciR : len = 5 > 4002020000
12-27 22:32:54.717 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:54.717 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:54.717 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:54.717 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.717 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.717 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:54.717 6653 6671 D NxpHal : Checking response
12-27 22:32:54.717 6653 6671 D NxpHal : Performing RF Settings BLK 1
12-27 22:32:54.717 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_RF_CONF_BLK_1= � �
12-27 22:32:54.717 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.717 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.723 6653 6674 D NxpNciX : len = 246 > 2002F320A00D03004008A00D03044320A00D0304FF05A00D060644A3900300A00D060630CF000800A00D06062F8
F05800CA00D040603006FA00D03064819A00D030643A0A00D0606420000F6F6A00D06064180000000A00D03063718A00D03061600A00D03061500A00D0606FF05000000A00D0608440
0000000A00D06204A00000000A00D0620428810FFFFA00D03201600A00D03201500A00D06224422000200A00D06222D50440C00A00D043203403DA00D063242F810FFFFA00D0332160
0A00D03321501A00D03320D22A00D03321422A00D06324A3007011FA00D06342D24770C00A00D0634340000E403A00D06344421000200
12-27 22:32:54.723 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.723 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.723 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.723 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.723 6653 6671 D NxpHal : Response timer started
12-27 22:32:54.723 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:54.829 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:54.829 6653 6673 D NxpNciR : len = 5 > 4002020000
12-27 22:32:54.829 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:54.830 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:54.830 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:54.830 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:54.830 6653 6671 D NxpHal : Checking response
12-27 22:32:54.830 6653 6671 D NxpHal : Performing RF Settings BLK 2
5D!27 22:32:54.830 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_RF_CONF_BLK_2= ��
12-27 22:32:54.830 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.830 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.830 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.830 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.838 6653 6674 D NxpNciX : len = 247 > 2002F41FA00D06354421000200A00D06384A5307011BA00D0638426810FFFFA00D03381600A00D03381500A00D0
63A2D15470D00A00D063C4A5207011BA00D063C426810FFFFA00D033C1600A00D033C1500A00D063E2D15470D00A00D064042F010FFFFA00D03400D02A00D03401402A00D06404A120
70000A00D03401600A00D03401500A00D06422D15470D00A00D06464421000200A00D06462D05470E00A00D06444A33070107A00D0644428810FFFFA00D03441600A00D03441500A00
D064A4422000200A00D064A2D05370C00A00D06484A33070107A00D0648428810FFFFA00D03481600A00D03481500A00D064E4422000200
12-27 22:32:54.838 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.838 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.838 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.839 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.839 6653 6671 D NxpHal : Response timer started
12-27 22:32:54.839 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:54.934 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:54.934 6653 6673 D NxpNciR : len = 5 > 4002020000
12-27 22:32:54.934 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:54.935 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:54.935 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:54.935 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:54.935 6653 6671 D NxpHal : Checking response
12-27 22:32:54.935 6653 6671 D NxpHal : Performing RF Settings BLK 3
N-727 22:32:54.935 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_RF_CONF_BLK_3= ��
12-27 22:32:54.935 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:54.935 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:54.935 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:54.936 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:54.943 6653 6674 D NxpNciX : len = 250 > 2002F71EA00D064E2D05370C00A00D064C4A33070107A00D064C428810FFFFA00D034C1600A00D034C1500A00D0
6524422000200A00D06522D05250C00A00D0650429010FFFFA00D06504A110F0107A00D03501600A00D03501500A00D06562D059E0C00A00D06564422000200A00D065C2D05690C00A
00D065C4421000200A00D0654428810FFFFA00D06544A33070107A00D03541600A00D03541500A00D065A429010FFFFA00D065A4A31070107A00D035A1600A00D035A1500A00D06982
FAF05800FA00D069A420000FFFFA00D063044A3900300A00D066C44A3900300A00D066C30CF000800A00D066C2F8F05800CA00D06702F8F058012
12-27 22:32:54.943 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:54.943 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:54.943 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:54.944 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:54.944 6653 6671 D NxpHal : Response timer started
12-27 22:32:54.944 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:55.033 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:55.033 6653 6673 D NxpNciR : len = 5 > 4002020000
12-27 22:32:55.033 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:55.034 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:55.034 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:55.034 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:55.034 6653 6671 D NxpHal : Checking response
12-27 22:32:55.034 6653 6671 D NxpHal : Performing RF Settings BLK 4
p0�27 22:32:55.034 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_RF_CONF_BLK_4= ��
12-27 22:32:55.034 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:55.034 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:55.034 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:55.034 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:55.042 6653 6674 D NxpNciX : len = 250 > 2002F71EA00D067030CF000800A00D06742F8F058012A00D067430DF000700A00D06782F1F068001A00D0678303
F000400A00D067844A2900300A00D03784700A00D067C2FAF05800FA00D067C30CF000700A00D067C44A3900300A00D067D30CF000800A00D06802FAF058090A00D068044A3900300A
00D06842FAF058092A00D068444A3900300A00D06882F7F048010A00D0688305F001600A00D03884700A00D068844A1900300A00D030C4819A00D03104320A00D066A42F810FFFFA00
D036A1600A00D036A1501A00D066A4A300F011FA00D068C428810FFFFA00D068C4A33070107A00D038C1600A00D038C1500A00D0692429010FFFF
12-27 22:32:55.042 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:55.042 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:55.042 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:55.043 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:55.043 6653 6671 D NxpHal : Response timer started
12-27 22:32:55.043 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:55.135 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:55.135 6653 6673 D NxpNciR : len = 5 > 4002020000
12-27 22:32:55.135 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:55.136 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:55.136 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:55.136 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:55.136 6653 6671 D NxpHal : Checking response
12-27 22:32:55.136 6653 6671 D NxpHal : Performing RF Settings BLK 5
�J1�7 22:32:55.136 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_RF_CONF_BLK_5= 7�
12-27 22:32:55.136 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:55.136 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:55.137 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:55.137 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:55.139 6653 6674 D NxpNciX : len = 58 > 20023707A00D06924A31070107A00D03921600A00D03921500A00D060A30CF000800A00D060A2F8F05800CA00D0
30A4810A00D060A44A3900300
12-27 22:32:55.139 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:55.139 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:55.139 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:55.139 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:55.139 6653 6671 D NxpHal : Response timer started
12-27 22:32:55.139 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:55.160 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:55.160 6653 6673 D NxpNciR : len = 5 > 4002020000
12-27 22:32:55.160 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:55.161 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:55.161 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:55.161 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:55.161 6653 6671 D NxpHal : Checking response
12-27 22:32:55.161 6653 6671 D NxpHal : Performing RF Settings BLK 6
12-27 22:32:55.162 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_RF_CONF_BLK_6=(0x0)
12-27 22:32:55.162 6653 6671 D NxpHal : Performing NAME_NXP_CORE_CONF_EXTN Settings
12-27 22:32:55.162 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_CORE_CONF_EXTN= N�
12-27 22:32:55.162 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:55.162 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:55.162 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:55.162 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:55.165 6653 6674 D NxpNciX : len = 81 > 20024E12A0020100A0030111A0040101A00902E803A00E0101A01104CD672201A0120100A0130100A0400101A04
10102A0420119A0430100A05E0101A0610100A0CD0118A0EC0101A0ED0100A047020027
12-27 22:32:55.165 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:55.165 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:55.165 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:55.165 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:55.165 6653 6671 D NxpHal : Response timer started
12-27 22:32:55.165 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:55.219 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:55.219 6653 6673 D NxpNciR : len = 5 > 4002020000
12-27 22:32:55.219 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:55.219 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:55.219 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:55.220 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:55.220 6653 6671 D NxpHal : Checking response
12-27 22:32:55.220 6653 6671 D NxpHal : Performing NAME_NXP_CORE_CONF Settings
!2-27 22:32:55.220 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_CORE_CONF= +
12-27 22:32:55.220 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:55.220 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:55.221 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:55.221 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:55.222 6653 6674 D NxpNciX : len = 46 > 20022B0D1801012101002801003001083101033304010203045001025401065B010060010E80010181010182010
E
12-27 22:32:55.222 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:55.223 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:55.223 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:55.223 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:55.223 6653 6671 D NxpHal : Response timer started
12-27 22:32:55.224 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:55.265 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:55.265 6653 6673 D NxpNciR : len = 5 > 4002020000
12-27 22:32:55.265 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:55.265 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:55.266 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:55.266 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:55.266 6653 6671 D NxpHal : Checking response
12-27 22:32:55.266 6653 6671 D NxpExtns: const nxp::CNfcParam* nxp::CNfcConfig::find(const char*) const found NXP_CORE_RF_FIELD= �b
12-27 22:32:55.266 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:55.266 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:55.267 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:55.267 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:55.268 6653 6674 D NxpNciX : len = 8 > 20020501A0620100
12-27 22:32:55.268 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:55.268 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:55.268 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:55.268 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:55.269 6653 6671 D NxpHal : Response timer started
12-27 22:32:55.269 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:55.273 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:55.273 6653 6673 D NxpNciR : len = 5 > 4002020000
12-27 22:32:55.273 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:55.274 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:55.274 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK
12-27 22:32:55.274 6653 6671 D NxpHal : Response timer stopped
12-27 22:32:55.274 6653 6671 D NxpHal : Checking response
12-27 22:32:55.274 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:55.274 6653 6673 D NxpTml : PN54X - Read requested.....
12-27 22:32:55.274 6653 6673 D NxpTml : PN54X - Invoking I2C Read.....
12-27 22:32:55.274 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:55.275 6653 6674 D NxpNciX : len = 8 > 20030502A086A087
12-27 22:32:55.275 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:55.275 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:55.275 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
12-27 22:32:55.275 6653 6676 D NxpHal : write successful status = 0x0
12-27 22:32:55.275 6653 6671 D NxpHal : Response timer started
12-27 22:32:55.275 6653 6671 D NxpHal : Waiting after ext cmd sent
12-27 22:32:55.276 6653 6673 D NxpTml : PN54X - I2C Read successful.....
12-27 22:32:55.276 6653 6673 D NxpNciR : len = 11 > 4003080902A08600A08700
12-27 22:32:55.276 6653 6673 D NxpTml : PN54X - Posting read message.....
12-27 22:32:55.276 6653 6676 D NxpHal : read successful status = 0x0
12-27 22:32:55.276 6653 6676 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_INVALID_PARAM
12-27 22:32:55.276 6653 6676 W NxpHal : Invalid Data from config file . Aborting..
12-27 22:32:55.277 6653 6674 D NxpTml : PN54X - Write requested.....
12-27 22:32:55.277 6653 6674 D NxpTml : PN54X - Invoking I2C Write.....
12-27 22:32:55.278 6653 6674 D NxpNciX : len = 10 > 21030703800181018201
12-27 22:32:55.278 6653 6674 D NxpTml : PN54X - I2C Write successful.....
12-27 22:32:55.278 6653 6674 D NxpTml : PN54X - Posting Fresh Write message.....
12-27 22:32:55.278 6653 6674 D NxpTml : PN54X - Tml Writer Thread Running................
The line "Invalid Data from config file . Aborting.." may be responsible ... Well it's nice to have a very verbose but meaningless log. Can't you tell me what exactly is invalid? *eyeroll.
btw. This "len = n > xxxxx" these are the bytes as hex found in the configs. The answer comes from the firmware (I guess). So huawei may have used another version wich uses slightly different config parameters.
I'm trying to use the buildable config (or template) and adapt huaweis settings there.
The issue is still the same... Now I try the official npx firmware blob.
I'm a bit out of ideas. No it did not work. So something must be wrong (version missmatch) with the shipped config and some other part of the stack.
I could connect my headset via nfc tag by using the merged nfc config and the uncommented abort on error line. Now I need to figure out what exactly that is and do some tests by reading out cards.
Reading metadata from the tags seems fine... The original conf files seem to be fine as well except that one invalid setting.
The only negative signs so far:
12-28 04:51:38.703 3898 7240 E BrcmNfcJni: nfaDeviceManagementCallback: NFA_DM_GET_CONFIG failed
12-28 04:51:38.703 3898 7243 D NxpTml : PN54X - Read requested.....
12-28 04:51:38.703 3898 7236 E BrcmNfcJni: enableDisableLptd: Config TLV length 0 returned is too short
...
12-28 04:51:38.703 3898 7240 D BrcmNfcJni: nfaConnectionCallback: event= 39
12-28 04:51:38.703 3898 7240 E BrcmNfcJni: nfaConnectionCallback: unknown event ????
Merged branches and changed title. Now we may discuss about what we could improve.
NFC doesn't work yet. Working on it.