Open5GS and Free5GC are set up successfully, but the N3IWF UE crashes when the UE tries to connect. #1
Description
OPEN5GS LOGS::----
coral@coral-HP-ProBook-6470b:~/5G-Core-Network/open5gs/install/bin$ ./open5gs-amfd
Open5GS daemon v2.4.11
08/18 16:29:32.384: [app] INFO: Configuration: '/home/coral/5G-Core-Network/open5gs/install/etc/open5gs/amf.yaml' (../lib/app/ogs-init.c:126)
08/18 16:29:32.384: [app] INFO: File Logging: '/home/coral/5G-Core-Network/open5gs/install/var/log/open5gs/amf.log' (../lib/app/ogs-init.c:129)
08/18 16:29:32.389: [sbi] INFO: NF Service [namf-comm] (../lib/sbi/context.c:1400)
08/18 16:29:32.390: [sbi] INFO: nghttp2_server() [127.0.0.5]:7777 (../lib/sbi/nghttp2-server.c:150)
08/18 16:29:32.390: [amf] INFO: ngap_server() [192.168.8.57]:38412 (../src/amf/ngap-sctp.c:61)
08/18 16:29:32.390: [sctp] INFO: AMF initialize...done (../src/amf/app.c:33)
RUN ALL THING
Running command ./bin/n3iwf -c ./config/n3iwfcfg.yaml
( 204019, ./bin/n3iwf -c ./config/n3iwfcfg.yaml, n3iwf, /home/coral/5G-Core-Network/script/.logs/n3iwf.log ) - Process started
PID NAME STATUS LOG FILE
203730 nrf Exited nrf.log
203738 update_bg_processes Running update_bg_processes.log
203755 amf Running amf.log
203776 ausf Running ausf.log
203803 udm Running udm.log
203826 udr Running udr.log
203842 pcf Running pcf.log
203857 smf Running smf.log
203872 nssf Running nssf.log
203887 bsf Running bsf.log
203902 upf Running upf.log
203917 mme Running mme.log
203932 scp Running scp.log
203947 sgwc Running sgwc.log
203962 sgwu Running sgwu.log
203977 hss Running hss.log
203992 pcrf Running pcrf.log
204019 n3iwf Running n3iwf.log
N3IWF LOGS ARE---
[sudo] password for coral:
2025-08-18T17:16:47.368431430+05:30 [INFO][N3IWF][Main] N3IWF version:
Not specify ldflags (which link version) during go build
go version: go1.21.13 linux/amd64
2025-08-18T17:16:47.368980169+05:30 [INFO][N3IWF][CFG] Read config from [config/n3iwfcfg.yaml]
2025-08-18T17:16:47.370351111+05:30 [INFO][N3IWF][Main] Log enable is set to [true]
2025-08-18T17:16:47.370367150+05:30 [INFO][N3IWF][Main] Log level is set to [info]
2025-08-18T17:16:47.370378321+05:30 [INFO][N3IWF][Main] Report Caller is set to [false]
2025-08-18T17:16:47.370386388+05:30 [INFO][N3IWF][Init] Server started
2025-08-18T17:16:47.370849970+05:30 [WARN][N3IWF][CTX] Parse PKCS8 private key failed: x509: failed to parse private key (use ParsePKCS1PrivateKey instead for this key format)
2025-08-18T17:16:47.370863174+05:30 [INFO][N3IWF][CTX] Parse using PKCS1...
2025-08-18T17:16:47.373526918+05:30 [WARN][N3IWF][Init] netlink.RouteAdd: file exists
2025-08-18T17:16:47.373565541+05:30 [INFO][N3IWF][Init] Setup XFRM interface xfrmi-default
2025-08-18T17:16:47.379235386+05:30 [INFO][N3IWF][NGAP] [N3IWF] Send NG Setup Request
2025-08-18T17:16:47.383388136+05:30 [INFO][N3IWF][Init] NGAP service running.
2025-08-18T17:16:47.383606494+05:30 [INFO][N3IWF][Init] NAS TCP server successfully started.
2025-08-18T17:16:47.387509349+05:30 [INFO][N3IWF][Init] Listening NWu user plane traffic
2025-08-18T17:16:47.387787807+05:30 [INFO][N3IWF][Init] IKE service running.
2025-08-18T17:16:47.387806905+05:30 [INFO][N3IWF][Init] N3IWF running...
2025-08-18T17:16:47.390315872+05:30 [INFO][N3IWF][NGAP] [N3IWF] Handle NG Setup Response
2025-08-18T17:16:56.363719070+05:30 [INFO][N3IWF][IKE] Decoding IKE message
2025-08-18T17:16:56.363806756+05:30 [INFO][N3IWF][IKE] Decoding IKE payloads
2025-08-18T17:16:56.363840401+05:30 [INFO][N3IWF][IKE] [SecurityAssociation] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.363861282+05:30 [INFO][N3IWF][IKE] [KeyExchange] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.363887066+05:30 [INFO][N3IWF][IKE] [Nonce] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.363903211+05:30 [INFO][N3IWF][IKE] [Notification] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.363927162+05:30 [INFO][N3IWF][IKE] [Notification] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.363946641+05:30 [INFO][N3IWF][IKE] Handle IKE_SA_INIT
2025-08-18T17:16:56.381292117+05:30 [INFO][N3IWF][IKE] Encoding IKE message
2025-08-18T17:16:56.381317293+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.381338964+05:30 [INFO][N3IWF][IKE] [SecurityAssociation] marshal(): Start marshalling
2025-08-18T17:16:56.381347866+05:30 [INFO][N3IWF][IKE] [KeyExchange] marshal(): Start marshalling
2025-08-18T17:16:56.381354264+05:30 [INFO][N3IWF][IKE] [Nonce] marshal(): Start marshalling
2025-08-18T17:16:56.381370540+05:30 [INFO][N3IWF][IKE] [Notification] marshal(): Start marshalling
2025-08-18T17:16:56.381381612+05:30 [INFO][N3IWF][IKE] [Notification] marshal(): Start marshalling
2025-08-18T17:16:56.381416019+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.381436799+05:30 [INFO][N3IWF][IKE] [Identification] marshal(): Start marshalling
2025-08-18T17:16:56.381497096+05:30 [INFO][N3IWF][IKE] Encoding IKE message
2025-08-18T17:16:56.381505776+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.381513232+05:30 [INFO][N3IWF][IKE] [SecurityAssociation] marshal(): Start marshalling
2025-08-18T17:16:56.381525529+05:30 [INFO][N3IWF][IKE] [KeyExchange] marshal(): Start marshalling
2025-08-18T17:16:56.381538944+05:30 [INFO][N3IWF][IKE] [Nonce] marshal(): Start marshalling
2025-08-18T17:16:56.381548320+05:30 [INFO][N3IWF][IKE] [Notification] marshal(): Start marshalling
2025-08-18T17:16:56.381578503+05:30 [INFO][N3IWF][IKE] [Notification] marshal(): Start marshalling
2025-08-18T17:16:56.390240437+05:30 [INFO][N3IWF][IKE] Decoding IKE message
2025-08-18T17:16:56.390289179+05:30 [INFO][N3IWF][IKE] Decoding IKE payloads
2025-08-18T17:16:56.390306804+05:30 [INFO][N3IWF][IKE] [Encrypted] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.390324103+05:30 [INFO][N3IWF][IKE] Handle IKE_AUTH
2025-08-18T17:16:56.390355449+05:30 [INFO][N3IWF][IKE] Encoding IKE message
2025-08-18T17:16:56.390368677+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.390387143+05:30 [INFO][N3IWF][IKE] [Encrypted] marshal(): Start marshalling
2025-08-18T17:16:56.390755619+05:30 [INFO][N3IWF][IKE] Decoding IKE payloads
2025-08-18T17:16:56.390912894+05:30 [INFO][N3IWF][IKE] [Identification] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.390947626+05:30 [INFO][N3IWF][IKE] [SecurityAssociation] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.390991387+05:30 [INFO][N3IWF][IKE] [TrafficSelector] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.391017290+05:30 [INFO][N3IWF][IKE] [TrafficSelector] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.391031396+05:30 [INFO][N3IWF][IKE] Ecoding initiator for later IKE authentication
2025-08-18T17:16:56.391041931+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.391052918+05:30 [INFO][N3IWF][IKE] [Identification] marshal(): Start marshalling
2025-08-18T17:16:56.391077747+05:30 [INFO][N3IWF][IKE] Parsing security association
2025-08-18T17:16:56.391090952+05:30 [INFO][N3IWF][IKE] Received traffic selector initiator from UE
2025-08-18T17:16:56.391100622+05:30 [INFO][N3IWF][IKE] Received traffic selector initiator from UE
2025-08-18T17:16:56.395186216+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.395272089+05:30 [INFO][N3IWF][IKE] [Identification] marshal(): Start marshalling
2025-08-18T17:16:56.395295315+05:30 [INFO][N3IWF][IKE] [Certificate] marshal(): Start marshalling
2025-08-18T17:16:56.395349109+05:30 [INFO][N3IWF][IKE] [Authentication] marshal(): Start marshalling
2025-08-18T17:16:56.395379773+05:30 [INFO][N3IWF][IKE] [EAP] marshal(): Start marshalling
2025-08-18T17:16:56.395392736+05:30 [INFO][N3IWF][IKE] [EAP][Expanded] marshal(): Start marshalling
2025-08-18T17:16:56.395463793+05:30 [INFO][N3IWF][IKE] Encoding IKE message
2025-08-18T17:16:56.395476088+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.395487405+05:30 [INFO][N3IWF][IKE] [Encrypted] marshal(): Start marshalling
2025-08-18T17:16:56.395580210+05:30 [INFO][N3IWF][IKE] Encoding IKE message
2025-08-18T17:16:56.395597948+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.395607885+05:30 [INFO][N3IWF][IKE] [Encrypted] marshal(): Start marshalling
2025-08-18T17:16:56.396945839+05:30 [INFO][N3IWF][IKE] Decoding IKE message
2025-08-18T17:16:56.396966163+05:30 [INFO][N3IWF][IKE] Decoding IKE payloads
2025-08-18T17:16:56.396980130+05:30 [INFO][N3IWF][IKE] [Encrypted] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.396992131+05:30 [INFO][N3IWF][IKE] Handle IKE_AUTH
2025-08-18T17:16:56.397008321+05:30 [INFO][N3IWF][IKE] Encoding IKE message
2025-08-18T17:16:56.397018474+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.397029957+05:30 [INFO][N3IWF][IKE] [Encrypted] marshal(): Start marshalling
2025-08-18T17:16:56.397064605+05:30 [INFO][N3IWF][IKE] Decoding IKE payloads
2025-08-18T17:16:56.397075936+05:30 [INFO][N3IWF][IKE] [EAP] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.397084084+05:30 [INFO][N3IWF][IKE] [EAP][Expanded] unmarshal(): Start unmarshalling received bytes
2025-08-18T17:16:56.397094931+05:30 [INFO][N3IWF][IKE] EAP5G MessageID : 2
2025-08-18T17:16:56.397114068+05:30 [INFO][N3IWF][NGAP] NGAP event handle
2025-08-18T17:16:56.397437226+05:30 [INFO][N3IWF][IKE] Handle IKE event
2025-08-18T17:16:56.397449505+05:30 [INFO][N3IWF][IKE] Handle UnmarshalEAP5GDataResponse event
2025-08-18T17:16:56.397480182+05:30 [INFO][N3IWF][NGAP] NGAP event handle
2025-08-18T17:16:56.397493178+05:30 [INFO][N3IWF][NGAP] [N3IWF] Send Initial UE Message
2025-08-18T17:16:56.398938079+05:30 [INFO][N3IWF][NGAP] [N3IWF] Handle Downlink NAS Transport
2025-08-18T17:16:56.399011026+05:30 [INFO][N3IWF][IKE] Handle IKE event
2025-08-18T17:16:56.399032506+05:30 [INFO][N3IWF][IKE] Handle SendEAPNASMsg event
2025-08-18T17:16:56.399052270+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.399063336+05:30 [INFO][N3IWF][IKE] [EAP] marshal(): Start marshalling
2025-08-18T17:16:56.399072577+05:30 [INFO][N3IWF][IKE] [EAP][Expanded] marshal(): Start marshalling
2025-08-18T17:16:56.399092017+05:30 [INFO][N3IWF][IKE] Encoding IKE message
2025-08-18T17:16:56.399101604+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.399110841+05:30 [INFO][N3IWF][IKE] [Encrypted] marshal(): Start marshalling
2025-08-18T17:16:56.399133365+05:30 [INFO][N3IWF][IKE] Encoding IKE message
2025-08-18T17:16:56.399143201+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.399151957+05:30 [INFO][N3IWF][IKE] [Encrypted] marshal(): Start marshalling
2025-08-18T17:16:56.399382172+05:30 [INFO][N3IWF][NGAP] [N3IWF] Handle UE Context Release Command
2025-08-18T17:16:56.399403979+05:30 [WARN][N3IWF][NGAP] Cause Nas[0]
2025-08-18T17:16:56.399423960+05:30 [INFO][N3IWF][IKE] Handle IKE event
2025-08-18T17:16:56.399435439+05:30 [INFO][N3IWF][IKE] Handle IKEDeleteRequest event
2025-08-18T17:16:56.399446064+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.399455509+05:30 [INFO][N3IWF][IKE] [Delete] marshal(): Start marshalling
2025-08-18T17:16:56.399473996+05:30 [INFO][N3IWF][IKE] Encoding IKE message
2025-08-18T17:16:56.399486156+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.399499216+05:30 [INFO][N3IWF][IKE] [Encrypted] marshal(): Start marshalling
2025-08-18T17:16:56.399516962+05:30 [INFO][N3IWF][IKE] Encoding IKE message
2025-08-18T17:16:56.399528466+05:30 [INFO][N3IWF][IKE] Encoding IKE payloads
2025-08-18T17:16:56.399538369+05:30 [INFO][N3IWF][IKE] [Encrypted] marshal(): Start marshalling
and ue logs(n3iwue)::
non-3gpp
[sudo] password for coral:
2025-08-18T17:16:56+05:30 [INFO][N3UE][CFG] config version [1.0.1]
2025-08-18T17:16:56+05:30 [INFO][N3UE][CFG] N3UE Log level is set to [trace] level
2025-08-18T17:16:56+05:30 [INFO][N3UE][APP] N3UE Start
2025-08-18T17:16:56+05:30 [INFO][N3UE][Context] SUPI: imsi-001010000000001
2025-08-18T17:16:56+05:30 [INFO][N3UE][Init] IKE service running.
2025-08-18T17:16:56+05:30 [INFO][N3UE][Init] N3UE running...
2025-08-18T17:16:56+05:30 [TRAC][N3UE][APP] Start Registration
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] start IKE_SA_INIT message
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] Send IKE message to UE
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] Encoding...
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] Sending...
2025-08-18T17:16:56+05:30 [INFO][N3UE][IKE] Handle IKESA INIT
2025-08-18T17:16:56+05:30 [INFO][N3UE][IKE] Get SA payload
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] Received IKE Notify: NAT_DETECTION_SOURCE_IP
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] N3IWF is behind NAT
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] Received IKE Notify: NAT_DETECTION_DESTINATION_IP
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] UE(SPI: 3caa9b6998c24891) is behind NAT
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] ====== IKE Security Association Info =====
Initiator's SPI: 000000000006f708
Responder's SPI: 3caa9b6998c24891
IKESAKey:
Encryption Algorithm: 12
SK_ei: 068ded58cb2e0996c231cff1edaa11b09d1ec0a6a4ff1e4ad43a8647018a1fac
SK_er: 8c048c485ec11dbea658581fd85feaa1b3070ad5cd894e029ab0ec384ace3104
Integrity Algorithm: 2
SK_ai: e460609d0cb48276a361f820c204431afc312eaa
SK_ar: 338f5a1b536927e1bba1059c9b032ac684f3efb4
SK_pi: 4886c8f76a2e737b51398f0e9de1b0bb9e08cc77
SK_pr: a30730ace49883511e1260f3a39da81edef26049
SK_d : 8dc444c990d227588a8b18406467401bb9c329b2
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] IKE_AUTH message
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] Send IKE message to UE
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] Encoding...
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] Sending...
2025-08-18T17:16:56+05:30 [INFO][N3UE][IKE] Handle IKE AUTH
2025-08-18T17:16:56+05:30 [INFO][N3UE][IKE] Get IDr
2025-08-18T17:16:56+05:30 [INFO][N3UE][IKE] Get CERT
2025-08-18T17:16:56+05:30 [INFO][N3UE][IKE] Get AUTH
2025-08-18T17:16:56+05:30 [INFO][N3UE][IKE] Get EAP
2025-08-18T17:16:56+05:30 [DEBU][N3UE][IKE] S-NSSAI: [1 255 255 255]
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] Send IKE message to UE
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] Encoding...
2025-08-18T17:16:56+05:30 [TRAC][N3UE][IKE] Sending...
2025-08-18T17:16:56+05:30 [INFO][N3UE][CFG] Write SQN=16f3b3f7100c into config file
2025-08-18T17:16:56+05:30 [INFO][N3UE][IKE] Handle IKE AUTH
2025-08-18T17:16:56+05:30 [INFO][N3UE][IKE] Get EAP
2025-08-18T17:16:56+05:30 [ERRO][N3UE][NAS] Received unexpected message type: 68
2025-08-18T17:16:56+05:30 [FATA][N3UE][IKE] panic: runtime error: invalid memory address or nil pointer dereference
goroutine 14 [running]:
runtime/debug.Stack()
/usr/local/go/src/runtime/debug/stack.go:24 +0x5e
github.com/free5gc/n3iwue/pkg/ike/handler.Dispatch.func1()
/home/coral/n3iwue/pkg/ike/handler/dispatcher.go:21 +0x38
panic({0x7f51e0?, 0xc2f460?})
/usr/local/go/src/runtime/panic.go:914 +0x21f
github.com/free5gc/n3iwue/pkg/ike/handler.HandleIKEAUTH(0xc000044ed8?, 0xc0005824b0, 0xc0005834d0, 0xc000577740)
/home/coral/n3iwue/pkg/ike/handler/handler.go:311 +0x8d8
github.com/free5gc/n3iwue/pkg/ike/handler.Dispatch(0x785a45?, 0x785125?, 0xc0005824b0?, 0xc0000774a0?)
/home/coral/n3iwue/pkg/ike/handler/dispatcher.go:29 +0x4f
created by github.com/free5gc/n3iwue/pkg/ike/service.listenAndServe in goroutine 10
/home/coral/n3iwue/pkg/ike/service/service.go:144 +0x6ee