+ '[' 7 -lt 1 ']'
+ [[ -z '' ]]
++ ip addr show eth0
++ grep -Po 'inet \K[\d.]+'
+ export GNB_NGAP_ADDR=10.244.0.3
+ GNB_NGAP_ADDR=10.244.0.3
+ [[ -z '' ]]
++ ip addr show eth0
++ grep -Po 'inet \K[\d.]+'
+ export GNB_GTPU_ADDR=10.244.0.3
+ GNB_GTPU_ADDR=10.244.0.3
+ [[ ! -z open5gs-amf-ngap ]]
++ host -4 open5gs-amf-ngap
++ awk '/has.*address/{print $NF; exit}'
+ export AMF_ADDR=10.107.122.161
+ AMF_ADDR=10.107.122.161
+ envsubst
+ ./packetrusher --config config.yml multi-ue -n 1 -d true -t true
time="2024-07-24T15:01:21Z" level=info msg="Selecting 10.107.122.161 for host 10.107.122.161 as AMF's IP address"
time="2024-07-24T15:01:21Z" level=info msg="Selecting 10.244.0.3 for host 10.244.0.3 as gNodeB's N3/Data IP address"
time="2024-07-24T15:01:21Z" level=info msg="Selecting 10.244.0.3 for host 10.244.0.3 as gNodeB's N2/Control IP address"
time="2024-07-24T15:01:21Z" level=info msg="Loaded config at: config.yml"
time="2024-07-24T15:01:21Z" level=info msg="PacketRusher version 1.0.1"
time="2024-07-24T15:01:21Z" level=info msg=---------------------------------------
time="2024-07-24T15:01:21Z" level=info msg="[TESTER] Starting test function: Testing registration of multiple UEs"
time="2024-07-24T15:01:21Z" level=info msg="[TESTER][UE] Number of UEs: 1"
time="2024-07-24T15:01:21Z" level=info msg="[TESTER][GNB] gNodeB control interface IP/Port: 10.244.0.3/9487"
time="2024-07-24T15:01:21Z" level=info msg="[TESTER][GNB] gNodeB data interface IP/Port: 10.244.0.3/2152"
time="2024-07-24T15:01:21Z" level=info msg="[TESTER][AMF] AMF IP/Port: 10.107.122.161/38412"
time="2024-07-24T15:01:21Z" level=info msg=---------------------------------------
time="2024-07-24T15:01:21Z" level=info msg="[GNB] SCTP/NGAP service is running"
time="2024-07-24T15:01:21Z" level=info msg="[GNB] Initiating NG Setup Request"
time="2024-07-24T15:01:21Z" level=info msg="[GNB][SCTP] Receive message in 0 stream\n"
time="2024-07-24T15:01:21Z" level=info msg="[GNB][NGAP] Receive NG Setup Response"
time="2024-07-24T15:01:21Z" level=info msg="[GNB][AMF] AMF Name: open5gs-amf"
time="2024-07-24T15:01:21Z" level=info msg="[GNB][AMF] State of AMF: Active"
time="2024-07-24T15:01:21Z" level=info msg="[GNB][AMF] Capacity of AMF: 255"
time="2024-07-24T15:01:21Z" level=info msg="[GNB][AMF] PLMNs Identities Supported by AMF -- mcc: 999 mnc:70"
time="2024-07-24T15:01:21Z" level=info msg="[GNB][AMF] List of AMF slices Supported by AMF -- sst:01 sd:was not informed"
time="2024-07-24T15:01:22Z" level=info msg="[TESTER] TESTING REGISTRATION USING IMSI 0000000001 UE"
time="2024-07-24T15:01:22Z" level=info msg="[GNB] Received incoming connection from new UE"
time="2024-07-24T15:01:22Z" level=info msg="[UE] Initiating Registration"
time="2024-07-24T15:01:22Z" level=info msg="[UE] Switched from state 0 to state 1"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][SCTP] Receive message in 1 stream\n"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP] Receive Downlink NAS Transport"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Message without security header"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Receive Authentication Request"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS][MAC] Authenticity of the authentication request message: OK"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS][SQN] SQN of the authentication request message: VALID"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Send authentication response"
time="2024-07-24T15:01:22Z" level=info msg="[UE] Switched from state 1 to state 2"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][SCTP] Receive message in 1 stream\n"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP] Receive Downlink NAS Transport"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Message with security header"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Message with integrity and with NEW 5G NAS SECURITY CONTEXT"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] successful NAS MAC verification"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Receive Security Mode Command"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Type of ciphering algorithm is 128-5G-EA2"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Type of integrity protection algorithm is 128-5G-IA2"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][SCTP] Receive message in 1 stream\n"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP] Receive Initial Context Setup Request"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][UE] UE Context was created with successful"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][UE] UE RAN ID 1"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][UE] UE AMF ID 1"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][UE] UE Mobility Restrict --Plmn-- Mcc: not informed Mnc: not informed"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][UE] UE Masked Imeisv: 1110000000ffff00"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][UE] Allowed Nssai-- Sst: [01] Sd: [not informed]"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP][AMF] Send Initial Context Setup Response."
time="2024-07-24T15:01:22Z" level=info msg="[GNB] Initiating Initial Context Setup Response"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP] No PDU Session to set up in InitialContextSetupResponse."
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Message with security header"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Message with integrity and ciphered"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] successful NAS MAC verification"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] successful NAS CIPHERING"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Receive Registration Accept"
time="2024-07-24T15:01:22Z" level=info msg="[UE] Switched from state 2 to state 3"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] UE 5G GUTI: &{119 11 [242 153 249 7 2 0 64 192 0 4 3]}"
time="2024-07-24T15:01:22Z" level=info msg="[UE] Initiating New PDU Session"
time="2024-07-24T15:01:22Z" level=info msg="[UE] Initiating New PDU Session"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][SCTP] Receive message in 1 stream\n"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP] Receive Downlink NAS Transport"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Message with security header"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Message with integrity and ciphered"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] successful NAS MAC verification"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] successful NAS CIPHERING"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Receive Configuration Update Command"
time="2024-07-24T15:01:22Z" level=info msg="[UE] Initiating Configuration Update Complete"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][SCTP] Receive message in 1 stream\n"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP] Receive PDU Session Resource Setup Request"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP][UE] PDU Session was created with successful."
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP][UE] PDU Session Id: 1"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP][UE] NSSAI Selected --- sst: NSSAI was not selected sd: NSSAI was not selected"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP][UE] PDU Session Type: ipv4"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP][UE] QOS Flow Identifier: 1"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP][UE] Uplink Teid: 37121"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP][UE] Downlink Teid: 1"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP][UE] Non-Dynamic-5QI: 9"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP][UE] Priority Level ARP: 8"
time="2024-07-24T15:01:22Z" level=info msg="[GNB][NGAP][UE] UPF Address: 10.244.0.216 :2152"
time="2024-07-24T15:01:22Z" level=info msg="[GNB] Initiating PDU Session Resource Setup Response"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Message with security header"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Message with integrity and ciphered"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] successful NAS MAC verification"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] successful NAS CIPHERING"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Receive DL NAS Transport"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] Receiving PDU Session Establishment Accept"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] PDU session QoS RULES: [1 0 6 49 49 1 1 255 1]"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] PDU session DNN: internet"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] PDU session NSSAI -- sst: 1 sd: 000"
time="2024-07-24T15:01:22Z" level=info msg="[UE][NAS] PDU address received: 10.45.0.3"
time="2024-07-24T15:01:22Z" level=info msg="[UE][GTP] Interface for UE 0000000001 has not been created. Tunnel has been disabled."