Hi all! Following wiki I am trying to launch OpenBSC on CalypsoBTS (two OsmocomBB phones) with speech support.

I compiled libosmocore, libosmo-dsp, libosmo-abis and jolly/trx branch of OsmocomBB with transceiver support. Then I compiled opencore-amr, Sip-Sofia, oRTP for LCR. Then I compiled OpenBSC, OsmoBTS (with osmobts-trx) and LCR.

OsmoBTS configured to use two timeslots only (slotmask 1 1 0 0 0 0 0 0) and it uses TS0 as CCCH+SDCCH4 and TS1 as TCH/H. Here is some strings from my openbsc.cfg:

bts 0
  codec-support fr hr amr
  trx 0
    timeslot 0
      phys_chan_config CCCH+SDCCH4
      hopping enabled 0
    timeslot 1
      phys_chan_config TCH/H
      hopping enabled 0

When I use jolly/multi-trx branch of libosmo-abis, jolly/testing branch of OpenBSC and jolly/trx branch of OsmoBTS my network works very unstable. When I try to make voice call sometimes it falls with message "No resources for TCH/H". Russian language in SMS is not supported. I think it is because this branches are obsolete.

I tried to compile everything again but used master branches, and it worked much better! Now everything works as well. But when I call to 995 or 993 numbers of LCR I hear nothing. :(

In OpenBSC console I see:
<0004> abis_rsl.c:1465 (bts=0,trx=0,ts=1,ss=0) Activating ARFCN(806) SS(0) lctype TCH/F r=CALL ra=0x43 ta=1
<0004> abis_rsl.c:1199 (bts=0,trx=0,ts=1,ss=0) CHANNEL ACTIVATE ACK
<0000> abis_rsl.c:1653 (bts=0,trx=0,ts=1,ss=0) SAPI=0 ESTABLISH INDICATION
<0000> gsm_04_08.c:3584 Dispatching 04.08 message, pdisc=5
<0002> gsm_04_08.c:958 <- CM SERVICE REQUEST serv_type=0x01 MI(TMSI)=4286202573
<0002> gsm_04_08_utils.c:692 -> CM SERVICE ACK
<0000> abis_rsl.c:1653 (bts=0,trx=0,ts=1,ss=0) SAPI=0 DATA INDICATION
<0003> bsc_api.c:500 CLASSMARK CHANGE CM2(len=3) CM3(len=9)
<0000> abis_rsl.c:1653 (bts=0,trx=0,ts=1,ss=0) SAPI=0 DATA INDICATION
<0003> bsc_api.c:586 GRPS SUSPEND REQUEST
<0000> abis_rsl.c:1653 (bts=0,trx=0,ts=1,ss=0) SAPI=0 DATA INDICATION
<0000> gsm_04_08.c:3584 Dispatching 04.08 message, pdisc=3
<0001> gsm_04_08.c:3508 (bts 0 trx 0 ts 1 ti 8 sub 49643) Received 'SETUP' from MS in state 0 (NULL)
<0001> gsm_04_08.c:3513 Unknown transaction ID 8, creating new trans.
<0001> transaction.c:71 subscr=0x1d1de30, net=0x1d0bf00
<0001> gsm_04_08.c:1296 new state NULL -> INITIATED
<0001> gsm_04_08.c:1931 Subscriber 250013894508275 (49643) sends SETUP to 995
<0001> gsm_04_08.c:1357 (bts 0 trx 0 ts 1 ti 8 sub 49643) Sending 'MNCC_SETUP_IND' to MNCC.
<0001> gsm_04_08.c:3415 (bts 0 trx 0 ts 1 ti 08 sub 49643) Received 'MNCC_LCHAN_MODIFY' from MNCC in state 1 (INITIATED)
<000a> bsc_api.c:397 Sending ChanModify for speech 65 1
<0003> gsm_04_08_utils.c:498 -> CHANNEL MODE MODIFY mode=0x41
<0001> gsm_04_08.c:3415 (bts 0 trx 0 ts 1 ti 08 sub 49643) Received 'MNCC_CALL_PROC_REQ' from MNCC in state 1 (INITIATED)
<0001> gsm_04_08.c:1296 new state INITIATED -> MO_CALL_PROC
<0001> gsm_04_08.c:139 (bts 0 trx 0 ts 1 ti 80) Sending 'CALL_PROC' to MS.
<0001> gsm_04_08.c:1718 queue tch_recv_mncc request (1)
<0001> gsm_04_08.c:3415 (bts 0 trx 0 ts 1 ti 08 sub 49643) Received 'MNCC_SETUP_RSP' from MNCC in state 3 (MO_CALL_PROC)
<0001> gsm_04_08.c:1853 starting timer T313 with 30 seconds
<0001> gsm_04_08.c:1296 new state MO_CALL_PROC -> CONNECT_IND
<0001> gsm_04_08.c:139 (bts 0 trx 0 ts 1 ti 80) Sending 'CONNECT' to MS.
<0000> abis_rsl.c:1653 (bts=0,trx=0,ts=1,ss=0) SAPI=0 DATA INDICATION
<0003> gsm_04_08_utils.c:534 CHANNEL MODE MODIFY ACK
<0004> abis_rsl.c:1867 (bts=0,trx=0,ts=1,ss=0) IPAC_BIND speech_mode=0x12 RTP_PAYLOAD=98
<0003> osmo_msc.c:72 MSC assign complete (do nothing).
<0004> abis_rsl.c:1218 (bts=0,trx=0,ts=1,ss=0) CHANNEL MODE MODIFY ACK
<0004> abis_rsl.c:2031 (bts=0,trx=0,ts=1,ss=0) IPAC_CRCX_ACK LOCAL_IP=127.0.0.1 LOCAL_PORT=34079 CON_ID=0 <0001> gsm_04_08.c:1570 pending tch_recv_mncc request
<0004> abis_rsl.c:1906 (bts=0,trx=0,ts=1,ss=0) IPAC_MDCX IP=127.0.0.1 PORT=30000 RTP_PAYLOAD=98 RTP_PAYLOAD2=0 CONN_ID=0 speech_mode=0x02
<0004> abis_rsl.c:2041 (bts=0,trx=0,ts=1,ss=0) IPAC_MDCX_ACK LOCAL_IP=127.0.0.1 LOCAL_PORT=34079 CON_ID=0
<0000> abis_rsl.c:1653 (bts=0,trx=0,ts=1,ss=0) SAPI=0 DATA INDICATION
<0000> gsm_04_08.c:3584 Dispatching 04.08 message, pdisc=3
<0001> gsm_04_08.c:3508 (bts 0 trx 0 ts 1 ti 8 sub 49643) Received 'CONNECT_ACK' from MS in state 28 (CONNECT_IND)
<0001> gsm_04_08.c:1337 stopping pending timer T313
<0001> gsm_04_08.c:1296 new state CONNECT_IND -> ACTIVE
<0001> gsm_04_08.c:1357 (bts 0 trx 0 ts 1 ti 8 sub 49643) Sending 'MNCC_SETUP_COMPL_IND' to MNCC.

In LCR console:
** LCR  Version 1.14

000000 DEBUG (in sip.cpp/sip_init() line 1987): SIP globals initialized
LCR 1.14 started, waiting for calls...
000000 TRACE 05.12.15 14:45:48.414 --: LCR 1.14 started, waiting for calls...
000000 TRACE 05.12.15 14:50:15.063 CH(1): New call ref LCR<->BSC  callref new=0x80000001
000000 TRACE 05.12.15 14:50:15.063 CH(1): Codec negotiation LCR<->BSC  bearer capa='given by MS'  speech version='AMR given' version='Full Rate given' version='AMR Half Rate given' ignored='Not TCH/H' version='Half Rate given' ignored='Not TCH/H'
000000 TRACE 05.12.15 14:50:15.063 CH(1): MNCC_SETUP_IND LCR<->BSC  calling number=49643 imsi=XXXXXXXXXXXXXXX  dialing number=995
000000 TRACE 05.12.15 14:50:15.063 CH(1): MNCC_LCHAN_MODIFY LCR<->BSC  speech version='AMR given'  mode 0x41
000000 TRACE 05.12.15 14:50:15.063 CH(1): MNCC_CALL_PROC_REQ LCR<->BSC  progress coding=3 location=1 descr=8
000000 TRACE 05.12.15 14:50:15.063 CH(1): MNCC_FRAME_RECV LCR<->BSC
000000 TRACE 05.12.15 14:50:15.063 EP(1): SETUP  from CH(1)  interface from=gsm  caller id number=49643 present=allowed  dialing 995  complete true
000000 TRACE 05.12.15 14:50:15.064 EP(1): TONE  to CH(1)  directory default  name dialing
000000 TRACE 05.12.15 14:50:15.064 EP(1): ACTION (match)  action goto  line 2
000000 TRACE 05.12.15 14:50:15.064 EP(1): ACTION goto/menu (change to)  ruleset gsm  dialing 995
000000 TRACE 05.12.15 14:50:15.064 EP(1): ACTION (match)  action test  line 6
000000 TRACE 05.12.15 14:50:15.064 EP(1): ACTION test  test 'hold music'
000000 TRACE 05.12.15 14:50:15.064 EP(1): CONNECT  to CH(1)  connect id number= present='not available'
000000 TRACE 05.12.15 14:50:15.064 EP(1): TONE  to CH(1)  directory default  name hold
000000 TRACE 05.12.15 14:50:15.064 CH(1): MNCC_SETUP_RSP LCR<->BSC  connected type=0 plan=1 present=0 screen=3 number=
000000 TRACE 05.12.15 14:50:15.880 CH(1): MNCC_SETUP_COMPL_IND LCR<->BSC

I can even send DTMF, but there is no sound...

Transceiver logs (part):
<0011> trx.c:590 TRX Data 914281:1:0:000000000000000000000000000000
<0011> trx.c:608 TRX Data Indication (fn=914253, tn=1, toa=0.00)
<0011> trx.c:590 TRX Data 914282:0:0:1500a8741832a5700a0bd5d609f850
<0011> trx.c:590 TRX Data 914282:1:0:000000000000000000000000000000
<0011> trx.c:608 TRX Data Indication (fn=914254, tn=1, toa=0.00)
<0011> trx.c:590 TRX Data 914283:0:0:811d500a01fd40e845d40284155020
<0011> trx.c:590 TRX Data 914283:1:0:000000000000000000000000000000
<0011> trx.c:608 TRX Data Indication (fn=914255, tn=1, toa=0.00)
<0011> trx.c:590 TRX Data 914284:0:0:abff40aafff4026bffd500aadd4080
<0011> trx.c:590 TRX Data 914284:1:0:000000000000000000000000000000
<0011> trx.c:608 TRX Data Indication (fn=914256, tn=1, toa=0.00)
<0011> trx.c:590 TRX Data 914285:0:0:01f5508115d50a651f510801755020
<0011> trx.c:590 TRX Data 914285:1:0:000000000000000000000000000000
<0011> trx.c:608 TRX Data Indication (fn=914257, tn=1, toa=0.00)
<0011> trx.c:590 TRX Data 914286:0:0:10aabdd500aefd7102ab75108bbd50
<0011> trx.c:590 TRX Data 914286:1:0:000000000000000000000000000000
<0011> trx.c:608 TRX Data Indication (fn=914258, tn=1, toa=0.00)
<0011> trx.c:590 TRX Data 914287:1:0:000000000000000000000000000000
<0011> trx.c:608 TRX Data Indication (fn=914259, tn=1, toa=0.00)
<0011> trx.c:590 TRX Data 914288:1:0:000000000000000000000000000000
<0011> trx.c:608 TRX Data Indication (fn=914260, tn=1, toa=0.00)
<0011> trx.c:590 TRX Data 914289:0:0:a05f550a04dd106a017d008015d020
<0011> trx.c:590 TRX Data 914289:1:0:e2985a4a90a51468a03d80e70dd060
<0011> trx.c:608 TRX Data Indication (fn=914261, tn=1, toa=0.00)
<0011> trx.c:590 TRX Data 914290:0:0:2ebf548abbf502eaadd548aeff4400
<0011> trx.c:590 TRX Data 914290:1:0:000000000000000000000000000000
<0011> trx.c:608 TRX Data Indication (fn=914262, tn=1, toa=0.00)
<0011> trx.c:590 TRX Data 914291:0:0:047d148847740a6517554000754020
<0011> trx.c:590 TRX Data 914291:1:0:000000000000000000000000000000

OsmoBTS logs (part):
<0000> rsl.c:1733 (bts=0,trx=0,ts=1,ss=0) Handing RLL msg UNIT_DATA_IND from LAPDm to MEAS REP
<0000> rsl.c:1683 (bts=0,trx=0,ts=1,ss=0) Tx MEAS RES valid(2)
<0006> scheduler.c:1186 Received Access Burst on RACH fn=913629 toa=54.75
<0006> scheduler.c:1192 Received bad AB frame at fn=913629 (15/51)
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913674 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913674 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913670 to transmit.
<0006> scheduler.c:339 PH-RTS.ind: chan=CCCH chan_nr=0x90 link_id=0x00 fn=913677 ts=0 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x90 link_id=0x00 fn=913677 ts=0 trx=0
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913679 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913679 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913674 to transmit.
<0006> scheduler.c:339 PH-RTS.ind: chan=CCCH chan_nr=0x90 link_id=0x00 fn=913681 ts=0 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x90 link_id=0x00 fn=913681 ts=0 trx=0
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913683 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913683 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913679 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913687 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913687 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913683 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913692 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913692 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913687 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913696 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913696 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913692 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913700 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913700 ts=1 trx=0
<0006> scheduler.c:3012 GSM clock jitter: -4
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913696 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913705 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913705 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913700 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913709 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913709 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913705 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913713 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913713 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913709 to transmit.
<0006> scheduler.c:339 PH-RTS.ind: chan=BCCH chan_nr=0x80 link_id=0x00 fn=913718 ts=0 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x80 link_id=0x00 fn=913718 ts=0 trx=0
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913718 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913718 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913713 to transmit.
<0006> scheduler.c:339 PH-RTS.ind: chan=CCCH chan_nr=0x90 link_id=0x00 fn=913722 ts=0 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x90 link_id=0x00 fn=913722 ts=0 trx=0
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913722 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913722 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913718 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913726 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913726 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913722 to transmit.
<0006> scheduler.c:339 PH-RTS.ind: chan=CCCH chan_nr=0x90 link_id=0x00 fn=913728 ts=0 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x90 link_id=0x00 fn=913728 ts=0 trx=0
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913731 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913731 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913726 to transmit.
<0006> scheduler.c:339 PH-RTS.ind: chan=CCCH chan_nr=0x90 link_id=0x00 fn=913732 ts=0 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x90 link_id=0x00 fn=913732 ts=0 trx=0
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913735 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913735 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913731 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913739 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913739 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913735 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913744 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913744 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913739 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913748 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913748 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913744 to transmit.
<0006> scheduler.c:3012 GSM clock jitter: 99
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913752 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913752 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913748 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913757 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913757 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913752 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913761 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913761 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913757 to transmit.
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913765 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913765 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913761 to transmit.
<0006> scheduler.c:339 PH-RTS.ind: chan=BCCH chan_nr=0x80 link_id=0x00 fn=913769 ts=0 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x80 link_id=0x00 fn=913769 ts=0 trx=0
<0006> scheduler.c:339 PH-RTS.ind: chan=SACCH/TF chan_nr=0x09 link_id=0x40 fn=913769 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x40 fn=913769 ts=1 trx=0
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913770 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913770 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913765 to transmit.
<0006> scheduler.c:339 PH-RTS.ind: chan=CCCH chan_nr=0x90 link_id=0x00 fn=913773 ts=0 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x90 link_id=0x00 fn=913773 ts=0 trx=0
<0006> scheduler.c:379 TCH RTS.ind: chan=TCH/F chan_nr=0x09 fn=913774 ts=1 trx=0
<0006> scheduler.c:276 PH-DATA.req: chan_nr=0x09 link_id=0x00 fn=913774 ts=1 trx=0
<0006> scheduler.c:1036 TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913770 to transmit.

What does it mean "TCH/F has not been served !! No prim for trx=0 ts=1 at fn=913770 to transmit."?

I tried to make phone<->phone call with and without LCR. I tried to switch between TCH/H and TCH/F and use different codecs: arm fr hr. But unfortunately there is no sound.
Can anyone help me?

Thanks a lot!