search

omec-project / gnbsim

gNB simulator
67 stars 37 forks source link

context.GetSimUe - fatal error: concurrent map read and map write #130

Open yoursunny opened 8 months ago

yoursunny commented 8 months ago

I have a sighting of a crash in simue/context package when a large number of profiles are starting/running in parallel. This error only occurred once and does not reproduce reliably. Nevertheless, I'm reporting it here so that this race condition can be reviewed.

Configuration

1 gNB, 40 UEs, 40 profiles running in parallel ```yaml --- info: version: 1.0.0 description: GNBSIM initial local configuration configuration: runConfigProfilesAtStart: true singleInterface: false #default value execInParallel: true #run all profiles in parallel httpServer: # Serves APIs to create/control profiles on the go enable: true ipAddr: 172.25.192.50 port: 8080 gnbs: gnb0: defaultAmf: hostName: 172.25.199.44 ipAddr: 172.25.199.44 port: 38412 globalRanId: gNbId: bitLength: 24 gNBValue: "000000" plmnId: &ref_0 mcc: "001" mnc: "01" n2IpAddr: 172.25.199.50 n2Port: 9487 n3IpAddr: 172.25.195.50 n3Port: 2152 name: gnb0 supportedTaList: - broadcastPlmnList: - plmnId: *ref_0 taiSliceSupportList: - sd: "000000" sst: 128 - sd: "000000" sst: 129 - sd: "000000" sst: 130 - sd: "000000" sst: 131 - sd: "000000" sst: 132 - sd: "000000" sst: 133 - sd: "000000" sst: 134 - sd: "000000" sst: 135 - sd: "000000" sst: 136 - sd: "000000" sst: 137 - sd: "000000" sst: 138 - sd: "000000" sst: 139 - sd: "000000" sst: 140 - sd: "000000" sst: 141 - sd: "000000" sst: 142 - sd: "000000" sst: 143 - sd: "000000" sst: 144 - sd: "000000" sst: 145 - sd: "000000" sst: 146 - sd: "000000" sst: 147 - sd: "000000" sst: 148 - sd: "000000" sst: 149 - sd: "000000" sst: 150 - sd: "000000" sst: 151 - sd: "000000" sst: 152 - sd: "000000" sst: 153 - sd: "000000" sst: 154 - sd: "000000" sst: 155 - sd: "000000" sst: 156 - sd: "000000" sst: 157 - sd: "000000" sst: 158 - sd: "000000" sst: 159 - sd: "000000" sst: 160 - sd: "000000" sst: 161 - sd: "000000" sst: 162 - sd: "000000" sst: 163 - sd: "000000" sst: 164 - sd: "000000" sst: 165 - sd: "000000" sst: 166 - sd: "000000" sst: 167 tac: "000005" profiles: - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n00 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551000 profileType: deregister sNssai: sd: "000000" sst: 128 sequenceNumber: "000000000020" startImsi: "001017005551000" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n01 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551001 profileType: deregister sNssai: sd: "000000" sst: 129 sequenceNumber: "000000000020" startImsi: "001017005551001" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n02 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551002 profileType: deregister sNssai: sd: "000000" sst: 130 sequenceNumber: "000000000020" startImsi: "001017005551002" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n03 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551003 profileType: deregister sNssai: sd: "000000" sst: 131 sequenceNumber: "000000000020" startImsi: "001017005551003" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n04 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551004 profileType: deregister sNssai: sd: "000000" sst: 132 sequenceNumber: "000000000020" startImsi: "001017005551004" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n05 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551005 profileType: deregister sNssai: sd: "000000" sst: 133 sequenceNumber: "000000000020" startImsi: "001017005551005" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n06 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551006 profileType: deregister sNssai: sd: "000000" sst: 134 sequenceNumber: "000000000020" startImsi: "001017005551006" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n07 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551007 profileType: deregister sNssai: sd: "000000" sst: 135 sequenceNumber: "000000000020" startImsi: "001017005551007" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n08 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551008 profileType: deregister sNssai: sd: "000000" sst: 136 sequenceNumber: "000000000020" startImsi: "001017005551008" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n09 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551009 profileType: deregister sNssai: sd: "000000" sst: 137 sequenceNumber: "000000000020" startImsi: "001017005551009" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n10 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551010 profileType: deregister sNssai: sd: "000000" sst: 138 sequenceNumber: "000000000020" startImsi: "001017005551010" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n11 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551011 profileType: deregister sNssai: sd: "000000" sst: 139 sequenceNumber: "000000000020" startImsi: "001017005551011" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n12 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551012 profileType: deregister sNssai: sd: "000000" sst: 140 sequenceNumber: "000000000020" startImsi: "001017005551012" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n13 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551013 profileType: deregister sNssai: sd: "000000" sst: 141 sequenceNumber: "000000000020" startImsi: "001017005551013" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n14 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551014 profileType: deregister sNssai: sd: "000000" sst: 142 sequenceNumber: "000000000020" startImsi: "001017005551014" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n15 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551015 profileType: deregister sNssai: sd: "000000" sst: 143 sequenceNumber: "000000000020" startImsi: "001017005551015" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n16 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551016 profileType: deregister sNssai: sd: "000000" sst: 144 sequenceNumber: "000000000020" startImsi: "001017005551016" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n17 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551017 profileType: deregister sNssai: sd: "000000" sst: 145 sequenceNumber: "000000000020" startImsi: "001017005551017" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n18 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551018 profileType: deregister sNssai: sd: "000000" sst: 146 sequenceNumber: "000000000020" startImsi: "001017005551018" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n19 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551019 profileType: deregister sNssai: sd: "000000" sst: 147 sequenceNumber: "000000000020" startImsi: "001017005551019" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n20 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551020 profileType: deregister sNssai: sd: "000000" sst: 148 sequenceNumber: "000000000020" startImsi: "001017005551020" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n21 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551021 profileType: deregister sNssai: sd: "000000" sst: 149 sequenceNumber: "000000000020" startImsi: "001017005551021" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n22 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551022 profileType: deregister sNssai: sd: "000000" sst: 150 sequenceNumber: "000000000020" startImsi: "001017005551022" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n23 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551023 profileType: deregister sNssai: sd: "000000" sst: 151 sequenceNumber: "000000000020" startImsi: "001017005551023" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n24 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551024 profileType: deregister sNssai: sd: "000000" sst: 152 sequenceNumber: "000000000020" startImsi: "001017005551024" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n25 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551025 profileType: deregister sNssai: sd: "000000" sst: 153 sequenceNumber: "000000000020" startImsi: "001017005551025" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n26 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551026 profileType: deregister sNssai: sd: "000000" sst: 154 sequenceNumber: "000000000020" startImsi: "001017005551026" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n27 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551027 profileType: deregister sNssai: sd: "000000" sst: 155 sequenceNumber: "000000000020" startImsi: "001017005551027" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n28 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551028 profileType: deregister sNssai: sd: "000000" sst: 156 sequenceNumber: "000000000020" startImsi: "001017005551028" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n29 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551029 profileType: deregister sNssai: sd: "000000" sst: 157 sequenceNumber: "000000000020" startImsi: "001017005551029" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n30 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551030 profileType: deregister sNssai: sd: "000000" sst: 158 sequenceNumber: "000000000020" startImsi: "001017005551030" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n31 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551031 profileType: deregister sNssai: sd: "000000" sst: 159 sequenceNumber: "000000000020" startImsi: "001017005551031" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n32 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551032 profileType: deregister sNssai: sd: "000000" sst: 160 sequenceNumber: "000000000020" startImsi: "001017005551032" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n33 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551033 profileType: deregister sNssai: sd: "000000" sst: 161 sequenceNumber: "000000000020" startImsi: "001017005551033" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n34 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551034 profileType: deregister sNssai: sd: "000000" sst: 162 sequenceNumber: "000000000020" startImsi: "001017005551034" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n35 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551035 profileType: deregister sNssai: sd: "000000" sst: 163 sequenceNumber: "000000000020" startImsi: "001017005551035" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n36 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551036 profileType: deregister sNssai: sd: "000000" sst: 164 sequenceNumber: "000000000020" startImsi: "001017005551036" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n37 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551037 profileType: deregister sNssai: sd: "000000" sst: 165 sequenceNumber: "000000000020" startImsi: "001017005551037" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n38 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551038 profileType: deregister sNssai: sd: "000000" sst: 166 sequenceNumber: "000000000020" startImsi: "001017005551038" ueCount: 1 - dataPktCount: 5 defaultAs: 172.25.193.42 dnn: n39 enable: true execInParallel: true gnbName: gnb0 key: c5dabfd66406eeb9871f18eacf1f8864 opc: efb1b89d8759b701a681875d09e322eb plmnId: mcc: "001" mnc: "01" profileName: deregister-001017005551039 profileType: deregister sNssai: sd: "000000" sst: 167 sequenceNumber: "000000000020" startImsi: "001017005551039" ueCount: 1 logger: logLevel: info # how detailed the log will be, values: trace, debug, info, warn, error, fatal, panic ```
yoursunny commented 8 months ago

Output and Stacktrace

InitProfile and ExecuteProfile are running in different goroutines at the same time, concurrent access occurred on context.SimUeTable ```text 2024-01-30T21:24:42Z [INFO][GNBSIM][App] App Name: GNBSIM 2024-01-30T21:24:42Z [INFO][GNBSIM][App] Setting log level to: info 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][gnb0] GNodeB IP: 172.25.199.50 GNodeB Port: 9487 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][UserPlaneTransport] User Plane transport listening on: 172.25.195.50:2152 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB] Current range selector value: 109 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB] Current ID range start: 1828716544 end: 1845493759 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][ControlPlaneTransport] Connected to AMF, AMF IP: 172.25.199.44 AMF Port: 38412 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][ControlPlaneTransport] Wrote 251 bytes 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][ControlPlaneTransport] Read 245 bytes from 172.25.199.44:38412 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][gnb0] NG Setup Successful: true [GIN-debug] [WARNING] Running in "debug" mode. Switch to "release" mode in production. - using env: export GIN_MODE=release - using code: gin.SetMode(gin.ReleaseMode) [GIN-debug] GET /gnbsim/v1/ --> github.com/omec-project/gnbsim/profile/httprouter.Index (4 handlers) [GIN-debug] POST /gnbsim/v1/executeProfile --> github.com/omec-project/gnbsim/profile/httprouter.HTTPExecuteProfile (4 handlers) [GIN-debug] GET /gnbsim/v1/executeConfigProfile --> github.com/omec-project/gnbsim/profile/httprouter.HTTPExecuteConfigProfile (4 handlers) [GIN-debug] POST /gnbsim/v1/:profile-name/stepProfile --> github.com/omec-project/gnbsim/profile/httprouter.HTTPStepProfile (4 handlers) [GIN-debug] POST /gnbsim/v1/:profile-name/addNewCalls --> github.com/omec-project/gnbsim/profile/httprouter.HTTPAddNewCallsProfile (4 handlers) 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551000] Init profile: deregister-001017005551000 , profile type: deregister 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbUeDao] Adding new GnbCpUe for RANUENGAPID: 1828716544 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551000] Connected to gNodeB, Name:gnb0, IP:172.25.199.50, Port:9487 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551000] SIM UE Init complete 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551001] Init profile: deregister-001017005551001 , profile type: deregister 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbUeDao] Adding new GnbCpUe for RANUENGAPID: 1828716545 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551001] Connected to gNodeB, Name:gnb0, IP:172.25.199.50, Port:9487 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551001] SIM UE Init complete 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551002] Init profile: deregister-001017005551002 , profile type: deregister 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716544] Handling event: CONNECTION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716545] Handling event: CONNECTION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551001] ExecuteProfile started 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551000] ExecuteProfile started 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbUeDao] Adding new GnbCpUe for RANUENGAPID: 1828716546 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551000] ExecuteProfile ExecInParallel true. Waiting for for all UEs to finish processing 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551002] Connected to gNodeB, Name:gnb0, IP:172.25.199.50, Port:9487 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551002] SIM UE Init complete 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551001] Execute procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716546] Handling event: CONNECTION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551001] ExecuteProfile ExecInParallel true. Waiting for for all UEs to finish processing 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551001] Waiting for procedure result from imsiStateMachine 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551000] Execute procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551002] ExecuteProfile started 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551003] Init profile: deregister-001017005551003 , profile type: deregister 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551001] Handling event: PROC-START-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551002] ExecuteProfile ExecInParallel true. Waiting for for all UEs to finish processing 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbUeDao] Adding new GnbCpUe for RANUENGAPID: 1828716547 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551001] Start new procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551002] Execute procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551002] Waiting for procedure result from imsiStateMachine 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551001] Initiating Registration Procedure 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551002] Handling event: PROC-START-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551002] Start new procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551002] Initiating Registration Procedure 2024-01-30T21:24:42Z [INFO][GNBSIM][RealUe][imsi-001017005551001] Handling: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551003] Connected to gNodeB, Name:gnb0, IP:172.25.199.50, Port:9487 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551001] Handling event: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][RealUe][imsi-001017005551002] Handling: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716545] Handling event: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716547] Handling event: CONNECTION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551000] Handling event: PROC-START-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551002] Handling event: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551000] Start new procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551000] Initiating Registration Procedure 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551000] Waiting for procedure result from imsiStateMachine 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716546] Handling event: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][RealUe][imsi-001017005551000] Handling: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551000] Handling event: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716544] Handling event: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551003] SIM UE Init complete 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551004] Init profile: deregister-001017005551004 , profile type: deregister 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbUeDao] Adding new GnbCpUe for RANUENGAPID: 1828716548 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551004] Connected to gNodeB, Name:gnb0, IP:172.25.199.50, Port:9487 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551003] ExecuteProfile started 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551004] SIM UE Init complete 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551003] ExecuteProfile ExecInParallel true. Waiting for for all UEs to finish processing 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551005] Init profile: deregister-001017005551005 , profile type: deregister 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551003] Execute procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551003] Waiting for procedure result from imsiStateMachine 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbUeDao] Adding new GnbCpUe for RANUENGAPID: 1828716549 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551004] ExecuteProfile started 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551003] Handling event: PROC-START-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716548] Handling event: CONNECTION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551005] Connected to gNodeB, Name:gnb0, IP:172.25.199.50, Port:9487 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551004] Execute procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551004] ExecuteProfile ExecInParallel true. Waiting for for all UEs to finish processing 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551004] Waiting for procedure result from imsiStateMachine 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551005] SIM UE Init complete 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551004] Handling event: PROC-START-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551004] Start new procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551005] ExecuteProfile started 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551004] Initiating Registration Procedure 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551003] Start new procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716549] Handling event: CONNECTION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551005] Execute procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551006] Init profile: deregister-001017005551006 , profile type: deregister 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbUeDao] Adding new GnbCpUe for RANUENGAPID: 1828716550 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551005] Handling event: PROC-START-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551005] Waiting for procedure result from imsiStateMachine 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551005] ExecuteProfile ExecInParallel true. Waiting for for all UEs to finish processing 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551003] Initiating Registration Procedure 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551006] Connected to gNodeB, Name:gnb0, IP:172.25.199.50, Port:9487 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551006] SIM UE Init complete 2024-01-30T21:24:42Z [INFO][GNBSIM][RealUe][imsi-001017005551004] Handling: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][RealUe][imsi-001017005551003] Handling: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551004] Handling event: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551003] Handling event: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551007] Init profile: deregister-001017005551007 , profile type: deregister 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716550] Handling event: CONNECTION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551006] ExecuteProfile started 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbUeDao] Adding new GnbCpUe for RANUENGAPID: 1828716551 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551007] Connected to gNodeB, Name:gnb0, IP:172.25.199.50, Port:9487 2024-01-30T21:24:42Z [INFO][GNBSIM][ProfUeCtx][imsi-001017005551006] Execute procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551007] SIM UE Init complete 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716547] Handling event: REGISTRATION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][GnbCpUe][1828716551] Handling event: CONNECTION-REQUEST-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551006] Handling event: PROC-START-EVENT 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551006] Start new procedure REGISTRATION-PROCEDURE 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551006] Initiating Registration Procedure 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551007] ExecuteProfile started 2024-01-30T21:24:42Z [INFO][GNBSIM][Profile][deregister-001017005551008] Init profile: deregister-001017005551008 , profile type: deregister 2024-01-30T21:24:42Z [INFO][GNBSIM][SimUe][imsi-001017005551005] Start new procedure REGISTRATION-PROCEDURE fatal error: concurrent map read and map write 2024-01-30T21:24:42Z [INFO][GNBSIM][GNodeB][ControlPlaneTransport] Wrote 73 bytes goroutine 181 [running]: github.com/omec-project/gnbsim/simue/context.GetSimUe(...) /gnbsim/simue/context/simue.go:74 github.com/omec-project/gnbsim/simue.ImsiStateMachine(0xc0003fb900, 0xc0000c2460, {0xc000538660, 0x14}, 0x0?) /gnbsim/simue/simue.go:185 +0x9a github.com/omec-project/gnbsim/profile.ExecuteProfile.func3(0x0?) /gnbsim/profile/profile.go:166 +0x7a created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 179 /gnbsim/profile/profile.go:164 +0x3c5 goroutine 1 [runnable]: sync.runtime_nanotime() /usr/local/go/src/runtime/sema.go:631 +0x2f sync.(*Mutex).lockSlow(0xc000354430) /usr/local/go/src/sync/mutex.go:169 +0x137 sync.(*Mutex).Lock(...) /usr/local/go/src/sync/mutex.go:90 github.com/sirupsen/logrus.(*MutexWrap).Lock(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/logger.go:61 github.com/sirupsen/logrus.(*Entry).write(0xc00040d570) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:287 +0x52 github.com/sirupsen/logrus.(*Entry).log(0xc0003dee70, 0x4, {0xc00081a390, 0x2e}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:252 +0x436 github.com/sirupsen/logrus.(*Entry).Log(0xc0003dee70, 0x4, {0xc000621120?, 0x40e05b?, 0x8?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x48 github.com/sirupsen/logrus.(*Entry).Logln(0xc0003dee70, 0x4, {0xc000621180?, 0x0?, 0x0?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:394 +0x7f github.com/sirupsen/logrus.(*Entry).Infoln(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:407 github.com/omec-project/gnbsim/gnodeb/context.(*GnbUeDao).AddGnbCpUe(0xc0007a03c0, 0xc0001842a0?, 0xc00017e2d0?) /gnbsim/gnodeb/context/gnbuedao.go:52 +0x85 github.com/omec-project/gnbsim/gnodeb.RequestConnection(0xc0001842a0, 0xc00040d490) /gnbsim/gnodeb/gnodeb.go:128 +0xf8 github.com/omec-project/gnbsim/simue.ConnectToGnb(0xc00040d340) /gnbsim/simue/simue.go:53 +0x89 github.com/omec-project/gnbsim/simue.Init(0xc00040d340) /gnbsim/simue/simue.go:27 +0x1f github.com/omec-project/gnbsim/simue.InitUE({0xc0007306c0?, 0x0?}, 0x100c000580000?, 0x7f2f056e94a0?, 0x7f2f4c73e3c8?) /gnbsim/simue/simue.go:22 +0x25 github.com/omec-project/gnbsim/profile.initImsi(0xc0003fba40, 0xc0007a56c8?, {0xc0007306c0, 0x14}) /gnbsim/profile/profile.go:79 +0x72 github.com/omec-project/gnbsim/profile.InitProfile(0xc0003fba40, 0x1?) /gnbsim/profile/profile.go:66 +0x49d main.action(0xc0003e42c0) /gnbsim/gnbsim.go:125 +0x68b github.com/urfave/cli.HandleAction({0xbc1480?, 0xd6bb20?}, 0xc0003b6380?) /go/pkg/mod/github.com/urfave/cli@v1.22.14/app.go:524 +0x50 github.com/urfave/cli.(*App).Run(0xc0003b6380, {0xc000034120, 0x3, 0x3}) /go/pkg/mod/github.com/urfave/cli@v1.22.14/app.go:286 +0x766 main.main() /gnbsim/gnbsim.go:39 +0x225 goroutine 68 [IO wait]: internal/poll.runtime_pollWait(0x7f2f05bace38, 0x72) /usr/local/go/src/runtime/netpoll.go:343 +0x85 internal/poll.(*pollDesc).wait(0xc000355f00?, 0xc00069e000?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).ReadFromInet4(0xc000355f00, {0xc00069e000, 0xffe3, 0xffe3}, 0xc000469d18?) /usr/local/go/src/internal/poll/fd_unix.go:247 +0x22b net.(*netFD).readFromInet4(0xc000355f00, {0xc00069e000?, 0x418065?, 0xc000469d80?}, 0x42b37b?) /usr/local/go/src/net/fd_posix.go:66 +0x25 net.(*UDPConn).readFrom(0x10000?, {0xc00069e000?, 0xc00069e000?, 0x0?}, 0xc0006b2f78) /usr/local/go/src/net/udpsock_posix.go:52 +0x1b1 net.(*UDPConn).readFromUDP(0xc000090318, {0xc00069e000?, 0xbe9460?, 0xc000057400?}, 0xc000469ea0?) /usr/local/go/src/net/udpsock.go:149 +0x30 net.(*UDPConn).ReadFromUDP(...) /usr/local/go/src/net/udpsock.go:141 github.com/omec-project/gnbsim/gnodeb/transport.(*GnbUpTransport).ReceiveFromPeer(0xc000010af8, {0x0?, 0xc0000b0240?}) /gnbsim/gnodeb/transport/uptransport.go:97 +0x89 created by github.com/omec-project/gnbsim/gnodeb/transport.(*GnbUpTransport).Init in goroutine 1 /gnbsim/gnodeb/transport/uptransport.go:60 +0x328 goroutine 69 [syscall]: syscall.Syscall(0xc000467cd0?, 0x42b37b?, 0x7f2f4c748158?, 0x100?) /usr/local/go/src/syscall/syscall_linux.go:69 +0x25 syscall.recvmsg(0x4d?, 0x467d10?, 0x419ca8?) /usr/local/go/src/syscall/zsyscall_linux_amd64.go:1568 +0x2f syscall.recvmsgRaw(0x40fc3e?, {0xc0006b6000?, 0x0?, 0xc000467da8?}, {0xc0006b8000?, 0xc000467d90?, 0x41d696?}, 0x147ca80?, 0xc000467df8?) /usr/local/go/src/syscall/syscall_linux.go:779 +0x116 syscall.Recvmsg(0x7f2f4c73f1d8?, {0xc0006b6000?, 0xc000500400?, 0xc0006b6000?}, {0xc0006b8000?, 0xc000467e80?, 0x452e89?}, 0x800?) /usr/local/go/src/syscall/syscall_unix.go:385 +0x65 git.cs.nctu.edu.tw/calee/sctp.(*SCTPConn).SCTPRead(0xc000512b60, {0xc0006b6000, 0x800, 0x800}) /go/pkg/mod/git.cs.nctu.edu.tw/calee/sctp@v1.1.0/sctp_linux.go:140 +0x6f github.com/omec-project/gnbsim/gnodeb/transport.(*GnbCpTransport).ReceiveFromPeer(0xc000512930, {0xe4ee30?, 0xc00017e2d0}) /gnbsim/gnodeb/transport/cptransport.go:149 +0x109 created by github.com/omec-project/gnbsim/gnodeb.Init in goroutine 1 /gnbsim/gnodeb/gnodeb.go:75 +0xc5b goroutine 70 [chan receive]: main.ListenAndLogSummary() /gnbsim/gnbsim.go:161 +0xc5 created by main.action in goroutine 1 /gnbsim/gnbsim.go:87 +0x3fb goroutine 71 [IO wait]: internal/poll.runtime_pollWait(0x7f2f05bacd40, 0x72) /usr/local/go/src/runtime/netpoll.go:343 +0x85 internal/poll.(*pollDesc).wait(0xc000186480?, 0xc0006aeb58?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Accept(0xc000186480) /usr/local/go/src/internal/poll/fd_unix.go:611 +0x2ac net.(*netFD).accept(0xc000186480) /usr/local/go/src/net/fd_unix.go:172 +0x29 net.(*TCPListener).accept(0xc000514140) /usr/local/go/src/net/tcpsock_posix.go:152 +0x1e net.(*TCPListener).Accept(0xc000514140) /usr/local/go/src/net/tcpsock.go:315 +0x30 net/http.(*Server).Serve(0xc000456000, {0xe50fc8, 0xc000514140}) /usr/local/go/src/net/http/server.go:3056 +0x364 net/http.(*Server).ListenAndServe(0xc000456000) /usr/local/go/src/net/http/server.go:2985 +0x71 github.com/omec-project/gnbsim/httpserver.StartHttpServer() /gnbsim/httpserver/server.go:63 +0x3d1 main.action.func2() /gnbsim/gnbsim.go:94 +0x4d created by main.action in goroutine 1 /gnbsim/gnbsim.go:92 +0x472 goroutine 73 [syscall]: os/signal.signal_recv() /usr/local/go/src/runtime/sigqueue.go:152 +0x29 os/signal.loop() /usr/local/go/src/os/signal/signal_unix.go:23 +0x13 created by os/signal.Notify.func1.1 in goroutine 1 /usr/local/go/src/os/signal/signal.go:151 +0x1f goroutine 28 [chan receive]: main.action.func3() /gnbsim/gnbsim.go:103 +0x1d created by main.action in goroutine 1 /gnbsim/gnbsim.go:102 +0x529 goroutine 29 [sync.Mutex.Lock]: sync.runtime_SemacquireMutex(0xc000100000?, 0x40?, 0x0?) /usr/local/go/src/runtime/sema.go:77 +0x25 sync.(*Mutex).lockSlow(0xc000354430) /usr/local/go/src/sync/mutex.go:171 +0x15d sync.(*Mutex).Lock(...) /usr/local/go/src/sync/mutex.go:90 github.com/sirupsen/logrus.(*MutexWrap).Lock(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/logger.go:61 github.com/sirupsen/logrus.(*Entry).log(0xc0003dec40, 0x4, {0xc00051bcb0, 0xf}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:233 +0x2d1 github.com/sirupsen/logrus.(*Entry).Log(0xc0003dec40, 0x4, {0xc0005d3d20?, 0x1?, 0x1?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x48 github.com/sirupsen/logrus.(*Entry).Logf(0xc0003dec40, 0x4, {0xd1f322?, 0xc00047b270?}, {0xc0005d3da0?, 0x0?, 0xc0005d3df0?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:349 +0x7c github.com/sirupsen/logrus.(*Entry).Infof(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:362 github.com/omec-project/gnbsim/gnodeb/transport.(*GnbCpTransport).SendToPeer(0xc000512930, {0xe4ee30?, 0xc00017e2d0}, {0xc00047b270, 0x49, 0x50}) /gnbsim/gnodeb/transport/cptransport.go:128 +0x237 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleInitialUEMessage(0xc00054c000, {0xe4ee08?, 0xc0003ff030?}) /gnbsim/gnodeb/worker/gnbcpueworker/handler.go:63 +0x2b5 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleEvents(0xc00054c000) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:25 +0x225 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.Init(...) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:13 github.com/omec-project/gnbsim/gnodeb.RequestConnection.func1() /gnbsim/gnodeb/gnodeb.go:135 +0x4e created by github.com/omec-project/gnbsim/gnodeb.RequestConnection in goroutine 1 /gnbsim/gnodeb/gnodeb.go:133 +0x167 goroutine 30 [chan receive]: github.com/omec-project/gnbsim/realue.HandleEvents(0xc00053a120) /gnbsim/realue/realue.go:20 +0x65 github.com/omec-project/gnbsim/realue.Init(0xc00053a120) /gnbsim/realue/realue.go:16 +0x22a github.com/omec-project/gnbsim/simue.Init.func1() /gnbsim/simue/simue.go:38 +0x53 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:36 +0x148 goroutine 31 [chan receive]: github.com/omec-project/gnbsim/simue.HandleEvents(0xc0003e21c0) /gnbsim/simue/simue.go:67 +0x67 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:41 +0x18a goroutine 32 [semacquire]: sync.runtime_Semacquire(0xc00044a030?) /usr/local/go/src/runtime/sema.go:62 +0x25 sync.(*WaitGroup).Wait(0xc0003cad90?) /usr/local/go/src/sync/waitgroup.go:116 +0x48 github.com/omec-project/gnbsim/profile.ExecuteProfile(0xc0003fb040, 0xc00023e000) /gnbsim/profile/profile.go:185 +0x49a main.action.func4(0x0?) /gnbsim/gnbsim.go:129 +0x50 created by main.action in goroutine 1 /gnbsim/gnbsim.go:127 +0x726 goroutine 81 [sync.Mutex.Lock]: sync.runtime_SemacquireMutex(0xc000500800?, 0xc0?, 0x0?) /usr/local/go/src/runtime/sema.go:77 +0x25 sync.(*Mutex).lockSlow(0xc000354430) /usr/local/go/src/sync/mutex.go:171 +0x15d sync.(*Mutex).Lock(...) /usr/local/go/src/sync/mutex.go:90 github.com/sirupsen/logrus.(*MutexWrap).Lock(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/logger.go:61 github.com/sirupsen/logrus.(*Entry).log(0xc0003dec40, 0x4, {0xc000410b20, 0xf}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:233 +0x2d1 github.com/sirupsen/logrus.(*Entry).Log(0xc0003dec40, 0x4, {0xc0004e1d20?, 0x1?, 0x1?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x48 github.com/sirupsen/logrus.(*Entry).Logf(0xc0003dec40, 0x4, {0xd1f322?, 0xc0004b5220?}, {0xc0004e1da0?, 0x0?, 0xc0004e1df0?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:349 +0x7c github.com/sirupsen/logrus.(*Entry).Infof(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:362 github.com/omec-project/gnbsim/gnodeb/transport.(*GnbCpTransport).SendToPeer(0xc000512930, {0xe4ee30?, 0xc00017e2d0}, {0xc0004b5220, 0x49, 0x50}) /gnbsim/gnodeb/transport/cptransport.go:128 +0x237 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleInitialUEMessage(0xc00054c080, {0xe4ee08?, 0xc0003e2770?}) /gnbsim/gnodeb/worker/gnbcpueworker/handler.go:63 +0x2b5 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleEvents(0xc00054c080) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:25 +0x225 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.Init(...) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:13 github.com/omec-project/gnbsim/gnodeb.RequestConnection.func1() /gnbsim/gnodeb/gnodeb.go:135 +0x4e created by github.com/omec-project/gnbsim/gnodeb.RequestConnection in goroutine 1 /gnbsim/gnodeb/gnodeb.go:133 +0x167 goroutine 82 [chan receive]: github.com/omec-project/gnbsim/realue.HandleEvents(0xc00053ab40) /gnbsim/realue/realue.go:20 +0x65 github.com/omec-project/gnbsim/realue.Init(0xc00053ab40) /gnbsim/realue/realue.go:16 +0x22a github.com/omec-project/gnbsim/simue.Init.func1() /gnbsim/simue/simue.go:38 +0x53 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:36 +0x148 goroutine 83 [chan receive]: github.com/omec-project/gnbsim/simue.HandleEvents(0xc0003e2a80) /gnbsim/simue/simue.go:67 +0x67 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:41 +0x18a goroutine 84 [semacquire]: sync.runtime_Semacquire(0xc00053c000?) /usr/local/go/src/runtime/sema.go:62 +0x25 sync.(*WaitGroup).Wait(0xc0003caee0?) /usr/local/go/src/sync/waitgroup.go:116 +0x48 github.com/omec-project/gnbsim/profile.ExecuteProfile(0xc0003fb180, 0xc00023e000) /gnbsim/profile/profile.go:185 +0x49a main.action.func4(0x0?) /gnbsim/gnbsim.go:129 +0x50 created by main.action in goroutine 1 /gnbsim/gnbsim.go:127 +0x726 goroutine 39 [chan receive]: github.com/omec-project/gnbsim/profile.ExecuteProfile.func2() /gnbsim/profile/profile.go:120 +0x89 created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 84 /gnbsim/profile/profile.go:116 +0x230 goroutine 40 [select]: github.com/omec-project/gnbsim/simue.ImsiStateMachine(0xc0003fb180, 0xc00054a230, {0xc00011c300, 0x14}, 0xbd9280?) /gnbsim/simue/simue.go:196 +0x248 github.com/omec-project/gnbsim/profile.ExecuteProfile.func3(0xc0004667b8?) /gnbsim/profile/profile.go:166 +0x7a created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 84 /gnbsim/profile/profile.go:164 +0x3c5 goroutine 97 [chan receive]: github.com/omec-project/gnbsim/profile.ExecuteProfile.func2() /gnbsim/profile/profile.go:120 +0x89 created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 32 /gnbsim/profile/profile.go:116 +0x230 goroutine 98 [select]: github.com/omec-project/gnbsim/simue.ImsiStateMachine(0xc0003fb040, 0xc00054a0f0, {0xc0005b4078, 0x14}, 0x0?) /gnbsim/simue/simue.go:196 +0x248 github.com/omec-project/gnbsim/profile.ExecuteProfile.func3(0x0?) /gnbsim/profile/profile.go:166 +0x7a created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 32 /gnbsim/profile/profile.go:164 +0x3c5 goroutine 85 [runnable]: github.com/sirupsen/logrus.(*Entry).write(0xc000404d90) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:297 +0x177 github.com/sirupsen/logrus.(*Entry).log(0xc0003dec40, 0x4, {0xc000735c80, 0xf}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:252 +0x436 github.com/sirupsen/logrus.(*Entry).Log(0xc0003dec40, 0x4, {0xc0006c5d20?, 0x1?, 0x1?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x48 github.com/sirupsen/logrus.(*Entry).Logf(0xc0003dec40, 0x4, {0xd1f322?, 0xc000183450?}, {0xc0006c5da0?, 0x0?, 0xc0006c5df0?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:349 +0x7c github.com/sirupsen/logrus.(*Entry).Infof(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:362 github.com/omec-project/gnbsim/gnodeb/transport.(*GnbCpTransport).SendToPeer(0xc000512930, {0xe4ee30?, 0xc00017e2d0}, {0xc000183450, 0x49, 0x50}) /gnbsim/gnodeb/transport/cptransport.go:128 +0x237 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleInitialUEMessage(0xc000836000, {0xe4ee08?, 0xc000404c40?}) /gnbsim/gnodeb/worker/gnbcpueworker/handler.go:63 +0x2b5 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleEvents(0xc000836000) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:25 +0x225 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.Init(...) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:13 github.com/omec-project/gnbsim/gnodeb.RequestConnection.func1() /gnbsim/gnodeb/gnodeb.go:135 +0x4e created by github.com/omec-project/gnbsim/gnodeb.RequestConnection in goroutine 1 /gnbsim/gnodeb/gnodeb.go:133 +0x167 goroutine 86 [chan receive]: github.com/omec-project/gnbsim/realue.HandleEvents(0xc000822120) /gnbsim/realue/realue.go:20 +0x65 github.com/omec-project/gnbsim/realue.Init(0xc000822120) /gnbsim/realue/realue.go:16 +0x22a github.com/omec-project/gnbsim/simue.Init.func1() /gnbsim/simue/simue.go:38 +0x53 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:36 +0x148 goroutine 87 [chan receive]: github.com/omec-project/gnbsim/simue.HandleEvents(0xc0004080e0) /gnbsim/simue/simue.go:67 +0x67 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:41 +0x18a goroutine 88 [semacquire]: sync.runtime_Semacquire(0xc0005b20f0?) /usr/local/go/src/runtime/sema.go:62 +0x25 sync.(*WaitGroup).Wait(0xc0003cafc0?) /usr/local/go/src/sync/waitgroup.go:116 +0x48 github.com/omec-project/gnbsim/profile.ExecuteProfile(0xc0003fb2c0, 0xc00023e000) /gnbsim/profile/profile.go:185 +0x49a main.action.func4(0x0?) /gnbsim/gnbsim.go:129 +0x50 created by main.action in goroutine 1 /gnbsim/gnbsim.go:127 +0x726 goroutine 89 [chan receive]: github.com/omec-project/gnbsim/profile.ExecuteProfile.func2() /gnbsim/profile/profile.go:120 +0x89 created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 88 /gnbsim/profile/profile.go:116 +0x230 goroutine 90 [select]: github.com/omec-project/gnbsim/simue.ImsiStateMachine(0xc0003fb2c0, 0xc00054a280, {0xc000884180, 0x14}, 0x0?) /gnbsim/simue/simue.go:196 +0x248 github.com/omec-project/gnbsim/profile.ExecuteProfile.func3(0x0?) /gnbsim/profile/profile.go:166 +0x7a created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 88 /gnbsim/profile/profile.go:164 +0x3c5 goroutine 130 [chan receive]: github.com/omec-project/gnbsim/profile.ExecuteProfile.func2() /gnbsim/profile/profile.go:120 +0x89 created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 41 /gnbsim/profile/profile.go:116 +0x230 goroutine 91 [runnable]: runtime.CallersFrames(...) /usr/local/go/src/runtime/symtab.go:77 runtime.Caller(0xc000590e40?) /usr/local/go/src/runtime/extern.go:284 +0x69 github.com/omec-project/aper.perTrace(0xd3a4ed?, {0xc00032c330, 0x29}) /go/pkg/mod/github.com/omec-project/aper@v1.1.0/aper.go:23 +0x34 github.com/omec-project/aper.(*perRawBitData).makeField(0x1?, {0xcf8b00?, 0xc000742010?, 0x4ef629?}, {0x0, 0x0, 0x0, 0x0, 0x0, 0x0, ...}) /go/pkg/mod/github.com/omec-project/aper@v1.1.0/marshal.go:734 +0x1119 github.com/omec-project/aper.(*perRawBitData).makeField(0x13ef380?, {0xc65060?, 0xc000742000?, 0xc000478170?}, {0x0, 0x0, 0x0, 0x0, 0x0, 0x0, ...}) /go/pkg/mod/github.com/omec-project/aper@v1.1.0/marshal.go:779 +0x1749 github.com/omec-project/aper.(*perRawBitData).makeField(0x0?, {0xb91380?, 0xc00074c028?, 0x1?}, {0x0, 0x0, 0x0, 0x0, 0x0, 0x0, ...}) /go/pkg/mod/github.com/omec-project/aper@v1.1.0/marshal.go:647 +0x969 github.com/omec-project/aper.(*perRawBitData).makeField(0xd2c9d4?, {0xc90400?, 0xc00074c020?, 0xc000591d38?}, {0x0, 0x0, 0x1, 0x0, 0x0, 0xc0004780d0, ...}) /go/pkg/mod/github.com/omec-project/aper@v1.1.0/marshal.go:742 +0x12cc github.com/omec-project/aper.MarshalWithParams({0xc90400?, 0xc00074c020?}, {0xd2c9d4?, 0x40?}) /go/pkg/mod/github.com/omec-project/aper@v1.1.0/marshal.go:806 +0x152 github.com/omec-project/ngap.Encoder(...) /go/pkg/mod/github.com/omec-project/ngap@v1.1.0/ngap.go:29 github.com/omec-project/gnbsim/gnodeb/ngap.GetInitialUEMessage(0xc00072c080, {0xc000794140?, 0xc0001d0480?, 0xc0001d0480?}) /gnbsim/gnodeb/ngap/build.go:83 +0xe5 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleInitialUEMessage(0xc00072c080, {0xe4ee08?, 0xc00040e1c0?}) /gnbsim/gnodeb/worker/gnbcpueworker/handler.go:58 +0x20c github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleEvents(0xc00072c080) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:25 +0x225 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.Init(...) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:13 github.com/omec-project/gnbsim/gnodeb.RequestConnection.func1() /gnbsim/gnodeb/gnodeb.go:135 +0x4e created by github.com/omec-project/gnbsim/gnodeb.RequestConnection in goroutine 1 /gnbsim/gnodeb/gnodeb.go:133 +0x167 goroutine 51 [chan receive]: github.com/omec-project/gnbsim/realue.HandleEvents(0xc0001d0000) /gnbsim/realue/realue.go:20 +0x65 github.com/omec-project/gnbsim/realue.Init(0xc0001d0000) /gnbsim/realue/realue.go:16 +0x22a github.com/omec-project/gnbsim/simue.Init.func1() /gnbsim/simue/simue.go:38 +0x53 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:36 +0x148 goroutine 52 [chan receive]: github.com/omec-project/gnbsim/simue.HandleEvents(0xc0003fe2a0) /gnbsim/simue/simue.go:67 +0x67 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:41 +0x18a goroutine 41 [semacquire]: sync.runtime_Semacquire(0xc000882090?) /usr/local/go/src/runtime/sema.go:62 +0x25 sync.(*WaitGroup).Wait(0xc0003cb0a0?) /usr/local/go/src/sync/waitgroup.go:116 +0x48 github.com/omec-project/gnbsim/profile.ExecuteProfile(0xc0003fb400, 0xc00023e000) /gnbsim/profile/profile.go:185 +0x49a main.action.func4(0xc000466fb8?) /gnbsim/gnbsim.go:129 +0x50 created by main.action in goroutine 1 /gnbsim/gnbsim.go:127 +0x726 goroutine 42 [sync.Mutex.Lock]: sync.runtime_SemacquireMutex(0xc000498800?, 0xc0?, 0x0?) /usr/local/go/src/runtime/sema.go:77 +0x25 sync.(*Mutex).lockSlow(0xc000354430) /usr/local/go/src/sync/mutex.go:171 +0x15d sync.(*Mutex).Lock(...) /usr/local/go/src/sync/mutex.go:90 github.com/sirupsen/logrus.(*MutexWrap).Lock(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/logger.go:61 github.com/sirupsen/logrus.(*Entry).log(0xc0003e3730, 0x4, {0xc0005a87e0, 0x2a}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:233 +0x2d1 github.com/sirupsen/logrus.(*Entry).Log(0xc0003e3730, 0x4, {0xc000327ec0?, 0x40dffb?, 0x4?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x48 github.com/sirupsen/logrus.(*Entry).Logln(0xc0003e3730, 0x4, {0xc000327f48?, 0x0?, 0x0?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:394 +0x7f github.com/sirupsen/logrus.(*Entry).Infoln(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:407 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleEvents(0xc00054c200) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:19 +0xdb github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.Init(...) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:13 github.com/omec-project/gnbsim/gnodeb.RequestConnection.func1() /gnbsim/gnodeb/gnodeb.go:135 +0x4e created by github.com/omec-project/gnbsim/gnodeb.RequestConnection in goroutine 1 /gnbsim/gnodeb/gnodeb.go:133 +0x167 goroutine 43 [chan receive]: github.com/omec-project/gnbsim/realue.HandleEvents(0xc00053b560) /gnbsim/realue/realue.go:20 +0x65 github.com/omec-project/gnbsim/realue.Init(0xc00053b560) /gnbsim/realue/realue.go:16 +0x22a github.com/omec-project/gnbsim/simue.Init.func1() /gnbsim/simue/simue.go:38 +0x53 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:36 +0x148 goroutine 44 [chan receive]: github.com/omec-project/gnbsim/simue.HandleEvents(0xc0003e33b0) /gnbsim/simue/simue.go:67 +0x67 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:41 +0x18a goroutine 131 [select]: github.com/omec-project/gnbsim/simue.ImsiStateMachine(0xc0003fb400, 0xc0000c20a0, {0xc000730198, 0x14}, 0xc?) /gnbsim/simue/simue.go:196 +0x248 github.com/omec-project/gnbsim/profile.ExecuteProfile.func3(0xc000466fb8?) /gnbsim/profile/profile.go:166 +0x7a created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 41 /gnbsim/profile/profile.go:164 +0x3c5 goroutine 45 [semacquire]: sync.runtime_Semacquire(0xc00044a0a8?) /usr/local/go/src/runtime/sema.go:62 +0x25 sync.(*WaitGroup).Wait(0xc0003cb110?) /usr/local/go/src/sync/waitgroup.go:116 +0x48 github.com/omec-project/gnbsim/profile.ExecuteProfile(0xc0003fb540, 0xc00023e000) /gnbsim/profile/profile.go:185 +0x49a main.action.func4(0xc0004647b8?) /gnbsim/gnbsim.go:129 +0x50 created by main.action in goroutine 1 /gnbsim/gnbsim.go:127 +0x726 goroutine 46 [chan receive]: github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleEvents(0xc00054c280) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:17 +0x45 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.Init(...) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:13 github.com/omec-project/gnbsim/gnodeb.RequestConnection.func1() /gnbsim/gnodeb/gnodeb.go:135 +0x4e created by github.com/omec-project/gnbsim/gnodeb.RequestConnection in goroutine 1 /gnbsim/gnodeb/gnodeb.go:133 +0x167 goroutine 99 [chan receive]: github.com/omec-project/gnbsim/profile.ExecuteProfile.func2() /gnbsim/profile/profile.go:120 +0x89 created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 45 /gnbsim/profile/profile.go:116 +0x230 goroutine 100 [select]: github.com/omec-project/gnbsim/simue.ImsiStateMachine(0xc0003fb540, 0xc0000c21e0, {0xc0005b4168, 0x14}, 0xbd9280?) /gnbsim/simue/simue.go:196 +0x248 github.com/omec-project/gnbsim/profile.ExecuteProfile.func3(0xc00030ffb8?) /gnbsim/profile/profile.go:166 +0x7a created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 45 /gnbsim/profile/profile.go:164 +0x3c5 goroutine 132 [chan receive]: github.com/omec-project/gnbsim/realue.HandleEvents(0xc000544000) /gnbsim/realue/realue.go:20 +0x65 github.com/omec-project/gnbsim/realue.Init(0xc000544000) /gnbsim/realue/realue.go:16 +0x22a github.com/omec-project/gnbsim/simue.Init.func1() /gnbsim/simue/simue.go:38 +0x53 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:36 +0x148 goroutine 133 [runnable]: bytes.(*Buffer).WriteByte(0xc0005acab0?, 0x3d?) /usr/local/go/src/bytes/buffer.go:285 +0x9c github.com/sirupsen/logrus.(*TextFormatter).appendKeyValue(0xc0005b43c0?, 0xc0005acab0, {0xd0b57e?, 0xd29255?}, {0xbb21a0, 0xc0005aa4e0}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/text_formatter.go:324 +0x7b github.com/sirupsen/logrus.(*TextFormatter).Format(0xc0000b06c0, 0xc0003e1b90) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/text_formatter.go:224 +0xf92 github.com/omec-project/logger_util.(*FileHook).Fire(0xc0007a82c0, 0xc000713a28?) /go/pkg/mod/github.com/omec-project/logger_util@v1.1.0/logger_util.go:146 +0x2e github.com/sirupsen/logrus.LevelHooks.Fire(0xc000713a58?, 0x713a28?, 0x0?) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/hooks.go:28 +0x70 github.com/sirupsen/logrus.(*Entry).fireHooks(0xc0003e1b90) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:280 +0x1fa github.com/sirupsen/logrus.(*Entry).log(0xc0003e3f10, 0x4, {0xc000718510, 0x21}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:242 +0x399 github.com/sirupsen/logrus.(*Entry).Log(0xc0003e3f10, 0x4, {0xc000713d08?, 0xc0007a2690?, 0xc000115230?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x48 github.com/sirupsen/logrus.(*Entry).Logln(0xc0003e3f10, 0x4, {0xc000713de8?, 0xc000544240?, 0x0?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:394 +0x7f github.com/sirupsen/logrus.(*Entry).Infoln(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:407 github.com/omec-project/gnbsim/simue.HandleProcedure(0xc0003e3e30) /gnbsim/simue/handler.go:433 +0x85 github.com/omec-project/gnbsim/simue.HandleProcedureEvent(0xc0003e3e30, {0xe4f8d0?, 0xc000550de0?}) /gnbsim/simue/handler.go:21 +0xa5 github.com/omec-project/gnbsim/simue.HandleEvents(0xc0003e3e30) /gnbsim/simue/simue.go:73 +0x765 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:41 +0x18a goroutine 102 [chan receive]: github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleEvents(0xc000186280) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:17 +0x45 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.Init(...) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:13 github.com/omec-project/gnbsim/gnodeb.RequestConnection.func1() /gnbsim/gnodeb/gnodeb.go:135 +0x4e created by github.com/omec-project/gnbsim/gnodeb.RequestConnection in goroutine 1 /gnbsim/gnodeb/gnodeb.go:133 +0x167 goroutine 134 [semacquire]: sync.runtime_Semacquire(0xc000882168?) /usr/local/go/src/runtime/sema.go:62 +0x25 sync.(*WaitGroup).Wait(0xc0003cb180?) /usr/local/go/src/sync/waitgroup.go:116 +0x48 github.com/omec-project/gnbsim/profile.ExecuteProfile(0xc0003fb680, 0xc00023e000) /gnbsim/profile/profile.go:185 +0x49a main.action.func4(0x0?) /gnbsim/gnbsim.go:129 +0x50 created by main.action in goroutine 1 /gnbsim/gnbsim.go:127 +0x726 goroutine 135 [chan receive]: github.com/omec-project/gnbsim/profile.ExecuteProfile.func2() /gnbsim/profile/profile.go:120 +0x89 created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 134 /gnbsim/profile/profile.go:116 +0x230 goroutine 136 [select]: github.com/omec-project/gnbsim/simue.ImsiStateMachine(0xc0003fb680, 0xc000834140, {0xc000730420, 0x14}, 0x130c098?) /gnbsim/simue/simue.go:196 +0x248 github.com/omec-project/gnbsim/profile.ExecuteProfile.func3(0x0?) /gnbsim/profile/profile.go:166 +0x7a created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 134 /gnbsim/profile/profile.go:164 +0x3c5 goroutine 48 [chan receive]: github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.HandleEvents(0xc00054c380) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:17 +0x45 github.com/omec-project/gnbsim/gnodeb/worker/gnbcpueworker.Init(...) /gnbsim/gnodeb/worker/gnbcpueworker/worker.go:13 github.com/omec-project/gnbsim/gnodeb.RequestConnection.func1() /gnbsim/gnodeb/gnodeb.go:135 +0x4e created by github.com/omec-project/gnbsim/gnodeb.RequestConnection in goroutine 1 /gnbsim/gnodeb/gnodeb.go:133 +0x167 goroutine 137 [sync.Mutex.Lock]: sync.runtime_SemacquireMutex(0xc000499800?, 0x0?, 0x0?) /usr/local/go/src/runtime/sema.go:77 +0x25 sync.(*Mutex).lockSlow(0xc000354430) /usr/local/go/src/sync/mutex.go:171 +0x15d sync.(*Mutex).Lock(...) /usr/local/go/src/sync/mutex.go:90 github.com/sirupsen/logrus.(*MutexWrap).Lock(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/logger.go:61 github.com/sirupsen/logrus.(*Entry).log(0xc0003e1490, 0x4, {0xc0000ddb30, 0x24}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:233 +0x2d1 github.com/sirupsen/logrus.(*Entry).Log(0xc0003e1490, 0x4, {0xc00031bd78?, 0x40dffb?, 0x4?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x48 github.com/sirupsen/logrus.(*Entry).Logln(0xc0003e1490, 0x4, {0xc000308e48?, 0x0?, 0x0?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:394 +0x7f github.com/sirupsen/logrus.(*Entry).Infoln(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:407 github.com/omec-project/gnbsim/realue.HandleEvents(0xc0005aeea0) /gnbsim/realue/realue.go:22 +0x11b github.com/omec-project/gnbsim/realue.Init(0xc0005aeea0) /gnbsim/realue/realue.go:16 +0x22a github.com/omec-project/gnbsim/simue.Init.func1() /gnbsim/simue/simue.go:38 +0x53 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:36 +0x148 goroutine 138 [chan receive]: github.com/omec-project/gnbsim/simue.HandleEvents(0xc0003e1340) /gnbsim/simue/simue.go:67 +0x67 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:41 +0x18a goroutine 139 [sync.Mutex.Lock]: sync.runtime_SemacquireMutex(0xc0003f52c0?, 0x0?, 0xc0007cfc98?) /usr/local/go/src/runtime/sema.go:77 +0x25 sync.(*Mutex).lockSlow(0xc000354430) /usr/local/go/src/sync/mutex.go:171 +0x15d sync.(*Mutex).Lock(...) /usr/local/go/src/sync/mutex.go:90 github.com/sirupsen/logrus.(*MutexWrap).Lock(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/logger.go:61 github.com/sirupsen/logrus.(*Entry).write(0xc00040e380) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:287 +0x52 github.com/sirupsen/logrus.(*Entry).log(0xc0003cb260, 0x4, {0xc0007f0000, 0x50}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:252 +0x436 github.com/sirupsen/logrus.(*Entry).Log(0xc0003cb260, 0x4, {0xc0007cfe78?, 0x445fc0?, 0xc0000100d8?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x48 github.com/sirupsen/logrus.(*Entry).Logln(0xc0003cb260, 0x4, {0xc0007cff28?, 0x14?, 0xc000309ed0?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:394 +0x7f github.com/sirupsen/logrus.(*Entry).Infoln(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:407 github.com/omec-project/gnbsim/profile.ExecuteProfile(0xc0003fb7c0, 0xc00023e000) /gnbsim/profile/profile.go:184 +0x490 main.action.func4(0x0?) /gnbsim/gnbsim.go:129 +0x50 created by main.action in goroutine 1 /gnbsim/gnbsim.go:127 +0x726 goroutine 161 [chan receive]: github.com/omec-project/gnbsim/profile.ExecuteProfile.func2() /gnbsim/profile/profile.go:120 +0x89 created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 139 /gnbsim/profile/profile.go:116 +0x230 goroutine 162 [sync.Mutex.Lock]: sync.runtime_SemacquireMutex(0x1?, 0x0?, 0x1?) /usr/local/go/src/runtime/sema.go:77 +0x25 sync.(*Mutex).lockSlow(0xc000354430) /usr/local/go/src/sync/mutex.go:171 +0x15d sync.(*Mutex).Lock(...) /usr/local/go/src/sync/mutex.go:90 github.com/sirupsen/logrus.(*MutexWrap).Lock(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/logger.go:61 github.com/sirupsen/logrus.(*Entry).write(0xc00040e4d0) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:287 +0x52 github.com/sirupsen/logrus.(*Entry).log(0xc00040ce00, 0x4, {0xc000794340, 0x32}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:252 +0x436 github.com/sirupsen/logrus.(*Entry).Log(0xc00040ce00, 0x4, {0xc0007d5d38?, 0x445fc0?, 0xc000010168?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x48 github.com/sirupsen/logrus.(*Entry).Logln(0xc00040ce00, 0x4, {0xc0007d5e18?, 0x14?, 0x0?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:394 +0x7f github.com/sirupsen/logrus.(*Entry).Infoln(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:407 github.com/omec-project/gnbsim/simue.ImsiStateMachine(0xc0003fb7c0, 0xc000834190, {0xc000790150, 0x14}, 0x0?) /gnbsim/simue/simue.go:195 +0x1db github.com/omec-project/gnbsim/profile.ExecuteProfile.func3(0x0?) /gnbsim/profile/profile.go:166 +0x7a created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 139 /gnbsim/profile/profile.go:164 +0x3c5 goroutine 177 [chan receive]: github.com/omec-project/gnbsim/realue.HandleEvents(0xc000544ea0) /gnbsim/realue/realue.go:20 +0x65 github.com/omec-project/gnbsim/realue.Init(0xc000544ea0) /gnbsim/realue/realue.go:16 +0x22a github.com/omec-project/gnbsim/simue.Init.func1() /gnbsim/simue/simue.go:38 +0x53 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:36 +0x148 goroutine 178 [chan receive]: github.com/omec-project/gnbsim/simue.HandleEvents(0xc0007a2930) /gnbsim/simue/simue.go:67 +0x67 created by github.com/omec-project/gnbsim/simue.Init in goroutine 1 /gnbsim/simue/simue.go:41 +0x18a goroutine 179 [sync.Mutex.Lock]: sync.runtime_SemacquireMutex(0xc000498800?, 0x30?, 0x0?) /usr/local/go/src/runtime/sema.go:77 +0x25 sync.(*Mutex).lockSlow(0xc000354430) /usr/local/go/src/sync/mutex.go:171 +0x15d sync.(*Mutex).Lock(...) /usr/local/go/src/sync/mutex.go:90 github.com/sirupsen/logrus.(*MutexWrap).Lock(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/logger.go:61 github.com/sirupsen/logrus.(*Entry).log(0xc0003cb2d0, 0x4, {0xc00081e3c0, 0x50}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:233 +0x2d1 github.com/sirupsen/logrus.(*Entry).Log(0xc0003cb2d0, 0x4, {0xc00063de78?, 0x445fc0?, 0xc00053c348?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x48 github.com/sirupsen/logrus.(*Entry).Logln(0xc0003cb2d0, 0x4, {0xc00063df28?, 0x14?, 0x0?}) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:394 +0x7f github.com/sirupsen/logrus.(*Entry).Infoln(...) /go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:407 github.com/omec-project/gnbsim/profile.ExecuteProfile(0xc0003fb900, 0xc00023e000) /gnbsim/profile/profile.go:184 +0x490 main.action.func4(0x0?) /gnbsim/gnbsim.go:129 +0x50 created by main.action in goroutine 1 /gnbsim/gnbsim.go:127 +0x726 goroutine 180 [runnable]: github.com/omec-project/gnbsim/profile.ExecuteProfile.func2() /gnbsim/profile/profile.go:116 created by github.com/omec-project/gnbsim/profile.ExecuteProfile in goroutine 179 /gnbsim/profile/profile.go:116 +0x230 ```
thakurajayL commented 8 months ago

Thanks for reporting issue. Good to see you are exploring GNBSIM to try out 40 Profiles. I hope you find the profile support useful. I will check this.

onf-bot commented 6 months ago

This issue has been stale for 30 days and will be closed in 5 days. Comment to keep it open.

yoursunny commented 6 months ago

https://fvsch.com/stale-bots

gab-arrobo commented 6 months ago

https://fvsch.com/stale-bots

Thanks for your input, @yoursunny. I am going to bring this topic to the next TST meeting to make a decision about it.

thakurajayL commented 5 months ago

Need this..adding comment to avoid issue getting closed.

gab-arrobo commented 5 months ago

Need this..adding comment to avoid issue getting closed.

Remember that we increase the number of days before an issue/PR is considered as "stale" from 30 to 120 (https://github.com/omec-project/gnbsim/blob/main/.github/workflows/stale.yml#L10)

github-actions[bot] commented 1 month ago

This issue has been stale for 120 days and will be closed in 15 days. Comment to keep it open.

thakurajayL commented 1 month ago

Need to fix it.