See https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/224/display/redirect
Changes:
------------------------------------------ [...truncated 235.10 MiB...] [32m06/25 13:47:39.002[0m: [[33msmf[0m] [1;37mDEBUG[0m: Merged PFCP-Node: addr_list [127.0.0.7]:8805 (../src/smf/pfcp-path.c:198) [32m06/25 13:47:39.002[0m: [[33msmf[0m] [1;37mDEBUG[0m: smf_state_operational(): SMF_EVT_N4_MESSAGE (../src/smf/smf-sm.c:94) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] Cannot find new type 1 from PFCP peer [127.0.0.7]:8805 (../lib/pfcp/xact.c:765) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] REMOTE Create peer [127.0.0.7]:8805 (../lib/pfcp/xact.c:194) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] REMOTE Receive peer [127.0.0.7]:8805 (../lib/pfcp/xact.c:771) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] REMOTE UPD RX-1 peer [127.0.0.7]:8805 (../lib/pfcp/xact.c:327) [32m06/25 13:47:39.002[0m: [[33msmf[0m] [1;37mDEBUG[0m: smf_pfcp_state_associated(): SMF_EVT_N4_MESSAGE (../src/smf/pfcp-sm.c:182) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: Heartbeat Response (../lib/pfcp/build.c:56) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] REMOTE UPD TX-2 peer [127.0.0.7]:8805 (../lib/pfcp/xact.c:229) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] REMOTE Commit peer [127.0.0.7]:8805 (../lib/pfcp/xact.c:498) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] REMOTE Delete peer [127.0.0.7]:8805 (../lib/pfcp/xact.c:829) [32m06/25 13:47:39.002[0m: [[33mupf[0m] [1;37mDEBUG[0m: ogs_pfcp_extract_node_id() type [2] pfcp_status [1] node_id [NULL] from [127.0.0.4]:8805 (../src/upf/pfcp-path.c:101) [32m06/25 13:47:39.002[0m: [[33mupf[0m] [1;37mDEBUG[0m: Found PFCP-Node: addr_list [127.0.0.4]:8805 (../src/upf/pfcp-path.c:155) [32m06/25 13:47:39.002[0m: [[33mupf[0m] [1;37mDEBUG[0m: Merged PFCP-Node: addr_list [127.0.0.4]:8805 (../src/upf/pfcp-path.c:161) [32m06/25 13:47:39.002[0m: [[33mupf[0m] [1;37mDEBUG[0m: upf_state_operational(): UPF_EVT_N4_MESSAGE (../src/upf/upf-sm.c:51) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] LOCAL Find peer [127.0.0.4]:8805 (../lib/pfcp/xact.c:756) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] LOCAL Receive peer [127.0.0.4]:8805 (../lib/pfcp/xact.c:771) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] LOCAL UPD RX-2 peer [127.0.0.4]:8805 (../lib/pfcp/xact.c:327) [32m06/25 13:47:39.002[0m: [[33mupf[0m] [1;37mDEBUG[0m: upf_pfcp_state_associated(): UPF_EVT_N4_MESSAGE (../src/upf/pfcp-sm.c:161) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] LOCAL Commit peer [127.0.0.4]:8805 (../lib/pfcp/xact.c:498) [32m06/25 13:47:39.002[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [23] LOCAL Delete peer [127.0.0.4]:8805 (../lib/pfcp/xact.c:829) MTC@e79a03f129c2: setverdict(fail): pass -> fail reason: ""C5G_Tests.ttcn:253 : Tguard timeout"", new component reason: ""C5G_Tests.ttcn:253 : Tguard timeout"" MTC@e79a03f129c2: Stopping testcase execution from "C5G_Tests.ttcn":253 TC_handover_inter_ngran_xn1(873)@e79a03f129c2: Final verdict of PTC: none TC_handover_inter_ngran_xn-NGAP1(871)@e79a03f129c2: Final verdict of PTC: none [38;5;23m20260625134742102 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m r=127.0.0.1:9999<->l=127.0.0.20:4268 NOTIFICATION SHUTDOWN_EVENT flags=0x0 (stream.c:348)[0;m 20260625134742102 [1;33mDUECUPS[0;m [1;33mNOTICE[0;m r=127.0.0.1:9999<->l=127.0.0.20:4268: UECUPS connection lost (cups_client.c:599) GTP1U_EM(869)@e79a03f129c2: Final verdict of PTC: none TC_handover_inter_ngran_xn-NGAP0(870)@e79a03f129c2: Final verdict of PTC: none MTC@e79a03f129c2: Setting final verdict of the test case. MTC@e79a03f129c2: Local verdict of MTC: fail reason: ""C5G_Tests.ttcn:253 : Tguard timeout"" MTC@e79a03f129c2: Local verdict of PTC GTP1U_EM(869): none (fail -> fail) MTC@e79a03f129c2: Local verdict of PTC TC_handover_inter_ngran_xn-NGAP0(870): none (fail -> fail) MTC@e79a03f129c2: Local verdict of PTC TC_handover_inter_ngran_xn-NGAP1(871): none (fail -> fail) MTC@e79a03f129c2: Local verdict of PTC TC_handover_inter_ngran_xn0(872): pass (fail -> fail) MTC@e79a03f129c2: Local verdict of PTC TC_handover_inter_ngran_xn1(873): none (fail -> fail) MTC@e79a03f129c2: Test case TC_handover_inter_ngran_xn finished. Verdict: fail reason: "C5G_Tests.ttcn:253 : Tguard timeout" MTC@e79a03f129c2: Starting external command `https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/ws/ttcn3-tcpdump-stop.sh C5G_Tests.TC_handover_inter_ngran_xn fail'. (13:47:42) load average: 1.15, 2.19, 2.24 [1;31m------ C5G_Tests.TC_handover_inter_ngran_xn fail ------[0m
Waiting for packet dumper to finish... 0 (prev_count=-1, count=133620) Waiting for packet dumper to finish... 1 (prev_count=133620, count=135088) MTC@e79a03f129c2: External command `https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/ws/ttcn3-tcpdump-stop.sh C5G_Tests.TC_handover_inter_ngran_xn fail' was executed successfully (exit status: 0). MTC@e79a03f129c2: Starting external command `https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/ws/ttcn3-tcpdump-start.sh C5G_Tests.TC_handover_inter_ngran_n2'. ------ C5G_Tests.TC_handover_inter_ngran_n2 ------ (13:47:44) load average: 1.15, 2.19, 2.24 /usr/bin/dumpcap -q -s 1520 -n -i any -w "https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/224/artifact/logs/testsuite/C5G_Tests.TC_handover_inter_ngran_n2.pcap" >https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/224/artifact/logs/testsuite/C5G_Tests.TC_handover_inter_ngran_n2.pcap.stdout 2>/tmp/cmderr & Waiting for packet dumper to start... 0 [1;34m[testenv] Running gdb to get a backtrace[0m [0;94m[testenv] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/ws/_cache', '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/ws/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/ws/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/ws/5gc:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-5gc-osmocom-latest-20260625-1343-6c70a2eb-1', 'sh', '-c', 'echo; gdb --batch /usr/bin/open5gs-amfd https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/224/artifact/logs/amf/core -ex bt | tee https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/224/artifact/logs/amf/core.backtrace; echo'][0m
[New LWP 6612] [New LWP 6610] [32m06/25 13:47:44.758[0m: [[33mscp[0m] [1;37mDEBUG[0m: scp_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/scp/scp-sm.c:54) [32m06/25 13:47:44.758[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/25 13:47:44.758[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/e27444f6-709b-41f1-a0d2-cf10... (../lib/sbi/client.c:797) [32m06/25 13:47:44.758[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/25 13:47:44.758[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/25 13:47:44.759[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [687] (../lib/sbi/nghttp2-server.c:1737) [32m06/25 13:47:44.759[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/e27444f6-709b-41f1-a0d2-cf10aa8598ad (../lib/sbi/nghttp2-server.c:1308) [32m06/25 13:47:44.759[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/25 13:47:44.759[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m06/25 13:47:44.759[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/25 13:47:44.759[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/25 13:47:44.759[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/25 13:47:44.759[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [687] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001b01 05000002 af89c961 97df3dbf ...........a..=. 0010: 4a09b532 db528200 9c502cdc 69db8d34 J..2.R...P,.i..4 0020: a62d1bff .-.. [32m06/25 13:47:44.759[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/e27444f6-709b-41f1-a0d2-cf10... (../lib/sbi/client.c:744) [32m06/25 13:47:44.759[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/25 13:47:44.759[0m: [[33mscp[0m] [1;37mDEBUG[0m: scp_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/scp/scp-sm.c:54) [32m06/25 13:47:44.759[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) [32m06/25 13:47:45.197[0m: [[33msepp[0m] [1;37mDEBUG[0m: sepp_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/sepp/sepp-sm.c:55) [32m06/25 13:47:45.197[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/25 13:47:45.197[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/e2a49ff2-709b-41f1-9818-f10... (../lib/sbi/client.c:797) [32m06/25 13:47:45.197[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/25 13:47:45.197[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/25 13:47:45.197[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [57] (../lib/sbi/nghttp2-server.c:1737) [32m06/25 13:47:45.197[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/e2a49ff2-709b-41f1-9818-f10d30c26150 (../lib/sbi/nghttp2-server.c:1308) [32m06/25 13:47:45.197[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/25 13:47:45.197[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m06/25 13:47:45.197[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/e2a49ff2-709b-41f1-9818-f10d... (../lib/sbi/client.c:797) [32m06/25 13:47:45.197[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/25 13:47:45.197[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/25 13:47:45.198[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [689] (../lib/sbi/nghttp2-server.c:1737) [32m06/25 13:47:45.198[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/e2a49ff2-709b-41f1-9818-f10d30c26150 (../lib/sbi/nghttp2-server.c:1308) [32m06/25 13:47:45.198[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/25 13:47:45.198[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m06/25 13:47:45.198[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/25 13:47:45.198[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/25 13:47:45.198[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/25 13:47:45.198[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [689] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001b01 05000002 b189ca61 97df3dbf ...........a..=. 0010: 4a09b532 db528200 9c502cdc 69db8d36 J..2.R...P,.i..6 0020: a62d1bff .-.. [32m06/25 13:47:45.198[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/e2a49ff2-709b-41f1-9818-f10d... (../lib/sbi/client.c:744) [32m06/25 13:47:45.198[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/25 13:47:45.198[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/25 13:47:45.198[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [57] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001b01 05000000 3989d861 97df3dbf ........9..a..=. 0010: 4a09b532 db528200 9c502cdc 69db8d36 J..2.R...P,.i..6 0020: a62d1bff .-.. [32m06/25 13:47:45.199[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/e2a49ff2-709b-41f1-9818-f10... (../lib/sbi/client.c:744) [32m06/25 13:47:45.199[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/25 13:47:45.199[0m: [[33msepp[0m] [1;37mDEBUG[0m: sepp_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/sepp/sepp-sm.c:55) [32m06/25 13:47:45.199[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) [Thread debugging using libthread_db enabled] Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1". Core was generated by `/usr/bin/open5gs-amfd -c open5gs-amf.yaml'. Program terminated with signal SIGSEGV, Segmentation fault. MTC@e79a03f129c2: External command `https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/ws/ttcn3-tcpdump-start.sh C5G_Tests.TC_handover_inter_ngran_n2' was executed successfully (exit status: 0). MTC@e79a03f129c2: Test case TC_handover_inter_ngran_n2 started. #0 0x00007fb0d65796bd in NativeInteger_encode_aper (td=0x7fb0d638dba0 <asn_DEF_NGAP_ProtocolIE_ID>, constraints=0x7fb0d63d5c20 <asn_PER_memb_NGAP_id_constr_454>, sptr=0x77, po=0x7fb070cead00) warning: 57 ../lib/asn1c/common/NativeInteger_aper.c: No such file or directory at ../lib/asn1c/common/NativeInteger_aper.c:57 [Current thread is 1 (Thread 0x7fb070cec6c0 (LWP 6612))] #0 0x00007fb0d65796bd in NativeInteger_encode_aper (td=0x7fb0d638dba0 <asn_DEF_NGAP_ProtocolIE_ID>, constraints=0x7fb0d63d5c20 <asn_PER_memb_NGAP_id_constr_454>, sptr=0x77, po=0x7fb070cead00) at ../lib/asn1c/common/NativeInteger_aper.c:57 #1 0x00007fb0d657bf20 in SEQUENCE_encode_aper (td=0x7fb0d63b5460 <asn_DEF_NGAP_PathSwitchRequestAcknowledgeIEs>, constraints=<optimized out>, sptr=0x77, po=0x7fb070cead00) at ../lib/asn1c/common/constr_SEQUENCE_aper.c:452 #2 0x00007fb0d657b148 in SEQUENCE_OF_encode_aper (td=0x7fb0d6394000 <asn_DEF_NGAP_ProtocolIE_Container_14662P36>, constraints=<optimized out>, sptr=0x7fb06d397230, po=0x7fb070cead00) at ../lib/asn1c/common/constr_SEQUENCE_OF_aper.c:92 #3 0x00007fb0d657bf20 in SEQUENCE_encode_aper (td=0x7fb0d6324d60 <asn_DEF_NGAP_PathSwitchRequestAcknowledge>, constraints=<optimized out>, sptr=0x7fb06c1286f0, po=0x7fb070cead00) at ../lib/asn1c/common/constr_SEQUENCE_aper.c:452 GTP1U_EM(874)@e79a03f129c2: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 [38;5;23m20260625134745240 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m SRV(,127.0.0.20:4268) accept()ed new link from 127.0.0.1:9999 (stream_srv.c:143)[0;m 20260625134745240 [1;32mDUECUPS[0;m [1;32mINFO[0;m r=127.0.0.1:9999<->l=127.0.0.20:4268: Accepted new UECUPS connection (cups_client.c:673) #4 0x00007fb0d6576d7f in aper_encode (td=0x7fb0d6324d60 <asn_DEF_NGAP_PathSwitchRequestAcknowledge>, constraints=<optimized out>, sptr=0x7fb06c1286f0, cb=<optimized out>, app_key=app_key@entry=0x7fb070ceadb0) at ../lib/asn1c/common/aper_encoder.c:115 #5 0x00007fb0d6576f19 in aper_encode_to_new_buffer (td=<optimized out>, constraints=<optimized out>, sptr=<optimized out>, buffer_r=buffer_r@entry=0x7fb070ceadf0) at ../lib/asn1c/common/aper_encoder.c:48 #6 0x00007fb0d65778bd in aper_open_type_put (td=<optimized out>, constraints=<optimized out>, sptr=<optimized out>, po=po@entry=0x7fb070ceb010) at ../lib/asn1c/common/aper_opentype.c:99 #7 0x00007fb0d657a6e1 in OPEN_TYPE_encode_aper (td=0x7fb0d6321260 <asn_DEF_NGAP_value_4>, constraints=<optimized out>, sptr=0x7fb06c28a670, po=0x7fb070ceb010) at ../lib/asn1c/common/OPEN_TYPE_aper.c:270 #8 0x00007fb0d657a7ab in OPEN_TYPE_aper_put (td=td@entry=0x7fb0d63210c0 <asn_DEF_NGAP_SuccessfulOutcome>, sptr=sptr@entry=0x7fb06c28a660, elm=0x7fb0d6321200 <asn_MBR_NGAP_SuccessfulOutcome_1+160>, po=po@entry=0x7fb070ceb010) at ../lib/asn1c/common/OPEN_TYPE_aper.c:336 #9 0x00007fb0d657bfe3 in SEQUENCE_encode_aper (td=0x7fb0d63210c0 <asn_DEF_NGAP_SuccessfulOutcome>, constraints=<optimized out>, sptr=0x7fb06c28a660, po=0x7fb070ceb010) at ../lib/asn1c/common/constr_SEQUENCE_aper.c:450 20260625134745241 [1;33mDGT[0;m [1;33mNOTICE[0;m tun0-R00000001-T00004fbd: Destroying (gtp_tunnel.c:136) #10 0x00007fb0d657af35 in CHOICE_encode_aper (td=0x7fb0d631f020 <asn_DEF_NGAP_NGAP_PDU>, constraints=<optimized out>, sptr=0x7fb070ceb150, po=0x7fb070ceb010) at ../lib/asn1c/common/constr_CHOICE_aper.c:195 20260625134745241 [1;32mDEP[0;m [1;32mINFO[0;m 127.0.0.20:2152: Destroying (gtp_endpoint.c:249) 20260625134745241 [1;32mDTUN[0;m [1;32mINFO[0;m tun0: Releasing (tun_device.c:524) 20260625134745242 [1;32mDTUN[0;m [1;32mINFO[0;m tun0: Destroying (tun_device.c:480) #11 0x00007fb0d6576d7f in aper_encode (td=td@entry=0x7fb0d631f020 <asn_DEF_NGAP_NGAP_PDU>, constraints=constraints@entry=0x0, sptr=sptr@entry=0x7fb070ceb150, cb=cb@entry=0x7fb0d6576cb0 <encode_to_buffer_cb>, app_key=app_key@entry=0x7fb070ceb0a0) at ../lib/asn1c/common/aper_encoder.c:115 #12 0x00007fb0d6576eb2 in aper_encode_to_buffer (td=td@entry=0x7fb0d631f020 <asn_DEF_NGAP_NGAP_PDU>, constraints=constraints@entry=0x0, sptr=sptr@entry=0x7fb070ceb150, buffer=<optimized out>, buffer_size=buffer_size@entry=32768) at ../lib/asn1c/common/aper_encoder.c:36 TC_handover_inter_ngran_n2-NGAP0(875)@e79a03f129c2: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 TC_handover_inter_ngran_n2-NGAP0(875)@e79a03f129c2: setverdict(fail): none -> fail reason: "Could not connect NGAP socket, check your configuration", new component reason: "Could not connect NGAP socket, check your configuration" MC@e79a03f129c2: Test Component 875 has requested to stop MTC. Terminating current testcase execution. TC_handover_inter_ngran_n2-NGAP0(875)@e79a03f129c2: Final verdict of PTC: fail reason: "Could not connect NGAP socket, check your configuration" GTP1U_EM(874)@e79a03f129c2: Final verdict of PTC: none MTC@e79a03f129c2: Setting final verdict of the test case. MTC@e79a03f129c2: Local verdict of MTC: none MTC@e79a03f129c2: Local verdict of PTC GTP1U_EM(874): none (none -> none) MTC@e79a03f129c2: Local verdict of PTC TC_handover_inter_ngran_n2-NGAP0(875): fail (none -> fail) reason: "Could not connect NGAP socket, check your configuration" MTC@e79a03f129c2: Test case TC_handover_inter_ngran_n2 finished. Verdict: fail reason: Could not connect NGAP socket, check your configuration MTC@e79a03f129c2: Starting external command `https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/ws/ttcn3-tcpdump-stop.sh C5G_Tests.TC_handover_inter_ngran_n2 fail'. #13 0x00007fb0d6566807 in ogs_asn_encode (td=td@entry=0x7fb0d631f020 <asn_DEF_NGAP_NGAP_PDU>, sptr=sptr@entry=0x7fb070ceb150) at ../lib/asn1c/util/message.c:95 (13:47:45) load average: 1.15, 2.19, 2.24 [1;31m------ C5G_Tests.TC_handover_inter_ngran_n2 fail ------[0m
Waiting for packet dumper to finish... 0 (prev_count=-1, count=748) #14 0x00007fb0d658cba7 in ogs_ngap_encode (message=message@entry=0x7fb070ceb150) at ../lib/ngap/message.c:33 #15 0x0000563eb31ec769 in ngap_build_path_switch_ack (amf_ue=amf_ue@entry=0x7fb07186a100) at ../src/amf/ngap-build.c:2514 #16 0x0000563eb31b6f81 in ngap_send_path_switch_ack (sess=sess@entry=0x7fb070ead780) at ../src/amf/ngap-path.c:611 #17 0x0000563eb31d648c in amf_nsmf_pdusession_handle_update_sm_context (amf_ue=amf_ue@entry=0x7fb07186a100, ran_ue=ran_ue@entry=0x563ec6075550, sess=sess@entry=0x7fb070ead780, state=state@entry=20, recvmsg=recvmsg@entry=0x7fb070ceb270) at ../src/amf/nsmf-handler.c:485 #18 0x0000563eb31cc8aa in amf_state_operational (s=<optimized out>, e=<optimized out>) at ../src/amf/amf-sm.c:608 #19 0x00007fb0d65b6e24 in ogs_fsm_dispatch (fsm=0x7fb070cebc20, event=0x7fb06c347890) at ../lib/core/ogs-fsm.c:127 [38;5;23m20260625134745269 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m r=127.0.0.1:9999<->l=127.0.0.20:4268 NOTIFICATION SHUTDOWN_EVENT flags=0x0 (stream.c:348)[0;m 20260625134745269 [1;33mDUECUPS[0;m [1;33mNOTICE[0;m r=127.0.0.1:9999<->l=127.0.0.20:4268: UECUPS connection lost (cups_client.c:599) #20 0x0000563eb31a2e49 in amf_main (data=<optimized out>) at ../src/amf/init.c:163 #21 0x00007fb0d65ac005 in thread_worker (arg=0x563ec609e8f0) at ../lib/core/ogs-thread.c:67 #22 0x00007fb0d549eb7b in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:448 #23 0x00007fb0d551c7f8 in __GI___clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78
[32m06/25 13:47:45.345[0m: [[33msepp[0m] [1;37mDEBUG[0m: sepp_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/sepp/sepp-sm.c:55) [32m06/25 13:47:45.345[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/25 13:47:45.345[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/e2bb58dc-709b-41f1-aec3-256... (../lib/sbi/client.c:797) [32m06/25 13:47:45.345[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/25 13:47:45.345[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/25 13:47:45.345[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [59] (../lib/sbi/nghttp2-server.c:1737) [32m06/25 13:47:45.345[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/e2bb58dc-709b-41f1-aec3-256a13cfb7cc (../lib/sbi/nghttp2-server.c:1308) [32m06/25 13:47:45.345[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/25 13:47:45.345[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m06/25 13:47:45.346[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/e2bb58dc-709b-41f1-aec3-256a... (../lib/sbi/client.c:797) [32m06/25 13:47:45.346[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/25 13:47:45.346[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/25 13:47:45.346[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [691] (../lib/sbi/nghttp2-server.c:1737) [32m06/25 13:47:45.346[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/e2bb58dc-709b-41f1-aec3-256a13cfb7cc (../lib/sbi/nghttp2-server.c:1308) [32m06/25 13:47:45.346[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/25 13:47:45.346[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m06/25 13:47:45.346[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/25 13:47:45.346[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/25 13:47:45.346[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/25 13:47:45.346[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [691] (../lib/sbi/nghttp2-server.c:1419) 0000: 00000301 05000002 b389cbbe ............ [32m06/25 13:47:45.347[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/e2bb58dc-709b-41f1-aec3-256a... (../lib/sbi/client.c:744) [32m06/25 13:47:45.347[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/25 13:47:45.347[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/25 13:47:45.347[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [59] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001b01 05000000 3b89d861 97df3dbf ........;..a..=. 0010: 4a09b532 db528200 9c502cdc 69db8d36 J..2.R...P,.i..6 0020: a62d1bff .-.. [32m06/25 13:47:45.347[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/e2bb58dc-709b-41f1-aec3-256... (../lib/sbi/client.c:744) [32m06/25 13:47:45.347[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/25 13:47:45.347[0m: [[33msepp[0m] [1;37mDEBUG[0m: sepp_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/sepp/sepp-sm.c:55) [32m06/25 13:47:45.347[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) [1;34m[testenv] Stopping podman container[0m [0;94m[testenv] + ['podman', 'kill', 'testenv-5gc-osmocom-latest-20260625-1343-6c70a2eb-1'][0m [32m06/25 13:47:45.404[0m: [[33mbsf[0m] [1;37mDEBUG[0m: bsf_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/bsf/bsf-sm.c:59) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/e2cfb070-709b-41f1-92ac-074... (../lib/sbi/client.c:797) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":6}] (../lib/sbi/client.c:548) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [63] (../lib/sbi/nghttp2-server.c:1737) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/e2cfb070-709b-41f1-92ac-074c29822948 (../lib/sbi/nghttp2-server.c:1308) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":6}] (../lib/sbi/nghttp2-server.c:1314) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/e2cfb070-709b-41f1-92ac-074c... (../lib/sbi/client.c:797) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":6}] (../lib/sbi/client.c:548) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [693] (../lib/sbi/nghttp2-server.c:1737) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/e2cfb070-709b-41f1-92ac-074c29822948 (../lib/sbi/nghttp2-server.c:1308) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":6}] (../lib/sbi/nghttp2-server.c:1314) [32m06/25 13:47:45.405[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/25 13:47:45.405[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/25 13:47:45.405[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [693] (../lib/sbi/nghttp2-server.c:1419) [32m06/25 13:47:45.406[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/e2cfb070-709b-41f1-92ac-074c... (../lib/sbi/client.c:744) [32m06/25 13:47:45.406[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/25 13:47:45.406[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/25 13:47:45.406[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [63] (../lib/sbi/nghttp2-server.c:1419) 0000: 00000301 05000002 b589cbbe ............ 0000: 00001b01 05000000 3f89d861 97df3dbf ........?..a..=. 0010: 4a09b532 db528200 9c502cdc 69db8d36 J..2.R...P,.i..6 0020: a62d1bff .-.. [32m06/25 13:47:45.406[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/e2cfb070-709b-41f1-92ac-074... (../lib/sbi/client.c:744) [32m06/25 13:47:45.406[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/25 13:47:45.406[0m: [[33mbsf[0m] [1;37mDEBUG[0m: bsf_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/bsf/bsf-sm.c:59) [32m06/25 13:47:45.406[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) testenv-5gc-osmocom-latest-20260625-1343-6c70a2eb-1 https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/224/artifact/logs/amf/core: ELF 64-bit LSB core file, x86-64, version 1 (SYSV), SVR4-style, from 'open5gs-amfd -c open5gs-amf.yaml', real uid: 0, effective uid: 0, real gid: 0, effective gid: 0, execfn: '/usr/bin/open5gs-amfd', platform: 'x86_64' [0;94m[testenv] Skipping clean up scripts, podman container has already stopped[0m [1;34m[testenv] Stopping testsuite (3533073)[0m [0;94m[testenv] feed_watchdog_loop: podman container has stopped[0m [1;34m[testenv] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs-latest/224/artifa... [0m + RC=1 + [ 1 = 0 ] + uptime + grep --color=always -o load.* [01;31m[Kload average: 1.15, 2.19, 2.24[m[K + exit 1 Error: container has already been removed Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.