Replicant

[EVT]:Req(3), RX(0)

[EVT]:Req(3), RX(0)

sizeof(packet) is <269>

sizeof(packet.data) is <256>

strlen((char *)packet.data) is <0>

p_args->data == NULL

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671342934

IPC_send_singleIPC: fd 17 sendto 13 bytes

TX: Time: 1314202031 / 33934

TX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_GET len:d mseq:26 aseq:0

TX: ---- DATA BEGIN ----

TX: C0 16 6F 00 00 0F

TX: ---- DATA END ----

IPC_send_singleIPC: 13 bytes sent.

send success

WaitForExpectedCmd(): cur_time: 33934, cur_req->timeout: 133934, ph->near_timeout: 133923

Serial: 39

Error: 0

[0039]< SIM_IO IccIoResponse sw1:0x90 sw2:0x0

ipc_debug_send_ipc: timestamp 1384293671349741

[EVT]:Req(3), RX(1)

RX: Time: 1314202037 / 33941

RX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_RESP len:a mseq:0 aseq:26

RX: ---- DATA BEGIN ----

RX: 94 04 00

RX: ---- DATA END ----

requestSIM_IO

RxSEC_ResRSIMAccess

File ID is (6f16)

RIL_onRequestComplete: tok(0xc4cd58)

[RM REQ]: req(0xc4cc68), tok(0xc4cd58)

[EVT]:Req(2), RX(0)

[EVT]:Req(2), RX(0)

requestSIM_IO

TxSEC_GetRSIMAccess()

sizeof(packet) is <269>

sizeof(packet.data) is <256>

strlen((char *)packet.data) is <0>

p_args->data == NULL

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671350022

IPC_send_singleIPC: fd 17 sendto 13 bytes

TX: Time: 1314202038 / 33941

TX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_GET len:d mseq:27 aseq:0

TX: ---- DATA BEGIN ----

TX: C0 15 6F 00 00 0F

TX: ---- DATA END ----

IPC_send_singleIPC: 13 bytes sent.

send success

WaitForExpectedCmd(): cur_time: 33941, cur_req->timeout: 133941, ph->near_timeout: 133934

Serial: 40

Error: 0

[0040]< SIM_IO IccIoResponse sw1:0x94 sw2:0x4

CatService: MSG_ID_ICC_CHANGED

CatService: New Card State = CARDSTATE_PRESENT Old Card State = CARDSTATE_PRESENT

ipc_debug_send_ipc: timestamp 1384293671357228

[EVT]:Req(2), RX(1)

RX: Time: 1314202045 / 33948

RX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_RESP len:a mseq:0 aseq:27

RX: ---- DATA BEGIN ----

RX: 94 04 00

RX: ---- DATA END ----

requestSIM_IO

RxSEC_ResRSIMAccess

File ID is (6f15)

RIL_onRequestComplete: tok(0xc4ceb0)

[RM REQ]: req(0xc4cec8), tok(0xc4ceb0)

[EVT]:Req(1), RX(0)

[EVT]:Req(1), RX(0)

requestSIM_IO

TxSEC_GetRSIMAccess()

sizeof(packet) is <269>

sizeof(packet.data) is <256>

strlen((char *)packet.data) is <0>

p_args->data == NULL

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671357642

IPC_send_singleIPC: fd 17 sendto 13 bytes

TX: Time: 1314202045 / 33949

TX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_GET len:d mseq:28 aseq:0

TX: ---- DATA BEGIN ----

TX: C0 3E 6F 00 00 0F

TX: ---- DATA END ----

IPC_send_singleIPC: 13 bytes sent.

send success

WaitForExpectedCmd(): cur_time: 33949, cur_req->timeout: 133949, ph->near_timeout: 133941

Serial: 41

Error: 0

[0041]< SIM_IO IccIoResponse sw1:0x94 sw2:0x4

ipc_debug_send_ipc: timestamp 1384293671365287

[EVT]:Req(1), RX(1)

RX: Time: 1314202053 / 33956

RX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_RESP len:a mseq:0 aseq:28

RX: ---- DATA BEGIN ----

RX: 94 04 00

RX: ---- DATA END ----

requestSIM_IO

RxSEC_ResRSIMAccess

File ID is (6f3e)

RIL_onRequestComplete: tok(0xc4cf60)

[RM REQ]: req(0xc4cf78), tok(0xc4cf60)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

Serial: 42

Error: 0

[0042]< SIM_IO IccIoResponse sw1:0x94 sw2:0x4

[SimPbInterfaceManager] Card update received: com.android.internal.telephony.uicc.UiccCard@41aa0458

[SimPbInterfaceManager] Existing app found

handleMessage msg={ what=270369 when=-301ms obj=android.os.AsyncResult@41aaedc8 }

getUiccCardApplication Unknown

onUpdateIcc: newIccRecords null

CatService: MSG_ID_ICC_CHANGED

CatService: New Card State = CARDSTATE_PRESENT Old Card State = CARDSTATE_PRESENT

[SIMRecords] IMSI: xxxxxxx

[SIMRecords] onRecordLoaded 15 requested: true

[0044]> iccIO: SIM_IO 0xb0 0x2fe2 path: 3F00,0,0,10 aid: null

onRequest: SIM_IO

CreateRequest(): req(0xc4cc90), id(28), tok(0xc4cc68) - FUNC(0x403c2809)

[EVT]:Req(1), RX(0)

requestSIM_IO

TxSEC_GetRSIMAccess()

sizeof(packet) is <269>

sizeof(packet.data) is <256>

strlen((char *)packet.data) is <0>

p_args->data == NULL

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671413397

IPC_send_singleIPC: fd 17 sendto 13 bytes

TX: Time: 1314202101 / 34004

TX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_GET len:d mseq:29 aseq:0

TX: ---- DATA BEGIN ----

TX: B0 E2 2F 00 00 0A

TX: ---- DATA END ----

IPC_send_singleIPC: 13 bytes sent.

send success

WaitForExpectedCmd(): cur_time: 34005, cur_req->timeout: 134005, ph->near_timeout: 134005

[0045]> iccIO: SIM_IO 0xb2 0x6f40 path: 3F007F10,1,4,24 aid: null

onRequest: SIM_IO

CreateRequest(): req(0xc4cd90), id(28), tok(0xc4cc28) - FUNC(0x403c2809)

[EVT]:Req(2), RX(0)

[0046]> iccIO: SIM_IO 0xb0 0x6fad path: 3F007F20,0,0,3 aid: null

onRequest: SIM_IO

CreateRequest(): req(0xc4ce18), id(28), tok(0xc4ce00) - FUNC(0x403c2809)

[EVT]:Req(3), RX(0)

setCurrentPreferredNetworkType IGNORED

ipc_debug_send_ipc: timestamp 1384293671440807

[EVT]:Req(3), RX(1)

RX: Time: 1314202128 / 34032

RX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_RESP len:14 mseq:0 aseq:29

RX: ---- DATA BEGIN ----

RX: 90 00 0A 98 34 10 75 90 32 02 23 48 F9

RX: ---- DATA END ----

requestSIM_IO

RxSEC_ResRSIMAccess

File ID is (2fe2)

return prv_bytes_to_hexadecimal_string is <> and size is <20>

simResponse is (983410759032022348f9)

RIL_onRequestComplete: tok(0xc4cc68)

[RM REQ]: req(0xc4cc90), tok(0xc4cc68)

[EVT]:Req(2), RX(0)

[EVT]:Req(2), RX(0)

requestSIM_IO

TxSEC_GetRSIMAccess()

sizeof(packet) is <269>

sizeof(packet.data) is <256>

strlen((char *)packet.data) is <0>

p_args->data == NULL

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671441141

IPC_send_singleIPC: fd 17 sendto 13 bytes

TX: Time: 1314202129 / 34032

TX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_GET len:d mseq:2a aseq:0

TX: ---- DATA BEGIN ----

TX: B2 40 6F 01 04 18

TX: ---- DATA END ----

IPC_send_singleIPC: 13 bytes sent.

send success

WaitForExpectedCmd(): cur_time: 34032, cur_req->timeout: 134032, ph->near_timeout: 134005

Serial: 44

Error: 0

[0044]< SIM_IO IccIoResponse sw1:0x90 sw2:0x0

[0047]> OPERATOR

[0048]> DATA_REGISTRATION_STATE

ipc_debug_send_ipc: timestamp 1384293671481392

[EVT]:Req(2), RX(1)

RX: Time: 1314202169 / 34072

RX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_RESP len:22 mseq:0 aseq:2a

RX: ---- DATA BEGIN ----

RX: 90 00 18 FF FF FF FF FF FF FF FF FF FF FF FF FF

RX: FF FF FF FF FF FF FF FF FF FF FF

RX: ---- DATA END ----

requestSIM_IO

RxSEC_ResRSIMAccess

File ID is (6f40)

return prv_bytes_to_hexadecimal_string is <9032!> and size is <48>

simResponse is (ffffffffffffffffffffffffffffffffffffffffffffffff)

RIL_onRequestComplete: tok(0xc4cc28)

[RM REQ]: req(0xc4cd90), tok(0xc4cc28)

[EVT]:Req(1), RX(0)

[EVT]:Req(1), RX(0)

requestSIM_IO

TxSEC_GetRSIMAccess()

sizeof(packet) is <269>

sizeof(packet.data) is <256>

strlen((char *)packet.data) is <0>

p_args->data == NULL

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671481722

IPC_send_singleIPC: fd 17 sendto 13 bytes

TX: Time: 1314202169 / 34073

TX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_GET len:d mseq:2b aseq:0

TX: ---- DATA BEGIN ----

TX: B0 AD 6F 00 00 03

TX: ---- DATA END ----

IPC_send_singleIPC: 13 bytes sent.

send success

WaitForExpectedCmd(): cur_time: 34073, cur_req->timeout: 134073, ph->near_timeout: 134032

Serial: 45

Error: 0

[0045]< SIM_IO IccIoResponse sw1:0x90 sw2:0x0

onRequest: OPERATOR

CreateRequest(): req(0xc4cc50), id(22), tok(0xc4cc38) - FUNC(0x403c6105)

[EVT]:Req(2), RX(0)

requestOperator()

TxNET_GetCurrentPLMN()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671483648

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314202171 / 34075

TX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_GET len:7 mseq:2c aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 34075, cur_req->timeout: 69075, ph->near_timeout: 69075

onRequest: GPRS_REGISTRATION_STATE

CreateRequest(): req(0xc4cd10), id(21), tok(0xc4ccb0) - FUNC(0x403c619d)

[EVT]:Req(3), RX(0)

ipc_debug_send_ipc: timestamp 1384293671484293

[EVT]:Req(3), RX(1)

RX: Time: 1314202172 / 34075

RX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_RESP len:12 mseq:0 aseq:2c

RX: ---- DATA BEGIN ----

RX: 02 05 FF 30 30 30 30 30 23 00 00

RX: ---- DATA END ----

requestOperator()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cc50), tok(0xc4cc38)

[EVT]:Req(2), RX(0)

[EVT]:Req(2), RX(0)

requestGprsRegistrationState()

TxNET_GetDataNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671484493

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314202172 / 34076

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:2d aseq:0

TX: ---- DATA BEGIN ----

TX: FF 03

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 34076, cur_req->timeout: 69076, ph->near_timeout: 69075

Serial: 47

Error: 0

[0047]< OPERATOR {null, null, 00000}

[0049]> VOICE_REGISTRATION_STATE

ipc_debug_send_ipc: timestamp 1384293671485225

[EVT]:Req(2), RX(1)

RX: Time: 1314202173 / 34076

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:0 aseq:2d

RX: ---- DATA BEGIN ----

RX: FF 03 01 00 00 00 00 00 00 00 00

RX: ---- DATA END ----

requestGprsRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4ccb0)

[RM REQ]: req(0xc4cd10), tok(0xc4ccb0)

[EVT]:Req(1), RX(0)

[EVT]:Req(1), RX(0)

Serial: 48

Error: 0

[0048]< DATA_REGISTRATION_STATE {0, 0000, 00000000, 0}

[0050]> QUERY_NETWORK_SELECTION_MODE

onRequest: REGISTRATION_STATE

CreateRequest(): req(0xc4cc50), id(20), tok(0xc4cc38) - FUNC(0x403c6235)

[EVT]:Req(2), RX(0)

requestRegistrationState()

TxNET_GetNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671487415

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314202175 / 34078

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:2e aseq:0

TX: ---- DATA BEGIN ----

TX: FF 02

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 34078, cur_req->timeout: 69078, ph->near_timeout: 69078

ipc_debug_send_ipc: timestamp 1384293671487967

[EVT]:Req(2), RX(1)

RX: Time: 1314202176 / 34079

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:0 aseq:2e

RX: ---- DATA BEGIN ----

RX: FF 02 01 00 00 00 00 00 00 00 00

RX: ---- DATA END ----

requestRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cc50), tok(0xc4cc38)

[EVT]:Req(1), RX(0)

[EVT]:Req(1), RX(0)

[0051]> iccIO: SIM_IO 0xb0 0x6f46 path: 3F007F20,0,0,17 aid: null

[0052]> iccIO: SIM_IO 0xb0 0x6fcd path: 3F007F20,0,0,34 aid: null

onRequest: QUERY_NETWORK_SELECTION_MODE

CreateRequest(): req(0xc4cd38), id(45), tok(0xc4cd20) - FUNC(0x403c6369)

[EVT]:Req(2), RX(0)

requestQueryNetworkSelectionMode()

TxNET_GetPLMNSelection()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671491069

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314202179 / 34082

TX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_GET len:7 mseq:2f aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 34082, cur_req->timeout: 69082, ph->near_timeout: 69082

onRequest: SIM_IO

CreateRequest(): req(0xc4cc28), id(28), tok(0xc4cde0) - FUNC(0x403c2809)

[EVT]:Req(3), RX(0)

ipc_debug_send_ipc: timestamp 1384293671491648

[EVT]:Req(3), RX(1)

RX: Time: 1314202179 / 34083

RX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_RESP len:8 mseq:0 aseq:2f

RX: ---- DATA BEGIN ----

RX: 02

RX: ---- DATA END ----

requestQueryNetworkSelectionMode()

RxNET_ResPLMNSelection()

RIL_onRequestComplete: tok(0xc4cd20)

[RM REQ]: req(0xc4cd38), tok(0xc4cd20)

[EVT]:Req(2), RX(0)

[EVT]:Req(2), RX(0)

Serial: 49

Error: 0

[0049]< VOICE_REGISTRATION_STATE {0, 0000, 00000000}

Serial: 50

Error: 0

[0050]< QUERY_NETWORK_SELECTION_MODE {0}

onRequest: SIM_IO

CreateRequest(): req(0xc4cd80), id(28), tok(0xc4cd58) - FUNC(0x403c2809)

[EVT]:Req(3), RX(0)

[0053]> iccIO: SIM_IO 0xb2 0x6fc5 path: 3F007F20,1,4,13 aid: null

onRequest: SIM_IO

CreateRequest(): req(0xc4ced8), id(28), tok(0xc4cec0) - FUNC(0x403c2809)

[EVT]:Req(4), RX(0)

[0054]> iccIO: SIM_IO 0xb0 0x6f38 path: 3F007F20,0,0,14 aid: null

onRequest: SIM_IO

CreateRequest(): req(0xc4cf88), id(28), tok(0xc4cf70) - FUNC(0x403c2809)

[EVT]:Req(5), RX(0)

onReceive: start auto registration

Broadcasting intent ACTION_SIM_STATE_CHANGED IMSI reason null

ipc_debug_send_ipc: timestamp 1384293671519395

[EVT]:Req(5), RX(1)

RX: Time: 1314202207 / 34110

RX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_RESP len:d mseq:0 aseq:2b

RX: ---- DATA BEGIN ----

RX: 90 00 03 00 FF FF

RX: ---- DATA END ----

requestSIM_IO

RxSEC_ResRSIMAccess

File ID is (6fad)

return prv_bytes_to_hexadecimal_string is <@> and size is <6>

simResponse is (00ffff)

RIL_onRequestComplete: tok(0xc4ce00)

[RM REQ]: req(0xc4ce18), tok(0xc4ce00)

[EVT]:Req(4), RX(0)

[EVT]:Req(4), RX(0)

requestSIM_IO

TxSEC_GetRSIMAccess()

sizeof(packet) is <269>

sizeof(packet.data) is <256>

strlen((char *)packet.data) is <0>

p_args->data == NULL

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671519754

IPC_send_singleIPC: fd 17 sendto 13 bytes

TX: Time: 1314202207 / 34111

TX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_GET len:d mseq:30 aseq:0

TX: ---- DATA BEGIN ----

TX: B0 46 6F 00 00 11

TX: ---- DATA END ----

IPC_send_singleIPC: 13 bytes sent.

send success

WaitForExpectedCmd(): cur_time: 34111, cur_req->timeout: 134111, ph->near_timeout: 134073

Serial: 46

Error: 0

[0046]< SIM_IO IccIoResponse sw1:0x90 sw2:0x0

[0055]> iccIO: SIM_IO 0xc0 0x6f17 path: 3F007F20,0,0,15 aid: null

onRequest: SIM_IO

CreateRequest(): req(0xc4ce18), id(28), tok(0xc4ce00) - FUNC(0x403c2809)

[EVT]:Req(5), RX(0)

ipc_debug_send_ipc: timestamp 1384293671537251

[EVT]:Req(5), RX(1)

RX: Time: 1314202225 / 34128

RX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_RESP len:1b mseq:0 aseq:30

RX: ---- DATA BEGIN ----

RX: 90 00 11 FF FF FF FF FF FF FF FF FF FF FF FF FF

RX: FF FF FF FF

RX: ---- DATA END ----

requestSIM_IO

RxSEC_ResRSIMAccess

File ID is (6f46)

return prv_bytes_to_hexadecimal_string is <> and size is <34>

simResponse is (ffffffffffffffffffffffffffffffffff)

RIL_onRequestComplete: tok(0xc4cde0)

[RM REQ]: req(0xc4cc28), tok(0xc4cde0)

[EVT]:Req(4), RX(0)

[EVT]:Req(4), RX(0)

requestSIM_IO

TxSEC_GetRSIMAccess()

sizeof(packet) is <269>

sizeof(packet.data) is <256>

strlen((char *)packet.data) is <0>

p_args->data == NULL

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671537592

IPC_send_singleIPC: fd 17 sendto 13 bytes

TX: Time: 1314202225 / 34129

TX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_GET len:d mseq:31 aseq:0

TX: ---- DATA BEGIN ----

TX: B0 CD 6F 00 00 22

TX: ---- DATA END ----

IPC_send_singleIPC: 13 bytes sent.

send success

WaitForExpectedCmd(): cur_time: 34129, cur_req->timeout: 134129, ph->near_timeout: 134111

Serial: 51

Error: 0

[0051]< SIM_IO IccIoResponse sw1:0x90 sw2:0x0

[SIMRecords] onRecordLoaded 15 requested: true

EF_MWIS : null

EVENT_GET_MWIS_DONE exception = com.android.internal.telephony.uicc.IccFileNotFound

[SIMRecords] onRecordLoaded 14 requested: true

EF_CPHS_MWI: null

EVENT_GET_VOICE_MAIL_INDICATOR_CPHS_DONE exception = com.android.internal.telephony.uicc.IccFileNotFound

[SIMRecords] onRecordLoaded 13 requested: true

[SIMRecords] onRecordLoaded 12 requested: true

[SIMRecords] onRecordLoaded 11 requested: true

[ServiceState] setDataRegState=1

[ServiceState] setDataRadioTechnology=0

[GsmSST] handlPollStateResultMessage: GsmSST setDataRegState=1 regState=0 dataRadioTechnology=0

[ServiceState] setVoiceRegState=1

[ServiceState] setState deprecated use setVoiceRegState()

[GsmSST] Poll ServiceState done: oldSS=[1 1 home null null 00000 Unknown Unknown CSS not supported -1 -1 RoamInd=-1 DefRoamInd=-1 EmergOnly=false] newSS=[1 1 home null null 00000 Unknown Unknown CSS not supported -1 -1 RoamInd=-1 DefRoamInd=-1 EmergOnly=false] oldMaxDataCalls=1 mNewMaxDataCalls=1 oldReasonDataDenied=-1 mNewReasonDataDenied=-1

[ServiceState] setNullState=1

[ServiceState] setNullState=1

[SIMRecords] onRecordLoaded 10 requested: true

[SIMRecords] Exception in fetching EF_CSP data com.android.internal.telephony.uicc.IccFileNotFound

[SIMRecords] onRecordLoaded 9 requested: true

[SIMRecords] Exception in get GID1 com.android.internal.telephony.uicc.IccFileNotFound

[SIMRecords] onRecordLoaded 8 requested: true

ipc_debug_send_ipc: timestamp 1384293671557427

[EVT]:Req(4), RX(1)

RX: Time: 1314202245 / 34149

RX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_RESP len:2c mseq:0 aseq:31

RX: ---- DATA BEGIN ----

RX: 90 00 22 FF FF FF FF FF FF FF FF FF FF FF FF FF

RX: FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF

RX: FF FF FF FF FF

RX: ---- DATA END ----

requestSIM_IO

RxSEC_ResRSIMAccess

File ID is (6fcd)

return prv_bytes_to_hexadecimal_string is <> and size is <68>

simResponse is (ffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffffff)

RIL_onRequestComplete: tok(0xc4cd58)

[RM REQ]: req(0xc4cd80), tok(0xc4cd58)

[EVT]:Req(3), RX(0)

[EVT]:Req(3), RX(0)

requestSIM_IO

TxSEC_GetRSIMAccess()

sizeof(packet) is <269>

sizeof(packet.data) is <256>

strlen((char *)packet.data) is <0>

p_args->data == NULL

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671557856

IPC_send_singleIPC: fd 17 sendto 13 bytes

TX: Time: 1314202245 / 34149

TX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_GET len:d mseq:32 aseq:0

TX: ---- DATA BEGIN ----

TX: B2 C5 6F 01 04 0D

TX: ---- DATA END ----

IPC_send_singleIPC: 13 bytes sent.

send success

WaitForExpectedCmd(): cur_time: 34149, cur_req->timeout: 134149, ph->near_timeout: 134129

Serial: 52

Error: 0

[0052]< SIM_IO IccIoResponse sw1:0x90 sw2:0x0

[SIMRecords] iccid: 8943015709232032849

[SIMRecords] onRecordLoaded 7 requested: true

ipc_debug_send_ipc: timestamp 1384293671575378

[EVT]:Req(3), RX(1)

RX: Time: 1314202263 / 34166

RX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_RESP len:17 mseq:0 aseq:32

RX: ---- DATA BEGIN ----

RX: 90 00 0D 43 04 83 E2 B7 18 04 FF FF FF FF FF FF

RX: ---- DATA END ----

requestSIM_IO

RxSEC_ResRSIMAccess

File ID is (6fc5)

return prv_bytes_to_hexadecimal_string is <??> and size is <26>

simResponse is (430483e2b71804ffffffffffff)

RIL_onRequestComplete: tok(0xc4cec0)

[RM REQ]: req(0xc4ced8), tok(0xc4cec0)

[EVT]:Req(2), RX(0)

[EVT]:Req(2), RX(0)

requestSIM_IO

TxSEC_GetRSIMAccess()

sizeof(packet) is <269>

sizeof(packet.data) is <256>

strlen((char *)packet.data) is <0>

p_args->data == NULL

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671575774

IPC_send_singleIPC: fd 17 sendto 13 bytes

TX: Time: 1314202263 / 34167

TX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_GET len:d mseq:33 aseq:0

TX: ---- DATA BEGIN ----

TX: B0 38 6F 00 00 0E

TX: ---- DATA END ----

IPC_send_singleIPC: 13 bytes sent.

send success

WaitForExpectedCmd(): cur_time: 34167, cur_req->timeout: 134167, ph->near_timeout: 134149

Serial: 53

Error: 0

[0053]< SIM_IO IccIoResponse sw1:0x90 sw2:0x0

ipc_debug_send_ipc: timestamp 1384293671592987

[EVT]:Req(2), RX(1)

RX: Time: 1314202281 / 34184

RX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_RESP len:18 mseq:0 aseq:33

RX: ---- DATA BEGIN ----

RX: 90 00 0E FF 3C FF 0F 3F 00 0C 03 00 0C F0 00 F0

RX: C0

RX: ---- DATA END ----

requestSIM_IO

RxSEC_ResRSIMAccess

File ID is (6f38)

return prv_bytes_to_hexadecimal_string is <> and size is <28>

simResponse is (ff3cff0f3f000c03000cf000f0c0)

RIL_onRequestComplete: tok(0xc4cf70)

[RM REQ]: req(0xc4cf88), tok(0xc4cf70)

[EVT]:Req(1), RX(0)

[EVT]:Req(1), RX(0)

requestSIM_IO

TxSEC_GetRSIMAccess()

sizeof(packet) is <269>

sizeof(packet.data) is <256>

strlen((char *)packet.data) is <0>

p_args->data == NULL

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293671593335

IPC_send_singleIPC: fd 17 sendto 13 bytes

TX: Time: 1314202281 / 34184

TX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_GET len:d mseq:34 aseq:0

TX: ---- DATA BEGIN ----

TX: C0 17 6F 00 00 0F

TX: ---- DATA END ----

IPC_send_singleIPC: 13 bytes sent.

send success

WaitForExpectedCmd(): cur_time: 34184, cur_req->timeout: 134184, ph->near_timeout: 134167

Serial: 54

Error: 0

[0054]< SIM_IO IccIoResponse sw1:0x90 sw2:0x0

ipc_debug_send_ipc: timestamp 1384293671600538

[EVT]:Req(1), RX(1)

RX: Time: 1314202288 / 34192

RX: (M)IPC_SEC_CMD (S)IPC_SEC_RSIM_ACCESS (T)IPC_CMD_RESP len:a mseq:0 aseq:34

RX: ---- DATA BEGIN ----

RX: 94 04 00

RX: ---- DATA END ----

requestSIM_IO

RxSEC_ResRSIMAccess

File ID is (6f17)

RIL_onRequestComplete: tok(0xc4ce00)

[RM REQ]: req(0xc4ce18), tok(0xc4ce00)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

Serial: 55

Error: 0

[0055]< SIM_IO IccIoResponse sw1:0x94 sw2:0x4

[SIMRecords] EF_AD: 00ffff

[SIMRecords] MNC length not present in EF_AD

updateMccMncConfiguration: mcc=232, mnc=11

getLteOnCdmaMode=0 curVal=-1 product_type='' lteOnCdmaProductType=''

locale set to de_at

WIFI_COUNTRY_CODE set to at

[SIMRecords] onRecordLoaded 6 requested: true

[SIMRecords] Load EF_SPN: spnDisplayCondition: 255

[SIMRecords] onRecordLoaded 5 requested: true

[SIMRecords] MSISDN: xxxxxxx

[SIMRecords] onRecordLoaded 4 requested: true

[SIMRecords] onRecordLoaded 3 requested: true

[SIMRecords] onRecordLoaded 2 requested: true

[SIMRecords] SST: UsimServiceTable[112]={ PHONEBOOK, FDN, FDN_EXTENSION, SDN, SDN_EXTENSION, BDN, BDN_EXTENSION, OUTGOING_CALL_INFO, SM_STATUS_REPORTS, SM_SERVICE_PARAMS, ADVICE_OF_CHARGE, CAP_CONFIG_PARAMS_2, GROUP_ID_LEVEL_1, GROUP_ID_LEVEL_2, SPN, USER_PLMN_SELECT, MSISDN, IMAGE, LOCALISED_SERVICE_AREAS, EMLPP, EMLPP_AUTO_ANSWER, RFU, GSM_ACCESS, DATA_DL_VIA_SMS_PP, IGNORED_1, ENABLED_SERVICES_TABLE, APN_CONTROL_LIST, DEPERSONALISATION_CONTROL_KEYS, COOPERATIVE_NETWORK_LIST, GSM_SECURITY_CONTEXT, SERVICE_PROVIDER_DISPLAY_INFO, MMS_NOTIFICATION, VGCS_GROUP_ID_LIST, VBS_GROUP_ID_LIST, OMA_BCAST_PROFILE, GBA_LOCAL_KEY_ESTABLISHMENT, EPS_MOBILITY_MANAGEMENT_INFO, ALLOWED_CSG_LISTS_AND_INDICATIONS, CALL_CONTROL_ON_EPS_PDN_CONNECTION_BY_USIM, HPLMN_DIRECT_ACCESS, #101, #102, #103, #104, #111, #112 }

[SIMRecords] onRecordLoaded 1 requested: true

[SIMRecords] Invalid or missing EF[MAILBOX]

[SIMRecords] onRecordLoaded 0 requested: true

[SIMRecords] record load complete

[SIMRecords] onAllRecordsLoaded set 'gsm.sim.operator.numeric' to operator='23211'

[SIMRecords] onAllRecordsLoaded set mcc imsi=232116810216544

Voicemail count retrieval for Imsi = null current Imsi = 232116810216544

updateCallForwardStatus got sim records

[GsmSST] updateSpnDisplay: radio is on but out of service, set plmn='Kein Dienst'

Broadcasting intent ACTION_SIM_STATE_CHANGED LOADED reason null

Get callforwarding info from perferences

Callforwarding is false

ipc_debug_send_ipc: timestamp 1384293677562688

[EVT]:Req(0), RX(1)

RX: Time: 1314208250 / 40154

RX: (M)IPC_GPRS_CMD (S)IPC_GPRS_HSDPA_STATUS (T)IPC_CMD_NOTI len:8 mseq:ff aseq:34

RX: ---- DATA BEGIN ----

RX: 00

RX: ---- DATA END ----

ipc_recv_gprs()

RxGPRS_ResHSDPAStatus()

RIL_onMultiClientUnsolicitedResponse:

[UNSL]< <unknown reponse>

ipc_debug_send_ipc: timestamp 1384293677563580

[EVT]:Req(0), RX(1)

RX: Time: 1314208251 / 40155

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_NOTI len:12 mseq:ff aseq:ff

RX: ---- DATA BEGIN ----

RX: 04 02 06 FF FF FF FF FF FF FF 00

RX: ---- DATA END ----

ipc_recv_network()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

ipc_debug_send_ipc: timestamp 1384293677564218

RIL_onMultiClientUnsolicitedResponse:

unsupported multiclient unsolicited response code 1002

[EVT]:Req(0), RX(1)

RX: Time: 1314208253 / 40156

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_NOTI len:12 mseq:ff aseq:ff

RX: ---- DATA BEGIN ----

RX: 04 03 03 FF FF FF FF FF FF FF FF

RX: ---- DATA END ----

ipc_recv_network()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onMultiClientUnsolicitedResponse:

unsupported multiclient unsolicited response code 1002

ipc_debug_send_ipc: timestamp 1384293677565318

ipc_debug_send_ipc: timestamp 1384293677565360

[EVT]:Req(0), RX(2)

RX: Time: 1314208253 / 40156

RX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_NOTI len:12 mseq:ff aseq:0

RX: ---- DATA BEGIN ----

RX: 02 06 FF 32 33 32 30 31 23 FF FF

RX: ---- DATA END ----

ipc_recv_network()

[EVT]:Req(0), RX(1)

RX: Time: 1314208253 / 40156

RX: (M)IPC_GPRS_CMD (S)IPC_GPRS_HSDPA_STATUS (T)IPC_CMD_NOTI len:8 mseq:ff aseq:0

RX: ---- DATA BEGIN ----

RX: 00

RX: ---- DATA END ----

ipc_recv_gprs()

RxGPRS_ResHSDPAStatus()

RIL_onMultiClientUnsolicitedResponse:

[UNSL]< UNSOL_RESPONSE_VOICE_NETWORK_STATE_CHANGED

[UNSL]< UNSOL_RESPONSE_VOICE_NETWORK_STATE_CHANGED

[UNSL]< <unknown reponse>

[0056]> OPERATOR

[0057]> DATA_REGISTRATION_STATE

onRequest: OPERATOR

CreateRequest(): req(0xc4cdb8), id(22), tok(0xc4cca0) - FUNC(0x403c6105)

[EVT]:Req(1), RX(0)

requestOperator()

TxNET_GetCurrentPLMN()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293677569104

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314208257 / 40160

TX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_GET len:7 mseq:35 aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 40160, cur_req->timeout: 75160, ph->near_timeout: 75160

ipc_debug_send_ipc: timestamp 1384293677569581

[EVT]:Req(1), RX(1)

RX: Time: 1314208257 / 40161

RX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_RESP len:12 mseq:ff aseq:35

RX: ---- DATA BEGIN ----

RX: 02 06 04 32 33 32 30 31 23 1E 00

RX: ---- DATA END ----

requestOperator()

lookupOpnameTable(): PLMN(23201)

RxNET_ResCurrentPLMN(): PLMN(23201), OP1((A1) OP2(A1)

RIL_onRequestComplete: tok(0xc4cca0)

[RM REQ]: req(0xc4cdb8), tok(0xc4cca0)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

onRequest: GPRS_REGISTRATION_STATE

CreateRequest(): req(0xc4cc90), id(21), tok(0xc4cc38) - FUNC(0x403c619d)

[EVT]:Req(1), RX(0)

requestGprsRegistrationState()

TxNET_GetDataNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293677570133

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314208258 / 40161

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:36 aseq:0

TX: ---- DATA BEGIN ----

TX: FF 03

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 40161, cur_req->timeout: 75161, ph->near_timeout: 75161

ipc_debug_send_ipc: timestamp 1384293677570484

[EVT]:Req(1), RX(1)

RX: Time: 1314208258 / 40162

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:ff aseq:36

RX: ---- DATA BEGIN ----

RX: 04 03 03 01 1E 00 FD 75 39 00 FF

RX: ---- DATA END ----

requestGprsRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cc90), tok(0xc4cc38)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

Serial: 56

Error: 0

[0056]< OPERATOR {A1, A1, 23201}

Serial: 57

Error: 0

[0057]< DATA_REGISTRATION_STATE {12, 001e, 003975fd, 3}

[0058]> VOICE_REGISTRATION_STATE

[0059]> QUERY_NETWORK_SELECTION_MODE

onRequest: REGISTRATION_STATE

CreateRequest(): req(0xc4cc90), id(20), tok(0xc4cc38) - FUNC(0x403c6235)

[EVT]:Req(1), RX(0)

requestRegistrationState()

TxNET_GetNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293677572824

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314208260 / 40164

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:37 aseq:0

TX: ---- DATA BEGIN ----

TX: FF 02

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 40164, cur_req->timeout: 75164, ph->near_timeout: 75164

ipc_debug_send_ipc: timestamp 1384293677573230

[EVT]:Req(1), RX(1)

RX: Time: 1314208261 / 40164

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:ff aseq:37

RX: ---- DATA BEGIN ----

RX: 04 02 06 01 1E 00 FD 75 39 00 00

RX: ---- DATA END ----

requestRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cc90), tok(0xc4cc38)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

onRequest: QUERY_NETWORK_SELECTION_MODE

CreateRequest(): req(0xc4cc90), id(45), tok(0xc4cc38) - FUNC(0x403c6369)

[EVT]:Req(1), RX(0)

requestQueryNetworkSelectionMode()

TxNET_GetPLMNSelection()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293677574394

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314208262 / 40165

TX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_GET len:7 mseq:38 aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 40165, cur_req->timeout: 75165, ph->near_timeout: 75165

ipc_debug_send_ipc: timestamp 1384293677574746

[EVT]:Req(1), RX(1)

RX: Time: 1314208262 / 40166

RX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_RESP len:8 mseq:ff aseq:38

RX: ---- DATA BEGIN ----

RX: 02

RX: ---- DATA END ----

requestQueryNetworkSelectionMode()

RxNET_ResPLMNSelection()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cc90), tok(0xc4cc38)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

Serial: 58

Error: 0

[0058]< VOICE_REGISTRATION_STATE {5, 001e, 003975fd}

Serial: 59

Error: 0

[0059]< QUERY_NETWORK_SELECTION_MODE {0}

[0060]> OPERATOR

[0061]> DATA_REGISTRATION_STATE

onRequest: OPERATOR

CreateRequest(): req(0xc4cc90), id(22), tok(0xc4cc38) - FUNC(0x403c6105)

[EVT]:Req(1), RX(0)

requestOperator()

TxNET_GetCurrentPLMN()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293677577580

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314208265 / 40169

TX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_GET len:7 mseq:39 aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 40169, cur_req->timeout: 75169, ph->near_timeout: 75169

ipc_debug_send_ipc: timestamp 1384293677578189

[EVT]:Req(1), RX(1)

RX: Time: 1314208266 / 40169

RX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_RESP len:12 mseq:ff aseq:39

RX: ---- DATA BEGIN ----

RX: 02 06 04 32 33 32 30 31 23 1E 00

RX: ---- DATA END ----

requestOperator()

lookupOpnameTable(): PLMN(23201)

RxNET_ResCurrentPLMN(): PLMN(23201), OP1((A1) OP2(A1)

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cc90), tok(0xc4cc38)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

[0062]> VOICE_REGISTRATION_STATE

Serial: 60

Error: 0

[0060]< OPERATOR {A1, A1, 23201}

[0063]> QUERY_NETWORK_SELECTION_MODE

onRequest: GPRS_REGISTRATION_STATE

CreateRequest(): req(0xc4cc90), id(21), tok(0xc4cc38) - FUNC(0x403c619d)

[EVT]:Req(1), RX(0)

requestGprsRegistrationState()

TxNET_GetDataNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293677581112

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314208269 / 40172

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:3a aseq:0

TX: ---- DATA BEGIN ----

TX: FF 03

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 40172, cur_req->timeout: 75172, ph->near_timeout: 75172

onRequest: REGISTRATION_STATE

CreateRequest(): req(0xc4cdd0), id(20), tok(0xc4cdb8) - FUNC(0x403c6235)

[EVT]:Req(2), RX(0)

onRequest: QUERY_NETWORK_SELECTION_MODE

CreateRequest(): req(0xc4ce48), id(45), tok(0xc4ce30) - FUNC(0x403c6369)

[EVT]:Req(3), RX(0)

ipc_debug_send_ipc: timestamp 1384293677582234

[EVT]:Req(3), RX(1)

RX: Time: 1314208270 / 40173

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:ff aseq:3a

RX: ---- DATA BEGIN ----

RX: 04 03 03 01 1E 00 FD 75 39 00 FF

RX: ---- DATA END ----

requestGprsRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cc90), tok(0xc4cc38)

[EVT]:Req(2), RX(0)

[EVT]:Req(2), RX(0)

requestRegistrationState()

TxNET_GetNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293677582473

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314208270 / 40173

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:3b aseq:0

TX: ---- DATA BEGIN ----

TX: FF 02

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 40174, cur_req->timeout: 75174, ph->near_timeout: 75172

Serial: 61

Error: 0

[0061]< DATA_REGISTRATION_STATE {12, 001e, 003975fd, 3}

ipc_debug_send_ipc: timestamp 1384293677583017

[EVT]:Req(2), RX(1)

RX: Time: 1314208271 / 40174

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:ff aseq:3b

RX: ---- DATA BEGIN ----

RX: 04 02 06 01 1E 00 FD 75 39 00 00

RX: ---- DATA END ----

requestRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4cdb8)

[RM REQ]: req(0xc4cdd0), tok(0xc4cdb8)

[EVT]:Req(1), RX(0)

[EVT]:Req(1), RX(0)

requestQueryNetworkSelectionMode()

TxNET_GetPLMNSelection()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293677583973

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314208272 / 40175

TX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_GET len:7 mseq:3c aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 40175, cur_req->timeout: 75175, ph->near_timeout: 75174

[ServiceState] setDataRegState=1

[ServiceState] setDataRadioTechnology=3

[GsmSST] handlPollStateResultMessage: GsmSST setDataRegState=1 regState=12 dataRadioTechnology=3

ipc_debug_send_ipc: timestamp 1384293677584436

[EVT]:Req(1), RX(1)

RX: Time: 1314208272 / 40175

RX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_RESP len:8 mseq:ff aseq:3c

RX: ---- DATA BEGIN ----

RX: 02

RX: ---- DATA END ----

requestQueryNetworkSelectionMode()

RxNET_ResPLMNSelection()

RIL_onRequestComplete: tok(0xc4ce30)

[RM REQ]: req(0xc4ce48), tok(0xc4ce30)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

Serial: 62

Error: 0

[0062]< VOICE_REGISTRATION_STATE {5, 001e, 003975fd}

Serial: 63

Error: 0

[0063]< QUERY_NETWORK_SELECTION_MODE {0}

[ServiceState] setVoiceRegState=0

[ServiceState] setState deprecated use setVoiceRegState()

[GsmSST] Poll ServiceState done: oldSS=[1 1 home null null 00000 Unknown Unknown CSS not supported -1 -1 RoamInd=-1 DefRoamInd=-1 EmergOnly=false] newSS=[0 1 roaming A1 A1 23201 Unknown UMTS CSS not supported -1 -1 RoamInd=-1 DefRoamInd=-1 EmergOnly=false] oldMaxDataCalls=1 mNewMaxDataCalls=1 oldReasonDataDenied=-1 mNewReasonDataDenied=-1

[ServiceState] setNullState=1

[ServiceState] setNullState=1

[GsmSST] pollStateDone: registering current mNitzUpdatedTime=false changing to false

[GsmSST] updateSpnDisplay: changed sending intent rule=2 showPlmn='true' plmn='A1' showSpn='false' spn=''

[GsmSST] pollStateDone: no nitz but one TZ for iso-cc=at with zone.getID=Europe/Vienna testOneUniqueOffsetPath=false

[GsmSST] setAndBroadcastNetworkSetTimeZone: setTimeZone=Europe/Vienna

[GsmSST] setAndBroadcastNetworkSetTimeZone: call alarm.setTimeZone and broadcast zoneId=Europe/Vienna

[GsmSST] shouldFixTimeZoneNow: retVal=true iccCardExist=true operatorNumeric=23201 mcc=232 prevOperatorNumeric=00000 prevMcc=0 needToFixTimeZone=false ltod=11-12 23:01:17.654

[GsmSST] pollStateDone: fix time zone zoneName='Europe/Vienna' mZoneOffset=0 mZoneDst=false iso-cc='at' iso-cc-idx=-1

[GsmSST] pollStateDone: using default TimeZone

[GsmSST] pollStateDone: zone != null zone.getID=Europe/Vienna

[GsmSST] setAndBroadcastNetworkSetTimeZone: setTimeZone=Europe/Vienna

[GsmSST] setAndBroadcastNetworkSetTimeZone: call alarm.setTimeZone and broadcast zoneId=Europe/Vienna

get all active apn types

getDataConnectionState: Data is Out of Service. ret = DISCONNECTED

isDataAllowed: not allowed due to - gprs= 1 - SIM not loaded and not NV subscription - Roaming and data roaming not enabled

[ApnContext:default] getApnSetting: mDataProfile=null

[GsmSST] getCellLocation(): X good mCellLoc=[30,3765757,-1]

handleMessage msg={ what=270377 when=-91ms obj=android.os.AsyncResult@41a7a868 }

getUiccCardApplication UMTS

onUpdateIcc: newIccRecords com.android.internal.telephony.uicc.SIMRecords

New records found com.android.internal.telephony.uicc.SIMRecords

onUpdateIcc: tryRestartDataConnections nwTypeChanged

overall state is IDLE

[EVT]:Req(0), RX(1)

RIL_onMultiClientUnsolicitedResponse:

unsupported multiclient unsolicited response code 1009

tryRestartDataConnections: createAllApnList and cleanUpAllConnections

getOperatorNumberic - returning from card: 23211

createAllApnList: selection=numeric = '23211' and carrier_enabled = 1

createApnList: X result=[[ApnSettingV2] Bob, 193, 23211, bob.at, null, null, null, null, null, -1, default | supl, IP, IP, true, 0, [ApnSettingV2] Bob MMS, 194, 23211, mms.bob.at, 194.48.124.7, http://mmsc.bob.at, 194.48.124.7, 8001, 8001, -1, mms, IP, IP, true, 0]

getPreferredApn: mRequestedApnType=default cursor=android.content.ContentResolver$CursorWrapperInner@41afa030 cursor.count=0

getPreferredApn: X not found

createAllApnList: mPreferredApn=null

createAllApnList: X mAllDps=[[ApnSettingV2] Bob, 193, 23211, bob.at, null, null, null, null, null, -1, default | supl, IP, IP, true, 0, [ApnSettingV2] Bob MMS, 194, 23211, mms.bob.at, 194.48.124.7, http://mmsc.bob.at, 194.48.124.7, 8001, 8001, -1, mms, IP, IP, true, 0]

cleanUpAllConnections: tearDown=false reason=nwTypeChanged

cleanUpConnection: E tearDown=false reason=nwTypeChanged apnContext={mApnType=dun mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=nwTypeChanged mDataEnabled=false mDependencyMet=true}

getDataConnectionState: Data is Out of Service. ret = DISCONNECTED

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:dun] getApnSetting: mDataProfile=null

cleanUpConnection: X tearDown=false reason=nwTypeChanged apnContext={mApnType=dun mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=nwTypeChanged mDataEnabled=false mDependencyMet=true} dcac=null

cleanUpConnection: E tearDown=false reason=nwTypeChanged apnContext={mApnType=supl mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=nwTypeChanged mDataEnabled=false mDependencyMet=true}

getDataConnectionState: Data is Out of Service. ret = DISCONNECTED

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:supl] getApnSetting: mDataProfile=null

cleanUpConnection: X tearDown=false reason=nwTypeChanged apnContext={mApnType=supl mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=nwTypeChanged mDataEnabled=false mDependencyMet=true} dcac=null

cleanUpConnection: E tearDown=false reason=nwTypeChanged apnContext={mApnType=hipri mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=nwTypeChanged mDataEnabled=false mDependencyMet=true}

getDataConnectionState: Data is Out of Service. ret = DISCONNECTED

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:hipri] getApnSetting: mDataProfile=null

cleanUpConnection: X tearDown=false reason=nwTypeChanged apnContext={mApnType=hipri mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=nwTypeChanged mDataEnabled=false mDependencyMet=true} dcac=null

cleanUpConnection: E tearDown=false reason=nwTypeChanged apnContext={mApnType=default mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=nwTypeChanged mDataEnabled=true mDependencyMet=true}

getDataConnectionState: Data is Out of Service. ret = DISCONNECTED

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:default] getApnSetting: mDataProfile=null

cleanUpConnection: X tearDown=false reason=nwTypeChanged apnContext={mApnType=default mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=nwTypeChanged mDataEnabled=true mDependencyMet=true} dcac=null

cleanUpConnection: E tearDown=false reason=nwTypeChanged apnContext={mApnType=mms mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=nwTypeChanged mDataEnabled=false mDependencyMet=true}

getDataConnectionState: Data is Out of Service. ret = DISCONNECTED

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:mms] getApnSetting: mDataProfile=null

ipc_debug_send_ipc: timestamp 1384293678227537

[EVT]:Req(0), RX(1)

RX: Time: 1314208915 / 40819

RX: (M)IPC_DISP_CMD (S)IPC_DISP_ICON_INFO (T)IPC_CMD_NOTI len:b mseq:ff aseq:3c

RX: ---- DATA BEGIN ----

RX: FF 01 00 04

RX: ---- DATA END ----

RxDis_ResIconInformation()

RSSI Updated

RIL_onMultiClientUnsolicitedResponse:

unsupported multiclient unsolicited response code 1009

[EVT]:Req(0), RX(1)

RIL_onMultiClientUnsolicitedResponse:

unsupported multiclient unsolicited response code 1009

cleanUpConnection: X tearDown=false reason=nwTypeChanged apnContext={mApnType=mms mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=nwTypeChanged mDataEnabled=false mDependencyMet=true} dcac=null

stopNetStatPoll

stopDataStallAlarm: current tag=30687 mDataStallAlarmIntent=null

setupDataOnReadyApns: nwTypeChanged

setupDataOnConnectableApns: isConnectable() call trySetupData

trySetupData for type:default due to nwTypeChanged apnContext={mApnType=default mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=nwTypeChanged mDataEnabled=true mDependencyMet=true}

trySetupData with mIsPsRestricted=false

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:dun] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:supl] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:hipri] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:mms] getApnSetting: mDataProfile=null

trySetupData: X apnContext not 'ready' retValue=false

handleMessage msg={ what=270347 when=-590ms obj=android.os.AsyncResult@41a668e8 }

onRoamingOn: Tear down data connection on roaming.

cleanUpAllConnections: tearDown=true reason=roamingOn

cleanUpConnection: E tearDown=true reason=roamingOn apnContext={mApnType=dun mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=roamingOn mDataEnabled=false mDependencyMet=true}

cleanUpConnection: X tearDown=true reason=roamingOn apnContext={mApnType=dun mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=roamingOn mDataEnabled=false mDependencyMet=true} dcac=null

cleanUpConnection: E tearDown=true reason=roamingOn apnContext={mApnType=supl mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=roamingOn mDataEnabled=false mDependencyMet=true}

cleanUpConnection: X tearDown=true reason=roamingOn apnContext={mApnType=supl mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=roamingOn mDataEnabled=false mDependencyMet=true} dcac=null

cleanUpConnection: E tearDown=true reason=roamingOn apnContext={mApnType=hipri mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=roamingOn mDataEnabled=false mDependencyMet=true}

cleanUpConnection: X tearDown=true reason=roamingOn apnContext={mApnType=hipri mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=roamingOn mDataEnabled=false mDependencyMet=true} dcac=null

cleanUpConnection: E tearDown=true reason=roamingOn apnContext={mApnType=default mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=roamingOn mDataEnabled=true mDependencyMet=true}

cleanUpConnection: X tearDown=true reason=roamingOn apnContext={mApnType=default mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=roamingOn mDataEnabled=true mDependencyMet=true} dcac=null

cleanUpConnection: E tearDown=true reason=roamingOn apnContext={mApnType=mms mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=roamingOn mDataEnabled=false mDependencyMet=true}

cleanUpConnection: X tearDown=true reason=roamingOn apnContext={mApnType=mms mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=roamingOn mDataEnabled=false mDependencyMet=true} dcac=null

stopNetStatPoll

stopDataStallAlarm: current tag=30688 mDataStallAlarmIntent=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:dun] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:supl] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:hipri] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:mms] getApnSetting: mDataProfile=null

handleMessage msg={ what=270338 when=-609ms obj=android.os.AsyncResult@41ac8fc0 }

onRecordsLoaded

onRecordsLoaded: createAllApnList

getOperatorNumberic - returning from card: 23211

createAllApnList: selection=numeric = '23211' and carrier_enabled = 1

createApnList: X result=[[ApnSettingV2] Bob, 193, 23211, bob.at, null, null, null, null, null, -1, default | supl, IP, IP, true, 0, [ApnSettingV2] Bob MMS, 194, 23211, mms.bob.at, 194.48.124.7, http://mmsc.bob.at, 194.48.124.7, 8001, 8001, -1, mms, IP, IP, true, 0]

getPreferredApn: mRequestedApnType=default cursor=android.content.ContentResolver$CursorWrapperInner@41a60dc0 cursor.count=0

getPreferredApn: X not found

createAllApnList: mPreferredApn=null

createAllApnList: X mAllDps=[[ApnSettingV2] Bob, 193, 23211, bob.at, null, null, null, null, null, -1, default | supl, IP, IP, true, 0, [ApnSettingV2] Bob MMS, 194, 23211, mms.bob.at, 194.48.124.7, http://mmsc.bob.at, 194.48.124.7, 8001, 8001, -1, mms, IP, IP, true, 0]

onRecordsLoaded: notifying data availability

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:dun] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:supl] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:hipri] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:mms] getApnSetting: mDataProfile=null

setupDataOnReadyApns: simLoaded

setupDataOnConnectableApns: isConnectable() call trySetupData

trySetupData for type:default due to simLoaded apnContext={mApnType=default mState=IDLE mWaitingDataProfiles={null} mWaitingApnsPermanentFailureCountDown=0 mDataProfile={null} mReason=simLoaded mDataEnabled=true mDependencyMet=true}

trySetupData with mIsPsRestricted=false

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:dun] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:supl] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:hipri] getApnSetting: mDataProfile=null

isDataAllowed: not allowed due to - gprs= 1 - Roaming and data roaming not enabled

[ApnContext:mms] getApnSetting: mDataProfile=null

trySetupData: X apnContext not 'ready' retValue=false

ipc_debug_send_ipc: timestamp 1384293679102904

[EVT]:Req(0), RX(1)

RX: Time: 1314209791 / 41694

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_NOTI len:12 mseq:ff aseq:ff

RX: ---- DATA BEGIN ----

RX: 04 02 06 01 1E 00 FD 75 39 00 00

RX: ---- DATA END ----

ipc_recv_network()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

ipc_debug_send_ipc: timestamp 1384293679103789

RIL_onMultiClientUnsolicitedResponse:

unsupported multiclient unsolicited response code 1002

[EVT]:Req(0), RX(1)

RX: Time: 1314209792 / 41695

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_NOTI len:12 mseq:ff aseq:ff

RX: ---- DATA BEGIN ----

RX: 04 03 03 01 1E 00 FD 75 39 00 FF

RX: ---- DATA END ----

ipc_recv_network()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onMultiClientUnsolicitedResponse:

unsupported multiclient unsolicited response code 1002

ipc_debug_send_ipc: timestamp 1384293679104525

[EVT]:Req(0), RX(1)

RX: Time: 1314209792 / 41696

RX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_NOTI len:12 mseq:ff aseq:0

RX: ---- DATA BEGIN ----

RX: 02 06 04 32 33 32 30 31 23 1E 00

RX: ---- DATA END ----

ipc_recv_network()

[UNSL]< UNSOL_RESPONSE_VOICE_NETWORK_STATE_CHANGED

[UNSL]< UNSOL_RESPONSE_VOICE_NETWORK_STATE_CHANGED

[0064]> OPERATOR

[0065]> DATA_REGISTRATION_STATE

onRequest: OPERATOR

CreateRequest(): req(0xc4cd10), id(22), tok(0xc4cc38) - FUNC(0x403c6105)

[EVT]:Req(1), RX(0)

requestOperator()

TxNET_GetCurrentPLMN()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679108030

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314209796 / 41699

TX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_GET len:7 mseq:3d aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 41699, cur_req->timeout: 76699, ph->near_timeout: 76699

ipc_debug_send_ipc: timestamp 1384293679108721

[EVT]:Req(1), RX(1)

RX: Time: 1314209796 / 41700

RX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_RESP len:12 mseq:ff aseq:3d

RX: ---- DATA BEGIN ----

RX: 02 06 04 32 33 32 30 31 23 1E 00

RX: ---- DATA END ----

requestOperator()

lookupOpnameTable(): PLMN(23201)

RxNET_ResCurrentPLMN(): PLMN(23201), OP1((A1) OP2(A1)

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cd10), tok(0xc4cc38)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

onRequest: GPRS_REGISTRATION_STATE

CreateRequest(): req(0xc4cd10), id(21), tok(0xc4cc38) - FUNC(0x403c619d)

[EVT]:Req(1), RX(0)

requestGprsRegistrationState()

TxNET_GetDataNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679109520

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314209797 / 41701

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:3e aseq:0

TX: ---- DATA BEGIN ----

TX: FF 03

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 41701, cur_req->timeout: 76701, ph->near_timeout: 76701

Serial: 64

Error: 0

ipc_debug_send_ipc: timestamp 1384293679110217

[EVT]:Req(1), RX(1)

RX: Time: 1314209798 / 41701

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:ff aseq:3e

RX: ---- DATA BEGIN ----

RX: 04 03 03 01 1E 00 FD 75 39 00 FF

RX: ---- DATA END ----

requestGprsRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cd10), tok(0xc4cc38)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

[0064]< OPERATOR {A1, A1, 23201}

Serial: 65

Error: 0

[0065]< DATA_REGISTRATION_STATE {12, 001e, 003975fd, 3}

[0066]> VOICE_REGISTRATION_STATE

[0067]> QUERY_NETWORK_SELECTION_MODE

onRequest: REGISTRATION_STATE

CreateRequest(): req(0xc4cd10), id(20), tok(0xc4cc38) - FUNC(0x403c6235)

[EVT]:Req(1), RX(0)

requestRegistrationState()

TxNET_GetNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679113662

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314209801 / 41705

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:3f aseq:0

TX: ---- DATA BEGIN ----

TX: FF 02

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 41705, cur_req->timeout: 76705, ph->near_timeout: 76705

[0068]> OPERATOR

ipc_debug_send_ipc: timestamp 1384293679114569

[EVT]:Req(1), RX(1)

RX: Time: 1314209802 / 41706

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:ff aseq:3f

RX: ---- DATA BEGIN ----

RX: 04 02 06 01 1E 00 FD 75 39 00 00

RX: ---- DATA END ----

requestRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cd10), tok(0xc4cc38)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

Serial: 66

Error: 0

[0066]< VOICE_REGISTRATION_STATE {5, 001e, 003975fd}

[0069]> DATA_REGISTRATION_STATE

[0070]> VOICE_REGISTRATION_STATE

[0071]> QUERY_NETWORK_SELECTION_MODE

onRequest: QUERY_NETWORK_SELECTION_MODE

CreateRequest(): req(0xc4cd10), id(45), tok(0xc4cc38) - FUNC(0x403c6369)

[EVT]:Req(1), RX(0)

requestQueryNetworkSelectionMode()

TxNET_GetPLMNSelection()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679119672

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314209807 / 41711

TX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_GET len:7 mseq:40 aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 41711, cur_req->timeout: 76711, ph->near_timeout: 76711

onRequest: OPERATOR

CreateRequest(): req(0xc4cd60), id(22), tok(0xc4cc60) - FUNC(0x403c6105)

[EVT]:Req(2), RX(0)

ipc_debug_send_ipc: timestamp 1384293679120327

[EVT]:Req(2), RX(1)

RX: Time: 1314209808 / 41711

RX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_RESP len:8 mseq:ff aseq:40

RX: ---- DATA BEGIN ----

RX: 02

RX: ---- DATA END ----

requestQueryNetworkSelectionMode()

RxNET_ResPLMNSelection()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cd10), tok(0xc4cc38)

[EVT]:Req(1), RX(0)

[EVT]:Req(1), RX(0)

requestOperator()

TxNET_GetCurrentPLMN()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679120526

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314209808 / 41712

TX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_GET len:7 mseq:41 aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 41712, cur_req->timeout: 76712, ph->near_timeout: 76711

onRequest: GPRS_REGISTRATION_STATE

CreateRequest(): req(0xc4cd10), id(21), tok(0xc4cc38) - FUNC(0x403c619d)

[EVT]:Req(2), RX(0)

ipc_debug_send_ipc: timestamp 1384293679120987

[EVT]:Req(2), RX(1)

RX: Time: 1314209809 / 41712

RX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_RESP len:12 mseq:ff aseq:41

RX: ---- DATA BEGIN ----

RX: 02 06 04 32 33 32 30 31 23 1E 00

RX: ---- DATA END ----

requestOperator()

lookupOpnameTable(): PLMN(23201)

RxNET_ResCurrentPLMN(): PLMN(23201), OP1((A1) OP2(A1)

RIL_onRequestComplete: tok(0xc4cc60)

[RM REQ]: req(0xc4cd60), tok(0xc4cc60)

[EVT]:Req(1), RX(0)

[EVT]:Req(1), RX(0)

requestGprsRegistrationState()

TxNET_GetDataNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679121208

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314209809 / 41712

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:42 aseq:0

TX: ---- DATA BEGIN ----

TX: FF 03

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 41712, cur_req->timeout: 76712, ph->near_timeout: 76712

ipc_debug_send_ipc: timestamp 1384293679121666

[EVT]:Req(1), RX(1)

RX: Time: 1314209809 / 41713

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:ff aseq:42

RX: ---- DATA BEGIN ----

RX: 04 03 03 01 1E 00 FD 75 39 00 FF

RX: ---- DATA END ----

requestGprsRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cd10), tok(0xc4cc38)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

onRequest: REGISTRATION_STATE

CreateRequest(): req(0xc4cd10), id(20), tok(0xc4cc38) - FUNC(0x403c6235)

[EVT]:Req(1), RX(0)

requestRegistrationState()

TxNET_GetNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679122086

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314209810 / 41713

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:43 aseq:0

TX: ---- DATA BEGIN ----

TX: FF 02

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 41713, cur_req->timeout: 76713, ph->near_timeout: 76713

onRequest: QUERY_NETWORK_SELECTION_MODE

CreateRequest(): req(0xc4cd60), id(45), tok(0xc4cc60) - FUNC(0x403c6369)

[EVT]:Req(2), RX(0)

ipc_debug_send_ipc: timestamp 1384293679122554

[EVT]:Req(2), RX(1)

RX: Time: 1314209810 / 41714

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:ff aseq:43

RX: ---- DATA BEGIN ----

RX: 04 02 06 01 1E 00 FD 75 39 00 00

RX: ---- DATA END ----

requestRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cd10), tok(0xc4cc38)

[EVT]:Req(1), RX(0)

[EVT]:Req(1), RX(0)

requestQueryNetworkSelectionMode()

TxNET_GetPLMNSelection()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679123454

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314209811 / 41714

TX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_GET len:7 mseq:44 aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 41715, cur_req->timeout: 76715, ph->near_timeout: 76713

ipc_debug_send_ipc: timestamp 1384293679123951

[EVT]:Req(1), RX(1)

RX: Time: 1314209812 / 41715

RX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_RESP len:8 mseq:ff aseq:44

RX: ---- DATA BEGIN ----

RX: 02

RX: ---- DATA END ----

requestQueryNetworkSelectionMode()

RxNET_ResPLMNSelection()

RIL_onRequestComplete: tok(0xc4cc60)

[RM REQ]: req(0xc4cd60), tok(0xc4cc60)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

Serial: 67

Error: 0

[0067]< QUERY_NETWORK_SELECTION_MODE {0}

Serial: 68

Error: 0

[0068]< OPERATOR {A1, A1, 23201}

Serial: 69

Error: 0

[0069]< DATA_REGISTRATION_STATE {12, 001e, 003975fd, 3}

Serial: 70

Error: 0

[0070]< VOICE_REGISTRATION_STATE {5, 001e, 003975fd}

Serial: 71

Error: 0

[0071]< QUERY_NETWORK_SELECTION_MODE {0}

[ServiceState] setDataRegState=1

[ServiceState] setDataRadioTechnology=3

[GsmSST] handlPollStateResultMessage: GsmSST setDataRegState=1 regState=12 dataRadioTechnology=3

[ServiceState] setVoiceRegState=0

[ServiceState] setState deprecated use setVoiceRegState()

[GsmSST] Poll ServiceState done: oldSS=[0 1 roaming A1 A1 23201 Unknown UMTS CSS not supported -1 -1 RoamInd=-1 DefRoamInd=-1 EmergOnly=false] newSS=[0 1 roaming A1 A1 23201 Unknown UMTS CSS not supported -1 -1 RoamInd=-1 DefRoamInd=-1 EmergOnly=false] oldMaxDataCalls=1 mNewMaxDataCalls=1 oldReasonDataDenied=-1 mNewReasonDataDenied=-1

[ServiceState] setNullState=1

[ServiceState] setNullState=1

ipc_debug_send_ipc: timestamp 1384293679267846

[EVT]:Req(0), RX(1)

RX: Time: 1314209955 / 41859

RX: (M)IPC_DISP_CMD (S)IPC_DISP_ICON_INFO (T)IPC_CMD_NOTI len:b mseq:ff aseq:44

RX: ---- DATA BEGIN ----

RX: FF 02 00 04

RX: ---- DATA END ----

RxDis_ResIconInformation()

RSSI Updated

RIL_onMultiClientUnsolicitedResponse:

unsupported multiclient unsolicited response code 1009

[EVT]:Req(0), RX(1)

RIL_onMultiClientUnsolicitedResponse:

unsupported multiclient unsolicited response code 1009

ipc_debug_send_ipc: timestamp 1384293679374587

[EVT]:Req(0), RX(1)

RX: Time: 1314210062 / 41966

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_NOTI len:12 mseq:ff aseq:ff

RX: ---- DATA BEGIN ----

RX: 04 02 06 01 1E 00 FD 75 39 00 00

RX: ---- DATA END ----

ipc_recv_network()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

ipc_debug_send_ipc: timestamp 1384293679375362

RIL_onMultiClientUnsolicitedResponse:

unsupported multiclient unsolicited response code 1002

[EVT]:Req(0), RX(1)

RX: Time: 1314210063 / 41967

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_NOTI len:12 mseq:ff aseq:ff

RX: ---- DATA BEGIN ----

RX: 04 03 06 01 1E 00 FD 75 39 00 00

RX: ---- DATA END ----

ipc_recv_network()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onMultiClientUnsolicitedResponse:

unsupported multiclient unsolicited response code 1002

ipc_debug_send_ipc: timestamp 1384293679376059

[EVT]:Req(0), RX(1)

RX: Time: 1314210064 / 41967

RX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_NOTI len:12 mseq:ff aseq:0

RX: ---- DATA BEGIN ----

RX: 02 06 04 32 33 32 30 31 23 1E 00

RX: ---- DATA END ----

ipc_recv_network()

[UNSL]< UNSOL_RESPONSE_VOICE_NETWORK_STATE_CHANGED

[UNSL]< UNSOL_RESPONSE_VOICE_NETWORK_STATE_CHANGED

[0072]> OPERATOR

[0073]> DATA_REGISTRATION_STATE

onRequest: OPERATOR

CreateRequest(): req(0xc4cd80), id(22), tok(0xc4cc38) - FUNC(0x403c6105)

[EVT]:Req(1), RX(0)

requestOperator()

TxNET_GetCurrentPLMN()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679378220

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314210066 / 41969

TX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_GET len:7 mseq:45 aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 41969, cur_req->timeout: 76969, ph->near_timeout: 76969

ipc_debug_send_ipc: timestamp 1384293679378958

[EVT]:Req(1), RX(1)

RX: Time: 1314210067 / 41970

RX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_RESP len:12 mseq:ff aseq:45

RX: ---- DATA BEGIN ----

RX: 02 06 04 32 33 32 30 31 23 1E 00

RX: ---- DATA END ----

requestOperator()

lookupOpnameTable(): PLMN(23201)

RxNET_ResCurrentPLMN(): PLMN(23201), OP1((A1) OP2(A1)

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cd80), tok(0xc4cc38)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

onRequest: GPRS_REGISTRATION_STATE

CreateRequest(): req(0xc4cd80), id(21), tok(0xc4cc38) - FUNC(0x403c619d)

[EVT]:Req(1), RX(0)

requestGprsRegistrationState()

TxNET_GetDataNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679379984

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314210068 / 41971

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:46 aseq:0

TX: ---- DATA BEGIN ----

TX: FF 03

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 41971, cur_req->timeout: 76971, ph->near_timeout: 76971

Serial: 72

Error: 0

ipc_debug_send_ipc: timestamp 1384293679380623

[EVT]:Req(1), RX(1)

RX: Time: 1314210068 / 41972

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:ff aseq:46

RX: ---- DATA BEGIN ----

RX: 04 03 06 01 1E 00 FD 75 39 00 00

RX: ---- DATA END ----

requestGprsRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cd80), tok(0xc4cc38)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

[0072]< OPERATOR {A1, A1, 23201}

Serial: 73

Error: 0

[0073]< DATA_REGISTRATION_STATE {5, 001e, 003975fd, 3}

[0074]> VOICE_REGISTRATION_STATE

[0075]> QUERY_NETWORK_SELECTION_MODE

onRequest: REGISTRATION_STATE

CreateRequest(): req(0xc4cd80), id(20), tok(0xc4cc38) - FUNC(0x403c6235)

[EVT]:Req(1), RX(0)

requestRegistrationState()

TxNET_GetNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679383248

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314210071 / 41974

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:47 aseq:0

TX: ---- DATA BEGIN ----

TX: FF 02

TX: ---- DATA END ----

IPC_send_singleIPC: 9 bytes sent.

WaitForExpectedCmd(): cur_time: 41974, cur_req->timeout: 76974, ph->near_timeout: 76974

[0076]> OPERATOR

ipc_debug_send_ipc: timestamp 1384293679383976

[EVT]:Req(1), RX(1)

RX: Time: 1314210072 / 41975

RX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_RESP len:12 mseq:ff aseq:47

RX: ---- DATA BEGIN ----

RX: 04 02 06 01 1E 00 FD 75 39 00 00

RX: ---- DATA END ----

requestRegistrationState()

RxNET_ResNetworkRegistration()

RegiStatus_Ipc2Ril()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cd80), tok(0xc4cc38)

[EVT]:Req(0), RX(0)

[EVT]:Req(0), RX(0)

Serial: 74

Error: 0

[0074]< VOICE_REGISTRATION_STATE {5, 001e, 003975fd}

[0077]> DATA_REGISTRATION_STATE

[0078]> VOICE_REGISTRATION_STATE

[0079]> QUERY_NETWORK_SELECTION_MODE

onRequest: QUERY_NETWORK_SELECTION_MODE

CreateRequest(): req(0xc4cd80), id(45), tok(0xc4cc38) - FUNC(0x403c6369)

[EVT]:Req(1), RX(0)

requestQueryNetworkSelectionMode()

TxNET_GetPLMNSelection()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679388059

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314210076 / 41979

TX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_GET len:7 mseq:48 aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 41979, cur_req->timeout: 76979, ph->near_timeout: 76979

onRequest: OPERATOR

CreateRequest(): req(0xc4cdd0), id(22), tok(0xc4cc60) - FUNC(0x403c6105)

[EVT]:Req(2), RX(0)

ipc_debug_send_ipc: timestamp 1384293679388728

[EVT]:Req(2), RX(1)

RX: Time: 1314210076 / 41980

RX: (M)IPC_NET_CMD (S)IPC_NET_PLMN_SEL (T)IPC_CMD_RESP len:8 mseq:ff aseq:48

RX: ---- DATA BEGIN ----

RX: 02

RX: ---- DATA END ----

requestQueryNetworkSelectionMode()

RxNET_ResPLMNSelection()

RIL_onRequestComplete: tok(0xc4cc38)

[RM REQ]: req(0xc4cd80), tok(0xc4cc38)

[EVT]:Req(1), RX(0)

[EVT]:Req(1), RX(0)

requestOperator()

TxNET_GetCurrentPLMN()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679388922

IPC_send_singleIPC: fd 17 sendto 7 bytes

TX: Time: 1314210076 / 41980

TX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_GET len:7 mseq:49 aseq:0

IPC_send_singleIPC: 7 bytes sent.

WaitForExpectedCmd(): cur_time: 41980, cur_req->timeout: 76980, ph->near_timeout: 76979

onRequest: GPRS_REGISTRATION_STATE

CreateRequest(): req(0xc4cd80), id(21), tok(0xc4cc38) - FUNC(0x403c619d)

[EVT]:Req(2), RX(0)

onRequest: REGISTRATION_STATE

CreateRequest(): req(0xc4ce48), id(20), tok(0xc4ce30) - FUNC(0x403c6235)

[EVT]:Req(3), RX(0)

ipc_debug_send_ipc: timestamp 1384293679389755

[EVT]:Req(3), RX(1)

RX: Time: 1314210077 / 41981

RX: (M)IPC_NET_CMD (S)IPC_NET_SERVING_NETWORK (T)IPC_CMD_RESP len:12 mseq:ff aseq:49

RX: ---- DATA BEGIN ----

RX: 02 06 04 32 33 32 30 31 23 1E 00

RX: ---- DATA END ----

requestOperator()

lookupOpnameTable(): PLMN(23201)

RxNET_ResCurrentPLMN(): PLMN(23201), OP1((A1) OP2(A1)

RIL_onRequestComplete: tok(0xc4cc60)

[RM REQ]: req(0xc4cdd0), tok(0xc4cc60)

[EVT]:Req(2), RX(0)

[EVT]:Req(2), RX(0)

requestGprsRegistrationState()

TxNET_GetDataNetworkRegistration()

get_msg_sequence()

ipc_debug_send_ipc: timestamp 1384293679389970

IPC_send_singleIPC: fd 17 sendto 9 bytes

TX: Time: 1314210078 / 41981

TX: (M)IPC_NET_CMD (S)IPC_NET_REGIST (T)IPC_CMD_GET len:9 mseq:4a aseq:0

TX: ---- DATA BEGIN ----