Project

General

Profile

Bug #2643 » nfd-trace.txt

Watch for /example/testApp/randomData - Ilya Moiseenko, 03/13/2015 05:14 PM

 
1426291249.825501 INFO: [UnixStreamFace] [id=-1,local=unix:///private/var/run/nfd.sock,remote=fd://37] Creating face
1426291249.825625 INFO: [FaceTable] Added face id=264 remote=fd://37 local=unix:///private/var/run/nfd.sock
1426291249.845472 DEBUG: [Forwarder] onIncomingData face=1 data=/localhost/nfd/faces/events/%FE%0B
1426291249.845646 DEBUG: [Forwarder] onIncomingData matching=/localhost/nfd/faces/events/%FE%0B
1426291249.845761 DEBUG: [Forwarder] onOutgoingData face=262 data=/localhost/nfd/faces/events/%FE%0B
1426291249.845868 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] sendData
1426291249.846028 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Successfully sent: 7 bytes
1426291249.846175 TRACE: [UnixStreamFace] [id=264,local=unix:///private/var/run/nfd.sock,remote=fd://37] Received: 51 bytes
1426291249.846311 DEBUG: [Forwarder] onIncomingInterest face=264 interest=/example/testApp/randomData
1426291249.846449 DEBUG: [Forwarder] onOutgoingInterest face=263 interest=/example/testApp/randomData
1426291249.846557 TRACE: [UnixStreamFace] [id=263,local=unix:///private/var/run/nfd.sock,remote=fd://36] sendInterest
1426291249.846696 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Successfully sent: 445 bytes
1426291249.846833 TRACE: [UnixStreamFace] [id=263,local=unix:///private/var/run/nfd.sock,remote=fd://36] Successfully sent: 51 bytes
1426291249.846968 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 49 bytes
1426291249.847098 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events/%FE%0C
1426291249.847247 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events/%FE%0C
1426291249.867175 TRACE: [UnixStreamFace] [id=263,local=unix:///private/var/run/nfd.sock,remote=fd://36] Received: 380 bytes
1426291249.867296 DEBUG: [Forwarder] onIncomingData face=263 data=/example/testApp/randomData
1426291249.867387 DEBUG: [Forwarder] onIncomingData matching=/example/testApp/randomData
1426291249.867461 DEBUG: [Forwarder] onOutgoingData face=264 data=/example/testApp/randomData
1426291249.867535 TRACE: [UnixStreamFace] [id=264,local=unix:///private/var/run/nfd.sock,remote=fd://37] sendData
1426291249.867640 TRACE: [UnixStreamFace] [id=264,local=unix:///private/var/run/nfd.sock,remote=fd://37] Successfully sent: 380 bytes
1426291249.867862 TRACE: [UnixStreamFace] [id=264,local=unix:///private/var/run/nfd.sock,remote=fd://37] Received: 87 bytes
1426291249.867986 DEBUG: [Forwarder] onIncomingInterest face=264 interest=/example/testApp/randomData
1426291249.868137 DEBUG: [Forwarder] onOutgoingInterest face=263 interest=/example/testApp/randomData
1426291249.868222 TRACE: [UnixStreamFace] [id=263,local=unix:///private/var/run/nfd.sock,remote=fd://36] sendInterest
1426291249.868323 TRACE: [UnixStreamFace] [id=263,local=unix:///private/var/run/nfd.sock,remote=fd://36] Successfully sent: 87 bytes
1426291249.885886 TRACE: [UnixStreamFace] [id=263,local=unix:///private/var/run/nfd.sock,remote=fd://36] Received: 380 bytes
1426291249.886006 DEBUG: [Forwarder] onIncomingData face=263 data=/example/testApp/randomData
1426291249.886133 DEBUG: [Forwarder] onIncomingData matching=/example/testApp/randomData
1426291249.945811 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events/%FE%0B satisfied
1426291249.986920 DEBUG: [Forwarder] onInterestFinalize interest=/example/testApp/randomData satisfied
1426291252.868870 DEBUG: [Forwarder] onInterestUnsatisfied interest=/example/testApp/randomData
1426291252.868984 DEBUG: [Forwarder] onInterestFinalize interest=/example/testApp/randomData unsatisfied
1426291252.948798 TRACE: [UnixStreamFace] [id=264,local=unix:///private/var/run/nfd.sock,remote=fd://37] shutdownSocket
1426291252.966534 DEBUG: [Forwarder] onIncomingData face=1 data=/localhost/nfd/faces/events/%FE%0C
1426291252.966657 DEBUG: [Forwarder] onIncomingData matching=/localhost/nfd/faces/events/%FE%0C
1426291252.966744 DEBUG: [Forwarder] onOutgoingData face=262 data=/localhost/nfd/faces/events/%FE%0C
1426291252.966824 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] sendData
1426291252.966934 INFO: [FaceTable] Removed face id=264 remote=fd://37 local=unix:///private/var/run/nfd.sock (Connection closed)
1426291252.967048 TRACE: [UnixStreamFace] [id=-1,local=unix:///private/var/run/nfd.sock,remote=fd://37] deferredClose
1426291252.967333 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Successfully sent: 7 bytes
1426291252.967447 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Successfully sent: 445 bytes
1426291252.967555 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 49 bytes
1426291252.967654 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events/%FE%0D
1426291252.967769 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events/%FE%0D
1426291253.066935 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events/%FE%0C satisfied
1426291312.967919 DEBUG: [Forwarder] onInterestUnsatisfied interest=/localhost/nfd/faces/events/%FE%0D
1426291312.968079 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events/%FE%0D unsatisfied
1426291312.977590 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 52 bytes
1426291312.977775 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events
1426291312.978038 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events
1426291372.978192 DEBUG: [Forwarder] onInterestUnsatisfied interest=/localhost/nfd/faces/events
1426291372.978320 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events unsatisfied
1426291373.025580 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 52 bytes
1426291373.025708 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events
1426291373.025859 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events
1426291433.026980 DEBUG: [Forwarder] onInterestUnsatisfied interest=/localhost/nfd/faces/events
1426291433.027124 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events unsatisfied
1426291433.054877 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 52 bytes
1426291433.055024 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events
1426291433.055223 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events
1426291493.056323 DEBUG: [Forwarder] onInterestUnsatisfied interest=/localhost/nfd/faces/events
1426291493.056581 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events unsatisfied
1426291493.108360 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 52 bytes
1426291493.108668 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events
1426291493.108939 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events
1426291537.178918 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 46 bytes
1426291537.179044 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/list
1426291537.179156 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/list
1426291537.196901 DEBUG: [Forwarder] onIncomingData face=1 data=/localhost/nfd/faces/list/%FD%00%00%01L%15%99%B5%1B/%00%00
1426291537.197043 DEBUG: [Forwarder] onIncomingData matching=/localhost/nfd/faces/list
1426291537.197119 DEBUG: [Forwarder] onOutgoingData face=262 data=/localhost/nfd/faces/list/%FD%00%00%01L%15%99%B5%1B/%00%00
1426291537.197220 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] sendData
1426291537.197335 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Successfully sent: 7 bytes
1426291537.197444 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Successfully sent: 1200 bytes
1426291537.298172 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/list satisfied
1426291553.109845 DEBUG: [Forwarder] onInterestUnsatisfied interest=/localhost/nfd/faces/events
1426291553.110021 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events unsatisfied
1426291553.168402 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 52 bytes
1426291553.168571 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events
1426291553.168793 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events
1426291613.169101 DEBUG: [Forwarder] onInterestUnsatisfied interest=/localhost/nfd/faces/events
1426291613.169315 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events unsatisfied
1426291613.226042 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 52 bytes
1426291613.226168 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events
1426291613.226324 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events
1426291673.227417 DEBUG: [Forwarder] onInterestUnsatisfied interest=/localhost/nfd/faces/events
1426291673.227516 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events unsatisfied
1426291673.284716 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 52 bytes
1426291673.284848 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events
1426291673.285044 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events
1426291733.285363 DEBUG: [Forwarder] onInterestUnsatisfied interest=/localhost/nfd/faces/events
1426291733.285461 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events unsatisfied
1426291733.345216 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 52 bytes
1426291733.345387 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events
1426291733.345596 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events
1426291793.346739 DEBUG: [Forwarder] onInterestUnsatisfied interest=/localhost/nfd/faces/events
1426291793.346891 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events unsatisfied
1426291793.397902 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 52 bytes
1426291793.398084 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events
1426291793.398324 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events
1426291837.198755 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 46 bytes
1426291837.198917 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/list
1426291837.199066 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/list
1426291837.219889 DEBUG: [Forwarder] onIncomingData face=1 data=/localhost/nfd/faces/list/%FD%00%00%01L%15%9EI%0F/%00%00
1426291837.220067 DEBUG: [Forwarder] onIncomingData matching=/localhost/nfd/faces/list
1426291837.220150 DEBUG: [Forwarder] onOutgoingData face=262 data=/localhost/nfd/faces/list/%FD%00%00%01L%15%9EI%0F/%00%00
1426291837.220257 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] sendData
1426291837.220379 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Successfully sent: 7 bytes
1426291837.220489 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Successfully sent: 1200 bytes
1426291837.321223 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/list satisfied
1426291853.399429 DEBUG: [Forwarder] onInterestUnsatisfied interest=/localhost/nfd/faces/events
1426291853.399556 DEBUG: [Forwarder] onInterestFinalize interest=/localhost/nfd/faces/events unsatisfied
1426291853.427285 TRACE: [UnixStreamFace] [id=262,local=unix:///private/var/run/nfd.sock,remote=fd://34] Received: 52 bytes
1426291853.427419 DEBUG: [Forwarder] onIncomingInterest face=262 interest=/localhost/nfd/faces/events
1426291853.427594 DEBUG: [Forwarder] onOutgoingInterest face=1 interest=/localhost/nfd/faces/events

(3-3/3)