[ndnSIM] Interest packets are not forwarded

Thu Apr 20 19:45:28 PDT 2017

Hi,

please see my previous response.

Thanks,

Spyridon (Spyros) Mastorakis
Personal Website: http://cs.ucla.edu/~mastorakis/ <http://cs.ucla.edu/~mastorakis/>
Internet Research Laboratory
Computer Science Department
UCLA

> On Apr 20, 2017, at 1:48 PM, Amir Ibrahim <a.ibrahim at fci-cu.edu.eg> wrote:
> 
> Hi Members,
>    I modified one of the examples to simulate the mobility impact on caching.
> My scenario is:
> 1. a grid of routers (5*5)
> 2. 8 WiFi access points 
> 3. 15 mobile wifi consumers
> 4. Only one producer (router at grid(4,4) positions)
> 
> - both routers and APs are cache enabled, WiFi consumers are unable to cache.
> - scenario code is accessed from here <https://gist.github.com/amiribrahim/47b31eb1d3918e21fa6717c7f5098af2> ( https://gist.github.com/amiribrahim/47b31eb1d3918e21fa6717c7f5098af2 <https://gist.github.com/amiribrahim/47b31eb1d3918e21fa6717c7f5098af2> )
> 
> When I run the scenario, I get lot of NACKs with no route reason (when I use Best-route forwarding), and re-transmission trials when I use (multicast) forwarding strategy.
> 
> Any clue why nodes aren't forwarding interest packets
> 
> as below:
> 
> 
> ns3 at ubuntu:~/ndnSIM/ns-3$ NS_LOG=ndn.Consumer:ndn.Producer ./waf --run scratch/project-simulation --vis
> Waf: Entering directory `/home/ns3/ndnSIM/ns-3/build'
> Waf: Leaving directory `/home/ns3/ndnSIM/ns-3/build'
> Build commands will be stored in build/compile_commands.json
> 'build' finished successfully (3.637s)
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Consumer:Consumer()
> 0s -1 ndn.Producer:Producer()
> 0s 24 ndn.Producer:StartApplication()
> 0s 33 ndn.Consumer:StartApplication()
> 0s 34 ndn.Consumer:StartApplication()
> 0s 35 ndn.Consumer:StartApplication()
> 0s 36 ndn.Consumer:StartApplication()
> 0s 37 ndn.Consumer:StartApplication()
> 0s 38 ndn.Consumer:StartApplication()
> 0s 39 ndn.Consumer:StartApplication()
> 0s 40 ndn.Consumer:StartApplication()
> 0s 41 ndn.Consumer:StartApplication()
> 0s 42 ndn.Consumer:StartApplication()
> 0s 43 ndn.Consumer:StartApplication()
> 0s 44 ndn.Consumer:StartApplication()
> 0s 45 ndn.Consumer:StartApplication()
> 0s 46 ndn.Consumer:StartApplication()
> 0s 47 ndn.Consumer:StartApplication()
> 0s 33 ndn.Consumer:SendPacket()
> 0s 33 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 33 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 34 ndn.Consumer:SendPacket()
> 0s 34 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 34 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 35 ndn.Consumer:SendPacket()
> 0s 35 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 35 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 36 ndn.Consumer:SendPacket()
> 0s 36 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 36 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 37 ndn.Consumer:SendPacket()
> 0s 37 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 37 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 38 ndn.Consumer:SendPacket()
> 0s 38 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 38 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 39 ndn.Consumer:SendPacket()
> 0s 39 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 39 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 40 ndn.Consumer:SendPacket()
> 0s 40 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 40 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 41 ndn.Consumer:SendPacket()
> 0s 41 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 41 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 42 ndn.Consumer:SendPacket()
> 0s 42 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 42 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 43 ndn.Consumer:SendPacket()
> 0s 43 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 43 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 44 ndn.Consumer:SendPacket()
> 0s 44 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 44 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 45 ndn.Consumer:SendPacket()
> 0s 45 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 45 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 46 ndn.Consumer:SendPacket()
> 0s 46 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 46 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0s 47 ndn.Consumer:SendPacket()
> 0s 47 ndn.Consumer:SendPacket(): [INFO ] > Interest for 0
> 0s 47 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 0 with +0.0ns. already 0 items
> 0.5s 33 ndn.Consumer:SendPacket()
> 0.5s 33 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 33 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 34 ndn.Consumer:SendPacket()
> 0.5s 34 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 34 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 35 ndn.Consumer:SendPacket()
> 0.5s 35 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 35 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 36 ndn.Consumer:SendPacket()
> 0.5s 36 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 36 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 37 ndn.Consumer:SendPacket()
> 0.5s 37 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 37 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 38 ndn.Consumer:SendPacket()
> 0.5s 38 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 38 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 39 ndn.Consumer:SendPacket()
> 0.5s 39 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 39 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 40 ndn.Consumer:SendPacket()
> 0.5s 40 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 40 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 41 ndn.Consumer:SendPacket()
> 0.5s 41 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 41 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 42 ndn.Consumer:SendPacket()
> 0.5s 42 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 42 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 43 ndn.Consumer:SendPacket()
> 0.5s 43 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 43 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 44 ndn.Consumer:SendPacket()
> 0.5s 44 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 44 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 45 ndn.Consumer:SendPacket()
> 0.5s 45 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 45 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 46 ndn.Consumer:SendPacket()
> 0.5s 46 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 46 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.5s 47 ndn.Consumer:SendPacket()
> 0.5s 47 ndn.Consumer:SendPacket(): [INFO ] > Interest for 1
> 0.5s 47 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 1 with +500000000.0ns. already 1 items
> 0.500489s 37 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%01, reason: NoRoute
> 0.500498s 43 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%01, reason: NoRoute
> 0.501802s 39 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%01, reason: NoRoute
> 0.502403s 41 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%01, reason: NoRoute
> 0.502652s 38 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%01, reason: NoRoute
> 0.503541s 35 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%01, reason: NoRoute
> 1s 33 ndn.Consumer:SendPacket()
> 1s 33 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 33 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 34 ndn.Consumer:SendPacket()
> 1s 34 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 34 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 35 ndn.Consumer:SendPacket()
> 1s 35 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 35 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 36 ndn.Consumer:SendPacket()
> 1s 36 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 36 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 37 ndn.Consumer:SendPacket()
> 1s 37 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 37 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 38 ndn.Consumer:SendPacket()
> 1s 38 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 38 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 39 ndn.Consumer:SendPacket()
> 1s 39 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 39 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 40 ndn.Consumer:SendPacket()
> 1s 40 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 40 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 41 ndn.Consumer:SendPacket()
> 1s 41 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 41 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 42 ndn.Consumer:SendPacket()
> 1s 42 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 42 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 43 ndn.Consumer:SendPacket()
> 1s 43 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 43 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 44 ndn.Consumer:SendPacket()
> 1s 44 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 44 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 45 ndn.Consumer:SendPacket()
> 1s 45 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 45 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 46 ndn.Consumer:SendPacket()
> 1s 46 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 46 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s 47 ndn.Consumer:SendPacket()
> 1s 47 ndn.Consumer:SendPacket(): [INFO ] > Interest for 2
> 1s 47 ndn.Consumer:WillSendOutInterest(): [DEBUG] Trying to add 2 with +1000000000.0ns. already 2 items
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1s -1 ndn.Consumer:OnTimeout(0)
> 1.0005s 37 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%02, reason: NoRoute
> 1.00056s 43 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%02, reason: NoRoute
> 1.00178s 41 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%02, reason: NoRoute
> 1.00196s 38 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%02, reason: NoRoute
> 1.00229s 39 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%02, reason: NoRoute
> 1.00395s 35 ndn.Consumer:OnNack(): [INFO ] NACK received for: /prefix/%FE%02, reason: NoRoute
> 1.5s 33 ndn.Consumer:SendPacket()
>    

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://www.lists.cs.ucla.edu/pipermail/ndnsim/attachments/20170420/b48807f8/attachment-0001.html>