ccdqueue.cpp 119 KB

12345678910111213141516171819202122232425262728293031323334353637383940414243444546474849505152535455565758596061626364656667686970717273747576777879808182838485868788899091929394959697989910010110210310410510610710810911011111211311411511611711811912012112212312412512612712812913013113213313413513613713813914014114214314414514614714814915015115215315415515615715815916016116216316416516616716816917017117217317417517617717817918018118218318418518618718818919019119219319419519619719819920020120220320420520620720820921021121221321421521621721821922022122222322422522622722822923023123223323423523623723823924024124224324424524624724824925025125225325425525625725825926026126226326426526626726826927027127227327427527627727827928028128228328428528628728828929029129229329429529629729829930030130230330430530630730830931031131231331431531631731831932032132232332432532632732832933033133233333433533633733833934034134234334434534634734834935035135235335435535635735835936036136236336436536636736836937037137237337437537637737837938038138238338438538638738838939039139239339439539639739839940040140240340440540640740840941041141241341441541641741841942042142242342442542642742842943043143243343443543643743843944044144244344444544644744844945045145245345445545645745845946046146246346446546646746846947047147247347447547647747847948048148248348448548648748848949049149249349449549649749849950050150250350450550650750850951051151251351451551651751851952052152252352452552652752852953053153253353453553653753853954054154254354454554654754854955055155255355455555655755855956056156256356456556656756856957057157257357457557657757857958058158258358458558658758858959059159259359459559659759859960060160260360460560660760860961061161261361461561661761861962062162262362462562662762862963063163263363463563663763863964064164264364464564664764864965065165265365465565665765865966066166266366466566666766866967067167267367467567667767867968068168268368468568668768868969069169269369469569669769869970070170270370470570670770870971071171271371471571671771871972072172272372472572672772872973073173273373473573673773873974074174274374474574674774874975075175275375475575675775875976076176276376476576676776876977077177277377477577677777877978078178278378478578678778878979079179279379479579679779879980080180280380480580680780880981081181281381481581681781881982082182282382482582682782882983083183283383483583683783883984084184284384484584684784884985085185285385485585685785885986086186286386486586686786886987087187287387487587687787887988088188288388488588688788888989089189289389489589689789889990090190290390490590690790890991091191291391491591691791891992092192292392492592692792892993093193293393493593693793893994094194294394494594694794894995095195295395495595695795895996096196296396496596696796896997097197297397497597697797897998098198298398498598698798898999099199299399499599699799899910001001100210031004100510061007100810091010101110121013101410151016101710181019102010211022102310241025102610271028102910301031103210331034103510361037103810391040104110421043104410451046104710481049105010511052105310541055105610571058105910601061106210631064106510661067106810691070107110721073107410751076107710781079108010811082108310841085108610871088108910901091109210931094109510961097109810991100110111021103110411051106110711081109111011111112111311141115111611171118111911201121112211231124112511261127112811291130113111321133113411351136113711381139114011411142114311441145114611471148114911501151115211531154115511561157115811591160116111621163116411651166116711681169117011711172117311741175117611771178117911801181118211831184118511861187118811891190119111921193119411951196119711981199120012011202120312041205120612071208120912101211121212131214121512161217121812191220122112221223122412251226122712281229123012311232123312341235123612371238123912401241124212431244124512461247124812491250125112521253125412551256125712581259126012611262126312641265126612671268126912701271127212731274127512761277127812791280128112821283128412851286128712881289129012911292129312941295129612971298129913001301130213031304130513061307130813091310131113121313131413151316131713181319132013211322132313241325132613271328132913301331133213331334133513361337133813391340134113421343134413451346134713481349135013511352135313541355135613571358135913601361136213631364136513661367136813691370137113721373137413751376137713781379138013811382138313841385138613871388138913901391139213931394139513961397139813991400140114021403140414051406140714081409141014111412141314141415141614171418141914201421142214231424142514261427142814291430143114321433143414351436143714381439144014411442144314441445144614471448144914501451145214531454145514561457145814591460146114621463146414651466146714681469147014711472147314741475147614771478147914801481148214831484148514861487148814891490149114921493149414951496149714981499150015011502150315041505150615071508150915101511151215131514151515161517151815191520152115221523152415251526152715281529153015311532153315341535153615371538153915401541154215431544154515461547154815491550155115521553155415551556155715581559156015611562156315641565156615671568156915701571157215731574157515761577157815791580158115821583158415851586158715881589159015911592159315941595159615971598159916001601160216031604160516061607160816091610161116121613161416151616161716181619162016211622162316241625162616271628162916301631163216331634163516361637163816391640164116421643164416451646164716481649165016511652165316541655165616571658165916601661166216631664166516661667166816691670167116721673167416751676167716781679168016811682168316841685168616871688168916901691169216931694169516961697169816991700170117021703170417051706170717081709171017111712171317141715171617171718171917201721172217231724172517261727172817291730173117321733173417351736173717381739174017411742174317441745174617471748174917501751175217531754175517561757175817591760176117621763176417651766176717681769177017711772177317741775177617771778177917801781178217831784178517861787178817891790179117921793179417951796179717981799180018011802180318041805180618071808180918101811181218131814181518161817181818191820182118221823182418251826182718281829183018311832183318341835183618371838183918401841184218431844184518461847184818491850185118521853185418551856185718581859186018611862186318641865186618671868186918701871187218731874187518761877187818791880188118821883188418851886188718881889189018911892189318941895189618971898189919001901190219031904190519061907190819091910191119121913191419151916191719181919192019211922192319241925192619271928192919301931193219331934193519361937193819391940194119421943194419451946194719481949195019511952195319541955195619571958195919601961196219631964196519661967196819691970197119721973197419751976197719781979198019811982198319841985198619871988198919901991199219931994199519961997199819992000200120022003200420052006200720082009201020112012201320142015201620172018201920202021202220232024202520262027202820292030203120322033203420352036203720382039204020412042204320442045204620472048204920502051205220532054205520562057205820592060206120622063206420652066206720682069207020712072207320742075207620772078207920802081208220832084208520862087208820892090209120922093209420952096209720982099210021012102210321042105210621072108210921102111211221132114211521162117211821192120212121222123212421252126212721282129213021312132213321342135213621372138213921402141214221432144214521462147214821492150215121522153215421552156215721582159216021612162216321642165216621672168216921702171217221732174217521762177217821792180218121822183218421852186218721882189219021912192219321942195219621972198219922002201220222032204220522062207220822092210221122122213221422152216221722182219222022212222222322242225222622272228222922302231223222332234223522362237223822392240224122422243224422452246224722482249225022512252225322542255225622572258225922602261226222632264226522662267226822692270227122722273227422752276227722782279228022812282228322842285228622872288228922902291229222932294229522962297229822992300230123022303230423052306230723082309231023112312231323142315231623172318231923202321232223232324232523262327232823292330233123322333233423352336233723382339234023412342234323442345234623472348234923502351235223532354235523562357235823592360236123622363236423652366236723682369237023712372237323742375237623772378237923802381238223832384238523862387238823892390239123922393239423952396239723982399240024012402240324042405240624072408240924102411241224132414241524162417241824192420242124222423242424252426242724282429243024312432243324342435243624372438243924402441244224432444244524462447244824492450245124522453245424552456245724582459246024612462246324642465246624672468246924702471247224732474247524762477247824792480248124822483248424852486248724882489249024912492249324942495249624972498249925002501250225032504250525062507250825092510251125122513251425152516251725182519252025212522252325242525252625272528252925302531253225332534253525362537253825392540254125422543254425452546254725482549255025512552255325542555255625572558255925602561256225632564256525662567256825692570257125722573257425752576257725782579258025812582258325842585258625872588258925902591259225932594259525962597259825992600260126022603260426052606260726082609261026112612261326142615261626172618261926202621262226232624262526262627262826292630263126322633263426352636263726382639264026412642264326442645264626472648264926502651265226532654265526562657265826592660266126622663266426652666266726682669267026712672267326742675267626772678267926802681268226832684268526862687268826892690269126922693269426952696269726982699270027012702270327042705270627072708270927102711271227132714271527162717271827192720272127222723272427252726272727282729273027312732273327342735273627372738273927402741274227432744274527462747274827492750275127522753275427552756275727582759276027612762276327642765276627672768276927702771277227732774277527762777277827792780278127822783278427852786278727882789279027912792279327942795279627972798279928002801280228032804280528062807280828092810281128122813281428152816281728182819282028212822282328242825282628272828282928302831283228332834283528362837283828392840284128422843284428452846284728482849285028512852285328542855285628572858285928602861286228632864286528662867286828692870287128722873287428752876287728782879288028812882288328842885288628872888288928902891289228932894289528962897289828992900290129022903290429052906290729082909291029112912291329142915291629172918291929202921292229232924292529262927292829292930293129322933293429352936293729382939294029412942294329442945294629472948294929502951295229532954295529562957295829592960296129622963296429652966296729682969297029712972297329742975297629772978297929802981298229832984298529862987298829892990299129922993299429952996299729982999300030013002300330043005300630073008300930103011301230133014301530163017301830193020302130223023302430253026302730283029303030313032303330343035303630373038303930403041304230433044304530463047304830493050305130523053305430553056305730583059306030613062306330643065306630673068306930703071307230733074307530763077307830793080308130823083308430853086308730883089309030913092309330943095309630973098309931003101310231033104310531063107310831093110311131123113311431153116311731183119312031213122312331243125312631273128312931303131313231333134313531363137313831393140314131423143314431453146314731483149315031513152315331543155315631573158315931603161316231633164316531663167316831693170317131723173317431753176317731783179318031813182318331843185318631873188318931903191319231933194319531963197319831993200320132023203320432053206320732083209321032113212321332143215321632173218321932203221322232233224322532263227322832293230323132323233323432353236323732383239324032413242324332443245324632473248324932503251325232533254325532563257325832593260326132623263326432653266326732683269327032713272327332743275327632773278327932803281328232833284328532863287328832893290329132923293329432953296329732983299330033013302330333043305330633073308330933103311331233133314331533163317331833193320332133223323332433253326332733283329333033313332333333343335333633373338333933403341334233433344334533463347334833493350335133523353335433553356335733583359336033613362336333643365336633673368336933703371337233733374337533763377337833793380338133823383338433853386338733883389339033913392339333943395339633973398339934003401340234033404340534063407340834093410341134123413341434153416341734183419342034213422342334243425342634273428342934303431343234333434343534363437343834393440344134423443344434453446344734483449345034513452345334543455345634573458345934603461346234633464346534663467346834693470347134723473347434753476347734783479348034813482348334843485348634873488348934903491349234933494349534963497349834993500350135023503350435053506350735083509351035113512351335143515
  1. /*##############################################################################
  2. HPCC SYSTEMS software Copyright (C) 2012 HPCC Systems®.
  3. Licensed under the Apache License, Version 2.0 (the "License");
  4. you may not use this file except in compliance with the License.
  5. You may obtain a copy of the License at
  6. http://www.apache.org/licenses/LICENSE-2.0
  7. Unless required by applicable law or agreed to in writing, software
  8. distributed under the License is distributed on an "AS IS" BASIS,
  9. WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
  10. See the License for the specific language governing permissions and
  11. limitations under the License.
  12. ############################################################################## */
  13. #include <platform.h>
  14. #include <jlib.hpp>
  15. #include <jio.hpp>
  16. #include <jqueue.tpp>
  17. #include <jsocket.hpp>
  18. #include <jlog.hpp>
  19. #include "jisem.hpp"
  20. #include "jencrypt.hpp"
  21. #include "udplib.hpp"
  22. #include "udptopo.hpp"
  23. #include "ccd.hpp"
  24. #include "ccddebug.hpp"
  25. #include "ccdquery.hpp"
  26. #include "ccdstate.hpp"
  27. #include "ccdqueue.ipp"
  28. #include "ccdsnmp.hpp"
  29. #ifdef _USE_CPPUNIT
  30. #include <cppunit/extensions/HelperMacros.h>
  31. #endif
  32. using roxiemem::OwnedRoxieRow;
  33. using roxiemem::OwnedConstRoxieRow;
  34. using roxiemem::IRowManager;
  35. using roxiemem::DataBuffer;
  36. //============================================================================================
  37. RoxiePacketHeader::RoxiePacketHeader(const RemoteActivityId &_remoteId, ruid_t _uid, unsigned _channel, unsigned _overflowSequence)
  38. {
  39. packetlength = sizeof(RoxiePacketHeader);
  40. #ifdef TIME_PACKETS
  41. tick = 0;
  42. #endif
  43. init(_remoteId, _uid, _channel, _overflowSequence);
  44. }
  45. RoxiePacketHeader::RoxiePacketHeader(const RoxiePacketHeader &source, unsigned _activityId, unsigned subChannel) : serverId(source.serverId)
  46. {
  47. // Used to create the header to send a callback to originating server or an IBYTI to a buddy
  48. activityId = _activityId;
  49. uid = source.uid;
  50. queryHash = source.queryHash;
  51. channel = source.channel;
  52. overflowSequence = source.overflowSequence;
  53. continueSequence = source.continueSequence;
  54. if (_activityId >= ROXIE_ACTIVITY_SPECIAL_FIRST && _activityId <= ROXIE_ACTIVITY_SPECIAL_LAST)
  55. overflowSequence |= OUTOFBAND_SEQUENCE; // Need to make sure it is not treated as dup of actual reply in the udp layer
  56. retries = getSubChannelMask(subChannel) | (source.retries & ~ROXIE_RETRIES_MASK);
  57. #ifdef TIME_PACKETS
  58. tick = source.tick;
  59. #endif
  60. #ifdef SUBCHANNELS_IN_HEADER
  61. memcpy(subChannels, source.subChannels, sizeof(subChannels));
  62. #endif
  63. packetlength = sizeof(RoxiePacketHeader);
  64. }
  65. unsigned RoxiePacketHeader::getSubChannelMask(unsigned subChannel)
  66. {
  67. return SUBCHANNEL_MASK << (SUBCHANNEL_BITS * subChannel);
  68. }
  69. unsigned RoxiePacketHeader::priorityHash() const
  70. {
  71. // Used to determine which agent to act as primary and which as secondary for a given packet (thus spreading the load)
  72. // It's important that we do NOT include channel (since that would result in different values for the different agents responding to a broadcast)
  73. // We also don't include continueSequence since we'd prefer continuations to go the same way as original
  74. unsigned hash = serverId.hash();
  75. hash = hashc((const unsigned char *) &uid, sizeof(uid), hash);
  76. hash += overflowSequence; // MORE - is this better than hashing?
  77. if (traceLevel > 9)
  78. {
  79. StringBuffer s;
  80. DBGLOG("Calculating hash: %s hash was %d", toString(s).str(), hash);
  81. }
  82. return hash;
  83. }
  84. void RoxiePacketHeader::copy(const RoxiePacketHeader &oh)
  85. {
  86. // used for saving away kill packets for later matching by match
  87. uid = oh.uid;
  88. overflowSequence = oh.overflowSequence;
  89. continueSequence = oh.continueSequence;
  90. serverId = oh.serverId;
  91. channel = oh.channel;
  92. // MORE - would it be safer, maybe even faster to copy the rest too?
  93. }
  94. bool RoxiePacketHeader::matchPacket(const RoxiePacketHeader &oh) const
  95. {
  96. // used when matching up a kill packet against a pending one...
  97. // DO NOT compare activityId - they are not supposed to match, since 0 in activityid identifies ibyti!
  98. return
  99. oh.uid==uid &&
  100. (oh.overflowSequence & ~OUTOFBAND_SEQUENCE) == (overflowSequence & ~OUTOFBAND_SEQUENCE) &&
  101. oh.continueSequence == continueSequence &&
  102. oh.serverId==serverId &&
  103. oh.channel==channel;
  104. }
  105. void RoxiePacketHeader::init(const RemoteActivityId &_remoteId, ruid_t _uid, unsigned _channel, unsigned _overflowSequence)
  106. {
  107. retries = 0;
  108. activityId = _remoteId.activityId;
  109. queryHash = _remoteId.queryHash;
  110. uid = _uid;
  111. serverId = myNode;
  112. channel = _channel;
  113. overflowSequence = _overflowSequence;
  114. continueSequence = 0;
  115. #ifdef SUBCHANNELS_IN_HEADER
  116. clearSubChannels();
  117. #endif
  118. }
  119. #ifdef SUBCHANNELS_IN_HEADER
  120. void RoxiePacketHeader::clearSubChannels()
  121. {
  122. for (unsigned idx = 0; idx < MAX_SUBCHANNEL; idx++)
  123. subChannels[idx].clear();
  124. }
  125. #endif
  126. StringBuffer &RoxiePacketHeader::toString(StringBuffer &ret) const
  127. {
  128. const IpAddress serverIP = serverId.getIpAddress();
  129. ret.append("activityId=");
  130. switch(activityId & ~ROXIE_PRIORITY_MASK)
  131. {
  132. case 0: ret.append("IBYTI"); break;
  133. case ROXIE_UNLOAD: ret.append("ROXIE_UNLOAD"); break;
  134. case ROXIE_PING: ret.append("ROXIE_PING"); break;
  135. case ROXIE_TRACEINFO: ret.append("ROXIE_TRACEINFO"); break;
  136. case ROXIE_DEBUGREQUEST: ret.append("ROXIE_DEBUGREQUEST"); break;
  137. case ROXIE_DEBUGCALLBACK: ret.append("ROXIE_DEBUGCALLBACK"); break;
  138. case ROXIE_FILECALLBACK: ret.append("ROXIE_FILECALLBACK"); break;
  139. case ROXIE_ALIVE: ret.append("ROXIE_ALIVE"); break;
  140. case ROXIE_KEYEDLIMIT_EXCEEDED: ret.append("ROXIE_KEYEDLIMIT_EXCEEDED"); break;
  141. case ROXIE_LIMIT_EXCEEDED: ret.append("ROXIE_LIMIT_EXCEEDED"); break;
  142. case ROXIE_EXCEPTION: ret.append("ROXIE_EXCEPTION"); break;
  143. default:
  144. ret.appendf("%u", (activityId & ~(ROXIE_ACTIVITY_FETCH | ROXIE_PRIORITY_MASK)));
  145. if (activityId & ROXIE_ACTIVITY_FETCH)
  146. ret.appendf(" (fetch part)");
  147. break;
  148. }
  149. ret.appendf(" uid=" RUIDF " pri=", uid);
  150. switch(activityId & ROXIE_PRIORITY_MASK)
  151. {
  152. case ROXIE_SLA_PRIORITY: ret.append("SLA"); break;
  153. case ROXIE_HIGH_PRIORITY: ret.append("HIGH"); break;
  154. case ROXIE_LOW_PRIORITY: ret.append("LOW"); break;
  155. default: ret.append("???"); break;
  156. }
  157. ret.appendf(" queryHash=%" I64F "x ch=%u seq=%d cont=%d server=", queryHash, channel, overflowSequence, continueSequence);
  158. serverIP.getIpText(ret);
  159. if (retries)
  160. {
  161. if (retries==QUERY_ABORTED)
  162. ret.append(" retries=QUERY_ABORTED");
  163. else
  164. {
  165. if (retries & ROXIE_RETRIES_MASK)
  166. ret.appendf(" retries=%04x", retries);
  167. if (retries & ROXIE_FASTLANE)
  168. ret.appendf(" FASTLANE");
  169. if (retries & ROXIE_BROADCAST)
  170. ret.appendf(" BROADCAST");
  171. }
  172. }
  173. #ifdef SUBCHANNELS_IN_HEADER
  174. ret.append(" subchannels=");
  175. for (unsigned idx = 0; idx < MAX_SUBCHANNEL; idx++)
  176. {
  177. if (subChannels[idx].isNull())
  178. break;
  179. if (idx)
  180. ret.append(',');
  181. subChannels[idx].getTraceText(ret);
  182. if (subChannels[idx].isMe())
  183. {
  184. ret.append("(me)");
  185. }
  186. }
  187. #endif
  188. return ret;
  189. }
  190. bool RoxiePacketHeader::allChannelsFailed()
  191. {
  192. unsigned mask = (1 << (getNumAgents(channel) * SUBCHANNEL_BITS)) - 1;
  193. return (retries & mask) == mask;
  194. }
  195. bool RoxiePacketHeader::retry()
  196. {
  197. bool worthRetrying = false;
  198. unsigned mask = SUBCHANNEL_MASK;
  199. unsigned numAgents = getNumAgents(channel);
  200. for (unsigned subChannel = 0; subChannel < numAgents; subChannel++)
  201. {
  202. unsigned subRetries = (retries & mask) >> (subChannel * SUBCHANNEL_BITS);
  203. if (subRetries != SUBCHANNEL_MASK)
  204. subRetries++;
  205. if (subRetries != SUBCHANNEL_MASK)
  206. worthRetrying = true;
  207. retries = (retries & ~mask) | (subRetries << (subChannel * SUBCHANNEL_BITS));
  208. mask <<= SUBCHANNEL_BITS;
  209. }
  210. return worthRetrying;
  211. }
  212. void RoxiePacketHeader::setException(unsigned subChannel)
  213. {
  214. retries |= SUBCHANNEL_MASK << (SUBCHANNEL_BITS * subChannel);
  215. }
  216. unsigned RoxiePacketHeader::thisChannelRetries(unsigned subChannel)
  217. {
  218. unsigned shift = SUBCHANNEL_BITS * subChannel;
  219. unsigned mask = SUBCHANNEL_MASK << shift;
  220. return (retries & mask) >> shift;
  221. }
  222. //============================================================================================
  223. unsigned getReplicationLevel(unsigned channel)
  224. {
  225. if (!channel)
  226. return 0;
  227. Owned<const ITopologyServer> topology = getTopology();
  228. return topology->queryChannelInfo(channel).replicationLevel();
  229. }
  230. //============================================================================================
  231. // This function maps a agent number to the multicast ip used to talk to it.
  232. IpAddress multicastBase("239.1.1.1"); // TBD IPv6 (need IPv6 multicast addresses?
  233. IpAddress multicastLast("239.1.5.254");
  234. const IpAddress &getChannelIp(IpAddress &ip, unsigned _channel)
  235. {
  236. // need to be careful to avoid the .0's and the .255's (not sure why...)
  237. ip = multicastBase;
  238. if (!ip.ipincrement(_channel,1,254,1,0xffff)
  239. ||(ip.ipcompare(multicastLast)>0))
  240. throw MakeStringException(ROXIE_MULTICAST_ERROR, "Out-of-range multicast channel %d", _channel);
  241. return ip;
  242. }
  243. static Owned<ISocket> multicastSocket;
  244. void joinMulticastChannel(unsigned channel)
  245. {
  246. IpAddress multicastIp;
  247. getChannelIp(multicastIp, channel);
  248. SocketEndpoint ep(ccdMulticastPort, multicastIp);
  249. StringBuffer epStr;
  250. ep.getUrlStr(epStr);
  251. if (!multicastSocket->join_multicast_group(ep))
  252. throw MakeStringException(ROXIE_MULTICAST_ERROR, "Failed to join multicast channel %d (%s)", channel, epStr.str());
  253. if (traceLevel)
  254. DBGLOG("Joined multicast channel %d (%s)", channel, epStr.str());
  255. }
  256. static SocketEndpointArray multicastEndpoints; // indexed by channel
  257. void setMulticastEndpoints(unsigned numChannels)
  258. {
  259. for (unsigned channel = 0; channel <= numChannels; channel++) // NOTE - channel 0 is special, and numChannels does not include it
  260. {
  261. IpAddress multicastIp;
  262. getChannelIp(multicastIp, channel);
  263. multicastEndpoints.append(SocketEndpoint(ccdMulticastPort, multicastIp));
  264. }
  265. }
  266. void openMulticastSocket()
  267. {
  268. if (!multicastSocket)
  269. {
  270. multicastSocket.setown(ISocket::udp_create(ccdMulticastPort));
  271. if (multicastTTL)
  272. {
  273. multicastSocket->set_ttl(multicastTTL);
  274. DBGLOG("Roxie: multicastTTL: %u", multicastTTL);
  275. }
  276. else
  277. DBGLOG("Roxie: multicastTTL not set");
  278. multicastSocket->set_receive_buffer_size(udpMulticastBufferSize);
  279. size32_t actualSize = multicastSocket->get_receive_buffer_size();
  280. if (actualSize < udpMulticastBufferSize)
  281. {
  282. DBGLOG("Roxie: multicast socket buffer size could not be set (requested=%d actual %d", udpMulticastBufferSize, actualSize);
  283. throwUnexpected();
  284. }
  285. if (traceLevel)
  286. DBGLOG("Roxie: multicast socket created port=%d sockbuffsize=%d actual %d", ccdMulticastPort, udpMulticastBufferSize, actualSize);
  287. if (roxieMulticastEnabled && !localAgent)
  288. {
  289. Owned<const ITopologyServer> topology = getTopology();
  290. for (unsigned channel : topology->queryChannels())
  291. {
  292. assertex(channel);
  293. joinMulticastChannel(channel);
  294. }
  295. joinMulticastChannel(0); // all agents also listen on channel 0
  296. }
  297. }
  298. }
  299. void closeMulticastSockets()
  300. {
  301. multicastSocket.clear();
  302. }
  303. static bool channelWrite(RoxiePacketHeader &buf, bool includeSelf)
  304. {
  305. size32_t minwrote = 0;
  306. if (roxieMulticastEnabled)
  307. {
  308. return multicastSocket->udp_write_to(multicastEndpoints.item(buf.channel), &buf, buf.packetlength) == buf.packetlength;
  309. }
  310. else
  311. {
  312. #ifdef SUBCHANNELS_IN_HEADER
  313. // In the containerized system, the list of subchannel IPs is captured in the packet header to ensure everyone is using the
  314. // same snapshot of the topology state.
  315. // If the subchannel IPs are not set, fill them in now. If they are set, use them.
  316. if (buf.subChannels[0].isNull())
  317. {
  318. Owned<const ITopologyServer> topo = getTopology();
  319. const SocketEndpointArray &eps = topo->queryAgents(buf.channel);
  320. if (!eps.ordinality())
  321. throw makeStringExceptionV(0, "No agents available for channel %d", buf.channel);
  322. if (buf.channel==0)
  323. {
  324. // Note that we expand any writes on channel 0 here, since we need to capture the server's view of what agents are on each channel
  325. bool allOk = true;
  326. if (traceRoxiePackets)
  327. {
  328. StringBuffer header;
  329. DBGLOG("Translating packet sent to channel 0: %s", buf.toString(header).str());
  330. }
  331. for (unsigned channel = 0; channel < numChannels; channel++)
  332. {
  333. buf.channel = channel+1;
  334. if (!channelWrite(buf, true))
  335. allOk = false;
  336. buf.clearSubChannels();
  337. }
  338. buf.channel = 0;
  339. return allOk;
  340. }
  341. unsigned hdrHashVal = buf.priorityHash();
  342. unsigned numAgents = eps.ordinality();
  343. unsigned subChannel = (hdrHashVal % numAgents);
  344. for (unsigned idx = 0; idx < MAX_SUBCHANNEL; idx++)
  345. {
  346. if (idx == numAgents)
  347. break;
  348. buf.subChannels[idx].setIp(eps.item(subChannel));
  349. subChannel++;
  350. if (subChannel == numAgents)
  351. subChannel = 0;
  352. }
  353. }
  354. else
  355. {
  356. assert(buf.channel != 0);
  357. }
  358. for (unsigned subChannel = 0; subChannel < MAX_SUBCHANNEL; subChannel++)
  359. {
  360. if (buf.subChannels[subChannel].isNull())
  361. break;
  362. if (includeSelf || !buf.subChannels[subChannel].isMe())
  363. {
  364. if (traceRoxiePackets)
  365. {
  366. StringBuffer s, header;
  367. DBGLOG("Writing %d bytes to subchannel %d (%s) %s", buf.packetlength, subChannel, buf.subChannels[subChannel].getTraceText(s).str(), buf.toString(header).str());
  368. }
  369. SocketEndpoint ep(ccdMulticastPort, buf.subChannels[subChannel].getIpAddress());
  370. size32_t wrote = multicastSocket->udp_write_to(ep, &buf, buf.packetlength);
  371. if (!subChannel || wrote < minwrote)
  372. minwrote = wrote;
  373. if (delaySubchannelPackets)
  374. MilliSleep(100);
  375. }
  376. else if (traceRoxiePackets)
  377. {
  378. StringBuffer s, header;
  379. DBGLOG("NOT writing %d bytes to subchannel %d (%s) %s", buf.packetlength, subChannel, buf.subChannels[subChannel].getTraceText(s).str(), buf.toString(header).str());
  380. }
  381. }
  382. #else
  383. Owned<const ITopologyServer> topo = getTopology();
  384. const SocketEndpointArray &eps = topo->queryAgents(buf.channel);
  385. if (!eps.ordinality())
  386. throw makeStringExceptionV(0, "No agents available for channel %d", buf.channel);
  387. ForEachItemIn(idx, eps)
  388. {
  389. size32_t wrote = multicastSocket->udp_write_to(eps.item(idx), &buf, buf.packetlength);
  390. if (!idx || wrote < minwrote)
  391. minwrote = wrote;
  392. }
  393. #endif
  394. }
  395. return minwrote==buf.packetlength;
  396. }
  397. //============================================================================================
  398. class CRoxieQueryPacketBase : public CInterface
  399. {
  400. protected:
  401. RoxiePacketHeader *data;
  402. const byte *traceInfo;
  403. unsigned traceLength;
  404. public:
  405. IMPLEMENT_IINTERFACE;
  406. CRoxieQueryPacketBase(const void *_data, int lengthRemaining) : data((RoxiePacketHeader *) _data)
  407. {
  408. assertex(lengthRemaining >= (int) sizeof(RoxiePacketHeader));
  409. data->packetlength = lengthRemaining;
  410. const byte *finger = (const byte *) (data + 1);
  411. lengthRemaining -= sizeof(RoxiePacketHeader);
  412. if (data->activityId == ROXIE_FILECALLBACK || data->activityId == ROXIE_DEBUGCALLBACK || data->retries == QUERY_ABORTED)
  413. {
  414. traceInfo = NULL;
  415. traceLength = 0;
  416. }
  417. else
  418. {
  419. assertex(lengthRemaining > 1);
  420. traceInfo = finger;
  421. lengthRemaining--;
  422. if (*finger++ & LOGGING_DEBUGGERACTIVE)
  423. {
  424. assertex(lengthRemaining >= (int) sizeof(unsigned short));
  425. unsigned short debugLen = *(unsigned short *) finger;
  426. finger += debugLen + sizeof(unsigned short);
  427. lengthRemaining -= debugLen + sizeof(unsigned short);
  428. }
  429. for (;;)
  430. {
  431. assertex(lengthRemaining>0);
  432. if (!*finger)
  433. {
  434. lengthRemaining--;
  435. finger++;
  436. break;
  437. }
  438. lengthRemaining--;
  439. finger++;
  440. }
  441. traceLength = finger - traceInfo;
  442. }
  443. }
  444. ~CRoxieQueryPacketBase()
  445. {
  446. free(data);
  447. }
  448. };
  449. // MORE - this is for TESTING ONLY - do not release with this key here like this!
  450. static byte key[32] = {
  451. 0xf7, 0xe8, 0x79, 0x40, 0x44, 0x16, 0x66, 0x18, 0x52, 0xb8, 0x18, 0x6e, 0x76, 0xd1, 0x68, 0xd3,
  452. 0x87, 0x47, 0x01, 0xe6, 0x66, 0x62, 0x2f, 0xbe, 0xc1, 0xd5, 0x9f, 0x4a, 0x53, 0x27, 0xae, 0xa1,
  453. };
  454. class CRoxieQueryPacket : public CRoxieQueryPacketBase, implements IRoxieQueryPacket
  455. {
  456. protected:
  457. const byte *continuationData = nullptr;
  458. unsigned continuationLength = 0;
  459. const byte *smartStepInfoData = nullptr;
  460. unsigned smartStepInfoLength = 0;
  461. const byte *contextData = nullptr;
  462. unsigned contextLength = 0;
  463. public:
  464. IMPLEMENT_IINTERFACE;
  465. CRoxieQueryPacket(const void *_data, int length) : CRoxieQueryPacketBase(_data, length)
  466. {
  467. const byte *finger = (const byte *) (data + 1) + traceLength;
  468. int lengthRemaining = length - sizeof(RoxiePacketHeader) - traceLength;
  469. if (data->activityId == ROXIE_FILECALLBACK || data->activityId == ROXIE_DEBUGCALLBACK || data->retries == QUERY_ABORTED)
  470. {
  471. continuationData = NULL;
  472. continuationLength = 0;
  473. smartStepInfoData = NULL;
  474. smartStepInfoLength = 0;
  475. }
  476. else
  477. {
  478. if (data->continueSequence & ~CONTINUE_SEQUENCE_SKIPTO)
  479. {
  480. assertex(lengthRemaining >= (int) sizeof(unsigned short));
  481. continuationLength = *(unsigned short *) finger;
  482. continuationData = finger + sizeof(unsigned short);
  483. finger = continuationData + continuationLength;
  484. lengthRemaining -= continuationLength + sizeof(unsigned short);
  485. }
  486. if (data->continueSequence & CONTINUE_SEQUENCE_SKIPTO)
  487. {
  488. assertex(lengthRemaining >= (int) sizeof(unsigned short));
  489. smartStepInfoLength = *(unsigned short *) finger;
  490. smartStepInfoData = finger + sizeof(unsigned short);
  491. finger = smartStepInfoData + smartStepInfoLength;
  492. lengthRemaining -= smartStepInfoLength + sizeof(unsigned short);
  493. }
  494. }
  495. assertex(lengthRemaining >= 0);
  496. contextData = finger;
  497. contextLength = lengthRemaining;
  498. }
  499. virtual RoxiePacketHeader &queryHeader() const
  500. {
  501. return *data;
  502. }
  503. virtual const byte *queryTraceInfo() const
  504. {
  505. return traceInfo;
  506. }
  507. virtual unsigned getTraceLength() const
  508. {
  509. return traceLength;
  510. }
  511. virtual const void *queryContinuationData() const
  512. {
  513. return continuationData;
  514. }
  515. virtual unsigned getContinuationLength() const
  516. {
  517. return continuationLength;
  518. }
  519. virtual const byte *querySmartStepInfoData() const
  520. {
  521. return smartStepInfoData;
  522. }
  523. virtual unsigned getSmartStepInfoLength() const
  524. {
  525. return smartStepInfoLength;
  526. }
  527. virtual const void *queryContextData() const
  528. {
  529. return contextData;
  530. }
  531. virtual unsigned getContextLength() const
  532. {
  533. return contextLength;
  534. }
  535. virtual IRoxieQueryPacket *clonePacket(unsigned channel) const
  536. {
  537. unsigned length = data->packetlength;
  538. RoxiePacketHeader *newdata = (RoxiePacketHeader *) malloc(length);
  539. memcpy(newdata, data, length);
  540. newdata->channel = channel;
  541. newdata->retries |= ROXIE_BROADCAST;
  542. return createRoxiePacket(newdata, length);
  543. }
  544. virtual IRoxieQueryPacket *insertSkipData(size32_t skipDataLen, const void *skipData) const
  545. {
  546. assertex((data->continueSequence & CONTINUE_SEQUENCE_SKIPTO) == 0); // Should not already be any skipto info in the source packet
  547. unsigned newDataSize = data->packetlength + sizeof(unsigned short) + skipDataLen;
  548. char *newdata = (char *) malloc(newDataSize);
  549. unsigned headSize = sizeof(RoxiePacketHeader);
  550. if (traceLength)
  551. headSize += traceLength;
  552. if (data->continueSequence & ~CONTINUE_SEQUENCE_SKIPTO)
  553. headSize += sizeof(unsigned short) + continuationLength;
  554. memcpy(newdata, data, headSize); // copy in leading part of old data
  555. ((RoxiePacketHeader *) newdata)->continueSequence |= CONTINUE_SEQUENCE_SKIPTO; // set flag indicating new data is present
  556. *(unsigned short *) (newdata + headSize) = skipDataLen; // add length field for new data
  557. memcpy(newdata + headSize + sizeof(unsigned short), skipData, skipDataLen); // copy in new data
  558. memcpy(newdata + headSize + sizeof(unsigned short) + skipDataLen, ((char *) data) + headSize, data->packetlength - headSize); // copy in remaining old data
  559. return createRoxiePacket(newdata, newDataSize);
  560. }
  561. virtual ISerializedRoxieQueryPacket *serialize() const override
  562. {
  563. unsigned length = data->packetlength;
  564. MemoryBuffer mb;
  565. if (encryptInTransit)
  566. {
  567. const byte *plainData = (const byte *) (data+1);
  568. plainData += traceLength;
  569. unsigned plainLen = length - sizeof(RoxiePacketHeader) - traceLength;
  570. mb.append(sizeof(RoxiePacketHeader)+traceLength, data); // Header and traceInfo are unencrypted
  571. aesEncrypt(key, sizeof(key), plainData, plainLen, mb); // Encrypt everything else
  572. RoxiePacketHeader *newHeader = (RoxiePacketHeader *) mb.toByteArray();
  573. newHeader->packetlength = mb.length();
  574. }
  575. else
  576. {
  577. mb.append(length, data);
  578. }
  579. return createSerializedRoxiePacket(mb);
  580. }
  581. };
  582. // CNocryptRoxieQueryPacket implements both serialized and deserialized packet interfaces, to avoid additional copy operations when
  583. // using localAgent mode.
  584. class CNocryptRoxieQueryPacket: public CRoxieQueryPacket, implements ISerializedRoxieQueryPacket
  585. {
  586. public:
  587. IMPLEMENT_IINTERFACE;
  588. CNocryptRoxieQueryPacket(const void *_data, int length) : CRoxieQueryPacket(_data, length)
  589. {
  590. }
  591. virtual RoxiePacketHeader &queryHeader() const
  592. {
  593. return CRoxieQueryPacket::queryHeader();
  594. }
  595. virtual const byte *queryTraceInfo() const
  596. {
  597. return traceInfo;
  598. }
  599. virtual unsigned getTraceLength() const
  600. {
  601. return traceLength;
  602. }
  603. virtual ISerializedRoxieQueryPacket *cloneSerializedPacket(unsigned channel) const
  604. {
  605. unsigned length = data->packetlength;
  606. RoxiePacketHeader *newdata = (RoxiePacketHeader *) malloc(length);
  607. memcpy(newdata, data, length);
  608. newdata->channel = channel;
  609. newdata->retries |= ROXIE_BROADCAST;
  610. return new CNocryptRoxieQueryPacket(newdata, length);
  611. }
  612. virtual ISerializedRoxieQueryPacket *serialize() const override
  613. {
  614. return const_cast<CNocryptRoxieQueryPacket *>(LINK(this));
  615. }
  616. virtual IRoxieQueryPacket *deserialize() const override
  617. {
  618. return const_cast<CNocryptRoxieQueryPacket *>(LINK(this));
  619. }
  620. };
  621. class CSerializedRoxieQueryPacket : public CRoxieQueryPacketBase, implements ISerializedRoxieQueryPacket
  622. {
  623. public:
  624. IMPLEMENT_IINTERFACE;
  625. CSerializedRoxieQueryPacket(const void *_data, int length) : CRoxieQueryPacketBase(_data, length)
  626. {
  627. }
  628. virtual RoxiePacketHeader &queryHeader() const
  629. {
  630. return *data;
  631. }
  632. virtual const byte *queryTraceInfo() const
  633. {
  634. return traceInfo;
  635. }
  636. virtual unsigned getTraceLength() const
  637. {
  638. return traceLength;
  639. }
  640. virtual ISerializedRoxieQueryPacket *cloneSerializedPacket(unsigned channel) const
  641. {
  642. unsigned length = data->packetlength;
  643. RoxiePacketHeader *newdata = (RoxiePacketHeader *) malloc(length);
  644. memcpy(newdata, data, length);
  645. newdata->channel = channel;
  646. newdata->retries |= ROXIE_BROADCAST;
  647. return new CSerializedRoxieQueryPacket(newdata, length);
  648. }
  649. virtual IRoxieQueryPacket *deserialize() const override
  650. {
  651. unsigned length = data->packetlength;
  652. MemoryBuffer mb;
  653. if (encryptInTransit)
  654. {
  655. const byte *encryptedData = (const byte *) (data+1);
  656. encryptedData += traceLength;
  657. unsigned encryptedLen = length - sizeof(RoxiePacketHeader) - traceLength;
  658. mb.append(sizeof(RoxiePacketHeader)+traceLength, data); // Header and traceInfo are unencrypted
  659. aesDecrypt(key, sizeof(key), encryptedData, encryptedLen, mb); // Decrypt everything else
  660. RoxiePacketHeader *newHeader = (RoxiePacketHeader *) mb.toByteArray();
  661. newHeader->packetlength = mb.length();
  662. }
  663. else
  664. {
  665. mb.append(length, data);
  666. }
  667. return createRoxiePacket(mb);
  668. }
  669. };
  670. extern IRoxieQueryPacket *createRoxiePacket(void *_data, unsigned _len)
  671. {
  672. if (!encryptInTransit)
  673. return new CNocryptRoxieQueryPacket(_data, _len);
  674. if ((unsigned short)_len != _len)
  675. {
  676. StringBuffer s;
  677. RoxiePacketHeader *header = (RoxiePacketHeader *) _data;
  678. header->toString(s);
  679. free(_data);
  680. throw MakeStringException(ROXIE_PACKET_ERROR, "Packet length %d exceeded maximum sending packet %s", _len, s.str());
  681. }
  682. return new CRoxieQueryPacket(_data, _len);
  683. }
  684. extern IRoxieQueryPacket *createRoxiePacket(MemoryBuffer &m)
  685. {
  686. unsigned length = m.length(); // don't make assumptions about evaluation order of parameters...
  687. return createRoxiePacket(m.detachOwn(), length);
  688. }
  689. extern IRoxieQueryPacket *deserializeCallbackPacket(MemoryBuffer &m)
  690. {
  691. // Direct decryption of special packets - others are only decrypted after being dequeued
  692. if (encryptInTransit)
  693. {
  694. RoxiePacketHeader *header = (RoxiePacketHeader *) m.toByteArray();
  695. assertex(header != nullptr);
  696. assertex(header->activityId == ROXIE_FILECALLBACK || header->activityId == ROXIE_DEBUGCALLBACK);
  697. assertex(m.length() >= header->packetlength);
  698. unsigned encryptedLen = header->packetlength - sizeof(RoxiePacketHeader);
  699. const void *encryptedData = (const void *)(header+1);
  700. MemoryBuffer decrypted;
  701. decrypted.append(sizeof(RoxiePacketHeader), header);
  702. decrypted.ensureCapacity(encryptedLen); // May be up to 16 bytes smaller...
  703. aesDecrypt(key, sizeof(key), encryptedData, encryptedLen, decrypted);
  704. unsigned length = decrypted.length();
  705. RoxiePacketHeader *newHeader = (RoxiePacketHeader *) decrypted.detachOwn();
  706. newHeader->packetlength = length;
  707. return createRoxiePacket(newHeader, length);
  708. }
  709. else
  710. {
  711. unsigned length = m.length(); // don't make assumptions about evaluation order of parameters...
  712. return createRoxiePacket(m.detachOwn(), length);
  713. }
  714. }
  715. extern ISerializedRoxieQueryPacket *createSerializedRoxiePacket(MemoryBuffer &m)
  716. {
  717. unsigned length = m.length(); // don't make assumptions about evaluation order of parameters...
  718. return new CSerializedRoxieQueryPacket(m.detachOwn(), length);
  719. }
  720. //=================================================================================
  721. AgentContextLogger::AgentContextLogger()
  722. {
  723. GetHostIp(ip);
  724. set(NULL);
  725. }
  726. AgentContextLogger::AgentContextLogger(ISerializedRoxieQueryPacket *packet)
  727. {
  728. GetHostIp(ip);
  729. set(packet);
  730. }
  731. void AgentContextLogger::set(ISerializedRoxieQueryPacket *packet)
  732. {
  733. anyOutput = false;
  734. intercept = false;
  735. debuggerActive = false;
  736. checkingHeap = false;
  737. aborted = false;
  738. stats.reset();
  739. start = msTick();
  740. if (packet)
  741. {
  742. CriticalBlock b(crit); // Why?
  743. RoxiePacketHeader &header = packet->queryHeader();
  744. const byte *traceInfo = packet->queryTraceInfo();
  745. StringBuffer s;
  746. if (traceInfo)
  747. {
  748. unsigned traceLength = packet->getTraceLength();
  749. unsigned char loggingFlags = *traceInfo;
  750. if (loggingFlags & LOGGING_FLAGSPRESENT) // should always be true.... but this flag is handy to avoid flags byte ever being NULL
  751. {
  752. traceInfo++;
  753. traceLength--;
  754. if (loggingFlags & LOGGING_INTERCEPTED)
  755. intercept = true;
  756. if (loggingFlags & LOGGING_TRACELEVELSET)
  757. {
  758. ctxTraceLevel = (*traceInfo++ - 1); // avoid null byte here in case anyone still thinks there's just a null-terminated string
  759. traceLength--;
  760. }
  761. if (loggingFlags & LOGGING_BLIND)
  762. blind = true;
  763. if (loggingFlags & LOGGING_CHECKINGHEAP)
  764. checkingHeap = true;
  765. if (loggingFlags & LOGGING_DEBUGGERACTIVE)
  766. {
  767. assertex(traceLength > sizeof(unsigned short));
  768. debuggerActive = true;
  769. unsigned short debugLen = *(unsigned short *) traceInfo;
  770. traceInfo += debugLen + sizeof(unsigned short);
  771. traceLength -= debugLen + sizeof(unsigned short);
  772. }
  773. // Passing the wuid via the logging context prefix is a lot of a hack...
  774. if (loggingFlags & LOGGING_WUID)
  775. {
  776. unsigned wuidLen = 0;
  777. while (wuidLen < traceLength)
  778. {
  779. if (traceInfo[wuidLen]=='@'||traceInfo[wuidLen]==':')
  780. break;
  781. wuidLen++;
  782. }
  783. wuid.set((const char *) traceInfo, wuidLen);
  784. }
  785. }
  786. s.append(traceLength, (const char *) traceInfo);
  787. s.append("|");
  788. }
  789. channel = header.channel;
  790. ip.getIpText(s);
  791. s.append(':').append(channel);
  792. StringContextLogger::set(s.str());
  793. if (intercept || mergeAgentStatistics)
  794. {
  795. RoxiePacketHeader newHeader(header, ROXIE_TRACEINFO, 0); // subchannel not relevant
  796. output.setown(ROQ->createOutputStream(newHeader, true, *this));
  797. }
  798. }
  799. else
  800. {
  801. StringContextLogger::set("");
  802. channel = 0;
  803. }
  804. }
  805. void AgentContextLogger::putStatProcessed(unsigned subGraphId, unsigned actId, unsigned idx, unsigned processed, unsigned strands) const
  806. {
  807. if (output && mergeAgentStatistics)
  808. {
  809. MemoryBuffer buf;
  810. buf.append((char) LOG_CHILDCOUNT); // A special log entry for the stats
  811. buf.append(subGraphId);
  812. buf.append(actId);
  813. buf.append(idx);
  814. buf.append(processed);
  815. buf.append(strands);
  816. }
  817. }
  818. void AgentContextLogger::putStats(unsigned subGraphId, unsigned actId, const CRuntimeStatisticCollection &stats) const
  819. {
  820. if (output && mergeAgentStatistics)
  821. {
  822. MemoryBuffer buf;
  823. buf.append((char) LOG_CHILDSTATS); // A special log entry for the stats
  824. buf.append(subGraphId);
  825. buf.append(actId);
  826. if (stats.serialize(buf))
  827. {
  828. unsigned len = buf.length();
  829. void *ret = output->getBuffer(len, true);
  830. memcpy(ret, buf.toByteArray(), len);
  831. output->putBuffer(ret, len, true);
  832. anyOutput = true;
  833. }
  834. }
  835. }
  836. void AgentContextLogger::flush()
  837. {
  838. if (output)
  839. {
  840. CriticalBlock b(crit);
  841. if (mergeAgentStatistics)
  842. {
  843. MemoryBuffer buf;
  844. buf.append((char) LOG_STATVALUES); // A special log entry for the stats
  845. if (stats.serialize(buf))
  846. {
  847. unsigned len = buf.length();
  848. void *ret = output->getBuffer(len, true);
  849. memcpy(ret, buf.toByteArray(), len);
  850. output->putBuffer(ret, len, true);
  851. anyOutput = true;
  852. }
  853. }
  854. ForEachItemIn(idx, log)
  855. {
  856. MemoryBuffer buf;
  857. LogItem &logItem = log.item(idx);
  858. logItem.serialize(buf);
  859. unsigned len = buf.length();
  860. void *ret = output->getBuffer(len, true);
  861. memcpy(ret, buf.toByteArray(), len);
  862. output->putBuffer(ret, len, true);
  863. anyOutput = true;
  864. }
  865. log.kill();
  866. if (anyOutput)
  867. output->flush();
  868. output.clear();
  869. }
  870. }
  871. //=================================================================================
  872. static SpinLock onDemandQueriesCrit;
  873. static MapXToMyClass<hash64_t, hash64_t, IQueryFactory> onDemandQueryCache;
  874. void sendUnloadMessage(hash64_t hash, const char *id, const IRoxieContextLogger &logctx)
  875. {
  876. RemoteActivityId unloadId(ROXIE_UNLOAD, hash);
  877. RoxiePacketHeader header(unloadId, 0, 0, 0);
  878. MemoryBuffer mb;
  879. mb.append(sizeof(RoxiePacketHeader), &header);
  880. mb.append((char) LOGGING_FLAGSPRESENT);
  881. mb.append(id);
  882. if (traceLevel > 1)
  883. DBGLOG("UNLOAD sent for query %s", id);
  884. Owned<IRoxieQueryPacket> packet = createRoxiePacket(mb);
  885. ROQ->sendPacket(packet, logctx);
  886. }
  887. void doUnload(IRoxieQueryPacket *packet, const IRoxieContextLogger &logctx)
  888. {
  889. const RoxiePacketHeader &header = packet->queryHeader();
  890. unsigned channelNo = header.channel;
  891. if (logctx.queryTraceLevel())
  892. logctx.CTXLOG("Unload received for channel %d", channelNo);
  893. hash64_t hashValue = header.queryHash;
  894. hashValue = rtlHash64Data(sizeof(channelNo), &channelNo, hashValue);
  895. SpinBlock b(onDemandQueriesCrit);
  896. onDemandQueryCache.remove(hashValue);
  897. }
  898. void cacheOnDemandQuery(hash64_t hashValue, unsigned channelNo, IQueryFactory *query)
  899. {
  900. hashValue = rtlHash64Data(sizeof(channelNo), &channelNo, hashValue);
  901. SpinBlock b(onDemandQueriesCrit);
  902. onDemandQueryCache.setValue(hashValue, query);
  903. }
  904. //=================================================================================
  905. struct PingRecord
  906. {
  907. unsigned tick;
  908. IpAddress senderIP;
  909. };
  910. void doPing(IRoxieQueryPacket *packet, const IRoxieContextLogger &logctx)
  911. {
  912. const RoxiePacketHeader &header = packet->queryHeader();
  913. const IpAddress serverIP = header.serverId.getIpAddress();
  914. unsigned contextLength = packet->getContextLength();
  915. if (contextLength != sizeof(PingRecord))
  916. {
  917. StringBuffer s;
  918. throw MakeStringException(ROXIE_UNKNOWN_SERVER, "Unexpected data size %d (expected %d) in PING: %s", contextLength, (unsigned) sizeof(PingRecord), header.toString(s).str());
  919. }
  920. const PingRecord *data = (const PingRecord *) packet->queryContextData();
  921. if (!serverIP.ipequals(data->senderIP))
  922. {
  923. StringBuffer s;
  924. throw MakeStringException(ROXIE_UNKNOWN_SERVER, "Message received from unknown Roxie server %s", header.toString(s).str());
  925. }
  926. RoxiePacketHeader newHeader(header, ROXIE_PING, 0); // subchannel not relevant
  927. Owned<IMessagePacker> output = ROQ->createOutputStream(newHeader, true, logctx);
  928. void *ret = output->getBuffer(contextLength, false);
  929. memcpy(ret, data, contextLength);
  930. output->putBuffer(ret, contextLength, false);
  931. output->flush();
  932. }
  933. //=================================================================================
  934. static ThreadId roxiePacketReaderThread = 0;
  935. class IBYTIbuffer
  936. {
  937. // This class is used to track a finite set of recently-received IBYTI messages, that may have arrived before the messages they refer to
  938. // It is accessed ONLY from the main reader thread and as such does not need to be threadsafe (but does need to be fast).
  939. // We use a circular buffer, and don't bother removing anything (just treat old items as expired). If the buffer overflows we will end up
  940. // discarding the oldest tracked orphaned IBYTI - but that's ok, no worse than if we hadn't tracked them at all.
  941. public:
  942. IBYTIbuffer(unsigned _numOrphans) : numOrphans(_numOrphans)
  943. {
  944. assertex(numOrphans);
  945. orphans = new RoxiePacketHeader[numOrphans];
  946. tail = 0;
  947. }
  948. void noteOrphan(const RoxiePacketHeader &hdr)
  949. {
  950. assert(GetCurrentThreadId()==roxiePacketReaderThread);
  951. unsigned now = msTick();
  952. // We could trace that the buffer may be too small, if (orphans[tail].activityId >= now)
  953. orphans[tail].copy(hdr);
  954. orphans[tail].activityId = now + IBYTIbufferLifetime;
  955. tail++;
  956. if (tail == numOrphans)
  957. tail = 0;
  958. }
  959. bool lookup(const RoxiePacketHeader &hdr) const
  960. {
  961. assert(GetCurrentThreadId()==roxiePacketReaderThread);
  962. unsigned now = msTick();
  963. unsigned lookat = tail;
  964. do
  965. {
  966. if (!lookat)
  967. lookat = numOrphans;
  968. lookat--;
  969. if ((int) (orphans[lookat].activityId - now) < 0) // Watch out for wrapping
  970. break; // expired;
  971. if (orphans[lookat].matchPacket(hdr))
  972. return true;
  973. } while (lookat != tail);
  974. return false;
  975. }
  976. private:
  977. RoxiePacketHeader *orphans = nullptr;
  978. unsigned tail = 0;
  979. unsigned numOrphans = 0;
  980. };
  981. //=================================================================================
  982. //
  983. // RoxieQueue - holds pending transactions on a roxie agent
  984. class RoxieQueue : public CInterface, implements IThreadFactory
  985. {
  986. Owned <IThreadPool> workers;
  987. QueueOf<ISerializedRoxieQueryPacket, true> waiting;
  988. Semaphore available;
  989. CriticalSection qcrit;
  990. unsigned headRegionSize;
  991. unsigned numWorkers;
  992. RelaxedAtomic<unsigned> started;
  993. std::atomic<unsigned> idle;
  994. IBYTIbuffer *myIBYTIbuffer = nullptr;
  995. void noteQueued()
  996. {
  997. maxQueueLength.store_max(++queueLength);
  998. // NOTE - there is a small race condition here - if idle is 1 but two enqueue's happen
  999. // close enough together that the signal has not yet caused idle to come back down to zero, then the
  1000. // desired new thread may not be created. It's unlikely, and it's benign in that the query is still
  1001. // processed and the thread will be created next time the HWM is reached.
  1002. if (started < numWorkers && idle==0)
  1003. {
  1004. workers->start(this);
  1005. started++;
  1006. }
  1007. }
  1008. public:
  1009. IMPLEMENT_IINTERFACE;
  1010. RoxieQueue(unsigned _headRegionSize, unsigned _numWorkers)
  1011. {
  1012. headRegionSize = _headRegionSize;
  1013. numWorkers = _numWorkers;
  1014. workers.setown(createThreadPool("RoxieWorkers", this, NULL, numWorkers));
  1015. started = 0;
  1016. idle = 0;
  1017. if (IBYTIbufferSize)
  1018. myIBYTIbuffer = new IBYTIbuffer(IBYTIbufferSize);
  1019. }
  1020. ~RoxieQueue()
  1021. {
  1022. delete myIBYTIbuffer;
  1023. }
  1024. virtual IPooledThread *createNew();
  1025. void abortChannel(unsigned channel);
  1026. void start()
  1027. {
  1028. if (prestartAgentThreads)
  1029. {
  1030. while (started < numWorkers)
  1031. {
  1032. workers->start(this);
  1033. started++;
  1034. }
  1035. }
  1036. }
  1037. IPooledThreadIterator *running()
  1038. {
  1039. return workers->running();
  1040. }
  1041. void stopAll()
  1042. {
  1043. workers->stopAll(true);
  1044. signal(workers->runningCount());
  1045. }
  1046. void join()
  1047. {
  1048. workers->joinAll(true);
  1049. workers.clear(); // Breaks a cyclic reference count that would stop us from releasing RoxieReceiverThread otherwise
  1050. }
  1051. void enqueue(ISerializedRoxieQueryPacket *x)
  1052. {
  1053. {
  1054. #ifdef TIME_PACKETS
  1055. x->queryHeader().tick = msTick();
  1056. #endif
  1057. CriticalBlock qc(qcrit);
  1058. waiting.enqueue(x);
  1059. noteQueued();
  1060. }
  1061. available.signal();
  1062. }
  1063. void enqueueUnique(ISerializedRoxieQueryPacket *x, unsigned subChannel)
  1064. {
  1065. RoxiePacketHeader &header = x->queryHeader();
  1066. #ifdef TIME_PACKETS
  1067. header.tick = msTick();
  1068. #endif
  1069. bool found = false;
  1070. {
  1071. CriticalBlock qc(qcrit);
  1072. unsigned len = waiting.ordinality();
  1073. unsigned i;
  1074. for (i = 0; i < len; i++)
  1075. {
  1076. ISerializedRoxieQueryPacket *queued = waiting.item(i);
  1077. if (queued && queued->queryHeader().matchPacket(header))
  1078. {
  1079. found = true;
  1080. break;
  1081. }
  1082. }
  1083. if (!found)
  1084. waiting.enqueue(x);
  1085. }
  1086. if (found)
  1087. {
  1088. if (traceLevel > 0)
  1089. {
  1090. StringBuffer xx;
  1091. AgentContextLogger l(x);
  1092. l.CTXLOG("Ignored retry on subchannel %u for queued activity %s", subChannel, header.toString(xx).str());
  1093. }
  1094. if (!subChannel)
  1095. retriesIgnoredPrm++;
  1096. else
  1097. retriesIgnoredSec++;
  1098. x->Release();
  1099. }
  1100. else
  1101. {
  1102. available.signal();
  1103. noteQueued();
  1104. if (traceLevel > 10)
  1105. {
  1106. AgentContextLogger l(x);
  1107. StringBuffer xx;
  1108. l.CTXLOG("enqueued %s", header.toString(xx).str());
  1109. }
  1110. }
  1111. }
  1112. bool remove(RoxiePacketHeader &x)
  1113. {
  1114. unsigned scanLength = 0;
  1115. ISerializedRoxieQueryPacket *found = nullptr;
  1116. {
  1117. CriticalBlock qc(qcrit);
  1118. unsigned len = waiting.ordinality();
  1119. unsigned i;
  1120. for (i = 0; i < len; i++)
  1121. {
  1122. ISerializedRoxieQueryPacket *queued = waiting.item(i);
  1123. if (queued)
  1124. {
  1125. scanLength++;
  1126. if (queued->queryHeader().matchPacket(x))
  1127. {
  1128. waiting.set(i, NULL);
  1129. found = queued;
  1130. break;
  1131. }
  1132. }
  1133. }
  1134. }
  1135. if (found)
  1136. {
  1137. #ifdef _DEBUG
  1138. RoxiePacketHeader &header = found->queryHeader();
  1139. AgentContextLogger l(found);
  1140. StringBuffer xx;
  1141. l.CTXLOG("discarded %s", header.toString(xx).str());
  1142. #endif
  1143. found->Release();
  1144. queueLength--;
  1145. if (scanLength > maxScanLength)
  1146. maxScanLength = scanLength;
  1147. totScanLength += scanLength;
  1148. totScans++;
  1149. return true;
  1150. }
  1151. else
  1152. return false;
  1153. }
  1154. void wait()
  1155. {
  1156. idle++;
  1157. available.wait();
  1158. idle--;
  1159. }
  1160. void signal(unsigned num)
  1161. {
  1162. available.signal(num);
  1163. }
  1164. ISerializedRoxieQueryPacket *dequeue()
  1165. {
  1166. CriticalBlock qc(qcrit);
  1167. unsigned lim = waiting.ordinality();
  1168. if (lim)
  1169. {
  1170. if (headRegionSize)
  1171. {
  1172. if (lim > headRegionSize)
  1173. lim = headRegionSize;
  1174. return waiting.dequeue(fastRand() % lim);
  1175. }
  1176. return waiting.dequeue();
  1177. }
  1178. else
  1179. return NULL;
  1180. }
  1181. unsigned getHeadRegionSize() const
  1182. {
  1183. return headRegionSize;
  1184. }
  1185. unsigned setHeadRegionSize(unsigned newsize)
  1186. {
  1187. unsigned ret = headRegionSize;
  1188. headRegionSize = newsize;
  1189. return ret;
  1190. }
  1191. void noteOrphanIBYTI(const RoxiePacketHeader &hdr)
  1192. {
  1193. if (myIBYTIbuffer)
  1194. myIBYTIbuffer->noteOrphan(hdr);
  1195. }
  1196. bool lookupOrphanIBYTI(const RoxiePacketHeader &hdr) const
  1197. {
  1198. if (myIBYTIbuffer)
  1199. return myIBYTIbuffer->lookup(hdr);
  1200. else
  1201. return false;
  1202. }
  1203. };
  1204. class CRoxieWorker : public CInterface, implements IPooledThread
  1205. {
  1206. RoxieQueue *queue;
  1207. CriticalSection actCrit;
  1208. #ifndef NEW_IBYTI
  1209. Semaphore ibytiSem;
  1210. #endif
  1211. bool stopped;
  1212. bool abortJob;
  1213. bool busy;
  1214. Owned<IRoxieAgentActivity> activity;
  1215. Owned<IRoxieQueryPacket> packet;
  1216. Owned<const ITopologyServer> topology;
  1217. AgentContextLogger logctx;
  1218. public:
  1219. IMPLEMENT_IINTERFACE;
  1220. CRoxieWorker()
  1221. {
  1222. queue = NULL;
  1223. stopped = false;
  1224. busy = false;
  1225. abortJob = false;
  1226. }
  1227. virtual void init(void *_r) override
  1228. {
  1229. queue = (RoxieQueue *) _r;
  1230. stopped = false;
  1231. busy = false;
  1232. abortJob = false;
  1233. }
  1234. virtual bool canReuse() const override
  1235. {
  1236. return true;
  1237. }
  1238. virtual bool stop() override
  1239. {
  1240. stopped = true;
  1241. return true;
  1242. }
  1243. inline void setActivity(IRoxieAgentActivity *act)
  1244. {
  1245. CriticalBlock b(actCrit);
  1246. activity.setown(act);
  1247. }
  1248. inline bool match(RoxiePacketHeader &h)
  1249. {
  1250. // There is a window between getting packet from queue and being able to match it.
  1251. // This could cause some deduping to fail, but it does not matter if it does (so long as it is rare!)
  1252. CriticalBlock b(actCrit);
  1253. return packet && packet->queryHeader().matchPacket(h);
  1254. }
  1255. void abortChannel(unsigned channel)
  1256. {
  1257. CriticalBlock b(actCrit);
  1258. if (packet && packet->queryHeader().channel==channel)
  1259. {
  1260. abortJob = true;
  1261. #ifndef NEW_IBYTI
  1262. if (doIbytiDelay)
  1263. ibytiSem.signal();
  1264. #endif
  1265. if (activity)
  1266. activity->abort();
  1267. }
  1268. }
  1269. bool checkAbort(RoxiePacketHeader &h, bool checkRank, bool &queryFound, bool &preActivity)
  1270. {
  1271. CriticalBlock b(actCrit);
  1272. if (packet && packet->queryHeader().matchPacket(h))
  1273. {
  1274. queryFound = true;
  1275. abortJob = true;
  1276. #ifndef NEW_IBYTI
  1277. if (doIbytiDelay)
  1278. ibytiSem.signal();
  1279. #endif
  1280. if (activity)
  1281. {
  1282. // Try to stop/abort a job after it starts only if IBYTI comes from a higher priority agent
  1283. // (more primary in the rank). The agents with higher rank will hold the lower bits of the retries field in IBYTI packet).
  1284. #ifdef SUBCHANNELS_IN_HEADER
  1285. if (!checkRank || h.getRespondingSubChannel() < h.mySubChannel())
  1286. #else
  1287. if (!checkRank || topology->queryChannelInfo(h.channel).otherAgentHasPriority(h.priorityHash(), h.getRespondingSubChannel()))
  1288. #endif
  1289. {
  1290. activity->abort();
  1291. return true;
  1292. }
  1293. else
  1294. {
  1295. return false;
  1296. }
  1297. }
  1298. if (busy)
  1299. {
  1300. preActivity = true;
  1301. return true;
  1302. }
  1303. }
  1304. return false;
  1305. }
  1306. void throwRemoteException(IException *E, IRoxieAgentActivity *activity, IRoxieQueryPacket *packet, bool isUser)
  1307. {
  1308. try
  1309. {
  1310. if (activity && (logctx.queryTraceLevel() > 1))
  1311. {
  1312. StringBuffer act;
  1313. activity->toString(act);
  1314. logctx.CTXLOG("throwRemoteException, activity %s, isUser=%d", act.str(), (int) isUser);
  1315. if (!isUser)
  1316. EXCLOG(E, "throwRemoteException");
  1317. }
  1318. RoxiePacketHeader &header = packet->queryHeader();
  1319. #ifdef SUBCHANNELS_IN_HEADER
  1320. unsigned mySubChannel = header.mySubChannel();
  1321. #else
  1322. unsigned mySubChannel = topology->queryChannelInfo(header.channel).subChannel();
  1323. #endif
  1324. // I failed to do the query, but already sent out IBYTI - resend it so someone else can try
  1325. if (!isUser)
  1326. {
  1327. StringBuffer s;
  1328. s.append("Exception in agent for packet ");
  1329. header.toString(s);
  1330. logctx.logOperatorException(E, NULL, 0, "%s", s.str());
  1331. header.setException(mySubChannel);
  1332. if (!header.allChannelsFailed() && !localAgent)
  1333. {
  1334. if (logctx.queryTraceLevel() > 1)
  1335. logctx.CTXLOG("resending packet from agent in case others want to try it");
  1336. ROQ->sendPacket(packet, logctx);
  1337. }
  1338. }
  1339. RoxiePacketHeader newHeader(header, ROXIE_EXCEPTION, mySubChannel);
  1340. if (isUser)
  1341. newHeader.retries = (unsigned short) -1;
  1342. Owned<IMessagePacker> output = ROQ->createOutputStream(newHeader, true, logctx);
  1343. StringBuffer message("<Exception>");
  1344. message.appendf("<Code>%d</Code><Message>", E->errorCode());
  1345. StringBuffer err;
  1346. E->errorMessage(err);
  1347. encodeXML(err.str(), message);
  1348. message.append("</Message></Exception>");
  1349. unsigned len = message.length();
  1350. void *ret = output->getBuffer(len+1, true);
  1351. memcpy(ret, message.str(), len+1);
  1352. output->putBuffer(ret, len+1, true);
  1353. output->flush();
  1354. E->Release();
  1355. }
  1356. catch (IException *EInE)
  1357. {
  1358. EXCLOG(EInE, "Exception during throwRemoteException");
  1359. E->Release();
  1360. EInE->Release();
  1361. }
  1362. catch (...)
  1363. {
  1364. logctx.CTXLOG("Unknown Exception during throwRemoteException");
  1365. E->Release();
  1366. }
  1367. }
  1368. void doActivity()
  1369. {
  1370. RoxiePacketHeader &header = packet->queryHeader();
  1371. unsigned channel = header.channel;
  1372. hash64_t queryHash = packet->queryHeader().queryHash;
  1373. unsigned activityId = packet->queryHeader().activityId & ~ROXIE_PRIORITY_MASK;
  1374. Owned<IQueryFactory> queryFactory = getQueryFactory(queryHash, channel);
  1375. #ifdef SUBCHANNELS_IN_HEADER
  1376. unsigned mySubChannel = header.mySubChannel();
  1377. #else
  1378. unsigned numAgents = topology->queryAgents(channel).ordinality();
  1379. unsigned mySubChannel = topology->queryChannelInfo(channel).subChannel();
  1380. #endif
  1381. if (!queryFactory && logctx.queryWuid())
  1382. {
  1383. Owned <IRoxieDaliHelper> daliHelper = connectToDali();
  1384. Owned<IConstWorkUnit> wu = daliHelper->attachWorkunit(logctx.queryWuid(), NULL);
  1385. queryFactory.setown(createAgentQueryFactoryFromWu(wu, channel));
  1386. if (queryFactory)
  1387. cacheOnDemandQuery(queryHash, channel, queryFactory);
  1388. }
  1389. if (!queryFactory)
  1390. {
  1391. StringBuffer hdr;
  1392. IException *E = MakeStringException(MSGAUD_operator, ROXIE_UNKNOWN_QUERY, "Roxie agent received request for unregistered query: %s", packet->queryHeader().toString(hdr).str());
  1393. EXCLOG(E, "doActivity");
  1394. throwRemoteException(E, activity, packet, false);
  1395. return;
  1396. }
  1397. try
  1398. {
  1399. bool debugging = logctx.queryDebuggerActive();
  1400. if (debugging)
  1401. {
  1402. if (mySubChannel)
  1403. abortJob = true; // when debugging, we always run on primary only...
  1404. }
  1405. #ifndef NEW_IBYTI
  1406. #ifdef SUBCHANNELS_IN_HEADER
  1407. else if (doIbytiDelay && mySubChannel)
  1408. {
  1409. unsigned delay = 0;
  1410. for (unsigned subChannel = 0; subChannel < mySubChannel; subChannel++)
  1411. delay += getIbytiDelay(header.subChannels[subChannel].getIpAddress());
  1412. unsigned start = 0;
  1413. if (traceRoxiePackets)
  1414. {
  1415. StringBuffer x;
  1416. DBGLOG("YES myTurnToDelay subchannel=%u delay=%u %s", mySubChannel, delay, header.toString(x).str());
  1417. start = msTick();
  1418. }
  1419. if (delay)
  1420. ibytiSem.wait(delay);
  1421. if (traceRoxiePackets)
  1422. {
  1423. StringBuffer x;
  1424. DBGLOG("Delay done, abortJob=%d, elapsed=%d", (int) abortJob, msTick()-start);
  1425. }
  1426. if (!abortJob)
  1427. {
  1428. for (unsigned subChannel = 0; subChannel < mySubChannel; subChannel++)
  1429. noteNodeSick(header.subChannels[subChannel]);
  1430. }
  1431. }
  1432. #else
  1433. else if (doIbytiDelay && (numAgents > 1))
  1434. {
  1435. unsigned hdrHashVal = header.priorityHash();
  1436. unsigned primarySubChannel = (hdrHashVal % numAgents);
  1437. if (primarySubChannel != mySubChannel)
  1438. {
  1439. unsigned delay = topology->queryChannelInfo(channel).getIbytiDelay(primarySubChannel);
  1440. if (logctx.queryTraceLevel() > 6)
  1441. {
  1442. StringBuffer x;
  1443. logctx.CTXLOG("YES myTurnToDelayIBYTI subchannel=%u delay=%u hash=%u %s", mySubChannel, delay, hdrHashVal, header.toString(x).str());
  1444. }
  1445. // MORE: if we are dealing with a query that was on channel 0, we may want a longer delay
  1446. // (since the theory about duplicated work not mattering when cluster is idle does not hold up)
  1447. if (delay)
  1448. {
  1449. ibytiSem.wait(delay);
  1450. if (!abortJob)
  1451. topology->queryChannelInfo(channel).noteChannelsSick(primarySubChannel);
  1452. if (logctx.queryTraceLevel() > 8)
  1453. {
  1454. StringBuffer x;
  1455. logctx.CTXLOG("Buddy did%s send IBYTI, updated delay : %s",
  1456. abortJob ? "" : " NOT", header.toString(x).str());
  1457. }
  1458. }
  1459. }
  1460. else
  1461. {
  1462. #ifndef NO_IBYTI_DELAYS_COUNT
  1463. if (!mySubChannel)
  1464. ibytiNoDelaysPrm++;
  1465. else
  1466. ibytiNoDelaysSec++;
  1467. #endif
  1468. if (logctx.queryTraceLevel() > 6)
  1469. {
  1470. StringBuffer x;
  1471. logctx.CTXLOG("NOT myTurnToDelayIBYTI subchannel=%u hash=%u %s", mySubChannel, hdrHashVal, header.toString(x).str());
  1472. }
  1473. }
  1474. }
  1475. #endif
  1476. #endif
  1477. if (abortJob)
  1478. {
  1479. CriticalBlock b(actCrit);
  1480. busy = false; // Keep order - before setActivity below
  1481. if (logctx.queryTraceLevel() > 5)
  1482. {
  1483. StringBuffer x;
  1484. logctx.CTXLOG("Stop before processing - activity aborted %s", header.toString(x).str());
  1485. }
  1486. return;
  1487. }
  1488. if (!debugging)
  1489. ROQ->sendIbyti(header, logctx, mySubChannel);
  1490. activitiesStarted++;
  1491. Owned <IAgentActivityFactory> factory = queryFactory->getAgentActivityFactory(activityId);
  1492. assertex(factory);
  1493. setActivity(factory->createActivity(logctx, packet));
  1494. Owned<IMessagePacker> output = activity->process();
  1495. if (logctx.queryTraceLevel() > 5)
  1496. {
  1497. StringBuffer x;
  1498. logctx.CTXLOG("done processing %s", header.toString(x).str());
  1499. }
  1500. if (output)
  1501. {
  1502. activitiesCompleted++;
  1503. busy = false; // Keep order - before setActivity below
  1504. setActivity(NULL); // Ensures all stats are merged from child queries etc
  1505. logctx.flush();
  1506. output->flush();
  1507. }
  1508. }
  1509. catch (IUserException *E)
  1510. {
  1511. throwRemoteException(E, activity, packet, true);
  1512. }
  1513. catch (IException *E)
  1514. {
  1515. if (E->errorCode()!=ROXIE_ABORT_ERROR)
  1516. throwRemoteException(E, activity, packet, false);
  1517. else
  1518. E->Release();
  1519. }
  1520. catch (...)
  1521. {
  1522. throwRemoteException(MakeStringException(ROXIE_MULTICAST_ERROR, "Unknown exception"), activity, packet, false);
  1523. }
  1524. busy = false; // Keep order - before setActivity below
  1525. setActivity(NULL);
  1526. }
  1527. virtual void threadmain() override
  1528. {
  1529. while (!stopped)
  1530. {
  1531. try
  1532. {
  1533. for (;;)
  1534. {
  1535. queue->wait();
  1536. if (stopped)
  1537. break;
  1538. agentsActive++;
  1539. maxAgentsActive.store_max(agentsActive);
  1540. abortJob = false;
  1541. busy = true;
  1542. #ifndef NEW_IBYTI
  1543. if (doIbytiDelay)
  1544. ibytiSem.reinit(0U); // Make sure sem is is in no-signaled state
  1545. #endif
  1546. Owned<ISerializedRoxieQueryPacket> next = queue->dequeue();
  1547. if (next)
  1548. {
  1549. logctx.set(next);
  1550. packet.setown(next->deserialize());
  1551. next.clear();
  1552. queueLength--;
  1553. RoxiePacketHeader &header = packet->queryHeader();
  1554. #ifdef TIME_PACKETS
  1555. {
  1556. unsigned now = msTick();
  1557. unsigned packetWait = now-header.tick;
  1558. header.tick = now;
  1559. packetWaitMax.store_max(packetWait);
  1560. packetWaitElapsed += packetWait;
  1561. packetWaitCount++;
  1562. }
  1563. #endif
  1564. topology.setown(getTopology());
  1565. if (logctx.queryTraceLevel() > 10)
  1566. {
  1567. StringBuffer x;
  1568. logctx.CTXLOG("dequeued %s", header.toString(x).str());
  1569. }
  1570. if ((header.activityId & ~ROXIE_PRIORITY_MASK) == ROXIE_UNLOAD)
  1571. {
  1572. doUnload(packet, logctx);
  1573. }
  1574. else if ((header.activityId & ~ROXIE_PRIORITY_MASK) == ROXIE_PING)
  1575. {
  1576. doPing(packet, logctx);
  1577. }
  1578. else if ((header.activityId & ~ROXIE_PRIORITY_MASK) == ROXIE_DEBUGREQUEST)
  1579. {
  1580. // MORE - we need to make sure only executed on primary, and that the proxyId (== pointer to DebugGraphManager) is still valid.
  1581. // It may be that there is not a lot of point using the pointer - may as well use an non-reused ID and look it up in a global hash table of active ones
  1582. doDebugRequest(packet, logctx);
  1583. }
  1584. else if (header.channel)
  1585. doActivity();
  1586. else
  1587. throwUnexpected(); // channel 0 requests translated earlier now
  1588. #ifdef TIME_PACKETS
  1589. {
  1590. unsigned now = msTick();
  1591. unsigned packetRun = now-header.tick;
  1592. packetRunMax.store_max(packetRun);
  1593. packetRunElapsed += packetRun;
  1594. packetRunCount++;
  1595. }
  1596. #endif
  1597. }
  1598. busy = false;
  1599. {
  1600. CriticalBlock b(actCrit);
  1601. packet.clear();
  1602. topology.clear();
  1603. logctx.set(NULL);
  1604. }
  1605. agentsActive--;
  1606. }
  1607. }
  1608. catch(IException *E)
  1609. {
  1610. CriticalBlock b(actCrit);
  1611. EXCLOG(E);
  1612. if (packet)
  1613. {
  1614. throwRemoteException(E, NULL, packet, false);
  1615. packet.clear();
  1616. }
  1617. else
  1618. E->Release();
  1619. topology.clear();
  1620. }
  1621. catch(...)
  1622. {
  1623. CriticalBlock b(actCrit);
  1624. Owned<IException> E = MakeStringException(ROXIE_INTERNAL_ERROR, "Unexpected exception in Roxie worker thread");
  1625. EXCLOG(E);
  1626. if (packet)
  1627. {
  1628. throwRemoteException(E.getClear(), NULL, packet, false);
  1629. packet.clear();
  1630. }
  1631. topology.clear();
  1632. }
  1633. }
  1634. }
  1635. };
  1636. IPooledThread *RoxieQueue::createNew()
  1637. {
  1638. return new CRoxieWorker;
  1639. }
  1640. void RoxieQueue::abortChannel(unsigned channel)
  1641. {
  1642. Owned<IPooledThreadIterator> wi = workers->running();
  1643. ForEach(*wi)
  1644. {
  1645. CRoxieWorker &w = (CRoxieWorker &) wi->query();
  1646. w.abortChannel(channel);
  1647. }
  1648. }
  1649. //=================================================================================
  1650. class CallbackEntry : implements IPendingCallback, public CInterface
  1651. {
  1652. const RoxiePacketHeader &header;
  1653. StringAttr lfn;
  1654. InterruptableSemaphore ready;
  1655. MemoryBuffer data;
  1656. bool gotData;
  1657. public:
  1658. IMPLEMENT_IINTERFACE;
  1659. CallbackEntry(const RoxiePacketHeader &_header, const char *_lfn) : header(_header), lfn(_lfn)
  1660. {
  1661. gotData = false;
  1662. }
  1663. virtual bool wait(unsigned msecs)
  1664. {
  1665. return ready.wait(msecs);
  1666. }
  1667. virtual MemoryBuffer &queryData()
  1668. {
  1669. return data;
  1670. }
  1671. bool matches(RoxiePacketHeader &cand, const char *_lfn)
  1672. {
  1673. return (cand.matchPacket(header) && (!_lfn|| stricmp(_lfn, lfn)==0));
  1674. }
  1675. void doFileCallback(unsigned _len, const void *_data, bool aborted)
  1676. {
  1677. // MORE - make sure we call this for whole query abort as well as for callback abort
  1678. if (aborted)
  1679. ready.interrupt(MakeStringException(0, "Interrupted"));
  1680. else if (!gotData)
  1681. {
  1682. gotData = true;
  1683. data.append(_len, _data);
  1684. ready.signal();
  1685. }
  1686. }
  1687. };
  1688. class RoxieReceiverBase : implements IRoxieOutputQueueManager, public CInterface
  1689. {
  1690. protected:
  1691. RoxieQueue slaQueue;
  1692. RoxieQueue hiQueue;
  1693. RoxieQueue loQueue;
  1694. unsigned numWorkers;
  1695. public:
  1696. IMPLEMENT_IINTERFACE;
  1697. RoxieReceiverBase(unsigned _numWorkers) : slaQueue(headRegionSize, _numWorkers), hiQueue(headRegionSize, _numWorkers), loQueue(headRegionSize, _numWorkers), numWorkers(_numWorkers)
  1698. {
  1699. }
  1700. virtual unsigned getHeadRegionSize() const
  1701. {
  1702. return loQueue.getHeadRegionSize();
  1703. }
  1704. virtual void setHeadRegionSize(unsigned newSize)
  1705. {
  1706. slaQueue.setHeadRegionSize(newSize);
  1707. hiQueue.setHeadRegionSize(newSize);
  1708. loQueue.setHeadRegionSize(newSize);
  1709. }
  1710. virtual void start()
  1711. {
  1712. loQueue.start();
  1713. hiQueue.start();
  1714. slaQueue.start();
  1715. }
  1716. virtual void stop()
  1717. {
  1718. loQueue.stopAll();
  1719. hiQueue.stopAll();
  1720. slaQueue.stopAll();
  1721. }
  1722. virtual void join()
  1723. {
  1724. loQueue.join();
  1725. hiQueue.join();
  1726. slaQueue.join();
  1727. }
  1728. IArrayOf<CallbackEntry> callbacks;
  1729. CriticalSection callbacksCrit;
  1730. virtual IPendingCallback *notePendingCallback(const RoxiePacketHeader &header, const char *lfn)
  1731. {
  1732. CriticalBlock b(callbacksCrit);
  1733. CallbackEntry *callback = new CallbackEntry(header, lfn);
  1734. callbacks.append(*callback);
  1735. return callback;
  1736. }
  1737. virtual void removePendingCallback(IPendingCallback *goer)
  1738. {
  1739. if (goer)
  1740. {
  1741. CriticalBlock b(callbacksCrit);
  1742. callbacks.zap(static_cast<CallbackEntry &>(*goer));
  1743. }
  1744. }
  1745. protected:
  1746. void doFileCallback(IRoxieQueryPacket *packet)
  1747. {
  1748. // This is called on the main agent reader thread so needs to be as fast as possible to avoid lost packets
  1749. const char *lfn;
  1750. const char *data;
  1751. unsigned len;
  1752. RoxiePacketHeader &header = packet->queryHeader();
  1753. if (header.activityId == ROXIE_FILECALLBACK || header.activityId == ROXIE_DEBUGCALLBACK)
  1754. {
  1755. lfn = (const char *) packet->queryContextData();
  1756. unsigned namelen = strlen(lfn) + 1;
  1757. data = lfn + namelen;
  1758. len = packet->getContextLength() - namelen;
  1759. }
  1760. else
  1761. {
  1762. lfn = data = NULL; // used when query aborted
  1763. len = 0;
  1764. }
  1765. CriticalBlock b(callbacksCrit);
  1766. ForEachItemIn(idx, callbacks)
  1767. {
  1768. CallbackEntry &c = callbacks.item(idx);
  1769. if (c.matches(header, lfn))
  1770. {
  1771. if (traceLevel > 10)
  1772. DBGLOG("callback return matched a waiting query");
  1773. c.doFileCallback(len, data, header.retries==QUERY_ABORTED);
  1774. }
  1775. }
  1776. }
  1777. };
  1778. #ifdef _MSC_VER
  1779. #pragma warning ( push )
  1780. #pragma warning ( disable: 4355 )
  1781. #endif
  1782. class RoxieThrottledPacketSender : public Thread
  1783. {
  1784. TokenBucket &bucket;
  1785. InterruptableSemaphore queued;
  1786. Semaphore started;
  1787. unsigned maxPacketSize;
  1788. SafeQueueOf<IRoxieQueryPacket, false> queue;
  1789. class DECL_EXCEPTION StoppedException: public IException, public CInterface
  1790. {
  1791. public:
  1792. IMPLEMENT_IINTERFACE;
  1793. int errorCode() const { return 0; }
  1794. StringBuffer & errorMessage(StringBuffer &str) const { return str.append("Stopped"); }
  1795. MessageAudience errorAudience() const { return MSGAUD_user; }
  1796. };
  1797. void enqueue(IRoxieQueryPacket *packet)
  1798. {
  1799. packet->Link();
  1800. queue.enqueue(packet);
  1801. queued.signal();
  1802. }
  1803. IRoxieQueryPacket *dequeue()
  1804. {
  1805. queued.wait();
  1806. return queue.dequeue();
  1807. }
  1808. public:
  1809. RoxieThrottledPacketSender(TokenBucket &_bucket, unsigned _maxPacketSize)
  1810. : Thread("RoxieThrottledPacketSender"), bucket(_bucket), maxPacketSize(_maxPacketSize)
  1811. {
  1812. start();
  1813. started.wait();
  1814. }
  1815. ~RoxieThrottledPacketSender()
  1816. {
  1817. stop();
  1818. join();
  1819. }
  1820. virtual int run()
  1821. {
  1822. started.signal();
  1823. for (;;)
  1824. {
  1825. try
  1826. {
  1827. Owned<IRoxieQueryPacket> packet = dequeue();
  1828. unsigned length = packet->queryHeader().packetlength;
  1829. {
  1830. MTIME_SECTION(queryActiveTimer(), "bucket_wait");
  1831. bucket.wait((length / 1024) + 1);
  1832. }
  1833. Owned<ISerializedRoxieQueryPacket> serialized = packet->serialize();
  1834. if (!channelWrite(serialized->queryHeader(), true))
  1835. DBGLOG("Roxie packet write wrote too little");
  1836. packetsSent++;
  1837. }
  1838. catch (StoppedException *E)
  1839. {
  1840. E->Release();
  1841. break;
  1842. }
  1843. catch (IException *E)
  1844. {
  1845. EXCLOG(E);
  1846. E->Release();
  1847. }
  1848. catch (...)
  1849. {
  1850. }
  1851. }
  1852. return 0;
  1853. }
  1854. void sendPacket(IRoxieQueryPacket *x, const IRoxieContextLogger &logctx)
  1855. {
  1856. RoxiePacketHeader &header = x->queryHeader();
  1857. unsigned length = x->queryHeader().packetlength;
  1858. assertex (header.activityId & ~ROXIE_PRIORITY_MASK);
  1859. switch (header.retries & ROXIE_RETRIES_MASK)
  1860. {
  1861. case (QUERY_ABORTED & ROXIE_RETRIES_MASK):
  1862. {
  1863. StringBuffer s;
  1864. logctx.CTXLOG("Aborting packet size=%d: %s", length, header.toString(s).str());
  1865. }
  1866. break;
  1867. default:
  1868. {
  1869. StringBuffer s;
  1870. logctx.CTXLOG("Resending packet size=%d: %s", length, header.toString(s).str());
  1871. }
  1872. break;
  1873. case 0:
  1874. if (logctx.queryTraceLevel() > 8)
  1875. {
  1876. StringBuffer s;
  1877. logctx.CTXLOG("Sending packet size=%d: %s", length, header.toString(s).str());
  1878. }
  1879. break;
  1880. }
  1881. if (length > maxPacketSize)
  1882. {
  1883. StringBuffer s;
  1884. throw MakeStringException(ROXIE_PACKET_ERROR, "Maximum packet length %d exceeded sending packet %s", maxPacketSize, header.toString(s).str());
  1885. }
  1886. enqueue(x);
  1887. }
  1888. void stop()
  1889. {
  1890. // bucket.stop();
  1891. queued.interrupt(new StoppedException);
  1892. }
  1893. };
  1894. //------------------------------------------------------------------------------------------------------------
  1895. #ifdef NEW_IBYTI
  1896. class DelayedPacketQueue
  1897. {
  1898. // Used to keep a list of all recently-received packets where we are not primary subchannel. There is one queue per subchannel level
  1899. // It is accessed ONLY from the main reader thread and does not need to be threadsafe (but does need to be fast)
  1900. // We use a doubly-linked list (not std::list as not quite flexible enough).
  1901. class DelayedPacketEntry
  1902. {
  1903. DelayedPacketEntry() = delete;
  1904. DelayedPacketEntry(const DelayedPacketEntry&) = delete;
  1905. public:
  1906. DelayedPacketEntry(ISerializedRoxieQueryPacket *_packet, unsigned _waitExpires)
  1907. : packet(_packet), waitExpires(_waitExpires)
  1908. {
  1909. }
  1910. ~DelayedPacketEntry()
  1911. {
  1912. if (prev)
  1913. prev->next = next;
  1914. if (next)
  1915. next->prev = prev;
  1916. }
  1917. bool matches(const RoxiePacketHeader &ibyti) const
  1918. {
  1919. return packet->queryHeader().matchPacket(ibyti);
  1920. }
  1921. ISerializedRoxieQueryPacket *getClear()
  1922. {
  1923. return packet.getClear();
  1924. }
  1925. StringBuffer & describe(StringBuffer &ret) const
  1926. {
  1927. return packet->queryHeader().toString(ret);
  1928. }
  1929. Owned<ISerializedRoxieQueryPacket> packet;
  1930. DelayedPacketEntry *next = nullptr;
  1931. DelayedPacketEntry *prev = nullptr;
  1932. unsigned waitExpires = 0;
  1933. };
  1934. public:
  1935. DelayedPacketQueue() = default;
  1936. DelayedPacketQueue(const DelayedPacketQueue&) = delete;
  1937. ~DelayedPacketQueue()
  1938. {
  1939. while (head)
  1940. removeEntry(head);
  1941. }
  1942. bool doIBYTI(const RoxiePacketHeader &ibyti)
  1943. {
  1944. assert(GetCurrentThreadId()==roxiePacketReaderThread);
  1945. DelayedPacketEntry *finger = head;
  1946. while (finger)
  1947. {
  1948. if (finger->matches(ibyti))
  1949. {
  1950. if (traceRoxiePackets)
  1951. {
  1952. StringBuffer s;
  1953. DBGLOG("IBYTI removing delayed packet %s", finger->describe(s).str());
  1954. }
  1955. removeEntry(finger);
  1956. return true;
  1957. }
  1958. finger = finger->next;
  1959. }
  1960. return false;
  1961. }
  1962. void append(ISerializedRoxieQueryPacket *packet, unsigned expires)
  1963. {
  1964. // Goes on the end. But percolate the expiry time backwards
  1965. assert(GetCurrentThreadId()==roxiePacketReaderThread);
  1966. DelayedPacketEntry *newEntry = new DelayedPacketEntry(packet, expires);
  1967. if (traceRoxiePackets)
  1968. {
  1969. StringBuffer s;
  1970. DBGLOG("Adding delayed packet %s", packet->queryHeader().toString(s).str());
  1971. }
  1972. newEntry->prev = tail;
  1973. if (tail)
  1974. {
  1975. tail->next = newEntry;
  1976. for (DelayedPacketEntry *finger = tail; finger != nullptr; finger = finger->prev)
  1977. {
  1978. if ((int) (finger->waitExpires - expires) <= 0)
  1979. break;
  1980. finger->waitExpires = expires;
  1981. finger = finger->prev;
  1982. }
  1983. }
  1984. else
  1985. head = newEntry;
  1986. tail = newEntry;
  1987. }
  1988. // Move any that we are done waiting for our buddy onto the active queue
  1989. void checkExpired(unsigned now, RoxieQueue &slaQueue, RoxieQueue &hiQueue, RoxieQueue &loQueue)
  1990. {
  1991. assert(GetCurrentThreadId()==roxiePacketReaderThread);
  1992. DelayedPacketEntry *finger = head;
  1993. while (finger)
  1994. {
  1995. if (((int) (finger->waitExpires - now)) <= 0) // Oddly coded to handle wrapping
  1996. {
  1997. ISerializedRoxieQueryPacket *packet = finger->getClear();
  1998. const RoxiePacketHeader &header = packet->queryHeader();
  1999. if (traceRoxiePackets)
  2000. {
  2001. StringBuffer s;
  2002. DBGLOG("No IBYTI received yet for delayed packet %s", header.toString(s).str());
  2003. }
  2004. if (header.activityId & ROXIE_SLA_PRIORITY)
  2005. slaQueue.enqueue(packet);
  2006. else if (header.activityId & ROXIE_HIGH_PRIORITY)
  2007. hiQueue.enqueue(packet);
  2008. else
  2009. loQueue.enqueue(packet);
  2010. for (unsigned subChannel = 0; subChannel < MAX_SUBCHANNEL; subChannel++)
  2011. {
  2012. if (header.subChannels[subChannel].isMe() || header.subChannels[subChannel].isNull())
  2013. break;
  2014. noteNodeSick(header.subChannels[subChannel]);
  2015. }
  2016. DelayedPacketEntry *goer = finger;
  2017. finger = finger->next;
  2018. removeEntry(goer);
  2019. }
  2020. else
  2021. break;
  2022. }
  2023. }
  2024. // How long until the next time we want to call checkExpires() ?
  2025. unsigned timeout(unsigned now) const
  2026. {
  2027. assert(GetCurrentThreadId()==roxiePacketReaderThread);
  2028. if (head)
  2029. {
  2030. int delay = (int) (head->waitExpires - now);
  2031. if (delay <= 0)
  2032. return 0;
  2033. else
  2034. return (unsigned) delay;
  2035. }
  2036. else
  2037. return (unsigned) -1;
  2038. }
  2039. private:
  2040. void removeEntry(DelayedPacketEntry *goer)
  2041. {
  2042. if (goer==head)
  2043. head = goer->next;
  2044. if (goer==tail)
  2045. tail = goer->prev;
  2046. delete goer;
  2047. }
  2048. DelayedPacketEntry *head = nullptr;
  2049. DelayedPacketEntry *tail = nullptr;
  2050. };
  2051. //------------------------------------------------------------------------------------------------------------
  2052. class DelayedPacketQueueChannel : public CInterface
  2053. {
  2054. // Manages a set of DelayedPacketQueues, one for each supported subchannel level.
  2055. DelayedPacketQueueChannel() = delete;
  2056. DelayedPacketQueueChannel(const DelayedPacketQueueChannel&) = delete;
  2057. public:
  2058. DelayedPacketQueueChannel(unsigned _channel) : channel(_channel)
  2059. {
  2060. }
  2061. inline unsigned queryChannel() const { return channel; }
  2062. inline DelayedPacketQueue &queryQueue(unsigned subchannel)
  2063. {
  2064. assertex(subchannel); // Subchannel 0 means primary and is never delayed
  2065. subchannel -= 1;
  2066. if (subchannel > maxSeen)
  2067. maxSeen = subchannel;
  2068. return queues[subchannel];
  2069. }
  2070. unsigned timeout(unsigned now) const
  2071. {
  2072. unsigned min = (unsigned) -1;
  2073. for (unsigned queue = 0; queue <= maxSeen; queue++)
  2074. {
  2075. unsigned t = queues[queue].timeout(now);
  2076. if (t < min)
  2077. min = t;
  2078. }
  2079. return min;
  2080. }
  2081. void checkExpired(unsigned now, RoxieQueue &slaQueue, RoxieQueue &hiQueue, RoxieQueue &loQueue)
  2082. {
  2083. for (unsigned queue = 0; queue <= maxSeen; queue++)
  2084. {
  2085. queues[queue].checkExpired(now, slaQueue, hiQueue, loQueue);
  2086. }
  2087. }
  2088. private:
  2089. DelayedPacketQueue queues[MAX_SUBCHANNEL-1]; // Note - primary subchannel is not included
  2090. unsigned channel = 0;
  2091. unsigned maxSeen = 0;
  2092. };
  2093. class DelayedPacketQueueManager
  2094. {
  2095. public:
  2096. DelayedPacketQueueManager() = default;
  2097. DelayedPacketQueueManager(const DelayedPacketQueueManager&) = delete;
  2098. inline DelayedPacketQueue &queryQueue(unsigned channel, unsigned subchannel)
  2099. {
  2100. // Note - there are normally no more than a couple of channels on a single agent.
  2101. // If that were to change we could make this a fixed size array
  2102. assert(GetCurrentThreadId()==roxiePacketReaderThread);
  2103. ForEachItemIn(idx, channels)
  2104. {
  2105. DelayedPacketQueueChannel &i = channels.item(idx);
  2106. if (i.queryChannel() == channel)
  2107. return i.queryQueue(subchannel);
  2108. }
  2109. channels.append(*new DelayedPacketQueueChannel(channel));
  2110. return channels.tos().queryQueue(subchannel);
  2111. }
  2112. unsigned timeout(unsigned now) const
  2113. {
  2114. unsigned ret = (unsigned) -1;
  2115. ForEachItemIn(idx, channels)
  2116. {
  2117. unsigned t = channels.item(idx).timeout(now);
  2118. if (t < ret)
  2119. ret = t;
  2120. }
  2121. return ret;
  2122. }
  2123. void checkExpired(unsigned now, RoxieQueue &slaQueue, RoxieQueue &hiQueue, RoxieQueue &loQueue)
  2124. {
  2125. ForEachItemIn(idx, channels)
  2126. {
  2127. channels.item(idx).checkExpired(now, slaQueue, hiQueue, loQueue);
  2128. }
  2129. }
  2130. private:
  2131. CIArrayOf<DelayedPacketQueueChannel> channels;
  2132. };
  2133. #endif
  2134. //------------------------------------------------------------------------------------------------------------
  2135. class RoxieSocketQueueManager : public RoxieReceiverBase
  2136. {
  2137. protected:
  2138. Linked<ISendManager> sendManager;
  2139. Linked<IReceiveManager> receiveManager;
  2140. Owned<RoxieThrottledPacketSender> throttledPacketSendManager;
  2141. Owned<TokenBucket> bucket;
  2142. unsigned maxPacketSize = 0;
  2143. std::atomic<bool> running = { false };
  2144. #ifdef NEW_IBYTI
  2145. DelayedPacketQueueManager delayed;
  2146. #endif
  2147. class ReceiverThread : public Thread
  2148. {
  2149. RoxieSocketQueueManager &parent;
  2150. public:
  2151. ReceiverThread(RoxieSocketQueueManager &_parent) : Thread("RoxieSocketQueueManager"), parent(_parent) {}
  2152. int run()
  2153. {
  2154. // Raise the priority so ibyti's get through in a timely fashion
  2155. #if defined( __linux__) || defined(__APPLE__)
  2156. setLinuxThreadPriority(3);
  2157. #else
  2158. adjustPriority(1);
  2159. #endif
  2160. roxiePacketReaderThread = GetCurrentThreadId();
  2161. return parent.run();
  2162. }
  2163. } readThread;
  2164. public:
  2165. RoxieSocketQueueManager(unsigned _numWorkers) : RoxieReceiverBase(_numWorkers), readThread(*this)
  2166. {
  2167. maxPacketSize = multicastSocket->get_max_send_size();
  2168. if ((maxPacketSize==0)||(maxPacketSize>65535))
  2169. maxPacketSize = 65535;
  2170. }
  2171. virtual void sendPacket(IRoxieQueryPacket *x, const IRoxieContextLogger &logctx)
  2172. {
  2173. if (throttledPacketSendManager)
  2174. throttledPacketSendManager->sendPacket(x, logctx);
  2175. else
  2176. {
  2177. MTIME_SECTION(queryActiveTimer(), "RoxieSocketQueueManager::sendPacket");
  2178. RoxiePacketHeader &header = x->queryHeader();
  2179. unsigned length = x->queryHeader().packetlength;
  2180. assertex (header.activityId & ~ROXIE_PRIORITY_MASK);
  2181. StringBuffer s;
  2182. switch (header.retries & ROXIE_RETRIES_MASK)
  2183. {
  2184. case (QUERY_ABORTED & ROXIE_RETRIES_MASK):
  2185. logctx.CTXLOG("Aborting packet size=%d: %s", length, header.toString(s).str());
  2186. break;
  2187. default:
  2188. logctx.CTXLOG("Resending packet size=%d: %s", length, header.toString(s).str());
  2189. break;
  2190. case 0:
  2191. if (logctx.queryTraceLevel() > 8)
  2192. logctx.CTXLOG("Sending packet size=%d: %s", length, header.toString(s).str());
  2193. break;
  2194. }
  2195. if (length > maxPacketSize)
  2196. {
  2197. StringBuffer s;
  2198. throw MakeStringException(ROXIE_PACKET_ERROR, "Maximum packet length %d exceeded sending packet %s", maxPacketSize, header.toString(s).str());
  2199. }
  2200. Owned <ISerializedRoxieQueryPacket> serialized = x->serialize();
  2201. if (!channelWrite(serialized->queryHeader(), true))
  2202. logctx.CTXLOG("Roxie packet write wrote too little");
  2203. packetsSent++;
  2204. }
  2205. }
  2206. virtual void sendIbyti(RoxiePacketHeader &header, const IRoxieContextLogger &logctx, unsigned subChannel) override
  2207. {
  2208. #ifdef SUBCHANNELS_IN_HEADER
  2209. if (!header.hasBuddies())
  2210. return;
  2211. #endif
  2212. MTIME_SECTION(queryActiveTimer(), "RoxieSocketQueueManager::sendIbyti");
  2213. RoxiePacketHeader ibytiHeader(header, header.activityId & ROXIE_PRIORITY_MASK, subChannel);
  2214. if (logctx.queryTraceLevel() > 8)
  2215. {
  2216. StringBuffer s; logctx.CTXLOG("Sending IBYTI packet %s", ibytiHeader.toString(s).str());
  2217. }
  2218. channelWrite(ibytiHeader, false); // don't send to self
  2219. ibytiPacketsSent++;
  2220. }
  2221. virtual void sendAbort(RoxiePacketHeader &header, const IRoxieContextLogger &logctx) override
  2222. {
  2223. MTIME_SECTION(queryActiveTimer(), "RoxieSocketQueueManager::sendAbort");
  2224. RoxiePacketHeader abortHeader(header, header.activityId & ROXIE_PRIORITY_MASK, 0); // subChannel irrelevant - we are about to overwrite retries anyway
  2225. abortHeader.retries = QUERY_ABORTED;
  2226. if (logctx.queryTraceLevel() > 8)
  2227. {
  2228. StringBuffer s; logctx.CTXLOG("Sending ABORT packet %s", abortHeader.toString(s).str());
  2229. }
  2230. if (!channelWrite(abortHeader, true))
  2231. logctx.CTXLOG("sendAbort wrote too little");
  2232. abortsSent++;
  2233. }
  2234. virtual void sendAbortCallback(const RoxiePacketHeader &header, const char *lfn, const IRoxieContextLogger &logctx) override
  2235. {
  2236. MTIME_SECTION(queryActiveTimer(), "RoxieSocketQueueManager::sendAbortCallback");
  2237. RoxiePacketHeader abortHeader(header, ROXIE_FILECALLBACK, 0); // subChannel irrelevant - we are about to overwrite retries anyway
  2238. abortHeader.retries = QUERY_ABORTED;
  2239. abortHeader.packetlength += strlen(lfn)+1;
  2240. MemoryBuffer data;
  2241. data.append(sizeof(abortHeader), &abortHeader).append(lfn);
  2242. if (logctx.queryTraceLevel() > 5)
  2243. {
  2244. StringBuffer s; logctx.CTXLOG("Sending ABORT FILECALLBACK packet %s for file %s", abortHeader.toString(s).str(), lfn);
  2245. }
  2246. Owned<IRoxieQueryPacket> packet = createRoxiePacket(data);
  2247. Owned<ISerializedRoxieQueryPacket> serialized = packet->serialize();
  2248. if (!channelWrite(serialized->queryHeader(), true))
  2249. logctx.CTXLOG("sendAbortCallback wrote too little");
  2250. abortsSent++;
  2251. }
  2252. virtual IMessagePacker *createOutputStream(RoxiePacketHeader &header, bool outOfBand, const IRoxieContextLogger &logctx)
  2253. {
  2254. unsigned qnum = outOfBand ? 0 : ((header.retries & ROXIE_FASTLANE) || !fastLaneQueue) ? 1 : 2;
  2255. if (logctx.queryTraceLevel() > 8)
  2256. {
  2257. StringBuffer s; logctx.CTXLOG("Creating Output Stream for reply packet on Q=%d - %s", qnum, header.toString(s).str());
  2258. }
  2259. return sendManager->createMessagePacker(header.uid, header.getSequenceId(), &header, sizeof(RoxiePacketHeader), header.serverId, qnum);
  2260. }
  2261. virtual bool replyPending(RoxiePacketHeader &header)
  2262. {
  2263. return sendManager->dataQueued(header.uid, header.getSequenceId(), header.serverId);
  2264. }
  2265. virtual bool abortCompleted(RoxiePacketHeader &header)
  2266. {
  2267. return sendManager->abortData(header.uid, header.getSequenceId(), header.serverId);
  2268. }
  2269. bool abortRunning(RoxiePacketHeader &header, RoxieQueue &queue, bool checkRank, bool &preActivity)
  2270. {
  2271. bool queryFound = false;
  2272. bool ret = false;
  2273. Owned<IPooledThreadIterator> wi = queue.running();
  2274. ForEach(*wi)
  2275. {
  2276. CRoxieWorker &w = (CRoxieWorker &) wi->query();
  2277. if (w.checkAbort(header, checkRank, queryFound, preActivity))
  2278. {
  2279. ret = true;
  2280. break;
  2281. }
  2282. else if (queryFound)
  2283. {
  2284. ret = false;
  2285. break;
  2286. }
  2287. }
  2288. if (!checkRank)
  2289. {
  2290. if (traceLevel > 8)
  2291. DBGLOG("discarding data for aborted query");
  2292. ROQ->abortCompleted(header);
  2293. }
  2294. return ret;
  2295. }
  2296. void doIbyti(RoxiePacketHeader &header, RoxieQueue &queue)
  2297. {
  2298. assert(!localAgent);
  2299. bool preActivity = false;
  2300. #ifdef SUBCHANNELS_IN_HEADER
  2301. unsigned mySubChannel = header.mySubChannel();
  2302. #else
  2303. Owned<const ITopologyServer> topology = getTopology();
  2304. const ChannelInfo &channelInfo = topology->queryChannelInfo(header.channel);
  2305. unsigned mySubChannel = channelInfo.subChannel();
  2306. #endif
  2307. if (header.retries == QUERY_ABORTED)
  2308. {
  2309. bool foundInQ = false;
  2310. #ifdef NEW_IBYTI
  2311. foundInQ = mySubChannel != 0 && delayed.queryQueue(header.channel, mySubChannel).doIBYTI(header);
  2312. #endif
  2313. if (!foundInQ)
  2314. foundInQ = queue.remove(header);
  2315. if (!foundInQ)
  2316. abortRunning(header, queue, false, preActivity);
  2317. if (traceRoxiePackets || traceLevel > 10)
  2318. {
  2319. StringBuffer s;
  2320. DBGLOG("Abort activity %s", header.toString(s).str());
  2321. }
  2322. }
  2323. else
  2324. {
  2325. ibytiPacketsReceived++;
  2326. unsigned subChannel = header.getRespondingSubChannel();
  2327. if (subChannel == mySubChannel)
  2328. {
  2329. if (traceRoxiePackets || traceLevel > 10)
  2330. DBGLOG("doIBYTI packet was from self");
  2331. ibytiPacketsFromSelf++;
  2332. }
  2333. else
  2334. {
  2335. #ifndef SUBCHANNELS_IN_HEADER
  2336. channelInfo.noteChannelHealthy(subChannel);
  2337. #else
  2338. noteNodeHealthy(header.subChannels[subChannel]);
  2339. #endif
  2340. bool foundInQ = false;
  2341. #ifdef NEW_IBYTI
  2342. foundInQ = mySubChannel != 0 && delayed.queryQueue(header.channel, mySubChannel).doIBYTI(header);
  2343. #endif
  2344. if (!foundInQ)
  2345. foundInQ = queue.remove(header);
  2346. if (foundInQ)
  2347. {
  2348. if (traceRoxiePackets || traceLevel > 10)
  2349. {
  2350. StringBuffer s;
  2351. DBGLOG("Removed activity from Q : %s", header.toString(s).str());
  2352. }
  2353. ibytiPacketsWorked++;
  2354. return;
  2355. }
  2356. if (abortRunning(header, queue, true, preActivity))
  2357. {
  2358. if (traceRoxiePackets || traceLevel > 10)
  2359. {
  2360. StringBuffer s;
  2361. DBGLOG("Aborted running activity : %s", header.toString(s).str());
  2362. }
  2363. if (preActivity)
  2364. ibytiPacketsWorked++;
  2365. else
  2366. ibytiPacketsHalfWorked++;
  2367. return;
  2368. }
  2369. if (traceRoxiePackets || traceLevel > 10)
  2370. {
  2371. StringBuffer s;
  2372. DBGLOG("doIBYTI packet was too late (or too early) : %s", header.toString(s).str());
  2373. }
  2374. ibytiPacketsTooLate++; // meaning either I started and reserve the right to finish, or I finished already
  2375. if (IBYTIbufferSize)
  2376. queue.noteOrphanIBYTI(header);
  2377. }
  2378. }
  2379. }
  2380. void processMessage(MemoryBuffer &mb, RoxiePacketHeader &header, RoxieQueue &queue)
  2381. {
  2382. // NOTE - this thread needs to do as little as possible - just read packets and queue them up - otherwise we can get packet loss due to buffer overflow
  2383. // DO NOT put tracing on this thread except at very high tracelevels!
  2384. if ((header.activityId & ~ROXIE_PRIORITY_MASK) == 0)
  2385. doIbyti(header, queue);
  2386. else
  2387. {
  2388. if (!header.channel)
  2389. {
  2390. // Turn broadcast packet (channel 0), as early as possible, into non-0 channel packets.
  2391. // So retries and other communication with Roxie server (which uses non-0 channel numbers) will not cause double work or confusion.
  2392. // Unfortunately this is bad news for dropping packets
  2393. // In SUBCHANNELS_IN_HEADER mode this translation has been done on server before sending, except for some control messages like PING or UNLOAD
  2394. Owned<const ITopologyServer> topology = getTopology();
  2395. const std::vector<unsigned> channels = topology->queryChannels();
  2396. Owned<ISerializedRoxieQueryPacket> packet = createSerializedRoxiePacket(mb);
  2397. for (unsigned i = 1; i < channels.size(); i++)
  2398. queue.enqueue(packet->cloneSerializedPacket(channels[i]));
  2399. header.channel = channels[0];
  2400. queue.enqueue(packet.getClear());
  2401. return;
  2402. }
  2403. #ifdef SUBCHANNELS_IN_HEADER
  2404. unsigned mySubchannel = header.mySubChannel();
  2405. #else
  2406. Owned<const ITopologyServer> topology = getTopology();
  2407. unsigned mySubchannel = topology->queryChannelInfo(header.channel).subChannel();
  2408. #endif
  2409. if (header.activityId == ROXIE_FILECALLBACK || header.activityId == ROXIE_DEBUGCALLBACK )
  2410. {
  2411. Owned<IRoxieQueryPacket> packet = deserializeCallbackPacket(mb);
  2412. if (traceLevel > 10)
  2413. {
  2414. StringBuffer s;
  2415. DBGLOG("ROXIE_CALLBACK %s", header.toString(s).str());
  2416. }
  2417. doFileCallback(packet);
  2418. }
  2419. else if (IBYTIbufferSize && queue.lookupOrphanIBYTI(header))
  2420. {
  2421. if (traceRoxiePackets || traceLevel > 10)
  2422. {
  2423. StringBuffer s;
  2424. DBGLOG("doIBYTI packet was too early : %s", header.toString(s).str());
  2425. }
  2426. ibytiPacketsTooLate--;
  2427. ibytiPacketsTooEarly++;
  2428. }
  2429. else
  2430. {
  2431. Owned<ISerializedRoxieQueryPacket> packet = createSerializedRoxiePacket(mb);
  2432. AgentContextLogger logctx(packet);
  2433. unsigned retries = header.thisChannelRetries(mySubchannel);
  2434. if (retries)
  2435. {
  2436. // MORE - is this fast enough? By the time I am seeing retries I may already be under load. Could move onto a separate thread
  2437. assertex(header.channel); // should never see a retry on channel 0
  2438. if (retries >= SUBCHANNEL_MASK)
  2439. return; // someone sent a failure or something - ignore it
  2440. // Send back an out-of-band immediately, to let Roxie server know that channel is still active
  2441. if (!(testAgentFailure & 0x800))
  2442. {
  2443. RoxiePacketHeader newHeader(header, ROXIE_ALIVE, mySubchannel);
  2444. Owned<IMessagePacker> output = ROQ->createOutputStream(newHeader, true, logctx);
  2445. output->flush();
  2446. }
  2447. // If it's a retry, look it up against already running, or output stream, or input queue
  2448. // if found, send an IBYTI and discard retry request
  2449. if (!mySubchannel)
  2450. retriesReceivedPrm++;
  2451. else
  2452. retriesReceivedSec++;
  2453. bool alreadyRunning = false;
  2454. Owned<IPooledThreadIterator> wi = queue.running();
  2455. ForEach(*wi)
  2456. {
  2457. CRoxieWorker &w = (CRoxieWorker &) wi->query();
  2458. if (w.match(header))
  2459. {
  2460. alreadyRunning = true;
  2461. if (!mySubchannel)
  2462. retriesIgnoredPrm++;
  2463. else
  2464. retriesIgnoredSec++;
  2465. ROQ->sendIbyti(header, logctx, mySubchannel);
  2466. if (logctx.queryTraceLevel() > 10)
  2467. {
  2468. StringBuffer xx; logctx.CTXLOG("Ignored retry on subchannel %u for running activity %s", mySubchannel, header.toString(xx).str());
  2469. }
  2470. break;
  2471. }
  2472. }
  2473. if (!alreadyRunning && checkCompleted && ROQ->replyPending(header))
  2474. {
  2475. alreadyRunning = true;
  2476. if (!mySubchannel)
  2477. retriesIgnoredPrm++;
  2478. else
  2479. retriesIgnoredSec++;
  2480. ROQ->sendIbyti(header, logctx, mySubchannel);
  2481. if (logctx.queryTraceLevel() > 10)
  2482. {
  2483. StringBuffer xx; logctx.CTXLOG("Ignored retry on subchannel %u for completed activity %s", mySubchannel, header.toString(xx).str());
  2484. }
  2485. }
  2486. if (!alreadyRunning)
  2487. {
  2488. if (logctx.queryTraceLevel() > 10)
  2489. {
  2490. StringBuffer xx; logctx.CTXLOG("Retry %d received on subchannel %u for %s", retries+1, mySubchannel, header.toString(xx).str());
  2491. }
  2492. queue.enqueueUnique(packet.getClear(), mySubchannel);
  2493. }
  2494. }
  2495. else // first time (not a retry).
  2496. {
  2497. #ifdef NEW_IBYTI
  2498. if (mySubchannel != 0) // i.e. I am not the primary here
  2499. {
  2500. unsigned delay = 0;
  2501. for (unsigned subChannel = 0; subChannel < mySubchannel; subChannel++)
  2502. delay += getIbytiDelay(header.subChannels[subChannel]);
  2503. delayed.queryQueue(header.channel, mySubchannel).append(packet.getClear(), msTick()+delay);
  2504. }
  2505. else
  2506. #endif
  2507. queue.enqueue(packet.getClear());
  2508. }
  2509. }
  2510. }
  2511. }
  2512. int run()
  2513. {
  2514. if (traceLevel)
  2515. DBGLOG("RoxieSocketQueueManager::run() starting: doIbytiDelay=%s minIbytiDelay=%u initIbytiDelay=%u",
  2516. doIbytiDelay?"YES":"NO", minIbytiDelay, initIbytiDelay);
  2517. for (;;)
  2518. {
  2519. MemoryBuffer mb;
  2520. try
  2521. {
  2522. // NOTE - this thread needs to do as little as possible - just read packets and queue them up - otherwise we can get packet loss due to buffer overflow
  2523. // DO NOT put tracing on this thread except at very high tracelevels!
  2524. #ifdef NEW_IBYTI
  2525. unsigned timeout = delayed.timeout(msTick());
  2526. if (timeout>5000)
  2527. timeout = 5000;
  2528. #else
  2529. unsigned timeout = 5000;
  2530. #endif
  2531. unsigned l;
  2532. multicastSocket->readtms(mb.reserve(maxPacketSize), sizeof(RoxiePacketHeader), maxPacketSize, l, timeout);
  2533. mb.setLength(l);
  2534. packetsReceived++;
  2535. RoxiePacketHeader &header = *(RoxiePacketHeader *) mb.toByteArray();
  2536. if (l != header.packetlength)
  2537. DBGLOG("sock->read returned %d but packetlength was %d", l, header.packetlength);
  2538. if (traceRoxiePackets || traceLevel > 10)
  2539. {
  2540. StringBuffer s;
  2541. DBGLOG("Read roxie packet: %s", header.toString(s).str());
  2542. }
  2543. if (header.activityId & ROXIE_SLA_PRIORITY)
  2544. processMessage(mb, header, slaQueue);
  2545. else if (header.activityId & ROXIE_HIGH_PRIORITY)
  2546. processMessage(mb, header, hiQueue);
  2547. else
  2548. processMessage(mb, header, loQueue);
  2549. }
  2550. catch (IException *E)
  2551. {
  2552. if (running)
  2553. {
  2554. // MORE: Maybe we should utilize IException::errorCode - not just text ??
  2555. if (E->errorCode()==JSOCKERR_timeout_expired)
  2556. E->Release();
  2557. else if (roxiemem::memPoolExhausted())
  2558. {
  2559. //MORE: I think this should probably be based on the error code instead.
  2560. EXCLOG(E, "Exception reading or processing roxie packet");
  2561. E->Release();
  2562. MilliSleep(1000); // Give a chance for mem free
  2563. }
  2564. else
  2565. {
  2566. EXCLOG(E, "Exception reading or processing roxie packet");
  2567. E->Release();
  2568. // MORE: Protect with try logic, in case udp_create throws exception ?
  2569. // What to do if create fails (ie exception is caught) ?
  2570. if (multicastSocket)
  2571. {
  2572. multicastSocket->close();
  2573. multicastSocket.clear();
  2574. openMulticastSocket();
  2575. }
  2576. }
  2577. }
  2578. else
  2579. {
  2580. E->Release();
  2581. break;
  2582. }
  2583. }
  2584. #ifdef NEW_IBYTI
  2585. delayed.checkExpired(msTick(), slaQueue, hiQueue, loQueue);
  2586. #endif
  2587. }
  2588. return 0;
  2589. }
  2590. void start()
  2591. {
  2592. RoxieReceiverBase::start();
  2593. running = true;
  2594. readThread.start();
  2595. }
  2596. void stop()
  2597. {
  2598. if (running)
  2599. {
  2600. running = false;
  2601. multicastSocket->close();
  2602. }
  2603. RoxieReceiverBase::stop();
  2604. }
  2605. void join()
  2606. {
  2607. readThread.join();
  2608. RoxieReceiverBase::join();
  2609. }
  2610. virtual IReceiveManager *queryReceiveManager()
  2611. {
  2612. return receiveManager;
  2613. }
  2614. };
  2615. class RoxieUdpSocketQueueManager : public RoxieSocketQueueManager
  2616. {
  2617. public:
  2618. RoxieUdpSocketQueueManager(unsigned snifferChannel, unsigned _numWorkers, bool encryptionInTransit) : RoxieSocketQueueManager(_numWorkers)
  2619. {
  2620. int udpQueueSize = topology->getPropInt("@udpQueueSize", UDP_QUEUE_SIZE);
  2621. int udpSendQueueSize = topology->getPropInt("@udpSendQueueSize", UDP_SEND_QUEUE_SIZE);
  2622. int udpMaxSlotsPerClient = topology->getPropInt("@udpMaxSlotsPerClient", 0x7fffffff);
  2623. if (topology->getPropInt("@sendMaxRate", 0))
  2624. {
  2625. unsigned sendMaxRate = topology->getPropInt("@sendMaxRate");
  2626. unsigned sendMaxRatePeriod = topology->getPropInt("@sendMaxRatePeriod", 1);
  2627. bucket.setown(new TokenBucket(sendMaxRate, sendMaxRatePeriod, sendMaxRate));
  2628. throttledPacketSendManager.setown(new RoxieThrottledPacketSender(*bucket, maxPacketSize));
  2629. }
  2630. IpAddress snifferIp;
  2631. getChannelIp(snifferIp, snifferChannel);
  2632. if (udpMaxSlotsPerClient > udpQueueSize)
  2633. udpMaxSlotsPerClient = udpQueueSize;
  2634. unsigned serverFlowPort = topology->getPropInt("@serverFlowPort", CCD_SERVER_FLOW_PORT);
  2635. unsigned dataPort = topology->getPropInt("@dataPort", CCD_DATA_PORT);
  2636. unsigned clientFlowPort = topology->getPropInt("@clientFlowPort", CCD_CLIENT_FLOW_PORT);
  2637. unsigned snifferPort = topology->getPropInt("@snifferPort", CCD_SNIFFER_PORT);
  2638. receiveManager.setown(createReceiveManager(serverFlowPort, dataPort, clientFlowPort, snifferPort, snifferIp, udpQueueSize, udpMaxSlotsPerClient, encryptionInTransit));
  2639. sendManager.setown(createSendManager(serverFlowPort, dataPort, clientFlowPort, snifferPort, snifferIp, udpSendQueueSize, fastLaneQueue ? 3 : 2, bucket, encryptionInTransit));
  2640. }
  2641. };
  2642. class RoxieAeronSocketQueueManager : public RoxieSocketQueueManager
  2643. {
  2644. public:
  2645. RoxieAeronSocketQueueManager(unsigned _numWorkers) : RoxieSocketQueueManager(_numWorkers)
  2646. {
  2647. unsigned dataPort = topology->getPropInt("@dataPort", CCD_DATA_PORT);
  2648. SocketEndpoint ep(dataPort, myNode.getIpAddress());
  2649. receiveManager.setown(createAeronReceiveManager(ep));
  2650. assertex(!myNode.getIpAddress().isNull());
  2651. sendManager.setown(createAeronSendManager(dataPort, fastLaneQueue ? 3 : 2, myNode.getIpAddress()));
  2652. }
  2653. };
  2654. #ifdef _MSC_VER
  2655. #pragma warning( pop )
  2656. #endif
  2657. //==================================================================================================
  2658. interface ILocalMessageCollator : extends IMessageCollator
  2659. {
  2660. virtual void enqueueMessage(bool outOfBand, void *data, unsigned datalen, void *meta, unsigned metalen, void *header, unsigned headerlen) = 0;
  2661. };
  2662. interface ILocalReceiveManager : extends IReceiveManager
  2663. {
  2664. virtual ILocalMessageCollator *lookupCollator(ruid_t id) = 0;
  2665. };
  2666. class LocalMessagePacker : public CDummyMessagePacker
  2667. {
  2668. MemoryBuffer meta;
  2669. MemoryBuffer header;
  2670. Linked<ILocalReceiveManager> rm;
  2671. ruid_t id;
  2672. bool outOfBand;
  2673. public:
  2674. IMPLEMENT_IINTERFACE;
  2675. LocalMessagePacker(RoxiePacketHeader &_header, bool _outOfBand, ILocalReceiveManager *_rm) : rm(_rm), outOfBand(_outOfBand)
  2676. {
  2677. id = _header.uid;
  2678. header.append(sizeof(RoxiePacketHeader), &_header);
  2679. }
  2680. virtual void flush() override;
  2681. virtual void sendMetaInfo(const void *buf, unsigned len) override
  2682. {
  2683. meta.append(len, buf);
  2684. }
  2685. };
  2686. class CLocalMessageUnpackCursor : implements IMessageUnpackCursor, public CInterface
  2687. {
  2688. void *data;
  2689. unsigned datalen;
  2690. unsigned pos;
  2691. Linked<IRowManager> rowManager;
  2692. public:
  2693. IMPLEMENT_IINTERFACE;
  2694. CLocalMessageUnpackCursor(IRowManager *_rowManager, void *_data, unsigned _datalen)
  2695. : rowManager(_rowManager)
  2696. {
  2697. datalen = _datalen;
  2698. data = _data;
  2699. pos = 0;
  2700. }
  2701. ~CLocalMessageUnpackCursor()
  2702. {
  2703. }
  2704. virtual bool atEOF() const
  2705. {
  2706. return datalen==pos;
  2707. }
  2708. virtual bool isSerialized() const
  2709. {
  2710. // NOTE: tempting to think that we could avoid serializing in localAgent case, but have to be careful about the lifespan of the rowManager...
  2711. return true;
  2712. }
  2713. virtual const void * getNext(int length)
  2714. {
  2715. if (pos==datalen)
  2716. return NULL;
  2717. assertex(pos + length <= datalen);
  2718. void * cur = ((char *) data) + pos;
  2719. pos += length;
  2720. void * ret = rowManager->allocate(length, 0);
  2721. memcpy(ret, cur, length);
  2722. //No need for finalize since only contains plain data.
  2723. return ret;
  2724. }
  2725. };
  2726. class CLocalMessageResult : implements IMessageResult, public CInterface
  2727. {
  2728. void *data;
  2729. void *meta;
  2730. void *header;
  2731. unsigned datalen, metalen, headerlen;
  2732. unsigned pos;
  2733. public:
  2734. IMPLEMENT_IINTERFACE;
  2735. CLocalMessageResult(void *_data, unsigned _datalen, void *_meta, unsigned _metalen, void *_header, unsigned _headerlen)
  2736. {
  2737. datalen = _datalen;
  2738. metalen = _metalen;
  2739. headerlen = _headerlen;
  2740. data = _data;
  2741. meta = _meta;
  2742. header = _header;
  2743. pos = 0;
  2744. }
  2745. ~CLocalMessageResult()
  2746. {
  2747. free(data);
  2748. free(meta);
  2749. free(header);
  2750. }
  2751. virtual IMessageUnpackCursor *getCursor(IRowManager *rowMgr) const
  2752. {
  2753. return new CLocalMessageUnpackCursor(rowMgr, data, datalen);
  2754. }
  2755. virtual const void *getMessageHeader(unsigned &length) const
  2756. {
  2757. length = headerlen;
  2758. return header;
  2759. }
  2760. virtual const void *getMessageMetadata(unsigned &length) const
  2761. {
  2762. length = metalen;
  2763. return meta;
  2764. }
  2765. virtual void discard() const
  2766. {
  2767. }
  2768. };
  2769. class CLocalMessageCollator : implements ILocalMessageCollator, public CInterface
  2770. {
  2771. InterruptableSemaphore sem;
  2772. QueueOf<IMessageResult, false> pending;
  2773. CriticalSection crit;
  2774. Linked<IRowManager> rowManager; // Linked to ensure it lives longer than me
  2775. Linked<ILocalReceiveManager> receiveManager;
  2776. ruid_t id;
  2777. unsigned totalBytesReceived;
  2778. public:
  2779. IMPLEMENT_IINTERFACE;
  2780. CLocalMessageCollator(IRowManager *_rowManager, ruid_t _ruid);
  2781. ~CLocalMessageCollator();
  2782. virtual ruid_t queryRUID() const
  2783. {
  2784. return id;
  2785. }
  2786. virtual IMessageResult* getNextResult(unsigned time_out, bool &anyActivity)
  2787. {
  2788. anyActivity = false;
  2789. if (!sem.wait(time_out))
  2790. return NULL;
  2791. anyActivity = true;
  2792. CriticalBlock c(crit);
  2793. return pending.dequeue();
  2794. }
  2795. virtual void interrupt(IException *E)
  2796. {
  2797. sem.interrupt(E);
  2798. }
  2799. virtual void enqueueMessage(bool outOfBand, void *data, unsigned datalen, void *meta, unsigned metalen, void *header, unsigned headerlen)
  2800. {
  2801. CriticalBlock c(crit);
  2802. if (outOfBand)
  2803. pending.enqueueHead(new CLocalMessageResult(data, datalen, meta, metalen, header, headerlen));
  2804. else
  2805. pending.enqueue(new CLocalMessageResult(data, datalen, meta, metalen, header, headerlen));
  2806. sem.signal();
  2807. totalBytesReceived += datalen + metalen + headerlen;
  2808. }
  2809. virtual unsigned queryBytesReceived() const
  2810. {
  2811. return totalBytesReceived;
  2812. }
  2813. };
  2814. class RoxieLocalReceiveManager : implements ILocalReceiveManager, public CInterface
  2815. {
  2816. MapXToMyClass<ruid_t, ruid_t, ILocalMessageCollator> collators;
  2817. CriticalSection crit;
  2818. Owned<StringContextLogger> logctx;
  2819. public:
  2820. IMPLEMENT_IINTERFACE;
  2821. RoxieLocalReceiveManager() : logctx(new StringContextLogger("RoxieLocalReceiveManager"))
  2822. {
  2823. }
  2824. virtual IMessageCollator *createMessageCollator(IRowManager *manager, ruid_t ruid)
  2825. {
  2826. ILocalMessageCollator *collator = new CLocalMessageCollator(manager, ruid);
  2827. CriticalBlock b(crit);
  2828. collators.setValue(ruid, collator);
  2829. return collator;
  2830. }
  2831. virtual void detachCollator(const IMessageCollator *collator)
  2832. {
  2833. ruid_t id = collator->queryRUID();
  2834. CriticalBlock b(crit);
  2835. collators.setValue(id, NULL);
  2836. }
  2837. virtual ILocalMessageCollator *lookupCollator(ruid_t id)
  2838. {
  2839. CriticalBlock b(crit);
  2840. ILocalMessageCollator *ret = collators.getValue(id);
  2841. if (!ret)
  2842. ret = collators.getValue(RUID_DISCARD);
  2843. return LINK(ret);
  2844. }
  2845. };
  2846. void LocalMessagePacker::flush()
  2847. {
  2848. // MORE - I think this means we don't send anything until whole message available in localAgent mode, which
  2849. // may not be optimal.
  2850. data.setLength(lastput);
  2851. Owned<ILocalMessageCollator> collator = rm->lookupCollator(id);
  2852. if (collator)
  2853. {
  2854. unsigned datalen = data.length();
  2855. unsigned metalen = meta.length();
  2856. unsigned headerlen = header.length();
  2857. collator->enqueueMessage(outOfBand, data.detach(), datalen, meta.detach(), metalen, header.detach(), headerlen);
  2858. }
  2859. // otherwise Roxie server is no longer interested and we can simply discard
  2860. }
  2861. CLocalMessageCollator::CLocalMessageCollator(IRowManager *_rowManager, ruid_t _ruid)
  2862. : rowManager(_rowManager), id(_ruid)
  2863. {
  2864. totalBytesReceived = 0;
  2865. }
  2866. CLocalMessageCollator::~CLocalMessageCollator()
  2867. {
  2868. IMessageResult *goer;
  2869. for (;;)
  2870. {
  2871. goer = pending.dequeue();
  2872. if (!goer)
  2873. break;
  2874. goer->Release();
  2875. }
  2876. }
  2877. class RoxieLocalQueueManager : public RoxieReceiverBase
  2878. {
  2879. Linked<RoxieLocalReceiveManager> receiveManager;
  2880. public:
  2881. RoxieLocalQueueManager(unsigned _numWorkers) : RoxieReceiverBase(_numWorkers)
  2882. {
  2883. receiveManager.setown(new RoxieLocalReceiveManager);
  2884. }
  2885. virtual void sendPacket(IRoxieQueryPacket *packet, const IRoxieContextLogger &logctx) override
  2886. {
  2887. RoxiePacketHeader &header = packet->queryHeader();
  2888. unsigned retries = header.thisChannelRetries(0);
  2889. if (header.activityId == ROXIE_FILECALLBACK || header.activityId == ROXIE_DEBUGCALLBACK )
  2890. {
  2891. if (traceLevel > 5)
  2892. {
  2893. StringBuffer s;
  2894. DBGLOG("ROXIE_CALLBACK %s", header.toString(s).str());
  2895. }
  2896. // MORE - do we need to encrypt these?
  2897. doFileCallback(packet);
  2898. }
  2899. else if (retries < SUBCHANNEL_MASK)
  2900. {
  2901. if (retries)
  2902. {
  2903. // Send back an out-of-band immediately, to let Roxie server know that channel is still active
  2904. RoxiePacketHeader newHeader(header, ROXIE_ALIVE, 0);
  2905. Owned<IMessagePacker> output = createOutputStream(newHeader, true, logctx);
  2906. output->flush();
  2907. return; // No point sending the retry in localAgent mode
  2908. }
  2909. RoxieQueue *targetQueue;
  2910. if (header.activityId & ROXIE_SLA_PRIORITY)
  2911. targetQueue = &slaQueue;
  2912. else if (header.activityId & ROXIE_HIGH_PRIORITY)
  2913. targetQueue = &hiQueue;
  2914. else
  2915. targetQueue = &loQueue;
  2916. Owned<ISerializedRoxieQueryPacket> serialized = packet->serialize();
  2917. if (header.channel)
  2918. {
  2919. targetQueue->enqueue(serialized.getClear());
  2920. }
  2921. else
  2922. {
  2923. // Turn broadcast packet (channel 0), as early as possible, into non-0 channel packets.
  2924. // So retries and other communication with Roxie server (which uses non-0 channel numbers) will not cause double work or confusion.
  2925. for (unsigned i = 1; i < numChannels; i++)
  2926. targetQueue->enqueue(serialized->cloneSerializedPacket(i+1));
  2927. header.channel = 1;
  2928. targetQueue->enqueue(serialized.getClear());
  2929. }
  2930. }
  2931. }
  2932. virtual void sendIbyti(RoxiePacketHeader &header, const IRoxieContextLogger &logctx, unsigned subChannel) override
  2933. {
  2934. // Don't do IBYTI's when local agent - no buddy to talk to anyway
  2935. }
  2936. virtual void sendAbort(RoxiePacketHeader &header, const IRoxieContextLogger &logctx) override
  2937. {
  2938. MTIME_SECTION(queryActiveTimer(), "RoxieLocalQueueManager::sendAbort");
  2939. RoxiePacketHeader abortHeader(header, header.activityId & ROXIE_PRIORITY_MASK, 0);
  2940. abortHeader.retries = QUERY_ABORTED;
  2941. if (logctx.queryTraceLevel() > 8)
  2942. {
  2943. StringBuffer s; logctx.CTXLOG("Sending ABORT packet %s", abortHeader.toString(s).str());
  2944. }
  2945. MemoryBuffer data;
  2946. data.append(sizeof(abortHeader), &abortHeader);
  2947. Owned<IRoxieQueryPacket> packet = createRoxiePacket(data);
  2948. sendPacket(packet, logctx);
  2949. abortsSent++;
  2950. }
  2951. virtual void sendAbortCallback(const RoxiePacketHeader &header, const char *lfn, const IRoxieContextLogger &logctx) override
  2952. {
  2953. MTIME_SECTION(queryActiveTimer(), "RoxieLocalQueueManager::sendAbortCallback");
  2954. RoxiePacketHeader abortHeader(header, ROXIE_FILECALLBACK, 0);
  2955. abortHeader.retries = QUERY_ABORTED;
  2956. MemoryBuffer data;
  2957. data.append(sizeof(abortHeader), &abortHeader).append(lfn);
  2958. if (logctx.queryTraceLevel() > 5)
  2959. {
  2960. StringBuffer s; logctx.CTXLOG("Sending ABORT FILECALLBACK packet %s for file %s", abortHeader.toString(s).str(), lfn);
  2961. }
  2962. Owned<IRoxieQueryPacket> packet = createRoxiePacket(data);
  2963. sendPacket(packet, logctx);
  2964. abortsSent++;
  2965. }
  2966. virtual IMessagePacker *createOutputStream(RoxiePacketHeader &header, bool outOfBand, const IRoxieContextLogger &logctx) override
  2967. {
  2968. return new LocalMessagePacker(header, outOfBand, receiveManager);
  2969. }
  2970. virtual IReceiveManager *queryReceiveManager() override
  2971. {
  2972. return receiveManager;
  2973. }
  2974. virtual bool replyPending(RoxiePacketHeader &header) override
  2975. {
  2976. // MORE - should really have some code here! But returning true is a reasonable approximation.
  2977. return true;
  2978. }
  2979. virtual bool abortCompleted(RoxiePacketHeader &header) override
  2980. {
  2981. // MORE - should really have some code here!
  2982. return false;
  2983. }
  2984. };
  2985. IRoxieOutputQueueManager *ROQ;
  2986. extern IRoxieOutputQueueManager *createOutputQueueManager(unsigned snifferChannel, unsigned numWorkers, bool encrypted)
  2987. {
  2988. if (localAgent)
  2989. return new RoxieLocalQueueManager(numWorkers);
  2990. else if (useAeron)
  2991. return new RoxieAeronSocketQueueManager(numWorkers);
  2992. else
  2993. return new RoxieUdpSocketQueueManager(snifferChannel, numWorkers, encrypted);
  2994. }
  2995. //================================================================================================================================
  2996. class PacketDiscarder : public Thread, implements IPacketDiscarder
  2997. {
  2998. bool aborted;
  2999. Owned<IRowManager> rowManager; // not completely sure I need one... maybe I do
  3000. Owned<IMessageCollator> mc;
  3001. public:
  3002. IMPLEMENT_IINTERFACE;
  3003. PacketDiscarder()
  3004. {
  3005. aborted = false;
  3006. };
  3007. ~PacketDiscarder()
  3008. {
  3009. if (mc)
  3010. ROQ->queryReceiveManager()->detachCollator(mc);
  3011. mc.clear();
  3012. }
  3013. virtual int run()
  3014. {
  3015. Owned<StringContextLogger> logctx = new StringContextLogger("PacketDiscarder");
  3016. rowManager.setown(roxiemem::createRowManager(0, NULL, *logctx, NULL, false));
  3017. mc.setown(ROQ->queryReceiveManager()->createMessageCollator(rowManager, RUID_DISCARD));
  3018. try
  3019. {
  3020. while (!aborted)
  3021. {
  3022. bool anyActivity = false;
  3023. Owned<IMessageResult> mr = mc->getNextResult(5000, anyActivity);
  3024. if (mr)
  3025. {
  3026. if (traceLevel > 4)
  3027. DBGLOG("Discarding unwanted message");
  3028. unsigned headerLen;
  3029. const RoxiePacketHeader &header = *(const RoxiePacketHeader *) mr->getMessageHeader(headerLen);
  3030. if (headerLen)
  3031. {
  3032. switch (header.activityId)
  3033. {
  3034. case ROXIE_FILECALLBACK:
  3035. {
  3036. Owned<IMessageUnpackCursor> callbackData = mr->getCursor(rowManager);
  3037. OwnedConstRoxieRow len = callbackData->getNext(sizeof(RecordLengthType));
  3038. if (len)
  3039. {
  3040. RecordLengthType *rowlen = (RecordLengthType *) len.get();
  3041. OwnedConstRoxieRow row = callbackData->getNext(*rowlen);
  3042. const char *rowdata = (const char *) row.get();
  3043. // bool isOpt = * (bool *) rowdata;
  3044. // bool isLocal = * (bool *) (rowdata+1);
  3045. ROQ->sendAbortCallback(header, rowdata+2, *logctx);
  3046. }
  3047. else
  3048. DBGLOG("Unrecognized format in discarded file callback");
  3049. break;
  3050. }
  3051. // MORE - ROXIE_ALIVE perhaps should go here too? debug callbacks? Actually any standard query results should too (though by the time I see them here it's too late (that may change once start streaming)
  3052. }
  3053. }
  3054. else
  3055. DBGLOG("Unwanted message had no header?!");
  3056. }
  3057. else if (!anyActivity)
  3058. {
  3059. // to avoid leaking partial unwanted packets, we clear out mc periodically...
  3060. ROQ->queryReceiveManager()->detachCollator(mc);
  3061. mc.setown(ROQ->queryReceiveManager()->createMessageCollator(rowManager, RUID_DISCARD));
  3062. }
  3063. }
  3064. }
  3065. catch (IException * E)
  3066. {
  3067. if (!aborted || QUERYINTERFACE(E, InterruptedSemaphoreException) == NULL)
  3068. EXCLOG(E);
  3069. ::Release(E);
  3070. }
  3071. return 0;
  3072. }
  3073. virtual void start()
  3074. {
  3075. Thread::start();
  3076. }
  3077. virtual void stop()
  3078. {
  3079. if (mc)
  3080. mc->interrupt();
  3081. aborted = true;
  3082. join();
  3083. }
  3084. };
  3085. IPacketDiscarder *createPacketDiscarder()
  3086. {
  3087. IPacketDiscarder *packetDiscarder = new PacketDiscarder;
  3088. packetDiscarder->start();
  3089. return packetDiscarder;
  3090. }
  3091. //================================================================================================================================
  3092. // There are various possibly interesting ways to reply to a ping:
  3093. // Reply as soon as receive, or put it on the queue like other messages?
  3094. // Reply for every channel, or just once for every agent?
  3095. // Should I send on channel 0 or round-robin the channels?
  3096. // My gut feeling is that knowing what channels are responding is useful so should reply on every unsuspended channel,
  3097. // and that the delay caused by queuing system is an interesting part of what we want to measure (though nice to know minimum possible too)
  3098. unsigned pingInterval = 60;
  3099. class PingTimer : public Thread
  3100. {
  3101. bool aborted;
  3102. Owned<IRowManager> rowManager;
  3103. Owned<IMessageCollator> mc;
  3104. StringContextLogger logctx;
  3105. void sendPing(unsigned priorityMask)
  3106. {
  3107. try
  3108. {
  3109. RemoteActivityId pingId(ROXIE_PING | priorityMask, 0);
  3110. RoxiePacketHeader header(pingId, 0, 0, 0);
  3111. MemoryBuffer mb;
  3112. mb.append(sizeof(RoxiePacketHeader), &header);
  3113. mb.append((char) LOGGING_FLAGSPRESENT);
  3114. mb.append("PING");
  3115. PingRecord data;
  3116. data.senderIP.ipset(myNode.getIpAddress());
  3117. data.tick = usTick();
  3118. mb.append(sizeof(PingRecord), &data);
  3119. if (traceLevel > 1)
  3120. DBGLOG("PING sent");
  3121. Owned<IRoxieQueryPacket> packet = createRoxiePacket(mb);
  3122. ROQ->sendPacket(packet, logctx);
  3123. }
  3124. catch (IException *E)
  3125. {
  3126. EXCLOG(E);
  3127. E->Release();
  3128. }
  3129. }
  3130. public:
  3131. PingTimer() : logctx("PingTimer")
  3132. {
  3133. aborted = false;
  3134. };
  3135. ~PingTimer()
  3136. {
  3137. if (mc)
  3138. ROQ->queryReceiveManager()->detachCollator(mc);
  3139. mc.clear();
  3140. }
  3141. virtual int run()
  3142. {
  3143. rowManager.setown(roxiemem::createRowManager(1, NULL, queryDummyContextLogger(), NULL, false));
  3144. mc.setown(ROQ->queryReceiveManager()->createMessageCollator(rowManager, RUID_PING));
  3145. unsigned pingsReceived = 0;
  3146. unsigned pingsElapsed = 0;
  3147. sendPing(ROXIE_HIGH_PRIORITY);
  3148. while (!aborted)
  3149. {
  3150. bool anyActivity = false;
  3151. Owned<IMessageResult> mr = mc->getNextResult(pingInterval*1000, anyActivity);
  3152. if (mr)
  3153. {
  3154. unsigned headerLen;
  3155. const RoxiePacketHeader *header = (const RoxiePacketHeader *) mr->getMessageHeader(headerLen);
  3156. Owned<IMessageUnpackCursor> mu = mr->getCursor(rowManager);
  3157. PingRecord *answer = (PingRecord *) mu->getNext(sizeof(PingRecord));
  3158. if (answer && mu->atEOF() && headerLen==sizeof(RoxiePacketHeader))
  3159. {
  3160. unsigned elapsed = usTick() - answer->tick;
  3161. pingsReceived++;
  3162. pingsElapsed += elapsed;
  3163. if (traceLevel > 10)
  3164. DBGLOG("PING reply channel=%d, time %d", header->channel, elapsed); // DBGLOG is slower than the pings so be careful!
  3165. }
  3166. else
  3167. DBGLOG("PING reply, garbled result");
  3168. ReleaseRoxieRow(answer);
  3169. }
  3170. else if (!anyActivity)
  3171. {
  3172. if (!pingsReceived && roxieMulticastEnabled)
  3173. DBGLOG("PING: NO replies received! Please check multicast settings, and that your network supports multicast.");
  3174. else if (traceLevel)
  3175. DBGLOG("PING: %d replies received, average delay %uus", pingsReceived, pingsReceived ? pingsElapsed / pingsReceived : 0);
  3176. pingsReceived = 0;
  3177. pingsElapsed = 0;
  3178. sendPing(ROXIE_HIGH_PRIORITY); // MORE - we could think about alternating the priority or sending pings on high and low at the same time...
  3179. }
  3180. }
  3181. return 0;
  3182. }
  3183. void stop()
  3184. {
  3185. if (mc)
  3186. mc->interrupt();
  3187. aborted = true;
  3188. }
  3189. static CriticalSection crit;
  3190. } *pingTimer;
  3191. CriticalSection PingTimer::crit;
  3192. extern void startPingTimer()
  3193. {
  3194. CriticalBlock b(PingTimer::crit);
  3195. if (!pingTimer)
  3196. {
  3197. pingTimer = new PingTimer();
  3198. pingTimer->start();
  3199. }
  3200. }
  3201. extern void stopPingTimer()
  3202. {
  3203. CriticalBlock b(PingTimer::crit);
  3204. if (pingTimer)
  3205. {
  3206. pingTimer->stop();
  3207. pingTimer->join();
  3208. delete pingTimer;
  3209. pingTimer = NULL;
  3210. }
  3211. }