portal.go 67 KB

1234567891011121314151617181920212223242526272829303132333435363738394041424344454647484950515253545556575859606162636465666768697071727374757677787980818283848586878889909192939495969798991001011021031041051061071081091101111121131141151161171181191201211221231241251261271281291301311321331341351361371381391401411421431441451461471481491501511521531541551561571581591601611621631641651661671681691701711721731741751761771781791801811821831841851861871881891901911921931941951961971981992002012022032042052062072082092102112122132142152162172182192202212222232242252262272282292302312322332342352362372382392402412422432442452462472482492502512522532542552562572582592602612622632642652662672682692702712722732742752762772782792802812822832842852862872882892902912922932942952962972982993003013023033043053063073083093103113123133143153163173183193203213223233243253263273283293303313323333343353363373383393403413423433443453463473483493503513523533543553563573583593603613623633643653663673683693703713723733743753763773783793803813823833843853863873883893903913923933943953963973983994004014024034044054064074084094104114124134144154164174184194204214224234244254264274284294304314324334344354364374384394404414424434444454464474484494504514524534544554564574584594604614624634644654664674684694704714724734744754764774784794804814824834844854864874884894904914924934944954964974984995005015025035045055065075085095105115125135145155165175185195205215225235245255265275285295305315325335345355365375385395405415425435445455465475485495505515525535545555565575585595605615625635645655665675685695705715725735745755765775785795805815825835845855865875885895905915925935945955965975985996006016026036046056066076086096106116126136146156166176186196206216226236246256266276286296306316326336346356366376386396406416426436446456466476486496506516526536546556566576586596606616626636646656666676686696706716726736746756766776786796806816826836846856866876886896906916926936946956966976986997007017027037047057067077087097107117127137147157167177187197207217227237247257267277287297307317327337347357367377387397407417427437447457467477487497507517527537547557567577587597607617627637647657667677687697707717727737747757767777787797807817827837847857867877887897907917927937947957967977987998008018028038048058068078088098108118128138148158168178188198208218228238248258268278288298308318328338348358368378388398408418428438448458468478488498508518528538548558568578588598608618628638648658668678688698708718728738748758768778788798808818828838848858868878888898908918928938948958968978988999009019029039049059069079089099109119129139149159169179189199209219229239249259269279289299309319329339349359369379389399409419429439449459469479489499509519529539549559569579589599609619629639649659669679689699709719729739749759769779789799809819829839849859869879889899909919929939949959969979989991000100110021003100410051006100710081009101010111012101310141015101610171018101910201021102210231024102510261027102810291030103110321033103410351036103710381039104010411042104310441045104610471048104910501051105210531054105510561057105810591060106110621063106410651066106710681069107010711072107310741075107610771078107910801081108210831084108510861087108810891090109110921093109410951096109710981099110011011102110311041105110611071108110911101111111211131114111511161117111811191120112111221123112411251126112711281129113011311132113311341135113611371138113911401141114211431144114511461147114811491150115111521153115411551156115711581159116011611162116311641165116611671168116911701171117211731174117511761177117811791180118111821183118411851186118711881189119011911192119311941195119611971198119912001201120212031204120512061207120812091210121112121213121412151216121712181219122012211222122312241225122612271228122912301231123212331234123512361237123812391240124112421243124412451246124712481249125012511252125312541255125612571258125912601261126212631264126512661267126812691270127112721273127412751276127712781279128012811282128312841285128612871288128912901291129212931294129512961297129812991300130113021303130413051306130713081309131013111312131313141315131613171318131913201321132213231324132513261327132813291330133113321333133413351336133713381339134013411342134313441345134613471348134913501351135213531354135513561357135813591360136113621363136413651366136713681369137013711372137313741375137613771378137913801381138213831384138513861387138813891390139113921393139413951396139713981399140014011402140314041405140614071408140914101411141214131414141514161417141814191420142114221423142414251426142714281429143014311432143314341435143614371438143914401441144214431444144514461447144814491450145114521453145414551456145714581459146014611462146314641465146614671468146914701471147214731474147514761477147814791480148114821483148414851486148714881489149014911492149314941495149614971498149915001501150215031504150515061507150815091510151115121513151415151516151715181519152015211522152315241525152615271528152915301531153215331534153515361537153815391540154115421543154415451546154715481549155015511552155315541555155615571558155915601561156215631564156515661567156815691570157115721573157415751576157715781579158015811582158315841585158615871588158915901591159215931594159515961597159815991600160116021603160416051606160716081609161016111612161316141615161616171618161916201621162216231624162516261627162816291630163116321633163416351636163716381639164016411642164316441645164616471648164916501651165216531654165516561657165816591660166116621663166416651666166716681669167016711672167316741675167616771678167916801681168216831684168516861687168816891690169116921693169416951696169716981699170017011702170317041705170617071708170917101711171217131714171517161717171817191720172117221723172417251726172717281729173017311732173317341735173617371738173917401741174217431744174517461747174817491750175117521753175417551756175717581759176017611762176317641765176617671768176917701771177217731774177517761777177817791780178117821783178417851786178717881789179017911792179317941795179617971798179918001801180218031804180518061807180818091810181118121813181418151816181718181819182018211822182318241825182618271828182918301831183218331834183518361837183818391840184118421843184418451846184718481849185018511852185318541855185618571858185918601861186218631864186518661867186818691870187118721873187418751876187718781879188018811882188318841885188618871888188918901891189218931894189518961897189818991900190119021903190419051906190719081909191019111912191319141915191619171918191919201921192219231924192519261927192819291930193119321933193419351936193719381939194019411942194319441945194619471948194919501951195219531954195519561957195819591960196119621963196419651966196719681969197019711972197319741975197619771978197919801981198219831984198519861987198819891990199119921993199419951996199719981999200020012002200320042005200620072008200920102011201220132014201520162017201820192020202120222023202420252026202720282029203020312032203320342035203620372038203920402041204220432044204520462047204820492050205120522053205420552056205720582059206020612062206320642065206620672068206920702071207220732074207520762077207820792080208120822083208420852086208720882089209020912092209320942095209620972098209921002101210221032104210521062107210821092110211121122113211421152116211721182119212021212122212321242125212621272128212921302131213221332134213521362137213821392140214121422143214421452146214721482149215021512152215321542155215621572158215921602161216221632164216521662167216821692170217121722173217421752176217721782179218021812182218321842185218621872188218921902191219221932194219521962197219821992200220122022203220422052206220722082209221022112212221322142215221622172218221922202221222222232224222522262227222822292230223122322233
  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("Fetching 50 messages of history 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. portal.log.Debugfln("Didn't get more messages to backfill (resp.Content is %T)", resp.Content)
  643. break
  644. }
  645. portal.handleHistory(user, messages)
  646. lastMessageProto, ok := messages[len(messages)-1].(*waProto.WebMessageInfo)
  647. if ok {
  648. lastMessageID = lastMessageProto.GetKey().GetId()
  649. lastMessageFromMe = lastMessageProto.GetKey().GetFromMe()
  650. }
  651. }
  652. portal.log.Infoln("Backfilling finished")
  653. return nil
  654. }
  655. func (portal *Portal) beginBackfill() func() {
  656. portal.backfillLock.Lock()
  657. portal.backfilling = true
  658. var privateChatPuppetInvited bool
  659. var privateChatPuppet *Puppet
  660. if portal.IsPrivateChat() && portal.bridge.Config.Bridge.InviteOwnPuppetForBackfilling && portal.Key.JID != portal.Key.Receiver {
  661. privateChatPuppet = portal.bridge.GetPuppetByJID(portal.Key.Receiver)
  662. portal.privateChatBackfillInvitePuppet = func() {
  663. if privateChatPuppetInvited {
  664. return
  665. }
  666. privateChatPuppetInvited = true
  667. _, _ = portal.MainIntent().InviteUser(portal.MXID, &mautrix.ReqInviteUser{UserID: privateChatPuppet.MXID})
  668. _ = privateChatPuppet.DefaultIntent().EnsureJoined(portal.MXID)
  669. }
  670. }
  671. return func() {
  672. portal.backfilling = false
  673. portal.privateChatBackfillInvitePuppet = nil
  674. portal.backfillLock.Unlock()
  675. if privateChatPuppet != nil && privateChatPuppetInvited {
  676. _, _ = privateChatPuppet.DefaultIntent().LeaveRoom(portal.MXID)
  677. }
  678. }
  679. }
  680. func (portal *Portal) disableNotifications(user *User) {
  681. if !portal.bridge.Config.Bridge.HistoryDisableNotifs {
  682. return
  683. }
  684. puppet := portal.bridge.GetPuppetByCustomMXID(user.MXID)
  685. if puppet == nil || puppet.customIntent == nil {
  686. return
  687. }
  688. portal.log.Debugfln("Disabling notifications for %s for backfilling", user.MXID)
  689. ruleID := fmt.Sprintf("net.maunium.silence_while_backfilling.%s", portal.MXID)
  690. err := puppet.customIntent.PutPushRule("global", pushrules.OverrideRule, ruleID, &mautrix.ReqPutPushRule{
  691. Actions: []pushrules.PushActionType{pushrules.ActionDontNotify},
  692. Conditions: []pushrules.PushCondition{{
  693. Kind: pushrules.KindEventMatch,
  694. Key: "room_id",
  695. Pattern: string(portal.MXID),
  696. }},
  697. })
  698. if err != nil {
  699. portal.log.Warnfln("Failed to disable notifications for %s while backfilling: %v", user.MXID, err)
  700. }
  701. }
  702. func (portal *Portal) enableNotifications(user *User) {
  703. if !portal.bridge.Config.Bridge.HistoryDisableNotifs {
  704. return
  705. }
  706. puppet := portal.bridge.GetPuppetByCustomMXID(user.MXID)
  707. if puppet == nil || puppet.customIntent == nil {
  708. return
  709. }
  710. portal.log.Debugfln("Re-enabling notifications for %s after backfilling", user.MXID)
  711. ruleID := fmt.Sprintf("net.maunium.silence_while_backfilling.%s", portal.MXID)
  712. err := puppet.customIntent.DeletePushRule("global", pushrules.OverrideRule, ruleID)
  713. if err != nil {
  714. portal.log.Warnfln("Failed to re-enable notifications for %s after backfilling: %v", user.MXID, err)
  715. }
  716. }
  717. func (portal *Portal) FillInitialHistory(user *User) error {
  718. if portal.bridge.Config.Bridge.InitialHistoryFill == 0 {
  719. return nil
  720. }
  721. endBackfill := portal.beginBackfill()
  722. defer endBackfill()
  723. if portal.privateChatBackfillInvitePuppet != nil {
  724. portal.privateChatBackfillInvitePuppet()
  725. }
  726. n := portal.bridge.Config.Bridge.InitialHistoryFill
  727. portal.log.Infoln("Filling initial history, maximum", n, "messages")
  728. var messages []interface{}
  729. before := ""
  730. fromMe := true
  731. chunkNum := 1
  732. for n > 0 {
  733. count := 50
  734. if n < count {
  735. count = n
  736. }
  737. portal.log.Debugfln("Fetching chunk %d (%d messages / %d cap) before message %s", chunkNum, count, n, before)
  738. resp, err := user.Conn.LoadMessagesBefore(portal.Key.JID, before, fromMe, count)
  739. if err != nil {
  740. return err
  741. }
  742. chunk, ok := resp.Content.([]interface{})
  743. if !ok || len(chunk) == 0 {
  744. portal.log.Infoln("Chunk empty, starting handling of loaded messages")
  745. break
  746. }
  747. messages = append(chunk, messages...)
  748. portal.log.Debugfln("Fetched chunk and received %d messages", len(chunk))
  749. n -= len(chunk)
  750. key := chunk[0].(*waProto.WebMessageInfo).GetKey()
  751. before = key.GetId()
  752. fromMe = key.GetFromMe()
  753. if len(before) == 0 {
  754. portal.log.Infoln("No message ID for first message, starting handling of loaded messages")
  755. break
  756. }
  757. }
  758. portal.disableNotifications(user)
  759. portal.handleHistory(user, messages)
  760. portal.enableNotifications(user)
  761. portal.log.Infoln("Initial history fill complete")
  762. return nil
  763. }
  764. func (portal *Portal) handleHistory(user *User, messages []interface{}) {
  765. portal.log.Infoln("Handling", len(messages), "messages of history")
  766. for _, rawMessage := range messages {
  767. message, ok := rawMessage.(*waProto.WebMessageInfo)
  768. if !ok {
  769. portal.log.Warnln("Unexpected non-WebMessageInfo item in history response:", rawMessage)
  770. continue
  771. }
  772. data := whatsapp.ParseProtoMessage(message)
  773. if data == nil || data == whatsapp.ErrMessageTypeNotImplemented {
  774. st := message.GetMessageStubType()
  775. // Ignore some types that are known to fail
  776. if st == waProto.WebMessageInfo_CALL_MISSED_VOICE || st == waProto.WebMessageInfo_CALL_MISSED_VIDEO ||
  777. st == waProto.WebMessageInfo_CALL_MISSED_GROUP_VOICE || st == waProto.WebMessageInfo_CALL_MISSED_GROUP_VIDEO {
  778. continue
  779. }
  780. portal.log.Warnln("Message", message.GetKey().GetId(), "failed to parse during backfilling")
  781. continue
  782. }
  783. if portal.privateChatBackfillInvitePuppet != nil && message.GetKey().GetFromMe() && portal.IsPrivateChat() {
  784. portal.privateChatBackfillInvitePuppet()
  785. }
  786. portal.handleMessage(PortalMessage{portal.Key.JID, user, data, message.GetMessageTimestamp()})
  787. }
  788. }
  789. type BridgeInfoSection struct {
  790. ID string `json:"id"`
  791. DisplayName string `json:"displayname,omitempty"`
  792. AvatarURL id.ContentURIString `json:"avatar_url,omitempty"`
  793. ExternalURL string `json:"external_url,omitempty"`
  794. }
  795. type BridgeInfoContent struct {
  796. BridgeBot id.UserID `json:"bridgebot"`
  797. Creator id.UserID `json:"creator,omitempty"`
  798. Protocol BridgeInfoSection `json:"protocol"`
  799. Network *BridgeInfoSection `json:"network,omitempty"`
  800. Channel BridgeInfoSection `json:"channel"`
  801. }
  802. var (
  803. StateBridgeInfo = event.Type{Type: "m.bridge", Class: event.StateEventType}
  804. StateHalfShotBridgeInfo = event.Type{Type: "uk.half-shot.bridge", Class: event.StateEventType}
  805. )
  806. func (portal *Portal) getBridgeInfo() (string, BridgeInfoContent) {
  807. bridgeInfo := BridgeInfoContent{
  808. BridgeBot: portal.bridge.Bot.UserID,
  809. Creator: portal.MainIntent().UserID,
  810. Protocol: BridgeInfoSection{
  811. ID: "whatsapp",
  812. DisplayName: "WhatsApp",
  813. AvatarURL: id.ContentURIString(portal.bridge.Config.AppService.Bot.Avatar),
  814. ExternalURL: "https://www.whatsapp.com/",
  815. },
  816. Channel: BridgeInfoSection{
  817. ID: portal.Key.JID,
  818. DisplayName: portal.Name,
  819. AvatarURL: portal.AvatarURL.CUString(),
  820. },
  821. }
  822. bridgeInfoStateKey := fmt.Sprintf("net.maunium.whatsapp://whatsapp/%s", portal.Key.JID)
  823. return bridgeInfoStateKey, bridgeInfo
  824. }
  825. func (portal *Portal) UpdateBridgeInfo() {
  826. if len(portal.MXID) == 0 {
  827. portal.log.Debugln("Not updating bridge info: no Matrix room created")
  828. return
  829. }
  830. portal.log.Debugln("Updating bridge info...")
  831. stateKey, content := portal.getBridgeInfo()
  832. _, err := portal.MainIntent().SendStateEvent(portal.MXID, StateBridgeInfo, stateKey, content)
  833. if err != nil {
  834. portal.log.Warnln("Failed to update m.bridge:", err)
  835. }
  836. _, err = portal.MainIntent().SendStateEvent(portal.MXID, StateHalfShotBridgeInfo, stateKey, content)
  837. if err != nil {
  838. portal.log.Warnln("Failed to update uk.half-shot.bridge:", err)
  839. }
  840. }
  841. func (portal *Portal) CreateMatrixRoom(user *User) error {
  842. portal.roomCreateLock.Lock()
  843. defer portal.roomCreateLock.Unlock()
  844. if len(portal.MXID) > 0 {
  845. return nil
  846. }
  847. intent := portal.MainIntent()
  848. if err := intent.EnsureRegistered(); err != nil {
  849. return err
  850. }
  851. portal.log.Infoln("Creating Matrix room. Info source:", user.MXID)
  852. var metadata *whatsappExt.GroupInfo
  853. if portal.IsPrivateChat() {
  854. puppet := portal.bridge.GetPuppetByJID(portal.Key.JID)
  855. if portal.bridge.Config.Bridge.PrivateChatPortalMeta {
  856. portal.Name = puppet.Displayname
  857. portal.AvatarURL = puppet.AvatarURL
  858. portal.Avatar = puppet.Avatar
  859. } else {
  860. portal.Name = ""
  861. }
  862. portal.Topic = "WhatsApp private chat"
  863. } else if portal.IsStatusBroadcastRoom() {
  864. portal.Name = "WhatsApp Status Broadcast"
  865. portal.Topic = "WhatsApp status updates from your contacts"
  866. } else {
  867. var err error
  868. metadata, err = user.Conn.GetGroupMetaData(portal.Key.JID)
  869. if err == nil && metadata.Status == 0 {
  870. portal.Name = metadata.Name
  871. portal.Topic = metadata.Topic
  872. }
  873. portal.UpdateAvatar(user, nil, false)
  874. }
  875. bridgeInfoStateKey, bridgeInfo := portal.getBridgeInfo()
  876. initialState := []*event.Event{{
  877. Type: event.StatePowerLevels,
  878. Content: event.Content{
  879. Parsed: portal.GetBasePowerLevels(),
  880. },
  881. }, {
  882. Type: StateBridgeInfo,
  883. Content: event.Content{Parsed: bridgeInfo},
  884. StateKey: &bridgeInfoStateKey,
  885. }, {
  886. // TODO remove this once https://github.com/matrix-org/matrix-doc/pull/2346 is in spec
  887. Type: StateHalfShotBridgeInfo,
  888. Content: event.Content{Parsed: bridgeInfo},
  889. StateKey: &bridgeInfoStateKey,
  890. }}
  891. if !portal.AvatarURL.IsEmpty() {
  892. initialState = append(initialState, &event.Event{
  893. Type: event.StateRoomAvatar,
  894. Content: event.Content{
  895. Parsed: event.RoomAvatarEventContent{URL: portal.AvatarURL},
  896. },
  897. })
  898. }
  899. invite := []id.UserID{user.MXID}
  900. if user.IsRelaybot {
  901. invite = portal.bridge.Config.Bridge.Relaybot.InviteUsers
  902. }
  903. if portal.bridge.Config.Bridge.Encryption.Default {
  904. initialState = append(initialState, &event.Event{
  905. Type: event.StateEncryption,
  906. Content: event.Content{
  907. Parsed: event.EncryptionEventContent{Algorithm: id.AlgorithmMegolmV1},
  908. },
  909. })
  910. portal.Encrypted = true
  911. if portal.IsPrivateChat() {
  912. invite = append(invite, portal.bridge.Bot.UserID)
  913. }
  914. }
  915. resp, err := intent.CreateRoom(&mautrix.ReqCreateRoom{
  916. Visibility: "private",
  917. Name: portal.Name,
  918. Topic: portal.Topic,
  919. Invite: invite,
  920. Preset: "private_chat",
  921. IsDirect: portal.IsPrivateChat(),
  922. InitialState: initialState,
  923. })
  924. if err != nil {
  925. return err
  926. }
  927. portal.MXID = resp.RoomID
  928. portal.Update()
  929. portal.bridge.portalsLock.Lock()
  930. portal.bridge.portalsByMXID[portal.MXID] = portal
  931. portal.bridge.portalsLock.Unlock()
  932. // We set the memberships beforehand to make sure the encryption key exchange in initial backfill knows the users are here.
  933. for _, user := range invite {
  934. portal.bridge.StateStore.SetMembership(portal.MXID, user, event.MembershipInvite)
  935. }
  936. if metadata != nil {
  937. portal.SyncParticipants(metadata)
  938. if metadata.Announce {
  939. portal.RestrictMessageSending(metadata.Announce)
  940. }
  941. } else {
  942. customPuppet := portal.bridge.GetPuppetByCustomMXID(user.MXID)
  943. if customPuppet != nil && customPuppet.CustomIntent() != nil {
  944. _ = customPuppet.CustomIntent().EnsureJoined(portal.MXID)
  945. }
  946. }
  947. user.addPortalToCommunity(portal)
  948. if portal.IsPrivateChat() {
  949. puppet := user.bridge.GetPuppetByJID(portal.Key.JID)
  950. user.addPuppetToCommunity(puppet)
  951. if portal.bridge.Config.Bridge.Encryption.Default {
  952. err = portal.bridge.Bot.EnsureJoined(portal.MXID)
  953. if err != nil {
  954. portal.log.Errorln("Failed to join created portal with bridge bot for e2be:", err)
  955. }
  956. }
  957. user.UpdateDirectChats(map[id.UserID][]id.RoomID{puppet.MXID: {portal.MXID}})
  958. }
  959. err = portal.FillInitialHistory(user)
  960. if err != nil {
  961. portal.log.Errorln("Failed to fill history:", err)
  962. }
  963. return nil
  964. }
  965. func (portal *Portal) IsPrivateChat() bool {
  966. if portal.isPrivate == nil {
  967. val := strings.HasSuffix(portal.Key.JID, whatsappExt.NewUserSuffix)
  968. portal.isPrivate = &val
  969. }
  970. return *portal.isPrivate
  971. }
  972. func (portal *Portal) HasRelaybot() bool {
  973. if portal.bridge.Relaybot == nil {
  974. return false
  975. } else if portal.hasRelaybot == nil {
  976. val := portal.bridge.Relaybot.IsInPortal(portal.Key)
  977. portal.hasRelaybot = &val
  978. }
  979. return *portal.hasRelaybot
  980. }
  981. func (portal *Portal) IsStatusBroadcastRoom() bool {
  982. return portal.Key.JID == "status@broadcast"
  983. }
  984. func (portal *Portal) MainIntent() *appservice.IntentAPI {
  985. if portal.IsPrivateChat() {
  986. return portal.bridge.GetPuppetByJID(portal.Key.JID).DefaultIntent()
  987. }
  988. return portal.bridge.Bot
  989. }
  990. func (portal *Portal) SetReply(content *event.MessageEventContent, info whatsapp.ContextInfo) {
  991. if len(info.QuotedMessageID) == 0 {
  992. return
  993. }
  994. message := portal.bridge.DB.Message.GetByJID(portal.Key, info.QuotedMessageID)
  995. if message != nil {
  996. evt, err := portal.MainIntent().GetEvent(portal.MXID, message.MXID)
  997. if err != nil {
  998. portal.log.Warnln("Failed to get reply target:", err)
  999. return
  1000. }
  1001. if evt.Type == event.EventEncrypted {
  1002. _ = evt.Content.ParseRaw(evt.Type)
  1003. decryptedEvt, err := portal.bridge.Crypto.Decrypt(evt)
  1004. if err != nil {
  1005. portal.log.Warnln("Failed to decrypt reply target:", err)
  1006. } else {
  1007. evt = decryptedEvt
  1008. }
  1009. }
  1010. _ = evt.Content.ParseRaw(evt.Type)
  1011. content.SetReply(evt)
  1012. }
  1013. return
  1014. }
  1015. func (portal *Portal) HandleMessageRevoke(user *User, message whatsappExt.MessageRevocation) {
  1016. msg := portal.bridge.DB.Message.GetByJID(portal.Key, message.Id)
  1017. if msg == nil {
  1018. return
  1019. }
  1020. var intent *appservice.IntentAPI
  1021. if message.FromMe {
  1022. if portal.IsPrivateChat() {
  1023. intent = portal.bridge.GetPuppetByJID(user.JID).CustomIntent()
  1024. } else {
  1025. intent = portal.bridge.GetPuppetByJID(user.JID).IntentFor(portal)
  1026. }
  1027. } else if len(message.Participant) > 0 {
  1028. intent = portal.bridge.GetPuppetByJID(message.Participant).IntentFor(portal)
  1029. }
  1030. if intent == nil {
  1031. intent = portal.MainIntent()
  1032. }
  1033. _, err := intent.RedactEvent(portal.MXID, msg.MXID)
  1034. if err != nil {
  1035. portal.log.Errorln("Failed to redact %s: %v", msg.JID, err)
  1036. return
  1037. }
  1038. msg.Delete()
  1039. }
  1040. func (portal *Portal) HandleFakeMessage(_ *User, message FakeMessage) {
  1041. if portal.isRecentlyHandled(message.ID) {
  1042. return
  1043. }
  1044. content := event.MessageEventContent{
  1045. MsgType: event.MsgNotice,
  1046. Body: message.Text,
  1047. }
  1048. if message.Alert {
  1049. content.MsgType = event.MsgText
  1050. }
  1051. _, err := portal.sendMainIntentMessage(content)
  1052. if err != nil {
  1053. portal.log.Errorfln("Failed to handle fake message %s: %v", message.ID, err)
  1054. return
  1055. }
  1056. portal.recentlyHandledLock.Lock()
  1057. index := portal.recentlyHandledIndex
  1058. portal.recentlyHandledIndex = (portal.recentlyHandledIndex + 1) % recentlyHandledLength
  1059. portal.recentlyHandledLock.Unlock()
  1060. portal.recentlyHandled[index] = message.ID
  1061. }
  1062. func (portal *Portal) sendMainIntentMessage(content interface{}) (*mautrix.RespSendEvent, error) {
  1063. return portal.sendMessage(portal.MainIntent(), event.EventMessage, content, 0)
  1064. }
  1065. const MessageSendRetries = 5
  1066. const MediaUploadRetries = 5
  1067. const BadGatewaySleep = 5 * time.Second
  1068. func (portal *Portal) sendMessage(intent *appservice.IntentAPI, eventType event.Type, content interface{}, timestamp int64) (*mautrix.RespSendEvent, error) {
  1069. return portal.sendMessageWithRetry(intent, eventType, content, timestamp, MessageSendRetries)
  1070. }
  1071. func isGatewayError(err error) bool {
  1072. if err == nil {
  1073. return false
  1074. }
  1075. var httpErr mautrix.HTTPError
  1076. return errors.As(err, &httpErr) && (httpErr.IsStatus(http.StatusBadGateway) || httpErr.IsStatus(http.StatusGatewayTimeout))
  1077. }
  1078. func (portal *Portal) sendMessageWithRetry(intent *appservice.IntentAPI, eventType event.Type, content interface{}, timestamp int64, retries int) (*mautrix.RespSendEvent, error) {
  1079. for ;;retries-- {
  1080. resp, err := portal.sendMessageDirect(intent, eventType, content, timestamp)
  1081. if retries > 0 && isGatewayError(err) {
  1082. portal.log.Warnfln("Got gateway error trying to send message, retrying in %d seconds", int(BadGatewaySleep.Seconds()))
  1083. time.Sleep(BadGatewaySleep)
  1084. } else {
  1085. return resp, err
  1086. }
  1087. }
  1088. }
  1089. func (portal *Portal) sendMessageDirect(intent *appservice.IntentAPI, eventType event.Type, content interface{}, timestamp int64) (*mautrix.RespSendEvent, error) {
  1090. wrappedContent := event.Content{Parsed: content}
  1091. if timestamp != 0 && intent.IsCustomPuppet {
  1092. wrappedContent.Raw = map[string]interface{}{
  1093. "net.maunium.whatsapp.puppet": intent.IsCustomPuppet,
  1094. }
  1095. }
  1096. if portal.Encrypted && portal.bridge.Crypto != nil {
  1097. encrypted, err := portal.bridge.Crypto.Encrypt(portal.MXID, eventType, wrappedContent)
  1098. if err != nil {
  1099. return nil, fmt.Errorf("failed to encrypt event: %w", err)
  1100. }
  1101. eventType = event.EventEncrypted
  1102. wrappedContent.Parsed = encrypted
  1103. }
  1104. if timestamp == 0 {
  1105. return intent.SendMessageEvent(portal.MXID, eventType, &wrappedContent)
  1106. } else {
  1107. return intent.SendMassagedMessageEvent(portal.MXID, eventType, &wrappedContent, timestamp)
  1108. }
  1109. }
  1110. func (portal *Portal) HandleTextMessage(source *User, message whatsapp.TextMessage) {
  1111. intent := portal.startHandling(source, message.Info)
  1112. if intent == nil {
  1113. return
  1114. }
  1115. content := &event.MessageEventContent{
  1116. Body: message.Text,
  1117. MsgType: event.MsgText,
  1118. }
  1119. portal.bridge.Formatter.ParseWhatsApp(content, message.ContextInfo.MentionedJID)
  1120. portal.SetReply(content, message.ContextInfo)
  1121. _, _ = intent.UserTyping(portal.MXID, false, 0)
  1122. resp, err := portal.sendMessage(intent, event.EventMessage, content, int64(message.Info.Timestamp*1000))
  1123. if err != nil {
  1124. portal.log.Errorfln("Failed to handle message %s: %v", message.Info.Id, err)
  1125. return
  1126. }
  1127. portal.finishHandling(source, message.Info.Source, resp.EventID)
  1128. }
  1129. func (portal *Portal) HandleLocationMessage(source *User, message whatsapp.LocationMessage) {
  1130. intent := portal.startHandling(source, message.Info)
  1131. if intent == nil {
  1132. return
  1133. }
  1134. url := message.Url
  1135. if len(url) == 0 {
  1136. url = fmt.Sprintf("https://maps.google.com/?q=%.5f,%.5f", message.DegreesLatitude, message.DegreesLongitude)
  1137. }
  1138. name := message.Name
  1139. if len(name) == 0 {
  1140. latChar := 'N'
  1141. if message.DegreesLatitude < 0 {
  1142. latChar = 'S'
  1143. }
  1144. longChar := 'E'
  1145. if message.DegreesLongitude < 0 {
  1146. longChar = 'W'
  1147. }
  1148. name = fmt.Sprintf("%.4f° %c %.4f° %c", math.Abs(message.DegreesLatitude), latChar, math.Abs(message.DegreesLongitude), longChar)
  1149. }
  1150. content := &event.MessageEventContent{
  1151. MsgType: event.MsgLocation,
  1152. Body: fmt.Sprintf("Location: %s\n%s\n%s", name, message.Address, url),
  1153. Format: event.FormatHTML,
  1154. FormattedBody: fmt.Sprintf("Location: <a href='%s'>%s</a><br>%s", url, name, message.Address),
  1155. GeoURI: fmt.Sprintf("geo:%.5f,%.5f", message.DegreesLatitude, message.DegreesLongitude),
  1156. }
  1157. if len(message.JpegThumbnail) > 0 {
  1158. thumbnailMime := http.DetectContentType(message.JpegThumbnail)
  1159. uploadedThumbnail, _ := intent.UploadBytes(message.JpegThumbnail, thumbnailMime)
  1160. if uploadedThumbnail != nil {
  1161. cfg, _, _ := image.DecodeConfig(bytes.NewReader(message.JpegThumbnail))
  1162. content.Info = &event.FileInfo{
  1163. ThumbnailInfo: &event.FileInfo{
  1164. Size: len(message.JpegThumbnail),
  1165. Width: cfg.Width,
  1166. Height: cfg.Height,
  1167. MimeType: thumbnailMime,
  1168. },
  1169. ThumbnailURL: uploadedThumbnail.ContentURI.CUString(),
  1170. }
  1171. }
  1172. }
  1173. portal.SetReply(content, message.ContextInfo)
  1174. _, _ = intent.UserTyping(portal.MXID, false, 0)
  1175. resp, err := portal.sendMessage(intent, event.EventMessage, content, int64(message.Info.Timestamp*1000))
  1176. if err != nil {
  1177. portal.log.Errorfln("Failed to handle message %s: %v", message.Info.Id, err)
  1178. return
  1179. }
  1180. portal.finishHandling(source, message.Info.Source, resp.EventID)
  1181. }
  1182. func (portal *Portal) HandleContactMessage(source *User, message whatsapp.ContactMessage) {
  1183. intent := portal.startHandling(source, message.Info)
  1184. if intent == nil {
  1185. return
  1186. }
  1187. fileName := fmt.Sprintf("%s.vcf", message.DisplayName)
  1188. data := []byte(message.Vcard)
  1189. mimeType := "text/vcard"
  1190. data, uploadMimeType, file := portal.encryptFile(data, mimeType)
  1191. uploadResp, err := intent.UploadBytesWithName(data, uploadMimeType, fileName)
  1192. if err != nil {
  1193. portal.log.Errorfln("Failed to upload vcard of %s: %v", message.DisplayName, err)
  1194. return
  1195. }
  1196. content := &event.MessageEventContent{
  1197. Body: fileName,
  1198. MsgType: event.MsgFile,
  1199. File: file,
  1200. Info: &event.FileInfo{
  1201. MimeType: mimeType,
  1202. Size: len(message.Vcard),
  1203. },
  1204. }
  1205. if content.File != nil {
  1206. content.File.URL = uploadResp.ContentURI.CUString()
  1207. } else {
  1208. content.URL = uploadResp.ContentURI.CUString()
  1209. }
  1210. portal.SetReply(content, message.ContextInfo)
  1211. _, _ = intent.UserTyping(portal.MXID, false, 0)
  1212. resp, err := portal.sendMessage(intent, event.EventMessage, content, int64(message.Info.Timestamp*1000))
  1213. if err != nil {
  1214. portal.log.Errorfln("Failed to handle message %s: %v", message.Info.Id, err)
  1215. return
  1216. }
  1217. portal.finishHandling(source, message.Info.Source, resp.EventID)
  1218. }
  1219. func (portal *Portal) sendMediaBridgeFailure(source *User, intent *appservice.IntentAPI, info whatsapp.MessageInfo, bridgeErr error) {
  1220. portal.log.Errorfln("Failed to bridge media for %s: %v", info.Id, bridgeErr)
  1221. resp, err := portal.sendMessage(intent, event.EventMessage, &event.MessageEventContent{
  1222. MsgType: event.MsgNotice,
  1223. Body: "Failed to bridge media",
  1224. }, int64(info.Timestamp*1000))
  1225. if err != nil {
  1226. portal.log.Errorfln("Failed to send media download error message for %s: %v", info.Id, err)
  1227. } else {
  1228. portal.finishHandling(source, info.Source, resp.EventID)
  1229. }
  1230. }
  1231. func (portal *Portal) encryptFile(data []byte, mimeType string) ([]byte, string, *event.EncryptedFileInfo) {
  1232. if !portal.Encrypted {
  1233. return data, mimeType, nil
  1234. }
  1235. file := &event.EncryptedFileInfo{
  1236. EncryptedFile: *attachment.NewEncryptedFile(),
  1237. URL: "",
  1238. }
  1239. return file.Encrypt(data), "application/octet-stream", file
  1240. }
  1241. func (portal *Portal) tryKickUser(userID id.UserID, intent *appservice.IntentAPI) error {
  1242. _, err := intent.KickUser(portal.MXID, &mautrix.ReqKickUser{UserID: userID})
  1243. if err != nil {
  1244. httpErr, ok := err.(mautrix.HTTPError)
  1245. if ok && httpErr.RespError != nil && httpErr.RespError.ErrCode == "M_FORBIDDEN" {
  1246. _, err = portal.MainIntent().KickUser(portal.MXID, &mautrix.ReqKickUser{UserID: userID})
  1247. }
  1248. }
  1249. return err
  1250. }
  1251. func (portal *Portal) removeUser(isSameUser bool, kicker *appservice.IntentAPI, target id.UserID, targetIntent *appservice.IntentAPI) {
  1252. if !isSameUser || targetIntent == nil {
  1253. err := portal.tryKickUser(target, kicker)
  1254. if err != nil {
  1255. portal.log.Warnfln("Failed to kick %s from %s: %v", target, portal.MXID, err)
  1256. if targetIntent != nil {
  1257. _, _ = targetIntent.LeaveRoom(portal.MXID)
  1258. }
  1259. }
  1260. } else {
  1261. _, err := targetIntent.LeaveRoom(portal.MXID)
  1262. if err != nil {
  1263. portal.log.Warnfln("Failed to leave portal as %s: %v", target, err)
  1264. _, _ = portal.MainIntent().KickUser(portal.MXID, &mautrix.ReqKickUser{UserID: target})
  1265. }
  1266. }
  1267. }
  1268. func (portal *Portal) HandleWhatsAppKick(senderJID string, jids []string) {
  1269. sender := portal.bridge.GetPuppetByJID(senderJID)
  1270. senderIntent := sender.IntentFor(portal)
  1271. for _, jid := range jids {
  1272. puppet := portal.bridge.GetPuppetByJID(jid)
  1273. portal.removeUser(puppet.JID == sender.JID, senderIntent, puppet.MXID, puppet.DefaultIntent())
  1274. user := portal.bridge.GetUserByJID(jid)
  1275. if user != nil {
  1276. var customIntent *appservice.IntentAPI
  1277. if puppet.CustomMXID == user.MXID {
  1278. customIntent = puppet.CustomIntent()
  1279. }
  1280. portal.removeUser(puppet.JID == sender.JID, senderIntent, user.MXID, customIntent)
  1281. }
  1282. }
  1283. }
  1284. func (portal *Portal) HandleWhatsAppInvite(senderJID string, jids []string) {
  1285. senderIntent := portal.MainIntent()
  1286. if senderJID != "unknown" {
  1287. sender := portal.bridge.GetPuppetByJID(senderJID)
  1288. senderIntent = sender.IntentFor(portal)
  1289. }
  1290. for _, jid := range jids {
  1291. puppet := portal.bridge.GetPuppetByJID(jid)
  1292. _, err := senderIntent.InviteUser(portal.MXID, &mautrix.ReqInviteUser{UserID: puppet.MXID})
  1293. if err != nil {
  1294. portal.log.Warnfln("Failed to invite %s as %s: %v", puppet.MXID, senderIntent.UserID, err)
  1295. }
  1296. err = puppet.DefaultIntent().EnsureJoined(portal.MXID)
  1297. if err != nil {
  1298. portal.log.Errorfln("Failed to ensure %s is joined: %v", puppet.MXID, err)
  1299. }
  1300. }
  1301. }
  1302. type base struct {
  1303. download func() ([]byte, error)
  1304. info whatsapp.MessageInfo
  1305. context whatsapp.ContextInfo
  1306. mimeType string
  1307. }
  1308. type mediaMessage struct {
  1309. base
  1310. thumbnail []byte
  1311. caption string
  1312. fileName string
  1313. length uint32
  1314. sendAsSticker bool
  1315. }
  1316. func (portal *Portal) uploadWithRetry(intent *appservice.IntentAPI, data []byte, mimeType string, retries int) (*mautrix.RespMediaUpload, error) {
  1317. for ;;retries-- {
  1318. uploaded, err := intent.UploadBytes(data, mimeType)
  1319. if isGatewayError(err) {
  1320. portal.log.Warnfln("Got gateway error trying to upload media, retrying in %d seconds", int(BadGatewaySleep.Seconds()))
  1321. time.Sleep(BadGatewaySleep)
  1322. } else {
  1323. return uploaded, err
  1324. }
  1325. }
  1326. }
  1327. func (portal *Portal) HandleMediaMessage(source *User, msg mediaMessage) {
  1328. intent := portal.startHandling(source, msg.info)
  1329. if intent == nil {
  1330. return
  1331. }
  1332. data, err := msg.download()
  1333. if err == whatsapp.ErrMediaDownloadFailedWith404 || err == whatsapp.ErrMediaDownloadFailedWith410 {
  1334. portal.log.Warnfln("Failed to download media for %s: %v. Calling LoadMediaInfo and retrying download...", msg.info.Id, err)
  1335. _, err = source.Conn.LoadMediaInfo(msg.info.RemoteJid, msg.info.Id, msg.info.FromMe)
  1336. if err != nil {
  1337. portal.sendMediaBridgeFailure(source, intent, msg.info, fmt.Errorf("failed to load media info: %w", err))
  1338. return
  1339. }
  1340. data, err = msg.download()
  1341. }
  1342. if err == whatsapp.ErrNoURLPresent {
  1343. portal.log.Debugfln("No URL present error for media message %s, ignoring...", msg.info.Id)
  1344. return
  1345. } else if err != nil {
  1346. portal.sendMediaBridgeFailure(source, intent, msg.info, err)
  1347. return
  1348. }
  1349. var width, height int
  1350. if strings.HasPrefix(msg.mimeType, "image/") {
  1351. cfg, _, _ := image.DecodeConfig(bytes.NewReader(data))
  1352. width, height = cfg.Width, cfg.Height
  1353. }
  1354. data, uploadMimeType, file := portal.encryptFile(data, msg.mimeType)
  1355. uploaded, err := portal.uploadWithRetry(intent, data, uploadMimeType, MediaUploadRetries)
  1356. if err != nil {
  1357. if errors.Is(err, mautrix.MTooLarge) {
  1358. portal.sendMediaBridgeFailure(source, intent, msg.info, errors.New("homeserver rejected too large file"))
  1359. } else if httpErr := err.(mautrix.HTTPError); httpErr.IsStatus(413) {
  1360. portal.sendMediaBridgeFailure(source, intent, msg.info, errors.New("proxy rejected too large file"))
  1361. } else {
  1362. portal.sendMediaBridgeFailure(source, intent, msg.info, fmt.Errorf("failed to upload media: %w", err))
  1363. }
  1364. return
  1365. }
  1366. if msg.fileName == "" {
  1367. mimeClass := strings.Split(msg.mimeType, "/")[0]
  1368. switch mimeClass {
  1369. case "application":
  1370. msg.fileName = "file"
  1371. default:
  1372. msg.fileName = mimeClass
  1373. }
  1374. exts, _ := mime.ExtensionsByType(msg.mimeType)
  1375. if exts != nil && len(exts) > 0 {
  1376. msg.fileName += exts[0]
  1377. }
  1378. }
  1379. content := &event.MessageEventContent{
  1380. Body: msg.fileName,
  1381. File: file,
  1382. Info: &event.FileInfo{
  1383. Size: len(data),
  1384. MimeType: msg.mimeType,
  1385. Width: width,
  1386. Height: height,
  1387. Duration: int(msg.length),
  1388. },
  1389. }
  1390. if content.File != nil {
  1391. content.File.URL = uploaded.ContentURI.CUString()
  1392. } else {
  1393. content.URL = uploaded.ContentURI.CUString()
  1394. }
  1395. portal.SetReply(content, msg.context)
  1396. if msg.thumbnail != nil && portal.bridge.Config.Bridge.WhatsappThumbnail {
  1397. thumbnailMime := http.DetectContentType(msg.thumbnail)
  1398. thumbnailCfg, _, _ := image.DecodeConfig(bytes.NewReader(msg.thumbnail))
  1399. thumbnailSize := len(msg.thumbnail)
  1400. thumbnail, thumbnailUploadMime, thumbnailFile := portal.encryptFile(msg.thumbnail, thumbnailMime)
  1401. uploadedThumbnail, err := intent.UploadBytes(thumbnail, thumbnailUploadMime)
  1402. if err != nil {
  1403. portal.log.Warnfln("Failed to upload thumbnail for %s: %v", msg.info.Id, err)
  1404. } else if uploadedThumbnail != nil {
  1405. if thumbnailFile != nil {
  1406. thumbnailFile.URL = uploadedThumbnail.ContentURI.CUString()
  1407. content.Info.ThumbnailFile = thumbnailFile
  1408. } else {
  1409. content.Info.ThumbnailURL = uploadedThumbnail.ContentURI.CUString()
  1410. }
  1411. content.Info.ThumbnailInfo = &event.FileInfo{
  1412. Size: thumbnailSize,
  1413. Width: thumbnailCfg.Width,
  1414. Height: thumbnailCfg.Height,
  1415. MimeType: thumbnailMime,
  1416. }
  1417. }
  1418. }
  1419. switch strings.ToLower(strings.Split(msg.mimeType, "/")[0]) {
  1420. case "image":
  1421. if !msg.sendAsSticker {
  1422. content.MsgType = event.MsgImage
  1423. }
  1424. case "video":
  1425. content.MsgType = event.MsgVideo
  1426. case "audio":
  1427. content.MsgType = event.MsgAudio
  1428. default:
  1429. content.MsgType = event.MsgFile
  1430. }
  1431. _, _ = intent.UserTyping(portal.MXID, false, 0)
  1432. ts := int64(msg.info.Timestamp * 1000)
  1433. eventType := event.EventMessage
  1434. if msg.sendAsSticker {
  1435. eventType = event.EventSticker
  1436. }
  1437. resp, err := portal.sendMessage(intent, eventType, content, ts)
  1438. if err != nil {
  1439. portal.log.Errorfln("Failed to handle message %s: %v", msg.info.Id, err)
  1440. return
  1441. }
  1442. if len(msg.caption) > 0 {
  1443. captionContent := &event.MessageEventContent{
  1444. Body: msg.caption,
  1445. MsgType: event.MsgNotice,
  1446. }
  1447. portal.bridge.Formatter.ParseWhatsApp(captionContent, msg.context.MentionedJID)
  1448. _, err := portal.sendMessage(intent, event.EventMessage, captionContent, ts)
  1449. if err != nil {
  1450. portal.log.Warnfln("Failed to handle caption of message %s: %v", msg.info.Id, err)
  1451. }
  1452. // TODO store caption mxid?
  1453. }
  1454. portal.finishHandling(source, msg.info.Source, resp.EventID)
  1455. }
  1456. func makeMessageID() *string {
  1457. b := make([]byte, 10)
  1458. rand.Read(b)
  1459. str := strings.ToUpper(hex.EncodeToString(b))
  1460. return &str
  1461. }
  1462. func (portal *Portal) downloadThumbnail(content *event.MessageEventContent, id id.EventID) []byte {
  1463. if len(content.GetInfo().ThumbnailURL) == 0 {
  1464. return nil
  1465. }
  1466. mxc, err := content.GetInfo().ThumbnailURL.Parse()
  1467. if err != nil {
  1468. portal.log.Errorln("Malformed thumbnail URL in %s: %v", id, err)
  1469. }
  1470. thumbnail, err := portal.MainIntent().DownloadBytes(mxc)
  1471. if err != nil {
  1472. portal.log.Errorln("Failed to download thumbnail in %s: %v", id, err)
  1473. return nil
  1474. }
  1475. thumbnailType := http.DetectContentType(thumbnail)
  1476. var img image.Image
  1477. switch thumbnailType {
  1478. case "image/png":
  1479. img, err = png.Decode(bytes.NewReader(thumbnail))
  1480. case "image/gif":
  1481. img, err = gif.Decode(bytes.NewReader(thumbnail))
  1482. case "image/jpeg":
  1483. return thumbnail
  1484. default:
  1485. return nil
  1486. }
  1487. var buf bytes.Buffer
  1488. err = jpeg.Encode(&buf, img, &jpeg.Options{
  1489. Quality: jpeg.DefaultQuality,
  1490. })
  1491. if err != nil {
  1492. portal.log.Errorln("Failed to re-encode thumbnail in %s: %v", id, err)
  1493. return nil
  1494. }
  1495. return buf.Bytes()
  1496. }
  1497. func (portal *Portal) convertGifToVideo(gif []byte) ([]byte, error) {
  1498. dir, err := ioutil.TempDir("", "gif-convert-*")
  1499. if err != nil {
  1500. return nil, fmt.Errorf("failed to make temp dir: %w", err)
  1501. }
  1502. defer os.RemoveAll(dir)
  1503. inputFile, err := os.OpenFile(filepath.Join(dir, "input.gif"), os.O_CREATE|os.O_EXCL|os.O_WRONLY, 0600)
  1504. if err != nil {
  1505. return nil, fmt.Errorf("failed open input file: %w", err)
  1506. }
  1507. _, err = inputFile.Write(gif)
  1508. if err != nil {
  1509. _ = inputFile.Close()
  1510. return nil, fmt.Errorf("failed to write gif to input file: %w", err)
  1511. }
  1512. _ = inputFile.Close()
  1513. outputFileName := filepath.Join(dir, "output.mp4")
  1514. cmd := exec.Command("ffmpeg", "-hide_banner", "-loglevel", "warning",
  1515. "-f", "gif", "-i", inputFile.Name(),
  1516. "-pix_fmt", "yuv420p", "-c:v", "libx264", "-movflags", "+faststart",
  1517. "-filter:v", "crop='floor(in_w/2)*2:floor(in_h/2)*2'",
  1518. outputFileName)
  1519. vcLog := portal.log.Sub("VideoConverter").WithDefaultLevel(log.LevelWarn)
  1520. cmd.Stdout = vcLog
  1521. cmd.Stderr = vcLog
  1522. err = cmd.Run()
  1523. if err != nil {
  1524. return nil, fmt.Errorf("failed to run ffmpeg: %w", err)
  1525. }
  1526. outputFile, err := os.OpenFile(filepath.Join(dir, "output.mp4"), os.O_RDONLY, 0)
  1527. if err != nil {
  1528. return nil, fmt.Errorf("failed to open output file: %w", err)
  1529. }
  1530. defer func() {
  1531. _ = outputFile.Close()
  1532. _ = os.Remove(outputFile.Name())
  1533. }()
  1534. mp4, err := ioutil.ReadAll(outputFile)
  1535. if err != nil {
  1536. return nil, fmt.Errorf("failed to read mp4 from output file: %w", err)
  1537. }
  1538. return mp4, nil
  1539. }
  1540. func (portal *Portal) preprocessMatrixMedia(sender *User, relaybotFormatted bool, content *event.MessageEventContent, eventID id.EventID, mediaType whatsapp.MediaType) *MediaUpload {
  1541. var caption string
  1542. var mentionedJIDs []types.WhatsAppID
  1543. if relaybotFormatted {
  1544. caption, mentionedJIDs = portal.bridge.Formatter.ParseMatrix(content.FormattedBody)
  1545. }
  1546. var file *event.EncryptedFileInfo
  1547. rawMXC := content.URL
  1548. if content.File != nil {
  1549. file = content.File
  1550. rawMXC = file.URL
  1551. }
  1552. mxc, err := rawMXC.Parse()
  1553. if err != nil {
  1554. portal.log.Errorln("Malformed content URL in %s: %v", eventID, err)
  1555. return nil
  1556. }
  1557. data, err := portal.MainIntent().DownloadBytes(mxc)
  1558. if err != nil {
  1559. portal.log.Errorfln("Failed to download media in %s: %v", eventID, err)
  1560. return nil
  1561. }
  1562. if file != nil {
  1563. data, err = file.Decrypt(data)
  1564. if err != nil {
  1565. portal.log.Errorfln("Failed to decrypt media in %s: %v", eventID, err)
  1566. return nil
  1567. }
  1568. }
  1569. if mediaType == whatsapp.MediaVideo && content.GetInfo().MimeType == "image/gif" {
  1570. data, err = portal.convertGifToVideo(data)
  1571. if err != nil {
  1572. portal.log.Errorfln("Failed to convert gif to mp4 in %s: %v", eventID, err)
  1573. return nil
  1574. }
  1575. content.Info.MimeType = "video/mp4"
  1576. }
  1577. url, mediaKey, fileEncSHA256, fileSHA256, fileLength, err := sender.Conn.Upload(bytes.NewReader(data), mediaType)
  1578. if err != nil {
  1579. portal.log.Errorfln("Failed to upload media in %s: %v", eventID, err)
  1580. return nil
  1581. }
  1582. return &MediaUpload{
  1583. Caption: caption,
  1584. MentionedJIDs: mentionedJIDs,
  1585. URL: url,
  1586. MediaKey: mediaKey,
  1587. FileEncSHA256: fileEncSHA256,
  1588. FileSHA256: fileSHA256,
  1589. FileLength: fileLength,
  1590. Thumbnail: portal.downloadThumbnail(content, eventID),
  1591. }
  1592. }
  1593. type MediaUpload struct {
  1594. Caption string
  1595. MentionedJIDs []types.WhatsAppID
  1596. URL string
  1597. MediaKey []byte
  1598. FileEncSHA256 []byte
  1599. FileSHA256 []byte
  1600. FileLength uint64
  1601. Thumbnail []byte
  1602. }
  1603. func (portal *Portal) sendMatrixConnectionError(sender *User, eventID id.EventID) bool {
  1604. if !sender.HasSession() {
  1605. portal.log.Debugln("Ignoring event", eventID, "from", sender.MXID, "as user has no session")
  1606. return true
  1607. } else if !sender.IsConnected() {
  1608. portal.log.Debugln("Ignoring event", eventID, "from", sender.MXID, "as user is not connected")
  1609. inRoom := ""
  1610. if portal.IsPrivateChat() {
  1611. inRoom = " in your management room"
  1612. }
  1613. reconnect := fmt.Sprintf("Use `%s reconnect`%s to reconnect.", portal.bridge.Config.Bridge.CommandPrefix, inRoom)
  1614. if sender.IsLoginInProgress() {
  1615. reconnect = "You have a login attempt in progress, please wait."
  1616. }
  1617. msg := format.RenderMarkdown("\u26a0 You are not connected to WhatsApp, so your message was not bridged. "+reconnect, true, false)
  1618. msg.MsgType = event.MsgNotice
  1619. _, err := portal.sendMainIntentMessage(msg)
  1620. if err != nil {
  1621. portal.log.Errorln("Failed to send bridging failure message:", err)
  1622. }
  1623. return true
  1624. }
  1625. return false
  1626. }
  1627. func (portal *Portal) addRelaybotFormat(sender *User, content *event.MessageEventContent) bool {
  1628. member := portal.MainIntent().Member(portal.MXID, sender.MXID)
  1629. if len(member.Displayname) == 0 {
  1630. member.Displayname = string(sender.MXID)
  1631. }
  1632. if content.Format != event.FormatHTML {
  1633. content.FormattedBody = strings.Replace(html.EscapeString(content.Body), "\n", "<br/>", -1)
  1634. content.Format = event.FormatHTML
  1635. }
  1636. data, err := portal.bridge.Config.Bridge.Relaybot.FormatMessage(content, sender.MXID, member)
  1637. if err != nil {
  1638. portal.log.Errorln("Failed to apply relaybot format:", err)
  1639. }
  1640. content.FormattedBody = data
  1641. return true
  1642. }
  1643. func (portal *Portal) convertMatrixMessage(sender *User, evt *event.Event) (*waProto.WebMessageInfo, *User) {
  1644. content, ok := evt.Content.Parsed.(*event.MessageEventContent)
  1645. if !ok {
  1646. portal.log.Debugfln("Failed to handle event %s: unexpected parsed content type %T", evt.ID, evt.Content.Parsed)
  1647. return nil, sender
  1648. }
  1649. ts := uint64(evt.Timestamp / 1000)
  1650. status := waProto.WebMessageInfo_ERROR
  1651. fromMe := true
  1652. info := &waProto.WebMessageInfo{
  1653. Key: &waProto.MessageKey{
  1654. FromMe: &fromMe,
  1655. Id: makeMessageID(),
  1656. RemoteJid: &portal.Key.JID,
  1657. },
  1658. MessageTimestamp: &ts,
  1659. Message: &waProto.Message{},
  1660. Status: &status,
  1661. }
  1662. ctxInfo := &waProto.ContextInfo{}
  1663. replyToID := content.GetReplyTo()
  1664. if len(replyToID) > 0 {
  1665. content.RemoveReplyFallback()
  1666. msg := portal.bridge.DB.Message.GetByMXID(replyToID)
  1667. if msg != nil && msg.Content != nil {
  1668. ctxInfo.StanzaId = &msg.JID
  1669. ctxInfo.Participant = &msg.Sender
  1670. ctxInfo.QuotedMessage = msg.Content
  1671. }
  1672. }
  1673. relaybotFormatted := false
  1674. if sender.NeedsRelaybot(portal) {
  1675. if !portal.HasRelaybot() {
  1676. if sender.HasSession() {
  1677. portal.log.Debugln("Database says", sender.MXID, "not in chat and no relaybot, but trying to send anyway")
  1678. } else {
  1679. portal.log.Debugln("Ignoring message from", sender.MXID, "in chat with no relaybot")
  1680. return nil, sender
  1681. }
  1682. } else {
  1683. relaybotFormatted = portal.addRelaybotFormat(sender, content)
  1684. sender = portal.bridge.Relaybot
  1685. }
  1686. }
  1687. if evt.Type == event.EventSticker {
  1688. content.MsgType = event.MsgImage
  1689. } else if content.MsgType == event.MsgImage && content.GetInfo().MimeType == "image/gif" {
  1690. content.MsgType = event.MsgVideo
  1691. }
  1692. switch content.MsgType {
  1693. case event.MsgText, event.MsgEmote, event.MsgNotice:
  1694. text := content.Body
  1695. if content.Format == event.FormatHTML {
  1696. text, ctxInfo.MentionedJid = portal.bridge.Formatter.ParseMatrix(content.FormattedBody)
  1697. }
  1698. if content.MsgType == event.MsgEmote && !relaybotFormatted {
  1699. text = "/me " + text
  1700. }
  1701. if ctxInfo.StanzaId != nil || ctxInfo.MentionedJid != nil {
  1702. info.Message.ExtendedTextMessage = &waProto.ExtendedTextMessage{
  1703. Text: &text,
  1704. ContextInfo: ctxInfo,
  1705. }
  1706. } else {
  1707. info.Message.Conversation = &text
  1708. }
  1709. case event.MsgImage:
  1710. media := portal.preprocessMatrixMedia(sender, relaybotFormatted, content, evt.ID, whatsapp.MediaImage)
  1711. if media == nil {
  1712. return nil, sender
  1713. }
  1714. ctxInfo.MentionedJid = media.MentionedJIDs
  1715. info.Message.ImageMessage = &waProto.ImageMessage{
  1716. ContextInfo: ctxInfo,
  1717. Caption: &media.Caption,
  1718. JpegThumbnail: media.Thumbnail,
  1719. Url: &media.URL,
  1720. MediaKey: media.MediaKey,
  1721. Mimetype: &content.GetInfo().MimeType,
  1722. FileEncSha256: media.FileEncSHA256,
  1723. FileSha256: media.FileSHA256,
  1724. FileLength: &media.FileLength,
  1725. }
  1726. case event.MsgVideo:
  1727. gifPlayback := content.GetInfo().MimeType == "image/gif"
  1728. media := portal.preprocessMatrixMedia(sender, relaybotFormatted, content, evt.ID, whatsapp.MediaVideo)
  1729. if media == nil {
  1730. return nil, sender
  1731. }
  1732. duration := uint32(content.GetInfo().Duration)
  1733. ctxInfo.MentionedJid = media.MentionedJIDs
  1734. info.Message.VideoMessage = &waProto.VideoMessage{
  1735. ContextInfo: ctxInfo,
  1736. Caption: &media.Caption,
  1737. JpegThumbnail: media.Thumbnail,
  1738. Url: &media.URL,
  1739. MediaKey: media.MediaKey,
  1740. Mimetype: &content.GetInfo().MimeType,
  1741. GifPlayback: &gifPlayback,
  1742. Seconds: &duration,
  1743. FileEncSha256: media.FileEncSHA256,
  1744. FileSha256: media.FileSHA256,
  1745. FileLength: &media.FileLength,
  1746. }
  1747. case event.MsgAudio:
  1748. media := portal.preprocessMatrixMedia(sender, relaybotFormatted, content, evt.ID, whatsapp.MediaAudio)
  1749. if media == nil {
  1750. return nil, sender
  1751. }
  1752. duration := uint32(content.GetInfo().Duration)
  1753. info.Message.AudioMessage = &waProto.AudioMessage{
  1754. ContextInfo: ctxInfo,
  1755. Url: &media.URL,
  1756. MediaKey: media.MediaKey,
  1757. Mimetype: &content.GetInfo().MimeType,
  1758. Seconds: &duration,
  1759. FileEncSha256: media.FileEncSHA256,
  1760. FileSha256: media.FileSHA256,
  1761. FileLength: &media.FileLength,
  1762. }
  1763. case event.MsgFile:
  1764. media := portal.preprocessMatrixMedia(sender, relaybotFormatted, content, evt.ID, whatsapp.MediaDocument)
  1765. if media == nil {
  1766. return nil, sender
  1767. }
  1768. info.Message.DocumentMessage = &waProto.DocumentMessage{
  1769. ContextInfo: ctxInfo,
  1770. Url: &media.URL,
  1771. Title: &content.Body,
  1772. FileName: &content.Body,
  1773. MediaKey: media.MediaKey,
  1774. Mimetype: &content.GetInfo().MimeType,
  1775. FileEncSha256: media.FileEncSHA256,
  1776. FileSha256: media.FileSHA256,
  1777. FileLength: &media.FileLength,
  1778. }
  1779. default:
  1780. portal.log.Debugln("Unhandled Matrix event %s: unknown msgtype %s", evt.ID, content.MsgType)
  1781. return nil, sender
  1782. }
  1783. return info, sender
  1784. }
  1785. func (portal *Portal) wasMessageSent(sender *User, id string) bool {
  1786. _, err := sender.Conn.LoadMessagesAfter(portal.Key.JID, id, true, 0)
  1787. if err != nil {
  1788. if err != whatsapp.ErrServerRespondedWith404 {
  1789. portal.log.Warnfln("Failed to check if message was bridged without response: %v", err)
  1790. }
  1791. return false
  1792. }
  1793. return true
  1794. }
  1795. func (portal *Portal) sendErrorMessage(message string) id.EventID {
  1796. resp, err := portal.sendMainIntentMessage(event.MessageEventContent{
  1797. MsgType: event.MsgNotice,
  1798. Body: fmt.Sprintf("\u26a0 Your message may not have been bridged: %v", message),
  1799. })
  1800. if err != nil {
  1801. portal.log.Warnfln("Failed to send bridging error message:", err)
  1802. return ""
  1803. }
  1804. return resp.EventID
  1805. }
  1806. func (portal *Portal) sendDeliveryReceipt(eventID id.EventID) {
  1807. if portal.bridge.Config.Bridge.DeliveryReceipts {
  1808. err := portal.bridge.Bot.MarkRead(portal.MXID, eventID)
  1809. if err != nil {
  1810. portal.log.Debugfln("Failed to send delivery receipt for %s: %v", eventID, err)
  1811. }
  1812. }
  1813. }
  1814. var timeout = errors.New("message sending timed out")
  1815. func (portal *Portal) HandleMatrixMessage(sender *User, evt *event.Event) {
  1816. if !portal.HasRelaybot() && (
  1817. (portal.IsPrivateChat() && sender.JID != portal.Key.Receiver) ||
  1818. portal.sendMatrixConnectionError(sender, evt.ID)) {
  1819. return
  1820. }
  1821. portal.log.Debugfln("Received event %s", evt.ID)
  1822. info, sender := portal.convertMatrixMessage(sender, evt)
  1823. if info == nil {
  1824. return
  1825. }
  1826. portal.markHandled(sender, info, evt.ID)
  1827. portal.log.Debugln("Sending event", evt.ID, "to WhatsApp", info.Key.GetId())
  1828. portal.sendRaw(sender, evt, info, false)
  1829. }
  1830. func (portal *Portal) sendRaw(sender *User, evt *event.Event, info *waProto.WebMessageInfo, isRetry bool) {
  1831. errChan := make(chan error, 1)
  1832. go sender.Conn.SendRaw(info, errChan)
  1833. var err error
  1834. var errorEventID id.EventID
  1835. select {
  1836. case err = <-errChan:
  1837. var statusResp whatsapp.StatusResponse
  1838. if !isRetry && errors.As(err, &statusResp) && statusResp.Status == 599 {
  1839. portal.log.Debugfln("599 status response sending %s to WhatsApp (%+v), retrying...", evt.ID, statusResp)
  1840. errorEventID = portal.sendErrorMessage(fmt.Sprintf("%v. The bridge will retry in 5 seconds.", err))
  1841. time.Sleep(5 * time.Second)
  1842. portal.sendRaw(sender, evt, info, true)
  1843. }
  1844. case <-time.After(time.Duration(portal.bridge.Config.Bridge.ConnectionTimeout) * time.Second):
  1845. if portal.bridge.Config.Bridge.FetchMessageOnTimeout && portal.wasMessageSent(sender, info.Key.GetId()) {
  1846. portal.log.Debugln("Matrix event %s was bridged, but response didn't arrive within timeout")
  1847. portal.sendDeliveryReceipt(evt.ID)
  1848. } else {
  1849. portal.log.Warnfln("Response when bridging Matrix event %s is taking long to arrive", evt.ID)
  1850. errorEventID = portal.sendErrorMessage(timeout.Error())
  1851. }
  1852. err = <-errChan
  1853. }
  1854. if err != nil {
  1855. portal.log.Errorfln("Error handling Matrix event %s: %v", evt.ID, err)
  1856. var statusResp whatsapp.StatusResponse
  1857. if errors.As(err, &statusResp) && statusResp.Status == 599 {
  1858. portal.log.Debugfln("599 status response data: %+v", statusResp)
  1859. }
  1860. portal.sendErrorMessage(err.Error())
  1861. } else {
  1862. portal.log.Debugfln("Handled Matrix event %s", evt.ID)
  1863. portal.sendDeliveryReceipt(evt.ID)
  1864. }
  1865. if errorEventID != "" {
  1866. _, err = portal.MainIntent().RedactEvent(portal.MXID, errorEventID)
  1867. if err != nil {
  1868. portal.log.Warnfln("Failed to redact timeout warning message %s: %v", errorEventID, err)
  1869. }
  1870. }
  1871. }
  1872. func (portal *Portal) HandleMatrixRedaction(sender *User, evt *event.Event) {
  1873. if portal.IsPrivateChat() && sender.JID != portal.Key.Receiver {
  1874. return
  1875. }
  1876. msg := portal.bridge.DB.Message.GetByMXID(evt.Redacts)
  1877. if msg == nil || msg.Sender != sender.JID {
  1878. return
  1879. }
  1880. ts := uint64(evt.Timestamp / 1000)
  1881. status := waProto.WebMessageInfo_PENDING
  1882. protoMsgType := waProto.ProtocolMessage_REVOKE
  1883. fromMe := true
  1884. info := &waProto.WebMessageInfo{
  1885. Key: &waProto.MessageKey{
  1886. FromMe: &fromMe,
  1887. Id: makeMessageID(),
  1888. RemoteJid: &portal.Key.JID,
  1889. },
  1890. MessageTimestamp: &ts,
  1891. Message: &waProto.Message{
  1892. ProtocolMessage: &waProto.ProtocolMessage{
  1893. Type: &protoMsgType,
  1894. Key: &waProto.MessageKey{
  1895. FromMe: &fromMe,
  1896. Id: &msg.JID,
  1897. RemoteJid: &portal.Key.JID,
  1898. },
  1899. },
  1900. },
  1901. Status: &status,
  1902. }
  1903. errChan := make(chan error, 1)
  1904. go sender.Conn.SendRaw(info, errChan)
  1905. var err error
  1906. select {
  1907. case err = <-errChan:
  1908. case <-time.After(time.Duration(portal.bridge.Config.Bridge.ConnectionTimeout) * time.Second):
  1909. portal.log.Warnfln("Response when bridging Matrix redaction %s is taking long to arrive", evt.ID)
  1910. err = <-errChan
  1911. }
  1912. if err != nil {
  1913. portal.log.Errorfln("Error handling Matrix redaction %s: %v", evt.ID, err)
  1914. } else {
  1915. portal.log.Debugln("Handled Matrix redaction %s of %s", evt.ID, evt.Redacts)
  1916. portal.sendDeliveryReceipt(evt.ID)
  1917. }
  1918. }
  1919. func (portal *Portal) Delete() {
  1920. portal.Portal.Delete()
  1921. portal.bridge.portalsLock.Lock()
  1922. delete(portal.bridge.portalsByJID, portal.Key)
  1923. if len(portal.MXID) > 0 {
  1924. delete(portal.bridge.portalsByMXID, portal.MXID)
  1925. }
  1926. portal.bridge.portalsLock.Unlock()
  1927. }
  1928. func (portal *Portal) GetMatrixUsers() ([]id.UserID, error) {
  1929. members, err := portal.MainIntent().JoinedMembers(portal.MXID)
  1930. if err != nil {
  1931. return nil, fmt.Errorf("failed to get member list: %w", err)
  1932. }
  1933. var users []id.UserID
  1934. for userID := range members.Joined {
  1935. _, isPuppet := portal.bridge.ParsePuppetMXID(userID)
  1936. if !isPuppet && userID != portal.bridge.Bot.UserID {
  1937. users = append(users, userID)
  1938. }
  1939. }
  1940. return users, nil
  1941. }
  1942. func (portal *Portal) CleanupIfEmpty() {
  1943. users, err := portal.GetMatrixUsers()
  1944. if err != nil {
  1945. portal.log.Errorfln("Failed to get Matrix user list to determine if portal needs to be cleaned up: %v", err)
  1946. return
  1947. }
  1948. if len(users) == 0 {
  1949. portal.log.Infoln("Room seems to be empty, cleaning up...")
  1950. portal.Delete()
  1951. portal.Cleanup(false)
  1952. }
  1953. }
  1954. func (portal *Portal) Cleanup(puppetsOnly bool) {
  1955. if len(portal.MXID) == 0 {
  1956. return
  1957. }
  1958. if portal.IsPrivateChat() {
  1959. _, err := portal.MainIntent().LeaveRoom(portal.MXID)
  1960. if err != nil {
  1961. portal.log.Warnln("Failed to leave private chat portal with main intent:", err)
  1962. }
  1963. return
  1964. }
  1965. intent := portal.MainIntent()
  1966. members, err := intent.JoinedMembers(portal.MXID)
  1967. if err != nil {
  1968. portal.log.Errorln("Failed to get portal members for cleanup:", err)
  1969. return
  1970. }
  1971. for member := range members.Joined {
  1972. if member == intent.UserID {
  1973. continue
  1974. }
  1975. puppet := portal.bridge.GetPuppetByMXID(member)
  1976. if puppet != nil {
  1977. _, err = puppet.DefaultIntent().LeaveRoom(portal.MXID)
  1978. if err != nil {
  1979. portal.log.Errorln("Error leaving as puppet while cleaning up portal:", err)
  1980. }
  1981. } else if !puppetsOnly {
  1982. _, err = intent.KickUser(portal.MXID, &mautrix.ReqKickUser{UserID: member, Reason: "Deleting portal"})
  1983. if err != nil {
  1984. portal.log.Errorln("Error kicking user while cleaning up portal:", err)
  1985. }
  1986. }
  1987. }
  1988. _, err = intent.LeaveRoom(portal.MXID)
  1989. if err != nil {
  1990. portal.log.Errorln("Error leaving with main intent while cleaning up portal:", err)
  1991. }
  1992. }
  1993. func (portal *Portal) HandleMatrixLeave(sender *User) {
  1994. if portal.IsPrivateChat() {
  1995. portal.log.Debugln("User left private chat portal, cleaning up and deleting...")
  1996. portal.Delete()
  1997. portal.Cleanup(false)
  1998. return
  1999. } else {
  2000. // TODO should we somehow deduplicate this call if this leave was sent by the bridge?
  2001. resp, err := sender.Conn.LeaveGroup(portal.Key.JID)
  2002. if err != nil {
  2003. portal.log.Errorfln("Failed to leave group as %s: %v", sender.MXID, err)
  2004. return
  2005. }
  2006. portal.log.Infoln("Leave response:", <-resp)
  2007. portal.CleanupIfEmpty()
  2008. }
  2009. }
  2010. func (portal *Portal) HandleMatrixKick(sender *User, evt *event.Event) {
  2011. puppet := portal.bridge.GetPuppetByMXID(id.UserID(evt.GetStateKey()))
  2012. if puppet != nil {
  2013. resp, err := sender.Conn.RemoveMember(portal.Key.JID, []string{puppet.JID})
  2014. if err != nil {
  2015. portal.log.Errorfln("Failed to kick %s from group as %s: %v", puppet.JID, sender.MXID, err)
  2016. return
  2017. }
  2018. portal.log.Infoln("Kick %s response: %s", puppet.JID, <-resp)
  2019. }
  2020. }
  2021. func (portal *Portal) HandleMatrixInvite(sender *User, evt *event.Event) {
  2022. puppet := portal.bridge.GetPuppetByMXID(id.UserID(evt.GetStateKey()))
  2023. if puppet != nil {
  2024. resp, err := sender.Conn.AddMember(portal.Key.JID, []string{puppet.JID})
  2025. if err != nil {
  2026. portal.log.Errorfln("Failed to add %s to group as %s: %v", puppet.JID, sender.MXID, err)
  2027. return
  2028. }
  2029. portal.log.Infoln("Add %s response: %s", puppet.JID, <-resp)
  2030. }
  2031. }