<0010> lapd_core.c:2180 Message DL-DATA-REQUEST received in state LAPD_STATE_MF_EST <0010> lapd_core.c:1756 writing message to send-queue: l3len: 2 <0010> lapd_core.c:1779 lapd_send_i() called from line 1762 <0010> lapd_core.c:1819 get message from send-queue <0010> lapd_core.c:1831 msg-len 2 sent 0 left 2 N201 20 length 2 first byte 05 <0010> lapd_core.c:1840 send I frame V(S)=0 <0010> lapd_core.c:196 start T200 <0010> lapd_core.c:1802 k frames outstanding, not sending more (k=1 V(S)=1 V(A)=0) <0010> lapdm.c:550 fmt=B <0010> lapd_core.c:992 UI received <0000> rsl.c:1734 (bts=0,trx=1,ts=0,ss=0) Handing RLL msg UNIT_DATA_IND from LAPDm to MEAS REP <0010> lapd_core.c:545 Timeout T200 (0xb6a4a49c) state=7 <0010> lapd_core.c:227 new state LAPD_STATE_MF_EST -> LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:614 retransmit last frame V(S)=0 <0010> lapd_core.c:196 start T200 <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1459 I received in state LAPD_STATE_TIMER_RECOV on SAPI(0) <0010> lapd_core.c:1542 incrementing V(R) to 1 <0010> lapd_core.c:1551 message in single I frame <0000> rsl.c:1741 (bts=0,trx=1,ts=0,ss=0) Fwd RLL msg DATA_IND from LAPDm to A-bis <0010> lapd_core.c:1779 lapd_send_i() called from line 1609 <0010> lapd_core.c:1789 timer recovery, not sending <0010> lapd_core.c:545 Timeout T200 (0xb6a4a49c) state=8 <0010> lapd_core.c:614 retransmit last frame V(S)=0 <0010> lapd_core.c:196 start T200 <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1252 RR received in state LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:721 ack frame 0 <0010> lapd_core.c:1779 lapd_send_i() called from line 1290 <0010> lapd_core.c:1789 timer recovery, not sending <0010> lapd_core.c:545 Timeout T200 (0xb6a4a49c) state=8 <0010> lapd_core.c:196 start T200 <0010> lapdm.c:550 fmt=B <0010> lapd_core.c:992 UI received <0000> rsl.c:1734 (bts=0,trx=1,ts=0,ss=0) Handing RLL msg UNIT_DATA_IND from LAPDm to MEAS REP <0010> lapd_core.c:545 Timeout T200 (0xb6a4a49c) state=8 <0010> lapd_core.c:196 start T200 <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1252 RR received in state LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:1281 RR response with F==1, and we are in timer recovery state, so we leave that state <0010> lapd_core.c:212 stop T200 <0010> lapd_core.c:227 new state LAPD_STATE_TIMER_RECOV -> LAPD_STATE_MF_EST <0010> lapd_core.c:1779 lapd_send_i() called from line 1290 <0010> lapd_core.c:1831 msg-len 2 sent 2 left 0 N201 20 length 0 first byte 05 <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1232 S frame response with F=1 error <0010> lapd_core.c:378 sending MDL-ERROR-IND cause 6 <0010> lapdm.c:386 sending MDL-ERROR-IND 6 <0000> rsl.c:1741 (bts=0,trx=1,ts=0,ss=0) Fwd RLL msg ERROR_IND from LAPDm to A-bis <0010> lapd_core.c:1252 RR received in state LAPD_STATE_MF_EST <0010> lapd_core.c:1779 lapd_send_i() called from line 1290 <0010> lapdm.c:550 fmt=B <0010> lapd_core.c:992 UI received <0000> rsl.c:1734 (bts=0,trx=1,ts=0,ss=0) Handing RLL msg UNIT_DATA_IND from LAPDm to MEAS REP <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1232 S frame response with F=1 error <0010> lapd_core.c:378 sending MDL-ERROR-IND cause 6 <0010> lapdm.c:386 sending MDL-ERROR-IND 6 <0000> rsl.c:1741 (bts=0,trx=1,ts=0,ss=0) Fwd RLL msg ERROR_IND from LAPDm to A-bis <0010> lapd_core.c:1252 RR received in state LAPD_STATE_MF_EST <0010> lapd_core.c:1779 lapd_send_i() called from line 1290 <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1232 S frame response with F=1 error <0010> lapd_core.c:378 sending MDL-ERROR-IND cause 6 <0010> lapdm.c:386 sending MDL-ERROR-IND 6 <0000> rsl.c:1741 (bts=0,trx=1,ts=0,ss=0) Fwd RLL msg ERROR_IND from LAPDm to A-bis <0010> lapd_core.c:1252 RR received in state LAPD_STATE_MF_EST <0010> lapd_core.c:1779 lapd_send_i() called from line 1290 <0010> lapdm.c:550 fmt=B <0010> lapd_core.c:992 UI received <0000> rsl.c:1734 (bts=0,trx=1,ts=0,ss=0) Handing RLL msg UNIT_DATA_IND from LAPDm to MEAS REP <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:789 SABM(E) received in state LAPD_STATE_IDLE <0010> lapd_core.c:227 new state LAPD_STATE_IDLE -> LAPD_STATE_MF_EST <0000> rsl.c:1741 (bts=0,trx=1,ts=0,ss=0) Fwd RLL msg EST_IND from LAPDm to A-bis <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1459 I received in state LAPD_STATE_MF_EST on SAPI(3) <0010> lapd_core.c:1542 incrementing V(R) to 1 <0010> lapd_core.c:1560 message in multiple I frames (first message) <0010> lapd_core.c:1583 message in multiple I frames (next message) <0010> lapd_core.c:1779 lapd_send_i() called from line 1609 <0010> lapd_core.c:1618 we are not busy and have no pending data, send RR <0010> lapdm.c:550 fmt=B <0010> lapd_core.c:992 UI received <0000> rsl.c:1734 (bts=0,trx=1,ts=0,ss=0) Handing RLL msg UNIT_DATA_IND from LAPDm to MEAS REP <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1459 I received in state LAPD_STATE_MF_EST on SAPI(3) <0010> lapd_core.c:1542 incrementing V(R) to 2 <0010> lapd_core.c:1576 message in multiple I frames (last message) <0000> rsl.c:1741 (bts=0,trx=1,ts=0,ss=0) Fwd RLL msg DATA_IND from LAPDm to A-bis <0010> lapd_core.c:1779 lapd_send_i() called from line 1609 <0010> lapd_core.c:1618 we are not busy and have no pending data, send RR <0010> lapd_core.c:2180 Message DL-DATA-REQUEST received in state LAPD_STATE_MF_EST <0010> lapd_core.c:1756 writing message to send-queue: l3len: 2 <0010> lapd_core.c:1779 lapd_send_i() called from line 1762 <0010> lapd_core.c:1819 get message from send-queue <0010> lapd_core.c:1831 msg-len 2 sent 0 left 2 N201 20 length 2 first byte 89 <0010> lapd_core.c:1840 send I frame V(S)=0 <0010> lapd_core.c:196 start T200 <0010> lapd_core.c:1802 k frames outstanding, not sending more (k=1 V(S)=1 V(A)=0) <0010> lapd_core.c:2180 Message DL-DATA-REQUEST received in state LAPD_STATE_MF_EST <0010> lapd_core.c:1756 writing message to send-queue: l3len: 5 <0010> lapd_core.c:1779 lapd_send_i() called from line 1762 <0010> lapd_core.c:1802 k frames outstanding, not sending more (k=1 V(S)=1 V(A)=0) <0010> lapd_core.c:545 Timeout T200 (0xb6a4a590) state=7 <0010> lapd_core.c:227 new state LAPD_STATE_MF_EST -> LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:614 retransmit last frame V(S)=0 <0010> lapd_core.c:196 start T200 <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:992 UI received <0010> lapd_core.c:1019 length=0 (discarding) <0010> lapd_core.c:545 Timeout T200 (0xb6a4a590) state=8 <0010> lapd_core.c:614 retransmit last frame V(S)=0 <0010> lapd_core.c:196 start T200 <0010> lapdm.c:550 fmt=B <0010> lapd_core.c:992 UI received <0000> rsl.c:1734 (bts=0,trx=1,ts=0,ss=0) Handing RLL msg UNIT_DATA_IND from LAPDm to MEAS REP <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1252 RR received in state LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:721 ack frame 0 <0010> lapd_core.c:1779 lapd_send_i() called from line 1290 <0010> lapd_core.c:1789 timer recovery, not sending <0010> lapd_core.c:545 Timeout T200 (0xb6a4a590) state=8 <0010> lapd_core.c:196 start T200 <0010> lapd_core.c:545 Timeout T200 (0xb6a4a590) state=8 <0010> lapd_core.c:196 start T200 <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1252 RR received in state LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:1281 RR response with F==1, and we are in timer recovery state, so we leave that state <0010> lapd_core.c:212 stop T200 <0010> lapd_core.c:227 new state LAPD_STATE_TIMER_RECOV -> LAPD_STATE_MF_EST <0010> lapd_core.c:1779 lapd_send_i() called from line 1290 <0010> lapd_core.c:1831 msg-len 2 sent 2 left 0 N201 20 length 0 first byte 89 <0010> lapd_core.c:1819 get message from send-queue <0010> lapd_core.c:1831 msg-len 5 sent 0 left 5 N201 20 length 5 first byte 89 <0010> lapd_core.c:1840 send I frame V(S)=1 <0010> lapd_core.c:196 start T200 <0010> lapd_core.c:1802 k frames outstanding, not sending more (k=1 V(S)=2 V(A)=1) <0010> lapdm.c:550 fmt=B <0010> lapd_core.c:992 UI received <0000> rsl.c:1734 (bts=0,trx=1,ts=0,ss=0) Handing RLL msg UNIT_DATA_IND from LAPDm to MEAS REP <0010> lapd_core.c:1252 RR received in state LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:1281 RR response with F==1, and we are in timer recovery state, so we leave that state <0010> lapd_core.c:212 stop T200 <0010> lapd_core.c:227 new state LAPD_STATE_TIMER_RECOV -> LAPD_STATE_MF_EST <0010> lapd_core.c:1779 lapd_send_i() called from line 1290 <0010> lapd_core.c:1873 resend I frame from tx buffer V(S)=1 <0010> lapd_core.c:196 start T200 <0010> lapd_core.c:1802 k frames outstanding, not sending more (k=1 V(S)=2 V(A)=1) <0010> lapd_core.c:545 Timeout T200 (0xb6a4a590) state=7 <0010> lapd_core.c:227 new state LAPD_STATE_MF_EST -> LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:614 retransmit last frame V(S)=1 <0010> lapd_core.c:196 start T200 <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1252 RR received in state LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:1281 RR response with F==1, and we are in timer recovery state, so we leave that state <0010> lapd_core.c:212 stop T200 <0010> lapd_core.c:227 new state LAPD_STATE_TIMER_RECOV -> LAPD_STATE_MF_EST <0010> lapd_core.c:1779 lapd_send_i() called from line 1290 <0010> lapd_core.c:1873 resend I frame from tx buffer V(S)=1 <0010> lapd_core.c:196 start T200 <0010> lapd_core.c:1802 k frames outstanding, not sending more (k=1 V(S)=2 V(A)=1) <0010> lapdm.c:550 fmt=B <0010> lapd_core.c:992 UI received <0000> rsl.c:1734 (bts=0,trx=1,ts=0,ss=0) Handing RLL msg UNIT_DATA_IND from LAPDm to MEAS REP <0010> lapd_core.c:545 Timeout T200 (0xb6a4a590) state=7 <0010> lapd_core.c:227 new state LAPD_STATE_MF_EST -> LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:614 retransmit last frame V(S)=1 <0010> lapd_core.c:196 start T200 <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1252 RR received in state LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:1281 RR response with F==1, and we are in timer recovery state, so we leave that state <0010> lapd_core.c:212 stop T200 <0010> lapd_core.c:227 new state LAPD_STATE_TIMER_RECOV -> LAPD_STATE_MF_EST <0010> lapd_core.c:1779 lapd_send_i() called from line 1290 <0010> lapd_core.c:1873 resend I frame from tx buffer V(S)=1 <0010> lapd_core.c:196 start T200 <0010> lapd_core.c:1802 k frames outstanding, not sending more (k=1 V(S)=2 V(A)=1) <0010> lapd_core.c:545 Timeout T200 (0xb6a4a590) state=7 <0010> lapd_core.c:227 new state LAPD_STATE_MF_EST -> LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:614 retransmit last frame V(S)=1 <0010> lapd_core.c:196 start T200 <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1459 I received in state LAPD_STATE_TIMER_RECOV on SAPI(3) <0010> lapd_core.c:1542 incrementing V(R) to 3 <0010> lapd_core.c:721 ack frame 1 <0010> lapd_core.c:1551 message in single I frame <0000> rsl.c:1741 (bts=0,trx=1,ts=0,ss=0) Fwd RLL msg DATA_IND from LAPDm to A-bis <0010> lapd_core.c:1779 lapd_send_i() called from line 1609 <0010> lapd_core.c:1789 timer recovery, not sending <0010> lapd_core.c:2180 Message DL-RELEASE-REQUEST received in state LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:2021 perform local release <0010> lapd_core.c:212 stop T200 <0010> lapd_core.c:227 new state LAPD_STATE_TIMER_RECOV -> LAPD_STATE_IDLE <0000> rsl.c:1741 (bts=0,trx=1,ts=0,ss=0) Fwd RLL msg REL_CONF from LAPDm to A-bis <0010> lapd_core.c:2180 Message DL-DATA-REQUEST received in state LAPD_STATE_MF_EST <0010> lapd_core.c:1756 writing message to send-queue: l3len: 3 <0010> lapd_core.c:1779 lapd_send_i() called from line 1762 <0010> lapd_core.c:1819 get message from send-queue <0010> lapd_core.c:1831 msg-len 3 sent 0 left 3 N201 20 length 3 first byte 06 <0010> lapd_core.c:1840 send I frame V(S)=1 <0010> lapd_core.c:196 start T200 <0010> lapd_core.c:1802 k frames outstanding, not sending more (k=1 V(S)=2 V(A)=1) <0000> rsl.c:1822 (bts=0,trx=1,ts=0,ss=0) Rx RSL DEACTIVATE_SACCH <0006> oml.c:1432 (bts=0,trx=1,ts=0,ss=0) MPH-DEACTIVATE.req (SACCH TxDL) <0006> oml.c:1372 (bts=0,trx=1,ts=0,ss=0) MPH-DEACTIVATE.conf (SACCH TxDL) <0006> oml.c:1432 (bts=0,trx=1,ts=0,ss=0) MPH-DEACTIVATE.req (SACCH RxUL) <0006> oml.c:1372 (bts=0,trx=1,ts=0,ss=0) MPH-DEACTIVATE.conf (SACCH RxUL) <0006> oml.c:660 (bts=0,trx=1,ts=0,ss=0) End of queue encountered. Now empty? 1 <0010> lapd_core.c:545 Timeout T200 (0xb6a4a49c) state=7 <0010> lapd_core.c:227 new state LAPD_STATE_MF_EST -> LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:614 retransmit last frame V(S)=1 <0010> lapd_core.c:196 start T200 <0010> lapdm.c:561 fmt=B <0010> lapd_core.c:1032 DISC received in state LAPD_STATE_TIMER_RECOV <0010> lapd_core.c:1076 DISC in est state <0010> lapd_core.c:212 stop T200 <0010> lapd_core.c:227 new state LAPD_STATE_TIMER_RECOV -> LAPD_STATE_IDLE <0000> rsl.c:1741 (bts=0,trx=1,ts=0,ss=0) Fwd RLL msg REL_IND from LAPDm to A-bis <0000> rsl.c:1822 (bts=0,trx=1,ts=0,ss=0) Rx RSL RF_CHAN_REL <0006> oml.c:1432 (bts=0,trx=1,ts=0,ss=0) MPH-DEACTIVATE.req (SDCCH RxUL) <0006> oml.c:1372 (bts=0,trx=1,ts=0,ss=0) MPH-DEACTIVATE.conf (SDCCH RxUL) <0006> oml.c:1432 (bts=0,trx=1,ts=0,ss=0) MPH-DEACTIVATE.req (SDCCH TxDL) <0006> oml.c:1372 (bts=0,trx=1,ts=0,ss=0) MPH-DEACTIVATE.conf (SDCCH TxDL) <0000> rsl.c:528 (bts=0,trx=1,ts=0,ss=0) Tx RF CHAN REL ACK <0006> oml.c:660 (bts=0,trx=1,ts=0,ss=0) End of queue encountered. Now empty? 1