make logging less verbose

This commit is contained in:
Jan Pochyla 2016-10-06 12:29:57 +02:00
parent c019741c33
commit 6d5514ac4a
4 changed files with 14 additions and 16 deletions

View File

@ -19,8 +19,8 @@ def perf_info_debug():
mem_alloc = gc.mem_alloc() mem_alloc = gc.mem_alloc()
gc.collect() gc.collect()
log.info(__name__, "mem_alloc: %s/%s, delay_avg: %d, delay_last: %d, queue: %s", log.debug(__name__, "mem_alloc: %s/%s, delay_avg: %d, delay_last: %d, queue: %s",
mem_alloc, gc.mem_alloc(), delay_avg, delay_last, ', '.join(queue)) mem_alloc, gc.mem_alloc(), delay_avg, delay_last, ', '.join(queue))
yield loop.Sleep(1000000) yield loop.Sleep(1000000)

View File

@ -14,8 +14,7 @@ def _unimport_func(func):
ret = func(*args, **kwargs) ret = func(*args, **kwargs)
finally: finally:
for to_remove in set(sys.modules) - mods: for to_remove in set(sys.modules) - mods:
print('removing module', to_remove) log.debug(__name__, 'unimport %s', to_remove)
# log.info(__name__, 'removing module %s', to_remove)
del sys.modules[to_remove] del sys.modules[to_remove]
gc.collect() gc.collect()
return ret return ret
@ -29,8 +28,7 @@ def _unimport_genfunc(genfunc):
ret = await genfunc(*args, **kwargs) ret = await genfunc(*args, **kwargs)
finally: finally:
for to_remove in set(sys.modules) - mods: for to_remove in set(sys.modules) - mods:
print('removing module', to_remove) log.debug(__name__, 'unimport %s', to_remove)
# log.info(__name__, 'removing module %s', to_remove)
del sys.modules[to_remove] del sys.modules[to_remove]
gc.collect() gc.collect()
return ret return ret

View File

@ -34,20 +34,20 @@ def open_session(session_id=None):
if session_id is None: if session_id is None:
session_id = generate_session_id() session_id = generate_session_id()
_opened_sessions.add(session_id) _opened_sessions.add(session_id)
log.info(__name__, 'opened session %d: %s', session_id, _opened_sessions) log.info(__name__, 'session %d: open', session_id)
return session_id return session_id
def close_session(session_id): def close_session(session_id):
_opened_sessions.discard(session_id) _opened_sessions.discard(session_id)
_session_handlers.pop(session_id, None) _session_handlers.pop(session_id, None)
log.info(__name__, 'closed session %d: %s', session_id, _opened_sessions) log.info(__name__, 'session %d: close', session_id)
def register_type(wire_type, genfunc, *args): def register_type(wire_type, genfunc, *args):
if wire_type in _workflow_genfuncs: if wire_type in _workflow_genfuncs:
raise KeyError('message of type %d already registered' % wire_type) raise KeyError('message of type %d already registered' % wire_type)
log.info(__name__, 'registering message type %d', wire_type) log.info(__name__, 'register type %d', wire_type)
_workflow_genfuncs[wire_type] = (genfunc, args) _workflow_genfuncs[wire_type] = (genfunc, args)
@ -56,7 +56,7 @@ def register_session(session_id, handler):
raise KeyError('session %d is unknown' % session_id) raise KeyError('session %d is unknown' % session_id)
if session_id in _session_handlers: if session_id in _session_handlers:
raise KeyError('session %d is already being listened on' % session_id) raise KeyError('session %d is already being listened on' % session_id)
log.info(__name__, 'listening on session %d', session_id) log.info(__name__, 'session %d: listening', session_id)
_session_handlers[session_id] = handler _session_handlers[session_id] = handler
@ -76,7 +76,7 @@ def setup():
async def read_message(session_id, *exp_types): async def read_message(session_id, *exp_types):
log.info(__name__, 'reading message of types %s', exp_types) log.info(__name__, 'session %d: read types %s', session_id, exp_types)
future = Future() future = Future()
if session_id == SESSION_V1: if session_id == SESSION_V1:
wire_decoder = decode_wire_v1_stream( wire_decoder = decode_wire_v1_stream(
@ -90,7 +90,7 @@ async def read_message(session_id, *exp_types):
async def write_message(session_id, pbuf_message): async def write_message(session_id, pbuf_message):
log.info(__name__, 'writing message %s', pbuf_message) log.info(__name__, 'session %d: write %s', session_id, pbuf_message)
msg_data = pbuf_message.dumps() msg_data = pbuf_message.dumps()
msg_type = pbuf_message.message_type.wire_type msg_type = pbuf_message.message_type.wire_type
@ -196,8 +196,8 @@ def _handle_registered_type(msg_type, data_len, session_id):
def _handle_unexpected_type(msg_type, data_len, session_id): def _handle_unexpected_type(msg_type, data_len, session_id):
log.info(__name__, 'skipping message %d of len %d on session %d' % log.warning(__name__, 'session %d: skip type %d, len %d',
(msg_type, data_len, session_id)) session_id, msg_type, data_len)
try: try:
while True: while True:
yield yield

View File

@ -8,12 +8,12 @@ _DEFAULT_IFACE = const(0)
def read_report_stream(target, iface=_DEFAULT_IFACE): def read_report_stream(target, iface=_DEFAULT_IFACE):
while True: while True:
report, = yield loop.Select(iface) report, = yield loop.Select(iface)
log.info(__name__, 'read report %s', ubinascii.hexlify(report)) log.debug(__name__, 'read report %s', ubinascii.hexlify(report))
target.send(report) target.send(report)
def write_report_stream(iface=_DEFAULT_IFACE): def write_report_stream(iface=_DEFAULT_IFACE):
while True: while True:
report = yield report = yield
log.info(__name__, 'write report %s', ubinascii.hexlify(report)) log.debug(__name__, 'write report %s', ubinascii.hexlify(report))
msg.send(iface, report) msg.send(iface, report)