Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

[NEW] Rocket.Chat one-click template #579

Merged
merged 4 commits into from
Dec 14, 2021

Conversation

debdutdeb
Copy link
Contributor

☑️ Self Check before Merge

  • I have tested the template using the method described in README.md thoroughly
  • I have ensured that I put as much default values as possible (except passwords) to ensure minimum effort required for end users to get started.
  • I have ensured that I am not using the "latest" tag as this tag is dynamically changing and might break the one-click app. Use a fixed version.
  • I have made sure that instructions.start and instructions.end are clear and self-explanatory.
  • Icon is added as a png file to the logos directory.

Closes #66

Signed-off-by: Debdut Chakraborty <debdut.chakraborty@rocket.chat>
Signed-off-by: Debdut Chakraborty <debdut.chakraborty@rocket.chat>
Signed-off-by: Debdut Chakraborty <debdut.chakraborty@rocket.chat>
@githubsaturn
Copy link
Collaborator

Looks great, excited to have Rocket Chat here!

Thanks!

@githubsaturn githubsaturn merged commit ffca426 into caprover:master Dec 14, 2021
@nileshtrivedi
Copy link

Thank you so much for this, @debdutdeb !

@debdutdeb debdutdeb deleted the rocketchat-one-click branch December 19, 2021 04:42
@GoaGit
Copy link

GoaGit commented Jan 11, 2022

@debdutdeb nice work! The initial user is created with a username and password. This allows for logging in. However, when accessing the user profile (My Account), the app throws an error, i.e. does not render the page. This is because there is no email address associated with this user, which is a mandatory field in Rocket.Chat. I added an email address in the db directly and then it works.

I am not entirely sure if this can be resolved by adding the email address as an environment variable. Rocket.Chat's underlying framework (MeteorJS) allows for creating a user object with an email address and username.

image

@debdutdeb
Copy link
Contributor Author

Hey @GoaGit can you please open an issue on https://github.com/rocketchat/rocket.chat ?

@Ziip-dev
Copy link

Hey, I opened issue #736 regarding a limitation of the regex that enforces version >= 5.0.4.
Feel free to ping me if you have any question or want me to do something else :)

@Ziip-dev
Copy link

@debdutdeb I also believe that this app is problematic to update as a one-click-app without loosing data.

Please tell me if I am wrong, but following caprover documentation:

  • there is no integrated update mechanism in rocket.chat...
  • so we need to deploy the new docker image version via deployment method 6 but...
  • the one-click-app script adds proper caprover parameters so we cannot do that...
  • hence we need to remove the rocket.chat app in order to redeploy a more recent one from the one-click method...
  • but we are blocked because the mongodb app already exists...

I am tinkering from the original yml file to deploy a new one-click version from the TEMPLATE app while conserving the previous db app and its data, but no success so far... any idea?

@debdutdeb
Copy link
Contributor Author

Hi @Ziip-dev

Can you please send me the caprover doc you mentioned?

@githubsaturn
Copy link
Collaborator

the one-click-app script adds proper caprover parameters so we cannot do that

Not sure if I understand what this is. From what I am seeing RocketChat is just a simple container, so deploying a new image should just work

image

@Ziip-dev
Copy link

Thank you for your answer, and sorry for pinging in the first place :)

Can you please send me the caprover doc you mentioned?

That is this one.

Well, from my understanding of that documentation, the caproverExtra section adds options that cannot be replicated in the deployment of a docker image. But as this is only an option in the caprover dashboard I guess you are right and that should work out of the box.

However, when I first tried this (deployment of image 5.1.3 via method 6) the build succeeded but my server became unaccessible (nginx 502 I believe). Reverting to the previous image didn't help either, that's why I started tinkering to deploy only a rocket.chat app that would reuse the existing db.

@debdutdeb
Copy link
Contributor Author

debdutdeb commented Sep 29, 2022

Did you check rocketchat logs (when you got the 502)? Can you share that here please?

@Ziip-dev
Copy link

Yep, somewhat it could not connect to the db container despite using the exact same environment variables. I suspected a docker network discrepancy but could not figure it out.

Details on what I have tried:

The modified rocketchat.yml file that I threw in a one-click-app template
captainVersion: 4

services:
    $$cap_appname:
        image: registry.rocket.chat/rocketchat/rocket.chat:$$cap_app_version
        volumes:
            - $$cap_appname-data:/app/uploads
            
        environment:
            PORT: 3000
            ROOT_URL: http://$$cap_appname.$$cap_root_domain
            MONGO_URL: mongodb://$$cap_mongodb_db_username:$$cap_mongodb_db_password@srv-captain--$$cap_appname-db:27017/rocketchat?replicaSet=rs0
            MONGO_OPLOG_URL: mongodb://$$cap_mongodb_root_username:$$cap_mongodb_root_password@srv-captain--$$cap_appname-db:27017/local?replicaSet=rs0&authSource=admin

            ADMIN_NAME: $$cap_admin_name
            ADMIN_EMAIL: $$cap_admin_email
            ADMIN_USERNAME: $$cap_admin_username
            ADMIN_PASS: $$cap_admin_password

            OVERWRITE_SETTING_Site_Url: http://$$cap_appname.$$cap_root_domain

            DEPLOY_METHOD: docker
            DEPLOY_PLATFORM: caprover

        caproverExtra:
            containerHttpPort: 3000
            
caproverOneClickApp:
    variables:
        - id: $$cap_app_version
          label: Rocket.Chat Version
          description: See version numbers at https://hub.docker.com/r/library/rocket-chat/tags/ or https://github.com/RocketChat/Rocket.Chat/releases. Version must be >=5.0.4
          defaultValue: '5.1.3'
          # enforcing deployment of v5.0.4+
          # validRegex: /^(?(?=5\.0)5\.0\.[4-9]|(?=[5-9])[5-9]\.[0-9]\.[0-9])$/

        - id: $$cap_admin_name
          label: Rocket.Chat Admin Real Name
          defaultValue: Captain
          description: Real name of your Rocket.Chat instance's Admin user
          validRegex: /^[a-zA-Z0-9\.-\s]+$/
          
        - id: $$cap_admin_email
          label: Rocket.Chat Admin Email Account
          description: Email address of Rocket.Chat instance's Admin user
          validRegex: /^[a-zA-Z0-9.!#$%&'*+/=?^_`{|}~-]+@[a-zA-Z0-9-]+(?:\.[a-zA-Z0-9-]+)*$/

        - id: $$cap_admin_username
          label: Rocket.Chat Admin Username
          defaultValue: captain
          description: Username of your Rocket.Chat instance's Admin user
          validRegex: /^[a-zA-Z0-9\.-]+$/

        - id: $$cap_admin_password
          label: Rocket.Chat Admin Password
          defaultValue: $$cap_gen_random_hex(16)
          description: Password of your Rocket.Chat instance's Admin user. Must be at least 8 characters long
          validRegex: /.{8,}/

        - id: $$cap_app_db_version
          label: MongoDB Version
          description: See https://docs.rocket.chat/quick-start/installing-and-updating/manual-installation/mongo-versions for supported MongoDB versions. See https://hub.docker.com/r/bitnami/mongodb/tags/ for MongoDB image tags. Version must be >=4.x.y but please prefer >=4.4.z
          defaultValue: '5.0'
          # ensuring v4+ is used
          validRegex: /^[4-9](\.[0-9](\.[0-9])?)?(-debian-[0-9]+-r[0-9]+)?$/

        - id: $$cap_mongodb_root_username
          label: MongoDB root user's username
          defaultValue: root
          validRegex: /^[a-zA-Z0-9]+$/

        - id: $$cap_mongodb_root_password
          label: MongoDB root user password
          description: Must be at least 8 characters long. Recommended to leave the default generated
          defaultValue: $$cap_gen_random_hex(24)
          validRegex: /^[^\@]{8,}$/

        - id: $$cap_mongodb_db_username
          label: MongoDB user with permissions to Rocket.Chat database
          defaultValue: rocketchat
          validRegex: /^[a-zA-Z0-9]+$/

        - id: $$cap_mongodb_db_password
          label: Password of the MongoDB user with permissions to Rocket.Chat database
          description: Must be at least 8 characters long. Recommended to leave the default generated
          defaultValue: $$cap_gen_random_hex(24)
          validRegex: /^[^\@]{8,}$/

        - id: $$cap_mongodb_db_replicaset_key
          label: MongoDB replicaset key
          description: Must be at least 5 characters long. Recommended to leave the default generated
          defaultValue: $$cap_gen_random_hex(32)
          validRegex: /.{5,}/

    instructions:
        start: |-
            Deploy your own Rocket.Chat instance with this one click.
            For more information see https://github.com/RocketChat/Rocket.Chat
        end: |-
            Your Rocket.Chat instance is now available at http://$$cap_appname.$$cap_root_domain
            Log in to your newly deployed Rocket.Chat instance with the default admin account, username: "captain" and password: "$$cap_admin_password"
            If you face any issues, you can reach out at,
            Forum: https://forums.rocket.chat
            Open Community Server: https://open.rocket.chat/channel/support

    displayName: Rocket.Chat
    isOfficial: true
    description: Slack like online chat, built with Meteor. Real-time conversations with your colleagues, other companies or customers.
    documentation: https://github.com/RocketChat/Rocket.Chat
The current app's logs (error due to lack of memory, different from yesterday)
2022-09-30T09:33:45.512325371Z strict mode: use allowUnionTypes to allow union type keyword at "#/properties/value" (strictTypes)
2022-09-30T09:34:04.813998413Z LocalStore: store created at 
2022-09-30T09:34:04.827328019Z LocalStore: store created at 
2022-09-30T09:34:04.827354859Z LocalStore: store created at 
2022-09-30T09:34:24.551721802Z MessageType.render is deprecated. Use MessageType.message instead. livechat_webrtc_video_call
2022-09-30T09:34:29.899568312Z {"level":40,"time":"2022-09-30T09:34:29.815Z","pid":1,"hostname":"c2654bd4875a","name":"VoIPService","msg":"Voip is not enabled. Cant start the service"}
2022-09-30T09:34:45.092029357Z 
2022-09-30T09:34:45.093292107Z <--- Last few GCs --->
2022-09-30T09:34:45.093300247Z 
2022-09-30T09:34:45.093304427Z [1:0x534da90]    84196 ms: Mark-sweep 397.1 (409.4) -> 392.9 (409.9) MB, 870.5 / 0.6 ms  (average mu = 0.351, current mu = 0.344) allocation failure scavenge might not succeed
2022-09-30T09:34:45.093309047Z [1:0x534da90]    85189 ms: Mark-sweep 397.2 (409.9) -> 394.5 (410.7) MB, 633.2 / 0.7 ms  (average mu = 0.356, current mu = 0.362) allocation failure scavenge might not succeed
2022-09-30T09:34:45.093313357Z 
2022-09-30T09:34:45.093316877Z 
2022-09-30T09:34:45.093320237Z <--- JS stacktrace --->
2022-09-30T09:34:45.093323727Z 
2022-09-30T09:34:45.093326917Z FATAL ERROR: MarkCompactCollector: young object promotion failed Allocation failed - JavaScript heap out of memory
2022-09-30T09:34:45.093330637Z  1: 0xa3aaf0 node::Abort() [node]
2022-09-30T09:34:45.093334007Z  2: 0x970199 node::FatalError(char const*, char const*) [node]
2022-09-30T09:34:45.093337357Z  3: 0xbba42e v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [node]
2022-09-30T09:34:45.093340777Z  4: 0xbba7a7 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [node]
2022-09-30T09:34:45.093344177Z  5: 0xd769c5  [node]
2022-09-30T09:34:45.093347457Z  6: 0xda735e v8::internal::EvacuateNewSpaceVisitor::Visit(v8::internal::HeapObject, int) [node]
2022-09-30T09:34:45.093350867Z  7: 0xdb3396 v8::internal::FullEvacuator::RawEvacuatePage(v8::internal::MemoryChunk*, long*) [node]
2022-09-30T09:34:45.093354267Z  8: 0xd9f52f v8::internal::Evacuator::EvacuatePage(v8::internal::MemoryChunk*) [node]
2022-09-30T09:34:45.093357627Z  9: 0xd9f7a8 v8::internal::PageEvacuationTask::RunInParallel(v8::internal::ItemParallelJob::Task::Runner) [node]
2022-09-30T09:34:45.093361087Z 10: 0xd92089 v8::internal::ItemParallelJob::Run() [node]
2022-09-30T09:34:45.093364557Z 11: 0xdb52f0 void v8::internal::MarkCompactCollectorBase::CreateAndExecuteEvacuationTasks<v8::internal::FullEvacuator, v8::internal::MarkCompactCollector>(v8::internal::MarkCompactCollector*, v8::internal::ItemParallelJob*, v8::internal::MigrationObserver*, long) [node]
2022-09-30T09:34:45.093368607Z 12: 0xdb5b8c v8::internal::MarkCompactCollector::EvacuatePagesInParallel() [node]
2022-09-30T09:34:45.093395447Z 13: 0xdb5d55 v8::internal::MarkCompactCollector::Evacuate() [node]
2022-09-30T09:34:45.093399647Z 14: 0xdc7d51 v8::internal::MarkCompactCollector::CollectGarbage() [node]
2022-09-30T09:34:45.093402847Z 15: 0xd84018 v8::internal::Heap::MarkCompact() [node]
2022-09-30T09:34:45.093406027Z 16: 0xd85b08 v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [node]
2022-09-30T09:34:45.093426247Z 17: 0xd88f4c v8::internal::Heap::AllocateRawWithRetryOrFailSlowPath(int, v8::internal::AllocationType, v8::internal::AllocationOrigin, v8::internal::AllocationAlignment) [node]
2022-09-30T09:34:45.093431187Z 18: 0xd5762b v8::internal::Factory::NewFillerObject(int, bool, v8::internal::AllocationType, v8::internal::AllocationOrigin) [node]
2022-09-30T09:34:45.093434607Z 19: 0x109fbef v8::internal::Runtime_AllocateInYoungGeneration(int, unsigned long*, v8::internal::Isolate*) [node]
2022-09-30T09:34:45.093437947Z 20: 0x1448df9  [node]
2022-09-30T09:36:01.426413766Z strict mode: use allowUnionTypes to allow union type keyword at "#/properties/value" (strictTypes)
2022-09-30T09:36:19.950884844Z LocalStore: store created at 
2022-09-30T09:36:19.971735004Z LocalStore: store created at 
2022-09-30T09:36:19.971764734Z LocalStore: store created at 
2022-09-30T09:36:34.656151087Z MessageType.render is deprecated. Use MessageType.message instead. livechat_webrtc_video_call
2022-09-30T09:36:40.388703672Z {"level":40,"time":"2022-09-30T09:36:40.287Z","pid":1,"hostname":"796133ac7670","name":"VoIPService","msg":"Voip is not enabled. Cant start the service"}
2022-09-30T09:36:55.606855718Z 
2022-09-30T09:36:55.610397569Z <--- Last few GCs --->
2022-09-30T09:36:55.610417729Z 
2022-09-30T09:36:55.610421889Z [1:0x5aeca90]    76850 ms: Mark-sweep 397.0 (409.9) -> 392.9 (410.4) MB, 751.9 / 0.5 ms  (average mu = 0.334, current mu = 0.317) allocation failure scavenge might not succeed
2022-09-30T09:36:55.610426449Z [1:0x5aeca90]    78209 ms: Mark-sweep 397.2 (410.4) -> 394.5 (410.9) MB, 1000.7 / 0.6 ms  (average mu = 0.297, current mu = 0.264) allocation failure scavenge might not succeed
2022-09-30T09:36:55.610430749Z 
2022-09-30T09:36:55.610434189Z 
2022-09-30T09:36:55.610437459Z <--- JS stacktrace --->
2022-09-30T09:36:55.610440889Z 
2022-09-30T09:36:55.610444149Z FATAL ERROR: MarkCompactCollector: young object promotion failed Allocation failed - JavaScript heap out of memory
2022-09-30T09:36:55.610447639Z  1: 0xa3aaf0 node::Abort() [node]
2022-09-30T09:36:55.610450969Z  2: 0x970199 node::FatalError(char const*, char const*) [node]
2022-09-30T09:36:55.610454469Z  3: 0xbba42e v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [node]
2022-09-30T09:36:55.610488329Z  4: 0xbba7a7 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [node]
2022-09-30T09:36:55.610494549Z  5: 0xd769c5  [node]
2022-09-30T09:36:55.610497809Z  6: 0xda735e v8::internal::EvacuateNewSpaceVisitor::Visit(v8::internal::HeapObject, int) [node]
2022-09-30T09:36:55.610501179Z  7: 0xdb3396 v8::internal::FullEvacuator::RawEvacuatePage(v8::internal::MemoryChunk*, long*) [node]
2022-09-30T09:36:55.610504529Z  8: 0xd9f52f v8::internal::Evacuator::EvacuatePage(v8::internal::MemoryChunk*) [node]
2022-09-30T09:36:55.610507859Z  9: 0xd9f7a8 v8::internal::PageEvacuationTask::RunInParallel(v8::internal::ItemParallelJob::Task::Runner) [node]
2022-09-30T09:36:55.610511429Z 10: 0xd92089 v8::internal::ItemParallelJob::Run() [node]
2022-09-30T09:36:55.610514889Z 11: 0xdb52f0 void v8::internal::MarkCompactCollectorBase::CreateAndExecuteEvacuationTasks<v8::internal::FullEvacuator, v8::internal::MarkCompactCollector>(v8::internal::MarkCompactCollector*, v8::internal::ItemParallelJob*, v8::internal::MigrationObserver*, long) [node]
2022-09-30T09:36:55.610518979Z 12: 0xdb5b8c v8::internal::MarkCompactCollector::EvacuatePagesInParallel() [node]
2022-09-30T09:36:55.610544969Z 13: 0xdb5d55 v8::internal::MarkCompactCollector::Evacuate() [node]
2022-09-30T09:36:55.610549309Z 14: 0xdc7d51 v8::internal::MarkCompactCollector::CollectGarbage() [node]
2022-09-30T09:36:55.610552579Z 15: 0xd84018 v8::internal::Heap::MarkCompact() [node]
2022-09-30T09:36:55.610555719Z 16: 0xd85b08 v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [node]
2022-09-30T09:36:55.610559019Z 17: 0xd87a45 v8::internal::Heap::HandleGCRequest() [node]
2022-09-30T09:36:55.610566569Z 18: 0xd2df57 v8::internal::StackGuard::HandleInterrupts() [node]
2022-09-30T09:36:55.610569809Z 19: 0x109f643 v8::internal::Runtime_StackGuard(int, unsigned long*, v8::internal::Isolate*) [node]
2022-09-30T09:36:55.610573069Z 20: 0x1448df9  [node]
2022-09-30T09:38:20.293678182Z strict mode: use allowUnionTypes to allow union type keyword at "#/properties/value" (strictTypes)
2022-09-30T09:38:37.858874805Z LocalStore: store created at 
2022-09-30T09:38:37.863026457Z LocalStore: store created at 
2022-09-30T09:38:37.863078057Z LocalStore: store created at 
2022-09-30T09:38:55.426503488Z MessageType.render is deprecated. Use MessageType.message instead. livechat_webrtc_video_call
2022-09-30T09:39:02.151086304Z {"level":40,"time":"2022-09-30T09:39:02.133Z","pid":1,"hostname":"98ac2295e196","name":"VoIPService","msg":"Voip is not enabled. Cant start the service"}
2022-09-30T09:39:22.279148711Z 
2022-09-30T09:39:22.410520361Z <--- Last few GCs --->
2022-09-30T09:39:22.410540581Z 
2022-09-30T09:39:22.410545151Z [1:0x480da90]    91879 ms: Mark-sweep 396.8 (407.7) -> 393.5 (407.9) MB, 577.6 / 0.5 ms  (average mu = 0.230, current mu = 0.238) allocation failure scavenge might not succeed
2022-09-30T09:39:22.410549801Z 
2022-09-30T09:39:22.410553521Z 
2022-09-30T09:39:22.410570961Z <--- JS stacktrace --->
2022-09-30T09:39:22.410574801Z 
2022-09-30T09:39:22.410578111Z FATAL ERROR: Ineffective mark-compacts near heap limit Allocation failed - JavaScript heap out of memory
2022-09-30T09:39:22.410581651Z  1: 0xa3aaf0 node::Abort() [node]
2022-09-30T09:39:22.410584971Z  2: 0x970199 node::FatalError(char const*, char const*) [node]
2022-09-30T09:39:22.410588341Z  3: 0xbba42e v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [node]
2022-09-30T09:39:22.410591671Z  4: 0xbba7a7 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [node]
2022-09-30T09:39:22.410595071Z  5: 0xd769c5  [node]
2022-09-30T09:39:22.410598281Z  6: 0xd7754f  [node]
2022-09-30T09:39:22.410601591Z  7: 0xd8538b v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [node]
2022-09-30T09:39:22.410605121Z  8: 0xd88f4c v8::internal::Heap::AllocateRawWithRetryOrFailSlowPath(int, v8::internal::AllocationType, v8::internal::AllocationOrigin, v8::internal::AllocationAlignment) [node]
2022-09-30T09:39:22.410608661Z  9: 0xd4e71d v8::internal::Factory::AllocateRaw(int, v8::internal::AllocationType, v8::internal::AllocationAlignment) [node]
2022-09-30T09:39:22.410612101Z 10: 0xd4a979 v8::internal::FactoryBase<v8::internal::Factory>::AllocateRawArray(int, v8::internal::AllocationType) [node]
2022-09-30T09:39:22.410615851Z 11: 0xd4aa34 v8::internal::FactoryBase<v8::internal::Factory>::NewFixedArrayWithFiller(v8::internal::Handle<v8::internal::Map>, int, v8::internal::Handle<v8::internal::Oddball>, v8::internal::AllocationType) [node]
2022-09-30T09:39:22.410619921Z 12: 0xf920be v8::internal::OrderedHashTable<v8::internal::OrderedHashMap, 2>::Allocate(v8::internal::Isolate*, int, v8::internal::AllocationType) [node]
2022-09-30T09:39:22.410623551Z 13: 0xf92256 v8::internal::OrderedHashTable<v8::internal::OrderedHashMap, 2>::Rehash(v8::internal::Isolate*, v8::internal::Handle<v8::internal::OrderedHashMap>, int) [node]
2022-09-30T09:39:22.410637301Z 14: 0x1083a58 v8::internal::Runtime_MapGrow(int, unsigned long*, v8::internal::Isolate*) [node]
2022-09-30T09:39:22.410640941Z 15: 0x1448df9  [node]
2022-09-30T09:40:40.915542966Z strict mode: use allowUnionTypes to allow union type keyword at "#/properties/value" (strictTypes)
2022-09-30T09:40:59.280637972Z LocalStore: store created at 
2022-09-30T09:40:59.282126673Z LocalStore: store created at 
2022-09-30T09:40:59.282142483Z LocalStore: store created at 
2022-09-30T09:41:16.827103006Z MessageType.render is deprecated. Use MessageType.message instead. livechat_webrtc_video_call
2022-09-30T09:41:24.367134813Z {"level":40,"time":"2022-09-30T09:41:24.071Z","pid":1,"hostname":"b0391ed3809c","name":"VoIPService","msg":"Voip is not enabled. Cant start the service"}
2022-09-30T09:41:45.878370378Z 
2022-09-30T09:41:45.882114470Z <--- Last few GCs --->
2022-09-30T09:41:45.882144280Z 
2022-09-30T09:41:45.882148820Z [1:0x6442a90]    88639 ms: Mark-sweep 398.3 (408.5) -> 397.0 (408.5) MB, 1109.1 / 0.6 ms  (average mu = 0.165, current mu = 0.085) allocation failure scavenge might not succeed
2022-09-30T09:41:45.882153320Z [1:0x6442a90]    89308 ms: Mark-sweep 399.0 (408.5) -> 397.7 (408.5) MB, 631.6 / 0.5 ms  (average mu = 0.125, current mu = 0.056) allocation failure scavenge might not succeed
2022-09-30T09:41:45.882157300Z 
2022-09-30T09:41:45.882160690Z 
2022-09-30T09:41:45.882164530Z <--- JS stacktrace --->
2022-09-30T09:41:45.882167890Z 
2022-09-30T09:41:45.882171090Z FATAL ERROR: Ineffective mark-compacts near heap limit Allocation failed - JavaScript heap out of memory
2022-09-30T09:41:45.882180940Z  1: 0xa3aaf0 node::Abort() [node]
2022-09-30T09:41:45.882184630Z  2: 0x970199 node::FatalError(char const*, char const*) [node]
2022-09-30T09:41:45.882187900Z  3: 0xbba42e v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [node]
2022-09-30T09:41:45.882191230Z  4: 0xbba7a7 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [node]
2022-09-30T09:41:45.882194560Z  5: 0xd769c5  [node]
2022-09-30T09:41:45.882197760Z  6: 0xd7754f  [node]
2022-09-30T09:41:45.882200970Z  7: 0xd8538b v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [node]
2022-09-30T09:41:45.882204410Z  8: 0xd88f4c v8::internal::Heap::AllocateRawWithRetryOrFailSlowPath(int, v8::internal::AllocationType, v8::internal::AllocationOrigin, v8::internal::AllocationAlignment) [node]
2022-09-30T09:41:45.882214490Z  9: 0xd5762b v8::internal::Factory::NewFillerObject(int, bool, v8::internal::AllocationType, v8::internal::AllocationOrigin) [node]
2022-09-30T09:41:45.882218510Z 10: 0x109fbef v8::internal::Runtime_AllocateInYoungGeneration(int, unsigned long*, v8::internal::Isolate*) [node]
2022-09-30T09:41:45.882221970Z 11: 0x1448df9  [node]
2022-09-30T09:43:13.732887343Z strict mode: use allowUnionTypes to allow union type keyword at "#/properties/value" (strictTypes)
2022-09-30T09:43:42.261845257Z LocalStore: store created at 
2022-09-30T09:43:42.263478868Z LocalStore: store created at 
2022-09-30T09:43:42.263493538Z LocalStore: store created at 
The db container's logs
2022-09-30T09:45:19.953089072Z mongodb 09:45:19.79 
2022-09-30T09:45:19.953179982Z mongodb 09:45:19.80 Welcome to the Bitnami mongodb container
2022-09-30T09:45:19.953191542Z mongodb 09:45:19.80 Subscribe to project updates by watching https://github.com/bitnami/containers
2022-09-30T09:45:19.953198452Z mongodb 09:45:19.80 Submit issues and feature requests at https://github.com/bitnami/containers/issues
2022-09-30T09:45:19.953205142Z mongodb 09:45:19.80 
2022-09-30T09:45:19.953210492Z mongodb 09:45:19.80 INFO  ==> ** Starting MongoDB setup **
2022-09-30T09:45:19.953215802Z mongodb 09:45:19.87 INFO  ==> Validating settings in MONGODB_* env vars...
2022-09-30T09:45:20.488965715Z mongodb 09:45:20.34 INFO  ==> Initializing MongoDB...
2022-09-30T09:45:20.826122749Z mongodb 09:45:20.62 INFO  ==> Enabling authentication...
2022-09-30T09:45:20.826158609Z mongodb 09:45:20.63 INFO  ==> Deploying MongoDB with persisted data...
2022-09-30T09:45:20.826164859Z mongodb 09:45:20.63 INFO  ==> Writing keyfile for replica set authentication...
2022-09-30T09:45:20.826171419Z mongodb 09:45:20.70 INFO  ==> ** MongoDB setup finished! **
2022-09-30T09:45:20.826176249Z mongodb 09:45:20.73 INFO  ==> ** Starting MongoDB **
2022-09-30T09:45:20.885384856Z 
2022-09-30T09:45:20.885410956Z 
2022-09-30T09:45:20.885414916Z {"t":{"$date":"2022-09-30T09:45:20.815+00:00"},"s":"I",  "c":"CONTROL",  "id":20698,   "ctx":"-","msg":"***** SERVER RESTARTED *****"}
2022-09-30T09:45:20.885420156Z {"t":{"$date":"2022-09-30T09:45:20.816+00:00"},"s":"I",  "c":"NETWORK",  "id":4915701, "ctx":"-","msg":"Initialized wire specification","attr":{"spec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":13},"incomingInternalClient":{"minWireVersion":0,"maxWireVersion":13},"outgoing":{"minWireVersion":0,"maxWireVersion":13},"isInternalClient":true}}}
2022-09-30T09:45:20.885485896Z {"t":{"$date":"2022-09-30T09:45:20.817+00:00"},"s":"I",  "c":"CONTROL",  "id":23285,   "ctx":"-","msg":"Automatically disabling TLS 1.0, to force-enable TLS 1.0 specify --sslDisabledProtocols 'none'"}
2022-09-30T09:45:20.885490656Z {"t":{"$date":"2022-09-30T09:45:20.819+00:00"},"s":"W",  "c":"ASIO",     "id":22601,   "ctx":"main","msg":"No TransportLayer configured during NetworkInterface startup"}
2022-09-30T09:45:20.885495056Z {"t":{"$date":"2022-09-30T09:45:20.820+00:00"},"s":"I",  "c":"NETWORK",  "id":4648601, "ctx":"main","msg":"Implicit TCP FastOpen unavailable. If TCP FastOpen is required, set tcpFastOpenServer, tcpFastOpenClient, and tcpFastOpenQueueSize."}
2022-09-30T09:45:21.038291045Z {"t":{"$date":"2022-09-30T09:45:20.910+00:00"},"s":"W",  "c":"ASIO",     "id":22601,   "ctx":"main","msg":"No TransportLayer configured during NetworkInterface startup"}
2022-09-30T09:45:21.038320675Z {"t":{"$date":"2022-09-30T09:45:20.910+00:00"},"s":"W",  "c":"ASIO",     "id":22601,   "ctx":"main","msg":"No TransportLayer configured during NetworkInterface startup"}
2022-09-30T09:45:21.038328565Z {"t":{"$date":"2022-09-30T09:45:20.910+00:00"},"s":"I",  "c":"REPL",     "id":5123008, "ctx":"main","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"TenantMigrationDonorService","ns":"config.tenantMigrationDonors"}}
2022-09-30T09:45:21.038336355Z {"t":{"$date":"2022-09-30T09:45:20.910+00:00"},"s":"I",  "c":"REPL",     "id":5123008, "ctx":"main","msg":"Successfully registered PrimaryOnlyService","attr":{"service":"TenantMigrationRecipientService","ns":"config.tenantMigrationRecipients"}}
2022-09-30T09:45:21.038343285Z {"t":{"$date":"2022-09-30T09:45:20.912+00:00"},"s":"I",  "c":"CONTROL",  "id":5945603, "ctx":"main","msg":"Multi threading initialized"}
2022-09-30T09:45:21.038349135Z {"t":{"$date":"2022-09-30T09:45:20.913+00:00"},"s":"I",  "c":"CONTROL",  "id":4615611, "ctx":"initandlisten","msg":"MongoDB starting","attr":{"pid":1,"port":27017,"dbPath":"/bitnami/mongodb/data/db","architecture":"64-bit","host":"fa6e777ce3e0"}}
2022-09-30T09:45:21.038355995Z {"t":{"$date":"2022-09-30T09:45:20.913+00:00"},"s":"I",  "c":"CONTROL",  "id":23403,   "ctx":"initandlisten","msg":"Build Info","attr":{"buildInfo":{"version":"5.0.13","gitVersion":"cfb7690563a3144d3d1175b3a20c2ec81b662a8f","openSSLVersion":"OpenSSL 1.1.1n  15 Mar 2022","modules":[],"allocator":"tcmalloc","environment":{"distmod":"debian11","distarch":"x86_64","target_arch":"x86_64"}}}}
2022-09-30T09:45:21.038363835Z {"t":{"$date":"2022-09-30T09:45:20.913+00:00"},"s":"I",  "c":"CONTROL",  "id":51765,   "ctx":"initandlisten","msg":"Operating System","attr":{"os":{"name":"PRETTY_NAME=\"Debian GNU/Linux 11 (bullseye)\"","version":"Kernel 4.18.0-383.el8.x86_64"}}}
2022-09-30T09:45:21.038371835Z {"t":{"$date":"2022-09-30T09:45:20.913+00:00"},"s":"I",  "c":"CONTROL",  "id":21951,   "ctx":"initandlisten","msg":"Options set by command line","attr":{"options":{"config":"/opt/bitnami/mongodb/conf/mongodb.conf","net":{"bindIp":"*","ipv6":false,"port":27017,"unixDomainSocket":{"enabled":true,"pathPrefix":"/opt/bitnami/mongodb/tmp"}},"processManagement":{"fork":false,"pidFilePath":"/opt/bitnami/mongodb/tmp/mongodb.pid"},"replication":{"enableMajorityReadConcern":true,"replSetName":"rs0"},"security":{"authorization":"enabled","keyFile":"/opt/bitnami/mongodb/conf/keyfile"},"setParameter":{"enableLocalhostAuthBypass":"false"},"storage":{"dbPath":"/bitnami/mongodb/data/db","directoryPerDB":false,"journal":{"enabled":true}},"systemLog":{"destination":"file","logAppend":true,"logRotate":"reopen","path":"/opt/bitnami/mongodb/logs/mongodb.log","quiet":false,"verbosity":0}}}}
2022-09-30T09:45:21.038406185Z {"t":{"$date":"2022-09-30T09:45:20.921+00:00"},"s":"I",  "c":"STORAGE",  "id":22270,   "ctx":"initandlisten","msg":"Storage engine to use detected by data files","attr":{"dbpath":"/bitnami/mongodb/data/db","storageEngine":"wiredTiger"}}
2022-09-30T09:45:21.038426645Z {"t":{"$date":"2022-09-30T09:45:20.922+00:00"},"s":"I",  "c":"STORAGE",  "id":22297,   "ctx":"initandlisten","msg":"Using the XFS filesystem is strongly recommended with the WiredTiger storage engine. See http://dochub.mongodb.org/core/prodnotes-filesystem","tags":["startupWarnings"]}
2022-09-30T09:45:21.038434245Z {"t":{"$date":"2022-09-30T09:45:20.922+00:00"},"s":"I",  "c":"STORAGE",  "id":22315,   "ctx":"initandlisten","msg":"Opening WiredTiger","attr":{"config":"create,cache_size=256M,session_max=33000,eviction=(threads_min=4,threads_max=4),config_base=false,statistics=(fast),log=(enabled=true,archive=true,path=journal,compressor=snappy),builtin_extension_config=(zstd=(compression_level=6)),file_manager=(close_idle_time=600,close_scan_interval=10,close_handle_minimum=250),statistics_log=(wait=0),verbose=[recovery_progress,checkpoint_progress,compact_progress],"}}
2022-09-30T09:45:26.700643478Z {"t":{"$date":"2022-09-30T09:45:26.647+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1664531126:647147][1:0x7f9a9295bc80], txn-recover: [WT_VERB_RECOVERY_PROGRESS] Recovering log 6 through 7"}}
2022-09-30T09:45:28.279353856Z {"t":{"$date":"2022-09-30T09:45:28.242+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1664531128:242755][1:0x7f9a9295bc80], txn-recover: [WT_VERB_RECOVERY_PROGRESS] Recovering log 7 through 7"}}
2022-09-30T09:45:30.584959353Z {"t":{"$date":"2022-09-30T09:45:30.146+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1664531130:122184][1:0x7f9a9295bc80], txn-recover: [WT_VERB_RECOVERY_ALL] Main recovery loop: starting at 6/591872 to 7/256"}}
2022-09-30T09:45:32.869604882Z {"t":{"$date":"2022-09-30T09:45:32.463+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1664531132:429992][1:0x7f9a9295bc80], txn-recover: [WT_VERB_RECOVERY_PROGRESS] Recovering log 6 through 7"}}
2022-09-30T09:45:33.265975162Z {"t":{"$date":"2022-09-30T09:45:33.112+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1664531133:112564][1:0x7f9a9295bc80], txn-recover: [WT_VERB_RECOVERY_PROGRESS] Recovering log 7 through 7"}}
2022-09-30T09:45:33.766295719Z {"t":{"$date":"2022-09-30T09:45:33.282+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1664531133:282582][1:0x7f9a9295bc80], txn-recover: [WT_VERB_RECOVERY_ALL] Set global recovery timestamp: (1664531094, 1)"}}
2022-09-30T09:45:33.766324859Z {"t":{"$date":"2022-09-30T09:45:33.282+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1664531133:282649][1:0x7f9a9295bc80], txn-recover: [WT_VERB_RECOVERY_ALL] Set global oldest timestamp: (1664530794, 1)"}}
2022-09-30T09:45:33.766331509Z {"t":{"$date":"2022-09-30T09:45:33.490+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"initandlisten","msg":"WiredTiger message","attr":{"message":"[1664531133:490348][1:0x7f9a9295bc80], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 20, snapshot max: 20 snapshot count: 0, oldest timestamp: (1664530794, 1) , meta checkpoint timestamp: (1664531094, 1) base write gen: 186766"}}
2022-09-30T09:45:33.766346439Z {"t":{"$date":"2022-09-30T09:45:33.672+00:00"},"s":"I",  "c":"STORAGE",  "id":4795906, "ctx":"initandlisten","msg":"WiredTiger opened","attr":{"durationMillis":12750}}
2022-09-30T09:45:33.766351459Z {"t":{"$date":"2022-09-30T09:45:33.682+00:00"},"s":"I",  "c":"RECOVERY", "id":23987,   "ctx":"initandlisten","msg":"WiredTiger recoveryTimestamp","attr":{"recoveryTimestamp":{"$timestamp":{"t":1664531094,"i":1}}}}
2022-09-30T09:45:33.766356099Z {"t":{"$date":"2022-09-30T09:45:33.689+00:00"},"s":"I",  "c":"RECOVERY", "id":5380106, "ctx":"initandlisten","msg":"WiredTiger oldestTimestamp","attr":{"oldestTimestamp":{"$timestamp":{"t":1664530794,"i":1}}}}
2022-09-30T09:45:34.091263037Z {"t":{"$date":"2022-09-30T09:45:33.967+00:00"},"s":"I",  "c":"STORAGE",  "id":22383,   "ctx":"initandlisten","msg":"The size storer reports that the oplog contains","attr":{"numRecords":90918,"dataSize":29831870}}
2022-09-30T09:45:34.091289917Z {"t":{"$date":"2022-09-30T09:45:33.967+00:00"},"s":"I",  "c":"STORAGE",  "id":22386,   "ctx":"initandlisten","msg":"Sampling the oplog to determine where to place markers for truncation"}
2022-09-30T09:45:34.091295557Z {"t":{"$date":"2022-09-30T09:45:33.997+00:00"},"s":"I",  "c":"STORAGE",  "id":22389,   "ctx":"initandlisten","msg":"Sampling from the oplog to determine where to place markers for truncation","attr":{"from":{"$timestamp":{"t":1663784800,"i":1}},"to":{"$timestamp":{"t":1664531094,"i":1}}}}
2022-09-30T09:45:34.091301257Z {"t":{"$date":"2022-09-30T09:45:33.997+00:00"},"s":"I",  "c":"STORAGE",  "id":22390,   "ctx":"initandlisten","msg":"Taking samples and assuming each oplog section contains","attr":{"numSamples":17,"containsNumRecords":51866,"containsNumBytes":17018189}}
2022-09-30T09:45:34.093632328Z {"t":{"$date":"2022-09-30T09:45:34.051+00:00"},"s":"I",  "c":"STORAGE",  "id":22393,   "ctx":"initandlisten","msg":"Oplog sampling complete"}
2022-09-30T09:45:34.093642698Z {"t":{"$date":"2022-09-30T09:45:34.051+00:00"},"s":"I",  "c":"STORAGE",  "id":22382,   "ctx":"initandlisten","msg":"WiredTiger record store oplog processing finished","attr":{"durationMillis":84}}
2022-09-30T09:45:34.308021155Z {"t":{"$date":"2022-09-30T09:45:34.259+00:00"},"s":"I",  "c":"STORAGE",  "id":22262,   "ctx":"initandlisten","msg":"Timestamp monitor starting"}
2022-09-30T09:45:34.339063889Z {"t":{"$date":"2022-09-30T09:45:34.314+00:00"},"s":"W",  "c":"CONTROL",  "id":22178,   "ctx":"initandlisten","msg":"/sys/kernel/mm/transparent_hugepage/enabled is 'always'. We suggest setting it to 'never'","tags":["startupWarnings"]}
2022-09-30T09:45:34.582182120Z {"t":{"$date":"2022-09-30T09:45:34.430+00:00"},"s":"I",  "c":"NETWORK",  "id":4915702, "ctx":"initandlisten","msg":"Updated wire specification","attr":{"oldSpec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":13},"incomingInternalClient":{"minWireVersion":0,"maxWireVersion":13},"outgoing":{"minWireVersion":0,"maxWireVersion":13},"isInternalClient":true},"newSpec":{"incomingExternalClient":{"minWireVersion":0,"maxWireVersion":13},"incomingInternalClient":{"minWireVersion":13,"maxWireVersion":13},"outgoing":{"minWireVersion":13,"maxWireVersion":13},"isInternalClient":true}}}
2022-09-30T09:45:34.582228010Z {"t":{"$date":"2022-09-30T09:45:34.458+00:00"},"s":"I",  "c":"STORAGE",  "id":5071100, "ctx":"initandlisten","msg":"Clearing temp directory"}
2022-09-30T09:45:34.912502140Z {"t":{"$date":"2022-09-30T09:45:34.819+00:00"},"s":"I",  "c":"CONTROL",  "id":20536,   "ctx":"initandlisten","msg":"Flow Control is enabled on this deployment"}
2022-09-30T09:45:34.912526780Z {"t":{"$date":"2022-09-30T09:45:34.819+00:00"},"s":"I",  "c":"STORAGE",  "id":5380103, "ctx":"initandlisten","msg":"Unpin oldest timestamp request","attr":{"service":"_wt_startup","requestedTs":{"$timestamp":{"t":1664530794,"i":1}}}}
2022-09-30T09:45:34.912532990Z {"t":{"$date":"2022-09-30T09:45:34.859+00:00"},"s":"I",  "c":"SHARDING", "id":20997,   "ctx":"initandlisten","msg":"Refreshed RWC defaults","attr":{"newDefaults":{}}}
2022-09-30T09:45:34.912538130Z {"t":{"$date":"2022-09-30T09:45:34.862+00:00"},"s":"I",  "c":"FTDC",     "id":20625,   "ctx":"initandlisten","msg":"Initializing full-time diagnostic data capture","attr":{"dataDirectory":"/bitnami/mongodb/data/db/diagnostic.data"}}
2022-09-30T09:45:34.912543090Z {"t":{"$date":"2022-09-30T09:45:34.907+00:00"},"s":"I",  "c":"REPL",     "id":6015317, "ctx":"initandlisten","msg":"Setting new configuration state","attr":{"newState":"ConfigStartingUp","oldState":"ConfigPreStart"}}
2022-09-30T09:45:35.136184392Z {"t":{"$date":"2022-09-30T09:45:35.018+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"monitoring-keys-for-HMAC","msg":"Slow query","attr":{"type":"command","ns":"config.external_validation_keys","command":{"find":"external_validation_keys","filter":{"purpose":"HMAC","expiresAt":{"$gt":{"$timestamp":{"t":0,"i":0}}}},"sort":{"expiresAt":1},"readConcern":{},"$readPreference":{"mode":"nearest","tags":[]},"$db":"config"},"planSummary":"COLLSCAN","keysExamined":0,"docsExamined":0,"hasSortStage":true,"cursorExhausted":true,"numYields":1,"nreturned":0,"queryHash":"6DC32749","planCacheKey":"10191ABA","reslen":120,"locks":{"FeatureCompatibilityVersion":{"acquireCount":{"r":2}},"Global":{"acquireCount":{"r":2}},"Mutex":{"acquireCount":{"r":1}}},"readConcern":{"provenance":"implicitDefault"},"storage":{},"protocol":"op_msg","durationMillis":126}}
2022-09-30T09:45:35.136230892Z {"t":{"$date":"2022-09-30T09:45:35.018+00:00"},"s":"I",  "c":"-",        "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextWakeupMillis":200}}
2022-09-30T09:45:35.136238092Z {"t":{"$date":"2022-09-30T09:45:35.078+00:00"},"s":"I",  "c":"REPL",     "id":4280500, "ctx":"initandlisten","msg":"Attempting to create internal replication collections"}
2022-09-30T09:45:35.452155665Z {"t":{"$date":"2022-09-30T09:45:35.190+00:00"},"s":"I",  "c":"REPL",     "id":4280501, "ctx":"initandlisten","msg":"Attempting to load local voted for document"}
2022-09-30T09:45:35.452186045Z {"t":{"$date":"2022-09-30T09:45:35.190+00:00"},"s":"I",  "c":"REPL",     "id":4280502, "ctx":"initandlisten","msg":"Searching for local Rollback ID document"}
2022-09-30T09:45:35.452211805Z {"t":{"$date":"2022-09-30T09:45:35.218+00:00"},"s":"I",  "c":"REPL",     "id":21529,   "ctx":"initandlisten","msg":"Initializing rollback ID","attr":{"rbid":2}}
2022-09-30T09:45:35.452217915Z {"t":{"$date":"2022-09-30T09:45:35.218+00:00"},"s":"I",  "c":"REPL",     "id":4280504, "ctx":"initandlisten","msg":"Cleaning up any partially applied oplog batches & reading last op from oplog"}
2022-09-30T09:45:35.452223135Z {"t":{"$date":"2022-09-30T09:45:35.219+00:00"},"s":"I",  "c":"-",        "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextWakeupMillis":400}}
2022-09-30T09:45:35.452228345Z {"t":{"$date":"2022-09-30T09:45:35.247+00:00"},"s":"I",  "c":"REPL",     "id":21544,   "ctx":"initandlisten","msg":"Recovering from stable timestamp","attr":{"stableTimestamp":{"$timestamp":{"t":1664531094,"i":1}},"topOfOplog":{"ts":{"$timestamp":{"t":1664531094,"i":1}},"t":5},"appliedThrough":{"ts":{"$timestamp":{"t":0,"i":0}},"t":-1}}}
2022-09-30T09:45:35.452233825Z {"t":{"$date":"2022-09-30T09:45:35.247+00:00"},"s":"I",  "c":"REPL",     "id":21545,   "ctx":"initandlisten","msg":"Starting recovery oplog application at the stable timestamp","attr":{"stableTimestamp":{"$timestamp":{"t":1664531094,"i":1}}}}
2022-09-30T09:45:35.452238435Z {"t":{"$date":"2022-09-30T09:45:35.247+00:00"},"s":"I",  "c":"REPL",     "id":5466604, "ctx":"initandlisten","msg":"Start point for recovery oplog application exists in oplog. No adjustment necessary","attr":{"startPoint":{"$timestamp":{"t":1664531094,"i":1}}}}
2022-09-30T09:45:35.452243255Z {"t":{"$date":"2022-09-30T09:45:35.247+00:00"},"s":"I",  "c":"REPL",     "id":21549,   "ctx":"initandlisten","msg":"No oplog entries to apply for recovery. Start point is at the top of the oplog"}
2022-09-30T09:45:35.454003336Z {"t":{"$date":"2022-09-30T09:45:35.247+00:00"},"s":"I",  "c":"REPL",     "id":4280505, "ctx":"initandlisten","msg":"Creating any necessary TenantMigrationAccessBlockers for unfinished migrations"}
2022-09-30T09:45:35.454016346Z {"t":{"$date":"2022-09-30T09:45:35.258+00:00"},"s":"I",  "c":"REPL",     "id":4280506, "ctx":"initandlisten","msg":"Reconstructing prepared transactions"}
2022-09-30T09:45:35.454022266Z {"t":{"$date":"2022-09-30T09:45:35.262+00:00"},"s":"I",  "c":"REPL",     "id":4280507, "ctx":"initandlisten","msg":"Loaded replica set config, scheduled callback to set local config"}
2022-09-30T09:45:35.454028466Z {"t":{"$date":"2022-09-30T09:45:35.262+00:00"},"s":"I",  "c":"REPL",     "id":4280508, "ctx":"ReplCoord-0","msg":"Attempting to set local replica set config; validating config for startup"}
2022-09-30T09:45:35.722056558Z {"t":{"$date":"2022-09-30T09:45:35.566+00:00"},"s":"I",  "c":"CONTROL",  "id":20714,   "ctx":"LogicalSessionCacheRefresh","msg":"Failed to refresh session cache, will try again at the next refresh interval","attr":{"error":"NotYetInitialized: Replication has not yet been configured"}}
2022-09-30T09:45:35.722081908Z {"t":{"$date":"2022-09-30T09:45:35.571+00:00"},"s":"I",  "c":"CONTROL",  "id":20711,   "ctx":"LogicalSessionCacheReap","msg":"Failed to reap transaction table","attr":{"error":"NotYetInitialized: Replication has not yet been configured"}}
2022-09-30T09:45:35.722098168Z {"t":{"$date":"2022-09-30T09:45:35.575+00:00"},"s":"I",  "c":"REPL",     "id":40440,   "ctx":"initandlisten","msg":"Starting the TopologyVersionObserver"}
2022-09-30T09:45:35.722103368Z {"t":{"$date":"2022-09-30T09:45:35.577+00:00"},"s":"I",  "c":"REPL",     "id":40445,   "ctx":"TopologyVersionObserver","msg":"Started TopologyVersionObserver"}
2022-09-30T09:45:35.722108028Z {"t":{"$date":"2022-09-30T09:45:35.627+00:00"},"s":"I",  "c":"-",        "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextWakeupMillis":600}}
2022-09-30T09:45:35.722113018Z {"t":{"$date":"2022-09-30T09:45:35.638+00:00"},"s":"I",  "c":"NETWORK",  "id":23015,   "ctx":"listener","msg":"Listening on","attr":{"address":"/opt/bitnami/mongodb/tmp/mongodb-27017.sock"}}
2022-09-30T09:45:35.722117598Z {"t":{"$date":"2022-09-30T09:45:35.639+00:00"},"s":"I",  "c":"NETWORK",  "id":23015,   "ctx":"listener","msg":"Listening on","attr":{"address":"0.0.0.0"}}
2022-09-30T09:45:35.722122098Z {"t":{"$date":"2022-09-30T09:45:35.639+00:00"},"s":"I",  "c":"NETWORK",  "id":23016,   "ctx":"listener","msg":"Waiting for connections","attr":{"port":27017,"ssl":"off"}}
2022-09-30T09:45:36.138374697Z {"t":{"$date":"2022-09-30T09:45:35.860+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:45712","uuid":"55f49fbc-37d3-464d-9669-34a76932aac6","connectionId":2,"connectionCount":1}}
2022-09-30T09:45:36.138411817Z {"t":{"$date":"2022-09-30T09:45:35.880+00:00"},"s":"W",  "c":"COMMAND",  "id":5578800, "ctx":"conn2","msg":"Deprecated operation requested. The client driver may require an upgrade in order to ensure compatibility with future server versions. For more details see https://dochub.mongodb.org/core/legacy-opcode-compatibility","attr":{"op":"query","clientInfo":{"address":"10.0.1.7:45712"}}}
2022-09-30T09:45:36.138420027Z {"t":{"$date":"2022-09-30T09:45:35.997+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn2","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":false,"principalName":"__system","authenticationDatabase":"local","remote":"10.0.1.7:45712","extraInfo":{}}}
2022-09-30T09:45:36.138427507Z {"t":{"$date":"2022-09-30T09:45:35.998+00:00"},"s":"I",  "c":"REPL",     "id":4280509, "ctx":"ReplCoord-0","msg":"Local configuration validated for startup"}
2022-09-30T09:45:36.138433237Z {"t":{"$date":"2022-09-30T09:45:35.998+00:00"},"s":"I",  "c":"REPL",     "id":6015317, "ctx":"ReplCoord-0","msg":"Setting new configuration state","attr":{"newState":"ConfigSteady","oldState":"ConfigStartingUp"}}
2022-09-30T09:45:36.138439197Z {"t":{"$date":"2022-09-30T09:45:35.998+00:00"},"s":"I",  "c":"REPL",     "id":21392,   "ctx":"ReplCoord-0","msg":"New replica set config in use","attr":{"config":{"_id":"rs0","version":1,"term":5,"members":[{"_id":0,"host":"srv-captain--chat-db:27017","arbiterOnly":false,"buildIndexes":true,"hidden":false,"priority":5,"tags":{},"secondaryDelaySecs":0,"votes":1}],"protocolVersion":1,"writeConcernMajorityJournalDefault":true,"settings":{"chainingAllowed":true,"heartbeatIntervalMillis":2000,"heartbeatTimeoutSecs":10,"electionTimeoutMillis":10000,"catchUpTimeoutMillis":-1,"catchUpTakeoverDelayMillis":30000,"getLastErrorModes":{},"getLastErrorDefaults":{"w":1,"wtimeout":0},"replicaSetId":{"$oid":"632b575fafd4e4bcd0f96e25"}}}}}
2022-09-30T09:45:36.138470097Z {"t":{"$date":"2022-09-30T09:45:35.998+00:00"},"s":"I",  "c":"REPL",     "id":21393,   "ctx":"ReplCoord-0","msg":"Found self in config","attr":{"hostAndPort":"srv-captain--chat-db:27017"}}
2022-09-30T09:45:36.138477077Z {"t":{"$date":"2022-09-30T09:45:35.998+00:00"},"s":"I",  "c":"REPL",     "id":21358,   "ctx":"ReplCoord-0","msg":"Replica set state transition","attr":{"newState":"STARTUP2","oldState":"STARTUP"}}
2022-09-30T09:45:36.138482987Z {"t":{"$date":"2022-09-30T09:45:35.998+00:00"},"s":"I",  "c":"REPL",     "id":21320,   "ctx":"ReplCoord-0","msg":"Updated term","attr":{"term":5}}
2022-09-30T09:45:36.138488157Z {"t":{"$date":"2022-09-30T09:45:35.998+00:00"},"s":"I",  "c":"REPL",     "id":21306,   "ctx":"ReplCoord-0","msg":"Starting replication storage threads"}
2022-09-30T09:45:36.138493297Z {"t":{"$date":"2022-09-30T09:45:36.070+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn2","msg":"Connection ended","attr":{"remote":"10.0.1.7:45712","uuid":"55f49fbc-37d3-464d-9669-34a76932aac6","connectionId":2,"connectionCount":0}}
2022-09-30T09:45:36.138499217Z {"t":{"$date":"2022-09-30T09:45:36.088+00:00"},"s":"I",  "c":"REPL",     "id":4280512, "ctx":"ReplCoord-0","msg":"No initial sync required. Attempting to begin steady replication"}
2022-09-30T09:45:36.138504287Z {"t":{"$date":"2022-09-30T09:45:36.088+00:00"},"s":"I",  "c":"REPL",     "id":21358,   "ctx":"ReplCoord-0","msg":"Replica set state transition","attr":{"newState":"RECOVERING","oldState":"STARTUP2"}}
2022-09-30T09:45:36.425216397Z {"t":{"$date":"2022-09-30T09:45:36.163+00:00"},"s":"I",  "c":"REPL",     "id":21299,   "ctx":"ReplCoord-0","msg":"Starting replication fetcher thread"}
2022-09-30T09:45:36.425245368Z {"t":{"$date":"2022-09-30T09:45:36.163+00:00"},"s":"I",  "c":"REPL",     "id":21300,   "ctx":"ReplCoord-0","msg":"Starting replication applier thread"}
2022-09-30T09:45:36.425250618Z {"t":{"$date":"2022-09-30T09:45:36.163+00:00"},"s":"I",  "c":"REPL",     "id":21301,   "ctx":"ReplCoord-0","msg":"Starting replication reporter thread"}
2022-09-30T09:45:36.425255428Z {"t":{"$date":"2022-09-30T09:45:36.163+00:00"},"s":"I",  "c":"REPL",     "id":4280511, "ctx":"ReplCoord-0","msg":"Set local replica set config"}
2022-09-30T09:45:36.425259878Z {"t":{"$date":"2022-09-30T09:45:36.163+00:00"},"s":"I",  "c":"REPL",     "id":21224,   "ctx":"OplogApplier-0","msg":"Starting oplog application"}
2022-09-30T09:45:36.425264298Z {"t":{"$date":"2022-09-30T09:45:36.188+00:00"},"s":"I",  "c":"REPL",     "id":21358,   "ctx":"OplogApplier-0","msg":"Replica set state transition","attr":{"newState":"SECONDARY","oldState":"RECOVERING"}}
2022-09-30T09:45:36.425279718Z {"t":{"$date":"2022-09-30T09:45:36.188+00:00"},"s":"I",  "c":"ELECTION", "id":4615652, "ctx":"OplogApplier-0","msg":"Starting an election, since we've seen no PRIMARY in election timeout period","attr":{"electionTimeoutPeriodMillis":10000}}
2022-09-30T09:45:36.425284638Z {"t":{"$date":"2022-09-30T09:45:36.188+00:00"},"s":"I",  "c":"ELECTION", "id":21438,   "ctx":"OplogApplier-0","msg":"Conducting a dry run election to see if we could be elected","attr":{"currentTerm":5}}
2022-09-30T09:45:36.425288958Z {"t":{"$date":"2022-09-30T09:45:36.188+00:00"},"s":"I",  "c":"ELECTION", "id":21444,   "ctx":"ReplCoord-0","msg":"Dry election run succeeded, running for election","attr":{"newTerm":6}}
2022-09-30T09:45:36.425293258Z {"t":{"$date":"2022-09-30T09:45:36.188+00:00"},"s":"I",  "c":"ELECTION", "id":6015300, "ctx":"ReplCoord-0","msg":"Storing last vote document in local storage for my election","attr":{"lastVote":{"term":6,"candidateIndex":0}}}
2022-09-30T09:45:36.425297868Z {"t":{"$date":"2022-09-30T09:45:36.204+00:00"},"s":"I",  "c":"ELECTION", "id":21450,   "ctx":"ReplCoord-0","msg":"Election succeeded, assuming primary role","attr":{"term":6}}
2022-09-30T09:45:36.425304088Z {"t":{"$date":"2022-09-30T09:45:36.204+00:00"},"s":"I",  "c":"REPL",     "id":21358,   "ctx":"ReplCoord-0","msg":"Replica set state transition","attr":{"newState":"PRIMARY","oldState":"SECONDARY"}}
2022-09-30T09:45:36.425308678Z {"t":{"$date":"2022-09-30T09:45:36.204+00:00"},"s":"I",  "c":"REPL",     "id":21106,   "ctx":"ReplCoord-0","msg":"Resetting sync source to empty","attr":{"previousSyncSource":":27017"}}
2022-09-30T09:45:36.425312918Z {"t":{"$date":"2022-09-30T09:45:36.204+00:00"},"s":"I",  "c":"REPL",     "id":21359,   "ctx":"ReplCoord-0","msg":"Entering primary catch-up mode"}
2022-09-30T09:45:36.425316888Z {"t":{"$date":"2022-09-30T09:45:36.204+00:00"},"s":"I",  "c":"REPL",     "id":6015304, "ctx":"ReplCoord-0","msg":"Skipping primary catchup since we are the only node in the replica set."}
2022-09-30T09:45:36.425321348Z {"t":{"$date":"2022-09-30T09:45:36.204+00:00"},"s":"I",  "c":"REPL",     "id":21363,   "ctx":"ReplCoord-0","msg":"Exited primary catch-up mode"}
2022-09-30T09:45:36.425326628Z {"t":{"$date":"2022-09-30T09:45:36.204+00:00"},"s":"I",  "c":"REPL",     "id":21107,   "ctx":"ReplCoord-0","msg":"Stopping replication producer"}
2022-09-30T09:45:36.432689481Z {"t":{"$date":"2022-09-30T09:45:36.204+00:00"},"s":"I",  "c":"REPL",     "id":21239,   "ctx":"ReplBatcher","msg":"Oplog buffer has been drained","attr":{"term":6}}
2022-09-30T09:45:36.432704441Z {"t":{"$date":"2022-09-30T09:45:36.205+00:00"},"s":"I",  "c":"REPL",     "id":21343,   "ctx":"RstlKillOpThread","msg":"Starting to kill user operations"}
2022-09-30T09:45:36.432709681Z {"t":{"$date":"2022-09-30T09:45:36.206+00:00"},"s":"I",  "c":"REPL",     "id":21344,   "ctx":"RstlKillOpThread","msg":"Stopped killing user operations"}
2022-09-30T09:45:36.432714181Z {"t":{"$date":"2022-09-30T09:45:36.206+00:00"},"s":"I",  "c":"REPL",     "id":21340,   "ctx":"RstlKillOpThread","msg":"State transition ops metrics","attr":{"metrics":{"lastStateTransition":"stepUp","userOpsKilled":0,"userOpsRunning":0}}}
2022-09-30T09:45:36.432741411Z {"t":{"$date":"2022-09-30T09:45:36.207+00:00"},"s":"I",  "c":"REPL",     "id":4508103, "ctx":"OplogApplier-0","msg":"Increment the config term via reconfig"}
2022-09-30T09:45:36.432749221Z {"t":{"$date":"2022-09-30T09:45:36.207+00:00"},"s":"I",  "c":"REPL",     "id":6015313, "ctx":"OplogApplier-0","msg":"Replication config state is Steady, starting reconfig"}
2022-09-30T09:45:36.432766801Z {"t":{"$date":"2022-09-30T09:45:36.207+00:00"},"s":"I",  "c":"REPL",     "id":6015317, "ctx":"OplogApplier-0","msg":"Setting new configuration state","attr":{"newState":"ConfigReconfiguring","oldState":"ConfigSteady"}}
2022-09-30T09:45:36.432777791Z {"t":{"$date":"2022-09-30T09:45:36.207+00:00"},"s":"I",  "c":"REPL",     "id":21353,   "ctx":"OplogApplier-0","msg":"replSetReconfig config object parses ok","attr":{"numMembers":1}}
2022-09-30T09:45:36.432782141Z {"t":{"$date":"2022-09-30T09:45:36.207+00:00"},"s":"I",  "c":"REPL",     "id":51814,   "ctx":"OplogApplier-0","msg":"Persisting new config to disk"}
2022-09-30T09:45:36.432787341Z {"t":{"$date":"2022-09-30T09:45:36.211+00:00"},"s":"I",  "c":"REPL",     "id":6015315, "ctx":"OplogApplier-0","msg":"Persisted new config to disk"}
2022-09-30T09:45:36.432791841Z {"t":{"$date":"2022-09-30T09:45:36.211+00:00"},"s":"I",  "c":"REPL",     "id":6015317, "ctx":"OplogApplier-0","msg":"Setting new configuration state","attr":{"newState":"ConfigSteady","oldState":"ConfigReconfiguring"}}
2022-09-30T09:45:36.432796601Z {"t":{"$date":"2022-09-30T09:45:36.211+00:00"},"s":"I",  "c":"REPL",     "id":21392,   "ctx":"OplogApplier-0","msg":"New replica set config in use","attr":{"config":{"_id":"rs0","version":1,"term":6,"members":[{"_id":0,"host":"srv-captain--chat-db:27017","arbiterOnly":false,"buildIndexes":true,"hidden":false,"priority":5,"tags":{},"secondaryDelaySecs":0,"votes":1}],"protocolVersion":1,"writeConcernMajorityJournalDefault":true,"settings":{"chainingAllowed":true,"heartbeatIntervalMillis":2000,"heartbeatTimeoutSecs":10,"electionTimeoutMillis":10000,"catchUpTimeoutMillis":-1,"catchUpTakeoverDelayMillis":30000,"getLastErrorModes":{},"getLastErrorDefaults":{"w":1,"wtimeout":0},"replicaSetId":{"$oid":"632b575fafd4e4bcd0f96e25"}}}}}
2022-09-30T09:45:36.432806271Z {"t":{"$date":"2022-09-30T09:45:36.211+00:00"},"s":"I",  "c":"REPL",     "id":21393,   "ctx":"OplogApplier-0","msg":"Found self in config","attr":{"hostAndPort":"srv-captain--chat-db:27017"}}
2022-09-30T09:45:36.432812021Z {"t":{"$date":"2022-09-30T09:45:36.211+00:00"},"s":"I",  "c":"REPL",     "id":6015310, "ctx":"OplogApplier-0","msg":"Starting to transition to primary."}
2022-09-30T09:45:36.432822131Z {"t":{"$date":"2022-09-30T09:45:36.212+00:00"},"s":"I",  "c":"REPL",     "id":6015309, "ctx":"OplogApplier-0","msg":"Logging transition to primary to oplog on stepup"}
2022-09-30T09:45:36.432827821Z {"t":{"$date":"2022-09-30T09:45:36.212+00:00"},"s":"I",  "c":"STORAGE",  "id":20657,   "ctx":"OplogApplier-0","msg":"IndexBuildsCoordinator::onStepUp - this node is stepping up to primary"}
2022-09-30T09:45:36.432834461Z {"t":{"$date":"2022-09-30T09:45:36.230+00:00"},"s":"I",  "c":"REPL",     "id":21331,   "ctx":"OplogApplier-0","msg":"Transition to primary complete; database writes are now permitted"}
2022-09-30T09:45:36.432857771Z {"t":{"$date":"2022-09-30T09:45:36.231+00:00"},"s":"I",  "c":"-",        "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextWakeupMillis":800}}
2022-09-30T09:45:36.432870991Z {"t":{"$date":"2022-09-30T09:45:36.281+00:00"},"s":"I",  "c":"REPL",     "id":5123005, "ctx":"TenantMigrationDonorService-0","msg":"Rebuilding PrimaryOnlyService due to stepUp","attr":{"service":"TenantMigrationDonorService"}}
2022-09-30T09:45:36.432877401Z {"t":{"$date":"2022-09-30T09:45:36.282+00:00"},"s":"I",  "c":"REPL",     "id":5123005, "ctx":"TenantMigrationRecipientService-0","msg":"Rebuilding PrimaryOnlyService due to stepUp","attr":{"service":"TenantMigrationRecipientService"}}
2022-09-30T09:45:51.170570308Z {"t":{"$date":"2022-09-30T09:45:51.141+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:33318","uuid":"3d0455d3-59aa-476d-bde6-f15b5792acf7","connectionId":3,"connectionCount":1}}
2022-09-30T09:45:51.255283517Z {"t":{"$date":"2022-09-30T09:45:51.197+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn3","msg":"client metadata","attr":{"remote":"10.0.1.7:33318","client":"conn3","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:45:51.437466600Z {"t":{"$date":"2022-09-30T09:45:51.348+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:33320","uuid":"9c77b014-a344-42c1-9846-debff76c86e7","connectionId":4,"connectionCount":2}}
2022-09-30T09:45:51.437503350Z {"t":{"$date":"2022-09-30T09:45:51.350+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn4","msg":"client metadata","attr":{"remote":"10.0.1.7:33320","client":"conn4","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:45:51.496104206Z {"t":{"$date":"2022-09-30T09:45:51.438+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn4","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:33320","extraInfo":{}}}
2022-09-30T09:45:54.518229750Z {"t":{"$date":"2022-09-30T09:45:54.456+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:33322","uuid":"9be48aed-5a20-4afb-970c-3ee3fbd88e95","connectionId":5,"connectionCount":3}}
2022-09-30T09:45:54.529769175Z {"t":{"$date":"2022-09-30T09:45:54.459+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn5","msg":"client metadata","attr":{"remote":"10.0.1.7:33322","client":"conn5","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:45:54.529817965Z {"t":{"$date":"2022-09-30T09:45:54.468+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn5","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:33322","extraInfo":{}}}
2022-09-30T09:46:02.479079197Z {"t":{"$date":"2022-09-30T09:46:02.314+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn3","msg":"Slow query","attr":{"type":"command","ns":"admin.$cmd","command":{"hello":true,"maxAwaitTimeMS":10000,"topologyVersion":{"processId":{"$oid":"6336bab0fc6a26ac71e7a347"},"counter":6},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531146,"i":1}},"signature":{"hash":{"$binary":{"base64":"hLk9EN9+g9g+sCNYiK1SWjUMSLk=","subType":"0"}},"keyId":7145901303581900806}},"$db":"admin"},"numYields":0,"reslen":774,"locks":{},"remote":"10.0.1.7:33318","protocol":"op_msg","durationMillis":103}}
2022-09-30T09:46:12.860803045Z {"t":{"$date":"2022-09-30T09:46:12.813+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:33326","uuid":"0d00391b-ceaf-4da8-83f7-eafc6e92d957","connectionId":6,"connectionCount":4}}
2022-09-30T09:46:12.867991708Z {"t":{"$date":"2022-09-30T09:46:12.826+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:33328","uuid":"23ff0b92-7eed-4b83-bae9-6583bd66c89d","connectionId":7,"connectionCount":5}}
2022-09-30T09:46:12.868007729Z {"t":{"$date":"2022-09-30T09:46:12.829+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn6","msg":"client metadata","attr":{"remote":"10.0.1.7:33326","client":"conn6","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:46:12.868015519Z {"t":{"$date":"2022-09-30T09:46:12.838+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn7","msg":"client metadata","attr":{"remote":"10.0.1.7:33328","client":"conn7","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:46:12.900876713Z {"t":{"$date":"2022-09-30T09:46:12.861+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn7","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:33328","extraInfo":{}}}
2022-09-30T09:46:12.925987285Z {"t":{"$date":"2022-09-30T09:46:12.909+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:33330","uuid":"ebc365c4-e67f-4e5c-87d6-93cb3659b403","connectionId":8,"connectionCount":6}}
2022-09-30T09:46:12.926013845Z {"t":{"$date":"2022-09-30T09:46:12.914+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn8","msg":"client metadata","attr":{"remote":"10.0.1.7:33330","client":"conn8","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:46:12.947722415Z {"t":{"$date":"2022-09-30T09:46:12.926+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn8","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:33330","extraInfo":{}}}
2022-09-30T09:46:12.970589695Z {"t":{"$date":"2022-09-30T09:46:12.950+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:33332","uuid":"3099f797-1363-4a20-8435-19fb2189cdee","connectionId":9,"connectionCount":7}}
2022-09-30T09:46:12.970618335Z {"t":{"$date":"2022-09-30T09:46:12.955+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn9","msg":"client metadata","attr":{"remote":"10.0.1.7:33332","client":"conn9","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:46:12.970628545Z {"t":{"$date":"2022-09-30T09:46:12.958+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn9","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:33332","extraInfo":{}}}
2022-09-30T09:46:14.918093510Z {"t":{"$date":"2022-09-30T09:46:14.864+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:33338","uuid":"3579200b-aeae-40be-aa86-8b7eb880379d","connectionId":10,"connectionCount":8}}
2022-09-30T09:46:14.918235820Z {"t":{"$date":"2022-09-30T09:46:14.865+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn10","msg":"client metadata","attr":{"remote":"10.0.1.7:33338","client":"conn10","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:46:14.918243840Z {"t":{"$date":"2022-09-30T09:46:14.870+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn10","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:33338","extraInfo":{}}}
2022-09-30T09:46:14.967796123Z {"t":{"$date":"2022-09-30T09:46:14.922+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:33340","uuid":"de89ec64-6dec-47d6-b962-7f23e7b9526e","connectionId":11,"connectionCount":9}}
2022-09-30T09:46:14.967829083Z {"t":{"$date":"2022-09-30T09:46:14.941+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn11","msg":"client metadata","attr":{"remote":"10.0.1.7:33340","client":"conn11","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:46:14.967866453Z {"t":{"$date":"2022-09-30T09:46:14.946+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn11","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:33340","extraInfo":{}}}
2022-09-30T09:46:15.025987799Z {"t":{"$date":"2022-09-30T09:46:14.989+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:33342","uuid":"b4893054-e077-4396-a389-bfc2c2be4487","connectionId":12,"connectionCount":10}}
2022-09-30T09:46:15.026017619Z {"t":{"$date":"2022-09-30T09:46:14.989+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn12","msg":"client metadata","attr":{"remote":"10.0.1.7:33342","client":"conn12","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:46:15.026025489Z {"t":{"$date":"2022-09-30T09:46:14.995+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn12","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:33342","extraInfo":{}}}
2022-09-30T09:46:15.056888703Z {"t":{"$date":"2022-09-30T09:46:15.028+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:33344","uuid":"89ed5b7f-32a8-43b5-ac3d-d7480eeccf8e","connectionId":13,"connectionCount":11}}
2022-09-30T09:46:15.056935343Z {"t":{"$date":"2022-09-30T09:46:15.029+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn13","msg":"client metadata","attr":{"remote":"10.0.1.7:33344","client":"conn13","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:46:15.056943863Z {"t":{"$date":"2022-09-30T09:46:15.033+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn13","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:33344","extraInfo":{}}}
2022-09-30T09:46:23.202645605Z {"t":{"$date":"2022-09-30T09:46:23.181+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn11","msg":"Slow query","attr":{"type":"command","ns":"rocketchat.migrations","command":{"find":"migrations","filter":{"_id":"control"},"limit":1,"lsid":{"id":{"$uuid":"f6fecc46-bbba-4b4e-ae07-efea31cf325b"}},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531166,"i":1}},"signature":{"hash":{"$binary":{"base64":"KkGXCtrP4ZVi5Z4cuHcmSG7YxdY=","subType":"0"}},"keyId":7145901303581900806}},"$db":"rocketchat"},"planSummary":"IDHACK","keysExamined":1,"docsExamined":1,"cursorExhausted":true,"numYields":1,"nreturned":1,"reslen":338,"locks":{"FeatureCompatibilityVersion":{"acquireCount":{"r":2}},"Global":{"acquireCount":{"r":2}},"Mutex":{"acquireCount":{"r":1}}},"readConcern":{"level":"local","provenance":"implicitDefault"},"storage":{"data":{"bytesRead":354,"timeReadingMicros":10}},"remote":"10.0.1.7:33340","protocol":"op_msg","durationMillis":281}}
2022-09-30T09:46:35.373895996Z {"t":{"$date":"2022-09-30T09:46:35.069+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"Checkpointer","msg":"WiredTiger message","attr":{"message":"[1664531195:67499][1:0x7f9a89948700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 38, snapshot max: 38 snapshot count: 0, oldest timestamp: (1664530886, 1) , meta checkpoint timestamp: (1664531186, 1) base write gen: 186766"}}
2022-09-30T09:46:35.738589052Z {"t":{"$date":"2022-09-30T09:46:35.624+00:00"},"s":"I",  "c":"INDEX",    "id":5479200, "ctx":"TTLMonitor","msg":"Deleted expired documents using index","attr":{"namespace":"rocketchat.rocketchat_cron_history","index":"startedAt_1","numDeleted":1,"durationMillis":115}}
2022-09-30T09:46:54.697382547Z {"t":{"$date":"2022-09-30T09:46:53.355+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn3","msg":"Slow query","attr":{"type":"command","ns":"admin.$cmd","command":{"hello":true,"maxAwaitTimeMS":10000,"topologyVersion":{"processId":{"$oid":"6336bab0fc6a26ac71e7a347"},"counter":6},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531146,"i":1}},"signature":{"hash":{"$binary":{"base64":"hLk9EN9+g9g+sCNYiK1SWjUMSLk=","subType":"0"}},"keyId":7145901303581900806}},"$db":"admin"},"numYields":0,"reslen":774,"locks":{},"remote":"10.0.1.7:33318","protocol":"op_msg","durationMillis":130}}
2022-09-30T09:47:00.755828031Z {"t":{"$date":"2022-09-30T09:47:00.298+00:00"},"s":"I",  "c":"WRITE",    "id":51803,   "ctx":"conn12","msg":"Slow query","attr":{"type":"remove","ns":"rocketchat.meteor_oauth_pendingCredentials","command":{"q":{"createdAt":{"$lt":{"$date":"2022-09-30T09:46:00.087Z"}}},"limit":0},"planSummary":"IXSCAN { createdAt: 1 }","keysExamined":0,"docsExamined":0,"ndeleted":0,"numYields":0,"queryHash":"C46DAAFC","planCacheKey":"5B82670B","locks":{"ParallelBatchWriterMode":{"acquireCount":{"r":1}},"FeatureCompatibilityVersion":{"acquireCount":{"w":1}},"ReplicationStateTransition":{"acquireCount":{"w":1}},"Global":{"acquireCount":{"w":1}},"Database":{"acquireCount":{"w":1}},"Collection":{"acquireCount":{"w":1}},"Mutex":{"acquireCount":{"r":1}}},"flowControl":{"acquireCount":1,"timeAcquiringMicros":4},"readConcern":{"level":"local","provenance":"implicitDefault"},"storage":{"timeWaitingMicros":{"schemaLock":24597}},"remote":"10.0.1.7:33342","durationMillis":127}}
2022-09-30T09:47:00.901230927Z {"t":{"$date":"2022-09-30T09:47:00.301+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn12","msg":"Slow query","attr":{"type":"command","ns":"rocketchat.$cmd","command":{"delete":"meteor_oauth_pendingCredentials","deletes":[{"q":{"createdAt":{"$lt":{"$date":"2022-09-30T09:46:00.087Z"}}},"limit":0}],"ordered":true,"lsid":{"id":{"$uuid":"abba8602-e857-4d70-8572-6e875f943b0e"}},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531166,"i":1}},"signature":{"hash":{"$binary":{"base64":"KkGXCtrP4ZVi5Z4cuHcmSG7YxdY=","subType":"0"}},"keyId":7145901303581900806}},"$db":"rocketchat"},"numYields":0,"reslen":230,"locks":{"ParallelBatchWriterMode":{"acquireCount":{"r":1}},"FeatureCompatibilityVersion":{"acquireCount":{"r":3,"w":1}},"ReplicationStateTransition":{"acquireCount":{"w":4}},"Global":{"acquireCount":{"r":3,"w":1}},"Database":{"acquireCount":{"w":1}},"Collection":{"acquireCount":{"w":1}},"Mutex":{"acquireCount":{"r":1}}},"flowControl":{"acquireCount":1,"timeAcquiringMicros":4},"readConcern":{"level":"local","provenance":"implicitDefault"},"writeConcern":{"w":"majority","wtimeout":0,"provenance":"implicitDefault"},"storage":{},"remote":"10.0.1.7:33342","protocol":"op_msg","durationMillis":141}}
2022-09-30T09:47:00.901338567Z {"t":{"$date":"2022-09-30T09:47:00.372+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn13","msg":"Slow query","attr":{"type":"command","ns":"rocketchat.users","command":{"find":"users","filter":{"_id":"rocket.cat"},"projection":{"__rooms":0},"limit":1,"lsid":{"id":{"$uuid":"96f2a91d-d991-41d7-8416-1244800e60c8"}},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531195,"i":1}},"signature":{"hash":{"$binary":{"base64":"2sV+f7O+dW/W3F18qPzFp2v9Ibs=","subType":"0"}},"keyId":7145901303581900806}},"$db":"rocketchat"},"planSummary":"IDHACK","keysExamined":1,"docsExamined":1,"cursorExhausted":true,"numYields":1,"nreturned":1,"reslen":485,"locks":{"FeatureCompatibilityVersion":{"acquireCount":{"r":2}},"Global":{"acquireCount":{"r":2}},"Mutex":{"acquireCount":{"r":1}}},"readConcern":{"level":"local","provenance":"implicitDefault"},"storage":{"data":{"bytesRead":4344,"timeReadingMicros":6454},"timeWaitingMicros":{"schemaLock":39824}},"remote":"10.0.1.7:33344","protocol":"op_msg","durationMillis":234}}
2022-09-30T09:47:16.330838788Z {"t":{"$date":"2022-09-30T09:47:16.234+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn13","msg":"Slow query","attr":{"type":"command","ns":"rocketchat.$cmd","command":{"createIndexes":"users","indexes":[{"name":"services.apple.id_1","key":{"services.apple.id":1},"unique":true,"sparse":true}],"lsid":{"id":{"$uuid":"96f2a91d-d991-41d7-8416-1244800e60c8"}},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531226,"i":1}},"signature":{"hash":{"$binary":{"base64":"Y13kmxGKJ3Qbh5ySwqQujZwgOjU=","subType":"0"}},"keyId":7145901303581900806}},"$db":"rocketchat"},"numYields":0,"reslen":242,"locks":{"ParallelBatchWriterMode":{"acquireCount":{"r":2}},"FeatureCompatibilityVersion":{"acquireCount":{"r":4}},"ReplicationStateTransition":{"acquireCount":{"w":4}},"Global":{"acquireCount":{"r":4}},"Database":{"acquireCount":{"r":2}},"Collection":{"acquireCount":{"r":2}},"Mutex":{"acquireCount":{"r":2}}},"readConcern":{"level":"local","provenance":"implicitDefault"},"writeConcern":{"w":"majority","wtimeout":0,"provenance":"implicitDefault"},"storage":{},"remote":"10.0.1.7:33344","protocol":"op_msg","durationMillis":384}}
2022-09-30T09:47:35.801341157Z {"t":{"$date":"2022-09-30T09:47:35.673+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"Checkpointer","msg":"WiredTiger message","attr":{"message":"[1664531255:672513][1:0x7f9a89948700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 53, snapshot max: 53 snapshot count: 0, oldest timestamp: (1664530937, 1) , meta checkpoint timestamp: (1664531237, 1) base write gen: 186766"}}
2022-09-30T09:48:05.907291248Z {"t":{"$date":"2022-09-30T09:48:05.128+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn3","msg":"Slow query","attr":{"type":"command","ns":"admin.$cmd","command":{"hello":true,"maxAwaitTimeMS":10000,"topologyVersion":{"processId":{"$oid":"6336bab0fc6a26ac71e7a347"},"counter":6},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531146,"i":1}},"signature":{"hash":{"$binary":{"base64":"hLk9EN9+g9g+sCNYiK1SWjUMSLk=","subType":"0"}},"keyId":7145901303581900806}},"$db":"admin"},"numYields":0,"reslen":774,"locks":{},"remote":"10.0.1.7:33318","protocol":"op_msg","durationMillis":125}}
2022-09-30T09:48:15.637015879Z {"t":{"$date":"2022-09-30T09:48:15.561+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn3","msg":"Slow query","attr":{"type":"command","ns":"admin.$cmd","command":{"hello":true,"maxAwaitTimeMS":10000,"topologyVersion":{"processId":{"$oid":"6336bab0fc6a26ac71e7a347"},"counter":6},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531146,"i":1}},"signature":{"hash":{"$binary":{"base64":"hLk9EN9+g9g+sCNYiK1SWjUMSLk=","subType":"0"}},"keyId":7145901303581900806}},"$db":"admin"},"numYields":0,"reslen":774,"locks":{},"remote":"10.0.1.7:33318","protocol":"op_msg","durationMillis":135}}
2022-09-30T09:48:36.321100339Z {"t":{"$date":"2022-09-30T09:48:36.296+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"Checkpointer","msg":"WiredTiger message","attr":{"message":"[1664531316:293735][1:0x7f9a89948700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 68, snapshot max: 68 snapshot count: 0, oldest timestamp: (1664531015, 1) , meta checkpoint timestamp: (1664531307, 1) base write gen: 186766"}}
2022-09-30T09:48:50.567157683Z {"t":{"$date":"2022-09-30T09:48:50.418+00:00"},"s":"I",  "c":"-",        "id":20883,   "ctx":"conn3","msg":"Interrupted operation as its client disconnected","attr":{"opId":3246}}
2022-09-30T09:48:50.569014084Z {"t":{"$date":"2022-09-30T09:48:50.460+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn4","msg":"Connection ended","attr":{"remote":"10.0.1.7:33320","uuid":"9c77b014-a344-42c1-9846-debff76c86e7","connectionId":4,"connectionCount":8}}
2022-09-30T09:48:50.569042154Z {"t":{"$date":"2022-09-30T09:48:50.465+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn13","msg":"Connection ended","attr":{"remote":"10.0.1.7:33344","uuid":"89ed5b7f-32a8-43b5-ac3d-d7480eeccf8e","connectionId":13,"connectionCount":7}}
2022-09-30T09:48:50.569059494Z {"t":{"$date":"2022-09-30T09:48:50.460+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn9","msg":"Connection ended","attr":{"remote":"10.0.1.7:33332","uuid":"3099f797-1363-4a20-8435-19fb2189cdee","connectionId":9,"connectionCount":10}}
2022-09-30T09:48:50.569066264Z {"t":{"$date":"2022-09-30T09:48:50.465+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn6","msg":"Connection ended","attr":{"remote":"10.0.1.7:33326","uuid":"0d00391b-ceaf-4da8-83f7-eafc6e92d957","connectionId":6,"connectionCount":5}}
2022-09-30T09:48:50.569071884Z {"t":{"$date":"2022-09-30T09:48:50.465+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn7","msg":"Connection ended","attr":{"remote":"10.0.1.7:33328","uuid":"23ff0b92-7eed-4b83-bae9-6583bd66c89d","connectionId":7,"connectionCount":4}}
2022-09-30T09:48:50.569077454Z {"t":{"$date":"2022-09-30T09:48:50.465+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn5","msg":"Connection ended","attr":{"remote":"10.0.1.7:33322","uuid":"9be48aed-5a20-4afb-970c-3ee3fbd88e95","connectionId":5,"connectionCount":3}}
2022-09-30T09:48:50.569100524Z {"t":{"$date":"2022-09-30T09:48:50.465+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn8","msg":"Connection ended","attr":{"remote":"10.0.1.7:33330","uuid":"ebc365c4-e67f-4e5c-87d6-93cb3659b403","connectionId":8,"connectionCount":2}}
2022-09-30T09:48:50.569110634Z {"t":{"$date":"2022-09-30T09:48:50.465+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn12","msg":"Connection ended","attr":{"remote":"10.0.1.7:33342","uuid":"b4893054-e077-4396-a389-bfc2c2be4487","connectionId":12,"connectionCount":9}}
2022-09-30T09:48:50.569116214Z {"t":{"$date":"2022-09-30T09:48:50.461+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn10","msg":"Connection ended","attr":{"remote":"10.0.1.7:33338","uuid":"3579200b-aeae-40be-aa86-8b7eb880379d","connectionId":10,"connectionCount":6}}
2022-09-30T09:48:50.569121294Z {"t":{"$date":"2022-09-30T09:48:50.467+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn11","msg":"Connection ended","attr":{"remote":"10.0.1.7:33340","uuid":"de89ec64-6dec-47d6-b962-7f23e7b9526e","connectionId":11,"connectionCount":1}}
2022-09-30T09:48:50.569126184Z {"t":{"$date":"2022-09-30T09:48:50.479+00:00"},"s":"I",  "c":"NETWORK",  "id":22989,   "ctx":"conn3","msg":"Error sending response to client. Ending connection from remote","attr":{"error":{"code":6,"codeName":"HostUnreachable","errmsg":"Connection reset by peer"},"remote":"10.0.1.7:33318","connectionId":3}}
2022-09-30T09:48:50.569324654Z {"t":{"$date":"2022-09-30T09:48:50.479+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn3","msg":"Connection ended","attr":{"remote":"10.0.1.7:33318","uuid":"3d0455d3-59aa-476d-bde6-f15b5792acf7","connectionId":3,"connectionCount":0}}
2022-09-30T09:49:12.662601634Z {"t":{"$date":"2022-09-30T09:49:12.513+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:38452","uuid":"cb04f834-f7b8-4955-a62e-68c3f6f02d57","connectionId":14,"connectionCount":1}}
2022-09-30T09:49:12.664008505Z {"t":{"$date":"2022-09-30T09:49:12.598+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn14","msg":"client metadata","attr":{"remote":"10.0.1.7:38452","client":"conn14","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:49:12.685262954Z {"t":{"$date":"2022-09-30T09:49:12.666+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:38454","uuid":"f0739526-ebe5-4a7f-be90-7573993c20a8","connectionId":15,"connectionCount":2}}
2022-09-30T09:49:12.685315854Z {"t":{"$date":"2022-09-30T09:49:12.671+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn15","msg":"client metadata","attr":{"remote":"10.0.1.7:38454","client":"conn15","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:49:12.724097502Z {"t":{"$date":"2022-09-30T09:49:12.713+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn15","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:38454","extraInfo":{}}}
2022-09-30T09:49:13.086136647Z {"t":{"$date":"2022-09-30T09:49:13.060+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn15","msg":"Slow query","attr":{"type":"command","ns":"rocketchat.$cmd","command":{"createIndexes":"users","indexes":[{"name":"username_1","key":{"username":1},"unique":true,"sparse":true}],"lsid":{"id":{"$uuid":"a4f6c11f-4a56-482e-8611-d93ec9a23385"}},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531347,"i":1}},"signature":{"hash":{"$binary":{"base64":"I55xCwPh17qFwQDFbpIsDP1wF18=","subType":"0"}},"keyId":7145901303581900806}},"$db":"rocketchat"},"numYields":0,"reslen":242,"locks":{"ParallelBatchWriterMode":{"acquireCount":{"r":2}},"FeatureCompatibilityVersion":{"acquireCount":{"r":4}},"ReplicationStateTransition":{"acquireCount":{"w":4}},"Global":{"acquireCount":{"r":4}},"Database":{"acquireCount":{"r":2}},"Collection":{"acquireCount":{"r":2}},"Mutex":{"acquireCount":{"r":2}}},"readConcern":{"level":"local","provenance":"implicitDefault"},"writeConcern":{"w":"majority","wtimeout":0,"provenance":"implicitDefault"},"storage":{},"remote":"10.0.1.7:38454","protocol":"op_msg","durationMillis":253}}
2022-09-30T09:49:13.875690185Z {"t":{"$date":"2022-09-30T09:49:13.875+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:38458","uuid":"f43cdd95-afc8-442c-9f46-bc135fb234f2","connectionId":16,"connectionCount":3}}
2022-09-30T09:49:13.881243078Z {"t":{"$date":"2022-09-30T09:49:13.876+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn16","msg":"client metadata","attr":{"remote":"10.0.1.7:38458","client":"conn16","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:49:13.887335621Z {"t":{"$date":"2022-09-30T09:49:13.886+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn16","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:38458","extraInfo":{}}}
2022-09-30T09:49:28.197532974Z {"t":{"$date":"2022-09-30T09:49:28.062+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:38518","uuid":"ac51dfdb-0815-4c8a-a77d-4dc6b742b6a3","connectionId":17,"connectionCount":4}}
2022-09-30T09:49:28.199378845Z {"t":{"$date":"2022-09-30T09:49:28.070+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:38520","uuid":"38e24cbb-c54d-437b-8e52-a4b12e52a79a","connectionId":18,"connectionCount":5}}
2022-09-30T09:49:28.199410785Z {"t":{"$date":"2022-09-30T09:49:28.079+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn17","msg":"client metadata","attr":{"remote":"10.0.1.7:38518","client":"conn17","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:49:28.199450335Z {"t":{"$date":"2022-09-30T09:49:28.079+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn18","msg":"client metadata","attr":{"remote":"10.0.1.7:38520","client":"conn18","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:49:28.199463215Z {"t":{"$date":"2022-09-30T09:49:28.132+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn17","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:38518","extraInfo":{}}}
2022-09-30T09:49:28.241868914Z {"t":{"$date":"2022-09-30T09:49:28.203+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:38522","uuid":"d69e1109-6d5a-4346-b66d-fe6997f24f4a","connectionId":19,"connectionCount":6}}
2022-09-30T09:49:28.241901184Z {"t":{"$date":"2022-09-30T09:49:28.208+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn19","msg":"client metadata","attr":{"remote":"10.0.1.7:38522","client":"conn19","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:49:28.241912634Z {"t":{"$date":"2022-09-30T09:49:28.214+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn19","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:38522","extraInfo":{}}}
2022-09-30T09:49:28.310458965Z {"t":{"$date":"2022-09-30T09:49:28.276+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:38524","uuid":"df655b2d-d371-46fb-ad50-4b52d511b232","connectionId":20,"connectionCount":7}}
2022-09-30T09:49:28.310486765Z {"t":{"$date":"2022-09-30T09:49:28.282+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn20","msg":"client metadata","attr":{"remote":"10.0.1.7:38524","client":"conn20","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:49:28.310494675Z {"t":{"$date":"2022-09-30T09:49:28.287+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn20","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:38524","extraInfo":{}}}
2022-09-30T09:49:30.389533190Z {"t":{"$date":"2022-09-30T09:49:30.310+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:38542","uuid":"e86c6ced-2341-4ec8-908a-ee7e27a3f6b4","connectionId":21,"connectionCount":8}}
2022-09-30T09:49:30.389577200Z {"t":{"$date":"2022-09-30T09:49:30.314+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn21","msg":"client metadata","attr":{"remote":"10.0.1.7:38542","client":"conn21","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:49:30.389585460Z {"t":{"$date":"2022-09-30T09:49:30.323+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn21","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:38542","extraInfo":{}}}
2022-09-30T09:49:30.512477596Z {"t":{"$date":"2022-09-30T09:49:30.401+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:38544","uuid":"015b9167-2c2e-45a8-a6c7-18015cf6340b","connectionId":22,"connectionCount":9}}
2022-09-30T09:49:30.512506926Z {"t":{"$date":"2022-09-30T09:49:30.406+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn22","msg":"client metadata","attr":{"remote":"10.0.1.7:38544","client":"conn22","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:49:30.512514336Z {"t":{"$date":"2022-09-30T09:49:30.412+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn22","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:38544","extraInfo":{}}}
2022-09-30T09:49:30.705301193Z {"t":{"$date":"2022-09-30T09:49:30.538+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:38546","uuid":"3076bcc7-bd23-4705-a9f9-8aae69363d8d","connectionId":23,"connectionCount":10}}
2022-09-30T09:49:30.844289537Z {"t":{"$date":"2022-09-30T09:49:30.732+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn23","msg":"client metadata","attr":{"remote":"10.0.1.7:38546","client":"conn23","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:49:30.844323207Z {"t":{"$date":"2022-09-30T09:49:30.737+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn23","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:38546","extraInfo":{}}}
2022-09-30T09:49:30.973998476Z {"t":{"$date":"2022-09-30T09:49:30.846+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:38548","uuid":"55424a2f-596e-497f-96dc-c81a42284f60","connectionId":24,"connectionCount":11}}
2022-09-30T09:49:30.974033316Z {"t":{"$date":"2022-09-30T09:49:30.897+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn24","msg":"client metadata","attr":{"remote":"10.0.1.7:38548","client":"conn24","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:49:30.974054066Z {"t":{"$date":"2022-09-30T09:49:30.907+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn24","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:38548","extraInfo":{}}}
2022-09-30T09:49:31.434345425Z {"t":{"$date":"2022-09-30T09:49:31.303+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn20","msg":"Slow query","attr":{"type":"command","ns":"rocketchat.rocketchat_settings","command":{"getMore":5079998272498730228,"collection":"rocketchat_settings","batchSize":1000,"lsid":{"id":{"$uuid":"58ffdeeb-302e-4c16-8c5b-e6892ed0d17f"}},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531368,"i":1}},"signature":{"hash":{"$binary":{"base64":"1fh2ytnuBTiIVm1EYQzild1J72k=","subType":"0"}},"keyId":7145901303581900806}},"$db":"rocketchat"},"originatingCommand":{"find":"rocketchat_settings","filter":{},"lsid":{"id":{"$uuid":"58ffdeeb-302e-4c16-8c5b-e6892ed0d17f"}},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531368,"i":1}},"signature":{"hash":{"$binary":{"base64":"1fh2ytnuBTiIVm1EYQzild1J72k=","subType":"0"}},"keyId":7145901303581900806}},"$db":"rocketchat"},"planSummary":"COLLSCAN","cursorid":5079998272498730228,"keysExamined":0,"docsExamined":848,"cursorExhausted":true,"numYields":6,"nreturned":848,"reslen":468408,"locks":{"FeatureCompatibilityVersion":{"acquireCount":{"r":7}},"Global":{"acquireCount":{"r":7}},"Mutex":{"acquireCount":{"r":1}}},"readConcern":{"level":"local","provenance":"implicitDefault"},"storage":{},"remote":"10.0.1.7:38524","protocol":"op_msg","durationMillis":207}}
2022-09-30T09:49:36.235523527Z {"t":{"$date":"2022-09-30T09:49:36.210+00:00"},"s":"I",  "c":"INDEX",    "id":5479200, "ctx":"TTLMonitor","msg":"Deleted expired documents using index","attr":{"namespace":"rocketchat.rocketchat_apps_logs","index":"_updatedAt_1","numDeleted":0,"durationMillis":115}}
2022-09-30T09:49:36.924331850Z {"t":{"$date":"2022-09-30T09:49:36.898+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"Checkpointer","msg":"WiredTiger message","attr":{"message":"[1664531376:898672][1:0x7f9a89948700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 83, snapshot max: 83 snapshot count: 0, oldest timestamp: (1664531068, 1) , meta checkpoint timestamp: (1664531368, 1) base write gen: 186766"}}
2022-09-30T09:50:08.830966469Z {"t":{"$date":"2022-09-30T09:50:08.760+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn24","msg":"Slow query","attr":{"type":"command","ns":"rocketchat.$cmd","command":{"createIndexes":"rocketchat_livechat_business_hours","indexes":[{"name":"_updatedAt_1","key":{"_updatedAt":1}}],"lsid":{"id":{"$uuid":"f49fb989-50d7-4e20-912c-78edbb0545f4"}},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531398,"i":1}},"signature":{"hash":{"$binary":{"base64":"qvoCuiqfZss609D2tex6oul84UE=","subType":"0"}},"keyId":7145901303581900806}},"$db":"rocketchat"},"numYields":0,"reslen":242,"locks":{"ParallelBatchWriterMode":{"acquireCount":{"r":2}},"FeatureCompatibilityVersion":{"acquireCount":{"r":4}},"ReplicationStateTransition":{"acquireCount":{"w":4}},"Global":{"acquireCount":{"r":4}},"Database":{"acquireCount":{"r":2}},"Collection":{"acquireCount":{"r":2}},"Mutex":{"acquireCount":{"r":2}}},"readConcern":{"level":"local","provenance":"implicitDefault"},"writeConcern":{"w":"majority","wtimeout":0,"provenance":"implicitDefault"},"storage":{},"remote":"10.0.1.7:38548","protocol":"op_msg","durationMillis":116}}
2022-09-30T09:50:16.173038886Z {"t":{"$date":"2022-09-30T09:50:15.956+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn22","msg":"Slow query","attr":{"type":"command","ns":"rocketchat.$cmd","command":{"createIndexes":"users","indexes":[{"name":"services.apple.id_1","key":{"services.apple.id":1},"unique":true,"sparse":true}],"lsid":{"id":{"$uuid":"1a5f0269-fb45-4d73-a81b-413895a08543"}},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531408,"i":1}},"signature":{"hash":{"$binary":{"base64":"ybciBHJfEZ5HW1l7dljhuZ1hkqg=","subType":"0"}},"keyId":7145901303581900806}},"$db":"rocketchat"},"numYields":0,"reslen":242,"locks":{"ParallelBatchWriterMode":{"acquireCount":{"r":2}},"FeatureCompatibilityVersion":{"acquireCount":{"r":4}},"ReplicationStateTransition":{"acquireCount":{"w":4}},"Global":{"acquireCount":{"r":4}},"Database":{"acquireCount":{"r":2}},"Collection":{"acquireCount":{"r":2}},"Mutex":{"acquireCount":{"r":2}}},"readConcern":{"level":"local","provenance":"implicitDefault"},"writeConcern":{"w":"majority","wtimeout":0,"provenance":"implicitDefault"},"storage":{},"remote":"10.0.1.7:38544","protocol":"op_msg","durationMillis":309}}
2022-09-30T09:50:17.474628207Z {"t":{"$date":"2022-09-30T09:50:17.384+00:00"},"s":"I",  "c":"WRITE",    "id":51803,   "ctx":"conn20","msg":"Slow query","attr":{"type":"update","ns":"rocketchat.rocketchat_settings","command":{"q":{"blocked":{"$ne":true},"value":{"$ne":"Disabled"},"_id":"FEDERATION_Status"},"u":{"$set":{"value":"Disabled","_updatedAt":{"$date":"2022-09-30T09:50:17.152Z"}}},"multi":false,"upsert":false},"planSummary":"IXSCAN { _id: 1 }","keysExamined":1,"docsExamined":1,"nMatched":1,"nModified":1,"nUpserted":0,"keysInserted":1,"keysDeleted":1,"numYields":1,"queryHash":"E0D92DF5","planCacheKey":"FC40D612","locks":{"ParallelBatchWriterMode":{"acquireCount":{"r":2}},"FeatureCompatibilityVersion":{"acquireCount":{"w":2}},"ReplicationStateTransition":{"acquireCount":{"w":2}},"Global":{"acquireCount":{"w":2}},"Database":{"acquireCount":{"w":2}},"Collection":{"acquireCount":{"w":2}},"Mutex":{"acquireCount":{"r":1}}},"flowControl":{"acquireCount":2,"timeAcquiringMicros":4},"readConcern":{"level":"local","provenance":"implicitDefault"},"storage":{},"remote":"10.0.1.7:38524","durationMillis":122}}
2022-09-30T09:50:17.474679827Z {"t":{"$date":"2022-09-30T09:50:17.412+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn20","msg":"Slow query","attr":{"type":"command","ns":"rocketchat.$cmd","command":{"update":"rocketchat_settings","updates":[{"q":{"blocked":{"$ne":true},"value":{"$ne":"Disabled"},"_id":"FEDERATION_Status"},"u":{"$set":{"value":"Disabled","_updatedAt":{"$date":"2022-09-30T09:50:17.152Z"}}}}],"ordered":true,"lsid":{"id":{"$uuid":"58ffdeeb-302e-4c16-8c5b-e6892ed0d17f"}},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531408,"i":1}},"signature":{"hash":{"$binary":{"base64":"ybciBHJfEZ5HW1l7dljhuZ1hkqg=","subType":"0"}},"keyId":7145901303581900806}},"$db":"rocketchat"},"numYields":1,"reslen":245,"locks":{"ParallelBatchWriterMode":{"acquireCount":{"r":2}},"FeatureCompatibilityVersion":{"acquireCount":{"r":2,"w":2}},"ReplicationStateTransition":{"acquireCount":{"w":4}},"Global":{"acquireCount":{"r":2,"w":2}},"Database":{"acquireCount":{"w":2}},"Collection":{"acquireCount":{"w":2}},"Mutex":{"acquireCount":{"r":1}}},"flowControl":{"acquireCount":2,"timeAcquiringMicros":4},"readConcern":{"level":"local","provenance":"implicitDefault"},"writeConcern":{"w":"majority","wtimeout":0,"provenance":"implicitDefault"},"storage":{},"remote":"10.0.1.7:38524","protocol":"op_msg","durationMillis":155}}
2022-09-30T09:50:24.464512904Z {"t":{"$date":"2022-09-30T09:50:24.205+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn14","msg":"Slow query","attr":{"type":"command","ns":"admin.$cmd","command":{"hello":true,"maxAwaitTimeMS":10000,"topologyVersion":{"processId":{"$oid":"6336bab0fc6a26ac71e7a347"},"counter":6},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531347,"i":1}},"signature":{"hash":{"$binary":{"base64":"I55xCwPh17qFwQDFbpIsDP1wF18=","subType":"0"}},"keyId":7145901303581900806}},"$db":"admin"},"numYields":0,"reslen":774,"locks":{},"remote":"10.0.1.7:38452","protocol":"op_msg","durationMillis":112}}
2022-09-30T09:50:37.300099417Z {"t":{"$date":"2022-09-30T09:50:37.284+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"Checkpointer","msg":"WiredTiger message","attr":{"message":"[1664531437:282041][1:0x7f9a89948700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 117, snapshot max: 117 snapshot count: 0, oldest timestamp: (1664531136, 1) , meta checkpoint timestamp: (1664531436, 1) base write gen: 186766"}}
2022-09-30T09:51:15.735177813Z {"t":{"$date":"2022-09-30T09:51:15.673+00:00"},"s":"I",  "c":"-",        "id":20883,   "ctx":"conn14","msg":"Interrupted operation as its client disconnected","attr":{"opId":5816}}
2022-09-30T09:51:15.737120894Z {"t":{"$date":"2022-09-30T09:51:15.685+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn21","msg":"Connection ended","attr":{"remote":"10.0.1.7:38542","uuid":"e86c6ced-2341-4ec8-908a-ee7e27a3f6b4","connectionId":21,"connectionCount":5}}
2022-09-30T09:51:15.737138324Z {"t":{"$date":"2022-09-30T09:51:15.685+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn19","msg":"Connection ended","attr":{"remote":"10.0.1.7:38522","uuid":"d69e1109-6d5a-4346-b66d-fe6997f24f4a","connectionId":19,"connectionCount":7}}
2022-09-30T09:51:15.737144644Z {"t":{"$date":"2022-09-30T09:51:15.682+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn17","msg":"Connection ended","attr":{"remote":"10.0.1.7:38518","uuid":"ac51dfdb-0815-4c8a-a77d-4dc6b742b6a3","connectionId":17,"connectionCount":6}}
2022-09-30T09:51:15.737579144Z {"t":{"$date":"2022-09-30T09:51:15.685+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn18","msg":"Connection ended","attr":{"remote":"10.0.1.7:38520","uuid":"38e24cbb-c54d-437b-8e52-a4b12e52a79a","connectionId":18,"connectionCount":10}}
2022-09-30T09:51:15.737596774Z {"t":{"$date":"2022-09-30T09:51:15.691+00:00"},"s":"I",  "c":"NETWORK",  "id":22989,   "ctx":"conn14","msg":"Error sending response to client. Ending connection from remote","attr":{"error":{"code":6,"codeName":"HostUnreachable","errmsg":"Connection reset by peer"},"remote":"10.0.1.7:38452","connectionId":14}}
2022-09-30T09:51:15.737611674Z {"t":{"$date":"2022-09-30T09:51:15.692+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn14","msg":"Connection ended","attr":{"remote":"10.0.1.7:38452","uuid":"cb04f834-f7b8-4955-a62e-68c3f6f02d57","connectionId":14,"connectionCount":0}}
2022-09-30T09:51:15.737626284Z {"t":{"$date":"2022-09-30T09:51:15.685+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn15","msg":"Connection ended","attr":{"remote":"10.0.1.7:38454","uuid":"f0739526-ebe5-4a7f-be90-7573993c20a8","connectionId":15,"connectionCount":9}}
2022-09-30T09:51:15.737636444Z {"t":{"$date":"2022-09-30T09:51:15.685+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn20","msg":"Connection ended","attr":{"remote":"10.0.1.7:38524","uuid":"df655b2d-d371-46fb-ad50-4b52d511b232","connectionId":20,"connectionCount":3}}
2022-09-30T09:51:15.737642214Z {"t":{"$date":"2022-09-30T09:51:15.685+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn22","msg":"Connection ended","attr":{"remote":"10.0.1.7:38544","uuid":"015b9167-2c2e-45a8-a6c7-18015cf6340b","connectionId":22,"connectionCount":4}}
2022-09-30T09:51:15.737647034Z {"t":{"$date":"2022-09-30T09:51:15.685+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn16","msg":"Connection ended","attr":{"remote":"10.0.1.7:38458","uuid":"f43cdd95-afc8-442c-9f46-bc135fb234f2","connectionId":16,"connectionCount":1}}
2022-09-30T09:51:15.737651904Z {"t":{"$date":"2022-09-30T09:51:15.689+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn23","msg":"Connection ended","attr":{"remote":"10.0.1.7:38546","uuid":"3076bcc7-bd23-4705-a9f9-8aae69363d8d","connectionId":23,"connectionCount":8}}
2022-09-30T09:51:15.737656624Z {"t":{"$date":"2022-09-30T09:51:15.685+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn24","msg":"Connection ended","attr":{"remote":"10.0.1.7:38548","uuid":"55424a2f-596e-497f-96dc-c81a42284f60","connectionId":24,"connectionCount":2}}
2022-09-30T09:51:33.752038731Z {"t":{"$date":"2022-09-30T09:51:33.678+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:54040","uuid":"22f42952-c880-4cdb-bfcb-251d9a164fe4","connectionId":25,"connectionCount":1}}
2022-09-30T09:51:33.752874151Z {"t":{"$date":"2022-09-30T09:51:33.696+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn25","msg":"client metadata","attr":{"remote":"10.0.1.7:54040","client":"conn25","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:51:33.810034407Z {"t":{"$date":"2022-09-30T09:51:33.759+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:54042","uuid":"03d2b5e5-559f-44e5-8c56-30aabe5ac7a8","connectionId":26,"connectionCount":2}}
2022-09-30T09:51:33.810063557Z {"t":{"$date":"2022-09-30T09:51:33.760+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn26","msg":"client metadata","attr":{"remote":"10.0.1.7:54042","client":"conn26","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:51:33.810089927Z {"t":{"$date":"2022-09-30T09:51:33.774+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn26","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:54042","extraInfo":{}}}
2022-09-30T09:51:34.732301476Z {"t":{"$date":"2022-09-30T09:51:34.646+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:54048","uuid":"48b2095e-a809-47ca-b598-a77cc245f8aa","connectionId":27,"connectionCount":3}}
2022-09-30T09:51:34.732323846Z {"t":{"$date":"2022-09-30T09:51:34.647+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn27","msg":"client metadata","attr":{"remote":"10.0.1.7:54048","client":"conn27","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:51:34.732330766Z {"t":{"$date":"2022-09-30T09:51:34.653+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn27","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:54048","extraInfo":{}}}
2022-09-30T09:51:40.366091986Z {"t":{"$date":"2022-09-30T09:51:40.299+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"Checkpointer","msg":"WiredTiger message","attr":{"message":"[1664531500:299357][1:0x7f9a89948700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 130, snapshot max: 130 snapshot count: 0, oldest timestamp: (1664531199, 1) , meta checkpoint timestamp: (1664531488, 1) base write gen: 186766"}}
2022-09-30T09:51:47.200732082Z {"t":{"$date":"2022-09-30T09:51:47.020+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:54084","uuid":"406ff602-b910-4212-9f16-6e50b87e478b","connectionId":28,"connectionCount":4}}
2022-09-30T09:51:47.201276212Z {"t":{"$date":"2022-09-30T09:51:47.051+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:54086","uuid":"e4032ac1-d86a-4465-84bf-65761b3327fb","connectionId":29,"connectionCount":5}}
2022-09-30T09:51:47.201332502Z {"t":{"$date":"2022-09-30T09:51:47.065+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn29","msg":"client metadata","attr":{"remote":"10.0.1.7:54086","client":"conn29","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:51:47.201342772Z {"t":{"$date":"2022-09-30T09:51:47.069+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn28","msg":"client metadata","attr":{"remote":"10.0.1.7:54084","client":"conn28","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:51:47.201611833Z {"t":{"$date":"2022-09-30T09:51:47.110+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn28","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:54084","extraInfo":{}}}
2022-09-30T09:51:47.253724136Z {"t":{"$date":"2022-09-30T09:51:47.205+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:54088","uuid":"677d9690-6da5-4ccc-9831-7de93d5b57ee","connectionId":30,"connectionCount":6}}
2022-09-30T09:51:47.253757656Z {"t":{"$date":"2022-09-30T09:51:47.212+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn30","msg":"client metadata","attr":{"remote":"10.0.1.7:54088","client":"conn30","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:51:47.253768236Z {"t":{"$date":"2022-09-30T09:51:47.220+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn30","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:54088","extraInfo":{}}}
2022-09-30T09:51:47.336173724Z {"t":{"$date":"2022-09-30T09:51:47.281+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:54090","uuid":"da29af5a-224b-4fa4-a963-92da14ada341","connectionId":31,"connectionCount":7}}
2022-09-30T09:51:47.336206454Z {"t":{"$date":"2022-09-30T09:51:47.295+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn31","msg":"client metadata","attr":{"remote":"10.0.1.7:54090","client":"conn31","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:51:47.336213974Z {"t":{"$date":"2022-09-30T09:51:47.300+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn31","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:54090","extraInfo":{}}}
2022-09-30T09:51:49.820424233Z {"t":{"$date":"2022-09-30T09:51:49.755+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:54104","uuid":"fe1c6205-a21a-48bc-be25-e74aadc31440","connectionId":32,"connectionCount":8}}
2022-09-30T09:51:49.820455173Z {"t":{"$date":"2022-09-30T09:51:49.782+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn32","msg":"client metadata","attr":{"remote":"10.0.1.7:54104","client":"conn32","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:51:49.820477113Z {"t":{"$date":"2022-09-30T09:51:49.788+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn32","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:54104","extraInfo":{}}}
2022-09-30T09:51:49.914594885Z {"t":{"$date":"2022-09-30T09:51:49.838+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:54106","uuid":"64f701fc-afc5-4f80-a683-e2a466633482","connectionId":33,"connectionCount":9}}
2022-09-30T09:51:49.914623586Z {"t":{"$date":"2022-09-30T09:51:49.842+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn33","msg":"client metadata","attr":{"remote":"10.0.1.7:54106","client":"conn33","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:51:49.914631096Z {"t":{"$date":"2022-09-30T09:51:49.846+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn33","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:54106","extraInfo":{}}}
2022-09-30T09:51:49.980892836Z {"t":{"$date":"2022-09-30T09:51:49.917+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:54114","uuid":"14ea1943-3cc9-47b4-88ea-d858d824a327","connectionId":34,"connectionCount":10}}
2022-09-30T09:51:49.981015896Z {"t":{"$date":"2022-09-30T09:51:49.921+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn34","msg":"client metadata","attr":{"remote":"10.0.1.7:54114","client":"conn34","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:51:49.981025716Z {"t":{"$date":"2022-09-30T09:51:49.925+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn34","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:54114","extraInfo":{}}}
2022-09-30T09:51:50.094967037Z {"t":{"$date":"2022-09-30T09:51:49.983+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"10.0.1.7:54116","uuid":"5bd8104a-f427-4088-a354-04046c07d70b","connectionId":35,"connectionCount":11}}
2022-09-30T09:51:50.094995727Z {"t":{"$date":"2022-09-30T09:51:49.988+00:00"},"s":"I",  "c":"NETWORK",  "id":51800,   "ctx":"conn35","msg":"client metadata","attr":{"remote":"10.0.1.7:54116","client":"conn35","doc":{"driver":{"name":"nodejs","version":"4.3.1"},"os":{"type":"Linux","name":"linux","architecture":"x64","version":"4.18.0-383.el8.x86_64"},"platform":"Node.js v14.19.3, LE (unified)|Node.js v14.19.3, LE (unified)"}}}
2022-09-30T09:51:50.095003087Z {"t":{"$date":"2022-09-30T09:51:49.992+00:00"},"s":"I",  "c":"ACCESS",   "id":20250,   "ctx":"conn35","msg":"Authentication succeeded","attr":{"mechanism":"SCRAM-SHA-256","speculative":true,"principalName":"rocketchat","authenticationDatabase":"rocketchat","remote":"10.0.1.7:54116","extraInfo":{}}}
2022-09-30T09:52:36.079953725Z {"t":{"$date":"2022-09-30T09:52:35.837+00:00"},"s":"I",  "c":"COMMAND",  "id":23099,   "ctx":"PeriodicTaskRunner","msg":"Task finished","attr":{"taskName":"UnusedLockCleaner","durationMillis":120}}
2022-09-30T09:52:41.192384818Z {"t":{"$date":"2022-09-30T09:52:41.021+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"Checkpointer","msg":"WiredTiger message","attr":{"message":"[1664531561:1495][1:0x7f9a89948700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 147, snapshot max: 147 snapshot count: 0, oldest timestamp: (1664531257, 1) , meta checkpoint timestamp: (1664531557, 1) base write gen: 186766"}}
2022-09-30T09:52:45.741112545Z {"t":{"$date":"2022-09-30T09:52:45.680+00:00"},"s":"I",  "c":"COMMAND",  "id":51803,   "ctx":"conn25","msg":"Slow query","attr":{"type":"command","ns":"admin.$cmd","command":{"hello":true,"maxAwaitTimeMS":10000,"topologyVersion":{"processId":{"$oid":"6336bab0fc6a26ac71e7a347"},"counter":6},"$clusterTime":{"clusterTime":{"$timestamp":{"t":1664531488,"i":1}},"signature":{"hash":{"$binary":{"base64":"XzlDHk2EhZ8LF9SMkqua8f8R9UM=","subType":"0"}},"keyId":7145901303581900806}},"$db":"admin"},"numYields":0,"reslen":774,"locks":{},"remote":"10.0.1.7:54040","protocol":"op_msg","durationMillis":118}}
2022-09-30T09:53:03.776714201Z {"t":{"$date":"2022-09-30T09:53:02.260+00:00"},"s":"I",  "c":"-",        "id":20883,   "ctx":"conn25","msg":"Interrupted operation as its client disconnected","attr":{"opId":7696}}
2022-09-30T09:53:03.822107072Z {"t":{"$date":"2022-09-30T09:53:02.390+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn32","msg":"Connection ended","attr":{"remote":"10.0.1.7:54104","uuid":"fe1c6205-a21a-48bc-be25-e74aadc31440","connectionId":32,"connectionCount":7}}
2022-09-30T09:53:03.822136522Z {"t":{"$date":"2022-09-30T09:53:02.403+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn31","msg":"Connection ended","attr":{"remote":"10.0.1.7:54090","uuid":"da29af5a-224b-4fa4-a963-92da14ada341","connectionId":31,"connectionCount":3}}
2022-09-30T09:53:03.822146032Z {"t":{"$date":"2022-09-30T09:53:02.403+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn26","msg":"Connection ended","attr":{"remote":"10.0.1.7:54042","uuid":"03d2b5e5-559f-44e5-8c56-30aabe5ac7a8","connectionId":26,"connectionCount":10}}
2022-09-30T09:53:03.822153692Z {"t":{"$date":"2022-09-30T09:53:02.390+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn30","msg":"Connection ended","attr":{"remote":"10.0.1.7:54088","uuid":"677d9690-6da5-4ccc-9831-7de93d5b57ee","connectionId":30,"connectionCount":9}}
2022-09-30T09:53:03.822160842Z {"t":{"$date":"2022-09-30T09:53:02.415+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn34","msg":"Connection ended","attr":{"remote":"10.0.1.7:54114","uuid":"14ea1943-3cc9-47b4-88ea-d858d824a327","connectionId":34,"connectionCount":1}}
2022-09-30T09:53:03.822167262Z {"t":{"$date":"2022-09-30T09:53:02.415+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn27","msg":"Connection ended","attr":{"remote":"10.0.1.7:54048","uuid":"48b2095e-a809-47ca-b598-a77cc245f8aa","connectionId":27,"connectionCount":6}}
2022-09-30T09:53:03.822212842Z {"t":{"$date":"2022-09-30T09:53:02.415+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn29","msg":"Connection ended","attr":{"remote":"10.0.1.7:54086","uuid":"e4032ac1-d86a-4465-84bf-65761b3327fb","connectionId":29,"connectionCount":5}}
2022-09-30T09:53:03.822227692Z {"t":{"$date":"2022-09-30T09:53:02.403+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn28","msg":"Connection ended","attr":{"remote":"10.0.1.7:54084","uuid":"406ff602-b910-4212-9f16-6e50b87e478b","connectionId":28,"connectionCount":4}}
2022-09-30T09:53:03.822235902Z {"t":{"$date":"2022-09-30T09:53:02.414+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn33","msg":"Connection ended","attr":{"remote":"10.0.1.7:54106","uuid":"64f701fc-afc5-4f80-a683-e2a466633482","connectionId":33,"connectionCount":8}}
2022-09-30T09:53:03.822241772Z {"t":{"$date":"2022-09-30T09:53:02.415+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn35","msg":"Connection ended","attr":{"remote":"10.0.1.7:54116","uuid":"5bd8104a-f427-4088-a354-04046c07d70b","connectionId":35,"connectionCount":2}}
2022-09-30T09:53:03.822247882Z {"t":{"$date":"2022-09-30T09:53:02.471+00:00"},"s":"I",  "c":"NETWORK",  "id":22989,   "ctx":"conn25","msg":"Error sending response to client. Ending connection from remote","attr":{"error":{"code":6,"codeName":"HostUnreachable","errmsg":"Connection reset by peer"},"remote":"10.0.1.7:54040","connectionId":25}}
2022-09-30T09:53:03.822254832Z {"t":{"$date":"2022-09-30T09:53:02.474+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn25","msg":"Connection ended","attr":{"remote":"10.0.1.7:54040","uuid":"22f42952-c880-4cdb-bfcb-251d9a164fe4","connectionId":25,"connectionCount":0}}
2022-09-30T09:53:41.330336937Z {"t":{"$date":"2022-09-30T09:53:41.325+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"Checkpointer","msg":"WiredTiger message","attr":{"message":"[1664531621:325148][1:0x7f9a89948700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 162, snapshot max: 162 snapshot count: 0, oldest timestamp: (1664531319, 1) , meta checkpoint timestamp: (1664531619, 1) base write gen: 186766"}}
2022-09-30T09:54:41.367879680Z {"t":{"$date":"2022-09-30T09:54:41.366+00:00"},"s":"I",  "c":"STORAGE",  "id":22430,   "ctx":"Checkpointer","msg":"WiredTiger message","attr":{"message":"[1664531681:366226][1:0x7f9a89948700], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 187, snapshot max: 187 snapshot count: 0, oldest timestamp: (1664531377, 11) , meta checkpoint timestamp: (1664531677, 11) base write gen: 186766"}}

PS: another deployment of rocketchat app made me notice heavy load on my server caused by several node main.js and runc init processes

@Ziip-dev
Copy link

Ziip-dev commented Oct 3, 2022

New deployment attempt of rocket.chat 5.1.4 today. Still a strange error related to JS out of memory... Any idea?

2022-10-03T20:29:34.359505074Z <--- JS stacktrace --->
2022-10-03T20:29:34.359509754Z 
2022-10-03T20:29:34.359514124Z FATAL ERROR: Ineffective mark-compacts near heap limit Allocation failed - JavaScript heap out of memory
2022-10-03T20:29:34.359520614Z  1: 0xa3aaf0 node::Abort() [node]
2022-10-03T20:29:34.359525124Z  2: 0x970199 node::FatalError(char const*, char const*) [node]
2022-10-03T20:29:34.359529284Z  3: 0xbba42e v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [node]
2022-10-03T20:29:34.359533174Z  4: 0xbba7a7 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [node]
2022-10-03T20:29:34.359537204Z  5: 0xd769c5  [node]
2022-10-03T20:29:34.359540764Z  6: 0xd7754f  [node]
2022-10-03T20:29:34.359544424Z  7: 0xd8538b v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [node]
2022-10-03T20:29:34.359548604Z  8: 0xd88f4c v8::internal::Heap::AllocateRawWithRetryOrFailSlowPath(int, v8::internal::AllocationType, v8::internal::AllocationOrigin, v8::internal::AllocationAlignment) [node]
2022-10-03T20:29:34.359553314Z  9: 0xd5762b v8::internal::Factory::NewFillerObject(int, bool, v8::internal::AllocationType, v8::internal::AllocationOrigin) [node]
2022-10-03T20:29:34.359558114Z 10: 0x109fbef v8::internal::Runtime_AllocateInYoungGeneration(int, unsigned long*, v8::internal::Isolate*) [node]
2022-10-03T20:29:34.359562564Z 11: 0x1448df9  [node]

Nothing very significant to me... I am really not familiar with JS ecosystem and changing node memory settings seems not to be a reliable solution.

@Ziip-dev
Copy link

Ziip-dev commented Oct 4, 2022

@debdutdeb I think there is an issue with the deployment of newer versions (not certain that it is not a problem on my side only though).
I gave up an deleted the db app to start over and still have JavaScript heap out of memory errors:

``` 2022-10-04T08:28:46.866155111Z <--- JS stacktrace ---> 2022-10-04T08:28:46.866158761Z 2022-10-04T08:28:46.866162101Z FATAL ERROR: MarkCompactCollector: young object promotion failed Allocation failed - JavaScript heap out of memory 2022-10-04T08:28:46.866165711Z 1: 0xa3aaf0 node::Abort() [node] 2022-10-04T08:28:46.866169101Z 2: 0x970199 node::FatalError(char const*, char const*) [node] 2022-10-04T08:28:46.866172551Z 3: 0xbba42e v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [node] 2022-10-04T08:28:46.866176031Z 4: 0xbba7a7 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [node] 2022-10-04T08:28:46.866179641Z 5: 0xd769c5 [node] 2022-10-04T08:28:46.866182951Z 6: 0xda735e v8::internal::EvacuateNewSpaceVisitor::Visit(v8::internal::HeapObject, int) [node] 2022-10-04T08:28:46.866186341Z 7: 0xdb3396 v8::internal::FullEvacuator::RawEvacuatePage(v8::internal::MemoryChunk*, long*) [node] 2022-10-04T08:28:46.866189821Z 8: 0xd9f52f v8::internal::Evacuator::EvacuatePage(v8::internal::MemoryChunk*) [node] 2022-10-04T08:28:46.866207741Z 9: 0xd9f7a8 v8::internal::PageEvacuationTask::RunInParallel(v8::internal::ItemParallelJob::Task::Runner) [node] 2022-10-04T08:28:46.866211481Z 10: 0xd92089 v8::internal::ItemParallelJob::Run() [node] 2022-10-04T08:28:46.866215301Z 11: 0xdb52f0 void v8::internal::MarkCompactCollectorBase::CreateAndExecuteEvacuationTasks(v8::internal::MarkCompactCollector*, v8::internal::ItemParallelJob*, v8::internal::MigrationObserver*, long) [node] 2022-10-04T08:28:46.866229631Z 12: 0xdb5b8c v8::internal::MarkCompactCollector::EvacuatePagesInParallel() [node] 2022-10-04T08:28:46.866233221Z 13: 0xdb5d55 v8::internal::MarkCompactCollector::Evacuate() [node] 2022-10-04T08:28:46.866236441Z 14: 0xdc7d51 v8::internal::MarkCompactCollector::CollectGarbage() [node] 2022-10-04T08:28:46.866239611Z 15: 0xd84018 v8::internal::Heap::MarkCompact() [node] 2022-10-04T08:28:46.866246081Z 16: 0xd85b08 v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [node] 2022-10-04T08:28:46.866249651Z 17: 0xd88f4c v8::internal::Heap::AllocateRawWithRetryOrFailSlowPath(int, v8::internal::AllocationType, v8::internal::AllocationOrigin, v8::internal::AllocationAlignment) [node] 2022-10-04T08:28:46.866253091Z 18: 0xd5762b v8::internal::Factory::NewFillerObject(int, bool, v8::internal::AllocationType, v8::internal::AllocationOrigin) [node] 2022-10-04T08:28:46.866256431Z 19: 0x109fbef v8::internal::Runtime_AllocateInYoungGeneration(int, unsigned long*, v8::internal::Isolate*) [node] 2022-10-04T08:28:46.866259701Z 20: 0x1448df9 [node] 2022-10-04T08:29:53.541270021Z strict mode: use allowUnionTypes to allow union type keyword at "#/properties/value" (strictTypes) ```

I then went to deploy the original rocket.chat 5.0.4 one click app without changing the version number and that works again.

@debdutdeb
Copy link
Contributor Author

Try adding this environment variable, NODE_OPTIONS=--max_old_space_size=4096

Tivin-i pushed a commit to SelfHosted-Club/caprover-one-click-apps that referenced this pull request May 19, 2023
* initial commit

* Working Rocket.Chat template

Signed-off-by: Debdut Chakraborty <debdut.chakraborty@rocket.chat>

* Add Rocket.Chat logo

Signed-off-by: Debdut Chakraborty <debdut.chakraborty@rocket.chat>

* fix formatting & fix real name var regex

Signed-off-by: Debdut Chakraborty <debdut.chakraborty@rocket.chat>
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

Successfully merging this pull request may close these issues.

App Suggestion: RocketChat
5 participants