1
|
|
2
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:496 N-CONNECT.ind(21, 00 1a 57 05 08 00 00 f1 10 23 6e 75 30 17 0d 05 24 21 03 50 18 82 05 f4 34 28 d1 c3 )
|
3
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 00 1a 57 05 08 00 00 f1 10 23 6e 75 30 17 0d 05 24 21 03 50 18 82 05 f4 34 28 d1 c3
|
4
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:612 Rx MSC DT1 BSSMAP COMPLETE LAYER 3
|
5
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:274 BSC has completed layer 3 connection (conn_id=21)
|
6
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:50 Allocating A-Interface subscriber conn: lac 9070, conn_id 21
|
7
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:68 A-Interface subscriber connection successfully allocated!
|
8
|
Fri Jul 7 13:36:30 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24)
|
9
|
Fri Jul 7 13:36:30 2017 <0002> gsm_04_08.c:665 <- CM SERVICE REQUEST serv_type=0x01 MI(TMSI)=875090371
|
10
|
Fri Jul 7 13:36:30 2017 <0002> fsm.c:229 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_INIT}: Allocated
|
11
|
Fri Jul 7 13:36:30 2017 <0002> subscr_conn.c:344 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START
|
12
|
Fri Jul 7 13:36:30 2017 <0002> subscr_conn.c:66 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_INIT}: state_chg to SUBSCR_CONN_S_NEW
|
13
|
Fri Jul 7 13:36:30 2017 <001e> fsm.c:229 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_INIT}: Allocated
|
14
|
Fri Jul 7 13:36:30 2017 <001e> fsm.c:259 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_INIT}: is child of Subscr_Conn(875090371)[0x793860]
|
15
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:684 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_INIT}: rev=R99 net=GERAN Auth+Ciph
|
16
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:710 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_INIT}: Received Event PR_ARQ_E_START
|
17
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:319 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_INIT}: proc_arq_vlr_fn_post_imsi()
|
18
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:326 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_INIT}: state_chg to PR_ARQ_S_WAIT_AUTH
|
19
|
Fri Jul 7 13:36:30 2017 <001e> fsm.c:229 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_NEEDS_AUTH}: Allocated
|
20
|
Fri Jul 7 13:36:30 2017 <001e> fsm.c:259 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_NEEDS_AUTH}: is child of Process_Access_Request_VLR(875090371)[0x793990]
|
21
|
Fri Jul 7 13:36:30 2017 <001e> vlr_auth_fsm.c:602 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_NEEDS_AUTH}: Received Event VLR_AUTH_E_START
|
22
|
Fri Jul 7 13:36:30 2017 <001e> vlr_auth_fsm.c:300 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_NEEDS_AUTH}: state_chg to VLR_SUB_AS_WAIT_RESP
|
23
|
Fri Jul 7 13:36:30 2017 <001e> vlr_auth_fsm.c:263 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_WAIT_RESP}: got auth tuple: use_count=1 key_seq=3
|
24
|
Fri Jul 7 13:36:30 2017 <0002> gsm_04_08.c:553 -> AUTH REQ (rand = 812468a52627d974ae4fcfa3028e48a8)
|
25
|
Fri Jul 7 13:36:30 2017 <000a> msc_ifaces.c:50 msc_tx 19 bytes to MSISDN:23001 via RAN_GERAN_A
|
26
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=21)
|
27
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
28
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:150 N-DATA.req(21, 01 00 13 05 12 03 81 24 68 a5 26 27 d9 74 ae 4f cf a3 02 8e 48 a8 )
|
29
|
Fri Jul 7 13:36:30 2017 <0002> osmo_msc.c:55 MSISDN:23001: bump: conn still being established (SUBSCR_CONN_S_NEW)
|
30
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:322 User has been accepted by MSC.
|
31
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:508 N-DATA.ind(21, 01 00 06 05 54 6a ba 29 ef )
|
32
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 06 05 54 6a ba 29 ef
|
33
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 21
|
34
|
Fri Jul 7 13:36:30 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 21
|
35
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=21)
|
36
|
Fri Jul 7 13:36:30 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14)
|
37
|
Fri Jul 7 13:36:30 2017 <0002> gsm_04_08.c:909 MSISDN:23001: MM GSM AUTHENTICATION RESPONSE (sres = 6aba29ef)
|
38
|
Fri Jul 7 13:36:30 2017 <001e> vlr.c:1043 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP
|
39
|
Fri Jul 7 13:36:30 2017 <001e> vlr_auth_fsm.c:142 SUBSCR(MSISDN:23001) received res: 6a ba 29 ef
|
40
|
Fri Jul 7 13:36:30 2017 <001e> vlr_auth_fsm.c:192 SUBSCR(MSISDN:23001) AUTH established GSM security context
|
41
|
Fri Jul 7 13:36:30 2017 <001e> vlr_auth_fsm.c:231 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_WAIT_RESP}: Authentication terminating with result VLR_AUTH_RES_PASSED
|
42
|
Fri Jul 7 13:36:30 2017 <001e> vlr_auth_fsm.c:235 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_WAIT_RESP}: state_chg to VLR_SUB_AS_AUTHENTICATED
|
43
|
Fri Jul 7 13:36:30 2017 <001e> vlr_auth_fsm.c:240 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_AUTHENTICATED}: Terminating (cause = OSMO_FSM_TERM_REGULAR)
|
44
|
Fri Jul 7 13:36:30 2017 <001e> vlr_auth_fsm.c:240 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_AUTHENTICATED}: Removing from parent Process_Access_Request_VLR(875090371)[0x793990]
|
45
|
Fri Jul 7 13:36:30 2017 <001e> vlr_auth_fsm.c:240 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_AUTHENTICATED}: Freeing instance
|
46
|
Fri Jul 7 13:36:30 2017 <001e> fsm.c:273 VLR_Authenticate(875090371)[0x793b90]{VLR_SUB_AS_AUTHENTICATED}: Deallocated
|
47
|
Fri Jul 7 13:36:30 2017 <001e> vlr_auth_fsm.c:240 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_AUTH}: Received Event PR_ARQ_E_AUTH_RES
|
48
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:421 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_AUTH}: got VLR_AUTH_RES_PASSED
|
49
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:284 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_AUTH}: _proc_arq_vlr_node2()
|
50
|
Fri Jul 7 13:36:30 2017 <0002> gsm_04_08.c:3807 -> CIPHER MODE COMMAND MSISDN:23001
|
51
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:164 Passing Cipher mode command message from MSC to BSC (conn_id=21)
|
52
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:186 N-DATA.req(21, 00 0c 53 0a 09 02 fb 26 72 21 bc ce ec 00 )
|
53
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:301 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_AUTH}: state_chg to PR_ARQ_S_WAIT_CIPH
|
54
|
Fri Jul 7 13:36:30 2017 <0002> osmo_msc.c:55 MSISDN:23001: bump: conn still being established (SUBSCR_CONN_S_NEW)
|
55
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:508 N-DATA.ind(21, 00 12 55 20 0d 06 32 17 09 33 45 62 02 74 92 06 14 f8 2c 02 )
|
56
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 00 12 55 20 0d 06 32 17 09 33 45 62 02 74 92 06 14 f8 2c 02
|
57
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:612 Rx MSC DT1 BSSMAP CIPHER MODE COMPLETE
|
58
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 21
|
59
|
Fri Jul 7 13:36:30 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 21
|
60
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:398 BSC sends cipher mode complete (conn_id=21)
|
61
|
Fri Jul 7 13:36:30 2017 <0003> osmo_msc.c:165 MSISDN:23001: CIPHERING MODE COMPLETE
|
62
|
Fri Jul 7 13:36:30 2017 <001e> vlr.c:1056 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_CIPH}: Received Event PR_ARQ_E_CIPH_RES
|
63
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:484 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_CIPH}: got IMEISV: 3542620472960418
|
64
|
Fri Jul 7 13:36:30 2017 <001e> vlr.c:393 set IMEISV on subscriber; IMSI=001010000000001 IMEISV=3542620472960418
|
65
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:251 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_node2_post_ciph()
|
66
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:223 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_node2_post_vlr()
|
67
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:209 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_post_pres()
|
68
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:194 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_post_trace()
|
69
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:173 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_post_imei()
|
70
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:185 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_CIPH}: proc_arq_fsm_done(VLR_PR_ARQ_RES_PASSED)
|
71
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:108 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_WAIT_CIPH}: state_chg to PR_ARQ_S_DONE
|
72
|
Fri Jul 7 13:36:30 2017 <001e> vlr_access_req_fsm.c:118 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_DONE}: Process Access Request result: VLR_PR_ARQ_RES_PASSED
|
73
|
Fri Jul 7 13:36:30 2017 <0002> vlr_access_req_fsm.c:157 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_NEW}: Received Event SUBSCR_CONN_E_ACCEPTED
|
74
|
Fri Jul 7 13:36:30 2017 <0002> subscr_conn.c:77 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_NEW}: SUBSCR_CONN_FROM_CM_SERVICE_REQ
|
75
|
Fri Jul 7 13:36:30 2017 <0002> subscr_conn.c:84 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_NEW}: state_chg to SUBSCR_CONN_S_ACCEPTED
|
76
|
Fri Jul 7 13:36:30 2017 <0002> subscr_conn.c:129 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_ACCEPTED}: received_cm_service_request = true
|
77
|
Fri Jul 7 13:36:30 2017 <0002> subscr_conn.c:132 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP
|
78
|
Fri Jul 7 13:36:30 2017 <0002> subscr_conn.c:146 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_ACCEPTED}: bump: still awaiting first request after a CM Service Request
|
79
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:508 N-DATA.ind(21, 01 00 1a 03 85 04 06 60 04 05 02 00 81 5e 04 81 32 01 f1 40 08 04 02 60 00 00 02 1f 00 )
|
80
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 1a 03 85 04 06 60 04 05 02 00 81 5e 04 81 32 01 f1 40 08 04 02 60 00 00 02 1f 00
|
81
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 21
|
82
|
Fri Jul 7 13:36:30 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 21
|
83
|
Fri Jul 7 13:36:30 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=21)
|
84
|
Fri Jul 7 13:36:30 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5)
|
85
|
Fri Jul 7 13:36:30 2017 <0001> gsm_04_08.c:3521 Unknown transaction ID 8, creating new trans.
|
86
|
Fri Jul 7 13:36:30 2017 <0001> transaction.c:89 subscr=0x7144b0, net=0x668640
|
87
|
Fri Jul 7 13:36:30 2017 <0002> gsm_04_08.c:3610 MSISDN:23001: rx msg GSM48_MT_CC_SETUP: received_cm_service_request changes to false
|
88
|
Fri Jul 7 13:36:30 2017 <0001> gsm_04_08.c:1232 new state NULL -> INITIATED
|
89
|
Fri Jul 7 13:36:30 2017 <0001> gsm_04_08.c:1864 Subscriber MSISDN:23001 (23001) sends SETUP to 23101
|
90
|
Fri Jul 7 13:36:30 2017 <0006> mncc_builtin.c:352 (call 8000000e) Call created.
|
91
|
Fri Jul 7 13:36:30 2017 <0006> mncc_builtin.c:361 (call 8000000e) Received message MNCC_SETUP_IND
|
92
|
Fri Jul 7 13:36:30 2017 <0006> mncc_builtin.c:125 (call 8000000e) Creating new remote instance e.
|
93
|
Fri Jul 7 13:36:30 2017 <0006> mncc_builtin.c:134 (call 8000000e) Accepting call.
|
94
|
Fri Jul 7 13:36:30 2017 <0006> gsm_04_08.c:3198 receive message MNCC_CALL_PROC_REQ
|
95
|
Fri Jul 7 13:36:30 2017 <0001> gsm_04_08.c:3416 (ti 08 sub 23001) Received 'MNCC_CALL_PROC_REQ' from MNCC in state 1 (INITIATED)
|
96
|
Fri Jul 7 13:36:30 2017 <0001> gsm_04_08.c:1232 new state INITIATED -> MO_CALL_PROC
|
97
|
Fri Jul 7 13:36:30 2017 <000a> msc_ifaces.c:50 msc_tx 2 bytes to MSISDN:23001 via RAN_GERAN_A
|
98
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=21)
|
99
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
100
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:150 N-DATA.req(21, 01 00 02 83 02 )
|
101
|
Fri Jul 7 13:36:30 2017 <000b> mgcpgw_client.c:507 Queued 30 bytes for MGCP GW
|
102
|
Fri Jul 7 13:36:30 2017 <000b> mgcpgw_client.c:507 Queued 66 bytes for MGCP GW
|
103
|
Fri Jul 7 13:36:30 2017 <0006> mncc_builtin.c:142 (call 8000000e) Modify channel mode: SPEECH_AMR
|
104
|
Fri Jul 7 13:36:30 2017 <0006> gsm_04_08.c:3198 receive message MNCC_LCHAN_MODIFY
|
105
|
Fri Jul 7 13:36:30 2017 <0001> gsm_04_08.c:3416 (ti 08 sub 23001) Received 'MNCC_LCHAN_MODIFY' from MNCC in state 3 (MO_CALL_PROC)
|
106
|
Fri Jul 7 13:36:30 2017 <0006> mncc_builtin.c:149 (call 8000000e) Forwarding SETUP to remote.
|
107
|
Fri Jul 7 13:36:30 2017 <0006> gsm_04_08.c:3198 receive message MNCC_SETUP_REQ
|
108
|
Fri Jul 7 13:36:30 2017 <0001> gsm_04_08.c:3313 (bts - trx - ts - ti -- sub 23101) Received 'MNCC_SETUP_REQ' from MNCC with unknown subscriber 23101
|
109
|
Fri Jul 7 13:36:30 2017 <0006> mncc_builtin.c:361 (call e) Received message MNCC_REL_IND
|
110
|
Fri Jul 7 13:36:30 2017 <0006> mncc_builtin.c:265 (call e) Releasing remote with cause 1
|
111
|
Fri Jul 7 13:36:30 2017 <0006> mncc_builtin.c:52 (call e) Call removed.
|
112
|
Fri Jul 7 13:36:30 2017 <0006> gsm_04_08.c:3198 receive message MNCC_REL_REQ
|
113
|
Fri Jul 7 13:36:30 2017 <0001> gsm_04_08.c:3416 (ti 08 sub 23001) Received 'MNCC_REL_REQ' from MNCC in state 3 (MO_CALL_PROC)
|
114
|
Fri Jul 7 13:36:30 2017 <0001> gsm_04_08.c:1780 starting timer T308 with 10 seconds
|
115
|
Fri Jul 7 13:36:30 2017 <0001> gsm_04_08.c:1232 new state MO_CALL_PROC -> RELEASE_REQ
|
116
|
Fri Jul 7 13:36:30 2017 <000a> msc_ifaces.c:50 msc_tx 6 bytes to MSISDN:23001 via RAN_GERAN_A
|
117
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=21)
|
118
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
119
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:150 N-DATA.req(21, 01 00 06 83 2d 08 02 81 81 )
|
120
|
Fri Jul 7 13:36:30 2017 <0002> subscr_conn.c:366 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING
|
121
|
Fri Jul 7 13:36:30 2017 <0002> subscr_conn.c:182 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING
|
122
|
Fri Jul 7 13:36:30 2017 <0002> osmo_msc.c:58 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP
|
123
|
Fri Jul 7 13:36:30 2017 <0002> subscr_conn.c:164 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_COMMUNICATING}: bump: connection still has active transaction: GSM48_PDISC_CC
|
124
|
Fri Jul 7 13:36:30 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'DLCX 76 1@mgw MGCP 1.0'
|
125
|
Fri Jul 7 13:36:30 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 30
|
126
|
Fri Jul 7 13:36:30 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'CRCX 77 1@mgw MGCP 1.0'
|
127
|
Fri Jul 7 13:36:30 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 66
|
128
|
Fri Jul 7 13:36:30 2017 <000b> mgcpgw_client.c:122 MGCP response ignored (NULL cb)
|
129
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:377 Sending assignment command to BSC (conn_id 21)
|
130
|
Fri Jul 7 13:36:30 2017 <000a> a_iface.c:404 N-DATA.req(21, 00 1d 01 0b 07 01 0a a1 a5 91 81 05 7c 06 0a 09 01 65 0f a2 7d 09 83 ff ff 84 07 3f 82 80 81 )
|
131
|
Fri Jul 7 13:36:31 2017 <000a> a_iface.c:508 N-DATA.ind(21, 01 00 02 03 ea )
|
132
|
Fri Jul 7 13:36:31 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 02 03 ea
|
133
|
Fri Jul 7 13:36:31 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 21
|
134
|
Fri Jul 7 13:36:31 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 21
|
135
|
Fri Jul 7 13:36:31 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=21)
|
136
|
Fri Jul 7 13:36:31 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_CC_RELEASE_COMPL (0x3:0x2a)
|
137
|
Fri Jul 7 13:36:31 2017 <0001> gsm_04_08.c:1272 stopping pending timer T308
|
138
|
Fri Jul 7 13:36:31 2017 <0006> mncc_builtin.c:361 (call 8000000e) Received message MNCC_REL_CNF
|
139
|
Fri Jul 7 13:36:31 2017 <0006> mncc_builtin.c:52 (call 8000000e) Call removed.
|
140
|
Fri Jul 7 13:36:31 2017 <000b> mgcpgw_client.c:507 Queued 30 bytes for MGCP GW
|
141
|
Fri Jul 7 13:36:31 2017 <0001> gsm_04_08.c:1232 new state RELEASE_REQ -> NULL
|
142
|
Fri Jul 7 13:36:31 2017 <0002> subscr_conn.c:366 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING
|
143
|
Fri Jul 7 13:36:31 2017 <0002> osmo_msc.c:58 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP
|
144
|
Fri Jul 7 13:36:31 2017 <0002> subscr_conn.c:168 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn
|
145
|
Fri Jul 7 13:36:31 2017 <0002> subscr_conn.c:169 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_COMMUNICATING}: state_chg to SUBSCR_CONN_S_RELEASED
|
146
|
Fri Jul 7 13:36:31 2017 <0002> subscr_conn.c:255 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_RELEASED}: Terminating (cause = OSMO_FSM_TERM_REGULAR)
|
147
|
Fri Jul 7 13:36:31 2017 <001e> subscr_conn.c:255 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_DONE}: Terminating (cause = OSMO_FSM_TERM_PARENT)
|
148
|
Fri Jul 7 13:36:31 2017 <001e> subscr_conn.c:255 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_DONE}: Removing from parent Subscr_Conn(875090371)[0x793860]
|
149
|
Fri Jul 7 13:36:31 2017 <001e> subscr_conn.c:255 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_DONE}: Freeing instance
|
150
|
Fri Jul 7 13:36:31 2017 <001e> fsm.c:273 Process_Access_Request_VLR(875090371)[0x793990]{PR_ARQ_S_DONE}: Deallocated
|
151
|
Fri Jul 7 13:36:31 2017 <0002> subscr_conn.c:255 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_RELEASED}: Freeing instance
|
152
|
Fri Jul 7 13:36:31 2017 <0002> fsm.c:273 Subscr_Conn(875090371)[0x793860]{SUBSCR_CONN_S_RELEASED}: Deallocated
|
153
|
Fri Jul 7 13:36:31 2017 <000a> a_iface.c:413 Sendig clear command to BSC (conn_id=21)
|
154
|
Fri Jul 7 13:36:31 2017 <0000> osmo_msc.c:213 subscr MSISDN:23001: Freeing subscriber connection
|
155
|
Fri Jul 7 13:36:31 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'DLCX 78 1@mgw MGCP 1.0'
|
156
|
Fri Jul 7 13:36:31 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 30
|
157
|
Fri Jul 7 13:36:31 2017 <000b> mgcpgw_client.c:122 MGCP response ignored (NULL cb)
|
158
|
Fri Jul 7 13:36:31 2017 <000a> a_iface.c:508 N-DATA.ind(21, 00 01 21 )
|
159
|
Fri Jul 7 13:36:31 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 00 01 21
|
160
|
Fri Jul 7 13:36:31 2017 <000a> a_iface_bssap.c:612 Rx MSC DT1 BSSMAP CLEAR COMPLETE
|
161
|
Fri Jul 7 13:36:31 2017 <000a> a_iface_bssap.c:244 Releasing connection (conn_id=21)
|
162
|
Fri Jul 7 13:36:31 2017 <000a> a_iface.c:84 Removing connection from active sccp-connection list (conn_id=21)
|
163
|
Fri Jul 7 13:36:37 2017 <000a> a_iface.c:496 N-CONNECT.ind(22, 00 1a 57 05 08 00 00 f1 10 23 6e 75 30 17 0d 05 24 31 03 50 18 82 05 f4 34 28 d1 c3 )
|
164
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 00 1a 57 05 08 00 00 f1 10 23 6e 75 30 17 0d 05 24 31 03 50 18 82 05 f4 34 28 d1 c3
|
165
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:612 Rx MSC DT1 BSSMAP COMPLETE LAYER 3
|
166
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:274 BSC has completed layer 3 connection (conn_id=22)
|
167
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:50 Allocating A-Interface subscriber conn: lac 9070, conn_id 22
|
168
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:68 A-Interface subscriber connection successfully allocated!
|
169
|
Fri Jul 7 13:36:37 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_MM_CM_SERV_REQ (0x5:0x24)
|
170
|
Fri Jul 7 13:36:37 2017 <0002> gsm_04_08.c:665 <- CM SERVICE REQUEST serv_type=0x01 MI(TMSI)=875090371
|
171
|
Fri Jul 7 13:36:37 2017 <0002> fsm.c:229 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_INIT}: Allocated
|
172
|
Fri Jul 7 13:36:37 2017 <0002> subscr_conn.c:344 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START
|
173
|
Fri Jul 7 13:36:37 2017 <0002> subscr_conn.c:66 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_INIT}: state_chg to SUBSCR_CONN_S_NEW
|
174
|
Fri Jul 7 13:36:37 2017 <001e> fsm.c:229 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_INIT}: Allocated
|
175
|
Fri Jul 7 13:36:37 2017 <001e> fsm.c:259 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_INIT}: is child of Subscr_Conn(875090371)[0x798890]
|
176
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:684 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_INIT}: rev=R99 net=GERAN Auth+Ciph
|
177
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:710 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_INIT}: Received Event PR_ARQ_E_START
|
178
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:319 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_INIT}: proc_arq_vlr_fn_post_imsi()
|
179
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:326 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_INIT}: state_chg to PR_ARQ_S_WAIT_AUTH
|
180
|
Fri Jul 7 13:36:37 2017 <001e> fsm.c:229 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_NEEDS_AUTH}: Allocated
|
181
|
Fri Jul 7 13:36:37 2017 <001e> fsm.c:259 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_NEEDS_AUTH}: is child of Process_Access_Request_VLR(875090371)[0x7989c0]
|
182
|
Fri Jul 7 13:36:37 2017 <001e> vlr_auth_fsm.c:602 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_NEEDS_AUTH}: Received Event VLR_AUTH_E_START
|
183
|
Fri Jul 7 13:36:37 2017 <001e> vlr_auth_fsm.c:300 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_NEEDS_AUTH}: state_chg to VLR_SUB_AS_WAIT_RESP
|
184
|
Fri Jul 7 13:36:37 2017 <001e> vlr_auth_fsm.c:263 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_WAIT_RESP}: got auth tuple: use_count=1 key_seq=4
|
185
|
Fri Jul 7 13:36:37 2017 <0002> gsm_04_08.c:553 -> AUTH REQ (rand = 365b163db85f3d6da927315f50a6aecc)
|
186
|
Fri Jul 7 13:36:37 2017 <000a> msc_ifaces.c:50 msc_tx 19 bytes to MSISDN:23001 via RAN_GERAN_A
|
187
|
Fri Jul 7 13:36:37 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=22)
|
188
|
Fri Jul 7 13:36:37 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
189
|
Fri Jul 7 13:36:37 2017 <000a> a_iface.c:150 N-DATA.req(22, 01 00 13 05 12 04 36 5b 16 3d b8 5f 3d 6d a9 27 31 5f 50 a6 ae cc )
|
190
|
Fri Jul 7 13:36:37 2017 <0002> osmo_msc.c:55 MSISDN:23001: bump: conn still being established (SUBSCR_CONN_S_NEW)
|
191
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:322 User has been accepted by MSC.
|
192
|
Fri Jul 7 13:36:37 2017 <000a> a_iface.c:508 N-DATA.ind(22, 01 00 06 05 54 22 f6 bb 72 )
|
193
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 06 05 54 22 f6 bb 72
|
194
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 22
|
195
|
Fri Jul 7 13:36:37 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 22
|
196
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=22)
|
197
|
Fri Jul 7 13:36:37 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14)
|
198
|
Fri Jul 7 13:36:37 2017 <0002> gsm_04_08.c:909 MSISDN:23001: MM GSM AUTHENTICATION RESPONSE (sres = 22f6bb72)
|
199
|
Fri Jul 7 13:36:37 2017 <001e> vlr.c:1043 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP
|
200
|
Fri Jul 7 13:36:37 2017 <001e> vlr_auth_fsm.c:142 SUBSCR(MSISDN:23001) received res: 22 f6 bb 72
|
201
|
Fri Jul 7 13:36:37 2017 <001e> vlr_auth_fsm.c:192 SUBSCR(MSISDN:23001) AUTH established GSM security context
|
202
|
Fri Jul 7 13:36:37 2017 <001e> vlr_auth_fsm.c:231 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_WAIT_RESP}: Authentication terminating with result VLR_AUTH_RES_PASSED
|
203
|
Fri Jul 7 13:36:37 2017 <001e> vlr_auth_fsm.c:235 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_WAIT_RESP}: state_chg to VLR_SUB_AS_AUTHENTICATED
|
204
|
Fri Jul 7 13:36:37 2017 <001e> vlr_auth_fsm.c:240 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_AUTHENTICATED}: Terminating (cause = OSMO_FSM_TERM_REGULAR)
|
205
|
Fri Jul 7 13:36:37 2017 <001e> vlr_auth_fsm.c:240 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_AUTHENTICATED}: Removing from parent Process_Access_Request_VLR(875090371)[0x7989c0]
|
206
|
Fri Jul 7 13:36:37 2017 <001e> vlr_auth_fsm.c:240 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_AUTHENTICATED}: Freeing instance
|
207
|
Fri Jul 7 13:36:37 2017 <001e> fsm.c:273 VLR_Authenticate(875090371)[0x798bc0]{VLR_SUB_AS_AUTHENTICATED}: Deallocated
|
208
|
Fri Jul 7 13:36:37 2017 <001e> vlr_auth_fsm.c:240 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_AUTH}: Received Event PR_ARQ_E_AUTH_RES
|
209
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:421 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_AUTH}: got VLR_AUTH_RES_PASSED
|
210
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:284 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_AUTH}: _proc_arq_vlr_node2()
|
211
|
Fri Jul 7 13:36:37 2017 <0002> gsm_04_08.c:3807 -> CIPHER MODE COMMAND MSISDN:23001
|
212
|
Fri Jul 7 13:36:37 2017 <000a> a_iface.c:164 Passing Cipher mode command message from MSC to BSC (conn_id=22)
|
213
|
Fri Jul 7 13:36:37 2017 <000a> a_iface.c:186 N-DATA.req(22, 00 0c 53 0a 09 02 92 d6 10 53 ae 1f 08 00 )
|
214
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:301 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_AUTH}: state_chg to PR_ARQ_S_WAIT_CIPH
|
215
|
Fri Jul 7 13:36:37 2017 <0002> osmo_msc.c:55 MSISDN:23001: bump: conn still being established (SUBSCR_CONN_S_NEW)
|
216
|
Fri Jul 7 13:36:37 2017 <000a> a_iface.c:508 N-DATA.ind(22, 00 12 55 20 0d 06 32 17 09 33 45 62 02 74 92 06 14 f8 2c 02 )
|
217
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 00 12 55 20 0d 06 32 17 09 33 45 62 02 74 92 06 14 f8 2c 02
|
218
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:612 Rx MSC DT1 BSSMAP CIPHER MODE COMPLETE
|
219
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 22
|
220
|
Fri Jul 7 13:36:37 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 22
|
221
|
Fri Jul 7 13:36:37 2017 <000a> a_iface_bssap.c:398 BSC sends cipher mode complete (conn_id=22)
|
222
|
Fri Jul 7 13:36:37 2017 <0003> osmo_msc.c:165 MSISDN:23001: CIPHERING MODE COMPLETE
|
223
|
Fri Jul 7 13:36:37 2017 <001e> vlr.c:1056 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_CIPH}: Received Event PR_ARQ_E_CIPH_RES
|
224
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:484 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_CIPH}: got IMEISV: 3542620472960418
|
225
|
Fri Jul 7 13:36:37 2017 <001e> vlr.c:393 set IMEISV on subscriber; IMSI=001010000000001 IMEISV=3542620472960418
|
226
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:251 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_node2_post_ciph()
|
227
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:223 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_node2_post_vlr()
|
228
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:209 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_post_pres()
|
229
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:194 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_post_trace()
|
230
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:173 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_post_imei()
|
231
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:185 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_CIPH}: proc_arq_fsm_done(VLR_PR_ARQ_RES_PASSED)
|
232
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:108 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_WAIT_CIPH}: state_chg to PR_ARQ_S_DONE
|
233
|
Fri Jul 7 13:36:37 2017 <001e> vlr_access_req_fsm.c:118 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_DONE}: Process Access Request result: VLR_PR_ARQ_RES_PASSED
|
234
|
Fri Jul 7 13:36:37 2017 <0002> vlr_access_req_fsm.c:157 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_NEW}: Received Event SUBSCR_CONN_E_ACCEPTED
|
235
|
Fri Jul 7 13:36:37 2017 <0002> subscr_conn.c:77 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_NEW}: SUBSCR_CONN_FROM_CM_SERVICE_REQ
|
236
|
Fri Jul 7 13:36:37 2017 <0002> subscr_conn.c:84 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_NEW}: state_chg to SUBSCR_CONN_S_ACCEPTED
|
237
|
Fri Jul 7 13:36:37 2017 <0002> subscr_conn.c:129 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_ACCEPTED}: received_cm_service_request = true
|
238
|
Fri Jul 7 13:36:37 2017 <0002> subscr_conn.c:132 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP
|
239
|
Fri Jul 7 13:36:37 2017 <0002> subscr_conn.c:146 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_ACCEPTED}: bump: still awaiting first request after a CM Service Request
|
240
|
Fri Jul 7 13:36:38 2017 <000a> a_iface.c:508 N-DATA.ind(22, 01 00 1a 03 85 04 06 60 04 05 02 00 81 5e 04 81 32 00 f6 40 08 04 02 60 00 00 02 1f 00 )
|
241
|
Fri Jul 7 13:36:38 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 1a 03 85 04 06 60 04 05 02 00 81 5e 04 81 32 00 f6 40 08 04 02 60 00 00 02 1f 00
|
242
|
Fri Jul 7 13:36:38 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 22
|
243
|
Fri Jul 7 13:36:38 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 22
|
244
|
Fri Jul 7 13:36:38 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=22)
|
245
|
Fri Jul 7 13:36:38 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_CC_SETUP (0x3:0x5)
|
246
|
Fri Jul 7 13:36:38 2017 <0001> gsm_04_08.c:3521 Unknown transaction ID 8, creating new trans.
|
247
|
Fri Jul 7 13:36:38 2017 <0001> transaction.c:89 subscr=0x7144b0, net=0x668640
|
248
|
Fri Jul 7 13:36:38 2017 <0002> gsm_04_08.c:3610 MSISDN:23001: rx msg GSM48_MT_CC_SETUP: received_cm_service_request changes to false
|
249
|
Fri Jul 7 13:36:38 2017 <0001> gsm_04_08.c:1232 new state NULL -> INITIATED
|
250
|
Fri Jul 7 13:36:38 2017 <0001> gsm_04_08.c:1864 Subscriber MSISDN:23001 (23001) sends SETUP to 23006
|
251
|
Fri Jul 7 13:36:38 2017 <0006> mncc_builtin.c:352 (call 8000000f) Call created.
|
252
|
Fri Jul 7 13:36:38 2017 <0006> mncc_builtin.c:361 (call 8000000f) Received message MNCC_SETUP_IND
|
253
|
Fri Jul 7 13:36:38 2017 <0006> mncc_builtin.c:125 (call 8000000f) Creating new remote instance f.
|
254
|
Fri Jul 7 13:36:38 2017 <0006> mncc_builtin.c:134 (call 8000000f) Accepting call.
|
255
|
Fri Jul 7 13:36:38 2017 <0006> gsm_04_08.c:3198 receive message MNCC_CALL_PROC_REQ
|
256
|
Fri Jul 7 13:36:38 2017 <0001> gsm_04_08.c:3416 (ti 08 sub 23001) Received 'MNCC_CALL_PROC_REQ' from MNCC in state 1 (INITIATED)
|
257
|
Fri Jul 7 13:36:38 2017 <0001> gsm_04_08.c:1232 new state INITIATED -> MO_CALL_PROC
|
258
|
Fri Jul 7 13:36:38 2017 <000a> msc_ifaces.c:50 msc_tx 2 bytes to MSISDN:23001 via RAN_GERAN_A
|
259
|
Fri Jul 7 13:36:38 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=22)
|
260
|
Fri Jul 7 13:36:38 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
261
|
Fri Jul 7 13:36:38 2017 <000a> a_iface.c:150 N-DATA.req(22, 01 00 02 83 02 )
|
262
|
Fri Jul 7 13:36:38 2017 <000b> mgcpgw_client.c:507 Queued 30 bytes for MGCP GW
|
263
|
Fri Jul 7 13:36:38 2017 <000b> mgcpgw_client.c:507 Queued 66 bytes for MGCP GW
|
264
|
Fri Jul 7 13:36:38 2017 <0006> mncc_builtin.c:142 (call 8000000f) Modify channel mode: SPEECH_AMR
|
265
|
Fri Jul 7 13:36:38 2017 <0006> gsm_04_08.c:3198 receive message MNCC_LCHAN_MODIFY
|
266
|
Fri Jul 7 13:36:38 2017 <0001> gsm_04_08.c:3416 (ti 08 sub 23001) Received 'MNCC_LCHAN_MODIFY' from MNCC in state 3 (MO_CALL_PROC)
|
267
|
Fri Jul 7 13:36:38 2017 <0006> mncc_builtin.c:149 (call 8000000f) Forwarding SETUP to remote.
|
268
|
Fri Jul 7 13:36:38 2017 <0006> gsm_04_08.c:3198 receive message MNCC_SETUP_REQ
|
269
|
Fri Jul 7 13:36:38 2017 <0001> transaction.c:89 subscr=0x71c0b0, net=0x668640
|
270
|
Fri Jul 7 13:36:38 2017 <0002> gsm_subscriber.c:146 Subscriber MSISDN:23006 not paged yet, start paging.
|
271
|
Fri Jul 7 13:36:38 2017 <000a> a_iface.c:211 Passing paging message from MSC RI=7,PC=1,SSN=254,GTI=0 to BSC RI=7,PC=1,SSN=254,GTI=0 (imsi=001010000000006, tmsi=0xbd50764e, lac=9070)
|
272
|
Fri Jul 7 13:36:38 2017 <0002> subscr_conn.c:366 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING
|
273
|
Fri Jul 7 13:36:38 2017 <0002> subscr_conn.c:182 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING
|
274
|
Fri Jul 7 13:36:38 2017 <0002> osmo_msc.c:58 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP
|
275
|
Fri Jul 7 13:36:38 2017 <0002> subscr_conn.c:164 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_COMMUNICATING}: bump: connection still has active transaction: GSM48_PDISC_CC
|
276
|
Fri Jul 7 13:36:38 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'DLCX 79 1@mgw MGCP 1.0'
|
277
|
Fri Jul 7 13:36:38 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 30
|
278
|
Fri Jul 7 13:36:38 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'CRCX 80 1@mgw MGCP 1.0'
|
279
|
Fri Jul 7 13:36:38 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 66
|
280
|
Fri Jul 7 13:36:38 2017 <000b> mgcpgw_client.c:122 MGCP response ignored (NULL cb)
|
281
|
Fri Jul 7 13:36:38 2017 <000a> a_iface.c:377 Sending assignment command to BSC (conn_id 22)
|
282
|
Fri Jul 7 13:36:38 2017 <000a> a_iface.c:404 N-DATA.req(22, 00 1d 01 0b 07 01 0a a1 a5 91 81 05 7c 06 0a 09 01 65 0f a2 7d 09 83 ff ff 84 07 3f 82 80 81 )
|
283
|
Fri Jul 7 13:36:38 2017 <000a> a_iface.c:508 N-DATA.ind(22, 00 14 02 15 00 21 98 2c 02 40 01 7c 06 0a 09 01 85 3e d0 7e 01 80 )
|
284
|
Fri Jul 7 13:36:38 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 00 14 02 15 00 21 98 2c 02 40 01 7c 06 0a 09 01 85 3e d0 7e 01 80
|
285
|
Fri Jul 7 13:36:38 2017 <000a> a_iface_bssap.c:612 Rx MSC DT1 BSSMAP ASSIGNMENT COMPL
|
286
|
Fri Jul 7 13:36:38 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 22
|
287
|
Fri Jul 7 13:36:38 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 22
|
288
|
Fri Jul 7 13:36:38 2017 <000a> a_iface_bssap.c:561 BSC sends assignment complete message (conn_id=22)
|
289
|
Fri Jul 7 13:36:38 2017 <0002> gsm_04_08.c:3835 <- SECURITY MODE COMPLETE MSISDN:23001
|
290
|
Fri Jul 7 13:36:39 2017 <000a> a_iface.c:496 N-CONNECT.ind(23, 00 1a 57 05 08 00 00 f1 10 23 6e 75 30 17 0d 06 27 01 03 50 18 80 05 f4 bd 50 76 4e )
|
291
|
Fri Jul 7 13:36:39 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 00 1a 57 05 08 00 00 f1 10 23 6e 75 30 17 0d 06 27 01 03 50 18 80 05 f4 bd 50 76 4e
|
292
|
Fri Jul 7 13:36:39 2017 <000a> a_iface_bssap.c:612 Rx MSC DT1 BSSMAP COMPLETE LAYER 3
|
293
|
Fri Jul 7 13:36:39 2017 <000a> a_iface_bssap.c:274 BSC has completed layer 3 connection (conn_id=23)
|
294
|
Fri Jul 7 13:36:39 2017 <000a> a_iface_bssap.c:50 Allocating A-Interface subscriber conn: lac 9070, conn_id 23
|
295
|
Fri Jul 7 13:36:39 2017 <000a> a_iface_bssap.c:68 A-Interface subscriber connection successfully allocated!
|
296
|
Fri Jul 7 13:36:39 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_RR_PAG_RESP (0x6:0x27)
|
297
|
Fri Jul 7 13:36:39 2017 <0003> gsm_04_08.c:1090 PAGING RESPONSE: MI(TMSI)=3176166990
|
298
|
Fri Jul 7 13:36:39 2017 <0002> fsm.c:229 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_INIT}: Allocated
|
299
|
Fri Jul 7 13:36:39 2017 <0002> subscr_conn.c:344 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_INIT}: Received Event SUBSCR_CONN_E_START
|
300
|
Fri Jul 7 13:36:39 2017 <0002> subscr_conn.c:66 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_INIT}: state_chg to SUBSCR_CONN_S_NEW
|
301
|
Fri Jul 7 13:36:39 2017 <001e> fsm.c:229 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_INIT}: Allocated
|
302
|
Fri Jul 7 13:36:39 2017 <001e> fsm.c:259 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_INIT}: is child of Subscr_Conn(3176166990)[0x79ffc0]
|
303
|
Fri Jul 7 13:36:39 2017 <001e> vlr_access_req_fsm.c:684 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_INIT}: rev=R99 net=GERAN Auth+Ciph
|
304
|
Fri Jul 7 13:36:39 2017 <001e> vlr_access_req_fsm.c:710 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_INIT}: Received Event PR_ARQ_E_START
|
305
|
Fri Jul 7 13:36:39 2017 <001e> vlr_access_req_fsm.c:319 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_INIT}: proc_arq_vlr_fn_post_imsi()
|
306
|
Fri Jul 7 13:36:39 2017 <001e> vlr_access_req_fsm.c:326 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_INIT}: state_chg to PR_ARQ_S_WAIT_AUTH
|
307
|
Fri Jul 7 13:36:39 2017 <001e> fsm.c:229 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_NEEDS_AUTH}: Allocated
|
308
|
Fri Jul 7 13:36:39 2017 <001e> fsm.c:259 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_NEEDS_AUTH}: is child of Process_Access_Request_VLR(3176166990)[0x7a00f0]
|
309
|
Fri Jul 7 13:36:39 2017 <001e> vlr_auth_fsm.c:602 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_NEEDS_AUTH}: Received Event VLR_AUTH_E_START
|
310
|
Fri Jul 7 13:36:39 2017 <001e> vlr_auth_fsm.c:300 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_NEEDS_AUTH}: state_chg to VLR_SUB_AS_WAIT_RESP
|
311
|
Fri Jul 7 13:36:39 2017 <001e> vlr_auth_fsm.c:263 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_WAIT_RESP}: got auth tuple: use_count=1 key_seq=2
|
312
|
Fri Jul 7 13:36:39 2017 <0002> gsm_04_08.c:553 -> AUTH REQ (rand = d0f1e379ab2f94437cfb5b5e3d3ff7aa)
|
313
|
Fri Jul 7 13:36:39 2017 <000a> msc_ifaces.c:50 msc_tx 19 bytes to MSISDN:23006 via RAN_GERAN_A
|
314
|
Fri Jul 7 13:36:39 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=23)
|
315
|
Fri Jul 7 13:36:39 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
316
|
Fri Jul 7 13:36:39 2017 <000a> a_iface.c:150 N-DATA.req(23, 01 00 13 05 12 02 d0 f1 e3 79 ab 2f 94 43 7c fb 5b 5e 3d 3f f7 aa )
|
317
|
Fri Jul 7 13:36:39 2017 <0002> osmo_msc.c:55 MSISDN:23006: bump: conn still being established (SUBSCR_CONN_S_NEW)
|
318
|
Fri Jul 7 13:36:39 2017 <000a> a_iface_bssap.c:322 User has been accepted by MSC.
|
319
|
Fri Jul 7 13:36:39 2017 <000a> a_iface.c:508 N-DATA.ind(23, 01 00 06 05 14 b9 05 2e e8 )
|
320
|
Fri Jul 7 13:36:39 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 06 05 14 b9 05 2e e8
|
321
|
Fri Jul 7 13:36:39 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 23
|
322
|
Fri Jul 7 13:36:39 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 23
|
323
|
Fri Jul 7 13:36:39 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=23)
|
324
|
Fri Jul 7 13:36:39 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_MM_AUTH_RESP (0x5:0x14)
|
325
|
Fri Jul 7 13:36:39 2017 <0002> gsm_04_08.c:909 MSISDN:23006: MM GSM AUTHENTICATION RESPONSE (sres = b9052ee8)
|
326
|
Fri Jul 7 13:36:39 2017 <001e> vlr.c:1043 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_WAIT_RESP}: Received Event VLR_AUTH_E_MS_AUTH_RESP
|
327
|
Fri Jul 7 13:36:39 2017 <001e> vlr_auth_fsm.c:142 SUBSCR(MSISDN:23006) received res: b9 05 2e e8
|
328
|
Fri Jul 7 13:36:39 2017 <001e> vlr_auth_fsm.c:192 SUBSCR(MSISDN:23006) AUTH established GSM security context
|
329
|
Fri Jul 7 13:36:39 2017 <001e> vlr_auth_fsm.c:231 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_WAIT_RESP}: Authentication terminating with result VLR_AUTH_RES_PASSED
|
330
|
Fri Jul 7 13:36:39 2017 <001e> vlr_auth_fsm.c:235 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_WAIT_RESP}: state_chg to VLR_SUB_AS_AUTHENTICATED
|
331
|
Fri Jul 7 13:36:39 2017 <001e> vlr_auth_fsm.c:240 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_AUTHENTICATED}: Terminating (cause = OSMO_FSM_TERM_REGULAR)
|
332
|
Fri Jul 7 13:36:39 2017 <001e> vlr_auth_fsm.c:240 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_AUTHENTICATED}: Removing from parent Process_Access_Request_VLR(3176166990)[0x7a00f0]
|
333
|
Fri Jul 7 13:36:39 2017 <001e> vlr_auth_fsm.c:240 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_AUTHENTICATED}: Freeing instance
|
334
|
Fri Jul 7 13:36:39 2017 <001e> fsm.c:273 VLR_Authenticate(3176166990)[0x7a0390]{VLR_SUB_AS_AUTHENTICATED}: Deallocated
|
335
|
Fri Jul 7 13:36:39 2017 <001e> vlr_auth_fsm.c:240 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_AUTH}: Received Event PR_ARQ_E_AUTH_RES
|
336
|
Fri Jul 7 13:36:39 2017 <001e> vlr_access_req_fsm.c:421 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_AUTH}: got VLR_AUTH_RES_PASSED
|
337
|
Fri Jul 7 13:36:39 2017 <001e> vlr_access_req_fsm.c:284 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_AUTH}: _proc_arq_vlr_node2()
|
338
|
Fri Jul 7 13:36:39 2017 <0002> gsm_04_08.c:3807 -> CIPHER MODE COMMAND MSISDN:23006
|
339
|
Fri Jul 7 13:36:39 2017 <000a> a_iface.c:164 Passing Cipher mode command message from MSC to BSC (conn_id=23)
|
340
|
Fri Jul 7 13:36:39 2017 <000a> a_iface.c:186 N-DATA.req(23, 00 0c 53 0a 09 02 58 43 83 be 79 1c d0 00 )
|
341
|
Fri Jul 7 13:36:39 2017 <001e> vlr_access_req_fsm.c:301 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_AUTH}: state_chg to PR_ARQ_S_WAIT_CIPH
|
342
|
Fri Jul 7 13:36:39 2017 <0002> osmo_msc.c:55 MSISDN:23006: bump: conn still being established (SUBSCR_CONN_S_NEW)
|
343
|
Fri Jul 7 13:36:40 2017 <000a> a_iface.c:508 N-DATA.ind(23, 00 12 55 20 0d 06 32 17 09 33 15 48 06 83 69 64 55 f2 2c 02 )
|
344
|
Fri Jul 7 13:36:40 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 00 12 55 20 0d 06 32 17 09 33 15 48 06 83 69 64 55 f2 2c 02
|
345
|
Fri Jul 7 13:36:40 2017 <000a> a_iface_bssap.c:612 Rx MSC DT1 BSSMAP CIPHER MODE COMPLETE
|
346
|
Fri Jul 7 13:36:40 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 23
|
347
|
Fri Jul 7 13:36:40 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 23
|
348
|
Fri Jul 7 13:36:40 2017 <000a> a_iface_bssap.c:398 BSC sends cipher mode complete (conn_id=23)
|
349
|
Fri Jul 7 13:36:40 2017 <0003> osmo_msc.c:165 MSISDN:23006: CIPHERING MODE COMPLETE
|
350
|
Fri Jul 7 13:36:40 2017 <001e> vlr.c:1056 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_CIPH}: Received Event PR_ARQ_E_CIPH_RES
|
351
|
Fri Jul 7 13:36:40 2017 <001e> vlr_access_req_fsm.c:484 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_CIPH}: got IMEISV: 3518460389646552
|
352
|
Fri Jul 7 13:36:40 2017 <001e> vlr.c:393 set IMEISV on subscriber; IMSI=001010000000006 IMEISV=3518460389646552
|
353
|
Fri Jul 7 13:36:40 2017 <001e> vlr_access_req_fsm.c:251 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_node2_post_ciph()
|
354
|
Fri Jul 7 13:36:40 2017 <001e> vlr_access_req_fsm.c:223 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_node2_post_vlr()
|
355
|
Fri Jul 7 13:36:40 2017 <001e> vlr_access_req_fsm.c:209 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_post_pres()
|
356
|
Fri Jul 7 13:36:40 2017 <001e> vlr_access_req_fsm.c:194 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_post_trace()
|
357
|
Fri Jul 7 13:36:40 2017 <001e> vlr_access_req_fsm.c:173 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_CIPH}: _proc_arq_vlr_post_imei()
|
358
|
Fri Jul 7 13:36:40 2017 <001e> vlr_access_req_fsm.c:185 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_CIPH}: proc_arq_fsm_done(VLR_PR_ARQ_RES_PASSED)
|
359
|
Fri Jul 7 13:36:40 2017 <001e> vlr_access_req_fsm.c:108 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_WAIT_CIPH}: state_chg to PR_ARQ_S_DONE
|
360
|
Fri Jul 7 13:36:40 2017 <001e> vlr_access_req_fsm.c:118 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_DONE}: Process Access Request result: VLR_PR_ARQ_RES_PASSED
|
361
|
Fri Jul 7 13:36:40 2017 <0002> vlr_access_req_fsm.c:157 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_NEW}: Received Event SUBSCR_CONN_E_ACCEPTED
|
362
|
Fri Jul 7 13:36:40 2017 <0002> subscr_conn.c:77 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_NEW}: SUBSCR_CONN_FROM_PAGING_RESP
|
363
|
Fri Jul 7 13:36:40 2017 <0002> subscr_conn.c:84 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_NEW}: state_chg to SUBSCR_CONN_S_ACCEPTED
|
364
|
Fri Jul 7 13:36:40 2017 <0007> gsm_subscriber.c:69 Paging success for MSISDN:23006 (event=0)
|
365
|
Fri Jul 7 13:36:40 2017 <0007> osmo_msc.c:326 Paging can stop for MSISDN:23006
|
366
|
Fri Jul 7 13:36:40 2017 <0007> gsm_subscriber.c:93 Calling paging cbfn.
|
367
|
Fri Jul 7 13:36:40 2017 <0001> gsm_04_08.c:1369 Paging subscr 23006 succeeded!
|
368
|
Fri Jul 7 13:36:40 2017 <0001> gsm_04_08.c:1780 starting timer T303 with 30 seconds
|
369
|
Fri Jul 7 13:36:40 2017 <0001> gsm_04_08.c:1232 new state NULL -> CALL_PRESENT
|
370
|
Fri Jul 7 13:36:40 2017 <000a> msc_ifaces.c:50 msc_tx 22 bytes to MSISDN:23006 via RAN_GERAN_A
|
371
|
Fri Jul 7 13:36:40 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=23)
|
372
|
Fri Jul 7 13:36:40 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
373
|
Fri Jul 7 13:36:40 2017 <000a> a_iface.c:150 N-DATA.req(23, 01 00 16 03 05 04 06 60 04 05 02 00 81 5c 04 80 32 00 f1 5e 04 81 32 00 f6 )
|
374
|
Fri Jul 7 13:36:40 2017 <0002> subscr_conn.c:132 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_BUMP
|
375
|
Fri Jul 7 13:36:40 2017 <0002> subscr_conn.c:164 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_ACCEPTED}: bump: connection still has active transaction: GSM48_PDISC_CC
|
376
|
Fri Jul 7 13:36:40 2017 <000a> a_iface.c:508 N-DATA.ind(23, 01 00 0e 83 48 04 06 60 04 02 00 05 81 15 02 01 00 )
|
377
|
Fri Jul 7 13:36:40 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 0e 83 48 04 06 60 04 02 00 05 81 15 02 01 00
|
378
|
Fri Jul 7 13:36:40 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 23
|
379
|
Fri Jul 7 13:36:40 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 23
|
380
|
Fri Jul 7 13:36:40 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=23)
|
381
|
Fri Jul 7 13:36:40 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_CC_CALL_CONF (0x3:0x8)
|
382
|
Fri Jul 7 13:36:40 2017 <0001> gsm_04_08.c:1272 stopping pending timer T303
|
383
|
Fri Jul 7 13:36:40 2017 <0001> gsm_04_08.c:1780 starting timer T310 with 180 seconds
|
384
|
Fri Jul 7 13:36:40 2017 <0001> gsm_04_08.c:1232 new state CALL_PRESENT -> MO_TERM_CALL_CONF
|
385
|
Fri Jul 7 13:36:40 2017 <000b> mgcpgw_client.c:507 Queued 30 bytes for MGCP GW
|
386
|
Fri Jul 7 13:36:40 2017 <000b> mgcpgw_client.c:507 Queued 66 bytes for MGCP GW
|
387
|
Fri Jul 7 13:36:40 2017 <0006> mncc_builtin.c:361 (call f) Received message MNCC_CALL_CONF_IND
|
388
|
Fri Jul 7 13:36:40 2017 <0006> gsm_04_08.c:3198 receive message MNCC_LCHAN_MODIFY
|
389
|
Fri Jul 7 13:36:40 2017 <0001> gsm_04_08.c:3416 (ti 00 sub 23006) Received 'MNCC_LCHAN_MODIFY' from MNCC in state 9 (MO_TERM_CALL_CONF)
|
390
|
Fri Jul 7 13:36:40 2017 <0002> subscr_conn.c:366 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_ACCEPTED}: Received Event SUBSCR_CONN_E_COMMUNICATING
|
391
|
Fri Jul 7 13:36:40 2017 <0002> subscr_conn.c:182 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_ACCEPTED}: state_chg to SUBSCR_CONN_S_COMMUNICATING
|
392
|
Fri Jul 7 13:36:40 2017 <0002> osmo_msc.c:58 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP
|
393
|
Fri Jul 7 13:36:40 2017 <0002> subscr_conn.c:164 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: bump: connection still has active transaction: GSM48_PDISC_CC
|
394
|
Fri Jul 7 13:36:40 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'DLCX 81 2@mgw MGCP 1.0'
|
395
|
Fri Jul 7 13:36:40 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 30
|
396
|
Fri Jul 7 13:36:40 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'CRCX 82 2@mgw MGCP 1.0'
|
397
|
Fri Jul 7 13:36:40 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 66
|
398
|
Fri Jul 7 13:36:40 2017 <000b> mgcpgw_client.c:122 MGCP response ignored (NULL cb)
|
399
|
Fri Jul 7 13:36:40 2017 <000a> a_iface.c:377 Sending assignment command to BSC (conn_id 23)
|
400
|
Fri Jul 7 13:36:40 2017 <000a> a_iface.c:404 N-DATA.req(23, 00 1d 01 0b 07 01 0a a1 91 81 a5 05 7c 06 0a 09 01 65 0f a4 7d 09 83 ff ff 82 80 84 07 3f 81 )
|
401
|
Fri Jul 7 13:36:41 2017 <000a> a_iface.c:508 N-DATA.ind(23, 00 14 02 15 00 21 98 2c 02 40 01 7c 06 0a 09 01 85 74 40 7e 01 80 )
|
402
|
Fri Jul 7 13:36:41 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 00 14 02 15 00 21 98 2c 02 40 01 7c 06 0a 09 01 85 74 40 7e 01 80
|
403
|
Fri Jul 7 13:36:41 2017 <000a> a_iface_bssap.c:612 Rx MSC DT1 BSSMAP ASSIGNMENT COMPL
|
404
|
Fri Jul 7 13:36:41 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 23
|
405
|
Fri Jul 7 13:36:41 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 23
|
406
|
Fri Jul 7 13:36:41 2017 <000a> a_iface_bssap.c:561 BSC sends assignment complete message (conn_id=23)
|
407
|
Fri Jul 7 13:36:41 2017 <0002> gsm_04_08.c:3835 <- SECURITY MODE COMPLETE MSISDN:23006
|
408
|
Fri Jul 7 13:36:41 2017 <000a> a_iface.c:508 N-DATA.ind(23, 01 00 02 83 81 )
|
409
|
Fri Jul 7 13:36:41 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 02 83 81
|
410
|
Fri Jul 7 13:36:41 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 23
|
411
|
Fri Jul 7 13:36:41 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 23
|
412
|
Fri Jul 7 13:36:41 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=23)
|
413
|
Fri Jul 7 13:36:41 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_CC_ALERTING (0x3:0x1)
|
414
|
Fri Jul 7 13:36:41 2017 <0001> gsm_04_08.c:1272 stopping pending timer T310
|
415
|
Fri Jul 7 13:36:41 2017 <0001> gsm_04_08.c:1780 starting timer T301 with 180 seconds
|
416
|
Fri Jul 7 13:36:41 2017 <0001> gsm_04_08.c:1232 new state MO_TERM_CALL_CONF -> CALL_RECEIVED
|
417
|
Fri Jul 7 13:36:41 2017 <0006> mncc_builtin.c:361 (call f) Received message MNCC_ALERT_IND
|
418
|
Fri Jul 7 13:36:41 2017 <0006> mncc_builtin.c:167 (call f) Forwarding ALERT to remote.
|
419
|
Fri Jul 7 13:36:41 2017 <0006> gsm_04_08.c:3198 receive message MNCC_ALERT_REQ
|
420
|
Fri Jul 7 13:36:41 2017 <0001> gsm_04_08.c:3416 (ti 08 sub 23001) Received 'MNCC_ALERT_REQ' from MNCC in state 3 (MO_CALL_PROC)
|
421
|
Fri Jul 7 13:36:41 2017 <0001> gsm_04_08.c:1232 new state MO_CALL_PROC -> CALL_DELIVERED
|
422
|
Fri Jul 7 13:36:41 2017 <000a> msc_ifaces.c:50 msc_tx 2 bytes to MSISDN:23001 via RAN_GERAN_A
|
423
|
Fri Jul 7 13:36:41 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=22)
|
424
|
Fri Jul 7 13:36:41 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
425
|
Fri Jul 7 13:36:41 2017 <000a> a_iface.c:150 N-DATA.req(22, 01 00 02 83 01 )
|
426
|
Fri Jul 7 13:36:41 2017 <0002> subscr_conn.c:366 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING
|
427
|
Fri Jul 7 13:36:41 2017 <0002> osmo_msc.c:58 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP
|
428
|
Fri Jul 7 13:36:41 2017 <0002> subscr_conn.c:164 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: bump: connection still has active transaction: GSM48_PDISC_CC
|
429
|
Fri Jul 7 13:36:42 2017 <000a> a_iface.c:508 N-DATA.ind(23, 01 00 02 83 c7 )
|
430
|
Fri Jul 7 13:36:42 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 02 83 c7
|
431
|
Fri Jul 7 13:36:42 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 23
|
432
|
Fri Jul 7 13:36:42 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 23
|
433
|
Fri Jul 7 13:36:42 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=23)
|
434
|
Fri Jul 7 13:36:42 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_CC_CONNECT (0x3:0x7)
|
435
|
Fri Jul 7 13:36:42 2017 <0001> gsm_04_08.c:1272 stopping pending timer T301
|
436
|
Fri Jul 7 13:36:42 2017 <0001> gsm_04_08.c:1232 new state CALL_RECEIVED -> CONNECT_REQUEST
|
437
|
Fri Jul 7 13:36:42 2017 <0006> mncc_builtin.c:361 (call f) Received message MNCC_SETUP_CNF
|
438
|
Fri Jul 7 13:36:42 2017 <0006> mncc_builtin.c:195 (call f) Acknowledge SETUP.
|
439
|
Fri Jul 7 13:36:42 2017 <0006> gsm_04_08.c:3198 receive message MNCC_SETUP_COMPL_REQ
|
440
|
Fri Jul 7 13:36:42 2017 <0001> gsm_04_08.c:3416 (ti 00 sub 23006) Received 'MNCC_SETUP_COMPL_REQ' from MNCC in state 8 (CONNECT_REQUEST)
|
441
|
Fri Jul 7 13:36:42 2017 <0001> gsm_04_08.c:1232 new state CONNECT_REQUEST -> ACTIVE
|
442
|
Fri Jul 7 13:36:42 2017 <000a> msc_ifaces.c:50 msc_tx 2 bytes to MSISDN:23006 via RAN_GERAN_A
|
443
|
Fri Jul 7 13:36:42 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=23)
|
444
|
Fri Jul 7 13:36:42 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
445
|
Fri Jul 7 13:36:42 2017 <000a> a_iface.c:150 N-DATA.req(23, 01 00 02 03 0f )
|
446
|
Fri Jul 7 13:36:42 2017 <0006> mncc_builtin.c:202 (call f) Sending CONNECT to remote.
|
447
|
Fri Jul 7 13:36:42 2017 <0006> gsm_04_08.c:3198 receive message MNCC_SETUP_RSP
|
448
|
Fri Jul 7 13:36:42 2017 <0001> gsm_04_08.c:3416 (ti 08 sub 23001) Received 'MNCC_SETUP_RSP' from MNCC in state 4 (CALL_DELIVERED)
|
449
|
Fri Jul 7 13:36:42 2017 <0001> gsm_04_08.c:1780 starting timer T313 with 30 seconds
|
450
|
Fri Jul 7 13:36:42 2017 <0001> gsm_04_08.c:1232 new state CALL_DELIVERED -> CONNECT_IND
|
451
|
Fri Jul 7 13:36:42 2017 <000a> msc_ifaces.c:50 msc_tx 8 bytes to MSISDN:23001 via RAN_GERAN_A
|
452
|
Fri Jul 7 13:36:42 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=22)
|
453
|
Fri Jul 7 13:36:42 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
454
|
Fri Jul 7 13:36:42 2017 <000a> a_iface.c:150 N-DATA.req(22, 01 00 08 83 07 4c 04 80 32 00 f6 )
|
455
|
Fri Jul 7 13:36:42 2017 <0006> mncc_builtin.c:208 (call f) Bridging with remote.
|
456
|
Fri Jul 7 13:36:42 2017 <0006> gsm_04_08.c:3198 receive message MNCC_BRIDGE
|
457
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:507 Queued 87 bytes for MGCP GW
|
458
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:507 Queued 87 bytes for MGCP GW
|
459
|
Fri Jul 7 13:36:42 2017 <0002> subscr_conn.c:366 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING
|
460
|
Fri Jul 7 13:36:42 2017 <0002> osmo_msc.c:58 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP
|
461
|
Fri Jul 7 13:36:42 2017 <0002> subscr_conn.c:164 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: bump: connection still has active transaction: GSM48_PDISC_CC
|
462
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'MDCX 83 2@mgw MGCP 1.0'
|
463
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 87
|
464
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'MDCX 84 1@mgw MGCP 1.0'
|
465
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 87
|
466
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:507 Queued 87 bytes for MGCP GW
|
467
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:507 Queued 87 bytes for MGCP GW
|
468
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'MDCX 85 1@mgw MGCP 1.0'
|
469
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 87
|
470
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'MDCX 86 2@mgw MGCP 1.0'
|
471
|
Fri Jul 7 13:36:42 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 87
|
472
|
Fri Jul 7 13:36:42 2017 <000a> a_iface.c:508 N-DATA.ind(22, 01 00 02 03 cf )
|
473
|
Fri Jul 7 13:36:42 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 02 03 cf
|
474
|
Fri Jul 7 13:36:42 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 22
|
475
|
Fri Jul 7 13:36:42 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 22
|
476
|
Fri Jul 7 13:36:42 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=22)
|
477
|
Fri Jul 7 13:36:42 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_CC_CONNECT_ACK (0x3:0xf)
|
478
|
Fri Jul 7 13:36:42 2017 <0001> gsm_04_08.c:1272 stopping pending timer T313
|
479
|
Fri Jul 7 13:36:42 2017 <0001> gsm_04_08.c:1232 new state CONNECT_IND -> ACTIVE
|
480
|
Fri Jul 7 13:36:42 2017 <0006> mncc_builtin.c:361 (call 8000000f) Received message MNCC_SETUP_COMPL_IND
|
481
|
Fri Jul 7 13:36:42 2017 <0002> subscr_conn.c:366 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING
|
482
|
Fri Jul 7 13:36:42 2017 <0002> osmo_msc.c:58 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP
|
483
|
Fri Jul 7 13:36:42 2017 <0002> subscr_conn.c:164 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_COMMUNICATING}: bump: connection still has active transaction: GSM48_PDISC_CC
|
484
|
Fri Jul 7 13:36:47 2017 <000a> a_iface.c:508 N-DATA.ind(23, 01 00 05 83 25 02 e0 90 )
|
485
|
Fri Jul 7 13:36:47 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 05 83 25 02 e0 90
|
486
|
Fri Jul 7 13:36:47 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 23
|
487
|
Fri Jul 7 13:36:47 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 23
|
488
|
Fri Jul 7 13:36:47 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=23)
|
489
|
Fri Jul 7 13:36:47 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_CC_DISCONNECT (0x3:0x25)
|
490
|
Fri Jul 7 13:36:47 2017 <0001> gsm_04_08.c:1232 new state ACTIVE -> DISCONNECT_IND
|
491
|
Fri Jul 7 13:36:47 2017 <0006> mncc_builtin.c:361 (call f) Received message MNCC_DISC_IND
|
492
|
Fri Jul 7 13:36:47 2017 <0006> mncc_builtin.c:240 (call f) Releasing call with cause 16
|
493
|
Fri Jul 7 13:36:47 2017 <0006> gsm_04_08.c:3198 receive message MNCC_REL_REQ
|
494
|
Fri Jul 7 13:36:47 2017 <0001> gsm_04_08.c:3416 (ti 00 sub 23006) Received 'MNCC_REL_REQ' from MNCC in state 12 (DISCONNECT_IND)
|
495
|
Fri Jul 7 13:36:47 2017 <0001> gsm_04_08.c:1780 starting timer T308 with 10 seconds
|
496
|
Fri Jul 7 13:36:47 2017 <0001> gsm_04_08.c:1232 new state DISCONNECT_IND -> RELEASE_REQ
|
497
|
Fri Jul 7 13:36:47 2017 <000a> msc_ifaces.c:50 msc_tx 6 bytes to MSISDN:23006 via RAN_GERAN_A
|
498
|
Fri Jul 7 13:36:47 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=23)
|
499
|
Fri Jul 7 13:36:47 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
500
|
Fri Jul 7 13:36:47 2017 <000a> a_iface.c:150 N-DATA.req(23, 01 00 06 03 2d 08 02 e0 90 )
|
501
|
Fri Jul 7 13:36:47 2017 <0006> mncc_builtin.c:249 (call 8000000f) Disconnecting remote with cause 16
|
502
|
Fri Jul 7 13:36:47 2017 <0006> gsm_04_08.c:3198 receive message MNCC_DISC_REQ
|
503
|
Fri Jul 7 13:36:47 2017 <0001> gsm_04_08.c:3416 (ti 08 sub 23001) Received 'MNCC_DISC_REQ' from MNCC in state 10 (ACTIVE)
|
504
|
Fri Jul 7 13:36:47 2017 <0001> gsm_04_08.c:1780 starting timer T306 with 30 seconds
|
505
|
Fri Jul 7 13:36:47 2017 <0001> gsm_04_08.c:1232 new state ACTIVE -> DISCONNECT_IND
|
506
|
Fri Jul 7 13:36:47 2017 <000a> msc_ifaces.c:50 msc_tx 5 bytes to MSISDN:23001 via RAN_GERAN_A
|
507
|
Fri Jul 7 13:36:47 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=22)
|
508
|
Fri Jul 7 13:36:47 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
509
|
Fri Jul 7 13:36:47 2017 <000a> a_iface.c:150 N-DATA.req(22, 01 00 05 83 25 02 e0 90 )
|
510
|
Fri Jul 7 13:36:47 2017 <0002> subscr_conn.c:366 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING
|
511
|
Fri Jul 7 13:36:47 2017 <0002> osmo_msc.c:58 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP
|
512
|
Fri Jul 7 13:36:47 2017 <0002> subscr_conn.c:164 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: bump: connection still has active transaction: GSM48_PDISC_CC
|
513
|
Fri Jul 7 13:36:48 2017 <000a> a_iface.c:508 N-DATA.ind(22, 01 00 02 03 2d )
|
514
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 02 03 2d
|
515
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 22
|
516
|
Fri Jul 7 13:36:48 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 22
|
517
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=22)
|
518
|
Fri Jul 7 13:36:48 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_CC_RELEASE (0x3:0x2d)
|
519
|
Fri Jul 7 13:36:48 2017 <0001> gsm_04_08.c:1272 stopping pending timer T306
|
520
|
Fri Jul 7 13:36:48 2017 <000a> msc_ifaces.c:50 msc_tx 2 bytes to MSISDN:23001 via RAN_GERAN_A
|
521
|
Fri Jul 7 13:36:48 2017 <000a> a_iface.c:140 Passing DTAP message from MSC to BSC (conn_id=22)
|
522
|
Fri Jul 7 13:36:48 2017 <000a> a_iface.c:148 Massage will be sent as BSSMAP DTAP message!
|
523
|
Fri Jul 7 13:36:48 2017 <000a> a_iface.c:150 N-DATA.req(22, 01 00 02 83 2a )
|
524
|
Fri Jul 7 13:36:48 2017 <0006> mncc_builtin.c:361 (call 8000000f) Received message MNCC_REL_IND
|
525
|
Fri Jul 7 13:36:48 2017 <0006> mncc_builtin.c:265 (call 8000000f) Releasing remote with cause 0
|
526
|
Fri Jul 7 13:36:48 2017 <0006> mncc_builtin.c:52 (call 8000000f) Call removed.
|
527
|
Fri Jul 7 13:36:48 2017 <0006> gsm_04_08.c:3198 receive message MNCC_REL_REQ
|
528
|
Fri Jul 7 13:36:48 2017 <0001> gsm_04_08.c:3416 (ti 00 sub 23006) Received 'MNCC_REL_REQ' from MNCC in state 19 (RELEASE_REQ)
|
529
|
Fri Jul 7 13:36:48 2017 <0001> gsm_04_08.c:3424 Message unhandled at this state.
|
530
|
Fri Jul 7 13:36:48 2017 <0001> gsm_04_08.c:1232 new state DISCONNECT_IND -> NULL
|
531
|
Fri Jul 7 13:36:48 2017 <000b> mgcpgw_client.c:507 Queued 30 bytes for MGCP GW
|
532
|
Fri Jul 7 13:36:48 2017 <0002> subscr_conn.c:366 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING
|
533
|
Fri Jul 7 13:36:48 2017 <0002> osmo_msc.c:58 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP
|
534
|
Fri Jul 7 13:36:48 2017 <0002> subscr_conn.c:168 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn
|
535
|
Fri Jul 7 13:36:48 2017 <0002> subscr_conn.c:169 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_COMMUNICATING}: state_chg to SUBSCR_CONN_S_RELEASED
|
536
|
Fri Jul 7 13:36:48 2017 <0002> subscr_conn.c:255 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_RELEASED}: Terminating (cause = OSMO_FSM_TERM_REGULAR)
|
537
|
Fri Jul 7 13:36:48 2017 <001e> subscr_conn.c:255 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_DONE}: Terminating (cause = OSMO_FSM_TERM_PARENT)
|
538
|
Fri Jul 7 13:36:48 2017 <001e> subscr_conn.c:255 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_DONE}: Removing from parent Subscr_Conn(875090371)[0x798890]
|
539
|
Fri Jul 7 13:36:48 2017 <001e> subscr_conn.c:255 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_DONE}: Freeing instance
|
540
|
Fri Jul 7 13:36:48 2017 <001e> fsm.c:273 Process_Access_Request_VLR(875090371)[0x7989c0]{PR_ARQ_S_DONE}: Deallocated
|
541
|
Fri Jul 7 13:36:48 2017 <0002> subscr_conn.c:255 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_RELEASED}: Freeing instance
|
542
|
Fri Jul 7 13:36:48 2017 <0002> fsm.c:273 Subscr_Conn(875090371)[0x798890]{SUBSCR_CONN_S_RELEASED}: Deallocated
|
543
|
Fri Jul 7 13:36:48 2017 <000a> a_iface.c:413 Sendig clear command to BSC (conn_id=22)
|
544
|
Fri Jul 7 13:36:48 2017 <0000> osmo_msc.c:213 subscr MSISDN:23001: Freeing subscriber connection
|
545
|
Fri Jul 7 13:36:48 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'DLCX 87 1@mgw MGCP 1.0'
|
546
|
Fri Jul 7 13:36:48 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 30
|
547
|
Fri Jul 7 13:36:48 2017 <000b> mgcpgw_client.c:122 MGCP response ignored (NULL cb)
|
548
|
Fri Jul 7 13:36:48 2017 <000a> a_iface.c:508 N-DATA.ind(22, 00 01 21 )
|
549
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 00 01 21
|
550
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:612 Rx MSC DT1 BSSMAP CLEAR COMPLETE
|
551
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:244 Releasing connection (conn_id=22)
|
552
|
Fri Jul 7 13:36:48 2017 <000a> a_iface.c:84 Removing connection from active sccp-connection list (conn_id=22)
|
553
|
Fri Jul 7 13:36:48 2017 <000a> a_iface.c:508 N-DATA.ind(23, 01 00 02 83 6a )
|
554
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 01 00 02 83 6a
|
555
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:80 Looking for A subscriber: conn_id 23
|
556
|
Fri Jul 7 13:36:48 2017 <001f> a_iface_bssap.c:88 Found A subscriber for conn_id 23
|
557
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:663 BSC sends layer 3 dtap (conn_id=23)
|
558
|
Fri Jul 7 13:36:48 2017 <0000> gsm_04_08.c:3632 Dispatching 04.08 message GSM48_MT_CC_RELEASE_COMPL (0x3:0x2a)
|
559
|
Fri Jul 7 13:36:48 2017 <0001> gsm_04_08.c:1272 stopping pending timer T308
|
560
|
Fri Jul 7 13:36:48 2017 <0006> mncc_builtin.c:361 (call f) Received message MNCC_REL_CNF
|
561
|
Fri Jul 7 13:36:48 2017 <0006> mncc_builtin.c:52 (call f) Call removed.
|
562
|
Fri Jul 7 13:36:48 2017 <000b> mgcpgw_client.c:507 Queued 30 bytes for MGCP GW
|
563
|
Fri Jul 7 13:36:48 2017 <0001> gsm_04_08.c:1232 new state RELEASE_REQ -> NULL
|
564
|
Fri Jul 7 13:36:48 2017 <0002> subscr_conn.c:366 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_COMMUNICATING
|
565
|
Fri Jul 7 13:36:48 2017 <0002> osmo_msc.c:58 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: Received Event SUBSCR_CONN_E_BUMP
|
566
|
Fri Jul 7 13:36:48 2017 <0002> subscr_conn.c:168 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: bump: releasing conn
|
567
|
Fri Jul 7 13:36:48 2017 <0002> subscr_conn.c:169 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_COMMUNICATING}: state_chg to SUBSCR_CONN_S_RELEASED
|
568
|
Fri Jul 7 13:36:48 2017 <0002> subscr_conn.c:255 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_RELEASED}: Terminating (cause = OSMO_FSM_TERM_REGULAR)
|
569
|
Fri Jul 7 13:36:48 2017 <001e> subscr_conn.c:255 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_DONE}: Terminating (cause = OSMO_FSM_TERM_PARENT)
|
570
|
Fri Jul 7 13:36:48 2017 <001e> subscr_conn.c:255 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_DONE}: Removing from parent Subscr_Conn(3176166990)[0x79ffc0]
|
571
|
Fri Jul 7 13:36:48 2017 <001e> subscr_conn.c:255 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_DONE}: Freeing instance
|
572
|
Fri Jul 7 13:36:48 2017 <001e> fsm.c:273 Process_Access_Request_VLR(3176166990)[0x7a00f0]{PR_ARQ_S_DONE}: Deallocated
|
573
|
Fri Jul 7 13:36:48 2017 <000a> a_iface.c:413 Sendig clear command to BSC (conn_id=23)
|
574
|
Fri Jul 7 13:36:48 2017 <0000> osmo_msc.c:213 subscr MSISDN:23006: Freeing subscriber connection
|
575
|
Fri Jul 7 13:36:48 2017 <0002> subscr_conn.c:255 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_RELEASED}: Freeing instance
|
576
|
Fri Jul 7 13:36:48 2017 <0002> fsm.c:273 Subscr_Conn(3176166990)[0x79ffc0]{SUBSCR_CONN_S_RELEASED}: Deallocated
|
577
|
Fri Jul 7 13:36:48 2017 <000b> mgcpgw_client.c:317 Tx MGCP msg to MGCP GW: 'DLCX 88 2@mgw MGCP 1.0'
|
578
|
Fri Jul 7 13:36:48 2017 <000b> mgcpgw_client.c:319 Sending msg to MGCP GW size: 30
|
579
|
Fri Jul 7 13:36:48 2017 <000b> mgcpgw_client.c:122 MGCP response ignored (NULL cb)
|
580
|
Fri Jul 7 13:36:48 2017 <000a> a_iface.c:508 N-DATA.ind(23, 00 01 21 )
|
581
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:682 Rx BSC DT: 00 01 21
|
582
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:612 Rx MSC DT1 BSSMAP CLEAR COMPLETE
|
583
|
Fri Jul 7 13:36:48 2017 <000a> a_iface_bssap.c:244 Releasing connection (conn_id=23)
|
584
|
Fri Jul 7 13:36:48 2017 <000a> a_iface.c:84 Removing connection from active sccp-connection list (conn_id=23)
|
585
|
|
586
|
|