2021-11-09 11:22:48 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) PDCH state: disabled => enabled
|
2023-01-19 15:51:46 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 72 for type SBA
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 78 for type SBA
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 72 for type SBA
|
2021-03-12 14:40:48 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Trying to reserve already reserved FN 72
|
2023-01-19 15:51:46 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 78 for type SBA
|
2021-03-12 14:40:48 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Trying to reserve already reserved FN 78
|
2023-01-19 15:51:46 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 72 for type POLL
|
2021-03-12 14:40:48 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Trying to reserve already reserved FN 72
|
2023-01-19 15:51:46 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 78 for type POLL
|
2021-03-12 14:40:48 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Trying to reserve already reserved FN 78
|
2023-01-19 15:51:46 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 82 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 86 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 91 for type POLL
|
2021-03-12 14:40:48 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Trying to release unregistered SBA (FN=78, TA=0)
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered SBA (FN=72, TA=0)
|
2021-11-09 11:22:48 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) PDCH state: disabled => enabled
|
2023-04-17 12:25:51 +00:00
|
|
|
Creating MS object
|
|
|
|
The MS object cannot fully confirm an unexpected TLLI: 0x12345678, partly confirmed
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Attaching TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){NEW}, 1 TBFs, USFs = 00, TFIs = 00000001.
|
|
|
|
MS(TLLI-0x12345678:TA-220:MSCLS-0-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){NEW}
|
2023-04-18 17:02:55 +00:00
|
|
|
MS(TLLI-0x12345678:TA-220:MSCLS-0-0:DL): + tbf: now used by 1 (tbf)
|
2023-01-19 15:51:46 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 2715608 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 2715613 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 2715617 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 2715622 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 2715626 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 2715630 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 2715635 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 2715639 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 2715643 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 0 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 4 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 8 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 13 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 17 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 21 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 26 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 30 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 34 for type POLL
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 39 for type POLL
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=2715613 but previous FN=2715608 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=2715608, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=2715613, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=2715617 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=2715617, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=2715622 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=2715622, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=2715626 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=2715626, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=2715630 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=2715630, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=2715635 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=2715635, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=2715639 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=2715639, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=2715643 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=2715643, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=4 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=4, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=8 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=8, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=13 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=13, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=17 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=17, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=21 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=21, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=26 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=26, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=30 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=30, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=34 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=34, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2021-03-12 17:24:57 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Expiring FN=43 but previous FN=39 is still reserved!
|
2023-05-31 10:52:41 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Timeout for registered POLL (FN=39, reason=UL_ASS): TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}
|
2023-04-17 16:23:56 +00:00
|
|
|
MS(TLLI-0x12345678:TA-220:MSCLS-0-0:DL) Destroying MS object
|
Make sure GprsMs free() also frees its tbfs
This fixes TBF objects leaking and ending up alive when the MS object is
explicitly freed through talloc_free (and sporadically
crashing TbfTest once a timeout for them occur).
This mostly affects unit tests, where most of the explicit free()
happens.
In osmo-pcu, in general, the GprsMs object only gets _free() called when
its resource count reaches 0, aka no more TBFs are attached to it. Hence
in general GprsMs object is freed() only when no TBFs (to be leaked) are
present.
However, in the unit tests it's usual that we want to wipe the entire
context by eg. feeing the PCU, the BTS or MS object, which should also
free the related TBFs.
When running osmo-pcu this may only be an issue when the MS object is
freed explicitly, which could happen for instance when a BTS is torn down,
ie. PCUIF going down, moment at which all GprsMs of that BTS are freed.
But in there actually it iterates over PDCHs to free all TBFs, so it's
fine.
If we iterated over MS, this could have ended up in a crash, like
it happened in TbfTest sporadically, but it's not a bit problem if we
crash + restart at that time since anyway the BTS is gone ore just
getting up around that time.
Related: OS#6359
Change-Id: Ibbdec94acb8132be20508d3178d88da44bfaf91d
2024-03-25 19:13:47 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Detaching TBF(DL:TFI-0-0-0:G:TLLI-0x12345678){ASSIGN}, 1 TBFs, USFs = 00, TFIs = 00000001.
|
|
|
|
MS(TLLI-0x12345678:TA-220:MSCLS-0-0:DL) Detaching TBF: TBF(DL:G:TLLI-0x12345678){ASSIGN}
|
2023-04-18 17:02:55 +00:00
|
|
|
MS(TLLI-0x12345678:TA-220:MSCLS-0-0): - tbf: now used by 0 (-)
|
2021-11-09 11:22:48 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) PDCH state: disabled => enabled
|
2023-01-19 15:51:46 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 104 for type SBA
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 117 for type SBA
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 121 for type SBA
|
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 125 for type SBA
|
2021-11-09 11:22:48 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) PDCH state: disabled => enabled
|
2021-03-29 11:49:43 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) POLL scheduled at FN 26 + 13 = 39
|
2023-01-19 15:51:46 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 104 for type SBA
|
2021-03-29 11:49:43 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) UL block already scheduled at FN 91 + 13 = 104
|
|
|
|
PDCH(bts=0,trx=0,ts=0) POLL scheduled at FN 91 + 17 = 108
|
2023-01-19 15:51:46 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 108 for type SBA
|
2021-03-29 11:49:43 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) UL block already scheduled at FN 91 + 13 = 104
|
|
|
|
PDCH(bts=0,trx=0,ts=0) UL block already scheduled at FN 91 + 17 = 108
|
|
|
|
PDCH(bts=0,trx=0,ts=0) POLL scheduled at FN 91 + 21 = 112
|
2023-01-19 15:51:46 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 112 for type SBA
|
2021-03-29 11:49:43 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) UL block already scheduled at FN 91 + 13 = 104
|
|
|
|
PDCH(bts=0,trx=0,ts=0) UL block already scheduled at FN 91 + 17 = 108
|
|
|
|
PDCH(bts=0,trx=0,ts=0) UL block already scheduled at FN 91 + 21 = 112
|
|
|
|
PDCH(bts=0,trx=0,ts=0) POLL scheduled at FN 91 + 26 = 117
|
2023-01-19 15:51:46 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) Reserving FN 117 for type SBA
|
2021-03-29 11:49:43 +00:00
|
|
|
PDCH(bts=0,trx=0,ts=0) UL block already scheduled at FN 91 + 13 = 104
|
|
|
|
PDCH(bts=0,trx=0,ts=0) UL block already scheduled at FN 91 + 17 = 108
|
|
|
|
PDCH(bts=0,trx=0,ts=0) UL block already scheduled at FN 91 + 21 = 112
|
|
|
|
PDCH(bts=0,trx=0,ts=0) UL block already scheduled at FN 91 + 26 = 117
|
|
|
|
PDCH(bts=0,trx=0,ts=0) FN=91 Failed allocating POLL, all RRBP values are already reserved!
|