gerrit-log

Download

gerrit-log@lists.osmocom.org

April 2023

1 participants
2252 discussions

[S] Change in libosmo-abis[master]: e1d: fix sourcecode formatting
by dexter 18 Apr '23

18 Apr '23

dexter has uploaded this change for review. ( https://gerrit.osmocom.org/c/libosmo-abis/+/32352 ) Change subject: e1d: fix sourcecode formatting ...................................................................... e1d: fix sourcecode formatting Change-Id: I715e77849d771e05f8e7be82147c9168f9e8f86b --- M src/input/e1d.c 1 file changed, 19 insertions(+), 20 deletions(-) git pull ssh://gerrit.osmocom.org:29418/libosmo-abis refs/changes/52/32352/1 diff --git a/src/input/e1d.c b/src/input/e1d.c index 56fb5e5..1296b52 100644 --- a/src/input/e1d.c +++ b/src/input/e1d.c @@ -51,8 +51,7 @@ static int e1d_want_write(struct e1inp_ts *e1i_ts); -static int -handle_ts_sign_read(struct osmo_fd *bfd) +static int handle_ts_sign_read(struct osmo_fd *bfd) { struct e1inp_line *line = bfd->data; unsigned int ts_nr = bfd->priv_nr; @@ -75,8 +74,7 @@ return e1inp_rx_ts_lapd(e1i_ts, msg); } -static void -timeout_ts_sign_write(void *data) +static void timeout_ts_sign_write(void *data) { struct e1inp_ts *e1i_ts = (struct e1inp_ts *)data; @@ -84,8 +82,7 @@ e1d_want_write(e1i_ts); } -static int -handle_ts_sign_write(struct osmo_fd *bfd) +static int handle_ts_sign_write(struct osmo_fd *bfd) { struct e1inp_line *line = bfd->data; unsigned int ts_nr = bfd->priv_nr; @@ -115,8 +112,7 @@ #define D_TSX_ALLOC_SIZE (D_BCHAN_TX_GRAN) -static int -handle_ts_trau_write(struct osmo_fd *bfd) +static int handle_ts_trau_write(struct osmo_fd *bfd) { struct e1inp_line *line = bfd->data; unsigned int ts_nr = bfd->priv_nr; @@ -147,8 +143,7 @@ } -static int -handle_ts_trau_read(struct osmo_fd *bfd) +static int handle_ts_trau_read(struct osmo_fd *bfd) { struct e1inp_line *line = bfd->data; unsigned int ts_nr = bfd->priv_nr; @@ -305,8 +300,7 @@ return ret; } -static void -e1d_write_msg(struct msgb *msg, void *cbdata) +static void e1d_write_msg(struct msgb *msg, void *cbdata) { struct osmo_fd *bfd = cbdata; struct e1inp_line *line = bfd->data; @@ -320,8 +314,7 @@ LOGPITS(e1i_ts, DLMI, LOGL_NOTICE, "%s write failed %d\n", __func__, ret); } -static int -e1d_fd_cb(struct osmo_fd *bfd, unsigned int what) +static int e1d_fd_cb(struct osmo_fd *bfd, unsigned int what) { struct e1inp_line *line = bfd->data; unsigned int ts_nr = bfd->priv_nr; @@ -364,8 +357,7 @@ } -static int -e1d_want_write(struct e1inp_ts *e1i_ts) +static int e1d_want_write(struct e1inp_ts *e1i_ts) { /* We never include the DAHDI B-Channel FD into the writeset */ if (e1i_ts->type == E1INP_TS_TYPE_TRAU || @@ -379,8 +371,7 @@ return 0; } -static int -e1d_line_update(struct e1inp_line *line) +static int e1d_line_update(struct e1inp_line *line) { int ts; int ret; @@ -532,8 +523,7 @@ .line_update = e1d_line_update, }; -int -e1inp_e1d_init(void) +int e1inp_e1d_init(void) { /* register the driver with the core */ return e1inp_driver_register(&e1d_driver); -- To view, visit https://gerrit.osmocom.org/c/libosmo-abis/+/32352 To unsubscribe, or for help writing mail filters, visit https://gerrit.osmocom.org/settings Gerrit-Project: libosmo-abis Gerrit-Branch: master Gerrit-Change-Id: I715e77849d771e05f8e7be82147c9168f9e8f86b Gerrit-Change-Number: 32352 Gerrit-PatchSet: 1 Gerrit-Owner: dexter <pmaier(a)sysmocom.de> Gerrit-MessageType: newchange

1 0

[S] Change in libosmo-abis[master]: e1d: fix log output
by dexter 18 Apr '23

18 Apr '23

Attention is currently required from: pespin. Hello Jenkins Builder, pespin, I'd like you to reexamine a change. Please visit https://gerrit.osmocom.org/c/libosmo-abis/+/32336 to look at the new patch set (#4). Change subject: e1d: fix log output ...................................................................... e1d: fix log output When a read access to the osmo-e1d fd fails we just print the error to LOGL_DEBUG but an error like this should be logged to LOGL_ERROR. Also the line might print "read error 0 Success", which is a bit misleading, so let's fix this as well. Change-Id: I3a0500f083cbe8cc162826e2ec974875bafcaba9 --- M src/input/e1d.c 1 file changed, 18 insertions(+), 2 deletions(-) git pull ssh://gerrit.osmocom.org:29418/libosmo-abis refs/changes/36/32336/4 -- To view, visit https://gerrit.osmocom.org/c/libosmo-abis/+/32336 To unsubscribe, or for help writing mail filters, visit https://gerrit.osmocom.org/settings Gerrit-Project: libosmo-abis Gerrit-Branch: master Gerrit-Change-Id: I3a0500f083cbe8cc162826e2ec974875bafcaba9 Gerrit-Change-Number: 32336 Gerrit-PatchSet: 4 Gerrit-Owner: dexter <pmaier(a)sysmocom.de> Gerrit-Reviewer: Jenkins Builder Gerrit-Reviewer: pespin <pespin(a)sysmocom.de> Gerrit-Attention: pespin <pespin(a)sysmocom.de> Gerrit-MessageType: newpatchset

1 0

[M] Change in osmo-pcap[master]: CI/CD: drop travis support
by msuraev 18 Apr '23

18 Apr '23

msuraev has submitted this change. ( https://gerrit.osmocom.org/c/osmo-pcap/+/32325 ) Change subject: CI/CD: drop travis support ...................................................................... CI/CD: drop travis support It hasn't been tried in years and has likely bit rot by now. Change-Id: Ia3c725e94ecd544adb8899c05d66828387906625 --- D .travis.yml D contrib/travis.sh 2 files changed, 11 insertions(+), 52 deletions(-) Approvals: pespin: Looks good to me, approved msuraev: Verified diff --git a/.travis.yml b/.travis.yml deleted file mode 100644 index ebec2d9..0000000 --- a/.travis.yml +++ /dev/null @@ -1,25 +0,0 @@ -language: c -os: - - linux -sudo: required -dist: trusty -addons: - apt: - packages: - - autoconf - - automake - - make - - gcc - - debhelper - - devscripts - - libtool - - build-essential - - pkg-config - - libtalloc-dev - - libpcsclite-dev - - libpcap-dev - - libzmq3-dev - - libgnutls28-dev - -script: - - contrib/travis.sh diff --git a/contrib/travis.sh b/contrib/travis.sh deleted file mode 100755 index b7375f3..0000000 --- a/contrib/travis.sh +++ /dev/null @@ -1,27 +0,0 @@ -#!/usr/bin/env bash - -set -ex - -rm -rf deps/install -mkdir deps || true -cd deps -git clone https://gitea.osmocom.org/osmocom/libosmocore - -cd libosmocore -git reset --hard 460f9ef7da1db11b104fdfe635ebcbd8a071f205 -autoreconf --install --force -./configure --prefix=$PWD/../install -make -j 4 install -export LD_LIBRARY_PATH=$PWD/../install/lib - -cd ../ -git clone https://gitea.osmocom.org/cellular-infrastructure/osmo-python-tests -cd osmo-python-tests -sudo ./setup.py install - -cd ../../ -autoreconf --install --force -PCAP_LIBS="-lpcap" PCAP_CFLAGS="" PKG_CONFIG_PATH=$PWD/deps/install/lib/pkgconfig ./configure --with-pcap-config=/bin/true --enable-external-tests -PKG_CONFIG_PATH=$PWD/deps/install/lib/pkgconfig make -j 4 -PKG_CONFIG_PATH=$PWD/deps/install/lib/pkgconfig make check -DISTCHECK_CONFIGURE_FLAGS="--with-pcap-config=/bin/true" PCAP_LIBS="-lpcap" PCAP_CFLAGS="" PKG_CONFIG_PATH=$PWD/deps/install/lib/pkgconfig LD_LIBRARY_PATH=$PWD/deps/install/lib make distcheck -- To view, visit https://gerrit.osmocom.org/c/osmo-pcap/+/32325 To unsubscribe, or for help writing mail filters, visit https://gerrit.osmocom.org/settings Gerrit-Project: osmo-pcap Gerrit-Branch: master Gerrit-Change-Id: Ia3c725e94ecd544adb8899c05d66828387906625 Gerrit-Change-Number: 32325 Gerrit-PatchSet: 2 Gerrit-Owner: msuraev <msuraev(a)sysmocom.de> Gerrit-Reviewer: Jenkins Builder Gerrit-Reviewer: msuraev <msuraev(a)sysmocom.de> Gerrit-Reviewer: pespin <pespin(a)sysmocom.de> Gerrit-MessageType: merged

1 0

[M] Change in osmo-pcap[master]: CI/CD: drop travis support
by msuraev 18 Apr '23

18 Apr '23

msuraev has posted comments on this change. ( https://gerrit.osmocom.org/c/osmo-pcap/+/32325 ) Change subject: CI/CD: drop travis support ...................................................................... Patch Set 2: Verified+1 -- To view, visit https://gerrit.osmocom.org/c/osmo-pcap/+/32325 To unsubscribe, or for help writing mail filters, visit https://gerrit.osmocom.org/settings Gerrit-Project: osmo-pcap Gerrit-Branch: master Gerrit-Change-Id: Ia3c725e94ecd544adb8899c05d66828387906625 Gerrit-Change-Number: 32325 Gerrit-PatchSet: 2 Gerrit-Owner: msuraev <msuraev(a)sysmocom.de> Gerrit-Reviewer: Jenkins Builder Gerrit-Reviewer: msuraev <msuraev(a)sysmocom.de> Gerrit-Reviewer: pespin <pespin(a)sysmocom.de> Gerrit-Comment-Date: Tue, 18 Apr 2023 09:00:44 +0000 Gerrit-HasComments: No Gerrit-Has-Labels: Yes Gerrit-MessageType: comment

1 0

[M] Change in pysim[master]: filesystem: define more convenient codec for EF.ACC
by fixeria 17 Apr '23

17 Apr '23

fixeria has uploaded this change for review. ( https://gerrit.osmocom.org/c/pysim/+/32351 ) Change subject: filesystem: define more convenient codec for EF.ACC ...................................................................... filesystem: define more convenient codec for EF.ACC This patch improves the output of the 'read_binary_decoded' command: pySIM-shell (MF/DF.GSM/EF.ACC)> read_binary_decoded { "ACC0": false, "ACC1": false, "ACC2": false, "ACC3": false, "ACC4": false, "ACC5": false, "ACC6": false, "ACC7": false, "ACC8": false, "ACC9": false, "ACC10": false, "ACC11": false, "ACC12": false, "ACC13": false, "ACC14": false, "ACC15": true } And allows to set/unset individual ACCs using 'update_binary_decoded': pySIM-shell (MF/DF.GSM/EF.ACC)> update_binary_decoded --json-path 'ACC15' 0 "0000" pySIM-shell (MF/DF.GSM/EF.ACC)> update_binary_decoded --json-path 'ACC8' 1 "0100" pySIM-shell (MF/DF.GSM/EF.ACC)> update_binary_decoded --json-path 'ACC0' 1 "0101" Change-Id: I805b3277410745815d3fdc44b9c0f8c5be8d7a10 Related: SYS#6425 --- M pySim/ts_51_011.py 1 file changed, 55 insertions(+), 2 deletions(-) git pull ssh://gerrit.osmocom.org:29418/pysim refs/changes/51/32351/1 diff --git a/pySim/ts_51_011.py b/pySim/ts_51_011.py index b9e19b2..3dc21c8 100644 --- a/pySim/ts_51_011.py +++ b/pySim/ts_51_011.py @@ -717,13 +717,25 @@ # TS 51.011 Section 10.3.15 class EF_ACC(TransparentEF): + # example: acc_list(15) will produce a dict with only ACC15 being True + # example: acc_list(2, 4) will produce a dict with ACC2 and ACC4 being True + # example: acc_list() will produce a dict with all ACCs being False + acc_list = lambda *active: {'ACC{}'.format(c) : c in active for c in range(16)} + _test_de_encode = [ - ( "0100", "0100" ), + ( "0000", acc_list() ), + ( "0001", acc_list(0) ), + ( "0002", acc_list(1) ), + ( "0100", acc_list(8) ), + ( "8000", acc_list(15) ), + ( "802b", acc_list(0,1,3,5,15) ), ] def __init__(self, fid='6f78', sfid=None, name='EF.ACC', desc='Access Control Class', size=(2, 2), **kwargs): super().__init__(fid, sfid=sfid, name=name, desc=desc, size=size, **kwargs) - self._construct = HexAdapter(Bytes(2)) + # LSB of octet 2 is ACC=0 ... MSB of octet 1 is ACC=15 + flags = ['ACC{}'.format(c) / Flag for c in range(16)] + self._construct = ByteSwapped(BitsSwapped(BitStruct(*flags))) # TS 51.011 Section 10.3.16 class EF_LOCI(TransparentEF): -- To view, visit https://gerrit.osmocom.org/c/pysim/+/32351 To unsubscribe, or for help writing mail filters, visit https://gerrit.osmocom.org/settings Gerrit-Project: pysim Gerrit-Branch: master Gerrit-Change-Id: I805b3277410745815d3fdc44b9c0f8c5be8d7a10 Gerrit-Change-Number: 32351 Gerrit-PatchSet: 1 Gerrit-Owner: fixeria <vyanitskiy(a)sysmocom.de> Gerrit-MessageType: newchange

1 0

[S] Change in osmo-ttcn3-hacks[master]: ggsn: Speed up tests by lowering retransmission T3,N3 timers
by pespin 17 Apr '23

17 Apr '23

Attention is currently required from: pespin. Hello Jenkins Builder, fixeria, daniel, I'd like you to reexamine a change. Please visit https://gerrit.osmocom.org/c/osmo-ttcn3-hacks/+/32283 to look at the new patch set (#4). Change subject: ggsn: Speed up tests by lowering retransmission T3,N3 timers ...................................................................... ggsn: Speed up tests by lowering retransmission T3,N3 timers The params are set in GGSN_Tests.cfg and not in GGSN_Tests.default, because those lower values are not really good default ones as per spec. For instance when running against open5gs-smfd, these values should be left to the default in code of 5 and 3 seconds, because open5gs-smfd doesn't support changing the values through cfg file yet. Related: OS#5485 Change-Id: I3798fba89c2c357afeaa83a73759442c6c433cea --- M ggsn_tests/GGSN_Tests.cfg M ggsn_tests/osmo-ggsn.cfg 2 files changed, 23 insertions(+), 0 deletions(-) git pull ssh://gerrit.osmocom.org:29418/osmo-ttcn3-hacks refs/changes/83/32283/4 -- To view, visit https://gerrit.osmocom.org/c/osmo-ttcn3-hacks/+/32283 To unsubscribe, or for help writing mail filters, visit https://gerrit.osmocom.org/settings Gerrit-Project: osmo-ttcn3-hacks Gerrit-Branch: master Gerrit-Change-Id: I3798fba89c2c357afeaa83a73759442c6c433cea Gerrit-Change-Number: 32283 Gerrit-PatchSet: 4 Gerrit-Owner: pespin <pespin(a)sysmocom.de> Gerrit-Reviewer: Jenkins Builder Gerrit-Reviewer: daniel <dwillmann(a)sysmocom.de> Gerrit-Reviewer: fixeria <vyanitskiy(a)sysmocom.de> Gerrit-Attention: pespin <pespin(a)sysmocom.de> Gerrit-MessageType: newpatchset

1 0

[M] Change in osmo-pcu[master]: Merge bts_alloc_ms() and ms_alloc()
by pespin 17 Apr '23

17 Apr '23

pespin has uploaded this change for review. ( https://gerrit.osmocom.org/c/osmo-pcu/+/32349 ) Change subject: Merge bts_alloc_ms() and ms_alloc() ...................................................................... Merge bts_alloc_ms() and ms_alloc() gprs_default_cb_ms_idle() is changed to have the same implementation as previous bts_ms_idle_cb(), since that's the only one being used in osmo-pcu code. It makes no sense to use different callback logic in unit tests. This is another step towards simplifying the code and getting rid of the idle/active_cb(). Change-Id: I2a06d17588572a21dc5a14ddbde83766076b446d --- M src/bts.cpp M src/bts.h M src/gprs_ms.c M src/pdch.cpp M src/tbf_dl.cpp M tests/alloc/AllocTest.cpp M tests/app_info/AppInfoTest.cpp M tests/llc/LlcTest.cpp M tests/ms/MsTest.cpp M tests/tbf/TbfTest.cpp M tests/types/TypesTest.cpp 11 files changed, 53 insertions(+), 62 deletions(-) git pull ssh://gerrit.osmocom.org:29418/osmo-pcu refs/changes/49/32349/1 diff --git a/src/bts.cpp b/src/bts.cpp index 3b27676..07ea77c 100644 --- a/src/bts.cpp +++ b/src/bts.cpp @@ -1007,7 +1007,7 @@ "SBFn=%u TRX=%u TS=%u\n", sb_fn, pdch->trx->trx_no, pdch->ts_no); bts_do_rate_ctr_inc(bts, CTR_IMMEDIATE_ASSIGN_UL_TBF_TWO_PHASE); } else { - GprsMs *ms = bts_alloc_ms(bts); + GprsMs *ms = ms_alloc(bts); ms_set_egprs_ms_class(ms, chan_req.egprs_mslot_class); tbf = ms_new_ul_tbf_assigned_agch(ms); if (!tbf) { @@ -1198,36 +1198,6 @@ } } -static void bts_ms_idle_cb(struct GprsMs *ms) -{ - bts_stat_item_dec(ms->bts, STAT_MS_PRESENT); - if (ms_is_idle(ms)) - talloc_free(ms); -} - -static void bts_ms_active_cb(struct GprsMs *ms) -{ - /* Nothing to do */ -} - -GprsMs *bts_alloc_ms(struct gprs_rlcmac_bts* bts) -{ - struct GprsMs *ms; - - static struct gpr_ms_callback bts_ms_cb = { - .ms_idle = bts_ms_idle_cb, - .ms_active = bts_ms_active_cb, - }; - - ms = ms_alloc(bts); - - ms_set_callback(ms, &bts_ms_cb); - ms_set_timeout(ms, osmo_tdef_get(bts->pcu->T_defs, -2030, OSMO_TDEF_S, -1)); - - bts_stat_item_inc(bts, STAT_MS_PRESENT); - return ms; -} - struct GprsMs *bts_get_ms(const struct gprs_rlcmac_bts *bts, uint32_t tlli, uint32_t old_tlli, const char *imsi) { diff --git a/src/bts.h b/src/bts.h index 5644b44..7dd8547 100644 --- a/src/bts.h +++ b/src/bts.h @@ -285,7 +285,6 @@ struct osmo_mobile_identity mi_imsi; }; -struct GprsMs *bts_alloc_ms(struct gprs_rlcmac_bts *bts); int bts_add_paging(struct gprs_rlcmac_bts *bts, const struct paging_req_cs *req, struct GprsMs *ms); uint32_t bts_rfn_to_fn(const struct gprs_rlcmac_bts *bts, uint32_t rfn); diff --git a/src/gprs_ms.c b/src/gprs_ms.c index 3e95103..b9a1b76 100644 --- a/src/gprs_ms.c +++ b/src/gprs_ms.c @@ -63,7 +63,8 @@ void gprs_default_cb_ms_idle(struct GprsMs *ms) { - talloc_free(ms); + if (ms_is_idle(ms)) + talloc_free(ms); } void gprs_default_cb_ms_active(struct GprsMs *ms) @@ -111,6 +112,7 @@ talloc_set_destructor(ms, ms_talloc_destructor); llist_add(&ms->list, &bts->ms_list); + bts_stat_item_inc(bts, STAT_MS_PRESENT); ms->bts = bts; ms->cb = gprs_default_cb; @@ -147,6 +149,8 @@ if (!ms->ctrs) goto free_ret; + ms_set_timeout(ms, osmo_tdef_get(bts->pcu->T_defs, -2030, OSMO_TDEF_S, -1)); + return ms; free_ret: talloc_free(ms); @@ -159,6 +163,7 @@ LOGPMS(ms, DRLCMAC, LOGL_INFO, "Destroying MS object\n"); + bts_stat_item_dec(ms->bts, STAT_MS_PRESENT); llist_del(&ms->list); ms_set_reserved_slots(ms, NULL, 0, 0); diff --git a/src/pdch.cpp b/src/pdch.cpp index 43b3936..1c39ceb 100644 --- a/src/pdch.cpp +++ b/src/pdch.cpp @@ -665,7 +665,7 @@ uint32_t tlli = request->ID.u.TLLI; ms = bts_get_ms_by_tlli(bts, tlli, GSM_RESERVED_TMSI); if (!ms) { - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_tlli(ms, tlli); } } else if (request->ID.u.Global_TFI.UnionType) { /* ID_TYPE = DL_TFI */ @@ -857,7 +857,7 @@ if (!ms) { LOGPDCH(this, DRLCMAC, LOGL_NOTICE, "MS send measurement " "but TLLI 0x%08x is unknown\n", report->TLLI); - ms = bts_alloc_ms(bts()); + ms = ms_alloc(bts()); ms_set_tlli(ms, report->TLLI); } if ((poll = pdch_ulc_get_node(ulc, fn))) { diff --git a/src/tbf_dl.cpp b/src/tbf_dl.cpp index 431eb58..823fcef 100644 --- a/src/tbf_dl.cpp +++ b/src/tbf_dl.cpp @@ -216,7 +216,7 @@ } if (!ms) - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); if (imsi) ms_set_imsi(ms, imsi); ms_confirm_tlli(ms, tlli); diff --git a/tests/alloc/AllocTest.cpp b/tests/alloc/AllocTest.cpp index 4497fbd..cf1bba7 100644 --- a/tests/alloc/AllocTest.cpp +++ b/tests/alloc/AllocTest.cpp @@ -135,7 +135,7 @@ * least this part is working okay. */ for (i = 0; i < (int)ARRAY_SIZE(tbfs); ++i) { - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); tbfs[i] = tbf_alloc(bts, ms, dir, -1, 0); if (tbfs[i] == NULL) break; @@ -155,7 +155,7 @@ if (tbfs[i]) tbf_free(tbfs[i]); - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); tbfs[0] = tbf_alloc(bts, ms, dir, -1, 0); OSMO_ASSERT(tbfs[0]); tbf_free(tbfs[0]); @@ -221,7 +221,7 @@ enable_ts_on_bts(bts, ts0, ts1, ts2, ts3, ts4, ts5, ts6, ts7); - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_ms_class(ms, ms_class); /* Avoid delaying free to avoid tons of to-be-freed ms objects queuing */ ms_set_timeout(ms, 0); @@ -264,7 +264,7 @@ enable_ts_on_bts(bts, ts0, ts1, ts2, ts3, ts4, ts5, ts6, ts7); - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_ms_class(ms, ms_class); /* Avoid delaying free to avoid tons of to-be-freed ms objects queuing */ ms_set_timeout(ms, 0); @@ -315,7 +315,7 @@ tfi = bts_tfi_find_free(bts, GPRS_RLCMAC_UL_TBF, &trx_no, -1); OSMO_ASSERT(tfi >= 0); - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_ms_class(ms, ms_class); /* Avoid delaying free to avoid tons of to-be-freed ms objects queuing */ ms_set_timeout(ms, 0); @@ -561,7 +561,7 @@ ms = bts_get_ms_by_tlli(bts, tlli, GSM_RESERVED_TMSI); if (!ms) - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_ms_class(ms, ms_class); ms = alloc_tbfs(bts, ms, mode); if (!ms) @@ -770,7 +770,7 @@ trx->pdch[6].enable(); trx->pdch[7].enable(); - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_ms_class(ms, ms_class); ms_set_egprs_ms_class(ms, egprs_ms_class); dl_tbf1 = dl_tbf_alloc(bts, ms, 0, false); @@ -783,7 +783,7 @@ OSMO_ASSERT(numTs1 == 4); printf("TBF1: numTs(%d)\n", numTs1); - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_ms_class(ms, ms_class); ms_set_egprs_ms_class(ms, egprs_ms_class); dl_tbf2 = dl_tbf_alloc(bts, ms, 0, false); diff --git a/tests/app_info/AppInfoTest.cpp b/tests/app_info/AppInfoTest.cpp index 1a4e660..ea84b20 100644 --- a/tests/app_info/AppInfoTest.cpp +++ b/tests/app_info/AppInfoTest.cpp @@ -90,11 +90,11 @@ trx->pdch[6].enable(); trx->pdch[7].enable(); - ms1 = bts_alloc_ms(bts); + ms1 = ms_alloc(bts); ms_set_ms_class(ms1, 10); ms_set_egprs_ms_class(ms1, 11); tbf1 = dl_tbf_alloc(bts, ms1, 0, false); - ms2 = bts_alloc_ms(bts); + ms2 = ms_alloc(bts); ms_set_ms_class(ms2, 12); ms_set_egprs_ms_class(ms2, 13); tbf2 = dl_tbf_alloc(bts, ms2, 0, false); @@ -162,7 +162,7 @@ bts = gprs_pcu_get_bts_by_nr(the_pcu, 0); talloc_free(bts); - /* FIXME: talloc report disabled, because bts_alloc_ms(bts, ) in prepare_bts_with_two_dl_tbf_subscr() causes leak */ + /* FIXME: talloc report disabled, because ms_alloc(bts, ) in prepare_bts_with_two_dl_tbf_subscr() causes leak */ /* talloc_report_full(tall_pcu_ctx, stderr); */ talloc_free(the_pcu); talloc_free(tall_pcu_ctx); diff --git a/tests/llc/LlcTest.cpp b/tests/llc/LlcTest.cpp index 3c19787..ee227f9 100644 --- a/tests/llc/LlcTest.cpp +++ b/tests/llc/LlcTest.cpp @@ -52,7 +52,7 @@ the_pcu = gprs_pcu_alloc(tall_pcu_ctx); the_pcu->vty.llc_codel_interval_msec = LLC_CODEL_DISABLE; struct gprs_rlcmac_bts *bts = bts_alloc(the_pcu, 0); - struct GprsMs *ms = bts_alloc_ms(bts); + struct GprsMs *ms = ms_alloc(bts); return ms_llc_queue(ms); } @@ -235,7 +235,7 @@ /* DEFAULT should be resolved to GPRS_CODEL_SLOW_INTERVAL_MS 4000 */ #define GPRS_CODEL_SLOW_INTERVAL_MS 4000 struct gprs_rlcmac_bts *bts = bts_alloc(the_pcu, 0); - struct GprsMs *ms = bts_alloc_ms(bts); + struct GprsMs *ms = ms_alloc(bts); gprs_llc_queue *queue = ms_llc_queue(ms); unsigned int i; @@ -297,7 +297,7 @@ static void test_llc_merge() { gprs_llc_queue *queue1 = prepare_queue(); - struct GprsMs *ms = bts_alloc_ms(queue1->ms->bts); + struct GprsMs *ms = ms_alloc(queue1->ms->bts); gprs_llc_queue *queue2 = ms_llc_queue(ms); struct timespec expire_time = {0}; diff --git a/tests/ms/MsTest.cpp b/tests/ms/MsTest.cpp index 84cb52e..a8febd0 100644 --- a/tests/ms/MsTest.cpp +++ b/tests/ms/MsTest.cpp @@ -380,7 +380,7 @@ if (ms) return ms; - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); if (dir == GPRS_RLCMAC_UL_TBF) ms_set_tlli(ms, tlli); diff --git a/tests/tbf/TbfTest.cpp b/tests/tbf/TbfTest.cpp index d493e6c..0f0960a 100644 --- a/tests/tbf/TbfTest.cpp +++ b/tests/tbf/TbfTest.cpp @@ -122,7 +122,7 @@ /* * Make a uplink and downlink allocation */ - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); gprs_rlcmac_tbf *dl_tbf = dl_tbf_alloc(bts, ms, 0, false); OSMO_ASSERT(dl_tbf != NULL); @@ -205,7 +205,7 @@ GprsMs *ms; gprs_rlcmac_dl_tbf *dl_tbf; - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_ms_class(ms, ms_class); ms_set_egprs_ms_class(ms, egprs_ms_class); @@ -2346,7 +2346,7 @@ gprs_bssgp_init(bts, 4234, 4234, 1, 1, false, 0, 0, 0); /* Does no support EGPRS */ - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_ms_class(ms, ms_class); dl_tbf = dl_tbf_alloc(bts, ms, 0, false); @@ -2355,7 +2355,7 @@ /* EGPRS-only */ /* Does support EGPRS */ - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_ms_class(ms, ms_class); ms_set_egprs_ms_class(ms, ms_class); dl_tbf = dl_tbf_alloc(bts, ms, 0, false); @@ -2397,7 +2397,7 @@ /* EGPRS-only */ /* Does support EGPRS */ - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_ms_class(ms, ms_class); ms_set_egprs_ms_class(ms, ms_class); dl_tbf = dl_tbf_alloc(bts, ms, 0, true); @@ -2476,7 +2476,7 @@ trx0->pdch[2].enable(); trx0->pdch[3].enable(); - second_ms = bts_alloc_ms(bts); + second_ms = ms_alloc(bts); ms_set_tlli(second_ms, new_tlli); ul_tbf = ul_tbf_alloc(bts, second_ms, 0, true); OSMO_ASSERT(ul_tbf != NULL); @@ -3335,7 +3335,7 @@ int rc = 0; - ms = bts_alloc_ms(bts); + ms = ms_alloc(bts); ms_set_tlli(ms, tlli); ul_tbf = ms_new_ul_tbf_rejected_pacch(ms, pdch); diff --git a/tests/types/TypesTest.cpp b/tests/types/TypesTest.cpp index 94fc980..91b7ce4 100644 --- a/tests/types/TypesTest.cpp +++ b/tests/types/TypesTest.cpp @@ -688,7 +688,7 @@ the_pcu->alloc_algorithm = alloc_algorithm_a; bts->trx[0].pdch[4].enable(); - GprsMs *ms = bts_alloc_ms(bts); + GprsMs *ms = ms_alloc(bts); ms_set_ms_class(ms, 1); ms_set_egprs_ms_class(ms, 1); struct gprs_rlcmac_ul_tbf *tbf = ul_tbf_alloc(bts, ms, 0, true); @@ -781,7 +781,7 @@ the_pcu->alloc_algorithm = alloc_algorithm_a; bts->trx[0].pdch[2].enable(); bts->trx[0].pdch[3].enable(); - GprsMs *ms = bts_alloc_ms(bts); + GprsMs *ms = ms_alloc(bts); ms_set_ms_class(ms, 1); struct gprs_rlcmac_tbf *tbf = dl_tbf_alloc(bts, ms, 0, false); @@ -808,7 +808,7 @@ bts->trx[0].pdch[4].enable(); bts->trx[0].pdch[5].enable(); - GprsMs *ms = bts_alloc_ms(bts); + GprsMs *ms = ms_alloc(bts); ms_set_ms_class(ms, 1); struct gprs_rlcmac_tbf *tbf = ul_tbf_alloc(bts, ms, 0, false); static uint8_t res[] = { 0x06, @@ -851,7 +851,7 @@ bts->trx[0].pdch[1].enable(); bts->trx[0].pdch[2].enable(); - GprsMs *ms = bts_alloc_ms(bts); + GprsMs *ms = ms_alloc(bts); ms_set_ms_class(ms, 1); ms_set_egprs_ms_class(ms, 1); struct gprs_rlcmac_tbf *tbf = ul_tbf_alloc(bts, ms, 0, false); -- To view, visit https://gerrit.osmocom.org/c/osmo-pcu/+/32349 To unsubscribe, or for help writing mail filters, visit https://gerrit.osmocom.org/settings Gerrit-Project: osmo-pcu Gerrit-Branch: master Gerrit-Change-Id: I2a06d17588572a21dc5a14ddbde83766076b446d Gerrit-Change-Number: 32349 Gerrit-PatchSet: 1 Gerrit-Owner: pespin <pespin(a)sysmocom.de> Gerrit-MessageType: newchange

1 0

[L] Change in osmo-pcu[master]: ms: Use osmo_use_count to track references
by pespin 17 Apr '23

17 Apr '23

pespin has uploaded this change for review. ( https://gerrit.osmocom.org/c/osmo-pcu/+/32350 ) Change subject: ms: Use osmo_use_count to track references ...................................................................... ms: Use osmo_use_count to track references Change-Id: Ib65629224e6bd5683bb9192ba4354e965e8d39ec --- M src/gprs_ms.c M src/gprs_ms.h M src/pdch.cpp M src/tbf_ul_fsm.c M tests/alloc/AllocTest.cpp M tests/app_info/AppInfoTest.err M tests/ms/MsTest.err M tests/tbf/TbfTest.cpp M tests/tbf/TbfTest.err M tests/ulc/PdchUlcTest.err 10 files changed, 414 insertions(+), 45 deletions(-) git pull ssh://gerrit.osmocom.org:29418/osmo-pcu refs/changes/50/32350/1 diff --git a/src/gprs_ms.c b/src/gprs_ms.c index b9a1b76..f65ffb8 100644 --- a/src/gprs_ms.c +++ b/src/gprs_ms.c @@ -61,6 +61,40 @@ return (int64_t)(ts.tv_sec) * 1000 + ts.tv_nsec / 1000000; } +static void ms_update_status(struct GprsMs *ms); + +static int ms_use_cb(struct osmo_use_count_entry *e, int32_t old_use_count, const char *file, int line) +{ + struct GprsMs *ms = e->use_count->talloc_object; + int32_t total; + int level; + char buf[1024]; + + if (!e->use) + return -EINVAL; + + total = osmo_use_count_total(&ms->use_count); + + if (total == 0 + || (total == 1 && old_use_count == 0 && e->count == 1)) + level = LOGL_INFO; + else + level = LOGL_DEBUG; + + + LOGPSRC(DRLCMAC, level, file, line, "%s: %s %s: now used by %s\n", + ms_name(ms), + (e->count - old_use_count) > 0 ? "+" : "-", e->use, + (osmo_use_count_to_str_buf(buf, sizeof(buf), &ms->use_count), buf)); + + if (e->count < 0) + return -ERANGE; + + if (total == 0) + ms_update_status(ms); + return 0; +} + void gprs_default_cb_ms_idle(struct GprsMs *ms) { if (ms_is_idle(ms)) @@ -84,7 +118,7 @@ if (ms->timer.data) { ms->timer.data = NULL; - ms_unref(ms); + ms_unref(ms, MS_USE_RELEASE_TIMER); } } @@ -125,6 +159,11 @@ ms->is_idle = true; INIT_LLIST_HEAD(&ms->old_tbfs); + ms->use_count = (struct osmo_use_count){ + .talloc_object = ms, + .use_cb = ms_use_cb, + }; + int codel_interval = LLC_CODEL_USE_DEFAULT; LOGP(DRLCMAC, LOGL_INFO, "Creating MS object\n"); @@ -204,7 +243,7 @@ static void ms_update_status(struct GprsMs *ms) { - if (ms->ref > 0) + if (osmo_use_count_total(&ms->use_count) > 0) return; if (ms_is_idle(ms) && !ms->is_idle) { @@ -220,20 +259,6 @@ } } -struct GprsMs *ms_ref(struct GprsMs *ms) -{ - ms->ref += 1; - return ms; -} - -void ms_unref(struct GprsMs *ms) -{ - OSMO_ASSERT(ms->ref >= 0); - ms->ref -= 1; - if (ms->ref == 0) - ms_update_status(ms); -} - static void ms_release_timer_start(struct GprsMs *ms) { /* Immediate free(): @@ -252,8 +277,10 @@ LOGPMS(ms, DRLCMAC, LOGL_DEBUG, "Schedule MS release in %u secs\n", ms->delay); - if (!ms->timer.data) - ms->timer.data = ms_ref(ms); + if (!ms->timer.data) { + ms_ref(ms, MS_USE_RELEASE_TIMER); + ms->timer.data = ms; + } osmo_timer_schedule(&ms->timer, ms->delay, 0); } @@ -267,7 +294,7 @@ osmo_timer_del(&ms->timer); ms->timer.data = NULL; - ms_unref(ms); + ms_unref(ms, MS_USE_RELEASE_TIMER); } void ms_set_mode(struct GprsMs *ms, enum mcs_kind mode) @@ -328,7 +355,7 @@ LOGPMS(ms, DRLCMAC, LOGL_INFO, "Attaching UL TBF: %s\n", tbf_name((struct gprs_rlcmac_tbf *)tbf)); - ms_ref(ms); + ms_ref(ms, __func__); if (ms->ul_tbf) llist_add_tail(tbf_ms_list(ul_tbf_as_tbf(ms->ul_tbf)), &ms->old_tbfs); @@ -338,7 +365,7 @@ if (tbf) ms_release_timer_stop(ms); - ms_unref(ms); + ms_unref(ms, __func__); } static void ms_attach_dl_tbf(struct GprsMs *ms, struct gprs_rlcmac_dl_tbf *tbf) @@ -348,7 +375,7 @@ LOGPMS(ms, DRLCMAC, LOGL_INFO, "Attaching DL TBF: %s\n", tbf_name((struct gprs_rlcmac_tbf *)tbf)); - ms_ref(ms); + ms_ref(ms, __func__); if (ms->dl_tbf) llist_add_tail(tbf_ms_list(dl_tbf_as_tbf(ms->dl_tbf)), &ms->old_tbfs); @@ -358,7 +385,7 @@ if (tbf) ms_release_timer_stop(ms); - ms_unref(ms); + ms_unref(ms, __func__); } void ms_attach_tbf(struct GprsMs *ms, struct gprs_rlcmac_tbf *tbf) @@ -452,7 +479,7 @@ { char old_ms_name[128]; OSMO_ASSERT(old_ms != ms); - ms_ref(old_ms); + ms_ref(old_ms, __func__); ms_name_buf(old_ms, old_ms_name, sizeof(old_ms_name)); @@ -478,7 +505,7 @@ ms_reset(old_ms); - ms_unref(old_ms); + ms_unref(old_ms, __func__); } /* Apply changes to the TLLI directly, used interally by functions below: */ diff --git a/src/gprs_ms.h b/src/gprs_ms.h index d976235..123db0e 100644 --- a/src/gprs_ms.h +++ b/src/gprs_ms.h @@ -31,6 +31,7 @@ #include <osmocom/core/timer.h> #include <osmocom/core/linuxlist.h> #include <osmocom/core/rate_ctr.h> +#include <osmocom/core/use_count.h> #include <osmocom/gsm/protocol/gsm_23_003.h> #include <osmocom/gsm/gsm48.h> @@ -84,7 +85,7 @@ struct osmo_timer_list llc_timer; bool is_idle; - int ref; + struct osmo_use_count use_count; struct osmo_timer_list timer; unsigned delay; @@ -107,8 +108,6 @@ void ms_set_first_common_ts(struct GprsMs *ms, struct gprs_rlcmac_pdch *pdch); void ms_set_reserved_slots(struct GprsMs *ms, struct gprs_rlcmac_trx *trx, uint8_t ul_slots, uint8_t dl_slots); -struct GprsMs *ms_ref(struct GprsMs *ms); -void ms_unref(struct GprsMs *ms); void ms_set_mode(struct GprsMs *ms, enum mcs_kind mode); void ms_set_ms_class(struct GprsMs *ms, uint8_t ms_class_); void ms_set_egprs_ms_class(struct GprsMs *ms, uint8_t ms_class_); @@ -157,7 +156,9 @@ static inline bool ms_is_idle(const struct GprsMs *ms) { - return !ms->ul_tbf && !ms->dl_tbf && !ms->ref && llist_empty(&ms->old_tbfs); + return !ms->ul_tbf && !ms->dl_tbf && + llist_empty(&ms->old_tbfs) && + osmo_use_count_total(&ms->use_count) == 0; } static inline struct gprs_llc_queue *ms_llc_queue(struct GprsMs *ms) @@ -250,6 +251,12 @@ return ms->current_trx; } +#define MS_USE_RELEASE_TIMER "release_timer" +#define ms_ref(ms, use) \ + OSMO_ASSERT(osmo_use_count_get_put(&(ms)->use_count, use, 1) == 0) +#define ms_unref(ms, use) \ + OSMO_ASSERT(osmo_use_count_get_put(&(ms)->use_count, use, -1) == 0) + #define LOGPMS(ms, category, level, fmt, args...) \ LOGP(category, level, "%s " fmt, ms_name(ms), ## args) diff --git a/src/pdch.cpp b/src/pdch.cpp index 1c39ceb..4495e21 100644 --- a/src/pdch.cpp +++ b/src/pdch.cpp @@ -697,7 +697,7 @@ * temporarily, in order to avoid it being freed if we free any of its * resources (TBF). */ OSMO_ASSERT(ms); - ms_ref(ms); + ms_ref(ms, __func__); switch (item->type) { @@ -843,7 +843,7 @@ /* schedule uplink assignment */ osmo_fsm_inst_dispatch(new_ul_tbf->ul_ass_fsm.fi, TBF_UL_ASS_EV_SCHED_ASS, NULL); return_unref: - ms_unref(ms); + ms_unref(ms, __func__); return; } diff --git a/src/tbf_ul_fsm.c b/src/tbf_ul_fsm.c index a7d24ec..8778e32 100644 --- a/src/tbf_ul_fsm.c +++ b/src/tbf_ul_fsm.c @@ -227,7 +227,7 @@ /* Ref the MS, otherwise it may be freed after ul_tbf is * detached when sending event below. */ ms = tbf_ms(ctx->tbf); - ms_ref(ms); + ms_ref(ms, __func__); /* UL TBF ACKed our transmitted UL ACK/NACK with final Ack * Indicator set to '1'. We can free the TBF right away, the MS * also just released its TBF on its side. */ @@ -242,7 +242,7 @@ * now. */ if (!new_ul_tbf_requested && ms_need_dl_tbf(ms)) ms_new_dl_tbf_assigned_on_pch(ms); - ms_unref(ms); + ms_unref(ms, __func__); break; case TBF_EV_MAX_N3103: ctx->T_release = 3169; diff --git a/tests/alloc/AllocTest.cpp b/tests/alloc/AllocTest.cpp index cf1bba7..065a257 100644 --- a/tests/alloc/AllocTest.cpp +++ b/tests/alloc/AllocTest.cpp @@ -465,7 +465,7 @@ if (ms_current_trx(old_ms)) trx_no = ms_current_trx(old_ms)->trx_no; - ms_ref(old_ms); + ms_ref(old_ms, __func__); /* Allocate what is needed first */ switch (mode) { @@ -477,7 +477,7 @@ tbf = ul_tbf_alloc(bts, old_ms, trx_no, false); if (tbf == NULL) { OSMO_ASSERT(trx_no != -1 || bts_all_pdch_allocated(bts)); - ms_unref(old_ms); + ms_unref(old_ms, __func__); return NULL; } break; @@ -489,7 +489,7 @@ tbf = dl_tbf_alloc(bts, old_ms, trx_no, false); if (tbf == NULL) { OSMO_ASSERT(trx_no != -1 || bts_all_pdch_allocated(bts)); - ms_unref(old_ms); + ms_unref(old_ms, __func__); return NULL; } } @@ -499,7 +499,7 @@ OSMO_ASSERT(old_ms == tbf->ms()); ms = tbf->ms(); - ms_ref(ms); + ms_ref(ms, __func__); new_ms = ms; /* Continue with what is needed next */ switch (mode) { @@ -534,8 +534,8 @@ if (!new_ms && tbf) tbf_free(tbf); - ms_unref(old_ms); - ms_unref(ms); + ms_unref(old_ms, __func__); + ms_unref(ms, __func__); return new_ms; } diff --git a/tests/app_info/AppInfoTest.err b/tests/app_info/AppInfoTest.err index 50ebd45..e8c8acf 100644 --- a/tests/app_info/AppInfoTest.err +++ b/tests/app_info/AppInfoTest.err @@ -24,6 +24,8 @@ PDCH(bts=0,trx=0,ts=6) Attaching TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS), 1 TBFs, USFs = 00, TFIs = 00000001. PDCH(bts=0,trx=0,ts=7) Attaching TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS), 1 TBFs, USFs = 00, TFIs = 00000001. MS(TA-220:MSCLS-10-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-10-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-10-11:DL): - ms_attach_dl_tbf: now used by 0 (-) ws(64) Creating MS object Modifying MS object, TLLI = 0xffffffff, MS class 0 -> 12 @@ -34,6 +36,8 @@ PDCH(bts=0,trx=0,ts=5) Attaching TBF(DL:TFI-0-0-1:STATE-NEW:EGPRS), 2 TBFs, USFs = 00, TFIs = 00000003. PDCH(bts=0,trx=0,ts=6) Attaching TBF(DL:TFI-0-0-1:STATE-NEW:EGPRS), 2 TBFs, USFs = 00, TFIs = 00000003. MS(TA-220:MSCLS-12-13) Attaching DL TBF: TBF(DL:TFI-0-0-1:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-12-13): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-12-13:DL): - ms_attach_dl_tbf: now used by 0 (-) ws(64) --- test_sched_app_info_ok --- diff --git a/tests/ms/MsTest.err b/tests/ms/MsTest.err index d667740..3d271ae 100644 --- a/tests/ms/MsTest.err +++ b/tests/ms/MsTest.err @@ -1,22 +1,36 @@ Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddbb, not yet confirmed MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:STATE-NEW:GPRS:TLLI-0xffeeddbb) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL) Attaching DL TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL) Detaching TBF: TBF(UL:STATE-NEW:GPRS:TLLI-0xffeeddbb) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Detaching TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Destroying MS object Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddbb, not yet confirmed MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:STATE-NEW:GPRS:TLLI-0xffeeddbb) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL) Attaching DL TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL) Detaching TBF: TBF(UL:STATE-NEW:GPRS:TLLI-0xffeeddbb) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Detaching TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Destroying MS object Creating MS object The MS object cannot fully confirm an unexpected TLLI: 0xffeeddbb, partly confirmed MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Attaching DL TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL): - ms_attach_dl_tbf: now used by 0 (-) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL) Attaching DL TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL): - ms_attach_dl_tbf: now used by 0 (-) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL) Attaching UL TBF: TBF(UL:STATE-NEW:GPRS:TLLI-0xffeeddbb) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL:DL): - ms_attach_ul_tbf: now used by 0 (-) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL) Detaching TBF: TBF(UL:STATE-NEW:GPRS:TLLI-0xffeeddbb) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL) Detaching TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Detaching TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) @@ -45,22 +59,34 @@ Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddbc, not yet confirmed Modifying MS object, TLLI = 0xffeeddbc, IMSI '' -> '001001987654322' MS(IMSI-001001987654321:TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:STATE-NEW:GPRS:IMSI-001001987654321:TLLI-0xffeeddbb) +MS(IMSI-001001987654321:TLLI-0xffeeddbb:TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(IMSI-001001987654321:TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) MS(IMSI-001001987654321:TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Detaching TBF: TBF(UL:STATE-NEW:GPRS:IMSI-001001987654321:TLLI-0xffeeddbb) MS(IMSI-001001987654321:TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Destroying MS object MS(IMSI-001001987654322:TLLI-0xffeeddbc:TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:STATE-NEW:GPRS) +MS(IMSI-001001987654322:TLLI-0xffeeddbc:TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(IMSI-001001987654322:TLLI-0xffeeddbc:TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) MS(IMSI-001001987654322:TLLI-0xffeeddbc:TA-220:MSCLS-0-0) Detaching TBF: TBF(UL:STATE-NEW:GPRS) MS(IMSI-001001987654322:TLLI-0xffeeddbc:TA-220:MSCLS-0-0) Destroying MS object Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddbb, not yet confirmed MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:STATE-NEW:GPRS:TLLI-0xffeeddbb) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL) Attaching DL TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL) Detaching TBF: TBF(UL:STATE-NEW:GPRS:TLLI-0xffeeddbb) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Detaching TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0): + release_timer: now used by 1 (release_timer) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Release timer expired +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0): - release_timer: now used by 0 (-) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Destroying MS object Creating MS object The MS object cannot fully confirm an unexpected TLLI: 0xffeeddbb, partly confirmed MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Attaching DL TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL): - ms_attach_dl_tbf: now used by 0 (-) MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0:DL) Destroying MS object MS(TLLI-0xffeeddbb:TA-220:MSCLS-0-0) Detaching TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xffeeddbb) Creating MS object @@ -68,6 +94,8 @@ Creating MS object The MS object cannot fully confirm an unexpected TLLI: 0xdeadbef0, partly confirmed MS(TLLI-0xdeadbef0:TA-220:MSCLS-0-0) Attaching DL TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xdeadbef0) +MS(TLLI-0xdeadbef0:TA-220:MSCLS-0-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TLLI-0xdeadbef0:TA-220:MSCLS-0-0:DL): - ms_attach_dl_tbf: now used by 0 (-) MS(TLLI-0xdeadbeef:TA-220:MSCLS-0-0) Destroying MS object MS(TLLI-0xdeadbef0:TA-220:MSCLS-0-0:DL) Destroying MS object MS(TLLI-0xdeadbef0:TA-220:MSCLS-0-0) Detaching TBF: TBF(DL:STATE-NEW:GPRS:TLLI-0xdeadbef0) diff --git a/tests/tbf/TbfTest.cpp b/tests/tbf/TbfTest.cpp index 0f0960a..e67bd17 100644 --- a/tests/tbf/TbfTest.cpp +++ b/tests/tbf/TbfTest.cpp @@ -340,20 +340,20 @@ OSMO_ASSERT(new_tbf->tfi() == 1); check_tbf(dl_tbf); if (test_mode == TEST_MODE_REVERSE_FREE) { - ms_ref(ms); + ms_ref(ms, __func__); tbf_free(new_tbf); OSMO_ASSERT(ms_dl_tbf(ms) == NULL); check_tbf(dl_tbf); tbf_free(dl_tbf); - ms_unref(ms); + ms_unref(ms, __func__); } else { - ms_ref(ms); + ms_ref(ms, __func__); tbf_free(dl_tbf); OSMO_ASSERT(ms_dl_tbf(ms) == new_tbf); check_tbf(new_tbf); tbf_free(new_tbf); OSMO_ASSERT(ms_dl_tbf(ms) == NULL); - ms_unref(ms); + ms_unref(ms, __func__); } TALLOC_FREE(the_pcu); @@ -469,14 +469,14 @@ /* use the same IMSI on TBF 1 */ { - ms_ref(ms2); + ms_ref(ms2, __func__); ms_set_imsi(dl_tbf[1]->ms(), "001001000000002"); ms1 = bts_get_ms(bts, GSM_RESERVED_TMSI, GSM_RESERVED_TMSI, "001001000000002"); OSMO_ASSERT(ms1 != NULL); OSMO_ASSERT(ms1 != ms2); OSMO_ASSERT(strcmp(ms_imsi(ms1), "001001000000002") == 0); OSMO_ASSERT(strcmp(ms_imsi(ms2), "") == 0); - ms_unref(ms2); + ms_unref(ms2, __func__); } ms2 = bts_get_ms_by_tlli(bts, 0xf1000001, GSM_RESERVED_TMSI); diff --git a/tests/tbf/TbfTest.err b/tests/tbf/TbfTest.err index 73f2903..c65377a 100644 --- a/tests/tbf/TbfTest.err +++ b/tests/tbf/TbfTest.err @@ -22,6 +22,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=2) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 04, dl_slots = 04 MS(TA-220:MSCLS-0-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) +MS(TA-220:MSCLS-0-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-0-0:DL): - ms_attach_dl_tbf: now used by 0 (-) The MS object cannot fully confirm an unexpected TLLI: 0x00002342, partly confirmed Modifying MS object, TLLI = 0x00002342, TA 220 -> 4 MS(TLLI-0x00002342:TA-4:MSCLS-0-0:DL) ********** UL-TBF starts here ********** @@ -43,6 +45,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0x00002342) Setting Control TS PDCH(bts=0,trx=0,ts=2) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0x00002342) Allocated: trx = 0, ul_slots = 04, dl_slots = 00 MS(TLLI-0x00002342:TA-4:MSCLS-0-0:DL) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0x00002342) +MS(TLLI-0x00002342:TA-4:MSCLS-0-0:DL): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TLLI-0x00002342:TA-4:MSCLS-0-0:UL:DL): - ms_attach_ul_tbf: now used by 0 (-) Modifying MS object, TLLI: 0xffffffff -> 0x00002342, already confirmed partly The MS object cannot fully confirm an unexpected TLLI: 0x00004232, partly confirmed Modifying MS object, TLLI: 0x00002342 -> 0x00004232, already confirmed partly @@ -74,6 +78,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) +MS(TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){NONE}: Received Event SCHED_ASS DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){NONE}: state_chg to SEND_ASS @@ -141,6 +147,8 @@ TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0:DL) Attaching DL TBF: TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) +MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0:DL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) [DOWNLINK] START (PACCH) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) Send downlink assignment on PACCH, because TBF(DL:TFI-0-0-0:STATE-WAIT_RELEASE:GPRS:TLLI-0xffeeddcc) exists DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){WAIT_ACK}: Received Event SCHED_ASS @@ -149,6 +157,7 @@ TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) set ass. type PACCH [prev CCCH:0, PACCH:0] DL_TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc){NEW}: state_chg to ASSIGN TBF(DL:TFI-0-0-1:STATE-ASSIGN:GPRS:TLLI-0xffeeddcc) Starting timer X2001 [assignment (PACCH)] with 2 sec. 0 microsec +MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0:DL): + test_tbf_final_ack: now used by 1 (test_tbf_final_ack) TBF(DL:TFI-0-0-0:STATE-WAIT_RELEASE:GPRS:TLLI-0xffeeddcc) free PDCH(bts=0,trx=0,ts=4) Detaching TBF(DL:TFI-0-0-0:STATE-WAIT_RELEASE:GPRS:TLLI-0xffeeddcc), 2 TBFs, USFs = 00, TFIs = 00000003. MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0:DL) Detaching TBF: TBF(DL:TFI-0-0-0:STATE-WAIT_RELEASE:GPRS:TLLI-0xffeeddcc) @@ -163,6 +172,7 @@ DL_TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc){ASSIGN}: Deallocated UL_ASS_TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc){NONE}: Deallocated DL_ASS_TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc){NONE}: Deallocated +MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0): - test_tbf_final_ack: now used by 0 (-) MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0) Destroying MS object === end test_tbf_final_ack === === start test_tbf_final_ack === @@ -188,6 +198,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) +MS(TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){NONE}: Received Event SCHED_ASS DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){NONE}: state_chg to SEND_ASS @@ -255,6 +267,8 @@ TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0:DL) Attaching DL TBF: TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) +MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0:DL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) [DOWNLINK] START (PACCH) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) Send downlink assignment on PACCH, because TBF(DL:TFI-0-0-0:STATE-WAIT_RELEASE:GPRS:TLLI-0xffeeddcc) exists DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){WAIT_ACK}: Received Event SCHED_ASS @@ -263,6 +277,7 @@ TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc) set ass. type PACCH [prev CCCH:0, PACCH:0] DL_TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xffeeddcc){NEW}: state_chg to ASSIGN TBF(DL:TFI-0-0-1:STATE-ASSIGN:GPRS:TLLI-0xffeeddcc) Starting timer X2001 [assignment (PACCH)] with 2 sec. 0 microsec +MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0:DL): + test_tbf_final_ack: now used by 1 (test_tbf_final_ack) TBF(DL:TFI-0-0-1:STATE-ASSIGN:GPRS:TLLI-0xffeeddcc) free PDCH(bts=0,trx=0,ts=4) Detaching TBF(DL:TFI-0-0-1:STATE-ASSIGN:GPRS:TLLI-0xffeeddcc), 2 TBFs, USFs = 00, TFIs = 00000003. MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0) Detaching TBF: TBF(DL:TFI-0-0-1:STATE-ASSIGN:GPRS:TLLI-0xffeeddcc) @@ -277,6 +292,7 @@ DL_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){WAIT_RELEASE}: Deallocated UL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){NONE}: Deallocated DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){WAIT_ACK}: Deallocated +MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0): - test_tbf_final_ack: now used by 0 (-) MS(TLLI-0xffeeddcc:TA-0:MSCLS-45-0) Destroying MS object === end test_tbf_final_ack === === start test_tbf_delayed_release === @@ -302,6 +318,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) +MS(TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){NONE}: Received Event SCHED_ASS DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){NONE}: state_chg to SEND_ASS @@ -573,6 +591,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) +MS(TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){NONE}: Received Event SCHED_ASS DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS){NONE}: state_chg to SEND_ASS @@ -605,6 +625,8 @@ TBF(DL:TFI-0-0-1:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-1:STATE-NEW:GPRS) +MS(TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 DL_ASS_TBF(DL:TFI-0-0-1:STATE-NEW:GPRS){NONE}: Received Event SCHED_ASS DL_ASS_TBF(DL:TFI-0-0-1:STATE-NEW:GPRS){NONE}: state_chg to SEND_ASS @@ -620,8 +642,10 @@ The MS object cannot fully confirm an unexpected TLLI: 0xf1000002, partly confirmed Modifying MS object, TLLI = 0xf1000001, IMSI '' -> '001001000000001' Modifying MS object, TLLI = 0xf1000001, IMSI '001001000000001' -> '001001000000002' +MS(IMSI-001001000000002:TLLI-0xf1000001:TA-0:MSCLS-45-0:DL): + test_tbf_imsi: now used by 1 (test_tbf_imsi) Modifying MS object, TLLI = 0xf1000002, IMSI '' -> '001001000000002' MS(TLLI-0xf1000002:TA-0:MSCLS-45-0:DL) IMSI '001001000000002' was already assigned to another MS object: TLLI = 0xf1000001, that IMSI will be removed +MS(IMSI-001001000000002:TLLI-0xf1000001:TA-0:MSCLS-45-0:DL): + ms_merge_and_clear_ms: now used by 2 (test_tbf_imsi,ms_merge_and_clear_ms) MS(TLLI-0xf1000002:TA-0:MSCLS-45-0:DL) Merge MS: MS(IMSI-001001000000002:TLLI-0xf1000001:TA-0:MSCLS-45-0:DL) TBF(DL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-001001000000002:TLLI-0xf1000001) free PDCH(bts=0,trx=0,ts=4) Detaching TBF(DL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-001001000000002:TLLI-0xf1000001), 2 TBFs, USFs = 00, TFIs = 00000003. @@ -631,6 +655,8 @@ UL_ASS_TBF(DL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-001001000000002:TLLI-0xf1000001){NONE}: Deallocated DL_ASS_TBF(DL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-001001000000002:TLLI-0xf1000001){SEND_ASS}: Deallocated MS(IMSI-001001000000002:TLLI-0xf1000001:TA-0:MSCLS-45-0) Clearing MS object +MS(TA-0:MSCLS-45-0): - ms_merge_and_clear_ms: now used by 1 (test_tbf_imsi) +MS(TA-0:MSCLS-45-0): - test_tbf_imsi: now used by 0 (-) MS(TA-0:MSCLS-45-0) Destroying MS object TBF(DL:TFI-0-0-1:STATE-FLOW:GPRS:IMSI-001001000000002:TLLI-0xf1000002) free PDCH(bts=0,trx=0,ts=4) Detaching TBF(DL:TFI-0-0-1:STATE-FLOW:GPRS:IMSI-001001000000002:TLLI-0xf1000002), 1 TBFs, USFs = 00, TFIs = 00000002. @@ -666,6 +692,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000000:TLLI-0xc0000000) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000000:TLLI-0xc0000000) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000000:TLLI-0xc0000000:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000000:TLLI-0xc0000000) +MS(IMSI-001001000000000:TLLI-0xc0000000:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000000:TLLI-0xc0000000:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000000:TLLI-0xc0000000) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000000:TLLI-0xc0000000) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000000) DL_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000000:TLLI-0xc0000000){NEW}: Received Event ASSIGN_ADD_CCCH @@ -696,6 +724,8 @@ TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xc0000001) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xc0000001) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000001:TLLI-0xc0000001:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xc0000001) +MS(IMSI-001001000000001:TLLI-0xc0000001:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000001:TLLI-0xc0000001:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xc0000001) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xc0000001) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000001) DL_TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xc0000001){NEW}: Received Event ASSIGN_ADD_CCCH @@ -726,6 +756,8 @@ TBF(DL:TFI-0-0-2:STATE-NEW:GPRS:IMSI-001001000000002:TLLI-0xc0000002) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-2:STATE-NEW:GPRS:IMSI-001001000000002:TLLI-0xc0000002) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000002:TLLI-0xc0000002:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-2:STATE-NEW:GPRS:IMSI-001001000000002:TLLI-0xc0000002) +MS(IMSI-001001000000002:TLLI-0xc0000002:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000002:TLLI-0xc0000002:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-2:STATE-NEW:GPRS:IMSI-001001000000002:TLLI-0xc0000002) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-2:STATE-NEW:GPRS:IMSI-001001000000002:TLLI-0xc0000002) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000002) DL_TBF(DL:TFI-0-0-2:STATE-NEW:GPRS:IMSI-001001000000002:TLLI-0xc0000002){NEW}: Received Event ASSIGN_ADD_CCCH @@ -756,6 +788,8 @@ TBF(DL:TFI-0-0-3:STATE-NEW:GPRS:IMSI-001001000000003:TLLI-0xc0000003) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-3:STATE-NEW:GPRS:IMSI-001001000000003:TLLI-0xc0000003) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000003:TLLI-0xc0000003:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-3:STATE-NEW:GPRS:IMSI-001001000000003:TLLI-0xc0000003) +MS(IMSI-001001000000003:TLLI-0xc0000003:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000003:TLLI-0xc0000003:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-3:STATE-NEW:GPRS:IMSI-001001000000003:TLLI-0xc0000003) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-3:STATE-NEW:GPRS:IMSI-001001000000003:TLLI-0xc0000003) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000003) DL_TBF(DL:TFI-0-0-3:STATE-NEW:GPRS:IMSI-001001000000003:TLLI-0xc0000003){NEW}: Received Event ASSIGN_ADD_CCCH @@ -786,6 +820,8 @@ TBF(DL:TFI-0-0-4:STATE-NEW:GPRS:IMSI-001001000000004:TLLI-0xc0000004) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-4:STATE-NEW:GPRS:IMSI-001001000000004:TLLI-0xc0000004) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000004:TLLI-0xc0000004:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-4:STATE-NEW:GPRS:IMSI-001001000000004:TLLI-0xc0000004) +MS(IMSI-001001000000004:TLLI-0xc0000004:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000004:TLLI-0xc0000004:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-4:STATE-NEW:GPRS:IMSI-001001000000004:TLLI-0xc0000004) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-4:STATE-NEW:GPRS:IMSI-001001000000004:TLLI-0xc0000004) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000004) DL_TBF(DL:TFI-0-0-4:STATE-NEW:GPRS:IMSI-001001000000004:TLLI-0xc0000004){NEW}: Received Event ASSIGN_ADD_CCCH @@ -816,6 +852,8 @@ TBF(DL:TFI-0-0-5:STATE-NEW:GPRS:IMSI-001001000000005:TLLI-0xc0000005) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-5:STATE-NEW:GPRS:IMSI-001001000000005:TLLI-0xc0000005) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000005:TLLI-0xc0000005:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-5:STATE-NEW:GPRS:IMSI-001001000000005:TLLI-0xc0000005) +MS(IMSI-001001000000005:TLLI-0xc0000005:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000005:TLLI-0xc0000005:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-5:STATE-NEW:GPRS:IMSI-001001000000005:TLLI-0xc0000005) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-5:STATE-NEW:GPRS:IMSI-001001000000005:TLLI-0xc0000005) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000005) DL_TBF(DL:TFI-0-0-5:STATE-NEW:GPRS:IMSI-001001000000005:TLLI-0xc0000005){NEW}: Received Event ASSIGN_ADD_CCCH @@ -846,6 +884,8 @@ TBF(DL:TFI-0-0-6:STATE-NEW:GPRS:IMSI-001001000000006:TLLI-0xc0000006) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-6:STATE-NEW:GPRS:IMSI-001001000000006:TLLI-0xc0000006) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000006:TLLI-0xc0000006:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-6:STATE-NEW:GPRS:IMSI-001001000000006:TLLI-0xc0000006) +MS(IMSI-001001000000006:TLLI-0xc0000006:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000006:TLLI-0xc0000006:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-6:STATE-NEW:GPRS:IMSI-001001000000006:TLLI-0xc0000006) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-6:STATE-NEW:GPRS:IMSI-001001000000006:TLLI-0xc0000006) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000006) DL_TBF(DL:TFI-0-0-6:STATE-NEW:GPRS:IMSI-001001000000006:TLLI-0xc0000006){NEW}: Received Event ASSIGN_ADD_CCCH @@ -876,6 +916,8 @@ TBF(DL:TFI-0-0-7:STATE-NEW:GPRS:IMSI-001001000000007:TLLI-0xc0000007) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-7:STATE-NEW:GPRS:IMSI-001001000000007:TLLI-0xc0000007) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000007:TLLI-0xc0000007:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-7:STATE-NEW:GPRS:IMSI-001001000000007:TLLI-0xc0000007) +MS(IMSI-001001000000007:TLLI-0xc0000007:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000007:TLLI-0xc0000007:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-7:STATE-NEW:GPRS:IMSI-001001000000007:TLLI-0xc0000007) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-7:STATE-NEW:GPRS:IMSI-001001000000007:TLLI-0xc0000007) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000007) DL_TBF(DL:TFI-0-0-7:STATE-NEW:GPRS:IMSI-001001000000007:TLLI-0xc0000007){NEW}: Received Event ASSIGN_ADD_CCCH @@ -906,6 +948,8 @@ TBF(DL:TFI-0-0-8:STATE-NEW:GPRS:IMSI-001001000000008:TLLI-0xc0000008) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-8:STATE-NEW:GPRS:IMSI-001001000000008:TLLI-0xc0000008) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000008:TLLI-0xc0000008:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-8:STATE-NEW:GPRS:IMSI-001001000000008:TLLI-0xc0000008) +MS(IMSI-001001000000008:TLLI-0xc0000008:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000008:TLLI-0xc0000008:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-8:STATE-NEW:GPRS:IMSI-001001000000008:TLLI-0xc0000008) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-8:STATE-NEW:GPRS:IMSI-001001000000008:TLLI-0xc0000008) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000008) DL_TBF(DL:TFI-0-0-8:STATE-NEW:GPRS:IMSI-001001000000008:TLLI-0xc0000008){NEW}: Received Event ASSIGN_ADD_CCCH @@ -936,6 +980,8 @@ TBF(DL:TFI-0-0-9:STATE-NEW:GPRS:IMSI-001001000000009:TLLI-0xc0000009) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-9:STATE-NEW:GPRS:IMSI-001001000000009:TLLI-0xc0000009) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000009:TLLI-0xc0000009:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-9:STATE-NEW:GPRS:IMSI-001001000000009:TLLI-0xc0000009) +MS(IMSI-001001000000009:TLLI-0xc0000009:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000009:TLLI-0xc0000009:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-9:STATE-NEW:GPRS:IMSI-001001000000009:TLLI-0xc0000009) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-9:STATE-NEW:GPRS:IMSI-001001000000009:TLLI-0xc0000009) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000009) DL_TBF(DL:TFI-0-0-9:STATE-NEW:GPRS:IMSI-001001000000009:TLLI-0xc0000009){NEW}: Received Event ASSIGN_ADD_CCCH @@ -966,6 +1012,8 @@ TBF(DL:TFI-0-0-10:STATE-NEW:GPRS:IMSI-001001000000010:TLLI-0xc000000a) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-10:STATE-NEW:GPRS:IMSI-001001000000010:TLLI-0xc000000a) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000010:TLLI-0xc000000a:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-10:STATE-NEW:GPRS:IMSI-001001000000010:TLLI-0xc000000a) +MS(IMSI-001001000000010:TLLI-0xc000000a:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000010:TLLI-0xc000000a:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-10:STATE-NEW:GPRS:IMSI-001001000000010:TLLI-0xc000000a) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-10:STATE-NEW:GPRS:IMSI-001001000000010:TLLI-0xc000000a) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000010) DL_TBF(DL:TFI-0-0-10:STATE-NEW:GPRS:IMSI-001001000000010:TLLI-0xc000000a){NEW}: Received Event ASSIGN_ADD_CCCH @@ -996,6 +1044,8 @@ TBF(DL:TFI-0-0-11:STATE-NEW:GPRS:IMSI-001001000000011:TLLI-0xc000000b) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-11:STATE-NEW:GPRS:IMSI-001001000000011:TLLI-0xc000000b) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000011:TLLI-0xc000000b:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-11:STATE-NEW:GPRS:IMSI-001001000000011:TLLI-0xc000000b) +MS(IMSI-001001000000011:TLLI-0xc000000b:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000011:TLLI-0xc000000b:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-11:STATE-NEW:GPRS:IMSI-001001000000011:TLLI-0xc000000b) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-11:STATE-NEW:GPRS:IMSI-001001000000011:TLLI-0xc000000b) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000011) DL_TBF(DL:TFI-0-0-11:STATE-NEW:GPRS:IMSI-001001000000011:TLLI-0xc000000b){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1026,6 +1076,8 @@ TBF(DL:TFI-0-0-12:STATE-NEW:GPRS:IMSI-001001000000012:TLLI-0xc000000c) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-12:STATE-NEW:GPRS:IMSI-001001000000012:TLLI-0xc000000c) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000012:TLLI-0xc000000c:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-12:STATE-NEW:GPRS:IMSI-001001000000012:TLLI-0xc000000c) +MS(IMSI-001001000000012:TLLI-0xc000000c:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000012:TLLI-0xc000000c:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-12:STATE-NEW:GPRS:IMSI-001001000000012:TLLI-0xc000000c) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-12:STATE-NEW:GPRS:IMSI-001001000000012:TLLI-0xc000000c) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000012) DL_TBF(DL:TFI-0-0-12:STATE-NEW:GPRS:IMSI-001001000000012:TLLI-0xc000000c){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1056,6 +1108,8 @@ TBF(DL:TFI-0-0-13:STATE-NEW:GPRS:IMSI-001001000000013:TLLI-0xc000000d) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-13:STATE-NEW:GPRS:IMSI-001001000000013:TLLI-0xc000000d) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000013:TLLI-0xc000000d:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-13:STATE-NEW:GPRS:IMSI-001001000000013:TLLI-0xc000000d) +MS(IMSI-001001000000013:TLLI-0xc000000d:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000013:TLLI-0xc000000d:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-13:STATE-NEW:GPRS:IMSI-001001000000013:TLLI-0xc000000d) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-13:STATE-NEW:GPRS:IMSI-001001000000013:TLLI-0xc000000d) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000013) DL_TBF(DL:TFI-0-0-13:STATE-NEW:GPRS:IMSI-001001000000013:TLLI-0xc000000d){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1086,6 +1140,8 @@ TBF(DL:TFI-0-0-14:STATE-NEW:GPRS:IMSI-001001000000014:TLLI-0xc000000e) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-14:STATE-NEW:GPRS:IMSI-001001000000014:TLLI-0xc000000e) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000014:TLLI-0xc000000e:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-14:STATE-NEW:GPRS:IMSI-001001000000014:TLLI-0xc000000e) +MS(IMSI-001001000000014:TLLI-0xc000000e:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000014:TLLI-0xc000000e:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-14:STATE-NEW:GPRS:IMSI-001001000000014:TLLI-0xc000000e) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-14:STATE-NEW:GPRS:IMSI-001001000000014:TLLI-0xc000000e) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000014) DL_TBF(DL:TFI-0-0-14:STATE-NEW:GPRS:IMSI-001001000000014:TLLI-0xc000000e){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1116,6 +1172,8 @@ TBF(DL:TFI-0-0-15:STATE-NEW:GPRS:IMSI-001001000000015:TLLI-0xc000000f) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-15:STATE-NEW:GPRS:IMSI-001001000000015:TLLI-0xc000000f) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000015:TLLI-0xc000000f:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-15:STATE-NEW:GPRS:IMSI-001001000000015:TLLI-0xc000000f) +MS(IMSI-001001000000015:TLLI-0xc000000f:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000015:TLLI-0xc000000f:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-15:STATE-NEW:GPRS:IMSI-001001000000015:TLLI-0xc000000f) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-15:STATE-NEW:GPRS:IMSI-001001000000015:TLLI-0xc000000f) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000015) DL_TBF(DL:TFI-0-0-15:STATE-NEW:GPRS:IMSI-001001000000015:TLLI-0xc000000f){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1146,6 +1204,8 @@ TBF(DL:TFI-0-0-16:STATE-NEW:GPRS:IMSI-001001000000016:TLLI-0xc0000010) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-16:STATE-NEW:GPRS:IMSI-001001000000016:TLLI-0xc0000010) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000016:TLLI-0xc0000010:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-16:STATE-NEW:GPRS:IMSI-001001000000016:TLLI-0xc0000010) +MS(IMSI-001001000000016:TLLI-0xc0000010:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000016:TLLI-0xc0000010:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-16:STATE-NEW:GPRS:IMSI-001001000000016:TLLI-0xc0000010) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-16:STATE-NEW:GPRS:IMSI-001001000000016:TLLI-0xc0000010) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000016) DL_TBF(DL:TFI-0-0-16:STATE-NEW:GPRS:IMSI-001001000000016:TLLI-0xc0000010){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1176,6 +1236,8 @@ TBF(DL:TFI-0-0-17:STATE-NEW:GPRS:IMSI-001001000000017:TLLI-0xc0000011) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-17:STATE-NEW:GPRS:IMSI-001001000000017:TLLI-0xc0000011) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000017:TLLI-0xc0000011:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-17:STATE-NEW:GPRS:IMSI-001001000000017:TLLI-0xc0000011) +MS(IMSI-001001000000017:TLLI-0xc0000011:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000017:TLLI-0xc0000011:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-17:STATE-NEW:GPRS:IMSI-001001000000017:TLLI-0xc0000011) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-17:STATE-NEW:GPRS:IMSI-001001000000017:TLLI-0xc0000011) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000017) DL_TBF(DL:TFI-0-0-17:STATE-NEW:GPRS:IMSI-001001000000017:TLLI-0xc0000011){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1206,6 +1268,8 @@ TBF(DL:TFI-0-0-18:STATE-NEW:GPRS:IMSI-001001000000018:TLLI-0xc0000012) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-18:STATE-NEW:GPRS:IMSI-001001000000018:TLLI-0xc0000012) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000018:TLLI-0xc0000012:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-18:STATE-NEW:GPRS:IMSI-001001000000018:TLLI-0xc0000012) +MS(IMSI-001001000000018:TLLI-0xc0000012:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000018:TLLI-0xc0000012:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-18:STATE-NEW:GPRS:IMSI-001001000000018:TLLI-0xc0000012) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-18:STATE-NEW:GPRS:IMSI-001001000000018:TLLI-0xc0000012) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000018) DL_TBF(DL:TFI-0-0-18:STATE-NEW:GPRS:IMSI-001001000000018:TLLI-0xc0000012){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1236,6 +1300,8 @@ TBF(DL:TFI-0-0-19:STATE-NEW:GPRS:IMSI-001001000000019:TLLI-0xc0000013) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-19:STATE-NEW:GPRS:IMSI-001001000000019:TLLI-0xc0000013) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000019:TLLI-0xc0000013:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-19:STATE-NEW:GPRS:IMSI-001001000000019:TLLI-0xc0000013) +MS(IMSI-001001000000019:TLLI-0xc0000013:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000019:TLLI-0xc0000013:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-19:STATE-NEW:GPRS:IMSI-001001000000019:TLLI-0xc0000013) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-19:STATE-NEW:GPRS:IMSI-001001000000019:TLLI-0xc0000013) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000019) DL_TBF(DL:TFI-0-0-19:STATE-NEW:GPRS:IMSI-001001000000019:TLLI-0xc0000013){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1266,6 +1332,8 @@ TBF(DL:TFI-0-0-20:STATE-NEW:GPRS:IMSI-001001000000020:TLLI-0xc0000014) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-20:STATE-NEW:GPRS:IMSI-001001000000020:TLLI-0xc0000014) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000020:TLLI-0xc0000014:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-20:STATE-NEW:GPRS:IMSI-001001000000020:TLLI-0xc0000014) +MS(IMSI-001001000000020:TLLI-0xc0000014:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000020:TLLI-0xc0000014:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-20:STATE-NEW:GPRS:IMSI-001001000000020:TLLI-0xc0000014) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-20:STATE-NEW:GPRS:IMSI-001001000000020:TLLI-0xc0000014) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000020) DL_TBF(DL:TFI-0-0-20:STATE-NEW:GPRS:IMSI-001001000000020:TLLI-0xc0000014){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1296,6 +1364,8 @@ TBF(DL:TFI-0-0-21:STATE-NEW:GPRS:IMSI-001001000000021:TLLI-0xc0000015) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-21:STATE-NEW:GPRS:IMSI-001001000000021:TLLI-0xc0000015) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000021:TLLI-0xc0000015:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-21:STATE-NEW:GPRS:IMSI-001001000000021:TLLI-0xc0000015) +MS(IMSI-001001000000021:TLLI-0xc0000015:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000021:TLLI-0xc0000015:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-21:STATE-NEW:GPRS:IMSI-001001000000021:TLLI-0xc0000015) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-21:STATE-NEW:GPRS:IMSI-001001000000021:TLLI-0xc0000015) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000021) DL_TBF(DL:TFI-0-0-21:STATE-NEW:GPRS:IMSI-001001000000021:TLLI-0xc0000015){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1326,6 +1396,8 @@ TBF(DL:TFI-0-0-22:STATE-NEW:GPRS:IMSI-001001000000022:TLLI-0xc0000016) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-22:STATE-NEW:GPRS:IMSI-001001000000022:TLLI-0xc0000016) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000022:TLLI-0xc0000016:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-22:STATE-NEW:GPRS:IMSI-001001000000022:TLLI-0xc0000016) +MS(IMSI-001001000000022:TLLI-0xc0000016:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000022:TLLI-0xc0000016:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-22:STATE-NEW:GPRS:IMSI-001001000000022:TLLI-0xc0000016) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-22:STATE-NEW:GPRS:IMSI-001001000000022:TLLI-0xc0000016) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000022) DL_TBF(DL:TFI-0-0-22:STATE-NEW:GPRS:IMSI-001001000000022:TLLI-0xc0000016){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1356,6 +1428,8 @@ TBF(DL:TFI-0-0-23:STATE-NEW:GPRS:IMSI-001001000000023:TLLI-0xc0000017) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-23:STATE-NEW:GPRS:IMSI-001001000000023:TLLI-0xc0000017) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000023:TLLI-0xc0000017:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-23:STATE-NEW:GPRS:IMSI-001001000000023:TLLI-0xc0000017) +MS(IMSI-001001000000023:TLLI-0xc0000017:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000023:TLLI-0xc0000017:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-23:STATE-NEW:GPRS:IMSI-001001000000023:TLLI-0xc0000017) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-23:STATE-NEW:GPRS:IMSI-001001000000023:TLLI-0xc0000017) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000023) DL_TBF(DL:TFI-0-0-23:STATE-NEW:GPRS:IMSI-001001000000023:TLLI-0xc0000017){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1386,6 +1460,8 @@ TBF(DL:TFI-0-0-24:STATE-NEW:GPRS:IMSI-001001000000024:TLLI-0xc0000018) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-24:STATE-NEW:GPRS:IMSI-001001000000024:TLLI-0xc0000018) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000024:TLLI-0xc0000018:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-24:STATE-NEW:GPRS:IMSI-001001000000024:TLLI-0xc0000018) +MS(IMSI-001001000000024:TLLI-0xc0000018:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000024:TLLI-0xc0000018:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-24:STATE-NEW:GPRS:IMSI-001001000000024:TLLI-0xc0000018) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-24:STATE-NEW:GPRS:IMSI-001001000000024:TLLI-0xc0000018) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000024) DL_TBF(DL:TFI-0-0-24:STATE-NEW:GPRS:IMSI-001001000000024:TLLI-0xc0000018){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1416,6 +1492,8 @@ TBF(DL:TFI-0-0-25:STATE-NEW:GPRS:IMSI-001001000000025:TLLI-0xc0000019) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-25:STATE-NEW:GPRS:IMSI-001001000000025:TLLI-0xc0000019) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000025:TLLI-0xc0000019:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-25:STATE-NEW:GPRS:IMSI-001001000000025:TLLI-0xc0000019) +MS(IMSI-001001000000025:TLLI-0xc0000019:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000025:TLLI-0xc0000019:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-25:STATE-NEW:GPRS:IMSI-001001000000025:TLLI-0xc0000019) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-25:STATE-NEW:GPRS:IMSI-001001000000025:TLLI-0xc0000019) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000025) DL_TBF(DL:TFI-0-0-25:STATE-NEW:GPRS:IMSI-001001000000025:TLLI-0xc0000019){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1446,6 +1524,8 @@ TBF(DL:TFI-0-0-26:STATE-NEW:GPRS:IMSI-001001000000026:TLLI-0xc000001a) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-26:STATE-NEW:GPRS:IMSI-001001000000026:TLLI-0xc000001a) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000026:TLLI-0xc000001a:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-26:STATE-NEW:GPRS:IMSI-001001000000026:TLLI-0xc000001a) +MS(IMSI-001001000000026:TLLI-0xc000001a:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000026:TLLI-0xc000001a:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-26:STATE-NEW:GPRS:IMSI-001001000000026:TLLI-0xc000001a) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-26:STATE-NEW:GPRS:IMSI-001001000000026:TLLI-0xc000001a) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000026) DL_TBF(DL:TFI-0-0-26:STATE-NEW:GPRS:IMSI-001001000000026:TLLI-0xc000001a){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1476,6 +1556,8 @@ TBF(DL:TFI-0-0-27:STATE-NEW:GPRS:IMSI-001001000000027:TLLI-0xc000001b) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-27:STATE-NEW:GPRS:IMSI-001001000000027:TLLI-0xc000001b) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000027:TLLI-0xc000001b:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-27:STATE-NEW:GPRS:IMSI-001001000000027:TLLI-0xc000001b) +MS(IMSI-001001000000027:TLLI-0xc000001b:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000027:TLLI-0xc000001b:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-27:STATE-NEW:GPRS:IMSI-001001000000027:TLLI-0xc000001b) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-27:STATE-NEW:GPRS:IMSI-001001000000027:TLLI-0xc000001b) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000027) DL_TBF(DL:TFI-0-0-27:STATE-NEW:GPRS:IMSI-001001000000027:TLLI-0xc000001b){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1506,6 +1588,8 @@ TBF(DL:TFI-0-0-28:STATE-NEW:GPRS:IMSI-001001000000028:TLLI-0xc000001c) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-28:STATE-NEW:GPRS:IMSI-001001000000028:TLLI-0xc000001c) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000028:TLLI-0xc000001c:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-28:STATE-NEW:GPRS:IMSI-001001000000028:TLLI-0xc000001c) +MS(IMSI-001001000000028:TLLI-0xc000001c:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000028:TLLI-0xc000001c:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-28:STATE-NEW:GPRS:IMSI-001001000000028:TLLI-0xc000001c) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-28:STATE-NEW:GPRS:IMSI-001001000000028:TLLI-0xc000001c) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000028) DL_TBF(DL:TFI-0-0-28:STATE-NEW:GPRS:IMSI-001001000000028:TLLI-0xc000001c){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1536,6 +1620,8 @@ TBF(DL:TFI-0-0-29:STATE-NEW:GPRS:IMSI-001001000000029:TLLI-0xc000001d) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-29:STATE-NEW:GPRS:IMSI-001001000000029:TLLI-0xc000001d) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000029:TLLI-0xc000001d:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-29:STATE-NEW:GPRS:IMSI-001001000000029:TLLI-0xc000001d) +MS(IMSI-001001000000029:TLLI-0xc000001d:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000029:TLLI-0xc000001d:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-29:STATE-NEW:GPRS:IMSI-001001000000029:TLLI-0xc000001d) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-29:STATE-NEW:GPRS:IMSI-001001000000029:TLLI-0xc000001d) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000029) DL_TBF(DL:TFI-0-0-29:STATE-NEW:GPRS:IMSI-001001000000029:TLLI-0xc000001d){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1566,6 +1652,8 @@ TBF(DL:TFI-0-0-30:STATE-NEW:GPRS:IMSI-001001000000030:TLLI-0xc000001e) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-30:STATE-NEW:GPRS:IMSI-001001000000030:TLLI-0xc000001e) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000030:TLLI-0xc000001e:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-30:STATE-NEW:GPRS:IMSI-001001000000030:TLLI-0xc000001e) +MS(IMSI-001001000000030:TLLI-0xc000001e:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000030:TLLI-0xc000001e:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-30:STATE-NEW:GPRS:IMSI-001001000000030:TLLI-0xc000001e) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-30:STATE-NEW:GPRS:IMSI-001001000000030:TLLI-0xc000001e) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000030) DL_TBF(DL:TFI-0-0-30:STATE-NEW:GPRS:IMSI-001001000000030:TLLI-0xc000001e){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1596,6 +1684,8 @@ TBF(DL:TFI-0-0-31:STATE-NEW:GPRS:IMSI-001001000000031:TLLI-0xc000001f) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-31:STATE-NEW:GPRS:IMSI-001001000000031:TLLI-0xc000001f) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000000031:TLLI-0xc000001f:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-31:STATE-NEW:GPRS:IMSI-001001000000031:TLLI-0xc000001f) +MS(IMSI-001001000000031:TLLI-0xc000001f:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000031:TLLI-0xc000001f:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-31:STATE-NEW:GPRS:IMSI-001001000000031:TLLI-0xc000001f) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-31:STATE-NEW:GPRS:IMSI-001001000000031:TLLI-0xc000001f) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000031) DL_TBF(DL:TFI-0-0-31:STATE-NEW:GPRS:IMSI-001001000000031:TLLI-0xc000001f){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1711,6 +1801,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000123456:TLLI-0xc0123456:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456) +MS(IMSI-001001000123456:TLLI-0xc0123456:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000123456:TLLI-0xc0123456:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456) Send downlink assignment on PCH, no TBF exist (IMSI=001001000123456) DL_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1724,6 +1816,7 @@ PDCH(bts=0,trx=0,ts=4) Detaching TBF(DL:TFI-0-0-0:STATE-ASSIGN:GPRS:IMSI-001001000123456:TLLI-0xc0123456), 1 TBFs, USFs = 00, TFIs = 00000001. MS(IMSI-001001000123456:TLLI-0xc0123456:TA-0:MSCLS-45-0) Detaching TBF: TBF(DL:TFI-0-0-0:STATE-ASSIGN:GPRS:IMSI-001001000123456:TLLI-0xc0123456) MS(IMSI-001001000123456:TLLI-0xc0123456:TA-0:MSCLS-45-0) Schedule MS release in 10 secs +MS(IMSI-001001000123456:TLLI-0xc0123456:TA-0:MSCLS-45-0): + release_timer: now used by 1 (release_timer) ********** DL-TBF ends here ********** DL_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456){ASSIGN}: Deallocated UL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456){NONE}: Deallocated @@ -1747,7 +1840,10 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001000123456:TLLI-0xc0123456:TA-0:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456) +MS(IMSI-001001000123456:TLLI-0xc0123456:TA-0:MSCLS-45-0): + ms_attach_dl_tbf: now used by 2 (release_timer,ms_attach_dl_tbf) MS(IMSI-001001000123456:TLLI-0xc0123456:TA-0:MSCLS-45-0:DL) Cancel scheduled MS release +MS(IMSI-001001000123456:TLLI-0xc0123456:TA-0:MSCLS-45-0:DL): - release_timer: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000123456:TLLI-0xc0123456:TA-0:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456) Send downlink assignment on PCH, no TBF exist (IMSI=001001000123456) DL_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000123456:TLLI-0xc0123456){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1826,6 +1922,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) +MS(TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS){NEW}: Received Event ASSIGN_ADD_CCCH TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) set ass. type CCCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS){NEW}: state_chg to FLOW @@ -1888,6 +1986,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) +MS(TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS){NEW}: Received Event ASSIGN_ADD_CCCH TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) set ass. type CCCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS){NEW}: state_chg to FLOW @@ -1937,6 +2037,7 @@ UL_ACK_TBF(UL:TFI-0-0-0:STATE-FINISHED:GPRS:IMSI-0011223344:TLLI-0xf1223344){WAIT_ACK}: Received Event RX_CTRL_ACK UL_ACK_TBF(UL:TFI-0-0-0:STATE-FINISHED:GPRS:IMSI-0011223344:TLLI-0xf1223344){WAIT_ACK}: state_chg to NONE UL_TBF(UL:TFI-0-0-0:STATE-FINISHED:GPRS:IMSI-0011223344:TLLI-0xf1223344){FINISHED}: Received Event FINAL_UL_ACK_CONFIRMED +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-0-0:UL): + st_finished: now used by 1 (st_finished) TBF(UL:TFI-0-0-0:STATE-FINISHED:GPRS:IMSI-0011223344:TLLI-0xf1223344) [UPLINK] END TBF(UL:TFI-0-0-0:STATE-FINISHED:GPRS:IMSI-0011223344:TLLI-0xf1223344) free PDCH(bts=0,trx=0,ts=7) Detaching TBF(UL:TFI-0-0-0:STATE-FINISHED:GPRS:IMSI-0011223344:TLLI-0xf1223344), 1 TBFs, USFs = 01, TFIs = 00000001. @@ -1964,6 +2065,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-0-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-0-0): + ms_attach_dl_tbf: now used by 2 (st_finished,ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-0-0:DL): - ms_attach_dl_tbf: now used by 1 (st_finished) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Send downlink assignment on PCH, no TBF exist (IMSI=0011223344) DL_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_CCCH @@ -1971,6 +2074,7 @@ DL_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NEW}: state_chg to ASSIGN TBF(DL:TFI-0-0-0:STATE-ASSIGN:GPRS:IMSI-0011223344:TLLI-0xf1223344) TX: START Immediate Assignment Downlink (PCH) - TRX=0 (0) TS=7 TA=7 +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-0-0:DL): - st_finished: now used by 0 (-) === end test_tbf_single_phase2 === MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-0-0:DL) Destroying MS object MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-0-0) Detaching TBF: TBF(DL:TFI-0-0-0:STATE-ASSIGN:GPRS:IMSI-0011223344:TLLI-0xf1223344) @@ -1987,6 +2091,7 @@ PDCH(bts=0,trx=0,ts=7) FN=2654270 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xf1223344, not yet confirmed +MS(TLLI-0xf1223344:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654270 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xf1223344, TA 220 -> 7 Modifying MS object, TLLI = 0xf1223344, MS class 0 -> 1 @@ -2009,6 +2114,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xf1223344:TA-7:MSCLS-1-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_PACCH TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) set ass. type PACCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NEW}: state_chg to ASSIGN @@ -2016,6 +2123,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:TLLI-0xf1223344) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NONE}: state_chg to SEND_ASS +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654270 + 13 = 2654283 TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:TLLI-0xf1223344) start Packet Uplink Assignment (PACCH) @@ -2067,6 +2175,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Send downlink assignment on PACCH, because TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344) exists DL_ASS_TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS @@ -2092,6 +2202,7 @@ PDCH(bts=0,trx=0,ts=7) FN=2654270 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xf1223344, not yet confirmed +MS(TLLI-0xf1223344:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654270 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xf1223344, TA 220 -> 7 Modifying MS object, TLLI = 0xf1223344, MS class 0 -> 1 @@ -2114,6 +2225,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xf1223344:TA-7:MSCLS-1-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_PACCH TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) set ass. type PACCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NEW}: state_chg to ASSIGN @@ -2121,6 +2234,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:TLLI-0xf1223344) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NONE}: state_chg to SEND_ASS +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654270 + 13 = 2654283 TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:TLLI-0xf1223344) start Packet Uplink Assignment (PACCH) @@ -2171,6 +2285,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Send downlink assignment on PACCH, because TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344) exists DL_ASS_TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS @@ -2265,6 +2381,7 @@ PDCH(bts=0,trx=0,ts=7) FN=2654348 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xf5667788, not yet confirmed +MS(TLLI-0xf5667788:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654348 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xf5667788, TA 220 -> 7 Modifying MS object, TLLI = 0xf5667788, MS class 0 -> 1 @@ -2287,6 +2404,8 @@ TBF(UL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xf5667788) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xf5667788) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xf5667788:TA-7:MSCLS-1-0) Attaching UL TBF: TBF(UL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xf5667788) +MS(TLLI-0xf5667788:TA-7:MSCLS-1-0): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xf5667788:TA-7:MSCLS-1-0:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) UL_TBF(UL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xf5667788){NEW}: Received Event ASSIGN_ADD_PACCH TBF(UL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xf5667788) set ass. type PACCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xf5667788){NEW}: state_chg to ASSIGN @@ -2294,6 +2413,7 @@ TBF(UL:TFI-0-0-1:STATE-ASSIGN:GPRS:TLLI-0xf5667788) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xf5667788){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-1:STATE-NEW:GPRS:TLLI-0xf5667788){NONE}: state_chg to SEND_ASS +MS(TLLI-0xf5667788:TA-7:MSCLS-1-0:UL): - rcv_resource_request: now used by 0 (-) PDCH(bts=0,trx=0,ts=7) Expiring FN=2654348 but previous FN=2654301 is still reserved! PDCH(bts=0,trx=0,ts=7) Timeout for registered USF (FN=2654301): TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344) TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344) N3101 2 => 3 (< MAX 10) @@ -2338,6 +2458,7 @@ TBF(UL:TFI-0-0-1:STATE-FLOW:GPRS:TLLI-0xf5667788) No gaps in received block, last block: BSN=0 CV=15 Old MS: TLLI = 0xf1223344, TA = 7, IMSI = 0011223344, LLC = 0 There is a new MS object for the same MS: (0xf1223344, '0011223344') -> (0xf5667788, '') +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL:DL): + ms_merge_and_clear_ms: now used by 1 (ms_merge_and_clear_ms) MS(TLLI-0xf5667788:TA-7:MSCLS-1-0:UL) Merge MS: MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL:DL) TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344) free PDCH(bts=0,trx=0,ts=7) Detaching TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344), 2 TBFs, USFs = 03, TFIs = 00000003. @@ -2348,6 +2469,7 @@ UL_ASS_TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Deallocated DL_ASS_TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Deallocated MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:DL) Clearing MS object +MS(TA-7:MSCLS-1-0:DL): - ms_merge_and_clear_ms: now used by 0 (-) Modifying MS object, TLLI: 0xf5667788 confirmed MS(IMSI-0011223344:TLLI-0xf5667788:TA-7:MSCLS-1-0:UL) appending 4 bytes to DL LLC queue MS(IMSI-0011223344:TLLI-0xf5667788:TA-7:MSCLS-1-0:UL) ********** DL-TBF starts here ********** @@ -2368,6 +2490,8 @@ TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf5667788) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf5667788) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf5667788:TA-7:MSCLS-1-0:UL) Attaching DL TBF: TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf5667788) +MS(IMSI-0011223344:TLLI-0xf5667788:TA-7:MSCLS-1-0:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf5667788:TA-7:MSCLS-1-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf5667788) [DOWNLINK] START (PACCH) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf5667788) Send downlink assignment on PACCH, because TBF(UL:TFI-0-0-1:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf5667788) exists DL_ASS_TBF(UL:TFI-0-0-1:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf5667788){NONE}: Received Event SCHED_ASS @@ -2396,6 +2520,7 @@ PDCH(bts=0,trx=0,ts=7) FN=2654270 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xf1223344, not yet confirmed +MS(TLLI-0xf1223344:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654270 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xf1223344, TA 220 -> 7 Modifying MS object, TLLI = 0xf1223344, MS class 0 -> 1 @@ -2419,6 +2544,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xf1223344:TA-7:MSCLS-1-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_PACCH TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) set ass. type PACCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NEW}: state_chg to ASSIGN @@ -2426,6 +2553,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:TLLI-0xf1223344) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NONE}: state_chg to SEND_ASS +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654270 + 13 = 2654283 TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:TLLI-0xf1223344) start Packet Uplink Assignment (PACCH) @@ -2477,6 +2605,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Send downlink assignment on PACCH, because TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344) exists DL_ASS_TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS @@ -2504,6 +2634,7 @@ Detected FN jump! 2654275 -> 2654327 (expected 2654279, delta 52) PDCH(bts=0,trx=0,ts=7) FN=2654327 +++++++++++++++++++++++++ RX : Uplink Control Block +++++++++++++++++++++++++ PDCH(bts=0,trx=0,ts=7) FN=2654327 ------------------------- RX : Uplink Control Block ------------------------- +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:DL): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654327 PKT RESOURCE REQ: MS requests UL TBF throguh SBA TBF(DL:TFI-0-0-0:STATE-ASSIGN:GPRS:IMSI-0011223344:TLLI-0xf1223344) Got PACKET RESOURCE REQ while DL-TBF pending, killing it TBF(DL:TFI-0-0-0:STATE-ASSIGN:GPRS:IMSI-0011223344:TLLI-0xf1223344) free @@ -2532,6 +2663,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_PACCH TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) set ass. type PACCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NEW}: state_chg to ASSIGN @@ -2539,6 +2672,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:IMSI-0011223344:TLLI-0xf1223344) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: state_chg to SEND_ASS +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654327 + 13 = 2654340 TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:IMSI-0011223344:TLLI-0xf1223344) start Packet Uplink Assignment (PACCH) @@ -2575,6 +2709,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Send downlink assignment on PACCH, because TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344) exists DL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS @@ -2611,6 +2747,7 @@ PDCH(bts=0,trx=0,ts=7) FN=2654270 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xf1223344, not yet confirmed +MS(TLLI-0xf1223344:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654270 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xf1223344, TA 220 -> 7 Modifying MS object, TLLI = 0xf1223344, MS class 0 -> 1 @@ -2634,6 +2771,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xf1223344:TA-7:MSCLS-1-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_PACCH TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) set ass. type PACCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NEW}: state_chg to ASSIGN @@ -2641,6 +2780,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:TLLI-0xf1223344) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NONE}: state_chg to SEND_ASS +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654270 + 13 = 2654283 TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:TLLI-0xf1223344) start Packet Uplink Assignment (PACCH) @@ -2692,6 +2832,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Send downlink assignment on PACCH, because TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344) exists DL_ASS_TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS @@ -2733,6 +2875,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) +MS(TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS){NEW}: Received Event ASSIGN_ADD_CCCH TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) set ass. type CCCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS){NEW}: state_chg to FLOW @@ -2748,6 +2892,7 @@ TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS) data_length=20, data=f1 22 33 44 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS) Decoded premier TLLI=0xf1223344 of UL DATA TFI=0. Modifying MS object, UL TLLI: 0xffffffff -> 0xf1223344, not yet confirmed +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:DL): + ms_merge_and_clear_ms: now used by 1 (ms_merge_and_clear_ms) MS(TLLI-0xf1223344:TA-7:MSCLS-0-0:UL) Merge MS: MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:DL) Modifying MS object, TLLI = 0xf1223344, MS class 0 -> 1 TBF(DL:TFI-0-0-0:STATE-ASSIGN:GPRS:IMSI-0011223344:TLLI-0xf1223344) free @@ -2758,6 +2903,7 @@ UL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Deallocated DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Deallocated MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0) Clearing MS object +MS(TA-7:MSCLS-1-0): - ms_merge_and_clear_ms: now used by 0 (-) MS(TA-7:MSCLS-1-0) Destroying MS object UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS){FLOW}: Received Event FIRST_UL_DATA_RECVD TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Assembling frames: (len=20) @@ -2790,6 +2936,7 @@ PDCH(bts=0,trx=0,ts=7) FN=2654270 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xf1223344, not yet confirmed +MS(TLLI-0xf1223344:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654270 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xf1223344, TA 220 -> 7 Modifying MS object, TLLI = 0xf1223344, MS class 0 -> 1 @@ -2813,6 +2960,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xf1223344:TA-7:MSCLS-1-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_PACCH TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344) set ass. type PACCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NEW}: state_chg to ASSIGN @@ -2820,6 +2969,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:TLLI-0xf1223344) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){NONE}: state_chg to SEND_ASS +MS(TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xf1223344){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654270 + 13 = 2654283 TBF(UL:TFI-0-0-0:STATE-ASSIGN:GPRS:TLLI-0xf1223344) start Packet Uplink Assignment (PACCH) @@ -2871,6 +3021,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Send downlink assignment on PACCH, because TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344) exists DL_ASS_TBF(UL:TFI-0-0-0:STATE-FLOW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS @@ -3627,6 +3779,8 @@ TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL:DL) Attaching DL TBF: TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL:DL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) TBF(DL:TFI-0-0-1:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344) Send downlink assignment on PACCH, because TBF(DL:TFI-0-0-0:STATE-WAIT_RELEASE:GPRS:IMSI-0011223344:TLLI-0xf1223344) exists DL_ASS_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-0011223344:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS @@ -3896,6 +4050,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001123456789:TLLI-0xc0006789) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001123456789:TLLI-0xc0006789) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(IMSI-001001123456789:TLLI-0xc0006789:TA-220:MSCLS-45-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001123456789:TLLI-0xc0006789) +MS(IMSI-001001123456789:TLLI-0xc0006789:TA-220:MSCLS-45-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001123456789:TLLI-0xc0006789:TA-220:MSCLS-45-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001123456789:TLLI-0xc0006789) [DOWNLINK] START (PCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001123456789:TLLI-0xc0006789) Send downlink assignment on PCH, no TBF exist (IMSI=001001123456789) DL_TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001123456789:TLLI-0xc0006789){NEW}: Received Event ASSIGN_ADD_CCCH @@ -3941,6 +4097,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 3c MS(TA-220:MSCLS-12-0) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) +MS(TA-220:MSCLS-12-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-12-0:DL): - ms_attach_dl_tbf: now used by 0 (-) DL TBF slots: 0x3c, N: 4, WS: 64 TBF(DL:TFI-0-0-0:STATE-NEW:GPRS) free PDCH(bts=0,trx=0,ts=2) Detaching TBF(DL:TFI-0-0-0:STATE-NEW:GPRS), 1 TBFs, USFs = 00, TFIs = 00000001. @@ -3985,6 +4143,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 3c MS(TA-220:MSCLS-12-12) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-12-12): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-12-12:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 384, base(128) slots(4) ws_pdch(64) ws(384) DL TBF slots: 0x3c, N: 4, WS: 384 @@ -4013,6 +4173,7 @@ PDCH(bts=0,trx=0,ts=7) FN=2654270 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xf1223344, not yet confirmed +MS(TLLI-0xf1223344:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654270 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xf1223344, TA 220 -> 7 Modifying MS object, TLLI = 0xf1223344, MS class 0 -> 1 @@ -4038,6 +4199,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xf1223344:TA-7:MSCLS-1-1) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) setting EGPRS UL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) UL_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_PACCH @@ -4047,6 +4210,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xf1223344) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NONE}: state_chg to SEND_ASS +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654270 + 13 = 2654283 TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xf1223344) start Packet Uplink Assignment (PACCH) @@ -4099,6 +4263,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) @@ -4126,6 +4292,7 @@ PDCH(bts=0,trx=0,ts=7) FN=2654270 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xf1223344, not yet confirmed +MS(TLLI-0xf1223344:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654270 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xf1223344, TA 220 -> 7 Modifying MS object, TLLI = 0xf1223344, MS class 0 -> 1 @@ -4151,6 +4318,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xf1223344:TA-7:MSCLS-1-1) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) setting EGPRS UL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) UL_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_PACCH @@ -4160,6 +4329,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xf1223344) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NONE}: state_chg to SEND_ASS +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654270 + 13 = 2654283 TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xf1223344) start Packet Uplink Assignment (PACCH) @@ -4335,6 +4505,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) @@ -4375,6 +4547,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -4686,6 +4860,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -4946,6 +5122,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -5166,6 +5344,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -5370,6 +5550,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -5558,6 +5740,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -5722,6 +5906,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -5895,6 +6081,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -6059,6 +6247,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -6215,6 +6405,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -6286,6 +6478,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -6356,6 +6550,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -6426,6 +6622,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -6521,6 +6719,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -6615,6 +6815,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -6709,6 +6911,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -6806,6 +7010,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -6883,6 +7089,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -6960,6 +7168,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -7037,6 +7247,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -7111,6 +7323,7 @@ PDCH(bts=0,trx=0,ts=7) FN=2654270 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xf1223344, not yet confirmed +MS(TLLI-0xf1223344:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654270 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xf1223344, TA 220 -> 7 Modifying MS object, TLLI = 0xf1223344, MS class 0 -> 1 @@ -7136,6 +7349,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xf1223344:TA-7:MSCLS-1-1) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) setting EGPRS UL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) UL_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_PACCH @@ -7145,6 +7360,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xf1223344) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NONE}: state_chg to SEND_ASS +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654270 + 13 = 2654283 TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xf1223344) start Packet Uplink Assignment (PACCH) @@ -7220,6 +7436,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) @@ -7265,6 +7483,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 192, base(128) slots(1) ws_pdch(64) ws(192) DL TBF slots: 0x10, N: 1, WS: 192 @@ -7317,6 +7537,7 @@ PDCH(bts=0,trx=0,ts=7) FN=2654270 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xf1223344, not yet confirmed +MS(TLLI-0xf1223344:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654270 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xf1223344, TA 220 -> 7 Modifying MS object, TLLI = 0xf1223344, MS class 0 -> 1 @@ -7342,6 +7563,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xf1223344:TA-7:MSCLS-1-1) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) setting EGPRS UL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) UL_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_PACCH @@ -7351,6 +7574,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xf1223344) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NONE}: state_chg to SEND_ASS +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654270 + 13 = 2654283 TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xf1223344) start Packet Uplink Assignment (PACCH) @@ -7415,6 +7639,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) @@ -7454,6 +7680,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -7506,6 +7734,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) +MS(TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS){NEW}: Received Event ASSIGN_ADD_CCCH TBF(UL:TFI-0-0-0:STATE-NEW:GPRS) set ass. type CCCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS){NEW}: state_chg to FLOW @@ -7534,6 +7764,8 @@ TBF(UL:TFI-0-0-1:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-1:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-1:STATE-NEW:GPRS) +MS(TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) UL_TBF(UL:TFI-0-0-1:STATE-NEW:GPRS){NEW}: Received Event ASSIGN_ADD_CCCH TBF(UL:TFI-0-0-1:STATE-NEW:GPRS) set ass. type CCCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-1:STATE-NEW:GPRS){NEW}: state_chg to FLOW @@ -7562,6 +7794,8 @@ TBF(UL:TFI-0-0-2:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-2:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-2:STATE-NEW:GPRS) +MS(TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) UL_TBF(UL:TFI-0-0-2:STATE-NEW:GPRS){NEW}: Received Event ASSIGN_ADD_CCCH TBF(UL:TFI-0-0-2:STATE-NEW:GPRS) set ass. type CCCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-2:STATE-NEW:GPRS){NEW}: state_chg to FLOW @@ -7590,6 +7824,8 @@ TBF(UL:TFI-0-0-3:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-3:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-3:STATE-NEW:GPRS) +MS(TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) UL_TBF(UL:TFI-0-0-3:STATE-NEW:GPRS){NEW}: Received Event ASSIGN_ADD_CCCH TBF(UL:TFI-0-0-3:STATE-NEW:GPRS) set ass. type CCCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-3:STATE-NEW:GPRS){NEW}: state_chg to FLOW @@ -7618,6 +7854,8 @@ TBF(UL:TFI-0-0-4:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-4:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-4:STATE-NEW:GPRS) +MS(TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) UL_TBF(UL:TFI-0-0-4:STATE-NEW:GPRS){NEW}: Received Event ASSIGN_ADD_CCCH TBF(UL:TFI-0-0-4:STATE-NEW:GPRS) set ass. type CCCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-4:STATE-NEW:GPRS){NEW}: state_chg to FLOW @@ -7646,6 +7884,8 @@ TBF(UL:TFI-0-0-5:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-5:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-5:STATE-NEW:GPRS) +MS(TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) UL_TBF(UL:TFI-0-0-5:STATE-NEW:GPRS){NEW}: Received Event ASSIGN_ADD_CCCH TBF(UL:TFI-0-0-5:STATE-NEW:GPRS) set ass. type CCCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-5:STATE-NEW:GPRS){NEW}: state_chg to FLOW @@ -7674,6 +7914,8 @@ TBF(UL:TFI-0-0-6:STATE-NEW:GPRS) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-6:STATE-NEW:GPRS) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-6:STATE-NEW:GPRS) +MS(TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) UL_TBF(UL:TFI-0-0-6:STATE-NEW:GPRS){NEW}: Received Event ASSIGN_ADD_CCCH TBF(UL:TFI-0-0-6:STATE-NEW:GPRS) set ass. type CCCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0-6:STATE-NEW:GPRS){NEW}: state_chg to FLOW @@ -7744,6 +7986,7 @@ PDCH(bts=0,trx=0,ts=7) FN=2654270 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xf1223344, not yet confirmed +MS(TLLI-0xf1223344:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=2654270 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xf1223344, TA 220 -> 7 Modifying MS object, TLLI = 0xf1223344, MS class 0 -> 1 @@ -7769,6 +8012,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xf1223344:TA-7:MSCLS-1-1) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344) setting EGPRS UL window size to 192, base(128) slots(1) ws_pdch(64) ws(192) UL_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NEW}: Received Event ASSIGN_ADD_PACCH @@ -7778,6 +8023,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xf1223344) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){NONE}: state_chg to SEND_ASS +MS(TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xf1223344){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654270 + 13 = 2654283 TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xf1223344) start Packet Uplink Assignment (PACCH) @@ -8327,6 +8573,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) Allocated: trx = 0, ul_slots = 80, dl_slots = 80 MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-0011223344:TLLI-0xf1223344:TA-7:MSCLS-1-1:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) setting EGPRS DL window size to 192, base(128) slots(1) ws_pdch(64) ws(192) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS:IMSI-0011223344:TLLI-0xf1223344) [DOWNLINK] START (PACCH) @@ -9028,6 +9276,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Setting Control TS PDCH(bts=0,trx=0,ts=4) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) Allocated: trx = 0, ul_slots = 10, dl_slots = 10 MS(TA-220:MSCLS-11-11) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-11-11): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TA-220:MSCLS-11-11:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) setting EGPRS DL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) Modifying MS object, TLLI = 0xffffffff, TA 220 -> 0 @@ -9098,6 +9348,7 @@ PDCH(bts=0,trx=0,ts=7) FN=52 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddcc, not yet confirmed +MS(TLLI-0xffeeddcc:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=52 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xffeeddcc, TA 220 -> 7 Modifying MS object, TLLI = 0xffeeddcc, MS class 0 -> 11 @@ -9123,6 +9374,8 @@ TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xffeeddcc) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xffeeddcc) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xffeeddcc:TA-7:MSCLS-11-11) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xffeeddcc) +MS(TLLI-0xffeeddcc:TA-7:MSCLS-11-11): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xffeeddcc:TA-7:MSCLS-11-11:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xffeeddcc) setting EGPRS UL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) UL_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xffeeddcc){NEW}: Received Event ASSIGN_ADD_PACCH @@ -9132,6 +9385,7 @@ TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xffeeddcc) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xffeeddcc){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xffeeddcc){NONE}: state_chg to SEND_ASS +MS(TLLI-0xffeeddcc:TA-7:MSCLS-11-11:UL): - rcv_resource_request: now used by 0 (-) UL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:EGPRS:TLLI-0xffeeddcc){SEND_ASS}: Received Event CREATE_RLCMAC_MSG PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 2654218 + 13 = 2654231 TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xffeeddcc) start Packet Uplink Assignment (PACCH) @@ -9145,6 +9399,7 @@ PDCH(bts=0,trx=0,ts=7) FN=56 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddcd, not yet confirmed +MS(TLLI-0xffeeddcd:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=56 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xffeeddcd, TA 220 -> 7 Modifying MS object, TLLI = 0xffeeddcd, MS class 0 -> 11 @@ -9170,6 +9425,8 @@ TBF(UL:TFI-0-0-1:STATE-NEW:EGPRS:TLLI-0xffeeddcd) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-1:STATE-NEW:EGPRS:TLLI-0xffeeddcd) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xffeeddcd:TA-7:MSCLS-11-11) Attaching UL TBF: TBF(UL:TFI-0-0-1:STATE-NEW:EGPRS:TLLI-0xffeeddcd) +MS(TLLI-0xffeeddcd:TA-7:MSCLS-11-11): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xffeeddcd:TA-7:MSCLS-11-11:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-1:STATE-NEW:EGPRS:TLLI-0xffeeddcd) setting EGPRS UL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) UL_TBF(UL:TFI-0-0-1:STATE-NEW:EGPRS:TLLI-0xffeeddcd){NEW}: Received Event ASSIGN_ADD_PACCH @@ -9179,6 +9436,7 @@ TBF(UL:TFI-0-0-1:STATE-ASSIGN:EGPRS:TLLI-0xffeeddcd) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-1:STATE-NEW:EGPRS:TLLI-0xffeeddcd){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-1:STATE-NEW:EGPRS:TLLI-0xffeeddcd){NONE}: state_chg to SEND_ASS +MS(TLLI-0xffeeddcd:TA-7:MSCLS-11-11:UL): - rcv_resource_request: now used by 0 (-) PDCH(bts=0,trx=0,ts=7) Expiring FN=56 but previous FN=2654231 is still reserved! PDCH(bts=0,trx=0,ts=7) Timeout for registered POLL (FN=2654231, reason=UL_ASS): TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xffeeddcc) TBF(UL:TFI-0-0-0:STATE-ASSIGN:EGPRS:TLLI-0xffeeddcc) poll timeout for FN=2654231, TS=7 (curr FN 56) @@ -9199,6 +9457,7 @@ PDCH(bts=0,trx=0,ts=7) FN=60 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddce, not yet confirmed +MS(TLLI-0xffeeddce:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=60 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xffeeddce, TA 220 -> 7 Modifying MS object, TLLI = 0xffeeddce, MS class 0 -> 11 @@ -9224,6 +9483,8 @@ TBF(UL:TFI-0-0-2:STATE-NEW:EGPRS:TLLI-0xffeeddce) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-2:STATE-NEW:EGPRS:TLLI-0xffeeddce) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xffeeddce:TA-7:MSCLS-11-11) Attaching UL TBF: TBF(UL:TFI-0-0-2:STATE-NEW:EGPRS:TLLI-0xffeeddce) +MS(TLLI-0xffeeddce:TA-7:MSCLS-11-11): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xffeeddce:TA-7:MSCLS-11-11:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-2:STATE-NEW:EGPRS:TLLI-0xffeeddce) setting EGPRS UL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) UL_TBF(UL:TFI-0-0-2:STATE-NEW:EGPRS:TLLI-0xffeeddce){NEW}: Received Event ASSIGN_ADD_PACCH @@ -9233,6 +9494,7 @@ TBF(UL:TFI-0-0-2:STATE-ASSIGN:EGPRS:TLLI-0xffeeddce) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-2:STATE-NEW:EGPRS:TLLI-0xffeeddce){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-2:STATE-NEW:EGPRS:TLLI-0xffeeddce){NONE}: state_chg to SEND_ASS +MS(TLLI-0xffeeddce:TA-7:MSCLS-11-11:UL): - rcv_resource_request: now used by 0 (-) PDCH(bts=0,trx=0,ts=7) Expiring FN=60 but previous FN=2654231 is still reserved! PDCH(bts=0,trx=0,ts=7) Timeout for registered POLL (FN=2654231, reason=UL_ASS): TBF(UL:TFI-0-0-1:STATE-ASSIGN:EGPRS:TLLI-0xffeeddcd) TBF(UL:TFI-0-0-1:STATE-ASSIGN:EGPRS:TLLI-0xffeeddcd) poll timeout for FN=2654231, TS=7 (curr FN 60) @@ -9253,6 +9515,7 @@ PDCH(bts=0,trx=0,ts=7) FN=65 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddcf, not yet confirmed +MS(TLLI-0xffeeddcf:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=65 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xffeeddcf, TA 220 -> 7 Modifying MS object, TLLI = 0xffeeddcf, MS class 0 -> 11 @@ -9278,6 +9541,8 @@ TBF(UL:TFI-0-0-3:STATE-NEW:EGPRS:TLLI-0xffeeddcf) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-3:STATE-NEW:EGPRS:TLLI-0xffeeddcf) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xffeeddcf:TA-7:MSCLS-11-11) Attaching UL TBF: TBF(UL:TFI-0-0-3:STATE-NEW:EGPRS:TLLI-0xffeeddcf) +MS(TLLI-0xffeeddcf:TA-7:MSCLS-11-11): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xffeeddcf:TA-7:MSCLS-11-11:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-3:STATE-NEW:EGPRS:TLLI-0xffeeddcf) setting EGPRS UL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) UL_TBF(UL:TFI-0-0-3:STATE-NEW:EGPRS:TLLI-0xffeeddcf){NEW}: Received Event ASSIGN_ADD_PACCH @@ -9287,6 +9552,7 @@ TBF(UL:TFI-0-0-3:STATE-ASSIGN:EGPRS:TLLI-0xffeeddcf) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-3:STATE-NEW:EGPRS:TLLI-0xffeeddcf){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-3:STATE-NEW:EGPRS:TLLI-0xffeeddcf){NONE}: state_chg to SEND_ASS +MS(TLLI-0xffeeddcf:TA-7:MSCLS-11-11:UL): - rcv_resource_request: now used by 0 (-) PDCH(bts=0,trx=0,ts=7) Expiring FN=65 but previous FN=2654231 is still reserved! PDCH(bts=0,trx=0,ts=7) Timeout for registered POLL (FN=2654231, reason=UL_ASS): TBF(UL:TFI-0-0-2:STATE-ASSIGN:EGPRS:TLLI-0xffeeddce) TBF(UL:TFI-0-0-2:STATE-ASSIGN:EGPRS:TLLI-0xffeeddce) poll timeout for FN=2654231, TS=7 (curr FN 65) @@ -9307,6 +9573,7 @@ PDCH(bts=0,trx=0,ts=7) FN=69 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddd0, not yet confirmed +MS(TLLI-0xffeeddd0:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=69 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xffeeddd0, TA 220 -> 7 Modifying MS object, TLLI = 0xffeeddd0, MS class 0 -> 11 @@ -9332,6 +9599,8 @@ TBF(UL:TFI-0-0-4:STATE-NEW:EGPRS:TLLI-0xffeeddd0) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-4:STATE-NEW:EGPRS:TLLI-0xffeeddd0) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xffeeddd0:TA-7:MSCLS-11-11) Attaching UL TBF: TBF(UL:TFI-0-0-4:STATE-NEW:EGPRS:TLLI-0xffeeddd0) +MS(TLLI-0xffeeddd0:TA-7:MSCLS-11-11): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xffeeddd0:TA-7:MSCLS-11-11:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-4:STATE-NEW:EGPRS:TLLI-0xffeeddd0) setting EGPRS UL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) UL_TBF(UL:TFI-0-0-4:STATE-NEW:EGPRS:TLLI-0xffeeddd0){NEW}: Received Event ASSIGN_ADD_PACCH @@ -9341,6 +9610,7 @@ TBF(UL:TFI-0-0-4:STATE-ASSIGN:EGPRS:TLLI-0xffeeddd0) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-4:STATE-NEW:EGPRS:TLLI-0xffeeddd0){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-4:STATE-NEW:EGPRS:TLLI-0xffeeddd0){NONE}: state_chg to SEND_ASS +MS(TLLI-0xffeeddd0:TA-7:MSCLS-11-11:UL): - rcv_resource_request: now used by 0 (-) PDCH(bts=0,trx=0,ts=7) Expiring FN=69 but previous FN=2654231 is still reserved! PDCH(bts=0,trx=0,ts=7) Timeout for registered POLL (FN=2654231, reason=UL_ASS): TBF(UL:TFI-0-0-3:STATE-ASSIGN:EGPRS:TLLI-0xffeeddcf) TBF(UL:TFI-0-0-3:STATE-ASSIGN:EGPRS:TLLI-0xffeeddcf) poll timeout for FN=2654231, TS=7 (curr FN 69) @@ -9361,6 +9631,7 @@ PDCH(bts=0,trx=0,ts=7) FN=73 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddd1, not yet confirmed +MS(TLLI-0xffeeddd1:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=73 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xffeeddd1, TA 220 -> 7 Modifying MS object, TLLI = 0xffeeddd1, MS class 0 -> 11 @@ -9386,6 +9657,8 @@ TBF(UL:TFI-0-0-5:STATE-NEW:EGPRS:TLLI-0xffeeddd1) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-5:STATE-NEW:EGPRS:TLLI-0xffeeddd1) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xffeeddd1:TA-7:MSCLS-11-11) Attaching UL TBF: TBF(UL:TFI-0-0-5:STATE-NEW:EGPRS:TLLI-0xffeeddd1) +MS(TLLI-0xffeeddd1:TA-7:MSCLS-11-11): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xffeeddd1:TA-7:MSCLS-11-11:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-5:STATE-NEW:EGPRS:TLLI-0xffeeddd1) setting EGPRS UL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) UL_TBF(UL:TFI-0-0-5:STATE-NEW:EGPRS:TLLI-0xffeeddd1){NEW}: Received Event ASSIGN_ADD_PACCH @@ -9395,6 +9668,7 @@ TBF(UL:TFI-0-0-5:STATE-ASSIGN:EGPRS:TLLI-0xffeeddd1) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-5:STATE-NEW:EGPRS:TLLI-0xffeeddd1){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-5:STATE-NEW:EGPRS:TLLI-0xffeeddd1){NONE}: state_chg to SEND_ASS +MS(TLLI-0xffeeddd1:TA-7:MSCLS-11-11:UL): - rcv_resource_request: now used by 0 (-) PDCH(bts=0,trx=0,ts=7) Expiring FN=73 but previous FN=2654231 is still reserved! PDCH(bts=0,trx=0,ts=7) Timeout for registered POLL (FN=2654231, reason=UL_ASS): TBF(UL:TFI-0-0-4:STATE-ASSIGN:EGPRS:TLLI-0xffeeddd0) TBF(UL:TFI-0-0-4:STATE-ASSIGN:EGPRS:TLLI-0xffeeddd0) poll timeout for FN=2654231, TS=7 (curr FN 73) @@ -9415,6 +9689,7 @@ PDCH(bts=0,trx=0,ts=7) FN=78 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddd2, not yet confirmed +MS(TLLI-0xffeeddd2:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=78 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xffeeddd2, TA 220 -> 7 Modifying MS object, TLLI = 0xffeeddd2, MS class 0 -> 11 @@ -9440,6 +9715,8 @@ TBF(UL:TFI-0-0-6:STATE-NEW:EGPRS:TLLI-0xffeeddd2) Setting Control TS PDCH(bts=0,trx=0,ts=7) TBF(UL:TFI-0-0-6:STATE-NEW:EGPRS:TLLI-0xffeeddd2) Allocated: trx = 0, ul_slots = 80, dl_slots = 00 MS(TLLI-0xffeeddd2:TA-7:MSCLS-11-11) Attaching UL TBF: TBF(UL:TFI-0-0-6:STATE-NEW:EGPRS:TLLI-0xffeeddd2) +MS(TLLI-0xffeeddd2:TA-7:MSCLS-11-11): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xffeeddd2:TA-7:MSCLS-11-11:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) TBF(UL:TFI-0-0-6:STATE-NEW:EGPRS:TLLI-0xffeeddd2) setting EGPRS UL window size to 64, base(64) slots(1) ws_pdch(0) ws(64) UL_TBF(UL:TFI-0-0-6:STATE-NEW:EGPRS:TLLI-0xffeeddd2){NEW}: Received Event ASSIGN_ADD_PACCH @@ -9449,6 +9726,7 @@ TBF(UL:TFI-0-0-6:STATE-ASSIGN:EGPRS:TLLI-0xffeeddd2) Change control TS PDCH(bts=0,trx=0,ts=7) -> PDCH(bts=0,trx=0,ts=7) until assignment is complete. UL_ASS_TBF(UL:TFI-0-0-6:STATE-NEW:EGPRS:TLLI-0xffeeddd2){NONE}: Received Event SCHED_ASS UL_ASS_TBF(UL:TFI-0-0-6:STATE-NEW:EGPRS:TLLI-0xffeeddd2){NONE}: state_chg to SEND_ASS +MS(TLLI-0xffeeddd2:TA-7:MSCLS-11-11:UL): - rcv_resource_request: now used by 0 (-) PDCH(bts=0,trx=0,ts=7) Expiring FN=78 but previous FN=2654231 is still reserved! PDCH(bts=0,trx=0,ts=7) Timeout for registered POLL (FN=2654231, reason=UL_ASS): TBF(UL:TFI-0-0-5:STATE-ASSIGN:EGPRS:TLLI-0xffeeddd1) TBF(UL:TFI-0-0-5:STATE-ASSIGN:EGPRS:TLLI-0xffeeddd1) poll timeout for FN=2654231, TS=7 (curr FN 78) @@ -9469,6 +9747,7 @@ PDCH(bts=0,trx=0,ts=7) FN=82 ------------------------- RX : Uplink Control Block ------------------------- Creating MS object Modifying MS object, UL TLLI: 0xffffffff -> 0xffeeddd3, not yet confirmed +MS(TLLI-0xffeeddd3:TA-220:MSCLS-0-0): + rcv_resource_request: now used by 1 (rcv_resource_request) PDCH(bts=0,trx=0,ts=7) FN=82 PKT RESOURCE REQ: MS requests UL TBF throguh SBA Modifying MS object, TLLI = 0xffeeddd3, TA 220 -> 7 Modifying MS object, TLLI = 0xffeeddd3, MS class 0 -> 11 @@ -9503,12 +9782,15 @@ UL_ACK_TBF{NONE}: Allocated TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddd3) Setting Control TS PDCH(bts=0,trx=0,ts=7) MS(TLLI-0xffeeddd3:TA-7:MSCLS-11-11) Attaching UL TBF: TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddd3) +MS(TLLI-0xffeeddd3:TA-7:MSCLS-11-11): + ms_attach_ul_tbf: now used by 2 (rcv_resource_request,ms_attach_ul_tbf) +MS(TLLI-0xffeeddd3:TA-7:MSCLS-11-11:UL): - ms_attach_ul_tbf: now used by 1 (rcv_resource_request) UL_TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddd3){NEW}: Received Event ASSIGN_ADD_PACCH TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddd3) set ass. type PACCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddd3){NEW}: state_chg to ASSIGN TBF(UL:TFI-0-0--1:STATE-ASSIGN:GPRS:TLLI-0xffeeddd3) Starting timer X2001 [assignment (PACCH)] with 2 sec. 0 microsec UL_ASS_TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddd3){NONE}: Received Event SCHED_ASS_REJ UL_ASS_TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddd3){NONE}: state_chg to SEND_ASS_REJ +MS(TLLI-0xffeeddd3:TA-7:MSCLS-11-11:UL): - rcv_resource_request: now used by 0 (-) PDCH(bts=0,trx=0,ts=7) Expiring FN=82 but previous FN=2654231 is still reserved! PDCH(bts=0,trx=0,ts=7) Timeout for registered POLL (FN=2654231, reason=UL_ASS): TBF(UL:TFI-0-0-6:STATE-ASSIGN:EGPRS:TLLI-0xffeeddd2) TBF(UL:TFI-0-0-6:STATE-ASSIGN:EGPRS:TLLI-0xffeeddd2) poll timeout for FN=2654231, TS=7 (curr FN 82) @@ -9552,6 +9834,8 @@ UL_ACK_TBF{NONE}: Allocated TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddcc) Setting Control TS PDCH(bts=0,trx=0,ts=7) MS(TLLI-0xffeeddcc:TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddcc) +MS(TLLI-0xffeeddcc:TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TLLI-0xffeeddcc:TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) UL_TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddcc){NEW}: Received Event ASSIGN_ADD_PACCH TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddcc) set ass. type PACCH [prev CCCH:0, PACCH:0] UL_TBF(UL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0xffeeddcc){NEW}: state_chg to ASSIGN @@ -9607,6 +9891,8 @@ TBF(DL:TFI-0-1-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xa3c2f953) Setting Control TS PDCH(bts=0,trx=1,ts=5) TBF(DL:TFI-0-1-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xa3c2f953) Allocated: trx = 1, ul_slots = 20, dl_slots = 20 MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0) Attaching DL TBF: TBF(DL:TFI-0-1-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xa3c2f953) +MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-1-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xa3c2f953) [DOWNLINK] START (PCH) TBF(DL:TFI-0-1-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xa3c2f953) Send downlink assignment on PCH, no TBF exist (IMSI=001001000000001) DL_TBF(DL:TFI-0-1-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xa3c2f953){NEW}: Received Event ASSIGN_ADD_CCCH @@ -9643,7 +9929,10 @@ TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xecc1f953) Setting Control TS PDCH(bts=0,trx=0,ts=2) TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xecc1f953) Allocated: trx = 0, ul_slots = 04, dl_slots = 00 MS(TLLI-0xecc1f953:TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:TLLI-0xecc1f953) +MS(TLLI-0xecc1f953:TA-220:MSCLS-0-0): + ms_attach_ul_tbf: now used by 1 (ms_attach_ul_tbf) +MS(TLLI-0xecc1f953:TA-220:MSCLS-0-0:UL): - ms_attach_ul_tbf: now used by 0 (-) There is a new MS object for the same MS: (0xa3c2f953, '001001000000001') -> (0xecc1f953, '') +MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0:DL): + ms_merge_and_clear_ms: now used by 1 (ms_merge_and_clear_ms) MS(TLLI-0xecc1f953:TA-220:MSCLS-0-0:UL) Merge MS: MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0:DL) Modifying MS object, TLLI = 0xecc1f953, MS class 0 -> 11 TBF(DL:TFI-0-1-0:STATE-ASSIGN:GPRS:IMSI-001001000000001:TLLI-0xa3c2f953) free @@ -9654,6 +9943,7 @@ UL_ASS_TBF(DL:TFI-0-1-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xa3c2f953){NONE}: Deallocated DL_ASS_TBF(DL:TFI-0-1-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xa3c2f953){NONE}: Deallocated MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0) Clearing MS object +MS(TA-220:MSCLS-11-0): - ms_merge_and_clear_ms: now used by 0 (-) MS(TA-220:MSCLS-11-0) Destroying MS object Modifying MS object, TLLI: 0xecc1f953 confirmed MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:UL) appending 19 bytes to DL LLC queue @@ -9675,6 +9965,8 @@ TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xecc1f953) Setting Control TS PDCH(bts=0,trx=0,ts=2) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xecc1f953) Allocated: trx = 0, ul_slots = 04, dl_slots = 0e MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xecc1f953) +MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:UL): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:UL:DL): - ms_attach_dl_tbf: now used by 0 (-) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xecc1f953) [DOWNLINK] START (PACCH) TBF(DL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xecc1f953) Send downlink assignment on PACCH, because TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xecc1f953) exists DL_ASS_TBF(UL:TFI-0-0-0:STATE-NEW:GPRS:IMSI-001001000000001:TLLI-0xecc1f953){NONE}: Received Event SCHED_ASS diff --git a/tests/ulc/PdchUlcTest.err b/tests/ulc/PdchUlcTest.err index 41aa9b4..b402517 100644 --- a/tests/ulc/PdchUlcTest.err +++ b/tests/ulc/PdchUlcTest.err @@ -18,6 +18,8 @@ Creating MS object The MS object cannot fully confirm an unexpected TLLI: 0x12345678, partly confirmed MS(TLLI-0x12345678:TA-220:MSCLS-0-0) Attaching DL TBF: TBF(DL:TFI-0-0--1:STATE-NEW:GPRS:TLLI-0x12345678) +MS(TLLI-0x12345678:TA-220:MSCLS-0-0): + ms_attach_dl_tbf: now used by 1 (ms_attach_dl_tbf) +MS(TLLI-0x12345678:TA-220:MSCLS-0-0:DL): - ms_attach_dl_tbf: now used by 0 (-) 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 -- To view, visit https://gerrit.osmocom.org/c/osmo-pcu/+/32350 To unsubscribe, or for help writing mail filters, visit https://gerrit.osmocom.org/settings Gerrit-Project: osmo-pcu Gerrit-Branch: master Gerrit-Change-Id: Ib65629224e6bd5683bb9192ba4354e965e8d39ec Gerrit-Change-Number: 32350 Gerrit-PatchSet: 1 Gerrit-Owner: pespin <pespin(a)sysmocom.de> Gerrit-MessageType: newchange

1 0

[S] Change in osmo-pcu[master]: ms: Fix MS without PTMSI not freed immediatelly
by pespin 17 Apr '23

17 Apr '23

pespin has uploaded this change for review. ( https://gerrit.osmocom.org/c/osmo-pcu/+/32348 ) Change subject: ms: Fix MS without PTMSI not freed immediatelly ...................................................................... ms: Fix MS without PTMSI not freed immediatelly This check (tlli != 0) was added in 2015 in 6d86628e5b6d81afae4ca1f24201ee90bfab1c2a, with the rationale below: """ To avoid dangling entries without a TLLI there (which cannnot be retrieved anyway), the timer in the MS objects is not started after all TBF have been detached, so that they get deleted immediately in that case. """ The rationale makes sense, but through time the MS class was fixed to return GSM_RESERVED_TMSI (0xFFFFFFFF) when no TMSI was available. Hence, the check was wrong, and as a result, free() of MS containing GSM_RESERVED_TMSI would be delayed over time by release timer. Related: OS#6002 Change-Id: I7a694a30f8709c00af774846d7c4925cef253a71 --- M src/gprs_ms.c M tests/app_info/AppInfoTest.err 2 files changed, 38 insertions(+), 4 deletions(-) git pull ssh://gerrit.osmocom.org:29418/osmo-pcu refs/changes/48/32348/1 diff --git a/src/gprs_ms.c b/src/gprs_ms.c index 7ecaae4..52ea431 100644 --- a/src/gprs_ms.c +++ b/src/gprs_ms.c @@ -229,9 +229,20 @@ static void ms_release_timer_start(struct GprsMs *ms) { + /* Immediate free(): + * Skip delaying free() through release timer if delay is configured to be 0. + * This is useful for synced freed during unit tests. + */ if (ms->delay == 0) return; + /* Immediate free(): + * Skip delaying free() through release timer if TMSI is not + * known, since those cannot really be reused. + */ + if (ms_tlli(ms) == GSM_RESERVED_TMSI) + return; + LOGPMS(ms, DRLCMAC, LOGL_DEBUG, "Schedule MS release in %u secs\n", ms->delay); if (!ms->timer.data) @@ -384,9 +395,7 @@ if (!ms->dl_tbf && !ms->ul_tbf) { ms_set_reserved_slots(ms, NULL, 0, 0); ms->first_common_ts = NULL; - - if (ms_tlli(ms) != 0) - ms_release_timer_start(ms); + ms_release_timer_start(ms); } ms_update_status(ms); diff --git a/tests/app_info/AppInfoTest.err b/tests/app_info/AppInfoTest.err index 3624250..b555f72 100644 --- a/tests/app_info/AppInfoTest.err +++ b/tests/app_info/AppInfoTest.err @@ -61,9 +61,9 @@ PDCH(bts=0,trx=0,ts=6) Detaching TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS), 2 TBFs, USFs = 00, TFIs = 00000003. PDCH(bts=0,trx=0,ts=7) Detaching TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS), 1 TBFs, USFs = 00, TFIs = 00000001. MS(TA-220:MSCLS-10-11) Detaching TBF: TBF(DL:TFI-0-0-0:STATE-NEW:EGPRS) +MS(TA-220:MSCLS-10-11) Destroying MS object PDCH(bts=0,trx=0,ts=4) Detaching TBF(DL:TFI-0-0-1:STATE-NEW:EGPRS), 1 TBFs, USFs = 00, TFIs = 00000002. PDCH(bts=0,trx=0,ts=5) Detaching TBF(DL:TFI-0-0-1:STATE-NEW:EGPRS), 1 TBFs, USFs = 00, TFIs = 00000002. PDCH(bts=0,trx=0,ts=6) Detaching TBF(DL:TFI-0-0-1:STATE-NEW:EGPRS), 1 TBFs, USFs = 00, TFIs = 00000002. MS(TA-220:MSCLS-12-13) Detaching TBF: TBF(DL:TFI-0-0-1:STATE-NEW:EGPRS) MS(TA-220:MSCLS-12-13) Destroying MS object -MS(TA-220:MSCLS-10-11) Destroying MS object -- To view, visit https://gerrit.osmocom.org/c/osmo-pcu/+/32348 To unsubscribe, or for help writing mail filters, visit https://gerrit.osmocom.org/settings Gerrit-Project: osmo-pcu Gerrit-Branch: master Gerrit-Change-Id: I7a694a30f8709c00af774846d7c4925cef253a71 Gerrit-Change-Number: 32348 Gerrit-PatchSet: 1 Gerrit-Owner: pespin <pespin(a)sysmocom.de> Gerrit-MessageType: newchange

1 0

[M] Change in libosmo-abis[master]: osmo_rtp2trau() for FR & EFR UL: set C13 & C14 correctly
by falconia 17 Apr '23

17 Apr '23

falconia has uploaded this change for review. ( https://gerrit.osmocom.org/c/libosmo-abis/+/32347 ) Change subject: osmo_rtp2trau() for FR & EFR UL: set C13 & C14 correctly ...................................................................... osmo_rtp2trau() for FR & EFR UL: set C13 & C14 correctly Control bits C13 & C14 in TRAU-UL frames indicate SID classification per section 6.1.1 of GSM 06.31 for FR or GSM 06.81 for EFR. Previous commit 08d0c0990275 implements correct setting of C16 in TRAU-DL, but the case of generating TRAU-UL was left as a FIXME. Now that we have osmo_{fr,efr}_sid_classify() functions in libosmocodec, we can set C13 & C14 in TRAU-UL too. Do it. Change-Id: Ifcfc28ad7d77e561d456be546689995abfd8a6f5 --- M src/trau/trau_rtp_conv.c 1 file changed, 38 insertions(+), 12 deletions(-) git pull ssh://gerrit.osmocom.org:29418/libosmo-abis refs/changes/47/32347/1 diff --git a/src/trau/trau_rtp_conv.c b/src/trau/trau_rtp_conv.c index e08b0b9..5c87c46 100644 --- a/src/trau/trau_rtp_conv.c +++ b/src/trau/trau_rtp_conv.c @@ -257,6 +257,7 @@ static int rtp2trau_fr(struct osmo_trau_frame *tf, const uint8_t *data, size_t data_len) { int i, j, k, l, o; + enum osmo_gsm631_sid_class sidc; /* data_len == 0 for BFI frame */ if (data_len < GSM_FR_BYTES && data_len != 0) @@ -296,13 +297,17 @@ } memset(&tf->c_bits[5], 0, 6); /* C6 .. C11: Time Alignment */ if (tf->dir == OSMO_TRAU_DIR_UL) { - if (data_len == 0) + if (data_len == 0) { tf->c_bits[11] = 1; /* C12: BFI */ - else + tf->c_bits[12] = 0; /* C13: SID=0 */ + tf->c_bits[13] = 0; /* C14: SID=0 */ + } else { tf->c_bits[11] = 0; /* C12: BFI */ - /* FIXME: set C13 & C14 per GSM 06.31 section 6.1.1 */ - tf->c_bits[12] = 0; /* C13: SID=0 */ - tf->c_bits[13] = 0; /* C14: SID=0 */ + /* SID classification per GSM 06.31 section 6.1.1 */ + sidc = osmo_fr_sid_classify(data); + tf->c_bits[12] = (sidc >> 1) & 1; /* C13: msb */ + tf->c_bits[13] = (sidc >> 0) & 1; /* C14: lsb */ + } tf->c_bits[14] = 0; /* C15: TAF (SACCH or not) */ tf->c_bits[15] = 1; /* C16: spare */ tf->c_bits[16] = 0; /* C17: DTXd not applied */ @@ -430,6 +435,7 @@ { int i, j; ubit_t check_bits[26]; + enum osmo_gsm631_sid_class sidc; /* data_len == 0 for BFI frame */ if (data_len < GSM_EFR_BYTES && data_len != 0) @@ -461,13 +467,17 @@ memset(&tf->c_bits[5], 0, 6); /* C6 .. C11: Time Alignment */ if (tf->dir == OSMO_TRAU_DIR_UL) { - if (data_len == 0) - tf->c_bits[11] = 1; /* C12: BFI=1 */ - else - tf->c_bits[11] = 0; /* C12: BFI=1 */ - /* FIXME: set C13 & C14 per GSM 06.81 section 6.1.1 */ - tf->c_bits[12] = 0; /* C13: SID=0 */ - tf->c_bits[13] = 0; /* C14: SID=0 */ + if (data_len == 0) { + tf->c_bits[11] = 1; /* C12: BFI */ + tf->c_bits[12] = 0; /* C13: SID=0 */ + tf->c_bits[13] = 0; /* C14: SID=0 */ + } else { + tf->c_bits[11] = 0; /* C12: BFI */ + /* SID classification per GSM 06.81 section 6.1.1 */ + sidc = osmo_efr_sid_classify(data); + tf->c_bits[12] = (sidc >> 1) & 1; /* C13: msb */ + tf->c_bits[13] = (sidc >> 0) & 1; /* C14: lsb */ + } tf->c_bits[14] = 0; /* C15: TAF (SACCH) */ tf->c_bits[15] = 1; /* C16: spare */ tf->c_bits[16] = 0; /* C17: DTXd applied */ -- To view, visit https://gerrit.osmocom.org/c/libosmo-abis/+/32347 To unsubscribe, or for help writing mail filters, visit https://gerrit.osmocom.org/settings Gerrit-Project: libosmo-abis Gerrit-Branch: master Gerrit-Change-Id: Ifcfc28ad7d77e561d456be546689995abfd8a6f5 Gerrit-Change-Number: 32347 Gerrit-PatchSet: 1 Gerrit-Owner: falconia <falcon(a)freecalypso.org> Gerrit-MessageType: newchange

1 0

Jump to page: