Changes:
------------------------------------------ [...truncated 491.39 KB...] l-wx------ 1 build build 64 Dec 14 06:21 2 -> pipe:[32462260] l-wx------ 1 build build 64 Dec 14 06:21 3 -> /dev/null
ss -tn
State Recv-Q Send-Q Local Address:Port Peer Address:Port ESTAB 0 0 127.0.0.1:5000 127.0.0.1:58504 ESTAB 0 0 127.0.0.1:58504 127.0.0.1:5000
ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port LISTEN 0 10 127.0.0.1:4244 0.0.0.0:* LISTEN 0 10 127.0.0.1:4250 0.0.0.0:* LISTEN 0 1 127.0.0.1:5000 0.0.0.0:* LISTEN 0 1 0.0.0.0:5001 0.0.0.0:*
ps xua | grep osmo
build 41862 0.0 0.0 16412 7032 ? S 06:23 0:00 ./src/osmo-bsc_nat/osmo-bsc_nat -l 127.0.0.1 -c /build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg build 41869 0.0 0.0 2388 760 ? S 06:23 0:00 /bin/sh -c ps xua | grep osmo build 41871 0.0 0.0 2388 92 ? R 06:23 0:00 /bin/sh -c ps xua | grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57398), raddr=('127.0.0.1', 4244)> (1 sockets open) MSC is ready at 127.0.0.1 'show msc connection' says: 'MSC is connected: 1' Socket: closing 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57398), raddr=('127.0.0.1', 4244)> (0 sockets open) ERROR testEnsureNoEnsureModeSet (__main__.TestVTYNAT) ... Launching: PWD=/build/openbsc './src/osmo-bsc_nat/osmo-bsc_nat' '-l' '127.0.0.1' '-c' '/build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg'
ls -l /proc/41601/fd
total 0 lr-x------ 1 build build 64 Dec 14 06:21 0 -> pipe:[32462258] l-wx------ 1 build build 64 Dec 14 06:21 1 -> pipe:[32462259] l-wx------ 1 build build 64 Dec 14 06:21 2 -> pipe:[32462260] l-wx------ 1 build build 64 Dec 14 06:21 3 -> /dev/null
ss -tn
State Recv-Q Send-Q Local Address:Port Peer Address:Port
ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port LISTEN 0 10 127.0.0.1:4244 0.0.0.0:* LISTEN 0 10 127.0.0.1:4250 0.0.0.0:* LISTEN 0 1 127.0.0.1:5000 0.0.0.0:* LISTEN 0 1 0.0.0.0:5001 0.0.0.0:*
ps xua | grep osmo
build 41872 0.0 0.0 16412 6508 ? S 06:23 0:00 ./src/osmo-bsc_nat/osmo-bsc_nat -l 127.0.0.1 -c /build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg build 41879 0.0 0.0 2388 688 ? S 06:23 0:00 /bin/sh -c ps xua | grep osmo build 41881 0.0 0.0 6076 888 ? R 06:23 0:00 grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57408), raddr=('127.0.0.1', 4244)> (1 sockets open) Socket: closing 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57408), raddr=('127.0.0.1', 4244)> (0 sockets open) ok testPrefixTreeLoading (__main__.TestVTYNAT) ... Launching: PWD=/build/openbsc './src/osmo-bsc_nat/osmo-bsc_nat' '-l' '127.0.0.1' '-c' '/build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg'
ls -l /proc/41601/fd
total 0 lr-x------ 1 build build 64 Dec 14 06:21 0 -> pipe:[32462258] l-wx------ 1 build build 64 Dec 14 06:21 1 -> pipe:[32462259] l-wx------ 1 build build 64 Dec 14 06:21 2 -> pipe:[32462260] l-wx------ 1 build build 64 Dec 14 06:21 3 -> /dev/null
ss -tn
State Recv-Q Send-Q Local Address:Port Peer Address:Port
ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port LISTEN 0 10 127.0.0.1:4244 0.0.0.0:* LISTEN 0 10 127.0.0.1:4250 0.0.0.0:* LISTEN 0 1 127.0.0.1:5000 0.0.0.0:* LISTEN 0 1 0.0.0.0:5001 0.0.0.0:*
ps xua | grep osmo
build 41882 0.0 0.0 16412 6368 ? S 06:23 0:00 ./src/osmo-bsc_nat/osmo-bsc_nat -l 127.0.0.1 -c /build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg build 41889 0.0 0.0 2388 756 ? S 06:23 0:00 /bin/sh -c ps xua | grep osmo build 41891 0.0 0.0 6076 884 ? S 06:23 0:00 grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57414), raddr=('127.0.0.1', 4244)> (1 sockets open) Socket: closing 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57414), raddr=('127.0.0.1', 4244)> (0 sockets open) ok testRewriteNoRewrite (__main__.TestVTYNAT) ... Launching: PWD=/build/openbsc './src/osmo-bsc_nat/osmo-bsc_nat' '-l' '127.0.0.1' '-c' '/build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg'
ls -l /proc/41601/fd
total 0 lr-x------ 1 build build 64 Dec 14 06:21 0 -> pipe:[32462258] l-wx------ 1 build build 64 Dec 14 06:21 1 -> pipe:[32462259] l-wx------ 1 build build 64 Dec 14 06:21 2 -> pipe:[32462260] l-wx------ 1 build build 64 Dec 14 06:21 3 -> /dev/null
ss -tn
State Recv-Q Send-Q Local Address:Port Peer Address:Port
ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port LISTEN 0 10 127.0.0.1:4244 0.0.0.0:* LISTEN 0 10 127.0.0.1:4250 0.0.0.0:* LISTEN 0 1 127.0.0.1:5000 0.0.0.0:* LISTEN 0 1 0.0.0.0:5001 0.0.0.0:*
ps xua | grep osmo
build 41892 0.0 0.0 16412 6452 ? S 06:23 0:00 ./src/osmo-bsc_nat/osmo-bsc_nat -l 127.0.0.1 -c /build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg build 41899 0.0 0.0 2388 696 ? S 06:23 0:00 /bin/sh -c ps xua | grep osmo build 41901 0.0 0.0 2388 92 ? R 06:23 0:00 /bin/sh -c ps xua | grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57426), raddr=('127.0.0.1', 4244)> (1 sockets open) Socket: closing 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57426), raddr=('127.0.0.1', 4244)> (0 sockets open) ok testRewritePostNoRewrite (__main__.TestVTYNAT) ... Launching: PWD=/build/openbsc './src/osmo-bsc_nat/osmo-bsc_nat' '-l' '127.0.0.1' '-c' '/build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg'
ls -l /proc/41601/fd
total 0 lr-x------ 1 build build 64 Dec 14 06:21 0 -> pipe:[32462258] l-wx------ 1 build build 64 Dec 14 06:21 1 -> pipe:[32462259] l-wx------ 1 build build 64 Dec 14 06:21 2 -> pipe:[32462260] l-wx------ 1 build build 64 Dec 14 06:21 3 -> /dev/null
ss -tn
State Recv-Q Send-Q Local Address:Port Peer Address:Port
ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port LISTEN 0 10 127.0.0.1:4244 0.0.0.0:* LISTEN 0 10 127.0.0.1:4250 0.0.0.0:* LISTEN 0 1 127.0.0.1:5000 0.0.0.0:* LISTEN 0 1 0.0.0.0:5001 0.0.0.0:*
ps xua | grep osmo
build 41902 0.0 0.0 16412 6400 ? S 06:23 0:00 ./src/osmo-bsc_nat/osmo-bsc_nat -l 127.0.0.1 -c /build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg build 41909 0.0 0.0 2388 696 ? S 06:23 0:00 /bin/sh -c ps xua | grep osmo build 41911 0.0 0.0 6076 820 ? S 06:23 0:00 grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57438), raddr=('127.0.0.1', 4244)> (1 sockets open) Socket: closing 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57438), raddr=('127.0.0.1', 4244)> (0 sockets open) ok testUssdSideChannelProvider (__main__.TestVTYNAT) ... Launching: PWD=/build/openbsc './src/osmo-bsc_nat/osmo-bsc_nat' '-l' '127.0.0.1' '-c' '/build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg'
ls -l /proc/41601/fd
total 0 lr-x------ 1 build build 64 Dec 14 06:21 0 -> pipe:[32462258] l-wx------ 1 build build 64 Dec 14 06:21 1 -> pipe:[32462259] l-wx------ 1 build build 64 Dec 14 06:21 2 -> pipe:[32462260] l-wx------ 1 build build 64 Dec 14 06:21 3 -> /dev/null
ss -tn
State Recv-Q Send-Q Local Address:Port Peer Address:Port
ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port LISTEN 0 10 127.0.0.1:4244 0.0.0.0:* LISTEN 0 10 127.0.0.1:4250 0.0.0.0:* LISTEN 0 1 127.0.0.1:5000 0.0.0.0:* LISTEN 0 1 0.0.0.0:5001 0.0.0.0:*
ps xua | grep osmo
build 41912 0.0 0.0 16412 6412 ? S 06:23 0:00 ./src/osmo-bsc_nat/osmo-bsc_nat -l 127.0.0.1 -c /build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg build 41919 0.0 0.0 2388 760 ? S 06:23 0:00 /bin/sh -c ps xua | grep osmo build 41921 0.0 0.0 6076 884 ? S 06:23 0:00 grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57452), raddr=('127.0.0.1', 4244)> (1 sockets open) Connected to 127.0.0.1:5001 Expecting ID_GET request Going to send ID_RESP response Going to send PING request Expecting PONG response Going to shut down connection Expecting EOF Socket: closing 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57452), raddr=('127.0.0.1', 4244)> (0 sockets open) ok testVtyTree (__main__.TestVTYNAT) ... Launching: PWD=/build/openbsc './src/osmo-bsc_nat/osmo-bsc_nat' '-l' '127.0.0.1' '-c' '/build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg'
ls -l /proc/41601/fd
total 0 lr-x------ 1 build build 64 Dec 14 06:21 0 -> pipe:[32462258] l-wx------ 1 build build 64 Dec 14 06:21 1 -> pipe:[32462259] l-wx------ 1 build build 64 Dec 14 06:21 2 -> pipe:[32462260] l-wx------ 1 build build 64 Dec 14 06:21 3 -> /dev/null
ss -tn
State Recv-Q Send-Q Local Address:Port Peer Address:Port
ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port LISTEN 0 10 127.0.0.1:4244 0.0.0.0:* LISTEN 0 10 127.0.0.1:4250 0.0.0.0:* LISTEN 0 1 127.0.0.1:5000 0.0.0.0:* LISTEN 0 1 0.0.0.0:5001 0.0.0.0:*
ps xua | grep osmo
build 41922 0.0 0.0 16412 6580 ? S 06:23 0:00 ./src/osmo-bsc_nat/osmo-bsc_nat -l 127.0.0.1 -c /build/openbsc/tests/../doc/examples/osmo-bsc_nat/osmo-bsc-nat.cfg build 41929 0.0 0.0 2388 756 ? S 06:23 0:00 /bin/sh -c ps xua | grep osmo build 41931 0.0 0.0 6076 888 ? S 06:23 0:00 grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57460), raddr=('127.0.0.1', 4244)> (1 sockets open) Socket: closing 127.0.0.1:4244 <socket.socket fd=4, family=AddressFamily.AF_INET, type=SocketKind.SOCK_STREAM, proto=0, laddr=('127.0.0.1', 57460), raddr=('127.0.0.1', 4244)> (0 sockets open) ok
====================================================================== ERROR: testBSCreload (__main__.TestVTYNAT) ---------------------------------------------------------------------- Traceback (most recent call last): File "./vty_test_runner.py", line 803, in testBSCreload msc_socket, msc = nat_msc_test(self, ip, port, verbose=True) File "./vty_test_runner.py", line 1048, in nat_msc_test " connected yet: %r %r" % (ip, port)) Exception: VTY reports MSC is connected, but I haven't connected yet: '127.0.0.1' 5522
---------------------------------------------------------------------- Ran 33 tests in 79.269s
FAILED (errors=1) make[5]: *** [Makefile:717: python-tests] Error 1 make[5]: Leaving directory '/build/openbsc/tests' make[4]: Leaving directory '/build/openbsc/tests' make[3]: Leaving directory '/build/openbsc/tests' make[4]: *** [Makefile:726: check-local] Error 2 make[3]: *** [Makefile:575: check-am] Error 2 make[2]: *** [Makefile:424: check-recursive] Error 1 make[2]: Leaving directory '/build/openbsc/tests' make[1]: *** [Makefile:455: check-recursive] Error 1 make[1]: Leaving directory '/build/openbsc' make: *** [Makefile:749: check] Error 2 + cat-testlogs.sh Build step 'Execute shell' marked build as failure $ ssh-agent -k unset SSH_AUTH_SOCK; unset SSH_AGENT_PID; echo Agent pid 2909773 killed; [ssh-agent] Stopped. Archiving artifacts