From 8c5cd5d86d932df05031a319fa2dc4e28c359654 Mon Sep 17 00:00:00 2001 From: Neels Hofmeyr Date: Fri, 10 Mar 2017 02:15:20 +0100 Subject: log protocol discriminators and message types by name Depends: libosmocore change-id I0fca8e95ed5c2148b1a7440eff3fc9c7583898df Change-Id: If1c49faf6e1757cb16b383dd2db87b48bc94eee6 --- openbsc/src/libmsc/gsm_04_08.c | 14 +- openbsc/tests/msc_vlr/msc_vlr_test_gsm_authen.err | 440 ++++++++++---------- openbsc/tests/msc_vlr/msc_vlr_test_gsm_ciph.err | 462 ++++++++++----------- openbsc/tests/msc_vlr/msc_vlr_test_hlr_reject.err | 60 +-- openbsc/tests/msc_vlr/msc_vlr_test_hlr_timeout.err | 8 +- openbsc/tests/msc_vlr/msc_vlr_test_ms_timeout.err | 16 +- openbsc/tests/msc_vlr/msc_vlr_test_no_authen.err | 276 ++++++------ openbsc/tests/msc_vlr/msc_vlr_test_rest.err | 106 ++--- openbsc/tests/msc_vlr/msc_vlr_test_umts_authen.err | 264 ++++++------ openbsc/tests/msc_vlr/msc_vlr_tests.c | 22 +- 10 files changed, 842 insertions(+), 826 deletions(-) diff --git a/openbsc/src/libmsc/gsm_04_08.c b/openbsc/src/libmsc/gsm_04_08.c index db7558e2c..f40fba28e 100644 --- a/openbsc/src/libmsc/gsm_04_08.c +++ b/openbsc/src/libmsc/gsm_04_08.c @@ -3592,10 +3592,10 @@ void cm_service_request_concludes(struct gsm_subscriber_connection *conn, uint8_t pdisc = gsm48_hdr_pdisc(gh); uint8_t msg_type = gsm48_hdr_msg_type(gh); - DEBUGP(DMM, "%s pdisc=%d msg_type=0x%02x:" + DEBUGP(DMM, "%s: rx msg %s:" " received_cm_service_request changes to false\n", vlr_subscr_name(conn->vsub), - pdisc, msg_type); + gsm48_pdisc_msgtype_name(pdisc, msg_type)); } conn->received_cm_service_request = false; } @@ -3611,14 +3611,16 @@ int gsm0408_dispatch(struct gsm_subscriber_connection *conn, struct msgb *msg) OSMO_ASSERT(conn); OSMO_ASSERT(msg); - LOGP(DRLL, LOGL_DEBUG, "Dispatching 04.08 message, pdisc=%d\n", pdisc); + LOGP(DRLL, LOGL_DEBUG, "Dispatching 04.08 message %s (0x%x:0x%x)\n", + gsm48_pdisc_msgtype_name(pdisc, gsm48_hdr_msg_type(gh)), + pdisc, gsm48_hdr_msg_type(gh)); if (!msc_subscr_conn_is_accepted(conn) && !msg_is_initially_permitted(gh)) { LOGP(DRLL, LOGL_ERROR, - "subscr %s: Message not permitted for initial conn:" - " pdisc=0x%02x msg_type=0x%02x\n", - vlr_subscr_name(conn->vsub), gh->proto_discr, gh->msg_type); + "subscr %s: Message not permitted for initial conn: %s\n", + vlr_subscr_name(conn->vsub), + gsm48_pdisc_msgtype_name(pdisc, gsm48_hdr_msg_type(gh))); return -EACCES; } diff --git a/openbsc/tests/msc_vlr/msc_vlr_test_gsm_authen.err b/openbsc/tests/msc_vlr/msc_vlr_test_gsm_authen.err index 7560d4b5d..e3f372cc4 100644 --- a/openbsc/tests/msc_vlr/msc_vlr_test_gsm_authen.err +++ b/openbsc/tests/msc_vlr/msc_vlr_test_gsm_authen.err @@ -1,9 +1,9 @@ ===== test_gsm_authen - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -55,19 +55,19 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: vlr_gsupc_read_cb() returns 0 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -161,10 +161,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - after a while, a new conn sends a CM Service Request. VLR responds with Auth Req, 2nd auth vector - rx from MS: pdisc=0x05 msg_type=0x24 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_CM_SERV_REQ new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24) DMM <- CM SERVICE REQUEST serv_type=0x08 MI(IMSI)=901700000004620 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated @@ -194,18 +194,18 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts with a CM Service Accept - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:46071: MM GSM AUTHENTICATION RESPONSE (sres = 20bde240) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:46071) received res: 20 bd e2 40 @@ -241,16 +241,16 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - a USSD request is serviced expecting USSD: Your extension is 46071 - rx from MS: pdisc=0x0b msg_type=0x3b + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_NC_SS:0x3b DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=11 -DMM MSISDN:46071 pdisc=11 msg_type=0x3b: received_cm_service_request changes to false +DRLL Dispatching 04.08 message GSM48_PDISC_NC_SS:0x3b (0xb:0x3b) +DMM MSISDN:46071: rx msg GSM48_PDISC_NC_SS:0x3b: received_cm_service_request changes to false DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM USSD: Own number requested DMM MSISDN:46071: MSISDN = 46071 DMSC msc_tx 43 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_NC_SS:0x2a: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d - DTAP matches expected message DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn @@ -286,10 +286,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 4 llist_count(&vsub->cs.requests) == 1 DREF VLR subscr MSISDN:46071 usage decreases to: 3 - MS replies with Paging Response, and VLR sends Auth Request with third key - rx from MS: pdisc=0x06 msg_type=0x27 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_PAG_RESP new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=6 +DRLL Dispatching 04.08 message GSM48_MT_RR_PAG_RESP (0x6:0x27) DRR PAGING RESPONSE: MI(IMSI)=901700000004620 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated @@ -318,18 +318,18 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts and sends pending SMS - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:46071: MM GSM AUTHENTICATION RESPONSE (sres = a29514ae) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:46071) received res: a2 95 14 ae @@ -359,7 +359,7 @@ DPAG Calling paging cbfn. DREF VLR subscr MSISDN:46071 usage increases to: 5 DREF MSISDN:46071: MSC conn use + 1 == 3 DMSC msc_tx 91 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x01: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 4 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP @@ -376,9 +376,9 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 4 - conn is still open to wait for SMS ack dance llist_count(&net->subscr_conns) == 1 - MS replies with CP-ACK for received SMS - rx from MS: pdisc=0x89 msg_type=0x04 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x04 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x04 (0x9:0x4) DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP @@ -386,12 +386,12 @@ DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: bump: connection DREF MSISDN:46071: MSC conn use - 1 == 2 llist_count(&net->subscr_conns) == 1 - MS also sends RP-ACK, MSC in turn sends CP-ACK for that - rx from MS: pdisc=0x89 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x01 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING DMSC msc_tx 2 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 0904 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x04: 0904 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 3 DREF VLR subscr MSISDN:46071 usage decreases to: 2 @@ -415,10 +415,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000004620 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -435,10 +435,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_gsm_authen_tmsi - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -490,19 +490,19 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: vlr_gsupc_read_cb() returns 0 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -573,14 +573,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 lu_result_sent == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - even though the TMSI is not acked, we can already find the subscr with it DREF VLR subscr MSISDN:46071 usage increases to: 2 vsub != NULL == 1 @@ -589,9 +589,9 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 vsub->tmsi == 0xffffffff DREF VLR subscr MSISDN:46071 usage decreases to: 1 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:46071 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK @@ -632,10 +632,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - after a while, a new conn sends a CM Service Request using above TMSI. VLR responds with Auth Req, 2nd auth vector - rx from MS: pdisc=0x05 msg_type=0x24 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_CM_SERV_REQ new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24) DMM <- CM SERVICE REQUEST serv_type=0x08 MI(TMSI)=50462976 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(50462976){SUBSCR_CONN_S_INIT}: Allocated @@ -665,18 +665,18 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts with a CM Service Accept - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:46071: MM GSM AUTHENTICATION RESPONSE (sres = 20bde240) DVLR VLR_Authenticate(50462976){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:46071) received res: 20 bd e2 40 @@ -712,16 +712,16 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - a USSD request is serviced expecting USSD: Your extension is 46071 - rx from MS: pdisc=0x0b msg_type=0x3b + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_NC_SS:0x3b DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=11 -DMM MSISDN:46071 pdisc=11 msg_type=0x3b: received_cm_service_request changes to false +DRLL Dispatching 04.08 message GSM48_PDISC_NC_SS:0x3b (0xb:0x3b) +DMM MSISDN:46071: rx msg GSM48_PDISC_NC_SS:0x3b: received_cm_service_request changes to false DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM USSD: Own number requested DMM MSISDN:46071: MSISDN = 46071 DMSC msc_tx 43 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_NC_SS:0x2a: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d - DTAP matches expected message DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn @@ -757,10 +757,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 4 llist_count(&vsub->cs.requests) == 1 DREF VLR subscr MSISDN:46071 usage decreases to: 3 - MS replies with Paging Response using TMSI, and VLR sends Auth Request with third key - rx from MS: pdisc=0x06 msg_type=0x27 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_PAG_RESP new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=6 +DRLL Dispatching 04.08 message GSM48_MT_RR_PAG_RESP (0x6:0x27) DRR PAGING RESPONSE: MI(TMSI)=50462976 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(50462976){SUBSCR_CONN_S_INIT}: Allocated @@ -789,18 +789,18 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts and sends pending SMS - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:46071: MM GSM AUTHENTICATION RESPONSE (sres = a29514ae) DVLR VLR_Authenticate(50462976){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:46071) received res: a2 95 14 ae @@ -830,7 +830,7 @@ DPAG Calling paging cbfn. DREF VLR subscr MSISDN:46071 usage increases to: 5 DREF MSISDN:46071: MSC conn use + 1 == 3 DMSC msc_tx 91 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x01: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 4 DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP @@ -847,9 +847,9 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 4 - conn is still open to wait for SMS ack dance llist_count(&net->subscr_conns) == 1 - MS replies with CP-ACK for received SMS - rx from MS: pdisc=0x89 msg_type=0x04 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x04 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x04 (0x9:0x4) DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP @@ -857,12 +857,12 @@ DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: bump: connection still h DREF MSISDN:46071: MSC conn use - 1 == 2 llist_count(&net->subscr_conns) == 1 - MS also sends RP-ACK, MSC in turn sends CP-ACK for that - rx from MS: pdisc=0x89 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x01 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING DMSC msc_tx 2 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 0904 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x04: 0904 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 3 DREF VLR subscr MSISDN:46071 usage decreases to: 2 @@ -887,10 +887,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - subscriber sends LU Request, this time with the TMSI - Location Update request causes an Auth Req to MS - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(50462976){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(50462976){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -919,9 +919,9 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:46071: MM GSM AUTHENTICATION RESPONSE (sres = 5afc8d72) DVLR VLR_Authenticate(50462976){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:46071) received res: 5a fc 8d 72 @@ -992,14 +992,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 2 lu_result_sent == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - even though the TMSI is not acked, we can already find the subscr with it DREF VLR subscr MSISDN:46071 usage increases to: 3 vsub != NULL == 1 @@ -1008,9 +1008,9 @@ DREF VLR subscr MSISDN:46071 usage increases to: 3 vsub->tmsi == 0x03020100 DREF VLR subscr MSISDN:46071 usage decreases to: 2 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:46071 DVLR vlr_lu_fsm(50462976){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(50462976){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK @@ -1050,10 +1050,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - subscriber detaches, using new TMSI - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(TMSI)=117835012 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -1070,10 +1070,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_gsm_authen_imei - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -1125,19 +1125,19 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: vlr_gsupc_read_cb() returns 0 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -1200,7 +1200,7 @@ DVLR sub_pres_vlr_fsm(901700000004620){SUB_PRES_VLR_S_DONE}: Deallocated DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: Received Event LU_COMPL_VLR_E_SUB_PRES_COMPL DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: state_chg to LU_COMPL_VLR_S_WAIT_IMEI DMSC msc_tx 3 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 051802 +- DTAP --RAN_GERAN_A--> MS: GSM48_MT_MM_ID_REQ: 051802 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 1 <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: vlr_gsupc_read_cb() returns 0 @@ -1211,18 +1211,18 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS replies with an Identity Response - rx from MS: pdisc=0x05 msg_type=0x59 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_ID_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_ID_RESP (0x5:0x19) DMM IDENTITY RESPONSE: MI(IMEI)=423423423423423 DVLR set IMEI on subscriber; IMSI=901700000004620 IMEI=423423423423423 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_ID_IMEI @@ -1263,10 +1263,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000004620 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -1283,10 +1283,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_gsm_authen_tmsi_imei - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -1338,19 +1338,19 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: vlr_gsupc_read_cb() returns 0 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -1413,7 +1413,7 @@ DVLR sub_pres_vlr_fsm(901700000004620){SUB_PRES_VLR_S_DONE}: Deallocated DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: Received Event LU_COMPL_VLR_E_SUB_PRES_COMPL DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: state_chg to LU_COMPL_VLR_S_WAIT_IMEI_TMSI DMSC msc_tx 3 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 051802 +- DTAP --RAN_GERAN_A--> MS: GSM48_MT_MM_ID_REQ: 051802 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 1 <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: vlr_gsupc_read_cb() returns 0 @@ -1424,18 +1424,18 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS replies with an Identity Response - rx from MS: pdisc=0x05 msg_type=0x59 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_ID_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_ID_RESP (0x5:0x19) DMM IDENTITY RESPONSE: MI(IMEI)=423423423423423 DVLR set IMEI on subscriber; IMSI=901700000004620 IMEI=423423423423423 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_ID_IMEI @@ -1450,14 +1450,14 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 lu_result_sent == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - even though the TMSI is not acked, we can already find the subscr with it DREF VLR subscr MSISDN:46071 usage increases to: 2 vsub != NULL == 1 @@ -1466,9 +1466,9 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 vsub->tmsi == 0xffffffff DREF VLR subscr MSISDN:46071 usage decreases to: 1 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:46071 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK @@ -1507,10 +1507,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - subscriber detaches, using TMSI - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(TMSI)=50462976 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -1527,10 +1527,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_gsm_milenage_authen - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -1573,9 +1573,9 @@ DREF VLR subscr IMSI:901700000010650 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000010650: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000010650: MM GSM AUTHENTICATION RESPONSE (sres = 9b36efdf) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000010650) received res: 9b 36 ef df @@ -1669,10 +1669,10 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - after a while, a new conn sends a CM Service Request. VLR responds with Auth Req, 2nd auth vector - rx from MS: pdisc=0x05 msg_type=0x24 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_CM_SERV_REQ new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24) DMM <- CM SERVICE REQUEST serv_type=0x08 MI(IMSI)=901700000010650 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Allocated @@ -1702,18 +1702,18 @@ DREF MSISDN:42342: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts with a CM Service Accept - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:42342: MM GSM AUTHENTICATION RESPONSE (sres = 85aa3130) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:42342) received res: 85 aa 31 30 @@ -1749,16 +1749,16 @@ DREF MSISDN:42342: MSC conn use - 1 == 1 - a USSD request is serviced expecting USSD: Your extension is 42342 - rx from MS: pdisc=0x0b msg_type=0x3b + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_NC_SS:0x3b DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=11 -DMM MSISDN:42342 pdisc=11 msg_type=0x3b: received_cm_service_request changes to false +DRLL Dispatching 04.08 message GSM48_PDISC_NC_SS:0x3b (0xb:0x3b) +DMM MSISDN:42342: rx msg GSM48_PDISC_NC_SS:0x3b: received_cm_service_request changes to false DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM USSD: Own number requested DMM MSISDN:42342: MSISDN = 42342 DMSC msc_tx 43 bytes to MSISDN:42342 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d273104d36a3c91a0d +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_NC_SS:0x2a: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d273104d36a3c91a0d - DTAP matches expected message DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn @@ -1794,10 +1794,10 @@ DREF VLR subscr MSISDN:42342 usage increases to: 4 llist_count(&vsub->cs.requests) == 1 DREF VLR subscr MSISDN:42342 usage decreases to: 3 - MS replies with Paging Response, and VLR sends Auth Request with third key - rx from MS: pdisc=0x06 msg_type=0x27 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_PAG_RESP new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=6 +DRLL Dispatching 04.08 message GSM48_MT_RR_PAG_RESP (0x6:0x27) DRR PAGING RESPONSE: MI(IMSI)=901700000010650 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Allocated @@ -1826,18 +1826,18 @@ DREF MSISDN:42342: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts and sends pending SMS - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:42342: MM GSM AUTHENTICATION RESPONSE (sres = 69d5f9fb) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:42342) received res: 69 d5 f9 fb @@ -1867,7 +1867,7 @@ DPAG Calling paging cbfn. DREF VLR subscr MSISDN:42342 usage increases to: 5 DREF MSISDN:42342: MSC conn use + 1 == 3 DMSC msc_tx 91 bytes to MSISDN:42342 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 09015801000791447758100650004c0005802443f2000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x01: 09015801000791447758100650004c0005802443f2000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 - DTAP matches expected message DREF VLR subscr MSISDN:42342 usage decreases to: 4 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP @@ -1884,9 +1884,9 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 4 - conn is still open to wait for SMS ack dance llist_count(&net->subscr_conns) == 1 - MS replies with CP-ACK for received SMS - rx from MS: pdisc=0x89 msg_type=0x04 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x04 DREF MSISDN:42342: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x04 (0x9:0x4) DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP @@ -1894,12 +1894,12 @@ DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: bump: connection DREF MSISDN:42342: MSC conn use - 1 == 2 llist_count(&net->subscr_conns) == 1 - MS also sends RP-ACK, MSC in turn sends CP-ACK for that - rx from MS: pdisc=0x89 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x01 DREF MSISDN:42342: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING DMSC msc_tx 2 bytes to MSISDN:42342 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 0904 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x04: 0904 - DTAP matches expected message DREF VLR subscr MSISDN:42342 usage decreases to: 3 DREF VLR subscr MSISDN:42342 usage decreases to: 2 @@ -1923,10 +1923,10 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000010650 DREF VLR subscr MSISDN:42342 usage increases to: 2 DMM Subscriber MSISDN:42342 DETACHED diff --git a/openbsc/tests/msc_vlr/msc_vlr_test_gsm_ciph.err b/openbsc/tests/msc_vlr/msc_vlr_test_gsm_ciph.err index 61f07e755..f48a9cdc7 100644 --- a/openbsc/tests/msc_vlr/msc_vlr_test_gsm_ciph.err +++ b/openbsc/tests/msc_vlr/msc_vlr_test_gsm_ciph.err @@ -1,9 +1,9 @@ ===== test_ciph - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -46,9 +46,9 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 lu_result_sent == 0 auth_request_sent == 1 - MS sends Authen Response, VLR accepts and sends Ciphering Mode Command to MS - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -69,17 +69,17 @@ DREF IMSI:901700000004620: MSC conn use - 1 == 1 - needs ciph, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - MS sends Ciphering Mode Complete, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x06 msg_type=0x32 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_CIPH_M_COMPL DRR IMSI:901700000004620: CIPHERING MODE COMPLETE DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_CIPH}: Received Event VLR_ULA_E_CIPH_RES DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_CIPH}: vlr_loc_upd_post_ciph() @@ -161,10 +161,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - after a while, a new conn sends a CM Service Request. VLR responds with Auth Req, 2nd auth vector - rx from MS: pdisc=0x05 msg_type=0x24 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_CM_SERV_REQ new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24) DMM <- CM SERVICE REQUEST serv_type=0x08 MI(IMSI)=901700000004620 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated @@ -194,18 +194,18 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts and requests Ciphering - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:46071: MM GSM AUTHENTICATION RESPONSE (sres = 20bde240) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:46071) received res: 20 bd e2 40 @@ -228,16 +228,16 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs ciph, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Ciphering Mode Complete, VLR accepts; above Ciphering is an implicit CM Service Accept - rx from MS: pdisc=0x06 msg_type=0x32 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_CIPH_M_COMPL DRR MSISDN:46071: CIPHERING MODE COMPLETE DVLR Process_Access_Request_VLR(901700000004620){PR_ARQ_S_WAIT_CIPH}: Received Event PR_ARQ_E_CIPH_RES DVLR Process_Access_Request_VLR(901700000004620){PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_node2_post_ciph() @@ -258,16 +258,16 @@ DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: bump: still awaiting f - a USSD request is serviced expecting USSD: Your extension is 46071 - rx from MS: pdisc=0x0b msg_type=0x3b + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_NC_SS:0x3b DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=11 -DMM MSISDN:46071 pdisc=11 msg_type=0x3b: received_cm_service_request changes to false +DRLL Dispatching 04.08 message GSM48_PDISC_NC_SS:0x3b (0xb:0x3b) +DMM MSISDN:46071: rx msg GSM48_PDISC_NC_SS:0x3b: received_cm_service_request changes to false DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM USSD: Own number requested DMM MSISDN:46071: MSISDN = 46071 DMSC msc_tx 43 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_NC_SS:0x2a: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d - DTAP matches expected message DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn @@ -303,10 +303,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 4 llist_count(&vsub->cs.requests) == 1 DREF VLR subscr MSISDN:46071 usage decreases to: 3 - MS replies with Paging Response, and VLR sends Auth Request with third key - rx from MS: pdisc=0x06 msg_type=0x27 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_PAG_RESP new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=6 +DRLL Dispatching 04.08 message GSM48_MT_RR_PAG_RESP (0x6:0x27) DRR PAGING RESPONSE: MI(IMSI)=901700000004620 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated @@ -335,18 +335,18 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts and requests Ciphering - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:46071: MM GSM AUTHENTICATION RESPONSE (sres = a29514ae) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:46071) received res: a2 95 14 ae @@ -368,16 +368,16 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs ciph, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Ciphering Mode Complete, VLR accepts and sends pending SMS - rx from MS: pdisc=0x06 msg_type=0x32 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_CIPH_M_COMPL DRR MSISDN:46071: CIPHERING MODE COMPLETE DVLR Process_Access_Request_VLR(901700000004620){PR_ARQ_S_WAIT_CIPH}: Received Event PR_ARQ_E_CIPH_RES DVLR Process_Access_Request_VLR(901700000004620){PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_node2_post_ciph() @@ -396,7 +396,7 @@ DPAG Calling paging cbfn. DREF VLR subscr MSISDN:46071 usage increases to: 5 DREF MSISDN:46071: MSC conn use + 1 == 2 DMSC msc_tx 91 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x01: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 4 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP @@ -410,9 +410,9 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 4 - conn is still open to wait for SMS ack dance llist_count(&net->subscr_conns) == 1 - MS replies with CP-ACK for received SMS - rx from MS: pdisc=0x89 msg_type=0x04 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x04 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x04 (0x9:0x4) DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP @@ -420,12 +420,12 @@ DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: bump: connection DREF MSISDN:46071: MSC conn use - 1 == 2 llist_count(&net->subscr_conns) == 1 - MS also sends RP-ACK, MSC in turn sends CP-ACK for that - rx from MS: pdisc=0x89 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x01 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING DMSC msc_tx 2 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 0904 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x04: 0904 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 3 DREF VLR subscr MSISDN:46071 usage decreases to: 2 @@ -449,10 +449,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000004620 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -469,10 +469,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_ciph_tmsi - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -515,9 +515,9 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends Ciphering Mode Command to MS - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -539,17 +539,17 @@ DREF IMSI:901700000004620: MSC conn use - 1 == 1 - needs ciph, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - MS sends Ciphering Mode Complete, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x06 msg_type=0x32 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_CIPH_M_COMPL DRR IMSI:901700000004620: CIPHERING MODE COMPLETE DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_CIPH}: Received Event VLR_ULA_E_CIPH_RES DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_CIPH}: vlr_loc_upd_post_ciph() @@ -608,14 +608,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 lu_result_sent == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - even though the TMSI is not acked, we can already find the subscr with it DREF VLR subscr MSISDN:46071 usage increases to: 2 vsub != NULL == 1 @@ -624,9 +624,9 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 vsub->tmsi == 0xffffffff DREF VLR subscr MSISDN:46071 usage decreases to: 1 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:46071 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK @@ -667,10 +667,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - after a while, a new conn sends a CM Service Request using above TMSI. VLR responds with Auth Req, 2nd auth vector - rx from MS: pdisc=0x05 msg_type=0x24 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_CM_SERV_REQ new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24) DMM <- CM SERVICE REQUEST serv_type=0x08 MI(TMSI)=50462976 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(50462976){SUBSCR_CONN_S_INIT}: Allocated @@ -700,18 +700,18 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts and requests Ciphering - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:46071: MM GSM AUTHENTICATION RESPONSE (sres = 20bde240) DVLR VLR_Authenticate(50462976){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:46071) received res: 20 bd e2 40 @@ -734,16 +734,16 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs ciph, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Ciphering Mode Complete, VLR accepts; above Ciphering is an implicit CM Service Accept - rx from MS: pdisc=0x06 msg_type=0x32 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_CIPH_M_COMPL DRR MSISDN:46071: CIPHERING MODE COMPLETE DVLR Process_Access_Request_VLR(50462976){PR_ARQ_S_WAIT_CIPH}: Received Event PR_ARQ_E_CIPH_RES DVLR Process_Access_Request_VLR(50462976){PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_node2_post_ciph() @@ -764,16 +764,16 @@ DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: bump: still awaiting first re - a USSD request is serviced expecting USSD: Your extension is 46071 - rx from MS: pdisc=0x0b msg_type=0x3b + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_NC_SS:0x3b DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=11 -DMM MSISDN:46071 pdisc=11 msg_type=0x3b: received_cm_service_request changes to false +DRLL Dispatching 04.08 message GSM48_PDISC_NC_SS:0x3b (0xb:0x3b) +DMM MSISDN:46071: rx msg GSM48_PDISC_NC_SS:0x3b: received_cm_service_request changes to false DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM USSD: Own number requested DMM MSISDN:46071: MSISDN = 46071 DMSC msc_tx 43 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_NC_SS:0x2a: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d - DTAP matches expected message DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn @@ -809,10 +809,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 4 llist_count(&vsub->cs.requests) == 1 DREF VLR subscr MSISDN:46071 usage decreases to: 3 - MS replies with Paging Response using TMSI, and VLR sends Auth Request with third key - rx from MS: pdisc=0x06 msg_type=0x27 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_PAG_RESP new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=6 +DRLL Dispatching 04.08 message GSM48_MT_RR_PAG_RESP (0x6:0x27) DRR PAGING RESPONSE: MI(TMSI)=50462976 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(50462976){SUBSCR_CONN_S_INIT}: Allocated @@ -841,18 +841,18 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts and requests Ciphering - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:46071: MM GSM AUTHENTICATION RESPONSE (sres = a29514ae) DVLR VLR_Authenticate(50462976){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:46071) received res: a2 95 14 ae @@ -874,16 +874,16 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 - needs ciph, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Ciphering Mode Complete, VLR accepts and sends pending SMS - rx from MS: pdisc=0x06 msg_type=0x32 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_CIPH_M_COMPL DRR MSISDN:46071: CIPHERING MODE COMPLETE DVLR Process_Access_Request_VLR(50462976){PR_ARQ_S_WAIT_CIPH}: Received Event PR_ARQ_E_CIPH_RES DVLR Process_Access_Request_VLR(50462976){PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_node2_post_ciph() @@ -902,7 +902,7 @@ DPAG Calling paging cbfn. DREF VLR subscr MSISDN:46071 usage increases to: 5 DREF MSISDN:46071: MSC conn use + 1 == 2 DMSC msc_tx 91 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x01: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 4 DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP @@ -916,9 +916,9 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 4 - conn is still open to wait for SMS ack dance llist_count(&net->subscr_conns) == 1 - MS replies with CP-ACK for received SMS - rx from MS: pdisc=0x89 msg_type=0x04 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x04 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x04 (0x9:0x4) DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP @@ -926,12 +926,12 @@ DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: bump: connection still h DREF MSISDN:46071: MSC conn use - 1 == 2 llist_count(&net->subscr_conns) == 1 - MS also sends RP-ACK, MSC in turn sends CP-ACK for that - rx from MS: pdisc=0x89 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x01 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING DMSC msc_tx 2 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 0904 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x04: 0904 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 3 DREF VLR subscr MSISDN:46071 usage decreases to: 2 @@ -955,10 +955,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - subscriber detaches, using TMSI - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(TMSI)=50462976 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -975,10 +975,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_ciph_imei - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -1021,9 +1021,9 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends Ciphering Mode Command to MS - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -1044,17 +1044,17 @@ DREF IMSI:901700000004620: MSC conn use - 1 == 1 - needs ciph, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - MS sends Ciphering Mode Complete, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x06 msg_type=0x32 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_CIPH_M_COMPL DRR IMSI:901700000004620: CIPHERING MODE COMPLETE DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_CIPH}: Received Event VLR_ULA_E_CIPH_RES DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_CIPH}: vlr_loc_upd_post_ciph() @@ -1105,7 +1105,7 @@ DVLR sub_pres_vlr_fsm(901700000004620){SUB_PRES_VLR_S_DONE}: Deallocated DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: Received Event LU_COMPL_VLR_E_SUB_PRES_COMPL DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: state_chg to LU_COMPL_VLR_S_WAIT_IMEI DMSC msc_tx 3 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 051802 +- DTAP --RAN_GERAN_A--> MS: GSM48_MT_MM_ID_REQ: 051802 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 1 <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: vlr_gsupc_read_cb() returns 0 @@ -1116,18 +1116,18 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS replies with an Identity Response - rx from MS: pdisc=0x05 msg_type=0x59 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_ID_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_ID_RESP (0x5:0x19) DMM IDENTITY RESPONSE: MI(IMEI)=423423423423423 DVLR set IMEI on subscriber; IMSI=901700000004620 IMEI=423423423423423 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_ID_IMEI @@ -1168,10 +1168,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000004620 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -1188,10 +1188,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_ciph_imeisv - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -1234,9 +1234,9 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends Ciphering Mode Command to MS - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -1259,20 +1259,20 @@ DREF IMSI:901700000004620: MSC conn use - 1 == 1 - needs ciph, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 DREF VLR subscr IMSI:901700000004620 usage increases to: 2 vsub->imeisv[0] == 0 DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 - MS sends Ciphering Mode Complete with IMEISV, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x06 msg_type=0x32 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_CIPH_M_COMPL DRR IMSI:901700000004620: CIPHERING MODE COMPLETE DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_CIPH}: Received Event VLR_ULA_E_CIPH_RES DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_CIPH}: got IMEISV: 4234234234234235F @@ -1293,18 +1293,18 @@ DREF VLR subscr IMSI:901700000004620 usage increases to: 2 DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS replies with an Identity Response - rx from MS: pdisc=0x05 msg_type=0x59 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_ID_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_ID_RESP (0x5:0x19) DMM IDENTITY RESPONSE: MI(IMEI)=423423423423423 DVLR set IMEI on subscriber; IMSI=901700000004620 IMEI=423423423423423 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_HLR_UPD}: Received Event VLR_ULA_E_ID_IMEI @@ -1380,10 +1380,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000004620 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -1400,10 +1400,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_ciph_tmsi_imei - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -1446,9 +1446,9 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends Ciphering Mode Command to MS - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -1469,17 +1469,17 @@ DREF IMSI:901700000004620: MSC conn use - 1 == 1 - needs ciph, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr IMSI:901700000004620: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - MS sends Ciphering Mode Complete, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x06 msg_type=0x32 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_CIPH_M_COMPL DRR IMSI:901700000004620: CIPHERING MODE COMPLETE DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_CIPH}: Received Event VLR_ULA_E_CIPH_RES DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_CIPH}: vlr_loc_upd_post_ciph() @@ -1530,7 +1530,7 @@ DVLR sub_pres_vlr_fsm(901700000004620){SUB_PRES_VLR_S_DONE}: Deallocated DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: Received Event LU_COMPL_VLR_E_SUB_PRES_COMPL DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: state_chg to LU_COMPL_VLR_S_WAIT_IMEI_TMSI DMSC msc_tx 3 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 051802 +- DTAP --RAN_GERAN_A--> MS: GSM48_MT_MM_ID_REQ: 051802 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 1 <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: vlr_gsupc_read_cb() returns 0 @@ -1541,18 +1541,18 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS replies with an Identity Response - rx from MS: pdisc=0x05 msg_type=0x59 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_ID_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_ID_RESP (0x5:0x19) DMM IDENTITY RESPONSE: MI(IMEI)=423423423423423 DVLR set IMEI on subscriber; IMSI=901700000004620 IMEI=423423423423423 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_ID_IMEI @@ -1567,14 +1567,14 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 lu_result_sent == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - even though the TMSI is not acked, we can already find the subscr with it DREF VLR subscr MSISDN:46071 usage increases to: 2 vsub != NULL == 1 @@ -1583,9 +1583,9 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 vsub->tmsi == 0xffffffff DREF VLR subscr MSISDN:46071 usage decreases to: 1 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:46071 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK @@ -1624,10 +1624,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - subscriber detaches, using TMSI - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(TMSI)=50462976 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED diff --git a/openbsc/tests/msc_vlr/msc_vlr_test_hlr_reject.err b/openbsc/tests/msc_vlr/msc_vlr_test_hlr_reject.err index 91f88ba45..e54824cf5 100644 --- a/openbsc/tests/msc_vlr/msc_vlr_test_hlr_reject.err +++ b/openbsc/tests/msc_vlr/msc_vlr_test_hlr_reject.err @@ -1,9 +1,9 @@ ===== test_hlr_rej_auth_info_unknown_imsi - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -73,10 +73,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_hlr_rej_auth_info_net_fail - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -148,10 +148,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 --- - Submit a used auth tuple in the VLR - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -194,9 +194,9 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -296,10 +296,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - Another LU wants to get new tuples; even though HLR sends Network Failure, we are reusing the old tuples. - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -340,9 +340,9 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 2 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:46071: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:46071) received res: 2d 8b 2c 3e @@ -443,10 +443,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 --- - Submit a used auth tuple in the VLR - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -489,9 +489,9 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -591,10 +591,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - Another LU wants to get new tuples; HLR sends Network Failure, we reject. - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -664,10 +664,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 --- - Submit a used auth tuple in the VLR - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -710,9 +710,9 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -813,10 +813,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 - Another LU wants to get new tuples; HLR sends IMSI Unknown. Even though we would re-use an old tuple, reject the unknown IMSI. net->vlr->cfg.auth_reuse_old_sets_on_error == 1 - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -884,10 +884,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_hlr_acc_but_no_auth_tuples - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -956,10 +956,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_hlr_rej_lu - Location Update request causes a GSUP LU request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -1031,10 +1031,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_hlr_no_insert_data - Location Update request causes a GSUP LU request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START diff --git a/openbsc/tests/msc_vlr/msc_vlr_test_hlr_timeout.err b/openbsc/tests/msc_vlr/msc_vlr_test_hlr_timeout.err index 18770f429..dee4bfbbc 100644 --- a/openbsc/tests/msc_vlr/msc_vlr_test_hlr_timeout.err +++ b/openbsc/tests/msc_vlr/msc_vlr_test_hlr_timeout.err @@ -1,10 +1,10 @@ ===== test_hlr_timeout_lu_auth_info - Total time passed: 0.000000 s - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -82,10 +82,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_hlr_timeout_lu_upd_loc_result - Total time passed: 0.000000 s - Location Update request causes a GSUP LU request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START diff --git a/openbsc/tests/msc_vlr/msc_vlr_test_ms_timeout.err b/openbsc/tests/msc_vlr/msc_vlr_test_ms_timeout.err index 3250e293b..8439def81 100644 --- a/openbsc/tests/msc_vlr/msc_vlr_test_ms_timeout.err +++ b/openbsc/tests/msc_vlr/msc_vlr_test_ms_timeout.err @@ -1,10 +1,10 @@ ===== test_ms_timeout_lu_auth_resp - Total time passed: 0.000000 s - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -102,10 +102,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_ms_timeout_cm_auth_resp - Total time passed: 0.000000 s - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -148,9 +148,9 @@ DREF VLR subscr IMSI:901700000004620 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000004620: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000004620: MM GSM AUTHENTICATION RESPONSE (sres = 2d8b2c3e) DVLR VLR_Authenticate(901700000004620){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000004620) received res: 2d 8b 2c 3e @@ -244,10 +244,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - after a while, a new conn sends a CM Service Request. VLR responds with Auth Req, 2nd auth vector - rx from MS: pdisc=0x05 msg_type=0x24 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_CM_SERV_REQ new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24) DMM <- CM SERVICE REQUEST serv_type=0x08 MI(IMSI)=901700000004620 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated diff --git a/openbsc/tests/msc_vlr/msc_vlr_test_no_authen.err b/openbsc/tests/msc_vlr/msc_vlr_test_no_authen.err index 722bd3d8a..405cc1d7a 100644 --- a/openbsc/tests/msc_vlr/msc_vlr_test_no_authen.err +++ b/openbsc/tests/msc_vlr/msc_vlr_test_no_authen.err @@ -1,9 +1,9 @@ ===== test_no_authen - Location Update request causes a GSUP LU request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -46,14 +46,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 - having received subscriber data does not mean acceptance msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - HLR also sends GSUP _UPDATE_LOCATION_RESULT <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: 06010809710000004026f0 @@ -114,10 +114,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - after a while, a new conn sends a CM Service Request - rx from MS: pdisc=0x05 msg_type=0x24 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_CM_SERV_REQ new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24) DMM <- CM SERVICE REQUEST serv_type=0x08 MI(IMSI)=901700000004620 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated @@ -155,16 +155,16 @@ msc_subscr_conn_is_accepted() == true - a USSD request is serviced expecting USSD: Your extension is 46071 - rx from MS: pdisc=0x0b msg_type=0x3b + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_NC_SS:0x3b DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=11 -DMM MSISDN:46071 pdisc=11 msg_type=0x3b: received_cm_service_request changes to false +DRLL Dispatching 04.08 message GSM48_PDISC_NC_SS:0x3b (0xb:0x3b) +DMM MSISDN:46071: rx msg GSM48_PDISC_NC_SS:0x3b: received_cm_service_request changes to false DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM USSD: Own number requested DMM MSISDN:46071: MSISDN = 46071 DMSC msc_tx 43 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_NC_SS:0x2a: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d - DTAP matches expected message DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn @@ -201,10 +201,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 4 llist_count(&vsub->cs.requests) == 1 DREF VLR subscr MSISDN:46071 usage decreases to: 3 - MS replies with Paging Response, we deliver the SMS - rx from MS: pdisc=0x06 msg_type=0x27 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_PAG_RESP new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=6 +DRLL Dispatching 04.08 message GSM48_MT_RR_PAG_RESP (0x6:0x27) DRR PAGING RESPONSE: MI(IMSI)=901700000004620 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated @@ -234,7 +234,7 @@ DPAG Calling paging cbfn. DREF VLR subscr MSISDN:46071 usage increases to: 6 DREF MSISDN:46071: MSC conn use + 1 == 3 DMSC msc_tx 91 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x01: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 5 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP @@ -252,9 +252,9 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 4 - conn is still open to wait for SMS ack dance llist_count(&net->subscr_conns) == 1 - MS replies with CP-ACK for received SMS - rx from MS: pdisc=0x89 msg_type=0x04 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x04 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x04 (0x9:0x4) DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP @@ -262,12 +262,12 @@ DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: bump: connection DREF MSISDN:46071: MSC conn use - 1 == 2 llist_count(&net->subscr_conns) == 1 - MS also sends RP-ACK, MSC in turn sends CP-ACK for that - rx from MS: pdisc=0x89 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x01 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING DMSC msc_tx 2 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 0904 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x04: 0904 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 3 DREF VLR subscr MSISDN:46071 usage decreases to: 2 @@ -291,10 +291,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000004620 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -311,10 +311,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_no_authen_tmsi - Location Update request causes a GSUP LU request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -357,14 +357,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 - having received subscriber data does not mean acceptance msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - HLR also sends GSUP _UPDATE_LOCATION_RESULT <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: 06010809710000004026f0 @@ -402,14 +402,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 lu_result_sent == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - even though the TMSI is not acked, we can already find the subscr with it DREF VLR subscr MSISDN:46071 usage increases to: 2 vsub != NULL == 1 @@ -418,9 +418,9 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 vsub->tmsi == 0xffffffff DREF VLR subscr MSISDN:46071 usage decreases to: 1 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:46071 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK @@ -461,10 +461,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - after a while, a new conn sends a CM Service Request using above TMSI - rx from MS: pdisc=0x05 msg_type=0x24 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_CM_SERV_REQ new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24) DMM <- CM SERVICE REQUEST serv_type=0x08 MI(TMSI)=50462976 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(50462976){SUBSCR_CONN_S_INIT}: Allocated @@ -502,16 +502,16 @@ msc_subscr_conn_is_accepted() == true - a USSD request is serviced expecting USSD: Your extension is 46071 - rx from MS: pdisc=0x0b msg_type=0x3b + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_NC_SS:0x3b DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=11 -DMM MSISDN:46071 pdisc=11 msg_type=0x3b: received_cm_service_request changes to false +DRLL Dispatching 04.08 message GSM48_PDISC_NC_SS:0x3b (0xb:0x3b) +DMM MSISDN:46071: rx msg GSM48_PDISC_NC_SS:0x3b: received_cm_service_request changes to false DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM USSD: Own number requested DMM MSISDN:46071: MSISDN = 46071 DMSC msc_tx 43 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_NC_SS:0x2a: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d27310cd06bbc51a0d - DTAP matches expected message DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn @@ -547,10 +547,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 4 llist_count(&vsub->cs.requests) == 1 DREF VLR subscr MSISDN:46071 usage decreases to: 3 - MS replies with Paging Response using TMSI, we deliver the SMS - rx from MS: pdisc=0x06 msg_type=0x27 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_PAG_RESP new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=6 +DRLL Dispatching 04.08 message GSM48_MT_RR_PAG_RESP (0x6:0x27) DRR PAGING RESPONSE: MI(TMSI)=50462976 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(50462976){SUBSCR_CONN_S_INIT}: Allocated @@ -580,7 +580,7 @@ DPAG Calling paging cbfn. DREF VLR subscr MSISDN:46071 usage increases to: 6 DREF MSISDN:46071: MSC conn use + 1 == 3 DMSC msc_tx 91 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x01: 09015801000791447758100650004c0005806470f1000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 5 DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP @@ -598,9 +598,9 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 4 - conn is still open to wait for SMS ack dance llist_count(&net->subscr_conns) == 1 - MS replies with CP-ACK for received SMS - rx from MS: pdisc=0x89 msg_type=0x04 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x04 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x04 (0x9:0x4) DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(50462976){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP @@ -608,12 +608,12 @@ DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: bump: connection still h DREF MSISDN:46071: MSC conn use - 1 == 2 llist_count(&net->subscr_conns) == 1 - MS also sends RP-ACK, MSC in turn sends CP-ACK for that - rx from MS: pdisc=0x89 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x01 DREF MSISDN:46071: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) DMM Subscr_Conn(50462976){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING DMSC msc_tx 2 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 0904 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x04: 0904 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 3 DREF VLR subscr MSISDN:46071 usage decreases to: 2 @@ -638,10 +638,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - subscriber sends LU Request, this time with the TMSI - Location Update request causes a GSUP LU request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(50462976){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(50462976){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -682,14 +682,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 2 - having received subscriber data does not mean acceptance msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - HLR also sends GSUP _UPDATE_LOCATION_RESULT <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: 06010809710000004026f0 @@ -727,14 +727,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 2 lu_result_sent == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - even though the TMSI is not acked, we can already find the subscr with it DREF VLR subscr MSISDN:46071 usage increases to: 3 vsub != NULL == 1 @@ -743,9 +743,9 @@ DREF VLR subscr MSISDN:46071 usage increases to: 3 vsub->tmsi == 0x03020100 DREF VLR subscr MSISDN:46071 usage decreases to: 2 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:46071 DVLR vlr_lu_fsm(50462976){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(50462976){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK @@ -785,10 +785,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - subscriber detaches, using new TMSI - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(TMSI)=117835012 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -805,10 +805,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_no_authen_imei - Location Update request causes a GSUP LU request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -851,14 +851,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 - having received subscriber data does not mean acceptance msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - HLR also sends GSUP _UPDATE_LOCATION_RESULT, and we send an ID Request for the IMEI to the MS <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: 06010809710000004026f0 @@ -888,7 +888,7 @@ DVLR sub_pres_vlr_fsm(901700000004620){SUB_PRES_VLR_S_DONE}: Deallocated DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: Received Event LU_COMPL_VLR_E_SUB_PRES_COMPL DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: state_chg to LU_COMPL_VLR_S_WAIT_IMEI DMSC msc_tx 3 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 051802 +- DTAP --RAN_GERAN_A--> MS: GSM48_MT_MM_ID_REQ: 051802 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 1 <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: vlr_gsupc_read_cb() returns 0 @@ -899,18 +899,18 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS replies with an Identity Response - rx from MS: pdisc=0x05 msg_type=0x59 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_ID_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_ID_RESP (0x5:0x19) DMM IDENTITY RESPONSE: MI(IMEI)=423423423423423 DVLR set IMEI on subscriber; IMSI=901700000004620 IMEI=423423423423423 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_ID_IMEI @@ -951,10 +951,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000004620 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -971,10 +971,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_no_authen_tmsi_imei - Location Update request causes a GSUP LU request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -1017,14 +1017,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 - having received subscriber data does not mean acceptance msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - HLR also sends GSUP _UPDATE_LOCATION_RESULT, and we send an ID Request for the IMEI to the MS <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: 06010809710000004026f0 @@ -1054,7 +1054,7 @@ DVLR sub_pres_vlr_fsm(901700000004620){SUB_PRES_VLR_S_DONE}: Deallocated DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: Received Event LU_COMPL_VLR_E_SUB_PRES_COMPL DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_SUB_PRES}: state_chg to LU_COMPL_VLR_S_WAIT_IMEI_TMSI DMSC msc_tx 3 bytes to MSISDN:46071 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 051802 +- DTAP --RAN_GERAN_A--> MS: GSM48_MT_MM_ID_REQ: 051802 - DTAP matches expected message DREF VLR subscr MSISDN:46071 usage decreases to: 1 <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: vlr_gsupc_read_cb() returns 0 @@ -1065,18 +1065,18 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS replies with an Identity Response - rx from MS: pdisc=0x05 msg_type=0x59 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_ID_RESP DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_ID_RESP (0x5:0x19) DMM IDENTITY RESPONSE: MI(IMEI)=423423423423423 DVLR set IMEI on subscriber; IMSI=901700000004620 IMEI=423423423423423 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_ID_IMEI @@ -1091,18 +1091,18 @@ DREF MSISDN:46071: MSC conn use - 1 == 1 lu_result_sent == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:46071: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:46071 DVLR vlr_lu_fsm(901700000004620){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(901700000004620){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK @@ -1142,10 +1142,10 @@ DREF VLR subscr MSISDN:46071 usage increases to: 2 DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000004620 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED diff --git a/openbsc/tests/msc_vlr/msc_vlr_test_rest.err b/openbsc/tests/msc_vlr/msc_vlr_test_rest.err index 8d898fb5b..bef3ba68f 100644 --- a/openbsc/tests/msc_vlr/msc_vlr_test_rest.err +++ b/openbsc/tests/msc_vlr/msc_vlr_test_rest.err @@ -10,14 +10,14 @@ DMM Subscr_Conn(test){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START DMM Subscr_Conn(test){SUBSCR_CONN_S_INIT}: state_chg to SUBSCR_CONN_S_NEW msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr unknown: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr unknown: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr unknown: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr unknown: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr unknown: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr unknown: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr unknown: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr unknown: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - fake: acceptance DREF VLR subscr unknown usage increases to: 1 DMM Subscr_Conn(test){SUBSCR_CONN_S_NEW}: state_chg to SUBSCR_CONN_S_ACCEPTED @@ -41,10 +41,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_cm_service_without_lu - CM Service Request without a prior Location Updating - rx from MS: pdisc=0x05 msg_type=0x24 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_CM_SERV_REQ new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24) DMM <- CM SERVICE REQUEST serv_type=0x08 MI(IMSI)=901700000004620 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated @@ -81,10 +81,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_two_lu - Location Update request causes a GSUP LU request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -127,14 +127,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 - having received subscriber data does not mean acceptance msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - HLR also sends GSUP _UPDATE_LOCATION_RESULT <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: 06010809710000004026f0 @@ -196,10 +196,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 --- - verify that the MS can send another LU request - Location Update request causes a GSUP LU request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000004620){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -240,14 +240,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 2 - having received subscriber data does not mean acceptance msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - HLR also sends GSUP _UPDATE_LOCATION_RESULT <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: 06010809710000004026f0 @@ -307,10 +307,10 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000004620 DREF VLR subscr MSISDN:46071 usage increases to: 2 DMM Subscriber MSISDN:46071 DETACHED @@ -327,10 +327,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_lu_unknown_tmsi - Location Update request with unknown TMSI sends ID Request for IMSI - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(591536962){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(591536962){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -347,7 +347,7 @@ DREF VLR subscr TMSI:0x23422342 usage increases to: 2 DVLR vlr_lu_fsm(591536962){VLR_ULA_S_IDLE}: vlr_loc_upd_want_imsi() DVLR vlr_lu_fsm(591536962){VLR_ULA_S_IDLE}: state_chg to VLR_ULA_S_WAIT_IMSI DMSC msc_tx 3 bytes to TMSI:0x23422342 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 051801 +- DTAP --RAN_GERAN_A--> MS: GSM48_MT_MM_ID_REQ: 051801 - DTAP matches expected message DREF VLR subscr TMSI:0x23422342 usage decreases to: 1 DMM TMSI:0x23422342: bump: conn still being established (SUBSCR_CONN_S_NEW) @@ -355,18 +355,18 @@ DREF TMSI:0x23422342: MSC conn use - 1 == 1 lu_result_sent == 0 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr TMSI:0x23422342: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr TMSI:0x23422342: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr TMSI:0x23422342: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr TMSI:0x23422342: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr TMSI:0x23422342: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr TMSI:0x23422342: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr TMSI:0x23422342: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr TMSI:0x23422342: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS tells us the IMSI, causes a GSUP LU request to HLR - rx from MS: pdisc=0x05 msg_type=0x59 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_ID_RESP DREF TMSI:0x23422342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_ID_RESP (0x5:0x19) DMM IDENTITY RESPONSE: MI(IMSI)=901700000004620 DVLR set IMSI on subscriber; IMSI=901700000004620 id=901700000004620 DVLR vlr_lu_fsm(591536962){VLR_ULA_S_WAIT_IMSI}: Received Event VLR_ULA_E_ID_IMSI @@ -398,14 +398,14 @@ DREF VLR subscr MSISDN:46071 usage decreases to: 1 - having received subscriber data does not mean acceptance msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:46071: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:46071: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 lu_result_sent == 0 - HLR also sends GSUP _UPDATE_LOCATION_RESULT <-- GSUP rx OSMO_GSUP_MSGT_UPDATE_LOCATION_RESULT: 06010809710000004026f0 diff --git a/openbsc/tests/msc_vlr/msc_vlr_test_umts_authen.err b/openbsc/tests/msc_vlr/msc_vlr_test_umts_authen.err index d98c5dc63..eabc794e3 100644 --- a/openbsc/tests/msc_vlr/msc_vlr_test_umts_authen.err +++ b/openbsc/tests/msc_vlr/msc_vlr_test_umts_authen.err @@ -1,9 +1,9 @@ ===== test_umts_authen_geran - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -47,9 +47,9 @@ DREF VLR subscr IMSI:901700000010650 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000010650: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000010650: MM R99 AUTHENTICATION RESPONSE (res = e229c19e791f2e41) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000010650) received res: e2 29 c1 9e 79 1f 2e 41 @@ -121,14 +121,14 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 1 llist_count(&net->subscr_conns) == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - even though the TMSI is not acked, we can already find the subscr with it DREF VLR subscr MSISDN:42342 usage increases to: 2 vsub != NULL == 1 @@ -137,9 +137,9 @@ DREF VLR subscr MSISDN:42342 usage increases to: 2 vsub->tmsi == 0xffffffff DREF VLR subscr MSISDN:42342 usage decreases to: 1 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:42342 DVLR vlr_lu_fsm(901700000010650){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(901700000010650){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK @@ -173,10 +173,10 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - after a while, a new conn sends a CM Service Request. VLR responds with Auth Req, 2nd auth vector - rx from MS: pdisc=0x05 msg_type=0x24 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_CM_SERV_REQ new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24) DMM <- CM SERVICE REQUEST serv_type=0x08 MI(IMSI)=901700000010650 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Allocated @@ -207,18 +207,18 @@ DREF MSISDN:42342: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts with a CM Service Accept - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:42342: MM R99 AUTHENTICATION RESPONSE (res = 7db47cf7f81e4dc7) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:42342) received res: 7d b4 7c f7 f8 1e 4d c7 @@ -254,16 +254,16 @@ DREF MSISDN:42342: MSC conn use - 1 == 1 - a USSD request is serviced expecting USSD: Your extension is 42342 - rx from MS: pdisc=0x0b msg_type=0x3b + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_NC_SS:0x3b DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=11 -DMM MSISDN:42342 pdisc=11 msg_type=0x3b: received_cm_service_request changes to false +DRLL Dispatching 04.08 message GSM48_PDISC_NC_SS:0x3b (0xb:0x3b) +DMM MSISDN:42342: rx msg GSM48_PDISC_NC_SS:0x3b: received_cm_service_request changes to false DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM USSD: Own number requested DMM MSISDN:42342: MSISDN = 42342 DMSC msc_tx 43 bytes to MSISDN:42342 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d273104d36a3c91a0d +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_NC_SS:0x2a: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d273104d36a3c91a0d - DTAP matches expected message DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn @@ -299,10 +299,10 @@ DREF VLR subscr MSISDN:42342 usage increases to: 4 llist_count(&vsub->cs.requests) == 1 DREF VLR subscr MSISDN:42342 usage decreases to: 3 - MS replies with Paging Response, and VLR sends Auth Request with third key - rx from MS: pdisc=0x06 msg_type=0x27 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_RR_PAG_RESP new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=6 +DRLL Dispatching 04.08 message GSM48_MT_RR_PAG_RESP (0x6:0x27) DRR PAGING RESPONSE: MI(IMSI)=901700000010650 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Allocated @@ -332,18 +332,18 @@ DREF MSISDN:42342: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts and sends pending SMS - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:42342: MM R99 AUTHENTICATION RESPONSE (res = 706f996719ba609c) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:42342) received res: 70 6f 99 67 19 ba 60 9c @@ -373,7 +373,7 @@ DPAG Calling paging cbfn. DREF VLR subscr MSISDN:42342 usage increases to: 5 DREF MSISDN:42342: MSC conn use + 1 == 3 DMSC msc_tx 91 bytes to MSISDN:42342 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 09015801000791447758100650004c0005802443f2000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x01: 09015801000791447758100650004c0005802443f2000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 - DTAP matches expected message DREF VLR subscr MSISDN:42342 usage decreases to: 4 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP @@ -390,9 +390,9 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 4 - conn is still open to wait for SMS ack dance llist_count(&net->subscr_conns) == 1 - MS replies with CP-ACK for received SMS - rx from MS: pdisc=0x89 msg_type=0x04 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x04 DREF MSISDN:42342: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x04 (0x9:0x4) DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP @@ -400,12 +400,12 @@ DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: bump: connection DREF MSISDN:42342: MSC conn use - 1 == 2 llist_count(&net->subscr_conns) == 1 - MS also sends RP-ACK, MSC in turn sends CP-ACK for that - rx from MS: pdisc=0x89 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_PDISC_SMS:0x01 DREF MSISDN:42342: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING DMSC msc_tx 2 bytes to MSISDN:42342 via RAN_GERAN_A -- DTAP --RAN_GERAN_A--> MS: 0904 +- DTAP --RAN_GERAN_A--> MS: GSM48_PDISC_SMS:0x04: 0904 - DTAP matches expected message DREF VLR subscr MSISDN:42342 usage decreases to: 3 DREF VLR subscr MSISDN:42342 usage decreases to: 2 @@ -429,10 +429,10 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000010650 DREF VLR subscr MSISDN:42342 usage increases to: 2 DMM Subscriber MSISDN:42342 DETACHED @@ -449,10 +449,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_umts_authen_utran - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -496,9 +496,9 @@ DREF VLR subscr IMSI:901700000010650 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends SecurityModeControl - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000010650: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000010650: MM R99 AUTHENTICATION RESPONSE (res = e229c19e791f2e41) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000010650) received res: e2 29 c1 9e 79 1f 2e 41 @@ -583,14 +583,14 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 1 llist_count(&net->subscr_conns) == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - even though the TMSI is not acked, we can already find the subscr with it DREF VLR subscr MSISDN:42342 usage increases to: 2 vsub != NULL == 1 @@ -599,9 +599,9 @@ DREF VLR subscr MSISDN:42342 usage increases to: 2 vsub->tmsi == 0xffffffff DREF VLR subscr MSISDN:42342 usage decreases to: 1 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:42342 DVLR vlr_lu_fsm(901700000010650){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(901700000010650){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK @@ -635,10 +635,10 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - after a while, a new conn sends a CM Service Request. VLR responds with Auth Req, 2nd auth vector - rx from MS: pdisc=0x05 msg_type=0x24 + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_MM_CM_SERV_REQ new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24) DMM <- CM SERVICE REQUEST serv_type=0x08 MI(IMSI)=901700000010650 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Allocated @@ -669,18 +669,18 @@ DREF MSISDN:42342: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts and sends SecurityModeControl - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:42342: MM R99 AUTHENTICATION RESPONSE (res = 7db47cf7f81e4dc7) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:42342) received res: 7d b4 7c f7 f8 1e 4d c7 @@ -727,16 +727,16 @@ DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: bump: still awaiting f - a USSD request is serviced expecting USSD: Your extension is 42342 - rx from MS: pdisc=0x0b msg_type=0x3b + MSC <--RAN_UTRAN_IU-- MS: GSM48_PDISC_NC_SS:0x3b DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=11 -DMM MSISDN:42342 pdisc=11 msg_type=0x3b: received_cm_service_request changes to false +DRLL Dispatching 04.08 message GSM48_PDISC_NC_SS:0x3b (0xb:0x3b) +DMM MSISDN:42342: rx msg GSM48_PDISC_NC_SS:0x3b: received_cm_service_request changes to false DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM USSD: Own number requested DMM MSISDN:42342: MSISDN = 42342 DMSC msc_tx 43 bytes to MSISDN:42342 via RAN_UTRAN_IU -- DTAP --RAN_UTRAN_IU--> MS: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d273104d36a3c91a0d +- DTAP --RAN_UTRAN_IU--> MS: GSM48_PDISC_NC_SS:0x2a: 8b2a1c27a225020100302002013b301b04010f0416d9775d0e2ae3e965f73cfd7683d273104d36a3c91a0d - DTAP matches expected message DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn @@ -772,10 +772,10 @@ DREF VLR subscr MSISDN:42342 usage increases to: 4 llist_count(&vsub->cs.requests) == 1 DREF VLR subscr MSISDN:42342 usage decreases to: 3 - MS replies with Paging Response, and VLR sends Auth Request with third key - rx from MS: pdisc=0x06 msg_type=0x27 + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_RR_PAG_RESP new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=6 +DRLL Dispatching 04.08 message GSM48_MT_RR_PAG_RESP (0x6:0x27) DRR PAGING RESPONSE: MI(IMSI)=901700000010650 DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Allocated @@ -805,18 +805,18 @@ DREF MSISDN:42342: MSC conn use - 1 == 1 - needs auth, not yet accepted msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - MS sends Authen Response, VLR accepts and sends SecurityModeControl - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_MM_AUTH_RESP DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM MSISDN:42342: MM R99 AUTHENTICATION RESPONSE (res = 706f996719ba609c) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(MSISDN:42342) received res: 70 6f 99 67 19 ba 60 9c @@ -861,7 +861,7 @@ DPAG Calling paging cbfn. DREF VLR subscr MSISDN:42342 usage increases to: 5 DREF MSISDN:42342: MSC conn use + 1 == 2 DMSC msc_tx 91 bytes to MSISDN:42342 via RAN_UTRAN_IU -- DTAP --RAN_UTRAN_IU--> MS: 09015801000791447758100650004c0005802443f2000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 +- DTAP --RAN_UTRAN_IU--> MS: GSM48_PDISC_SMS:0x01: 09015801000791447758100650004c0005802443f2000007101000000000445079da1e1ee7416937485e9ea7c965373d1d6683c270383b3d0ed3d36ff71c949e83c22072799e9687c5ec32a81d96afcbf4b4fb0c7ac3e9e9b7db05 - DTAP matches expected message DREF VLR subscr MSISDN:42342 usage decreases to: 4 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP @@ -874,9 +874,9 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 4 - conn is still open to wait for SMS ack dance llist_count(&net->subscr_conns) == 1 - MS replies with CP-ACK for received SMS - rx from MS: pdisc=0x89 msg_type=0x04 + MSC <--RAN_UTRAN_IU-- MS: GSM48_PDISC_SMS:0x04 DREF MSISDN:42342: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x04 (0x9:0x4) DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP @@ -884,12 +884,12 @@ DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: bump: connection DREF MSISDN:42342: MSC conn use - 1 == 2 llist_count(&net->subscr_conns) == 1 - MS also sends RP-ACK, MSC in turn sends CP-ACK for that - rx from MS: pdisc=0x89 msg_type=0x01 + MSC <--RAN_UTRAN_IU-- MS: GSM48_PDISC_SMS:0x01 DREF MSISDN:42342: MSC conn use + 1 == 3 -DRLL Dispatching 04.08 message, pdisc=9 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING DMSC msc_tx 2 bytes to MSISDN:42342 via RAN_UTRAN_IU -- DTAP --RAN_UTRAN_IU--> MS: 0904 +- DTAP --RAN_UTRAN_IU--> MS: GSM48_PDISC_SMS:0x04: 0904 - DTAP matches expected message DREF VLR subscr MSISDN:42342 usage decreases to: 3 DREF VLR subscr MSISDN:42342 usage decreases to: 2 @@ -913,10 +913,10 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 1 llist_count(&net->subscr_conns) == 0 --- - subscriber detaches - rx from MS: pdisc=0x05 msg_type=0x01 + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_MM_IMSI_DETACH_IND new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_IMSI_DETACH_IND (0x5:0x1) DMM IMSI DETACH INDICATION: MI(IMSI)=901700000010650 DREF VLR subscr MSISDN:42342 usage increases to: 2 DMM Subscriber MSISDN:42342 DETACHED @@ -933,10 +933,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_umts_authen_resync_geran - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -980,9 +980,9 @@ DREF VLR subscr IMSI:901700000010650 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Failure with Resync cause, VLR sends GSUP to HLR to resync - rx from MS: pdisc=0x05 msg_type=0x1c + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_FAIL DREF IMSI:901700000010650: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_FAIL (0x5:0x1c) DMM IMSI:901700000010650: MM R99 AUTHENTICATION SYNCH (AUTS = 979498b1f72d3e28c59fa2e72f9c) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_FAIL DVLR GSUP tx: 08010809710000000156f0260e979498b1f72d3e28c59fa2e72f9c201039fa2f4e3d523d8619a73b4f65c3e14d @@ -1010,9 +1010,9 @@ DREF VLR subscr IMSI:901700000010650 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends GSUP LU Req to HLR - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000010650: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000010650: MM R99 AUTHENTICATION RESPONSE (res = 1df5f0b4f22b696e) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP_RESYNC}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000010650) received res: 1d f5 f0 b4 f2 2b 69 6e @@ -1084,14 +1084,14 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 1 llist_count(&net->subscr_conns) == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - even though the TMSI is not acked, we can already find the subscr with it DREF VLR subscr MSISDN:42342 usage increases to: 2 vsub != NULL == 1 @@ -1100,9 +1100,9 @@ DREF VLR subscr MSISDN:42342 usage increases to: 2 vsub->tmsi == 0xffffffff DREF VLR subscr MSISDN:42342 usage decreases to: 1 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_GERAN_A-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:42342 DVLR vlr_lu_fsm(901700000010650){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(901700000010650){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK @@ -1142,10 +1142,10 @@ talloc_total_blocks(tall_bsc_ctx) == 9 ===== test_umts_authen_resync_utran - Location Update request causes a GSUP Send Auth Info request to HLR - rx from MS: pdisc=0x05 msg_type=0x08 + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_MM_LOC_UPD_REQUEST new conn DREF unknown: MSC conn use + 1 == 1 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_LOC_UPD_REQUEST (0x5:0x8) DREF unknown: MSC conn use + 1 == 2 DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Allocated DMM Subscr_Conn(901700000010650){SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START @@ -1189,9 +1189,9 @@ DREF VLR subscr IMSI:901700000010650 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Failure with Resync cause, VLR sends GSUP to HLR to resync - rx from MS: pdisc=0x05 msg_type=0x1c + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_MM_AUTH_FAIL DREF IMSI:901700000010650: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_FAIL (0x5:0x1c) DMM IMSI:901700000010650: MM R99 AUTHENTICATION SYNCH (AUTS = 979498b1f72d3e28c59fa2e72f9c) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_FAIL DVLR GSUP tx: 08010809710000000156f0260e979498b1f72d3e28c59fa2e72f9c201039fa2f4e3d523d8619a73b4f65c3e14d @@ -1219,9 +1219,9 @@ DREF VLR subscr IMSI:901700000010650 usage decreases to: 1 auth_request_sent == 1 lu_result_sent == 0 - MS sends Authen Response, VLR accepts and sends SecurityModeControl - rx from MS: pdisc=0x05 msg_type=0x54 + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_MM_AUTH_RESP DREF IMSI:901700000010650: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14) DMM IMSI:901700000010650: MM R99 AUTHENTICATION RESPONSE (res = 1df5f0b4f22b696e) DVLR VLR_Authenticate(901700000010650){VLR_SUB_AS_WAIT_RESP_RESYNC}: Received Event VLR_AUTH_E_MS_AUTH_RESP DVLR SUBSCR(IMSI:901700000010650) received res: 1d f5 f0 b4 f2 2b 69 6e @@ -1306,14 +1306,14 @@ DREF VLR subscr MSISDN:42342 usage decreases to: 1 llist_count(&net->subscr_conns) == 1 msc_subscr_conn_is_accepted() == false requests shall be thwarted -DRLL Dispatching 04.08 message, pdisc=3 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x03 msg_type=0x05 -DRLL Dispatching 04.08 message, pdisc=5 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x05 msg_type=0x33 -DRLL Dispatching 04.08 message, pdisc=6 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x06 msg_type=0x19 -DRLL Dispatching 04.08 message, pdisc=9 -DRLL subscr MSISDN:42342: Message not permitted for initial conn: pdisc=0x09 msg_type=0x01 +DRLL Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_CC_SETUP +DRLL Dispatching 04.08 message unknown 0x33 (0x5:0x33) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: unknown 0x33 +DRLL Dispatching 04.08 message GSM48_MT_RR_SYSINFO_1 (0x6:0x19) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_MT_RR_SYSINFO_1 +DRLL Dispatching 04.08 message GSM48_PDISC_SMS:0x01 (0x9:0x1) +DRLL subscr MSISDN:42342: Message not permitted for initial conn: GSM48_PDISC_SMS:0x01 - even though the TMSI is not acked, we can already find the subscr with it DREF VLR subscr MSISDN:42342 usage increases to: 2 vsub != NULL == 1 @@ -1322,9 +1322,9 @@ DREF VLR subscr MSISDN:42342 usage increases to: 2 vsub->tmsi == 0xffffffff DREF VLR subscr MSISDN:42342 usage decreases to: 1 - MS sends TMSI Realloc Complete - rx from MS: pdisc=0x05 msg_type=0x5b + MSC <--RAN_UTRAN_IU-- MS: GSM48_MT_MM_TMSI_REALL_COMPL DREF MSISDN:42342: MSC conn use + 1 == 2 -DRLL Dispatching 04.08 message, pdisc=5 +DRLL Dispatching 04.08 message GSM48_MT_MM_TMSI_REALL_COMPL (0x5:0x1b) DMM TMSI Reallocation Completed. Subscriber: MSISDN:42342 DVLR vlr_lu_fsm(901700000010650){VLR_ULA_S_WAIT_LU_COMPL}: Received Event VLR_ULA_E_NEW_TMSI_ACK DVLR lu_compl_vlr_fsm(901700000010650){LU_COMPL_VLR_S_WAIT_TMSI_CNF}: Received Event LU_COMPL_VLR_E_NEW_TMSI_ACK diff --git a/openbsc/tests/msc_vlr/msc_vlr_tests.c b/openbsc/tests/msc_vlr/msc_vlr_tests.c index 4c0126305..d2ccb2a71 100644 --- a/openbsc/tests/msc_vlr/msc_vlr_tests.c +++ b/openbsc/tests/msc_vlr/msc_vlr_tests.c @@ -69,6 +69,17 @@ struct msgb *msgb_from_hex(const char *label, uint16_t size, const char *hex) return msg; } +const char *gh_type_name(struct gsm48_hdr *gh) +{ + return gsm48_pdisc_msgtype_name(gsm48_hdr_pdisc(gh), + gsm48_hdr_msg_type(gh)); +} + +const char *msg_type_name(struct msgb *msg) +{ + return gh_type_name((void*)msg->data); +} + void dtap_expect_tx(const char *hex) { /* Has the previously expected dtap been received? */ @@ -153,8 +164,10 @@ void rx_from_ms(struct msgb *msg) int rc; struct gsm48_hdr *gh = msgb_l3(msg); - log("rx from MS: pdisc=0x%02x msg_type=0x%02x", - gh->proto_discr, gh->msg_type); + + log("MSC <--%s-- MS: %s", + ran_type_name(rx_from_ran), + gh_type_name(gh)); if (g_conn && !conn_exists(g_conn)) g_conn = NULL; @@ -425,8 +438,9 @@ int __wrap_gsup_client_send(struct gsup_client *gsupc, struct msgb *msg) int _validate_dtap(struct msgb *msg, enum ran_type to_ran) { - btw("DTAP --%s--> MS: %s", - ran_type_name(to_ran), + struct gsm48_hdr *gh = (void*)msg->data; + btw("DTAP --%s--> MS: %s: %s", + ran_type_name(to_ran), msg_type_name(msg), osmo_hexdump_nospc(msg->data, msg->len)); OSMO_ASSERT(dtap_tx_expected); -- cgit v1.2.3