[2020/11/24 20:27:54.053] Failed test: u'maxConnecting is enforced'
 [2020/11/24 20:27:54.053] Operations:
 [2020/11/24 20:27:54.053] {u'name': u'start', u'target': u'thread1'}
 [2020/11/24 20:27:54.053] {u'name': u'checkOut', u'thread': u'thread1'}
 [2020/11/24 20:27:54.053] {u'name': u'start', u'target': u'thread2'}
 [2020/11/24 20:27:54.053] {u'thread': u'thread2', u'name': u'wait', u'ms': 100}
 [2020/11/24 20:27:54.053] {u'name': u'checkOut', u'thread': u'thread2'}
 [2020/11/24 20:27:54.053] {u'name': u'start', u'target': u'thread3'}
 [2020/11/24 20:27:54.053] {u'thread': u'thread3', u'name': u'wait', u'ms': 100}
 [2020/11/24 20:27:54.053] {u'name': u'checkOut', u'thread': u'thread3'}
 [2020/11/24 20:27:54.053] {u'count': 3, u'name': u'waitForEvent', u'event': u'ConnectionReady'}
 [2020/11/24 20:27:54.053] Threads:
 [2020/11/24 20:27:54.053] {u'thread3': <SpecRunnerThread(thread3, started daemon 140145570637568)>, u'thread2': <SpecRunnerThread(thread2, started daemon 140143130294016)>, u'thread1': <SpecRunnerThread(thread1, started daemon 140143140783872)>}
 [2020/11/24 20:27:54.053] Connections:
 [2020/11/24 20:27:54.053] {}
 [2020/11/24 20:27:54.053] Events:
 [2020/11/24 20:27:54.053] PoolCreatedEvent(('localhost', 27017), {'maxPoolSize': 10, 'waitQueueTimeoutMS': 5000.0})
 [2020/11/24 20:27:54.053] ConnectionCheckOutStartedEvent(('localhost', 27017))
 [2020/11/24 20:27:54.053] ConnectionCreatedEvent(('localhost', 27017), 1)
 [2020/11/24 20:27:54.053] ConnectionCheckOutStartedEvent(('localhost', 27017))
 [2020/11/24 20:27:54.053] ConnectionCreatedEvent(('localhost', 27017), 2)
 [2020/11/24 20:27:54.053] ConnectionReadyEvent(('localhost', 27017), 1)
 [2020/11/24 20:27:54.053] ConnectionCheckedOutEvent(('localhost', 27017), 1)
 [2020/11/24 20:27:54.053] ConnectionReadyEvent(('localhost', 27017), 2)
 [2020/11/24 20:27:54.053] ConnectionCheckedOutEvent(('localhost', 27017), 2)
 [2020/11/24 20:27:54.053]   test_cmap_pool_checkout_maxConnecting_is_enforced_maxConnecting_is_enforced (test_cmap.TestCMAP) ... FAIL (12.317s)
...
 [2020/11/24 20:33:15.958] ======================================================================
 [2020/11/24 20:33:15.958] FAIL [12.317s]: test_cmap_pool_checkout_maxConnecting_is_enforced_maxConnecting_is_enforced (test_cmap.TestCMAP)
 [2020/11/24 20:33:15.958] ----------------------------------------------------------------------
 [2020/11/24 20:33:15.958] Traceback (most recent call last):
 [2020/11/24 20:33:15.958]   File "/data/mci/4896f95d7e99a267a12c67b5378967b8/src/test/__init__.py", line 444, in wrap
 [2020/11/24 20:33:15.958]     return f(*args, **kwargs)
 [2020/11/24 20:33:15.958]   File "/data/mci/4896f95d7e99a267a12c67b5378967b8/src/test/test_cmap.py", line 399, in run_scenario
 [2020/11/24 20:33:15.958]     self.run_scenario(scenario_def, test)
 [2020/11/24 20:33:15.958]   File "/data/mci/4896f95d7e99a267a12c67b5378967b8/src/test/test_cmap.py", line 238, in run_scenario
 [2020/11/24 20:33:15.958]     self.run_operations(test['operations'])
 [2020/11/24 20:33:15.958]   File "/data/mci/4896f95d7e99a267a12c67b5378967b8/src/test/test_cmap.py", line 146, in run_operations
 [2020/11/24 20:33:15.959]     self.run_operation(op)
 [2020/11/24 20:33:15.959]   File "/data/mci/4896f95d7e99a267a12c67b5378967b8/src/test/test_cmap.py", line 140, in run_operation
 [2020/11/24 20:33:15.959]     meth(op)
 [2020/11/24 20:33:15.959]   File "/data/mci/4896f95d7e99a267a12c67b5378967b8/src/test/test_cmap.py", line 107, in wait_for_event
 [2020/11/24 20:33:15.959]     'find %s %s event(s)' % (count, event))
 [2020/11/24 20:33:15.959]   File "/data/mci/4896f95d7e99a267a12c67b5378967b8/src/test/utils.py", line 695, in wait_until
 [2020/11/24 20:33:15.959]     raise AssertionError("Didn't ever %s" % success_description)
 [2020/11/24 20:33:15.959] AssertionError: Didn't ever find 3 <class 'pymongo.monitoring.ConnectionReadyEvent'> event(s)