2022-03-07T09:33:41.590092+0100 test-netjail-1650548 INFO Running command `netjail-start'
2022-03-07T09:33:41.590304+0100 test-netjail-1650548 INFO Trying to start child management.
2022-03-07T09:33:41.590335+0100 test-netjail-1650548 INFO Child management started.
+ export PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ filename=test_transport_simple_send_topo.conf
+ PREFIX=1650548
+ readfile=1
+ BROADCAST=0
+ '[' 1 -eq 0 ']'
+ echo read file
+ read_topology test_transport_simple_send_topo.conf
+ local filename=test_transport_simple_send_topo.conf
+ read line
+ parse_line M:2
+ line=M:2
+ echo M:2
++ cut -c -1
+ key=M
+ '[' M = M ']'
++ cut -d : -f 2
+ LOCAL_M=2
+ echo 2
+ read line
+ parse_line N:1
+ line=N:1
+ echo N:1
++ cut -c -1
+ key=N
+ '[' N = M ']'
+ '[' N = N ']'
++ cut -d : -f 2
+ GLOBAL_N=1
+ echo 1
+ (( i=1 ))
+ (( i<=1 ))
+ R_TCP[$i]=0
+ R_UDP[$i]=0
+ (( i++ ))
+ (( i<=1 ))
+ read line
+ parse_line X:0
+ line=X:0
+ echo X:0
++ cut -c -1
+ key=X
+ '[' X = M ']'
+ '[' X = N ']'
+ '[' X = X ']'
++ cut -d : -f 2
+ KNOWN=0
+ echo 0
+ read line
+ parse_line T:libgnunet_test_transport_plugin_cmd_simple_send
+ line=T:libgnunet_test_transport_plugin_cmd_simple_send
+ echo T:libgnunet_test_transport_plugin_cmd_simple_send
++ cut -c -1
+ key=T
+ '[' T = M ']'
+ '[' T = N ']'
+ '[' T = X ']'
+ '[' T = T ']'
++ cut -d : -f 2
+ PLUGIN=libgnunet_test_transport_plugin_cmd_simple_send
+ echo libgnunet_test_transport_plugin_cmd_simple_send
+ read line
+ parse_line 'P:1:1|{connect:{P:1:2:tcp}}'
+ line='P:1:1|{connect:{P:1:2:tcp}}'
+ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ cut -c -1
+ key=P
+ '[' P = M ']'
+ '[' P = N ']'
+ '[' P = X ']'
+ '[' P = T ']'
+ '[' P = B ']'
+ '[' P = K ']'
+ '[' P = R ']'
+ '[' P = P ']'
+ echo node
+ extract_attributes P 'P:1:1|{connect:{P:1:2:tcp}}'
+ line_key=P
+ line='P:1:1|{connect:{P:1:2:tcp}}'
+ '[' P = P ']'
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ cut -d '|' -f 1
++ awk -F: '{print $2}'
+ n=1
+ echo 1
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ cut -d '|' -f 1
++ awk -F: '{print $3}'
+ m=1
+ echo 1
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -F: '{print NF}'
+ nf=7
+ (( i=2 ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=2 '-F|' '{print $i}'
+ entry='{connect:{P:1:2:tcp}}'
++ echo '{connect:{P:1:2:tcp}}'
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=connect
++ echo '{connect:{P:1:2:tcp}}'
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' connect = tcp_port ']'
+ '[' connect = udp_port ']'
+ '[' connect = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=3 '-F|' '{print $i}'
+ entry=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' '' = tcp_port ']'
+ '[' '' = udp_port ']'
+ '[' '' = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=4 '-F|' '{print $i}'
+ entry=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' '' = tcp_port ']'
+ '[' '' = udp_port ']'
+ '[' '' = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=5 '-F|' '{print $i}'
+ entry=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' '' = tcp_port ']'
+ '[' '' = udp_port ']'
+ '[' '' = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=6 '-F|' '{print $i}'
+ entry=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' '' = tcp_port ']'
+ '[' '' = udp_port ']'
+ '[' '' = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=7 '-F|' '{print $i}'
+ entry=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' '' = tcp_port ']'
+ '[' '' = udp_port ']'
+ '[' '' = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
+ read line
+ shift 2
+ LOCAL_GROUP=192.168.15
+ GLOBAL_GROUP=92.68.150
+ KNOWN_GROUP=92.68.151
+ '[' 0 -eq 0 ']'
+ PORT=60002
+ echo 'Start [local: 192.168.15.0/24, global: 92.68.150.0/16]'
+ netjail_bridge
+ netjail_next_interface
+ local NUM=0
+ INTERFACE_NUM=1
+ RESULT=0
+ local NUM=0
++ printf %06x-%08x 1650548 0
+ local BRIDGE=192f74-00000000
+ ip link add 192f74-00000000 type bridge
+ ip link set dev 192f74-00000000 up
+ RESULT=192f74-00000000
+ NETWORK_NET=192f74-00000000
++ seq 0
+ declare -A NODES
+ declare -A NODE_LINKS
++ seq 1
+ for N in $(seq $GLOBAL_N)
+ netjail_node
+ netjail_next_namespace
+ local NUM=0
+ NAMESPACE_NUM=1
+ RESULT=0
+ local NUM=0
++ printf %06x-%08x 1650548 0
+ local NODE=192f74-00000000
+ ip netns add 192f74-00000000
+ RESULT=192f74-00000000
+ ROUTERS[$N]=192f74-00000000
+ netjail_node_link_bridge 192f74-00000000 192f74-00000000 92.68.150.1 16
+ local NODE=192f74-00000000
+ local BRIDGE=192f74-00000000
+ local ADDRESS=92.68.150.1
+ local MASK=16
+ netjail_next_interface
+ local NUM=1
+ INTERFACE_NUM=2
+ RESULT=1
+ local NUM_IF=1
+ netjail_next_interface
+ local NUM=2
+ INTERFACE_NUM=3
+ RESULT=2
+ local NUM_BR=2
++ printf %06x-%08x 1650548 1
+ local LINK_IF=192f74-00000001
++ printf %06x-%08x 1650548 2
+ local LINK_BR=192f74-00000002
+ ip link add 192f74-00000001 type veth peer name 192f74-00000002
+ ip link set 192f74-00000001 netns 192f74-00000000
+ ip link set 192f74-00000002 master 192f74-00000000
+ ip -n 192f74-00000000 addr add 92.68.150.1/16 broadcast + dev 192f74-00000001
+ ip -n 192f74-00000000 link set 192f74-00000001 up
+ ip -n 192f74-00000000 link set up dev lo
+ ip link set 192f74-00000002 up
+ RESULT=192f74-00000002
+ NETWORK_LINKS[$N]=192f74-00000002
+ netjail_bridge
+ netjail_next_interface
+ local NUM=3
+ INTERFACE_NUM=4
+ RESULT=3
+ local NUM=3
++ printf %06x-%08x 1650548 3
+ local BRIDGE=192f74-00000003
+ ip link add 192f74-00000003 type bridge
+ ip link set dev 192f74-00000003 up
+ RESULT=192f74-00000003
+ ROUTER_NETS[$N]=192f74-00000003
++ seq 2
+ for M in $(seq $LOCAL_M)
+ netjail_node
+ netjail_next_namespace
+ local NUM=1
+ NAMESPACE_NUM=2
+ RESULT=1
+ local NUM=1
++ printf %06x-%08x 1650548 1
+ local NODE=192f74-00000001
+ ip netns add 192f74-00000001
+ RESULT=192f74-00000001
+ NODES[$N,$M]=192f74-00000001
+ netjail_node_link_bridge 192f74-00000001 192f74-00000003 192.168.15.1 24
+ local NODE=192f74-00000001
+ local BRIDGE=192f74-00000003
+ local ADDRESS=192.168.15.1
+ local MASK=24
+ netjail_next_interface
+ local NUM=4
+ INTERFACE_NUM=5
+ RESULT=4
+ local NUM_IF=4
+ netjail_next_interface
+ local NUM=5
+ INTERFACE_NUM=6
+ RESULT=5
+ local NUM_BR=5
++ printf %06x-%08x 1650548 4
+ local LINK_IF=192f74-00000004
++ printf %06x-%08x 1650548 5
+ local LINK_BR=192f74-00000005
+ ip link add 192f74-00000004 type veth peer name 192f74-00000005
+ ip link set 192f74-00000004 netns 192f74-00000001
+ ip link set 192f74-00000005 master 192f74-00000003
+ ip -n 192f74-00000001 addr add 192.168.15.1/24 broadcast + dev 192f74-00000004
+ ip -n 192f74-00000001 link set 192f74-00000004 up
+ ip -n 192f74-00000001 link set up dev lo
+ ip link set 192f74-00000005 up
+ RESULT=192f74-00000005
+ NODE_LINKS[$N,$M]=192f74-00000005
+ for M in $(seq $LOCAL_M)
+ netjail_node
+ netjail_next_namespace
+ local NUM=2
+ NAMESPACE_NUM=3
+ RESULT=2
+ local NUM=2
++ printf %06x-%08x 1650548 2
+ local NODE=192f74-00000002
+ ip netns add 192f74-00000002
+ RESULT=192f74-00000002
+ NODES[$N,$M]=192f74-00000002
+ netjail_node_link_bridge 192f74-00000002 192f74-00000003 192.168.15.2 24
+ local NODE=192f74-00000002
+ local BRIDGE=192f74-00000003
+ local ADDRESS=192.168.15.2
+ local MASK=24
+ netjail_next_interface
+ local NUM=6
+ INTERFACE_NUM=7
+ RESULT=6
+ local NUM_IF=6
+ netjail_next_interface
+ local NUM=7
+ INTERFACE_NUM=8
+ RESULT=7
+ local NUM_BR=7
++ printf %06x-%08x 1650548 6
+ local LINK_IF=192f74-00000006
++ printf %06x-%08x 1650548 7
+ local LINK_BR=192f74-00000007
+ ip link add 192f74-00000006 type veth peer name 192f74-00000007
+ ip link set 192f74-00000006 netns 192f74-00000002
+ ip link set 192f74-00000007 master 192f74-00000003
+ ip -n 192f74-00000002 addr add 192.168.15.2/24 broadcast + dev 192f74-00000006
+ ip -n 192f74-00000002 link set 192f74-00000006 up
+ ip -n 192f74-00000002 link set up dev lo
+ ip link set 192f74-00000007 up
+ RESULT=192f74-00000007
+ NODE_LINKS[$N,$M]=192f74-00000007
+ ROUTER_ADDR=192.168.15.3
+ netjail_node_link_bridge 192f74-00000000 192f74-00000003 192.168.15.3 24
+ local NODE=192f74-00000000
+ local BRIDGE=192f74-00000003
+ local ADDRESS=192.168.15.3
+ local MASK=24
+ netjail_next_interface
+ local NUM=8
+ INTERFACE_NUM=9
+ RESULT=8
+ local NUM_IF=8
+ netjail_next_interface
+ local NUM=9
+ INTERFACE_NUM=10
+ RESULT=9
+ local NUM_BR=9
++ printf %06x-%08x 1650548 8
+ local LINK_IF=192f74-00000008
++ printf %06x-%08x 1650548 9
+ local LINK_BR=192f74-00000009
+ ip link add 192f74-00000008 type veth peer name 192f74-00000009
+ ip link set 192f74-00000008 netns 192f74-00000000
+ ip link set 192f74-00000009 master 192f74-00000003
+ ip -n 192f74-00000000 addr add 192.168.15.3/24 broadcast + dev 192f74-00000008
+ ip -n 192f74-00000000 link set 192f74-00000008 up
+ ip -n 192f74-00000000 link set up dev lo
+ ip link set 192f74-00000009 up
+ RESULT=192f74-00000009
+ ROUTER_LINKS[$N]=192f74-00000009
+ netjail_node_add_nat 192f74-00000000 192.168.15.3 24
+ local NODE=192f74-00000000
+ local ADDRESS=192.168.15.3
+ local MASK=24
+ ip netns exec 192f74-00000000 nft add table nat
+ ip netns exec 192f74-00000000 nft add chain nat postrouting '{' type nat hook postrouting priority 0 ';' '}'
+ ip netns exec 192f74-00000000 nft add rule ip nat postrouting ip saddr 192.168.15.3/24 counter masquerade
++ seq 2
+ for M in $(seq $LOCAL_M)
+ netjail_node_add_default 192f74-00000001 192.168.15.3
+ local NODE=192f74-00000001
+ local ADDRESS=192.168.15.3
+ ip -n 192f74-00000001 route add default via 192.168.15.3
+ for M in $(seq $LOCAL_M)
+ netjail_node_add_default 192f74-00000002 192.168.15.3
+ local NODE=192f74-00000002
+ local ADDRESS=192.168.15.3
+ ip -n 192f74-00000002 route add default via 192.168.15.3
+ '[' 1 == 0 ']'
+ '[' 1 == 0 ']'
2022-03-07T09:33:41.810307+0100 test-netjail-1650548 INFO Running command `netjail-start-testbed'
+ export PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ M=1
+ N=1
+ NODE='192f74-00000001
'
+ netjail_node_exec_without_fds_and_sudo 192f74-00000001 /home/schanzen/lib//gnunet/libexec/gnunet-cmds-helper 1 2 1 1 1 test_transport_simple_send_topo.conf
+ NODE=192f74-00000001
+ shift 1
+ ip netns exec 192f74-00000001 /home/schanzen/lib//gnunet/libexec/gnunet-cmds-helper 1 2 1 1 1 test_transport_simple_send_topo.conf
+ export PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ M=2
+ N=1
+ NODE='192f74-00000002
'
+ netjail_node_exec_without_fds_and_sudo 192f74-00000002 /home/schanzen/lib//gnunet/libexec/gnunet-cmds-helper 1 2 2 1 1 test_transport_simple_send_topo.conf
+ NODE=192f74-00000002
+ shift 1
+ ip netns exec 192f74-00000002 /home/schanzen/lib//gnunet/libexec/gnunet-cmds-helper 1 2 2 1 1 test_transport_simple_send_topo.conf
2022-03-07T09:33:41.823992+0100 simple-send-1650734 ERROR subnet node n: 1
2022-03-07T09:33:41.824194+0100 simple-send-1650734 INFO Running command `system-create'
2022-03-07T09:33:41.824294+0100 simple-send-1650734 INFO Running command `start-peer'
2022-03-07T09:33:41.824357+0100 simple-send-1650735 ERROR subnet node n: 1
2022-03-07T09:33:41.824532+0100 simple-send-1650735 INFO Running command `system-create'
2022-03-07T09:33:41.824606+0100 simple-send-1650735 INFO Running command `start-peer'
2022-03-07T09:33:41.841821+0100 transport-1650740 DEBUG Starting udp communicator
2022-03-07T09:33:41.841907+0100 transport-1650741 DEBUG Starting udp communicator
2022-03-07T09:33:41.842006+0100 transport-1650742 DEBUG Starting tcp communicator
2022-03-07T09:33:41.842032+0100 transport-1650743 DEBUG Starting tcp communicator
2022-03-07T09:33:41.844386+0100 transport-1650740 DEBUG Bound to `192.168.15.1:60002'
2022-03-07T09:33:41.844665+0100 transport-1650741 DEBUG Bound to `192.168.15.2:60002'
2022-03-07T09:33:41.848184+0100 nat-1650747 ERROR UPnP enabled in configuration, but UPnP client `upnpc` command not found, disabling UPnP
2022-03-07T09:33:41.848443+0100 nat-1650746 ERROR UPnP enabled in configuration, but UPnP client `upnpc` command not found, disabling UPnP
2022-03-07T09:33:41.848988+0100 simple-send-1650735 INFO Running command `send-peer-ready'
2022-03-07T09:33:41.849012+0100 simple-send-1650735 INFO Running command `block'
2022-03-07T09:33:41.849218+0100 simple-send-1650734 INFO Running command `send-peer-ready'
2022-03-07T09:33:41.849241+0100 simple-send-1650734 INFO Running command `block'
2022-03-07T09:33:41.849276+0100 simple-send-1650735 INFO Running command `connect-peers'
2022-03-07T09:33:41.849278+0100 simple-send-1650734 INFO Running command `connect-peers'
2022-03-07T09:33:41.849639+0100 transport-1650743 DEBUG Connecting to tcp-192.168.15.1:60002
2022-03-07T09:33:41.849650+0100 transport-1650742 DEBUG Connecting to tcp-192.168.15.2:60002
2022-03-07T09:33:41.850067+0100 transport-1650742 DEBUG handshake written
2022-03-07T09:33:41.850069+0100 transport-1650743 DEBUG handshake written
2022-03-07T09:33:41.850138+0100 transport-1650743 DEBUG Received 168 bytes for KX
2022-03-07T09:33:41.850143+0100 transport-1650742 DEBUG Received 168 bytes for KX
2022-03-07T09:33:41.850546+0100 transport-1650743 DEBUG handshake written
2022-03-07T09:33:41.850599+0100 transport-1650742 DEBUG handshake written
2022-03-07T09:33:41.850636+0100 transport-1650742 DEBUG Received 168 bytes for KX
2022-03-07T09:33:41.850650+0100 transport-1650743 DEBUG Received 168 bytes for KX
2022-03-07T09:33:41.850821+0100 transport-1650743 DEBUG sending challenge
2022-03-07T09:33:41.850823+0100 transport-1650742 DEBUG sending challenge
2022-03-07T09:33:41.850879+0100 transport-1650743 DEBUG sending challenge done
2022-03-07T09:33:41.850894+0100 transport-1650743 DEBUG Received 18446744073709551615 bytes from TCP queue
2022-03-07T09:33:41.850893+0100 transport-1650742 DEBUG sending challenge done
2022-03-07T09:33:41.850911+0100 transport-1650742 DEBUG Received 18446744073709551615 bytes from TCP queue
2022-03-07T09:33:41.850937+0100 transport-1650743 DEBUG Received 140 bytes from TCP queue
2022-03-07T09:33:41.850939+0100 transport-1650742 DEBUG Received 140 bytes from TCP queue
2022-03-07T09:33:41.851016+0100 transport-1650743 DEBUG sending challenge
2022-03-07T09:33:41.851026+0100 transport-1650742 DEBUG sending challenge
2022-03-07T09:33:41.851071+0100 transport-1650743 DEBUG sending challenge done
2022-03-07T09:33:41.851098+0100 transport-1650742 DEBUG sending challenge done
2022-03-07T09:33:41.851233+0100 transport-1650742 DEBUG Received 140 bytes from TCP queue
2022-03-07T09:33:41.851250+0100 transport-1650743 DEBUG Received 140 bytes from TCP queue
2022-03-07T09:33:41.851378+0100 transport-1650742 DEBUG Received 188 bytes from TCP queue
2022-03-07T09:33:41.851419+0100 transport-1650742 DEBUG Received 84 bytes from TCP queue
2022-03-07T09:33:41.851424+0100 transport-1650743 DEBUG Received 188 bytes from TCP queue
2022-03-07T09:33:41.851467+0100 transport-1650743 DEBUG Received 84 bytes from TCP queue
2022-03-07T09:33:41.851619+0100 transport-1650743 DEBUG Received 156 bytes from TCP queue
2022-03-07T09:33:41.851698+0100 transport-1650742 DEBUG Received 156 bytes from TCP queue
2022-03-07T09:33:41.851784+0100 transport-1650742 DEBUG Received 76 bytes from TCP queue
2022-03-07T09:33:41.851857+0100 simple-send-1650735 INFO Running command `send-simple'
2022-03-07T09:33:41.851894+0100 simple-send-1650735 INFO Running command `block-receive'
2022-03-07T09:33:41.851934+0100 transport-1650743 DEBUG Received 152 bytes from TCP queue
2022-03-07T09:33:41.851940+0100 simple-send-1650734 INFO Running command `send-simple'
2022-03-07T09:33:41.851976+0100 simple-send-1650734 INFO Running command `block-receive'
2022-03-07T09:33:41.851984+0100 transport-1650742 DEBUG Received 76 bytes from TCP queue
2022-03-07T09:33:41.852026+0100 transport-1650742 DEBUG Received 76 bytes from TCP queue
2022-03-07T09:33:41.852065+0100 transport-1650742 DEBUG Received 1036 bytes from TCP queue
2022-03-07T09:33:41.852097+0100 transport-1650742 DEBUG Received 76 bytes from TCP queue
2022-03-07T09:33:41.852118+0100 simple-send-1650734 INFO Running command `local-test-prepared'
2022-03-07T09:33:41.852124+0100 transport-1650742 DEBUG Received 84 bytes from TCP queue
2022-03-07T09:33:41.852172+0100 transport-1650743 DEBUG Received 1036 bytes from TCP queue
2022-03-07T09:33:41.852200+0100 transport-1650743 DEBUG Received 76 bytes from TCP queue
2022-03-07T09:33:41.852217+0100 transport-1650743 DEBUG Received 152 bytes from TCP queue
2022-03-07T09:33:41.852258+0100 simple-send-1650735 INFO Running command `local-test-prepared'
2022-03-07T09:33:41.852269+0100 transport-1650742 DEBUG Received 76 bytes from TCP queue
2022-03-07T09:33:41.852269+0100 transport-1650743 DEBUG Received 156 bytes from TCP queue
2022-03-07T09:33:41.852300+0100 simple-send-1650735 INFO Running command `stop-peer'
2022-03-07T09:33:41.852320+0100 transport-1650742 DEBUG Received 76 bytes from TCP queue
2022-03-07T09:33:41.852432+0100 transport-1650743 DEBUG Received 152 bytes from TCP queue
2022-03-07T09:33:41.852438+0100 simple-send-1650734 INFO Running command `stop-peer'
* Lost NATed local address 192.168.15.2, stopping NAT server
2022-03-07T09:33:41.852689+0100 gnunet-communicator-udp-1650741 ERROR Assertion failed at transport_api2_communication.c:864.
2022-03-07T09:33:41.852643+0100 transport-1650745 ERROR client still connected: 3
2022-03-07T09:33:41.852724+0100 transport-1650745 ERROR client still connected: 0
2022-03-07T09:33:41.852735+0100 transport-1650745 ERROR client still connected: 3
2022-03-07T09:33:41.852870+0100 gnunet-communicator-udp-1650740 ERROR Assertion failed at transport_api2_communication.c:864.
2022-03-07T09:33:41.852844+0100 transport-1650744 ERROR client still connected: 3
2022-03-07T09:33:41.852925+0100 transport-1650744 ERROR client still connected: 0
2022-03-07T09:33:41.852936+0100 transport-1650744 ERROR client still connected: 3
2022-03-07T09:33:41.852987+0100 transport-1650742 DEBUG Received 0 bytes from TCP queue
2022-03-07T09:33:41.853005+0100 transport-1650742 DEBUG Received 76 bytes from TCP queue
2022-03-07T09:33:41.853043+0100 transport-1650742 DEBUG Received 0 bytes from TCP queue
2022-03-07T09:33:41.853068+0100 transport-1650742 DEBUG Received 0 bytes from TCP queue
* Lost NATed local address 192.168.15.1, stopping NAT server
2022-03-07T09:33:41.923244+0100 transport-1650745 ERROR Our last client disconnected
2022-03-07T09:33:41.925387+0100 simple-send-1650735 INFO Running command `system-destroy'
2022-03-07T09:33:41.925783+0100 simple-send-1650735 INFO Interpreter finishes at `END' with status 1
2022-03-07T09:33:41.926526+0100 transport-1650744 ERROR Our last client disconnected
2022-03-07T09:33:41.928368+0100 simple-send-1650734 INFO Running command `system-destroy'
2022-03-07T09:33:41.928653+0100 simple-send-1650734 INFO Interpreter finishes at `END' with status 1
2022-03-07T09:33:41.928824+0100 test-netjail-1650548 INFO Running command `stop-testbed'
2022-03-07T09:33:41.931266+0100 test-netjail-1650548 INFO Running command `netjail-stop'
2022-03-07T09:33:41.931810+0100 test-netjail-1650548 INFO Trying to start child management.
+ export PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
+ filename=test_transport_simple_send_topo.conf
+ PREFIX=1650548
+ readfile=1
+ '[' 1 -eq 0 ']'
+ read_topology test_transport_simple_send_topo.conf
+ local filename=test_transport_simple_send_topo.conf
+ read line
+ parse_line M:2
+ line=M:2
+ echo M:2
++ cut -c -1
+ key=M
+ '[' M = M ']'
++ cut -d : -f 2
+ LOCAL_M=2
+ echo 2
+ read line
+ parse_line N:1
+ line=N:1
+ echo N:1
++ cut -c -1
+ key=N
+ '[' N = M ']'
+ '[' N = N ']'
++ cut -d : -f 2
+ GLOBAL_N=1
+ echo 1
+ (( i=1 ))
+ (( i<=1 ))
+ R_TCP[$i]=0
+ R_UDP[$i]=0
+ (( i++ ))
+ (( i<=1 ))
+ read line
+ parse_line X:0
+ line=X:0
+ echo X:0
++ cut -c -1
+ key=X
+ '[' X = M ']'
+ '[' X = N ']'
+ '[' X = X ']'
++ cut -d : -f 2
+ KNOWN=0
+ echo 0
+ read line
+ parse_line T:libgnunet_test_transport_plugin_cmd_simple_send
+ line=T:libgnunet_test_transport_plugin_cmd_simple_send
+ echo T:libgnunet_test_transport_plugin_cmd_simple_send
++ cut -c -1
+ key=T
+ '[' T = M ']'
+ '[' T = N ']'
+ '[' T = X ']'
+ '[' T = T ']'
++ cut -d : -f 2
+ PLUGIN=libgnunet_test_transport_plugin_cmd_simple_send
+ echo libgnunet_test_transport_plugin_cmd_simple_send
+ read line
+ parse_line 'P:1:1|{connect:{P:1:2:tcp}}'
+ line='P:1:1|{connect:{P:1:2:tcp}}'
+ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ cut -c -1
+ key=P
+ '[' P = M ']'
+ '[' P = N ']'
+ '[' P = X ']'
+ '[' P = T ']'
+ '[' P = B ']'
+ '[' P = K ']'
+ '[' P = R ']'
+ '[' P = P ']'
+ echo node
+ extract_attributes P 'P:1:1|{connect:{P:1:2:tcp}}'
+ line_key=P
+ line='P:1:1|{connect:{P:1:2:tcp}}'
+ '[' P = P ']'
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ cut -d '|' -f 1
++ awk -F: '{print $2}'
+ n=1
+ echo 1
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ cut -d '|' -f 1
++ awk -F: '{print $3}'
+ m=1
+ echo 1
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -F: '{print NF}'
+ nf=7
+ (( i=2 ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=2 '-F|' '{print $i}'
+ entry='{connect:{P:1:2:tcp}}'
++ echo '{connect:{P:1:2:tcp}}'
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=connect
++ echo '{connect:{P:1:2:tcp}}'
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' connect = tcp_port ']'
+ '[' connect = udp_port ']'
+ '[' connect = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=3 '-F|' '{print $i}'
+ entry=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' '' = tcp_port ']'
+ '[' '' = udp_port ']'
+ '[' '' = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=4 '-F|' '{print $i}'
+ entry=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' '' = tcp_port ']'
+ '[' '' = udp_port ']'
+ '[' '' = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=5 '-F|' '{print $i}'
+ entry=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' '' = tcp_port ']'
+ '[' '' = udp_port ']'
+ '[' '' = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=6 '-F|' '{print $i}'
+ entry=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' '' = tcp_port ']'
+ '[' '' = udp_port ']'
+ '[' '' = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
++ echo 'P:1:1|{connect:{P:1:2:tcp}}'
++ awk -v i=7 '-F|' '{print $i}'
+ entry=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 1
+ key=
++ echo
++ cut -d '{' -f 2
++ cut -d '}' -f 1
++ cut -d : -f 2
+ value=
+ '[' '' = tcp_port ']'
+ '[' '' = udp_port ']'
+ '[' '' = plugin ']'
+ (( i++ ))
+ (( i<=7 ))
+ read line
+ declare -A NODES
+ declare -A NODE_LINKS
+ netjail_bridge_name
+ netjail_next_interface
+ local NUM=0
+ INTERFACE_NUM=1
+ RESULT=0
+ local NUM=0
++ printf %06x-%08x 1650548 0
+ local BRIDGE=192f74-00000000
+ RESULT=192f74-00000000
+ NETWORK_NET=192f74-00000000
++ seq 0
++ seq 1
+ for N in $(seq $GLOBAL_N)
+ netjail_node_name
+ netjail_next_namespace
+ local NUM=0
+ NAMESPACE_NUM=1
+ RESULT=0
+ local NUM=0
++ printf %06x-%08x 1650548 0
+ local NODE=192f74-00000000
+ RESULT=192f74-00000000
+ ROUTERS[$N]=192f74-00000000
+ netjail_node_link_bridge_name
+ netjail_next_interface
+ local NUM=1
+ INTERFACE_NUM=2
+ RESULT=1
+ netjail_next_interface
+ local NUM=2
+ INTERFACE_NUM=3
+ RESULT=2
+ local NUM_BR=2
++ printf %06x-%08x 1650548 2
+ local LINK_BR=192f74-00000002
+ RESULT=192f74-00000002
+ NETWORK_LINKS[$N]=192f74-00000002
+ netjail_bridge_name
+ netjail_next_interface
+ local NUM=3
+ INTERFACE_NUM=4
+ RESULT=3
+ local NUM=3
++ printf %06x-%08x 1650548 3
+ local BRIDGE=192f74-00000003
+ RESULT=192f74-00000003
+ ROUTER_NETS[$N]=192f74-00000003
+ netjail_node_link_bridge_name
+ netjail_next_interface
+ local NUM=4
+ INTERFACE_NUM=5
+ RESULT=4
+ netjail_next_interface
+ local NUM=5
+ INTERFACE_NUM=6
+ RESULT=5
+ local NUM_BR=5
++ printf %06x-%08x 1650548 5
+ local LINK_BR=192f74-00000005
+ RESULT=192f74-00000005
+ ROUTER_LINKS[$N]=192f74-00000005
+ netjail_node_unlink_bridge 192f74-00000005
+ local LINK_BR=192f74-00000005
+ ip link delete 192f74-00000005
++ seq 2
+ for M in $(seq $LOCAL_M)
+ netjail_node_name
+ netjail_next_namespace
+ local NUM=1
+ NAMESPACE_NUM=2
+ RESULT=1
+ local NUM=1
++ printf %06x-%08x 1650548 1
+ local NODE=192f74-00000001
+ RESULT=192f74-00000001
+ NODES[$N,$M]=192f74-00000001
+ netjail_node_link_bridge_name
+ netjail_next_interface
+ local NUM=6
+ INTERFACE_NUM=7
+ RESULT=6
+ netjail_next_interface
+ local NUM=7
+ INTERFACE_NUM=8
+ RESULT=7
+ local NUM_BR=7
++ printf %06x-%08x 1650548 7
+ local LINK_BR=192f74-00000007
+ RESULT=192f74-00000007
+ NODE_LINKS[$N,$M]=192f74-00000007
+ netjail_node_unlink_bridge 192f74-00000007
+ local LINK_BR=192f74-00000007
+ ip link delete 192f74-00000007
+ netjail_node_clear 192f74-00000001
+ local NODE=192f74-00000001
+ ip netns delete 192f74-00000001
+ for M in $(seq $LOCAL_M)
+ netjail_node_name
+ netjail_next_namespace
+ local NUM=2
+ NAMESPACE_NUM=3
+ RESULT=2
+ local NUM=2
++ printf %06x-%08x 1650548 2
+ local NODE=192f74-00000002
+ RESULT=192f74-00000002
+ NODES[$N,$M]=192f74-00000002
+ netjail_node_link_bridge_name
+ netjail_next_interface
+ local NUM=8
+ INTERFACE_NUM=9
+ RESULT=8
+ netjail_next_interface
+ local NUM=9
+ INTERFACE_NUM=10
+ RESULT=9
+ local NUM_BR=9
++ printf %06x-%08x 1650548 9
+ local LINK_BR=192f74-00000009
+ RESULT=192f74-00000009
+ NODE_LINKS[$N,$M]=192f74-00000009
+ netjail_node_unlink_bridge 192f74-00000009
+ local LINK_BR=192f74-00000009
+ ip link delete 192f74-00000009
+ netjail_node_clear 192f74-00000002
+ local NODE=192f74-00000002
+ ip netns delete 192f74-00000002
+ netjail_bridge_clear 192f74-00000003
+ local BRIDGE=192f74-00000003
+ ip link delete 192f74-00000003
+ netjail_node_unlink_bridge 192f74-00000002
+ local LINK_BR=192f74-00000002
+ ip link delete 192f74-00000002
+ netjail_node_clear 192f74-00000000
+ local NODE=192f74-00000000
+ ip netns delete 192f74-00000000
+ netjail_bridge_clear 192f74-00000000
+ local BRIDGE=192f74-00000000
+ ip link delete 192f74-00000000
+ echo Done
2022-03-07T09:33:42.183789+0100 test-netjail-1650548 INFO Interpreter finishes at `END' with status 1
2022-03-07T09:33:42.183852+0100 test-netjail-1650548 INFO Test exits with status 1