Log Misc
2019-08-05 11:17 中华田园一只耳 阅读(601) 评论(0) 收藏 举报1.HDMI
console:/ # cat /sys/devices/platform/9800d000.hdmitx/hdmitx_info
------ HDMI Info -----
Mode: HDMI
RTK VO_STANDARD: 25
VO type: ANALOG_AND_DIGITAL
VIC: 16
Resolution: 1920x1080P @ 60Hz
Pixel format: YUV444
Color depth: 8 Bits
Colorimetry: ITU 709
3D: N/A
HDR mode: SDR
HDMI2.0: No
Scramble: No
2.HDCP
logcat | grep HDCP
V1.4 sample:
console:/ # logcat | grep HDCP
01-01 08:00:14.497 1637 2131 D HDMI-HIDL-HDMICore-HDCP: [HDCPThread] HDCP version 22 delay 3
01-01 08:00:17.497 1637 2131 D HDMI-HIDL-HDMICore-HDCP: [setHDCPVersion] version 22 reqHDCPVersion 22 supportHDCPVersion 22
01-01 08:00:17.497 1637 2131 D HDMI-HIDL-HDCP: HDCPController::HDCPController()
01-01 08:00:17.589 1637 2131 D HDMI-HIDL-HDCP: module is ok, call hdcp_dev_open
01-01 08:00:17.590 1637 2131 I : open HDCP successfully! fd: 10
01-01 08:00:17.590 1637 2131 D HDMI-HIDL-HDCP: Succeed to initHDCPDevice
01-01 08:00:17.592 1637 2131 D HDMI-HIDL-HDCP: HDCPController::querySink(), capable:1
01-01 08:00:17.593 1637 2131 D RTKHDCPAPI: [HDCP22]get_hdcp_22_version_bit 0x00.
01-01 08:00:17.695 1637 2131 D RTKHDCPAPI: [HDCP22]get_hdcp_22_version_bit 0x00.
01-01 08:00:18.000 1637 2131 D RTKHDCPAPI: [HDCP22]get_hdcp_22_version_bit 0x00.
01-01 08:00:18.100 1637 2131 D HDMI-HIDL-HDMICore-HDCP: [getSinkHDCPCapability] exit -> HDCP vsn 14 retry[4]
01-01 08:00:18.100 1637 2131 W HDMI-HIDL-HDMICore-HDCP: setHDCPVersion version 22 > sinkHDCP 14
01-01 08:00:18.100 1637 2131 D HDMI-HIDL-HDCP: [enableHDCP] key path: /data/vendor/hdcp/_custom_param_h13
01-01 08:00:18.101 1637 2131 D HDMI-HIDL-HDCP: [enableHDCP] 8f 31 1d
01-01 08:00:18.145 1637 2131 D HDMI-HIDL-HDCP: [HDMI]: Valid Key Selection Vector= 0x13 ac f1 55 d4
01-01 08:00:18.146 1637 2131 D HDMI-HIDL-HDCP: HDCPController::enableHDCP() done
01-01 08:00:18.146 1637 2131 D HDMI-HIDL-HDMICore-HDCP: [enableHDCP14] rst:1
01-01 08:00:18.272 1637 1691 D HDMI-HIDL-HDMICore: [onHDCPEvent] HDCP_EVENT_SUCCESS
v2.2 sample:
console:/ # logcat | grep HDCP 01-01 08:00:08.421 1638 1638 D HDMI-HIDL-HDMICore-HDCP: HDCPCore() mSupportVersion 22 mReqHDCPVersion 22 01-01 08:00:08.602 1638 1791 D HDMI-HIDL-HDCP: HDCPController::HDCPController() 01-01 08:00:08.818 1638 1791 D HDMI-HIDL-HDCP: module is ok, call hdcp_dev_open 01-01 08:00:08.818 1638 1791 I : open HDCP successfully! fd: 9 01-01 08:00:08.818 1638 1791 D HDMI-HIDL-HDCP: Succeed to initHDCPDevice 01-01 08:00:08.818 1638 1791 D HDMI-HIDL-HDCP: HDCPController::disableHDCP() done 07-26 11:18:53.661 1638 3104 D HDMI-HIDL-HDMICore-HDCP: [HDCPThread] HDCP version 22 delay 5 07-26 11:18:58.662 1638 3104 D HDMI-HIDL-HDMICore-HDCP: [setHDCPVersion] version 22 reqHDCPVersion 22 supportHDCPVersion 22 0[ 171.730554] [MCP] Warning, wait clear bit deassert timeout, force unset clear bit, (CTRL=0000001c, STATUS=00000000) 7-26 11:18:58.664 1638 3104 D [ 171.741852] [MCP] Warning, CTRL=0000000c, STATUS=00000000) HDMI-HIDL-HDCP: HDCPController::querySink(), capable:1 07-26 11:18:58.665 1638 3104 D RTKHDCPAPI: [HDCP22]get_hdcp_22_version_bit 0x04. 07-26 11:18:58.666 1638 3104 D HDMI-HIDL-HDMICore-HDCP: [getSinkHDCPCapability] exit -> HDCP vsn 22 retry[0] 07-26 11:18:58.666 1638 3104 D RTKHDCPAPI: [HDCP]enable_hdcptx_22 07-26 11:18:58.666 1638 3104 D RTKHDCPAPI: [init_rx_info_storage] path:/data/vendor/hdcp 07-26 11:18:58.666 1638 3104 D RTKHDCPAPI: [init_rx_info_storage] rx info file: /data/vendor/hdcp/hdcpRxInfo 07-26 11:18:58.667 1638 3104 D RTKHDCPAPI: [init_rx_info_storage] pf 0xb238400c 07-26 11:18:58.667 1638 3104 D RTKHDCPTX22Core: [HDCP] Create HDCPTX22 for HDMI 07-26 11:18:58.668 1638 3104 D RTKHDCPTX22Core: [SRM] file not exists 07-26 11:18:58.668 1638 3104 D RTKHDCPAPI: [HDCP] SRM analysis rst: 0 07-26 11:18:58.669 1638 3105 D RTKHDCPAPI: [HDCP] pthread_entrt start 07-26 11:18:58.670 1638 3105 D RTKHDCPTX22Core: [dec_hdcptx_key] db 60 94 07-26 11:18:58.718 1638 3105 D RTKHDCPTX22Core: dec_hdcptx_key() done 07-26 11:18:58.718 1638 3105 D RTKHDCPAPI: [HDCP] dec_hdcptx_key rst: 1 07-26 11:18:58.718 1638 3105 D RTKHDCPTX22Core: [HDCP] start_hdcp_nego 07-26 11:18:58.718 1638 3105 D RTKHDCPTX22Core: [HDCP][>] AKE_Init 07-26 11:18:58.721 1638 3105 D RTKHDCPTX22Core: [hdcp_safe_write] HDCP_ERR_SUCCESS 07-26 11:18:58.721 1638 3105 D RTKHDCPTX22Core: [HDCP][<] read_send_cert 07-26 11:18:58.722 1638 3105 D RTKHDCPTX22Core: [hdcp_safe_read_with_timeout] check_read_count 1 07-26 11:18:58.784 1638 3105 D RTKHDCPTX22Core: [HDCP] Analysis RxCert. 07-26 11:18:58.787 1638 3105 D RTKHDCPTX22Core: RxCap: 02 00 00 07-26 11:18:58.787 1638 3105 D RTKHDCPTX22Core: [HDCP] hdcp_read_msg rst=HDCP_ERR_SUCCESS 07-26 11:18:58.787 1638 3105 D RTKHDCPTX22Core: [HDCP][>] AKE_No_Stored_km 07-26 11:18:58.787 1638 3105 D RTKHDCPTX22Core: [HDCP] encrypt EkhKm. 07-26 11:18:58.806 1638 3105 D RTKHDCPTX22Core: [hdcp_safe_write] HDCP_ERR_SUCCESS 07-26 11:18:58.806 1638 3105 D RTKHDCPTX22Core: [HDCP][<] read_send_h_prime 07-26 11:18:58.862 1638 3105 D RTKHDCPTX22Core: [hdcp_safe_read_with_timeout] check_read_count 77 07-26 11:18:58.867 1638 3105 D RTKHDCPTX22Core: [HDCP] Read Hprime ok, start checking H' correctness. 07-26 11:18:58.867 1638 3105 D RTKHDCPTX22Core: [HDCP] compute kd 07-26 11:18:58.867 1638 3105 D RTKHDCPTX22Core: [HDCP] hdcp_compute_dkey 0 07-26 11:18:58.867 1638 3105 D RTKHDCPTX22Core: [HDCP] hdcp_compute_dkey 1 07-26 11:18:58.867 1638 3105 D RTKHDCPTX22Core: [HDCP] Use 0 ms to compute H 07-26 11:18:58.867 1638 3105 D RTKHDCPTX22Core: [HDCP] H compare success, read Pairing_Info in no_stored_km case 07-26 11:18:58.867 1638 3105 D RTKHDCPTX22Core: [HDCP][<] read_send_pairing_info 07-26 11:18:58.868 1638 3105 D RTKHDCPTX22Core: [hdcp_safe_read_with_timeout] check_read_count 1 07-26 11:18:58.870 1638 3105 D RTKHDCPTX22Core: [HDCP] Read Pairing Info use 3 ms 07-26 11:18:58.870 1638 3105 D RTKHDCPTX22Core: hdcp_save_pairing_info 07-26 11:18:58.870 1638 3105 D RTKHDCPAPI: [save_rx_record] : E pf:0xb238400c 07-26 11:18:58.871 1638 3105 D RTKHDCPAPI: [save_rx_record] : X pf:0xb238400c 07-26 11:18:58.871 1638 3105 D RTKHDCPTX22Core: change state to LC_INIT 07-26 11:18:58.871 1638 3105 D RTKHDCPTX22Core: [HDCP] hdcp_read_msg rst=HDCP_ERR_SUCCESS 07-26 11:18:58.871 1638 3105 D RTKHDCPTX22Core: [HDCP][>] (resend) LC_Init retry count 0 07-26 11:18:58.873 1638 3105 D RTKHDCPTX22Core: [hdcp_safe_write] HDCP_ERR_SUCCESS 07-26 11:18:58.873 1638 3105 D RTKHDCPTX22Core: [HDCP][<] read_send_l_prime 07-26 11:18:58.873 1638 3105 D RTKHDCPTX22Core: [hdcp_safe_read_with_timeout] check_read_count 1 07-26 11:18:58.878 1638 3105 D RTKHDCPTX22Core: [HDCP] read l_prime use 5 ms err_code= HDCP_ERR_SUCCESS 07-26 11:18:58.878 1638 3105 D RTKHDCPTX22Core: [HDCP] Locality check pass, change state to Send_SKE 07-26 11:18:58.878 1638 3105 D RTKHDCPTX22Core: [HDCP] hdcp_read_msg rst=HDCP_ERR_SUCCESS 07-26 11:18:58.878 1638 3105 D RTKHDCPTX22Core: [HDCP][>] Send_SKE 07-26 11:18:58.878 1638 3105 D RTKHDCPTX22Core: 07-26 11:18:58.878 1638 3105 D RTKHDCPTX22Core: ks [1] length:16 07-26 11:18:58.878 1638 3105 D RTKHDCPTX22Core: a7 15 a5 3e 84 bb 52 08 c0 56 2c 76 7c be e2 17 07-26 11:18:58.878 1638 3105 D RTKHDCPTX22Core: [HDCP] hdcp_compute_dkey 2 07-26 11:18:58.881 1638 3105 D RTKHDCPTX22Core: [hdcp_safe_write] HDCP_ERR_SUCCESS 07-26 11:18:58.881 1638 3105 D RTKHDCPTX22Core: 07-26 11:18:58.881 1638 3105 D RTKHDCPTX22Core: ks [2] length:16 07-26 11:18:58.882 1638 3105 D RTKHDCPTX22Core: a7 15 a5 3e 84 bb 52 08 c0 56 2c 76 7c be e2 17 07-26 11:18:58.882 1638 3105 D RTKHDCPTX22Core: [HDCP] use production lc128 [] 07-26 11:18:58.882 1638 3105 D RTKHDCPTX22Core: 07-26 11:18:58.882 1638 3105 D RTKHDCPTX22Core: ks_xor_1c128 [before swap] length:16 07-26 11:18:58.882 1638 3105 D RTKHDCPTX22Core: 12 cd 4c 95 db 31 ac c2 f8 03 9d d3 62 77 5e 18 07-26 11:18:59.082 1638 3105 D HDMI-HIDL-HDCP: HDCPController::setHDCP22CipherInfo 07-26 11:18:59.082 1638 3105 D HDMI-HIDL-HDCP: setHDCP22CipherInfo RIV: 07-26 11:18:59.082 1638 3105 D HDMI-HIDL-HDCP: 1e 7a b8 f7 32 d3 ce e5 07-26 11:18:59.082 1638 3105 D HDMI-HIDL-HDCP: setHDCP22CipherInfo ks_xor_lc128: 07-26 11:18:59.082 1638 3105 D HDMI-HIDL-HDCP: 18 5e 77 62 d3 9d 03 f8 c2 ac 31 db 95 4c cd 12 07-26 11:18:59.183 1638 3105 D HDMI-HIDL-HDMICore-HDCP: hdcp_22_state_update_callback state 0 07-26 11:18:59.183 1638 3105 D RTKHDCPTX22Core: HDCP 2.2 nego complete rst= HDCP_ERR_NEGO_COMPLETE , state= HDCP_STATE_POLLING_RXSTATUS 07-26 11:18:59.183 1638 3105 D RTKHDCPTX22Core: [HDCP] start polling RxStatus. 07-26 11:18:59.183 1638 1686 D HDMI-HIDL-HDMICore: [onHDCPEvent] HDCP_EVENT_SUCCESS 07-26 11:19:01.728 1638 3105 D RTKHDCPTX22Core: [HDCP] polling rx status 1
3.BT
adb pull system/etc/bluetooth/bt_stack.conf D:\bt_stack.conf文件修改bt_stack.conf文件打开全部log：
BtSnoopLogOutput=true
BtSnoopFileName=/sdcard/btsnoop_hci.cfa
TraceConf=true
TRC_BTM=5
TRC_HCI=5
TRC_L5CAP=5
TRC_RFCOMM=5
TRC_OBEX=5
TRC_AVCT=5
TRC_AVDT=5
TRC_AVRC=5
TRC_AVDT_SCB=5
TRC_AVDT_CCB=5
TRC_A5D=5
TRC_SDP=5
TRC_GATT=5
TRC_SMP=5
TRC_BTAPP=5
TRC_BTIF=5
adb push bt_stack.conf system/etc/bluetooth
然后抓取logcat和snoop log，方法为：
先关闭蓝牙：
adb logcat -v time > D:\rebootlogcat.txt 录制logcat信息（开始测试时cmd窗口输入命令）
开启蓝牙，配对连接，其他操作：
btsnoop_hci.cfa会自动在对应的目录生成。
snoop log： adb pull sdcard/btsnoop_hci.cfa D:\btsnoop_hci.cfa (蓝牙打开时覆盖上一次的snoop log，请在出问题的点pull就可以)
抓log之前先确认系统时间和本地时间要一致，否则btsnoop就无法对应起来。
4.wifi
一般有问题先提供4.1 的kernel log
4.1 抓kernel log，開起kernel log level 到 8 (以公版為例)，若使用tera term抓log，一定要把time stamp加入。
echo 8 > /proc/sys/kernel/printk
4.2 如果有需要開起wifi driver裡的log，届时我这边在另行提供
rtwpriv binary
rtwpriv push到 /system/bin 或其它可擺放的位置，記得把rtwpriv chmod為755
./rtwpriv wlan0 dbg 0x7f230000 1
./rtwpriv wlan0 dbg 0x7f110000 1
4.3 打iperf (Note: 請不要在 Setting 下的AP List 畫面時使用 iperf command，因此時Android 每10sec 會做scan AP，使TP嚴重drop，而影響實驗數據)
1195端:
./iperf202_arm -s -i 1 -w 1M -P 3
PC端:
iperf -c xx.xx.xx.xx -t 60 -i 1 -w 1M -P 3
測試時需要換AP與不同的測試點, 請依下表做測試, 若有多台AP, 就要重覆以下，同時需要跳距離
<wiz_tmp_tag id="wiz-table-range-border" contenteditable="false" style="display: none;">
浙公网安备 33010602011771号