NFC PN7150 on Qualcomm Android R integration errors, memory access error

smile123 · ‎09-05-2022

We face following issue with respect to NFC.

We are using PN7150 NFC on Qualcomm based chipset running android R with sn100 hal. While enabling the pn7150 using sn100 android stack we are facing issues. Once we enable the NFC we could see RF side active with 13.5 MHz clock. But we are not able to detect NFC card / tag.

From log we can see some command responses to the i2c chip with the syntax errors in the responses.. we are not certain whether this error response from device is causing detection failures or is it because of configuration not right done initially from the software.

We would like to know why the error is coming and how to prevent it. error prints are below.?

Does sn100 libraries on android R support PN7150.? Are there any customizations needed?

09-29 11:15:22.397 666 666 D vendor.nxp.hardware.nfc@2.0-service: nxp_rf_config_path=/system/vendor/libnfc-nxp_RF.conf

09-29 11:15:22.398 666 666 D vendor.nxp.hardware.nfc@2.0-service: Fw_Lib_Path=/system/vendor/lib/libsn100u_fw.so

09-29 11:15:22.400 666 666 D NxpHal : Error : opening (/system/vendor/lib64/libonebinary.so) !!

09-29 11:15:22.400 666 666 D NxpHal : nfc_debug_enabled : 1

09-29 11:15:22.400 666 666 D NxpExtns: find found NXPLOG_NCIHAL_LOGLEVEL=(0x3)

09-29 11:15:22.401 666 666 D NxpExtns: find found NXPLOG_EXTNS_LOGLEVEL=(0x3)

09-29 11:15:22.401 666 666 D NxpExtns: find found NXPLOG_TML_LOGLEVEL=(0x3)

09-29 11:15:22.401 666 666 D NxpExtns: find found NXPLOG_FWDNLD_LOGLEVEL=(0x3)

09-29 11:15:22.401 666 666 D NxpExtns: find found NXPLOG_NCIX_LOGLEVEL=(0x3)

09-29 11:15:22.401 666 666 D NxpExtns: find found NXPLOG_NCIR_LOGLEVEL=(0x3)

09-29 11:15:22.401 666 666 D NxpNfcHal: phNxpLog_InitializeLogLevel: global =1, Fwdnld =3, extns =3, hal =3, tml =3, ncir =3, ncix =3

09-29 11:15:22.401 666 666 D NxpExtns: find found MIFARE_READER_ENABLE=(0x1)

09-29 11:15:22.403 666 666 D NxpHal : Entering phNxpNciHal_init_monitor

09-29 11:15:22.403 666 666 D NxpHal : Returning with SUCCESS

09-29 11:15:22.403 666 666 D NxpExtns: find found NXP_NFC_DEV_NODE=/dev/pn544

09-29 11:15:22.403 666 666 D NxpTml : Opening port=/dev/pn544

09-29 11:15:22.404 666 666 D NxpTml : phTmlNfc_i2c_reset(), VEN level 7

09-29 11:15:22.412 0 0 I pn54x_dev_open: 10,62

09-29 11:15:22.431 3946 3969 I omm.location.X: Background young concurrent copying GC freed 5682(494KB) AllocSpace objects, 2(40KB) LOS objects, 93% free, 1757KB/25MB, paused 162us total 115.626ms

09-29 11:15:22.435 4035 4035 I d.process.acor: The ClassLoaderContext is a special shared library.

09-29 11:15:22.457 941 1220 I chatty : uid=1000(system) android.bg expire 3 lines

09-29 11:15:22.457 0 0 I : pn54x_dev_ioctl, cmd=1074063617, arg=7

09-29 11:15:22.457 0 0 E : pn54x_dev_ioctl bad SET_PWR arg 7 error override

09-29 11:15:22.473 0 0 I : pn54x_dev_ioctl, cmd=59652, arg=5138418468164818527

09-29 11:15:22.473 0 0 E : pn54x_dev_ioctl bad ioctl 59652 error override

09-29 11:15:22.474 666 666 D NxpTml : phTmlNfc_get_platform: interface = 0

09-29 11:15:22.477 666 4159 D NxpTml : PN54X - Tml Reader Thread Started................

09-29 11:15:22.479 666 4162 D NxpHal : thread started

09-29 11:15:22.480 666 4159 D NxpTml : PN54X - Read requested.....

09-29 11:15:22.480 666 4159 D NxpTml : PN54X - Invoking I2C Read.....

09-29 11:15:22.494 666 4160 D NxpTml : PN54X - Tml Writer Thread Started................

09-29 11:15:22.494 666 4160 D NxpTml : PN54X - Tml Writer Thread Running................

09-29 11:15:22.494 666 4160 D NxpTml : PN54X - Write requested.....

09-29 11:15:22.494 666 4160 D NxpTml : PN54X - Invoking I2C Write.....

09-29 11:15:22.496 666 4160 D NxpNciX : len = 4 > 20000100

09-29 11:15:22.497 666 4160 D NxpTml : PN54X - I2C Write successful.....

09-29 11:15:22.497 666 4160 D NxpTml : PN54X - Posting Fresh Write message.....

09-29 11:15:22.497 666 4160 D NxpTml : PN54X - Tml Writer Thread Running................

09-29 11:15:22.497 666 4162 D NxpHal : write successful status = 0x0

09-29 11:15:22.497 666 666 D NxpHal : Response timer started

09-29 11:15:22.497 666 666 D NxpHal : Waiting after ext cmd sent

09-29 11:15:22.501 666 4159 D NxpTml : PN54X - I2C Read successful.....

09-29 11:15:22.501 666 4159 D NxpNciR : len = 6 > 400003001100

09-29 11:15:22.501 666 4159 D NxpTml : PN54X - Posting read message.....

09-29 11:15:22.501 666 4162 D NxpHal : read successful status = 0x0

09-29 11:15:22.502 666 4162 D NxpHal : CORE_RESET_RSP NCI1.0

09-29 11:15:22.502 666 666 D NxpHal : Response timer stopped

09-29 11:15:22.502 666 666 D NxpHal : Checking response

09-29 11:15:22.502 666 4159 D NxpTml : PN54X - Read requested.....

09-29 11:15:22.503 666 4159 D NxpTml : PN54X - Invoking I2C Read.....

09-29 11:15:22.503 666 4160 D NxpTml : PN54X - Write requested.....

09-29 11:15:22.503 666 4160 D NxpTml : PN54X - Invoking I2C Write.....

09-29 11:15:22.506 666 4160 D NxpNciX : len = 3 > 200100

09-29 11:15:22.506 666 4160 D NxpTml : PN54X - I2C Write successful.....

09-29 11:15:22.506 666 4160 D NxpTml : PN54X - Posting Fresh Write message.....

09-29 11:15:22.507 666 4160 D NxpTml : PN54X - Tml Writer Thread Running................

09-29 11:15:22.507 666 4162 D NxpHal : write successful status = 0x0

09-29 11:15:22.508 666 666 D NxpHal : Response timer started

09-29 11:15:22.509 666 666 D NxpHal : Waiting after ext cmd sent

09-29 11:15:22.509 666 4159 D NxpTml : PN54X - I2C Read successful.....

09-29 11:15:22.509 666 4159 D NxpNciR : len = 28 > 40011900031E030008000102038081828302D002FF020004881001AE

09-29 11:15:22.509 666 4159 D NxpTml : PN54X - Posting read message.....

09-29 11:15:22.510 666 4162 D NxpHal : read successful status = 0x0

09-29 11:15:22.510 666 4162 D NxpHal : CORE_INIT_RSP NCI1.0 received !

09-29 11:15:22.510 666 4162 D NxpHal : processChipType HwVersion : 0x88

09-29 11:15:22.510 666 4162 D NxpHal : processChipType Product : PN548C2

09-29 11:15:22.510 666 4162 D NxpHal : phNxpNciHal_configFeatureList ()chipType = 3

09-29 11:15:22.511 666 4162 D NxpHal : phNxpNciHal_configFeatureList ()chipType = 3

09-29 11:15:22.511 666 4162 D NxpHal : phNxpNciHal_configFeatureList ()FW = 1

09-29 11:15:22.511 666 4162 D NxpHal : NxpNci> FW Version: 10.1.ae

09-29 11:15:22.511 666 666 D NxpHal : Response timer stopped

09-29 11:15:22.511 666 666 D NxpHal : Checking response

09-29 11:15:22.512 666 666 D NxpExtns: find found NXP_I2C_FRAGMENTATION_ENABLED=(0x0)

09-29 11:15:22.512 666 666 D NxpFwDnld: I2C status : 0

09-29 11:15:22.512 666 4160 D NxpTml : PN54X - Write requested.....

09-29 11:15:22.512 666 4159 D NxpTml : PN54X - Read requested.....

09-29 11:15:22.512 666 4159 D NxpTml : PN54X - Invoking I2C Read.....

09-29 11:15:22.512 666 4160 D NxpTml : PN54X - Invoking I2C Write.....

09-29 11:15:22.514 666 4160 D NxpNciX : len = 6 > 20030301A005

09-29 11:15:22.514 666 4160 D NxpTml : PN54X - I2C Write successful.....

09-29 11:15:22.514 666 4160 D NxpTml : PN54X - Posting Fresh Write message.....

09-29 11:15:22.515 666 4160 D NxpTml : PN54X - Tml Writer Thread Running................

09-29 11:15:22.515 666 4162 D NxpHal : write successful status = 0x0

09-29 11:15:22.515 666 666 D NxpHal : Response timer started

09-29 11:15:22.515 666 666 D NxpHal : Waiting after ext cmd sent

09-29 11:15:22.516 666 4159 D NxpTml : PN54X - I2C Read successful.....

09-29 11:15:22.517 666 4159 D NxpNciR : len = 9 > 4003060001A0050100

09-29 11:15:22.517 666 4159 D NxpTml : PN54X - Posting read message.....

09-29 11:15:22.517 666 4162 D NxpHal : read successful status = 0x0

09-29 11:15:22.517 666 4162 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK

09-29 11:15:22.519 666 666 D NxpHal : Response timer stopped

09-29 11:15:22.519 666 666 D NxpHal : Checking response

09-29 11:15:22.519 666 666 D NxpHal : phNxpNciHal_CheckFwRegFlashRequired() : enter

09-29 11:15:22.519 666 666 D NxpFwDnld: Allocating Mem for Dnld Context..

09-29 11:15:22.519 666 666 E NxpFwDnld: phDnldNfc_SetDlRspTimeout timeout value =9c4

09-29 11:15:22.520 666 666 D NxpExtns: find found NXP_FW_TYPE=(0x1)

09-29 11:15:22.520 666 666 D NxpFwDnld: firmware type from conf file: 1

09-29 11:15:22.521 666 4159 D NxpTml : PN54X - Read requested.....

09-29 11:15:22.521 666 4159 D NxpTml : PN54X - Invoking I2C Read.....

09-29 11:15:22.532 4084 4084 I Perf : Connecting to perf service.

09-29 11:15:22.559 4084 4084 D NetworkSecurityConfig: No Network Security Config specified, using platform default

09-29 11:15:22.561 4084 4084 D NetworkSecurityConfig: No Network Security Config specified, using platform default

09-29 11:15:22.565 425 425 I hwservicemanager: getTransport: Cannot find entry vendor.qti.hardware.iop@2.0::IIop/default in either framework or device manifest.

09-29 11:15:22.566 1098 1098 E ANDR-IOP: IIop:: Iop HAL Service is not available.

09-29 11:15:22.580 4128 4128 I .localtranspor: The ClassLoaderContext is a special shared library.

09-29 11:15:22.582 4084 4084 I WigigBootCompleteReceiver: onReceive: got Intent { act=android.intent.action.BOOT_COMPLETED flg=0x89000010 cmp=com.qualcomm.qti.server.wigigapp/.BootCompleteBroadcastReceiver (has extras) }

09-29 11:15:22.601 4084 4084 I WigigSettingsService: onCreate

09-29 11:15:22.601 666 666 D NxpFwDnld: @@@/system/vendor/lib/libsn100u_fw.so

09-29 11:15:22.602 666 666 D NxpFwDnld: FW Image Length - ImageInfoLen 204518

09-29 11:15:22.602 666 666 D NxpFwDnld: FW Image Info Pointer - pImageInfo 0x74b2733488

09-29 11:15:22.602 666 666 D NxpFwDnld: FW Major Version Num - 10

09-29 11:15:22.602 666 666 D NxpFwDnld: FW Minor Version Num - 57

09-29 11:15:22.602 666 666 D NxpFwDnld: FW Image Length - 204518

09-29 11:15:22.603 666 666 D NxpFwDnld: FW Image Info Pointer - 0x74b2733488

09-29 11:15:22.603 666 666 D NxpHal : FW version of the libsn100u.so binary = 0x1057

09-29 11:15:22.603 666 666 D NxpHal : FW version found on the device = 0x1001ae

09-29 11:15:22.604 2124 2124 D KeyguardViewMediator: adjustStatusBarLocked: mShowing=true mOccluded=false isSecure=false force=false --> flags=0x1200000

09-29 11:15:22.604 666 666 D NxpHal : Flash option not found; giving default value

09-29 11:15:22.606 2124 2124 D StatusBar: disable<e i a s b H R c s > disable2<q i n >

09-29 11:15:22.609 4084 4084 E WigigManager: Wigig service not available

09-29 11:15:22.610 4084 4084 E WigigSettingsService: Failed to get WigigManager instance

09-29 11:15:22.611 941 941 I chatty : uid=1000(system) Binder:941_3 expire 4 lines

09-29 11:15:22.616 666 666 D NxpHal : FW update not required

09-29 11:15:22.616 666 666 D NxpFwDnld: Freeing Mem for Dnld Context..

09-29 11:15:22.617 2357 2357 D ApplicationLoaders: Returning zygote-cached class loader: /system/framework/android.test.base.jar

09-29 11:15:22.617 666 666 D NxpHal : phNxpNciHal_CheckFwRegFlashRequired() : exit - status = 0 wFwUpdateReq=0, wRfUpdateReq=0

09-29 11:15:22.617 666 666 D NxpHal : FW update not required

09-29 11:15:22.618 666 666 D NxpHal : property_set_intf, key[nfc.fw.downloadmode_force], value[0]

09-29 11:15:22.618 666 666 D NxpHal : phNxpNciHal_setSystemProperty : Enter Key = nfc.fw.downloadmode_force, value = 0

09-29 11:15:22.618 666 666 E NxpHal : phNxpNciHal_conf_nfc_forum_mode: command is not provided

09-29 11:15:22.619 666 4160 D NxpTml : PN54X - Write requested.....

09-29 11:15:22.619 666 4160 D NxpTml : PN54X - Invoking I2C Write.....

09-29 11:15:22.621 666 4160 D NxpNciX : len = 6 > 20030301A068

09-29 11:15:22.621 666 4160 D NxpTml : PN54X - I2C Write successful.....

09-29 11:15:22.622 666 4160 D NxpTml : PN54X - Posting Fresh Write message.....

09-29 11:15:22.622 666 4160 D NxpTml : PN54X - Tml Writer Thread Running................

09-29 11:15:22.622 666 4162 D NxpHal : write successful status = 0x0

09-29 11:15:22.623 666 4159 D NxpTml : PN54X - I2C Read successful.....

09-29 11:15:22.626 666 4159 D NxpNciR : len = 9 > 4003060001A0680100

09-29 11:15:22.626 666 4159 D NxpTml : PN54X - Posting read message.....

09-29 11:15:22.627 666 4162 D NxpHal : read successful status = 0x0

09-29 11:15:22.627 666 4162 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_OK

09-29 11:15:22.628 666 4159 D NxpTml : PN54X - Read requested.....

09-29 11:15:22.628 666 4159 D NxpTml : PN54X - Invoking I2C Read.....

09-29 11:15:22.634 666 666 D NxpHal : Response timer started

09-29 11:15:22.634 666 666 D NxpHal : Waiting after ext cmd sent

09-29 11:15:22.634 666 666 D NxpHal : Response timer stopped

09-29 11:15:22.634 666 666 D NxpHal : Checking response

09-29 11:15:22.635 666 4160 D NxpTml : PN54X - Write requested.....

09-29 11:15:22.635 666 4160 D NxpTml : PN54X - Invoking I2C Write.....

09-29 11:15:22.638 666 4160 D NxpNciX : len = 49 > 20022E01A0680100000102038081828382D002FF020004881001AE00000000000000000000000000000000000000000000

09-29 11:15:22.638 666 4160 D NxpTml : PN54X - I2C Write successful.....

09-29 11:15:22.638 666 4160 D NxpTml : PN54X - Posting Fresh Write message.....

09-29 11:15:22.639 666 4160 D NxpTml : PN54X - Tml Writer Thread Running................

09-29 11:15:22.639 666 4162 D NxpHal : write successful status = 0x0

09-29 11:15:22.639 666 666 D NxpHal : Response timer started

09-29 11:15:22.639 666 666 D NxpHal : Waiting after ext cmd sent

09-29 11:15:22.642 666 4159 D NxpTml : PN54X - I2C Read successful.....

09-29 11:15:22.642 666 4159 D NxpNciR : len = 5 > 4002020500

09-29 11:15:22.642 666 4159 D NxpTml : PN54X - Posting read message.....

09-29 11:15:22.642 666 4162 D NxpHal : read successful status = 0x0

09-29 11:15:22.643 666 4162 D NxpHal : phNxpNciHal_print_res_status: response status =STATUS_SYNTAX_ERROR

09-29 11:15:22.643 666 666 D NxpHal : Response timer stopped

09-29 11:15:22.643 666 666 D NxpHal : Checking response

09-29 11:15:22.643 666 666 D NxpHal : phNxpNciHal_MinOpen(): exit

09-29 11:15:22.644 666 666 D android.hardware.nfc@1.2-impl: Nfc::open Exit

09-29 11:15:22.644 4035 4035 I ContactsPerf: VoicemailContentProvider.onCreate start

09-29 11:15:22.645 666 4159 D NxpTml : PN54X - Read requested.....

09-29 11:15:22.645 666 4159 D NxpTml : PN54X - Invoking I2C Read.....

09-29 11:15:22.648 3726 3829 I libnfc_nci: [INFO:NfcAdaptation.cc(1035)] NfcAdaptation::HalDownloadFirmwareCallback: event=0x0

09-29 11:15:22.649 3726 3829 I libnfc_nci: [INFO:NfcAdaptation.cc(1051)] NfcAdaptation::HalDownloadFirmwareCallback: HAL_NFC_OPEN_CPLT_EVT

09-29 11:15:22.651 3726 4140 I libnfc_nci: [INFO:NfcAdaptation.cc(855)] HalWriteIntf: Enter

09-29 11:15:22.652 3726 4140 I libnfc_nci: [INFO:NfcAdaptation.cc(704)] NfcAdaptation::HalWrite

09-29 11:15:22.658 666 4160 D NxpTml : PN54X - Write requested.....

09-29 11:15:22.658 666 4160 D NxpTml : PN54X - Invoking I2C Write.....

09-29 11:15:22.660 666 4160 D NxpNciX : len = 4 > 20000100

09-29 11:15:22.660 666 4160 D NxpTml : PN54X - I2C Write successful.....

09-29 11:15:22.660 666 4160 D NxpTml : PN54X - Posting Fresh Write message.....

09-29 11:15:22.661 666 4160 D NxpTml : PN54X - Tml Writer Thread Running................

09-29 11:15:22.661 666 4162 D NxpHal : write successful status = 0x0

09-29 11:15:22.664 666 4159 D NxpTml : PN54X - I2C Read successful.....

09-29 11:15:22.665 666 4159 D NxpNciR : len = 6 > 400003001100

09-29 11:15:22.665 666 4159 D NxpTml : PN54X - Posting read message.....

09-29 11:15:22.665 666 4162 D NxpHal : read successful status = 0x0

09-29 11:15:22.665 666 4162 D NxpHal : CORE_RESET_RSP NCI1.0

09-29 11:15:22.665 4128 4128 I Perf : Connecting to perf service.

09-29 11:15:22.666 3726 3829 I libnfc_nci: [INFO:NfcAdaptation.cc(1115)] HalDownloadFirmwareDataCallback: enter

09-29 11:15:22.666 3726 3829 I libnfc_nci: [INFO:nfc_ncif.cc(1554)] CORE_RESET_RSP len :0x3

09-29 11:15:22.666 3726 3829 I libnfc_nci: [INFO:nfc_ncif.cc(398)] nfc_ncif_send_cmd()

09-29 11:15:22.666 3726 3829 I libnfc_nci: [INFO:nfc_ncif.cc(315)] nfc_ncif_check_cmd_queue : making p_buf NULL.

09-29 11:15:22.667 666 4159 D NxpTml : PN54X - Read requested.....

09-29 11:15:22.667 666 4159 D NxpTml : PN54X - Invoking I2C Read.....

09-29 11:15:22.693 941 4166 I chatty : uid=1000(system) Binder:941_3 expire 1 line

09-29 11:15:22.698 4128 4128 D NetworkSecurityConfig: No Network Security Config specified, using platform default

09-29 11:15:22.699 4128 4128 D NetworkSecurityConfig: No Network Security Config specified, using platform default

09-29 11:15:22.703 425 425 I hwservicemanager: getTransport: Cannot find entry vendor.qti.hardware.iop@2.0::IIop/default in either framework or device manifest.

09-29 11:15:22.704 1098 1098 E ANDR-IOP: IIop:: Iop HAL Service is not available.

09-29 11:15:22.706 941 4166 I DropBoxManagerService: add tag=SYSTEM_BOOT isTagEnabled=true flags=0x2

09-29 11:15:22.717 4035 4035 I ContactsPerf: VoicemailContentProvider.onCreate finish

09-29 11:15:22.717 941 4166 I BootReceiver: Copying audit failures to DropBox

09-29 11:15:22.727 941 4166 I BootReceiver: Checking for fsck errors