Hi Ivan.

More pcu logs (Nokia 5000d-2). At the begining everything is ok (PACKET CONTROL ACK with expected FN only), but from line 1248 frome the start of log something occurs and a lot of "PACKET DOWNLINK ACK with unknown FN" appears. Possibly timing problems..

<0001> pcu_l1_if.cpp:334 BTS available <0001> pcu_l1_if.cpp:335 mcc=452 <0001> pcu_l1_if.cpp:336 mnc=2 <0001> pcu_l1_if.cpp:337 lac=1000 <0001> pcu_l1_if.cpp:338 rac=0 <0001> pcu_l1_if.cpp:339 cell_id=0 <0001> pcu_l1_if.cpp:340 nsei=8 <0001> pcu_l1_if.cpp:345 nse_timer=0 0 0 0 0 0 0 <0001> pcu_l1_if.cpp:353 cell_timer=0 0 0 0 0 0 0 0 0 0 0 <0001> pcu_l1_if.cpp:354 repeat_time=5 <0001> pcu_l1_if.cpp:355 repeat_count=10 <0001> pcu_l1_if.cpp:356 bvci=7 <0001> pcu_l1_if.cpp:357 t3142=20 <0001> pcu_l1_if.cpp:358 t3169=5 <0001> pcu_l1_if.cpp:359 t3191=5 <0001> pcu_l1_if.cpp:360 t3193=1000 (ms) <0001> pcu_l1_if.cpp:361 t3195=5 <0001> pcu_l1_if.cpp:362 n3101=10 <0001> pcu_l1_if.cpp:363 n3103=4 <0001> pcu_l1_if.cpp:364 n3105=8 <0001> pcu_l1_if.cpp:365 cv_countdown=15 <0001> pcu_l1_if.cpp:366 dl_tbf_ext=0 <0001> pcu_l1_if.cpp:367 ul_tbf_ext=0 <0001> pcu_l1_if.cpp:376 initial_cs=1 <0001> pcu_l1_if.cpp:377 initial_mcs=0 <0001> pcu_l1_if.cpp:378 nsvci=4 <0001> pcu_l1_if.cpp:379 local_port=5944 <0001> pcu_l1_if.cpp:380 remote_port=23000 <0001> pcu_l1_if.cpp:381 remote_ip=2130706433 <0008> gprs_bssgp_pcu.cpp:611 bctx mcc=452 <0008> gprs_bssgp_pcu.cpp:612 bctx mnc=2 <0001> pcu_l1_if.cpp:82 Sending activate request: trx=0 ts=7 <0001> pcu_l1_if.cpp:429 PDCH: trx=0 ts=7 <0009> gprs_bssgp_pcu.cpp:491 NS-VC 4 is unblocked. <0008> gprs_bssgp_pcu.cpp:532 Sending reset on BVCI 0 <0008> gprs_bssgp_pcu.cpp:540 Sending reset on BVCI 7 <0008> gprs_bssgp_pcu.cpp:548 Sending unblock on BVCI 7 <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=123, fn=153643 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=0 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1183 TX: START TFI: 0 Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0005> gprs_rlcmac_data.cpp:896 Decoded premier TLLI=0xb9e1d899 of UL DATA TBF=0. <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=44 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xb9e1d899 len=44 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xb9e1d899 IMSI: 000 len: 9 <0002> gprs_rlcmac.cpp:354 Allocating DL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xb9e1d899 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=153716 block_nr=1 scheduling free USF for polling at FN=153720 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=153720 TLL=0xb9e1d899 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=9 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=153746 block_nr=8 scheduling free USF for polling at FN=153751 of UL TFI=0 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=153751 block_nr=9 scheduling free USF for polling at FN=153755 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=153751 TLL=0xb9e1d899 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xb9e1d899. <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=124, fn=153895 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=0 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1183 TX: START TFI: 0 Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0005> gprs_rlcmac_data.cpp:896 Decoded premier TLLI=0xb9e1d899 of UL DATA TBF=0. <0005> gprs_rlcmac_data.cpp:901 Got RACH from TLLI=0xb9e1d899 while DL TBF=0 still exists. Killing pending DL TBF <0002> gprs_rlcmac.cpp:895 Free DL TBF=0 with TLLI=0xb9e1d899. <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=17 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xb9e1d899 len=17 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xb9e1d899 IMSI: 000 len: 9 <0002> gprs_rlcmac.cpp:354 Allocating DL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xb9e1d899 Immediate Assignment Downlink (PCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=153963 block_nr=10 scheduling free USF for polling at FN=153967 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=153967 TLL=0xb9e1d899 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xb9e1d899. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=9 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=154011 block_nr=9 scheduling free USF for polling at FN=154015 of DL TFI=0 <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=120, fn=154136 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=0 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1183 TX: START TFI: 0 Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0005> gprs_rlcmac_data.cpp:896 Decoded premier TLLI=0xb9e1d899 of UL DATA TBF=0. <0005> gprs_rlcmac_data.cpp:901 Got RACH from TLLI=0xb9e1d899 while DL TBF=0 still exists. Killing pending DL TBF <0002> gprs_rlcmac.cpp:895 Free DL TBF=0 with TLLI=0xb9e1d899. <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=17 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xb9e1d899 len=17 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xb9e1d899 IMSI: 452022112638582 len: 24 <0002> gprs_rlcmac.cpp:354 Allocating DL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xb9e1d899 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=154223 block_nr=10 scheduling free USF for polling at FN=154227 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=154227 TLL=0xb9e1d899 (TRX 0 TS 7) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=154249 block_nr=4 scheduling free USF for polling at FN=154253 of UL TFI=0 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=24 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=154258 block_nr=6 scheduling free USF for polling at FN=154262 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=154253 TLL=0xb9e1d899 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xb9e1d899. <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=124, fn=154413 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=0 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1183 TX: START TFI: 0 Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0005> gprs_rlcmac_data.cpp:896 Decoded premier TLLI=0xe75a5338 of UL DATA TBF=0. <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=8 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=8 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=154470 block_nr=7 scheduling free USF for polling at FN=154474 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=154474 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0002> gprs_rlcmac.cpp:895 Free DL TBF=0 with TLLI=0xb9e1d899. <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=125, fn=154507 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=0 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1183 TX: START TFI: 0 Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0005> gprs_rlcmac_data.cpp:896 Decoded premier TLLI=0xe75a5338 of UL DATA TBF=0. <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=59 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=59 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 55 <0002> gprs_rlcmac.cpp:354 Allocating DL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=154587 block_nr=10 scheduling free USF for polling at FN=154591 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=154591 TLL=0xe75a5338 (TRX 0 TS 7) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=154613 block_nr=4 scheduling free USF for polling at FN=154617 of UL TFI=0 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=55 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=154626 block_nr=7 scheduling free USF for polling at FN=154630 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=154617 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=112, fn=154767 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0005> gprs_rlcmac_data.cpp:456 Got RACH from TLLI=0xe75a5338 while DL TBF=0 still exists. Killing pending DL TBF <0002> gprs_rlcmac.cpp:895 Free DL TBF=0 with TLLI=0xe75a5338. <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=154851 block_nr=11 scheduling free USF for polling at FN=154856 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=154856 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=70 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=70 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=154912 block_nr=1 scheduling free USF for polling at FN=154916 of UL TFI=0 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 107 <0002> gprs_rlcmac.cpp:354 Allocating DL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=154916 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=107 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155003 block_nr=10 scheduling free USF for polling at FN=155007 of DL TFI=0 <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=117, fn=155163 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0002> gprs_rlcmac.cpp:895 Free DL TBF=0 with TLLI=0xe75a5338. <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155250 block_nr=7 scheduling free USF for polling at FN=155254 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=155254 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=66 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=66 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155315 block_nr=10 scheduling free USF for polling at FN=155319 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 66 <0002> gprs_rlcmac.cpp:354 Allocating DL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=155319 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=66 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155393 block_nr=4 scheduling free USF for polling at FN=155397 of DL TFI=0 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 66 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155458 block_nr=7 scheduling free USF for polling at FN=155462 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=155462 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=66 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155501 block_nr=5 scheduling free USF for polling at FN=155506 of DL TFI=0 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155532 block_nr=0 scheduling free USF for polling at FN=155536 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=155536 TLL=0xe75a5338 (TRX 0 TS 7) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 66 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155588 block_nr=1 scheduling free USF for polling at FN=155592 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=155592 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=66 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155627 block_nr=10 scheduling free USF for polling at FN=155631 of DL TFI=0 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=506 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=506 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=125 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=125 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155761 block_nr=5 scheduling free USF for polling at FN=155766 of DL TFI=0 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155770 block_nr=7 scheduling free USF for polling at FN=155774 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 214 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 414 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 79 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=155774 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:158 - Timeout for polling PACKET CONTROL ACK for PACKET DOWNLINK ASSIGNMENT. <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:92 - No downlink ACK received yet <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=155896 block_nr=0 scheduling free USF for polling at FN=155900 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=156008 block_nr=2 scheduling free USF for polling at FN=156013 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=156078 block_nr=6 scheduling free USF for polling at FN=156082 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=156143 block_nr=9 scheduling free USF for polling at FN=156147 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:534 Releasing due to PACCH assignment timeout. <0002> gprs_rlcmac.cpp:895 Free DL TBF=0 with TLLI=0xe75a5338. <0002> gprs_rlcmac.cpp:905 Software error: Pending downlink assignment. This may not happen, because the assignment message never gets transmitted. Please be shure not to free in this state. PLEASE FIX! <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=119, fn=156360 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=156446 block_nr=7 scheduling free USF for polling at FN=156450 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=156450 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=506 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=506 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=125 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=125 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_rlcmac.cpp:354 Allocating DL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=156632 block_nr=2 scheduling free USF for polling at FN=156637 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=156637 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=156771 block_nr=10 scheduling free USF for polling at FN=156775 of DL TFI=0 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=0 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=156858 block_nr=6 scheduling free USF for polling at FN=156862 of DL TFI=0 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=0 (len=416) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=156944 block_nr=2 scheduling free USF for polling at FN=156949 of DL TFI=0 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=0 (len=62) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=157027 block_nr=9 scheduling free USF for polling at FN=157031 of DL TFI=0 <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=118, fn=157151 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0005> gprs_rlcmac_data.cpp:456 Got RACH from TLLI=0xe75a5338 while DL TBF=0 still exists. Killing pending DL TBF <0002> gprs_rlcmac.cpp:895 Free DL TBF=0 with TLLI=0xe75a5338. <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=157235 block_nr=9 scheduling free USF for polling at FN=157239 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=157239 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=157300 block_nr=0 scheduling free USF for polling at FN=157304 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_rlcmac.cpp:354 Allocating DL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 86 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=157304 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=157451 block_nr=11 scheduling free USF for polling at FN=157456 of DL TFI=0 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=0 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=157538 block_nr=7 scheduling free USF for polling at FN=157542 of DL TFI=0 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=0 (len=86) <0004> gprs_rlcmac_data.cpp:1412 Complete DL frame for TBF=0 that fits precisely in last block: len=86 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=157625 block_nr=3 scheduling free USF for polling at FN=157629 of DL TFI=0 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=157655 block_nr=10 scheduling free USF for polling at FN=157659 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=157659 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=157720 block_nr=1 scheduling free USF for polling at FN=157724 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=157724 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=112, fn=157748 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=116, fn=157823 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0002> gprs_rlcmac.cpp:895 Free DL TBF=0 with TLLI=0xe75a5338. <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=116, fn=157931 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=114, fn=158014 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=119, fn=158768 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=118, fn=158831 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=113, fn=158946 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=113, fn=159038 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=114, fn=159853 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=159939 block_nr=9 scheduling free USF for polling at FN=159943 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=159943 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=75 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=75 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=159995 block_nr=10 scheduling free USF for polling at FN=159999 of UL TFI=0 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 185 <0002> gprs_rlcmac.cpp:354 Allocating DL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=159999 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=185 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160103 block_nr=11 scheduling free USF for polling at FN=160108 of DL TFI=0 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160190 block_nr=7 scheduling free USF for polling at FN=160194 of DL TFI=0 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160220 block_nr=2 scheduling free USF for polling at FN=160225 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=160225 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=66 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=66 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=66 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=66 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 66 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=66 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=66 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160307 block_nr=10 scheduling free USF for polling at FN=160311 of DL TFI=0 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 66 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=66 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=66 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=160311 TLL=0xe75a5338 (TRX 0 TS 7) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 66 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=66 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=66 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 66 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=66 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=0 (len=66) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160346 block_nr=7 scheduling free USF for polling at FN=160350 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=66 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=0 (len=66) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 66 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=160350 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=66 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=0 (len=66) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=66 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=0 (len=66) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=66 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160407 block_nr=9 scheduling free USF for polling at FN=160411 of DL TFI=0 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160437 block_nr=4 scheduling free USF for polling at FN=160441 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=160441 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=506 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=506 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=17 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=17 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 66 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 281 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160632 block_nr=1 scheduling free USF for polling at FN=160636 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:158 - Timeout for polling PACKET CONTROL ACK for PACKET DOWNLINK ASSIGNMENT. <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:92 - No downlink ACK received yet <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160675 block_nr=11 scheduling free USF for polling at FN=160680 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160723 block_nr=10 scheduling free USF for polling at FN=160727 of DL TFI=0 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=506 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=506 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=17 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=17 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 66 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160771 block_nr=9 scheduling free USF for polling at FN=160775 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160823 block_nr=9 scheduling free USF for polling at FN=160827 of DL TFI=0 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 66 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=506 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=506 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160875 block_nr=9 scheduling free USF for polling at FN=160879 of DL TFI=0 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=17 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=17 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 281 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 452 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160927 block_nr=9 scheduling free USF for polling at FN=160931 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=160970 block_nr=7 scheduling free USF for polling at FN=160974 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:166 - N3105 exceeded <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=506 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=506 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=17 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=17 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_rlcmac.cpp:354 Allocating DL TBF: TFI=1 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 371 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:1783 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Downlink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161048 block_nr=1 scheduling free USF for polling at FN=161052 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=161052 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=381 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=381 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161126 block_nr=7 scheduling free USF for polling at FN=161130 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 487 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=161130 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161169 block_nr=5 scheduling free USF for polling at FN=161174 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161200 block_nr=0 scheduling free USF for polling at FN=161204 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=161204 TLL=0xe75a5338 (TRX 0 TS 7) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161260 block_nr=2 scheduling free USF for polling at FN=161265 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=506 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=506 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161351 block_nr=11 scheduling free USF for polling at FN=161356 of DL TFI=1 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=17 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=17 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161369 block_nr=3 scheduling free USF for polling at FN=161373 of UL TFI=0 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 74 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=161373 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 452 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 281 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161442 block_nr=8 scheduling free USF for polling at FN=161447 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161529 block_nr=4 scheduling free USF for polling at FN=161533 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161555 block_nr=10 scheduling free USF for polling at FN=161559 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=161559 TLL=0xe75a5338 (TRX 0 TS 7) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161620 block_nr=1 scheduling free USF for polling at FN=161624 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=371) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=506 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=506 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161711 block_nr=10 scheduling free USF for polling at FN=161715 of DL TFI=1 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=17 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=17 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=371 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 74 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161802 block_nr=7 scheduling free USF for polling at FN=161806 of DL TFI=1 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=506 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=506 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=487) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=17 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=17 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 74 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 487 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161893 block_nr=4 scheduling free USF for polling at FN=161897 of DL TFI=1 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=381 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=381 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161958 block_nr=7 scheduling free USF for polling at FN=161962 of UL TFI=0 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=487 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 74 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=161962 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=161984 block_nr=1 scheduling free USF for polling at FN=161988 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162071 block_nr=9 scheduling free USF for polling at FN=162075 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0002> gprs_rlcmac_data.cpp:555 TBF T3195 timeout during transsmission <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:92 - No downlink ACK received yet <0002> gprs_rlcmac.cpp:895 Free DL TBF=0 with TLLI=0xe75a5338. <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162101 block_nr=4 scheduling free USF for polling at FN=162105 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=162105 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162162 block_nr=6 scheduling free USF for polling at FN=162166 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162166 block_nr=7 scheduling free USF for polling at FN=162170 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=162170 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162253 block_nr=3 scheduling free USF for polling at FN=162257 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=74) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=74 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162339 block_nr=11 scheduling free USF for polling at FN=162344 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162370 block_nr=6 scheduling free USF for polling at FN=162374 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=162374 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=452) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 452 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162430 block_nr=8 scheduling free USF for polling at FN=162435 of DL TFI=1 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162448 block_nr=0 scheduling free USF for polling at FN=162452 of UL TFI=0 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=162452 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=452 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162521 block_nr=5 scheduling free USF for polling at FN=162526 of DL TFI=1 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 281 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162608 block_nr=1 scheduling free USF for polling at FN=162612 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=281) <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162638 block_nr=8 scheduling free USF for polling at FN=162643 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=162643 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=281 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162699 block_nr=10 scheduling free USF for polling at FN=162703 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162790 block_nr=7 scheduling free USF for polling at FN=162794 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=506 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=506 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=17 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=17 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162842 block_nr=7 scheduling free USF for polling at FN=162846 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 74 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=162846 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162881 block_nr=4 scheduling free USF for polling at FN=162885 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=162968 block_nr=0 scheduling free USF for polling at FN=162972 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=74) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=74 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=74) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=74 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163054 block_nr=8 scheduling free USF for polling at FN=163059 of DL TFI=1 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163085 block_nr=3 scheduling free USF for polling at FN=163089 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=163089 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163145 block_nr=5 scheduling free USF for polling at FN=163150 of DL TFI=1 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163163 block_nr=9 scheduling free USF for polling at FN=163167 of UL TFI=0 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=487) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=163167 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163236 block_nr=2 scheduling free USF for polling at FN=163241 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=487 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163323 block_nr=10 scheduling free USF for polling at FN=163327 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163353 block_nr=5 scheduling free USF for polling at FN=163358 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=163358 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163414 block_nr=7 scheduling free USF for polling at FN=163418 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163418 block_nr=8 scheduling free USF for polling at FN=163423 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=163423 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163505 block_nr=4 scheduling free USF for polling at FN=163509 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=74) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163592 block_nr=0 scheduling free USF for polling at FN=163596 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=74 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163678 block_nr=8 scheduling free USF for polling at FN=163683 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163709 block_nr=3 scheduling free USF for polling at FN=163713 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=452) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=163713 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163769 block_nr=5 scheduling free USF for polling at FN=163774 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163774 block_nr=6 scheduling free USF for polling at FN=163778 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=163778 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=452 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163860 block_nr=2 scheduling free USF for polling at FN=163865 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163891 block_nr=9 scheduling free USF for polling at FN=163895 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=163895 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163951 block_nr=11 scheduling free USF for polling at FN=163956 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=163956 block_nr=0 scheduling free USF for polling at FN=163960 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=163960 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164042 block_nr=8 scheduling free USF for polling at FN=164047 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164129 block_nr=4 scheduling free USF for polling at FN=164133 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164216 block_nr=0 scheduling free USF for polling at FN=164220 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=1 <0002> gprs_rlcmac_data.cpp:180 - Timeout for polling PACKET DOWNLINK ACK. <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:90 - Downlink ACK was received <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164328 block_nr=2 scheduling free USF for polling at FN=164333 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:407 Recovered downlink ack for DL TBF=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164359 block_nr=9 scheduling free USF for polling at FN=164363 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=164363 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164419 block_nr=11 scheduling free USF for polling at FN=164424 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164424 block_nr=0 scheduling free USF for polling at FN=164428 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=164428 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164510 block_nr=8 scheduling free USF for polling at FN=164515 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164541 block_nr=3 scheduling free USF for polling at FN=164545 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=164545 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=281) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164601 block_nr=5 scheduling free USF for polling at FN=164606 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164606 block_nr=6 scheduling free USF for polling at FN=164610 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=164610 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=281 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=74) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=74 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164692 block_nr=2 scheduling free USF for polling at FN=164697 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164779 block_nr=10 scheduling free USF for polling at FN=164783 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164809 block_nr=5 scheduling free USF for polling at FN=164814 of DL TFI=1 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=164814 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164870 block_nr=7 scheduling free USF for polling at FN=164874 of DL TFI=1 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164887 block_nr=11 scheduling free USF for polling at FN=164892 of UL TFI=0 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=164892 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=164961 block_nr=4 scheduling free USF for polling at FN=164965 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165048 block_nr=0 scheduling free USF for polling at FN=165052 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165078 block_nr=7 scheduling free USF for polling at FN=165082 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=165082 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165139 block_nr=9 scheduling free USF for polling at FN=165143 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165143 block_nr=10 scheduling free USF for polling at FN=165147 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=165147 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165230 block_nr=6 scheduling free USF for polling at FN=165234 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165316 block_nr=2 scheduling free USF for polling at FN=165321 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165403 block_nr=10 scheduling free USF for polling at FN=165407 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165433 block_nr=5 scheduling free USF for polling at FN=165438 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1226 Discarding LLC PDU of DL TBF=1, because lifetime limit reached <0004> gprs_rlcmac_data.cpp:1226 Discarding LLC PDU of DL TBF=1, because lifetime limit reached <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=165438 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165494 block_nr=7 scheduling free USF for polling at FN=165498 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165498 block_nr=8 scheduling free USF for polling at FN=165503 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=165503 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165585 block_nr=4 scheduling free USF for polling at FN=165589 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165615 block_nr=11 scheduling free USF for polling at FN=165620 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=165620 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165676 block_nr=1 scheduling free USF for polling at FN=165680 of DL TFI=1 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165711 block_nr=9 scheduling free USF for polling at FN=165715 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 62 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=165715 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165767 block_nr=10 scheduling free USF for polling at FN=165771 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165854 block_nr=6 scheduling free USF for polling at FN=165858 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165884 block_nr=1 scheduling free USF for polling at FN=165888 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=165888 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=82 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=82 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165945 block_nr=3 scheduling free USF for polling at FN=165949 of DL TFI=1 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=165997 block_nr=3 scheduling free USF for polling at FN=166001 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=166001 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166036 block_nr=0 scheduling free USF for polling at FN=166040 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166122 block_nr=8 scheduling free USF for polling at FN=166127 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166209 block_nr=4 scheduling free USF for polling at FN=166213 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166235 block_nr=10 scheduling free USF for polling at FN=166239 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=166239 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166300 block_nr=1 scheduling free USF for polling at FN=166304 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166304 block_nr=2 scheduling free USF for polling at FN=166309 of DL TFI=1 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=166304 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166391 block_nr=10 scheduling free USF for polling at FN=166395 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166478 block_nr=6 scheduling free USF for polling at FN=166482 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166564 block_nr=2 scheduling free USF for polling at FN=166569 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166595 block_nr=9 scheduling free USF for polling at FN=166599 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=166599 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166655 block_nr=11 scheduling free USF for polling at FN=166660 of DL TFI=1 <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166673 block_nr=3 scheduling free USF for polling at FN=166677 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=166677 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166746 block_nr=8 scheduling free USF for polling at FN=166751 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166833 block_nr=4 scheduling free USF for polling at FN=166837 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=62) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=62 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166920 block_nr=0 scheduling free USF for polling at FN=166924 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=166950 block_nr=7 scheduling free USF for polling at FN=166954 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=166954 TLL=0xe75a5338 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=74 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=74 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167011 block_nr=9 scheduling free USF for polling at FN=167015 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167015 block_nr=10 scheduling free USF for polling at FN=167019 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=167019 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167102 block_nr=6 scheduling free USF for polling at FN=167106 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167188 block_nr=2 scheduling free USF for polling at FN=167193 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167275 block_nr=10 scheduling free USF for polling at FN=167279 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167305 block_nr=5 scheduling free USF for polling at FN=167310 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=167310 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167366 block_nr=7 scheduling free USF for polling at FN=167370 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167370 block_nr=8 scheduling free USF for polling at FN=167375 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=167375 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167457 block_nr=4 scheduling free USF for polling at FN=167461 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167544 block_nr=0 scheduling free USF for polling at FN=167548 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167630 block_nr=8 scheduling free USF for polling at FN=167635 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167661 block_nr=3 scheduling free USF for polling at FN=167665 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=167665 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167721 block_nr=5 scheduling free USF for polling at FN=167726 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167726 block_nr=6 scheduling free USF for polling at FN=167730 of UL TFI=0 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 416 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 490 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 1 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=167730 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167812 block_nr=2 scheduling free USF for polling at FN=167817 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167899 block_nr=10 scheduling free USF for polling at FN=167903 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167929 block_nr=5 scheduling free USF for polling at FN=167934 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=167934 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167990 block_nr=7 scheduling free USF for polling at FN=167994 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=167994 block_nr=8 scheduling free USF for polling at FN=167999 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=167999 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=416) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168081 block_nr=4 scheduling free USF for polling at FN=168085 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=416 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=506) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168168 block_nr=0 scheduling free USF for polling at FN=168172 of DL TFI=1 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=1 (len=490) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168254 block_nr=8 scheduling free USF for polling at FN=168259 of DL TFI=1 <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168285 block_nr=3 scheduling free USF for polling at FN=168289 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=168289 TLL=0xe75a5338 (TRX 0 TS 7) <0005> gprs_rlcmac_data.cpp:759 Complete UL frame for TBF=0: len=62 <0008> gprs_rlcmac.cpp:1760 LLC [PCU -> SGSN] TFI: 0 TLLI: 0xe75a5338 len=62 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168345 block_nr=5 scheduling free USF for polling at FN=168350 of DL TFI=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168350 block_nr=6 scheduling free USF for polling at FN=168354 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:500 RX: [PCU <- BTS] FIXME: Packet uplink dummy control block <0002> gprs_rlcmac_data.cpp:307 PACKET CONTROL ACK with expected FN=168354 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=1: len=490 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=168402 TFI=1 (TRX 0 TS 7) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168423 block_nr=11 scheduling free USF for polling at FN=168428 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=168432 TFI=1 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=1 <0002> gprs_rlcmac_data.cpp:180 - Timeout for polling PACKET DOWNLINK ACK. <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:90 - Downlink ACK was received <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168510 block_nr=7 scheduling free USF for polling at FN=168514 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=168519 TFI=1 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168597 block_nr=3 scheduling free USF for polling at FN=168601 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=168605 TFI=1 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168683 block_nr=11 scheduling free USF for polling at FN=168688 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=168692 TFI=1 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168770 block_nr=7 scheduling free USF for polling at FN=168774 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=168779 TFI=1 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168857 block_nr=3 scheduling free USF for polling at FN=168861 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=168865 TFI=1 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=168948 block_nr=0 scheduling free USF for polling at FN=168952 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=168956 TFI=1 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=1 <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=169034 block_nr=8 scheduling free USF for polling at FN=169039 of DL TFI=1 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=169043 TFI=1 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=1 <0002> gprs_rlcmac_data.cpp:187 - N3105 exceeded <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=117, fn=169172 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=169260 block_nr=0 scheduling free USF for polling at FN=169264 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=169268 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:135 - Timeout for polling PACKET CONTROL ACK for PACKET UPLINK ASSIGNMENT. <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:88 - No uplink data received yet <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=169320 block_nr=2 scheduling free USF for polling at FN=169325 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=169329 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=169411 block_nr=11 scheduling free USF for polling at FN=169416 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=169420 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=169507 block_nr=9 scheduling free USF for polling at FN=169511 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=169515 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=169676 block_nr=0 scheduling free USF for polling at FN=169680 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=169684 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=169866 block_nr=8 scheduling free USF for polling at FN=169871 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=169875 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=170022 block_nr=8 scheduling free USF for polling at FN=170027 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=170031 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=170066 block_nr=6 scheduling free USF for polling at FN=170070 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=170074 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:143 - N3105 exceeded <0002> gprs_rlcmac_data.cpp:555 TBF T3195 timeout during transsmission <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:90 - Downlink ACK was received <0002> gprs_rlcmac.cpp:895 Free DL TBF=1 with TLLI=0xe75a5338. <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=119, fn=170372 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=1 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=170460 block_nr=1 scheduling free USF for polling at FN=170464 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=170469 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:135 - Timeout for polling PACKET CONTROL ACK for PACKET UPLINK ASSIGNMENT. <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:88 - No uplink data received yet <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=170620 block_nr=2 scheduling free USF for polling at FN=170625 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=170629 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=170724 block_nr=2 scheduling free USF for polling at FN=170729 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=170733 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=170807 block_nr=9 scheduling free USF for polling at FN=170811 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=170815 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=170932 block_nr=2 scheduling free USF for polling at FN=170937 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=170941 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=170997 block_nr=5 scheduling free USF for polling at FN=171002 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=171006 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=171041 block_nr=3 scheduling free USF for polling at FN=171045 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=171049 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=171205 block_nr=5 scheduling free USF for polling at FN=171210 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=171214 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:555 TBF T3195 timeout during transsmission <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:88 - No uplink data received yet <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:143 - N3105 exceeded <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=115, fn=171569 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 506 <0002> gprs_rlcmac.cpp:354 Allocating DL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0008> gprs_bssgp_pcu.cpp:145 LLC [SGSN -> PCU] = TLLI: 0xe75a5338 IMSI: 452022112638582 len: 490 <0002> gprs_bssgp_pcu.cpp:149 TBF: APPEND TFI: 0 TLLI: 0xe75a5338 <0002> gprs_rlcmac_data.cpp:555 TBF T3195 timeout during transsmission <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:88 - No uplink data received yet <0002> gprs_rlcmac.cpp:895 Free UL TBF=1 with TLLI=0xe75a5338. <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=172453 block_nr=5 scheduling free USF for polling at FN=172458 of DL TFI=0 <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=506 <0004> gprs_rlcmac_data.cpp:1480 - Dequeue next LLC for TBF=0 (len=490) <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=172462 TFI=0 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:180 - Timeout for polling PACKET DOWNLINK ACK. <0002> gprs_rlcmac_data.cpp:82 - Assignment was on CCCH <0002> gprs_rlcmac_data.cpp:92 - No downlink ACK received yet <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0002> gprs_rlcmac_data.cpp:548 Continue flow after IMM.ASS confirm <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=172583 block_nr=11 scheduling free USF for polling at FN=172588 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=172592 TFI=0 (TRX 0 TS 7) <0004> gprs_rlcmac_data.cpp:1472 Complete DL frame for TBF=0: len=490 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0002> gprs_rlcmac_data.cpp:548 Continue flow after IMM.ASS confirm <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=172718 block_nr=6 scheduling free USF for polling at FN=172722 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0002> gprs_rlcmac_data.cpp:548 Continue flow after IMM.ASS confirm <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=172913 block_nr=3 scheduling free USF for polling at FN=172917 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=172921 TFI=0 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0002> gprs_rlcmac_data.cpp:548 Continue flow after IMM.ASS confirm <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=173043 block_nr=9 scheduling free USF for polling at FN=173047 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0002> gprs_rlcmac_data.cpp:548 Continue flow after IMM.ASS confirm <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=173203 block_nr=10 scheduling free USF for polling at FN=173207 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=173212 TFI=0 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0002> gprs_rlcmac_data.cpp:548 Continue flow after IMM.ASS confirm <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=173407 block_nr=9 scheduling free USF for polling at FN=173411 of DL TFI=0 <0002> gprs_rlcmac_data.cpp:395 PACKET DOWNLINK ACK with unknown FN=173415 TFI=0 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for DL TBF=0 <0002> gprs_rlcmac_data.cpp:1820 TX: START TFI: 0 TLLI: 0xe75a5338 Immediate Assignment Downlink (PCH) <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=116, fn=173535 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0002> gprs_rlcmac_data.cpp:548 Continue flow after IMM.ASS confirm <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=173589 block_nr=3 scheduling free USF for polling at FN=173593 of DL TFI=0 <0005> gprs_rlcmac_data.cpp:456 Got RACH from TLLI=0xe75a5338 while DL TBF=0 still exists. Killing pending DL TBF <0002> gprs_rlcmac.cpp:895 Free DL TBF=0 with TLLI=0xe75a5338. <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=0 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=173623 block_nr=11 scheduling free USF for polling at FN=173628 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=173632 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:135 - Timeout for polling PACKET CONTROL ACK for PACKET UPLINK ASSIGNMENT. <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:88 - No uplink data received yet <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=173719 block_nr=9 scheduling free USF for polling at FN=173723 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=173727 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=173766 block_nr=8 scheduling free USF for polling at FN=173771 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=173775 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=173870 block_nr=8 scheduling free USF for polling at FN=173875 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=173879 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=173922 block_nr=8 scheduling free USF for polling at FN=173927 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=173931 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=174018 block_nr=6 scheduling free USF for polling at FN=174022 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=174026 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=174143 block_nr=11 scheduling free USF for polling at FN=174148 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=174152 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 0 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=174299 block_nr=11 scheduling free USF for polling at FN=174304 of UL TFI=0 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=174308 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=0 <0002> gprs_rlcmac_data.cpp:143 - N3105 exceeded <0001> pcu_l1_if.cpp:256 RACH request received: sapi=1 qta=0, ra=116, fn=174761 <0002> gprs_rlcmac_data.cpp:1157 TX: Immediate Assignment Uplink (AGCH) <0002> gprs_rlcmac_data.cpp:1895 Got IMM.ASS confirm, but rest octets do not start with bit sequence 'HH01' (Packet Downlink Assignment) <0002> gprs_rlcmac.cpp:354 Allocating UL TBF: TFI=1 TRX=0 MS_CLASS=10 <0002> gprs_rlcmac.cpp:948 - Setting Control TS 7 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=174845 block_nr=5 scheduling free USF for polling at FN=174850 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=174854 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:135 - Timeout for polling PACKET CONTROL ACK for PACKET UPLINK ASSIGNMENT. <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:88 - No uplink data received yet <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=174902 block_nr=6 scheduling free USF for polling at FN=174906 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=174910 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=175001 block_nr=5 scheduling free USF for polling at FN=175006 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=175010 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=175118 block_nr=8 scheduling free USF for polling at FN=175123 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=175127 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=175292 block_nr=0 scheduling free USF for polling at FN=175296 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=175300 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=175404 block_nr=2 scheduling free USF for polling at FN=175409 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=175413 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=175474 block_nr=6 scheduling free USF for polling at FN=175478 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:555 TBF T3195 timeout during transsmission <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:88 - No uplink data received yet <0002> gprs_rlcmac.cpp:895 Free UL TBF=0 with TLLI=0xe75a5338. <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=175482 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:1088 TBF: START TFI: 1 TLLI: 0xe75a5338 Packet Uplink Assignment (PACCH) <0006> gprs_rlcmac_sched.cpp:260 Received RTS for PDCH: TRX=0 TS=7 FN=175552 block_nr=0 scheduling free USF for polling at FN=175556 of UL TFI=1 <0002> gprs_rlcmac_data.cpp:281 PACKET CONTROL ACK with unknown FN=175560 TLL=0xe75a5338 (TRX 0 TS 7) <0002> gprs_rlcmac_data.cpp:100 Poll timeout for UL TBF=1 <0002> gprs_rlcmac_data.cpp:143 - N3105 exceeded <0002> gprs_rlcmac_data.cpp:555 TBF T3195 timeout during transsmission <0002> gprs_rlcmac_data.cpp:84 - Assignment was on PACCH <0002> gprs_rlcmac_data.cpp:88 - No uplink data received yet <0002> gprs_rlcmac.cpp:895 Free UL TBF=1 with TLLI=0xe75a5338.

Regards, Vladimir Rolbin