Skip to content

[HOLD for payment 2022-03-02] Conversation - A single message was sent 100s of times  #7666

Closed

Description

@isagoico

If you haven’t already, check out our contributing guidelines for onboarding and email contributors@expensify.com to request to join our Slack channel!


Action Performed:

  1. Send a message in a conversation

Expected Result:

A single message should be seen in the conversation history.

Actual Result:

100s of repeated messages were sent to the other user.

Workaround:

No need.

Platform:

Where is this issue occurring?

  • Web

Version Number: v1.1.38-1

Reproducible in staging?: Unknown
Reproducible in production?: Yes

Logs: https://stackoverflow.com/c/expensify/questions/4856

Notes/Photos/Videos:

image

Expensify/Expensify Issue URL:

Issue reported by: @tgolen
Slack conversation: https://expensify.slack.com/archives/C01GTK53T8Q/p1644440925115879

View all open jobs on GitHub

Activity

  1. MelvinBot commented on Feb 9, 2022

    @MelvinBot
    Contributor

    Triggered auto assignment to @pecanoro (Engineering), see https://stackoverflow.com/c/expensify/questions/4319 for more details.

  2. conorpendergrast commented on Feb 10, 2022

    @conorpendergrast
    Contributor

    This hit me too, and it was so weird

  3. VictoriaExpensify commented on Feb 10, 2022

    @VictoriaExpensify
    Contributor

    The same issue happened with @conorpendergrast this morning:

    image
    It appears that every time he tries to send me a new response, it resends that same message another couple of hundred times:
    image

    Also happened with Conor's 10ams so it seems to be an issue on his end rather than mine:
    image

  4. mallenexpensify commented on Feb 10, 2022

    @mallenexpensify
    Contributor

    Here's logs when it happened to me, also, my steps, since it happened right after I reopened my computer.

    BUG: A message sent while my laptop was closed kept sending a couple dozen times and I got a notification ping for each.
    Action Performed: Had production web open in Chrome, closed lid, opened lid 10-15 mins later
    Expected Result: To see one new message
    Actual Result: Saw ~2 dozen of the same message and got browser notifications for each. It stopped after I sent multiple messages to the user.
    Platforms: web, production, Chrome
    Version Number: v.1.1.37-2
    Screenshots or Videos: in :thred:

    image

  5. StefStavri commented on Feb 10, 2022

    @StefStavri

    Also happened to @twisterdotcom and I at 12:25 UTC (i kept getting notification after notification for the same line)

    image

    Can't make it stop by closing the app and restarting unfortunately.

  6. twisterdotcom commented on Feb 10, 2022

    @twisterdotcom
    Contributor

    I first sent that message to Stef at Today at 12:18 PM UTC according to my desktop app (which isn't experiencing this)
    image

  7. twisterdotcom commented on Feb 10, 2022

    @twisterdotcom
    Contributor

    Happened when I next sent a message to @muttmuure and then my test account pecan@expensivepie.com
    File

    Desktop, endless errors but no repeating message:
    https://user-images.githubusercontent.com/9133401/153413258-3a65a126-9ba1-4683-824f-078227244ba4.mp4

    Basically endless:

    Access to fetch at 'https://www.expensify.com/api?command=Log' from origin 'app://-' has been blocked by CORS policy: No 'Access-Control-Allow-Origin' header is present on the requested resource. If an opaque response serves your needs, set the request's mode to 'no-cors' to fetch the resource with CORS disabled.
    HttpUtils.js:23          POST https://www.expensify.com/api?command=Log net::ERR_FAILED 200
    

    Mobile vid:
    Still trying to get it off my phone

    Logs from the recipient:
    image

    One such log: 6db5746a0dfa76f9-SAN

    64/64hits @0.2670s - ASC order - request_id:("6db5746a0dfa76f9-SAN") AND timestamp:[2022-02-10T11:48:58.143Z TO 2022-02-10T13:48:58.143Z]
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 140	pecan@expensivepie.com	 PID ~~ 3068045
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 141	pecan@expensivepie.com	 Processing 'Log' for 'expensify.com' from '89.240.137.71' ~~ accountID: '8698376' authToken: '<REDACTED>' email: 'pecan@expensivepie.com' browserGUID: '5fda887ca3ef6' initialReferer: '<REDACTED>' command: 'Log' api_setCookie: 'false' expensifyCashAppVersion: 'expensifyCash[ios]1.1.38-0' referer: 'ecash' partnerName: 'expensify.com'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Previous log requestID ~~ requestID: '6db57426ff6b76f9-DEN' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '82096737' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [LOCAL_NOTIFICATION] Creating notification ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Onyx] set() called for key: report_82096737 properties: reportID,reportName,chatType,ownerEmail,policyID,unreadActionCount,maxSequenceNumber,participants,isPinned,lastVisitedTimestamp,lastMessageTimestamp,lastMessageText,lastActorEmail,hasOutstandingIOU,notificationPreference,stateNum,statusNum,oldPolicyName,iouReportID,icons,optimisticReportActionIDs,visibility,newMarkerSequenceNumber ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Onyx] set() called for key: reportActions_82096737 properties: 0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56 ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '82096737' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [LOCAL_NOTIFICATION] Creating notification ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Onyx] set() called for key: report_82096737 properties: reportID,reportName,chatType,ownerEmail,policyID,unreadActionCount,maxSequenceNumber,participants,isPinned,lastVisitedTimestamp,lastMessageTimestamp,lastMessageText,lastActorEmail,hasOutstandingIOU,notificationPreference,stateNum,statusNum,oldPolicyName,iouReportID,icons,optimisticReportActionIDs,visibility,newMarkerSequenceNumber ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Onyx] set() called for key: reportActions_82096737 properties: 0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57 ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [NetworkConnection] Firing reconnection callbacks because app became active ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Onyx] set() called for key: isLoadingAfterReconnect ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'personalDetailsList' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Onyx] set() called for key: isLoadingReportData ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'chatList' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Making API request ~~ command: 'Report_UpdateLastRead' type: 'post' shouldUseSecure: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Onyx] set() called for key: report_82096737 properties: reportID,reportName,chatType,ownerEmail,policyID,unreadActionCount,maxSequenceNumber,participants,isPinned,lastVisitedTimestamp,lastMessageTimestamp,lastMessageText,lastActorEmail,hasOutstandingIOU,notificationPreference,stateNum,statusNum,oldPolicyName,iouReportID,icons,optimisticReportActionIDs,visibility,newMarkerSequenceNumber ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Finished API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' jsonCode: '200' requestID: '6db57452fffe76f9-SJC' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Making API request ~~ command: 'Graphite_Timer' type: 'post' shouldUseSecure: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Onyx] set() called for key: personalDetails properties: apple@expensivepie.com,blueberry@expensivepie.com,concierge@expensify.com,custard@expensivepie.com,manager.peeters@expensicorp.com,pecan@expensivepie.com,ted+pie@expensifail.com,ted@expensifail.com,ted@expensify.com,gary@harris.live,ted@harris.live,newdot@harris.live ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Onyx] set() called for key: myPersonalDetails properties: login,avatar,displayName,firstName,lastName,pronouns,timezone,payPalMeAddress,phoneNumber,localCurrencyCode ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Finished API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' jsonCode: '200' requestID: '6db57452f80176f9-SJC' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'reportSummaryList' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Finished API request ~~ command: 'Report_UpdateLastRead' type: 'post' shouldUseSecure: '' jsonCode: '200' requestID: '6db57452f80c76f9-SJC' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Finished API request ~~ command: 'Graphite_Timer' type: 'post' shouldUseSecure: '' jsonCode: '200' requestID: '6db574550c8076f9-LHR' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Finished API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' jsonCode: '200' requestID: '6db574555d2776f9-SJC' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Report] successfully fetched report data ~~ chatList: '[0: '62646273' 1: '64167786' 2: '76810162' 3: '76810163' 4: '76886915' 5: '82079854' 6: '82096737' 7: '82442146']' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Making API request ~~ command: 'GetIOUReport' type: 'post' shouldUseSecure: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Finished API request ~~ command: 'GetIOUReport' type: 'post' shouldUseSecure: '' jsonCode: '200' requestID: '6db57456a87276f9-SJC' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'reportStuff' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Finished API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' jsonCode: '200' requestID: '6db57458bcf176f9-SJC' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Making API request ~~ command: 'PersonalDetails_GetForEmails' type: 'post' shouldUseSecure: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Onyx] set() called for key: initialReportDataLoaded ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] [Onyx] set() called for key: isLoadingReportData ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 142	pecan@expensivepie.com	 [info] Making API request ~~ command: 'CreateChatReport' type: 'post' shouldUseSecure: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] [Onyx] set() called for key: isLoadingAfterReconnect ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] Finished API request ~~ command: 'PersonalDetails_GetForEmails' type: 'post' shouldUseSecure: '' jsonCode: '200' requestID: '6db5745a591176f9-SJC' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] Making API request ~~ command: 'Graphite_Timer' type: 'post' shouldUseSecure: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] [Onyx] set() called for key: personalDetails properties: apple@expensivepie.com,blueberry@expensivepie.com,concierge@expensify.com,custard@expensivepie.com,manager.peeters@expensicorp.com,pecan@expensivepie.com,ted+pie@expensifail.com,ted@expensifail.com,ted@expensify.com,gary@harris.live,ted@harris.live,newdot@harris.live ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '82096737' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] [LOCAL_NOTIFICATION] No notification because it was a comment for the current report ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] [Onyx] set() called for key: report_82096737 properties: reportID,reportName,chatType,ownerEmail,policyID,unreadActionCount,maxSequenceNumber,participants,isPinned,lastVisitedTimestamp,lastMessageTimestamp,lastMessageText,lastActorEmail,hasOutstandingIOU,notificationPreference,stateNum,statusNum,oldPolicyName,iouReportID,icons,optimisticReportActionIDs,visibility,newMarkerSequenceNumber ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] [Onyx] set() called for key: reportActions_82096737 properties: 0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58 ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] Making API request ~~ command: 'Report_UpdateLastRead' type: 'post' shouldUseSecure: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] [Onyx] set() called for key: report_82096737 properties: reportID,reportName,chatType,ownerEmail,policyID,unreadActionCount,maxSequenceNumber,participants,isPinned,lastVisitedTimestamp,lastMessageTimestamp,lastMessageText,lastActorEmail,hasOutstandingIOU,notificationPreference,stateNum,statusNum,oldPolicyName,iouReportID,icons,optimisticReportActionIDs,visibility,newMarkerSequenceNumber ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] Finished API request ~~ command: 'CreateChatReport' type: 'post' shouldUseSecure: '' jsonCode: '200' requestID: '6db5745b6c6576f9-SJC' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] [Onyx] set() called for key: report_62646273 properties: reportID,reportName,chatType,ownerEmail,policyID,unreadActionCount,maxSequenceNumber,participants,isPinned,lastVisitedTimestamp,lastMessageTimestamp,lastMessageText,lastActorEmail,hasOutstandingIOU,notificationPreference,stateNum,statusNum,oldPolicyName,visibility,newMarkerSequenceNumber,icons,optimisticReportActionIDs ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] Finished API request ~~ command: 'Graphite_Timer' type: 'post' shouldUseSecure: '' jsonCode: '200' requestID: '6db5745bcd5c76f9-SJC' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] Finished API request ~~ command: 'Report_UpdateLastRead' type: 'post' shouldUseSecure: '' jsonCode: '200' requestID: '6db5745c5e8176f9-SJC' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] [Report] Local reportActions up to date. Not fetching additional actions. ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '82096737' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 [info] [LOCAL_NOTIFICATION] No notification because it was a comment for the current report ~~ parameters: '' userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 ~~ userAgent: 'New%20Expensify/1.1.38.0 CFNetwork/1331.0.3 Darwin/21.4.0'
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 StoreUtils - Clearing all the stores.
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 TransactionStore cache fully cleared
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 ReportStore cache cleared
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 NVPStore - clear cache
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 NVPStore - clear cache
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 SharedInNVPStore - clear cache
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 ReportDuplicatedTransactionsStore - Cache cleared
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 Profile ~~ {"total":4,"cmd":"Log","jsonCode":200,"output":{"size":71,"gzip":1,"ratio":139},"gzip":71,"PHP":{"total":4,"%":100,"boot":2,"proc":2,"pack":0,"mem":2}}
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 143	pecan@expensivepie.com	 Timing: cmd= Log totalTime= 4 authTotalTime= authRunTime= 0
    6db5746a0dfa76f9-SAN	virt1.lax	2022-02-10 12:48:58 144	
    

    From the sender:
    image

    One example: 6db560f1683b773b-LHR

    48/48hits @0.3550s - ASC order - request_id:("6db560f1683b773b-LHR") AND timestamp:[2022-02-10T11:35:40.547Z TO 2022-02-10T13:35:40.547Z]
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 546	ted@expensify.com	 PID ~~ 497904
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 547	ted@expensify.com	 Processing 'Log' for 'expensify.com' from '89.240.137.71' ~~ command: 'Log' api_setCookie: 'false' expensifyCashAppVersion: 'expensifyCash[desktop]1.1.38-1' referer: 'ecash' email: 'ted@expensify.com' browserGUID: '6205069c85ac8' partnerName: 'expensify.com'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 547	ted@expensify.com	 [info] Making API request ~~ command: 'Report_AddComment' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 547	ted@expensify.com	 [info] Making API request ~~ command: 'Graphite_Timer' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'nameValuePairs' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'nameValuePairs' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'nameValuePairs' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Graphite_Timer' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Graphite_Timer' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'nameValuePairs' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'userWallet' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'account, loginList, nameValuePairs' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'chatList' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'GetRequestCountryCode' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'User_IsFromPublicDomain' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'policySummaryList' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'User_GetBetas' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Report_GetHistory' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Report_GetHistory' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'GetLocalCurrency' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'personalDetailsList' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Report_AddComment' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Graphite_Timer' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Graphite_Timer' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'nameValuePairs' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'nameValuePairs' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Graphite_Timer' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'nameValuePairs' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'nameValuePairs' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'chatList' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 548	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'userWallet' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 [info] Making API request ~~ command: 'GetRequestCountryCode' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 [info] Making API request ~~ command: 'Get' type: 'post' shouldUseSecure: '' rvl: 'policySummaryList' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 [info] Making API request ~~ command: 'GetLocalCurrency' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 [info] Making API request ~~ command: 'User_IsFromPublicDomain' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 [info] Making API request ~~ command: 'User_GetBetas' type: 'post' shouldUseSecure: '' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 [info] Flushing logs as app is going inactive ~~ userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 ~~ userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.38-1 Chrome/98.0.4758.74 Electron/17.0.0 Safari/537.36'
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 StoreUtils - Clearing all the stores.
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 TransactionStore cache fully cleared
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 ReportStore cache cleared
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 NVPStore - clear cache
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 NVPStore - clear cache
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 SharedInNVPStore - clear cache
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 ReportDuplicatedTransactionsStore - Cache cleared
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 Profile ~~ {"total":3,"cmd":"Log","jsonCode":200,"output":{"size":71,"gzip":1,"ratio":139},"gzip":71,"PHP":{"total":3,"%":100,"boot":1,"proc":2,"pack":0,"mem":2}}
    6db560f1683b773b-LHR	virt2.sjc	2022-02-10 12:35:40 549	ted@expensify.com	 Timing: cmd= Log totalTime= 3 authTotalTime= authRunTime= 0
    
  8. tgolen commented on Feb 10, 2022

    @tgolen
    Contributor

    Here were the logs from when it happened to me yesterday.

    The recipient (544 total):

    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 009 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    -- | -- | -- | -- | --
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 009 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 009 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 010 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 010 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 010 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 010 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 010 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 010 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 010 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 010 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 010 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae255e29d05245-LAX | virt1.rno | 2022-02-09 15:31:40 010 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae2595af035245-LAX | virt1.lax | 2022-02-09 15:31:48 850 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae2595af035245-LAX | virt1.lax | 2022-02-09 15:31:48 851 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae2595af035245-LAX | virt1.lax | 2022-02-09 15:31:48 851 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae2595af035245-LAX | virt1.lax | 2022-02-09 15:31:48 851 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae2595af035245-LAX | virt1.lax | 2022-02-09 15:31:48 851 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae2595af035245-LAX | virt1.lax | 2022-02-09 15:31:48 851 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae2595af035245-LAX | virt1.lax | 2022-02-09 15:31:48 851 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae2595af035245-LAX | virt1.lax | 2022-02-09 15:31:48 851 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae2595af035245-LAX | virt1.lax | 2022-02-09 15:31:48 851 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    6dae2595af035245-LAX | virt1.lax | 2022-02-09 15:31:48 852 | joelbettner@expensify.com | [info] [Report] Handled reportComment event sent by Pusher ~~ reportID: '64705968' userAgent: 'Mozilla/5.0 (Macintosh; Intel Mac OS X 11_6_0) AppleWebKit/537.36 (KHTML, like Gecko) new.expensify/1.1.27-1 Chrome/87.0.4280.141 Electron/11.4.8 Safari/537.36'
    

    The sender (554), on web:

    6dae24fc4c2a6701-SJC | virt2.sjc | 2022-02-09 15:31:24 235 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de4c39646' partnerName: 'expensify.com'
    -- | -- | -- | -- | --
    6dae2505add36701-SJC | virt2.sjc | 2022-02-09 15:31:25 747 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de4db67fe' partnerName: 'expensify.com'
    6dae250bef956701-SAN | virt2.rno | 2022-02-09 15:31:26 757 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de4eb8f41' partnerName: 'expensify.com'
    6dae2512280b6701-SAN | virt2.rno | 2022-02-09 15:31:27 755 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de4fb86c3' partnerName: 'expensify.com'
    6dae251858d86701-SAN | virt2.rno | 2022-02-09 15:31:28 755 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de50b87a8' partnerName: 'expensify.com'
    6dae251e99ee6701-SAN | virt2.rno | 2022-02-09 15:31:29 769 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de51bbcd8' partnerName: 'expensify.com'
    6dae2524e9516701-SAN | virt2.rno | 2022-02-09 15:31:30 746 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de52b6414' partnerName: 'expensify.com'
    6dae25316fee6701-SAN | virt2.rno | 2022-02-09 15:31:32 767 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de54bb3c7' partnerName: 'expensify.com'
    6dae253798fd6701-SAN | virt2.rno | 2022-02-09 15:31:33 749 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de55b6e7e' partnerName: 'expensify.com'
    6dae253de8706701-SAN | virt2.rno | 2022-02-09 15:31:34 747 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de56b65a2' partnerName: 'expensify.com'
    6dae2544286b6701-SAN | virt2.rno | 2022-02-09 15:31:35 807 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de57c4fbe' partnerName: 'expensify.com'
    6dae254a6f7c6701-SAN | virt2.rno | 2022-02-09 15:31:36 783 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de58bf40a' partnerName: 'expensify.com'
    6dae2550af3e6701-SAN | virt2.rno | 2022-02-09 15:31:37 755 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de59b84c8' partnerName: 'expensify.com'
    6dae2556dfb56701-SAN | virt2.rno | 2022-02-09 15:31:38 738 | tgolen@expensify.com | Processing 'Report_AddComment' for 'expensify.com' from '67.177.248.66' ~~ command: 'Report_AddComment' reportID: '64705968' file: 'undefined' reportComment: '<REDACTED>' clientID: '1644420684024480' authToken: '<REDACTED>' referer: 'ecash' api_setCookie: 'false' email: 'tgolen@expensify.com' browserGUID: '6203de5ab42a7' partnerName: 'expensify.com'
    
  9. kidroca commented on Feb 10, 2022

    @kidroca
  10. removed their assignment
    on Feb 10, 2022
  11. 38 remaining items

  12. added
    Awaiting PaymentAuto-added when associated PR is deployed to production
    on Feb 23, 2022
  13. botify commented on Feb 23, 2022

    @botify

    The solution for this issue has been 🚀 deployed to production 🚀 in version 1.1.39-3 and is now subject to a 7-day regression period 📆. Here is the list of pull requests that resolve this issue:

    If no regressions arise, payment will be issued on 2022-03-02. 🎊

  14. changed the title [-]Conversation - A single message was sent 100s of times [/-] [+][HOLD for payment 2022-03-02] Conversation - A single message was sent 100s of times [/+] on Feb 23, 2022
  15. tgolen commented on Feb 23, 2022

    @tgolen
    Contributor

    Cool, thanks for that info! This is the backend code for the CORS header:

    image

    So, maybe we should just ad app:// to that? Isn't that a protocol though, not the host? PHP is doing things with the host there.

  16. kidroca commented on Feb 23, 2022

    @kidroca
    Contributor

    So, maybe we should just ad app:// to that? Isn't that a protocol though, not the host? PHP is doing things with the host there.

    The current code adds this

    details.responseHeaders['access-control-allow-origin'] = ['app://-'];

    It shouldn't be prefixed with https

    Buuut it also changes the origin sent by the request (I geuss $host) so it won't work unless we revert that

    details.requestHeaders.origin = newDotURL;

    Also maybe there's some way to change app:// to expensify:// or app://expensify or something in that sense

  17. kidroca commented on Feb 23, 2022

    @kidroca
    Contributor

    @NicMendonca, @tgolen
    I'm sorry but I submitted the #7673 before there was an Upwork job and never applied for it

    I've tracked any work around this ticket (including recreating the problem in Desktop today) in my hourly contract referencing this issue
    Can we just close the Upwork job?

  18. tgolen commented on Feb 23, 2022

    @tgolen
    Contributor

    @NicMendonca Can you close the upwork job, please?

    Maybe to fix the host/origin problem, the PHP code can also look at HTTP_REFERRER to see if it contains app://. So it would look more like this:

        if (in_array($host, ['comp.expensify.com', 'new.expensify.com', 'staging.new.expensify.com']) ) {
            header('Access-Control-Allow-Origin: https://'.$host);
            header('Access-Control-Allow-Credentials: true');
        } elseif (str_starts_with($_SERVER['HTTP_REFERER'], 'app://')) {
            header('Access-Control-Allow-Origin: app://-');
            header('Access-Control-Allow-Credentials: true');
        } elseif (DEBUG) {
            header('Access-Control-Allow-Origin: *');
            header('Access-Control-Allow-Credentials: true');
        }

    We would have to change this too:

    details.requestHeaders.origin = newDotURL.replace('https://', 'app://');
    
  19. kidroca commented on Feb 23, 2022

    @kidroca
    Contributor

    Well just so you know both the referrer and origin are overridden here, so if you do decide to take this to the backend we should unset them on Desktop (which can happen after the server is updated)

    App/desktop/main.js

    Lines 167 to 169 in 853db57

    details.requestHeaders.origin = newDotURL;
    // eslint-disable-next-line no-param-reassign
    details.requestHeaders.referer = newDotURL;

  20. mallenexpensify commented on Mar 1, 2022

    @mallenexpensify
    Contributor

    @kidroca is there still work being done here before filling out the Root Cause Analysis (RCA) doc?
    https://docs.google.com/document/d/1OwX4QGqemKbm2yb1opwqIDrYkt8b5wskHcgYNwAKkzo/edit

  21. kidroca commented on Mar 1, 2022

    @kidroca
    Contributor

    @kidroca is there still work being done here before filling out the Root Cause Analysis (RCA) doc?

    Not that I know of.
    I'll fill out the doc and post back

  22. kidroca commented on Mar 4, 2022

    @kidroca
    Contributor

    @mallenexpensify
    I've filled the RCA

    This ticket can be closed: #7666 (comment)

  23. mallenexpensify commented on Mar 4, 2022

    @mallenexpensify
    Contributor

    Thanks @kidroca , closing.
    cc @michaelhaxhiu , cuz it's RCA

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment

Metadata

Metadata

Labels

Awaiting PaymentAuto-added when associated PR is deployed to productionDailyKSv2EngineeringExternalAdded to denote the issue can be worked on by a contributorImprovementItem broken or needs improvement.Needs ReproductionReproducible steps needed

Type

No type

Projects

No projects

    Milestone

    No milestone

    Relationships

    None yet

    Development

    No branches or pull requests

    Issue actions