cetic / 6lbr

A deployment-ready 6LoWPAN Border Router solution based on Contiki
github.com/cetic/6lbr/wiki
Other
337 stars 194 forks source link

no communication 6lbr <-> 6lbr-demo with default configurations #145

Closed tiagodiogo closed 8 years ago

tiagodiogo commented 8 years ago

hello all, i'm currently having issues while trying to communicate between the border router and the network nodes. in order to facilitate the exposure of my situation, i will start by doing and overview of my setup and what i have already working, folllowing with an explanation of my problem and some attemps to understand what is going on.

the following image shows an overview of my setup. the border router, slip-radio and coap client (6lbr-demo) have been built from the 6lbr develop branch. the coap client is firefox browser with the copper plugin the border router is a raspberry pi the slip radio and coap server are zolertia remotes

drawing2

so far i believe i have managed to setup the 6lbr. my linux client network interfaces are properly configured:

2016-03-26-124422_1920x1080_scrot

i can access the web interface both from the border router and the linux client as seen in the following picture:

2016-03-27-194024_1920x1080_scrot

and my nvm.dat file looks like this:

Reading nvm file '/etc/6lbr/nvm.dat'
Channel : 26
PAN ID : abcd

WSN network prefix : aaaa::
WSN network prefix length : 64
WSN IP address : aaaa::100
WSN accept RA : True
WSN IP address autoconf : True
WSN 6LoWPAN context 0 : aaaa::
DNS server : ::

Eth network prefix : bbbb::
Eth network prefix length : 64
Eth IP address : bbbb::100
Eth default router : ::
Eth IP address autoconf : False

RA daemon : True
RA router lifetime : 0
RA maximum interval : 600
RA minimum interval : 200
RA minimum delay : 3
RA PIO enabled : True
RA prefix valid lifetime : 86400
RA prefix preferred lifetime : 14400
RA RIO enabled : True
RA RIO lifetime : 1800

RPL instance ID : 30
RPL DODAG ID manual : False
RPL DODAG ID : ::
RPL DODAG ID global : True
RPL Preference : 0
RPL version ID :  : 10
RPL DIO interval doubling : 8
RPL DIO minimum interval : 12
RPL DIO redundancy : 10
RPL default lifetime : 30
RPL maximum rank increase : 1792
RPL minimum rank increment : 256
RPL lifetime unit : 256

MAC layer : 1
Security layer : 0
Security level : 6
Security key : 0:1:2:3:4:5:6:7:8:9:a:b:c:d:e:f
Noncoresec anti-replay disabled : False
Noncoresec anti-replay workaround : False
Filter unknown nodes : False

NAT 64 Enabled : False
NAT 64 DHCP Enabled : False
NAT 64 static port mapping Enabled : False
NAT 64 RFC-6052 prefix : False
NAT 64 address : 172.16.0.2
NAT 64 netmask : 255.255.255.0
NAT 64 gateway : 172.16.0.1

Local address rewrite : True
Smart Multi BR : False
Webserver configuration page disabled : False
Webserver port : 80

the 6lbr recognizes what i believe is the slip-radio, as reachable:

2016-03-26-124513_1920x1080_scrot

but then... my node running the 6lbr-demo is never added to the list of neighbours nor is a route established towards him.

"maybe it's a hardware issue?"

i don't believe so, because if i switch the firmware of the network node with the er-rest-example coap server, the device is added and a route is established as seen in this picture:

2016-03-27-193503_1920x1080_scrot

but although a route is added, i cannot access the coap server resources:

2016-03-27-193643_1920x1080_scrot

and the node itself does not seem fully configured:

2016-03-27-193512_1920x1080_scrot

so my questions at this point are:

should not this setup be working? the border-router, slip-radio and 6lbr-demo (coap server) are all built from the 6lbr-develop branch.

what can be the cause of this lack of connectivity? i don't know what else to do at this point

if it helps, here is the 6lbr.log file (the one using the 6lbr-demo as coap server, which was not added to the list of 6lbr neighbours) with a level 5 debug:

********************************************************************************
Sun 27 Mar 21:21:46 UTC 2016 : Starting 6LBR
/usr/lib/6lbr/bin/cetic_6lbr_router -c /etc/6lbr/nvm.dat -o /etc/6lbr/nvm.conf -s /dev/ttyUSB0 -R -t tap0 -B 115200 -U /usr/lib/6lbr/6lbr-ifup -D /usr/lib/6lbr/6lbr-ifdown -w /usr/lib/6lbr/www -L 5  -W /var/log/6lbr.timestamp -P 60 -C /var/log/6lbr.ip  -m /usr/lib/6lbr/plugins   
Contiki-develop-20150825-215-g80e6eca started with IPV6, RPL
Rime started with address 1.2.3.4.5.6.7.8
MAC mac_wrapper RDC br-rdc SEC llsec-wrapper NETWORK sicslowpan
2016-03-27 21:21:46.967127: INFO: 6LBR: Starting 6LBR version 1.4.x (Contiki-develop-20150825-215-g80e6eca)
Log level : 50
Log services : ffffffff
2016-03-27 21:21:46.968242: INFO: ETH: 6LBR watchdog started (interval: 60)
2016-03-27 21:21:46.968662: DEBUG: NVM: Opening nvm file '/etc/6lbr/nvm.dat'
2016-03-27 21:21:46.968841: INFO: NVM: NVM Magic : 2009
2016-03-27 21:21:46.968877: INFO: NVM: NVM Version : 5
2016-03-27 21:21:46.969242: INFO: CONFIG: Loading configuration : /etc/6lbr/nvm.conf
2016-03-27 21:21:46.969427: WARN: CONFIG: Can not open /etc/6lbr/nvm.conf : No such file or directory
2016-03-27 21:21:46.969524: INFO: MAC: Using 'csma' mac driver
2016-03-27 21:21:46.976568: INFO: SLIP: SLIP started on /dev/ttyUSB0
2016-03-27 21:21:46.996624: INFO: SCMD: Started br-cmd process
2016-03-27 21:21:46.996843: INFO: BR-RDC: Reset SLIP Radio
2016-03-27 21:21:46.996935: PACKET: SLIP: write: 2
2016-03-27 21:21:46.997028: INFO: BR-RDC: Fetching MAC address
2016-03-27 21:21:46.997104: PACKET: SLIP: write: 2
2016-03-27 21:21:47.997137: INFO: BR-RDC: Fetching MAC address
2016-03-27 21:21:47.997554: PACKET: SLIP: write: 2
2016-03-27 21:21:48.070105: PACKET: SLIP: read: 37
2016-03-27 21:21:48.070756: INFO: SLIP: Contiki-develop-20160323-2-g8fe6b2c
2016-03-27 21:21:48.071101: PACKET: SLIP: read: 27
2016-03-27 21:21:48.071345: INFO: SLIP: Zolertia Re-Mote platform
2016-03-27 21:21:48.071523: PACKET: SLIP: read: 15
2016-03-27 21:21:48.071703: INFO: SLIP:  Net: slipnet
2016-03-27 21:21:48.071880: PACKET: SLIP: read: 15
2016-03-27 21:21:48.072060: INFO: SLIP:  MAC: nullmac
2016-03-27 21:21:48.072318: PACKET: SLIP: read: 15
2016-03-27 21:21:48.072549: INFO: SLIP:  RDC: nullrdc
2016-03-27 21:21:48.072742: PACKET: SLIP: read: 54
2016-03-27 21:21:48.072920: INFO: SLIP: Rime configured with address 00:12:4b:00:06:16:0f:5d
2016-03-27 21:21:48.073101: PACKET: SLIP: read: 23
2016-03-27 21:21:48.073280: INFO: SLIP: Slip Radio started...
2016-03-27 21:21:48.999612: INFO: BR-RDC: Fetching MAC address
2016-03-27 21:21:49.000179: PACKET: SLIP: write: 2
2016-03-27 21:21:49.002861: PACKET: SLIP: read: 10
2016-03-27 21:21:49.003896: DEBUG: SCMD: Setting MAC address
2016-03-27 21:21:49.004998: INFO: BR-RDC: Got MAC: 00:12:4b:00:06:16:0f:5d
2016-03-27 21:21:49.999227: PACKET: SLIP: write: 3
2016-03-27 21:21:50.000416: INFO: ETH: TAP Ethernet interface init
2016-03-27 21:21:50.019529: INFO: TAP: opened device /dev/tap0
2016-03-27 21:21:50.038597: INFO: TAP: Running 6lbr-ifup script '/usr/lib/6lbr/6lbr-ifup'
6lbr-ifup: Create bridge br0
6lbr-ifup: Attach device eth0 to bridge br0
6lbr-ifup: Attach device tap0 to bridge br0
br0       Link encap:Ethernet  HWaddr 02:0a:0b:0c:0d:0e  
          inet6 addr: fe80::ba27:ebff:fe47:7841/64 Scope:Link
          UP BROADCAST MULTICAST  MTU:1500  Metric:1
          RX packets:0 errors:0 dropped:0 overruns:0 frame:0
          TX packets:1 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:0 
          RX bytes:0 (0.0 B)  TX bytes:90 (90.0 B)

tap0      Link encap:Ethernet  HWaddr 02:0a:0b:0c:0d:0e  
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:0 errors:0 dropped:0 overruns:0 frame:0
          TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:500 
          RX bytes:0 (0.0 B)  TX bytes:0 (0.0 B)

2016-03-27 21:21:51.658881: INFO: ETH: Eth MAC address : 02:00:06:16:0f:5d
2016-03-27 21:21:51.661317: INFO: LLSEC: Using 'nullsec' llsec driver
2016-03-27 21:21:51.662611: INFO: 6LBR: Security layer initialized
2016-03-27 21:21:51.664346: PACKET: SLIP: read: 25
2016-03-27 21:21:51.665688: ERROR: SLIP: Unknown command 2143 (3)
2016-03-27 21:21:51.697271: PACKET: TAP: read: 90
2016-03-27 21:21:51.698679: PACKET: ETH: read: 90
2016-03-27 21:21:51.700031: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:51.701280: DEBUG: PF: No input function set
2016-03-27 21:21:51.702571: INFO: 6LBR: Tentative local IPv6 address fe80::212:4b00:616:f5d
2016-03-27 21:21:51.704508: INFO: 6LBR: Tentative global IPv6 address (WSN) aaaa::212:4b00:616:f5d
2016-03-27 21:21:51.724891: INFO: 6LBR: Tentative global IPv6 address (ETH) bbbb::100
2016-03-27 21:21:51.726661: DEBUG: RIO: Adding route information: length=64, flags=0, route lifetime=1800, dest=aaaa::
2016-03-27 21:21:51.728579: INFO: 6LBR: RA Daemon enabled
2016-03-27 21:21:51.729751: INFO: 6LBR: Checking addresses duplication
2016-03-27 21:21:51.731055: PACKET: TAP: read: 78
2016-03-27 21:21:51.732493: PACKET: ETH: read: 78
2016-03-27 21:21:51.733819: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:51.735414: PACKET: TAP: read: 90
2016-03-27 21:21:51.767533: PACKET: ETH: read: 90
2016-03-27 21:21:51.768848: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:51.770540: PACKET: TAP: read: 90
2016-03-27 21:21:51.771995: PACKET: ETH: read: 90
2016-03-27 21:21:51.773391: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:51.774745: PACKET: TAP: read: 90
2016-03-27 21:21:51.776060: PACKET: ETH: read: 90
2016-03-27 21:21:51.807711: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:52.048488: PACKET: TAP: read: 78
2016-03-27 21:21:52.050043: PACKET: ETH: read: 78
2016-03-27 21:21:52.051536: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:52.105322: PACKET: PF: bridge_output: Sending packet to Broadcast
2016-03-27 21:21:52.107020: PACKET: PF: wireless_output: sending packet
2016-03-27 21:21:52.108518: PACKET: PF: eth_output: broadcast
2016-03-27 21:21:52.109782: PACKET: PF: eth_output: Sending packet to Ethernet
2016-03-27 21:21:52.111023: PACKET: ETH: write: 78
2016-03-27 21:21:52.157075: PACKET: TAP: write: 78
2016-03-27 21:21:52.176585: PACKET: BR-RDC: write: 33 (sid: 1, cb: 1)
2016-03-27 21:21:52.178490: PACKET: SLIP: write: 64
2016-03-27 21:21:52.203854: PACKET: SLIP: read: 5
2016-03-27 21:21:52.205361: DEBUG: SCMD: Packet data report for sid:1 st:0 tx:1
2016-03-27 21:21:52.217340: PACKET: BR-RDC: sid ack: 1 (0, 1)
2016-03-27 21:21:52.218932: PACKET: TAP: read: 90
2016-03-27 21:21:52.220375: PACKET: ETH: read: 90
2016-03-27 21:21:52.221679: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:52.564788: PACKET: PF: bridge_output: Sending packet to Broadcast
2016-03-27 21:21:52.566171: PACKET: PF: wireless_output: sending packet
2016-03-27 21:21:52.567561: PACKET: PF: eth_output: broadcast
2016-03-27 21:21:52.568768: PACKET: PF: eth_output: Sending packet to Ethernet
2016-03-27 21:21:52.569951: PACKET: ETH: write: 78
2016-03-27 21:21:52.571674: PACKET: TAP: write: 78
2016-03-27 21:21:52.606547: PACKET: BR-RDC: write: 33 (sid: 2, cb: 1)
2016-03-27 21:21:52.608389: PACKET: SLIP: write: 64
2016-03-27 21:21:52.619995: PACKET: SLIP: read: 5
2016-03-27 21:21:52.621523: DEBUG: SCMD: Packet data report for sid:2 st:0 tx:1
2016-03-27 21:21:52.623048: PACKET: BR-RDC: sid ack: 2 (0, 1)
2016-03-27 21:21:52.664795: PACKET: PF: bridge_output: Sending packet to Broadcast
2016-03-27 21:21:52.666179: PACKET: PF: eth_output: broadcast
2016-03-27 21:21:52.667733: PACKET: PF: eth_output: Sending packet to Ethernet
2016-03-27 21:21:52.669050: PACKET: ETH: write: 78
2016-03-27 21:21:52.696366: PACKET: TAP: write: 78
2016-03-27 21:21:52.764774: PACKET: PF: bridge_output: Sending packet to Broadcast
2016-03-27 21:21:52.766169: PACKET: PF: wireless_output: sending packet
2016-03-27 21:21:52.767683: PACKET: PF: eth_output: broadcast
2016-03-27 21:21:52.768903: PACKET: PF: eth_output: Sending packet to Ethernet
2016-03-27 21:21:52.770150: PACKET: ETH: write: 78
2016-03-27 21:21:52.771894: PACKET: TAP: write: 78
2016-03-27 21:21:52.796504: PACKET: BR-RDC: write: 33 (sid: 3, cb: 1)
2016-03-27 21:21:52.798482: PACKET: SLIP: write: 64
2016-03-27 21:21:52.811543: PACKET: SLIP: read: 5
2016-03-27 21:21:52.813085: DEBUG: SCMD: Packet data report for sid:3 st:0 tx:1
2016-03-27 21:21:52.814519: PACKET: BR-RDC: sid ack: 3 (0, 1)
2016-03-27 21:21:53.057757: PACKET: TAP: read: 90
2016-03-27 21:21:53.059368: PACKET: ETH: read: 90
2016-03-27 21:21:53.060900: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:53.076446: PACKET: TAP: read: 90
2016-03-27 21:21:53.078044: PACKET: ETH: read: 90
2016-03-27 21:21:53.079406: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:53.175731: PACKET: TAP: read: 70
2016-03-27 21:21:53.177373: PACKET: ETH: read: 70
2016-03-27 21:21:53.178785: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:53.279615: PACKET: TAP: read: 376
2016-03-27 21:21:53.281047: PACKET: ETH: read: 376
2016-03-27 21:21:53.282495: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:53.319279: PACKET: TAP: read: 220
2016-03-27 21:21:53.320755: PACKET: ETH: read: 220
2016-03-27 21:21:53.322028: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:53.366500: PACKET: TAP: read: 373
2016-03-27 21:21:53.367979: PACKET: ETH: read: 373
2016-03-27 21:21:53.369244: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:21:53.416722: PACKET: TAP: read: 110
2016-03-27 21:21:53.418189: PACKET: ETH: read: 110
2016-03-27 21:21:53.419676: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:53.529878: PACKET: TAP: read: 376
2016-03-27 21:21:53.531609: PACKET: ETH: read: 376
2016-03-27 21:21:53.533014: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:53.587591: PACKET: TAP: read: 373
2016-03-27 21:21:53.589145: PACKET: ETH: read: 373
2016-03-27 21:21:53.590414: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:21:53.780828: PACKET: TAP: read: 376
2016-03-27 21:21:53.782357: PACKET: ETH: read: 376
2016-03-27 21:21:53.783640: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:53.982083: PACKET: TAP: read: 352
2016-03-27 21:21:53.983621: PACKET: ETH: read: 352
2016-03-27 21:21:53.984924: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:54.036893: PACKET: TAP: read: 90
2016-03-27 21:21:54.038441: PACKET: ETH: read: 90
2016-03-27 21:21:54.039812: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:54.498862: PACKET: TAP: read: 320
2016-03-27 21:21:54.505256: PACKET: ETH: read: 320
2016-03-27 21:21:54.530804: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:55.160797: PACKET: TAP: read: 241
2016-03-27 21:21:55.174991: PACKET: ETH: read: 241
2016-03-27 21:21:55.185063: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:55.207463: PACKET: TAP: read: 196
2016-03-27 21:21:55.218790: PACKET: ETH: read: 196
2016-03-27 21:21:55.235860: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:56.677486: PACKET: TAP: read: 320
2016-03-27 21:21:56.691583: PACKET: ETH: read: 320
2016-03-27 21:21:56.701723: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:57.031737: PACKET: TAP: read: 373
2016-03-27 21:21:57.033313: PACKET: ETH: read: 373
2016-03-27 21:21:57.034653: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:21:57.172987: PACKET: TAP: read: 70
2016-03-27 21:21:57.174518: PACKET: ETH: read: 70
2016-03-27 21:21:57.175822: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:57.264456: PACKET: PF: bridge_output: Sending packet to Broadcast
2016-03-27 21:21:57.265892: PACKET: PF: eth_output: broadcast
2016-03-27 21:21:57.279051: PACKET: PF: eth_output: Sending packet to Ethernet
2016-03-27 21:21:57.284983: PACKET: ETH: write: 134
2016-03-27 21:21:57.297057: PACKET: TAP: write: 134
2016-03-27 21:21:57.309538: PACKET: TAP: read: 373
2016-03-27 21:21:57.315826: PACKET: ETH: read: 373
2016-03-27 21:21:57.329993: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:21:57.339615: PACKET: TAP: read: 241
2016-03-27 21:21:57.356938: PACKET: ETH: read: 241
2016-03-27 21:21:57.363304: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:57.369621: PACKET: TAP: read: 196
2016-03-27 21:21:57.376437: PACKET: ETH: read: 196
2016-03-27 21:21:57.384262: PACKET: PF: eth_input: Processing frame
2016-03-27 21:21:58.339729: PACKET: TAP: read: 42
2016-03-27 21:21:58.341365: PACKET: ETH: read: 42
2016-03-27 21:21:58.342737: PACKET: PF: eth_input: Dropping packet type=0x0806
2016-03-27 21:21:58.582799: PACKET: TAP: read: 42
2016-03-27 21:21:58.584331: PACKET: ETH: read: 42
2016-03-27 21:21:58.585617: PACKET: PF: eth_input: Dropping packet type=0x0806
2016-03-27 21:21:59.801275: PACKET: TAP: read: 42
2016-03-27 21:21:59.815884: PACKET: ETH: read: 42
2016-03-27 21:21:59.825770: PACKET: PF: eth_input: Dropping packet type=0x0806
2016-03-27 21:22:00.401127: PACKET: TAP: read: 42
2016-03-27 21:22:00.402802: PACKET: ETH: read: 42
2016-03-27 21:22:00.404313: PACKET: PF: eth_input: Dropping packet type=0x0806
2016-03-27 21:22:00.850751: PACKET: TAP: read: 42
2016-03-27 21:22:00.866179: PACKET: ETH: read: 42
2016-03-27 21:22:00.877688: PACKET: PF: eth_input: Dropping packet type=0x0806
2016-03-27 21:22:01.173901: PACKET: TAP: read: 70
2016-03-27 21:22:01.175614: PACKET: ETH: read: 70
2016-03-27 21:22:01.189657: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:01.267139: PACKET: PF: bridge_output: Sending packet to Broadcast
2016-03-27 21:22:01.299299: PACKET: PF: eth_output: broadcast
2016-03-27 21:22:01.305371: PACKET: PF: eth_output: Sending packet to Ethernet
2016-03-27 21:22:01.312076: PACKET: ETH: write: 134
2016-03-27 21:22:01.353019: PACKET: TAP: write: 134
2016-03-27 21:22:01.473550: PACKET: TAP: read: 42
2016-03-27 21:22:01.475159: PACKET: ETH: read: 42
2016-03-27 21:22:01.489036: PACKET: PF: eth_input: Dropping packet type=0x0806
2016-03-27 21:22:02.876807: PACKET: TAP: read: 54
2016-03-27 21:22:02.892830: PACKET: ETH: read: 54
2016-03-27 21:22:02.907604: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:02.909161: PACKET: TAP: read: 342
2016-03-27 21:22:02.910699: PACKET: ETH: read: 342
2016-03-27 21:22:02.912218: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:03.090027: PACKET: TAP: read: 200
2016-03-27 21:22:03.091689: PACKET: ETH: read: 200
2016-03-27 21:22:03.093316: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:03.094819: PACKET: TAP: read: 415
2016-03-27 21:22:03.096176: PACKET: ETH: read: 415
2016-03-27 21:22:03.118774: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:03.340393: PACKET: TAP: read: 415
2016-03-27 21:22:03.342241: PACKET: ETH: read: 415
2016-03-27 21:22:03.343662: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:03.593422: PACKET: TAP: read: 415
2016-03-27 21:22:03.637695: PACKET: ETH: read: 415
2016-03-27 21:22:03.657496: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:03.733952: PACKET: TAP: read: 42
2016-03-27 21:22:03.748758: PACKET: ETH: read: 42
2016-03-27 21:22:03.759187: PACKET: PF: eth_input: Dropping packet type=0x0806
2016-03-27 21:22:03.797369: PACKET: TAP: read: 54
2016-03-27 21:22:03.808694: PACKET: ETH: read: 54
2016-03-27 21:22:03.853001: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:03.864827: PACKET: TAP: read: 54
2016-03-27 21:22:03.881701: PACKET: ETH: read: 54
2016-03-27 21:22:03.921735: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:03.936505: PACKET: TAP: read: 200
2016-03-27 21:22:03.966447: PACKET: ETH: read: 200
2016-03-27 21:22:03.997478: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:04.018022: DEBUG: NVM: Opening nvm file '/etc/6lbr/nvm.dat'
2016-03-27 21:22:04.040730: INFO: 6LBR: Configured as DODAG Root aaaa::212:4b00:616:f5d
2016-03-27 21:22:04.060014: INFO: 6LBR: Starting as RPL ROUTER
2016-03-27 21:22:04.069266: INFO: NODECFG: Node Config init
2016-03-27 21:22:04.087116: INFO: NODECFG: No node_config.conf file specified
2016-03-27 21:22:04.093504: INFO: HTTP: Starting webserver on port 80
2016-03-27 21:22:04.116563: DEBUG: HTTP: Adding group : System
2016-03-27 21:22:04.128954: DEBUG: HTTP: Adding group : Sensors
2016-03-27 21:22:04.147426: DEBUG: HTTP: Adding group : Status
2016-03-27 21:22:04.161676: DEBUG: HTTP: Adding group : Configuration
2016-03-27 21:22:04.171895: DEBUG: HTTP: Adding group : Statistics
2016-03-27 21:22:04.173547: DEBUG: HTTP: Adding group : Administration
2016-03-27 21:22:04.174970: DEBUG: HTTP: Adding page : index.html
2016-03-27 21:22:04.188962: DEBUG: HTTP: Adding page : config.html
2016-03-27 21:22:04.199946: DEBUG: HTTP: Adding page : sensors.html
2016-03-27 21:22:04.216685: DEBUG: HTTP: Adding page : sensor
2016-03-27 21:22:04.227858: DEBUG: HTTP: Adding page : sensors_tree.html
2016-03-27 21:22:04.244010: DEBUG: HTTP: Adding page : sensors_prr.html
2016-03-27 21:22:04.256207: DEBUG: HTTP: Adding page : sensors_ps.html
2016-03-27 21:22:04.267892: DEBUG: HTTP: Adding page : sensors_hc.html
2016-03-27 21:22:04.269405: DEBUG: HTTP: Adding command : reset-stats-all
2016-03-27 21:22:04.296307: DEBUG: HTTP: Adding command : reset-stats
2016-03-27 21:22:04.310496: DEBUG: HTTP: Adding command : rm-node
2016-03-27 21:22:04.321048: DEBUG: HTTP: Adding page : sensors_config.html
2016-03-27 21:22:04.340290: DEBUG: HTTP: Adding page : network.html
2016-03-27 21:22:04.350841: DEBUG: HTTP: Adding page : rpl.html
2016-03-27 21:22:04.362380: DEBUG: HTTP: Adding page : statistics.html
2016-03-27 21:22:04.364893: DEBUG: HTTP: Adding command : rpl-gr
2016-03-27 21:22:04.373666: DEBUG: HTTP: Adding command : rpl-reset
2016-03-27 21:22:04.387187: DEBUG: HTTP: Adding command : rpl-child
2016-03-27 21:22:04.406765: DEBUG: HTTP: Adding command : route-add
2016-03-27 21:22:04.416604: DEBUG: HTTP: Adding command : route-rm
2016-03-27 21:22:04.428426: DEBUG: HTTP: Adding command : nbr-rm
2016-03-27 21:22:04.444896: DEBUG: HTTP: Adding command : config
2016-03-27 21:22:04.454200: DEBUG: HTTP: Adding command : reset-config
2016-03-27 21:22:04.455572: DEBUG: HTTP: Adding page : admin.html
2016-03-27 21:22:04.477018: DEBUG: HTTP: Adding command : restart
2016-03-27 21:22:04.485415: DEBUG: HTTP: Adding command : reset-sr
2016-03-27 21:22:04.498940: DEBUG: HTTP: Adding command : reboot
2016-03-27 21:22:04.510050: DEBUG: HTTP: Adding command : halt
2016-03-27 21:22:04.528484: DEBUG: HTTP: Adding page : log
2016-03-27 21:22:04.538061: DEBUG: HTTP: Adding page : err
2016-03-27 21:22:04.548102: DEBUG: HTTP: Adding command : clear-log
2016-03-27 21:22:04.552924: DEBUG: HTTP: Adding page : plugins.html
2016-03-27 21:22:04.554460: INFO: UDPS: UDP server started
CoAP push started
CoAP server started
2016-03-27 21:22:04.566495: INFO: DNS: DNS proxy started
2016-03-27 21:22:04.579873: INFO: 6LBR: CETIC 6LBR Started
2016-03-27 21:22:04.590838: PACKET: TAP: read: 298
2016-03-27 21:22:04.608850: PACKET: ETH: read: 298
2016-03-27 21:22:04.618027: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:04.635344: PACKET: TAP: read: 385
2016-03-27 21:22:04.656428: PACKET: ETH: read: 385
2016-03-27 21:22:04.663914: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:04.677353: PACKET: TAP: read: 298
2016-03-27 21:22:04.696673: PACKET: ETH: read: 298
2016-03-27 21:22:04.700510: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:04.702242: PACKET: TAP: read: 200
2016-03-27 21:22:04.703665: PACKET: ETH: read: 200
2016-03-27 21:22:04.705068: PACKET: PF: eth_input: Dropping packet type=0x0800
RD client started
2016-03-27 21:22:04.728615: PACKET: TAP: read: 298
2016-03-27 21:22:04.735271: PACKET: ETH: read: 298
2016-03-27 21:22:04.747546: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:04.768495: PACKET: TAP: read: 274
2016-03-27 21:22:04.777999: PACKET: ETH: read: 274
2016-03-27 21:22:04.789103: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:04.801013: PACKET: TAP: read: 54
2016-03-27 21:22:04.807899: PACKET: ETH: read: 54
2016-03-27 21:22:04.819096: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:04.827083: PACKET: TAP: read: 42
2016-03-27 21:22:04.828728: PACKET: ETH: read: 42
2016-03-27 21:22:04.830160: PACKET: PF: eth_input: Dropping packet type=0x0806
2016-03-27 21:22:04.831995: PACKET: TAP: read: 373
2016-03-27 21:22:04.833598: PACKET: ETH: read: 373
2016-03-27 21:22:04.834968: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:04.854288: PACKET: TAP: read: 200
2016-03-27 21:22:04.866749: PACKET: ETH: read: 200
2016-03-27 21:22:04.875999: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:04.886454: PACKET: TAP: read: 303
2016-03-27 21:22:04.898474: PACKET: ETH: read: 303
2016-03-27 21:22:04.907361: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:04.922820: PACKET: TAP: read: 174
2016-03-27 21:22:04.928913: PACKET: ETH: read: 174
2016-03-27 21:22:04.930260: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:05.175114: PACKET: TAP: read: 70
2016-03-27 21:22:05.198839: PACKET: ETH: read: 70
2016-03-27 21:22:05.216393: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:05.264816: PACKET: PF: bridge_output: Sending packet to Broadcast
2016-03-27 21:22:05.266400: PACKET: PF: eth_output: broadcast
2016-03-27 21:22:05.267836: PACKET: PF: eth_output: Update src address
2016-03-27 21:22:05.269213: PACKET: PF: eth_output: Sending packet to Ethernet
2016-03-27 21:22:05.270553: PACKET: ETH: write: 134
2016-03-27 21:22:05.295493: PACKET: TAP: write: 134
2016-03-27 21:22:05.317918: PACKET: TAP: read: 130
2016-03-27 21:22:05.324351: PACKET: ETH: read: 130
2016-03-27 21:22:05.331076: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:05.546483: PACKET: TAP: read: 234
2016-03-27 21:22:05.548152: PACKET: ETH: read: 234
2016-03-27 21:22:05.549756: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:05.551257: PACKET: TAP: read: 105
2016-03-27 21:22:05.552750: PACKET: ETH: read: 105
2016-03-27 21:22:05.554103: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:05.631208: PACKET: TAP: read: 42
2016-03-27 21:22:05.632864: PACKET: ETH: read: 42
2016-03-27 21:22:05.634290: PACKET: PF: eth_input: Dropping packet type=0x0806
2016-03-27 21:22:05.856870: PACKET: TAP: read: 78
2016-03-27 21:22:05.858532: PACKET: ETH: read: 78
2016-03-27 21:22:05.859939: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:06.016685: PACKET: TAP: read: 130
2016-03-27 21:22:06.018333: PACKET: ETH: read: 130
2016-03-27 21:22:06.019815: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:06.196943: PACKET: TAP: read: 373
2016-03-27 21:22:06.216366: PACKET: ETH: read: 373
2016-03-27 21:22:06.233336: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:06.245998: PACKET: TAP: read: 316
2016-03-27 21:22:06.280072: PACKET: ETH: read: 316
2016-03-27 21:22:06.286611: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:06.786701: PACKET: TAP: read: 42
2016-03-27 21:22:06.788416: PACKET: ETH: read: 42
2016-03-27 21:22:06.790044: PACKET: PF: eth_input: Dropping packet type=0x0806
2016-03-27 21:22:06.867509: PACKET: TAP: read: 199
2016-03-27 21:22:06.869178: PACKET: ETH: read: 199
2016-03-27 21:22:06.870612: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:06.872011: PACKET: TAP: read: 179
2016-03-27 21:22:06.873435: PACKET: ETH: read: 179
2016-03-27 21:22:06.874864: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:06.907525: PACKET: TAP: read: 90
2016-03-27 21:22:06.927817: PACKET: ETH: read: 90
2016-03-27 21:22:06.947785: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:06.959252: PACKET: TAP: read: 189
2016-03-27 21:22:06.977147: PACKET: ETH: read: 189
2016-03-27 21:22:07.007001: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:07.013295: PACKET: TAP: read: 174
2016-03-27 21:22:07.014941: PACKET: ETH: read: 174
2016-03-27 21:22:07.017038: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:07.028400: PACKET: TAP: read: 288
2016-03-27 21:22:07.046822: PACKET: ETH: read: 288
2016-03-27 21:22:07.055924: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:07.070804: PACKET: TAP: read: 211
2016-03-27 21:22:07.081386: PACKET: ETH: read: 211
2016-03-27 21:22:07.098804: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:07.100533: PACKET: TAP: read: 191
2016-03-27 21:22:07.102335: PACKET: ETH: read: 191
2016-03-27 21:22:07.103772: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:07.105282: PACKET: TAP: read: 110
2016-03-27 21:22:07.124704: PACKET: ETH: read: 110
2016-03-27 21:22:07.143042: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:07.196820: PACKET: TAP: read: 90
2016-03-27 21:22:07.198721: PACKET: ETH: read: 90
2016-03-27 21:22:07.211294: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:07.235218: PACKET: TAP: read: 211
2016-03-27 21:22:07.237872: PACKET: ETH: read: 211
2016-03-27 21:22:07.239300: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:07.240680: PACKET: TAP: read: 191
2016-03-27 21:22:07.242072: PACKET: ETH: read: 191
2016-03-27 21:22:07.243440: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:07.447666: PACKET: PF: bridge_output: Sending packet to Broadcast
2016-03-27 21:22:07.466804: PACKET: PF: wireless_output: sending packet
2016-03-27 21:22:07.509274: PACKET: TAP: read: 211
2016-03-27 21:22:07.523946: PACKET: ETH: read: 211
2016-03-27 21:22:07.552155: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:07.575235: PACKET: BR-RDC: write: 80 (sid: 4, cb: 1)
2016-03-27 21:22:07.614432: PACKET: SLIP: write: 111
2016-03-27 21:22:07.631877: PACKET: TAP: read: 191
2016-03-27 21:22:07.686399: PACKET: ETH: read: 191
2016-03-27 21:22:07.697919: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:07.720325: PACKET: SLIP: read: 5
2016-03-27 21:22:07.730270: DEBUG: SCMD: Packet data report for sid:4 st:0 tx:1
2016-03-27 21:22:07.739034: PACKET: BR-RDC: sid ack: 4 (0, 1)
2016-03-27 21:22:07.768376: PACKET: TAP: read: 110
2016-03-27 21:22:07.775326: PACKET: ETH: read: 110
2016-03-27 21:22:07.782359: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:07.785916: PACKET: TAP: read: 106
2016-03-27 21:22:07.811490: PACKET: ETH: read: 106
2016-03-27 21:22:07.818300: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:07.824630: PACKET: TAP: read: 234
2016-03-27 21:22:07.826057: PACKET: ETH: read: 234
2016-03-27 21:22:07.846682: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:07.856899: PACKET: TAP: read: 105
2016-03-27 21:22:07.866918: PACKET: ETH: read: 105
2016-03-27 21:22:07.877486: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:07.882114: PACKET: TAP: read: 179
2016-03-27 21:22:07.883520: PACKET: ETH: read: 179
2016-03-27 21:22:07.885031: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:07.896577: PACKET: TAP: read: 199
2016-03-27 21:22:07.909721: PACKET: ETH: read: 199
2016-03-27 21:22:07.916128: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:08.759755: PACKET: TAP: read: 179
2016-03-27 21:22:08.788185: PACKET: ETH: read: 179
2016-03-27 21:22:08.794661: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:08.804886: PACKET: TAP: read: 199
2016-03-27 21:22:08.816091: PACKET: ETH: read: 199
2016-03-27 21:22:08.825095: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:10.831787: PACKET: TAP: read: 179
2016-03-27 21:22:10.845900: PACKET: ETH: read: 179
2016-03-27 21:22:10.856481: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:10.877245: PACKET: TAP: read: 199
2016-03-27 21:22:10.898099: PACKET: ETH: read: 199
2016-03-27 21:22:10.912534: PACKET: PF: eth_input: Processing frame
2016-03-27 21:22:13.875830: PACKET: PF: bridge_output: Sending packet to Broadcast
2016-03-27 21:22:13.889906: PACKET: PF: wireless_output: sending packet
2016-03-27 21:22:13.900069: PACKET: BR-RDC: write: 80 (sid: 5, cb: 1)
2016-03-27 21:22:13.919675: PACKET: SLIP: write: 111
2016-03-27 21:22:13.941265: PACKET: SLIP: read: 5
2016-03-27 21:22:13.942832: DEBUG: SCMD: Packet data report for sid:5 st:0 tx:1
2016-03-27 21:22:13.944292: PACKET: BR-RDC: sid ack: 5 (0, 1)
2016-03-27 21:22:19.327369: PACKET: TAP: read: 342
2016-03-27 21:22:19.342167: PACKET: ETH: read: 342
2016-03-27 21:22:19.353164: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:20.618512: PACKET: TAP: read: 373
2016-03-27 21:22:20.634355: PACKET: ETH: read: 373
2016-03-27 21:22:20.645803: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:22.805479: PACKET: TAP: read: 373
2016-03-27 21:22:22.820962: PACKET: ETH: read: 373
2016-03-27 21:22:22.831918: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:24.873081: PACKET: PF: bridge_output: Sending packet to Broadcast
2016-03-27 21:22:24.886950: PACKET: PF: wireless_output: sending packet
2016-03-27 21:22:24.896591: PACKET: BR-RDC: write: 80 (sid: 6, cb: 1)
2016-03-27 21:22:24.911575: PACKET: SLIP: write: 111
2016-03-27 21:22:24.933687: PACKET: SLIP: read: 5
2016-03-27 21:22:24.935195: DEBUG: SCMD: Packet data report for sid:6 st:0 tx:1
2016-03-27 21:22:24.943022: PACKET: BR-RDC: sid ack: 6 (0, 1)
2016-03-27 21:22:51.763677: PACKET: PF: bridge_output: Sending packet to Broadcast
2016-03-27 21:22:51.765452: PACKET: PF: wireless_output: sending packet
2016-03-27 21:22:51.766946: PACKET: BR-RDC: write: 80 (sid: 7, cb: 1)
2016-03-27 21:22:51.768466: PACKET: SLIP: write: 111
2016-03-27 21:22:51.785656: PACKET: SLIP: read: 5
2016-03-27 21:22:51.787505: DEBUG: SCMD: Packet data report for sid:7 st:0 tx:1
2016-03-27 21:22:51.788859: PACKET: BR-RDC: sid ack: 7 (0, 1)
2016-03-27 21:22:51.927540: PACKET: TAP: read: 373
2016-03-27 21:22:51.929024: PACKET: ETH: read: 373
2016-03-27 21:22:51.930401: PACKET: PF: eth_input: Dropping packet type=0x0800
2016-03-27 21:22:55.250722: PACKET: TAP: read: 373
2016-03-27 21:22:55.252332: PACKET: ETH: read: 373
2016-03-27 21:22:55.253749: PACKET: PF: eth_input: Dropping packet type=0x0800
msolters commented 8 years ago

You're not seeing any wireless_input lines in your /var/log/6lbr.log. In my experience, that means your SLIP radio is not actually receiving any traffic from your node.

Are your nodes definitely being compiled with radio channel 26 (that's what 6LBR is expecting according to your .dat file) and PAN_ID of abcd? Does that COAP example which does show up in the neighbors list have different values for those two parameters?

tiagodiogo commented 8 years ago

they both are, the one that does not even show up (6lbr-demo) has those settings already present under section radio in project-conf.h:

*---------------------------------------------------------------------------*/
/* Radio                                                                     */
/*---------------------------------------------------------------------------*/

#ifndef IEEE802154_CONF_PANID
#define IEEE802154_CONF_PANID 0xABCD
#endif

#ifndef RF_CHANNEL
#define RF_CHANNEL 26
#endif

the one that does show up, but doesn't really work (er-rest-example) has those settings, commented, in its project-conf.h:

/* Custom channel and PAN ID configuration for your project. */

   #undef RF_CHANNEL
   #define RF_CHANNEL                     26

   #undef IEEE802154_CONF_PANID
   #define IEEE802154_CONF_PANID          0xABCD

however i tried with and without the commented section and the result was the same

tiagodiogo commented 8 years ago

i saw that in the Makefile of the 6lbr/examples/ipv6/slip-radio there are the options:

CONTIKI_WITH_RPL = 0
CONTIKI_WITH_IPV6 = 1

i don't know exactly what the CONTIKI_WITH_RPL does but i have already tried with 0 and 1

laurentderu commented 8 years ago

If er-rest-example shows up in 6lbr and 6lbr-demo does not, I think @msolters is right, the channel and or the pan-id is wrong. Maybe in the platform-conf.h or contiki-conf.h of the ReMote the channel is forced the code in 6lbr-demo will not change it as it will only update it if it's not yet configured.

The second issue, not being able to access the CoAP server from your PC, looks like the aaaa::/64 route is not created in your PC. You should either create it manually or allow route creation from the RA sent by 6LBR.

tiagodiogo commented 8 years ago

you are absolutely right, the contiki-conf.h of the ReMote had channel 25 hardcoded in there. i wasn't expecting it to work after i changed it because one of my tests was to replace the channel and pan id definition of 6lbr-demo:

#ifndef IEEE802154_CONF_PANID
#define IEEE802154_CONF_PANID 0xABCD
#endif

#ifndef RF_CHANNEL
#define RF_CHANNEL 26
#endif

with:

#undef IEEE802154_CONF_PANID
#define IEEE802154_CONF_PANID 0xABCD

#undef RF_CHANNEL
#define RF_CHANNEL 26

thinking that any previous value would be replaced at this point. guess this is what happens when you don't know what you are doing...

regarding the access to CoAP resources from my PC, it seems I miss understood the role of the border-router, I thought that I was supposed to have the bbbb::/64 route on my linux machine, and the border-router would translate the request into an aaaa:://64 ip as soon as I allowed the route creation from the RA sent by 6lbr i could immediately access the server resources.

thank you @msolters and @laurentderu for your help