--------- beginning of radio 06-26 14:34:30.190 366 366 D RILD : **RIL Daemon Started** 06-26 14:34:30.190 366 366 D RILD : **RILd param count=1** 06-26 14:34:31.191 366 366 E RILD : no modem 06-26 14:34:31.705 366 366 D RILD : RIL_Init argc = 3 clientId = 0 06-26 14:34:31.705 366 366 D RILC : Quectel RIL Version: Quectel_Android_RIL_Driver_radio1.5_V3.9.4 06-26 14:34:31.706 366 366 D RIL_READ_CONF: original conf line: asr_support_gps=1 06-26 14:34:31.706 366 366 D RIL_READ_CONF: asr_support_gps = 1 06-26 14:34:31.706 366 366 D RILC : [ro.build.version.release]: [11] 06-26 14:34:31.706 366 366 D RILC : Android Version: 110, RIL_VERSION: 12 / 12 06-26 14:34:31.706 366 366 E RILC : '/vendor/manifest.xml' not exist. 06-26 14:34:31.707 366 366 D RILC : __getIRadioVersion:753 IRadioVersion:4 06-26 14:34:31.707 366 366 D RILC : [ro.build.description]: [rk3568_r-userdebug 11 RD2A.211001.002 eng.hansen.20260626.140807 release-keys] 06-26 14:34:31.707 366 366 D RILC : [ro.hardware]: [rk30board] 06-26 14:34:31.707 366 366 D RILC : selinux maybe set Enforcing mode, use command getenforce to check 06-26 14:34:31.707 366 366 D RILC : selinux maybe set Enforcing mode, use command "setenforce 0" to disable 06-26 14:34:31.707 366 366 I RILC : clientID = 0 06-26 14:34:31.707 366 366 D RILD : RIL_Init rilInit completed 06-26 14:34:31.707 366 366 I RILC : SIM_COUNT: 1 06-26 14:34:31.707 366 366 E RILC : RIL_register: RIL version 12 06-26 14:34:31.707 366 423 I RILC : mainLoop Start 06-26 14:34:31.707 366 366 I RILC : s_registerCalled flag set, 1 06-26 14:34:31.708 366 423 D RILU : find_pci_device is 0 06-26 14:34:31.708 366 366 D RILC : registerService: starting android::hardware::radio::V1_1::IRadio slot1 06-26 14:34:31.708 366 423 D RILC : PCI can't find at device 06-26 14:34:31.708 366 423 D RILU : find quectel module /sys/bus/usb/devices/1-1.7 idVendor=2c7c idProduct=6005 06-26 14:34:31.708 366 423 D RILU : find_usb_device is 1 06-26 14:34:31.711 366 366 I RILC : RILHIDL called registerService 06-26 14:34:31.711 366 366 D RILD : RIL_Init RIL_register completed 06-26 14:34:31.711 366 366 D RILD : RIL_register_socket started 06-26 14:34:31.711 366 366 D RIL_UIM_SOCKET: Adding socket with id: 0 06-26 14:34:31.711 366 366 I RILC : RIL_register_socket: calling registerService 06-26 14:34:31.711 366 366 D RIL_SAP : registerService: starting ISap slot1 for slotId 0 06-26 14:34:31.712 366 366 D RIL_SAP : registerService: started ISap slot1 status 0 06-26 14:34:31.712 366 366 D RILD : RIL_register_socket completed 06-26 14:34:32.391 256 256 D TelephonyManager: No /proc/cmdline exception=java.io.FileNotFoundException: /proc/cmdline: open failed: EACCES (Permission denied) 06-26 14:34:32.392 256 256 D TelephonyManager: /proc/cmdline= 06-26 14:34:32.709 366 422 D RILC : dlopen /vendor/lib64/hw/radio.quectel.module.so failed: dlopen failed: library "/vendor/lib64/hw/radio.quectel.module.so" not found 06-26 14:34:32.709 366 422 D RILC : start the service through api... 06-26 14:34:32.709 366 422 D RILC : ql_radio_config_init start 06-26 14:34:32.709 366 422 E RadioConfigFactory: '/vendor/manifest.xml' not exist. 06-26 14:34:32.709 366 422 D RadioConfigFactory: 1.0 06-26 14:34:32.709 366 422 D RadioConfigFactory: __getIRadioConfigVersion:114 IRadioconfigVersion:0 06-26 14:34:32.709 366 422 D RadioConfigImpl: RadioConfigImpl() 06-26 14:34:32.709 366 422 D RadioConfigImpl: RadioConfigImpl:registerAsService(default) 06-26 14:34:32.710 366 423 D RILU : find /sys/bus/usb/devices/1-1.7:1.3/ttyUSB1 06-26 14:34:32.711 366 423 D RILU : ttyAT = ttyUSB1 06-26 14:34:32.711 366 422 D RadioConfigFactory: radio_config_register_service status=0 06-26 14:34:32.711 366 422 D RILC : ql_radio_config_init finish 06-26 14:34:32.711 366 422 D RILC : ql_radio_sap_init start 06-26 14:34:32.711 366 423 D RILU : find /sys/bus/usb/devices/1-1.7:1.4/ttyUSB2 06-26 14:34:32.711 366 422 D RIL_SAP_1_2: ql_radio_sap_init() start. 06-26 14:34:32.711 366 423 D RILU : ttyPPP = ttyUSB2 06-26 14:34:32.711 366 423 D RILU : find /sys/bus/usb/devices/1-1.7:1.2/ttyUSB0 06-26 14:34:32.711 366 423 D RILU : ttyDM = ttyUSB0 06-26 14:34:32.711 366 423 D RILU : find /sys/bus/usb/devices/1-1.7:1.6/ttyUSB3 06-26 14:34:32.711 366 423 D RILU : ttyGPS = ttyUSB3 06-26 14:34:32.711 366 423 E RILU : MTK debug detect RNDIS interface. Call detect_ecm_or_rndis 06-26 14:34:32.711 366 423 D RILU : MTK debug ql_find_ecm_rndis_ncm: usbnet adapter dir:/sys/bus/usb/devices/1-1.7:1.0 06-26 14:34:32.711 366 423 D RILU : find /sys/bus/usb/devices/1-1.7:1.0/net/wwan0 06-26 14:34:32.711 366 423 D RILU : usbnet_adapter = wwan0 06-26 14:34:32.712 366 423 D RILU : netcard driver: rndis_host, driver version: 22-Aug-2005 06-26 14:34:32.712 366 423 D RILU : RNDIS = wwan0 06-26 14:34:32.712 366 423 D RILC : quectel at port is /dev/ttyUSB1 06-26 14:34:32.712 366 423 D RILU : ql_set_autosuspend, enter... 06-26 14:34:32.712 366 423 D RILU : ro_hardware:rk30board 06-26 14:34:32.712 366 423 D RILU : ----------------------------------------------2:rk30board 06-26 14:34:32.712 366 423 D RILU : ----------------------------------------------3:1 06-26 14:34:32.712 366 423 D RILU : ----------------------------------------------3:2 06-26 14:34:32.713 366 422 D RIL_SAP_1_2: radio_sap_register_service status=0 06-26 14:34:32.713 366 422 D RILC : ql_radio_sap_init finish 06-26 14:34:32.726 366 423 D RILU : echo on > /sys/bus/usb/devices/1-1.7/power/control 06-26 14:34:32.726 366 423 D RILU : ql_set_autosuspend off 06-26 14:34:32.726 366 423 D RILU : ----------------------------------------------3:3 06-26 14:34:32.726 366 423 D RILU : ----------------------------------------------3:1 06-26 14:34:32.726 366 423 D RILU : ----------------------------------------------3:3 06-26 14:34:32.726 366 423 D RILU : ----------------------------------------------3:1 06-26 14:34:32.726 366 423 D RILU : ----------------------------------------------3:3 06-26 14:34:32.726 366 423 D RILU : ----------------------------------------------3:1 06-26 14:34:32.726 366 423 D RILU : ----------------------------------------------3:3 06-26 14:34:32.726 366 423 D RILU : ----------------------------------------------4 06-26 14:34:32.726 366 423 D RILC : s_device_path is /dev/ttyUSB1 06-26 14:34:32.727 366 423 D RILC : open device /dev/ttyUSB1 correctly 06-26 14:34:32.727 366 423 E ATC : at_open s_tild_reader = 494404996288 06-26 14:34:32.727 366 422 D ATC : AT> ATE0 06-26 14:34:32.728 366 425 D ATC : AT< OK 06-26 14:34:32.728 366 422 D ATC : AT> AT+CMEE=1 06-26 14:34:32.729 366 425 D ATC : AT< OK 06-26 14:34:32.729 366 422 D ATC : AT> ATI 06-26 14:34:32.730 366 425 D ATC : AT< Quectel 06-26 14:34:32.730 366 425 D ATC : AT< EC200A 06-26 14:34:32.730 366 425 D ATC : AT< Revision: EC200ACNGAR01A06M16 06-26 14:34:32.730 366 425 D ATC : AT< OK 06-26 14:34:32.730 366 422 D RILC : ql_product_version is EC200ACNGAR01A06M16 06-26 14:34:32.730 366 422 D RILC : Quectel Product Revision: EC200ACNGAR01A06M16 06-26 14:34:32.730 366 422 D RILU : ql_set_autosuspend, enter... 06-26 14:34:32.730 366 422 D RILU : ro_hardware:rk30board 06-26 14:34:32.730 366 422 D RILU : ----------------------------------------------2:rk30board 06-26 14:34:32.730 366 422 D RILU : ----------------------------------------------3:1 06-26 14:34:32.730 366 422 D RILU : ----------------------------------------------3:2 06-26 14:34:32.745 366 422 D RILU : echo on > /sys/bus/usb/devices/1-1.7/power/control 06-26 14:34:32.745 366 422 D RILU : ql_set_autosuspend off 06-26 14:34:32.745 366 422 D RILU : ----------------------------------------------3:3 06-26 14:34:32.745 366 422 D RILU : ----------------------------------------------3:1 06-26 14:34:32.745 366 422 D RILU : ----------------------------------------------3:3 06-26 14:34:32.745 366 422 D RILU : ----------------------------------------------3:1 06-26 14:34:32.745 366 422 D RILU : ----------------------------------------------3:3 06-26 14:34:32.745 366 422 D RILU : ----------------------------------------------3:1 06-26 14:34:32.745 366 422 D RILU : ----------------------------------------------3:3 06-26 14:34:32.745 366 422 D RILU : ----------------------------------------------4 06-26 14:34:32.745 366 422 D RILC : ASR Platform 06-26 14:34:32.745 366 422 D ATC : AT> AT+QGPSCFG="outport","usbnmea" 06-26 14:34:32.748 366 425 D ATC : AT< OK 06-26 14:34:32.749 366 428 D tty2tcp : swap_sources ( s:rild-nmea <> c:13 ) fifo_size=4096 06-26 14:34:32.749 366 428 D tty2tcp : create_socket_server( rild-nmea ) 06-26 14:34:32.749 366 428 D tty2tcp : local server: rild-nmea sockfd = 16 06-26 14:34:32.749 366 428 D tty2tcp : create_socket_server( serverfd=16 ) 06-26 14:34:32.749 366 428 D tty2tcp : rild_socket_add [1]=16 06-26 14:34:32.749 366 422 D ATC : AT> AT+CSUB;+CVERSION 06-26 14:34:32.750 366 430 D tty2tcp : open /dev/ttyUSB3 ttyfd = 17 06-26 14:34:32.750 366 430 D GPS : ql_gps_read_nmea open gps device /dev/ttyUSB3 successfully, fd = 17 06-26 14:34:32.751 366 425 D ATC : AT< SubEdition: V01 06-26 14:34:32.751 366 425 D ATC : AT< VERSION: EC200ACNGAR01A06M16 06-26 14:34:32.751 366 425 D ATC : AT< Dec 10 2024 09:59:56 06-26 14:34:32.751 366 425 D ATC : AT< Authors: QCT 06-26 14:34:32.751 366 425 D ATC : AT< OK 06-26 14:34:32.751 366 422 D ATC : AT> ATE0 06-26 14:34:32.751 366 425 D ATC : AT< OK 06-26 14:34:32.751 366 422 D ATC : AT> at+cmee=1 06-26 14:34:32.752 366 425 D ATC : AT< OK 06-26 14:34:32.752 366 422 D ATC : AT> ATS0=0 06-26 14:34:32.753 366 425 D ATC : AT< OK 06-26 14:34:32.753 366 430 D ATC : AT> AT+QGPSXTRA=1 06-26 14:34:32.754 366 425 D ATC : AT< ERROR 06-26 14:34:32.754 366 430 D ATC : AT> AT+QGPSXTRADATA? 06-26 14:34:32.754 366 425 D ATC : AT< ERROR 06-26 14:34:32.754 366 422 D ATC : AT> AT+QURCCFG="URCPORT","usbat" 06-26 14:34:32.755 366 430 D GPS : ql_xtradata_inject_time :0/0/0, 0:0:0 06-26 14:34:32.758 366 425 D ATC : AT< OK 06-26 14:34:32.758 366 422 D ATC : AT> AT&D2 06-26 14:34:32.759 366 425 D ATC : AT< OK 06-26 14:34:32.759 366 422 D ATC : AT> AT+CMEE=1 06-26 14:34:32.760 366 425 D ATC : AT< OK 06-26 14:34:32.760 366 422 D ATC : AT> AT+QCFG="ims",1 06-26 14:34:33.786 366 425 D ATC : AT< OK 06-26 14:34:33.786 366 422 D ATC : AT> AT+CREG=2 06-26 14:34:33.787 366 425 D ATC : AT< OK 06-26 14:34:33.787 366 422 D ATC : AT> AT+CREG=2 06-26 14:34:33.788 366 425 D ATC : AT< OK 06-26 14:34:33.788 366 422 D ATC : AT> AT+CGREG=2 06-26 14:34:33.789 366 425 D ATC : AT< OK 06-26 14:34:33.789 366 422 D ATC : AT> AT+CEREG=2 06-26 14:34:33.790 366 425 D ATC : AT< OK 06-26 14:34:33.790 366 422 D ATC : AT> AT+C5GREG=2 06-26 14:34:33.791 366 425 D ATC : AT< ERROR 06-26 14:34:33.791 366 422 D ATC : AT> AT+QENDC=1 06-26 14:34:33.791 366 425 D ATC : AT< ERROR 06-26 14:34:33.792 366 422 D ATC : AT> AT^DSCI=1 06-26 14:34:33.792 366 425 D ATC : AT< OK 06-26 14:34:33.792 366 422 D ATC : AT> AT+CFUN? 06-26 14:34:33.793 366 425 D ATC : AT< +CFUN: 1 06-26 14:34:33.793 366 425 D ATC : AT< OK 06-26 14:34:33.793 366 422 D ATC : AT> AT+CPIN? 06-26 14:34:33.794 366 425 D ATC : AT< +CME ERROR: 14 06-26 14:34:33.794 366 430 D ATC : AT> AT+QGPSXTRA=0 06-26 14:34:33.796 366 425 D ATC : AT< ERROR 06-26 14:34:34.794 366 422 D ATC : AT> AT+CFUN? 06-26 14:34:34.796 366 425 D ATC : AT< +CFUN: 1 06-26 14:34:34.796 366 425 D ATC : AT< OK 06-26 14:34:34.796 366 422 I RILC : [setRadioState]:oldState=1, newState=2 06-26 14:34:34.798 366 422 E RILC : radioStateChangedInd: radioService[0]->mRadioIndication == NULL 06-26 14:34:34.798 366 422 D ATC : AT> AT+CPIN? 06-26 14:34:34.798 366 425 D ATC : AT< +CME ERROR: 14 06-26 14:34:34.798 366 422 I RILC : [setRadioState]:oldState=2, newState=3 06-26 14:34:34.799 366 422 E RILC : radioStateChangedInd: radioService[0]->mRadioIndication == NULL 06-26 14:34:34.799 366 422 D ATC : AT> at+qcfg=nat 06-26 14:34:34.800 366 425 D ATC : AT< +QCFG: "nat",1 06-26 14:34:34.800 366 425 D ATC : AT< OK 06-26 14:34:34.800 366 422 D ATC : AT> AT+QCFG="speed" 06-26 14:34:34.801 366 425 D ATC : AT< +CME ERROR: 4 06-26 14:34:34.801 366 422 D ATC : AT> AT+QNWCFG="lte_pco",2 06-26 14:34:34.802 366 425 D ATC : AT< +CME ERROR: 50 06-26 14:34:34.802 366 422 D ATC : AT> AT+QIMSCFG="ims_status" 06-26 14:34:34.802 366 425 D ATC : AT< ERROR 06-26 14:34:34.802 366 422 D SIGNAL_STRENGTH: requestSignalStrength:816 iradio_version = 4 06-26 14:34:34.803 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:34:34.804 366 425 D ATC : AT< +COPS: 0 06-26 14:34:34.804 366 425 D ATC : AT< +COPS: 0 06-26 14:34:34.804 366 425 D ATC : AT< OK 06-26 14:34:34.804 366 422 D ATC : AT> AT+QENG="servingcell" 06-26 14:34:34.805 366 425 D ATC : AT< +QENG: "servingcell","SEARCH" 06-26 14:34:34.805 366 425 D ATC : AT< OK 06-26 14:34:34.805 366 422 D CELL_INFO: parseServingCell_234G:699 Enter... 06-26 14:34:34.805 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:34:34.806 366 425 D ATC : AT< +COPS: 0 06-26 14:34:34.806 366 425 D ATC : AT< +COPS: 0 06-26 14:34:34.806 366 425 D ATC : AT< OK 06-26 14:34:34.806 366 422 D CELL_INFO: parseServingCell_234G:802 *count = 0 06-26 14:34:34.806 366 422 E RILC : currentSignalStrengthInd: radioService[0]->mRadioIndication == NULL 06-26 14:34:35.360 366 425 D ATC : AT< +CPIN: READY 06-26 14:34:35.360 366 425 D ATC : AT< +QUSIM: 1 06-26 14:34:35.360 366 422 D ATC : AT> AT+CPIN? 06-26 14:34:35.360 366 425 D ATC : AT< +CREG: 2 06-26 14:34:35.360 366 425 D RILC : RIL_UNSOL_RESPONSE_VOICE_NETWORK_STATE_CHANGED wait sim ready 06-26 14:34:35.361 366 425 D ATC : AT< +CPIN: READY 06-26 14:34:35.361 366 425 D ATC : AT< OK 06-26 14:34:35.361 366 422 I RILC : [setRadioState]:oldState=3, newState=4 06-26 14:34:35.362 366 422 E RILC : radioStateChangedInd: radioService[0]->mRadioIndication == NULL 06-26 14:34:35.362 366 422 D ATC : AT> AT+QNVFR="/nv/item_files/modem/mmode/ue_usage_setting" 06-26 14:34:35.363 366 425 D ATC : AT< ERROR 06-26 14:34:35.363 366 422 D RILC : ue_function check failed no need to set 06-26 14:34:35.363 366 422 D ATC : AT> AT+QINISTAT 06-26 14:34:35.364 366 425 D ATC : AT< +QINISTAT: 1 06-26 14:34:35.364 366 425 D ATC : AT< OK 06-26 14:34:35.364 366 422 D ATC : AT> AT+CSMS=1 06-26 14:34:35.365 366 425 D ATC : AT< +CSMS: 1,1,1 06-26 14:34:35.365 366 425 D ATC : AT< OK 06-26 14:34:35.365 366 422 D ATC : AT> AT+CNMI=2,2 06-26 14:34:35.367 366 425 D ATC : AT< OK 06-26 14:34:35.367 366 422 D ATC : AT> AT+CMGF=0 06-26 14:34:35.368 366 425 D ATC : AT< OK 06-26 14:34:35.368 366 422 D ATC : AT> AT+CCWA=1 06-26 14:34:35.416 366 425 D ATC : AT< OK 06-26 14:34:35.417 366 422 D ATC : AT> AT+CMOD=0 06-26 14:34:35.417 366 425 D ATC : AT< OK 06-26 14:34:35.418 366 422 D ATC : AT> AT+CMUT=0 06-26 14:34:35.418 366 425 D ATC : AT< +CME ERROR: 903 06-26 14:34:35.418 366 422 D ATC : AT> AT+CSSN=0,1 06-26 14:34:35.419 366 425 D ATC : AT< OK 06-26 14:34:35.419 366 422 D ATC : AT> AT+COLP=0 06-26 14:34:35.420 366 425 D ATC : AT< OK 06-26 14:34:35.420 366 422 D ATC : AT> AT+CSCS="UCS2" 06-26 14:34:35.421 366 425 D ATC : AT< OK 06-26 14:34:35.421 366 422 D ATC : AT> AT+CUSD=1 06-26 14:34:35.422 366 425 D ATC : AT< OK 06-26 14:34:35.422 366 422 D ATC : AT> AT+CGEREP=0 06-26 14:34:35.423 366 425 D ATC : AT< OK 06-26 14:34:35.423 366 422 D ATC : AT> AT+CGEREP=0 06-26 14:34:35.424 366 425 D ATC : AT< OK 06-26 14:34:35.424 366 422 D ATC : AT> AT+CTZU=1 06-26 14:34:35.425 366 425 D ATC : AT< OK 06-26 14:34:35.425 366 422 D ATC : AT> AT+CTZR=2 06-26 14:34:35.427 366 425 D ATC : AT< OK 06-26 14:34:35.427 366 422 E RILC : simStatusChangedInd: radioService[0]->mRadioIndication == NULL 06-26 14:34:35.427 366 422 D RILC : RIL_UNSOL_RESPONSE_SIM_STATUS_CHANGED pending 06-26 14:34:35.427 366 422 D ATC : AT> AT+CPIN? 06-26 14:34:35.428 366 425 D ATC : AT< +CPIN: READY 06-26 14:34:35.428 366 425 D ATC : AT< OK 06-26 14:34:35.428 366 422 I RILC : [setRadioState]:oldState=4, newState=4 06-26 14:34:36.124 366 425 D ATC : AT< +CREG: 0 06-26 14:34:36.124 366 425 D RILC : RIL_UNSOL_RESPONSE_VOICE_NETWORK_STATE_CHANGED wait sim ready 06-26 14:34:36.752 366 425 D ATC : AT< +QGPS: "firmware",0,0 06-26 14:34:36.983 366 425 D ATC : AT< +CEREG: 1,"F40B","8F46F4F",7 06-26 14:34:36.983 366 425 D RILC : RIL_UNSOL_RESPONSE_VOICE_NETWORK_STATE_CHANGED wait sim ready 06-26 14:34:36.983 366 425 D ATC : AT< +CGREG: 1,"F40B","8F46F4F",7 06-26 14:34:36.983 366 425 D RILC : RIL_UNSOL_RESPONSE_VOICE_NETWORK_STATE_CHANGED wait sim ready 06-26 14:34:36.983 366 425 D ATC : AT< +CREG: 1,"F40B","8F46F4F",7 06-26 14:34:36.983 366 425 D RILC : RIL_UNSOL_RESPONSE_VOICE_NETWORK_STATE_CHANGED wait sim ready 06-26 14:34:37.051 366 425 D ATC : AT< +CTZE: "+32",0,"2026/06/26,06:34:38" 06-26 14:34:39.456 257 257 D TelephonyManager: No /proc/cmdline exception=java.io.FileNotFoundException: /proc/cmdline: open failed: EACCES (Permission denied) 06-26 14:34:39.456 257 257 D TelephonyManager: /proc/cmdline= 06-26 14:34:40.053 366 422 D ATC : AT> AT+QLTS=1 06-26 14:34:40.055 366 425 D ATC : AT< +QLTS: "2026/06/26,06:34:41+32,0" 06-26 14:34:40.055 366 425 D ATC : AT< OK 06-26 14:34:40.056 366 422 E RILC : nitzTimeReceivedInd: radioService[0]->mRadioIndication == NULL 06-26 14:34:40.479 434 434 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:40.599 434 515 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:40.643 434 434 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:40.658 366 428 D tty2tcp : sa_family = 1 06-26 14:34:40.658 366 428 D tty2tcp : clientfd = 18 sun_path: connect 06-26 14:34:40.658 366 428 D tty2tcp : wait_client_connect( clientfd=18 ) 06-26 14:34:40.658 366 428 D tty2tcp : rild_socket_delete [1]=16 06-26 14:34:40.658 366 428 D tty2tcp : is_tcp_socket 06-26 14:34:40.658 366 428 D tty2tcp : swap_fds fds={18, 16} fifo_sizes={4096, 4096} 06-26 14:34:40.658 366 428 D tty2tcp : swap_fds read={0x75afe657a0, 0x75afe657a0} write={0x75afe657c0, 0x75afe657c0} 06-26 14:34:40.661 366 429 D GPS : ql_gps_receive_cmd_from_gps_hal = {type=0, length=0} 06-26 14:34:40.661 366 427 D GPS : onGPSStateChange = {type=0, length=0} 06-26 14:34:40.661 366 427 D GPS : onGPSStateChange = CMD_QUIT 06-26 14:34:40.661 366 427 D ATC : AT> AT+QGPS? 06-26 14:34:40.662 366 425 D ATC : AT< +QGPS: 1 06-26 14:34:40.662 366 425 D ATC : AT< OK 06-26 14:34:40.662 366 427 D ATC : AT> AT+QGPSEND 06-26 14:34:40.663 366 425 D ATC : AT< OK 06-26 14:34:40.765 434 434 D TelephonyRegistry: systemRunning register for intents 06-26 14:34:40.862 434 448 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:41.040 434 459 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:41.953 848 848 D TelephonyComponentFactory: validated paths: null 06-26 14:34:41.953 848 848 D TelephonyComponentFactory: Total components injected: 0 06-26 14:34:41.954 848 848 D TDC : updateOrInsert: inserting: Modem { uuid=modem, state=0, rilModel=0, rat={}, maxActiveVoiceCall=1, maxActiveDataCall=1, maxStandby=1 } 06-26 14:34:41.954 848 848 D TDC : updateOrInsert: inserting: Sim { uuid=sim, modemUuid=modem, state=0 } 06-26 14:34:41.972 848 848 E PersistAtomsStorage: cannot load/parse PersistAtoms 06-26 14:34:41.972 848 848 E PersistAtomsStorage: java.nio.file.NoSuchFileException: /data/user_de/0/com.android.phone/files/persist_atoms.pb 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at sun.nio.fs.UnixFileSystemProvider.newByteChannel(UnixFileSystemProvider.java:214) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at java.nio.file.Files.newByteChannel(Files.java:361) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at java.nio.file.Files.newByteChannel(Files.java:407) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at java.nio.file.Files.readAllBytes(Files.java:3152) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at com.android.internal.telephony.metrics.PersistAtomsStorage.loadAtomsFromFile(PersistAtomsStorage.java:132) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at com.android.internal.telephony.metrics.PersistAtomsStorage.(PersistAtomsStorage.java:60) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at com.android.internal.telephony.metrics.MetricsCollector.(MetricsCollector.java:88) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at com.android.internal.telephony.PhoneFactory.makeDefaultPhone(PhoneFactory.java:149) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at com.android.internal.telephony.PhoneFactory.makeDefaultPhones(PhoneFactory.java:105) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at com.android.phone.PhoneGlobals.onCreate(PhoneGlobals.java:346) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at com.android.phone.PhoneApp.onCreate(PhoneApp.java:39) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at android.app.Instrumentation.callApplicationOnCreate(Instrumentation.java:1192) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at android.app.ActivityThread.handleBindApplication(ActivityThread.java:6719) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at android.app.ActivityThread.access$1300(ActivityThread.java:237) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1913) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at android.os.Handler.dispatchMessage(Handler.java:106) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at android.os.Looper.loop(Looper.java:223) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at android.app.ActivityThread.main(ActivityThread.java:7664) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at java.lang.reflect.Method.invoke(Native Method) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:592) 06-26 14:34:41.972 848 848 E PersistAtomsStorage: at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:947) 06-26 14:34:41.972 848 848 D PersistAtomsStorage: created new PersistAtoms 06-26 14:34:41.977 848 848 D MetricsCollector: registered 06-26 14:34:41.979 848 848 D CdmaSSM : subscriptionSource from settings: 0 06-26 14:34:41.979 848 848 I PhoneFactory: Cdma Subscription set to 0 06-26 14:34:41.979 848 848 I PhoneFactory: Network Mode set to 9 06-26 14:34:41.980 848 848 D RILJ : RIL: init preferredNetworkType=9 cdmaSubscription=0) [PHONEnull] 06-26 14:34:42.000 366 366 D RILC : setResponseFunctions 06-26 14:34:42.002 366 366 D RILC : rilConnectedInd 06-26 14:34:42.002 366 366 D RILC : radioStateChangedInd: radioState 10 06-26 14:34:42.002 366 366 I RILC : RIL Daemon version: Quectel_Android_RIL_Driver_radio1.5_V3.9.4 06-26 14:34:42.006 848 969 D RILJ : [UNSL]< UNSOL_RIL_CONNECTED [PHONE0] 06-26 14:34:42.013 848 848 D RILJ : [0000]> GET_HARDWARE_CONFIG [PHONE0] 06-26 14:34:42.013 366 366 D RILC : onRequest: GET_HARDWARE_CONFIG 06-26 14:34:42.013 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:42.015 848 969 D RILJ : [0001]> RADIO_POWER on = true forEmergencyCall= false preferredForEmergencyCall=false [PHONE0] 06-26 14:34:42.016 434 434 D TelephonyRegistry: notifyCellLocationForSubscriber: subId=0 cellLocation=null 06-26 14:34:42.019 366 366 D RILC : setRadioPower: serial 1 on 1 06-26 14:34:42.019 366 366 D RILC : onRequest: RADIO_POWER datalen=4 06-26 14:34:42.019 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:42.019 366 366 D RADIO_POWRE: requestSetRadioPower:149 datalen = 4 06-26 14:34:42.019 366 366 E RADIO_POWRE: radio_power begin. 06-26 14:34:42.019 366 366 D RILC : setRadioPowerResponse: serial 1 06-26 14:34:42.019 366 366 E RADIO_POWRE: radio_power end. 06-26 14:34:42.021 848 848 D RILJ : Radio HAL version: 1.1 [PHONE0] 06-26 14:34:42.021 848 848 D UiccController: Creating UiccController 06-26 14:34:42.021 848 848 D UiccController: config_num_physical_slots = 1 06-26 14:34:42.024 848 969 D RILJ : [0002]> RIL_REQUEST_CDMA_SET_SUBSCRIPTION_SOURCE cdmaSubscription = 0 [PHONE0] 06-26 14:34:42.026 366 366 D RILC : onRequest: CDMA_SET_SUBSCRIPTION_SOURCE datalen=4 06-26 14:34:42.026 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:42.027 848 969 D RILJ : [0000]< GET_HARDWARE_CONFIG error 6 [PHONE0] 06-26 14:34:42.027 848 969 D RilRequest: [0000]< GET_HARDWARE_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= [Modem { uuid=www.quectel.com, state=0, rilModel=0, rat={0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30}, maxActiveVoiceCall=1, maxActiveDataCall=1, maxStandby=0 }] 06-26 14:34:42.028 848 969 D RILJ : [UNSL]< UNSOL_RESPONSE_RADIO_STATE_CHANGED radioStateChanged: 1 [PHONE0] 06-26 14:34:42.029 848 969 D RILJ : [0001]< RADIO_POWER [PHONE0] 06-26 14:34:42.030 848 969 D RILJ : [UNSL]< UNSOL_NITZ_TIME_RECEIVED 26/06/26,06:34:41+32,0 [PHONE0] 06-26 14:34:42.031 848 969 D RILJ : [0002]< RIL_REQUEST_CDMA_SET_SUBSCRIPTION_SOURCE [PHONE0] 06-26 14:34:42.094 848 848 I PhoneFactory: Creating SubscriptionController 06-26 14:34:42.118 848 872 D SubscriptionController: [getSlotIndex]- subId invalid 06-26 14:34:42.152 848 848 D SubscriptionController: [SubscriptionController] init by Context 06-26 14:34:42.157 848 848 I PhoneFactory: Creating Phone with type = 1 phoneId = 0 06-26 14:34:42.161 848 848 D TelephonyTester: register for intent action=com.android.internal.telephony.action_detached 06-26 14:34:42.162 848 848 D TelephonyTester: register for intent action=com.android.internal.telephony.action_attached 06-26 14:34:42.162 848 848 D TelephonyTester: register for intent action=com.android.internal.telephony.TestServiceState 06-26 14:34:42.162 848 848 D TelephonyTester: register for intent action=com.android.internal.telephony.TestChangeNumber 06-26 14:34:42.167 848 848 D Phone : mDoesRilSendMultipleCallRing=true 06-26 14:34:42.167 848 848 D Phone : mCallRingDelay=3000 06-26 14:34:42.184 848 848 D RILJ : [0003]> RIL_REQUEST_START_LCE reportIntervalMs = 200 pullMode = true [PHONE0] 06-26 14:34:42.185 366 366 D RILC : onRequest: START_LCE datalen=8 06-26 14:34:42.185 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:42.186 848 969 D RILJ : [0003]< RIL_REQUEST_START_LCE [255, 0] [PHONE0] 06-26 14:34:42.190 848 848 D SmsDispatchersController: SmsDispatchersController created 06-26 14:34:42.203 848 848 E ImsSmsDispatcher [0]: Failed to get sms format. Error: getSmsFormat() 06-26 14:34:42.203 848 848 D SMSDispatcher: SMSDispatcher: ctor mSmsCapable=true format=unknown mSmsSendDisabled=false 06-26 14:34:42.203 848 848 W FeatureConnector: [ImsSmsDispatcher, 0] connect: not supported. 06-26 14:34:42.206 848 848 D SMSDispatcher: SMSDispatcher: ctor mSmsCapable=true format=3gpp2 mSmsSendDisabled=false 06-26 14:34:42.206 848 848 D CdmaSMSDispatcher: CdmaSMSDispatcher created 06-26 14:34:42.239 848 848 D GsmInboundSmsHandler: created InboundSmsHandler 06-26 14:34:42.244 848 1004 D GsmInboundSmsHandler: StartupState.enter: entering StartupState 06-26 14:34:42.254 848 848 D CdmaInboundSmsHandler: created InboundSmsHandler 06-26 14:34:42.261 848 1016 D CdmaInboundSmsHandler: StartupState.enter: entering StartupState 06-26 14:34:42.269 848 848 D SMSDispatcher: SMSDispatcher: ctor mSmsCapable=true format=3gpp mSmsSendDisabled=false 06-26 14:34:42.271 848 848 D GsmSMSDispatcher: GsmSMSDispatcher created 06-26 14:34:42.288 848 1016 D CdmaInboundSmsHandler: StartupState.processMessage: processing EVENT_START_ACCEPTING_SMS 06-26 14:34:42.289 848 1004 D GsmInboundSmsHandler: StartupState.processMessage: processing EVENT_START_ACCEPTING_SMS 06-26 14:34:42.289 848 1016 D CdmaInboundSmsHandler: IdleState.enter: entering IdleState 06-26 14:34:42.289 848 1004 D GsmInboundSmsHandler: IdleState.enter: entering IdleState 06-26 14:34:42.289 848 1016 D CdmaInboundSmsHandler: IdleState.processMessage: processing EVENT_RELEASE_WAKELOCK 06-26 14:34:42.302 848 1004 D GsmInboundSmsHandler: IdleState.processMessage: processing EVENT_RELEASE_WAKELOCK 06-26 14:34:42.305 848 1004 D GsmInboundSmsHandler: IdleState.processMessage: EVENT_RELEASE_WAKELOCK: mWakeLock released 06-26 14:34:42.305 848 848 D CdmaSSM : subscriptionSource from settings: 0 06-26 14:34:42.306 848 848 D CdmaSSM : cdmaSSM constructor: 0 06-26 14:34:42.306 848 1016 D CdmaInboundSmsHandler: IdleState.processMessage: EVENT_RELEASE_WAKELOCK: mWakeLock released 06-26 14:34:42.311 848 848 D GsmCdmaPhone: [0] Precise phone type 1 06-26 14:34:42.311 848 848 D RILJ : setPhoneType=1 old value=0 [PHONE0] 06-26 14:34:42.321 848 848 D CarrierActionAgent: [0]Creating CarrierActionAgent 06-26 14:34:42.324 848 848 W CarrierConfigManager: Error getting config for subId -1 ICarrierConfigLoader is null 06-26 14:34:42.327 848 848 D TransportManager: operates in legacy mode. 06-26 14:34:42.338 848 848 W CarrierConfigManager: Error getting config for subId -1 ICarrierConfigLoader is null 06-26 14:34:42.340 434 809 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:42.347 848 848 D NRM-C-0 : registerForNetworkRegistrationInfoChanged 06-26 14:34:42.355 848 848 D NewNitzStateMachineImpl: handleNetworkUnavailable(): mLatestNitzSignal was already null. Nothing to do. 06-26 14:34:42.396 848 848 D RILJ : [0004]> SIGNAL_STRENGTH [PHONE0] 06-26 14:34:42.397 366 366 D RILC : onRequest: SIGNAL_STRENGTH 06-26 14:34:42.398 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:42.398 366 366 D SIGNAL_STRENGTH: requestSignalStrength:816 iradio_version = 4 06-26 14:34:42.398 366 366 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:34:42.399 848 848 D SST : [0] notifyVoiceRegStateRilRadioTechnologyChanged: vrs=1 rat=0 06-26 14:34:42.400 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:34:42.401 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:34:42.401 366 425 D ATC : AT< OK 06-26 14:34:42.401 366 366 D ATC : AT> AT+QENG="servingcell" 06-26 14:34:42.403 366 425 D ATC : AT< +QENG: "servingcell","NOCONN","LTE","FDD",460,01,8F46F4F,300,1800,3,5,5,F40B,-92,-11,-61,8,31 06-26 14:34:42.403 366 425 D ATC : AT< OK 06-26 14:34:42.403 366 366 D CELL_INFO: parseServingCell_234G:699 Enter... 06-26 14:34:42.403 366 366 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:34:42.405 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:34:42.405 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:34:42.405 366 425 D ATC : AT< OK 06-26 14:34:42.405 366 366 D CELL_INFO: parseServingCell_234G:767 LTE RSRP=-92 06-26 14:34:42.405 366 366 D CELL_INFO: parseServingCell_234G:802 *count = 1 06-26 14:34:42.405 366 366 D ATC : AT> AT+CSQ 06-26 14:34:42.406 434 809 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:42.406 366 425 D ATC : AT< +CSQ: 27,99 06-26 14:34:42.406 366 425 D ATC : AT< OK 06-26 14:34:42.407 366 366 D RADIO_1_4: getSignalStrength_1_4:588 LTE RSRP = 92 RSRQ = 11 06-26 14:34:42.407 366 366 D RILC : isNetworkInNrEndc 772 Enter: 0 06-26 14:34:42.407 366 366 D RILC : isNetworkInNrEndc 799 End, is_NR_ENDC:0 06-26 14:34:42.407 366 366 E RILC : getSignalStrengthResponse: Invalid response 06-26 14:34:42.411 848 848 W CarrierConfigManager: Error getting config for subId -1 ICarrierConfigLoader is null 06-26 14:34:42.415 848 969 D RILJ : [0004]< SIGNAL_STRENGTH error 66 [PHONE0] 06-26 14:34:42.415 848 969 D RilRequest: [0004]< SIGNAL_STRENGTH error: com.android.internal.telephony.CommandException: INVALID_RESPONSE ret=SignalStrength:{mCdma=CellSignalStrengthCdma: cdmaDbm=0 cdmaEcio=0 evdoDbm=0 evdoEcio=0 evdoSnr=0 level=4,mGsm=CellSignalStrengthGsm: rssi=-113 ber=0 mTa=0 mLevel=0,mWcdma=CellSignalStrengthWcdma: ss=2147483647 ber=2147483647 rscp=2147483647 ecno=2147483647 level=0,mTdscdma=CellSignalStrengthTdscdma: rssi=2147483647 ber=2147483647 rscp=2147483647 level=0,mLte=CellSignalStrengthLte: rssi=-113 rsrp=2147483647 rsrq=0 rssnr=0 cqi=0 ta=0 level=1 parametersUseForLevel=1,mNr=CellSignalStrengthNr:{ csiRsrp = 2147483647 csiRsrq = 2147483647 csiSinr = 2147483647 ssRsrp = 2147483647 ssRsrq = 2147483647 ssSinr = 2147483647 level = 0 parametersUseForLevel = 1 },primary=CellSignalStrengthLte} 06-26 14:34:42.479 848 848 D EmergencyNumberTracker: asset emergency database is loaded. Ver: 1 Phone Id: 0 06-26 14:34:42.480 848 848 E EmergencyNumberTracker: Cache ota emergency database IOException: java.io.FileNotFoundException: /data/misc/emergencynumberdb/emergency_number_db: open failed: ENOENT (No such file or directory) 06-26 14:34:42.480 848 848 D EmergencyNumberTracker: Using Asset Emergency database. Version: 1 06-26 14:34:42.481 434 809 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:42.500 848 848 D SubscriptionController: Valid row not present in db 06-26 14:34:42.502 848 848 D SubscriptionController: getSubscriptionProperty Query value = null 06-26 14:34:42.507 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:42.550 848 848 D m.android.phon: DCT.constructor 06-26 14:34:42.562 848 848 D Dcc-C-0 : E ctor 06-26 14:34:42.562 848 848 D Dcc-C-0 : X ctor 06-26 14:34:42.562 848 848 D DcTesterDeacativateAll: register for intent action=com.android.internal.telephony.dataconnection.action_deactivate_all 06-26 14:34:42.562 848 848 D DcTesterDeacativateAll: register for intent action=com.android.internal.telephony.action_detached 06-26 14:34:42.571 848 848 D DcTesterFailBrinupAll: register for intent action=com.android.internal.telephony.dataconnection.action_fail_bringup 06-26 14:34:42.571 848 848 D DcTesterFailBrinupAll: register for intent action=com.android.internal.telephony.action_detached 06-26 14:34:42.571 848 848 D DcTesterFailBrinupAll: register for intent action=com.android.internal.telephony.action_attached 06-26 14:34:42.576 848 1051 D Dcc-C-0 : DccDefaultState: msg.what=EVENT_RIL_CONNECTED mRilVersion=15 06-26 14:34:42.577 848 848 W CarrierConfigManager: Error getting config for subId -1 ICarrierConfigLoader is null 06-26 14:34:42.578 848 848 D DCT-C-0 : initApnContexts: E 06-26 14:34:42.579 848 848 W ApnConfigTypeRepository: carrier config is null 06-26 14:34:42.579 848 848 D DCT-C-0 : initApnContexts: apnContext=hipri 06-26 14:34:42.580 848 848 D DCT-C-0 : initApnContexts: apnContext=fota 06-26 14:34:42.580 848 848 D DCT-C-0 : initApnContexts: apnContext=ims 06-26 14:34:42.580 848 848 D DCT-C-0 : initApnContexts: apnContext=cbs 06-26 14:34:42.580 848 848 D DCT-C-0 : initApnContexts: apnContext=ia 06-26 14:34:42.580 848 848 D DCT-C-0 : initApnContexts: apnContext=emergency 06-26 14:34:42.580 848 848 D DCT-C-0 : initApnContexts: apnContext=mcx 06-26 14:34:42.580 848 848 D DCT-C-0 : initApnContexts: apnContext=xcap 06-26 14:34:42.580 848 848 D DCT-C-0 : initApnContexts: apnContext=default 06-26 14:34:42.580 848 848 D DCT-C-0 : initApnContexts: apnContext=mms 06-26 14:34:42.581 848 848 D DCT-C-0 : initApnContexts: apnContext=supl 06-26 14:34:42.582 848 848 D DCT-C-0 : initApnContexts: apnContext=dun 06-26 14:34:42.612 848 848 D DCT-C-0 : Adding emergency APN : [ApnSettingV7] Emergency, 0, null, sos, null, null, null, null, null, 0, emergency, IPV4V6, IPV4V6, false, 0, false, 0, 0, 0, 0, null, null, false, 135168, -1, -1, -1 06-26 14:34:42.616 848 848 D CarrierResolver: Creating CarrierResolver[0] 06-26 14:34:42.619 848 848 D SST : [0] notifyVoiceRegStateRilRadioTechnologyChanged: vrs=1 rat=0 06-26 14:34:42.625 848 848 I GsmCdmaPhone: [0] updateTtyMode ttyMode=0 06-26 14:34:42.632 848 848 D RILJ : [0005]> RIL_REQUEST_SET_TTY_MODE ttyMode = 0 [PHONE0] 06-26 14:34:42.632 366 366 D RILC : onRequest: SET_TTY_MODE datalen=4 06-26 14:34:42.632 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:42.633 848 969 D RILJ : [0005]< RIL_REQUEST_SET_TTY_MODE [PHONE0] 06-26 14:34:42.636 848 848 I GsmCdmaPhone: [0] updateUiTtyMode ttyMode=0 06-26 14:34:42.637 848 848 D CallManager: registerPhone(GSM Handler (com.android.internal.telephony.GsmCdmaPhone) {8d58632}) 06-26 14:34:42.639 848 848 D GsmCdmaPhone: [0] GsmCdmaPhone: constructor: sub = 0 06-26 14:34:42.677 848 848 I PhoneFactory: defaultSmsApplication: com.android.messaging 06-26 14:34:42.684 848 848 I PhoneFactory: Creating SubInfoRecordUpdater 06-26 14:34:42.685 848 848 D SubscriptionInfoUpdater: Constructor invoked 06-26 14:34:42.688 587 587 W CarrierConfigManager: Error getting config for subId -1 ICarrierConfigLoader is null 06-26 14:34:42.705 848 848 I PhoneFactory: IMS is not supported on this device, skipping ImsResolver. 06-26 14:34:42.708 434 968 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:42.712 848 848 D PhoneSwitcher: PhoneSwitcher started 06-26 14:34:42.714 848 848 D ProxyController: Constructor - Enter 06-26 14:34:42.717 848 848 D ProxyController: clearTransaction 06-26 14:34:42.717 848 848 D ProxyController: clearTransaction: phoneId=0 status=IDLE 06-26 14:34:42.717 848 848 D ProxyController: Constructor - Exit 06-26 14:34:42.724 434 968 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:42.732 848 848 D m.android.phon: hans set 4G score 50 06-26 14:34:42.733 434 809 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:42.734 848 848 D TelephonyNetworkFactory[0]: Registering NetworkFactory 06-26 14:34:42.759 434 809 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:42.760 848 848 D CallManager: registerForMmiComplete 06-26 14:34:42.763 848 848 D NewNitzStateMachineImpl: handleAirplaneModeChanged(false): mLatestNitzSignal was already null. Nothing to do. 06-26 14:34:42.772 434 809 D TelephonyRegistry: listen oscl: mHasNotifySubscriptionInfoChangedOccurred==false no callback 06-26 14:34:42.779 848 848 D UiccController: handleMessage: Received RADIO_AVAILABLE for phoneId 0 06-26 14:34:42.780 848 848 D UiccController: Received EVENT_RADIO_AVAILABLE/EVENT_RADIO_ON, calling getIccCardStatus 06-26 14:34:42.783 848 848 D RILJ : [0006]> GET_SIM_STATUS [PHONE0] 06-26 14:34:42.783 848 848 D UiccController: Received EVENT_RADIO_AVAILABLE/EVENT_RADIO_ON for phoneId 0, calling getIccSlotsStatus 06-26 14:34:42.783 366 366 D RILC : onRequest: GET_SIM_STATUS 06-26 14:34:42.783 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:42.783 366 366 D SIM : requestGetIccCardStatus() start 06-26 14:34:42.784 366 366 D ATC : AT> AT+CPIN? 06-26 14:34:42.784 366 425 D ATC : AT< +CPIN: READY 06-26 14:34:42.785 366 425 D ATC : AT< OK 06-26 14:34:42.785 366 366 D RILC : ql_getPinDisabled : 0 06-26 14:34:42.785 366 366 D ATC : AT> AT+QSIMCFG="app_type" 06-26 14:34:43.840 848 1058 D SubscriptionController: [getSlotIndex]- subId invalid 06-26 14:34:45.245 366 425 D ATC : AT< +QSIMCFG: "app_type",3 06-26 14:34:45.245 366 425 D ATC : AT< OK 06-26 14:34:45.245 366 366 D ATC : AT> AT+CFUN? 06-26 14:34:45.246 366 425 D ATC : AT< +CFUN: 1 06-26 14:34:45.246 366 425 D ATC : AT< OK 06-26 14:34:45.246 366 366 D SIM : ql_get_sim_state:203 app_state = 5 06-26 14:34:45.246 366 366 D SIM : ql_get_sim_state:221 06-26 14:34:45.246 366 366 D SIM : ql_get_atr start 06-26 14:34:45.246 366 366 D ATC : AT> AT+QSIMCFG="ATR" 06-26 14:34:45.277 366 425 D ATC : AT< +QCFG: "ims",1,1 06-26 14:34:45.278 366 425 D ATC : AT< OK 06-26 14:34:45.278 366 366 D ATC : AT> AT+CRSM=176,12258,0,0,10 06-26 14:34:45.290 366 425 D ATC : AT< +QSIMCFG: "atr","3B9F94801FC78031E073FE21135758485553494D01F9" 06-26 14:34:45.290 366 425 D ATC : AT< OK 06-26 14:34:45.290 366 425 D ATC : AT< +CRSM: 144,0,"98681061380484081769" 06-26 14:34:45.290 366 366 D SIM : ql_get_eid start 06-26 14:34:45.290 366 425 D ATC : AT< OK 06-26 14:34:45.290 366 366 D ATC : AT> AT+QSIMCFG="EID" 06-26 14:34:45.290 366 366 D ATC : AT> AT+QESIM="EID" 06-26 14:34:45.446 366 425 D ATC : AT< +CME ERROR: 0 06-26 14:34:45.446 366 425 D ATC : AT< OK 06-26 14:34:45.446 366 366 D RADIO_1_4: getIccCardStatus_1_4:673 cdma_subscription_app_index = -1 06-26 14:34:45.446 366 366 D RADIO_1_4: getIccCardStatus_1_4:674 gsm_umts_subscription_app_index = 0 06-26 14:34:45.446 366 366 D RADIO_1_4: getIccCardStatus_1_4:675 ims_subscription_app_index = -1 06-26 14:34:45.446 366 366 D RADIO_1_4: getIccCardStatus_1_4:676 num_applications = 1 06-26 14:34:45.447 366 366 E RILC : getIccCardStatusResponse: Invalid response 06-26 14:34:45.448 366 366 D RILC : ql_getPinDisabled : 0 06-26 14:34:45.449 848 969 D RILJ : responseIccCardStatus: from HIDL: IccCardState {CARDSTATE_ABSENT,PINSTATE_UNKNOWN,num_apps=0,gsm_id=-1,cdma_id=-1,ims_id=-1,physical_slot_id=-1,atr=null,iccid=null,eid=null} [PHONE0] 06-26 14:34:45.450 848 969 D RILJ : [0006]< GET_SIM_STATUS error 66 [PHONE0] 06-26 14:34:45.450 848 969 D RilRequest: [0006]< GET_SIM_STATUS error: com.android.internal.telephony.CommandException: INVALID_RESPONSE ret=IccCardState {CARDSTATE_ABSENT,PINSTATE_UNKNOWN,num_apps=0,gsm_id=-1,cdma_id=-1,ims_id=-1,physical_slot_id=-1,atr=null,iccid=null,eid=null} 06-26 14:34:45.451 366 425 D ATC : AT< +QIND: SMS DONE 06-26 14:34:45.451 366 425 D ATC : AT< +QIND: PB DONE 06-26 14:34:45.451 366 422 D ATC : AT> AT+CPIN? 06-26 14:34:45.451 366 425 E RILC : RDY !!! 06-26 14:34:45.452 366 425 D ATC : AT< +CPIN: READY 06-26 14:34:45.452 366 425 D ATC : AT< OK 06-26 14:34:45.452 366 422 I RILC : [setRadioState]:oldState=4, newState=4 06-26 14:34:45.452 366 422 D ATC : AT> AT+QINISTAT 06-26 14:34:45.456 366 425 D ATC : AT< +QINISTAT: 7 06-26 14:34:45.456 366 425 D ATC : AT< OK 06-26 14:34:45.456 366 422 D ATC : AT> AT+CSMS=1 06-26 14:34:45.457 366 366 D RadioConfigImpl: setResponseFunctions start 06-26 14:34:45.457 366 366 D RadioConfigImpl: radioConfigResponse: . radioConfigIndication: 06-26 14:34:45.457 848 848 D RadioConfig: [0007]> GET_SLOT_STATUS 06-26 14:34:45.459 366 425 D ATC : AT< +CSMS: 1,1,1 06-26 14:34:45.459 366 425 D ATC : AT< OK 06-26 14:34:45.459 366 422 D ATC : AT> AT+CNMI=2,2 06-26 14:34:45.460 366 366 D RadioConfigImpl: getSimSlotsStatus 06-26 14:34:45.463 366 425 D ATC : AT< OK 06-26 14:34:45.463 366 422 D ATC : AT> AT+CMGF=0 06-26 14:34:45.465 366 425 D ATC : AT< OK 06-26 14:34:45.466 366 422 D ATC : AT> AT+CPIN? 06-26 14:34:45.467 366 425 D ATC : AT< +CPIN: READY 06-26 14:34:45.467 366 425 D ATC : AT< OK 06-26 14:34:45.467 366 422 I RILC : [setRadioState]:oldState=4, newState=4 06-26 14:34:45.467 366 366 D ATC : AT> AT+CPIN? 06-26 14:34:45.468 366 425 D ATC : AT< +CPIN: READY 06-26 14:34:45.468 366 425 D ATC : AT< OK 06-26 14:34:45.468 366 366 D ATC : AT> AT+CRSM=176,12258,0,0,10 06-26 14:34:45.469 366 425 D ATC : AT< +CRSM: 144,0,"98681061380484081769" 06-26 14:34:45.469 366 425 D ATC : AT< OK 06-26 14:34:45.469 366 366 D SIM : ql_get_atr start 06-26 14:34:45.469 366 366 D ATC : AT> AT+QSIMCFG="ATR" 06-26 14:34:45.470 366 425 D ATC : AT< +QSIMCFG: "atr","3B9F94801FC78031E073FE21135758485553494D01F9" 06-26 14:34:45.470 366 425 D ATC : AT< OK 06-26 14:34:45.471 366 366 D SIM : ql_get_atr:188 atr = 3B9F94801FC78031E073FE21135758485553494D01F9 06-26 14:34:45.473 848 969 D RadioConfigResponse: [0007]< GET_SLOT_STATUS [IccSlotStatus {CARDSTATE_PRESENT,SLOTSTATE_ACTIVE,logicalSlotIndex=0,atr=3B9F94801FC78031E073FE21135758485553494D01F9,iccid=89860116834048807196,eid=null}] 06-26 14:34:45.483 366 425 D ATC : AT< +QESIM: EID,FAIL 06-26 14:34:45.953 848 848 D RILJ : [0008]> GET_CURRENT_CALLS [PHONE0] 06-26 14:34:45.953 366 366 D RILC : onRequest: GET_CURRENT_CALLS 06-26 14:34:45.953 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:45.953 366 366 D RILC : requestGetCurrentCalls start 06-26 14:34:45.953 366 366 D RILC : getCurrentCalls start 06-26 14:34:45.953 366 366 D ATC : AT> AT+QCFG="ip_caller_name" 06-26 14:34:45.953 848 848 D GsmSMSDispatcher: GsmSMSDispatcher: subId = -1 slotId = 0 06-26 14:34:45.955 366 425 D ATC : AT< +CME ERROR: 4 06-26 14:34:45.955 366 366 D RILC : getCallerId send AT+QCFG="ip_caller_name" error 06-26 14:34:45.955 366 366 D ATC : AT> AT+CLCC 06-26 14:34:45.957 848 848 D RILJ : [0009]> RIL_REQUEST_IMS_REGISTRATION_STATE [PHONE0] 06-26 14:34:45.974 366 425 D ATC : AT< OK 06-26 14:34:45.975 366 366 I RILC : Calls=0,Valid=0 06-26 14:34:45.975 366 366 D RILC : getCurrentCalls end 06-26 14:34:45.975 366 366 D RILC : requestGetCurrentCalls ql_mo_call_wait_for_no_carrier = 0 06-26 14:34:45.975 366 366 D ATC : AT> AT+QSPCH 06-26 14:34:45.976 366 425 D ATC : AT< ERROR 06-26 14:34:45.976 366 366 D RILC : ql_destroy_ril_call start 06-26 14:34:45.977 366 366 D RILC : ql_destroy_ril_call end 06-26 14:34:45.977 366 366 D RILC : requestGetCurrentCalls end 06-26 14:34:45.977 366 366 D RILC : onRequest: IMS_REGISTRATION_STATE 06-26 14:34:45.977 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:45.977 366 366 D ATC : AT> AT+QCFG="ims" 06-26 14:34:45.977 848 969 D RILJ : [0008]< GET_CURRENT_CALLS {} [PHONE0] 06-26 14:34:45.984 848 848 D RILJ : [0010]> BASEBAND_VERSION [PHONE0] 06-26 14:34:45.988 848 848 D RILJ : [0011]> RIL_REQUEST_DEVICE_IDENTITY [PHONE0] 06-26 14:34:45.993 848 848 D RILJ : [0012]> RIL_REQUEST_GET_RADIO_CAPABILITY [PHONE0] 06-26 14:34:45.997 848 848 D RILJ : [0013]> RIL_REQUEST_START_LCE reportIntervalMs = 200 pullMode = true [PHONE0] 06-26 14:34:45.997 848 848 D GsmCdmaPhone: [0] Event EVENT_RADIO_ON Received 06-26 14:34:46.004 848 848 D RILJ : [0014]> RIL_REQUEST_VOICE_RADIO_TECH [PHONE0] 06-26 14:34:46.005 848 848 D GsmCdmaPhone: [0] EVENT EVENT_RADIO_STATE_CHANGED 06-26 14:34:46.005 848 848 D GsmCdmaPhone: handleRadioPowerStateChange, state= 1 06-26 14:34:46.010 366 425 D ATC : AT< +QCFG: "ims",1,1 06-26 14:34:46.010 366 425 D ATC : AT< OK 06-26 14:34:46.010 366 366 D RILC : ImsRegistrationState = 1,1 06-26 14:34:46.010 366 366 D RILC : ImsRegistrationState = 1,1 06-26 14:34:46.010 366 366 D RILC : onRequest: BASEBAND_VERSION 06-26 14:34:46.010 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.010 366 366 D ATC : AT> AT+CGMR 06-26 14:34:46.011 848 969 D RILJ : [0009]< RIL_REQUEST_IMS_REGISTRATION_STATE {1, 1} [PHONE0] 06-26 14:34:46.012 366 425 D ATC : AT< EC200ACNGAR01A06M16 06-26 14:34:46.012 366 425 D ATC : AT< OK 06-26 14:34:46.012 366 366 D RILC : onRequest: DEVICE_IDENTITY 06-26 14:34:46.012 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.012 366 366 E RILC : requestDeviceIdentity begin. 06-26 14:34:46.012 366 366 D ATC : AT> AT+CGSN 06-26 14:34:46.013 848 969 D RILJ : [0010]< BASEBAND_VERSION EC200ACNGAR01A06M16 [PHONE0] 06-26 14:34:46.014 366 425 D ATC : AT< 865965089012569 06-26 14:34:46.014 366 425 D ATC : AT< OK 06-26 14:34:46.014 366 366 D ATC : AT> AT+QSVN? 06-26 14:34:46.016 848 848 D RILJ : [0015]> RIL_REQUEST_CDMA_GET_SUBSCRIPTION_SOURCE [PHONE0] 06-26 14:34:46.017 848 848 D SST : [0] received event 42 06-26 14:34:46.017 848 848 D SST : [0] EVENT_ICC_CHANGED: SIM absent 06-26 14:34:46.017 848 848 D SST : [0] cancelAllNotifications: mPrevSubId=-1 06-26 14:34:46.018 366 425 D ATC : AT< +QSVN: "06" 06-26 14:34:46.018 366 425 D ATC : AT< OK 06-26 14:34:46.018 366 366 D ATC : AT> AT^MEID 06-26 14:34:46.019 848 848 D SST : [0] updateSpnDisplayLegacy+ 06-26 14:34:46.019 366 425 D ATC : AT< ERROR 06-26 14:34:46.020 366 366 E RILC : error for AT^MEID try egmr 06-26 14:34:46.020 366 366 D ATC : AT> AT+EGMR=0,8 06-26 14:34:46.021 366 425 D ATC : AT< ERROR 06-26 14:34:46.021 366 366 D RILC : not support meid and egmr 06-26 14:34:46.021 366 366 D RILC : onRequest: GET_RADIO_CAPABILITY 06-26 14:34:46.021 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.021 366 366 D ATC : AT> AT+CMGL 06-26 14:34:46.023 848 969 D RILJ : [0011]< RIL_REQUEST_DEVICE_IDENTITY {[-ksbj5Yzktb8MofzfZFFetTsR9s], 06, , } [PHONE0] 06-26 14:34:46.025 848 969 D RILJ : convertHalRadioCapability: session=0, phase=0, rat=916479, logicModemUuid=0, status=1, rcRil.raf=1835006 [PHONE0] 06-26 14:34:46.026 366 425 D ATC : AT< OK 06-26 14:34:46.026 366 366 D RILC : onRequest: START_LCE datalen=8 06-26 14:34:46.026 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.026 366 366 D RILC : onRequest: VOICE_RADIO_TECH 06-26 14:34:46.027 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.027 366 366 D REGISTRATION_STATE: try to get data registration state 06-26 14:34:46.027 366 366 D ATC : AT> AT+C5GREG? 06-26 14:34:46.030 366 425 D ATC : AT< ERROR 06-26 14:34:46.030 366 366 D ATC : AT> AT+CEREG? 06-26 14:34:46.030 848 969 D RILJ : [0012]< RIL_REQUEST_GET_RADIO_CAPABILITY {mPhoneId = 0 mVersion=1 mSession=0 mPhase=0 mRadioAccessFamily=916479 mLogicModemId=0 mStatus=1} [PHONE0] 06-26 14:34:46.031 848 969 D RILJ : [0013]< RIL_REQUEST_START_LCE [255, 0] [PHONE0] 06-26 14:34:46.031 366 425 D ATC : AT< +CEREG: 2,1,"F40B","8F46F4F",7 06-26 14:34:46.031 366 425 D ATC : AT< OK 06-26 14:34:46.031 366 366 D REGISTRATION_STATE: ql_pase_reg_line:52 06-26 14:34:46.031 366 366 D REGISTRATION_STATE: ql_pase_reg_line:76 1,62475,150237007,7 06-26 14:34:46.031 366 366 D REGISTRATION_STATE: ql_at_cxxreg success... RegState=1 06-26 14:34:46.031 366 366 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:34:46.033 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:34:46.034 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:34:46.034 366 425 D ATC : AT< OK 06-26 14:34:46.035 366 366 D ATC : AT> AT+QENG="servingcell" 06-26 14:34:46.038 366 425 D ATC : AT< +QENG: "servingcell","NOCONN","LTE","FDD",460,01,8F46F4F,300,1800,3,5,5,F40B,-89,-10,-59,7,33 06-26 14:34:46.038 366 425 D ATC : AT< OK 06-26 14:34:46.038 366 366 D CELL_INFO: parseServingCell_234G:699 Enter... 06-26 14:34:46.038 366 366 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:34:46.040 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:34:46.040 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:34:46.040 366 425 D ATC : AT< OK 06-26 14:34:46.040 366 366 D CELL_INFO: parseServingCell_234G:767 LTE RSRP=-89 06-26 14:34:46.040 366 366 D CELL_INFO: parseServingCell_234G:802 *count = 1 06-26 14:34:46.040 366 366 D REGISTRATION_STATE: ql_is_5g_nsa 234 06-26 14:34:46.040 366 366 D ATC : AT> AT+COPS=3,2;+COPS? 06-26 14:34:46.042 366 425 D ATC : AT< +COPS: 0,2,"46001",7 06-26 14:34:46.042 366 425 D ATC : AT< OK 06-26 14:34:46.042 366 366 D REGISTRATION_STATE: 0,2,46001,7 06-26 14:34:46.042 366 366 D ATC : AT> AT+QENDC 06-26 14:34:46.043 366 425 D ATC : AT< ERROR 06-26 14:34:46.043 366 366 D REGISTRATION_STATE: ql_is_5g_nsa:it is lte net work 06-26 14:34:46.043 366 366 D ATC : AT> AT+QENG="servingcell" 06-26 14:34:46.046 366 425 D ATC : AT< +QENG: "servingcell","NOCONN","LTE","FDD",460,01,8F46F4F,300,1800,3,5,5,F40B,-89,-10,-59,8,33 06-26 14:34:46.047 366 425 D ATC : AT< OK 06-26 14:34:46.047 366 366 D RILC : onRequest: CDMA_GET_SUBSCRIPTION_SOURCE 06-26 14:34:46.047 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.049 848 969 D RILJ : [0014]< RIL_REQUEST_VOICE_RADIO_TECH {14} [PHONE0] 06-26 14:34:46.050 848 969 D RILJ : [0015]< RIL_REQUEST_CDMA_GET_SUBSCRIPTION_SOURCE {0} [PHONE0] 06-26 14:34:46.058 848 848 D SST : [0] updateSpnDisplay: radio is on but out of service, set plmn='No service' 06-26 14:34:46.060 848 848 D SST : [0] updateSpnDisplay: rawSpn = 06-26 14:34:46.064 848 848 D SST : [0] updateSpnDisplay: updateSpnDisplay: changed sending intent, rule=2, showPlmn='true', plmn='No service', showSpn='false', spn='', dataSpn='', subId='-1' 06-26 14:34:46.064 848 848 D SubscriptionManager: putPhoneIdAndSubIdExtra: no valid subs 06-26 14:34:46.084 848 848 D SubscriptionController: [setPlmnSpn] No valid subscription to store info 06-26 14:34:46.084 848 848 D SubscriptionController: notifySubscriptionInfoChanged: 06-26 14:34:46.085 434 792 D TelephonyRegistry: notifySubscriptionInfoChanged: first invocation mRecords.size=27 06-26 14:34:46.098 848 848 D SST : [0] updateSpnDisplayLegacy- 06-26 14:34:46.102 848 848 D NRM-C-0 : Trying to bind com.android.phone for transport WWAN 06-26 14:34:46.129 848 848 D SST : [0] received event 1 06-26 14:34:46.130 848 848 D SST : [0] mDeviceShuttingDown=false, mDesiredPowerState=true, getRadioState=1, mPowerOffDelayNeed=true, mAlarmSwitch=false, mRadioDisabledByCarrier=false 06-26 14:34:46.130 848 848 D SST : [0] pollState: modemTriggered=true 06-26 14:34:46.140 848 848 D RILJ : [0016]> OPERATOR [PHONE0] 06-26 14:34:46.140 366 366 D RILC : onRequest: OPERATOR 06-26 14:34:46.140 848 848 E NRM-C-0 : service not connected. Domain = PS 06-26 14:34:46.140 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.140 366 366 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS?;+COPS=3,2;+COPS? 06-26 14:34:46.141 848 848 E NRM-C-0 : service not connected. Domain = CS 06-26 14:34:46.143 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:34:46.143 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:34:46.143 366 425 D ATC : AT< +COPS: 0,2,"46001",7 06-26 14:34:46.143 366 425 D ATC : AT< OK 06-26 14:34:46.144 848 848 D RILJ : [0017]> QUERY_NETWORK_SELECTION_MODE [PHONE0] 06-26 14:34:46.144 848 969 D RILJ : [0016]< OPERATOR {CHN-UNICOM, UNICOM, 46001} [PHONE0] 06-26 14:34:46.145 848 848 D SST : [0] received event 11 06-26 14:34:46.145 848 848 D SST : NITZ: 26/06/26,06:34:41+32,0,16099 start=22188 delay=6089 06-26 14:34:46.145 366 366 D RILC : onRequest: QUERY_NETWORK_SELECTION_MODE 06-26 14:34:46.145 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.146 848 848 D NewNitzStateMachineImpl: handleNitzReceived: nitzSignal=TimestampedValue{mReferenceTimeMillis=16099, mValue=NitzData{mOriginalString=26/06/26,06:34:41+32,0, mZoneOffset=28800000, mDstOffset=0, mCurrentTimeMillis=1782455681000, mEmulatorHostTimeZone=null}} 06-26 14:34:46.147 848 969 D RILJ : [0017]< QUERY_NETWORK_SELECTION_MODE {0} [PHONE0] 06-26 14:34:46.155 848 848 D NewNitzStateMachineImpl: doTimeZoneDetection: countryIsoCode=null, nitzSignal=TimestampedValue{mReferenceTimeMillis=16099, mValue=NitzData{mOriginalString=26/06/26,06:34:41+32,0, mZoneOffset=28800000, mDstOffset=0, mCurrentTimeMillis=1782455681000, mEmulatorHostTimeZone=null}}, suggestion=TelephonyTimeZoneSuggestion{mSlotIndex=0, mZoneId='null', mMatchType=0, mQuality=0, mDebugInfo=[getTimeZoneSuggestion: nitzSignal=TimestampedValue{mReferenceTimeMillis=16099, mValue=NitzData{mOriginalString=26/06/26,06:34:41+32,0, mZoneOffset=28800000, mDstOffset=0, mCurrentTimeMillis=1782455681000, mEmulatorHostTimeZone=null}}, countryIsoCode=null, Detection reason=handleNitzReceived(TimestampedValue{mReferenceTimeMillis=16099, mValue=NitzData{mOriginalString=26/06/26,06:34:41+32,0, mZoneOffset=28800000, mDstOffset=0, mCurrentTimeMillis=1782455681000, mEmulatorHostTimeZone=null}})]}, reason=handleNitzReceived(TimestampedValue{mReferenceTimeMillis=16099, mValue=NitzData{mOriginalString=26/06/26,06:34:41+32,0, mZoneOffset=28800000, mDstOffset=0, mCurrentTimeMillis=1782455681000, mEmulatorHostTimeZone=null}}) 06-26 14:34:46.175 848 848 D SST : NITZ: end=22218 dur=30 06-26 14:34:46.175 848 848 D SST : [0] received event 50 06-26 14:34:46.175 848 848 D SST : [0] mDeviceShuttingDown=false, mDesiredPowerState=true, getRadioState=1, mPowerOffDelayNeed=true, mAlarmSwitch=false, mRadioDisabledByCarrier=false 06-26 14:34:46.176 848 848 D SST : [0] pollState: modemTriggered=true 06-26 14:34:46.203 848 848 D RILJ : [0018]> OPERATOR [PHONE0] 06-26 14:34:46.203 366 366 D RILC : onRequest: OPERATOR 06-26 14:34:46.203 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.203 366 366 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS?;+COPS=3,2;+COPS? 06-26 14:34:46.204 848 848 E NRM-C-0 : service not connected. Domain = PS 06-26 14:34:46.204 848 848 E NRM-C-0 : service not connected. Domain = CS 06-26 14:34:46.206 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:34:46.206 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:34:46.206 366 425 D ATC : AT< +COPS: 0,2,"46001",7 06-26 14:34:46.206 366 425 D ATC : AT< OK 06-26 14:34:46.207 848 969 D RILJ : [0018]< OPERATOR {CHN-UNICOM, UNICOM, 46001} [PHONE0] 06-26 14:34:46.221 848 848 D RILJ : [0019]> QUERY_NETWORK_SELECTION_MODE [PHONE0] 06-26 14:34:46.221 366 366 D RILC : onRequest: QUERY_NETWORK_SELECTION_MODE 06-26 14:34:46.221 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.222 848 969 D RILJ : [0019]< QUERY_NETWORK_SELECTION_MODE {0} [PHONE0] 06-26 14:34:46.257 848 848 D SubscriptionController: [getSlotIndex]- subId invalid 06-26 14:34:46.270 848 848 D SubscriptionController: Valid row not present in db 06-26 14:34:46.273 848 848 D SubscriptionController: getSubscriptionProperty Query value = null 06-26 14:34:46.273 848 848 I CSST : isNrSupported: carrierConfigEnabled: true, AccessFamilySupported: false, isNrNetworkTypeAllowed: true 06-26 14:34:46.273 848 848 I CSST : PrefNetworkNotification: sendMessage() w/values: ,false,-1,false,true 06-26 14:34:46.274 848 848 I CSST : canceling notifications: 1000 06-26 14:34:46.275 848 848 D Phone : isWifiCallingEnabled =false 06-26 14:34:46.275 848 848 D CSST : isPhoneRegisteredForWifiCalling: false 06-26 14:34:46.275 848 848 D Phone : isWifiCallingEnabled =false 06-26 14:34:46.275 848 848 I CSST : EmergencyNetworkNotification: sendMessage() w/values: ,-1,false,true 06-26 14:34:46.277 848 848 I CSST : canceling notifications: 1001 06-26 14:34:46.292 848 848 D SubscriptionController: Valid row not present in db 06-26 14:34:46.295 848 848 D SubscriptionController: getSubscriptionProperty Query value = null 06-26 14:34:46.295 848 848 I CSST : isNrSupported: carrierConfigEnabled: true, AccessFamilySupported: false, isNrNetworkTypeAllowed: true 06-26 14:34:46.295 848 848 I CSST : PrefNetworkNotification: sendMessage() w/values: ,false,-1,false,true 06-26 14:34:46.301 848 848 I CSST : canceling notifications: 1000 06-26 14:34:46.301 848 848 D Phone : isWifiCallingEnabled =false 06-26 14:34:46.301 848 848 D CSST : isPhoneRegisteredForWifiCalling: false 06-26 14:34:46.301 848 848 D Phone : isWifiCallingEnabled =false 06-26 14:34:46.301 848 848 I CSST : EmergencyNetworkNotification: sendMessage() w/values: ,-1,false,true 06-26 14:34:46.303 848 848 I CSST : canceling notifications: 1001 06-26 14:34:46.303 848 848 D SST : [0] received event 3 06-26 14:34:46.303 848 848 D SST : [0] onSignalStrengthResult() Exception from RIL : com.android.internal.telephony.CommandException: INVALID_RESPONSE 06-26 14:34:46.309 848 848 D EmergencyNumberTracker: updateRadioEmergencyNumberListAndNotify(): receiving [] 06-26 14:34:46.314 848 848 D RILJ : [0020]> RIL_REQUEST_SEND_DEVICE_STATE 1:true [PHONE0] 06-26 14:34:46.315 848 969 D RILJ : [0020]< RIL_REQUEST_SEND_DEVICE_STATE error 6 [PHONE0] 06-26 14:34:46.315 848 969 D RilRequest: [0020]< RIL_REQUEST_SEND_DEVICE_STATE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 06-26 14:34:46.325 848 848 D RILJ : [0021]> RIL_REQUEST_SEND_DEVICE_STATE 2:false [PHONE0] 06-26 14:34:46.325 366 366 D RILC : sendDeviceState: calling screen state 1 06-26 14:34:46.325 366 366 D RILC : onRequest: SCREEN_STATE datalen=4 06-26 14:34:46.326 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.326 366 366 D RILU : ql_set_autosuspend, enter... 06-26 14:34:46.326 366 366 D RILU : ro_hardware:rk30board 06-26 14:34:46.326 366 366 D RILU : ----------------------------------------------2:rk30board 06-26 14:34:46.326 366 366 D RILU : ----------------------------------------------3:1 06-26 14:34:46.326 366 366 D RILU : ----------------------------------------------3:2 06-26 14:34:46.327 848 848 D RILJ : [0022]> RIL_REQUEST_SEND_DEVICE_STATE 0:false [PHONE0] 06-26 14:34:46.329 848 848 D RILJ : [0023]> RIL_REQUEST_SET_UNSOLICITED_RESPONSE_FILTER -1 [PHONE0] 06-26 14:34:46.330 848 848 E RILJ : setSignalStrengthReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.331 848 848 I chatty : uid=1001(radio) com.android.phone identical 2 lines 06-26 14:34:46.331 848 848 E RILJ : setSignalStrengthReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.332 848 848 D RILJ : [0024]> RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA [PHONE0] 06-26 14:34:46.333 848 848 E RILJ : setLinkCapacityReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.336 848 848 D RILJ : [0025]> RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA [PHONE0] 06-26 14:34:46.336 848 848 E RILJ : setLinkCapacityReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.338 848 848 D RILJ : [0026]> RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA [PHONE0] 06-26 14:34:46.338 848 848 E RILJ : setLinkCapacityReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.340 848 848 D RILJ : [0027]> RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA [PHONE0] 06-26 14:34:46.340 848 848 E RILJ : setLinkCapacityReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.342 848 848 D RILJ : [0028]> RIL_REQUEST_SEND_DEVICE_STATE 1:true [PHONE0] 06-26 14:34:46.344 848 848 D RILJ : [0029]> RIL_REQUEST_SEND_DEVICE_STATE 2:false [PHONE0] 06-26 14:34:46.348 848 848 D RILJ : [0030]> RIL_REQUEST_SEND_DEVICE_STATE 0:false [PHONE0] 06-26 14:34:46.366 848 848 D RILJ : [0031]> RIL_REQUEST_SET_UNSOLICITED_RESPONSE_FILTER -1 [PHONE0] 06-26 14:34:46.366 848 848 E RILJ : setSignalStrengthReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.367 848 848 I chatty : uid=1001(radio) com.android.phone identical 2 lines 06-26 14:34:46.367 848 848 E RILJ : setSignalStrengthReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.368 848 848 D RILJ : [0032]> RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA [PHONE0] 06-26 14:34:46.368 848 848 E RILJ : setLinkCapacityReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.371 848 848 D RILJ : [0033]> RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA [PHONE0] 06-26 14:34:46.371 848 848 E RILJ : setLinkCapacityReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.375 848 848 D RILJ : [0034]> RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA [PHONE0] 06-26 14:34:46.375 848 848 E RILJ : setLinkCapacityReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.380 848 848 D RILJ : [0035]> RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA [PHONE0] 06-26 14:34:46.380 848 848 E RILJ : setLinkCapacityReportingCriteria ignored on IRadio version less than 1.2 [PHONE0] 06-26 14:34:46.381 848 848 D NetworkTypeController: [0] DefaultState: process EVENT_INITIALIZE 06-26 14:34:46.386 366 366 D RILU : echo on > /sys/bus/usb/devices/1-1.7/power/control 06-26 14:34:46.386 366 366 D RILU : ql_set_autosuspend off 06-26 14:34:46.386 366 366 D RILU : ----------------------------------------------3:3 06-26 14:34:46.386 366 366 D RILU : ----------------------------------------------3:1 06-26 14:34:46.386 366 366 D RILU : ----------------------------------------------3:3 06-26 14:34:46.386 366 366 D RILU : ----------------------------------------------3:1 06-26 14:34:46.386 366 366 D RILU : ----------------------------------------------3:3 06-26 14:34:46.386 366 366 D RILU : ----------------------------------------------3:1 06-26 14:34:46.386 366 366 D RILU : ----------------------------------------------3:3 06-26 14:34:46.386 366 366 D RILU : ----------------------------------------------4 06-26 14:34:46.387 366 366 D RILC : sendDeviceState: calling screen state 1 06-26 14:34:46.387 366 366 D RILC : onRequest: SCREEN_STATE datalen=4 06-26 14:34:46.387 366 366 D RILC : onRequest,8089 g_is_scan_ing = 0 06-26 14:34:46.387 366 366 D RILU : ql_set_autosuspend, enter... 06-26 14:34:46.387 366 366 D RILU : ro_hardware:rk30board 06-26 14:34:46.387 366 366 D RILU : ----------------------------------------------2:rk30board 06-26 14:34:46.387 366 366 D RILU : ----------------------------------------------3:1 06-26 14:34:46.387 366 366 D RILU : ----------------------------------------------3:2 06-26 14:34:46.389 848 969 D RILJ : [0021]< RIL_REQUEST_SEND_DEVICE_STATE [PHONE0] 06-26 14:34:46.391 848 848 D NetworkTypeController: [0] mOverrideTimerRules: {connected={mState=connected, mOverrideType=NR_NSA, mPrimaryTimers={}, mSecondaryTimers={}}, not_restricted_rrc_con={mState=not_restricted_rrc_con, mOverrideType=NR_NSA, mPrimaryTimers={}, mSecondaryTimers={}}, legacy={mState=legacy, mOverrideType=NONE, mPrimaryTimers={}, mSecondaryTimers={}}, not_restricted_rrc_idle={mState=not_restricted_rrc_idle, mOverrideType=NR_NSA, mPrimaryTimers={}, mSecondaryTimers={}}, restricted={mState=restricted, mOverrideType=NONE, mPrimaryTimers={}, mSecondaryTimers={}}, connected_mmwave={mState=connected_mmwave, mOverrideType=NR_NSA, mPrimaryTimers={}, mSecondaryTimers={}}} 06-26 14:34:46.391 848 848 D NetworkTypeController: [0] DefaultState: process EVENT_UPDATE 06-26 14:34:46.391 848 848 D NetworkTypeController: [0] Remove all timers 06-26 14:34:46.392 848 969 D RILJ : [0022]< RIL_REQUEST_SEND_DEVICE_STATE error 6 [PHONE0] 06-26 14:34:46.392 848 848 D NetworkTypeController: [0] Entering LegacyState 06-26 14:34:46.392 848 848 D NetworkTypeController: [0] Remove all timers 06-26 14:34:46.392 848 848 D DisplayInfoController: TelephonyDisplayInfo[0] changed from null to TelephonyDisplayInfo {network=UNKNOWN, override=NONE} 06-26 14:34:46.392 848 969 D RilRequest: [0022]< RIL_REQUEST_SEND_DEVICE_STATE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 06-26 14:34:46.406 848 969 D RILJ : [0023]< RIL_REQUEST_SET_UNSOLICITED_RESPONSE_FILTER error 6 [PHONE0] 06-26 14:34:46.406 848 969 D RilRequest: [0023]< RIL_REQUEST_SET_UNSOLICITED_RESPONSE_FILTER error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 06-26 14:34:46.407 848 969 D RILJ : [0028]< RIL_REQUEST_SEND_DEVICE_STATE error 6 [PHONE0] 06-26 14:34:46.407 848 969 D RilRequest: [0028]< RIL_REQUEST_SEND_DEVICE_STATE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 06-26 14:34:46.425 848 848 D DCT-C-0 : onDataEnabledChanged: enable=true, enabledChangedReason=0 06-26 14:34:46.425 848 848 D DCT-C-0 : setupDataOnAllConnectableApns: dataEnabled hipri:[state=IDLE,enabled=false] mcx:[state=IDLE,enabled=false] xcap:[state=IDLE,enabled=false] fota:[state=IDLE,enabled=false] ims:[state=IDLE,enabled=false] cbs:[state=IDLE,enabled=false] ia:[state=IDLE,enabled=false] emergency:[state=IDLE,enabled=false] mms:[state=IDLE,enabled=false] supl:[state=IDLE,enabled=false] dun:[state=IDLE,enabled=false] default:[state=IDLE,enabled=false] 06-26 14:34:46.425 848 848 D DCT-C-0 : onDataEnabledOverrideRulesChanged 06-26 14:34:46.430 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.432 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.436 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.447 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.457 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.458 366 366 D RILU : echo on > /sys/bus/usb/devices/1-1.7/power/control 06-26 14:34:46.458 366 366 D RILU : ql_set_autosuspend off 06-26 14:34:46.458 366 366 D RILU : ----------------------------------------------3:3 06-26 14:34:46.458 366 366 D RILU : ----------------------------------------------3:1 06-26 14:34:46.458 366 366 D RILU : ----------------------------------------------3:3 06-26 14:34:46.458 366 366 D RILU : ----------------------------------------------3:1 06-26 14:34:46.458 366 366 D RILU : ----------------------------------------------3:3 06-26 14:34:46.458 366 366 D RILU : ----------------------------------------------3:1 06-26 14:34:46.458 366 366 D RILU : ----------------------------------------------3:3 06-26 14:34:46.458 366 366 D RILU : ----------------------------------------------4 06-26 14:34:46.459 848 969 D RILJ : [0029]< RIL_REQUEST_SEND_DEVICE_STATE [PHONE0] 06-26 14:34:46.460 848 969 D RILJ : [0030]< RIL_REQUEST_SEND_DEVICE_STATE error 6 [PHONE0] 06-26 14:34:46.460 848 969 D RilRequest: [0030]< RIL_REQUEST_SEND_DEVICE_STATE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 06-26 14:34:46.461 848 969 D RILJ : [0031]< RIL_REQUEST_SET_UNSOLICITED_RESPONSE_FILTER error 6 [PHONE0] 06-26 14:34:46.461 848 969 D RilRequest: [0031]< RIL_REQUEST_SET_UNSOLICITED_RESPONSE_FILTER error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 06-26 14:34:46.463 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.465 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.470 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.473 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.480 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.481 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.486 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.488 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.489 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.497 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.498 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.500 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.507 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.509 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.510 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.513 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.515 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.517 848 848 D DCT-C-0 : shouldRestrictDataForEcbm: isInEcm=false isInImsEcm=false 06-26 14:34:46.518 848 848 D SubscriptionController: [getActiveSubscriptionInfo]- subId=-1 subList=[] subInfo=null 06-26 14:34:46.518 848 848 D DCT-C-0 : onRadioAvailable 06-26 14:34:46.518 848 848 D DCT-C-0 : onDataConnectionDetached: stop polling and notify detached 06-26 14:34:46.519 848 848 D DCT-C-0 : stopNetStatPoll 06-26 14:34:46.525 848 848 D DCT-C-0 : onDataRoamingOff 06-26 14:34:46.527 848 848 D CarrierResolver: handleMessage: 2 06-26 14:34:46.528 848 848 D GsmCdmaPhone: [0] onVoiceRegStateOrRatChanged 06-26 14:34:46.529 848 848 D GsmCdmaPhone: [0] getCsCallRadioTech, current vrs=1, vrat=0 06-26 14:34:46.529 848 848 D GsmCdmaPhone: [0] getCsCallRadioTech, result calcVrat=0 06-26 14:34:46.529 848 848 D PhoneCfgMgr: Received EVENT_RADIO_AVAILABLE/EVENT_RADIO_ON 06-26 14:34:46.529 848 848 D PhoneCfgMgr: getStaticPhoneCapability: sending the request for getting PhoneCapability 06-26 14:34:46.530 848 848 D PhoneCfgMgr: getStaticPhoneCapability: mStaticCapability maxActiveVoiceCalls=1 maxActiveData=1 max5G=0logicalModemList:[modemId=0 rat=0 isVoiceSupported:true isDataSupported:true] 06-26 14:34:46.530 848 848 D DCT-C-0 : onDataEnabledChanged: enable=true, enabledChangedReason=0 06-26 14:34:46.530 848 848 D DCT-C-0 : setupDataOnAllConnectableApns: dataEnabled hipri:[state=IDLE,enabled=false] mcx:[state=IDLE,enabled=false] xcap:[state=IDLE,enabled=false] fota:[state=IDLE,enabled=false] ims:[state=IDLE,enabled=false] cbs:[state=IDLE,enabled=false] ia:[state=IDLE,enabled=false] emergency:[state=IDLE,enabled=false] mms:[state=IDLE,enabled=false] supl:[state=IDLE,enabled=false] dun:[state=IDLE,enabled=false] default:[state=IDLE,enabled=false] 06-26 14:34:46.531 848 848 D PhoneSwitcher: No active subscriptions: resetting preferred phone to 0 for emergency 06-26 14:34:46.531 848 848 D PhoneSwitcher: evaluating due to EVENT_PRECISE_CALL_STATE_CHANGED phone[0] 0->-1 06-26 14:34:46.534 848 848 D PhoneSwitcher: activate 0 06-26 14:34:46.535 848 848 D PhoneSwitcher: notifyPreferredDataSubIdChanged to -1 06-26 14:34:46.554 848 848 D PhoneSwitcher: logDataSwitchEvent subId -1 state 1 reason 2 06-26 14:34:46.579 848 848 D TelephonyNetworkFactory[0]: got request NetworkRequest [ TRACK_DEFAULT id=15, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 10109 AdministratorUids: [] RequestorUid: 10109 RequestorPackageName: com.android.systemui] ] with score 0 and providerId -1 06-26 14:34:46.579 848 848 D TelephonyNetworkFactory[0]: got request NetworkRequest [ TRACK_DEFAULT id=16, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 10109 AdministratorUids: [] RequestorUid: 10109 RequestorPackageName: com.android.systemui] ] with score 0 and providerId -1 06-26 14:34:46.582 848 848 D TelephonyNetworkFactory[0]: got request NetworkRequest [ REQUEST id=12, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN AdministratorUids: [] RequestorUid: 1073 RequestorPackageName: com.android.networkstack] ] with score 0 and providerId -1 06-26 14:34:46.582 848 848 D TelephonyNetworkFactory[0]: got request NetworkRequest [ TRACK_DEFAULT id=9, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 1000 AdministratorUids: [] RequestorUid: 1000 RequestorPackageName: android] ] with score 0 and providerId -1 06-26 14:34:46.583 848 848 D TelephonyNetworkFactory[0]: got request NetworkRequest [ TRACK_DEFAULT id=10, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 1073 AdministratorUids: [] RequestorUid: 1073 RequestorPackageName: com.android.networkstack] ] with score 0 and providerId -1 06-26 14:34:46.585 848 848 D TelephonyNetworkFactory[0]: got request NetworkRequest [ REQUEST id=1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN AdministratorUids: [] RequestorUid: 1000 RequestorPackageName: android] ] with score 0 and providerId -1 06-26 14:34:46.585 848 848 D TelephonyNetworkFactory[0]: got request NetworkRequest [ BACKGROUND_REQUEST id=2, [ Transports: CELLULAR Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN AdministratorUids: [] RequestorUid: 1000 RequestorPackageName: android] ] with score 0 and providerId -1 06-26 14:34:46.587 848 848 D DebugService: DebugService DebugService: 06-26 14:34:46.650 848 848 D WAP PUSH: Received broadcast android.intent.action.USER_UNLOCKED 06-26 14:34:46.651 848 848 D WAP PUSH: Received broadcast android.intent.action.USER_UNLOCKED 06-26 14:34:46.651 848 848 D SmsBroadcastUndelivered: Received broadcast android.intent.action.USER_UNLOCKED 06-26 14:34:46.652 848 848 D SmsDispatchersController: Received broadcast android.intent.action.USER_UNLOCKED 06-26 14:34:46.654 848 848 D UiccController: handleMessage: Received GET_ICC_STATUS_DONE for phoneId 0 06-26 14:34:46.655 848 848 D UiccController: Received EVENT_GET_ICC_STATUS_DONE 06-26 14:34:46.657 848 848 E UiccController: Error getting ICC status. RIL_REQUEST_GET_ICC_STATUS should never return an error 06-26 14:34:46.657 848 848 E UiccController: com.android.internal.telephony.CommandException: INVALID_RESPONSE 06-26 14:34:46.657 848 848 E UiccController: at com.android.internal.telephony.RILRequest.onError(RILRequest.java:238) 06-26 14:34:46.657 848 848 E UiccController: at com.android.internal.telephony.RIL.processResponseDone(RIL.java:5553) 06-26 14:34:46.657 848 848 E UiccController: at com.android.internal.telephony.RadioResponse.responseIccCardStatus(RadioResponse.java:1808) 06-26 14:34:46.657 848 848 E UiccController: at com.android.internal.telephony.RadioResponse.getIccCardStatusResponse(RadioResponse.java:109) 06-26 14:34:46.657 848 848 E UiccController: at android.hardware.radio.V1_5.IRadioResponse$Stub.onTransact(IRadioResponse.java:3773) 06-26 14:34:46.657 848 848 D UiccController: handleMessage: Received GET_SLOT_STATUS_DONE for phoneId 0 06-26 14:34:46.657 848 848 D UiccController: Received EVENT_SLOT_STATUS_CHANGED or EVENT_GET_SLOT_STATUS_DONE 06-26 14:34:46.658 848 848 D UiccController: onGetSlotStatusDone: [IccSlotStatus {CARDSTATE_PRESENT,SLOTSTATE_ACTIVE,logicalSlotIndex=0,atr=3B9F94801FC78031E073FE21135758485553494D01F9,iccid=89860116834048807196,eid=null}] 06-26 14:34:46.658 848 848 D UiccSlot: Creating 06-26 14:34:46.658 848 848 D UiccSlot: slotStatus update: IccSlotStatus {CARDSTATE_PRESENT,SLOTSTATE_ACTIVE,logicalSlotIndex=0,atr=3B9F94801FC78031E073FE21135758485553494D01F9,iccid=89860116834048807196,eid=null} 06-26 14:34:46.659 848 848 D AnswerToReset: Successfully parsed the ATR string 3B9F94801FC78031E073FE21135758485553494D01F9 into AnswerToReset:{mConventionByte=3B,mFormatByte=9F,mInterfaceBytes={{TA=94,TB=null,TC=null,TD=80}{TA=null,TB=null,TC=null,TD=1F}{TA=C7,TB=null,TC=null,TD=null}},mHistoricalBytes={80,31,E0,73,FE,21,13,57,58,48,55,53,49,4D,01,},mCheckByte=F9} 06-26 14:34:46.659 848 1333 D SmsBroadcastUndelivered: scanning raw table for undelivered messages 06-26 14:34:46.659 848 848 D UiccController: onGetSlotStatusDone: mDefaultEuiccCardId=UNINITIALIZED 06-26 14:34:46.677 848 848 D GsmCdmaCallTracker: Event EVENT_POLL_CALLS_RESULT Received 06-26 14:34:46.677 848 848 D GsmCdmaCallTracker: [0] update phone state, old=IDLE new=IDLE 06-26 14:34:46.678 848 848 D GsmCdmaPhone: [0] Received exception on event55 : com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED 06-26 14:34:46.680 848 848 D SmsDispatchersController: IMS registration state: true format: 3gpp 06-26 14:34:46.681 848 848 D GsmCdmaPhone: [0] Baseband version: EC200ACNGAR01A06M16 06-26 14:34:46.684 848 848 D GsmCdmaPhone: EVENT_GET_RADIO_CAPABILITY: phone rc: {mPhoneId = 0 mVersion=1 mSession=0 mPhase=0 mRadioAccessFamily=916479 mLogicModemId=0 mStatus=1} 06-26 14:34:46.684 848 848 D GsmCdmaPhone: [0] EVENT_REQUEST_VOICE_RADIO_TECH_DONE: newVoiceTech=14 06-26 14:34:46.684 848 848 D GsmCdmaPhone: [0] phoneObjectUpdater: newVoiceRadioTech=14 06-26 14:34:46.697 848 848 D GsmCdmaPhone: [0] phoneObjectUpdater: volteReplacementRat=0 06-26 14:34:46.697 848 848 D GsmCdmaPhone: [0] phoneObjectUpdater: No change ignore, newVoiceRadioTech=14 mActivePhone=GSM 06-26 14:34:46.697 848 848 D CdmaSSM : CDMA_SUBSCRIPTION_SOURCE event = 2 06-26 14:34:46.697 848 848 D SST : [0] SubscriptionListener.onSubscriptionInfoChanged 06-26 14:34:46.703 848 848 D Phone : isImsRegistered =false 06-26 14:34:46.755 848 1333 D SmsBroadcastUndelivered: finished scanning raw table in 95 ms 06-26 14:34:46.860 848 848 D NetworkService: network service created 06-26 14:34:46.869 848 848 D SST : [0] received event 5 06-26 14:34:46.869 848 848 D SST : [0] received event 4 06-26 14:34:46.870 848 848 D SST : [0] received event 7 06-26 14:34:46.870 848 848 D SST : [0] received event 14 06-26 14:34:46.870 848 848 D SST : [0] EVENT_POLL_STATE_NETWORK_SELECTION_MODE 06-26 14:34:46.870 848 848 D SST : [0] received event 5 06-26 14:34:46.870 848 848 D SST : [0] handlePollStateResult exception java.lang.IllegalStateException: Service not connected. 06-26 14:34:46.870 848 848 E SST : [0] RIL implementation has returned an error where it must succeedjava.lang.IllegalStateException: Service not connected. 06-26 14:34:46.870 848 848 D SST : [0] received event 4 06-26 14:34:46.870 848 848 D SST : [0] handlePollStateResult exception java.lang.IllegalStateException: Service not connected. 06-26 14:34:46.870 848 848 E SST : [0] RIL implementation has returned an error where it must succeedjava.lang.IllegalStateException: Service not connected. 06-26 14:34:46.870 848 848 D SST : [0] received event 7 06-26 14:34:46.871 848 848 D SST : [0] received event 14 06-26 14:34:46.871 848 848 D SST : [0] EVENT_POLL_STATE_NETWORK_SELECTION_MODE 06-26 14:34:46.871 848 848 D SST : [0] combinePsRegistrationStates: {mVoiceRegState=1(OUT_OF_SERVICE), mDataRegState=1(OUT_OF_SERVICE), mChannelNumber=-1, duplexMode()=0, mCellBandwidths=[], mOperatorAlphaLong=CHN-UNICOM, mOperatorAlphaShort=UNICOM, isManualNetworkSelection=false(automatic), getRilVoiceRadioTechnology=0(Unknown), getRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=false, isUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0, mNetworkRegistrationInfos=[NetworkRegistrationInfo{ domain=CS transportType=WWAN registrationState=UNKNOWN roamingType=NOT_ROAMING accessNetworkTechnology=UNKNOWN rejectCause=0 emergencyEnabled=false availableServices=[] cellIdentity=null voiceSpecificInfo=null dataSpecificInfo=null nrState=NONE rRplmn=}, NetworkRegistrationInfo{ domain=PS transportType=WWAN registrationState=UNKNOWN roamingType=NOT_ROAMING accessNetworkTechnology=UNKNOWN rejectCause=0 emergencyEnabled=false availableServices=[] cellIdentity=null voiceSpecificInfo=null dataSpecificInfo=null nrState=NONE rRplmn=}], mNrFrequencyRange=0, mOperatorAlphaLongRaw=CHN-UNICOM, mOperatorAlphaShortRaw=UNICOM, mIsDataRoamingFromRegistration=false, mIsIwlanPreferred=false} 06-26 14:34:46.873 848 848 D SST : [0] useDataRegStateForDataOnlyDevice: VoiceRegState=1 DataRegState=1 06-26 14:34:46.874 848 848 D SST : [0] Poll ServiceState done: oldSS=[{mVoiceRegState=1(OUT_OF_SERVICE), mDataRegState=1(OUT_OF_SERVICE), mChannelNumber=-1, duplexMode()=0, mCellBandwidths=[], mOperatorAlphaLong=null, mOperatorAlphaShort=null, isManualNetworkSelection=false(automatic), getRilVoiceRadioTechnology=0(Unknown), getRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=false, isUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0, mNetworkRegistrationInfos=[NetworkRegistrationInfo{ domain=CS transportType=WWAN registrationState=UNKNOWN roamingType=NOT_ROAMING accessNetworkTechnology=UNKNOWN rejectCause=0 emergencyEnabled=false availableServices=[] cellIdentity=null voiceSpecificInfo=null dataSpecificInfo=null nrState=NONE rRplmn=}, NetworkRegistrationInfo{ domain=PS transportType=WWAN registrationState=UNKNOWN roamingType=NOT_ROAMING accessNetworkTechnology=UNKNOWN rejectCause=0 emergencyEnabled=false availableServices=[] cellIdentity=null voiceSpecificInfo=null dataSpecificInfo=null nrState=NONE rRplmn=}], mNrFrequencyRange=0, mOperatorAlphaLongRaw=null, mOperatorAlphaShortRaw=null, mIsDataRoamingFromRegistration=false, mIsIwlanPreferred=false}] newSS=[{mVoiceRegState=1(OUT_OF_SERVICE), mDataRegState=1(OUT_OF_SERVICE), mChannelNumber=-1, duplexMode()=0, mCellBandwidths=[], mOperatorAlphaLong=CHN-UNICOM, mOperatorAlphaShort=UNICOM, isManualNetworkSelection=false(automatic), getRilVoiceRadioTechnology=0(Unknown), getRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=false, isUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0, mNetworkRegistrationInfos=[NetworkRegistrationInfo{ domain=CS transportType=WWAN registrationState=UNKNOWN roamingType=NOT_ROAMING accessNetworkTechnology=UNKNOWN rejectCause=0 emergencyEnabled=false availableServices=[] cellIdentity=null voiceSpecificInfo=null dataSpecificInfo=null nrState=NONE rRplmn=}, NetworkRegistrationInfo{ domain=PS transportType=WWAN registrationState=UNKNOWN roamingType=NOT_ROAMING accessNetworkTechnology=UNKNOWN rejectCause=0 emergencyEnabled=false availableServices=[] cellIdentity=null voiceSpecificInfo=null dataSpecificInfo=null nrState=NONE rRplmn=}], mNrFrequencyRange=0, mOperatorAlphaLongRaw=CHN-UNICOM, mOperatorAlphaShortRaw=UNICOM, mIsDataRoamingFromRegistration=false, mIsIwlanPreferred=false}] oldMaxDataCalls=1 mNewMaxDataCalls=1 oldReasonDataDenied=-1 mNewReasonDataDenied=-1 06-26 14:34:46.884 848 848 D SST : [0] pollStateDone: hasRegistered = false hasDeregistered = false hasDataAttached = {1=false} hasDataDetached = {1=false} hasDataRegStateChanged = {1=false} hasRilVoiceRadioTechnologyChanged = false hasRilDataRadioTechnologyChanged = {1=true} hasDataTransportPreferenceChanged = false hasChanged = true hasVoiceRoamingOn = false hasVoiceRoamingOff = false hasDataRoamingOn =false hasDataRoamingOff = false hasLocationChanged = false has4gHandoff = false hasMultiApnSupport = false hasLostMultiApnSupport = false hasCssIndicatorChanged = false hasNrFrequencyRangeChanged = false hasNrStateChanged = false hasAirplaneModeOnlChanged = false 06-26 14:34:46.887 848 848 D SST : [0] updateSpnDisplayLegacy+ 06-26 14:34:46.890 848 848 D SST : [0] updateSpnDisplay: radio is on but out of service, set plmn='No service' 06-26 14:34:46.892 848 848 D SST : [0] updateSpnDisplay: rawSpn = 06-26 14:34:46.893 848 848 D SST : [0] updateSpnDisplayLegacy- 06-26 14:34:46.898 848 848 D LocaleTracker-0: Operator numeric changes to "46001" 06-26 14:34:46.943 848 848 D LocaleTracker-0: updateLocale: countryIso = , countryIsoDebugInfo = OperatorNumeric(46001): MccTable.countryCodeForMcc("460") 06-26 14:34:46.943 848 848 D LocaleTracker-0: updateLocale: Change the current country to "", countryIsoDebugInfo = OperatorNumeric(46001): MccTable.countryCodeForMcc("460"), mCellInfoList = null 06-26 14:34:46.945 848 848 D SubscriptionManager: putPhoneIdAndSubIdExtra: no valid subs 06-26 14:34:46.951 848 868 D SubscriptionController: [getSlotIndex]- subId invalid 06-26 14:34:46.953 848 868 D SubscriptionController: [getSlotIndex]- subId invalid 06-26 14:34:46.954 848 848 D LocaleTracker-0: updateLocale: timeZoneCountryIso = cn, timeZoneCountryIsoDebugInfo = OperatorNumeric: MccTable.geoCountryCodeForMccMnc(MccMnc{mcc='460', mnc='01'}) 06-26 14:34:46.955 848 848 D NewNitzStateMachineImpl: handleCountryDetected: countryIsoCode=cn, mLatestNitzSignal=TimestampedValue{mReferenceTimeMillis=16099, mValue=NitzData{mOriginalString=26/06/26,06:34:41+32,0, mZoneOffset=28800000, mDstOffset=0, mCurrentTimeMillis=1782455681000, mEmulatorHostTimeZone=null}} 06-26 14:34:47.011 848 848 D NewNitzStateMachineImpl: doTimeZoneDetection: countryIsoCode=cn, nitzSignal=TimestampedValue{mReferenceTimeMillis=16099, mValue=NitzData{mOriginalString=26/06/26,06:34:41+32,0, mZoneOffset=28800000, mDstOffset=0, mCurrentTimeMillis=1782455681000, mEmulatorHostTimeZone=null}}, suggestion=TelephonyTimeZoneSuggestion{mSlotIndex=0, mZoneId='Asia/Shanghai', mMatchType=3, mQuality=1, mDebugInfo=[findTimeZoneFromCountryAndNitz: countryIsoCode=cn, nitzSignal=TimestampedValue{mReferenceTimeMillis=16099, mValue=NitzData{mOriginalString=26/06/26,06:34:41+32,0, mZoneOffset=28800000, mDstOffset=0, mCurrentTimeMillis=1782455681000, mEmulatorHostTimeZone=null}}, findTimeZoneFromCountryAndNitz: lookupResult=OffsetResult{mTimeZone(ID)=Asia/Shanghai, mIsOnlyMatch=true}, Detection reason=handleCountryDetected("cn")]}, reason=handleCountryDetected("cn") 06-26 14:34:47.019 848 848 D SST : [0] Broadcasting ServiceState : {mVoiceRegState=1(OUT_OF_SERVICE), mDataRegState=1(OUT_OF_SERVICE), mChannelNumber=-1, duplexMode()=0, mCellBandwidths=[], mOperatorAlphaLong=CHN-UNICOM, mOperatorAlphaShort=UNICOM, isManualNetworkSelection=false(automatic), getRilVoiceRadioTechnology=0(Unknown), getRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=false, isUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0, mNetworkRegistrationInfos=[NetworkRegistrationInfo{ domain=CS transportType=WWAN registrationState=UNKNOWN roamingType=NOT_ROAMING accessNetworkTechnology=UNKNOWN rejectCause=0 emergencyEnabled=false availableServices=[] cellIdentity=null voiceSpecificInfo=null dataSpecificInfo=null nrState=NONE rRplmn=}, NetworkRegistrationInfo{ domain=PS transportType=WWAN registrationState=UNKNOWN roamingType=NOT_ROAMING accessNetworkTechnology=UNKNOWN rejectCause=0 emergencyEnabled=false availableServices=[] cellIdentity=null voiceSpecificInfo=null dataSpecificInfo=null nrState=NONE rRplmn=}], mNrFrequencyRange=0, mOperatorAlphaLongRaw=CHN-UNICOM, mOperatorAlphaShortRaw=UNICOM, mIsDataRoamingFromRegistration=false, mIsIwlanPreferred=false} 06-26 14:34:47.020 848 848 D DefaultPhoneNotifier: notifyServiceStateForSubId: mRegistryMgr=android.telephony.TelephonyRegistryManager@7029d45 ss={mVoiceRegState=1(OUT_OF_SERVICE), mDataRegState=1(OUT_OF_SERVICE), mChannelNumber=-1, duplexMode()=0, mCellBandwidths=[], mOperatorAlphaLong=CHN-UNICOM, mOperatorAlphaShort=UNICOM, isManualNetworkSelection=false(automatic), getRilVoiceRadioTechnology=0(Unknown), getRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=false, isUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0, mNetworkRegistrationInfos=[NetworkRegistrationInfo{ domain=CS transportType=WWAN registrationState=UNKNOWN roamingType=NOT_ROAMING accessNetworkTechnology=UNKNOWN rejectCause=0 emergencyEnabled=false availableServices=[] cellIdentity=null voiceSpecificInfo=null dataSpecificInfo=null nrState=NONE rRplmn=}, NetworkRegistrationInfo{ domain=PS transportType=WWAN registrationState=UNKNOWN roamingType=NOT_ROAMING accessNetworkTechnology=UNKNOWN rejectCause=0 emergencyEnabled=false availableServices=[] cellIdentity=null voiceSpecificInfo=null dataSpecificInfo=null nrState=NONE rRplmn=}], mNrFrequencyRange=0, mOperatorAlphaLongRaw=CHN-UNICOM, mOperatorAlphaShortRaw=UNICOM, mIsDataRoamingFromRegistration=false, mIsIwlanPreferred=false} sender=Handler (com.android.internal.telephony.GsmCdmaPhone) {8d58632} phondId=0 subId=-1 06-26 14:34:47.024 434 792 D TelephonyRegistry: notifyServiceStateForSubscriber: INVALID phoneId=0 or subId=-1 06-26 14:34:47.026 434 792 E PHONE : ServiceState.getRadioTechnology() DEPRECATED will be removed ******* 06-26 14:34:47.047 848 848 D NetworkTypeController: [0] LegacyState: process EVENT_DATA_RAT_CHANGED 06-26 14:34:47.047 848 848 D NetworkTypeController: [0] Remove all timers 06-26 14:34:47.047 848 848 D NetworkTypeController: [0] Remove all timers 06-26 14:34:47.048 848 848 D DCT-C-0 : reevaluateUnmeteredConnections 06-26 14:34:47.055 848 848 D DataService: Data service created 06-26 14:34:47.060 848 848 D PhoneCfgMgr: 102 failure. Not updating modem status.com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED 06-26 14:34:47.060 848 848 D PhoneCfgMgr: 103 failure. Not getting phone capability.com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED 06-26 14:34:47.062 848 848 D DcRequest: Cellular request confirmed: NetworkRequest [ REQUEST id=12, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN AdministratorUids: [] RequestorUid: 1073 RequestorPackageName: com.android.networkstack] ] 06-26 14:34:47.065 848 848 D PhoneSwitcher: evaluating due to netRequest 06-26 14:34:47.066 848 848 D PhoneSwitcher: notifyPreferredDataSubIdChanged to -1 06-26 14:34:47.070 848 848 D PhoneSwitcher: Added DcRequest, size: 1 06-26 14:34:47.071 848 848 D TelephonyNetworkFactory[0]: got request NetworkRequest [ TRACK_DEFAULT id=18, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 1001 AdministratorUids: [] RequestorUid: 1001 RequestorPackageName: com.android.phone] ] with score 0 and providerId 0 06-26 14:34:47.077 848 848 D DcRequest: Cellular request confirmed: NetworkRequest [ REQUEST id=1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN AdministratorUids: [] RequestorUid: 1000 RequestorPackageName: android] ] 06-26 14:34:47.077 848 848 D PhoneSwitcher: evaluating due to netRequest 06-26 14:34:47.078 848 848 D PhoneSwitcher: notifyPreferredDataSubIdChanged to -1 06-26 14:34:47.080 848 848 D PhoneSwitcher: Added DcRequest, size: 2 06-26 14:34:47.082 848 848 D DcRequest: Cellular request confirmed: NetworkRequest [ BACKGROUND_REQUEST id=2, [ Transports: CELLULAR Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN AdministratorUids: [] RequestorUid: 1000 RequestorPackageName: android] ] 06-26 14:34:47.082 848 848 D PhoneSwitcher: evaluating due to netRequest 06-26 14:34:47.084 848 848 D PhoneSwitcher: notifyPreferredDataSubIdChanged to -1 06-26 14:34:47.088 848 848 D PhoneSwitcher: Added DcRequest, size: 3 06-26 14:34:47.090 848 848 D DcRequest: Cellular request confirmed: NetworkRequest [ TRACK_DEFAULT id=9, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 1000 AdministratorUids: [] RequestorUid: 1000 RequestorPackageName: android] ] 06-26 14:34:47.091 848 848 D PhoneSwitcher: evaluating due to netRequest 06-26 14:34:47.091 848 848 D PhoneSwitcher: notifyPreferredDataSubIdChanged to -1 06-26 14:34:47.093 848 848 D PhoneSwitcher: Added DcRequest, size: 4 06-26 14:34:47.095 848 848 D DcRequest: Cellular request confirmed: NetworkRequest [ TRACK_DEFAULT id=10, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 1073 AdministratorUids: [] RequestorUid: 1073 RequestorPackageName: com.android.networkstack] ] 06-26 14:34:47.096 848 848 D PhoneSwitcher: evaluating due to netRequest 06-26 14:34:47.096 848 848 D PhoneSwitcher: notifyPreferredDataSubIdChanged to -1 06-26 14:34:47.098 848 848 D PhoneSwitcher: Added DcRequest, size: 5 06-26 14:34:47.099 848 848 D DcRequest: Cellular request confirmed: NetworkRequest [ TRACK_DEFAULT id=15, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 10109 AdministratorUids: [] RequestorUid: 10109 RequestorPackageName: com.android.systemui] ] 06-26 14:34:47.099 848 848 D PhoneSwitcher: evaluating due to netRequest 06-26 14:34:47.100 848 848 D PhoneSwitcher: notifyPreferredDataSubIdChanged to -1 06-26 14:34:47.102 848 848 D PhoneSwitcher: Added DcRequest, size: 6 06-26 14:34:47.105 848 848 D DcRequest: Cellular request confirmed: NetworkRequest [ TRACK_DEFAULT id=16, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 10109 AdministratorUids: [] RequestorUid: 10109 RequestorPackageName: com.android.systemui] ] 06-26 14:34:47.105 848 848 D PhoneSwitcher: evaluating due to netRequest 06-26 14:34:47.107 848 848 D PhoneSwitcher: notifyPreferredDataSubIdChanged to -1 06-26 14:34:47.109 848 848 D PhoneSwitcher: Added DcRequest, size: 7 06-26 14:34:47.109 848 848 D TelephonyNetworkFactory[0]: onNeedNetworkFor NetworkRequest [ TRACK_DEFAULT id=15, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 10109 AdministratorUids: [] RequestorUid: 10109 RequestorPackageName: com.android.systemui] ] shouldApply false 06-26 14:34:47.110 848 848 D TelephonyNetworkFactory[0]: onNeedNetworkFor NetworkRequest [ TRACK_DEFAULT id=16, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 10109 AdministratorUids: [] RequestorUid: 10109 RequestorPackageName: com.android.systemui] ] shouldApply false 06-26 14:34:47.110 848 848 D TelephonyNetworkFactory[0]: onNeedNetworkFor NetworkRequest [ REQUEST id=12, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN AdministratorUids: [] RequestorUid: 1073 RequestorPackageName: com.android.networkstack] ] shouldApply false 06-26 14:34:47.110 848 848 D TelephonyNetworkFactory[0]: onNeedNetworkFor NetworkRequest [ TRACK_DEFAULT id=9, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 1000 AdministratorUids: [] RequestorUid: 1000 RequestorPackageName: android] ] shouldApply false 06-26 14:34:47.111 848 848 D TelephonyNetworkFactory[0]: onNeedNetworkFor NetworkRequest [ TRACK_DEFAULT id=10, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 1073 AdministratorUids: [] RequestorUid: 1073 RequestorPackageName: com.android.networkstack] ] shouldApply false 06-26 14:34:47.112 848 848 D TelephonyNetworkFactory[0]: onNeedNetworkFor NetworkRequest [ REQUEST id=1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN AdministratorUids: [] RequestorUid: 1000 RequestorPackageName: android] ] shouldApply false 06-26 14:34:47.112 848 848 D TelephonyNetworkFactory[0]: onNeedNetworkFor NetworkRequest [ BACKGROUND_REQUEST id=2, [ Transports: CELLULAR Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN AdministratorUids: [] RequestorUid: 1000 RequestorPackageName: android] ] shouldApply false 06-26 14:34:47.135 848 848 D NRM-C-0 : service ComponentInfo{com.android.phone/com.android.internal.telephony.CellularNetworkService} for transport WWAN is now connected. 06-26 14:34:47.137 848 848 D EmergencyNumberTracker: ACTION_NETWORK_COUNTRY_CHANGED: PhoneId: 0 CountryIso: 06-26 14:34:47.140 848 848 D Phone : isImsRegistered =false 06-26 14:34:47.166 848 848 D LocaleTracker-0: updateLocale: countryIso = cn, countryIsoDebugInfo = OperatorNumeric(46001): MccTable.countryCodeForMcc("460") 06-26 14:34:47.166 848 848 D LocaleTracker-0: updateLocale: Change the current country to "cn", countryIsoDebugInfo = OperatorNumeric(46001): MccTable.countryCodeForMcc("460"), mCellInfoList = null 06-26 14:34:47.167 848 848 D LocaleTracker-0: update country iso in sharedPrefs cn 06-26 14:34:47.171 848 848 D SubscriptionManager: putPhoneIdAndSubIdExtra: no valid subs 06-26 14:34:47.179 848 848 D LocaleTracker-0: updateLocale: timeZoneCountryIso = cn, timeZoneCountryIsoDebugInfo = OperatorNumeric: MccTable.geoCountryCodeForMccMnc(MccMnc{mcc='460', mnc='01'}) 06-26 14:34:47.179 848 848 D NewNitzStateMachineImpl: handleCountryDetected: countryIsoCode=cn, mLatestNitzSignal=TimestampedValue{mReferenceTimeMillis=16099, mValue=NitzData{mOriginalString=26/06/26,06:34:41+32,0, mZoneOffset=28800000, mDstOffset=0, mCurrentTimeMillis=1782455681000, mEmulatorHostTimeZone=null}} 06-26 14:34:47.181 848 848 D NetworkTypeController: [0] LegacyState: process EVENT_DATA_RAT_CHANGED 06-26 14:34:47.181 848 848 D NetworkTypeController: [0] Remove all timers 06-26 14:34:47.181 848 848 D NetworkTypeController: [0] Remove all timers 06-26 14:34:47.182 848 848 D DSM-C-0 : onServiceConnected 06-26 14:34:47.182 848 1389 D CellularDataService: Cellular data service created for slot 0 06-26 14:34:47.187 848 848 D DcRequest: Cellular request confirmed: NetworkRequest [ TRACK_DEFAULT id=18, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 1001 AdministratorUids: [] RequestorUid: 1001 RequestorPackageName: com.android.phone] ] 06-26 14:34:47.188 848 848 D PhoneSwitcher: evaluating due to netRequest 06-26 14:34:47.188 848 848 D PhoneSwitcher: notifyPreferredDataSubIdChanged to -1 06-26 14:34:47.191 848 848 D PhoneSwitcher: Added DcRequest, size: 8 06-26 14:34:47.192 848 848 D TelephonyNetworkFactory[0]: onNeedNetworkFor NetworkRequest [ TRACK_DEFAULT id=18, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 1001 AdministratorUids: [] RequestorUid: 1001 RequestorPackageName: com.android.phone] ] shouldApply false 06-26 14:34:47.206 848 848 D EmergencyNumberTracker: ACTION_NETWORK_COUNTRY_CHANGED: PhoneId: 0 CountryIso: cn 06-26 14:34:47.208 848 848 D Phone : isImsRegistered =false 06-26 14:34:47.219 848 848 D EmergencyNumberTracker: updateEmergencyNumberListDatabaseAndNotify(): receiving countryIso: cn 06-26 14:34:47.226 848 848 D EmergencyNumberTracker: cn asset emergency database is loaded. Ver: 1 Phone Id: 0 06-26 14:34:47.227 848 848 E EmergencyNumberTracker: Cache ota emergency database IOException: java.io.FileNotFoundException: /data/misc/emergencynumberdb/emergency_number_db: open failed: ENOENT (No such file or directory) 06-26 14:34:47.227 848 848 D EmergencyNumberTracker: Using Asset Emergency database. Version: 1 06-26 14:34:47.229 848 848 D SubscriptionController: [getSlotIndex]- subId invalid 06-26 14:34:47.229 848 848 E EmergencyNumber: Found unexpected duplicate numbers: EmergencyNumber:Number-112|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 vs EmergencyNumber:Number-112|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 06-26 14:34:47.230 848 848 E EmergencyNumber: Found unexpected duplicate numbers: EmergencyNumber:Number-911|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 vs EmergencyNumber:Number-911|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 06-26 14:34:47.233 848 848 D SubscriptionController: [getSlotIndex]- subId invalid 06-26 14:34:47.233 848 848 E EmergencyNumber: Found unexpected duplicate numbers: EmergencyNumber:Number-112|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 vs EmergencyNumber:Number-112|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 06-26 14:34:47.233 848 848 E EmergencyNumber: Found unexpected duplicate numbers: EmergencyNumber:Number-911|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 vs EmergencyNumber:Number-911|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 06-26 14:34:47.234 848 848 D SubscriptionController: [getSlotIndex]- subId invalid 06-26 14:34:47.234 848 848 E EmergencyNumber: Found unexpected duplicate numbers: EmergencyNumber:Number-112|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 vs EmergencyNumber:Number-112|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 06-26 14:34:47.235 848 848 E EmergencyNumber: Found unexpected duplicate numbers: EmergencyNumber:Number-911|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 vs EmergencyNumber:Number-911|CountryIso-|Mnc-|ServiceCategories-0|Urns-[]|Sources-0|Routing-0 06-26 14:34:47.239 848 848 D EmergencyNumberTracker: notifyEmergencyNumberList(): notified 06-26 14:34:48.477 848 848 D CAT : BootCompletedReceiver: [ACTION_BOOT_COMPLETED] 06-26 14:34:48.478 848 848 D CAT : StkAppService: onCreate()+ 06-26 14:34:48.479 848 848 D CAT : StkAppService: simCount: 1 06-26 14:34:48.479 848 848 D CAT : StkAppService: slotId: 0 06-26 14:34:48.481 848 848 D CAT : StkAppService: onStart sim id: 0, op: 5, ***** 06-26 14:34:48.481 848 848 D CAT : StkAppService: mStkService is: -1 06-26 14:34:48.483 848 848 D CAT : StkAppInstaller: [setAppState]+ 06-26 14:34:48.484 848 848 D CAT : StkAppInstaller: Need not change app state!! 06-26 14:34:48.484 848 848 D CAT : StkAppInstaller: [setAppState]- 06-26 14:34:48.485 848 848 D CAT : StkAppService: onDestroy() 06-26 14:34:51.575 848 848 D DcRequest: Cellular request confirmed: NetworkRequest [ TRACK_DEFAULT id=18, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 1001 AdministratorUids: [] RequestorUid: 1001 RequestorPackageName: com.android.phone] ] 06-26 14:34:51.576 848 848 D PhoneSwitcher: evaluating due to netReleased 06-26 14:34:51.576 848 848 D PhoneSwitcher: notifyPreferredDataSubIdChanged to -1 06-26 14:34:51.579 848 848 D PhoneSwitcher: Removed DcRequest, size: 7 06-26 14:34:51.580 848 848 D TelephonyNetworkFactory[0]: onReleaseNetworkFor NetworkRequest [ TRACK_DEFAULT id=18, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED Uid: 1001 AdministratorUids: [] RequestorUid: 1001 RequestorPackageName: com.android.phone] ] applied false 06-26 14:34:54.813 366 422 D SIGNAL_STRENGTH: requestSignalStrength:816 iradio_version = 4 06-26 14:34:54.814 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:34:54.816 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:34:54.816 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:34:54.816 366 425 D ATC : AT< OK 06-26 14:34:54.816 366 422 D ATC : AT> AT+QENG="servingcell" 06-26 14:34:54.820 366 425 D ATC : AT< +QENG: "servingcell","NOCONN","LTE","FDD",460,01,8F46F4F,300,1800,3,5,5,F40B,-90,-13,-57,7,31 06-26 14:34:54.820 366 425 D ATC : AT< OK 06-26 14:34:54.820 366 422 D CELL_INFO: parseServingCell_234G:699 Enter... 06-26 14:34:54.820 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:34:54.822 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:34:54.822 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:34:54.822 366 425 D ATC : AT< OK 06-26 14:34:54.823 366 422 D CELL_INFO: parseServingCell_234G:767 LTE RSRP=-90 06-26 14:34:54.823 366 422 D CELL_INFO: parseServingCell_234G:802 *count = 1 06-26 14:34:54.823 366 422 D ATC : AT> AT+CSQ 06-26 14:34:54.824 366 425 D ATC : AT< +CSQ: 27,99 06-26 14:34:54.824 366 425 D ATC : AT< OK 06-26 14:34:54.825 366 422 D RADIO_1_4: getSignalStrength_1_4:588 LTE RSRP = 90 RSRQ = 13 06-26 14:34:54.825 366 422 D RILC : isNetworkInNrEndc 772 Enter: 0 06-26 14:34:54.825 366 422 D RILC : isNetworkInNrEndc 799 End, is_NR_ENDC:0 06-26 14:34:54.825 366 422 E RILC : currentSignalStrengthInd: invalid response 06-26 14:35:14.825 366 422 D SIGNAL_STRENGTH: requestSignalStrength:816 iradio_version = 4 06-26 14:35:14.826 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:35:14.828 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:35:14.828 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:35:14.828 366 425 D ATC : AT< OK 06-26 14:35:14.828 366 422 D ATC : AT> AT+QENG="servingcell" 06-26 14:35:14.832 366 425 D ATC : AT< +QENG: "servingcell","NOCONN","LTE","FDD",460,01,8F46F4F,300,1800,3,5,5,F40B,-90,-9,-61,8,32 06-26 14:35:14.832 366 425 D ATC : AT< OK 06-26 14:35:14.832 366 422 D CELL_INFO: parseServingCell_234G:699 Enter... 06-26 14:35:14.833 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:35:14.835 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:35:14.835 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:35:14.835 366 425 D ATC : AT< OK 06-26 14:35:14.835 366 422 D CELL_INFO: parseServingCell_234G:767 LTE RSRP=-90 06-26 14:35:14.836 366 422 D CELL_INFO: parseServingCell_234G:802 *count = 1 06-26 14:35:14.836 366 422 D ATC : AT> AT+CSQ 06-26 14:35:14.837 366 425 D ATC : AT< +CSQ: 27,99 06-26 14:35:14.837 366 425 D ATC : AT< OK 06-26 14:35:14.838 366 422 D RADIO_1_4: getSignalStrength_1_4:588 LTE RSRP = 90 RSRQ = 9 06-26 14:35:14.838 366 422 D RILC : isNetworkInNrEndc 772 Enter: 0 06-26 14:35:14.838 366 422 D RILC : isNetworkInNrEndc 799 End, is_NR_ENDC:0 06-26 14:35:14.838 366 422 E RILC : currentSignalStrengthInd: invalid response 06-26 14:35:34.846 366 422 D SIGNAL_STRENGTH: requestSignalStrength:816 iradio_version = 4 06-26 14:35:34.847 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:35:34.849 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:35:34.849 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:35:34.850 366 425 D ATC : AT< OK 06-26 14:35:34.850 366 422 D ATC : AT> AT+QENG="servingcell" 06-26 14:35:34.854 366 425 D ATC : AT< +QENG: "servingcell","NOCONN","LTE","FDD",460,01,8F46F4F,300,1800,3,5,5,F40B,-90,-10,-60,6,33 06-26 14:35:34.854 366 425 D ATC : AT< OK 06-26 14:35:34.854 366 422 D CELL_INFO: parseServingCell_234G:699 Enter... 06-26 14:35:34.854 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:35:34.856 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:35:34.857 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:35:34.857 366 425 D ATC : AT< OK 06-26 14:35:34.857 366 422 D CELL_INFO: parseServingCell_234G:767 LTE RSRP=-90 06-26 14:35:34.857 366 422 D CELL_INFO: parseServingCell_234G:802 *count = 1 06-26 14:35:34.857 366 422 D ATC : AT> AT+CSQ 06-26 14:35:34.859 366 425 D ATC : AT< +CSQ: 27,99 06-26 14:35:34.859 366 425 D ATC : AT< OK 06-26 14:35:34.860 366 422 D RADIO_1_4: getSignalStrength_1_4:588 LTE RSRP = 90 RSRQ = 10 06-26 14:35:34.860 366 422 D RILC : isNetworkInNrEndc 772 Enter: 0 06-26 14:35:34.860 366 422 D RILC : isNetworkInNrEndc 799 End, is_NR_ENDC:0 06-26 14:35:34.860 366 422 E RILC : currentSignalStrengthInd: invalid response 06-26 14:35:46.381 848 848 D RILJ : NOTE: mWakeLockCount is 8at time of clearing 06-26 14:35:46.382 848 848 D RILJ : WAKE_LOCK_TIMEOUT mRequestList=8 06-26 14:35:46.382 848 848 D RILJ : 0: [24] RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA 06-26 14:35:46.382 848 848 D RILJ : 1: [25] RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA 06-26 14:35:46.382 848 848 D RILJ : 2: [26] RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA 06-26 14:35:46.383 848 848 D RILJ : 3: [27] RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA 06-26 14:35:46.383 848 848 D RILJ : 4: [32] RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA 06-26 14:35:46.383 848 848 D RILJ : 5: [33] RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA 06-26 14:35:46.383 848 848 D RILJ : 6: [34] RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA 06-26 14:35:46.383 848 848 D RILJ : 7: [35] RIL_REQUEST_SET_LINK_CAPACITY_REPORTING_CRITERIA 06-26 14:35:54.880 366 422 D SIGNAL_STRENGTH: requestSignalStrength:816 iradio_version = 4 06-26 14:35:54.881 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:35:54.883 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:35:54.883 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:35:54.883 366 425 D ATC : AT< OK 06-26 14:35:54.884 366 422 D ATC : AT> AT+QENG="servingcell" 06-26 14:35:54.887 366 425 D ATC : AT< +QENG: "servingcell","NOCONN","LTE","FDD",460,01,8F46F4F,300,1800,3,5,5,F40B,-90,-10,-60,7,33 06-26 14:35:54.887 366 425 D ATC : AT< OK 06-26 14:35:54.888 366 422 D CELL_INFO: parseServingCell_234G:699 Enter... 06-26 14:35:54.888 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:35:54.890 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:35:54.890 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:35:54.890 366 425 D ATC : AT< OK 06-26 14:35:54.891 366 422 D CELL_INFO: parseServingCell_234G:767 LTE RSRP=-90 06-26 14:35:54.891 366 422 D CELL_INFO: parseServingCell_234G:802 *count = 1 06-26 14:35:54.891 366 422 D ATC : AT> AT+CSQ 06-26 14:35:54.893 366 425 D ATC : AT< +CSQ: 27,99 06-26 14:35:54.893 366 425 D ATC : AT< OK 06-26 14:35:54.893 366 422 D RADIO_1_4: getSignalStrength_1_4:588 LTE RSRP = 90 RSRQ = 10 06-26 14:35:54.893 366 422 D RILC : isNetworkInNrEndc 772 Enter: 0 06-26 14:35:54.893 366 422 D RILC : isNetworkInNrEndc 799 End, is_NR_ENDC:0 06-26 14:35:54.893 366 422 E RILC : currentSignalStrengthInd: invalid response 06-26 14:36:14.913 366 422 D SIGNAL_STRENGTH: requestSignalStrength:816 iradio_version = 4 06-26 14:36:14.913 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:36:14.916 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:36:14.916 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:36:14.916 366 425 D ATC : AT< OK 06-26 14:36:14.916 366 422 D ATC : AT> AT+QENG="servingcell" 06-26 14:36:14.920 366 425 D ATC : AT< +QENG: "servingcell","NOCONN","LTE","FDD",460,01,8F46F4F,300,1800,3,5,5,F40B,-90,-10,-60,8,32 06-26 14:36:14.920 366 425 D ATC : AT< OK 06-26 14:36:14.920 366 422 D CELL_INFO: parseServingCell_234G:699 Enter... 06-26 14:36:14.921 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:36:14.923 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:36:14.923 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:36:14.923 366 425 D ATC : AT< OK 06-26 14:36:14.923 366 422 D CELL_INFO: parseServingCell_234G:767 LTE RSRP=-90 06-26 14:36:14.924 366 422 D CELL_INFO: parseServingCell_234G:802 *count = 1 06-26 14:36:14.924 366 422 D ATC : AT> AT+CSQ 06-26 14:36:14.925 366 425 D ATC : AT< +CSQ: 27,99 06-26 14:36:14.926 366 425 D ATC : AT< OK 06-26 14:36:14.926 366 422 D RADIO_1_4: getSignalStrength_1_4:588 LTE RSRP = 90 RSRQ = 10 06-26 14:36:14.926 366 422 D RILC : isNetworkInNrEndc 772 Enter: 0 06-26 14:36:14.926 366 422 D RILC : isNetworkInNrEndc 799 End, is_NR_ENDC:0 06-26 14:36:14.926 366 422 E RILC : currentSignalStrengthInd: invalid response 06-26 14:36:34.947 366 422 D SIGNAL_STRENGTH: requestSignalStrength:816 iradio_version = 4 06-26 14:36:34.947 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:36:34.950 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:36:34.950 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:36:34.950 366 425 D ATC : AT< OK 06-26 14:36:34.950 366 422 D ATC : AT> AT+QENG="servingcell" 06-26 14:36:34.954 366 425 D ATC : AT< +QENG: "servingcell","NOCONN","LTE","FDD",460,01,8F46F4F,300,1800,3,5,5,F40B,-89,-10,-59,7,34 06-26 14:36:34.954 366 425 D ATC : AT< OK 06-26 14:36:34.954 366 422 D CELL_INFO: parseServingCell_234G:699 Enter... 06-26 14:36:34.954 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:36:34.957 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:36:34.957 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:36:34.957 366 425 D ATC : AT< OK 06-26 14:36:34.957 366 422 D CELL_INFO: parseServingCell_234G:767 LTE RSRP=-89 06-26 14:36:34.958 366 422 D CELL_INFO: parseServingCell_234G:802 *count = 1 06-26 14:36:34.958 366 422 D ATC : AT> AT+CSQ 06-26 14:36:34.959 366 425 D ATC : AT< +CSQ: 27,99 06-26 14:36:34.959 366 425 D ATC : AT< OK 06-26 14:36:34.960 366 422 D RADIO_1_4: getSignalStrength_1_4:588 LTE RSRP = 89 RSRQ = 10 06-26 14:36:34.960 366 422 D RILC : isNetworkInNrEndc 772 Enter: 0 06-26 14:36:34.960 366 422 D RILC : isNetworkInNrEndc 799 End, is_NR_ENDC:0 06-26 14:36:34.960 366 422 E RILC : currentSignalStrengthInd: invalid response 06-26 14:36:54.981 366 422 D SIGNAL_STRENGTH: requestSignalStrength:816 iradio_version = 4 06-26 14:36:54.981 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:36:54.983 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:36:54.983 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:36:54.983 366 425 D ATC : AT< OK 06-26 14:36:54.984 366 422 D ATC : AT> AT+QENG="servingcell" 06-26 14:36:54.987 366 425 D ATC : AT< +QENG: "servingcell","NOCONN","LTE","FDD",460,01,8F46F4F,300,1800,3,5,5,F40B,-90,-9,-61,7,32 06-26 14:36:54.988 366 425 D ATC : AT< OK 06-26 14:36:54.988 366 422 D CELL_INFO: parseServingCell_234G:699 Enter... 06-26 14:36:54.988 366 422 D ATC : AT> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS? 06-26 14:36:54.991 366 425 D ATC : AT< +COPS: 0,0,"CHN-UNICOM",7 06-26 14:36:54.991 366 425 D ATC : AT< +COPS: 0,1,"UNICOM",7 06-26 14:36:54.991 366 425 D ATC : AT< OK 06-26 14:36:54.991 366 422 D CELL_INFO: parseServingCell_234G:767 LTE RSRP=-90 06-26 14:36:54.991 366 422 D CELL_INFO: parseServingCell_234G:802 *count = 1 06-26 14:36:54.991 366 422 D ATC : AT> AT+CSQ 06-26 14:36:54.993 366 425 D ATC : AT< +CSQ: 27,99 06-26 14:36:54.993 366 425 D ATC : AT< OK 06-26 14:36:54.994 366 422 D RADIO_1_4: getSignalStrength_1_4:588 LTE RSRP = 90 RSRQ = 9 06-26 14:36:54.994 366 422 D RILC : isNetworkInNrEndc 772 Enter: 0 06-26 14:36:54.994 366 422 D RILC : isNetworkInNrEndc 799 End, is_NR_ENDC:0 06-26 14:36:54.994 366 422 E RILC : currentSignalStrengthInd: invalid response