1
|
osmocom-testing:~ # /usr/bin/osmo-sgsn -c /root/osmo-gsm-tester/src/osmo_gsm_tester/templates/osmo-sgsn.cfg.tmpl-cisco
|
2
|
20181112235334961 DLGLOBAL <001b> telnet_interface.c:104 Available via telnet 127.0.0.1 4245
|
3
|
20181112235334961 DLCTRL <0022> control_if.c:911 CTRL at 127.0.0.1 4251
|
4
|
20181112235334961 DLGTP <0023> gtp.c:798 GTP: gtp_newgsn() started at 192.168.200.153
|
5
|
20181112235334963 DGPRS <000e> sgsn_libgtp.c:856 Created GTP on 192.168.200.153
|
6
|
20181112235334963 DGPRS <000e> sgsn_main.c:471 libGTP v1.2.2.15 initialized
|
7
|
20181112235334964 DLGSUP <0025> gsup_client.c:73 GSUP connecting to 192.168.200.155:4222
|
8
|
20181112235334964 DNS <000f> gprs_ns.c:1628 Listening for nsip packets on 192.168.200.153:23000
|
9
|
20181112235334964 DNS <000f> gprs_ns.c:1644 NS UDP socket at 192.168.200.153:23000
|
10
|
20181112235334964 DLSCCP <0028> sccp_user.c:370 OsmoSGSN: Creating SS7 instance
|
11
|
20181112235334964 DLSS7 <0027> osmo_ss7.c:363 1: Creating SS7 Instance
|
12
|
20181112235334964 DLSS7 <0027> osmo_ss7.c:699 1: Creating Route Table system
|
13
|
20181112235334964 DLSCCP <0028> sccp_user.c:397 OsmoSGSN: Using SS7 instance 1, pc:0.23.4
|
14
|
20181112235334964 DLSCCP <0028> sccp_user.c:404 OsmoSGSN: Creating AS instance
|
15
|
20181112235334964 DLSS7 <0027> osmo_ss7.c:948 1: Creating AS as-clnt-OsmoSGSN
|
16
|
20181112235334964 DLSS7 <0027> fsm.c:299 XUA_AS(as-clnt-OsmoSGSN)[0x55a732989bf0]{AS_DOWN}: Allocated
|
17
|
20181112235334965 DLSCCP <0028> sccp_user.c:415 OsmoSGSN: Using AS instance as-clnt-OsmoSGSN
|
18
|
20181112235334965 DLSCCP <0028> sccp_user.c:420 OsmoSGSN: Creating default route
|
19
|
20181112235334965 DLSS7 <0027> osmo_ss7.c:823 1: Creating route: pc=0=0.0.0 mask=0x0 via AS 'as-clnt-OsmoSGSN'
|
20
|
20181112235334965 DLSCCP <0028> sccp_user.c:440 OsmoSGSN: Creating ASP instance
|
21
|
20181112235334965 DLSS7 <0027> osmo_ss7.c:980 1: Adding ASP asp-clnt-OsmoSGSN to AS as-clnt-OsmoSGSN
|
22
|
20181112235334965 DLSS7 <0027> fsm.c:299 xua_default_lm(asp-clnt-OsmoSGSN)[0x55a73298a070]{IDLE}: Allocated
|
23
|
20181112235334965 DLSS7 <0027> osmo_ss7.c:1233 1: Restarting ASP asp-clnt-OsmoSGSN
|
24
|
20181112235334965 DLSS7 <0027> fsm.c:299 XUA_ASP(asp-clnt-OsmoSGSN)[0x55a73298a500]{ASP_DOWN}: Allocated
|
25
|
20181112235334965 DLSCCP <0028> sccp_user.c:476 OsmoSGSN: Using ASP instance asp-clnt-OsmoSGSN
|
26
|
20181112235334965 DLSS7 <0027> osmo_ss7.c:470 1: Creating SCCP instance
|
27
|
20181112235334965 DLSS7 <0027> osmo_ss7.c:494 registering user=SCCP for SI 3 with priv 0x55a73298a820
|
28
|
20181112235334965 DLSCCP <0028> sccp_user.c:88 Binding user 'OsmoSGSN-IuPS' to SSN=142 PC=(no PC)
|
29
|
20181112235334965 DLINP <001d> input/ipa.c:128 192.168.200.155:4222 connection done
|
30
|
20181112235334966 DLGSUP <0025> gsup_client.c:131 GSUP link to 192.168.200.155:4222 UP
|
31
|
20181112235334966 DLGSUP <0025> gsup_client.c:261 GSUP sending PING
|
32
|
20181112235334966 DLINP <001d> stream.c:166 connection closed
|
33
|
20181112235334966 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
34
|
20181112235334966 DLINP <001d> input/ipa.c:135 192.168.200.155:4222 connected read
|
35
|
20181112235334966 DLINP <001d> input/ipa.c:56 192.168.200.155:4222 message received
|
36
|
20181112235334966 DLINP <001d> input/ipaccess.c:705 received ID get from 0/0/0
|
37
|
20181112235334966 DLINP <001d> input/ipaccess.c:639 tag 8: 0/0/0
|
38
|
20181112235334966 DLINP <001d> input/ipaccess.c:639 tag 7: 00:00:00:00:00:00
|
39
|
20181112235334966 DLINP <001d> input/ipaccess.c:639 tag 2: 00:00:00:00:00:00
|
40
|
20181112235334966 DLINP <001d> input/ipaccess.c:639 tag 3: 00:00:00:00:00:00
|
41
|
20181112235334966 DLINP <001d> input/ipaccess.c:639 tag 4: 00:00:00:00:00:00
|
42
|
20181112235334966 DLINP <001d> input/ipaccess.c:639 tag 5: 00:00:00:00:00:00
|
43
|
20181112235334966 DLINP <001d> input/ipaccess.c:639 tag 1: SGSN-00-00-00-00-00-00
|
44
|
20181112235334966 DLINP <001d> input/ipaccess.c:639 tag 0: SGSN-00-00-00-00-00-00
|
45
|
20181112235334967 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
46
|
20181112235334967 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
47
|
20181112235334967 DLINP <001d> input/ipa.c:135 192.168.200.155:4222 connected read
|
48
|
20181112235334967 DLINP <001d> input/ipa.c:56 192.168.200.155:4222 message received
|
49
|
20181112235334967 DLMI <001f> ipa.c:502 ID_ACK
|
50
|
20181112235334967 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
51
|
20181112235334967 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
52
|
20181112235334967 DLINP <001d> input/ipa.c:135 192.168.200.155:4222 connected read
|
53
|
20181112235334967 DLINP <001d> input/ipa.c:56 192.168.200.155:4222 message received
|
54
|
20181112235334967 DLMI <001f> ipa.c:499 PONG!
|
55
|
20181112235334968 DLGSUP <0025> gsup_client.c:198 GSUP receiving PONG
|
56
|
20181112235339323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-ALIVE from 192.168.200.150:23020 for non-existing NS-VC
|
57
|
20181112235339323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [DEAD,BLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
58
|
20181112235339323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
59
|
20181112235339966 DLINP <001d> stream.c:506 reconnecting.
|
60
|
20181112235339966 DLINP <001d> stream.c:166 connection closed
|
61
|
20181112235339966 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
62
|
20181112235342323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-ALIVE from 192.168.200.150:23020 for non-existing NS-VC
|
63
|
20181112235342323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [ALIVE,UNBLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
64
|
20181112235342323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
65
|
20181112235344966 DLINP <001d> stream.c:506 reconnecting.
|
66
|
20181112235344966 DLINP <001d> stream.c:166 connection closed
|
67
|
20181112235344966 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
68
|
20181112235345323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-ALIVE from 192.168.200.150:23020 for non-existing NS-VC
|
69
|
20181112235345323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [ALIVE,UNBLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
70
|
20181112235345323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
71
|
20181112235348323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-ALIVE from 192.168.200.150:23020 for non-existing NS-VC
|
72
|
20181112235348323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [ALIVE,UNBLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
73
|
20181112235348323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
74
|
20181112235349967 DLINP <001d> stream.c:506 reconnecting.
|
75
|
20181112235349967 DLINP <001d> stream.c:166 connection closed
|
76
|
20181112235349967 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
77
|
20181112235351323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-ALIVE from 192.168.200.150:23020 for non-existing NS-VC
|
78
|
20181112235351323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [ALIVE,UNBLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
79
|
20181112235351323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
80
|
20181112235354323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-ALIVE from 192.168.200.150:23020 for non-existing NS-VC
|
81
|
20181112235354323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [ALIVE,UNBLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
82
|
20181112235354323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
83
|
20181112235354966 DLGSUP <0025> gsup_client.c:241 GSUP ping callback (connected, got PONG)
|
84
|
20181112235354966 DLGSUP <0025> gsup_client.c:261 GSUP sending PING
|
85
|
20181112235354966 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
86
|
20181112235354966 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
87
|
20181112235354966 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
88
|
20181112235354966 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
89
|
20181112235354966 DLINP <001d> input/ipa.c:135 192.168.200.155:4222 connected read
|
90
|
20181112235354966 DLINP <001d> input/ipa.c:56 192.168.200.155:4222 message received
|
91
|
20181112235354966 DLMI <001f> ipa.c:499 PONG!
|
92
|
20181112235354966 DLGSUP <0025> gsup_client.c:198 GSUP receiving PONG
|
93
|
20181112235354967 DLINP <001d> stream.c:506 reconnecting.
|
94
|
20181112235354967 DLINP <001d> stream.c:166 connection closed
|
95
|
20181112235354967 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
96
|
20181112235357323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-ALIVE from 192.168.200.150:23020 for non-existing NS-VC
|
97
|
20181112235357323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [ALIVE,UNBLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
98
|
20181112235357323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
99
|
20181112235359968 DLINP <001d> stream.c:506 reconnecting.
|
100
|
20181112235359969 DLINP <001d> stream.c:166 connection closed
|
101
|
20181112235359969 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
102
|
20181112235400323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-ALIVE from 192.168.200.150:23020 for non-existing NS-VC
|
103
|
20181112235400323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [ALIVE,UNBLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
104
|
20181112235400323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
105
|
20181112235403323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-ALIVE from 192.168.200.150:23020 for non-existing NS-VC
|
106
|
20181112235403323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [ALIVE,UNBLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
107
|
20181112235403323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
108
|
20181112235404961 DGPRS <000e> gprs_sgsn.c:963 Checking for inactive LLMEs, time = 1327416
|
109
|
20181112235404969 DLINP <001d> stream.c:506 reconnecting.
|
110
|
20181112235404969 DLINP <001d> stream.c:166 connection closed
|
111
|
20181112235404969 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
112
|
20181112235406323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-ALIVE from 192.168.200.150:23020 for non-existing NS-VC
|
113
|
20181112235406323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [ALIVE,UNBLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
114
|
20181112235406323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
115
|
20181112235409323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-ALIVE from 192.168.200.150:23020 for non-existing NS-VC
|
116
|
20181112235409323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [ALIVE,UNBLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
117
|
20181112235409323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
118
|
20181112235409970 DLINP <001d> stream.c:506 reconnecting.
|
119
|
20181112235409970 DLINP <001d> stream.c:166 connection closed
|
120
|
20181112235409970 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
121
|
20181112235412323 DNS <000f> gprs_ns.c:1289 Rejecting NS PDU type NS-BLOCK from 192.168.200.150:23020 for non-existing NS-VC
|
122
|
20181112235412323 DNS <000f> gprs_ns.c:1292 NSEI 65534 (NS-VCI=65534) setting state [ALIVE,UNBLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
123
|
20181112235412323 DNS <000f> gprs_ns.c:483 NSEI=65534 Tx NS STATUS (NSVCI=65534, cause=PDU not compatible with protocol state)
|
124
|
20181112235414967 DLGSUP <0025> gsup_client.c:241 GSUP ping callback (connected, got PONG)
|
125
|
20181112235414967 DLGSUP <0025> gsup_client.c:261 GSUP sending PING
|
126
|
20181112235414967 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
127
|
20181112235414967 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
128
|
20181112235414967 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
129
|
20181112235414967 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
130
|
20181112235414967 DLINP <001d> input/ipa.c:135 192.168.200.155:4222 connected read
|
131
|
20181112235414967 DLINP <001d> input/ipa.c:56 192.168.200.155:4222 message received
|
132
|
20181112235414967 DLMI <001f> ipa.c:499 PONG!
|
133
|
20181112235414967 DLGSUP <0025> gsup_client.c:198 GSUP receiving PONG
|
134
|
20181112235414970 DLINP <001d> stream.c:506 reconnecting.
|
135
|
20181112235414970 DLINP <001d> stream.c:166 connection closed
|
136
|
20181112235414970 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
137
|
20181112235419971 DLINP <001d> stream.c:506 reconnecting.
|
138
|
20181112235419972 DLINP <001d> stream.c:166 connection closed
|
139
|
20181112235419972 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
140
|
20181112235424972 DLINP <001d> stream.c:506 reconnecting.
|
141
|
20181112235424972 DLINP <001d> stream.c:166 connection closed
|
142
|
20181112235424972 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
143
|
20181112235429973 DLINP <001d> stream.c:506 reconnecting.
|
144
|
20181112235429973 DLINP <001d> stream.c:166 connection closed
|
145
|
20181112235429973 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
146
|
20181112235434961 DGPRS <000e> gprs_sgsn.c:963 Checking for inactive LLMEs, time = 1327446
|
147
|
20181112235434967 DLGSUP <0025> gsup_client.c:241 GSUP ping callback (connected, got PONG)
|
148
|
20181112235434967 DLGSUP <0025> gsup_client.c:261 GSUP sending PING
|
149
|
20181112235434967 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
150
|
20181112235434967 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
151
|
20181112235434967 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
152
|
20181112235434967 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
153
|
20181112235434967 DLINP <001d> input/ipa.c:135 192.168.200.155:4222 connected read
|
154
|
20181112235434967 DLINP <001d> input/ipa.c:56 192.168.200.155:4222 message received
|
155
|
20181112235434967 DLMI <001f> ipa.c:499 PONG!
|
156
|
20181112235434967 DLGSUP <0025> gsup_client.c:198 GSUP receiving PONG
|
157
|
20181112235434973 DLINP <001d> stream.c:506 reconnecting.
|
158
|
20181112235434974 DLINP <001d> stream.c:166 connection closed
|
159
|
20181112235434974 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
160
|
20181112235439975 DLINP <001d> stream.c:506 reconnecting.
|
161
|
20181112235439975 DLINP <001d> stream.c:166 connection closed
|
162
|
20181112235439975 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
163
|
20181112235442366 DNS <000f> gprs_ns.c:266 NSVCI=65535 Creating NS-VC
|
164
|
20181112235442366 DNS <000f> gprs_ns.c:272 NSEI 0 (NS-VCI=65535) setting state [DEAD,UNBLOCKED,UNRESET] -> [DEAD,BLOCKED,UNRESET]
|
165
|
20181112235442366 DLGLOBAL <001b> rate_ctr.c:88 validating counter group 0x7f131edbd560(ns:nsvc) with 12 counters
|
166
|
20181112235442366 DNS <000f> gprs_ns.c:1330 Creating NS-VC for BSS at 192.168.200.150:23020
|
167
|
20181112235442366 DNS <000f> gprs_ns.c:890 NSVCI=65535(invalid) Rx NS RESET (NSEI=1234, NSVCI=1234, cause=O&M intervention)
|
168
|
20181112235442366 DNS <000f> gprs_ns.c:939 NSEI 0 (NS-VCI=65535) setting state [DEAD,BLOCKED,UNRESET] -> [ALIVE,BLOCKED,UNRESET]
|
169
|
20181112235442366 DNS <000f> gprs_ns.c:710 NSEI=1234 Tx NS RESET ACK (NSVCI=1234)
|
170
|
20181112235442366 DNS <000f> gprs_ns.c:610 NSEI=1234 Starting timer in mode tns-test (30 seconds)
|
171
|
20181112235442368 DNS <000f> gprs_ns.c:610 NSEI=1234 Starting timer in mode tns-test (30 seconds)
|
172
|
20181112235442370 DNS <000f> gprs_ns.c:1414 NSEI=1234 Rx NS UNBLOCK
|
173
|
20181112235442370 DNS <000f> gprs_ns.c:1415 NSEI 1234 (NS-VCI=1234) setting state [ALIVE,BLOCKED,UNRESET] -> [ALIVE,UNBLOCKED,UNRESET]
|
174
|
20181112235442377 DBSSGP <0010> gprs_bssgp.c:266 BSSGP BVCI=0 Rx RESET cause=Transmission capacity modified
|
175
|
20181112235442377 DLGLOBAL <001b> rate_ctr.c:88 validating counter group 0x7f131edbd6c0(bssgp:bss_ctx) with 7 counters
|
176
|
20181112235442379 DBSSGP <0010> gprs_bssgp.c:266 BSSGP BVCI=1234 Rx RESET cause=Transmission capacity modified
|
177
|
20181112235442379 DLGLOBAL <001b> rate_ctr.c:88 validating counter group 0x7f131edbd6c0(bssgp:bss_ctx) with 7 counters
|
178
|
20181112235442379 DBSSGP <0010> gprs_bssgp.c:288 Cell 001-01-1-1 CI 0 on BVCI 1234
|
179
|
20181112235444975 DLINP <001d> stream.c:506 reconnecting.
|
180
|
20181112235444975 DLINP <001d> stream.c:166 connection closed
|
181
|
20181112235444975 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
182
|
20181112235449976 DLINP <001d> stream.c:506 reconnecting.
|
183
|
20181112235449977 DLINP <001d> stream.c:166 connection closed
|
184
|
20181112235449977 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
185
|
20181112235452408 DBSSGP <0010> gprs_bssgp.c:360 BSSGP BVCI=1234 Rx BVC-UNBLOCK
|
186
|
20181112235452416 DBSSGP <0010> gprs_bssgp.c:806 BSSGP BVCI=1234 Rx Flow Control BVC
|
187
|
20181112235452416 DBSSGP <0010> gprs_bssgp.c:839 BSS instructs us to MS default bucket leak rate != 0, restarting DL GPRS!
|
188
|
20181112235454968 DLGSUP <0025> gsup_client.c:241 GSUP ping callback (connected, got PONG)
|
189
|
20181112235454968 DLGSUP <0025> gsup_client.c:261 GSUP sending PING
|
190
|
20181112235454968 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
191
|
20181112235454968 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
192
|
20181112235454968 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
193
|
20181112235454968 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
194
|
20181112235454969 DLINP <001d> input/ipa.c:135 192.168.200.155:4222 connected read
|
195
|
20181112235454969 DLINP <001d> input/ipa.c:56 192.168.200.155:4222 message received
|
196
|
20181112235454969 DLMI <001f> ipa.c:499 PONG!
|
197
|
20181112235454969 DLGSUP <0025> gsup_client.c:198 GSUP receiving PONG
|
198
|
20181112235454977 DLINP <001d> stream.c:506 reconnecting.
|
199
|
20181112235454977 DLINP <001d> stream.c:166 connection closed
|
200
|
20181112235454977 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
201
|
20181112235459978 DLINP <001d> stream.c:506 reconnecting.
|
202
|
20181112235459978 DLINP <001d> stream.c:166 connection closed
|
203
|
20181112235459978 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
204
|
20181112235504962 DGPRS <000e> gprs_sgsn.c:963 Checking for inactive LLMEs, time = 1327476
|
205
|
20181112235504979 DLINP <001d> stream.c:506 reconnecting.
|
206
|
20181112235504979 DLINP <001d> stream.c:166 connection closed
|
207
|
20181112235504979 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
208
|
20181112235509980 DLINP <001d> stream.c:506 reconnecting.
|
209
|
20181112235509980 DLINP <001d> stream.c:166 connection closed
|
210
|
20181112235509980 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
211
|
20181112235512369 DNS <000f> gprs_ns.c:638 NSEI=1234 Timer expired in mode tns-test (30 seconds)
|
212
|
20181112235512369 DNS <000f> gprs_ns.c:571 NSEI=1234 Tx NS ALIVE (NSVCI=1234)
|
213
|
20181112235512369 DNS <000f> gprs_ns.c:610 NSEI=1234 Starting timer in mode tns-alive (3 seconds)
|
214
|
20181112235512373 DNS <000f> gprs_ns.c:584 NSEI=1234 Tx NS ALIVE_ACK (NSVCI=1234)
|
215
|
20181112235512377 DNS <000f> gprs_ns.c:610 NSEI=1234 Starting timer in mode tns-test (30 seconds)
|
216
|
20181112235514969 DLGSUP <0025> gsup_client.c:241 GSUP ping callback (connected, got PONG)
|
217
|
20181112235514969 DLGSUP <0025> gsup_client.c:261 GSUP sending PING
|
218
|
20181112235514969 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
219
|
20181112235514969 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
220
|
20181112235514969 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
221
|
20181112235514969 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
222
|
20181112235514970 DLINP <001d> input/ipa.c:135 192.168.200.155:4222 connected read
|
223
|
20181112235514970 DLINP <001d> input/ipa.c:56 192.168.200.155:4222 message received
|
224
|
20181112235514970 DLMI <001f> ipa.c:499 PONG!
|
225
|
20181112235514970 DLGSUP <0025> gsup_client.c:198 GSUP receiving PONG
|
226
|
20181112235514980 DLINP <001d> stream.c:506 reconnecting.
|
227
|
20181112235514981 DLINP <001d> stream.c:166 connection closed
|
228
|
20181112235514981 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
229
|
20181112235519982 DLINP <001d> stream.c:506 reconnecting.
|
230
|
20181112235519982 DLINP <001d> stream.c:166 connection closed
|
231
|
20181112235519982 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
232
|
20181112235524982 DLINP <001d> stream.c:506 reconnecting.
|
233
|
20181112235524982 DLINP <001d> stream.c:166 connection closed
|
234
|
20181112235524982 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
235
|
20181112235526196 DBSSGP <0010> gprs_bssgp.c:392 BSSGP TLLI=0x8bc4d3af Rx UPLINK-UNITDATA
|
236
|
20181112235526196 DLLC <0011> gprs_llc.c:526 LLC RX: unknown TLLI 0x8bc4d3af, creating LLME on the fly
|
237
|
20181112235526196 DLLC <0011> gprs_llc_parse.c:81 LLC SAPI=1 C U GEA0 IOV-UI=0x000000 FCS=0xde24a6 CMD=UI DATA
|
238
|
20181112235526196 DMM <0002> gprs_gmm.c:1278 MM(---/ffffffff) -> GMM ATTACH REQUEST MI(3418674095) type="GPRS attach"
|
239
|
20181112235526196 DMM <0002> gprs_sgsn.c:239 MM(/00000000) Allocated with GEA0 cipher.
|
240
|
20181112235526196 DLGLOBAL <001b> rate_ctr.c:88 validating counter group 0x55a7320533a0(sgsn:mmctx) with 11 counters
|
241
|
20181112235526196 DMM <0002> fsm.c:299 GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55a73298e010]{Init}: Allocated
|
242
|
20181112235526196 DMM <0002> gprs_gmm.c:1434 GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55a73298e010]{Init}: Received Event Received an attach request
|
243
|
20181112235526196 DMM <0002> gprs_gmm_attach.c:36 GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55a73298e010]{Init}: state_chg to CheckIdentity
|
244
|
20181112235526196 DMM <0002> gprs_gmm.c:557 MM(/c23c73ac) <- GPRS IDENTITY REQUEST: mi_type=IMEI
|
245
|
20181112235526777 DBSSGP <0010> gprs_bssgp.c:392 BSSGP TLLI=0x8bc4d3af Rx UPLINK-UNITDATA
|
246
|
20181112235526777 DLLC <0011> gprs_llc_parse.c:81 LLC SAPI=1 C U GEA0 IOV-UI=0x000000 FCS=0x4335ac CMD=UI DATA
|
247
|
20181112235526777 DMM <0002> gprs_gmm.c:1201 MM(/c23c73ac) -> GMM IDENTITY RESPONSE: MI(IMEI)=356161072930990
|
248
|
20181112235526777 DMM <0002> gprs_gmm.c:242 MM(/c23c73ac) Stopping MM timer 3370 but 0 is running
|
249
|
20181112235526777 DMM <0002> gprs_gmm.c:1244 GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55a73298e010]{CheckIdentity}: Received Event Identity Request received
|
250
|
20181112235526777 DMM <0002> gprs_gmm_attach.c:97 GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55a73298e010]{CheckIdentity}: state_chg to CheckIdentity
|
251
|
20181112235526777 DMM <0002> gprs_gmm.c:557 MM(/c23c73ac) <- GPRS IDENTITY REQUEST: mi_type=IMSI
|
252
|
20181112235527018 DBSSGP <0010> gprs_bssgp.c:892 BSSGP BVCI=1234 Rx Flow Control MS
|
253
|
20181112235527216 DBSSGP <0010> gprs_bssgp.c:392 BSSGP TLLI=0x8bc4d3af Rx UPLINK-UNITDATA
|
254
|
20181112235527216 DLLC <0011> gprs_llc_parse.c:81 LLC SAPI=1 C U GEA0 IOV-UI=0x000000 FCS=0x4ebb00 CMD=UI DATA
|
255
|
20181112235527216 DMM <0002> gprs_gmm.c:1201 MM(/c23c73ac) -> GMM IDENTITY RESPONSE: MI(IMSI)=010000000001100
|
256
|
20181112235527216 DMM <0002> gprs_gmm.c:242 MM(/c23c73ac) Stopping MM timer 3370 but 0 is running
|
257
|
20181112235527216 DMM <0002> gprs_gmm.c:1244 GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55a73298e010]{CheckIdentity}: Received Event Identity Request received
|
258
|
20181112235527216 DMM <0002> gprs_gmm_attach.c:99 GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55a73298e010]{CheckIdentity}: state_chg to Authenticate
|
259
|
20181112235527216 DMM <0002> gprs_gmm_attach.c:134 GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55a73298e010]{Authenticate}: state_chg to WaitAttachComplete
|
260
|
20181112235527216 DMM <0002> gprs_gmm.c:438 MM(010000000001100/c23c73ac) <- GPRS ATTACH ACCEPT (new P-TMSI=0xc23c73ac)
|
261
|
20181112235527657 DBSSGP <0010> gprs_bssgp.c:392 BSSGP TLLI=0xc23c73ac Rx UPLINK-UNITDATA
|
262
|
20181112235527657 DLLC <0011> gprs_llc_parse.c:81 LLC SAPI=1 C U GEA0 IOV-UI=0x000000 FCS=0xbcf132 CMD=UI DATA
|
263
|
20181112235527657 DMM <0002> gprs_gmm.c:2037 MM(010000000001100/c23c73ac) -> ATTACH COMPLETE
|
264
|
20181112235527657 DMM <0002> gprs_gmm.c:242 MM(010000000001100/c23c73ac) Stopping MM timer 3350 but 0 is running
|
265
|
20181112235527657 DMM <0002> gprs_gmm.c:166 MM(010000000001100/c23c73ac) Changing MM state from MM IDLE to MM READY
|
266
|
20181112235527657 DMM <0002> gprs_gmm.c:2054 GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55a73298e010]{WaitAttachComplete}: Received Event Attach complete received.
|
267
|
20181112235527657 DMM <0002> gprs_gmm_attach.c:196 GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55a73298e010]{WaitAttachComplete}: state_chg to Init
|
268
|
20181112235528098 DBSSGP <0010> gprs_bssgp.c:392 BSSGP TLLI=0xc23c73ac Rx UPLINK-UNITDATA
|
269
|
20181112235528098 DLLC <0011> gprs_llc_parse.c:81 LLC SAPI=1 C U GEA0 IOV-UI=0x000000 FCS=0xa1eb62 CMD=UI DATA
|
270
|
20181112235528098 DMM <0002> gprs_gmm.c:2506 MM(010000000001100/c23c73ac) -> ACTIVATE PDP CONTEXT REQ: SAPI=3 NSAPI=5 IETF IPv4
|
271
|
20181112235528098 DMM <0002> gprs_sgsn.c:927 MM(010000000001100/c23c73ac) Found GGSN 0 for APN 'cisco' (requested 'cisco')
|
272
|
20181112235528098 DMM <0002> gprs_gmm.c:2393 MM(010000000001100/c23c73ac) Using GGSN 0
|
273
|
20181112235528098 DLGLOBAL <001b> rate_ctr.c:88 validating counter group 0x55a732053340(sgsn:pdpctx) with 4 counters
|
274
|
20181112235528098 DLGTP <0023> pdp.c:237 Begin pdp_tidset tid = 5001100000000010
|
275
|
20181112235528098 DLGTP <0023> pdp.c:246 End pdp_tidset
|
276
|
20181112235528098 DGPRS <000e> sgsn_libgtp.c:175 PDP(010000000001100/0) Create PDP Context
|
277
|
20181112235528115 DGPRS <000e> sgsn_libgtp.c:625 libgtp cb_conf(type=16, cause=193, pdp=0x7f131df2d2e0, cbp=0x55a7328b25d0)
|
278
|
20181112235528115 DGPRS <000e> sgsn_libgtp.c:396 PDP(010000000001100/0) Received CREATE PDP CTX CONF, cause=193(Invalid message format)
|
279
|
20181112235528115 DLGTP <0023> pdp.c:255 Begin pdp_tiddel tid = 5001100000000010
|
280
|
20181112235528115 DLGTP <0023> pdp.c:262 End pdp_tiddel: PDP found
|
281
|
20181112235528115 DMM <0002> gprs_gmm.c:2317 MM(010000000001100/c23c73ac) <- ACTIVATE PDP CONTEXT REJ(cause=30)
|
282
|
20181112235528393 DBSSGP <0010> gprs_bssgp.c:892 BSSGP BVCI=1234 Rx Flow Control MS
|
283
|
20181112235529983 DLINP <001d> stream.c:506 reconnecting.
|
284
|
20181112235529984 DLINP <001d> stream.c:166 connection closed
|
285
|
20181112235529984 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
286
|
20181112235530955 DBSSGP <0010> gprs_bssgp.c:892 BSSGP BVCI=1234 Rx Flow Control MS
|
287
|
20181112235533511 DBSSGP <0010> gprs_bssgp.c:892 BSSGP BVCI=1234 Rx Flow Control MS
|
288
|
20181112235534964 DGPRS <000e> gprs_sgsn.c:963 Checking for inactive LLMEs, time = 1327506
|
289
|
20181112235534969 DLGSUP <0025> gsup_client.c:241 GSUP ping callback (connected, got PONG)
|
290
|
20181112235534969 DLGSUP <0025> gsup_client.c:261 GSUP sending PING
|
291
|
20181112235534969 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
292
|
20181112235534969 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
293
|
20181112235534970 DLINP <001d> input/ipa.c:139 192.168.200.155:4222 connected write
|
294
|
20181112235534970 DLINP <001d> input/ipa.c:89 192.168.200.155:4222 sending data
|
295
|
20181112235534970 DLINP <001d> input/ipa.c:135 192.168.200.155:4222 connected read
|
296
|
20181112235534970 DLINP <001d> input/ipa.c:56 192.168.200.155:4222 message received
|
297
|
20181112235534970 DLMI <001f> ipa.c:499 PONG!
|
298
|
20181112235534970 DLGSUP <0025> gsup_client.c:198 GSUP receiving PONG
|
299
|
20181112235534984 DLINP <001d> stream.c:506 reconnecting.
|
300
|
20181112235534984 DLINP <001d> stream.c:166 connection closed
|
301
|
20181112235534984 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
302
|
20181112235536096 DBSSGP <0010> gprs_bssgp.c:392 BSSGP TLLI=0xc23c73ac Rx UPLINK-UNITDATA
|
303
|
20181112235536096 DLLC <0011> gprs_llc_parse.c:81 LLC SAPI=1 C U GEA0 IOV-UI=0x000000 FCS=0x3be662 CMD=UI DATA
|
304
|
20181112235536096 DMM <0002> gprs_gmm.c:2506 MM(010000000001100/c23c73ac) -> ACTIVATE PDP CONTEXT REQ: SAPI=3 NSAPI=5 IETF IPv4
|
305
|
20181112235536096 DMM <0002> gprs_sgsn.c:927 MM(010000000001100/c23c73ac) Found GGSN 0 for APN 'cisco' (requested 'cisco')
|
306
|
20181112235536096 DMM <0002> gprs_gmm.c:2393 MM(010000000001100/c23c73ac) Using GGSN 0
|
307
|
20181112235536096 DLGLOBAL <001b> rate_ctr.c:88 validating counter group 0x55a732053340(sgsn:pdpctx) with 4 counters
|
308
|
20181112235536096 DLGTP <0023> pdp.c:237 Begin pdp_tidset tid = 5001100000000010
|
309
|
20181112235536096 DLGTP <0023> pdp.c:246 End pdp_tidset
|
310
|
20181112235536096 DGPRS <000e> sgsn_libgtp.c:175 PDP(010000000001100/0) Create PDP Context
|
311
|
20181112235536113 DGPRS <000e> sgsn_libgtp.c:625 libgtp cb_conf(type=16, cause=193, pdp=0x7f131df2d2e0, cbp=0x55a7328b25d0)
|
312
|
20181112235536113 DGPRS <000e> sgsn_libgtp.c:396 PDP(010000000001100/0) Received CREATE PDP CTX CONF, cause=193(Invalid message format)
|
313
|
20181112235536113 DLGTP <0023> pdp.c:255 Begin pdp_tiddel tid = 5001100000000010
|
314
|
20181112235536113 DLGTP <0023> pdp.c:262 End pdp_tiddel: PDP found
|
315
|
20181112235536113 DMM <0002> gprs_gmm.c:2317 MM(010000000001100/c23c73ac) <- ACTIVATE PDP CONTEXT REJ(cause=30)
|
316
|
20181112235536716 DBSSGP <0010> gprs_bssgp.c:892 BSSGP BVCI=1234 Rx Flow Control MS
|
317
|
20181112235538637 DBSSGP <0010> gprs_bssgp.c:892 BSSGP BVCI=1234 Rx Flow Control MS
|
318
|
20181112235539985 DLINP <001d> stream.c:506 reconnecting.
|
319
|
20181112235539986 DLINP <001d> stream.c:166 connection closed
|
320
|
20181112235539986 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
321
|
20181112235541191 DBSSGP <0010> gprs_bssgp.c:892 BSSGP BVCI=1234 Rx Flow Control MS
|
322
|
20181112235542377 DNS <000f> gprs_ns.c:638 NSEI=1234 Timer expired in mode tns-test (30 seconds)
|
323
|
20181112235542377 DNS <000f> gprs_ns.c:571 NSEI=1234 Tx NS ALIVE (NSVCI=1234)
|
324
|
20181112235542377 DNS <000f> gprs_ns.c:610 NSEI=1234 Starting timer in mode tns-alive (3 seconds)
|
325
|
20181112235542379 DNS <000f> gprs_ns.c:584 NSEI=1234 Tx NS ALIVE_ACK (NSVCI=1234)
|
326
|
20181112235542380 DNS <000f> gprs_ns.c:610 NSEI=1234 Starting timer in mode tns-test (30 seconds)
|
327
|
20181112235543753 DBSSGP <0010> gprs_bssgp.c:892 BSSGP BVCI=1234 Rx Flow Control MS
|
328
|
20181112235544986 DLINP <001d> stream.c:506 reconnecting.
|
329
|
20181112235544986 DLINP <001d> stream.c:166 connection closed
|
330
|
20181112235544986 DLINP <001d> stream.c:169 retrying in 5 seconds...
|
331
|
^Csignal 2 received
|
332
|
osmocom-testing:~ #
|