[CDRIVER-2248] db slow log has more " saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" }" Created: 19/Aug/17  Updated: 23/Aug/17  Resolved: 21/Aug/17

Status: Closed
Project: C Driver
Component/s: auth
Affects Version/s: None
Fix Version/s: None

Type: Bug Priority: Critical - P2
Reporter: kylin Assignee: Unassigned
Resolution: Done Votes: 0
Labels: Bug
Remaining Estimate: Not Specified
Time Spent: Not Specified
Original Estimate: Not Specified
Environment:

os: CentOS release 6.5 (Final)
mongod: 3.2.4
drive: mgo


Backwards Compatibility: Fully Compatible

 Description   

A lot of slow logs are popping up

2017-08-19T01:04:52.623+0800 I COMMAND  [conn2059626] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 233ms
2017-08-19T01:04:52.624+0800 I COMMAND  [conn2057077] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 260ms
2017-08-19T01:04:52.623+0800 I COMMAND  [conn2057122] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 262ms
2017-08-19T01:04:52.624+0800 I COMMAND  [conn2059636] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 243ms
2017-08-19T01:04:52.623+0800 I COMMAND  [conn2057082] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 251ms
2017-08-19T01:04:52.624+0800 I COMMAND  [conn2059632] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 120ms
2017-08-19T01:04:52.624+0800 I COMMAND  [conn2057362] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 322ms
2017-08-19T01:04:52.622+0800 I COMMAND  [conn2057508] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 223ms
2017-08-19T01:04:52.624+0800 I COMMAND  [conn2058127] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 317ms
2017-08-19T01:04:52.623+0800 I COMMAND  [conn2058103] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 238ms
2017-08-19T01:04:52.623+0800 I COMMAND  [conn2057528] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 198ms
2017-08-19T01:04:52.624+0800 I COMMAND  [conn2057386] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 248ms
2017-08-19T01:04:52.624+0800 I COMMAND  [conn2057131] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 288ms
2017-08-19T01:04:52.623+0800 I COMMAND  [conn2057957] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 257ms
2017-08-19T01:04:52.623+0800 I COMMAND  [conn2058358] command im.$cmd command: saslStart { saslStart: 1, mechanism: "SCRAM-SHA-1", payload: "xxx" } keyUpdates:0 writeConflicts:0 numYields:0
 reslen:155 locks:{} protocol:op_query 128ms
 
 
2017-08-19T14:09:05.132+0800 I COMMAND  [conn2058119] command admin.$cmd command: isMaster { ismaster: 1 } keyUpdates:0 writeConflicts:0 numYields:0 reslen:384 locks:{} protocol:op_query 13
2ms
2017-08-19T14:09:05.132+0800 I COMMAND  [conn2057097] command admin.$cmd command: isMaster { ismaster: 1 } keyUpdates:0 writeConflicts:0 numYields:0 reslen:384 locks:{} protocol:op_query 13
2ms
2017-08-19T14:09:05.132+0800 I COMMAND  [conn2057993] command admin.$cmd command: isMaster { ismaster: 1 } keyUpdates:0 writeConflicts:0 numYields:0 reslen:384 locks:{} protocol:op_query 13
2ms
2017-08-19T14:09:05.132+0800 I COMMAND  [conn2057129] command admin.$cmd command: isMaster { ismaster: 1 } keyUpdates:0 writeConflicts:0 numYields:0 reslen:384 locks:{} protocol:op_query 13
2ms
2017-08-19T14:09:05.132+0800 I COMMAND  [conn2057052] command admin.$cmd command: isMaster { ismaster: 1 } keyUpdates:0 writeConflicts:0 numYields:0 reslen:384 locks:{} protocol:op_query 13
2ms
2017-08-19T14:09:05.132+0800 I COMMAND  [conn2057409] command admin.$cmd command: isMaster { ismaster: 1 } keyUpdates:0 writeConflicts:0 numYields:0 reslen:384 locks:{} protocol:op_query 13
2ms
2017-08-19T14:09:05.132+0800 I COMMAND  [conn2057184] command admin.$cmd command: isMaster { ismaster: 1 } keyUpdates:0 writeConflicts:0 numYields:0 reslen:384 locks:{} protocol:op_query 13
2ms
2017-08-19T14:09:05.132+0800 I COMMAND  [conn2059643] command admin.$cmd command: isMaster { ismaster: 1 } keyUpdates:0 writeConflicts:0 numYields:0 reslen:384 locks:{} protocol:op_query 132ms



 Comments   
Comment by kylin [ 23/Aug/17 ]

ok,thanks

Comment by A. Jesse Jiryu Davis [ 23/Aug/17 ]

If you'd like to ask a question about MGO, please open an issue in the tracker at github.com/go-mgo/mgo. If your question is about the MongoDB server, please open an issue in the SERVER project, not here in CDRIVER. This issue tracker is for bugs in the MongoDB C Driver. Thanks!

Comment by kylin [ 23/Aug/17 ]

Thank you,Will there be lock competition for writing and authentication operations?

Comment by Bernie Hackett [ 21/Aug/17 ]

Hi kylin.chen,

The MGO driver is not maintained by MongoDB, Inc. Please open a ticket here:

https://github.com/go-mgo/mgo

Comment by Hannes Magnusson [ 21/Aug/17 ]

I'm not sure what exactly you are reporting?

It is expected that SCRAM-SHA-1 authentication takes a while. It is built into the mechanism itself, otherwise bruteforcing the passwords would be trivial.

If you believe you found a bug in mongoc, please could you include a sample code showcasing the problem, along with what outcome you expect to see?

Comment by kylin [ 19/Aug/17 ]

The update operation is caused,thank you

Generated at Wed Feb 07 21:14:38 UTC 2024 using Jira 9.7.1#970001-sha1:2222b88b221c4928ef0de3161136cc90c8356a66.