564 lines
39 KiB
Plaintext
564 lines
39 KiB
Plaintext
DLGLOBAL INFO Rx from upper layers: GRR-UNITDATA.request
|
|
DLGLOBAL INFO TLLI=0x00002342 not found, creating entity on the fly
|
|
DLGLOBAL INFO UL_TBF{NEW}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x7e
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Sending new block at BSN 0, CS=CS-2
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Dequeue next LLC (len=33)
|
|
DLGLOBAL DEBUG -- Chunk with length 33 larger than space (26) left in block: copy only remaining space, and we are done
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) data block (BSN 0, CS-2): 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 3c 00 01 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04 00
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event FIRST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent, stop T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent (1 phase access), start T3166
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (1)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Sending new block at BSN 1, CS=CS-2
|
|
DLGLOBAL DEBUG -- Chunk with length 7 is less than remaining space (26): add length header to delimit LLC frame
|
|
DLGLOBAL DEBUG -- Final block, so we done.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Complete UL frame, len=0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) data block (BSN 1, CS-2): 1d 00 00 23 42 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 1 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 1, CS-2): 00 00 02 1d 00 00 23 42 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event LAST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: state_chg to FINISHED
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (2)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_DATA.indication
|
|
DLGLOBAL INFO TS=7 FN=8 Rx Pkt UL ACK/NACK
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Got GPRS UL ACK bitmap: SSN: 1, BSN 0 to 2 - 1 (2 blocks), "RR"
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) ack: (BSN=0)"RR"(BSN=1) R=ACK I=NACK
|
|
DLGLOBAL DEBUG - got ack for BSN=0
|
|
DLGLOBAL DEBUG - got ack for BSN=1
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) V(B): (V(A)=2)""(V(S)-1=1) A=Acked N=Nacked U=Unacked X=Resend-Unacked I=Invalid
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event CONTENTION_RESOLUTION_SUCCESS
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Contention resolution succeeded, stop T3166
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Final ACK received.
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event FINAL_ACK_RECVD
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: state_chg to RELEASING
|
|
DLGLOBAL DEBUG Register POLL (TS=7 FN=21, reason=UL_ACK)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG (ts=7,fn=21,usf=0) Tx Pkt Control Ack (UL ACK/NACK poll)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Tx Packet Control Ack
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Deallocated
|
|
DLGLOBAL INFO UL_TBF{RELEASING}: Deallocated
|
|
DLGLOBAL INFO Rx from upper layers: GRR-UNITDATA.request
|
|
DLGLOBAL INFO TLLI=0x00002342 not found, creating entity on the fly
|
|
DLGLOBAL INFO UL_TBF{NEW}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x79
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Timeout of T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: T3164 timeout attempts=1
|
|
DLGLOBAL INFO UL_TBF{FLOW}: state_chg to NEW
|
|
DLGLOBAL INFO UL_TBF{NEW}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x00
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x7b
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Timeout of T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: T3164 timeout attempts=2
|
|
DLGLOBAL INFO UL_TBF{FLOW}: state_chg to NEW
|
|
DLGLOBAL INFO UL_TBF{NEW}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x00
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x79
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Timeout of T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: T3164 timeout attempts=3
|
|
DLGLOBAL INFO UL_TBF{FLOW}: state_chg to NEW
|
|
DLGLOBAL INFO UL_TBF{NEW}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x00
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x78
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Timeout of T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: T3164 timeout attempts=4
|
|
DLGLOBAL NOTICE UL_TBF{FLOW}: TBF establishment failure (T3164 timeout attempts=4)
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Deallocated
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Deallocated
|
|
DLGLOBAL INFO Rx from upper layers: GRR-UNITDATA.request
|
|
DLGLOBAL INFO TLLI=0x00002342 not found, creating entity on the fly
|
|
DLGLOBAL INFO UL_TBF{NEW}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x7a
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Sending new block at BSN 0, CS=CS-2
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Dequeue next LLC (len=33)
|
|
DLGLOBAL DEBUG -- Chunk with length 33 larger than space (26) left in block: copy only remaining space, and we are done
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) data block (BSN 0, CS-2): 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 3c 00 01 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04 00
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event FIRST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent, stop T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent (1 phase access), start T3166
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (1)
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Timeout of T3166
|
|
DLGLOBAL INFO UL_TBF{FLOW}: T3166 timeout attempts=1
|
|
DLGLOBAL INFO UL_TBF{FLOW}: state_chg to NEW
|
|
DLGLOBAL INFO UL_TBF{NEW}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x00
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x7c
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 3c 00 01 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04 00
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event FIRST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent, stop T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent (1 phase access), start T3166
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (1)
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Timeout of T3166
|
|
DLGLOBAL INFO UL_TBF{FLOW}: T3166 timeout attempts=2
|
|
DLGLOBAL INFO UL_TBF{FLOW}: state_chg to NEW
|
|
DLGLOBAL INFO UL_TBF{NEW}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x00
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x79
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 3c 00 01 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04 00
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event FIRST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent, stop T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent (1 phase access), start T3166
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (1)
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Timeout of T3166
|
|
DLGLOBAL INFO UL_TBF{FLOW}: T3166 timeout attempts=3
|
|
DLGLOBAL INFO UL_TBF{FLOW}: state_chg to NEW
|
|
DLGLOBAL INFO UL_TBF{NEW}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x00
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x7d
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 3c 00 01 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04 00
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event FIRST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent, stop T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent (1 phase access), start T3166
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (1)
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Timeout of T3166
|
|
DLGLOBAL INFO UL_TBF{FLOW}: T3166 timeout attempts=4
|
|
DLGLOBAL NOTICE UL_TBF{FLOW}: TBF establishment failure (T3166 timeout attempts=4)
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Deallocated
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Deallocated
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL DEBUG Rx SI13 from lower layers
|
|
DLGLOBAL INFO Rx from upper layers: GRR-UNITDATA.request
|
|
DLGLOBAL INFO TLLI=0x00002342 not found, creating entity on the fly
|
|
DLGLOBAL INFO UL_TBF{NEW}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x7a
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Sending new block at BSN 0, CS=CS-2
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Dequeue next LLC (len=33)
|
|
DLGLOBAL DEBUG -- Chunk with length 33 larger than space (26) left in block: copy only remaining space, and we are done
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) data block (BSN 0, CS-2): 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 3c 00 01 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04 00
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event FIRST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent, stop T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent (1 phase access), start T3166
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (1)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Sending new block at BSN 1, CS=CS-2
|
|
DLGLOBAL DEBUG -- Chunk with length 7 is less than remaining space (26): add length header to delimit LLC frame
|
|
DLGLOBAL DEBUG -- Final block, so we done.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Complete UL frame, len=0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) data block (BSN 1, CS-2): 1d 00 00 23 42 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 1 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 1, CS-2): 00 00 02 1d 00 00 23 42 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event LAST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: state_chg to FINISHED
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (2)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Restarting at BSN 0, because all blocks have been transmitted.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 3c 00 01 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04 00
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (3)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 1
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 1 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 1, CS-2): 00 00 02 1d 00 00 23 42 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event LAST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Data block with CV=0 retransmit attempts=1
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (4)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Restarting at BSN 0, because all blocks have been transmitted.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 3c 00 01 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04 00
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (5)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 1
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 1 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 1, CS-2): 00 00 02 1d 00 00 23 42 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event LAST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Data block with CV=0 retransmit attempts=2
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (6)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Restarting at BSN 0, because all blocks have been transmitted.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 3c 00 01 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04 00
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (7)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 1
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 1 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 1, CS-2): 00 00 02 1d 00 00 23 42 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event LAST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Data block with CV=0 retransmit attempts=3
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (8)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Restarting at BSN 0, because all blocks have been transmitted.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 3c 00 01 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04 00
|
|
DLGLOBAL NOTICE TBF(UL:NR-0:TLLI-00002342) N3104_MAX (9) reached
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event N3104_MAX
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: state_chg to NEW
|
|
DLGLOBAL INFO UL_TBF{NEW}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x00
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x7b
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Deallocated
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Deallocated
|
|
DLGLOBAL INFO Rx from upper layers: GRR-UNITDATA.request
|
|
DLGLOBAL INFO TLLI=0x00002342 not found, creating entity on the fly
|
|
DLGLOBAL INFO UL_TBF{NEW}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x7a
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Sending new block at BSN 0, CS=CS-2
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Dequeue next LLC (len=33)
|
|
DLGLOBAL DEBUG -- Chunk with length 33 larger than space (26) left in block: copy only remaining space, and we are done
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) data block (BSN 0, CS-2): 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 3c 00 01 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 00 00 00 00 71 62 f2 24 6c 84 44 04 00
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event FIRST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent, stop T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent (1 phase access), start T3166
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (1)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_DATA.indication
|
|
DLGLOBAL INFO TS=7 FN=4 Rx Pkt UL ACK/NACK
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Got GPRS UL ACK bitmap: SSN: 1, BSN 0 to 1 - 1 (1 blocks), "R"
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) ack: (BSN=0)"R"(BSN=0) R=ACK I=NACK
|
|
DLGLOBAL DEBUG - got ack for BSN=0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) V(B): (V(A)=1)""(V(S)-1=0) A=Acked N=Nacked U=Unacked X=Resend-Unacked I=Invalid
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event CONTENTION_RESOLUTION_SUCCESS
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Contention resolution succeeded, stop T3166
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Sending new block at BSN 1, CS=CS-2
|
|
DLGLOBAL DEBUG -- Chunk with length 7 is less than remaining space (30): add length header to delimit LLC frame
|
|
DLGLOBAL DEBUG -- Final block, so we done.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Complete UL frame, len=0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) data block (BSN 1, CS-2): 1d 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 1 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 1, CS-2): 00 00 02 1d 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event LAST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: state_chg to FINISHED
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Restarting at BSN 1, because all blocks have been transmitted.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 1
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 1 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 1, CS-2): 00 00 02 1d 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event LAST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Data block with CV=0 retransmit attempts=1
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Restarting at BSN 1, because all blocks have been transmitted.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 1
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 1 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 1, CS-2): 00 00 02 1d 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event LAST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Data block with CV=0 retransmit attempts=2
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Restarting at BSN 1, because all blocks have been transmitted.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 1
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 1 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 1, CS-2): 00 00 02 1d 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event LAST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Data block with CV=0 retransmit attempts=3
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Restarting at BSN 1, because all blocks have been transmitted.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Resending BSN 1
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 1 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 1, CS-2): 00 00 02 1d 11 e5 10 00 e2 18 f2 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event LAST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Data block with CV=0 retransmit attempts=4
|
|
DLGLOBAL NOTICE UL_TBF{FINISHED}: TBF establishment failure (Data block with CV=0 retransmit attempts=4)
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Deallocated
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Deallocated
|
|
DLGLOBAL INFO Rx from upper layers: GRR-UNITDATA.request
|
|
DLGLOBAL INFO TLLI=0x00002342 not found, creating entity on the fly
|
|
DLGLOBAL INFO UL_TBF{NEW}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Send RACH.req ra=0x7b
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to WAIT_CCCH_IMM_ASS
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: Received Event RX_CCCH_IMM_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss initial CS=CS-2
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: ImmAss DynamicAlloc (1phase access) ts_nr=7 usf=0
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_CCCH_IMM_ASS}: state_chg to COMPLETED
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Received Event UL_ASS_COMPL
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Send L1CTL-CF_UL_TBF.req ul_slotmask=0x80
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: state_chg to FLOW
|
|
DLGLOBAL INFO UL_TBF_ASS{COMPLETED}: state_chg to IDLE
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Sending new block at BSN 0, CS=CS-2
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Dequeue next LLC (len=14)
|
|
DLGLOBAL DEBUG -- Chunk with length 14 is less than remaining space (26): add length header to delimit LLC frame
|
|
DLGLOBAL DEBUG -- Final block, so we done.
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Complete UL frame, len=0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) data block (BSN 0, CS-2): 39 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) need_padding 0 spb_status 0 spb 0 (BSN1 0 BSN2 -1)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying 1 RLC blocks, 1 BSNs
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Copying data unit 0 (BSN 0)
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) msg block (BSN 0, CS-2): 00 00 00 39 00 00 23 42 01 c0 00 08 01 01 d5 71 00 00 08 29 26 24 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event FIRST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent, stop T3164
|
|
DLGLOBAL INFO UL_TBF{FLOW}: First UL block sent (1 phase access), start T3166
|
|
DLGLOBAL INFO UL_TBF{FLOW}: Received Event LAST_UL_DATA_SENT
|
|
DLGLOBAL INFO UL_TBF{FLOW}: state_chg to FINISHED
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) N3104 inc (1)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_DATA.indication
|
|
DLGLOBAL INFO TS=7 FN=4 Rx Pkt UL ACK/NACK
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Got GPRS UL ACK bitmap: SSN: 1, BSN 0 to 1 - 1 (1 blocks), "R"
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) ack: (BSN=0)"R"(BSN=0) R=ACK I=NACK
|
|
DLGLOBAL DEBUG - got ack for BSN=0
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) V(B): (V(A)=1)""(V(S)-1=0) A=Acked N=Nacked U=Unacked X=Resend-Unacked I=Invalid
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event CONTENTION_RESOLUTION_SUCCESS
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Contention resolution succeeded, stop T3166
|
|
DLGLOBAL DEBUG TBF(UL:NR-0:TLLI-00002342) Final ACK received.
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: Received Event FINAL_ACK_RECVD
|
|
DLGLOBAL INFO UL_TBF{FINISHED}: state_chg to RELEASING
|
|
DLGLOBAL DEBUG Register POLL (TS=7 FN=17, reason=UL_ACK)
|
|
DLGLOBAL INFO Rx from upper layers: GRR-UNITDATA.request
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG (ts=7,fn=17,usf=0) Tx Pkt Resource Request (UL ACK/NACK poll)
|
|
DLGLOBAL INFO UL_TBF{NEW}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Allocated
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Received Event START_DIRECT_2PHASE
|
|
DLGLOBAL INFO UL_TBF{NEW}: Received Event UL_ASS_START
|
|
DLGLOBAL INFO UL_TBF{NEW}: state_chg to ASSIGN
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: state_chg to SCHED_PKT_RES_REQ
|
|
DLGLOBAL INFO UL_TBF_ASS{IDLE}: Deallocated
|
|
DLGLOBAL INFO UL_TBF{RELEASING}: Deallocated
|
|
DLGLOBAL INFO UL_TBF_ASS{SCHED_PKT_RES_REQ}: Received Event CREATE_RLCMAC_MSG
|
|
DLGLOBAL INFO UL_TBF_ASS{SCHED_PKT_RES_REQ}: state_chg to WAIT_PKT_UL_ASS
|
|
DLGLOBAL INFO UL_TBF_ASS{WAIT_PKT_UL_ASS}: Deallocated
|
|
DLGLOBAL INFO UL_TBF{ASSIGN}: Deallocated
|
|
DLGLOBAL INFO Rx from upper layers: GMMRR-ASSIGN.request
|
|
DLGLOBAL INFO GMMRR-ASSIGN.req: creating new entity TLLI=0x00000001
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-CCCH_DATA.indication
|
|
DLGLOBAL INFO GRE(00000001) Got PCH IMM_ASS (DL_TBF): DL_TFI=0 TS=7
|
|
DLGLOBAL INFO DL_TBF{NEW}: Allocated
|
|
DLGLOBAL INFO DL_TBF{NEW}: Received Event DL_ASS_COMPL
|
|
DLGLOBAL INFO TBF(DL:NR-0:TLLI-00000001) Send L1CTL-CF_DL_TBF.req dl_slotmask=0x80 dl_tfi=0
|
|
DLGLOBAL INFO DL_TBF{NEW}: state_chg to FLOW
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_DATA.indication
|
|
DLGLOBAL DEBUG TBF(DL:NR-0:TLLI-00000001) Rx new DL data
|
|
DLGLOBAL DEBUG TBF(DL:NR-0:TLLI-00000001) DL DATA TFI=0 received (V(Q)=0 .. V(R)=0)
|
|
DLGLOBAL DEBUG TBF(DL:NR-0:TLLI-00000001) Got CS-1 RLC data block: FBI=1, BSN=0, SPB=0, S/P=1 RRBP=1, E=0, bitoffs=24
|
|
DLGLOBAL DEBUG TBF(DL:NR-0:TLLI-00000001) BSN 0 storing in window (0..63)
|
|
DLGLOBAL DEBUG TBF(DL:NR-0:TLLI-00000001) data_length=20, data=19 43 c0 01 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b
|
|
DLGLOBAL DEBUG - Raising V(R) to 1
|
|
DLGLOBAL DEBUG - Taking block 0 out, raising V(Q) to 1
|
|
DLGLOBAL DEBUG TBF(DL:NR-0:TLLI-00000001) Assembling frames: (len=20)
|
|
DLGLOBAL DEBUG DL DATA LI contains extension octet: LI=6, M=0, E=1, count=0
|
|
DLGLOBAL DEBUG TBF(DL:NR-0:TLLI-00000001) Frame 1 starts at offset 1, length=6, is_complete=1
|
|
DLGLOBAL DEBUG TBF(DL:NR-0:TLLI-00000001) complete UL frame len=6
|
|
DLGLOBAL DEBUG TBF(DL:NR-0:TLLI-00000001) No gaps in received block, last block: BSN=0 FBI=1
|
|
DLGLOBAL DEBUG TBF(DL:NR-0:TLLI-00000001) Finished with DL TBF
|
|
DLGLOBAL INFO DL_TBF{FLOW}: Received Event LAST_DL_DATA_RECVD
|
|
DLGLOBAL INFO DL_TBF{FLOW}: state_chg to FINISHED
|
|
DLGLOBAL DEBUG Register POLL (TS=7 FN=21, reason=DL_ACK)
|
|
DLGLOBAL INFO Rx from lower layers: L1CTL-PDCH_RTS.indication
|
|
DLGLOBAL DEBUG (ts=7,fn=21,usf=0) Tx DL ACK/NACK FinalAck=1
|
|
DLGLOBAL DEBUG TBF(DL:NR-0:TLLI-00000001) - V(N): "IIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIIR" R=Received I=Invalid
|