net.go 35 KB

12345678910111213141516171819202122232425262728293031323334353637383940414243444546474849505152535455565758596061626364656667686970717273747576777879808182838485868788899091929394959697989910010110210310410510610710810911011111211311411511611711811912012112212312412512612712812913013113213313413513613713813914014114214314414514614714814915015115215315415515615715815916016116216316416516616716816917017117217317417517617717817918018118218318418518618718818919019119219319419519619719819920020120220320420520620720820921021121221321421521621721821922022122222322422522622722822923023123223323423523623723823924024124224324424524624724824925025125225325425525625725825926026126226326426526626726826927027127227327427527627727827928028128228328428528628728828929029129229329429529629729829930030130230330430530630730830931031131231331431531631731831932032132232332432532632732832933033133233333433533633733833934034134234334434534634734834935035135235335435535635735835936036136236336436536636736836937037137237337437537637737837938038138238338438538638738838939039139239339439539639739839940040140240340440540640740840941041141241341441541641741841942042142242342442542642742842943043143243343443543643743843944044144244344444544644744844945045145245345445545645745845946046146246346446546646746846947047147247347447547647747847948048148248348448548648748848949049149249349449549649749849950050150250350450550650750850951051151251351451551651751851952052152252352452552652752852953053153253353453553653753853954054154254354454554654754854955055155255355455555655755855956056156256356456556656756856957057157257357457557657757857958058158258358458558658758858959059159259359459559659759859960060160260360460560660760860961061161261361461561661761861962062162262362462562662762862963063163263363463563663763863964064164264364464564664764864965065165265365465565665765865966066166266366466566666766866967067167267367467567667767867968068168268368468568668768868969069169269369469569669769869970070170270370470570670770870971071171271371471571671771871972072172272372472572672772872973073173273373473573673773873974074174274374474574674774874975075175275375475575675775875976076176276376476576676776876977077177277377477577677777877978078178278378478578678778878979079179279379479579679779879980080180280380480580680780880981081181281381481581681781881982082182282382482582682782882983083183283383483583683783883984084184284384484584684784884985085185285385485585685785885986086186286386486586686786886987087187287387487587687787887988088188288388488588688788888989089189289389489589689789889990090190290390490590690790890991091191291391491591691791891992092192292392492592692792892993093193293393493593693793893994094194294394494594694794894995095195295395495595695795895996096196296396496596696796896997097197297397497597697797897998098198298398498598698798898999099199299399499599699799899910001001100210031004100510061007100810091010101110121013101410151016101710181019102010211022102310241025102610271028102910301031103210331034103510361037103810391040104110421043104410451046104710481049105010511052105310541055105610571058105910601061106210631064106510661067106810691070107110721073107410751076107710781079108010811082108310841085108610871088108910901091109210931094109510961097109810991100110111021103110411051106110711081109111011111112111311141115111611171118111911201121112211231124112511261127112811291130113111321133113411351136113711381139114011411142114311441145114611471148114911501151115211531154115511561157115811591160116111621163116411651166116711681169117011711172117311741175117611771178117911801181118211831184118511861187118811891190119111921193119411951196119711981199120012011202120312041205120612071208120912101211121212131214121512161217121812191220122112221223122412251226122712281229123012311232123312341235123612371238123912401241124212431244124512461247124812491250125112521253125412551256125712581259126012611262126312641265126612671268126912701271127212731274
  1. // Copyright 2016 The go-ethereum Authors
  2. // This file is part of the go-ethereum library.
  3. //
  4. // The go-ethereum library is free software: you can redistribute it and/or modify
  5. // it under the terms of the GNU Lesser General Public License as published by
  6. // the Free Software Foundation, either version 3 of the License, or
  7. // (at your option) any later version.
  8. //
  9. // The go-ethereum library is distributed in the hope that it will be useful,
  10. // but WITHOUT ANY WARRANTY; without even the implied warranty of
  11. // MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
  12. // GNU Lesser General Public License for more details.
  13. //
  14. // You should have received a copy of the GNU Lesser General Public License
  15. // along with the go-ethereum library. If not, see <http://www.gnu.org/licenses/>.
  16. package discv5
  17. import (
  18. "bytes"
  19. "crypto/ecdsa"
  20. "errors"
  21. "fmt"
  22. "net"
  23. "time"
  24. "github.com/ethereum/go-ethereum/common"
  25. "github.com/ethereum/go-ethereum/common/mclock"
  26. "github.com/ethereum/go-ethereum/crypto"
  27. "github.com/ethereum/go-ethereum/crypto/sha3"
  28. "github.com/ethereum/go-ethereum/log"
  29. "github.com/ethereum/go-ethereum/p2p/netutil"
  30. "github.com/ethereum/go-ethereum/rlp"
  31. )
  32. var (
  33. errInvalidEvent = errors.New("invalid in current state")
  34. errNoQuery = errors.New("no pending query")
  35. errWrongAddress = errors.New("unknown sender address")
  36. )
  37. const (
  38. autoRefreshInterval = 1 * time.Hour
  39. bucketRefreshInterval = 1 * time.Minute
  40. seedCount = 30
  41. seedMaxAge = 5 * 24 * time.Hour
  42. lowPort = 1024
  43. )
  44. const testTopic = "foo"
  45. const (
  46. printTestImgLogs = false
  47. )
  48. // Network manages the table and all protocol interaction.
  49. type Network struct {
  50. db *nodeDB // database of known nodes
  51. conn transport
  52. netrestrict *netutil.Netlist
  53. closed chan struct{} // closed when loop is done
  54. closeReq chan struct{} // 'request to close'
  55. refreshReq chan []*Node // lookups ask for refresh on this channel
  56. refreshResp chan (<-chan struct{}) // ...and get the channel to block on from this one
  57. read chan ingressPacket // ingress packets arrive here
  58. timeout chan timeoutEvent
  59. queryReq chan *findnodeQuery // lookups submit findnode queries on this channel
  60. tableOpReq chan func()
  61. tableOpResp chan struct{}
  62. topicRegisterReq chan topicRegisterReq
  63. topicSearchReq chan topicSearchReq
  64. // State of the main loop.
  65. tab *Table
  66. topictab *topicTable
  67. ticketStore *ticketStore
  68. nursery []*Node
  69. nodes map[NodeID]*Node // tracks active nodes with state != known
  70. timeoutTimers map[timeoutEvent]*time.Timer
  71. // Revalidation queues.
  72. // Nodes put on these queues will be pinged eventually.
  73. slowRevalidateQueue []*Node
  74. fastRevalidateQueue []*Node
  75. // Buffers for state transition.
  76. sendBuf []*ingressPacket
  77. }
  78. // transport is implemented by the UDP transport.
  79. // it is an interface so we can test without opening lots of UDP
  80. // sockets and without generating a private key.
  81. type transport interface {
  82. sendPing(remote *Node, remoteAddr *net.UDPAddr, topics []Topic) (hash []byte)
  83. sendNeighbours(remote *Node, nodes []*Node)
  84. sendFindnodeHash(remote *Node, target common.Hash)
  85. sendTopicRegister(remote *Node, topics []Topic, topicIdx int, pong []byte)
  86. sendTopicNodes(remote *Node, queryHash common.Hash, nodes []*Node)
  87. send(remote *Node, ptype nodeEvent, p interface{}) (hash []byte)
  88. localAddr() *net.UDPAddr
  89. Close()
  90. }
  91. type findnodeQuery struct {
  92. remote *Node
  93. target common.Hash
  94. reply chan<- []*Node
  95. nresults int // counter for received nodes
  96. }
  97. type topicRegisterReq struct {
  98. add bool
  99. topic Topic
  100. }
  101. type topicSearchReq struct {
  102. topic Topic
  103. found chan<- *Node
  104. lookup chan<- bool
  105. delay time.Duration
  106. }
  107. type topicSearchResult struct {
  108. target lookupInfo
  109. nodes []*Node
  110. }
  111. type timeoutEvent struct {
  112. ev nodeEvent
  113. node *Node
  114. }
  115. func newNetwork(conn transport, ourPubkey ecdsa.PublicKey, dbPath string, netrestrict *netutil.Netlist) (*Network, error) {
  116. ourID := PubkeyID(&ourPubkey)
  117. var db *nodeDB
  118. if dbPath != "<no database>" {
  119. var err error
  120. if db, err = newNodeDB(dbPath, Version, ourID); err != nil {
  121. return nil, err
  122. }
  123. }
  124. tab := newTable(ourID, conn.localAddr())
  125. net := &Network{
  126. db: db,
  127. conn: conn,
  128. netrestrict: netrestrict,
  129. tab: tab,
  130. topictab: newTopicTable(db, tab.self),
  131. ticketStore: newTicketStore(),
  132. refreshReq: make(chan []*Node),
  133. refreshResp: make(chan (<-chan struct{})),
  134. closed: make(chan struct{}),
  135. closeReq: make(chan struct{}),
  136. read: make(chan ingressPacket, 100),
  137. timeout: make(chan timeoutEvent),
  138. timeoutTimers: make(map[timeoutEvent]*time.Timer),
  139. tableOpReq: make(chan func()),
  140. tableOpResp: make(chan struct{}),
  141. queryReq: make(chan *findnodeQuery),
  142. topicRegisterReq: make(chan topicRegisterReq),
  143. topicSearchReq: make(chan topicSearchReq),
  144. nodes: make(map[NodeID]*Node),
  145. }
  146. go net.loop()
  147. return net, nil
  148. }
  149. // Close terminates the network listener and flushes the node database.
  150. func (net *Network) Close() {
  151. net.conn.Close()
  152. select {
  153. case <-net.closed:
  154. case net.closeReq <- struct{}{}:
  155. <-net.closed
  156. }
  157. }
  158. // Self returns the local node.
  159. // The returned node should not be modified by the caller.
  160. func (net *Network) Self() *Node {
  161. return net.tab.self
  162. }
  163. // ReadRandomNodes fills the given slice with random nodes from the
  164. // table. It will not write the same node more than once. The nodes in
  165. // the slice are copies and can be modified by the caller.
  166. func (net *Network) ReadRandomNodes(buf []*Node) (n int) {
  167. net.reqTableOp(func() { n = net.tab.readRandomNodes(buf) })
  168. return n
  169. }
  170. // SetFallbackNodes sets the initial points of contact. These nodes
  171. // are used to connect to the network if the table is empty and there
  172. // are no known nodes in the database.
  173. func (net *Network) SetFallbackNodes(nodes []*Node) error {
  174. nursery := make([]*Node, 0, len(nodes))
  175. for _, n := range nodes {
  176. if err := n.validateComplete(); err != nil {
  177. return fmt.Errorf("bad bootstrap/fallback node %q (%v)", n, err)
  178. }
  179. // Recompute cpy.sha because the node might not have been
  180. // created by NewNode or ParseNode.
  181. cpy := *n
  182. cpy.sha = crypto.Keccak256Hash(n.ID[:])
  183. nursery = append(nursery, &cpy)
  184. }
  185. net.reqRefresh(nursery)
  186. return nil
  187. }
  188. // Resolve searches for a specific node with the given ID.
  189. // It returns nil if the node could not be found.
  190. func (net *Network) Resolve(targetID NodeID) *Node {
  191. result := net.lookup(crypto.Keccak256Hash(targetID[:]), true)
  192. for _, n := range result {
  193. if n.ID == targetID {
  194. return n
  195. }
  196. }
  197. return nil
  198. }
  199. // Lookup performs a network search for nodes close
  200. // to the given target. It approaches the target by querying
  201. // nodes that are closer to it on each iteration.
  202. // The given target does not need to be an actual node
  203. // identifier.
  204. //
  205. // The local node may be included in the result.
  206. func (net *Network) Lookup(targetID NodeID) []*Node {
  207. return net.lookup(crypto.Keccak256Hash(targetID[:]), false)
  208. }
  209. func (net *Network) lookup(target common.Hash, stopOnMatch bool) []*Node {
  210. var (
  211. asked = make(map[NodeID]bool)
  212. seen = make(map[NodeID]bool)
  213. reply = make(chan []*Node, alpha)
  214. result = nodesByDistance{target: target}
  215. pendingQueries = 0
  216. )
  217. // Get initial answers from the local node.
  218. result.push(net.tab.self, bucketSize)
  219. for {
  220. // Ask the α closest nodes that we haven't asked yet.
  221. for i := 0; i < len(result.entries) && pendingQueries < alpha; i++ {
  222. n := result.entries[i]
  223. if !asked[n.ID] {
  224. asked[n.ID] = true
  225. pendingQueries++
  226. net.reqQueryFindnode(n, target, reply)
  227. }
  228. }
  229. if pendingQueries == 0 {
  230. // We have asked all closest nodes, stop the search.
  231. break
  232. }
  233. // Wait for the next reply.
  234. select {
  235. case nodes := <-reply:
  236. for _, n := range nodes {
  237. if n != nil && !seen[n.ID] {
  238. seen[n.ID] = true
  239. result.push(n, bucketSize)
  240. if stopOnMatch && n.sha == target {
  241. return result.entries
  242. }
  243. }
  244. }
  245. pendingQueries--
  246. case <-time.After(respTimeout):
  247. // forget all pending requests, start new ones
  248. pendingQueries = 0
  249. reply = make(chan []*Node, alpha)
  250. }
  251. }
  252. return result.entries
  253. }
  254. func (net *Network) RegisterTopic(topic Topic, stop <-chan struct{}) {
  255. select {
  256. case net.topicRegisterReq <- topicRegisterReq{true, topic}:
  257. case <-net.closed:
  258. return
  259. }
  260. select {
  261. case <-net.closed:
  262. case <-stop:
  263. select {
  264. case net.topicRegisterReq <- topicRegisterReq{false, topic}:
  265. case <-net.closed:
  266. }
  267. }
  268. }
  269. func (net *Network) SearchTopic(topic Topic, setPeriod <-chan time.Duration, found chan<- *Node, lookup chan<- bool) {
  270. for {
  271. select {
  272. case <-net.closed:
  273. return
  274. case delay, ok := <-setPeriod:
  275. select {
  276. case net.topicSearchReq <- topicSearchReq{topic: topic, found: found, lookup: lookup, delay: delay}:
  277. case <-net.closed:
  278. return
  279. }
  280. if !ok {
  281. return
  282. }
  283. }
  284. }
  285. }
  286. func (net *Network) reqRefresh(nursery []*Node) <-chan struct{} {
  287. select {
  288. case net.refreshReq <- nursery:
  289. return <-net.refreshResp
  290. case <-net.closed:
  291. return net.closed
  292. }
  293. }
  294. func (net *Network) reqQueryFindnode(n *Node, target common.Hash, reply chan []*Node) bool {
  295. q := &findnodeQuery{remote: n, target: target, reply: reply}
  296. select {
  297. case net.queryReq <- q:
  298. return true
  299. case <-net.closed:
  300. return false
  301. }
  302. }
  303. func (net *Network) reqReadPacket(pkt ingressPacket) {
  304. select {
  305. case net.read <- pkt:
  306. case <-net.closed:
  307. }
  308. }
  309. func (net *Network) reqTableOp(f func()) (called bool) {
  310. select {
  311. case net.tableOpReq <- f:
  312. <-net.tableOpResp
  313. return true
  314. case <-net.closed:
  315. return false
  316. }
  317. }
  318. // TODO: external address handling.
  319. type topicSearchInfo struct {
  320. lookupChn chan<- bool
  321. period time.Duration
  322. }
  323. const maxSearchCount = 5
  324. func (net *Network) loop() {
  325. var (
  326. refreshTimer = time.NewTicker(autoRefreshInterval)
  327. bucketRefreshTimer = time.NewTimer(bucketRefreshInterval)
  328. refreshDone chan struct{} // closed when the 'refresh' lookup has ended
  329. )
  330. // Tracking the next ticket to register.
  331. var (
  332. nextTicket *ticketRef
  333. nextRegisterTimer *time.Timer
  334. nextRegisterTime <-chan time.Time
  335. )
  336. defer func() {
  337. if nextRegisterTimer != nil {
  338. nextRegisterTimer.Stop()
  339. }
  340. }()
  341. resetNextTicket := func() {
  342. ticket, timeout := net.ticketStore.nextFilteredTicket()
  343. if nextTicket != ticket {
  344. nextTicket = ticket
  345. if nextRegisterTimer != nil {
  346. nextRegisterTimer.Stop()
  347. nextRegisterTime = nil
  348. }
  349. if ticket != nil {
  350. nextRegisterTimer = time.NewTimer(timeout)
  351. nextRegisterTime = nextRegisterTimer.C
  352. }
  353. }
  354. }
  355. // Tracking registration and search lookups.
  356. var (
  357. topicRegisterLookupTarget lookupInfo
  358. topicRegisterLookupDone chan []*Node
  359. topicRegisterLookupTick = time.NewTimer(0)
  360. searchReqWhenRefreshDone []topicSearchReq
  361. searchInfo = make(map[Topic]topicSearchInfo)
  362. activeSearchCount int
  363. )
  364. topicSearchLookupDone := make(chan topicSearchResult, 100)
  365. topicSearch := make(chan Topic, 100)
  366. <-topicRegisterLookupTick.C
  367. statsDump := time.NewTicker(10 * time.Second)
  368. loop:
  369. for {
  370. resetNextTicket()
  371. select {
  372. case <-net.closeReq:
  373. log.Trace("<-net.closeReq")
  374. break loop
  375. // Ingress packet handling.
  376. case pkt := <-net.read:
  377. //fmt.Println("read", pkt.ev)
  378. log.Trace("<-net.read")
  379. n := net.internNode(&pkt)
  380. prestate := n.state
  381. status := "ok"
  382. if err := net.handle(n, pkt.ev, &pkt); err != nil {
  383. status = err.Error()
  384. }
  385. log.Trace("", "msg", log.Lazy{Fn: func() string {
  386. return fmt.Sprintf("<<< (%d) %v from %x@%v: %v -> %v (%v)",
  387. net.tab.count, pkt.ev, pkt.remoteID[:8], pkt.remoteAddr, prestate, n.state, status)
  388. }})
  389. // TODO: persist state if n.state goes >= known, delete if it goes <= known
  390. // State transition timeouts.
  391. case timeout := <-net.timeout:
  392. log.Trace("<-net.timeout")
  393. if net.timeoutTimers[timeout] == nil {
  394. // Stale timer (was aborted).
  395. continue
  396. }
  397. delete(net.timeoutTimers, timeout)
  398. prestate := timeout.node.state
  399. status := "ok"
  400. if err := net.handle(timeout.node, timeout.ev, nil); err != nil {
  401. status = err.Error()
  402. }
  403. log.Trace("", "msg", log.Lazy{Fn: func() string {
  404. return fmt.Sprintf("--- (%d) %v for %x@%v: %v -> %v (%v)",
  405. net.tab.count, timeout.ev, timeout.node.ID[:8], timeout.node.addr(), prestate, timeout.node.state, status)
  406. }})
  407. // Querying.
  408. case q := <-net.queryReq:
  409. log.Trace("<-net.queryReq")
  410. if !q.start(net) {
  411. q.remote.deferQuery(q)
  412. }
  413. // Interacting with the table.
  414. case f := <-net.tableOpReq:
  415. log.Trace("<-net.tableOpReq")
  416. f()
  417. net.tableOpResp <- struct{}{}
  418. // Topic registration stuff.
  419. case req := <-net.topicRegisterReq:
  420. log.Trace("<-net.topicRegisterReq")
  421. if !req.add {
  422. net.ticketStore.removeRegisterTopic(req.topic)
  423. continue
  424. }
  425. net.ticketStore.addTopic(req.topic, true)
  426. // If we're currently waiting idle (nothing to look up), give the ticket store a
  427. // chance to start it sooner. This should speed up convergence of the radius
  428. // determination for new topics.
  429. // if topicRegisterLookupDone == nil {
  430. if topicRegisterLookupTarget.target == (common.Hash{}) {
  431. log.Trace("topicRegisterLookupTarget == null")
  432. if topicRegisterLookupTick.Stop() {
  433. <-topicRegisterLookupTick.C
  434. }
  435. target, delay := net.ticketStore.nextRegisterLookup()
  436. topicRegisterLookupTarget = target
  437. topicRegisterLookupTick.Reset(delay)
  438. }
  439. case nodes := <-topicRegisterLookupDone:
  440. log.Trace("<-topicRegisterLookupDone")
  441. net.ticketStore.registerLookupDone(topicRegisterLookupTarget, nodes, func(n *Node) []byte {
  442. net.ping(n, n.addr())
  443. return n.pingEcho
  444. })
  445. target, delay := net.ticketStore.nextRegisterLookup()
  446. topicRegisterLookupTarget = target
  447. topicRegisterLookupTick.Reset(delay)
  448. topicRegisterLookupDone = nil
  449. case <-topicRegisterLookupTick.C:
  450. log.Trace("<-topicRegisterLookupTick")
  451. if (topicRegisterLookupTarget.target == common.Hash{}) {
  452. target, delay := net.ticketStore.nextRegisterLookup()
  453. topicRegisterLookupTarget = target
  454. topicRegisterLookupTick.Reset(delay)
  455. topicRegisterLookupDone = nil
  456. } else {
  457. topicRegisterLookupDone = make(chan []*Node)
  458. target := topicRegisterLookupTarget.target
  459. go func() { topicRegisterLookupDone <- net.lookup(target, false) }()
  460. }
  461. case <-nextRegisterTime:
  462. log.Trace("<-nextRegisterTime")
  463. net.ticketStore.ticketRegistered(*nextTicket)
  464. //fmt.Println("sendTopicRegister", nextTicket.t.node.addr().String(), nextTicket.t.topics, nextTicket.idx, nextTicket.t.pong)
  465. net.conn.sendTopicRegister(nextTicket.t.node, nextTicket.t.topics, nextTicket.idx, nextTicket.t.pong)
  466. case req := <-net.topicSearchReq:
  467. if refreshDone == nil {
  468. log.Trace("<-net.topicSearchReq")
  469. info, ok := searchInfo[req.topic]
  470. if ok {
  471. if req.delay == time.Duration(0) {
  472. delete(searchInfo, req.topic)
  473. net.ticketStore.removeSearchTopic(req.topic)
  474. } else {
  475. info.period = req.delay
  476. searchInfo[req.topic] = info
  477. }
  478. continue
  479. }
  480. if req.delay != time.Duration(0) {
  481. var info topicSearchInfo
  482. info.period = req.delay
  483. info.lookupChn = req.lookup
  484. searchInfo[req.topic] = info
  485. net.ticketStore.addSearchTopic(req.topic, req.found)
  486. topicSearch <- req.topic
  487. }
  488. } else {
  489. searchReqWhenRefreshDone = append(searchReqWhenRefreshDone, req)
  490. }
  491. case topic := <-topicSearch:
  492. if activeSearchCount < maxSearchCount {
  493. activeSearchCount++
  494. target := net.ticketStore.nextSearchLookup(topic)
  495. go func() {
  496. nodes := net.lookup(target.target, false)
  497. topicSearchLookupDone <- topicSearchResult{target: target, nodes: nodes}
  498. }()
  499. }
  500. period := searchInfo[topic].period
  501. if period != time.Duration(0) {
  502. go func() {
  503. time.Sleep(period)
  504. topicSearch <- topic
  505. }()
  506. }
  507. case res := <-topicSearchLookupDone:
  508. activeSearchCount--
  509. if lookupChn := searchInfo[res.target.topic].lookupChn; lookupChn != nil {
  510. lookupChn <- net.ticketStore.radius[res.target.topic].converged
  511. }
  512. net.ticketStore.searchLookupDone(res.target, res.nodes, func(n *Node, topic Topic) []byte {
  513. if n.state != nil && n.state.canQuery {
  514. return net.conn.send(n, topicQueryPacket, topicQuery{Topic: topic}) // TODO: set expiration
  515. } else {
  516. if n.state == unknown {
  517. net.ping(n, n.addr())
  518. }
  519. return nil
  520. }
  521. })
  522. case <-statsDump.C:
  523. log.Trace("<-statsDump.C")
  524. /*r, ok := net.ticketStore.radius[testTopic]
  525. if !ok {
  526. fmt.Printf("(%x) no radius @ %v\n", net.tab.self.ID[:8], time.Now())
  527. } else {
  528. topics := len(net.ticketStore.tickets)
  529. tickets := len(net.ticketStore.nodes)
  530. rad := r.radius / (maxRadius/10000+1)
  531. fmt.Printf("(%x) topics:%d radius:%d tickets:%d @ %v\n", net.tab.self.ID[:8], topics, rad, tickets, time.Now())
  532. }*/
  533. tm := mclock.Now()
  534. for topic, r := range net.ticketStore.radius {
  535. if printTestImgLogs {
  536. rad := r.radius / (maxRadius/1000000 + 1)
  537. minrad := r.minRadius / (maxRadius/1000000 + 1)
  538. fmt.Printf("*R %d %v %016x %v\n", tm/1000000, topic, net.tab.self.sha[:8], rad)
  539. fmt.Printf("*MR %d %v %016x %v\n", tm/1000000, topic, net.tab.self.sha[:8], minrad)
  540. }
  541. }
  542. for topic, t := range net.topictab.topics {
  543. wp := t.wcl.nextWaitPeriod(tm)
  544. if printTestImgLogs {
  545. fmt.Printf("*W %d %v %016x %d\n", tm/1000000, topic, net.tab.self.sha[:8], wp/1000000)
  546. }
  547. }
  548. // Periodic / lookup-initiated bucket refresh.
  549. case <-refreshTimer.C:
  550. log.Trace("<-refreshTimer.C")
  551. // TODO: ideally we would start the refresh timer after
  552. // fallback nodes have been set for the first time.
  553. if refreshDone == nil {
  554. refreshDone = make(chan struct{})
  555. net.refresh(refreshDone)
  556. }
  557. case <-bucketRefreshTimer.C:
  558. target := net.tab.chooseBucketRefreshTarget()
  559. go func() {
  560. net.lookup(target, false)
  561. bucketRefreshTimer.Reset(bucketRefreshInterval)
  562. }()
  563. case newNursery := <-net.refreshReq:
  564. log.Trace("<-net.refreshReq")
  565. if newNursery != nil {
  566. net.nursery = newNursery
  567. }
  568. if refreshDone == nil {
  569. refreshDone = make(chan struct{})
  570. net.refresh(refreshDone)
  571. }
  572. net.refreshResp <- refreshDone
  573. case <-refreshDone:
  574. log.Trace("<-net.refreshDone", "table size", net.tab.count)
  575. if net.tab.count != 0 {
  576. refreshDone = nil
  577. list := searchReqWhenRefreshDone
  578. searchReqWhenRefreshDone = nil
  579. go func() {
  580. for _, req := range list {
  581. net.topicSearchReq <- req
  582. }
  583. }()
  584. } else {
  585. refreshDone = make(chan struct{})
  586. net.refresh(refreshDone)
  587. }
  588. }
  589. }
  590. log.Trace("loop stopped")
  591. log.Debug(fmt.Sprintf("shutting down"))
  592. if net.conn != nil {
  593. net.conn.Close()
  594. }
  595. if refreshDone != nil {
  596. // TODO: wait for pending refresh.
  597. //<-refreshResults
  598. }
  599. // Cancel all pending timeouts.
  600. for _, timer := range net.timeoutTimers {
  601. timer.Stop()
  602. }
  603. if net.db != nil {
  604. net.db.close()
  605. }
  606. close(net.closed)
  607. }
  608. // Everything below runs on the Network.loop goroutine
  609. // and can modify Node, Table and Network at any time without locking.
  610. func (net *Network) refresh(done chan<- struct{}) {
  611. var seeds []*Node
  612. if net.db != nil {
  613. seeds = net.db.querySeeds(seedCount, seedMaxAge)
  614. }
  615. if len(seeds) == 0 {
  616. seeds = net.nursery
  617. }
  618. if len(seeds) == 0 {
  619. log.Trace("no seed nodes found")
  620. close(done)
  621. return
  622. }
  623. for _, n := range seeds {
  624. log.Debug("", "msg", log.Lazy{Fn: func() string {
  625. var age string
  626. if net.db != nil {
  627. age = time.Since(net.db.lastPong(n.ID)).String()
  628. } else {
  629. age = "unknown"
  630. }
  631. return fmt.Sprintf("seed node (age %s): %v", age, n)
  632. }})
  633. n = net.internNodeFromDB(n)
  634. if n.state == unknown {
  635. net.transition(n, verifyinit)
  636. }
  637. // Force-add the seed node so Lookup does something.
  638. // It will be deleted again if verification fails.
  639. net.tab.add(n)
  640. }
  641. // Start self lookup to fill up the buckets.
  642. go func() {
  643. net.Lookup(net.tab.self.ID)
  644. close(done)
  645. }()
  646. }
  647. // Node Interning.
  648. func (net *Network) internNode(pkt *ingressPacket) *Node {
  649. if n := net.nodes[pkt.remoteID]; n != nil {
  650. n.IP = pkt.remoteAddr.IP
  651. n.UDP = uint16(pkt.remoteAddr.Port)
  652. n.TCP = uint16(pkt.remoteAddr.Port)
  653. return n
  654. }
  655. n := NewNode(pkt.remoteID, pkt.remoteAddr.IP, uint16(pkt.remoteAddr.Port), uint16(pkt.remoteAddr.Port))
  656. n.state = unknown
  657. net.nodes[pkt.remoteID] = n
  658. return n
  659. }
  660. func (net *Network) internNodeFromDB(dbn *Node) *Node {
  661. if n := net.nodes[dbn.ID]; n != nil {
  662. return n
  663. }
  664. n := NewNode(dbn.ID, dbn.IP, dbn.UDP, dbn.TCP)
  665. n.state = unknown
  666. net.nodes[n.ID] = n
  667. return n
  668. }
  669. func (net *Network) internNodeFromNeighbours(sender *net.UDPAddr, rn rpcNode) (n *Node, err error) {
  670. if rn.ID == net.tab.self.ID {
  671. return nil, errors.New("is self")
  672. }
  673. if rn.UDP <= lowPort {
  674. return nil, errors.New("low port")
  675. }
  676. n = net.nodes[rn.ID]
  677. if n == nil {
  678. // We haven't seen this node before.
  679. n, err = nodeFromRPC(sender, rn)
  680. if net.netrestrict != nil && !net.netrestrict.Contains(n.IP) {
  681. return n, errors.New("not contained in netrestrict whitelist")
  682. }
  683. if err == nil {
  684. n.state = unknown
  685. net.nodes[n.ID] = n
  686. }
  687. return n, err
  688. }
  689. if !n.IP.Equal(rn.IP) || n.UDP != rn.UDP || n.TCP != rn.TCP {
  690. if n.state == known {
  691. // reject address change if node is known by us
  692. err = fmt.Errorf("metadata mismatch: got %v, want %v", rn, n)
  693. } else {
  694. // accept otherwise; this will be handled nicer with signed ENRs
  695. n.IP = rn.IP
  696. n.UDP = rn.UDP
  697. n.TCP = rn.TCP
  698. }
  699. }
  700. return n, err
  701. }
  702. // nodeNetGuts is embedded in Node and contains fields.
  703. type nodeNetGuts struct {
  704. // This is a cached copy of sha3(ID) which is used for node
  705. // distance calculations. This is part of Node in order to make it
  706. // possible to write tests that need a node at a certain distance.
  707. // In those tests, the content of sha will not actually correspond
  708. // with ID.
  709. sha common.Hash
  710. // State machine fields. Access to these fields
  711. // is restricted to the Network.loop goroutine.
  712. state *nodeState
  713. pingEcho []byte // hash of last ping sent by us
  714. pingTopics []Topic // topic set sent by us in last ping
  715. deferredQueries []*findnodeQuery // queries that can't be sent yet
  716. pendingNeighbours *findnodeQuery // current query, waiting for reply
  717. queryTimeouts int
  718. }
  719. func (n *nodeNetGuts) deferQuery(q *findnodeQuery) {
  720. n.deferredQueries = append(n.deferredQueries, q)
  721. }
  722. func (n *nodeNetGuts) startNextQuery(net *Network) {
  723. if len(n.deferredQueries) == 0 {
  724. return
  725. }
  726. nextq := n.deferredQueries[0]
  727. if nextq.start(net) {
  728. n.deferredQueries = append(n.deferredQueries[:0], n.deferredQueries[1:]...)
  729. }
  730. }
  731. func (q *findnodeQuery) start(net *Network) bool {
  732. // Satisfy queries against the local node directly.
  733. if q.remote == net.tab.self {
  734. closest := net.tab.closest(crypto.Keccak256Hash(q.target[:]), bucketSize)
  735. q.reply <- closest.entries
  736. return true
  737. }
  738. if q.remote.state.canQuery && q.remote.pendingNeighbours == nil {
  739. net.conn.sendFindnodeHash(q.remote, q.target)
  740. net.timedEvent(respTimeout, q.remote, neighboursTimeout)
  741. q.remote.pendingNeighbours = q
  742. return true
  743. }
  744. // If the node is not known yet, it won't accept queries.
  745. // Initiate the transition to known.
  746. // The request will be sent later when the node reaches known state.
  747. if q.remote.state == unknown {
  748. net.transition(q.remote, verifyinit)
  749. }
  750. return false
  751. }
  752. // Node Events (the input to the state machine).
  753. type nodeEvent uint
  754. //go:generate stringer -type=nodeEvent
  755. const (
  756. invalidEvent nodeEvent = iota // zero is reserved
  757. // Packet type events.
  758. // These correspond to packet types in the UDP protocol.
  759. pingPacket
  760. pongPacket
  761. findnodePacket
  762. neighborsPacket
  763. findnodeHashPacket
  764. topicRegisterPacket
  765. topicQueryPacket
  766. topicNodesPacket
  767. // Non-packet events.
  768. // Event values in this category are allocated outside
  769. // the packet type range (packet types are encoded as a single byte).
  770. pongTimeout nodeEvent = iota + 256
  771. pingTimeout
  772. neighboursTimeout
  773. )
  774. // Node State Machine.
  775. type nodeState struct {
  776. name string
  777. handle func(*Network, *Node, nodeEvent, *ingressPacket) (next *nodeState, err error)
  778. enter func(*Network, *Node)
  779. canQuery bool
  780. }
  781. func (s *nodeState) String() string {
  782. return s.name
  783. }
  784. var (
  785. unknown *nodeState
  786. verifyinit *nodeState
  787. verifywait *nodeState
  788. remoteverifywait *nodeState
  789. known *nodeState
  790. contested *nodeState
  791. unresponsive *nodeState
  792. )
  793. func init() {
  794. unknown = &nodeState{
  795. name: "unknown",
  796. enter: func(net *Network, n *Node) {
  797. net.tab.delete(n)
  798. n.pingEcho = nil
  799. // Abort active queries.
  800. for _, q := range n.deferredQueries {
  801. q.reply <- nil
  802. }
  803. n.deferredQueries = nil
  804. if n.pendingNeighbours != nil {
  805. n.pendingNeighbours.reply <- nil
  806. n.pendingNeighbours = nil
  807. }
  808. n.queryTimeouts = 0
  809. },
  810. handle: func(net *Network, n *Node, ev nodeEvent, pkt *ingressPacket) (*nodeState, error) {
  811. switch ev {
  812. case pingPacket:
  813. net.handlePing(n, pkt)
  814. net.ping(n, pkt.remoteAddr)
  815. return verifywait, nil
  816. default:
  817. return unknown, errInvalidEvent
  818. }
  819. },
  820. }
  821. verifyinit = &nodeState{
  822. name: "verifyinit",
  823. enter: func(net *Network, n *Node) {
  824. net.ping(n, n.addr())
  825. },
  826. handle: func(net *Network, n *Node, ev nodeEvent, pkt *ingressPacket) (*nodeState, error) {
  827. switch ev {
  828. case pingPacket:
  829. net.handlePing(n, pkt)
  830. return verifywait, nil
  831. case pongPacket:
  832. err := net.handleKnownPong(n, pkt)
  833. return remoteverifywait, err
  834. case pongTimeout:
  835. return unknown, nil
  836. default:
  837. return verifyinit, errInvalidEvent
  838. }
  839. },
  840. }
  841. verifywait = &nodeState{
  842. name: "verifywait",
  843. handle: func(net *Network, n *Node, ev nodeEvent, pkt *ingressPacket) (*nodeState, error) {
  844. switch ev {
  845. case pingPacket:
  846. net.handlePing(n, pkt)
  847. return verifywait, nil
  848. case pongPacket:
  849. err := net.handleKnownPong(n, pkt)
  850. return known, err
  851. case pongTimeout:
  852. return unknown, nil
  853. default:
  854. return verifywait, errInvalidEvent
  855. }
  856. },
  857. }
  858. remoteverifywait = &nodeState{
  859. name: "remoteverifywait",
  860. enter: func(net *Network, n *Node) {
  861. net.timedEvent(respTimeout, n, pingTimeout)
  862. },
  863. handle: func(net *Network, n *Node, ev nodeEvent, pkt *ingressPacket) (*nodeState, error) {
  864. switch ev {
  865. case pingPacket:
  866. net.handlePing(n, pkt)
  867. return remoteverifywait, nil
  868. case pingTimeout:
  869. return known, nil
  870. default:
  871. return remoteverifywait, errInvalidEvent
  872. }
  873. },
  874. }
  875. known = &nodeState{
  876. name: "known",
  877. canQuery: true,
  878. enter: func(net *Network, n *Node) {
  879. n.queryTimeouts = 0
  880. n.startNextQuery(net)
  881. // Insert into the table and start revalidation of the last node
  882. // in the bucket if it is full.
  883. last := net.tab.add(n)
  884. if last != nil && last.state == known {
  885. // TODO: do this asynchronously
  886. net.transition(last, contested)
  887. }
  888. },
  889. handle: func(net *Network, n *Node, ev nodeEvent, pkt *ingressPacket) (*nodeState, error) {
  890. switch ev {
  891. case pingPacket:
  892. net.handlePing(n, pkt)
  893. return known, nil
  894. case pongPacket:
  895. err := net.handleKnownPong(n, pkt)
  896. return known, err
  897. default:
  898. return net.handleQueryEvent(n, ev, pkt)
  899. }
  900. },
  901. }
  902. contested = &nodeState{
  903. name: "contested",
  904. canQuery: true,
  905. enter: func(net *Network, n *Node) {
  906. net.ping(n, n.addr())
  907. },
  908. handle: func(net *Network, n *Node, ev nodeEvent, pkt *ingressPacket) (*nodeState, error) {
  909. switch ev {
  910. case pongPacket:
  911. // Node is still alive.
  912. err := net.handleKnownPong(n, pkt)
  913. return known, err
  914. case pongTimeout:
  915. net.tab.deleteReplace(n)
  916. return unresponsive, nil
  917. case pingPacket:
  918. net.handlePing(n, pkt)
  919. return contested, nil
  920. default:
  921. return net.handleQueryEvent(n, ev, pkt)
  922. }
  923. },
  924. }
  925. unresponsive = &nodeState{
  926. name: "unresponsive",
  927. canQuery: true,
  928. handle: func(net *Network, n *Node, ev nodeEvent, pkt *ingressPacket) (*nodeState, error) {
  929. switch ev {
  930. case pingPacket:
  931. net.handlePing(n, pkt)
  932. return known, nil
  933. case pongPacket:
  934. err := net.handleKnownPong(n, pkt)
  935. return known, err
  936. default:
  937. return net.handleQueryEvent(n, ev, pkt)
  938. }
  939. },
  940. }
  941. }
  942. // handle processes packets sent by n and events related to n.
  943. func (net *Network) handle(n *Node, ev nodeEvent, pkt *ingressPacket) error {
  944. //fmt.Println("handle", n.addr().String(), n.state, ev)
  945. if pkt != nil {
  946. if err := net.checkPacket(n, ev, pkt); err != nil {
  947. //fmt.Println("check err:", err)
  948. return err
  949. }
  950. // Start the background expiration goroutine after the first
  951. // successful communication. Subsequent calls have no effect if it
  952. // is already running. We do this here instead of somewhere else
  953. // so that the search for seed nodes also considers older nodes
  954. // that would otherwise be removed by the expirer.
  955. if net.db != nil {
  956. net.db.ensureExpirer()
  957. }
  958. }
  959. if n.state == nil {
  960. n.state = unknown //???
  961. }
  962. next, err := n.state.handle(net, n, ev, pkt)
  963. net.transition(n, next)
  964. //fmt.Println("new state:", n.state)
  965. return err
  966. }
  967. func (net *Network) checkPacket(n *Node, ev nodeEvent, pkt *ingressPacket) error {
  968. // Replay prevention checks.
  969. switch ev {
  970. case pingPacket, findnodeHashPacket, neighborsPacket:
  971. // TODO: check date is > last date seen
  972. // TODO: check ping version
  973. case pongPacket:
  974. if !bytes.Equal(pkt.data.(*pong).ReplyTok, n.pingEcho) {
  975. // fmt.Println("pong reply token mismatch")
  976. return fmt.Errorf("pong reply token mismatch")
  977. }
  978. n.pingEcho = nil
  979. }
  980. // Address validation.
  981. // TODO: Ideally we would do the following:
  982. // - reject all packets with wrong address except ping.
  983. // - for ping with new address, transition to verifywait but keep the
  984. // previous node (with old address) around. if the new one reaches known,
  985. // swap it out.
  986. return nil
  987. }
  988. func (net *Network) transition(n *Node, next *nodeState) {
  989. if n.state != next {
  990. n.state = next
  991. if next.enter != nil {
  992. next.enter(net, n)
  993. }
  994. }
  995. // TODO: persist/unpersist node
  996. }
  997. func (net *Network) timedEvent(d time.Duration, n *Node, ev nodeEvent) {
  998. timeout := timeoutEvent{ev, n}
  999. net.timeoutTimers[timeout] = time.AfterFunc(d, func() {
  1000. select {
  1001. case net.timeout <- timeout:
  1002. case <-net.closed:
  1003. }
  1004. })
  1005. }
  1006. func (net *Network) abortTimedEvent(n *Node, ev nodeEvent) {
  1007. timer := net.timeoutTimers[timeoutEvent{ev, n}]
  1008. if timer != nil {
  1009. timer.Stop()
  1010. delete(net.timeoutTimers, timeoutEvent{ev, n})
  1011. }
  1012. }
  1013. func (net *Network) ping(n *Node, addr *net.UDPAddr) {
  1014. //fmt.Println("ping", n.addr().String(), n.ID.String(), n.sha.Hex())
  1015. if n.pingEcho != nil || n.ID == net.tab.self.ID {
  1016. //fmt.Println(" not sent")
  1017. return
  1018. }
  1019. log.Trace("Pinging remote node", "node", n.ID)
  1020. n.pingTopics = net.ticketStore.regTopicSet()
  1021. n.pingEcho = net.conn.sendPing(n, addr, n.pingTopics)
  1022. net.timedEvent(respTimeout, n, pongTimeout)
  1023. }
  1024. func (net *Network) handlePing(n *Node, pkt *ingressPacket) {
  1025. log.Trace("Handling remote ping", "node", n.ID)
  1026. ping := pkt.data.(*ping)
  1027. n.TCP = ping.From.TCP
  1028. t := net.topictab.getTicket(n, ping.Topics)
  1029. pong := &pong{
  1030. To: makeEndpoint(n.addr(), n.TCP), // TODO: maybe use known TCP port from DB
  1031. ReplyTok: pkt.hash,
  1032. Expiration: uint64(time.Now().Add(expiration).Unix()),
  1033. }
  1034. ticketToPong(t, pong)
  1035. net.conn.send(n, pongPacket, pong)
  1036. }
  1037. func (net *Network) handleKnownPong(n *Node, pkt *ingressPacket) error {
  1038. log.Trace("Handling known pong", "node", n.ID)
  1039. net.abortTimedEvent(n, pongTimeout)
  1040. now := mclock.Now()
  1041. ticket, err := pongToTicket(now, n.pingTopics, n, pkt)
  1042. if err == nil {
  1043. // fmt.Printf("(%x) ticket: %+v\n", net.tab.self.ID[:8], pkt.data)
  1044. net.ticketStore.addTicket(now, pkt.data.(*pong).ReplyTok, ticket)
  1045. } else {
  1046. log.Trace("Failed to convert pong to ticket", "err", err)
  1047. }
  1048. n.pingEcho = nil
  1049. n.pingTopics = nil
  1050. return err
  1051. }
  1052. func (net *Network) handleQueryEvent(n *Node, ev nodeEvent, pkt *ingressPacket) (*nodeState, error) {
  1053. switch ev {
  1054. case findnodePacket:
  1055. target := crypto.Keccak256Hash(pkt.data.(*findnode).Target[:])
  1056. results := net.tab.closest(target, bucketSize).entries
  1057. net.conn.sendNeighbours(n, results)
  1058. return n.state, nil
  1059. case neighborsPacket:
  1060. err := net.handleNeighboursPacket(n, pkt)
  1061. return n.state, err
  1062. case neighboursTimeout:
  1063. if n.pendingNeighbours != nil {
  1064. n.pendingNeighbours.reply <- nil
  1065. n.pendingNeighbours = nil
  1066. }
  1067. n.queryTimeouts++
  1068. if n.queryTimeouts > maxFindnodeFailures && n.state == known {
  1069. return contested, errors.New("too many timeouts")
  1070. }
  1071. return n.state, nil
  1072. // v5
  1073. case findnodeHashPacket:
  1074. results := net.tab.closest(pkt.data.(*findnodeHash).Target, bucketSize).entries
  1075. net.conn.sendNeighbours(n, results)
  1076. return n.state, nil
  1077. case topicRegisterPacket:
  1078. //fmt.Println("got topicRegisterPacket")
  1079. regdata := pkt.data.(*topicRegister)
  1080. pong, err := net.checkTopicRegister(regdata)
  1081. if err != nil {
  1082. //fmt.Println(err)
  1083. return n.state, fmt.Errorf("bad waiting ticket: %v", err)
  1084. }
  1085. net.topictab.useTicket(n, pong.TicketSerial, regdata.Topics, int(regdata.Idx), pong.Expiration, pong.WaitPeriods)
  1086. return n.state, nil
  1087. case topicQueryPacket:
  1088. // TODO: handle expiration
  1089. topic := pkt.data.(*topicQuery).Topic
  1090. results := net.topictab.getEntries(topic)
  1091. if _, ok := net.ticketStore.tickets[topic]; ok {
  1092. results = append(results, net.tab.self) // we're not registering in our own table but if we're advertising, return ourselves too
  1093. }
  1094. if len(results) > 10 {
  1095. results = results[:10]
  1096. }
  1097. var hash common.Hash
  1098. copy(hash[:], pkt.hash)
  1099. net.conn.sendTopicNodes(n, hash, results)
  1100. return n.state, nil
  1101. case topicNodesPacket:
  1102. p := pkt.data.(*topicNodes)
  1103. if net.ticketStore.gotTopicNodes(n, p.Echo, p.Nodes) {
  1104. n.queryTimeouts++
  1105. if n.queryTimeouts > maxFindnodeFailures && n.state == known {
  1106. return contested, errors.New("too many timeouts")
  1107. }
  1108. }
  1109. return n.state, nil
  1110. default:
  1111. return n.state, errInvalidEvent
  1112. }
  1113. }
  1114. func (net *Network) checkTopicRegister(data *topicRegister) (*pong, error) {
  1115. var pongpkt ingressPacket
  1116. if err := decodePacket(data.Pong, &pongpkt); err != nil {
  1117. return nil, err
  1118. }
  1119. if pongpkt.ev != pongPacket {
  1120. return nil, errors.New("is not pong packet")
  1121. }
  1122. if pongpkt.remoteID != net.tab.self.ID {
  1123. return nil, errors.New("not signed by us")
  1124. }
  1125. // check that we previously authorised all topics
  1126. // that the other side is trying to register.
  1127. if rlpHash(data.Topics) != pongpkt.data.(*pong).TopicHash {
  1128. return nil, errors.New("topic hash mismatch")
  1129. }
  1130. if data.Idx < 0 || int(data.Idx) >= len(data.Topics) {
  1131. return nil, errors.New("topic index out of range")
  1132. }
  1133. return pongpkt.data.(*pong), nil
  1134. }
  1135. func rlpHash(x interface{}) (h common.Hash) {
  1136. hw := sha3.NewKeccak256()
  1137. rlp.Encode(hw, x)
  1138. hw.Sum(h[:0])
  1139. return h
  1140. }
  1141. func (net *Network) handleNeighboursPacket(n *Node, pkt *ingressPacket) error {
  1142. if n.pendingNeighbours == nil {
  1143. return errNoQuery
  1144. }
  1145. net.abortTimedEvent(n, neighboursTimeout)
  1146. req := pkt.data.(*neighbors)
  1147. nodes := make([]*Node, len(req.Nodes))
  1148. for i, rn := range req.Nodes {
  1149. nn, err := net.internNodeFromNeighbours(pkt.remoteAddr, rn)
  1150. if err != nil {
  1151. log.Debug(fmt.Sprintf("invalid neighbour (%v) from %x@%v: %v", rn.IP, n.ID[:8], pkt.remoteAddr, err))
  1152. continue
  1153. }
  1154. nodes[i] = nn
  1155. // Start validation of query results immediately.
  1156. // This fills the table quickly.
  1157. // TODO: generates way too many packets, maybe do it via queue.
  1158. if nn.state == unknown {
  1159. net.transition(nn, verifyinit)
  1160. }
  1161. }
  1162. // TODO: don't ignore second packet
  1163. n.pendingNeighbours.reply <- nodes
  1164. n.pendingNeighbours = nil
  1165. // Now that this query is done, start the next one.
  1166. n.startNextQuery(net)
  1167. return nil
  1168. }