Channel Synchronization Problem with USRP

Hello, I have built a local GSM network with the Osmocom Stack and an Ettus B200. I can see and attach to the network with my smartphone. Now, i want to use another usrp to simulate a mobile device but i am having trouble with synchronization with the channel. I think the problem lays in the layer 1 control channel or maybe even with the mobile configuration file. It starts camping on the channel, gets sysinfo, ccch mode COMB but then following a FBSB RESP: result=255 i get a channel synch error. Any help in steering me to the right direction would be greatly appreciated. Thank you in advance. mobile configuration file: ! ! OsmocomBB example configuration for mobile application !! ! line vty no login ! gps device /dev/ttyACM0 gps baudrate default no gps enable ! no hide-default ! ms 1 layer2-socket /tmp/osmocom_l2 sap-socket /tmp/osmocom_sap sim sap network-selection-mode auto imei 123456789012345 0 imei-fixed no emergency-imsi no sms-service-center no call-waiting no auto-answer no force-rekey no clip no clir tx-power auto no simulated-delay stick 119 location-updating neighbour-measurement codec full-speed prefer codec half-speed no abbrev support sms a5/1 a5/2 p-gsm no e-gsm no r-gsm no gsm-850 no dcs no pcs class-900 4 class-850 4 class-dcs 1 class-pcs 1 channel-capability sdcch+tchf+tchh full-speech-v1 full-speech-v2 half-speech-v1 min-rxlev -106 dsc-max 90 no skip-max-per-band test-sim imsi 001010000000000 ki comp128 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 no barred-access rplmn 123 01 audio io-handler none no shutdown trxcon logs: 20201203162008375 DL1C NOTICE l1ctl_link.c:236 Init L1CTL link (/tmp/osmocom_l2) 20201203162008375 DTRX NOTICE trx_if.c:675 Init transceiver interface (127.0.0.1:6700) 20201203162008375 DSCH NOTICE sched_trx.c:136 Init scheduler 20201203162008375 DAPP NOTICE trxcon.c:341 Init complete 20201203162016623 DL1C NOTICE l1ctl_link.c:180 L1CTL has a new connection 20201203162016623 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162016623 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162017260 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162017260 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162017260 DL1C NOTICE l1ctl.c:399 Received power measurement request (GSM900: 119 -> 119) 20201203162017261 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162017261 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162017261 DL1C NOTICE l1ctl.c:342 Received FBSB request (GSM900 119) 20201203162017261 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162017261 DSCH NOTICE sched_trx.c:199 Add a new TDMA timeslot #0 20201203162017261 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH 20201203162017261 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162017261 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162017261 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162017261 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162017513 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1481847 (42/51) for CCCH …. 20201203162017768 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1481902 (46/51) for CCCH 20201203162017777 DSCH NOTICE sched_clck.c:136 Clock indication: fn=1481907 20201203162017892 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1481929 (22/51) for CCCH …. 20201203162018004 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1481953 (46/51) for CCCH 20201203162018012 DSCH NOTICE sched_clck.c:136 Clock indication: fn=1481958 20201203162018037 DL1C NOTICE l1ctl.c:482 Received CCCH mode request (2) 20201203162018037 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH+SDCCH/4+SACCH/4 20201203162018037 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162018037 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162018037 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162018037 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162018037 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162018037 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162018037 DSCH NOTICE sched_trx.c:223 Delete TDMA timeslot #0 20201203162018037 DL1C NOTICE l1ctl.c:342 Received FBSB request (GSM900 119) 20201203162018037 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162018037 DSCH NOTICE sched_trx.c:199 Add a new TDMA timeslot #0 20201203162018037 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH+SDCCH/4+SACCH/4 20201203162018037 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162018037 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162018037 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162018037 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162018498 DL1C NOTICE l1ctl.c:307 FBSB timer fired for ARFCN 119 20201203162018498 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162018498 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162018498 DSCH NOTICE sched_trx.c:223 Delete TDMA timeslot #0 20201203162018498 DL1C NOTICE l1ctl.c:342 Received FBSB request (GSM900 119) 20201203162018498 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162018498 DSCH NOTICE sched_trx.c:199 Add a new TDMA timeslot #0 20201203162018498 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH+SDCCH/4+SACCH/4 20201203162018498 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162018498 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162018498 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162018498 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162018520 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1481964 (6/102) for CCCH …. 20201203162018806 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482025 (67/102) for CCCH 20201203162018949 DSCH NOTICE sched_clck.c:136 Clock indication: fn=1482060 20201203162018960 DL1C NOTICE l1ctl.c:307 FBSB timer fired for ARFCN 119 20201203162018960 DL1C NOTICE l1ctl.c:694 Received L1CTL_DM_REL_REQ, switching back to CCCH 20201203162018960 DSCH NOTICE sched_trx.c:177 Reset scheduler 20201203162018960 DSCH NOTICE sched_trx.c:223 Delete TDMA timeslot #0 20201203162018960 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162018960 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162018961 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162018961 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162018961 DL1C NOTICE l1ctl.c:399 Received power measurement request (GSM900: 119 -> 119) 20201203162018963 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162018963 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162018963 DL1C NOTICE l1ctl.c:342 Received FBSB request (GSM900 119) 20201203162018963 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162018963 DSCH NOTICE sched_trx.c:199 Add a new TDMA timeslot #0 20201203162018963 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH 20201203162018963 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162018963 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162018963 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162018964 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162019070 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482184 (22/51) for CCCH …. 20201203162019890 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482361 (46/51) for CCCH 20201203162019898 DSCH NOTICE sched_clck.c:136 Clock indication: fn=1482366 20201203162019920 DL1C NOTICE l1ctl.c:482 Received CCCH mode request (2) 20201203162019920 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH+SDCCH/4+SACCH/4 20201203162019920 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162019920 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162019920 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162019920 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162019920 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162019920 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162019920 DSCH NOTICE sched_trx.c:223 Delete TDMA timeslot #0 20201203162019920 DL1C NOTICE l1ctl.c:342 Received FBSB request (GSM900 119) 20201203162019920 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162019920 DSCH NOTICE sched_trx.c:199 Add a new TDMA timeslot #0 20201203162019920 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH+SDCCH/4+SACCH/4 20201203162019920 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162019920 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162019921 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162019921 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162020382 DL1C NOTICE l1ctl.c:307 FBSB timer fired for ARFCN 119 20201203162020382 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162020382 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162020382 DSCH NOTICE sched_trx.c:223 Delete TDMA timeslot #0 20201203162020382 DL1C NOTICE l1ctl.c:342 Received FBSB request (GSM900 119) 20201203162020382 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162020382 DSCH NOTICE sched_trx.c:199 Add a new TDMA timeslot #0 20201203162020382 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH+SDCCH/4+SACCH/4 20201203162020382 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162020382 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162020382 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162020382 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162020405 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482372 (6/102) for CCCH …. 20201203162020687 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482433 (67/102) for CCCH 20201203162020834 DSCH NOTICE sched_clck.c:136 Clock indication: fn=1482468 20201203162020844 DL1C NOTICE l1ctl.c:307 FBSB timer fired for ARFCN 119 20201203162020844 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162020844 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162020844 DSCH NOTICE sched_trx.c:223 Delete TDMA timeslot #0 20201203162020844 DL1C NOTICE l1ctl.c:399 Received power measurement request (GSM900: 119 -> 119) 20201203162020846 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162020846 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162020846 DL1C NOTICE l1ctl.c:342 Received FBSB request (GSM900 119) 20201203162020846 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162020846 DSCH NOTICE sched_trx.c:199 Add a new TDMA timeslot #0 20201203162020846 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH 20201203162020846 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162020846 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162020846 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162020846 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162020953 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482592 (22/51) for CCCH …. 20201203162021298 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482667 (46/51) for CCCH 20201203162021307 DSCH NOTICE sched_clck.c:136 Clock indication: fn=1482672 20201203162021424 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482694 (22/51) for CCCH …. 20201203162021533 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482718 (46/51) for CCCH 20201203162021543 DSCH NOTICE sched_clck.c:136 Clock indication: fn=1482723 20201203162021660 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482745 (22/51) for CCCH …. 20201203162021770 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482769 (46/51) for CCCH 20201203162021779 DSCH NOTICE sched_clck.c:136 Clock indication: fn=1482774 20201203162021803 DL1C NOTICE l1ctl.c:482 Received CCCH mode request (2) 20201203162021803 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH+SDCCH/4+SACCH/4 20201203162021803 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162021803 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162021803 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162021803 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162021803 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162021803 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162021803 DSCH NOTICE sched_trx.c:223 Delete TDMA timeslot #0 20201203162021803 DL1C NOTICE l1ctl.c:342 Received FBSB request (GSM900 119) 20201203162021803 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162021803 DSCH NOTICE sched_trx.c:199 Add a new TDMA timeslot #0 20201203162021803 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH+SDCCH/4+SACCH/4 20201203162021803 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162021803 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162021803 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162021803 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162022265 DL1C NOTICE l1ctl.c:307 FBSB timer fired for ARFCN 119 20201203162022265 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162022265 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162022265 DSCH NOTICE sched_trx.c:223 Delete TDMA timeslot #0 20201203162022265 DL1C NOTICE l1ctl.c:342 Received FBSB request (GSM900 119) 20201203162022265 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162022265 DSCH NOTICE sched_trx.c:199 Add a new TDMA timeslot #0 20201203162022265 DSCH NOTICE sched_trx.c:274 (Re)configure TDMA timeslot #0 as BCCH+CCCH+SDCCH/4+SACCH/4 20201203162022265 DSCH NOTICE sched_trx.c:431 Activating lchan=SCH on ts=0 20201203162022265 DSCH NOTICE sched_trx.c:431 Activating lchan=BCCH on ts=0 20201203162022265 DSCH NOTICE sched_trx.c:431 Activating lchan=RACH on ts=0 20201203162022265 DSCH NOTICE sched_trx.c:431 Activating lchan=CCCH on ts=0 20201203162022309 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482786 (12/102) for CCCH …. 20201203162022518 DSCHD ERROR sched_lchan_xcch.c:102 Received bad data frame at fn=1482831 (57/102) for CCCH 20201203162022523 DL1C NOTICE l1ctl.c:426 Received reset request (1) 20201203162022523 DSCH NOTICE sched_trx.c:177 Reset scheduler and clock counter 20201203162022523 DSCH NOTICE sched_trx.c:223 Delete TDMA timeslot #0 20201203162022523 DL1D NOTICE l1ctl_link.c:81 L1CTL has lost connection …. mobile application logs: 000e> gsm322.c:1380 Start search of last registered PLMN (mcc=123 mnc=01 One, Two) <0002> gsm322.c:1384 Use RPLMN (mcc=123 mnc=01 One, Two) <0002> gsm322.c:810 new state 'A0 null' -> 'A1 trying RPLMN' <0003> gsm322.c:4060 (ms 1) Event 'EVENT_NEW_PLMN' for Cell selection in state 'C0 null' <000e> gsm322.c:3642 Selecting PLMN (mcc=123 mnc=01 One, Two) <0003> gsm322.c:3650 Start stored cell selection. <0003> gsm322.c:833 new state 'C0 null' -> 'C2 stored cell selection' <0003> gsm322.c:2793 Scanning power for sticked cell. <0003> gsm322.c:2868 Scanning frequencies. (119..119) <0003> gsm322.c:2916 Found signal (ARFCN 119 rxlev -55 (55)) <0003> gsm322.c:2933 Done with power scanning range. <0003> gsm322.c:2793 Scanning power for sticked cell. <0003> gsm322.c:2845 Found 1 frequencies. <0003> gsm322.c:2258 Scanning frequency 119 (rxlev -55). <0003> gsm322.c:477 Sync to ARFCN=119 rxlev=-55 (No sysinfo yet, ccch mode NONE) <0003> gsm322.c:2278 30 frequencies left in band 955..124 <000c> l1ctl.c:300 Dropping frame with 55 bit errors …. <000c> l1ctl.c:300 Dropping frame with 55 bit errors <0003> gsm322.c:2956 Channel synched. (ARFCN=119, snr=0, BSIC=63) <0003> gsm322.c:703 Starting CS timer with 4 seconds. <0001> gsm322.c:2979 using DSC of 90 <0003> gsm48_rr.c:4822 Channel provides data. <0003> gsm322.c:703 Starting CS timer with 4 seconds. <0001> gsm48_rr.c:1816 New SYSTEM INFORMATION 2 <000c> l1ctl.c:300 Dropping frame with 55 bit errors …. <000c> l1ctl.c:300 Dropping frame with 55 bit errors <0001> sysinfo.c:703 New SYSTEM INFORMATION 3 (mcc 123 mnc 01 lac 0x007c) <0001> gsm48_rr.c:1907 Changing CCCH_MODE to 2 <0001> gsm48_rr.c:1939 New SYSTEM INFORMATION 4 (mcc 123 mnc 01 lac 0x007c) <0001> sysinfo.c:615 Now updating previously received SYSTEM INFORMATION 4 <0001> gsm48_rr.c:1787 New SYSTEM INFORMATION 1 <0003> gsm322.c:2721 Received relevant sysinfo. <0003> gsm322.c:713 stopping pending CS timer. <0003> gsm322.c:2327 Scan frequency 119: Cell found. (rxlev -55 mcc 123 mnc 01 lac 007c) <0003> gsm322.c:1841 Select using access class <0003> gsm322.c:383 A (RLA_C (-55) - RXLEV_ACC_MIN (-110)) = 55 <0003> gsm322.c:385 B (MS_TXPWR_MAX_CCH (35) - p (33)) = 2 <0003> gsm322.c:387 C1 (A - MAX(B,0)) = 53 <0003> gsm322.c:1955 Cell ARFCN 119: Cell found, (rxlev=-55 mcc=123 mnc=01 lac=007c One, Two) <0003> gsm322.c:1970 Cell ARFCN 119 selected. <0003> gsm322.c:2428 Tune to frequency 119. <0003> gsm322.c:464 Sync to ARFCN=119 rxlev=-55 (Sysinfo, ccch mode COMB) <0003> gsm322.c:2455 Cell available. <0003> gsm322.c:4060 (ms 1) Event 'EVENT_CELL_FOUND' for Cell selection in state 'C2 stored cell selection' <000e> gsm322.c:3392 Camping normally on cell (ARFCN=119 mcc=123 mnc=01 One, Two) <0003> gsm322.c:833 new state 'C2 stored cell selection' -> 'C3 camped normally' <0005> gsm48_mm.c:4305 (ms 1) Received 'MM_EVENT_CELL_SELECTED' event in state MM IDLE, PLMN search <0005> gsm48_mm.c:904 new MM IDLE state PLMN search -> location updating needed <0005> gsm48_mm.c:904 new MM IDLE state location updating needed -> attempting to update <0005> gsm48_mm.c:424 starting T3212 (periodic loc. upd. delay) with 1800 seconds <0005> gsm48_mm.c:2285 Do Loc. upd. for IMSI attach. <000e> gsm48_mm.c:2204 Perform location update (MCC 123, MNC 01 LAC 0x007c) <0005> gsm48_mm.c:2340 LOCATION UPDATING REQUEST <0005> gsm48_mm.c:2360 using LAI (mcc 123 mnc 01 lac 0x007c) <0005> gsm48_mm.c:2370 using TMSI 0x9d4f59da <0005> gsm48_mm.c:909 new state MM IDLE, attempting to update -> wait for RR connection (location updating) <0001> gsm48_rr.c:5449 (ms 1) Message 'RR_EST_REQ' received in state idle (sapi 0) <000e> gsm48_rr.c:1299 Establish radio link due to mobility management request <0003> gsm322.c:4060 (ms 1) Event 'EVENT_LEAVE_IDLE' for Cell selection in state 'C3 camped normally' <0003> gsm322.c:833 new state 'C3 camped normally' -> 'connected mode 1' <0003> gsm322.c:3677 Going to camping (normal) ARFCN 119. <0003> gsm322.c:456 Sync to ARFCN=119, but there is a sync already pending <0001> gsm48_rr.c:359 new state idle -> connection pending <0001> gsm48_rr.c:1446 CHANNEL REQUEST: 00 (Location Update with NECI) <000c> l1ctl.c:169 FBSB RESP: result=255 <0003> gsm322.c:3001 Channel sync error, try again <0003> gsm322.c:464 Sync to ARFCN=119 rxlev=-55 (Sysinfo, ccch mode COMB) <000c> l1ctl.c:300 Dropping frame with 60 bit errors …. <000c> l1ctl.c:300 Dropping frame with 61 bit errors <0001> gsm48_rr.c:667 MON: f=119 lev=>=-47 snr= 0 ber= 61 LAI=123 01 007c ID=1e61 <000c> l1ctl.c:169 FBSB RESP: result=255 <0003> gsm322.c:3014 Channel sync error. <0003> gsm322.c:3018 free sysinfo ARFCN=119 <0003> gsm322.c:3027 Unselect cell due to sync error! <0003> gsm322.c:509 Unselecting serving cell. <0003> gsm322.c:3111 Loss of SACCH, Trigger RR abort. <000e> gsm48_rr.c:2879 Radio link lost signal <0001> gsm48_rr.c:2886 LOS during RACH request <0001> gsm48_rr.c:359 new state connection pending -> idle <0003> gsm322.c:4060 (ms 1) Event 'EVENT_RET_IDLE' for Cell selection in state 'connected mode 1' <0003> gsm322.c:3581 Cell not selected anymore, choose cell! <0003> gsm322.c:833 new state 'connected mode 1' -> 'C5 choose cell' <0003> gsm322.c:3523 No BA range(s), try sysinfo. <0003> gsm322.c:2480 No BA, because no sysinfo <0003> gsm322.c:3527 No BA on sysinfo, try stored BA list. <0003> gsm322.c:3537 No BA list to use. <0003> gsm322.c:4060 (ms 1) Event 'EVENT_NO_CELL_FOUND' for Cell selection in state 'C5 choose cell' <0003> gsm322.c:833 new state 'C5 choose cell' -> 'C1 normal cell selection' <0003> gsm322.c:2793 Scanning power for sticked cell. <0003> gsm322.c:2868 Scanning frequencies. (119..119) <0005> gsm48_mm.c:3902 (ms 1) Received 'RR_REL_IND' from RR in state wait for RR connection (location updating) (sapi 0) <0005> gsm48_mm.c:2739 RR link released after loc. upd. <000e> gsm48_mm.c:2683 Location update failed <000e> gsm48_mm.c:2693 Try location update later <0005> gsm48_mm.c:2694 Loc. upd. failed, retry #0 <0005> gsm48_mm.c:411 starting T3211 (loc. upd. retry delay) with 15.0 seconds <0005> gsm48_mm.c:1086 Not camping, wait for CS process to camp, it sends us CELL_SELECTED then. <0003> gsm322.c:2916 Found signal (ARFCN 119 rxlev -55 (55)) <0003> gsm322.c:2933 Done with power scanning range. <0003> gsm322.c:2793 Scanning power for sticked cell. <0003> gsm322.c:2845 Found 1 frequencies. <0003> gsm322.c:2258 Scanning frequency 119 (rxlev -55). <0003> gsm322.c:477 Sync to ARFCN=119 rxlev=-55 (No sysinfo yet, ccch mode NONE) <0003> gsm322.c:2278 30 frequencies left in band 955..124 <0003> gsm322.c:2956 Channel synched. (ARFCN=119, snr=0, BSIC=63) <0003> gsm322.c:703 Starting CS timer with 4 seconds. <0001> gsm322.c:2979 using DSC of 90 <000c> l1ctl.c:300 Dropping frame with 55 bit errors …. <000c> l1ctl.c:300 Dropping frame with 55 bit errors <0003> gsm48_rr.c:4822 Channel provides data. <0003> gsm322.c:703 Starting CS timer with 4 seconds. <0001> gsm48_rr.c:1816 New SYSTEM INFORMATION 2 <000c> l1ctl.c:300 Dropping frame with 55 bit errors …. <000c> l1ctl.c:300 Dropping frame with 55 bit errors <0001> sysinfo.c:703 New SYSTEM INFORMATION 3 (mcc 123 mnc 01 lac 0x007c) <0001> gsm48_rr.c:1907 Changing CCCH_MODE to 2 <0001> gsm48_rr.c:1939 New SYSTEM INFORMATION 4 (mcc 123 mnc 01 lac 0x007c) <0001> sysinfo.c:615 Now updating previously received SYSTEM INFORMATION 4 <0001> gsm48_rr.c:1787 New SYSTEM INFORMATION 1 <0003> gsm322.c:2721 Received relevant sysinfo. <0003> gsm322.c:713 stopping pending CS timer. <0003> gsm322.c:2327 Scan frequency 119: Cell found. (rxlev -55 mcc 123 mnc 01 lac 007c) <0003> gsm322.c:1841 Select using access class <0003> gsm322.c:383 A (RLA_C (-55) - RXLEV_ACC_MIN (-110)) = 55 <0003> gsm322.c:385 B (MS_TXPWR_MAX_CCH (35) - p (33)) = 2 <0003> gsm322.c:387 C1 (A - MAX(B,0)) = 53 <0003> gsm322.c:1955 Cell ARFCN 119: Cell found, (rxlev=-55 mcc=123 mnc=01 lac=007c One, Two) <0003> gsm322.c:1970 Cell ARFCN 119 selected. <0003> gsm322.c:2428 Tune to frequency 119. <0003> gsm322.c:464 Sync to ARFCN=119 rxlev=-55 (Sysinfo, ccch mode COMB) <0003> gsm322.c:2455 Cell available. <0003> gsm322.c:4060 (ms 1) Event 'EVENT_CELL_FOUND' for Cell selection in state 'C1 normal cell selection' <000e> gsm322.c:3392 Camping normally on cell (ARFCN=119 mcc=123 mnc=01 One, Two) <0003> gsm322.c:833 new state 'C1 normal cell selection' -> 'C3 camped normally' <0005> gsm48_mm.c:4310 (ms 1) Received 'MM_EVENT_CELL_SELECTED' event in state wait for RR connection (location updating) <0005> gsm48_mm.c:1141 We are camping normally as returning to MM IDLE <0005> gsm48_mm.c:1166 Loc. upd. allowed. <0005> gsm48_mm.c:914 new state wait for RR connection (location updating) -> MM IDLE, location updating needed <0005> gsm48_mm.c:904 new MM IDLE state location updating needed -> attempting to update <0005> gsm48_mm.c:2222 Loc. upd. already pending. <000c> l1ctl.c:169 FBSB RESP: result=255 <0003> gsm322.c:3001 Channel sync error, try again <0003> gsm322.c:464 Sync to ARFCN=119 rxlev=-55 (Sysinfo, ccch mode COMB) <000c> l1ctl.c:300 Dropping frame with 60 bit errors …. <000c> l1ctl.c:300 Dropping frame with 60 bit errors <000c> l1ctl.c:169 FBSB RESP: result=255 <0003> gsm322.c:3014 Channel sync error. <0003> gsm322.c:3018 free sysinfo ARFCN=119 <0003> gsm322.c:3027 Unselect cell due to sync error!