2020-04-01T23:59:34.075+0000 I CONTROL [initandlisten] MongoDB starting : pid=1 port=27017 dbpath=/data/db 64-bit host=0b46bb9d5d10 2020-04-01T23:59:34.075+0000 I CONTROL [initandlisten] db version v3.6.5 2020-04-01T23:59:34.075+0000 I CONTROL [initandlisten] git version: a20ecd3e3a174162052ff99913bc2ca9a839d618 2020-04-01T23:59:34.075+0000 I CONTROL [initandlisten] OpenSSL version: OpenSSL 1.0.1t 3 May 2016 2020-04-01T23:59:34.075+0000 I CONTROL [initandlisten] allocator: tcmalloc 2020-04-01T23:59:34.075+0000 I CONTROL [initandlisten] modules: none 2020-04-01T23:59:34.075+0000 I CONTROL [initandlisten] build environment: 2020-04-01T23:59:34.075+0000 I CONTROL [initandlisten] distmod: debian81 2020-04-01T23:59:34.075+0000 I CONTROL [initandlisten] distarch: x86_64 2020-04-01T23:59:34.075+0000 I CONTROL [initandlisten] target_arch: x86_64 2020-04-01T23:59:34.075+0000 I CONTROL [initandlisten] options: { net: { bindIpAll: true }, setParameter: { internalQueryExecMaxBlockingSortBytes: "196100200" } } 2020-04-01T23:59:34.076+0000 I STORAGE [initandlisten] 2020-04-01T23:59:34.076+0000 I STORAGE [initandlisten] ** WARNING: Using the XFS filesystem is strongly recommended with the WiredTiger storage engine 2020-04-01T23:59:34.076+0000 I STORAGE [initandlisten] ** See http://dochub.mongodb.org/core/prodnotes-filesystem 2020-04-01T23:59:34.076+0000 I STORAGE [initandlisten] wiredtiger_open config: create,cache_size=3469M,session_max=20000,eviction=(threads_min=4,threads_max=4),config_base=false,statistics=(fast),cache_cursors=false,log=(enabled=true,archive=true,path=journal,compressor=snappy),file_manager=(close_idle_time=100000),statistics_log=(wait=0),verbose=(recovery_progress), 2020-04-01T23:59:34.837+0000 I STORAGE [initandlisten] WiredTiger message [1585785574:837026][1:0x7f358439da00], txn-recover: Set global recovery timestamp: 0 2020-04-01T23:59:35.061+0000 I CONTROL [initandlisten] 2020-04-01T23:59:35.061+0000 I CONTROL [initandlisten] ** WARNING: Access control is not enabled for the database. 2020-04-01T23:59:35.061+0000 I CONTROL [initandlisten] ** Read and write access to data and configuration is unrestricted. 2020-04-01T23:59:35.061+0000 I CONTROL [initandlisten] 2020-04-01T23:59:35.062+0000 I STORAGE [initandlisten] createCollection: admin.system.version with provided UUID: 3a528ced-953b-4155-b59e-0e10f1637fec 2020-04-01T23:59:35.177+0000 I COMMAND [initandlisten] setting featureCompatibilityVersion to 3.6 2020-04-01T23:59:35.184+0000 I STORAGE [initandlisten] createCollection: local.startup_log with generated UUID: 1a2f52ef-d5ab-4168-833b-e4e7ded2aaa8 2020-04-01T23:59:35.294+0000 I FTDC [initandlisten] Initializing full-time diagnostic data capture with directory '/data/db/diagnostic.data' 2020-04-01T23:59:35.295+0000 I NETWORK [initandlisten] waiting for connections on port 27017 2020-04-01T23:59:50.401+0000 I NETWORK [listener] connection accepted from 172.27.0.6:34666 #1 (1 connection now open) 2020-04-01T23:59:50.401+0000 I NETWORK [conn1] received client metadata from 172.27.0.6:34666 conn1: { driver: { name: "PyMongo", version: "3.6.1" }, os: { type: "Linux", name: "Linux", architecture: "x86_64", version: "4.19.76-linuxkit" }, platform: "CPython 3.6.8.final.0" } 2020-04-01T23:59:50.403+0000 I NETWORK [listener] connection accepted from 172.27.0.6:34668 #2 (2 connections now open) 2020-04-01T23:59:50.403+0000 I NETWORK [conn2] received client metadata from 172.27.0.6:34668 conn2: { driver: { name: "PyMongo", version: "3.6.1" }, os: { type: "Linux", name: "Linux", architecture: "x86_64", version: "4.19.76-linuxkit" }, platform: "CPython 3.6.8.final.0" } 2020-04-01T23:59:50.406+0000 I NETWORK [listener] connection accepted from 172.27.0.6:34670 #3 (3 connections now open) 2020-04-01T23:59:50.406+0000 I NETWORK [conn3] received client metadata from 172.27.0.6:34670 conn3: { driver: { name: "PyMongo", version: "3.6.1" }, os: { type: "Linux", name: "Linux", architecture: "x86_64", version: "4.19.76-linuxkit" }, platform: "CPython 3.6.8.final.0" } 2020-04-01T23:59:50.407+0000 I NETWORK [listener] connection accepted from 172.27.0.6:34672 #4 (4 connections now open) 2020-04-01T23:59:50.407+0000 I NETWORK [conn4] received client metadata from 172.27.0.6:34672 conn4: { driver: { name: "PyMongo", version: "3.6.1" }, os: { type: "Linux", name: "Linux", architecture: "x86_64", version: "4.19.76-linuxkit" }, platform: "CPython 3.6.8.final.0" } 2020-04-01T23:59:50.408+0000 I STORAGE [conn4] createCollection: backend.versions with generated UUID: 688a933b-3f27-4eb1-a15f-c22c92411c01 2020-04-01T23:59:50.601+0000 I INDEX [conn4] build index on: backend.versions properties: { v: 2, key: { created: -1, num: -1 }, name: "created_-1_num_-1", ns: "backend.versions", background: false } 2020-04-01T23:59:50.601+0000 I INDEX [conn4] building index using bulk method; build may temporarily use up to 500 megabytes of RAM 2020-04-01T23:59:50.602+0000 I INDEX [conn4] build index done. scanned 0 total records. 0 secs 2020-04-01T23:59:50.602+0000 I COMMAND [conn4] command backend.$cmd command: createIndexes { createIndexes: "versions", indexes: [ { key: { created: -1, num: -1 }, background: false, name: "created_-1_num_-1" } ], lsid: { id: UUID("e45670d2-d978-4855-ba7f-665fd399b047") }, $db: "backend" } numYields:0 reslen:113 locks:{ Global: { acquireCount: { r: 1, w: 1 } }, Database: { acquireCount: { W: 1 } }, Collection: { acquireCount: { w: 1 } } } protocol:op_query 194ms 2020-04-01T23:59:50.621+0000 I STORAGE [conn4] createCollection: backend.settings with generated UUID: 12f2f0d3-2f4a-406e-8537-38ed71a6b954 2020-04-01T23:59:50.758+0000 I COMMAND [conn4] command backend.settings command: insert { insert: "settings", ordered: true, writeConcern: { w: 1 }, lsid: { id: UUID("e45670d2-d978-4855-ba7f-665fd399b047") }, $db: "backend" } ninserted:1 keysInserted:1 numYields:0 reslen:44 locks:{ Global: { acquireCount: { r: 3, w: 3 } }, Database: { acquireCount: { w: 2, W: 1 } }, Collection: { acquireCount: { w: 2 } } } protocol:op_query 137ms 2020-04-01T23:59:50.759+0000 I STORAGE [conn4] createCollection: backend.company with generated UUID: 447aa6fc-8cf1-4ba6-9510-30b19765bdb2 2020-04-01T23:59:50.945+0000 I INDEX [conn4] build index on: backend.company properties: { v: 2, unique: true, key: { name: 1 }, name: "name_1", ns: "backend.company", background: false, sparse: false } 2020-04-01T23:59:50.945+0000 I INDEX [conn4] building index using bulk method; build may temporarily use up to 500 megabytes of RAM 2020-04-01T23:59:50.946+0000 I INDEX [conn4] build index done. scanned 0 total records. 0 secs 2020-04-01T23:59:50.947+0000 I COMMAND [conn4] command backend.$cmd command: createIndexes { createIndexes: "company", indexes: [ { key: { name: 1 }, background: false, unique: true, sparse: false, name: "name_1" } ], lsid: { id: UUID("e45670d2-d978-4855-ba7f-665fd399b047") }, $db: "backend" } numYields:0 reslen:113 locks:{ Global: { acquireCount: { r: 1, w: 1 } }, Database: { acquireCount: { W: 1 } }, Collection: { acquireCount: { w: 1 } } } protocol:op_query 187ms 2020-04-01T23:59:50.954+0000 I STORAGE [conn4] createCollection: backend.queue with generated UUID: fc9e0d38-8a97-405a-baa5-dca239258b02 2020-04-01T23:59:51.224+0000 I INDEX [conn4] build index on: backend.queue properties: { v: 2, unique: true, key: { name: 1, company: 1 }, name: "name_1_company_1", ns: "backend.queue", background: false, sparse: false } 2020-04-01T23:59:51.224+0000 I INDEX [conn4] building index using bulk method; build may temporarily use up to 500 megabytes of RAM 2020-04-01T23:59:51.226+0000 I INDEX [conn4] build index done. scanned 0 total records. 0 secs 2020-04-01T23:59:51.226+0000 I COMMAND [conn4] command backend.$cmd command: createIndexes { createIndexes: "queue", indexes: [ { key: { name: 1, company: 1 }, background: false, unique: true, sparse: false, name: "name_1_company_1" } ], lsid: { id: UUID("e45670d2-d978-4855-ba7f-665fd399b047") }, $db: "backend" } numYields:0 reslen:113 locks:{ Global: { acquireCount: { r: 1, w: 1 } }, Database: { acquireCount: { W: 1 } }, Collection: { acquireCount: { w: 1 } } } protocol:op_query 271ms 2020-04-01T23:59:51.232+0000 I STORAGE [conn2] createCollection: auth.user with generated UUID: 182a903d-4967-4c9c-9705-75be8272814c 2020-04-01T23:59:51.436+0000 I INDEX [conn2] build index on: auth.user properties: { v: 2, unique: true, key: { email: 1 }, name: "email_1", ns: "auth.user", background: false, sparse: false } 2020-04-01T23:59:51.436+0000 I INDEX [conn2] building index using bulk method; build may temporarily use up to 500 megabytes of RAM 2020-04-01T23:59:51.438+0000 I INDEX [conn2] build index done. scanned 0 total records. 0 secs 2020-04-01T23:59:51.438+0000 I COMMAND [conn2] command auth.$cmd command: createIndexes { createIndexes: "user", indexes: [ { key: { email: 1 }, background: false, unique: true, sparse: false, name: "email_1" } ], lsid: { id: UUID("6cb3a83d-ab42-4532-8108-126354bfc7e9") }, $db: "auth" } numYields:0 reslen:113 locks:{ Global: { acquireCount: { r: 1, w: 1 } }, Database: { acquireCount: { W: 1 } }, Collection: { acquireCount: { w: 1 } } } protocol:op_query 205ms 2020-04-02T00:00:10.442+0000 I STORAGE [conn4] createCollection: backend.project with generated UUID: 2e472973-5bcf-4064-b15b-b8f5ce35ac63 2020-04-02T00:00:10.595+0000 I NETWORK [listener] connection accepted from 172.27.0.6:34718 #5 (5 connections now open) 2020-04-02T00:00:10.595+0000 I NETWORK [conn5] received client metadata from 172.27.0.6:34718 conn5: { driver: { name: "PyMongo", version: "3.6.1" }, os: { type: "Linux", name: "Linux", architecture: "x86_64", version: "4.19.76-linuxkit" }, platform: "CPython 3.6.8.final.0" } 2020-04-02T00:00:10.602+0000 I NETWORK [listener] connection accepted from 172.27.0.6:34724 #6 (6 connections now open) 2020-04-02T00:00:10.603+0000 I NETWORK [conn6] received client metadata from 172.27.0.6:34724 conn6: { driver: { name: "PyMongo", version: "3.6.1" }, os: { type: "Linux", name: "Linux", architecture: "x86_64", version: "4.19.76-linuxkit" }, platform: "CPython 3.6.8.final.0" } 2020-04-02T00:00:10.689+0000 I INDEX [conn4] build index on: backend.project properties: { v: 2, key: { _fts: "text", _ftsx: 1 }, name: "backend-db.project.main_text_index", ns: "backend.project", background: false, default_language: "english", weights: { _id: 1, description: 10, id: 10, name: 10 }, language_override: "language", textIndexVersion: 3 } 2020-04-02T00:00:10.689+0000 I INDEX [conn4] building index using bulk method; build may temporarily use up to 500 megabytes of RAM 2020-04-02T00:00:10.690+0000 I INDEX [conn4] build index done. scanned 0 total records. 0 secs 2020-04-02T00:00:10.690+0000 I COMMAND [conn4] command backend.$cmd command: createIndexes { createIndexes: "project", indexes: [ { key: { name: "text", _id: "text", description: "text" }, background: false, name: "backend-db.project.main_text_index", default_language: "english", weights: { name: 10, id: 10, description: 10 } } ], lsid: { id: UUID("e45670d2-d978-4855-ba7f-665fd399b047") }, $db: "backend" } numYields:0 reslen:113 locks:{ Global: { acquireCount: { r: 1, w: 1 } }, Database: { acquireCount: { W: 1 } }, Collection: { acquireCount: { w: 1 } } } protocol:op_query 248ms 2020-04-02T00:00:10.691+0000 I STORAGE [conn6] createCollection: backend.task with generated UUID: e77b153d-bfb7-457f-a483-e118f4e93cbe 2020-04-02T00:00:10.904+0000 I INDEX [conn6] build index on: backend.task properties: { v: 2, key: { created: 1 }, name: "created_1", ns: "backend.task", background: false } 2020-04-02T00:00:10.904+0000 I INDEX [conn6] building index using bulk method; build may temporarily use up to 500 megabytes of RAM 2020-04-02T00:00:10.906+0000 I INDEX [conn6] build index done. scanned 0 total records. 0 secs 2020-04-02T00:00:10.906+0000 I COMMAND [conn6] command backend.$cmd command: createIndexes { createIndexes: "task", indexes: [ { key: { created: 1 }, background: false, name: "created_1" } ], lsid: { id: UUID("719bfad7-ef3f-4288-8cc6-11aa9efc5578") }, $db: "backend" } numYields:0 reslen:113 locks:{ Global: { acquireCount: { r: 1, w: 1 } }, Database: { acquireCount: { W: 1 }, acquireWaitCount: { W: 1 }, timeAcquiringMicros: { W: 86986 } }, Collection: { acquireCount: { w: 1 } } } protocol:op_query 302ms 2020-04-02T00:00:10.981+0000 I INDEX [conn4] build index on: backend.project properties: { v: 2, unique: true, key: { name: 1, company: 1 }, name: "name_1_company_1", ns: "backend.project", background: false, sparse: false } 2020-04-02T00:00:10.981+0000 I INDEX [conn4] building index using bulk method; build may temporarily use up to 500 megabytes of RAM 2020-04-02T00:00:10.994+0000 I INDEX [conn4] build index done. scanned 0 total records. 0 secs 2020-04-02T00:00:10.994+0000 I COMMAND [conn4] command backend.$cmd command: createIndexes { createIndexes: "project", indexes: [ { key: { name: 1, company: 1 }, background: false, unique: true, sparse: false, name: "name_1_company_1" } ], lsid: { id: UUID("e45670d2-d978-4855-ba7f-665fd399b047") }, $db: "backend" } numYields:0 reslen:113 locks:{ Global: { acquireCount: { r: 1, w: 1 } }, Database: { acquireCount: { W: 1 }, acquireWaitCount: { W: 1 }, timeAcquiringMicros: { W: 214397 } }, Collection: { acquireCount: { w: 1 } } } protocol:op_query 302ms 2020-04-02T00:00:10.994+0000 I COMMAND [conn5] command backend.project command: find { find: "project", filter: { $or: [ { company: { $in: [ "d1bd92a3b039400cbafc60a7a5b1e52b", null, "" ] } }, { company: { $exists: false } } ] }, sort: { last_update: -1 }, limit: 4, lsid: { id: UUID("c52db52d-d541-4106-8953-f46b844cfac3") }, $readPreference: { mode: "secondaryPreferred" }, $db: "backend" } planSummary: COLLSCAN keysExamined:0 docsExamined:0 hasSortStage:1 cursorExhausted:1 numYields:0 nreturned:0 reslen:103 locks:{ Global: { acquireCount: { r: 2 } }, Database: { acquireCount: { r: 1 }, acquireWaitCount: { r: 1 }, timeAcquiringMicros: { r: 301721 } }, Collection: { acquireCount: { r: 1 } } } protocol:op_query 301ms 2020-04-02T00:00:11.071+0000 I INDEX [conn6] build index on: backend.task properties: { v: 2, key: { started: 1 }, name: "started_1", ns: "backend.task", background: false } 2020-04-02T00:00:11.071+0000 I INDEX [conn6] building index using bulk method; build may temporarily use up to 500 megabytes of RAM 2020-04-02T00:00:11.073+0000 I INDEX [conn6] build index done. scanned 0 total records. 0 secs 2020-04-02T00:00:11.073+0000 I COMMAND [conn6] command backend.$cmd command: createIndexes { createIndexes: "task", indexes: [ { key: { started: 1 }, background: false, name: "started_1" } ], lsid: { id: UUID("719bfad7-ef3f-4288-8cc6-11aa9efc5578") }, $db: "backend" } numYields:0 reslen:113 locks:{ Global: { acquireCount: { r: 1, w: 1 } }, Database: { acquireCount: { W: 1 }, acquireWaitCount: { W: 1 }, timeAcquiringMicros: { W: 87848 } }, Collection: { acquireCount: { w: 1 } } } protocol:op_query 166ms 2020-04-02T00:00:11.151+0000 I INDEX [conn6] build index on: backend.task properties: { v: 2, key: { completed: 1 }, name: "completed_1", ns: "backend.task", background: false } 2020-04-02T00:00:11.151+0000 I INDEX [conn6] building index using bulk method; build may temporarily use up to 500 megabytes of RAM 2020-04-02T00:00:11.153+0000 I INDEX [conn6] build index done. scanned 0 total records. 0 secs 2020-04-02T00:00:11.286+0000 I INDEX [conn4] build index on: backend.task properties: { v: 2, key: { _fts: "text", _ftsx: 1 }, name: "backend-db.task.main_text_index", ns: "backend.task", background: false, default_language: "english", weights: { _id: 1, comment: 10, execution.model: 2, id: 10, name: 10, output.model: 2, script.entry_point: 1, script.repository: 1 }, language_override: "language", textIndexVersion: 3 } 2020-04-02T00:00:11.286+0000 I INDEX [conn4] building index using bulk method; build may temporarily use up to 500 megabytes of RAM 2020-04-02T00:00:11.288+0000 I INDEX [conn4] build index done. scanned 0 total records. 0 secs 2020-04-02T00:00:11.288+0000 I COMMAND [conn4] command backend.$cmd command: createIndexes { createIndexes: "task", indexes: [ { key: { name: "text", _id: "text", comment: "text", execution.model: "text", output.model: "text", script.repository: "text", script.entry_point: "text" }, background: false, name: "backend-db.task.main_text_index", default_language: "english", weights: { name: 10, id: 10, comment: 10, execution.model: 2, output.model: 2, script.repository: 1, script.entry_point: 1 } } ], lsid: { id: UUID("719bfad7-ef3f-4288-8cc6-11aa9efc5578") }, $db: "backend" } numYields:0 reslen:113 locks:{ Global: { acquireCount: { r: 1, w: 1 } }, Database: { acquireCount: { W: 1 } }, Collection: { acquireCount: { w: 1 } } } protocol:op_query 133ms 2020-04-02T00:00:22.684+0000 I STORAGE [conn4] createCollection: backend.user with generated UUID: b18caa59-042e-4659-b47b-9449be02d786 2020-04-02T00:04:35.295+0000 I STORAGE [thread7] createCollection: config.system.sessions with generated UUID: 76646d98-47f6-4702-926c-b95eb60042ec 2020-04-02T00:04:35.407+0000 I INDEX [thread7] build index on: config.system.sessions properties: { v: 2, key: { lastUse: 1 }, name: "lsidTTLIndex", ns: "config.system.sessions", expireAfterSeconds: 1800 } 2020-04-02T00:04:35.407+0000 I INDEX [thread7] building index using bulk method; build may temporarily use up to 500 megabytes of RAM 2020-04-02T00:04:35.407+0000 W STORAGE [thread7] failed to create WiredTiger bulk cursor: Device or resource busy 2020-04-02T00:04:35.407+0000 W STORAGE [thread7] falling back to non-bulk cursor for index table:index-32--8328462529197189371 2020-04-02T00:04:35.407+0000 I INDEX [thread7] build index done. scanned 0 total records. 0 secs 2020-04-02T00:04:35.407+0000 I COMMAND [thread7] command config.$cmd command: createIndexes { createIndexes: "system.sessions", indexes: [ { key: { lastUse: 1 }, name: "lsidTTLIndex", expireAfterSeconds: 1800 } ], $db: "config" } numYields:0 reslen:98 locks:{ Global: { acquireCount: { r: 1, w: 1 } }, Database: { acquireCount: { W: 1 } }, Collection: { acquireCount: { w: 1 } } } protocol:op_msg 112ms 2020-04-02T00:10:35.637+0000 I NETWORK [listener] connection accepted from 127.0.0.1:39112 #7 (7 connections now open) 2020-04-02T00:10:35.638+0000 I NETWORK [conn7] received client metadata from 127.0.0.1:39112 conn7: { application: { name: "MongoDB Shell" }, driver: { name: "MongoDB Internal Client", version: "3.6.5" }, os: { type: "Linux", name: "PRETTY_NAME="Debian GNU/Linux 8 (jessie)"", architecture: "x86_64", version: "Kernel 4.19.76-linuxkit" } } 2020-04-02T02:56:40.274+0000 I NETWORK [conn7] end connection 127.0.0.1:39112 (6 connections now open)