See
<https://jenkins.osmocom.org/jenkins/job/Osmocom-Debian-install-nightly/438/display/redirect>
------------------------------------------
[...truncated 299.85 KB...]
Nov 19 04:53:11 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> m3ua.c:686
XUA_ASP(asp-dyn-1){ASP_DOWN}: Received Event ASPSM-ASP_UP
Nov 19 04:53:11 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_asp_fsm.c:369
XUA_ASP(asp-dyn-1){ASP_DOWN}: state_chg to ASP_INACTIVE
Nov 19 04:53:11 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_asp_fsm.c:118 0:
asp-asp-dyn-1: No Layer Manager, dropping M-ASP_UP.indication
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:1753
(r=127.0.0.1:35220<->l=127.0.0.1:2905): New m3ua connection accepted
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:1793
(r=127.0.0.1:35220<->l=127.0.0.1:2905): created dynamic ASP asp-dyn-2
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:1324 0:
asp-asp-dyn-2: Restarting ASP asp-dyn-2, r=127.0.0.1:35220<->l=0.0.0.0:2905
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:1372 0:
asp-asp-dyn-2: ASP Restart for server not implemented yet!
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> fsm.c:461
XUA_ASP(asp-dyn-2){ASP_DOWN}: Allocated
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:1829
XUA_ASP(asp-dyn-2){ASP_DOWN}: Received Event SCTP-EST.ind
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_asp_fsm.c:118 0:
asp-asp-dyn-2: No Layer Manager, dropping M-SCTP_ESTABLISH.indication
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:1519 0:
asp-asp-dyn-2: xua_srv_conn_cb(): sctp_recvmsg() returned 8 (flags=0x80)
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLM3UA <000f> m3ua.c:722 0:
asp-asp-dyn-2: Received M3UA Message (ASPSM:UP)
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> m3ua.c:686
XUA_ASP(asp-dyn-2){ASP_DOWN}: Received Event ASPSM-ASP_UP
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_asp_fsm.c:369
XUA_ASP(asp-dyn-2){ASP_DOWN}: state_chg to ASP_INACTIVE
Nov 19 04:53:12 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_asp_fsm.c:118 0:
asp-asp-dyn-2: No Layer Manager, dropping M-ASP_UP.indication
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:1519 0:
asp-asp-dyn-0: xua_srv_conn_cb(): sctp_recvmsg() returned 44 (flags=0x80)
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLM3UA <000f> m3ua.c:722 0:
asp-asp-dyn-0: Received M3UA Message (RKM:REG-REQ)
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_rkm.c:196 0:
asp-asp-dyn-0: RKM: Registering routing key 1 for DPC 0.23.4
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> fsm.c:461
XUA_AS(as-rkm-1){AS_DOWN}: Allocated
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:970 0:
as-as-rkm-1: Created AS
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:792 0:
Creating route: pc=188=0.23.4 mask=0xffffff via AS 'as-rkm-1'
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:990 0:
as-as-rkm-1: Adding ASP asp-dyn-0 to AS
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_rkm.c:333
XUA_AS(as-rkm-1){AS_DOWN}: Received Event ASPAS-ASP_INACTIVE.ind
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_as_fsm.c:251
XUA_AS(as-rkm-1){AS_DOWN}: state_chg to AS_INACTIVE
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:1519 0:
asp-asp-dyn-0: xua_srv_conn_cb(): sctp_recvmsg() returned 8 (flags=0x80)
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLM3UA <000f> m3ua.c:722 0:
asp-asp-dyn-0: Received M3UA Message (ASPTM:ACTIVE)
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> m3ua.c:686
XUA_ASP(asp-dyn-0){ASP_INACTIVE}: Received Event ASPTM-ASP_AC
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_asp_fsm.c:490
XUA_ASP(asp-dyn-0){ASP_INACTIVE}: state_chg to ASP_ACTIVE
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_asp_fsm.c:398
XUA_AS(as-rkm-1){AS_INACTIVE}: Received Event ASPAS-ASP_ACTIVE.ind
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_as_fsm.c:320
XUA_AS(as-rkm-1){AS_INACTIVE}: state_chg to AS_ACTIVE
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_asp_fsm.c:118 0:
asp-asp-dyn-0: No Layer Manager, dropping M-ASP_ACTIVE.indication
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:1519 0:
asp-asp-dyn-1: xua_srv_conn_cb(): sctp_recvmsg() returned 44 (flags=0x80)
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLM3UA <000f> m3ua.c:722 0:
asp-asp-dyn-1: Received M3UA Message (RKM:REG-REQ)
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_rkm.c:196 0:
asp-asp-dyn-1: RKM: Registering routing key 2 for DPC 0.23.5
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> fsm.c:461
XUA_AS(as-rkm-2){AS_DOWN}: Allocated
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:970 0:
as-as-rkm-2: Created AS
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:792 0:
Creating route: pc=189=0.23.5 mask=0xffffff via AS 'as-rkm-2'
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:990 0:
as-as-rkm-2: Adding ASP asp-dyn-1 to AS
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_rkm.c:333
XUA_AS(as-rkm-2){AS_DOWN}: Received Event ASPAS-ASP_INACTIVE.ind
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_as_fsm.c:251
XUA_AS(as-rkm-2){AS_DOWN}: state_chg to AS_INACTIVE
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> osmo_ss7.c:1519 0:
asp-asp-dyn-1: xua_srv_conn_cb(): sctp_recvmsg() returned 8 (flags=0x80)
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLM3UA <000f> m3ua.c:722 0:
asp-asp-dyn-1: Received M3UA Message (ASPTM:ACTIVE)
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> m3ua.c:686
XUA_ASP(asp-dyn-1){ASP_INACTIVE}: Received Event ASPTM-ASP_AC
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_asp_fsm.c:490
XUA_ASP(asp-dyn-1){ASP_INACTIVE}: state_chg to ASP_ACTIVE
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_asp_fsm.c:398
XUA_AS(as-rkm-2){AS_INACTIVE}: Received Event ASPAS-ASP_ACTIVE.ind
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_as_fsm.c:320
XUA_AS(as-rkm-2){AS_INACTIVE}: state_chg to AS_ACTIVE
Nov 19 04:53:13 3fd58d2e53f7 osmo-stp[13355]: DLSS7 <000c> xua_asp_fsm.c:118 0:
asp-asp-dyn-1: No Layer Manager, dropping M-ASP_ACTIVE.indication
+ systemctl --no-pager -l -n 200 status osmo-pcap-server
● osmo-pcap-server.service - PCAP Server for the PCAP aggregation
Loaded: loaded (/lib/systemd/system/osmo-pcap-server.service; disabled; vendor preset:
enabled)
Active: active (running) since Tue 2019-11-19 04:53:11 UTC; 2s ago
Main PID: 13356 (osmo-pcap-serve)
Tasks: 1 (limit: 4915)
CGroup:
/docker/3fd58d2e53f7bbdda862f080fa558d3e2481e5faf79e660ab6c0ece2a9a8e9be/system.slice/osmo-pcap-server.service
└─13356 /usr/bin/osmo-pcap-server -c /etc/osmocom/osmo-pcap-server.cfg
Nov 19 04:53:11 3fd58d2e53f7 osmo-pcap-server[13356]: <0005> telnet_interface.c:104
Available via telnet 127.0.0.1 4238
Nov 19 04:53:11 3fd58d2e53f7 osmo-pcap-server[13356]: <0004> osmo_tls.c:44 Going to
create DH params for 3072 bits
Nov 19 04:53:11 3fd58d2e53f7 systemd[1]: osmo-pcap-server.service: Failed to reset
devices.list: Operation not permitted
Nov 19 04:53:11 3fd58d2e53f7 systemd[1]: Started PCAP Server for the PCAP aggregation.
Nov 19 04:53:13 3fd58d2e53f7 osmo-pcap-server[13356]: <0002>
osmo_server_network.c:573 New connection from zecke
+ systemctl --no-pager -l -n 200 status osmo-sgsn
● osmo-sgsn.service - Osmocom SGSN (Serving GPRS Support Node)
Loaded: loaded (/lib/systemd/system/osmo-sgsn.service; disabled; vendor preset:
enabled)
Active: active (running) since Tue 2019-11-19 04:53:11 UTC; 2s ago
Main PID: 13357 (osmo-sgsn)
Tasks: 1 (limit: 4915)
CGroup:
/docker/3fd58d2e53f7bbdda862f080fa558d3e2481e5faf79e660ab6c0ece2a9a8e9be/system.slice/osmo-sgsn.service
└─13357 /usr/bin/osmo-sgsn -c /etc/osmocom/osmo-sgsn.cfg
Nov 19 04:53:11 3fd58d2e53f7 systemd[1]: osmo-sgsn.service: Failed to reset devices.list:
Operation not permitted
Nov 19 04:53:11 3fd58d2e53f7 systemd[1]: Started Osmocom SGSN (Serving GPRS Support
Node).
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <0020> telnet_interface.c:104
Available via telnet 127.0.0.1 4245
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <0027> control_if.c:911 CTRL at
127.0.0.1 4251
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <0028> gtp.c:902 GTP: gtp_newgsn()
started at 127.0.0.1
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <0028> gtp.c:859 State information
file (.//gsn_restart) not found. Creating new file.
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <000e> sgsn_libgtp.c:767 Created GTP
on 127.0.0.1
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <000e> sgsn_main.c:474 libGTP
v1.4.0.27-1bf4 initialized
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <002a> gsup_client.c:73 GSUP
connecting to 127.0.0.1:4222
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <000f> gprs_ns.c:2072 Listening for
nsip packets on 127.0.0.1:23000
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <000f> gprs_ns.c:2088 NS UDP socket
at 127.0.0.1:23000
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <002d> sccp_user.c:488 OsmoSGSN:
Creating SS7 instance
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <002d> sccp_user.c:515 OsmoSGSN:
Using SS7 instance 0, pc:0.23.4
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <002d> sccp_user.c:522 OsmoSGSN:
Creating AS instance
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <002d> sccp_user.c:533 OsmoSGSN:
Using AS instance as-clnt-OsmoSGSN
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <002d> sccp_user.c:538 OsmoSGSN:
Creating default route
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <002d> sccp_user.c:558 OsmoSGSN:
Creating ASP instance
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <002d> sccp_user.c:597 OsmoSGSN:
Using ASP instance asp-clnt-OsmoSGSN
Nov 19 04:53:11 3fd58d2e53f7 osmo-sgsn[13357]: <002c> osmo_ss7.c:439 0: Creating
SCCP instance
Nov 19 04:53:12 3fd58d2e53f7 osmo-sgsn[13357]: <002a> gsup_client.c:73 GSUP
connecting to 127.0.0.1:4222
Nov 19 04:53:12 3fd58d2e53f7 osmo-sgsn[13357]: <0022> input/ipa.c:128 127.0.0.1:4222
connection done
Nov 19 04:53:12 3fd58d2e53f7 osmo-sgsn[13357]: <0022> input/ipaccess.c:720 received
ID get from 0/0/0
Nov 19 04:53:13 3fd58d2e53f7 osmo-sgsn[13357]: <002f> m3ua.c:634 0:
asp-asp-clnt-OsmoSGSN: Received NOTIFY Type State Change:AS Inactive ()
Nov 19 04:53:13 3fd58d2e53f7 osmo-sgsn[13357]: <002c> xua_default_lm_fsm.c:354
xua_default_lm(asp-clnt-OsmoSGSN)[0x55f4fcc67df0]{ACTIVE}: Ignoring primitive
M-ASP_ACTIVE.confirm
Nov 19 04:53:13 3fd58d2e53f7 osmo-sgsn[13357]: <002f> m3ua.c:634 0:
asp-asp-clnt-OsmoSGSN: Received NOTIFY Type State Change:AS Active ()
+ systemctl --no-pager -l -n 200 status osmo-pcu
● osmo-pcu.service - Osmocom osmo-pcu
Loaded: loaded (/lib/systemd/system/osmo-pcu.service; enabled; vendor preset: enabled)
Active: active (running) since Tue 2019-11-19 04:53:11 UTC; 2s ago
Main PID: 13358 (osmo-pcu)
Tasks: 1 (limit: 4915)
CGroup:
/docker/3fd58d2e53f7bbdda862f080fa558d3e2481e5faf79e660ab6c0ece2a9a8e9be/system.slice/osmo-pcu.service
└─13358 /usr/bin/osmo-pcu -c /etc/osmocom/osmo-pcu.cfg
Nov 19 04:53:11 3fd58d2e53f7 systemd[1]: osmo-pcu.service: Failed to reset devices.list:
Operation not permitted
Nov 19 04:53:11 3fd58d2e53f7 systemd[1]: Started Osmocom osmo-pcu.
Nov 19 04:53:11 3fd58d2e53f7 osmo-pcu[13358]: <000b> gprs_ns.c:321 NSVCI=65534
Creating NS-VC
Nov 19 04:53:11 3fd58d2e53f7 osmo-pcu[13358]: <000e> telnet_interface.c:104
Available via telnet 127.0.0.1 4240
Nov 19 04:53:11 3fd58d2e53f7 osmo-pcu[13358]: <0001> osmobts_sock.cpp:224 Opening
OsmoPCU L1 interface to OsmoBTS
Nov 19 04:53:11 3fd58d2e53f7 osmo-pcu[13358]: <0001> osmobts_sock.cpp:238 Failed to
connect to the BTS (/tmp/pcu_bts). Retrying...
+ systemctl --no-pager -l -n 200 status osmo-hnbgw
● osmo-hnbgw.service - Osmocom Home Nodeb Gateway (OsmoHNBGW)
Loaded: loaded (/lib/systemd/system/osmo-hnbgw.service; disabled; vendor preset:
enabled)
Active: active (running) since Tue 2019-11-19 04:53:11 UTC; 2s ago
Main PID: 13359 (osmo-hnbgw)
Tasks: 1 (limit: 4915)
CGroup:
/docker/3fd58d2e53f7bbdda862f080fa558d3e2481e5faf79e660ab6c0ece2a9a8e9be/system.slice/osmo-hnbgw.service
└─13359 /usr/bin/osmo-hnbgw -c /etc/osmocom/osmo-hnbgw.cfg
Nov 19 04:53:11 3fd58d2e53f7 systemd[1]: osmo-hnbgw.service: Failed to reset devices.list:
Operation not permitted
Nov 19 04:53:11 3fd58d2e53f7 systemd[1]: Started Osmocom Home Nodeb Gateway (OsmoHNBGW).
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLGLOBAL <0004>
telnet_interface.c:104 Available via telnet 127.0.0.1 4261
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLCTRL <000b>
control_if.c:911 CTRL at 127.0.0.1 4262
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DMAIN <0000>
hnbgw_cn.c:461 IuCS remote addr not configured, using default:
RI=SSN_PC,PC=0.23.1,SSN=RANAP
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DMAIN <0000>
hnbgw_cn.c:461 IuPS remote addr not configured, using default:
RI=SSN_PC,PC=0.23.4,SSN=RANAP
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DRANAP <0003>
hnbgw_cn.c:512 No cs7 instance configured for IuCS nor IuPS, creating default instance
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
osmo_ss7.c:368 0: Creating SS7 Instance
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
osmo_ss7.c:668 0: Creating Route Table system
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DRANAP <0003>
hnbgw_cn.c:525 Local SCCP addr: RI=SSN_PC,PC=0.23.5,SSN=RANAP
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSCCP <0011>
sccp_user.c:515 OsmoHNBGW: Using SS7 instance 0, pc:0.23.5
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSCCP <0011>
sccp_user.c:522 OsmoHNBGW: Creating AS instance
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
fsm.c:461 XUA_AS(as-clnt-OsmoHNBGW)[0x564c3d83a550]{AS_DOWN}: Allocated
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
osmo_ss7.c:970 0: as-as-clnt-OsmoHNBGW: Created AS
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSCCP <0011>
sccp_user.c:533 OsmoHNBGW: Using AS instance as-clnt-OsmoHNBGW
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSCCP <0011>
sccp_user.c:538 OsmoHNBGW: Creating default route
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
osmo_ss7.c:792 0: Creating route: pc=0=0.0.0 mask=0x0 via AS 'as-clnt-OsmoHNBGW'
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSCCP <0011>
sccp_user.c:558 OsmoHNBGW: Creating ASP instance
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
osmo_ss7.c:990 0: as-as-clnt-OsmoHNBGW: Adding ASP asp-clnt-OsmoHNBGW to AS
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
fsm.c:461 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{IDLE}: Allocated
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
osmo_ss7.c:1324 0: asp-asp-clnt-OsmoHNBGW: Restarting ASP asp-clnt-OsmoHNBGW,
r=127.0.0.1:2905<->l=0.0.0.0:0
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
fsm.c:461 XUA_ASP(asp-clnt-OsmoHNBGW)[0x564c3d83b710]{ASP_DOWN}: Allocated
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSCCP <0011>
sccp_user.c:597 OsmoHNBGW: Using ASP instance asp-clnt-OsmoHNBGW
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
osmo_ss7.c:439 0: Creating SCCP instance
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
osmo_ss7.c:463 registering user=SCCP for SI 3 with priv 0x564c3d83ba30
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSCCP <0011>
sccp_user.c:88 Binding user 'OsmoHNBGW' to SSN=142 PC=0.23.5
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DRANAP <0003>
hnbgw_cn.c:550 Remote SCCP addr: IuCS: RI=SSN_PC,PC=0.23.1,SSN=RANAP
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DRANAP <0003>
hnbgw_cn.c:552 Remote SCCP addr: IuPS: RI=SSN_PC,PC=0.23.4,SSN=RANAP
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DHNBAP <0001>
hnbgw.c:598 Using RNC-Id 23
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DMAIN <0000>
hnbgw.c:603 Listening for Iuh at 0.0.0.0 29169
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLINP <0006>
stream.c:293 [CONNECTING] osmo_stream_cli_fd_cb(): connection done.
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
osmo_ss7.c:1583 0: asp-asp-clnt-OsmoHNBGW: Client connected
(r=127.0.0.1:2905<->l=127.0.0.1:43788)
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
xua_default_lm_fsm.c:351 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{IDLE}:
Received primitive M-SCTP_ESTABLISH.indication
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
xua_default_lm_fsm.c:358 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{IDLE}:
Received Event SCTP-ESTABLISH.ind
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
xua_default_lm_fsm.c:142 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{IDLE}:
state_chg to WAIT_ASP_UP
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLSS7 <0010>
xua_default_lm_fsm.c:143 XUA_ASP(asp-clnt-OsmoHNBGW)[0x564c3d83b710]{ASP_DOWN}: Received
Event M-ASP_UP.req
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLINP <0006>
stream.c:314 [ CONNECTED] osmo_stream_cli_fd_cb(): connected write
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLINP <0006>
stream.c:234 [ CONNECTED] osmo_stream_cli_write(): sending data
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLINP <0006>
stream.c:314 [ CONNECTED] osmo_stream_cli_fd_cb(): connected write
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311420 DLINP <0006>
stream.c:234 [ CONNECTED] osmo_stream_cli_write(): sending data
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLINP <0006>
stream.c:310 [ CONNECTED] osmo_stream_cli_fd_cb(): connected read
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLINP <0006>
stream.c:219 [ CONNECTED] osmo_stream_cli_read(): message received
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLSS7 <0010>
osmo_ss7.c:1660 0: asp-asp-clnt-OsmoHNBGW: xua_cli_read_cb(): sctp_recvmsg() returned 8
(flags=0x80)
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLM3UA <0013>
m3ua.c:722 0: asp-asp-clnt-OsmoHNBGW: Received M3UA Message (ASPSM:UP-ACK)
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLSS7 <0010>
m3ua.c:686 XUA_ASP(asp-clnt-OsmoHNBGW)[0x564c3d83b710]{ASP_DOWN}: Received Event
ASPSM-ASP_UP_ACK
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLSS7 <0010>
xua_asp_fsm.c:300 XUA_ASP(asp-clnt-OsmoHNBGW)[0x564c3d83b710]{ASP_DOWN}: T(ack) stopped
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLSS7 <0010>
xua_asp_fsm.c:349 XUA_ASP(asp-clnt-OsmoHNBGW)[0x564c3d83b710]{ASP_DOWN}: state_chg to
ASP_INACTIVE
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLSS7 <0010>
xua_asp_fsm.c:398 XUA_AS(as-clnt-OsmoHNBGW)[0x564c3d83a550]{AS_DOWN}: Received Event
ASPAS-ASP_INACTIVE.ind
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLSS7 <0010>
xua_as_fsm.c:251 XUA_AS(as-clnt-OsmoHNBGW)[0x564c3d83a550]{AS_DOWN}: state_chg to
AS_INACTIVE
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLSS7 <0010>
xua_default_lm_fsm.c:351 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{WAIT_ASP_UP}:
Received primitive M-ASP_UP.confirm
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLSS7 <0010>
xua_default_lm_fsm.c:358 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{WAIT_ASP_UP}:
Received Event ASP-UP.conf
Nov 19 04:53:11 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045311421 DLSS7 <0010>
xua_default_lm_fsm.c:154 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{WAIT_ASP_UP}:
state_chg to WAIT_NOTIFY
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
fsm.c:322 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{WAIT_NOTIFY}: Timeout of T1
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:176 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{WAIT_NOTIFY}:
state_chg to RKM_REG
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_rkm.c:559 0: asp-asp-clnt-OsmoHNBGW: Received XUA Layer Manager Primitive:
M-RK_REG.request)
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:314 [ CONNECTED] osmo_stream_cli_fd_cb(): connected write
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:234 [ CONNECTED] osmo_stream_cli_write(): sending data
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:314 [ CONNECTED] osmo_stream_cli_fd_cb(): connected write
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:234 [ CONNECTED] osmo_stream_cli_write(): sending data
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:310 [ CONNECTED] osmo_stream_cli_fd_cb(): connected read
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:219 [ CONNECTED] osmo_stream_cli_read(): message received
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
osmo_ss7.c:1660 0: asp-asp-clnt-OsmoHNBGW: xua_cli_read_cb(): sctp_recvmsg() returned 36
(flags=0x80)
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLM3UA <0013>
m3ua.c:722 0: asp-asp-clnt-OsmoHNBGW: Received M3UA Message (RKM:REG-RESP)
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_rkm.c:435 0: asp-asp-clnt-OsmoHNBGW: Received RKM REG RES rctx=2 status=SUCCESS
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:351 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{RKM_REG}:
Received primitive M-RK_REG.confirm
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:358 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{RKM_REG}:
Received Event RKM_REG.conf
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:249 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{RKM_REG}:
state_chg to WAIT_NOTIFY
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:310 [ CONNECTED] osmo_stream_cli_fd_cb(): connected read
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:219 [ CONNECTED] osmo_stream_cli_read(): message received
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
osmo_ss7.c:1660 0: asp-asp-clnt-OsmoHNBGW: xua_cli_read_cb(): sctp_recvmsg() returned 24
(flags=0x80)
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLM3UA <0013>
m3ua.c:722 0: asp-asp-clnt-OsmoHNBGW: Received M3UA Message (MGMT:NOTIFY)
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLM3UA <0013>
m3ua.c:634 0: asp-asp-clnt-OsmoHNBGW: Received NOTIFY Type State Change:AS Inactive ()
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:351 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{WAIT_NOTIFY}:
Received primitive M-NOTIFY.indication
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:358 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{WAIT_NOTIFY}:
Received Event NOTIFY.ind
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:215 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{WAIT_NOTIFY}:
state_chg to ACTIVE
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:216 XUA_ASP(asp-clnt-OsmoHNBGW)[0x564c3d83b710]{ASP_INACTIVE}:
Received Event M-ASP_ACTIVE.req
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:314 [ CONNECTED] osmo_stream_cli_fd_cb(): connected write
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:234 [ CONNECTED] osmo_stream_cli_write(): sending data
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:310 [ CONNECTED] osmo_stream_cli_fd_cb(): connected read
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:219 [ CONNECTED] osmo_stream_cli_read(): message received
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
osmo_ss7.c:1660 0: asp-asp-clnt-OsmoHNBGW: xua_cli_read_cb(): sctp_recvmsg() returned 8
(flags=0x80)
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLM3UA <0013>
m3ua.c:722 0: asp-asp-clnt-OsmoHNBGW: Received M3UA Message (ASPTM:ACTIVE-ACK)
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
m3ua.c:686 XUA_ASP(asp-clnt-OsmoHNBGW)[0x564c3d83b710]{ASP_INACTIVE}: Received Event
ASPTM-ASP_AC_ACK
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_asp_fsm.c:300 XUA_ASP(asp-clnt-OsmoHNBGW)[0x564c3d83b710]{ASP_INACTIVE}: T(ack)
stopped
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_asp_fsm.c:432 XUA_ASP(asp-clnt-OsmoHNBGW)[0x564c3d83b710]{ASP_INACTIVE}: state_chg to
ASP_ACTIVE
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_asp_fsm.c:398 XUA_AS(as-clnt-OsmoHNBGW)[0x564c3d83a550]{AS_INACTIVE}: Received Event
ASPAS-ASP_ACTIVE.ind
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_as_fsm.c:320 XUA_AS(as-clnt-OsmoHNBGW)[0x564c3d83a550]{AS_INACTIVE}: state_chg to
AS_ACTIVE
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:351 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{ACTIVE}:
Received primitive M-ASP_ACTIVE.confirm
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:354 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{ACTIVE}:
Ignoring primitive M-ASP_ACTIVE.confirm
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:314 [ CONNECTED] osmo_stream_cli_fd_cb(): connected write
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:234 [ CONNECTED] osmo_stream_cli_write(): sending data
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:310 [ CONNECTED] osmo_stream_cli_fd_cb(): connected read
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLINP <0006>
stream.c:219 [ CONNECTED] osmo_stream_cli_read(): message received
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
osmo_ss7.c:1660 0: asp-asp-clnt-OsmoHNBGW: xua_cli_read_cb(): sctp_recvmsg() returned 24
(flags=0x80)
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLM3UA <0013>
m3ua.c:722 0: asp-asp-clnt-OsmoHNBGW: Received M3UA Message (MGMT:NOTIFY)
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLM3UA <0013>
m3ua.c:634 0: asp-asp-clnt-OsmoHNBGW: Received NOTIFY Type State Change:AS Active ()
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:351 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{ACTIVE}:
Received primitive M-NOTIFY.indication
Nov 19 04:53:13 3fd58d2e53f7 osmo-hnbgw[13359]: 20191119045313423 DLSS7 <0010>
xua_default_lm_fsm.c:358 xua_default_lm(asp-clnt-OsmoHNBGW)[0x564c3d83aa20]{ACTIVE}:
Received Event NOTIFY.ind
+ systemctl --no-pager -l -n 200 status osmo-bts-virtual
● osmo-bts-virtual.service - Osmocom GSM BTS for virtual Um layer based on GSMTAP/UDP
Loaded: loaded (/lib/systemd/system/osmo-bts-virtual.service; enabled; vendor preset:
enabled)
Active: activating (auto-restart) (Result: exit-code) since Tue 2019-11-19 04:53:13
UTC; 79ms ago
Process: 13364 ExecStart=/usr/bin/osmo-bts-virtual -s -c
/etc/osmocom/osmo-bts-virtual.cfg (code=exited, status=1/FAILURE)
Main PID: 13364 (code=exited, status=1/FAILURE)
Nov 19 04:53:13 3fd58d2e53f7 systemd[1]: Stopped Osmocom GSM BTS for virtual Um layer
based on GSMTAP/UDP.
Nov 19 04:53:13 3fd58d2e53f7 osmo-bts-virtual[13364]: Error occurred during reading the
below line:
Nov 19 04:53:13 3fd58d2e53f7 osmo-bts-virtual[13364]: ms-power-control dsp
Nov 19 04:53:13 3fd58d2e53f7 osmo-bts-virtual[13364]: Failed to parse the config file:
'/etc/osmocom/osmo-bts-virtual.cfg'
Nov 19 04:53:13 3fd58d2e53f7 osmo-bts-virtual[13364]: ((*))
Nov 19 04:53:13 3fd58d2e53f7 osmo-bts-virtual[13364]: |
Nov 19 04:53:13 3fd58d2e53f7 osmo-bts-virtual[13364]: / \ OsmoBTS
Nov 19 04:53:13 3fd58d2e53f7 systemd[1]: osmo-bts-virtual.service: Failed to reset
devices.list: Operation not permitted
Nov 19 04:53:13 3fd58d2e53f7 systemd[1]: Started Osmocom GSM BTS for virtual Um layer
based on GSMTAP/UDP.
Nov 19 04:53:13 3fd58d2e53f7 systemd[1]: osmo-bts-virtual.service: Main process exited,
code=exited, status=1/FAILURE
Nov 19 04:53:13 3fd58d2e53f7 systemd[1]: osmo-bts-virtual.service: Unit entered failed
state.
Nov 19 04:53:13 3fd58d2e53f7 systemd[1]: osmo-bts-virtual.service: Failed with result
'exit-code'.
+ failed= osmo-bts-virtual
+ systemctl stop osmo-bsc osmo-gbproxy osmo-gtphub osmo-hlr osmo-mgw osmo-msc
osmo-pcap-client osmo-sip-connector osmo-stp osmo-pcap-server osmo-sgsn osmo-pcu
osmo-hnbgw osmo-bts-virtual
+ [ -n osmo-bts-virtual ]
+ set +x
ERROR: services failed to start: osmo-bts-virtual
+ ret=1
+ [ -n ]
+ docker container kill repo-install-test-nightly
repo-install-test-nightly
+ exit 1
Build step 'Execute shell' marked build as failure
Show replies by date
See
<https://jenkins.osmocom.org/jenkins/job/Osmocom-Debian-install-nightly/439/display/redirect?page=changes>