tbf: Log timeslot allocation failure

Change-Id: I48fc1eac37eeb74649bfc0888e06afc0079a58f8

2 files changed, 40 insertions, 0 deletions

diff --git a/tests/alloc/AllocTest.err b/tests/alloc/AllocTest.err
index 0866c9c3..8c175f50 100644
--- a/tests/alloc/AllocTest.err
+++ b/tests/alloc/AllocTest.err
@@ -194,6 +194,7 @@ TBF(TFI=31 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 08,
 No TFI available (suggested TRX: 0).
 Allocating DL TBF: MS_CLASS=0/0
 [DL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
 TBF(TFI=1 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
@@ -306,6 +307,7 @@ TBF(TFI=6 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 3
 TBF(TFI=6 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 00
 Allocating UL TBF: MS_CLASS=0/0
 [UL] algo A <multi> (suggested TRX: -1): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
 TBF(TFI=1 TLLI=0xffffffff DIR=UL STATE=NULL) free
@@ -714,6 +716,7 @@ TBF(TFI=31 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 10,
 No TFI available (suggested TRX: 0).
 Allocating DL TBF: MS_CLASS=0/0
 [DL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
@@ -932,6 +935,7 @@ TBF(TFI=6 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 4
 TBF(TFI=6 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 10, dl_slots = 00
 Allocating UL TBF: MS_CLASS=0/0
 [UL] algo A <multi> (suggested TRX: -1): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
@@ -189960,6 +189964,7 @@ TBF(TFI=6 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 7
 TBF(TFI=6 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 80, dl_slots = 80
 Allocating UL TBF: MS_CLASS=1/0
 [UL] algo A <multi> (suggested TRX: -1): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating UL TBF: MS_CLASS=10/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 5
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 20, dl_slots = 00
@@ -190052,6 +190057,7 @@ TBF(TFI=14 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 3
 TBF(TFI=14 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 18
 Allocating UL TBF: MS_CLASS=10/0
 No USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating UL TBF: MS_CLASS=12/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 5
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 20, dl_slots = 00
@@ -190144,6 +190150,7 @@ TBF(TFI=14 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 3
 TBF(TFI=14 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 18
 Allocating UL TBF: MS_CLASS=12/0
 No USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating UL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 3
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 00
@@ -190284,6 +190291,7 @@ TBF(TFI=22 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 5
 TBF(TFI=22 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 20, dl_slots = 78
 Allocating UL TBF: MS_CLASS=12/0
 No USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating UL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 3
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 00
@@ -190388,6 +190396,7 @@ TBF(TFI=16 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 3
 TBF(TFI=16 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = f8
 Allocating UL TBF: MS_CLASS=18/0
 No USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating UL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 3
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 00
@@ -190493,6 +190502,7 @@ TBF(TFI=16 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 08,
 Allocating UL TBF: MS_CLASS=18/0
 No USF available
 [UL] algo A <multi> (suggested TRX: -1): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating DL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 3
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 08
@@ -190708,6 +190718,7 @@ TBF(TFI=7 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 3
 TBF(TFI=7 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 08
 Allocating UL TBF: MS_CLASS=1/0
 [UL] algo A <multi> (suggested TRX: 0): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
 TBF(TFI=7 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
 Allocating DL TBF: MS_CLASS=10/0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 5
@@ -190804,6 +190815,7 @@ TBF(TFI=15 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 6
 TBF(TFI=15 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 40, dl_slots = f0
 Allocating UL TBF: MS_CLASS=10/0
 No USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
 TBF(TFI=15 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
 Allocating DL TBF: MS_CLASS=10/0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 5
@@ -190901,6 +190913,7 @@ TBF(TFI=15 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 40,
 Allocating UL TBF: MS_CLASS=10/0
 No USF available
 [UL] algo A <multi> (suggested TRX: 0): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
 TBF(TFI=15 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
 Allocating UL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 3
@@ -192029,6 +192042,7 @@ TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
 No TFI available (suggested TRX: 0).
 Allocating UL TBF: MS_CLASS=1/0
 [UL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating UL TBF: MS_CLASS=10/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 5
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 20, dl_slots = 00
@@ -192260,6 +192274,7 @@ TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = c0,
 Allocating DL TBF: MS_CLASS=10/0
 No TFI available (suggested TRX: 0).
 [DL] algo B <multi> (suggested TRX: 0): failed to allocate a TFI
+TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
 Allocating UL TBF: MS_CLASS=10/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 5
@@ -193042,6 +193057,7 @@ TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
 No TFI available (suggested TRX: 0).
 Allocating UL TBF: MS_CLASS=10/0
 [UL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating DL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 3
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 08
@@ -193292,6 +193308,7 @@ TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 3
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 08
 Allocating UL TBF: MS_CLASS=1/0
 [UL] algo A <multi> (suggested TRX: 0): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
 Allocating DL TBF: MS_CLASS=10/0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 5
@@ -193403,6 +193420,7 @@ TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 6
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 40, dl_slots = f0
 Allocating UL TBF: MS_CLASS=10/0
 No USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
 Allocating DL TBF: MS_CLASS=10/0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 5
@@ -193515,6 +193533,7 @@ TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 40,
 Allocating UL TBF: MS_CLASS=10/0
 No USF available
 [UL] algo A <multi> (suggested TRX: 0): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=RELEASING) free
 Allocating UL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 3
@@ -193623,6 +193642,7 @@ TBF(TFI=6 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 7
 TBF(TFI=6 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 80, dl_slots = 00
 Allocating UL TBF: MS_CLASS=1/0
 [UL] algo A <multi> (suggested TRX: -1): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating UL TBF: MS_CLASS=10/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 5
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 20, dl_slots = 00
@@ -193670,6 +193690,7 @@ TBF(TFI=14 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 3
 TBF(TFI=14 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 18, dl_slots = 00
 Allocating UL TBF: MS_CLASS=10/0
 No USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating UL TBF: MS_CLASS=10/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 5
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 20, dl_slots = 00
@@ -193742,6 +193763,7 @@ TBF(TFI=5 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 08,
 Allocating UL TBF: MS_CLASS=10/0
 No USF available
 [UL] algo A <multi> (suggested TRX: -1): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating DL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 3
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 08
@@ -194229,6 +194251,7 @@ TBF(TFI=31 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 80,
 No TFI available (suggested TRX: 0).
 Allocating DL TBF: MS_CLASS=1/0
 [DL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating DL TBF: MS_CLASS=10/0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 5
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 20, dl_slots = 78
@@ -194329,6 +194352,7 @@ No TFI available (suggested TRX: 0).
 Allocating DL TBF: MS_CLASS=10/0
 No TFI available (suggested TRX: -1).
 [DL] algo B <multi> (suggested TRX: -1): failed to allocate a TFI
+TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating DL TBF: MS_CLASS=10/0
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Setting Control TS 5
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 20, dl_slots = 78
@@ -194706,6 +194730,7 @@ TBF(TFI=31 TLLI=0xffffffff DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 80,
 No TFI available (suggested TRX: 0).
 Allocating DL TBF: MS_CLASS=10/0
 [DL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
 Allocating UL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 3
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 00
@@ -195833,6 +195858,7 @@ TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
 No TFI available (suggested TRX: 0).
 Allocating UL TBF: MS_CLASS=23/0
 [UL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
   Allocated 160 TBFs (previously -1)
 Allocating UL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xc0000000 DIR=UL STATE=NULL) Setting Control TS 3
@@ -195941,6 +195967,7 @@ TBF(TFI=6 TLLI=0xc0000022 DIR=UL STATE=NULL) Setting Control TS 7
 TBF(TFI=6 TLLI=0xc0000022 DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 80, dl_slots = 00
 Allocating UL TBF: MS_CLASS=36/0
 [UL] algo A <multi> (suggested TRX: 0): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xc0000023 DIR=UL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
   Allocated 35 TBFs (previously 160)
 TBF(TFI=0 TLLI=0xc0000000 DIR=UL STATE=NULL) free
 Allocating UL TBF: MS_CLASS=1/0
@@ -197419,6 +197446,7 @@ TBF(TFI=0 TLLI=0xc000009f DIR=UL STATE=NULL) free
 No TFI available (suggested TRX: 0).
 Allocating UL TBF: MS_CLASS=23/0
 [UL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
   Allocated 160 TBFs (previously 160)
 TBF(TFI=0 TLLI=0xc0000000 DIR=DL STATE=RELEASING) free
 Allocating DL TBF: MS_CLASS=1/0
@@ -198222,6 +198250,7 @@ TBF(TFI=31 TLLI=0xc000009f DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 80,
 No TFI available (suggested TRX: 0).
 Allocating DL TBF: MS_CLASS=23/0
 [DL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
   Allocated 160 TBFs (previously 160)
 Allocating UL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 3
@@ -198454,6 +198483,7 @@ TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = c0,
 Allocating DL TBF: MS_CLASS=33/0
 No TFI available (suggested TRX: 0).
 [DL] algo B <multi> (suggested TRX: 0): failed to allocate a TFI
+TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
   Allocated 32 TBFs (previously -1)
 Allocating UL TBF: MS_CLASS=1/0
@@ -198509,6 +198539,7 @@ TBF(TFI=16 TLLI=0xc0000010 DIR=UL STATE=NULL) Setting Control TS 3
 TBF(TFI=16 TLLI=0xc0000010 DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 88, dl_slots = 00
 Allocating UL TBF: MS_CLASS=18/0
 No USF available
+TBF(TFI=0 TLLI=0xc0000011 DIR=UL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
   Allocated 17 TBFs (previously 32)
 TBF(TFI=0 TLLI=0xc0000000 DIR=UL STATE=NULL) free
 Allocating UL TBF: MS_CLASS=1/0
@@ -198821,6 +198852,7 @@ TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 60,
 Allocating DL TBF: MS_CLASS=33/0
 No TFI available (suggested TRX: 0).
 [DL] algo B <multi> (suggested TRX: 0): failed to allocate a TFI
+TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
   Allocated 32 TBFs (previously 32)
 TBF(TFI=0 TLLI=0xc0000000 DIR=DL STATE=RELEASING) free
@@ -198986,6 +199018,7 @@ No TFI available (suggested TRX: 0).
 Allocating DL TBF: MS_CLASS=33/0
 No TFI available (suggested TRX: -1).
 [DL] algo B <multi> (suggested TRX: -1): failed to allocate a TFI
+TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
   Allocated 32 TBFs (previously 32)
 Allocating UL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Setting Control TS 3
@@ -199672,6 +199705,7 @@ TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
 No TFI available (suggested TRX: 0).
 Allocating UL TBF: MS_CLASS=44/0
 [UL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
   Allocated 89 TBFs (previously -1)
 Allocating UL TBF: MS_CLASS=1/0
 TBF(TFI=0 TLLI=0xc0000000 DIR=UL STATE=NULL) Setting Control TS 3
@@ -199726,6 +199760,7 @@ TBF(TFI=6 TLLI=0xc0000010 DIR=UL STATE=NULL) Setting Control TS 3
 TBF(TFI=6 TLLI=0xc0000010 DIR=UL STATE=NULL) Allocated: trx = 0, ul_slots = 08, dl_slots = 00
 Allocating UL TBF: MS_CLASS=18/0
 [UL] algo A <multi> (suggested TRX: 0): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xc0000011 DIR=UL STATE=NULL) Timeslot Allocation failed: trx = 0, single_slot = 0
   Allocated 17 TBFs (previously 89)
 TBF(TFI=0 TLLI=0xc0000000 DIR=UL STATE=NULL) free
 Allocating UL TBF: MS_CLASS=1/0
@@ -200974,6 +201009,7 @@ TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) free
 No TFI available (suggested TRX: 0).
 Allocating UL TBF: MS_CLASS=23/0
 [UL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
   Allocated 160 TBFs (previously 89)
 TBF(TFI=0 TLLI=0xc0000000 DIR=DL STATE=RELEASING) free
 Allocating DL TBF: MS_CLASS=1/0
@@ -201777,6 +201813,7 @@ TBF(TFI=31 TLLI=0xc000009f DIR=DL STATE=NULL) Allocated: trx = 0, ul_slots = 80,
 No TFI available (suggested TRX: 0).
 Allocating DL TBF: MS_CLASS=23/0
 [DL] algo A <multi> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 0
   Allocated 160 TBFs (previously 160)
 Allocating DL TBF: MS_CLASS=11/11
 TBF(TFI=0 TLLI=0xffffffff DIR=DL STATE=NULL EGPRS) Setting Control TS 6
diff --git a/tests/tbf/TbfTest.err b/tests/tbf/TbfTest.err
index eb197d4e..26e4b69a 100644
--- a/tests/tbf/TbfTest.err
+++ b/tests/tbf/TbfTest.err
@@ -1342,6 +1342,7 @@ The MS object cannot fully confirm an unexpected TLLI: 0xc0000020, partly confir
 Allocating DL TBF: MS_CLASS=45/0
 [DL] algo A <single> (suggested TRX: -1): Alloc start
 [DL] algo A <single> (suggested TRX: -1): failed to find a usable TRX (TFI exhausted)
+TBF(TFI=0 TLLI=0xc0000020 DIR=DL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 1
 No PDCH resource
 === end test_tbf_exhaustion ===
 Destroying MS object, TLLI = 0xc0000020
@@ -6193,6 +6194,7 @@ Allocating UL TBF: MS_CLASS=0/0
 - Skipping TS 6, because not enabled
 - Skipping TS 7, because no USF available
 [UL] algo A <single> (suggested TRX: -1): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffffffff DIR=UL STATE=NULL) Timeslot Allocation failed: trx = -1, single_slot = 1
 No PDCH resource for Uplink TBF
 Tx Immediate Assignment Reject on AGCH
 Destroying MS object, TLLI = 0xffffffff
@@ -7630,6 +7632,7 @@ Allocating UL TBF: MS_CLASS=11/11
 - Skipping TS 6, because not enabled
 - Skipping TS 7, because no USF available
 [UL] algo A <multi> (suggested TRX: 0): failed to allocate a TS, no USF available
+TBF(TFI=0 TLLI=0xffeeddcc DIR=UL STATE=NULL EGPRS) Timeslot Allocation failed: trx = 0, single_slot = 0
 No PDCH resource
 TBF(TFI=0 TLLI=0xffeeddcc DIR=UL STATE=NULL) changes state from NULL to ASSIGN
 Attaching TBF to MS object, TLLI = 0xffeeddcc, TBF = TBF(TFI=0 TLLI=0xffeeddcc DIR=UL STATE=ASSIGN)