See
<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/97/display/redirect?page=changes>
Changes:
[Oliver Smith] testenv: install curl backport only for bookworm
[Oliver Smith] Cosmetic: testenv: make builddir_env more readable
[laforge] msc: also execute evil USSD tests for -latest
[Oliver Smith] testenv: use separate cache dirs per distro
[Oliver Smith] testenv: init podman: add --distro arg
[Oliver Smith] testenv: debian 13: fix installing libgcc
[Oliver Smith] testenv: debian 13: fix installing eclipse-titan
[Oliver Smith] testenv: check for --distro without --podman
[Oliver Smith] testenv: check value of --distro early
[Oliver Smith] testenv: add debian:trixie
[Oliver Smith] testenv: enable_binary_repo: configure apt pin
[Oliver Smith] testenv: set default distro to debian:trixie
[Oliver Smith] testenv: qemu: ignore builtin modules
------------------------------------------
[...truncated 2.34 MiB...]
0070: 7454696d 6572223a 31302c22 706c6d6e tTimer":10,"plmn
0080: 4c697374 223a5b7b 226d6363 223a2239 List":[{"mcc":"9
0090: 3939222c 226d6e63 223a2237 30227d5d 99","mnc":"70"}]
00a0: 2c226970 76344164 64726573 73657322 ,"ipv4Addresses"
00b0: 3a5b2231 32372e30 2e302e35 225d2c22 :["127.0.0.5"],"
00c0: 616c6c6f 7765644e 66547970 6573223a allowedNfTypes":
00d0: 5b225343 50222c22 534d4622 2c22414d ["SCP","SMF","AM
00e0: 46225d2c 22707269 6f726974 79223a30 F"],"priority":0
00f0: 2c226361 70616369 7479223a 3130302c ,"capacity":100,
0100: 226c6f61 64223a30 2c22616d 66496e66 "load":0,"amfInf
0110: 6f223a7b 22616d66 53657449 64223a22 o":{"amfSetId":"
0120: 30303122 2c22616d 66526567 696f6e49 001","amfRegionI
0130: 64223a22 3032222c 22677561 6d694c69 d":"02","guamiLi
0140: 7374223a 5b7b2270 6c6d6e49 64223a7b st":[{"plmnId":{
0150: 226d6363 223a2239 3939222c 226d6e63 "mcc":"999","mnc
0160: 223a2237 30227d2c 22616d66 4964223a ":"70"},"amfId":
0170: 22303230 30343022 7d5d2c22 7461694c "020040"}],"taiL
0180: 69737422 3a5b7b22 706c6d6e 4964223a ist":[{"plmnId":
0190: 7b226d63 63223a22 39393922 2c226d6e {"mcc":"999","mn
01a0: 63223a22 3730227d 2c227461 63223a22
c":"70"},"tac":"
01b0: 30303030 3031227d 5d7d2c22 6e665365 000001"}]},"nfSe
01c0: 72766963 654c6973 74223a7b 22626331 rviceList":{"bc1
01d0: 66373365 342d3833 66312d34 3166302d f73e4-83f1-41f0-
01e0: 61383037 2d373766 62333631 36316362 a807-77fb36161cb
01f0: 66223a7b 22736572 76696365 496e7374 f":{"serviceInst
0200: 616e6365 4964223a 22626331 66373365 anceId":"bc1f73e
0210: 342d3833 66312d34 3166302d 61383037 4-83f1-41f0-a807
0220: 2d373766 62333631 36316362 66222c22 -77fb36161cbf","
0230: 73657276 6963654e 616d6522 3a226e61 serviceName":"na
0240: 6d662d63 6f6d6d22 2c227665 7273696f mf-comm","versio
0250: 6e73223a 5b7b2261 70695665 7273696f ns":[{"apiVersio
0260: 6e496e55 7269223a 22763122 2c226170 nInUri":"v1","ap
0270: 6946756c 6c566572 73696f6e 223a2231 iFullVersion":"1
0280: 2e302e30 227d5d2c 22736368 656d6522 .0.0"}],"scheme"
0290: 3a226874 7470222c 226e6653 65727669 :"http","nfServi
02a0: 63655374 61747573 223a2252 45474953 ceStatus":"REGIS
02b0: 54455245 44222c22 6970456e 64506f69 TERED","ipEndPoi
02c0: 6e747322 3a5b7b22 69707634 41646472 nts":[{"ipv4Addr
02d0: 65737322 3a223132 372e302e 302e3522 ess":"127.0.0.5"
02e0: 2c22706f 7274223a 37373737 7d5d2c22 ,"port":7777}],"
02f0: 616c6c6f 7765644e 66547970 6573223a allowedNfTypes":
0300: 5b22534d 46222c22 414d4622 5d2c2270 ["SMF","AMF"],"p
0310: 72696f72 69747922 3a302c22 63617061 riority":0,"capa
0320: 63697479 223a3130 302c226c 6f616422 city":100,"load"
0330: 3a307d7d 7d :0}}}
0000: 00000901 04000000 2188c1c0 0f0d8278 ........!......x
0010: 22bf ".
[32m08/28 09:31:11.505[0m: [[33msbi[0m] [1;37mDEBUG[0m: [200:GET]
http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/bc1f585a-83f1-41f0-a807-77…
(../lib/sbi/client.c:734)
[32m08/28 09:31:11.505[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[812]
(../lib/sbi/client.c:745)
[32m08/28 09:31:11.505[0m: [[33msbi[0m] [1;37mDEBUG[0m:
{"nfInstanceId":"bc1f585a-83f1-41f0-a807-77fb36161cbf","nfType":"AMF","nfStatus":"REGISTERED","heartBeatTimer":10,"plmnList":[{"mcc":"999","mnc":"70"}],"ipv4Addresses":["127.0.0.5"],"allowedNfTypes":["SCP","SMF","AMF"],"priority":0,"capacity":100,"load":0,"amfInfo":{"amfSetId":"001","amfRegionId":"02","guamiList":[{"plmnId":{"mcc":"999","mnc":"70"},"amfId":"020040"}],"taiList":[{"plmnId":{"mcc":"999","mnc":"70"},"tac":"000001"}]},"nfServiceList":{"bc1f73e4-83f1-41f0-a807-77fb36161cbf":{"serviceInstanceId":"bc1f73e4-83f1-41f0-a807-77fb36161cbf","serviceName":"namf-comm","versions":[{"apiVersionInUri":"v1","apiFullVersion":"1.0.0"}],"scheme":"http","nfServiceStatus":"REGISTERED","ipEndPoints":[{"ipv4Address":"127.0.0.5","port":7777}],"allowedNfTypes":["SMF","AMF"],"priority":0,"capacity":100,"load":0}}}
(../lib/sbi/client.c:748)
[32m08/28 09:31:11.505[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational():
OGS_EVENT_NAME_SBI_CLIENT (../src/amf/amf-sm.c:84)
[32m08/28 09:31:11.506[0m: [[33msbi[0m] [1;37mDEBUG[0m:
ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:285)
0000: 00032c00 01000000 217b226e 66496e73 ..,.....!{"nfIns
0010: 74616e63 65496422 3a226263 31663538 tanceId":"bc1f58
0020: 35612d38 3366312d 34316630 2d613830 5a-83f1-41f0-a80
0030: 372d3737 66623336 31363163 6266222c 7-77fb36161cbf",
0040: 226e6654 79706522 3a22414d 46222c22 "nfType":"AMF","
0050: 6e665374 61747573 223a2252 45474953 nfStatus":"REGIS
0060: 54455245 44222c22 68656172 74426561 TERED","heartBea
0070: 7454696d 6572223a 31302c22 706c6d6e tTimer":10,"plmn
0080: 4c697374 223a5b7b 226d6363 223a2239 List":[{"mcc":"9
0090: 3939222c 226d6e63 223a2237 30227d5d 99","mnc":"70"}]
00a0: 2c226970 76344164 64726573 73657322 ,"ipv4Addresses"
00b0: 3a5b2231 32372e30 2e302e35 225d2c22 :["127.0.0.5"],"
00c0: 616c6c6f 7765644e 66547970 6573223a allowedNfTypes":
00d0: 5b225343 50222c22 534d4622 2c22414d ["SCP","SMF","AM
00e0: 46225d2c 22707269 6f726974 79223a30 F"],"priority":0
00f0: 2c226361 70616369 7479223a 3130302c ,"capacity":100,
0100: 226c6f61 64223a30 2c22616d 66496e66 "load":0,"amfInf
0110: 6f223a7b 22616d66 53657449 64223a22 o":{"amfSetId":"
0120: 30303122 2c22616d 66526567 696f6e49 001","amfRegionI
0130: 64223a22 3032222c 22677561 6d694c69 d":"02","guamiLi
0140: 7374223a 5b7b2270 6c6d6e49 64223a7b st":[{"plmnId":{
0150: 226d6363 223a2239 3939222c 226d6e63 "mcc":"999","mnc
0160: 223a2237 30227d2c 22616d66 4964223a ":"70"},"amfId":
0170: 22303230 30343022 7d5d2c22 7461694c "020040"}],"taiL
0180: 69737422 3a5b7b22 706c6d6e 4964223a ist":[{"plmnId":
0190: 7b226d63 63223a22 39393922 2c226d6e {"mcc":"999","mn
01a0: 63223a22 3730227d 2c227461 63223a22
c":"70"},"tac":"
01b0: 30303030 3031227d 5d7d2c22 6e665365 000001"}]},"nfSe
01c0: 72766963 654c6973 74223a7b 22626331 rviceList":{"bc1
01d0: 66373365 342d3833 66312d34 3166302d f73e4-83f1-41f0-
01e0: 61383037 2d373766 62333631 36316362 a807-77fb36161cb
01f0: 66223a7b 22736572 76696365 496e7374 f":{"serviceInst
0200: 616e6365 4964223a 22626331 66373365 anceId":"bc1f73e
0210: 342d3833 66312d34 3166302d 61383037 4-83f1-41f0-a807
0220: 2d373766 62333631 36316362 66222c22 -77fb36161cbf","
0230: 73657276 6963654e 616d6522 3a226e61 serviceName":"na
0240: 6d662d63 6f6d6d22 2c227665 7273696f mf-comm","versio
0250: 6e73223a 5b7b2261 70695665 7273696f ns":[{"apiVersio
0260: 6e496e55 7269223a 22763122 2c226170 nInUri":"v1","ap
0270: 6946756c 6c566572 73696f6e 223a2231 iFullVersion":"1
0280: 2e302e30 227d5d2c 22736368 656d6522 .0.0"}],"scheme"
0290: 3a226874 7470222c 226e6653 65727669 :"http","nfServi
02a0: 63655374 61747573 223a2252 45474953 ceStatus":"REGIS
02b0: 54455245 44222c22 6970456e 64506f69 TERED","ipEndPoi
02c0: 6e747322 3a5b7b22 69707634 41646472 nts":[{"ipv4Addr
02d0: 65737322 3a223132 372e302e 302e3522 ess":"127.0.0.5"
02e0: 2c22706f 7274223a 37373737 7d5d2c22 ,"port":7777}],"
02f0: 616c6c6f 7765644e 66547970 6573223a allowedNfTypes":
0300: 5b22534d 46222c22 414d4622 5d2c2270 ["SMF","AMF"],"p
0310: 72696f72 69747922 3a302c22 63617061 riority":0,"capa
0320: 63697479 223a3130 302c226c 6f616422 city":100,"load"
0330: 3a307d7d 7d :0}}}
[1;34m[testenv] Running uecups-daemon[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/ws/_cache',>
'-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace',
'-e', 'TESTENV_INSTALL_DIR=/-debian-trixie', '-e',
'TERM=dumb', '-e',
'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_testenv/data/scripts>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_testenv/data/scripts/qemu>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/5gc>:/-debian-trixie/bin:/-debian-trixie/usr/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin',
'-e', 'HOME=/home/osmocom-build', '-w',
'<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/97/artifact/logs/uecups-daemon',>
'testenv-5gc-osmocom-nightly-20250828-0929-a30f78ff-0', 'sh',
'-c', 'sudo $(which osmo-uecups-daemon) 2>&1 | tee
<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/97/artifact/logs/uecups-daemon/uecups-daemon.log'][0m>
[1;34m[testenv] Running testsuite (eclipse-titan 11.1.0, from titan_min= in
testenv.cfg)[0m
20250828093111833 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m Available via telnet 127.0.0.20
4268 (telnet_interface.c:88)
[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/ws/_cache',>
'-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace',
'-e', 'TESTENV_INSTALL_DIR=/-debian-trixie', '-e',
'TERM=dumb', '-e',
'PATH=/opt/eclipse-titan-11.1.0/bin:<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_testenv/data/scripts>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_testenv/data/scripts/qemu>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/5gc>:/-debian-trixie/bin:/-debian-trixie/usr/bin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin',
'-e', 'HOME=/home/osmocom-build', '-e',
'BUILDDIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_cache/podman/titan-11.1.0-debian-trixie',>
'-e', 'TTCN3_DIR=/opt/eclipse-titan-11.1.0', '-e',
'TTCN3_PCAP_PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/97/artifact/logs/testsuite',>
'-w',
'<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/97/artifact/logs/testsuite',>
'testenv-5gc-osmocom-nightly-20250828-0929-a30f78ff-0',
'<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/start-testsuite.sh',>
'5gc/C5G_Tests', 'C5G_Tests.cfg'][0m
ttcn3_start: Starting the test suite
spawn /opt/eclipse-titan-11.1.0/bin/mctr_cli C5G_Tests.cfg
*************************************************************************
* TTCN-3 Test Executor - Main Controller 2 *
* Version: 11.1.0 *
* Copyright (c) 2000-2025 Ericsson Telecom AB *
* All rights reserved. This program and the accompanying materials *
* are made available under the terms of the Eclipse Public License v2.0 *
* which accompanies this distribution, and is available at *
*
https://www.eclipse.org/org/documents/epl-2.0/EPL-2.0.html *
*************************************************************************
Using configuration file: C5G_Tests.cfg
MC@8c4b9ca3a635: Unix server socket created successfully.
MC@8c4b9ca3a635: Listening on TCP port 33971.
8c4b9ca3a635 is the default
MC2> spawn
<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_cache/podman/titan-11.1.0-debian-trixie/5gc/C5G_Tests>
8c4b9ca3a635 33971
TTCN-3 Host Controller (parallel mode), version 11.1.0
MC@8c4b9ca3a635: New HC connected from 10.0.2.100 [10.0.2.100]. 8c4b9ca3a635: Linux
6.1.0-29-amd64 on x86_64.
cmtc
MC@8c4b9ca3a635: Downloading configuration file to all HCs.
construct junitlogger
Initializing `JUnitLogger' (v2.0): JUnitLogger writes JUnit-compatible XML
HC@8c4b9ca3a635: Warning: Option `FileMask' was given more than once in section
[LOGGING] of the configuration file.
MC@8c4b9ca3a635: Configuration file was processed on all HCs.
MC@8c4b9ca3a635: Creating MTC on host 10.0.2.100.
MC@8c4b9ca3a635: MTC is created.
MC2> smtc
Executing all items of [EXECUTE] section.
MC2> MTC@8c4b9ca3a635: Starting external command
`<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/ttcn3-tcpdump-start.sh>
C5G_Tests.TC_ng_setup'.
------ C5G_Tests.TC_ng_setup ------
Thu Aug 28 09:31:12 UTC 2025
/usr/bin/dumpcap -q -s 1520 -n -i any -w
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/97/artifact/logs/testsuite/C5G_Tests.TC_ng_setup.pcap">
><https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/97/artifact/logs/testsuite/C5G_Tests.TC_ng_setup.pcap.stdout>
2>/tmp/cmderr &
Waiting for packet dumper to start... 0
[1;34m[testenv] Looking for a coredump on lxc host[0m
[0;94m[testenv] + ['ip', '-j', '-o', '-4',
'addr', 'show', 'dev', 'eth0'][0m
[32m08/28 09:31:12.952[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL Response Timeout
for step 1 type 5 peer [127.0.0.7]:8805 (../lib/pfcp/xact.c:583)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: ogs_pfcp_extract_node_id()
type [5] pfcp_status [0] node_id [127.0.0.4] from [127.0.0.4]:8805
(../src/upf/pfcp-path.c:101)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: Added PFCP-Node: addr_list
[127.0.0.4]:8805 (../src/upf/pfcp-path.c:140)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: upf_pfcp_state_initial():
ENTRY (../src/upf/pfcp-sm.c:38)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m:
upf_pfcp_state_will_associate(): ENTRY (../src/upf/pfcp-sm.c:72)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: upf_state_operational():
UPF_EVT_N4_MESSAGE (../src/upf/upf-sm.c:51)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] Cannot find new type 5
from PFCP peer [127.0.0.4]:8805 (../lib/pfcp/xact.c:727)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] REMOTE Create peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:156)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] REMOTE Receive peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:733)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] REMOTE UPD RX-5 peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:289)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m:
upf_pfcp_state_will_associate(): UPF_EVT_N4_MESSAGE (../src/upf/pfcp-sm.c:72)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: Association Setup Response
(../lib/pfcp/build.c:252)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] REMOTE UPD TX-6 peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:191)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] REMOTE Commit peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:460)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m:
upf_pfcp_state_will_associate(): EXIT (../src/upf/pfcp-sm.c:72)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: upf_pfcp_state_associated():
ENTRY (../src/upf/pfcp-sm.c:161)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;32mINFO[0m: PFCP associated
[127.0.0.4]:8805 (../src/upf/pfcp-sm.c:168)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL Create peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:111)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: Heartbeat Request
(../lib/pfcp/build.c:28)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL UPD TX-1 peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:191)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL Commit peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:460)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: ogs_pfcp_extract_node_id()
type [6] pfcp_status [0] node_id [127.0.0.7] from [127.0.0.7]:8805
(../src/smf/pfcp-path.c:138)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: Found PFCP-Node: addr_list
[127.0.0.7]:8805 (../src/smf/pfcp-path.c:192)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: Merged PFCP-Node: addr_list
[127.0.0.7]:8805 (../src/smf/pfcp-path.c:198)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: smf_state_operational():
SMF_EVT_N4_MESSAGE (../src/smf/smf-sm.c:93)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL Find peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:718)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL Receive peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:733)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL UPD RX-6 peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:289)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m:
smf_pfcp_state_will_associate(): SMF_EVT_N4_MESSAGE (../src/smf/pfcp-sm.c:74)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL Commit peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:460)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL Delete peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:791)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m:
smf_pfcp_state_will_associate(): EXIT (../src/smf/pfcp-sm.c:74)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: smf_pfcp_state_associated():
ENTRY (../src/smf/pfcp-sm.c:182)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;32mINFO[0m: PFCP associated
[127.0.0.7]:8805 (../src/smf/pfcp-sm.c:189)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] LOCAL Create peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:111)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: Heartbeat Request
(../lib/pfcp/build.c:28)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] LOCAL UPD TX-1 peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:191)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] LOCAL Commit peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:460)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: ogs_pfcp_extract_node_id()
type [1] pfcp_status [1] node_id [NULL] from [127.0.0.7]:8805
(../src/smf/pfcp-path.c:138)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: Found PFCP-Node: addr_list
[127.0.0.7]:8805 (../src/smf/pfcp-path.c:192)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: Merged PFCP-Node: addr_list
[127.0.0.7]:8805 (../src/smf/pfcp-path.c:198)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: smf_state_operational():
SMF_EVT_N4_MESSAGE (../src/smf/smf-sm.c:93)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] Cannot find new type 1
from PFCP peer [127.0.0.7]:8805 (../lib/pfcp/xact.c:727)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] REMOTE Create peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:156)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] REMOTE Receive peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:733)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] REMOTE UPD RX-1 peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:289)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: smf_pfcp_state_associated():
SMF_EVT_N4_MESSAGE (../src/smf/pfcp-sm.c:182)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: Heartbeat Response
(../lib/pfcp/build.c:56)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] REMOTE UPD TX-2 peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:191)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] REMOTE Commit peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:460)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] REMOTE Delete peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:791)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: ogs_pfcp_extract_node_id()
type [1] pfcp_status [1] node_id [NULL] from [127.0.0.4]:8805
(../src/upf/pfcp-path.c:101)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: Found PFCP-Node: addr_list
[127.0.0.4]:8805 (../src/upf/pfcp-path.c:155)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: Merged PFCP-Node: addr_list
[127.0.0.4]:8805 (../src/upf/pfcp-path.c:161)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: upf_state_operational():
UPF_EVT_N4_MESSAGE (../src/upf/upf-sm.c:51)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] Cannot find new type 1
from PFCP peer [127.0.0.4]:8805 (../lib/pfcp/xact.c:727)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] REMOTE Create peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:156)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] REMOTE Receive peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:733)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] REMOTE UPD RX-1 peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:289)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: upf_pfcp_state_associated():
UPF_EVT_N4_MESSAGE (../src/upf/pfcp-sm.c:161)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: Heartbeat Response
(../lib/pfcp/build.c:56)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] REMOTE UPD TX-2 peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:191)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] REMOTE Commit peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:460)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] REMOTE Delete peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:791)
[32m08/28 09:31:12.953[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)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: Found PFCP-Node: addr_list
[127.0.0.4]:8805 (../src/upf/pfcp-path.c:155)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: Merged PFCP-Node: addr_list
[127.0.0.4]:8805 (../src/upf/pfcp-path.c:161)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: upf_state_operational():
UPF_EVT_N4_MESSAGE (../src/upf/upf-sm.c:51)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL Find peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:718)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL Receive peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:733)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL UPD RX-2 peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:289)
[32m08/28 09:31:12.953[0m: [[33mupf[0m] [1;37mDEBUG[0m: upf_pfcp_state_associated():
UPF_EVT_N4_MESSAGE (../src/upf/pfcp-sm.c:161)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL Commit peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:460)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [1] LOCAL Delete peer
[127.0.0.4]:8805 (../lib/pfcp/xact.c:791)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: ogs_pfcp_extract_node_id()
type [2] pfcp_status [1] node_id [NULL] from [127.0.0.7]:8805
(../src/smf/pfcp-path.c:138)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: Found PFCP-Node: addr_list
[127.0.0.7]:8805 (../src/smf/pfcp-path.c:192)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: Merged PFCP-Node: addr_list
[127.0.0.7]:8805 (../src/smf/pfcp-path.c:198)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: smf_state_operational():
SMF_EVT_N4_MESSAGE (../src/smf/smf-sm.c:93)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] LOCAL Find peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:718)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] LOCAL Receive peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:733)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] LOCAL UPD RX-2 peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:289)
[32m08/28 09:31:12.953[0m: [[33msmf[0m] [1;37mDEBUG[0m: smf_pfcp_state_associated():
SMF_EVT_N4_MESSAGE (../src/smf/pfcp-sm.c:182)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] LOCAL Commit peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:460)
[32m08/28 09:31:12.953[0m: [[33mpfcp[0m] [1;37mDEBUG[0m: [2] LOCAL Delete peer
[127.0.0.7]:8805 (../lib/pfcp/xact.c:791)
[0;94m[testenv] No coredump found[0m
[1;91m[testenv] sepp1 unexpected exit! rc=0[0m
[1;34m[testenv] Stopping podman container[0m
[0;94m[testenv] + ['podman', 'kill',
'testenv-5gc-osmocom-nightly-20250828-0929-a30f78ff-0'][0m
testenv-5gc-osmocom-nightly-20250828-0929-a30f78ff-0
[0;94m[testenv] Skipping clean up scripts, podman container has already stopped[0m
[1;34m[testenv] Stopping testsuite (300031)[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/97/artifact/logs/ [0m
+ RC=1
+ [ 1 = 0 ]
+ grep --color=always -o load.*
+ uptime
[01;31m[Kload average: 8.95, 4.75, 2.57[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.