Major - P3 Queries against virtual collections (e.g. queries that specify named pipes for data transfer) currently result in these log messages:
{"t":{"$date":"2023-02-20T12:58:48.095-08:00"},"s":"I", "c":"STORAGE", "id":20320, "ctx":"conn3","msg":"createCollection","attr":{"namespace":"test.named_pipe_1","uuidDisposition":"generated","uuid":{"uuid":{"$uuid":"31c6b2ac-3dfc-4965-9738-a484c2ebd43d"}},"options":{"autoIndexId":false}}}
{"t":{"$date":"2023-02-20T12:58:48.095-08:00"},"s":"I", "c":"STORAGE", "id":7005001, "ctx":"conn3","msg":"Named pipe is closed","attr":{"path":"/tmp/named_pipe_1"}}
{"t":{"$date":"2023-02-20T12:58:48.095-08:00"},"s":"I", "c":"STORAGE", "id":7005001, "ctx":"conn3","msg":"Named pipe is closed","attr":{"path":"/tmp/named_pipe_1"}}
{"t":{"$date":"2023-02-20T12:58:48.095-08:00"},"s":"I", "c":"STORAGE", "id":20318, "ctx":"conn3","msg":"Finishing collection drop","attr":{"namespace":"test.named_pipe_1","uuid":{"uuid":{"$uuid":"31c6b2ac-3dfc-4965-9738-a484c2ebd43d"}}}}
This is a significant amount of logging for a single query, especially because create/dropping of the collection now goes from a log that is only published infrequently in OLTP workloads to being published for every query. To reduce the verbosity here, we should:
1. Change create/drop collection to be DEBUG level for virtual collections.
2. Deduplicate the "Named pipe is closed" message so it is only published once.
- related to
-
SERVER-80367 Set all virtual collection query logs to be DEBUG level
-
- Closed
-