portal.go 67 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147148149150151152153154155156157158159160161162163164165166167168169170171172173174175176177178179180181182183184185186187188189190191192193194195196197198199200201202203204205206207208209210211212213214215216217218219220221222223224225226227228229230231232233234235236237238239240241242243244245246247248249250251252253254255256257258259260261262263264265266267268269270271272273274275276277278279280281282283284285286287288289290291292293294295296297298299300301302303304305306307308309310311312313314315316317318319320321322323324325326327328329330331332333334335336337338339340341342343344345346347348349350351352353354355356357358359360361362363364365366367368369370371372373374375376377378379380381382383384385386387388389390391392393394395396397398399400401402403404405406407408409410411412413414415416417418419420421422423424425426427428429430431432433434435436437438439440441442443444445446447448449450451452453454455456457458459460461462463464465466467468469470471472473474475476477478479480481482483484485486487488489490491492493494495496497498499500501502503504505506507508509510511512513514515516517518519520521522523524525526527528529530531532533534535536537538539540541542543544545546547548549550551552553554555556557558559560561562563564565566567568569570571572573574575576577578579580581582583584585586587588589590591592593594595596597598599600601602603604605606607608609610611612613614615616617618619620621622623624625626627628629630631632633634635636637638639640641642643644645646647648649650651652653654655656657658659660661662663664665666667668669670671672673674675676677678679680681682683684685686687688689690691692693694695696697698699700701702703704705706707708709710711712713714715716717718719720721722723724725726727728729730731732733734735736737738739740741742743744745746747748749750751752753754755756757758759760761762763764765766767768769770771772773774775776777778779780781782783784785786787788789790791792793794795796797798799800801802803804805806807808809810811812813814815816817818819820821822823824825826827828829830831832833834835836837838839840841842843844845846847848849850851852853854855856857858859860861862863864865866867868869870871872873874875876877878879880881882883884885886887888889890891892893894895896897898899900901902903904905906907908909910911912913914915916917918919920921922923924925926927928929930931932933934935936937938939940941942943944945946947948949950951952953954955956957958959960961962963964965966967968969970971972973974975976977978979980981982983984985986987988989990991992993994995996997998999100010011002100310041005100610071008100910101011101210131014101510161017101810191020102110221023102410251026102710281029103010311032103310341035103610371038103910401041104210431044104510461047104810491050105110521053105410551056105710581059106010611062106310641065106610671068106910701071107210731074107510761077107810791080108110821083108410851086108710881089109010911092109310941095109610971098109911001101110211031104110511061107110811091110111111121113111411151116111711181119112011211122112311241125112611271128112911301131113211331134113511361137113811391140114111421143114411451146114711481149115011511152115311541155115611571158115911601161116211631164116511661167116811691170117111721173117411751176117711781179118011811182118311841185118611871188118911901191119211931194119511961197119811991200120112021203120412051206120712081209121012111212121312141215121612171218121912201221122212231224122512261227122812291230123112321233123412351236123712381239124012411242124312441245124612471248124912501251125212531254125512561257125812591260126112621263126412651266126712681269127012711272127312741275127612771278127912801281128212831284128512861287128812891290129112921293129412951296129712981299130013011302130313041305130613071308130913101311131213131314131513161317131813191320132113221323132413251326132713281329133013311332133313341335133613371338133913401341134213431344134513461347134813491350135113521353135413551356135713581359136013611362136313641365136613671368136913701371137213731374137513761377137813791380138113821383138413851386138713881389139013911392139313941395139613971398139914001401140214031404140514061407140814091410141114121413141414151416141714181419142014211422142314241425142614271428142914301431143214331434143514361437143814391440144114421443144414451446144714481449145014511452145314541455145614571458145914601461146214631464146514661467146814691470147114721473147414751476147714781479148014811482148314841485148614871488148914901491149214931494149514961497149814991500150115021503150415051506150715081509151015111512151315141515151615171518151915201521152215231524152515261527152815291530153115321533153415351536153715381539154015411542154315441545154615471548154915501551155215531554155515561557155815591560156115621563156415651566156715681569157015711572157315741575157615771578157915801581158215831584158515861587158815891590159115921593159415951596159715981599160016011602160316041605160616071608160916101611161216131614161516161617161816191620162116221623162416251626162716281629163016311632163316341635163616371638163916401641164216431644164516461647164816491650165116521653165416551656165716581659166016611662166316641665166616671668166916701671167216731674167516761677167816791680168116821683168416851686168716881689169016911692169316941695169616971698169917001701170217031704170517061707170817091710171117121713171417151716171717181719172017211722172317241725172617271728172917301731173217331734173517361737173817391740174117421743174417451746174717481749175017511752175317541755175617571758175917601761176217631764176517661767176817691770177117721773177417751776177717781779178017811782178317841785178617871788178917901791179217931794179517961797179817991800180118021803180418051806180718081809181018111812181318141815181618171818181918201821182218231824182518261827182818291830183118321833183418351836183718381839184018411842184318441845184618471848184918501851185218531854185518561857185818591860186118621863186418651866186718681869187018711872187318741875187618771878187918801881188218831884188518861887188818891890189118921893189418951896189718981899190019011902190319041905190619071908190919101911191219131914191519161917191819191920192119221923192419251926192719281929193019311932193319341935193619371938193919401941194219431944194519461947194819491950195119521953195419551956195719581959196019611962196319641965196619671968196919701971197219731974197519761977197819791980198119821983198419851986198719881989199019911992199319941995199619971998199920002001200220032004200520062007200820092010201120122013201420152016201720182019202020212022202320242025202620272028202920302031203220332034203520362037203820392040204120422043204420452046204720482049205020512052205320542055205620572058205920602061206220632064206520662067206820692070207120722073207420752076207720782079208020812082208320842085208620872088208920902091209220932094209520962097209820992100210121022103210421052106210721082109211021112112211321142115211621172118211921202121212221232124212521262127212821292130213121322133213421352136213721382139214021412142214321442145214621472148214921502151215221532154215521562157215821592160216121622163216421652166216721682169217021712172217321742175217621772178217921802181218221832184218521862187218821892190219121922193219421952196219721982199220022012202220322042205220622072208220922102211221222132214221522162217221822192220222122222223222422252226222722282229223022312232
  1. // mautrix-whatsapp - A Matrix-WhatsApp puppeting bridge.
  2. // Copyright (C) 2020 Tulir Asokan
  3. //
  4. // This program is free software: you can redistribute it and/or modify
  5. // it under the terms of the GNU Affero General Public License as published by
  6. // the Free Software Foundation, either version 3 of the License, or
  7. // (at your option) any later version.
  8. //
  9. // This program is distributed in the hope that it will be useful,
  10. // but WITHOUT ANY WARRANTY; without even the implied warranty of
  11. // MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
  12. // GNU Affero General Public License for more details.
  13. //
  14. // You should have received a copy of the GNU Affero General Public License
  15. // along with this program. If not, see <https://www.gnu.org/licenses/>.
  16. package main
  17. import (
  18. "bytes"
  19. "encoding/gob"
  20. "encoding/hex"
  21. "errors"
  22. "fmt"
  23. "html"
  24. "image"
  25. "image/gif"
  26. "image/jpeg"
  27. "image/png"
  28. "io/ioutil"
  29. "math"
  30. "math/rand"
  31. "mime"
  32. "net/http"
  33. "os"
  34. "os/exec"
  35. "path/filepath"
  36. "reflect"
  37. "strings"
  38. "sync"
  39. "time"
  40. log "maunium.net/go/maulogger/v2"
  41. "maunium.net/go/mautrix/crypto/attachment"
  42. "github.com/Rhymen/go-whatsapp"
  43. waProto "github.com/Rhymen/go-whatsapp/binary/proto"
  44. "maunium.net/go/mautrix"
  45. "maunium.net/go/mautrix/appservice"
  46. "maunium.net/go/mautrix/event"
  47. "maunium.net/go/mautrix/format"
  48. "maunium.net/go/mautrix/id"
  49. "maunium.net/go/mautrix/pushrules"
  50. "maunium.net/go/mautrix-whatsapp/database"
  51. "maunium.net/go/mautrix-whatsapp/types"
  52. "maunium.net/go/mautrix-whatsapp/whatsapp-ext"
  53. )
  54. func (bridge *Bridge) GetPortalByMXID(mxid id.RoomID) *Portal {
  55. bridge.portalsLock.Lock()
  56. defer bridge.portalsLock.Unlock()
  57. portal, ok := bridge.portalsByMXID[mxid]
  58. if !ok {
  59. return bridge.loadDBPortal(bridge.DB.Portal.GetByMXID(mxid), nil)
  60. }
  61. return portal
  62. }
  63. func (bridge *Bridge) GetPortalByJID(key database.PortalKey) *Portal {
  64. bridge.portalsLock.Lock()
  65. defer bridge.portalsLock.Unlock()
  66. portal, ok := bridge.portalsByJID[key]
  67. if !ok {
  68. return bridge.loadDBPortal(bridge.DB.Portal.GetByJID(key), &key)
  69. }
  70. return portal
  71. }
  72. func (bridge *Bridge) GetAllPortals() []*Portal {
  73. return bridge.dbPortalsToPortals(bridge.DB.Portal.GetAll())
  74. }
  75. func (bridge *Bridge) GetAllPortalsByJID(jid types.WhatsAppID) []*Portal {
  76. return bridge.dbPortalsToPortals(bridge.DB.Portal.GetAllByJID(jid))
  77. }
  78. func (bridge *Bridge) dbPortalsToPortals(dbPortals []*database.Portal) []*Portal {
  79. bridge.portalsLock.Lock()
  80. defer bridge.portalsLock.Unlock()
  81. output := make([]*Portal, len(dbPortals))
  82. for index, dbPortal := range dbPortals {
  83. if dbPortal == nil {
  84. continue
  85. }
  86. portal, ok := bridge.portalsByJID[dbPortal.Key]
  87. if !ok {
  88. portal = bridge.loadDBPortal(dbPortal, nil)
  89. }
  90. output[index] = portal
  91. }
  92. return output
  93. }
  94. func (bridge *Bridge) loadDBPortal(dbPortal *database.Portal, key *database.PortalKey) *Portal {
  95. if dbPortal == nil {
  96. if key == nil {
  97. return nil
  98. }
  99. dbPortal = bridge.DB.Portal.New()
  100. dbPortal.Key = *key
  101. dbPortal.Insert()
  102. }
  103. portal := bridge.NewPortal(dbPortal)
  104. bridge.portalsByJID[portal.Key] = portal
  105. if len(portal.MXID) > 0 {
  106. bridge.portalsByMXID[portal.MXID] = portal
  107. }
  108. return portal
  109. }
  110. func (portal *Portal) GetUsers() []*User {
  111. return nil
  112. }
  113. func (bridge *Bridge) NewManualPortal(key database.PortalKey) *Portal {
  114. portal := &Portal{
  115. Portal: bridge.DB.Portal.New(),
  116. bridge: bridge,
  117. log: bridge.Log.Sub(fmt.Sprintf("Portal/%s", key)),
  118. recentlyHandled: [recentlyHandledLength]types.WhatsAppMessageID{},
  119. messages: make(chan PortalMessage, bridge.Config.Bridge.PortalMessageBuffer),
  120. }
  121. portal.Key = key
  122. go portal.handleMessageLoop()
  123. return portal
  124. }
  125. func (bridge *Bridge) NewPortal(dbPortal *database.Portal) *Portal {
  126. portal := &Portal{
  127. Portal: dbPortal,
  128. bridge: bridge,
  129. log: bridge.Log.Sub(fmt.Sprintf("Portal/%s", dbPortal.Key)),
  130. recentlyHandled: [recentlyHandledLength]types.WhatsAppMessageID{},
  131. messages: make(chan PortalMessage, bridge.Config.Bridge.PortalMessageBuffer),
  132. }
  133. go portal.handleMessageLoop()
  134. return portal
  135. }
  136. const recentlyHandledLength = 100
  137. type PortalMessage struct {
  138. chat string
  139. source *User
  140. data interface{}
  141. timestamp uint64
  142. }
  143. type Portal struct {
  144. *database.Portal
  145. bridge *Bridge
  146. log log.Logger
  147. roomCreateLock sync.Mutex
  148. recentlyHandled [recentlyHandledLength]types.WhatsAppMessageID
  149. recentlyHandledLock sync.Mutex
  150. recentlyHandledIndex uint8
  151. backfillLock sync.Mutex
  152. backfilling bool
  153. lastMessageTs uint64
  154. privateChatBackfillInvitePuppet func()
  155. messages chan PortalMessage
  156. isPrivate *bool
  157. hasRelaybot *bool
  158. }
  159. const MaxMessageAgeToCreatePortal = 5 * 60 // 5 minutes
  160. func (portal *Portal) handleMessageLoop() {
  161. for msg := range portal.messages {
  162. if len(portal.MXID) == 0 {
  163. if msg.timestamp+MaxMessageAgeToCreatePortal < uint64(time.Now().Unix()) {
  164. portal.log.Debugln("Not creating portal room for incoming message as the message is too old.")
  165. continue
  166. }
  167. portal.log.Debugln("Creating Matrix room from incoming message")
  168. err := portal.CreateMatrixRoom(msg.source)
  169. if err != nil {
  170. portal.log.Errorln("Failed to create portal room:", err)
  171. return
  172. }
  173. }
  174. portal.backfillLock.Lock()
  175. portal.handleMessage(msg)
  176. portal.backfillLock.Unlock()
  177. }
  178. }
  179. func (portal *Portal) handleMessage(msg PortalMessage) {
  180. if len(portal.MXID) == 0 {
  181. portal.log.Warnln("handleMessage called even though portal.MXID is empty")
  182. return
  183. }
  184. switch data := msg.data.(type) {
  185. case whatsapp.TextMessage:
  186. portal.HandleTextMessage(msg.source, data)
  187. case whatsapp.ImageMessage:
  188. portal.HandleMediaMessage(msg.source, mediaMessage{
  189. base: base{data.Download, data.Info, data.ContextInfo, data.Type},
  190. thumbnail: data.Thumbnail,
  191. caption: data.Caption,
  192. })
  193. case whatsapp.StickerMessage:
  194. portal.HandleMediaMessage(msg.source, mediaMessage{
  195. base: base{data.Download, data.Info, data.ContextInfo, data.Type},
  196. sendAsSticker: true,
  197. })
  198. case whatsapp.VideoMessage:
  199. portal.HandleMediaMessage(msg.source, mediaMessage{
  200. base: base{data.Download, data.Info, data.ContextInfo, data.Type},
  201. thumbnail: data.Thumbnail,
  202. caption: data.Caption,
  203. length: data.Length,
  204. })
  205. case whatsapp.AudioMessage:
  206. portal.HandleMediaMessage(msg.source, mediaMessage{
  207. base: base{data.Download, data.Info, data.ContextInfo, data.Type},
  208. length: data.Length,
  209. })
  210. case whatsapp.DocumentMessage:
  211. fileName := data.FileName
  212. if len(fileName) == 0 {
  213. fileName = data.Title
  214. }
  215. portal.HandleMediaMessage(msg.source, mediaMessage{
  216. base: base{data.Download, data.Info, data.ContextInfo, data.Type},
  217. thumbnail: data.Thumbnail,
  218. fileName: fileName,
  219. })
  220. case whatsapp.ContactMessage:
  221. portal.HandleContactMessage(msg.source, data)
  222. case whatsapp.LocationMessage:
  223. portal.HandleLocationMessage(msg.source, data)
  224. case whatsappExt.MessageRevocation:
  225. portal.HandleMessageRevoke(msg.source, data)
  226. case FakeMessage:
  227. portal.HandleFakeMessage(msg.source, data)
  228. default:
  229. portal.log.Warnln("Unknown message type:", reflect.TypeOf(msg.data))
  230. }
  231. }
  232. func (portal *Portal) isRecentlyHandled(id types.WhatsAppMessageID) bool {
  233. start := portal.recentlyHandledIndex
  234. for i := start; i != start; i = (i - 1) % recentlyHandledLength {
  235. if portal.recentlyHandled[i] == id {
  236. return true
  237. }
  238. }
  239. return false
  240. }
  241. func (portal *Portal) isDuplicate(id types.WhatsAppMessageID) bool {
  242. msg := portal.bridge.DB.Message.GetByJID(portal.Key, id)
  243. if msg != nil {
  244. return true
  245. }
  246. return false
  247. }
  248. func init() {
  249. gob.Register(&waProto.Message{})
  250. }
  251. func (portal *Portal) markHandled(source *User, message *waProto.WebMessageInfo, mxid id.EventID) {
  252. msg := portal.bridge.DB.Message.New()
  253. msg.Chat = portal.Key
  254. msg.JID = message.GetKey().GetId()
  255. msg.MXID = mxid
  256. msg.Timestamp = message.GetMessageTimestamp()
  257. if message.GetKey().GetFromMe() {
  258. msg.Sender = source.JID
  259. } else if portal.IsPrivateChat() {
  260. msg.Sender = portal.Key.JID
  261. } else {
  262. msg.Sender = message.GetKey().GetParticipant()
  263. if len(msg.Sender) == 0 {
  264. msg.Sender = message.GetParticipant()
  265. }
  266. }
  267. msg.Content = message.Message
  268. msg.Insert()
  269. portal.recentlyHandledLock.Lock()
  270. index := portal.recentlyHandledIndex
  271. portal.recentlyHandledIndex = (portal.recentlyHandledIndex + 1) % recentlyHandledLength
  272. portal.recentlyHandledLock.Unlock()
  273. portal.recentlyHandled[index] = msg.JID
  274. }
  275. func (portal *Portal) getMessageIntent(user *User, info whatsapp.MessageInfo) *appservice.IntentAPI {
  276. if info.FromMe {
  277. return portal.bridge.GetPuppetByJID(user.JID).IntentFor(portal)
  278. } else if portal.IsPrivateChat() {
  279. return portal.MainIntent()
  280. } else if len(info.SenderJid) == 0 {
  281. if len(info.Source.GetParticipant()) != 0 {
  282. info.SenderJid = info.Source.GetParticipant()
  283. } else {
  284. return nil
  285. }
  286. }
  287. return portal.bridge.GetPuppetByJID(info.SenderJid).IntentFor(portal)
  288. }
  289. func (portal *Portal) startHandling(source *User, info whatsapp.MessageInfo) *appservice.IntentAPI {
  290. // TODO these should all be trace logs
  291. if portal.lastMessageTs > info.Timestamp+1 {
  292. portal.log.Debugfln("Not handling %s: message is older (%d) than last bridge message (%d)", info.Id, info.Timestamp, portal.lastMessageTs)
  293. } else if portal.isRecentlyHandled(info.Id) {
  294. portal.log.Debugfln("Not handling %s: message was recently handled", info.Id)
  295. } else if portal.isDuplicate(info.Id) {
  296. portal.log.Debugfln("Not handling %s: message is duplicate", info.Id)
  297. } else {
  298. portal.lastMessageTs = info.Timestamp
  299. intent := portal.getMessageIntent(source, info)
  300. if intent != nil {
  301. portal.log.Debugfln("Starting handling of %s (ts: %d)", info.Id, info.Timestamp)
  302. } else {
  303. portal.log.Debugfln("Not handling %s: sender is not known")
  304. }
  305. return intent
  306. }
  307. return nil
  308. }
  309. func (portal *Portal) finishHandling(source *User, message *waProto.WebMessageInfo, mxid id.EventID) {
  310. portal.markHandled(source, message, mxid)
  311. portal.sendDeliveryReceipt(mxid)
  312. portal.log.Debugln("Handled message", message.GetKey().GetId(), "->", mxid)
  313. }
  314. func (portal *Portal) SyncParticipants(metadata *whatsappExt.GroupInfo) {
  315. changed := false
  316. levels, err := portal.MainIntent().PowerLevels(portal.MXID)
  317. if err != nil {
  318. levels = portal.GetBasePowerLevels()
  319. changed = true
  320. }
  321. participantMap := make(map[string]bool)
  322. for _, participant := range metadata.Participants {
  323. participantMap[participant.JID] = true
  324. user := portal.bridge.GetUserByJID(participant.JID)
  325. portal.userMXIDAction(user, portal.ensureMXIDInvited)
  326. puppet := portal.bridge.GetPuppetByJID(participant.JID)
  327. err := puppet.IntentFor(portal).EnsureJoined(portal.MXID)
  328. if err != nil {
  329. portal.log.Warnfln("Failed to make puppet of %s join %s: %v", participant.JID, portal.MXID, err)
  330. }
  331. expectedLevel := 0
  332. if participant.IsSuperAdmin {
  333. expectedLevel = 95
  334. } else if participant.IsAdmin {
  335. expectedLevel = 50
  336. }
  337. changed = levels.EnsureUserLevel(puppet.MXID, expectedLevel) || changed
  338. if user != nil {
  339. changed = levels.EnsureUserLevel(user.MXID, expectedLevel) || changed
  340. }
  341. }
  342. if changed {
  343. _, err = portal.MainIntent().SetPowerLevels(portal.MXID, levels)
  344. if err != nil {
  345. portal.log.Errorln("Failed to change power levels:", err)
  346. }
  347. }
  348. members, err := portal.MainIntent().JoinedMembers(portal.MXID)
  349. if err != nil {
  350. portal.log.Warnln("Failed to get member list:", err)
  351. } else {
  352. for member := range members.Joined {
  353. jid, ok := portal.bridge.ParsePuppetMXID(member)
  354. if ok {
  355. _, shouldBePresent := participantMap[jid]
  356. if !shouldBePresent {
  357. _, err := portal.MainIntent().KickUser(portal.MXID, &mautrix.ReqKickUser{
  358. UserID: member,
  359. Reason: "User had left this WhatsApp chat",
  360. })
  361. if err != nil {
  362. portal.log.Warnfln("Failed to kick user %s who had left: %v", member, err)
  363. }
  364. }
  365. }
  366. }
  367. }
  368. }
  369. func (portal *Portal) UpdateAvatar(user *User, avatar *whatsappExt.ProfilePicInfo, updateInfo bool) bool {
  370. if avatar == nil {
  371. var err error
  372. avatar, err = user.Conn.GetProfilePicThumb(portal.Key.JID)
  373. if err != nil {
  374. portal.log.Errorln(err)
  375. return false
  376. }
  377. }
  378. if avatar.Status != 0 {
  379. return false
  380. }
  381. if portal.Avatar == avatar.Tag {
  382. return false
  383. }
  384. data, err := avatar.DownloadBytes()
  385. if err != nil {
  386. portal.log.Warnln("Failed to download avatar:", err)
  387. return false
  388. }
  389. mimeType := http.DetectContentType(data)
  390. resp, err := portal.MainIntent().UploadBytes(data, mimeType)
  391. if err != nil {
  392. portal.log.Warnln("Failed to upload avatar:", err)
  393. return false
  394. }
  395. portal.AvatarURL = resp.ContentURI
  396. if len(portal.MXID) > 0 {
  397. _, err = portal.MainIntent().SetRoomAvatar(portal.MXID, resp.ContentURI)
  398. if err != nil {
  399. portal.log.Warnln("Failed to set room topic:", err)
  400. return false
  401. }
  402. }
  403. portal.Avatar = avatar.Tag
  404. if updateInfo {
  405. portal.UpdateBridgeInfo()
  406. }
  407. return true
  408. }
  409. func (portal *Portal) UpdateName(name string, setBy types.WhatsAppID, updateInfo bool) bool {
  410. if portal.Name != name {
  411. intent := portal.MainIntent()
  412. if len(setBy) > 0 {
  413. intent = portal.bridge.GetPuppetByJID(setBy).IntentFor(portal)
  414. }
  415. _, err := intent.SetRoomName(portal.MXID, name)
  416. if err == nil {
  417. portal.Name = name
  418. if updateInfo {
  419. portal.UpdateBridgeInfo()
  420. }
  421. return true
  422. }
  423. portal.log.Warnln("Failed to set room name:", err)
  424. }
  425. return false
  426. }
  427. func (portal *Portal) UpdateTopic(topic string, setBy types.WhatsAppID, updateInfo bool) bool {
  428. if portal.Topic != topic {
  429. intent := portal.MainIntent()
  430. if len(setBy) > 0 {
  431. intent = portal.bridge.GetPuppetByJID(setBy).IntentFor(portal)
  432. }
  433. _, err := intent.SetRoomTopic(portal.MXID, topic)
  434. if err == nil {
  435. portal.Topic = topic
  436. if updateInfo {
  437. portal.UpdateBridgeInfo()
  438. }
  439. return true
  440. }
  441. portal.log.Warnln("Failed to set room topic:", err)
  442. }
  443. return false
  444. }
  445. func (portal *Portal) UpdateMetadata(user *User) bool {
  446. if portal.IsPrivateChat() {
  447. return false
  448. } else if portal.IsStatusBroadcastRoom() {
  449. update := false
  450. update = portal.UpdateName("WhatsApp Status Broadcast", "", false) || update
  451. update = portal.UpdateTopic("WhatsApp status updates from your contacts", "", false) || update
  452. return update
  453. }
  454. metadata, err := user.Conn.GetGroupMetaData(portal.Key.JID)
  455. if err != nil {
  456. portal.log.Errorln(err)
  457. return false
  458. }
  459. if metadata.Status != 0 {
  460. // 401: access denied
  461. // 404: group does (no longer) exist
  462. // 500: ??? happens with status@broadcast
  463. // TODO: update the room, e.g. change priority level
  464. // to send messages to moderator
  465. return false
  466. }
  467. portal.SyncParticipants(metadata)
  468. update := false
  469. update = portal.UpdateName(metadata.Name, metadata.NameSetBy, false) || update
  470. update = portal.UpdateTopic(metadata.Topic, metadata.TopicSetBy, false) || update
  471. portal.RestrictMessageSending(metadata.Announce)
  472. return update
  473. }
  474. func (portal *Portal) userMXIDAction(user *User, fn func(mxid id.UserID)) {
  475. if user == nil {
  476. return
  477. }
  478. if user == portal.bridge.Relaybot {
  479. for _, mxid := range portal.bridge.Config.Bridge.Relaybot.InviteUsers {
  480. fn(mxid)
  481. }
  482. } else {
  483. fn(user.MXID)
  484. }
  485. }
  486. func (portal *Portal) ensureMXIDInvited(mxid id.UserID) {
  487. err := portal.MainIntent().EnsureInvited(portal.MXID, mxid)
  488. if err != nil {
  489. portal.log.Warnfln("Failed to ensure %s is invited to %s: %v", mxid, portal.MXID, err)
  490. }
  491. }
  492. func (portal *Portal) ensureUserInvited(user *User) {
  493. portal.userMXIDAction(user, portal.ensureMXIDInvited)
  494. customPuppet := portal.bridge.GetPuppetByCustomMXID(user.MXID)
  495. if customPuppet != nil && customPuppet.CustomIntent() != nil {
  496. _ = customPuppet.CustomIntent().EnsureJoined(portal.MXID)
  497. }
  498. }
  499. func (portal *Portal) Sync(user *User, contact whatsapp.Contact) {
  500. portal.log.Infoln("Syncing portal for", user.MXID)
  501. if user.IsRelaybot {
  502. yes := true
  503. portal.hasRelaybot = &yes
  504. }
  505. if len(portal.MXID) == 0 {
  506. if !portal.IsPrivateChat() {
  507. portal.Name = contact.Name
  508. }
  509. err := portal.CreateMatrixRoom(user)
  510. if err != nil {
  511. portal.log.Errorln("Failed to create portal room:", err)
  512. return
  513. }
  514. } else {
  515. portal.ensureUserInvited(user)
  516. }
  517. if portal.IsPrivateChat() {
  518. return
  519. }
  520. update := false
  521. update = portal.UpdateMetadata(user) || update
  522. if !portal.IsStatusBroadcastRoom() {
  523. update = portal.UpdateAvatar(user, nil, false) || update
  524. }
  525. if update {
  526. portal.Update()
  527. portal.UpdateBridgeInfo()
  528. }
  529. }
  530. func (portal *Portal) GetBasePowerLevels() *event.PowerLevelsEventContent {
  531. anyone := 0
  532. nope := 99
  533. invite := 50
  534. if portal.bridge.Config.Bridge.AllowUserInvite {
  535. invite = 0
  536. }
  537. return &event.PowerLevelsEventContent{
  538. UsersDefault: anyone,
  539. EventsDefault: anyone,
  540. RedactPtr: &anyone,
  541. StateDefaultPtr: &nope,
  542. BanPtr: &nope,
  543. InvitePtr: &invite,
  544. Users: map[id.UserID]int{
  545. portal.MainIntent().UserID: 100,
  546. },
  547. Events: map[string]int{
  548. event.StateRoomName.Type: anyone,
  549. event.StateRoomAvatar.Type: anyone,
  550. event.StateTopic.Type: anyone,
  551. },
  552. }
  553. }
  554. func (portal *Portal) ChangeAdminStatus(jids []string, setAdmin bool) {
  555. levels, err := portal.MainIntent().PowerLevels(portal.MXID)
  556. if err != nil {
  557. levels = portal.GetBasePowerLevels()
  558. }
  559. newLevel := 0
  560. if setAdmin {
  561. newLevel = 50
  562. }
  563. changed := false
  564. for _, jid := range jids {
  565. puppet := portal.bridge.GetPuppetByJID(jid)
  566. changed = levels.EnsureUserLevel(puppet.MXID, newLevel) || changed
  567. user := portal.bridge.GetUserByJID(jid)
  568. if user != nil {
  569. changed = levels.EnsureUserLevel(user.MXID, newLevel) || changed
  570. }
  571. }
  572. if changed {
  573. _, err = portal.MainIntent().SetPowerLevels(portal.MXID, levels)
  574. if err != nil {
  575. portal.log.Errorln("Failed to change power levels:", err)
  576. }
  577. }
  578. }
  579. func (portal *Portal) RestrictMessageSending(restrict bool) {
  580. levels, err := portal.MainIntent().PowerLevels(portal.MXID)
  581. if err != nil {
  582. levels = portal.GetBasePowerLevels()
  583. }
  584. newLevel := 0
  585. if restrict {
  586. newLevel = 50
  587. }
  588. if levels.EventsDefault == newLevel {
  589. return
  590. }
  591. levels.EventsDefault = newLevel
  592. _, err = portal.MainIntent().SetPowerLevels(portal.MXID, levels)
  593. if err != nil {
  594. portal.log.Errorln("Failed to change power levels:", err)
  595. }
  596. }
  597. func (portal *Portal) RestrictMetadataChanges(restrict bool) {
  598. levels, err := portal.MainIntent().PowerLevels(portal.MXID)
  599. if err != nil {
  600. levels = portal.GetBasePowerLevels()
  601. }
  602. newLevel := 0
  603. if restrict {
  604. newLevel = 50
  605. }
  606. changed := false
  607. changed = levels.EnsureEventLevel(event.StateRoomName, newLevel) || changed
  608. changed = levels.EnsureEventLevel(event.StateRoomAvatar, newLevel) || changed
  609. changed = levels.EnsureEventLevel(event.StateTopic, newLevel) || changed
  610. if changed {
  611. _, err = portal.MainIntent().SetPowerLevels(portal.MXID, levels)
  612. if err != nil {
  613. portal.log.Errorln("Failed to change power levels:", err)
  614. }
  615. }
  616. }
  617. func (portal *Portal) BackfillHistory(user *User, lastMessageTime uint64) error {
  618. if !portal.bridge.Config.Bridge.RecoverHistory {
  619. return nil
  620. }
  621. endBackfill := portal.beginBackfill()
  622. defer endBackfill()
  623. lastMessage := portal.bridge.DB.Message.GetLastInChat(portal.Key)
  624. if lastMessage == nil {
  625. return nil
  626. }
  627. if lastMessage.Timestamp >= lastMessageTime {
  628. portal.log.Debugln("Not backfilling: no new messages")
  629. return nil
  630. }
  631. lastMessageID := lastMessage.JID
  632. lastMessageFromMe := lastMessage.Sender == user.JID
  633. portal.log.Infoln("Backfilling history since", lastMessageID, "for", user.MXID)
  634. for len(lastMessageID) > 0 {
  635. portal.log.Debugln("Backfilling history: 50 messages after", lastMessageID)
  636. resp, err := user.Conn.LoadMessagesAfter(portal.Key.JID, lastMessageID, lastMessageFromMe, 50)
  637. if err != nil {
  638. return err
  639. }
  640. messages, ok := resp.Content.([]interface{})
  641. if !ok || len(messages) == 0 {
  642. break
  643. }
  644. portal.handleHistory(user, messages)
  645. lastMessageProto, ok := messages[len(messages)-1].(*waProto.WebMessageInfo)
  646. if ok {
  647. lastMessageID = lastMessageProto.GetKey().GetId()
  648. lastMessageFromMe = lastMessageProto.GetKey().GetFromMe()
  649. }
  650. }
  651. portal.log.Infoln("Backfilling finished")
  652. return nil
  653. }
  654. func (portal *Portal) beginBackfill() func() {
  655. portal.backfillLock.Lock()
  656. portal.backfilling = true
  657. var privateChatPuppetInvited bool
  658. var privateChatPuppet *Puppet
  659. if portal.IsPrivateChat() && portal.bridge.Config.Bridge.InviteOwnPuppetForBackfilling && portal.Key.JID != portal.Key.Receiver {
  660. privateChatPuppet = portal.bridge.GetPuppetByJID(portal.Key.Receiver)
  661. portal.privateChatBackfillInvitePuppet = func() {
  662. if privateChatPuppetInvited {
  663. return
  664. }
  665. privateChatPuppetInvited = true
  666. _, _ = portal.MainIntent().InviteUser(portal.MXID, &mautrix.ReqInviteUser{UserID: privateChatPuppet.MXID})
  667. _ = privateChatPuppet.DefaultIntent().EnsureJoined(portal.MXID)
  668. }
  669. }
  670. return func() {
  671. portal.backfilling = false
  672. portal.privateChatBackfillInvitePuppet = nil
  673. portal.backfillLock.Unlock()
  674. if privateChatPuppet != nil && privateChatPuppetInvited {
  675. _, _ = privateChatPuppet.DefaultIntent().LeaveRoom(portal.MXID)
  676. }
  677. }
  678. }
  679. func (portal *Portal) disableNotifications(user *User) {
  680. if !portal.bridge.Config.Bridge.HistoryDisableNotifs {
  681. return
  682. }
  683. puppet := portal.bridge.GetPuppetByCustomMXID(user.MXID)
  684. if puppet == nil || puppet.customIntent == nil {
  685. return
  686. }
  687. portal.log.Debugfln("Disabling notifications for %s for backfilling", user.MXID)
  688. ruleID := fmt.Sprintf("net.maunium.silence_while_backfilling.%s", portal.MXID)
  689. err := puppet.customIntent.PutPushRule("global", pushrules.OverrideRule, ruleID, &mautrix.ReqPutPushRule{
  690. Actions: []pushrules.PushActionType{pushrules.ActionDontNotify},
  691. Conditions: []pushrules.PushCondition{{
  692. Kind: pushrules.KindEventMatch,
  693. Key: "room_id",
  694. Pattern: string(portal.MXID),
  695. }},
  696. })
  697. if err != nil {
  698. portal.log.Warnfln("Failed to disable notifications for %s while backfilling: %v", user.MXID, err)
  699. }
  700. }
  701. func (portal *Portal) enableNotifications(user *User) {
  702. if !portal.bridge.Config.Bridge.HistoryDisableNotifs {
  703. return
  704. }
  705. puppet := portal.bridge.GetPuppetByCustomMXID(user.MXID)
  706. if puppet == nil || puppet.customIntent == nil {
  707. return
  708. }
  709. portal.log.Debugfln("Re-enabling notifications for %s after backfilling", user.MXID)
  710. ruleID := fmt.Sprintf("net.maunium.silence_while_backfilling.%s", portal.MXID)
  711. err := puppet.customIntent.DeletePushRule("global", pushrules.OverrideRule, ruleID)
  712. if err != nil {
  713. portal.log.Warnfln("Failed to re-enable notifications for %s after backfilling: %v", user.MXID, err)
  714. }
  715. }
  716. func (portal *Portal) FillInitialHistory(user *User) error {
  717. if portal.bridge.Config.Bridge.InitialHistoryFill == 0 {
  718. return nil
  719. }
  720. endBackfill := portal.beginBackfill()
  721. defer endBackfill()
  722. if portal.privateChatBackfillInvitePuppet != nil {
  723. portal.privateChatBackfillInvitePuppet()
  724. }
  725. n := portal.bridge.Config.Bridge.InitialHistoryFill
  726. portal.log.Infoln("Filling initial history, maximum", n, "messages")
  727. var messages []interface{}
  728. before := ""
  729. fromMe := true
  730. chunkNum := 1
  731. for n > 0 {
  732. count := 50
  733. if n < count {
  734. count = n
  735. }
  736. portal.log.Debugfln("Fetching chunk %d (%d messages / %d cap) before message %s", chunkNum, count, n, before)
  737. resp, err := user.Conn.LoadMessagesBefore(portal.Key.JID, before, fromMe, count)
  738. if err != nil {
  739. return err
  740. }
  741. chunk, ok := resp.Content.([]interface{})
  742. if !ok || len(chunk) == 0 {
  743. portal.log.Infoln("Chunk empty, starting handling of loaded messages")
  744. break
  745. }
  746. messages = append(chunk, messages...)
  747. portal.log.Debugfln("Fetched chunk and received %d messages", len(chunk))
  748. n -= len(chunk)
  749. key := chunk[0].(*waProto.WebMessageInfo).GetKey()
  750. before = key.GetId()
  751. fromMe = key.GetFromMe()
  752. if len(before) == 0 {
  753. portal.log.Infoln("No message ID for first message, starting handling of loaded messages")
  754. break
  755. }
  756. }
  757. portal.disableNotifications(user)
  758. portal.handleHistory(user, messages)
  759. portal.enableNotifications(user)
  760. portal.log.Infoln("Initial history fill complete")
  761. return nil
  762. }
  763. func (portal *Portal) handleHistory(user *User, messages []interface{}) {
  764. portal.log.Infoln("Handling", len(messages), "messages of history")
  765. for _, rawMessage := range messages {
  766. message, ok := rawMessage.(*waProto.WebMessageInfo)
  767. if !ok {
  768. portal.log.Warnln("Unexpected non-WebMessageInfo item in history response:", rawMessage)
  769. continue
  770. }
  771. data := whatsapp.ParseProtoMessage(message)
  772. if data == nil {
  773. st := message.GetMessageStubType()
  774. // Ignore some types that are known to fail
  775. if st == waProto.WebMessageInfo_CALL_MISSED_VOICE || st == waProto.WebMessageInfo_CALL_MISSED_VIDEO ||
  776. st == waProto.WebMessageInfo_CALL_MISSED_GROUP_VOICE || st == waProto.WebMessageInfo_CALL_MISSED_GROUP_VIDEO {
  777. continue
  778. }
  779. portal.log.Warnln("Message", message.GetKey().GetId(), "failed to parse during backfilling")
  780. continue
  781. }
  782. if portal.privateChatBackfillInvitePuppet != nil && message.GetKey().GetFromMe() && portal.IsPrivateChat() {
  783. portal.privateChatBackfillInvitePuppet()
  784. }
  785. portal.handleMessage(PortalMessage{portal.Key.JID, user, data, message.GetMessageTimestamp()})
  786. }
  787. }
  788. type BridgeInfoSection struct {
  789. ID string `json:"id"`
  790. DisplayName string `json:"displayname,omitempty"`
  791. AvatarURL id.ContentURIString `json:"avatar_url,omitempty"`
  792. ExternalURL string `json:"external_url,omitempty"`
  793. }
  794. type BridgeInfoContent struct {
  795. BridgeBot id.UserID `json:"bridgebot"`
  796. Creator id.UserID `json:"creator,omitempty"`
  797. Protocol BridgeInfoSection `json:"protocol"`
  798. Network *BridgeInfoSection `json:"network,omitempty"`
  799. Channel BridgeInfoSection `json:"channel"`
  800. }
  801. var (
  802. StateBridgeInfo = event.Type{Type: "m.bridge", Class: event.StateEventType}
  803. StateHalfShotBridgeInfo = event.Type{Type: "uk.half-shot.bridge", Class: event.StateEventType}
  804. )
  805. func (portal *Portal) getBridgeInfo() (string, BridgeInfoContent) {
  806. bridgeInfo := BridgeInfoContent{
  807. BridgeBot: portal.bridge.Bot.UserID,
  808. Creator: portal.MainIntent().UserID,
  809. Protocol: BridgeInfoSection{
  810. ID: "whatsapp",
  811. DisplayName: "WhatsApp",
  812. AvatarURL: id.ContentURIString(portal.bridge.Config.AppService.Bot.Avatar),
  813. ExternalURL: "https://www.whatsapp.com/",
  814. },
  815. Channel: BridgeInfoSection{
  816. ID: portal.Key.JID,
  817. DisplayName: portal.Name,
  818. AvatarURL: portal.AvatarURL.CUString(),
  819. },
  820. }
  821. bridgeInfoStateKey := fmt.Sprintf("net.maunium.whatsapp://whatsapp/%s", portal.Key.JID)
  822. return bridgeInfoStateKey, bridgeInfo
  823. }
  824. func (portal *Portal) UpdateBridgeInfo() {
  825. if len(portal.MXID) == 0 {
  826. portal.log.Debugln("Not updating bridge info: no Matrix room created")
  827. return
  828. }
  829. portal.log.Debugln("Updating bridge info...")
  830. stateKey, content := portal.getBridgeInfo()
  831. _, err := portal.MainIntent().SendStateEvent(portal.MXID, StateBridgeInfo, stateKey, content)
  832. if err != nil {
  833. portal.log.Warnln("Failed to update m.bridge:", err)
  834. }
  835. _, err = portal.MainIntent().SendStateEvent(portal.MXID, StateHalfShotBridgeInfo, stateKey, content)
  836. if err != nil {
  837. portal.log.Warnln("Failed to update uk.half-shot.bridge:", err)
  838. }
  839. }
  840. func (portal *Portal) CreateMatrixRoom(user *User) error {
  841. portal.roomCreateLock.Lock()
  842. defer portal.roomCreateLock.Unlock()
  843. if len(portal.MXID) > 0 {
  844. return nil
  845. }
  846. intent := portal.MainIntent()
  847. if err := intent.EnsureRegistered(); err != nil {
  848. return err
  849. }
  850. portal.log.Infoln("Creating Matrix room. Info source:", user.MXID)
  851. var metadata *whatsappExt.GroupInfo
  852. if portal.IsPrivateChat() {
  853. puppet := portal.bridge.GetPuppetByJID(portal.Key.JID)
  854. if portal.bridge.Config.Bridge.PrivateChatPortalMeta {
  855. portal.Name = puppet.Displayname
  856. portal.AvatarURL = puppet.AvatarURL
  857. portal.Avatar = puppet.Avatar
  858. } else {
  859. portal.Name = ""
  860. }
  861. portal.Topic = "WhatsApp private chat"
  862. } else if portal.IsStatusBroadcastRoom() {
  863. portal.Name = "WhatsApp Status Broadcast"
  864. portal.Topic = "WhatsApp status updates from your contacts"
  865. } else {
  866. var err error
  867. metadata, err = user.Conn.GetGroupMetaData(portal.Key.JID)
  868. if err == nil && metadata.Status == 0 {
  869. portal.Name = metadata.Name
  870. portal.Topic = metadata.Topic
  871. }
  872. portal.UpdateAvatar(user, nil, false)
  873. }
  874. bridgeInfoStateKey, bridgeInfo := portal.getBridgeInfo()
  875. initialState := []*event.Event{{
  876. Type: event.StatePowerLevels,
  877. Content: event.Content{
  878. Parsed: portal.GetBasePowerLevels(),
  879. },
  880. }, {
  881. Type: StateBridgeInfo,
  882. Content: event.Content{Parsed: bridgeInfo},
  883. StateKey: &bridgeInfoStateKey,
  884. }, {
  885. // TODO remove this once https://github.com/matrix-org/matrix-doc/pull/2346 is in spec
  886. Type: StateHalfShotBridgeInfo,
  887. Content: event.Content{Parsed: bridgeInfo},
  888. StateKey: &bridgeInfoStateKey,
  889. }}
  890. if !portal.AvatarURL.IsEmpty() {
  891. initialState = append(initialState, &event.Event{
  892. Type: event.StateRoomAvatar,
  893. Content: event.Content{
  894. Parsed: event.RoomAvatarEventContent{URL: portal.AvatarURL},
  895. },
  896. })
  897. }
  898. invite := []id.UserID{user.MXID}
  899. if user.IsRelaybot {
  900. invite = portal.bridge.Config.Bridge.Relaybot.InviteUsers
  901. }
  902. if portal.bridge.Config.Bridge.Encryption.Default {
  903. initialState = append(initialState, &event.Event{
  904. Type: event.StateEncryption,
  905. Content: event.Content{
  906. Parsed: event.EncryptionEventContent{Algorithm: id.AlgorithmMegolmV1},
  907. },
  908. })
  909. portal.Encrypted = true
  910. if portal.IsPrivateChat() {
  911. invite = append(invite, portal.bridge.Bot.UserID)
  912. }
  913. }
  914. resp, err := intent.CreateRoom(&mautrix.ReqCreateRoom{
  915. Visibility: "private",
  916. Name: portal.Name,
  917. Topic: portal.Topic,
  918. Invite: invite,
  919. Preset: "private_chat",
  920. IsDirect: portal.IsPrivateChat(),
  921. InitialState: initialState,
  922. })
  923. if err != nil {
  924. return err
  925. }
  926. portal.MXID = resp.RoomID
  927. portal.Update()
  928. portal.bridge.portalsLock.Lock()
  929. portal.bridge.portalsByMXID[portal.MXID] = portal
  930. portal.bridge.portalsLock.Unlock()
  931. // We set the memberships beforehand to make sure the encryption key exchange in initial backfill knows the users are here.
  932. for _, user := range invite {
  933. portal.bridge.StateStore.SetMembership(portal.MXID, user, event.MembershipInvite)
  934. }
  935. if metadata != nil {
  936. portal.SyncParticipants(metadata)
  937. if metadata.Announce {
  938. portal.RestrictMessageSending(metadata.Announce)
  939. }
  940. } else {
  941. customPuppet := portal.bridge.GetPuppetByCustomMXID(user.MXID)
  942. if customPuppet != nil && customPuppet.CustomIntent() != nil {
  943. _ = customPuppet.CustomIntent().EnsureJoined(portal.MXID)
  944. }
  945. }
  946. user.addPortalToCommunity(portal)
  947. if portal.IsPrivateChat() {
  948. puppet := user.bridge.GetPuppetByJID(portal.Key.JID)
  949. user.addPuppetToCommunity(puppet)
  950. if portal.bridge.Config.Bridge.Encryption.Default {
  951. err = portal.bridge.Bot.EnsureJoined(portal.MXID)
  952. if err != nil {
  953. portal.log.Errorln("Failed to join created portal with bridge bot for e2be:", err)
  954. }
  955. }
  956. user.UpdateDirectChats(map[id.UserID][]id.RoomID{puppet.MXID: {portal.MXID}})
  957. }
  958. err = portal.FillInitialHistory(user)
  959. if err != nil {
  960. portal.log.Errorln("Failed to fill history:", err)
  961. }
  962. return nil
  963. }
  964. func (portal *Portal) IsPrivateChat() bool {
  965. if portal.isPrivate == nil {
  966. val := strings.HasSuffix(portal.Key.JID, whatsappExt.NewUserSuffix)
  967. portal.isPrivate = &val
  968. }
  969. return *portal.isPrivate
  970. }
  971. func (portal *Portal) HasRelaybot() bool {
  972. if portal.bridge.Relaybot == nil {
  973. return false
  974. } else if portal.hasRelaybot == nil {
  975. val := portal.bridge.Relaybot.IsInPortal(portal.Key)
  976. portal.hasRelaybot = &val
  977. }
  978. return *portal.hasRelaybot
  979. }
  980. func (portal *Portal) IsStatusBroadcastRoom() bool {
  981. return portal.Key.JID == "status@broadcast"
  982. }
  983. func (portal *Portal) MainIntent() *appservice.IntentAPI {
  984. if portal.IsPrivateChat() {
  985. return portal.bridge.GetPuppetByJID(portal.Key.JID).DefaultIntent()
  986. }
  987. return portal.bridge.Bot
  988. }
  989. func (portal *Portal) SetReply(content *event.MessageEventContent, info whatsapp.ContextInfo) {
  990. if len(info.QuotedMessageID) == 0 {
  991. return
  992. }
  993. message := portal.bridge.DB.Message.GetByJID(portal.Key, info.QuotedMessageID)
  994. if message != nil {
  995. evt, err := portal.MainIntent().GetEvent(portal.MXID, message.MXID)
  996. if err != nil {
  997. portal.log.Warnln("Failed to get reply target:", err)
  998. return
  999. }
  1000. if evt.Type == event.EventEncrypted {
  1001. _ = evt.Content.ParseRaw(evt.Type)
  1002. decryptedEvt, err := portal.bridge.Crypto.Decrypt(evt)
  1003. if err != nil {
  1004. portal.log.Warnln("Failed to decrypt reply target:", err)
  1005. } else {
  1006. evt = decryptedEvt
  1007. }
  1008. }
  1009. _ = evt.Content.ParseRaw(evt.Type)
  1010. content.SetReply(evt)
  1011. }
  1012. return
  1013. }
  1014. func (portal *Portal) HandleMessageRevoke(user *User, message whatsappExt.MessageRevocation) {
  1015. msg := portal.bridge.DB.Message.GetByJID(portal.Key, message.Id)
  1016. if msg == nil {
  1017. return
  1018. }
  1019. var intent *appservice.IntentAPI
  1020. if message.FromMe {
  1021. if portal.IsPrivateChat() {
  1022. intent = portal.bridge.GetPuppetByJID(user.JID).CustomIntent()
  1023. } else {
  1024. intent = portal.bridge.GetPuppetByJID(user.JID).IntentFor(portal)
  1025. }
  1026. } else if len(message.Participant) > 0 {
  1027. intent = portal.bridge.GetPuppetByJID(message.Participant).IntentFor(portal)
  1028. }
  1029. if intent == nil {
  1030. intent = portal.MainIntent()
  1031. }
  1032. _, err := intent.RedactEvent(portal.MXID, msg.MXID)
  1033. if err != nil {
  1034. portal.log.Errorln("Failed to redact %s: %v", msg.JID, err)
  1035. return
  1036. }
  1037. msg.Delete()
  1038. }
  1039. func (portal *Portal) HandleFakeMessage(_ *User, message FakeMessage) {
  1040. if portal.isRecentlyHandled(message.ID) {
  1041. return
  1042. }
  1043. content := event.MessageEventContent{
  1044. MsgType: event.MsgNotice,
  1045. Body: message.Text,
  1046. }
  1047. if message.Alert {
  1048. content.MsgType = event.MsgText
  1049. }
  1050. _, err := portal.sendMainIntentMessage(content)
  1051. if err != nil {
  1052. portal.log.Errorfln("Failed to handle fake message %s: %v", message.ID, err)
  1053. return
  1054. }
  1055. portal.recentlyHandledLock.Lock()
  1056. index := portal.recentlyHandledIndex
  1057. portal.recentlyHandledIndex = (portal.recentlyHandledIndex + 1) % recentlyHandledLength
  1058. portal.recentlyHandledLock.Unlock()
  1059. portal.recentlyHandled[index] = message.ID
  1060. }
  1061. func (portal *Portal) sendMainIntentMessage(content interface{}) (*mautrix.RespSendEvent, error) {
  1062. return portal.sendMessage(portal.MainIntent(), event.EventMessage, content, 0)
  1063. }
  1064. const MessageSendRetries = 5
  1065. const MediaUploadRetries = 5
  1066. const BadGatewaySleep = 5 * time.Second
  1067. func (portal *Portal) sendMessage(intent *appservice.IntentAPI, eventType event.Type, content interface{}, timestamp int64) (*mautrix.RespSendEvent, error) {
  1068. return portal.sendMessageWithRetry(intent, eventType, content, timestamp, MessageSendRetries)
  1069. }
  1070. func isGatewayError(err error) bool {
  1071. if err == nil {
  1072. return false
  1073. }
  1074. var httpErr mautrix.HTTPError
  1075. return errors.As(err, &httpErr) && (httpErr.IsStatus(http.StatusBadGateway) || httpErr.IsStatus(http.StatusGatewayTimeout))
  1076. }
  1077. func (portal *Portal) sendMessageWithRetry(intent *appservice.IntentAPI, eventType event.Type, content interface{}, timestamp int64, retries int) (*mautrix.RespSendEvent, error) {
  1078. for ;;retries-- {
  1079. resp, err := portal.sendMessageDirect(intent, eventType, content, timestamp)
  1080. if retries > 0 && isGatewayError(err) {
  1081. portal.log.Warnfln("Got gateway error trying to send message, retrying in %d seconds", int(BadGatewaySleep.Seconds()))
  1082. time.Sleep(BadGatewaySleep)
  1083. } else {
  1084. return resp, err
  1085. }
  1086. }
  1087. }
  1088. func (portal *Portal) sendMessageDirect(intent *appservice.IntentAPI, eventType event.Type, content interface{}, timestamp int64) (*mautrix.RespSendEvent, error) {
  1089. wrappedContent := event.Content{Parsed: content}
  1090. if timestamp != 0 && intent.IsCustomPuppet {
  1091. wrappedContent.Raw = map[string]interface{}{
  1092. "net.maunium.whatsapp.puppet": intent.IsCustomPuppet,
  1093. }
  1094. }
  1095. if portal.Encrypted && portal.bridge.Crypto != nil {
  1096. encrypted, err := portal.bridge.Crypto.Encrypt(portal.MXID, eventType, wrappedContent)
  1097. if err != nil {
  1098. return nil, fmt.Errorf("failed to encrypt event: %w", err)
  1099. }
  1100. eventType = event.EventEncrypted
  1101. wrappedContent.Parsed = encrypted
  1102. }
  1103. if timestamp == 0 {
  1104. return intent.SendMessageEvent(portal.MXID, eventType, &wrappedContent)
  1105. } else {
  1106. return intent.SendMassagedMessageEvent(portal.MXID, eventType, &wrappedContent, timestamp)
  1107. }
  1108. }
  1109. func (portal *Portal) HandleTextMessage(source *User, message whatsapp.TextMessage) {
  1110. intent := portal.startHandling(source, message.Info)
  1111. if intent == nil {
  1112. return
  1113. }
  1114. content := &event.MessageEventContent{
  1115. Body: message.Text,
  1116. MsgType: event.MsgText,
  1117. }
  1118. portal.bridge.Formatter.ParseWhatsApp(content, message.ContextInfo.MentionedJID)
  1119. portal.SetReply(content, message.ContextInfo)
  1120. _, _ = intent.UserTyping(portal.MXID, false, 0)
  1121. resp, err := portal.sendMessage(intent, event.EventMessage, content, int64(message.Info.Timestamp*1000))
  1122. if err != nil {
  1123. portal.log.Errorfln("Failed to handle message %s: %v", message.Info.Id, err)
  1124. return
  1125. }
  1126. portal.finishHandling(source, message.Info.Source, resp.EventID)
  1127. }
  1128. func (portal *Portal) HandleLocationMessage(source *User, message whatsapp.LocationMessage) {
  1129. intent := portal.startHandling(source, message.Info)
  1130. if intent == nil {
  1131. return
  1132. }
  1133. url := message.Url
  1134. if len(url) == 0 {
  1135. url = fmt.Sprintf("https://maps.google.com/?q=%.5f,%.5f", message.DegreesLatitude, message.DegreesLongitude)
  1136. }
  1137. name := message.Name
  1138. if len(name) == 0 {
  1139. latChar := 'N'
  1140. if message.DegreesLatitude < 0 {
  1141. latChar = 'S'
  1142. }
  1143. longChar := 'E'
  1144. if message.DegreesLongitude < 0 {
  1145. longChar = 'W'
  1146. }
  1147. name = fmt.Sprintf("%.4f° %c %.4f° %c", math.Abs(message.DegreesLatitude), latChar, math.Abs(message.DegreesLongitude), longChar)
  1148. }
  1149. content := &event.MessageEventContent{
  1150. MsgType: event.MsgLocation,
  1151. Body: fmt.Sprintf("Location: %s\n%s\n%s", name, message.Address, url),
  1152. Format: event.FormatHTML,
  1153. FormattedBody: fmt.Sprintf("Location: <a href='%s'>%s</a><br>%s", url, name, message.Address),
  1154. GeoURI: fmt.Sprintf("geo:%.5f,%.5f", message.DegreesLatitude, message.DegreesLongitude),
  1155. }
  1156. if len(message.JpegThumbnail) > 0 {
  1157. thumbnailMime := http.DetectContentType(message.JpegThumbnail)
  1158. uploadedThumbnail, _ := intent.UploadBytes(message.JpegThumbnail, thumbnailMime)
  1159. if uploadedThumbnail != nil {
  1160. cfg, _, _ := image.DecodeConfig(bytes.NewReader(message.JpegThumbnail))
  1161. content.Info = &event.FileInfo{
  1162. ThumbnailInfo: &event.FileInfo{
  1163. Size: len(message.JpegThumbnail),
  1164. Width: cfg.Width,
  1165. Height: cfg.Height,
  1166. MimeType: thumbnailMime,
  1167. },
  1168. ThumbnailURL: uploadedThumbnail.ContentURI.CUString(),
  1169. }
  1170. }
  1171. }
  1172. portal.SetReply(content, message.ContextInfo)
  1173. _, _ = intent.UserTyping(portal.MXID, false, 0)
  1174. resp, err := portal.sendMessage(intent, event.EventMessage, content, int64(message.Info.Timestamp*1000))
  1175. if err != nil {
  1176. portal.log.Errorfln("Failed to handle message %s: %v", message.Info.Id, err)
  1177. return
  1178. }
  1179. portal.finishHandling(source, message.Info.Source, resp.EventID)
  1180. }
  1181. func (portal *Portal) HandleContactMessage(source *User, message whatsapp.ContactMessage) {
  1182. intent := portal.startHandling(source, message.Info)
  1183. if intent == nil {
  1184. return
  1185. }
  1186. fileName := fmt.Sprintf("%s.vcf", message.DisplayName)
  1187. data := []byte(message.Vcard)
  1188. mimeType := "text/vcard"
  1189. data, uploadMimeType, file := portal.encryptFile(data, mimeType)
  1190. uploadResp, err := intent.UploadBytesWithName(data, uploadMimeType, fileName)
  1191. if err != nil {
  1192. portal.log.Errorfln("Failed to upload vcard of %s: %v", message.DisplayName, err)
  1193. return
  1194. }
  1195. content := &event.MessageEventContent{
  1196. Body: fileName,
  1197. MsgType: event.MsgFile,
  1198. File: file,
  1199. Info: &event.FileInfo{
  1200. MimeType: mimeType,
  1201. Size: len(message.Vcard),
  1202. },
  1203. }
  1204. if content.File != nil {
  1205. content.File.URL = uploadResp.ContentURI.CUString()
  1206. } else {
  1207. content.URL = uploadResp.ContentURI.CUString()
  1208. }
  1209. portal.SetReply(content, message.ContextInfo)
  1210. _, _ = intent.UserTyping(portal.MXID, false, 0)
  1211. resp, err := portal.sendMessage(intent, event.EventMessage, content, int64(message.Info.Timestamp*1000))
  1212. if err != nil {
  1213. portal.log.Errorfln("Failed to handle message %s: %v", message.Info.Id, err)
  1214. return
  1215. }
  1216. portal.finishHandling(source, message.Info.Source, resp.EventID)
  1217. }
  1218. func (portal *Portal) sendMediaBridgeFailure(source *User, intent *appservice.IntentAPI, info whatsapp.MessageInfo, bridgeErr error) {
  1219. portal.log.Errorfln("Failed to bridge media for %s: %v", info.Id, bridgeErr)
  1220. resp, err := portal.sendMessage(intent, event.EventMessage, &event.MessageEventContent{
  1221. MsgType: event.MsgNotice,
  1222. Body: "Failed to bridge media",
  1223. }, int64(info.Timestamp*1000))
  1224. if err != nil {
  1225. portal.log.Errorfln("Failed to send media download error message for %s: %v", info.Id, err)
  1226. } else {
  1227. portal.finishHandling(source, info.Source, resp.EventID)
  1228. }
  1229. }
  1230. func (portal *Portal) encryptFile(data []byte, mimeType string) ([]byte, string, *event.EncryptedFileInfo) {
  1231. if !portal.Encrypted {
  1232. return data, mimeType, nil
  1233. }
  1234. file := &event.EncryptedFileInfo{
  1235. EncryptedFile: *attachment.NewEncryptedFile(),
  1236. URL: "",
  1237. }
  1238. return file.Encrypt(data), "application/octet-stream", file
  1239. }
  1240. func (portal *Portal) tryKickUser(userID id.UserID, intent *appservice.IntentAPI) error {
  1241. _, err := intent.KickUser(portal.MXID, &mautrix.ReqKickUser{UserID: userID})
  1242. if err != nil {
  1243. httpErr, ok := err.(mautrix.HTTPError)
  1244. if ok && httpErr.RespError != nil && httpErr.RespError.ErrCode == "M_FORBIDDEN" {
  1245. _, err = portal.MainIntent().KickUser(portal.MXID, &mautrix.ReqKickUser{UserID: userID})
  1246. }
  1247. }
  1248. return err
  1249. }
  1250. func (portal *Portal) removeUser(isSameUser bool, kicker *appservice.IntentAPI, target id.UserID, targetIntent *appservice.IntentAPI) {
  1251. if !isSameUser || targetIntent == nil {
  1252. err := portal.tryKickUser(target, kicker)
  1253. if err != nil {
  1254. portal.log.Warnfln("Failed to kick %s from %s: %v", target, portal.MXID, err)
  1255. if targetIntent != nil {
  1256. _, _ = targetIntent.LeaveRoom(portal.MXID)
  1257. }
  1258. }
  1259. } else {
  1260. _, err := targetIntent.LeaveRoom(portal.MXID)
  1261. if err != nil {
  1262. portal.log.Warnfln("Failed to leave portal as %s: %v", target, err)
  1263. _, _ = portal.MainIntent().KickUser(portal.MXID, &mautrix.ReqKickUser{UserID: target})
  1264. }
  1265. }
  1266. }
  1267. func (portal *Portal) HandleWhatsAppKick(senderJID string, jids []string) {
  1268. sender := portal.bridge.GetPuppetByJID(senderJID)
  1269. senderIntent := sender.IntentFor(portal)
  1270. for _, jid := range jids {
  1271. puppet := portal.bridge.GetPuppetByJID(jid)
  1272. portal.removeUser(puppet.JID == sender.JID, senderIntent, puppet.MXID, puppet.DefaultIntent())
  1273. user := portal.bridge.GetUserByJID(jid)
  1274. if user != nil {
  1275. var customIntent *appservice.IntentAPI
  1276. if puppet.CustomMXID == user.MXID {
  1277. customIntent = puppet.CustomIntent()
  1278. }
  1279. portal.removeUser(puppet.JID == sender.JID, senderIntent, user.MXID, customIntent)
  1280. }
  1281. }
  1282. }
  1283. func (portal *Portal) HandleWhatsAppInvite(senderJID string, jids []string) {
  1284. senderIntent := portal.MainIntent()
  1285. if senderJID != "unknown" {
  1286. sender := portal.bridge.GetPuppetByJID(senderJID)
  1287. senderIntent = sender.IntentFor(portal)
  1288. }
  1289. for _, jid := range jids {
  1290. puppet := portal.bridge.GetPuppetByJID(jid)
  1291. _, err := senderIntent.InviteUser(portal.MXID, &mautrix.ReqInviteUser{UserID: puppet.MXID})
  1292. if err != nil {
  1293. portal.log.Warnfln("Failed to invite %s as %s: %v", puppet.MXID, senderIntent.UserID, err)
  1294. }
  1295. err = puppet.DefaultIntent().EnsureJoined(portal.MXID)
  1296. if err != nil {
  1297. portal.log.Errorfln("Failed to ensure %s is joined: %v", puppet.MXID, err)
  1298. }
  1299. }
  1300. }
  1301. type base struct {
  1302. download func() ([]byte, error)
  1303. info whatsapp.MessageInfo
  1304. context whatsapp.ContextInfo
  1305. mimeType string
  1306. }
  1307. type mediaMessage struct {
  1308. base
  1309. thumbnail []byte
  1310. caption string
  1311. fileName string
  1312. length uint32
  1313. sendAsSticker bool
  1314. }
  1315. func (portal *Portal) uploadWithRetry(intent *appservice.IntentAPI, data []byte, mimeType string, retries int) (*mautrix.RespMediaUpload, error) {
  1316. for ;;retries-- {
  1317. uploaded, err := intent.UploadBytes(data, mimeType)
  1318. if isGatewayError(err) {
  1319. portal.log.Warnfln("Got gateway error trying to upload media, retrying in %d seconds", int(BadGatewaySleep.Seconds()))
  1320. time.Sleep(BadGatewaySleep)
  1321. } else {
  1322. return uploaded, err
  1323. }
  1324. }
  1325. }
  1326. func (portal *Portal) HandleMediaMessage(source *User, msg mediaMessage) {
  1327. intent := portal.startHandling(source, msg.info)
  1328. if intent == nil {
  1329. return
  1330. }
  1331. data, err := msg.download()
  1332. if err == whatsapp.ErrMediaDownloadFailedWith404 || err == whatsapp.ErrMediaDownloadFailedWith410 {
  1333. portal.log.Warnfln("Failed to download media for %s: %v. Calling LoadMediaInfo and retrying download...", msg.info.Id, err)
  1334. _, err = source.Conn.LoadMediaInfo(msg.info.RemoteJid, msg.info.Id, msg.info.FromMe)
  1335. if err != nil {
  1336. portal.sendMediaBridgeFailure(source, intent, msg.info, fmt.Errorf("failed to load media info: %w", err))
  1337. return
  1338. }
  1339. data, err = msg.download()
  1340. }
  1341. if err == whatsapp.ErrNoURLPresent {
  1342. portal.log.Debugfln("No URL present error for media message %s, ignoring...", msg.info.Id)
  1343. return
  1344. } else if err != nil {
  1345. portal.sendMediaBridgeFailure(source, intent, msg.info, err)
  1346. return
  1347. }
  1348. var width, height int
  1349. if strings.HasPrefix(msg.mimeType, "image/") {
  1350. cfg, _, _ := image.DecodeConfig(bytes.NewReader(data))
  1351. width, height = cfg.Width, cfg.Height
  1352. }
  1353. data, uploadMimeType, file := portal.encryptFile(data, msg.mimeType)
  1354. uploaded, err := portal.uploadWithRetry(intent, data, uploadMimeType, MediaUploadRetries)
  1355. if err != nil {
  1356. if errors.Is(err, mautrix.MTooLarge) {
  1357. portal.sendMediaBridgeFailure(source, intent, msg.info, errors.New("homeserver rejected too large file"))
  1358. } else if httpErr := err.(mautrix.HTTPError); httpErr.IsStatus(413) {
  1359. portal.sendMediaBridgeFailure(source, intent, msg.info, errors.New("proxy rejected too large file"))
  1360. } else {
  1361. portal.sendMediaBridgeFailure(source, intent, msg.info, fmt.Errorf("failed to upload media: %w", err))
  1362. }
  1363. return
  1364. }
  1365. if msg.fileName == "" {
  1366. mimeClass := strings.Split(msg.mimeType, "/")[0]
  1367. switch mimeClass {
  1368. case "application":
  1369. msg.fileName = "file"
  1370. default:
  1371. msg.fileName = mimeClass
  1372. }
  1373. exts, _ := mime.ExtensionsByType(msg.mimeType)
  1374. if exts != nil && len(exts) > 0 {
  1375. msg.fileName += exts[0]
  1376. }
  1377. }
  1378. content := &event.MessageEventContent{
  1379. Body: msg.fileName,
  1380. File: file,
  1381. Info: &event.FileInfo{
  1382. Size: len(data),
  1383. MimeType: msg.mimeType,
  1384. Width: width,
  1385. Height: height,
  1386. Duration: int(msg.length),
  1387. },
  1388. }
  1389. if content.File != nil {
  1390. content.File.URL = uploaded.ContentURI.CUString()
  1391. } else {
  1392. content.URL = uploaded.ContentURI.CUString()
  1393. }
  1394. portal.SetReply(content, msg.context)
  1395. if msg.thumbnail != nil && portal.bridge.Config.Bridge.WhatsappThumbnail {
  1396. thumbnailMime := http.DetectContentType(msg.thumbnail)
  1397. thumbnailCfg, _, _ := image.DecodeConfig(bytes.NewReader(msg.thumbnail))
  1398. thumbnailSize := len(msg.thumbnail)
  1399. thumbnail, thumbnailUploadMime, thumbnailFile := portal.encryptFile(msg.thumbnail, thumbnailMime)
  1400. uploadedThumbnail, err := intent.UploadBytes(thumbnail, thumbnailUploadMime)
  1401. if err != nil {
  1402. portal.log.Warnfln("Failed to upload thumbnail for %s: %v", msg.info.Id, err)
  1403. } else if uploadedThumbnail != nil {
  1404. if thumbnailFile != nil {
  1405. thumbnailFile.URL = uploadedThumbnail.ContentURI.CUString()
  1406. content.Info.ThumbnailFile = thumbnailFile
  1407. } else {
  1408. content.Info.ThumbnailURL = uploadedThumbnail.ContentURI.CUString()
  1409. }
  1410. content.Info.ThumbnailInfo = &event.FileInfo{
  1411. Size: thumbnailSize,
  1412. Width: thumbnailCfg.Width,
  1413. Height: thumbnailCfg.Height,
  1414. MimeType: thumbnailMime,
  1415. }
  1416. }
  1417. }
  1418. switch strings.ToLower(strings.Split(msg.mimeType, "/")[0]) {
  1419. case "image":
  1420. if !msg.sendAsSticker {
  1421. content.MsgType = event.MsgImage
  1422. }
  1423. case "video":
  1424. content.MsgType = event.MsgVideo
  1425. case "audio":
  1426. content.MsgType = event.MsgAudio
  1427. default:
  1428. content.MsgType = event.MsgFile
  1429. }
  1430. _, _ = intent.UserTyping(portal.MXID, false, 0)
  1431. ts := int64(msg.info.Timestamp * 1000)
  1432. eventType := event.EventMessage
  1433. if msg.sendAsSticker {
  1434. eventType = event.EventSticker
  1435. }
  1436. resp, err := portal.sendMessage(intent, eventType, content, ts)
  1437. if err != nil {
  1438. portal.log.Errorfln("Failed to handle message %s: %v", msg.info.Id, err)
  1439. return
  1440. }
  1441. if len(msg.caption) > 0 {
  1442. captionContent := &event.MessageEventContent{
  1443. Body: msg.caption,
  1444. MsgType: event.MsgNotice,
  1445. }
  1446. portal.bridge.Formatter.ParseWhatsApp(captionContent, msg.context.MentionedJID)
  1447. _, err := portal.sendMessage(intent, event.EventMessage, captionContent, ts)
  1448. if err != nil {
  1449. portal.log.Warnfln("Failed to handle caption of message %s: %v", msg.info.Id, err)
  1450. }
  1451. // TODO store caption mxid?
  1452. }
  1453. portal.finishHandling(source, msg.info.Source, resp.EventID)
  1454. }
  1455. func makeMessageID() *string {
  1456. b := make([]byte, 10)
  1457. rand.Read(b)
  1458. str := strings.ToUpper(hex.EncodeToString(b))
  1459. return &str
  1460. }
  1461. func (portal *Portal) downloadThumbnail(content *event.MessageEventContent, id id.EventID) []byte {
  1462. if len(content.GetInfo().ThumbnailURL) == 0 {
  1463. return nil
  1464. }
  1465. mxc, err := content.GetInfo().ThumbnailURL.Parse()
  1466. if err != nil {
  1467. portal.log.Errorln("Malformed thumbnail URL in %s: %v", id, err)
  1468. }
  1469. thumbnail, err := portal.MainIntent().DownloadBytes(mxc)
  1470. if err != nil {
  1471. portal.log.Errorln("Failed to download thumbnail in %s: %v", id, err)
  1472. return nil
  1473. }
  1474. thumbnailType := http.DetectContentType(thumbnail)
  1475. var img image.Image
  1476. switch thumbnailType {
  1477. case "image/png":
  1478. img, err = png.Decode(bytes.NewReader(thumbnail))
  1479. case "image/gif":
  1480. img, err = gif.Decode(bytes.NewReader(thumbnail))
  1481. case "image/jpeg":
  1482. return thumbnail
  1483. default:
  1484. return nil
  1485. }
  1486. var buf bytes.Buffer
  1487. err = jpeg.Encode(&buf, img, &jpeg.Options{
  1488. Quality: jpeg.DefaultQuality,
  1489. })
  1490. if err != nil {
  1491. portal.log.Errorln("Failed to re-encode thumbnail in %s: %v", id, err)
  1492. return nil
  1493. }
  1494. return buf.Bytes()
  1495. }
  1496. func (portal *Portal) convertGifToVideo(gif []byte) ([]byte, error) {
  1497. dir, err := ioutil.TempDir("", "gif-convert-*")
  1498. if err != nil {
  1499. return nil, fmt.Errorf("failed to make temp dir: %w", err)
  1500. }
  1501. defer os.RemoveAll(dir)
  1502. inputFile, err := os.OpenFile(filepath.Join(dir, "input.gif"), os.O_CREATE|os.O_EXCL|os.O_WRONLY, 0600)
  1503. if err != nil {
  1504. return nil, fmt.Errorf("failed open input file: %w", err)
  1505. }
  1506. _, err = inputFile.Write(gif)
  1507. if err != nil {
  1508. _ = inputFile.Close()
  1509. return nil, fmt.Errorf("failed to write gif to input file: %w", err)
  1510. }
  1511. _ = inputFile.Close()
  1512. outputFileName := filepath.Join(dir, "output.mp4")
  1513. cmd := exec.Command("ffmpeg", "-hide_banner", "-loglevel", "warning",
  1514. "-f", "gif", "-i", inputFile.Name(),
  1515. "-pix_fmt", "yuv420p", "-c:v", "libx264", "-movflags", "+faststart",
  1516. "-filter:v", "crop='floor(in_w/2)*2:floor(in_h/2)*2'",
  1517. outputFileName)
  1518. vcLog := portal.log.Sub("VideoConverter").WithDefaultLevel(log.LevelWarn)
  1519. cmd.Stdout = vcLog
  1520. cmd.Stderr = vcLog
  1521. err = cmd.Run()
  1522. if err != nil {
  1523. return nil, fmt.Errorf("failed to run ffmpeg: %w", err)
  1524. }
  1525. outputFile, err := os.OpenFile(filepath.Join(dir, "output.mp4"), os.O_RDONLY, 0)
  1526. if err != nil {
  1527. return nil, fmt.Errorf("failed to open output file: %w", err)
  1528. }
  1529. defer func() {
  1530. _ = outputFile.Close()
  1531. _ = os.Remove(outputFile.Name())
  1532. }()
  1533. mp4, err := ioutil.ReadAll(outputFile)
  1534. if err != nil {
  1535. return nil, fmt.Errorf("failed to read mp4 from output file: %w", err)
  1536. }
  1537. return mp4, nil
  1538. }
  1539. func (portal *Portal) preprocessMatrixMedia(sender *User, relaybotFormatted bool, content *event.MessageEventContent, eventID id.EventID, mediaType whatsapp.MediaType) *MediaUpload {
  1540. var caption string
  1541. var mentionedJIDs []types.WhatsAppID
  1542. if relaybotFormatted {
  1543. caption, mentionedJIDs = portal.bridge.Formatter.ParseMatrix(content.FormattedBody)
  1544. }
  1545. var file *event.EncryptedFileInfo
  1546. rawMXC := content.URL
  1547. if content.File != nil {
  1548. file = content.File
  1549. rawMXC = file.URL
  1550. }
  1551. mxc, err := rawMXC.Parse()
  1552. if err != nil {
  1553. portal.log.Errorln("Malformed content URL in %s: %v", eventID, err)
  1554. return nil
  1555. }
  1556. data, err := portal.MainIntent().DownloadBytes(mxc)
  1557. if err != nil {
  1558. portal.log.Errorfln("Failed to download media in %s: %v", eventID, err)
  1559. return nil
  1560. }
  1561. if file != nil {
  1562. data, err = file.Decrypt(data)
  1563. if err != nil {
  1564. portal.log.Errorfln("Failed to decrypt media in %s: %v", eventID, err)
  1565. return nil
  1566. }
  1567. }
  1568. if mediaType == whatsapp.MediaVideo && content.GetInfo().MimeType == "image/gif" {
  1569. data, err = portal.convertGifToVideo(data)
  1570. if err != nil {
  1571. portal.log.Errorfln("Failed to convert gif to mp4 in %s: %v", eventID, err)
  1572. return nil
  1573. }
  1574. content.Info.MimeType = "video/mp4"
  1575. }
  1576. url, mediaKey, fileEncSHA256, fileSHA256, fileLength, err := sender.Conn.Upload(bytes.NewReader(data), mediaType)
  1577. if err != nil {
  1578. portal.log.Errorfln("Failed to upload media in %s: %v", eventID, err)
  1579. return nil
  1580. }
  1581. return &MediaUpload{
  1582. Caption: caption,
  1583. MentionedJIDs: mentionedJIDs,
  1584. URL: url,
  1585. MediaKey: mediaKey,
  1586. FileEncSHA256: fileEncSHA256,
  1587. FileSHA256: fileSHA256,
  1588. FileLength: fileLength,
  1589. Thumbnail: portal.downloadThumbnail(content, eventID),
  1590. }
  1591. }
  1592. type MediaUpload struct {
  1593. Caption string
  1594. MentionedJIDs []types.WhatsAppID
  1595. URL string
  1596. MediaKey []byte
  1597. FileEncSHA256 []byte
  1598. FileSHA256 []byte
  1599. FileLength uint64
  1600. Thumbnail []byte
  1601. }
  1602. func (portal *Portal) sendMatrixConnectionError(sender *User, eventID id.EventID) bool {
  1603. if !sender.HasSession() {
  1604. portal.log.Debugln("Ignoring event", eventID, "from", sender.MXID, "as user has no session")
  1605. return true
  1606. } else if !sender.IsConnected() {
  1607. portal.log.Debugln("Ignoring event", eventID, "from", sender.MXID, "as user is not connected")
  1608. inRoom := ""
  1609. if portal.IsPrivateChat() {
  1610. inRoom = " in your management room"
  1611. }
  1612. reconnect := fmt.Sprintf("Use `%s reconnect`%s to reconnect.", portal.bridge.Config.Bridge.CommandPrefix, inRoom)
  1613. if sender.IsLoginInProgress() {
  1614. reconnect = "You have a login attempt in progress, please wait."
  1615. }
  1616. msg := format.RenderMarkdown("\u26a0 You are not connected to WhatsApp, so your message was not bridged. "+reconnect, true, false)
  1617. msg.MsgType = event.MsgNotice
  1618. _, err := portal.sendMainIntentMessage(msg)
  1619. if err != nil {
  1620. portal.log.Errorln("Failed to send bridging failure message:", err)
  1621. }
  1622. return true
  1623. }
  1624. return false
  1625. }
  1626. func (portal *Portal) addRelaybotFormat(sender *User, content *event.MessageEventContent) bool {
  1627. member := portal.MainIntent().Member(portal.MXID, sender.MXID)
  1628. if len(member.Displayname) == 0 {
  1629. member.Displayname = string(sender.MXID)
  1630. }
  1631. if content.Format != event.FormatHTML {
  1632. content.FormattedBody = strings.Replace(html.EscapeString(content.Body), "\n", "<br/>", -1)
  1633. content.Format = event.FormatHTML
  1634. }
  1635. data, err := portal.bridge.Config.Bridge.Relaybot.FormatMessage(content, sender.MXID, member)
  1636. if err != nil {
  1637. portal.log.Errorln("Failed to apply relaybot format:", err)
  1638. }
  1639. content.FormattedBody = data
  1640. return true
  1641. }
  1642. func (portal *Portal) convertMatrixMessage(sender *User, evt *event.Event) (*waProto.WebMessageInfo, *User) {
  1643. content, ok := evt.Content.Parsed.(*event.MessageEventContent)
  1644. if !ok {
  1645. portal.log.Debugfln("Failed to handle event %s: unexpected parsed content type %T", evt.ID, evt.Content.Parsed)
  1646. return nil, sender
  1647. }
  1648. ts := uint64(evt.Timestamp / 1000)
  1649. status := waProto.WebMessageInfo_ERROR
  1650. fromMe := true
  1651. info := &waProto.WebMessageInfo{
  1652. Key: &waProto.MessageKey{
  1653. FromMe: &fromMe,
  1654. Id: makeMessageID(),
  1655. RemoteJid: &portal.Key.JID,
  1656. },
  1657. MessageTimestamp: &ts,
  1658. Message: &waProto.Message{},
  1659. Status: &status,
  1660. }
  1661. ctxInfo := &waProto.ContextInfo{}
  1662. replyToID := content.GetReplyTo()
  1663. if len(replyToID) > 0 {
  1664. content.RemoveReplyFallback()
  1665. msg := portal.bridge.DB.Message.GetByMXID(replyToID)
  1666. if msg != nil && msg.Content != nil {
  1667. ctxInfo.StanzaId = &msg.JID
  1668. ctxInfo.Participant = &msg.Sender
  1669. ctxInfo.QuotedMessage = msg.Content
  1670. }
  1671. }
  1672. relaybotFormatted := false
  1673. if sender.NeedsRelaybot(portal) {
  1674. if !portal.HasRelaybot() {
  1675. if sender.HasSession() {
  1676. portal.log.Debugln("Database says", sender.MXID, "not in chat and no relaybot, but trying to send anyway")
  1677. } else {
  1678. portal.log.Debugln("Ignoring message from", sender.MXID, "in chat with no relaybot")
  1679. return nil, sender
  1680. }
  1681. } else {
  1682. relaybotFormatted = portal.addRelaybotFormat(sender, content)
  1683. sender = portal.bridge.Relaybot
  1684. }
  1685. }
  1686. if evt.Type == event.EventSticker {
  1687. content.MsgType = event.MsgImage
  1688. } else if content.MsgType == event.MsgImage && content.GetInfo().MimeType == "image/gif" {
  1689. content.MsgType = event.MsgVideo
  1690. }
  1691. switch content.MsgType {
  1692. case event.MsgText, event.MsgEmote, event.MsgNotice:
  1693. text := content.Body
  1694. if content.Format == event.FormatHTML {
  1695. text, ctxInfo.MentionedJid = portal.bridge.Formatter.ParseMatrix(content.FormattedBody)
  1696. }
  1697. if content.MsgType == event.MsgEmote && !relaybotFormatted {
  1698. text = "/me " + text
  1699. }
  1700. if ctxInfo.StanzaId != nil || ctxInfo.MentionedJid != nil {
  1701. info.Message.ExtendedTextMessage = &waProto.ExtendedTextMessage{
  1702. Text: &text,
  1703. ContextInfo: ctxInfo,
  1704. }
  1705. } else {
  1706. info.Message.Conversation = &text
  1707. }
  1708. case event.MsgImage:
  1709. media := portal.preprocessMatrixMedia(sender, relaybotFormatted, content, evt.ID, whatsapp.MediaImage)
  1710. if media == nil {
  1711. return nil, sender
  1712. }
  1713. ctxInfo.MentionedJid = media.MentionedJIDs
  1714. info.Message.ImageMessage = &waProto.ImageMessage{
  1715. ContextInfo: ctxInfo,
  1716. Caption: &media.Caption,
  1717. JpegThumbnail: media.Thumbnail,
  1718. Url: &media.URL,
  1719. MediaKey: media.MediaKey,
  1720. Mimetype: &content.GetInfo().MimeType,
  1721. FileEncSha256: media.FileEncSHA256,
  1722. FileSha256: media.FileSHA256,
  1723. FileLength: &media.FileLength,
  1724. }
  1725. case event.MsgVideo:
  1726. gifPlayback := content.GetInfo().MimeType == "image/gif"
  1727. media := portal.preprocessMatrixMedia(sender, relaybotFormatted, content, evt.ID, whatsapp.MediaVideo)
  1728. if media == nil {
  1729. return nil, sender
  1730. }
  1731. duration := uint32(content.GetInfo().Duration)
  1732. ctxInfo.MentionedJid = media.MentionedJIDs
  1733. info.Message.VideoMessage = &waProto.VideoMessage{
  1734. ContextInfo: ctxInfo,
  1735. Caption: &media.Caption,
  1736. JpegThumbnail: media.Thumbnail,
  1737. Url: &media.URL,
  1738. MediaKey: media.MediaKey,
  1739. Mimetype: &content.GetInfo().MimeType,
  1740. GifPlayback: &gifPlayback,
  1741. Seconds: &duration,
  1742. FileEncSha256: media.FileEncSHA256,
  1743. FileSha256: media.FileSHA256,
  1744. FileLength: &media.FileLength,
  1745. }
  1746. case event.MsgAudio:
  1747. media := portal.preprocessMatrixMedia(sender, relaybotFormatted, content, evt.ID, whatsapp.MediaAudio)
  1748. if media == nil {
  1749. return nil, sender
  1750. }
  1751. duration := uint32(content.GetInfo().Duration)
  1752. info.Message.AudioMessage = &waProto.AudioMessage{
  1753. ContextInfo: ctxInfo,
  1754. Url: &media.URL,
  1755. MediaKey: media.MediaKey,
  1756. Mimetype: &content.GetInfo().MimeType,
  1757. Seconds: &duration,
  1758. FileEncSha256: media.FileEncSHA256,
  1759. FileSha256: media.FileSHA256,
  1760. FileLength: &media.FileLength,
  1761. }
  1762. case event.MsgFile:
  1763. media := portal.preprocessMatrixMedia(sender, relaybotFormatted, content, evt.ID, whatsapp.MediaDocument)
  1764. if media == nil {
  1765. return nil, sender
  1766. }
  1767. info.Message.DocumentMessage = &waProto.DocumentMessage{
  1768. ContextInfo: ctxInfo,
  1769. Url: &media.URL,
  1770. Title: &content.Body,
  1771. FileName: &content.Body,
  1772. MediaKey: media.MediaKey,
  1773. Mimetype: &content.GetInfo().MimeType,
  1774. FileEncSha256: media.FileEncSHA256,
  1775. FileSha256: media.FileSHA256,
  1776. FileLength: &media.FileLength,
  1777. }
  1778. default:
  1779. portal.log.Debugln("Unhandled Matrix event %s: unknown msgtype %s", evt.ID, content.MsgType)
  1780. return nil, sender
  1781. }
  1782. return info, sender
  1783. }
  1784. func (portal *Portal) wasMessageSent(sender *User, id string) bool {
  1785. _, err := sender.Conn.LoadMessagesAfter(portal.Key.JID, id, true, 0)
  1786. if err != nil {
  1787. if err != whatsapp.ErrServerRespondedWith404 {
  1788. portal.log.Warnfln("Failed to check if message was bridged without response: %v", err)
  1789. }
  1790. return false
  1791. }
  1792. return true
  1793. }
  1794. func (portal *Portal) sendErrorMessage(message string) id.EventID {
  1795. resp, err := portal.sendMainIntentMessage(event.MessageEventContent{
  1796. MsgType: event.MsgNotice,
  1797. Body: fmt.Sprintf("\u26a0 Your message may not have been bridged: %v", message),
  1798. })
  1799. if err != nil {
  1800. portal.log.Warnfln("Failed to send bridging error message:", err)
  1801. return ""
  1802. }
  1803. return resp.EventID
  1804. }
  1805. func (portal *Portal) sendDeliveryReceipt(eventID id.EventID) {
  1806. if portal.bridge.Config.Bridge.DeliveryReceipts {
  1807. err := portal.bridge.Bot.MarkRead(portal.MXID, eventID)
  1808. if err != nil {
  1809. portal.log.Debugfln("Failed to send delivery receipt for %s: %v", eventID, err)
  1810. }
  1811. }
  1812. }
  1813. var timeout = errors.New("message sending timed out")
  1814. func (portal *Portal) HandleMatrixMessage(sender *User, evt *event.Event) {
  1815. if !portal.HasRelaybot() && (
  1816. (portal.IsPrivateChat() && sender.JID != portal.Key.Receiver) ||
  1817. portal.sendMatrixConnectionError(sender, evt.ID)) {
  1818. return
  1819. }
  1820. portal.log.Debugfln("Received event %s", evt.ID)
  1821. info, sender := portal.convertMatrixMessage(sender, evt)
  1822. if info == nil {
  1823. return
  1824. }
  1825. portal.markHandled(sender, info, evt.ID)
  1826. portal.log.Debugln("Sending event", evt.ID, "to WhatsApp", info.Key.GetId())
  1827. portal.sendRaw(sender, evt, info, false)
  1828. }
  1829. func (portal *Portal) sendRaw(sender *User, evt *event.Event, info *waProto.WebMessageInfo, isRetry bool) {
  1830. errChan := make(chan error, 1)
  1831. go sender.Conn.SendRaw(info, errChan)
  1832. var err error
  1833. var errorEventID id.EventID
  1834. select {
  1835. case err = <-errChan:
  1836. var statusResp whatsapp.StatusResponse
  1837. if !isRetry && errors.As(err, &statusResp) && statusResp.Status == 599 {
  1838. portal.log.Debugfln("599 status response sending %s to WhatsApp (%+v), retrying...", evt.ID, statusResp)
  1839. errorEventID = portal.sendErrorMessage(fmt.Sprintf("%v. The bridge will retry in 5 seconds.", err))
  1840. time.Sleep(5 * time.Second)
  1841. portal.sendRaw(sender, evt, info, true)
  1842. }
  1843. case <-time.After(time.Duration(portal.bridge.Config.Bridge.ConnectionTimeout) * time.Second):
  1844. if portal.bridge.Config.Bridge.FetchMessageOnTimeout && portal.wasMessageSent(sender, info.Key.GetId()) {
  1845. portal.log.Debugln("Matrix event %s was bridged, but response didn't arrive within timeout")
  1846. portal.sendDeliveryReceipt(evt.ID)
  1847. } else {
  1848. portal.log.Warnfln("Response when bridging Matrix event %s is taking long to arrive", evt.ID)
  1849. errorEventID = portal.sendErrorMessage(timeout.Error())
  1850. }
  1851. err = <-errChan
  1852. }
  1853. if err != nil {
  1854. portal.log.Errorfln("Error handling Matrix event %s: %v", evt.ID, err)
  1855. var statusResp whatsapp.StatusResponse
  1856. if errors.As(err, &statusResp) && statusResp.Status == 599 {
  1857. portal.log.Debugfln("599 status response data: %+v", statusResp)
  1858. }
  1859. portal.sendErrorMessage(err.Error())
  1860. } else {
  1861. portal.log.Debugfln("Handled Matrix event %s", evt.ID)
  1862. portal.sendDeliveryReceipt(evt.ID)
  1863. }
  1864. if errorEventID != "" {
  1865. _, err = portal.MainIntent().RedactEvent(portal.MXID, errorEventID)
  1866. if err != nil {
  1867. portal.log.Warnfln("Failed to redact timeout warning message %s: %v", errorEventID, err)
  1868. }
  1869. }
  1870. }
  1871. func (portal *Portal) HandleMatrixRedaction(sender *User, evt *event.Event) {
  1872. if portal.IsPrivateChat() && sender.JID != portal.Key.Receiver {
  1873. return
  1874. }
  1875. msg := portal.bridge.DB.Message.GetByMXID(evt.Redacts)
  1876. if msg == nil || msg.Sender != sender.JID {
  1877. return
  1878. }
  1879. ts := uint64(evt.Timestamp / 1000)
  1880. status := waProto.WebMessageInfo_PENDING
  1881. protoMsgType := waProto.ProtocolMessage_REVOKE
  1882. fromMe := true
  1883. info := &waProto.WebMessageInfo{
  1884. Key: &waProto.MessageKey{
  1885. FromMe: &fromMe,
  1886. Id: makeMessageID(),
  1887. RemoteJid: &portal.Key.JID,
  1888. },
  1889. MessageTimestamp: &ts,
  1890. Message: &waProto.Message{
  1891. ProtocolMessage: &waProto.ProtocolMessage{
  1892. Type: &protoMsgType,
  1893. Key: &waProto.MessageKey{
  1894. FromMe: &fromMe,
  1895. Id: &msg.JID,
  1896. RemoteJid: &portal.Key.JID,
  1897. },
  1898. },
  1899. },
  1900. Status: &status,
  1901. }
  1902. errChan := make(chan error, 1)
  1903. go sender.Conn.SendRaw(info, errChan)
  1904. var err error
  1905. select {
  1906. case err = <-errChan:
  1907. case <-time.After(time.Duration(portal.bridge.Config.Bridge.ConnectionTimeout) * time.Second):
  1908. portal.log.Warnfln("Response when bridging Matrix redaction %s is taking long to arrive", evt.ID)
  1909. err = <-errChan
  1910. }
  1911. if err != nil {
  1912. portal.log.Errorfln("Error handling Matrix redaction %s: %v", evt.ID, err)
  1913. } else {
  1914. portal.log.Debugln("Handled Matrix redaction %s of %s", evt.ID, evt.Redacts)
  1915. portal.sendDeliveryReceipt(evt.ID)
  1916. }
  1917. }
  1918. func (portal *Portal) Delete() {
  1919. portal.Portal.Delete()
  1920. portal.bridge.portalsLock.Lock()
  1921. delete(portal.bridge.portalsByJID, portal.Key)
  1922. if len(portal.MXID) > 0 {
  1923. delete(portal.bridge.portalsByMXID, portal.MXID)
  1924. }
  1925. portal.bridge.portalsLock.Unlock()
  1926. }
  1927. func (portal *Portal) GetMatrixUsers() ([]id.UserID, error) {
  1928. members, err := portal.MainIntent().JoinedMembers(portal.MXID)
  1929. if err != nil {
  1930. return nil, fmt.Errorf("failed to get member list: %w", err)
  1931. }
  1932. var users []id.UserID
  1933. for userID := range members.Joined {
  1934. _, isPuppet := portal.bridge.ParsePuppetMXID(userID)
  1935. if !isPuppet && userID != portal.bridge.Bot.UserID {
  1936. users = append(users, userID)
  1937. }
  1938. }
  1939. return users, nil
  1940. }
  1941. func (portal *Portal) CleanupIfEmpty() {
  1942. users, err := portal.GetMatrixUsers()
  1943. if err != nil {
  1944. portal.log.Errorfln("Failed to get Matrix user list to determine if portal needs to be cleaned up: %v", err)
  1945. return
  1946. }
  1947. if len(users) == 0 {
  1948. portal.log.Infoln("Room seems to be empty, cleaning up...")
  1949. portal.Delete()
  1950. portal.Cleanup(false)
  1951. }
  1952. }
  1953. func (portal *Portal) Cleanup(puppetsOnly bool) {
  1954. if len(portal.MXID) == 0 {
  1955. return
  1956. }
  1957. if portal.IsPrivateChat() {
  1958. _, err := portal.MainIntent().LeaveRoom(portal.MXID)
  1959. if err != nil {
  1960. portal.log.Warnln("Failed to leave private chat portal with main intent:", err)
  1961. }
  1962. return
  1963. }
  1964. intent := portal.MainIntent()
  1965. members, err := intent.JoinedMembers(portal.MXID)
  1966. if err != nil {
  1967. portal.log.Errorln("Failed to get portal members for cleanup:", err)
  1968. return
  1969. }
  1970. for member := range members.Joined {
  1971. if member == intent.UserID {
  1972. continue
  1973. }
  1974. puppet := portal.bridge.GetPuppetByMXID(member)
  1975. if puppet != nil {
  1976. _, err = puppet.DefaultIntent().LeaveRoom(portal.MXID)
  1977. if err != nil {
  1978. portal.log.Errorln("Error leaving as puppet while cleaning up portal:", err)
  1979. }
  1980. } else if !puppetsOnly {
  1981. _, err = intent.KickUser(portal.MXID, &mautrix.ReqKickUser{UserID: member, Reason: "Deleting portal"})
  1982. if err != nil {
  1983. portal.log.Errorln("Error kicking user while cleaning up portal:", err)
  1984. }
  1985. }
  1986. }
  1987. _, err = intent.LeaveRoom(portal.MXID)
  1988. if err != nil {
  1989. portal.log.Errorln("Error leaving with main intent while cleaning up portal:", err)
  1990. }
  1991. }
  1992. func (portal *Portal) HandleMatrixLeave(sender *User) {
  1993. if portal.IsPrivateChat() {
  1994. portal.log.Debugln("User left private chat portal, cleaning up and deleting...")
  1995. portal.Delete()
  1996. portal.Cleanup(false)
  1997. return
  1998. } else {
  1999. // TODO should we somehow deduplicate this call if this leave was sent by the bridge?
  2000. resp, err := sender.Conn.LeaveGroup(portal.Key.JID)
  2001. if err != nil {
  2002. portal.log.Errorfln("Failed to leave group as %s: %v", sender.MXID, err)
  2003. return
  2004. }
  2005. portal.log.Infoln("Leave response:", <-resp)
  2006. portal.CleanupIfEmpty()
  2007. }
  2008. }
  2009. func (portal *Portal) HandleMatrixKick(sender *User, evt *event.Event) {
  2010. puppet := portal.bridge.GetPuppetByMXID(id.UserID(evt.GetStateKey()))
  2011. if puppet != nil {
  2012. resp, err := sender.Conn.RemoveMember(portal.Key.JID, []string{puppet.JID})
  2013. if err != nil {
  2014. portal.log.Errorfln("Failed to kick %s from group as %s: %v", puppet.JID, sender.MXID, err)
  2015. return
  2016. }
  2017. portal.log.Infoln("Kick %s response: %s", puppet.JID, <-resp)
  2018. }
  2019. }
  2020. func (portal *Portal) HandleMatrixInvite(sender *User, evt *event.Event) {
  2021. puppet := portal.bridge.GetPuppetByMXID(id.UserID(evt.GetStateKey()))
  2022. if puppet != nil {
  2023. resp, err := sender.Conn.AddMember(portal.Key.JID, []string{puppet.JID})
  2024. if err != nil {
  2025. portal.log.Errorfln("Failed to add %s to group as %s: %v", puppet.JID, sender.MXID, err)
  2026. return
  2027. }
  2028. portal.log.Infoln("Add %s response: %s", puppet.JID, <-resp)
  2029. }
  2030. }