x86_64:/ # logcat -b radio 10-25 15:06:53.341 1727 1727 D SubscriptionController: [getActiveSubscriptionInfoForSimSlotIndex]+ slotIndex=0 subId={id=1, iccId=89918570400285867536 simSlotIndex=0 displayName=CARD 1 carrierName=Emergency calls only nameSource=0 iconTint=-16746133 dataRoaming=0 iconBitmap=android.graphics.Bitmap@71690d1 mcc 405 mnc 857 isEmbedded false accessRules null} 10-25 15:06:54.902 1199 1303 D use-Rlog/RLOG-RIL: nasSigInfoCallback invoked 10-25 15:06:54.965 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[0]=5 10-25 15:06:54.966 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 SignalStrength[0]=-105 10-25 15:06:54.966 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[1]=5 10-25 15:06:54.966 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 SignalStrength[1]=-105 10-25 15:06:55.030 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 TD SCDMA RSCP=0 10-25 15:06:55.030 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for SIGNAL_STRENGTH 10-25 15:06:55.030 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for SIGNAL_STRENGTH 10-25 15:06:59.383 1199 1303 D use-Rlog/RLOG-RIL: nasSigInfoCallback invoked 10-25 15:06:59.447 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[0]=5 10-25 15:06:59.447 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 SignalStrength[0]=-105 10-25 15:06:59.447 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[1]=5 10-25 15:06:59.447 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 SignalStrength[1]=-105 10-25 15:06:59.511 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 TD SCDMA RSCP=0 10-25 15:06:59.511 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for SIGNAL_STRENGTH 10-25 15:06:59.751 3133 3133 D TDC : updateOrInsert: inserting: Modem { uuid=modem, state=0, rilModel=0, rat={}, maxActiveVoiceCall=1, maxActiveDataCall=1, maxStandby=1 } 10-25 15:06:59.752 3133 3133 D TDC : updateOrInsert: inserting: Sim { uuid=sim, modemUuid=modem, state=0 } 10-25 15:06:59.756 3133 3133 D CdmaSSM : subscriptionSource from settings: 0 10-25 15:06:59.757 3133 3133 I PhoneFactory: Cdma Subscription set to 0 10-25 15:06:59.757 3133 3133 I PhoneFactory: ImsResolver: defaultImsPackage: 10-25 15:06:59.771 3133 3133 I PhoneFactory: Network Mode set to 0 10-25 15:06:59.772 3133 3133 D RILJ : RIL: init preferredNetworkType=0 cdmaSubscription=0) 10-25 15:06:59.779 1199 1199 D RILC : setResponseFunctions 10-25 15:06:59.783 1199 1199 D RILC : rilConnectedInd 10-25 15:06:59.783 1199 1199 D RILC : radioStateChangedInd: radioState 10 10-25 15:06:59.783 1199 1199 I RILC : RIL Daemon version: Sierra Ril V8.1.2 QMI 10-25 15:06:59.783 3133 3151 D RILJ : [UNSL]< UNSOL_RIL_CONNECTED [SUB0] 10-25 15:06:59.786 3133 3151 D RILJ : [3648]> RADIO_POWER on = false [SUB0] 10-25 15:06:59.787 1199 1199 D RILC : setRadioPower: serial 0 on 0 10-25 15:06:59.787 3133 3133 D RILJ : [3649]> GET_HARDWARE_CONFIG [SUB0] 10-25 15:06:59.787 1199 1369 E use-Rlog/RLOG-RIL: processRequest: RADIO_POWER 10-25 15:06:59.787 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for VOICE_REGISTRATION_STATE 10-25 15:06:59.787 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for DATA_REGISTRATION_STATE 10-25 15:06:59.787 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for SIGNAL_STRENGTH 10-25 15:06:59.787 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for OPERATOR 10-25 15:06:59.787 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for QUERY_NETWORK_SELECTION_MODE 10-25 15:06:59.787 1199 1369 D use-Rlog/RLOG-RIL: requestRadioPowerUMTS 0 10-25 15:06:59.787 3133 3151 D RILJ : [3650]> RIL_REQUEST_CDMA_SET_SUBSCRIPTION_SOURCE cdmaSubscription = 0 [SUB0] 10-25 15:06:59.789 3133 3151 D RILJ : [3651]> RIL_REQUEST_SET_CELL_INFO_LIST_RATE rateInMillis = 2147483647 [SUB0] 10-25 15:06:59.789 3133 3133 I PhoneFactory: Creating SubscriptionController 10-25 15:06:59.789 3133 3151 D RILJ : [UNSL]< UNSOL_RESPONSE_RADIO_STATE_CHANGED radioStateChanged: RADIO_ON [SUB0] 10-25 15:06:59.790 3133 3133 D SubscriptionController: [SubscriptionController] init by Context 10-25 15:06:59.791 3133 3133 D UiccController: Creating UiccController 10-25 15:06:59.794 3133 3133 D TelephonyTester: register for intent action=com.android.internal.telephony.action_detached 10-25 15:06:59.794 3133 3133 D TelephonyTester: register for intent action=com.android.internal.telephony.action_attached 10-25 15:06:59.796 3133 3133 D Phone : mDoesRilSendMultipleCallRing=true 10-25 15:06:59.796 3133 3133 D Phone : mCallRingDelay=3000 10-25 15:06:59.799 1199 1369 I use-Rlog/RLOG-RIL: DHCP: 0, 10-25 15:06:59.799 1199 1369 D RILC : radioStateChangedInd: radioState 0 10-25 15:06:59.799 1199 1369 D RILC : setRadioPowerResponse: serial 0 10-25 15:06:59.799 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GET_HARDWARE_CONFIG 10-25 15:06:59.799 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GET_HARDWARE_CONFIG 10-25 15:06:59.799 1199 1369 E use-Rlog/RLOG-RIL: processRequest: CDMA_SET_SUBSCRIPTION_SOURCE 10-25 15:06:59.799 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: CDMA_SET_SUBSCRIPTION_SOURCE 10-25 15:06:59.799 3133 3151 D RILJ : [UNSL]< UNSOL_RESPONSE_RADIO_STATE_CHANGED radioStateChanged: RADIO_OFF [SUB0] 10-25 15:06:59.799 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SET_UNSOL_CELL_INFO_LIST_RATE 10-25 15:06:59.799 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: SET_UNSOL_CELL_INFO_LIST_RATE 10-25 15:06:59.800 3133 3151 D RILJ : [3648]< RADIO_POWER [SUB0] 10-25 15:06:59.801 3133 3151 D RILJ : [3649]< GET_HARDWARE_CONFIG error 6 [SUB0] 10-25 15:06:59.802 3133 3151 D RilRequest: [3649]< GET_HARDWARE_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:06:59.802 3133 3133 D RILJ : [3652]> RIL_REQUEST_START_LCE reportIntervalMs = 200 pullMode = true [SUB0] 10-25 15:06:59.802 3133 3151 D RILJ : [3650]< RIL_REQUEST_CDMA_SET_SUBSCRIPTION_SOURCE error 6 [SUB0] 10-25 15:06:59.802 3133 3151 D RilRequest: [3650]< RIL_REQUEST_CDMA_SET_SUBSCRIPTION_SOURCE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:06:59.803 3133 3151 D RILJ : [3651]< RIL_REQUEST_SET_CELL_INFO_LIST_RATE error 6 [SUB0] 10-25 15:06:59.803 1199 1369 E use-Rlog/RLOG-RIL: processRequest: START_LCE 10-25 15:06:59.803 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: START_LCE 10-25 15:06:59.803 1199 1369 E RILC : Invalid response: NULL 10-25 15:06:59.803 3133 3151 D RilRequest: [3651]< RIL_REQUEST_SET_CELL_INFO_LIST_RATE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:06:59.803 3133 3151 D RILJ : [3652]< RIL_REQUEST_START_LCE error 6 [SUB0] 10-25 15:06:59.804 3133 3151 D RilRequest: [3652]< RIL_REQUEST_START_LCE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret=[0, 0] 10-25 15:06:59.808 3133 3133 E RIL_ImsSms: getFormat should never be called from here! 10-25 15:06:59.808 3133 3133 D SMSDispatcher: SMSDispatcher: ctor mSmsCapable=true format=unknown mSmsSendDisabled=false 10-25 15:06:59.808 3133 3133 D RIL_ImsSms: ImsSMSDispatcher created 10-25 15:06:59.809 3133 3133 D SMSDispatcher: SMSDispatcher: ctor mSmsCapable=true format=3gpp2 mSmsSendDisabled=false 10-25 15:06:59.809 3133 3133 D CdmaSMSDispatcher: CdmaSMSDispatcher created 10-25 15:06:59.814 3133 3133 E WAP PUSH: bindService() for wappush manager failed 10-25 15:06:59.815 3133 3133 D GsmInboundSmsHandler: created InboundSmsHandler 10-25 15:06:59.815 3133 3154 D GsmInboundSmsHandler: entering Startup state 10-25 15:06:59.818 3133 3133 E WAP PUSH: bindService() for wappush manager failed 10-25 15:06:59.818 3133 3133 D CdmaInboundSmsHandler: created InboundSmsHandler 10-25 15:06:59.820 3133 3156 D CdmaInboundSmsHandler: entering Startup state 10-25 15:06:59.821 3133 3133 D SMSDispatcher: SMSDispatcher: ctor mSmsCapable=true format=3gpp mSmsSendDisabled=false 10-25 15:06:59.821 3133 3133 D GsmSMSDispatcher: GsmSMSDispatcher created 10-25 15:06:59.822 3133 3156 D CdmaInboundSmsHandler: StartupState.processMessage:6 10-25 15:06:59.822 3133 3158 D SmsBroadcastUndelivered: scanning raw table for undelivered messages 10-25 15:06:59.822 3133 3156 D CdmaInboundSmsHandler: entering Idle state 10-25 15:06:59.822 3133 3156 D CdmaInboundSmsHandler: IdleState.processMessage:5 10-25 15:06:59.822 3133 3156 D CdmaInboundSmsHandler: Idle state processing message type 5 10-25 15:06:59.822 3133 3154 D GsmInboundSmsHandler: StartupState.processMessage:6 10-25 15:06:59.822 3133 3154 D GsmInboundSmsHandler: entering Idle state 10-25 15:06:59.822 3133 3154 D GsmInboundSmsHandler: IdleState.processMessage:5 10-25 15:06:59.822 3133 3154 D GsmInboundSmsHandler: Idle state processing message type 5 10-25 15:06:59.823 3133 3156 D CdmaInboundSmsHandler: mWakeLock released 10-25 15:06:59.823 3133 3154 D GsmInboundSmsHandler: mWakeLock released 10-25 15:06:59.825 3133 3133 D IccCardProxy: ctor: ci=com.android.internal.telephony.RIL@a79d7a1 phoneId=0 10-25 15:06:59.826 3133 3133 D CdmaSSM : subscriptionSource from settings: 0 10-25 15:06:59.826 3133 3133 D CdmaSSM : cdmaSSM constructor: 0 10-25 15:06:59.826 3133 3133 D IccCardProxy: update icc_operator_numeric= 10-25 15:06:59.826 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.sim.operator.numeric value: propVal= 10-25 15:06:59.827 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.sim.operator.iso-country value: propVal= 10-25 15:06:59.827 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.sim.operator.alpha value: propVal= 10-25 15:06:59.831 3133 3133 D RILJ : setPhoneType=1 old value=0 [SUB0] 10-25 15:06:59.831 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.current.phone-type value: 1 propVal=1 10-25 15:06:59.832 3133 3133 D IccCardProxy: Setting radio tech UMTS 10-25 15:06:59.832 3133 3133 D TelephonyManager: getLteOnCdmaMode=0 curVal=0 product_type='' lteOnCdmaProductType='' 10-25 15:06:59.832 3133 3133 D IccCardProxy: updateQuietMode: 3GPP subscription -> newQuietMode=false 10-25 15:06:59.832 3133 3133 D IccCardProxy: updateQuietMode: no changes don't setExternalState 10-25 15:06:59.832 3133 3133 D IccCardProxy: updateQuietMode: QuietMode is false (app_type=1 isLteOnCdmaMode=false cdmaSource=-1) 10-25 15:06:59.834 3133 3133 D CarrierActionAgent: [0]Creating CarrierActionAgent 10-25 15:06:59.834 3133 3133 W CarrierConfigManager: Error getting config for subId -1 ICarrierConfigLoader is null 10-25 15:06:59.834 3133 3158 D SmsBroadcastUndelivered: finished scanning raw table in 12 ms 10-25 15:06:59.838 3133 3133 W CarrierConfigManager: Error getting config for subId -1 ICarrierConfigLoader is null 10-25 15:06:59.859 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.network.type value: Unknown propVal=Unknown 10-25 15:06:59.860 3133 3133 D RILJ : [3653]> SIGNAL_STRENGTH [SUB0] 10-25 15:06:59.860 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIGNAL_STRENGTH 10-25 15:06:59.860 3133 3133 D SST : notifyDataRegStateRilRadioTechnologyChanged: drs=1 rat=0 10-25 15:06:59.860 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.network.type value: Unknown propVal=Unknown 10-25 15:06:59.863 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[0]=5 10-25 15:06:59.863 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 SignalStrength[0]=-105 10-25 15:06:59.863 3133 3133 D DCT : [0]DCT.constructor 10-25 15:06:59.863 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[1]=5 10-25 15:06:59.863 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 SignalStrength[1]=-105 10-25 15:06:59.866 3133 3133 D Dcc : E ctor 10-25 15:06:59.866 3133 3133 D Dcc : X ctor 10-25 15:06:59.868 3133 3133 D SubscriptionController: [getPhoneId] asked for default subId=-1 10-25 15:06:59.869 3133 3159 D DcTesterDeacativateAll: register for intent action=com.android.internal.telephony.dataconnection.action_deactivate_all 10-25 15:06:59.869 3133 3159 D DcTesterDeacativateAll: register for intent action=com.android.internal.telephony.action_detached 10-25 15:06:59.870 3133 3133 D DcTesterFailBrinupAll: register for intent action=com.android.internal.telephony.dataconnection.action_fail_bringup 10-25 15:06:59.870 3133 3133 D DcTesterFailBrinupAll: register for intent action=com.android.internal.telephony.action_detached 10-25 15:06:59.870 3133 3133 D DcTesterFailBrinupAll: register for intent action=com.android.internal.telephony.action_attached 10-25 15:06:59.870 3133 3159 D Dcc : DccDefaultState: msg.what=EVENT_RIL_CONNECTED mRilVersion=15 10-25 15:06:59.871 3133 3133 D SST : notifyDataRegStateRilRadioTechnologyChanged: drs=1 rat=0 10-25 15:06:59.871 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.network.type value: Unknown propVal=Unknown 10-25 15:06:59.871 3133 3133 D DCT : [0]update sub = -2 10-25 15:06:59.871 3133 3133 D DCT : [0]update(): Active DDS, register for all events now! 10-25 15:06:59.872 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] updateCurrentCarrierInProvider: mSubId = -2 currentDds = 1 operatorNumeric = null 10-25 15:06:59.873 3133 3133 D DCT : [0]initApnContexts: E 10-25 15:06:59.874 3133 3133 D DCT : [0]initApnContexts: skipping unknown type=1 10-25 15:06:59.874 3133 3133 D DCT : [0]initApnContexts: apnContext={mApnType=default mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=dataEnabled mDataEnabled=false mDependencyMet=true} 10-25 15:06:59.874 3133 3133 D DCT : [0]initApnContexts: apnContext={mApnType=mms mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=dataEnabled mDataEnabled=false mDependencyMet=true} 10-25 15:06:59.874 3133 3133 D DCT : [0]initApnContexts: apnContext={mApnType=supl mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=dataEnabled mDataEnabled=false mDependencyMet=true} 10-25 15:06:59.874 3133 3133 D DCT : [0]initApnContexts: apnContext={mApnType=hipri mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=dataEnabled mDataEnabled=false mDependencyMet=true} 10-25 15:06:59.874 3133 3133 D DCT : [0]initApnContexts: skipping unknown type=9 10-25 15:06:59.874 3133 3133 D DCT : [0]initApnContexts: skipping unknown type=7 10-25 15:06:59.874 3133 3133 D DCT : [0]initApnContexts: apnContext={mApnType=fota mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=dataEnabled mDataEnabled=false mDependencyMet=true} 10-25 15:06:59.874 3133 3133 D DCT : [0]initApnContexts: apnContext={mApnType=ims mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=dataEnabled mDataEnabled=false mDependencyMet=true} 10-25 15:06:59.874 3133 3133 D DCT : [0]initApnContexts: apnContext={mApnType=cbs mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=dataEnabled mDataEnabled=false mDependencyMet=true} 10-25 15:06:59.874 3133 3133 D DCT : [0]initApnContexts: skipping unknown type=13 10-25 15:06:59.885 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] GsmCdmaPhone: constructor: sub = 0 10-25 15:06:59.885 3133 3133 I PhoneFactory: Creating Phone with type = 1 sub = 0 10-25 15:06:59.887 3133 3133 I PhoneFactory: defaultSmsApplication: NONE 10-25 15:06:59.890 3133 3133 I PhoneFactory: Creating SubInfoRecordUpdater 10-25 15:06:59.892 3133 3133 D SubscriptionInfoUpdater: Constructor invoked 10-25 15:06:59.922 3133 3133 I ImsManager: Creating ImsService using ServiceManager 10-25 15:06:59.923 3133 3133 I ImsManager: Creating ImsService using ServiceManager 10-25 15:06:59.924 3133 3133 D SubscriptionController: [getPhoneId]- no sims, returning default phoneId=2147483647 10-25 15:06:59.927 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 TD SCDMA RSCP=0 10-25 15:06:59.927 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for SIGNAL_STRENGTH 10-25 15:06:59.927 3133 3133 D PhoneSwitcher: PhoneSwitcher started 10-25 15:06:59.928 3133 3133 D ProxyController: Constructor - Enter 10-25 15:06:59.929 3133 3151 D RILJ : [3653]< SIGNAL_STRENGTH SignalStrength: 4 99 110 85 110 85 8 99 2147483647 2147483647 -1 2147483647 0 2147483647 cdma [SUB0] 10-25 15:06:59.930 3133 3133 D ProxyController: clearTransaction 10-25 15:06:59.931 3133 3133 D ProxyController: clearTransaction: phoneId=0 status=IDLE 10-25 15:06:59.931 3133 3133 D ProxyController: Constructor - Exit 10-25 15:06:59.936 3133 3133 D TelephonyNetworkFactory[0]: Registering NetworkFactory 10-25 15:06:59.938 3133 3133 D CallManager: registerPhone(GSM Handler (com.android.internal.telephony.GsmCdmaPhone) {1d22f5a}) 10-25 15:06:59.958 3133 3133 D CallManager: registerForMmiComplete 10-25 15:06:59.964 3133 3133 D RILJ : [3654]> RIL_REQUEST_SET_TTY_MODE ttyMode = 0 [SUB0] 10-25 15:06:59.965 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SET_TTY_MODE 10-25 15:06:59.965 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: SET_TTY_MODE 10-25 15:06:59.966 3133 3151 D RILJ : [3654]< RIL_REQUEST_SET_TTY_MODE error 6 [SUB0] 10-25 15:06:59.966 3133 3151 D RilRequest: [3654]< RIL_REQUEST_SET_TTY_MODE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:06:59.967 3133 3133 D SubscriptionController: [getPhoneId] asked for default subId=-1 10-25 15:06:59.970 3133 3133 D DebugService: DebugService DebugService: 10-25 15:06:59.972 3133 3133 D SubscriptionController: [getSlotIndex]- subId invalid 10-25 15:06:59.973 3133 3133 D UiccController: Received EVENT_ICC_STATUS_CHANGED, calling getIccCardStatus 10-25 15:06:59.974 3133 3133 D RILJ : [3655]> GET_SIM_STATUS [SUB0] 10-25 15:06:59.974 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GET_SIM_STATUS 10-25 15:06:59.974 1199 1369 I use-Rlog/RLOG-AT: --- AT+CPIN? 10-25 15:06:59.974 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:06:59.974 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CPIN? 10-25 15:06:59.974 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:06:59.975 3133 3133 D Phone : config LCE service failed: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED 10-25 15:06:59.975 3133 3133 D GsmSMSDispatcher: GsmSMSDispatcher: subId = -2 slotId = 0 10-25 15:06:59.975 3133 3133 D IccCardProxy: setExternalState: !override and newstate unchanged from UNKNOWN 10-25 15:06:59.975 3133 3133 D IccCardProxy: setExternalState: !override and newstate unchanged from UNKNOWN 10-25 15:06:59.976 3133 3133 D RILJ : [3656]> BASEBAND_VERSION [SUB0] 10-25 15:06:59.976 3133 3133 D RILJ : [3657]> RIL_REQUEST_DEVICE_IDENTITY [SUB0] 10-25 15:06:59.977 3133 3133 D RILJ : [3658]> RIL_REQUEST_GET_RADIO_CAPABILITY [SUB0] 10-25 15:06:59.978 3133 3133 D RILJ : [3659]> RIL_REQUEST_START_LCE reportIntervalMs = 200 pullMode = true [SUB0] 10-25 15:06:59.978 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] Event EVENT_RADIO_OFF_OR_NOT_AVAILABLE Received 10-25 15:06:59.978 3133 3133 D GsmCdmaPhone: mBroadcastReceiver: action android.telephony.action.CARRIER_CONFIG_CHANGED 10-25 15:06:59.980 3133 3133 D IccCardProxy: setExternalState: !override and newstate unchanged from UNKNOWN 10-25 15:06:59.980 3133 3133 D CarrierSignalAgent: [0]CarrierSignalAgent receiver action: android.telephony.action.CARRIER_CONFIG_CHANGED 10-25 15:06:59.980 3133 3133 D CarrierSignalAgent: [0]Loading carrier config: carrier_app_wake_signal_config 10-25 15:06:59.981 3133 3133 D CarrierSignalAgent: [0]Loading carrier config: carrier_app_no_wake_signal_config 10-25 15:06:59.982 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CPIN: READY 10-25 15:06:59.982 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:06:59.983 3133 3133 D SST : SubscriptionListener.onSubscriptionInfoChanged 10-25 15:06:59.983 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] updateVoiceMail countVoiceMessages = 0 subId -2 10-25 15:06:59.983 3133 3133 E Phone : setVoiceMessageCount in sharedPreference: invalid subId -2 10-25 15:06:59.983 3133 3133 D SubscriptionController: [getSlotIndex]- subId invalid 10-25 15:06:59.984 3133 3133 D SST : mDeviceShuttingDown=false, mDesiredPowerState=true, getRadioState=RADIO_OFF, mPowerOffDelayNeed=true, mAlarmSwitch=false, mRadioDisabledByCarrier=false 10-25 15:06:59.985 3133 3133 D RILJ : [3660]> RADIO_POWER on = true [SUB0] 10-25 15:06:59.985 3133 3133 D SST : pollState: modemTriggered=true 10-25 15:06:59.985 1199 1199 D RILC : setRadioPower: serial 12 on 1 10-25 15:06:59.985 3133 3133 D RILJ : [3661]> OPERATOR [SUB0] 10-25 15:06:59.986 3133 3133 D RILJ : [3662]> DATA_REGISTRATION_STATE [SUB0] 10-25 15:06:59.986 3133 3133 D RILJ : [3663]> VOICE_REGISTRATION_STATE [SUB0] 10-25 15:06:59.987 3133 3133 D RILJ : [3664]> QUERY_NETWORK_SELECTION_MODE [SUB0] 10-25 15:06:59.988 3133 3133 D SST : mDeviceShuttingDown=false, mDesiredPowerState=true, getRadioState=RADIO_OFF, mPowerOffDelayNeed=true, mAlarmSwitch=false, mRadioDisabledByCarrier=false 10-25 15:06:59.988 3133 3133 D RILJ : [3665]> RADIO_POWER on = true [SUB0] 10-25 15:06:59.988 3133 3133 D SST : pollState: modemTriggered=true 10-25 15:06:59.988 1199 1199 D RILC : setRadioPower: serial 17 on 1 10-25 15:06:59.989 3133 3133 D RILJ : [3666]> OPERATOR [SUB0] 10-25 15:06:59.989 3133 3133 D RILJ : [3667]> DATA_REGISTRATION_STATE [SUB0] 10-25 15:06:59.990 3133 3133 D RILJ : [3668]> VOICE_REGISTRATION_STATE [SUB0] 10-25 15:06:59.990 3133 3133 D RILJ : [3669]> QUERY_NETWORK_SELECTION_MODE [SUB0] 10-25 15:06:59.991 3133 3133 I CSST : reading time to delay notification emergency: -1 10-25 15:06:59.991 3133 3133 I CSST : reading time to delay notification emergency: -1 10-25 15:06:59.991 3133 3133 I CSST : PrefNetworkNotification: sendMessage() w/values: ,false,-1,false,false 10-25 15:06:59.991 1199 1303 D use-Rlog/RLOG-RIL: SLQSSetServingSystemCB Registration State: 3 10-25 15:06:59.991 1199 1303 D use-Rlog/RLOG-RIL: CS Attach State: 2 10-25 15:06:59.991 1199 1303 D use-Rlog/RLOG-RIL: PS Attach State: 2 10-25 15:06:59.991 1199 1303 D use-Rlog/RLOG-RIL: Selected Network: 0 10-25 15:06:59.991 1199 1303 D use-Rlog/RLOG-RIL: radioInterfaceList[0]: 0 10-25 15:06:59.991 3133 3133 I CSST : canceling notifications: 1000 10-25 15:06:59.991 3133 3133 D Phone : isWifiCallingEnabled =false 10-25 15:06:59.991 3133 3133 D CSST : isPhoneRegisteredForWifiCalling: false 10-25 15:06:59.991 3133 3133 D Phone : isWifiCallingEnabled =false 10-25 15:06:59.991 3133 3133 I CSST : EmergencyNetworkNotification: sendMessage() w/values: ,false,-1,false,false 10-25 15:06:59.992 3133 3133 I CSST : canceling notifications: 1001 10-25 15:06:59.992 3133 3133 I CSST : PrefNetworkNotification: sendMessage() w/values: ,false,-1,false,false 10-25 15:06:59.992 3133 3133 I CSST : canceling notifications: 1000 10-25 15:06:59.992 3133 3133 D Phone : isWifiCallingEnabled =false 10-25 15:06:59.992 3133 3133 D CSST : isPhoneRegisteredForWifiCalling: false 10-25 15:06:59.992 3133 3133 D Phone : isWifiCallingEnabled =false 10-25 15:06:59.992 3133 3133 I CSST : EmergencyNetworkNotification: sendMessage() w/values: ,false,-1,false,false 10-25 15:06:59.992 3133 3133 I CSST : canceling notifications: 1001 10-25 15:06:59.992 3133 3133 I CSST : PrefNetworkNotification: sendMessage() w/values: ,false,-1,false,false 10-25 15:06:59.993 3133 3133 I CSST : canceling notifications: 1000 10-25 15:06:59.993 3133 3133 D Phone : isWifiCallingEnabled =false 10-25 15:06:59.993 3133 3133 D CSST : isPhoneRegisteredForWifiCalling: false 10-25 15:06:59.993 3133 3133 D Phone : isWifiCallingEnabled =false 10-25 15:06:59.993 3133 3133 I CSST : EmergencyNetworkNotification: sendMessage() w/values: ,false,-1,false,false 10-25 15:06:59.993 3133 3133 I CSST : canceling notifications: 1001 10-25 15:06:59.993 3133 3133 D DCT : [0]NETWORK_STATE_CHANGED_ACTION: mIsWifiConnected=true 10-25 15:06:59.993 3133 3133 D DCT : [0]Wifi state changed 10-25 15:06:59.993 3133 3133 D DCT : [0]WIFI_STATE_CHANGED_ACTION: enabled=true mIsWifiConnected=true 10-25 15:06:59.993 3133 3133 D DCT : [0]SubscriptionListener.onSubscriptionInfoChanged 10-25 15:06:59.994 3133 3133 D DCT : [0]onRadioAvailable 10-25 15:06:59.994 3133 3133 D DCT : [0]onRadioOffOrNotAvailable: is off and clean up all connections 10-25 15:06:59.994 3133 3133 D DCT : [0]cleanUpAllConnections: tearDown=false reason=radioTurnedOff 10-25 15:06:59.994 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] getDataConnectionState apnType=default ret=DISCONNECTED 10-25 15:06:59.995 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:06:59.996 3133 3133 D DCT : [0]cleanUpConnection: X tearDown=false reason=radioTurnedOff apnContext={mApnType=default mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=radioTurnedOff mDataEnabled=false mDependencyMet=true} dcac=null 10-25 15:06:59.996 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] getDataConnectionState apnType=mms ret=DISCONNECTED 10-25 15:06:59.996 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:06:59.997 3133 3133 D DCT : [0]cleanUpConnection: X tearDown=false reason=radioTurnedOff apnContext={mApnType=mms mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=radioTurnedOff mDataEnabled=false mDependencyMet=true} dcac=null 10-25 15:06:59.997 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] getDataConnectionState apnType=cbs ret=DISCONNECTED 10-25 15:06:59.998 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:06:59.999 3133 3133 D DCT : [0]cleanUpConnection: X tearDown=false reason=radioTurnedOff apnContext={mApnType=cbs mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=radioTurnedOff mDataEnabled=false mDependencyMet=true} dcac=null 10-25 15:06:59.999 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] getDataConnectionState apnType=fota ret=DISCONNECTED 10-25 15:06:59.999 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.000 3133 3133 D DCT : [0]cleanUpConnection: X tearDown=false reason=radioTurnedOff apnContext={mApnType=fota mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=radioTurnedOff mDataEnabled=false mDependencyMet=true} dcac=null 10-25 15:07:00.000 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] getDataConnectionState apnType=supl ret=DISCONNECTED 10-25 15:07:00.001 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.003 3133 3133 D DCT : [0]cleanUpConnection: X tearDown=false reason=radioTurnedOff apnContext={mApnType=supl mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=radioTurnedOff mDataEnabled=false mDependencyMet=true} dcac=null 10-25 15:07:00.003 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] getDataConnectionState apnType=hipri ret=DISCONNECTED 10-25 15:07:00.003 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.005 3133 3133 D DCT : [0]cleanUpConnection: X tearDown=false reason=radioTurnedOff apnContext={mApnType=hipri mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=radioTurnedOff mDataEnabled=false mDependencyMet=true} dcac=null 10-25 15:07:00.005 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] getDataConnectionState apnType=ims ret=DISCONNECTED 10-25 15:07:00.006 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.007 3133 3133 D DCT : [0]cleanUpConnection: X tearDown=false reason=radioTurnedOff apnContext={mApnType=ims mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=radioTurnedOff mDataEnabled=false mDependencyMet=true} dcac=null 10-25 15:07:00.007 3133 3133 D DCT : [0]stopNetStatPoll 10-25 15:07:00.008 3133 3133 D DCT : [0]cleanUpConnection: mDisconnectPendingCount = 0 10-25 15:07:00.008 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.015 3133 3133 I chatty : uid=1001(radio) com.android.phone identical 5 lines 10-25 15:07:00.016 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.018 3133 3133 D DCT : [0]onDataConnectionDetached: stop polling and notify detached 10-25 15:07:00.018 3133 3133 D DCT : [0]stopNetStatPoll 10-25 15:07:00.018 3133 3133 D DCT : [0]notifyDataConnection: reason=dataDetached 10-25 15:07:00.018 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.027 3133 3133 I chatty : uid=1001(radio) com.android.phone identical 5 lines 10-25 15:07:00.028 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.029 3133 3133 D DCT : [0]onDataRoamingOff 10-25 15:07:00.030 3133 3133 D DCT : [0]notifyDataConnection: reason=roamingOff 10-25 15:07:00.031 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.038 3133 3133 I chatty : uid=1001(radio) com.android.phone identical 5 lines 10-25 15:07:00.039 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.044 3133 3133 D RILJ : [3670]> RIL_REQUEST_SEND_DEVICE_STATE 1:false [SUB0] 10-25 15:07:00.045 3133 3151 D RILJ : [3670]< RIL_REQUEST_SEND_DEVICE_STATE error 6 [SUB0] 10-25 15:07:00.045 3133 3151 D RilRequest: [3670]< RIL_REQUEST_SEND_DEVICE_STATE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:00.045 3133 3133 D RILJ : [3671]> RIL_REQUEST_SEND_DEVICE_STATE 2:false [SUB0] 10-25 15:07:00.045 1199 1199 D RILC : sendDeviceState: calling screen state 1 10-25 15:07:00.046 3133 3133 D RILJ : [3672]> RIL_REQUEST_SEND_DEVICE_STATE 0:false [SUB0] 10-25 15:07:00.046 3133 3151 D RILJ : [3672]< RIL_REQUEST_SEND_DEVICE_STATE error 6 [SUB0] 10-25 15:07:00.046 3133 3151 D RilRequest: [3672]< RIL_REQUEST_SEND_DEVICE_STATE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:00.047 3133 3133 D RILJ : [3673]> RIL_REQUEST_SET_UNSOLICITED_RESPONSE_FILTER 7 [SUB0] 10-25 15:07:00.047 3133 3133 D SubscriptionInfoUpdater: [Receiver]+ 10-25 15:07:00.047 3133 3133 D SubscriptionInfoUpdater: Action: android.intent.action.SIM_STATE_CHANGED 10-25 15:07:00.047 3133 3133 D SubscriptionInfoUpdater: slotIndex: 0 10-25 15:07:00.047 3133 3133 D SubscriptionInfoUpdater: simStatus: LOADED 10-25 15:07:00.047 3133 3133 D SubscriptionInfoUpdater: Ignoring simStatus: LOADED 10-25 15:07:00.047 3133 3133 D SubscriptionInfoUpdater: [Receiver]- 10-25 15:07:00.047 3133 3151 D RILJ : [3673]< RIL_REQUEST_SET_UNSOLICITED_RESPONSE_FILTER error 6 [SUB0] 10-25 15:07:00.047 3133 3133 D SubscriptionInfoUpdater: [Receiver]+ 10-25 15:07:00.047 3133 3133 D SubscriptionInfoUpdater: Action: android.intent.action.internal_sim_state_changed 10-25 15:07:00.047 3133 3133 D SubscriptionInfoUpdater: slotIndex: 0 10-25 15:07:00.047 3133 3151 D RilRequest: [3673]< RIL_REQUEST_SET_UNSOLICITED_RESPONSE_FILTER error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:00.047 3133 3133 D SubscriptionInfoUpdater: simStatus: LOADED 10-25 15:07:00.047 3133 3133 D SubscriptionInfoUpdater: [Receiver]- 10-25 15:07:00.048 3133 3160 D SubscriptionInfoUpdater: handleSimLoaded: slotId: 0 10-25 15:07:00.048 3133 3160 D SubscriptionInfoUpdater: handleSimLoaded: IccRecords null 10-25 15:07:00.048 3133 3133 D PhoneSwitcher: evaluating due to subChanged default 0->1 phone[0] 0->-2 10-25 15:07:00.050 3133 3133 D TelephonyNetworkFactory[0]: onSubIdChange -1->-2 10-25 15:07:00.050 3133 3133 D TelephonyNetworkFactory[0]: got request NetworkRequest [ BACKGROUND_REQUEST id=2, [ Transports: CELLULAR Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN] ] with score 0 10-25 15:07:00.050 3133 3133 D TelephonyNetworkFactory[0]: got request NetworkRequest [ TRACK_DEFAULT id=5, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN] ] with score 52 10-25 15:07:00.050 3133 3133 D TelephonyNetworkFactory[0]: got request NetworkRequest [ REQUEST id=1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN] ] with score 52 10-25 15:07:00.050 3133 3133 D TelephonyNetworkFactory[0]: got request NetworkRequest [ TRACK_DEFAULT id=3, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN] ] with score 52 10-25 15:07:00.050 3133 3133 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:00.053 3133 3133 D SipService: SipService: started! 10-25 15:07:00.055 1199 1303 D use-Rlog/RLOG-RIL: Received SysInfo callback 10-25 15:07:00.056 3133 3133 D SipService: start: 10-25 15:07:00.057 3133 3133 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:00.059 3133 3133 D SubscriptionController: [getPhoneId]- no sims, returning default phoneId=2147483647 10-25 15:07:00.059 3133 3133 D SubscriptionController: [getPhoneId]- no sims, returning default phoneId=2147483647 10-25 15:07:00.060 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.061 3133 3133 D SubscriptionController: [getPhoneId]- no sims, returning default phoneId=2147483647 10-25 15:07:00.061 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:00.062 3133 3133 D RILJ : [3674]> RIL_REQUEST_QUERY_TTY_MODE [SUB0] 10-25 15:07:00.071 3133 3133 D SubscriptionController: [getSlotIndex]- size == 0, return SIM_NOT_INSERTED instead 10-25 15:07:00.072 3133 3133 D SubscriptionController: [getPhoneId]- no sims, returning default phoneId=2147483647 10-25 15:07:00.072 3133 3133 I ImsManager: Creating ImsService using ServiceManager 10-25 15:07:00.073 3133 3133 D ImsManager: updateVolteFeatureValue: available = false, enabled = true, nonTTY = true 10-25 15:07:00.073 3133 3133 I ImsManager: Creating ImsService using ServiceManager 10-25 15:07:00.074 3133 3133 E ImsManager: updateImsServiceConfig: 10-25 15:07:00.074 3133 3133 E ImsManager: com.android.ims.ImsException: getConfigInterface() 10-25 15:07:00.074 3133 3133 E ImsManager: at com.android.ims.ImsManager.getConfigInterface(ImsManager.java:1915) 10-25 15:07:00.074 3133 3133 E ImsManager: at com.android.ims.ImsManager.updateVolteFeatureValue(ImsManager.java:1399) 10-25 15:07:00.074 3133 3133 E ImsManager: at com.android.ims.ImsManager.updateImsServiceConfig(ImsManager.java:1309) 10-25 15:07:00.074 3133 3133 E ImsManager: at com.android.internal.telephony.GsmCdmaPhone.handleMessage(GsmCdmaPhone.java:2250) 10-25 15:07:00.074 3133 3133 E ImsManager: at android.os.Handler.dispatchMessage(Handler.java:106) 10-25 15:07:00.074 3133 3133 E ImsManager: at android.os.Looper.loop(Looper.java:164) 10-25 15:07:00.074 3133 3133 E ImsManager: at android.app.ActivityThread.main(ActivityThread.java:6494) 10-25 15:07:00.074 3133 3133 E ImsManager: at java.lang.reflect.Method.invoke(Native Method) 10-25 15:07:00.074 3133 3133 E ImsManager: at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:463) 10-25 15:07:00.074 3133 3133 E ImsManager: at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:807) 10-25 15:07:00.074 3133 3133 E ImsManager: Caused by: android.os.RemoteException: ImsServiceProxy is not available for that feature. 10-25 15:07:00.074 3133 3133 E ImsManager: at android.telephony.ims.ImsServiceProxyCompat.checkBinderConnection(ImsServiceProxyCompat.java:180) 10-25 15:07:00.074 3133 3133 E ImsManager: at android.telephony.ims.ImsServiceProxyCompat.getConfigInterface(ImsServiceProxyCompat.java:125) 10-25 15:07:00.074 3133 3133 E ImsManager: at com.android.ims.ImsManager.getConfigInterface(ImsManager.java:1908) 10-25 15:07:00.074 3133 3133 E ImsManager: ... 9 more 10-25 15:07:00.075 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] broadcastEmergencyCallStateChanges = false 10-25 15:07:00.075 3133 3133 E GsmCdmaPhone: [GsmCdmaPhone] Invalid cdma_roaming_mode settings: -1 10-25 15:07:00.075 3133 3133 D EriManager: loadEriFileFromXml: check for alternate file 10-25 15:07:00.075 3133 3133 D EriManager: loadEriFileFromXml: no alternate file 10-25 15:07:00.076 3133 3133 D EriManager: eriFile = eri.xml 10-25 15:07:00.078 3133 3133 D EriManager: loadEriFileFromXml: eri parsing successful, file loaded. ver = 1357, # of entries = 176 10-25 15:07:00.078 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] ERI read, notify registrants 10-25 15:07:00.078 3133 3133 E CarrierActionAgent: [0]Unsupported action: 7 10-25 15:07:00.078 3133 3133 D CarrierActionAgent: [0]EVENT_SIM_STATE_CHANGED status: LOADED 10-25 15:07:00.080 3133 3133 D CarrierSignalAgent: [0]Sending signal com.android.internal.telephony.CARRIER_SIGNAL_RESET to the carrier signal receiver: ComponentInfo{com.android.carrierdefaultapp/com.android.carrierdefaultapp.CarrierDefaultBroadcastReceiver} 10-25 15:07:00.091 3133 3133 D SST : EVENT_SIM_NOT_INSERTED 10-25 15:07:00.091 3133 3133 D SST : setNotification: cancelAllNotifications 10-25 15:07:00.092 3133 3133 D PhoneSwitcher: evaluating due to netRequest 10-25 15:07:00.092 3133 3133 I chatty : uid=1001(radio) com.android.phone identical 2 lines 10-25 15:07:00.092 3133 3133 D PhoneSwitcher: evaluating due to netRequest 10-25 15:07:00.093 3133 3133 D TelephonyNetworkFactory[0]: not acting - isApp=false, isAct=false NetworkRequest [ BACKGROUND_REQUEST id=2, [ Transports: CELLULAR Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED&NOT_VPN] ] 10-25 15:07:00.121 3133 3151 D RILJ : responseIccCardStatus: from HIDL: IccCardState {CARDSTATE_PRESENT,PINSTATE_UNKNOWN,num_apps=1,gsm_id=0{APPTYPE_SIM,APPSTATE_READY},cdma_id=8,ims_id=8} [SUB0] 10-25 15:07:00.121 3133 3133 D UiccController: Received EVENT_GET_ICC_STATUS_DONE 10-25 15:07:00.121 3133 3151 D RILJ : [3655]< GET_SIM_STATUS IccCardState {CARDSTATE_PRESENT,PINSTATE_UNKNOWN,num_apps=1,gsm_id=0{APPTYPE_SIM,APPSTATE_READY},cdma_id=8,ims_id=8} [SUB0] 10-25 15:07:00.121 3133 3133 D UiccCard: Creating 10-25 15:07:00.121 3133 3133 D UiccCard: 1 applications 10-25 15:07:00.121 3133 3133 D UiccCardApplication: Creating UiccApp: {APPTYPE_SIM,APPSTATE_READY} 10-25 15:07:00.123 3133 3133 W CarrierTestOverride: Can not open /data/user_de/0/com.android.phone/files/carrier_test_conf.xml 10-25 15:07:00.124 3133 3133 W VoiceMailConstants: Can't open /system/etc/voicemail-conf.xml 10-25 15:07:00.124 3133 3133 D SpnOverride: No SPN in OEM image = /oem/telephony/spn-conf.xml Load SPN from system image 10-25 15:07:00.124 3133 3133 W SpnOverride: Can not open /system/etc/spn-conf.xml 10-25 15:07:00.124 3133 3133 D SIMRecords: [SIMRecords] setting0 mMncLength-1 10-25 15:07:00.124 3133 3133 D SIMRecords: [SIMRecords] SIMRecords: onRadioOffOrNotAvailable set 'gsm.sim.operator.numeric' to operator=null 10-25 15:07:00.124 3133 3133 D SIMRecords: [SIMRecords] update icc_operator_numeric=null 10-25 15:07:00.124 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.sim.operator.numeric value: propVal= 10-25 15:07:00.125 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.sim.operator.alpha value: propVal= 10-25 15:07:00.126 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.sim.operator.iso-country value: propVal= 10-25 15:07:00.127 3133 3133 D UiccCardApplication: Notifying 1 registrant: READY 10-25 15:07:00.127 3133 3133 D SIMRecords: [SIMRecords] getOperatorNumeric: IMSI == null 10-25 15:07:00.127 3133 3133 D SIMRecords: [SIMRecords] SIMRecords X ctor this=SimRecords: mDestroyed=false mContext=com.android.phone.PhoneGlobals@72f0962 mCi=com.android.internal.telephony.RIL@a79d7a1 mFh=Handler (com.android.internal.telephony.uicc.SIMFileHandler) {7af0af3} mParentApp=com.android.internal.telephony.uicc.UiccCardApplication@5cfe3b0 recordsLoadedRegistrants=android.os.RegistrantList@b03c229 mImsiReadyRegistrants=android.os.RegistrantList@a7859ae mRecordsEventsRegistrants=android.os.RegistrantList@b25634f mNewSmsRegistrants=android.os.RegistrantList@1478adc mNetworkSelectionModeAutomaticRegistrants=android.os.RegistrantList@9ed57e5 recordsToLoad=0 adnCache=Handler (com.android.internal.telephony.uicc.AdnRecordCache) {af462ba} recordsRequested=false iccid=null msisdnTag=null voiceMailNum=null voiceMailTag=null voiceMailNum=null newVoiceMailTag=null isVoiceMailFixed=false mImsi=null mncLength=-1 mailboxIndex=0 spn=null mVmConfigcom.android.internal.telephony.uicc.VoiceMailConstants@5fee56b mSpnOverride=com.android.internal.telephony.uicc.SpnOverride@33078c8 callForwardingEnabled=0 spnState=null mCphsInfo=null mCspPlmnEnabled=true efMWIS=null efCPHS_MWI=null mEfCff=null mEfCfis=null getOperatorNumeric=null 10-25 15:07:00.129 3133 3133 D RILJ : [3675]> QUERY_FACILITY_LOCK facility = FD serviceClass = 7 appId = [SUB0] 10-25 15:07:00.129 3133 3133 D RILJ : [3676]> QUERY_FACILITY_LOCK facility = SC serviceClass = 7 appId = [SUB0] 10-25 15:07:00.142 3133 3133 D CAT : CatService: registerForRecordsLoaded slotid=0 instance:Handler (com.android.internal.telephony.cat.CatService) {9308f12} 10-25 15:07:00.143 3133 3133 D CAT : CatService: Running CAT service on Slotid: 0. STK app installed:false 10-25 15:07:00.143 3133 3133 D UiccCard: Before privilege rules: null : CARDSTATE_PRESENT 10-25 15:07:00.144 3133 3133 D RILJ : [3677]> RIL_REQUEST_SIM_OPEN_CHANNEL aid = A00000015141434C00 p2 = 0 [SUB0] 10-25 15:07:00.144 3133 3133 E UiccCard: App index 8 is invalid since there are no applications 10-25 15:07:00.144 3133 3133 E UiccCard: App index 8 is invalid since there are no applications 10-25 15:07:00.144 3133 3133 D UiccCard: update: radioState=RADIO_OFF mLastRadioState=RADIO_UNAVAILABLE 10-25 15:07:00.144 3133 3133 D UiccController: Notifying IccChangedRegistrants 10-25 15:07:00.144 3133 3133 D SIMRecords: [SIMRecords] fetchSimRecords 0 10-25 15:07:00.144 3133 3133 D RILJ : [3678]> GET_IMSI aid = [SUB0] 10-25 15:07:00.145 3133 3133 D RILJ : [3679]> iccIO: SIM_IO command = 0xc0 fileId = 0x2fe2 path = 3F00 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.146 3133 3133 D RILJ : [3680]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f40 path = 3F007F10 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.146 3133 3133 D RILJ : [3681]> iccIO: SIM_IO command = 0xc0 fileId = 0x6fc9 path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.147 3133 3133 D RILJ : [3682]> iccIO: SIM_IO command = 0xc0 fileId = 0x6fad path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.148 3133 3133 D RILJ : [3683]> iccIO: SIM_IO command = 0xc0 fileId = 0x6fca path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.148 3133 3133 D RILJ : [3684]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f11 path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.149 3133 3133 D RILJ : [3685]> iccIO: SIM_IO command = 0xc0 fileId = 0x6fcb path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.149 3133 3133 D RILJ : [3686]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f13 path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.150 3133 3133 D RILJ : [3687]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f46 path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.150 3133 3133 D RILJ : [3688]> iccIO: SIM_IO command = 0xc0 fileId = 0x6fcd path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.151 3133 3133 D RILJ : [3689]> iccIO: SIM_IO command = 0xc0 fileId = 0x6fc5 path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.152 3133 3133 D RILJ : [3690]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f38 path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.152 3133 3133 D RILJ : [3691]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f16 path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.153 3133 3133 D RILJ : [3692]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f15 path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.153 3133 3133 D RILJ : [3693]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f3e path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.154 3133 3133 D RILJ : [3694]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f3f path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.154 3133 3133 E SIMFileHandler: Error: EF Path being returned in null 10-25 15:07:00.154 3133 3133 D RILJ : [3695]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f60 path = null p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.154 3133 3133 E SIMFileHandler: Error: EF Path being returned in null 10-25 15:07:00.155 3133 3133 D RILJ : [3696]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f61 path = null p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.155 3133 3133 E SIMFileHandler: Error: EF Path being returned in null 10-25 15:07:00.155 3133 3133 D RILJ : [3697]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f62 path = null p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.156 3133 3133 E SIMFileHandler: Error: EF Path being returned in null 10-25 15:07:00.157 3133 3133 D RILJ : [3698]> iccIO: SIM_IO command = 0xc0 fileId = 0x6fd9 path = null p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.157 3133 3133 E SIMFileHandler: Error: EF Path being returned in null 10-25 15:07:00.157 3133 3133 D RILJ : [3699]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f7b path = null p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:00.158 3133 3133 D SIMRecords: [SIMRecords] fetchSimRecords 22 requested: true 10-25 15:07:00.158 3133 3133 D CAT : CatService: handleMessage[8] 10-25 15:07:00.158 3133 3133 D CAT : CatService: MSG_ID_ICC_CHANGED 10-25 15:07:00.158 3133 3133 D CAT : CatService: New Card State = CARDSTATE_PRESENT Old Card State = CARDSTATE_ABSENT 10-25 15:07:00.158 3133 3133 D RILJ : [3700]> RIL_REQUEST_REPORT_STK_SERVICE_IS_RUNNING [SUB0] 10-25 15:07:00.158 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] New Uicc application found. type = APPTYPE_SIM 10-25 15:07:00.159 3133 3133 D GsmSMSDispatcher: GsmSMSDispatcher: subId = -2 slotId = 0 10-25 15:07:00.159 3133 3133 D GsmSMSDispatcher: New Uicc application found 10-25 15:07:00.159 3133 3133 D IccCardProxy: Icc changed. Reregistering. 10-25 15:07:00.159 3133 3133 D UiccCardApplication: Notifying 1 registrant: READY 10-25 15:07:00.159 3133 3133 D IccCardProxy: setExternalState: set mPhoneId=0 mExternalState=READY 10-25 15:07:00.159 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.sim.state value: READY propVal=READY 10-25 15:07:00.159 3133 3133 D IccCardProxy: broadcastIccStateChangedIntent intent ACTION_SIM_STATE_CHANGED value=READY reason=null for mPhoneId=0 10-25 15:07:00.161 3133 3133 D SST : New card found 10-25 15:07:00.162 3133 3133 D UiccCardApplication: Notifying 1 registrant: READY 10-25 15:07:00.162 3133 3133 D CAT : CatService: handleMessage[8] 10-25 15:07:00.162 3133 3133 D CAT : CatService: MSG_ID_ICC_CHANGED 10-25 15:07:00.162 3133 3133 D CAT : CatService: New Card State = CARDSTATE_PRESENT Old Card State = CARDSTATE_PRESENT 10-25 15:07:00.162 3133 3161 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:00.162 3133 3133 D SIMRecords: [SIMRecords] getOperatorNumeric: IMSI == null 10-25 15:07:00.163 3133 3133 I GsmCdmaPhone: [GsmCdmaPhone] processIccRecordEvents: EVENT_CFI 10-25 15:07:00.163 3133 3133 E Phone : getCallForwardingIndicatorFromSharedPref: invalid subId -2 10-25 15:07:00.163 3133 3133 V Phone : getCallForwardingIndicator: iccForwardingFlag=0, sharedPrefFlag=0 10-25 15:07:00.163 3133 3133 D DefaultPhoneNotifier: notifyCallForwardingChanged: subId=-2, isCFActive=false 10-25 15:07:00.163 3133 3133 E Phone : getCallForwardingIndicatorFromSharedPref: invalid subId -2 10-25 15:07:00.163 3133 3133 V Phone : getCallForwardingIndicator: iccForwardingFlag=0, sharedPrefFlag=0 10-25 15:07:00.163 3133 3133 D IccCardProxy: setExternalState: !override and newstate unchanged from READY 10-25 15:07:00.163 3133 3133 D SubscriptionInfoUpdater: [Receiver]+ 10-25 15:07:00.163 3133 3133 D SubscriptionInfoUpdater: Action: android.intent.action.SIM_STATE_CHANGED 10-25 15:07:00.163 3133 3133 D SubscriptionInfoUpdater: slotIndex: 0 10-25 15:07:00.163 3133 3133 D SubscriptionInfoUpdater: simStatus: READY 10-25 15:07:00.163 3133 3133 D SubscriptionInfoUpdater: Ignoring simStatus: READY 10-25 15:07:00.163 3133 3133 D SubscriptionInfoUpdater: [Receiver]- 10-25 15:07:00.164 3133 3133 D SST : pollState: modemTriggered=false 10-25 15:07:00.164 3133 3133 D SST : set service state as POWER_OFF 10-25 15:07:00.165 3133 3133 D SST : Poll ServiceState done: oldSS=[{mVoiceRegState=1(OUT_OF_SERVICE), mDataRegState=1(OUT_OF_SERVICE), mVoiceRoamingType=home, mDataRoamingType=home, mVoiceOperatorAlphaLong=null, mVoiceOperatorAlphaShort=null, mDataOperatorAlphaLong=null, mDataOperatorAlphaShort=null, isManualNetworkSelection=false(automatic), mRilVoiceRadioTechnology=0(Unknown), mRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=0, mSystemId=0, mCdmaRoamingIndicator=0, mCdmaDefaultRoamingIndicator=0, mIsEmergencyOnly=false, mIsDataRoamingFromRegistration=false, mIsUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0}] newSS=[{mVoiceRegState=3(POWER_OFF), mDataRegState=3(POWER_OFF), mVoiceRoamingType=home, mDataRoamingType=home, mVoiceOperatorAlphaLong=null, mVoiceOperatorAlphaShort=null, mDataOperatorAlphaLong=null, mDataOperatorAlphaShort=null, isManualNetworkSelection=false(automatic), mRilVoiceRadioTechnology=0(Unknown), mRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=false, mIsDataRoamingFromRegistration=false, mIsUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0}] oldMaxDataCalls=1 mNewMaxDataCalls=1 oldReasonDataDenied=-1 mNewReasonDataDenied=-1 10-25 15:07:00.165 3133 3133 D SST : pollStateDone: hasRegistered=false hasDeregistered=false hasDataAttached=false hasDataDetached=false hasDataRegStateChanged=true hasRilVoiceRadioTechnologyChanged= false hasRilDataRadioTechnologyChanged=false hasChanged=true hasVoiceRoamingOn=false hasVoiceRoamingOff=false hasDataRoamingOn=false hasDataRoamingOff=false hasLocationChanged=false has4gHandoff = false hasMultiApnSupport=false hasLostMultiApnSupport=false 10-25 15:07:00.167 3133 3133 D SIMRecords: [SIMRecords] getServiceProviderName: no brandOverride, providerName=null 10-25 15:07:00.167 3133 3133 D SST : updateSpnDisplay: radio is off w/ showPlmn=true plmn=No service 10-25 15:07:00.167 3133 3133 D SIMRecords: [SIMRecords] getServiceProviderName: no brandOverride, providerName=null 10-25 15:07:00.168 3133 3133 D SST : updateSpnDisplay: changed sending intent rule=2 showPlmn='true' plmn='No service' showSpn='false' spn='null' dataSpn='null' subId='-2' 10-25 15:07:00.171 3133 3133 D SubscriptionController: [setPlmnSpn] No valid subscription to store info 10-25 15:07:00.171 3133 3133 D SubscriptionController: notifySubscriptionInfoChanged: 10-25 15:07:00.173 3133 3161 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:00.173 3133 3146 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:00.178 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.operator.alpha value: propVal= 10-25 15:07:00.179 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.operator.numeric value: propVal= 10-25 15:07:00.180 3133 3133 D SST : operatorNumeric null is invalid 10-25 15:07:00.180 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.operator.iso-country value: propVal= 10-25 15:07:00.180 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.operator.isroaming value: false propVal=false 10-25 15:07:00.180 3133 3133 D SST : Broadcasting ServiceState : {mVoiceRegState=3(POWER_OFF), mDataRegState=3(POWER_OFF), mVoiceRoamingType=home, mDataRoamingType=home, mVoiceOperatorAlphaLong=null, mVoiceOperatorAlphaShort=null, mDataOperatorAlphaLong=null, mDataOperatorAlphaShort=null, isManualNetworkSelection=false(automatic), mRilVoiceRadioTechnology=0(Unknown), mRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=false, mIsDataRoamingFromRegistration=false, mIsUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0} 10-25 15:07:00.180 3133 3133 D DefaultPhoneNotifier: nofityServiceState: mRegistry=com.android.internal.telephony.ITelephonyRegistry$Stub$Proxy@f3096e3 ss={mVoiceRegState=3(POWER_OFF), mDataRegState=3(POWER_OFF), mVoiceRoamingType=home, mDataRoamingType=home, mVoiceOperatorAlphaLong=null, mVoiceOperatorAlphaShort=null, mDataOperatorAlphaLong=null, mDataOperatorAlphaShort=null, isManualNetworkSelection=false(automatic), mRilVoiceRadioTechnology=0(Unknown), mRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=false, mIsDataRoamingFromRegistration=false, mIsUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0} sender=Handler (com.android.internal.telephony.GsmCdmaPhone) {1d22f5a} phondId=0 subId=-2 10-25 15:07:00.182 3133 3133 D SubscriptionController: [getSlotIndex]- subId invalid 10-25 15:07:00.190 3133 3133 D SST : notifyDataRegStateRilRadioTechnologyChanged: drs=3 rat=0 10-25 15:07:00.190 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.network.type value: Unknown propVal=Unknown 10-25 15:07:00.191 3133 3133 D DCT : [0]get all active apn types 10-25 15:07:00.191 3133 3133 E CarrierActionAgent: [0]Unsupported action: 7 10-25 15:07:00.196 3133 3133 D SST : SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:00.196 3133 3133 E Phone : getStoredVoiceMessageCount: invalid subId -2 10-25 15:07:00.196 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] updateVoiceMail countVoiceMessages = 0 subId -2 10-25 15:07:00.196 3133 3133 E Phone : setVoiceMessageCount in sharedPreference: invalid subId -2 10-25 15:07:00.196 3133 3133 D SubscriptionController: [getSlotIndex]- subId invalid 10-25 15:07:00.196 3133 3133 D DCT : [0]SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:00.200 3133 3133 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:00.200 3133 3133 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:00.207 3133 3133 D SST : EVENT_SIM_NOT_INSERTED 10-25 15:07:00.207 3133 3133 D SST : setNotification: cancelAllNotifications 10-25 15:07:00.221 3133 3146 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:00.311 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for VOICE_REGISTRATION_STATE 10-25 15:07:00.312 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for DATA_REGISTRATION_STATE 10-25 15:07:00.312 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for SIGNAL_STRENGTH 10-25 15:07:00.312 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for OPERATOR 10-25 15:07:00.312 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: getServingNetworkQMI registrationState : 3 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: CSDomain : 2 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: PSDomain : 2 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: RAN : 0 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: radioIfacesSize : 1 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: radioIfaces[0] : 0 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: roamingInd : 0 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: MCC : 0 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: MNC : 0 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: Name : 000 00 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: switchTechnologyDualMode no need to switch 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechCDMA radioIface=0 10-25 15:07:00.312 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechCDMA networkType=0 10-25 15:07:00.312 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for VOICE_REGISTRATION_STATE 10-25 15:07:00.313 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechCDMA radioIface=0 10-25 15:07:00.313 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechCDMA networkType=0 10-25 15:07:00.313 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for DATA_REGISTRATION_STATE 10-25 15:07:00.313 3133 3151 D RILJ : [UNSL]< UNSOL_RESPONSE_NETWORK_STATE_CHANGED [SUB0] 10-25 15:07:00.313 1199 1369 E use-Rlog/RLOG-RIL: processRequest: BASEBAND_VERSION 10-25 15:07:00.313 3133 3133 D SST : pollState: modemTriggered=true 10-25 15:07:00.313 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for BASEBAND_VERSION 10-25 15:07:00.313 3133 3151 D RILJ : [UNSL]< UNSOL_RESPONSE_NETWORK_STATE_CHANGED [SUB0] 10-25 15:07:00.313 3133 3151 D RILJ : [3656]< BASEBAND_VERSION SWI9X30C_02.32.11.00 r8042 CARMD-EV-FRMWR2 2019/05/15 21:52:20 [SUB0] 10-25 15:07:00.314 3133 3133 D RILJ : [3701]> OPERATOR [SUB0] 10-25 15:07:00.316 3133 3133 D RILJ : [3702]> DATA_REGISTRATION_STATE [SUB0] 10-25 15:07:00.317 3133 3133 D RILJ : [3703]> VOICE_REGISTRATION_STATE [SUB0] 10-25 15:07:00.318 3133 3133 D RILJ : [3704]> QUERY_NETWORK_SELECTION_MODE [SUB0] 10-25 15:07:00.319 3133 3133 D SST : pollState: modemTriggered=true 10-25 15:07:00.320 3133 3133 D RILJ : [3705]> OPERATOR [SUB0] 10-25 15:07:00.321 3133 3133 D RILJ : [3706]> DATA_REGISTRATION_STATE [SUB0] 10-25 15:07:00.322 3133 3133 D RILJ : [3707]> VOICE_REGISTRATION_STATE [SUB0] 10-25 15:07:00.323 3133 3133 D RILJ : [3708]> QUERY_NETWORK_SELECTION_MODE [SUB0] 10-25 15:07:00.323 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] Baseband version: SWI9X30C_02.32.11.00 r8042 CARMD-EV-FRMWR2 2019/05/15 21:52:20 10-25 15:07:00.375 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[0]=0 10-25 15:07:00.375 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[1]=0 10-25 15:07:00.440 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for SIGNAL_STRENGTH 10-25 15:07:00.440 1199 1369 E use-Rlog/RLOG-RIL: processRequest: DEVICE_IDENTITY 10-25 15:07:00.440 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for DEVICE_IDENTITY 10-25 15:07:00.440 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GET_RADIO_CAPABILITY 10-25 15:07:00.440 1199 1369 D use-Rlog/RLOG-RIL: requestGetRadioCapabilityQMI:: entered 10-25 15:07:00.441 3133 3151 D RILJ : [3657]< RIL_REQUEST_DEVICE_IDENTITY {359073062363324, 19, 0, 35907306236332} [SUB0] 10-25 15:07:00.504 1199 1369 E use-Rlog/RLOG-RIL: requestGetRadioCapabilityQMI:: rat = 577033 10-25 15:07:00.504 1199 1369 E use-Rlog/RLOG-RIL: processRequest: START_LCE 10-25 15:07:00.504 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: START_LCE 10-25 15:07:00.504 1199 1369 E RILC : Invalid response: NULL 10-25 15:07:00.505 1199 1369 E use-Rlog/RLOG-RIL: processRequest: RADIO_POWER 10-25 15:07:00.505 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for VOICE_REGISTRATION_STATE 10-25 15:07:00.505 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for DATA_REGISTRATION_STATE 10-25 15:07:00.505 3133 3151 D RILJ : convertHalRadioCapability: session=0, phase=0, rat=577033, logicModemUuid=, status=1 [SUB0] 10-25 15:07:00.505 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for SIGNAL_STRENGTH 10-25 15:07:00.505 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for OPERATOR 10-25 15:07:00.505 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:00.505 1199 1369 D use-Rlog/RLOG-RIL: requestRadioPowerUMTS 1 10-25 15:07:00.506 3133 3151 D RILJ : [3658]< RIL_REQUEST_GET_RADIO_CAPABILITY {mPhoneId = 0 mVersion=1 mSession=0 mPhase=0 mRadioAccessFamily=577033 mLogicModemId= mStatus=1} [SUB0] 10-25 15:07:00.506 3133 3133 D GsmCdmaPhone: EVENT_GET_RADIO_CAPABILITY: phone rc: {mPhoneId = 0 mVersion=1 mSession=0 mPhase=0 mRadioAccessFamily=577033 mLogicModemId= mStatus=1} 10-25 15:07:00.506 3133 3151 D RILJ : [3659]< RIL_REQUEST_START_LCE error 6 [SUB0] 10-25 15:07:00.507 3133 3151 D RilRequest: [3659]< RIL_REQUEST_START_LCE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret=[0, 0] 10-25 15:07:00.507 3133 3133 D Phone : config LCE service failed: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED 10-25 15:07:00.568 1199 1369 D RILC : radioStateChangedInd: radioState 10 10-25 15:07:00.568 1199 1369 D RILC : setRadioPowerResponse: serial 12 10-25 15:07:00.568 3133 3151 D RILJ : [UNSL]< UNSOL_RESPONSE_RADIO_STATE_CHANGED radioStateChanged: RADIO_ON [SUB0] 10-25 15:07:00.568 1199 1369 I use-Rlog/RLOG-AT: --- AT+CTZU=1 10-25 15:07:00.568 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:00.568 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CTZU=1 10-25 15:07:00.568 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:00.569 3133 3151 D RILJ : [3660]< RADIO_POWER [SUB0] 10-25 15:07:00.569 3133 3133 D SST : mDeviceShuttingDown=false, mDesiredPowerState=true, getRadioState=RADIO_ON, mPowerOffDelayNeed=true, mAlarmSwitch=false, mRadioDisabledByCarrier=false 10-25 15:07:00.570 3133 3133 D SST : pollState: modemTriggered=true 10-25 15:07:00.571 3133 3133 D RILJ : [3709]> OPERATOR [SUB0] 10-25 15:07:00.572 3133 3133 D RILJ : [3710]> DATA_REGISTRATION_STATE [SUB0] 10-25 15:07:00.573 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:00.573 3133 3133 D RILJ : [3711]> VOICE_REGISTRATION_STATE [SUB0] 10-25 15:07:00.574 3133 3133 D RILJ : [3712]> QUERY_NETWORK_SELECTION_MODE [SUB0] 10-25 15:07:00.575 3133 3133 D RILJ : [3713]> GET_CURRENT_CALLS [SUB0] 10-25 15:07:00.575 3133 3133 D RILJ : [3714]> RIL_REQUEST_IMS_REGISTRATION_STATE [SUB0] 10-25 15:07:00.576 3133 3133 D RILJ : [3715]> RIL_REQUEST_CDMA_GET_SUBSCRIPTION_SOURCE [SUB0] 10-25 15:07:00.576 3133 3133 D IccCardProxy: setExternalState: !override and newstate unchanged from READY 10-25 15:07:00.576 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] Event EVENT_RADIO_ON Received 10-25 15:07:00.577 3133 3133 D RILJ : [3716]> RIL_REQUEST_VOICE_RADIO_TECH [SUB0] 10-25 15:07:00.631 1199 1303 D use-Rlog/RLOG-RIL: DDTMSettingsIndicationCallback:: Entered 10-25 15:07:00.632 1199 1303 D use-Rlog/RLOG-RIL: CurrentDDTMStatus : 00 10-25 15:07:00.632 1199 1303 D use-Rlog/RLOG-RIL: DDTMPrefSetting: 01 10-25 15:07:00.632 1199 1303 D use-Rlog/RLOG-RIL: DDTMAction: 04 10-25 15:07:00.632 1199 1303 D use-Rlog/RLOG-RIL: SOListAction: 05 10-25 15:07:00.632 1199 1303 D use-Rlog/RLOG-RIL: SOLen : 4 10-25 15:07:00.632 1199 1303 D use-Rlog/RLOG-RIL: SO[0] 0500 10-25 15:07:00.632 1199 1303 D use-Rlog/RLOG-RIL: SO[1] 0C00 10-25 15:07:00.632 1199 1303 D use-Rlog/RLOG-RIL: SO[2] 0D00 10-25 15:07:00.632 1199 1303 D use-Rlog/RLOG-RIL: SO[3] 2100 10-25 15:07:00.632 3133 3151 V RILJ : [UNSL]< UNSOL_OEM_HOOK_RAW 0501 [SUB0] 10-25 15:07:00.633 3133 3133 D GsmCdmaPhone: Module is EM7455 10-25 15:07:00.696 1199 1303 D use-Rlog/RLOG-RIL: SLQSSetBandPreferenceCB:: band_pref = 0x0002000007c00000 10-25 15:07:00.696 1199 1303 D use-Rlog/RLOG-RIL: SLQSSetSysSelecttionPreferenceCB:: Emergency mode value = 0 10-25 15:07:00.920 1199 1369 E use-Rlog/RLOG-RIL: processRequest: OPERATOR 10-25 15:07:00.984 1199 1369 I use-Rlog/RLOG-AT: --- AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS?;+COPS=3,2;+COPS? 10-25 15:07:00.984 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:00.984 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS?;+COPS=3,2;+COPS? 10-25 15:07:00.985 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:00.986 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +COPS: 0 10-25 15:07:00.986 1199 1371 I chatty : uid=1001(radio) /system/vendor/bin/hw/rild identical 1 line 10-25 15:07:00.986 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +COPS: 0 10-25 15:07:00.986 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:00.986 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for OPERATOR 10-25 15:07:00.986 1199 1369 D use-Rlog/RLOG-RIL: getVMInfo:: entered 10-25 15:07:00.986 1199 1369 E use-Rlog/RLOG-RIL: processRequest: DATA_REGISTRATION_STATE 10-25 15:07:00.987 3133 3151 D RILJ : [3661]< OPERATOR {, , } [SUB0] 10-25 15:07:01.176 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS radioIfaces=0 10-25 15:07:01.176 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS networkType=0 10-25 15:07:01.176 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for DATA_REGISTRATION_STATE 10-25 15:07:01.178 3133 3151 D RILJ : [3662]< DATA_REGISTRATION_STATE {.regState = NOT_REG_MT_SEARCHING_OP, .rat = 0, .reasonDataDenied = -1, .maxDataCalls = 1, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:01.240 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[0]=0 10-25 15:07:01.240 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[1]=0 10-25 15:07:01.304 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for SIGNAL_STRENGTH 10-25 15:07:01.304 1199 1369 E use-Rlog/RLOG-RIL: processRequest: VOICE_REGISTRATION_STATE 10-25 15:07:01.496 1199 1369 D use-Rlog/RLOG-RIL: sendVoiceRegistStateUMTS update status from 3 to 13 10-25 15:07:01.496 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS radioIfaces=0 10-25 15:07:01.496 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS networkType=0 10-25 15:07:01.496 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for VOICE_REGISTRATION_STATE 10-25 15:07:01.496 1199 1369 E use-Rlog/RLOG-RIL: processRequest: QUERY_NETWORK_SELECTION_MODE 10-25 15:07:01.497 1199 1369 I use-Rlog/RLOG-AT: --- AT+COPS? 10-25 15:07:01.497 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:01.497 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+COPS? 10-25 15:07:01.497 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:01.498 3133 3151 D RILJ : [3663]< VOICE_REGISTRATION_STATE {.regState = REG_DENIED_EM, .rat = 0, .cssSupported = false, .roamingIndicator = -1, .systemIsInPrl = 0, .defaultRoamingIndicator = 0, .reasonForDenial = 0, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:01.500 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +COPS: 0 10-25 15:07:01.501 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:01.501 1199 1369 E use-Rlog/RLOG-RIL: requestQueryNetworkSelectionModeUMTS, mode = 0 10-25 15:07:01.501 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:01.501 1199 1369 E use-Rlog/RLOG-RIL: processRequest: RADIO_POWER 10-25 15:07:01.501 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for VOICE_REGISTRATION_STATE 10-25 15:07:01.501 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for DATA_REGISTRATION_STATE 10-25 15:07:01.501 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for SIGNAL_STRENGTH 10-25 15:07:01.501 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for OPERATOR 10-25 15:07:01.501 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:01.501 1199 1369 D use-Rlog/RLOG-RIL: requestRadioPowerUMTS 1 10-25 15:07:01.501 1199 1369 E use-Rlog/RLOG-RIL: Erroneous input to requestRadioPowerUMTS(): onOff=1, sState=10 10-25 15:07:01.501 1199 1369 D RILC : setRadioPowerResponse: serial 17 10-25 15:07:01.502 1199 1369 E use-Rlog/RLOG-RIL: processRequest: OPERATOR 10-25 15:07:01.502 3133 3151 D RILJ : [3664]< QUERY_NETWORK_SELECTION_MODE {0} [SUB0] 10-25 15:07:01.502 3133 3133 D SST : EVENT_POLL_STATE_NETWORK_SELECTION_MODE 10-25 15:07:01.503 3133 3151 D RILJ : [3665]< RADIO_POWER error 2 [SUB0] 10-25 15:07:01.503 3133 3151 D RilRequest: [3665]< RADIO_POWER error: com.android.internal.telephony.CommandException: GENERIC_FAILURE ret= 10-25 15:07:01.560 1199 1369 I use-Rlog/RLOG-AT: --- AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS?;+COPS=3,2;+COPS? 10-25 15:07:01.560 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:01.560 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS?;+COPS=3,2;+COPS? 10-25 15:07:01.561 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:01.564 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +COPS: 0 10-25 15:07:01.564 1199 1371 I chatty : uid=1001(radio) /system/vendor/bin/hw/rild identical 1 line 10-25 15:07:01.564 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +COPS: 0 10-25 15:07:01.564 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:01.565 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for OPERATOR 10-25 15:07:01.565 1199 1369 E use-Rlog/RLOG-RIL: processRequest: DATA_REGISTRATION_STATE 10-25 15:07:01.565 3133 3151 D RILJ : [3666]< OPERATOR {, , } [SUB0] 10-25 15:07:01.752 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS radioIfaces=0 10-25 15:07:01.752 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS networkType=0 10-25 15:07:01.752 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for DATA_REGISTRATION_STATE 10-25 15:07:01.752 1199 1369 E use-Rlog/RLOG-RIL: processRequest: VOICE_REGISTRATION_STATE 10-25 15:07:01.753 3133 3151 D RILJ : [3667]< DATA_REGISTRATION_STATE {.regState = NOT_REG_MT_SEARCHING_OP, .rat = 0, .reasonDataDenied = -1, .maxDataCalls = 1, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:01.945 1199 1369 D use-Rlog/RLOG-RIL: sendVoiceRegistStateUMTS update status from 3 to 13 10-25 15:07:01.945 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS radioIfaces=0 10-25 15:07:01.945 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS networkType=0 10-25 15:07:01.945 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for VOICE_REGISTRATION_STATE 10-25 15:07:01.945 1199 1369 E use-Rlog/RLOG-RIL: processRequest: QUERY_NETWORK_SELECTION_MODE 10-25 15:07:01.946 1199 1369 I use-Rlog/RLOG-AT: --- AT+COPS? 10-25 15:07:01.946 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:01.946 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+COPS? 10-25 15:07:01.946 3133 3151 D RILJ : [3668]< VOICE_REGISTRATION_STATE {.regState = REG_DENIED_EM, .rat = 0, .cssSupported = false, .roamingIndicator = -1, .systemIsInPrl = 0, .defaultRoamingIndicator = 0, .reasonForDenial = 0, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:01.947 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:01.949 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +COPS: 0 10-25 15:07:01.949 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:01.950 1199 1369 E use-Rlog/RLOG-RIL: requestQueryNetworkSelectionModeUMTS, mode = 0 10-25 15:07:01.950 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:01.950 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SCREEN_STATE 10-25 15:07:01.950 1199 1369 D use-Rlog/RLOG-RIL: Screen is ON, check if modem is in emergency mode 10-25 15:07:01.950 3133 3151 D RILJ : [3669]< QUERY_NETWORK_SELECTION_MODE {0} [SUB0] 10-25 15:07:01.951 3133 3133 D SST : EVENT_POLL_STATE_NETWORK_SELECTION_MODE 10-25 15:07:01.951 3133 3151 D RILJ : [3671]< RIL_REQUEST_SEND_DEVICE_STATE [SUB0] 10-25 15:07:02.009 1199 1369 D use-Rlog/RLOG-RIL: Emergency mode is: 0 10-25 15:07:02.009 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for VOICE_REGISTRATION_STATE 10-25 15:07:02.009 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for DATA_REGISTRATION_STATE 10-25 15:07:02.009 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for SIGNAL_STRENGTH 10-25 15:07:02.009 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for OPERATOR 10-25 15:07:02.009 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:02.010 3133 3151 D RILJ : [UNSL]< UNSOL_RESPONSE_NETWORK_STATE_CHANGED [SUB0] 10-25 15:07:02.010 3133 3133 D SST : pollState: modemTriggered=true 10-25 15:07:02.011 3133 3133 D RILJ : [3717]> OPERATOR [SUB0] 10-25 15:07:02.012 3133 3133 D RILJ : [3718]> DATA_REGISTRATION_STATE [SUB0] 10-25 15:07:02.013 3133 3133 D RILJ : [3719]> VOICE_REGISTRATION_STATE [SUB0] 10-25 15:07:02.015 3133 3133 D RILJ : [3720]> QUERY_NETWORK_SELECTION_MODE [SUB0] 10-25 15:07:02.073 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[0]=0 10-25 15:07:02.073 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[1]=0 10-25 15:07:02.137 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for SIGNAL_STRENGTH 10-25 15:07:02.137 1199 1369 E use-Rlog/RLOG-RIL: processRequest: QUERY_TTY_MODE 10-25 15:07:02.137 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: QUERY_TTY_MODE 10-25 15:07:02.137 1199 1369 E RILC : responseInt: Invalid response 10-25 15:07:02.137 1199 1369 E use-Rlog/RLOG-RIL: processRequest: QUERY_FACILITY_LOCK 10-25 15:07:02.138 3133 3151 D RILJ : [3674]< RIL_REQUEST_QUERY_TTY_MODE error 6 [SUB0] 10-25 15:07:02.138 3133 3151 D RilRequest: [3674]< RIL_REQUEST_QUERY_TTY_MODE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret={-1} 10-25 15:07:02.638 1199 1369 I use-Rlog/RLOG-AT: --- AT+CLCK="FD",2 10-25 15:07:02.638 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:02.638 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CLCK="FD",2 10-25 15:07:02.638 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:02.642 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CLCK: 0 10-25 15:07:02.643 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:02.643 1199 1369 E use-Rlog/RLOG-RIL: processRequest: QUERY_FACILITY_LOCK 10-25 15:07:02.643 3133 3151 D RILJ : [3675]< QUERY_FACILITY_LOCK {0} [SUB0] 10-25 15:07:02.644 3133 3133 D UiccCardApplication: Query facility FDN : FDN service available: true enabled: false 10-25 15:07:02.817 3133 3153 D GsmCellBroadcastHandler: mWakeLock released 10-25 15:07:02.821 3133 3155 D CellBroadcastHandler: mWakeLock released 10-25 15:07:02.823 3133 3157 D CdmaServiceCategoryProgramHandler: mWakeLock released 10-25 15:07:02.832 3133 3133 D RILJ : [3721]> RIL_REQUEST_GET_ACTIVITY_INFO [SUB0] 10-25 15:07:03.143 1199 1369 I use-Rlog/RLOG-AT: --- AT+CLCK="SC",2 10-25 15:07:03.144 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:03.144 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CLCK="SC",2 10-25 15:07:03.144 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:03.149 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CLCK: 0 10-25 15:07:03.149 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:03.150 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_OPEN_CHANNEL 10-25 15:07:03.150 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: SIM_OPEN_CHANNEL 10-25 15:07:03.150 1199 1369 E RILC : iccOpenLogicalChannelResponse Invalid response: NULL 10-25 15:07:03.150 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GET_IMSI 10-25 15:07:03.150 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for GET_IMSI 10-25 15:07:03.150 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:03.150 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:03.151 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:03.151 3133 3151 D RILJ : [3676]< QUERY_FACILITY_LOCK {0} [SUB0] 10-25 15:07:03.151 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:03.151 3133 3133 D UiccCardApplication: Query facility lock : 0 10-25 15:07:03.151 3133 3133 D UiccCardApplication: Ignoring: pin1state=PINSTATE_UNKNOWN 10-25 15:07:03.151 3133 3151 D RILJ : [3677]< RIL_REQUEST_SIM_OPEN_CHANNEL error 6 [SUB0] 10-25 15:07:03.151 3133 3151 D RilRequest: [3677]< RIL_REQUEST_SIM_OPEN_CHANNEL error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:03.152 3133 3151 D RILJ : [3678]< GET_IMSI [SUB0] 10-25 15:07:03.152 3133 3133 D UiccCard: Error in SIM access with exceptioncom.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED 10-25 15:07:03.153 3133 3133 D SIMRecords: [SIMRecords] IMSI: mMncLength=-1 10-25 15:07:03.153 3133 3133 D SIMRecords: [SIMRecords] IMSI: 405857[V9DQG7UlzVw5rO7Qq9WXvoLlU7A] 10-25 15:07:03.153 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 21 requested: true 10-25 15:07:03.154 3133 3133 D UiccPkcs15: Creating UiccPkcs15 10-25 15:07:03.156 3133 3133 D RILJ : [3722]> RIL_REQUEST_SIM_OPEN_CHANNEL aid = A000000063504B43532D3135 p2 = 4 [SUB0] 10-25 15:07:03.156 3133 3133 D IccCardProxy: broadcastIccStateChangedIntent intent ACTION_SIM_STATE_CHANGED value=IMSI reason=null for mPhoneId=0 10-25 15:07:03.159 3133 3133 D SubscriptionInfoUpdater: [Receiver]+ 10-25 15:07:03.159 3133 3133 D SubscriptionInfoUpdater: Action: android.intent.action.SIM_STATE_CHANGED 10-25 15:07:03.159 3133 3133 D SubscriptionInfoUpdater: slotIndex: 0 10-25 15:07:03.159 3133 3133 D SubscriptionInfoUpdater: simStatus: IMSI 10-25 15:07:03.159 3133 3133 D SubscriptionInfoUpdater: Ignoring simStatus: IMSI 10-25 15:07:03.159 3133 3133 D SubscriptionInfoUpdater: [Receiver]- 10-25 15:07:03.159 3133 3133 E CarrierActionAgent: [0]Unsupported action: 7 10-25 15:07:03.161 3133 3145 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:03.225 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:03.226 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 12258,path: 3F00 10-25 15:07:03.289 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:simResponse: 0000000A2FE2040000000000000000 10-25 15:07:03.289 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes: sw1:90,sw2:0 10-25 15:07:03.289 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:03.289 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:03.289 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:03.289 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:03.291 3133 3151 D RILJ : [3679]< SIM_IO IccIoResult sw1:0x90 sw2:0x0 [SUB0] 10-25 15:07:03.292 3133 3133 D RILJ : [3723]> iccIO: SIM_IO command = 0xb0 fileId = 0x2fe2 path = 3F00 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:03.417 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:03.417 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28480,path: 3F007F10 10-25 15:07:03.481 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:simResponse: 0000001F6F4004000000000000011F 10-25 15:07:03.481 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes: sw1:90,sw2:0 10-25 15:07:03.481 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:03.481 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:03.481 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:03.481 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:03.482 3133 3151 D RILJ : [3680]< SIM_IO IccIoResult sw1:0x90 sw2:0x0 [SUB0] 10-25 15:07:03.484 3133 3133 D RILJ : [3724]> iccIO: SIM_IO command = 0xb2 fileId = 0x6f40 path = 3F007F10 p1 = 1 p2 = 4 p3 = data = null aid = [SUB0] 10-25 15:07:03.609 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:03.609 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28617,path: 3F007F20 10-25 15:07:03.673 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:03.801 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28617,0,0,64 10-25 15:07:03.801 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:03.801 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28617,0,0,64 10-25 15:07:03.802 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:03.839 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 111,0,"" 10-25 15:07:03.839 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:03.839 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - retrying SIMIO command 10-25 15:07:03.839 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28617,0,0,64 10-25 15:07:03.839 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:03.839 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28617,0,0,64 10-25 15:07:03.840 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:03.870 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 111,0,"" 10-25 15:07:03.870 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:03.870 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:03.871 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:03.871 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:03.871 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:03.871 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:03.871 3133 3151 D RILJ : [3681]< SIM_IO IccIoResult sw1:0x6f sw2:0x0 Error: technical problem with no diagnostic given [SUB0] 10-25 15:07:03.872 3133 3133 E SIMFileHandler: exception caught from EVENT_GET_RECORD_SIZE 10-25 15:07:03.873 3133 3133 D RILJ : [3725]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f17 path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:03.873 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 21 requested: true 10-25 15:07:03.961 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:03.962 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28589,path: 3F007F20 10-25 15:07:04.025 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:04.090 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28589,0,0,64 10-25 15:07:04.090 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:04.090 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28589,0,0,64 10-25 15:07:04.090 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:04.118 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 111,0,"" 10-25 15:07:04.118 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:04.118 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:04.118 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:04.118 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:04.118 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:04.118 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:04.119 3133 3151 D RILJ : [3682]< SIM_IO IccIoResult sw1:0x6f sw2:0x0 Error: technical problem with no diagnostic given [SUB0] 10-25 15:07:04.119 3133 3133 D SIMRecords: [SIMRecords] mccmncCode=405857 10-25 15:07:04.120 3133 3133 D SIMRecords: [SIMRecords] setting6 mMncLength=3 10-25 15:07:04.120 3133 3133 D SIMRecords: [SIMRecords] update mccmnc=405857 10-25 15:07:04.128 3133 3133 D SubscriptionController: [getPhoneId]- no sims, returning default phoneId=2147483647 10-25 15:07:04.130 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 20 requested: true 10-25 15:07:04.217 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:04.218 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28618,path: 3F007F20 10-25 15:07:04.281 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:04.346 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28618,0,0,64 10-25 15:07:04.346 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:04.346 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28618,0,0,64 10-25 15:07:04.347 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:04.379 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 111,0,"" 10-25 15:07:04.379 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:04.379 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:04.379 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:04.379 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:04.379 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:04.379 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:04.380 3133 3151 D RILJ : [3683]< SIM_IO IccIoResult sw1:0x6f sw2:0x0 Error: technical problem with no diagnostic given [SUB0] 10-25 15:07:04.381 3133 3133 E SIMFileHandler: exception caught from EVENT_GET_RECORD_SIZE 10-25 15:07:04.382 3133 3133 D SIMRecords: [SIMRecords] EF_MWIS : null 10-25 15:07:04.382 3133 3133 D SIMRecords: [SIMRecords] EVENT_GET_MWIS_DONE exception = com.android.internal.telephony.uicc.IccException: sw1:111 sw2:0 10-25 15:07:04.382 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 19 requested: true 10-25 15:07:04.473 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:04.473 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28433,path: 3F007F20 10-25 15:07:04.538 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:04.601 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28433,0,0,64 10-25 15:07:04.601 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:04.602 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28433,0,0,64 10-25 15:07:04.602 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:04.632 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 106,130,"" 10-25 15:07:04.632 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:04.632 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:04.632 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:04.632 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:04.632 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:04.632 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:04.633 3133 3151 D RILJ : [3684]< SIM_IO IccIoResult sw1:0x6a sw2:0x82 Error: File not found [SUB0] 10-25 15:07:04.633 3133 3133 D SIMRecords: [SIMRecords] EF_CPHS_MWI: null 10-25 15:07:04.633 3133 3133 D SIMRecords: [SIMRecords] EVENT_GET_VOICE_MAIL_INDICATOR_CPHS_DONE exception = com.android.internal.telephony.uicc.IccException: sw1:106 sw2:130 10-25 15:07:04.633 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 18 requested: true 10-25 15:07:04.730 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:04.730 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28619,path: 3F007F20 10-25 15:07:04.794 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:04.842 3133 3133 D RILJ : [3726]> RIL_REQUEST_GET_ACTIVITY_INFO [SUB0] 10-25 15:07:04.857 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28619,0,0,64 10-25 15:07:04.858 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:04.858 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28619,0,0,64 10-25 15:07:04.858 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:04.893 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 111,0,"" 10-25 15:07:04.893 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:04.894 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:04.894 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:04.894 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:04.894 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:04.894 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:04.895 3133 3151 D RILJ : [3685]< SIM_IO IccIoResult sw1:0x6f sw2:0x0 Error: technical problem with no diagnostic given [SUB0] 10-25 15:07:04.895 3133 3133 E SIMFileHandler: exception caught from EVENT_GET_RECORD_SIZE 10-25 15:07:04.895 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 17 requested: true 10-25 15:07:04.986 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:04.986 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28435,path: 3F007F20 10-25 15:07:05.050 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:05.114 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28435,0,0,64 10-25 15:07:05.114 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:05.114 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28435,0,0,64 10-25 15:07:05.114 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:05.144 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 106,130,"" 10-25 15:07:05.144 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:05.144 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:05.144 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:05.144 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:05.144 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:05.144 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:05.145 3133 3151 D RILJ : [3686]< SIM_IO IccIoResult sw1:0x6a sw2:0x82 Error: File not found [SUB0] 10-25 15:07:05.145 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 16 requested: true 10-25 15:07:05.241 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:05.241 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28486,path: 3F007F20 10-25 15:07:05.305 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:05.370 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28486,0,0,64 10-25 15:07:05.370 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:05.370 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28486,0,0,64 10-25 15:07:05.370 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:05.408 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 111,0,"" 10-25 15:07:05.408 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:05.408 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:05.408 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:05.408 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:05.409 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:05.409 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:05.410 3133 3151 D RILJ : [3687]< SIM_IO IccIoResult sw1:0x6f sw2:0x0 Error: technical problem with no diagnostic given [SUB0] 10-25 15:07:05.411 3133 3133 D RILJ : [3727]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f14 path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:05.412 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 16 requested: true 10-25 15:07:05.498 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:05.498 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28621,path: 3F007F20 10-25 15:07:05.562 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:05.626 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28621,0,0,64 10-25 15:07:05.626 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:05.626 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28621,0,0,64 10-25 15:07:05.626 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:05.655 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 111,0,"" 10-25 15:07:05.655 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:05.655 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:05.655 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:05.655 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:05.655 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:05.655 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:05.656 3133 3151 D RILJ : [3688]< SIM_IO IccIoResult sw1:0x6f sw2:0x0 Error: technical problem with no diagnostic given [SUB0] 10-25 15:07:05.657 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 15 requested: true 10-25 15:07:05.754 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:05.754 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28613,path: 3F007F20 10-25 15:07:05.818 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:05.883 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28613,0,0,64 10-25 15:07:05.883 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:05.883 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28613,0,0,64 10-25 15:07:05.883 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:05.914 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 111,0,"" 10-25 15:07:05.914 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:05.914 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:05.914 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:05.914 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:05.914 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:05.914 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:05.915 3133 3151 D RILJ : [3689]< SIM_IO IccIoResult sw1:0x6f sw2:0x0 Error: technical problem with no diagnostic given [SUB0] 10-25 15:07:05.916 3133 3133 E SIMFileHandler: exception caught from EVENT_GET_RECORD_SIZE 10-25 15:07:05.916 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 14 requested: true 10-25 15:07:06.010 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:06.010 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28472,path: 3F007F20 10-25 15:07:06.074 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:06.138 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28472,0,0,64 10-25 15:07:06.138 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:06.138 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28472,0,0,64 10-25 15:07:06.138 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:06.166 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 111,0,"" 10-25 15:07:06.166 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:06.166 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:06.166 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:06.166 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:06.166 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:06.166 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:06.167 3133 3151 D RILJ : [3690]< SIM_IO IccIoResult sw1:0x6f sw2:0x0 Error: technical problem with no diagnostic given [SUB0] 10-25 15:07:06.167 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 13 requested: true 10-25 15:07:06.266 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:06.267 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28438,path: 3F007F20 10-25 15:07:06.330 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:06.395 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28438,0,0,64 10-25 15:07:06.395 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:06.395 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28438,0,0,64 10-25 15:07:06.395 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:06.428 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 106,130,"" 10-25 15:07:06.428 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:06.429 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:06.429 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:06.429 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:06.429 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:06.429 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:06.430 3133 3151 D RILJ : [3691]< SIM_IO IccIoResult sw1:0x6a sw2:0x82 Error: File not found [SUB0] 10-25 15:07:06.430 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 12 requested: true 10-25 15:07:06.522 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:06.523 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28437,path: 3F007F20 10-25 15:07:06.586 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:06.650 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28437,0,0,64 10-25 15:07:06.650 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:06.650 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28437,0,0,64 10-25 15:07:06.650 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:06.688 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 106,130,"" 10-25 15:07:06.688 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:06.688 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:06.688 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:06.688 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:06.688 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:06.688 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:06.689 3133 3151 D RILJ : [3692]< SIM_IO IccIoResult sw1:0x6a sw2:0x82 Error: File not found [SUB0] 10-25 15:07:06.689 3133 3133 E SIMRecords: [SIMRecords] Exception in fetching EF_CSP data com.android.internal.telephony.uicc.IccException: sw1:106 sw2:130 10-25 15:07:06.690 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 11 requested: true 10-25 15:07:06.779 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:06.779 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28478,path: 3F007F20 10-25 15:07:06.842 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:06.906 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28478,0,0,64 10-25 15:07:06.906 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:06.906 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28478,0,0,64 10-25 15:07:06.906 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:06.942 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 111,0,"" 10-25 15:07:06.942 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:06.942 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:06.942 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:06.942 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:06.942 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:06.942 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:06.943 3133 3151 D RILJ : [3693]< SIM_IO IccIoResult sw1:0x6f sw2:0x0 Error: technical problem with no diagnostic given [SUB0] 10-25 15:07:06.943 3133 3133 E SIMRecords: [SIMRecords] Exception in get GID1 com.android.internal.telephony.uicc.IccException: sw1:111 sw2:0 10-25 15:07:06.943 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 10 requested: true 10-25 15:07:07.034 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:07.034 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28479,path: 3F007F20 10-25 15:07:07.098 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:07.162 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28479,0,0,64 10-25 15:07:07.162 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:07.162 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28479,0,0,64 10-25 15:07:07.163 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:07.191 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 111,0,"" 10-25 15:07:07.191 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:07.191 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:07.191 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:07.192 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:07.192 1199 1369 E use-Rlog/RLOG-RIL: SIM IO Path cannot be NULL 10-25 15:07:07.192 1199 1369 E use-Rlog/RLOG-RIL: requestSIM_IOQMI - error detected 10-25 15:07:07.192 1199 1369 E RILC : Invalid response: NULL 10-25 15:07:07.192 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:07.192 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:07.192 1199 1369 E use-Rlog/RLOG-RIL: SIM IO Path cannot be NULL 10-25 15:07:07.192 1199 1369 E use-Rlog/RLOG-RIL: requestSIM_IOQMI - error detected 10-25 15:07:07.192 1199 1369 E RILC : Invalid response: NULL 10-25 15:07:07.192 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:07.192 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:07.192 3133 3151 D RILJ : [3694]< SIM_IO IccIoResult sw1:0x6f sw2:0x0 Error: technical problem with no diagnostic given [SUB0] 10-25 15:07:07.192 1199 1369 E use-Rlog/RLOG-RIL: SIM IO Path cannot be NULL 10-25 15:07:07.192 1199 1369 E use-Rlog/RLOG-RIL: requestSIM_IOQMI - error detected 10-25 15:07:07.192 1199 1369 E RILC : Invalid response: NULL 10-25 15:07:07.193 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:07.193 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:07.193 3133 3133 E SIMRecords: [SIMRecords] Exception in get GID2 com.android.internal.telephony.uicc.IccException: sw1:111 sw2:0 10-25 15:07:07.193 1199 1369 E use-Rlog/RLOG-RIL: SIM IO Path cannot be NULL 10-25 15:07:07.193 1199 1369 E use-Rlog/RLOG-RIL: requestSIM_IOQMI - error detected 10-25 15:07:07.193 1199 1369 E RILC : Invalid response: NULL 10-25 15:07:07.193 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 9 requested: true 10-25 15:07:07.193 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:07.193 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:07.193 3133 3151 D RILJ : [3695]< SIM_IO error 2 [SUB0] 10-25 15:07:07.193 1199 1369 E use-Rlog/RLOG-RIL: SIM IO Path cannot be NULL 10-25 15:07:07.193 1199 1369 E use-Rlog/RLOG-RIL: requestSIM_IOQMI - error detected 10-25 15:07:07.193 1199 1369 E RILC : Invalid response: NULL 10-25 15:07:07.193 1199 1369 E use-Rlog/RLOG-RIL: processRequest: REPORT_STK_SERVICE_IS_RUNNING 10-25 15:07:07.193 3133 3151 D RilRequest: [3695]< SIM_IO error: com.android.internal.telephony.CommandException: GENERIC_FAILURE ret=IccIoResult sw1:0x0 sw2:0x0 Error: unknown 10-25 15:07:07.193 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: REPORT_STK_SERVICE_IS_RUNNING 10-25 15:07:07.193 1199 1369 E use-Rlog/RLOG-RIL: processRequest: OPERATOR 10-25 15:07:07.194 3133 3133 E SIMRecords: [SIMRecords] Failed getting User PLMN with Access Tech Records: com.android.internal.telephony.CommandException: GENERIC_FAILURE 10-25 15:07:07.194 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 8 requested: true 10-25 15:07:07.194 3133 3151 D RILJ : [3696]< SIM_IO error 2 [SUB0] 10-25 15:07:07.194 3133 3151 D RilRequest: [3696]< SIM_IO error: com.android.internal.telephony.CommandException: GENERIC_FAILURE ret=IccIoResult sw1:0x0 sw2:0x0 Error: unknown 10-25 15:07:07.195 3133 3133 E SIMRecords: [SIMRecords] Failed getting Operator PLMN with Access Tech Records: com.android.internal.telephony.CommandException: GENERIC_FAILURE 10-25 15:07:07.195 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 7 requested: true 10-25 15:07:07.195 3133 3151 D RILJ : [3697]< SIM_IO error 2 [SUB0] 10-25 15:07:07.195 3133 3151 D RilRequest: [3697]< SIM_IO error: com.android.internal.telephony.CommandException: GENERIC_FAILURE ret=IccIoResult sw1:0x0 sw2:0x0 Error: unknown 10-25 15:07:07.196 3133 3133 E SIMRecords: [SIMRecords] Failed getting Home PLMN with Access Tech Records: com.android.internal.telephony.CommandException: GENERIC_FAILURE 10-25 15:07:07.196 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 6 requested: true 10-25 15:07:07.196 3133 3151 D RILJ : [3698]< SIM_IO error 2 [SUB0] 10-25 15:07:07.197 3133 3151 D RilRequest: [3698]< SIM_IO error: com.android.internal.telephony.CommandException: GENERIC_FAILURE ret=IccIoResult sw1:0x0 sw2:0x0 Error: unknown 10-25 15:07:07.197 3133 3133 E SIMRecords: [SIMRecords] Failed getting Equivalent Home PLMNs: com.android.internal.telephony.CommandException: GENERIC_FAILURE 10-25 15:07:07.197 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 5 requested: true 10-25 15:07:07.197 3133 3151 D RILJ : [3699]< SIM_IO error 2 [SUB0] 10-25 15:07:07.198 3133 3151 D RilRequest: [3699]< SIM_IO error: com.android.internal.telephony.CommandException: GENERIC_FAILURE ret=IccIoResult sw1:0x0 sw2:0x0 Error: unknown 10-25 15:07:07.198 3133 3133 E SIMRecords: [SIMRecords] Failed getting Forbidden PLMNs: com.android.internal.telephony.CommandException: GENERIC_FAILURE 10-25 15:07:07.198 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 4 requested: true 10-25 15:07:07.198 3133 3151 D RILJ : [3700]< RIL_REQUEST_REPORT_STK_SERVICE_IS_RUNNING error 6 [SUB0] 10-25 15:07:07.199 3133 3151 D RilRequest: [3700]< RIL_REQUEST_REPORT_STK_SERVICE_IS_RUNNING error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:07.227 1199 1369 I use-Rlog/RLOG-AT: --- AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS?;+COPS=3,2;+COPS? 10-25 15:07:07.227 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:07.227 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+COPS=3,0;+COPS?;+COPS=3,1;+COPS?;+COPS=3,2;+COPS? 10-25 15:07:07.227 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:07.231 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +COPS: 0 10-25 15:07:07.231 1199 1371 I chatty : uid=1001(radio) /system/vendor/bin/hw/rild identical 1 line 10-25 15:07:07.231 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +COPS: 0 10-25 15:07:07.231 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:07.231 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for OPERATOR 10-25 15:07:07.231 1199 1369 E use-Rlog/RLOG-RIL: processRequest: DATA_REGISTRATION_STATE 10-25 15:07:07.232 3133 3151 D RILJ : [3701]< OPERATOR {, , } [SUB0] 10-25 15:07:07.419 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS radioIfaces=0 10-25 15:07:07.419 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS networkType=0 10-25 15:07:07.419 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for DATA_REGISTRATION_STATE 10-25 15:07:07.419 1199 1369 E use-Rlog/RLOG-RIL: processRequest: VOICE_REGISTRATION_STATE 10-25 15:07:07.420 3133 3151 D RILJ : [3702]< DATA_REGISTRATION_STATE {.regState = NOT_REG_MT_SEARCHING_OP, .rat = 0, .reasonDataDenied = -1, .maxDataCalls = 1, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:07.611 1199 1369 D use-Rlog/RLOG-RIL: sendVoiceRegistStateUMTS update status from 3 to 13 10-25 15:07:07.611 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS radioIfaces=0 10-25 15:07:07.611 1199 1369 D use-Rlog/RLOG-RIL: getRadioTechUMTS networkType=0 10-25 15:07:07.611 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for VOICE_REGISTRATION_STATE 10-25 15:07:07.612 1199 1369 E use-Rlog/RLOG-RIL: processRequest: QUERY_NETWORK_SELECTION_MODE 10-25 15:07:07.612 1199 1369 I use-Rlog/RLOG-AT: --- AT+COPS? 10-25 15:07:07.612 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:07.612 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+COPS? 10-25 15:07:07.612 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:07.613 3133 3151 D RILJ : [3703]< VOICE_REGISTRATION_STATE {.regState = REG_DENIED_EM, .rat = 0, .cssSupported = false, .roamingIndicator = -1, .systemIsInPrl = 0, .defaultRoamingIndicator = 0, .reasonForDenial = 0, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:07.613 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +COPS: 0 10-25 15:07:07.613 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:07.613 1199 1369 E use-Rlog/RLOG-RIL: requestQueryNetworkSelectionModeUMTS, mode = 0 10-25 15:07:07.613 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:07.613 1199 1369 E use-Rlog/RLOG-RIL: processRequest: OPERATOR 10-25 15:07:07.613 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for OPERATOR 10-25 15:07:07.613 1199 1369 E use-Rlog/RLOG-RIL: processRequest: DATA_REGISTRATION_STATE 10-25 15:07:07.613 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for DATA_REGISTRATION_STATE 10-25 15:07:07.614 3133 3151 D RILJ : [3704]< QUERY_NETWORK_SELECTION_MODE {0} [SUB0] 10-25 15:07:07.614 3133 3133 D SST : EVENT_POLL_STATE_NETWORK_SELECTION_MODE 10-25 15:07:07.614 1199 1369 E use-Rlog/RLOG-RIL: processRequest: VOICE_REGISTRATION_STATE 10-25 15:07:07.614 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for VOICE_REGISTRATION_STATE 10-25 15:07:07.614 1199 1369 E use-Rlog/RLOG-RIL: processRequest: QUERY_NETWORK_SELECTION_MODE 10-25 15:07:07.614 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:07.614 1199 1369 E use-Rlog/RLOG-RIL: processRequest: OPERATOR 10-25 15:07:07.614 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for OPERATOR 10-25 15:07:07.614 3133 3151 D RILJ : [3705]< OPERATOR {, , } [SUB0] 10-25 15:07:07.614 1199 1369 E use-Rlog/RLOG-RIL: processRequest: DATA_REGISTRATION_STATE 10-25 15:07:07.614 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for DATA_REGISTRATION_STATE 10-25 15:07:07.614 1199 1369 E use-Rlog/RLOG-RIL: processRequest: VOICE_REGISTRATION_STATE 10-25 15:07:07.614 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for VOICE_REGISTRATION_STATE 10-25 15:07:07.615 1199 1369 E use-Rlog/RLOG-RIL: processRequest: QUERY_NETWORK_SELECTION_MODE 10-25 15:07:07.615 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:07.615 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GET_CURRENT_CALLS 10-25 15:07:07.615 1199 1369 W use-Rlog/RLOG-RIL: RIL_REQUEST_GET_CURRENT_CALLS: returning no current calls 10-25 15:07:07.615 1199 1369 E use-Rlog/RLOG-RIL: processRequest: IMS_REGISTRATION_STATE 10-25 15:07:07.615 1199 1369 I use-Rlog/RLOG-RIL: requestQueryIMSRegistrationState: IMS state=0, SMS format =0 10-25 15:07:07.615 3133 3151 D RILJ : [3706]< DATA_REGISTRATION_STATE {.regState = NOT_REG_MT_SEARCHING_OP, .rat = 0, .reasonDataDenied = -1, .maxDataCalls = 1, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:07.615 1199 1369 E use-Rlog/RLOG-RIL: processRequest: CDMA_GET_SUBSCRIPTION_SOURCE 10-25 15:07:07.615 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: CDMA_GET_SUBSCRIPTION_SOURCE 10-25 15:07:07.615 1199 1369 E RILC : responseInt: Invalid response 10-25 15:07:07.615 1199 1369 E use-Rlog/RLOG-RIL: processRequest: VOICE_RADIO_TECH 10-25 15:07:07.615 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: VOICE_RADIO_TECH 10-25 15:07:07.616 1199 1369 E RILC : responseInt: Invalid response 10-25 15:07:07.616 1199 1369 E use-Rlog/RLOG-RIL: processRequest: OPERATOR 10-25 15:07:07.616 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for OPERATOR 10-25 15:07:07.616 1199 1369 E use-Rlog/RLOG-RIL: processRequest: DATA_REGISTRATION_STATE 10-25 15:07:07.616 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for DATA_REGISTRATION_STATE 10-25 15:07:07.616 3133 3151 D RILJ : [3707]< VOICE_REGISTRATION_STATE {.regState = REG_DENIED_EM, .rat = 0, .cssSupported = false, .roamingIndicator = -1, .systemIsInPrl = 0, .defaultRoamingIndicator = 0, .reasonForDenial = 0, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:07.616 1199 1369 E use-Rlog/RLOG-RIL: processRequest: VOICE_REGISTRATION_STATE 10-25 15:07:07.616 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for VOICE_REGISTRATION_STATE 10-25 15:07:07.616 1199 1369 E use-Rlog/RLOG-RIL: processRequest: QUERY_NETWORK_SELECTION_MODE 10-25 15:07:07.616 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_get: valid cached data for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:07.616 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GET_ACTIVITY_INFO 10-25 15:07:07.616 3133 3151 D RILJ : [3708]< QUERY_NETWORK_SELECTION_MODE {0} [SUB0] 10-25 15:07:07.616 3133 3133 D SST : EVENT_POLL_STATE_NETWORK_SELECTION_MODE 10-25 15:07:07.617 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GET_ACTIVITY_INFO 10-25 15:07:07.617 1199 1369 E RILC : getModemActivityInfoResponse Invalid response: NULL 10-25 15:07:07.617 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_OPEN_CHANNEL 10-25 15:07:07.617 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: SIM_OPEN_CHANNEL 10-25 15:07:07.617 1199 1369 E RILC : iccOpenLogicalChannelResponse Invalid response: NULL 10-25 15:07:07.617 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:07.617 3133 3151 D RILJ : [3709]< OPERATOR {, , } [SUB0] 10-25 15:07:07.617 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:07.617 1199 1369 D use-Rlog/RLOG-RIL: readBinaryQMI:Entered 10-25 15:07:07.617 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:07.618 3133 3151 D RILJ : [3710]< DATA_REGISTRATION_STATE {.regState = NOT_REG_MT_SEARCHING_OP, .rat = 0, .reasonDataDenied = -1, .maxDataCalls = 1, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:07.619 3133 3151 D RILJ : [3711]< VOICE_REGISTRATION_STATE {.regState = REG_DENIED_EM, .rat = 0, .cssSupported = false, .roamingIndicator = -1, .systemIsInPrl = 0, .defaultRoamingIndicator = 0, .reasonForDenial = 0, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:07.619 3133 3151 D RILJ : [3712]< QUERY_NETWORK_SELECTION_MODE {0} [SUB0] 10-25 15:07:07.619 3133 3133 D SST : EVENT_POLL_STATE_NETWORK_SELECTION_MODE 10-25 15:07:07.620 3133 3151 D RILJ : [3713]< GET_CURRENT_CALLS {} [SUB0] 10-25 15:07:07.620 3133 3133 D GsmCdmaCallTracker: Event EVENT_POLL_CALLS_RESULT Received 10-25 15:07:07.621 3133 3133 D GsmCdmaCallTracker: [GsmCdmaCallTracker] update phone state, old=IDLE new=IDLE 10-25 15:07:07.621 3133 3151 D RILJ : [3714]< RIL_REQUEST_IMS_REGISTRATION_STATE {0, 0} [SUB0] 10-25 15:07:07.621 3133 3151 D RILJ : [3715]< RIL_REQUEST_CDMA_GET_SUBSCRIPTION_SOURCE error 6 [SUB0] 10-25 15:07:07.621 3133 3133 D RIL_ImsSms: IMS is NOT registered! 10-25 15:07:07.621 3133 3151 D RilRequest: [3715]< RIL_REQUEST_CDMA_GET_SUBSCRIPTION_SOURCE error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret={-1} 10-25 15:07:07.621 3133 3133 E RIL_ImsSms: IMS format was unknown! 10-25 15:07:07.621 3133 3133 D CdmaSSM : CDMA_SUBSCRIPTION_SOURCE event = 2 10-25 15:07:07.621 3133 3151 D RILJ : [3716]< RIL_REQUEST_VOICE_RADIO_TECH error 6 [SUB0] 10-25 15:07:07.621 3133 3151 D RilRequest: [3716]< RIL_REQUEST_VOICE_RADIO_TECH error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret={-1} 10-25 15:07:07.621 3133 3133 W CdmaSSM : Unable to get CDMA Subscription Source, Exception: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED, result: [I@c3b98e0 10-25 15:07:07.621 3133 3133 E GsmCdmaPhone: [GsmCdmaPhone] EVENT_REQUEST_VOICE_RADIO_TECH_DONE: exception=com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED 10-25 15:07:07.622 3133 3151 D RILJ : [3717]< OPERATOR {, , } [SUB0] 10-25 15:07:07.622 3133 3151 D RILJ : [3718]< DATA_REGISTRATION_STATE {.regState = NOT_REG_MT_SEARCHING_OP, .rat = 0, .reasonDataDenied = -1, .maxDataCalls = 1, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:07.622 3133 3133 D SST : handlPollStateResultMessage: GsmSST setDataRegState=1 regState=2 dataRadioTechnology=0 10-25 15:07:07.622 3133 3151 D RILJ : [3719]< VOICE_REGISTRATION_STATE {.regState = REG_DENIED_EM, .rat = 0, .cssSupported = false, .roamingIndicator = -1, .systemIsInPrl = 0, .defaultRoamingIndicator = 0, .reasonForDenial = 0, .cellIdentity = {.cellInfoType = NONE, .cellIdentityGsm = [], .cellIdentityWcdma = [], .cellIdentityCdma = [], .cellIdentityLte = [], .cellIdentityTdscdma = []}} [SUB0] 10-25 15:07:07.622 3133 3133 D SST : handlPollVoiceRegResultMessage: regState=13 radioTechnology=0 10-25 15:07:07.622 3133 3151 D RILJ : [3720]< QUERY_NETWORK_SELECTION_MODE {0} [SUB0] 10-25 15:07:07.622 3133 3133 D SST : EVENT_POLL_STATE_NETWORK_SELECTION_MODE 10-25 15:07:07.622 3133 3151 E RILJ : processResponse: Unexpected response! serial: 73 error: 6 10-25 15:07:07.623 3133 3151 D RILJ : [3722]< RIL_REQUEST_SIM_OPEN_CHANNEL error 6 [SUB0] 10-25 15:07:07.623 3133 3151 D RilRequest: [3722]< RIL_REQUEST_SIM_OPEN_CHANNEL error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:07.623 3133 3133 D SST : Poll ServiceState done: oldSS=[{mVoiceRegState=3(POWER_OFF), mDataRegState=3(POWER_OFF), mVoiceRoamingType=home, mDataRoamingType=home, mVoiceOperatorAlphaLong=null, mVoiceOperatorAlphaShort=null, mDataOperatorAlphaLong=null, mDataOperatorAlphaShort=null, isManualNetworkSelection=false(automatic), mRilVoiceRadioTechnology=0(Unknown), mRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=false, mIsDataRoamingFromRegistration=false, mIsUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0}] newSS=[{mVoiceRegState=1(OUT_OF_SERVICE), mDataRegState=1(OUT_OF_SERVICE), mVoiceRoamingType=home, mDataRoamingType=home, mVoiceOperatorAlphaLong=, mVoiceOperatorAlphaShort=, mDataOperatorAlphaLong=, mDataOperatorAlphaShort=, isManualNetworkSelection=false(automatic), mRilVoiceRadioTechnology=0(Unknown), mRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=true, mIsDataRoamingFromRegistration=false, mIsUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0}] oldMaxDataCalls=1 mNewMaxDataCalls=1 oldReasonDataDenied=-1 mNewReasonDataDenied=-1 10-25 15:07:07.623 3133 3133 D SST : pollStateDone: hasRegistered=false hasDeregistered=false hasDataAttached=false hasDataDetached=false hasDataRegStateChanged=true hasRilVoiceRadioTechnologyChanged= false hasRilDataRadioTechnologyChanged=false hasChanged=true hasVoiceRoamingOn=false hasVoiceRoamingOff=false hasDataRoamingOn=false hasDataRoamingOff=false hasLocationChanged=false has4gHandoff = false hasMultiApnSupport=false hasLostMultiApnSupport=false 10-25 15:07:07.623 3133 3133 D SIMRecords: [SIMRecords] getServiceProviderName: no brandOverride, providerName=null 10-25 15:07:07.623 3133 3133 D SST : updateSpnDisplay: radio is on but out of service, set plmn='Emergency calls only' 10-25 15:07:07.623 3133 3133 D SIMRecords: [SIMRecords] getServiceProviderName: no brandOverride, providerName=null 10-25 15:07:07.623 3133 3133 D SST : updateSpnDisplay: changed sending intent rule=2 showPlmn='true' plmn='Emergency calls only' showSpn='false' spn='null' dataSpn='null' subId='-2' 10-25 15:07:07.625 3133 3133 D SubscriptionController: [setPlmnSpn] No valid subscription to store info 10-25 15:07:07.625 3133 3133 D SubscriptionController: notifySubscriptionInfoChanged: 10-25 15:07:07.626 3133 3145 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:07.626 3133 3146 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:07.626 3133 3162 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:07.627 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.operator.alpha value: propVal= 10-25 15:07:07.627 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.operator.numeric value: propVal= 10-25 15:07:07.628 3133 3133 D SST : operatorNumeric is invalid 10-25 15:07:07.628 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.operator.iso-country value: propVal= 10-25 15:07:07.628 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.operator.isroaming value: false propVal=false 10-25 15:07:07.628 3133 3133 D SST : Broadcasting ServiceState : {mVoiceRegState=1(OUT_OF_SERVICE), mDataRegState=1(OUT_OF_SERVICE), mVoiceRoamingType=home, mDataRoamingType=home, mVoiceOperatorAlphaLong=, mVoiceOperatorAlphaShort=, mDataOperatorAlphaLong=, mDataOperatorAlphaShort=, isManualNetworkSelection=false(automatic), mRilVoiceRadioTechnology=0(Unknown), mRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=true, mIsDataRoamingFromRegistration=false, mIsUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0} 10-25 15:07:07.628 3133 3133 D DefaultPhoneNotifier: nofityServiceState: mRegistry=com.android.internal.telephony.ITelephonyRegistry$Stub$Proxy@f3096e3 ss={mVoiceRegState=1(OUT_OF_SERVICE), mDataRegState=1(OUT_OF_SERVICE), mVoiceRoamingType=home, mDataRoamingType=home, mVoiceOperatorAlphaLong=, mVoiceOperatorAlphaShort=, mDataOperatorAlphaLong=, mDataOperatorAlphaShort=, isManualNetworkSelection=false(automatic), mRilVoiceRadioTechnology=0(Unknown), mRilDataRadioTechnology=0(Unknown), mCssIndicator=unsupported, mNetworkId=-1, mSystemId=-1, mCdmaRoamingIndicator=-1, mCdmaDefaultRoamingIndicator=-1, mIsEmergencyOnly=true, mIsDataRoamingFromRegistration=false, mIsUsingCarrierAggregation=false, mLteEarfcnRsrpBoost=0} sender=Handler (com.android.internal.telephony.GsmCdmaPhone) {1d22f5a} phondId=0 subId=-2 10-25 15:07:07.630 3133 3133 D SubscriptionController: [getSlotIndex]- subId invalid 10-25 15:07:07.633 3133 3133 D SST : notifyDataRegStateRilRadioTechnologyChanged: drs=1 rat=0 10-25 15:07:07.633 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.network.type value: Unknown propVal=Unknown 10-25 15:07:07.634 3133 3133 D DCT : [0]get all active apn types 10-25 15:07:07.634 3133 3133 D UiccCard: Error in SIM access with exceptioncom.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED 10-25 15:07:07.634 3133 3133 D DCT : [0]SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:07.634 3133 3133 D SST : SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:07.640 3133 3133 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:07.640 3133 3133 D SubscriptionController: [getActiveSubInfoList] Sub Controller not ready 10-25 15:07:07.641 3133 3133 D UiccPkcs15: handleMessage: 201 10-25 15:07:07.641 3133 3133 D UiccPkcs15: error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED 10-25 15:07:07.645 3133 3133 D UiccPkcs15: handleMessage: 1 10-25 15:07:07.646 3133 3133 D UiccPkcs15: select pkcs15 failed: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED 10-25 15:07:07.738 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:07.739 1199 1369 D use-Rlog/RLOG-RIL: readBinaryQMI:file_id: 12258,path: 3F00,record: 0,length: 10 10-25 15:07:07.803 1199 1369 D use-Rlog/RLOG-RIL: readBinaryQMI:simResponse: 98195807042058685763 10-25 15:07:07.803 1199 1369 D use-Rlog/RLOG-RIL: readBinaryQMI: SLQSUIMReadTransparent sw1: 90 sw2: 0 10-25 15:07:07.803 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:07.803 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:07.803 1199 1369 D use-Rlog/RLOG-RIL: readRecordQMI:Entered 10-25 15:07:07.803 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:07.804 3133 3151 D RILJ : [3723]< SIM_IO IccIoResult sw1:0x90 sw2:0x0 [SUB0] 10-25 15:07:07.804 3133 3133 D SIMRecords: [SIMRecords] iccid: 89918570400285867536 10-25 15:07:07.804 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 3 requested: true 10-25 15:07:07.931 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:07.931 1199 1369 D use-Rlog/RLOG-RIL: readRecordQMI:file_id: 28480,path: 3F007F10,record: 1,length: 31 10-25 15:07:07.995 1199 1369 D use-Rlog/RLOG-RIL: readRecordQMI:simResponse: FFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFFF0781193961632528FFFFFFFFFFFF 10-25 15:07:07.995 1199 1369 D use-Rlog/RLOG-RIL: readRecordQMI:SLQSUIMReadRecord sw1: 90 sw2: 0 10-25 15:07:07.995 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:07.995 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:07.995 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:07.995 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:07.996 3133 3151 D RILJ : [3724]< SIM_IO IccIoResult sw1:0x90 sw2:0x0 [SUB0] 10-25 15:07:08.005 3133 3133 D SIMRecords: [SIMRecords] MSISDN: [DihHxnzyAaj5e-JfzEWuNM0BOSw] 10-25 15:07:08.005 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 2 requested: true 10-25 15:07:08.123 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:08.123 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28439,path: 3F007F20 10-25 15:07:08.187 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:08.316 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28439,0,0,64 10-25 15:07:08.316 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:08.316 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28439,0,0,64 10-25 15:07:08.316 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:08.352 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 106,130,"" 10-25 15:07:08.352 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:08.352 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - retrying SIMIO command 10-25 15:07:08.352 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28439,0,0,64 10-25 15:07:08.352 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:08.353 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28439,0,0,64 10-25 15:07:08.353 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:08.402 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 106,130,"" 10-25 15:07:08.402 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:08.403 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:08.403 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GET_ACTIVITY_INFO 10-25 15:07:08.403 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GET_ACTIVITY_INFO 10-25 15:07:08.403 1199 1369 E RILC : getModemActivityInfoResponse Invalid response: NULL 10-25 15:07:08.403 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:08.403 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:08.403 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:08.403 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:08.403 3133 3151 D RILJ : [3725]< SIM_IO IccIoResult sw1:0x6a sw2:0x82 Error: File not found [SUB0] 10-25 15:07:08.404 3133 3133 E SIMFileHandler: exception caught from EVENT_GET_RECORD_SIZE 10-25 15:07:08.404 3133 3151 E RILJ : processResponse: Unexpected response! serial: 78 error: 6 10-25 15:07:08.404 3133 3133 D SIMRecords: [SIMRecords] Invalid or missing EF[MAILBOX] 10-25 15:07:08.405 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 1 requested: true 10-25 15:07:08.507 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:08.507 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28436,path: 3F007F20 10-25 15:07:08.571 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:08.635 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28436,0,0,64 10-25 15:07:08.635 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:08.635 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28436,0,0,64 10-25 15:07:08.635 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:08.674 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 106,130,"" 10-25 15:07:08.674 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:08.675 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:08.675 3133 3151 D RILJ : [3727]< SIM_IO IccIoResult sw1:0x6a sw2:0x82 Error: File not found [SUB0] 10-25 15:07:08.676 3133 3133 D RILJ : [3728]> iccIO: SIM_IO command = 0xc0 fileId = 0x6f18 path = 3F007F20 p1 = 0 p2 = 0 p3 = data = null aid = [SUB0] 10-25 15:07:08.677 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 1 requested: true 10-25 15:07:08.677 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SIM_IO 10-25 15:07:08.677 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IOQMI:Entered 10-25 15:07:08.677 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:Entered 10-25 15:07:08.677 1199 1369 D use-Rlog/RLOG-RIL: Entered getCardStatusQMI 10-25 15:07:08.763 1199 1369 D use-Rlog/RLOG-RIL: SLQSUIMGetCardStatus Successful 10-25 15:07:08.763 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:file_id: 28440,path: 3F007F20 10-25 15:07:08.827 1199 1369 D use-Rlog/RLOG-RIL: getFileAttributesQMI:SLQSUIMGetFileAttributes failed, nRet: 1003 10-25 15:07:08.892 1199 1369 I use-Rlog/RLOG-AT: --- AT+CRSM=192,28440,0,0,64 10-25 15:07:08.892 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:08.892 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+CRSM=192,28440,0,0,64 10-25 15:07:08.892 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:08.930 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +CRSM: 106,130,"" 10-25 15:07:08.931 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:08.931 1199 1369 D use-Rlog/RLOG-RIL: requestSIM_IO - successfully completed 10-25 15:07:08.932 3133 3151 D RILJ : [3728]< SIM_IO IccIoResult sw1:0x6a sw2:0x82 Error: File not found [SUB0] 10-25 15:07:08.932 3133 3133 D SIMRecords: [SIMRecords] No SPN loaded in either CHPS or 3GPP 10-25 15:07:08.932 3133 3133 D SIMRecords: [SIMRecords] onRecordLoaded 0 requested: true 10-25 15:07:08.933 3133 3133 D SIMRecords: [SIMRecords] record load complete 10-25 15:07:08.933 3133 3133 D SIMRecords: [SIMRecords] Not using EF LI/EF PL 10-25 15:07:08.933 3133 3133 D SIMRecords: [SIMRecords] EF_CFIS and EF_CFF not valid. callForwardingEnabled=-1 10-25 15:07:08.933 3133 3133 D SIMRecords: [SIMRecords] onAllRecordsLoaded set 'gsm.sim.operator.numeric' to operator='405857' 10-25 15:07:08.933 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.sim.operator.numeric value: 405857 propVal=405857 10-25 15:07:08.934 3133 3133 D SIMRecords: [SIMRecords] onAllRecordsLoaded set mcc imsi 10-25 15:07:08.935 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.sim.operator.iso-country value: in propVal=in 10-25 15:07:08.936 3133 3133 D CAT : CatService: handleMessage[20] 10-25 15:07:08.936 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] updateCurrentCarrierInProvider: mSubId = -2 currentDds = 1 operatorNumeric = 405857 10-25 15:07:08.937 3133 3133 D IccCardProxy: operator=405857 mPhoneId=0 10-25 15:07:08.938 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.sim.operator.numeric value: 405857 propVal=405857 10-25 15:07:08.939 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.sim.operator.iso-country value: in propVal=in 10-25 15:07:08.940 3133 3133 D IccCardProxy: Sending intent ACTION_INTERNAL_SIM_STATE_CHANGED value=LOADED for mPhoneId : 0 10-25 15:07:08.941 3133 3133 D SST : EVENT_SIM_RECORDS_LOADED: what=16 10-25 15:07:08.941 3133 3133 D SST : updatePhoneObject: Ignore update 10-25 15:07:08.941 3133 3133 D SST : getOtasp: otasp not needed for GSM 10-25 15:07:08.941 3133 3133 D SST : updateOtaspState: call notifyOtaspChanged old otaspMode=0 new otaspMode=3 10-25 15:07:08.942 3133 3133 D SIMRecords: [SIMRecords] getServiceProviderName: no brandOverride, providerName=null 10-25 15:07:08.942 3133 3133 D SST : updateSpnDisplay: radio is on but out of service, set plmn='Emergency calls only' 10-25 15:07:08.942 3133 3133 D SIMRecords: [SIMRecords] getServiceProviderName: no brandOverride, providerName=null 10-25 15:07:08.942 3133 3133 D SubscriptionInfoUpdater: [Receiver]+ 10-25 15:07:08.942 3133 3133 D SubscriptionInfoUpdater: Action: android.intent.action.internal_sim_state_changed 10-25 15:07:08.942 3133 3133 D SubscriptionInfoUpdater: slotIndex: 0 10-25 15:07:08.942 3133 3133 D SubscriptionInfoUpdater: simStatus: LOADED 10-25 15:07:08.942 3133 3133 D SubscriptionInfoUpdater: [Receiver]- 10-25 15:07:08.942 3133 3160 D SubscriptionInfoUpdater: handleSimLoaded: slotId: 0 10-25 15:07:08.942 3133 3160 D SubscriptionInfoUpdater: All IccIds query complete 10-25 15:07:08.942 3133 3160 D SubscriptionInfoUpdater: updateSubscriptionInfoByIccId:+ Start 10-25 15:07:08.942 3133 3160 D SubscriptionInfoUpdater: insertedSimCount = 1 10-25 15:07:08.942 3133 3160 D SubscriptionController: [getSubInfoUsingSlotIndexWithCheck]+ slotIndex:0 10-25 15:07:08.945 3133 3160 D SubscriptionController: [getPhoneId]- no sims, returning default phoneId=2147483647 10-25 15:07:08.946 3133 3160 I chatty : uid=1001(radio) android.bg identical 1 line 10-25 15:07:08.946 3133 3160 D SubscriptionController: [getPhoneId]- no sims, returning default phoneId=2147483647 10-25 15:07:08.948 3133 3160 D SubscriptionController: [getSubInfoUsingSlotIndex]- null info return 10-25 15:07:08.948 3133 3160 D SubscriptionInfoUpdater: updateSubscriptionInfoByIccId: oldSubId = 1 10-25 15:07:08.948 3133 3160 D SubscriptionInfoUpdater: updateSubscriptionInfoByIccId: oldIccId[0] = 89918570400285867536, sIccId[0] = 89918570400285867536 10-25 15:07:08.948 3133 3160 D SubscriptionController: [addSubInfoRecord]+ iccId:89918570400285867536 slotIndex:0 10-25 15:07:08.949 3133 3160 D SubscriptionController: [addSubInfoRecord] Record already exists 10-25 15:07:08.951 3133 3160 D SubscriptionController: [addSubInfoRecord] sSlotIndexToSubId.size=1 slotIndex=0 subId=1 defaultSubId=1 simCount=1 10-25 15:07:08.952 3133 3160 D SubscriptionController: [setDefaultFallbackSubId] subId=1 10-25 15:07:08.952 3133 3160 D SubscriptionController: [setDefaultFallbackSubId] set mDefaultFallbackSubId=1 10-25 15:07:08.954 3133 3160 D SubscriptionController: [setDefaultFallbackSubId] broadcast default subId changed phoneId=0 subId=1 10-25 15:07:08.955 3133 3160 D SubscriptionController: [addSubInfoRecord] one sim set defaults to subId=1 10-25 15:07:08.955 3133 3160 D SubscriptionController: [setDefaultDataSubId] num phones=1, subId=1 10-25 15:07:08.956 3133 3160 D SubscriptionController: [setDefaultDataSubId] phoneId=0 subId=1 RAF=577033 10-25 15:07:08.956 3133 3160 D ProxyController: setRadioCapability: Already in requested configuration, nothing to do. 10-25 15:07:08.956 3133 3160 D SubscriptionController: [updateAllDataConnectionTrackers] sPhones.length=1 10-25 15:07:08.956 3133 3160 D SubscriptionController: [updateAllDataConnectionTrackers] phoneId=0 10-25 15:07:08.956 3133 3160 D DCT : [0]update sub = 1 10-25 15:07:08.956 3133 3160 D DCT : [0]update(): Active DDS, register for all events now! 10-25 15:07:08.956 3133 3160 D DCT : [0]New records found. 10-25 15:07:08.956 3133 3133 D DCT : [0]onRecordsLoadedOrSubIdChanged: createAllApnList 10-25 15:07:08.957 3133 3133 D DCT : [0]createAllApnList: selection=numeric = '405857' 10-25 15:07:08.957 3133 3160 D GsmCdmaPhone: [GsmCdmaPhone] updateCurrentCarrierInProvider: mSubId = 1 currentDds = 1 operatorNumeric = 405857 10-25 15:07:08.960 3133 3133 D DCT : [0]createApnList: X result=[[ApnSettingV3] Loop Internet (405857), 1901, 405857, www, , , , , , -1, default | supl | agps | fota | dun, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false, [ApnSettingV3] Loop MMS (405857), 1902, 405857, mizone, , http://mms.loopmobile.in:8080/, 10.0.0.10, 9401, , -1, mms, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false] 10-25 15:07:08.979 3133 3160 D SubscriptionController: [broadcastDefaultDataSubIdChanged] subId=1 10-25 15:07:08.981 3133 3160 D SubscriptionController: [setDefaultSmsSubId] subId=1 10-25 15:07:08.981 3133 3160 D SubscriptionController: [broadcastDefaultSmsSubIdChanged] subId=1 10-25 15:07:08.984 3133 3160 D SubscriptionController: [setDefaultVoiceSubId] subId=1 10-25 15:07:08.985 3133 3160 D SubscriptionController: [broadcastDefaultVoiceSubIdChanged] subId=1 10-25 15:07:08.985 3133 3133 D DCT : [0]getPreferredApn: mRequestedApnType=default cursor=android.content.ContentResolver$CursorWrapperInner@48a5e cursor.count=0 10-25 15:07:08.986 3133 3133 D DCT : [0]getPreferredApn: X not found 10-25 15:07:08.986 3133 3133 D DCT : [0]createAllApnList: mPreferredApn=null 10-25 15:07:08.986 3133 3133 D DCT : [0]createAllApnList: X mAllApnSettings=[[ApnSettingV3] Loop Internet (405857), 1901, 405857, www, , , , , , -1, default | supl | agps | fota | dun, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false, [ApnSettingV3] Loop MMS (405857), 1902, 405857, mizone, , http://mms.loopmobile.in:8080/, 10.0.0.10, 9401, , -1, mms, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false] 10-25 15:07:08.986 3133 3133 D DCT : [0]setDataProfilesAsNeeded 10-25 15:07:08.986 3133 3133 D DCT : [0]setInitialApn: E mPreferredApn=null 10-25 15:07:08.986 3133 3133 D DCT : [0]setInitialApn: firstApnSetting=[ApnSettingV3] Loop Internet (405857), 1901, 405857, www, , , , , , -1, default | supl | agps | fota | dun, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false 10-25 15:07:08.986 3133 3133 D DCT : [0]setInitialApn: defaultApnSetting=[ApnSettingV3] Loop Internet (405857), 1901, 405857, www, , , , , , -1, default | supl | agps | fota | dun, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false 10-25 15:07:08.987 3133 3133 D DCT : [0]setInitialAttachApn: using defaultApnSetting 10-25 15:07:08.987 3133 3133 D DCT : [0]setInitialAttachApn: X selected Apn=[ApnSettingV3] Loop Internet (405857), 1901, 405857, www, , , , , , -1, default | supl | agps | fota | dun, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false 10-25 15:07:08.987 3133 3160 D SubscriptionController: [addSubInfoRecord] hashmap(0,1) 10-25 15:07:08.988 3133 3133 D RILJ : [3729]> RIL_REQUEST_SET_INITIAL_ATTACH_APNDataProfile=0/www/IP/0///0/0/0/0/true/45/IP/0/0///false [SUB0] 10-25 15:07:08.989 3133 3133 D DCT : [0]onRecordsLoadedOrSubIdChanged: notifying data availability 10-25 15:07:08.989 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SET_INITIAL_ATTACH_APN 10-25 15:07:08.989 1199 1369 E use-Rlog/RLOG-RIL: isAPNProfileIdentical invalid parameters 10-25 15:07:08.989 1199 1369 I use-Rlog/RLOG-RIL: requestSetInitialAPN APN info: apn=www, protocol=IP, authtype=0 , username=(null), password=(null) 10-25 15:07:08.989 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:08.991 3133 3133 I chatty : uid=1001(radio) com.android.phone identical 1 line 10-25 15:07:08.995 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:08.996 3133 3145 D RILJ : [3730]> RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:08.996 3133 3145 D RILJ : {.serviceCategory = 4096, .language = 1, .selected = true} [SUB0] 10-25 15:07:08.997 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:09.000 3133 3133 I chatty : uid=1001(radio) com.android.phone identical 2 lines 10-25 15:07:09.002 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:09.004 3133 3133 D DCT : [0]setupDataOnConnectableApns: simLoaded hipri:[state=IDLE,enabled=false] mms:[state=IDLE,enabled=false] supl:[state=IDLE,enabled=false] default:[state=IDLE,enabled=false] fota:[state=IDLE,enabled=false] ims:[state=IDLE,enabled=false] cbs:[state=IDLE,enabled=false] 10-25 15:07:09.006 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:09.007 3133 3133 D PhoneSwitcher: evaluating due to defaultChanged phone[0] -2->1 10-25 15:07:09.007 3133 3133 D PhoneSwitcher: activate 0 10-25 15:07:09.007 3133 3133 D TelephonyNetworkFactory[0]: onActivePhoneSwitch(true, false) 10-25 15:07:09.009 3133 3160 D SubscriptionController: [addSubInfoRecord] sim name = CARD 1 10-25 15:07:09.010 3133 3160 D DCT : [0]update sub = 1 10-25 15:07:09.010 3133 3160 D DCT : [0]update(): Active DDS, register for all events now! 10-25 15:07:09.010 3133 3160 D GsmCdmaPhone: [GsmCdmaPhone] updateCurrentCarrierInProvider: mSubId = 1 currentDds = 1 operatorNumeric = 405857 10-25 15:07:09.029 3133 3160 D SubscriptionController: [addSubInfoRecord]- info size=1 10-25 15:07:09.030 3133 3160 D SubscriptionInfoUpdater: newSim = false 10-25 15:07:09.030 3133 3160 D SubscriptionInfoUpdater: updateSubscriptionInfoByIccId: sInsertSimState[0] = 0 10-25 15:07:09.030 3133 3160 D SubscriptionInfoUpdater: updateSubscriptionInfoByIccId: nSubCount = 1 10-25 15:07:09.032 3133 3160 D SubscriptionController: [setDefaultDataSubId] num phones=1, subId=1 10-25 15:07:09.032 3133 3160 D SubscriptionController: [setDefaultDataSubId] phoneId=0 subId=1 RAF=577033 10-25 15:07:09.033 3133 3160 D ProxyController: setRadioCapability: Already in requested configuration, nothing to do. 10-25 15:07:09.033 3133 3160 D SubscriptionController: [updateAllDataConnectionTrackers] sPhones.length=1 10-25 15:07:09.033 3133 3160 D SubscriptionController: [updateAllDataConnectionTrackers] phoneId=0 10-25 15:07:09.033 3133 3160 D DCT : [0]update sub = 1 10-25 15:07:09.033 3133 3160 D DCT : [0]update(): Active DDS, register for all events now! 10-25 15:07:09.034 3133 3160 D GsmCdmaPhone: [GsmCdmaPhone] updateCurrentCarrierInProvider: mSubId = 1 currentDds = 1 operatorNumeric = 405857 10-25 15:07:09.056 3133 3160 D SubscriptionController: [broadcastDefaultDataSubIdChanged] subId=1 10-25 15:07:09.058 3133 3160 D SubscriptionController: notifySubscriptionInfoChanged: 10-25 15:07:09.059 3133 3161 D SubscriptionMonitor: Phone[0] subId changed -2->1, 1 registrants 10-25 15:07:09.060 3133 3161 D SubscriptionMonitor: mDefaultDataSubId = 1, 1 registrants 10-25 15:07:09.064 3133 3160 D SubscriptionInfoUpdater: updateSubscriptionInfoByIccId:- SubscriptionInfo update complete 10-25 15:07:09.066 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:09.067 3133 3133 D SST : SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:09.068 3133 3160 D SubscriptionController: [setMccMnc]+ mcc/mnc:405/857 subId:1 10-25 15:07:09.069 3133 3133 D Phone : getCallForwardingIndicatorFromSharedPref: for subId 1= -1 10-25 15:07:09.069 3133 3133 D Phone : getCallForwardingIndicatorFromSharedPref: for subId 1= -1 10-25 15:07:09.069 3133 3133 V Phone : getCallForwardingIndicator: iccForwardingFlag=-1, sharedPrefFlag=-1 10-25 15:07:09.069 3133 3133 D DefaultPhoneNotifier: notifyCallForwardingChanged: subId=1, isCFActive=false 10-25 15:07:09.069 3133 3133 D Phone : getCallForwardingIndicatorFromSharedPref: for subId 1= -1 10-25 15:07:09.069 3133 3133 D Phone : getCallForwardingIndicatorFromSharedPref: for subId 1= -1 10-25 15:07:09.069 3133 3133 V Phone : getCallForwardingIndicator: iccForwardingFlag=-1, sharedPrefFlag=-1 10-25 15:07:09.070 3133 3133 D PhoneFactory: calculatePreferredNetworkType: phoneSubId = 1 networkType = 0 10-25 15:07:09.070 3133 3133 D Phone : setPreferredNetworkType: networkType = 0 modemRaf = 577033 rafFromType = 101902 filteredType = 2 10-25 15:07:09.071 3133 3133 D RILJ : [3731]> REQUEST_SET_PREFERRED_NETWORK_TYPE networkType = 2 [SUB0] 10-25 15:07:09.072 3133 3133 D Phone : setNetworkSelectionModeAutomatic, querying current mode 10-25 15:07:09.072 3133 3133 D RILJ : [3732]> QUERY_NETWORK_SELECTION_MODE [SUB0] 10-25 15:07:09.072 3133 3133 D TelephonyManager: setTelephonyProperty: success phoneId=0 property=gsm.network.type value: Unknown propVal=Unknown 10-25 15:07:09.073 3133 3133 D SubscriptionController: [setCarrierText]+ text:Emergency calls only subId:1 10-25 15:07:09.083 1199 1369 E use-Rlog/RLOG-RIL: processRequest: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.083 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.083 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SET_PREFERRED_NETWORK_TYPE 10-25 15:07:09.083 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for VOICE_REGISTRATION_STATE 10-25 15:07:09.083 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for DATA_REGISTRATION_STATE 10-25 15:07:09.083 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for SIGNAL_STRENGTH 10-25 15:07:09.083 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for OPERATOR 10-25 15:07:09.083 3133 3151 D RILJ : [3729]< RIL_REQUEST_SET_INITIAL_ATTACH_APN [SUB0] 10-25 15:07:09.083 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: clearing cache for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:09.083 3133 3151 D RILJ : [3730]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.083 3133 3151 D RilRequest: [3730]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.096 3133 3133 D SubscriptionController: notifySubscriptionInfoChanged: 10-25 15:07:09.098 3133 3133 D SIMRecords: [SIMRecords] getServiceProviderName: no brandOverride, providerName=null 10-25 15:07:09.098 3133 3133 D SST : updateSpnDisplay: radio is on but out of service, set plmn='Emergency calls only' 10-25 15:07:09.098 3133 3133 D SIMRecords: [SIMRecords] getServiceProviderName: no brandOverride, providerName=null 10-25 15:07:09.098 3133 3133 D SST : updateSpnDisplay: changed sending intent rule=2 showPlmn='true' plmn='Emergency calls only' showSpn='false' spn='null' dataSpn='null' subId='1' 10-25 15:07:09.100 3133 3133 D SubscriptionController: [setCarrierText]+ text:Emergency calls only subId:1 10-25 15:07:09.102 3133 3160 D SubscriptionController: notifySubscriptionInfoChanged: 10-25 15:07:09.105 3133 3160 D SubscriptionController: [getActiveSubscriptionInfo]+ subId=1 subInfo={id=1, iccId=89918570400285867536 simSlotIndex=0 displayName=CARD 1 carrierName=Emergency calls only nameSource=0 iconTint=-16746133 dataRoaming=0 iconBitmap=android.graphics.Bitmap@4c7ff5b mcc 405 mnc 857 isEmbedded false accessRules null} 10-25 15:07:09.106 3133 3160 D SubscriptionInfoUpdater: sim name = CARD 1 10-25 15:07:09.117 3133 3133 D SubscriptionController: notifySubscriptionInfoChanged: 10-25 15:07:09.119 3133 3133 D Phone : getStoredVoiceMessageCount: from preference for subId 1= 0 10-25 15:07:09.119 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] updateVoiceMail countVoiceMessages = 0 subId 1 10-25 15:07:09.119 3133 3133 D Phone : setVoiceMessageCount: Storing Voice Mail Count = 0 for mVmCountKey = vm_count_key1 in preferences. 10-25 15:07:09.120 3133 3133 D TelephonyNetworkFactory[0]: onSubIdChange -2->1 10-25 15:07:09.120 3133 3133 D TelephonyNetworkFactory[0]: onDefaultChange(true,true) 10-25 15:07:09.124 3133 3133 D SubscriptionController: [getActiveSubscriptionInfo]+ subId=1 subInfo={id=1, iccId=89918570400285867536 simSlotIndex=0 displayName=CARD 1 carrierName=Emergency calls only nameSource=0 iconTint=-16746133 dataRoaming=0 iconBitmap=android.graphics.Bitmap@71690d1 mcc 405 mnc 857 isEmbedded false accessRules null} 10-25 15:07:09.132 3133 3160 D SubscriptionInfoUpdater: Broadcasting intent ACTION_SIM_STATE_CHANGED LOADED reason null for mCardIndex: 0 10-25 15:07:09.137 3133 3133 D DCT : [0]SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:09.140 3133 3133 D DCT : [0]onRecordsLoadedOrSubIdChanged: createAllApnList 10-25 15:07:09.140 3133 3133 D DCT : [0]createAllApnList: selection=numeric = '405857' 10-25 15:07:09.142 3133 3133 D DCT : [0]createApnList: X result=[[ApnSettingV3] Loop Internet (405857), 1901, 405857, www, , , , , , -1, default | supl | agps | fota | dun, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false, [ApnSettingV3] Loop MMS (405857), 1902, 405857, mizone, , http://mms.loopmobile.in:8080/, 10.0.0.10, 9401, , -1, mms, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false] 10-25 15:07:09.144 3133 3133 D DCT : [0]getPreferredApn: mRequestedApnType=default cursor=android.content.ContentResolver$CursorWrapperInner@57d3637 cursor.count=0 10-25 15:07:09.145 3133 3133 D DCT : [0]getPreferredApn: X not found 10-25 15:07:09.145 3133 3133 D DCT : [0]createAllApnList: mPreferredApn=null 10-25 15:07:09.145 3133 3133 D DCT : [0]createAllApnList: X mAllApnSettings=[[ApnSettingV3] Loop Internet (405857), 1901, 405857, www, , , , , , -1, default | supl | agps | fota | dun, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false, [ApnSettingV3] Loop MMS (405857), 1902, 405857, mizone, , http://mms.loopmobile.in:8080/, 10.0.0.10, 9401, , -1, mms, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false] 10-25 15:07:09.145 3133 3133 D DCT : [0]setDataProfilesAsNeeded 10-25 15:07:09.145 3133 3133 D DCT : [0]setInitialApn: E mPreferredApn=null 10-25 15:07:09.145 3133 3133 D DCT : [0]setInitialApn: firstApnSetting=[ApnSettingV3] Loop Internet (405857), 1901, 405857, www, , , , , , -1, default | supl | agps | fota | dun, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false 10-25 15:07:09.145 3133 3133 D DCT : [0]setInitialApn: defaultApnSetting=[ApnSettingV3] Loop Internet (405857), 1901, 405857, www, , , , , , -1, default | supl | agps | fota | dun, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false 10-25 15:07:09.145 3133 3133 D DCT : [0]setInitialAttachApn: using defaultApnSetting 10-25 15:07:09.145 3133 3133 D DCT : [0]setInitialAttachApn: X selected Apn=[ApnSettingV3] Loop Internet (405857), 1901, 405857, www, , , , , , -1, default | supl | agps | fota | dun, IP, IP, true, 0, 0, 0, false, 0, 0, 0, 0, , , false 10-25 15:07:09.146 3133 3133 D RILJ : [3733]> RIL_REQUEST_SET_INITIAL_ATTACH_APNDataProfile=0/www/IP/0///0/0/0/0/true/45/IP/0/0///false [SUB0] 10-25 15:07:09.146 3133 3133 D DCT : [0]onRecordsLoadedOrSubIdChanged: notifying data availability 10-25 15:07:09.147 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:09.156 3133 3133 I chatty : uid=1001(radio) com.android.phone identical 5 lines 10-25 15:07:09.157 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:09.158 3133 3133 D DCT : [0]setupDataOnConnectableApns: simLoaded hipri:[state=IDLE,enabled=false] mms:[state=IDLE,enabled=false] supl:[state=IDLE,enabled=false] default:[state=IDLE,enabled=false] fota:[state=IDLE,enabled=false] ims:[state=IDLE,enabled=false] cbs:[state=IDLE,enabled=false] 10-25 15:07:09.158 3133 3133 D SST : SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:09.160 3133 3145 D RILJ : [3734]> RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.161 3133 3145 D RILJ : {.serviceCategory = 4097, .language = 1, .selected = true} [SUB0] 10-25 15:07:09.161 3133 3133 D SubscriptionController: [getActiveSubscriptionInfo]+ subId=1 subInfo={id=1, iccId=89918570400285867536 simSlotIndex=0 displayName=CARD 1 carrierName=Emergency calls only nameSource=0 iconTint=-16746133 dataRoaming=0 iconBitmap=android.graphics.Bitmap@25f07a4 mcc 405 mnc 857 isEmbedded false accessRules null} 10-25 15:07:09.167 3133 3133 D DCT : [0]SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:09.169 3133 3133 D SST : SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:09.169 3133 3133 D DCT : [0]SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:09.174 3133 3133 D SubscriptionController: [getActiveSubscriptionInfo]+ subId=1 subInfo={id=1, iccId=89918570400285867536 simSlotIndex=0 displayName=CARD 1 carrierName=Emergency calls only nameSource=0 iconTint=-16746133 dataRoaming=0 iconBitmap=android.graphics.Bitmap@25f07a4 mcc 405 mnc 857 isEmbedded false accessRules null} 10-25 15:07:09.181 3133 3133 D DCT : [0]SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:09.182 3133 3133 D SST : SubscriptionListener.onSubscriptionInfoChanged 10-25 15:07:09.185 3133 3133 D SubscriptionController: [getActiveSubscriptionInfo]+ subId=1 subInfo={id=1, iccId=89918570400285867536 simSlotIndex=0 displayName=CARD 1 carrierName=Emergency calls only nameSource=0 iconTint=-16746133 dataRoaming=0 iconBitmap=android.graphics.Bitmap@25f07a4 mcc 405 mnc 857 isEmbedded false accessRules null} 10-25 15:07:09.190 3133 3133 D DCT : [0]onEnableApn: apnContext={mApnType=default mState=IDLE mWaitingApns={null} mApnSetting={null} mReason=radioTurnedOff mDataEnabled=false mDependencyMet=true} call applyNewState 10-25 15:07:09.190 3133 3133 D DCT : [0]applyNewState(default, true(false), true(true)) 10-25 15:07:09.192 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:09.192 3133 3133 D DCT : [0]trySetupData for APN type default, reason: dataEnabled. Data disallowed, reasons: NOT_ATTACHED 10-25 15:07:09.192 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:09.201 3133 3133 I chatty : uid=1001(radio) com.android.phone identical 5 lines 10-25 15:07:09.203 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:09.204 3133 3133 D DCT : [0]trySetupData failed. apnContext = [type=default, mState=IDLE, apnEnabled=true, mDependencyMet=true] 10-25 15:07:09.210 3133 3133 D SubscriptionInfoUpdater: [Receiver]+ 10-25 15:07:09.210 3133 3133 D SubscriptionInfoUpdater: Action: android.intent.action.SIM_STATE_CHANGED 10-25 15:07:09.211 3133 3133 D SubscriptionInfoUpdater: slotIndex: 0 10-25 15:07:09.211 3133 3133 D SubscriptionInfoUpdater: simStatus: LOADED 10-25 15:07:09.211 3133 3133 D SubscriptionInfoUpdater: Ignoring simStatus: LOADED 10-25 15:07:09.211 3133 3133 D SubscriptionInfoUpdater: [Receiver]- 10-25 15:07:09.211 1199 1369 D use-Rlog/RLOG-RIL: requestSetPreferredNetworkTypeQMI_v2:: Entered 10-25 15:07:09.211 1199 1369 D use-Rlog/RLOG-RIL: requestSetPreferredNetworkTypeQMI_v2:: Rat: 2, Mode Preference: 0x8, GW acq Order:0 10-25 15:07:09.218 3133 3133 D SubscriptionController: [getActiveSubscriptionInfo]+ subId=1 subInfo={id=1, iccId=89918570400285867536 simSlotIndex=0 displayName=CARD 1 carrierName=Emergency calls only nameSource=0 iconTint=-16746133 dataRoaming=0 iconBitmap=android.graphics.Bitmap@25f07a4 mcc 405 mnc 857 isEmbedded false accessRules null} 10-25 15:07:09.230 3133 3133 E CarrierActionAgent: [0]Unsupported action: 7 10-25 15:07:09.230 3133 3133 D CarrierActionAgent: [0]EVENT_SIM_STATE_CHANGED status: LOADED 10-25 15:07:09.235 3133 3133 D CarrierSignalAgent: [0]Sending signal com.android.internal.telephony.CARRIER_SIGNAL_RESET to the carrier signal receiver: ComponentInfo{com.android.carrierdefaultapp/com.android.carrierdefaultapp.CarrierDefaultBroadcastReceiver} 10-25 15:07:09.240 3133 3133 D GsmCdmaPhone: mBroadcastReceiver: action android.telephony.action.CARRIER_CONFIG_CHANGED 10-25 15:07:09.251 3133 3133 D CarrierSignalAgent: [0]CarrierSignalAgent receiver action: android.telephony.action.CARRIER_CONFIG_CHANGED 10-25 15:07:09.252 3133 3133 D CarrierSignalAgent: [0]Loading carrier config: carrier_app_wake_signal_config 10-25 15:07:09.252 3133 3133 D CarrierSignalAgent: [0]Loading carrier config: carrier_app_no_wake_signal_config 10-25 15:07:09.256 3133 3133 I CSST : reading time to delay notification emergency: -1 10-25 15:07:09.256 3133 3133 I CSST : reading time to delay notification emergency: -1 10-25 15:07:09.256 3133 3133 I CSST : PrefNetworkNotification: sendMessage() w/values: ,false,-1,false,true 10-25 15:07:09.256 3133 3133 I CSST : canceling notifications: 1000 10-25 15:07:09.257 3133 3133 D Phone : isWifiCallingEnabled =false 10-25 15:07:09.257 3133 3133 D CSST : isPhoneRegisteredForWifiCalling: false 10-25 15:07:09.257 3133 3133 D Phone : isWifiCallingEnabled =false 10-25 15:07:09.257 3133 3133 I CSST : EmergencyNetworkNotification: sendMessage() w/values: ,false,-1,false,true 10-25 15:07:09.257 3133 3133 I CSST : canceling notifications: 1001 10-25 15:07:09.258 3133 3133 D DCT : [0]isEmergency: result=false 10-25 15:07:09.260 3133 3133 I ImsManager: Creating ImsService using ServiceManager 10-25 15:07:09.261 3133 3133 D ImsManager: updateVolteFeatureValue: available = false, enabled = true, nonTTY = true 10-25 15:07:09.261 3133 3133 I ImsManager: Creating ImsService using ServiceManager 10-25 15:07:09.262 3133 3133 E ImsManager: updateImsServiceConfig: 10-25 15:07:09.262 3133 3133 E ImsManager: com.android.ims.ImsException: getConfigInterface() 10-25 15:07:09.262 3133 3133 E ImsManager: at com.android.ims.ImsManager.getConfigInterface(ImsManager.java:1915) 10-25 15:07:09.262 3133 3133 E ImsManager: at com.android.ims.ImsManager.updateVolteFeatureValue(ImsManager.java:1399) 10-25 15:07:09.262 3133 3133 E ImsManager: at com.android.ims.ImsManager.updateImsServiceConfig(ImsManager.java:1309) 10-25 15:07:09.262 3133 3133 E ImsManager: at com.android.internal.telephony.GsmCdmaPhone.handleMessage(GsmCdmaPhone.java:2250) 10-25 15:07:09.262 3133 3133 E ImsManager: at android.os.Handler.dispatchMessage(Handler.java:106) 10-25 15:07:09.262 3133 3133 E ImsManager: at android.os.Looper.loop(Looper.java:164) 10-25 15:07:09.262 3133 3133 E ImsManager: at android.app.ActivityThread.main(ActivityThread.java:6494) 10-25 15:07:09.262 3133 3133 E ImsManager: at java.lang.reflect.Method.invoke(Native Method) 10-25 15:07:09.262 3133 3133 E ImsManager: at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:463) 10-25 15:07:09.262 3133 3133 E ImsManager: at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:807) 10-25 15:07:09.262 3133 3133 E ImsManager: Caused by: android.os.RemoteException: ImsServiceProxy is not available for that feature. 10-25 15:07:09.262 3133 3133 E ImsManager: at android.telephony.ims.ImsServiceProxyCompat.checkBinderConnection(ImsServiceProxyCompat.java:180) 10-25 15:07:09.262 3133 3133 E ImsManager: at android.telephony.ims.ImsServiceProxyCompat.getConfigInterface(ImsServiceProxyCompat.java:125) 10-25 15:07:09.262 3133 3133 E ImsManager: at com.android.ims.ImsManager.getConfigInterface(ImsManager.java:1908) 10-25 15:07:09.262 3133 3133 E ImsManager: ... 9 more 10-25 15:07:09.262 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] broadcastEmergencyCallStateChanges = false 10-25 15:07:09.262 3133 3133 E GsmCdmaPhone: [GsmCdmaPhone] Invalid cdma_roaming_mode settings: -1 10-25 15:07:09.262 3133 3133 D EriManager: loadEriFileFromXml: check for alternate file 10-25 15:07:09.262 3133 3133 D EriManager: loadEriFileFromXml: no alternate file 10-25 15:07:09.263 3133 3133 D EriManager: eriFile = eri.xml 10-25 15:07:09.266 3133 3133 D EriManager: loadEriFileFromXml: eri parsing successful, file loaded. ver = 1357, # of entries = 176 10-25 15:07:09.266 3133 3133 D GsmCdmaPhone: [GsmCdmaPhone] ERI read, notify registrants 10-25 15:07:09.275 1199 1369 D use-Rlog/RLOG-RIL: requestSetPreferredNetworkTypeQMI_v2:: SLQSSetSysSelectionPref succeed 0 10-25 15:07:09.275 1199 1369 E use-Rlog/RLOG-RIL: processRequest: QUERY_NETWORK_SELECTION_MODE 10-25 15:07:09.275 1199 1369 I use-Rlog/RLOG-AT: --- AT+COPS? 10-25 15:07:09.275 1199 1369 I use-Rlog/RLOG-AT: at_port_setup started 10-25 15:07:09.275 1199 1369 I use-Rlog/RLOG-AT: AT(14)> AT+COPS? 10-25 15:07:09.275 1199 1371 D use-Rlog/RLOG-AT: readline received cmd(b): o 10-25 15:07:09.275 3133 3151 D RILJ : [3731]< REQUEST_SET_PREFERRED_NETWORK_TYPE [SUB0] 10-25 15:07:09.278 1199 1371 I use-Rlog/RLOG-AT: AT(14)< +COPS: 0 10-25 15:07:09.278 1199 1371 I use-Rlog/RLOG-AT: AT(14)< OK 10-25 15:07:09.278 1199 1369 E use-Rlog/RLOG-RIL: requestQueryNetworkSelectionModeUMTS, mode = 0 10-25 15:07:09.278 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for QUERY_NETWORK_SELECTION_MODE 10-25 15:07:09.278 1199 1369 E use-Rlog/RLOG-RIL: processRequest: SET_INITIAL_ATTACH_APN 10-25 15:07:09.278 1199 1369 E use-Rlog/RLOG-RIL: isAPNProfileIdentical invalid parameters 10-25 15:07:09.278 1199 1369 I use-Rlog/RLOG-RIL: requestSetInitialAPN APN info: apn=www, protocol=IP, authtype=0 , username=(null), password=(null) 10-25 15:07:09.279 3133 3151 D RILJ : [3732]< QUERY_NETWORK_SELECTION_MODE {0} [SUB0] 10-25 15:07:09.279 3133 3133 D Phone : setNetworkSelectionModeAutomatic - already auto, ignoring 10-25 15:07:09.339 1199 1303 D use-Rlog/RLOG-RIL: SLQSSetBandPreferenceCB:: band_pref = 0x0002000007c00000 10-25 15:07:09.339 1199 1303 D use-Rlog/RLOG-RIL: SLQSSetSysSelecttionPreferenceCB:: Emergency mode value = 0 10-25 15:07:09.468 3133 3151 D RILJ : [3733]< RIL_REQUEST_SET_INITIAL_ATTACH_APN [SUB0] 10-25 15:07:09.531 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[0]=0 10-25 15:07:09.531 1199 1369 D use-Rlog/RLOG-RIL: requestSignalStrengthQMI_r12 RadioInterface[1]=0 10-25 15:07:09.595 1199 1369 I use-Rlog/RLOG-RIL: swiril_cache_set: updating cache for SIGNAL_STRENGTH 10-25 15:07:09.595 1199 1369 E use-Rlog/RLOG-RIL: processRequest: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.595 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.596 3133 3151 D RILJ : [3734]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.596 3133 3151 D RilRequest: [3734]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.603 3133 3145 D RILJ : [3735]> RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.603 3133 3145 D RILJ : {.serviceCategory = 4098, .language = 1, .selected = true} [SUB0] 10-25 15:07:09.604 1199 1369 E use-Rlog/RLOG-RIL: processRequest: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.604 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.604 3133 3151 D RILJ : [3735]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.604 3133 3151 D RilRequest: [3735]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.607 3133 3145 D RILJ : [3736]> RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.607 3133 3145 D RILJ : {.serviceCategory = 4099, .language = 1, .selected = true} [SUB0] 10-25 15:07:09.607 1199 1369 E use-Rlog/RLOG-RIL: processRequest: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.607 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.607 3133 3151 D RILJ : [3736]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.608 3133 3151 D RilRequest: [3736]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.611 3133 3145 D RILJ : [3737]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.611 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4352,4354] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.611 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.612 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.612 3133 3151 D RILJ : [3737]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.612 3133 3151 D RilRequest: [3737]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.614 3133 3145 D RILJ : [3738]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.614 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4356,4356] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.614 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.614 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.614 3133 3151 D RILJ : [3738]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.614 3133 3151 D RilRequest: [3738]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.618 3133 3145 D RILJ : [3739]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.618 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4370,4370] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.619 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.619 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.619 3133 3151 D RILJ : [3739]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.619 3133 3151 D RilRequest: [3739]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.621 3133 3145 D RILJ : [3740]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.621 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4371,4372] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.621 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.621 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.622 3133 3151 D RILJ : [3740]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.622 3133 3151 D RilRequest: [3740]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.625 3133 3145 D RILJ : [3741]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.625 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4373,4378] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.625 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.625 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.625 3133 3151 D RILJ : [3741]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.626 3133 3151 D RilRequest: [3741]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.628 3133 3145 D RILJ : [3742]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.628 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4379,4379] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.628 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.628 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.628 3133 3151 D RILJ : [3742]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.628 3133 3151 D RilRequest: [3742]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.632 3133 3145 D RILJ : [3743]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.632 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4383,4383] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.632 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.632 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.632 3133 3151 D RILJ : [3743]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.632 3133 3151 D RilRequest: [3743]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.634 3133 3145 D RILJ : [3744]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.634 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4384,4385] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.635 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.635 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.635 3133 3151 D RILJ : [3744]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.635 3133 3151 D RilRequest: [3744]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.637 3133 3145 D RILJ : [3745]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.637 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4386,4391] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.637 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.637 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.638 3133 3151 D RILJ : [3745]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.638 3133 3151 D RilRequest: [3745]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.640 3133 3145 D RILJ : [3746]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.640 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4392,4392] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.641 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.641 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.641 3133 3151 D RILJ : [3746]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.641 3133 3151 D RilRequest: [3746]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.647 3133 3145 D RILJ : [3747]> RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.647 3133 3145 D RILJ : {.serviceCategory = 4096, .language = 1, .selected = true} [SUB0] 10-25 15:07:09.648 1199 1369 E use-Rlog/RLOG-RIL: processRequest: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.648 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.648 3133 3151 D RILJ : [3747]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.648 3133 3151 D RilRequest: [3747]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.650 3133 3145 D RILJ : [3748]> RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.650 3133 3145 D RILJ : {.serviceCategory = 4097, .language = 1, .selected = true} [SUB0] 10-25 15:07:09.650 1199 1369 E use-Rlog/RLOG-RIL: processRequest: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.650 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.651 3133 3151 D RILJ : [3748]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.651 3133 3151 D RilRequest: [3748]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.653 3133 3145 D RILJ : [3749]> RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.653 3133 3145 D RILJ : {.serviceCategory = 4098, .language = 1, .selected = true} [SUB0] 10-25 15:07:09.653 1199 1369 E use-Rlog/RLOG-RIL: processRequest: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.653 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.653 3133 3151 D RILJ : [3749]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.653 3133 3151 D RilRequest: [3749]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.655 3133 3145 D RILJ : [3750]> RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.655 3133 3145 D RILJ : {.serviceCategory = 4099, .language = 1, .selected = true} [SUB0] 10-25 15:07:09.655 1199 1369 E use-Rlog/RLOG-RIL: processRequest: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.655 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: CDMA_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.656 3133 3151 D RILJ : [3750]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.656 3133 3151 D RilRequest: [3750]< RIL_REQUEST_CDMA_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.659 3133 3145 D RILJ : [3751]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.659 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4352,4354] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.659 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.659 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.659 3133 3151 D RILJ : [3751]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.659 3133 3151 D RilRequest: [3751]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.661 3133 3145 D RILJ : [3752]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.661 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4356,4356] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.662 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.662 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.662 3133 3151 D RILJ : [3752]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.662 3133 3151 D RilRequest: [3752]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.665 3133 3145 D RILJ : [3753]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.665 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4370,4370] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.665 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.665 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.665 3133 3151 D RILJ : [3753]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.666 3133 3151 D RilRequest: [3753]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.668 3133 3145 D RILJ : [3754]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.668 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4371,4372] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.668 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.668 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.668 3133 3151 D RILJ : [3754]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.668 3133 3151 D RilRequest: [3754]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.671 3133 3145 D RILJ : [3755]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.671 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4373,4378] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.671 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.671 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.671 3133 3151 D RILJ : [3755]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.671 3133 3151 D RilRequest: [3755]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.673 3133 3145 D RILJ : [3756]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.674 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4379,4379] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.674 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.674 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.674 3133 3151 D RILJ : [3756]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.674 3133 3151 D RilRequest: [3756]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.677 3133 3145 D RILJ : [3757]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.677 3133 3145 D RILJ : SmsBroadcastConfigInfo: Id [4383,4383] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.678 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.678 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.678 3133 3151 D RILJ : [3757]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.678 3133 3151 D RilRequest: [3757]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.680 3133 3147 D RILJ : [3758]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.680 3133 3147 D RILJ : SmsBroadcastConfigInfo: Id [4384,4385] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.681 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.681 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.681 3133 3151 D RILJ : [3758]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.681 3133 3151 D RilRequest: [3758]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.683 3133 3147 D RILJ : [3759]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.683 3133 3147 D RILJ : SmsBroadcastConfigInfo: Id [4386,4391] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.683 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.683 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.683 3133 3151 D RILJ : [3759]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.683 3133 3151 D RilRequest: [3759]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= 10-25 15:07:09.685 3133 3147 D RILJ : [3760]> RIL_REQUEST_GSM_SET_BROADCAST_CONFIG with 1 configs : [SUB0] 10-25 15:07:09.685 3133 3147 D RILJ : SmsBroadcastConfigInfo: Id [4392,4392] Code [0,255] ENABLED [SUB0] 10-25 15:07:09.686 1199 1369 E use-Rlog/RLOG-RIL: processRequest: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.686 1199 1369 W use-Rlog/RLOG-RIL: Unsupported request logged: GSM_SET_BROADCAST_SMS_CONFIG 10-25 15:07:09.686 3133 3151 D RILJ : [3760]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error 6 [SUB0] 10-25 15:07:09.686 3133 3151 D RilRequest: [3760]< RIL_REQUEST_GSM_SET_BROADCAST_CONFIG error: com.android.internal.telephony.CommandException: REQUEST_NOT_SUPPORTED ret= ^C