Fix #60

chronicles.nim

@@ -99,6 +99,8 @@ template dynamicLogScope*(bindings: varargs[untyped]) {.dirty.} =
                       bindSym("activeChroniclesScope", brForceOpen),
                       bindings)
 
+let chroniclesBlockName {.compileTime.} = ident "chroniclesLogStmt"
+
 when runtimeFilteringEnabled:
   import chronicles/topics_registry
   export setTopicState, setLogLevel, TopicState
@@ -127,7 +129,7 @@ when runtimeFilteringEnabled:
 
     result.add quote do:
       if not `topicsMatch`(LogLevel(`logLevel`), `topicsArray`):
-        break chroniclesLogStmt
+        break `chroniclesBlockName`
 else:
   template runtimeFilteringDisabledError =
     {.error: "Run-time topic filtering is currently disabled. " &
@@ -316,7 +318,12 @@ macro logIMPL(lineInfo: static InstInfo,
   code.add newCall("logAllDynamicProperties", Stream, record)
   code.add newCall("flushRecord", record)
 
-  result = newBlockStmt(id"chroniclesLogStmt", code)
+  result = quote do:
+    try:
+      block `chroniclesBlockName`:
+        `code`
+    except CatchableError as err:
+      logLoggingFailure(cstring(`eventName`))
 
   when defined(debugLogImpl):
     echo result.repr

chronicles.nimble

@@ -1,7 +1,7 @@
 mode = ScriptMode.Verbose
 
 packageName   = "chronicles"
-version       = "0.7.2"
+version       = "0.8.0"
 author        = "Status Research & Development GmbH"
 description   = "A crafty implementation of structured logging for Nim"
 license       = "Apache License 2.0"

chronicles/log_output.nim

@@ -158,9 +158,12 @@ template ignoreIOErrors(body: untyped) =
   try: body
   except IOError: discard
 
+proc logLoggingFailure*(msg: cstring) =
+  ignoreIOErrors: stderr.writeLine(msg)
+
 template undeliveredMsg(reason: string, logMsg: OutStr) =
   const error = "[Chronicles] " & reason & ". Log message not delivered: "
-  ignoreIOErrors stderr.writeLine(error & logMsg)
+  logLoggingFailure(cstring(error & logMsg))
 
 # XXX:
 # Uncomenting this leads to an error message that the Outputs tuple

tests/colors/ansi_colors.test

@@ -1,4 +1,4 @@
-program=long_lines
+program="../long_lines"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=AnsiColors
 chronicles_timestamps=None

tests/colors/native_colors_unix.test

@@ -1,6 +1,6 @@
 ; NativeColors on Unix will give AnsiColors
 
-program=long_lines
+program="../long_lines"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=NativeColors
 chronicles_timestamps=None

tests/colors/native_colors_windows.test

@@ -1,5 +1,5 @@
 ; NativeColors test for Windows, actually just compares the non colored output
-program=long_lines
+program="../long_lines"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=NativeColors
 chronicles_timestamps=None

tests/colors/no_colors.test

@@ -1,4 +1,4 @@
-program=long_lines
+program="../long_lines"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/customization/formatters.test

@@ -1,4 +1,4 @@
-program=custom_formatters
+program="../custom_formatters"
 chronicles_sinks="textlines[file(lines.txt,truncate)],textblocks[file(blocks.txt,truncate)],json[file(json.txt,truncate)]"
 chronicles_timestamps=None
 chronicles_colors=None

tests/lexical_scopes.nim

@@ -11,7 +11,7 @@ logScope:
 logScope:
   c = 100
 
-proc main(arg: int) =
+proc main(arg: int) {.raises: [Defect].} =
   logScope:
     topics = "main"
     arg

tests/loglevel/info_level.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/loglevel/no_level.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/loglevel/release_build_level.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/loglevel/topic_log_level1.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/loglevel/topic_log_level2.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/loglevel/topic_log_level3.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/loglevel/topic_log_level4.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/loglevel/topic_log_level_none.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/loglevel/topic_log_level_number.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/loglevel/trace_level.test

@@ -1,4 +1,4 @@
-program=no_side_effect
+program="../no_side_effect"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None
@@ -6,4 +6,4 @@ chronicles_log_level=TRACE
 
 [Output]
 stdout="""TRC effect-free                                tid=0
-"""
+"""

tests/loglevel/warn_level.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/logscope/dynamic_scopes.test

@@ -1,4 +1,4 @@
-program="dynamic_scopes"
+program="../dynamic_scopes"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/other/indent.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textblocks[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/other/line_numbers.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/other/long_lines.test

@@ -1,4 +1,4 @@
-program=long_lines
+program="../long_lines"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/perf/release_opt_size.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/perf/size_check_debug.test

@@ -1,4 +1,4 @@
-program=size
+program="../size"
 max_size=1000000
 
 chronicles_sinks="textlines[stdout]"

tests/perf/size_check_release.test

@@ -1,4 +1,4 @@
-program=size
+program="../size"
 max_size=650000
 release
 

tests/rt_filtering/runtime_filtering.test

@@ -1,4 +1,4 @@
-program="runtime_filtering"
+program="../runtime_filtering"
 chronicles_sinks="textlines[stdout,file]"
 chronicles_runtime_filtering="on"
 chronicles_colors=None

tests/rt_filtering/runtime_filtering_no_scopes.test

@@ -1,4 +1,4 @@
-program="runtime_filtering_no_scopes"
+program="../runtime_filtering_no_scopes"
 chronicles_sinks="textlines[stdout,file]"
 chronicles_runtime_filtering="on"
 chronicles_colors=None

tests/sinks/custom_file_nocolors.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[nocolors,file(mylog.txt)]"
 chronicles_timestamps=None
 

tests/sinks/custom_file_notimestamps.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[notimestamps,file(mylog.txt)]"
 chronicles_colors=None
 

tests/sinks/double_sink.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[file(lines.txt,truncate)],textblocks[file(blocks.txt,truncate)]"
 chronicles_timestamps=None
 chronicles_colors=None

tests/sinks/json_file_stdout.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="json[stdout,file]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/sinks/property_per_sink.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[file(lines.txt,truncate),nocolors],textblocks[file(blocks.txt,truncate),notimestamps,ansicolors]"
 
 [Output]

tests/sinks/textblocks_file_stdout.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textblocks[stdout,file]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/sinks/textlines_file.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[file]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/sinks/textlines_file_stdout.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[stdout,file]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/sinks/textlines_stdout.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/sinks/tripple_sink.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[file(lines.txt,truncate)],textblocks[file(blocks.txt,truncate)],json[file(log.json,truncate)]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/streams/custom_stream.test

@@ -1,4 +1,4 @@
-program="custom_stream"
+program="../custom_stream"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/streams/file_log_stream.test

@@ -1,4 +1,4 @@
-program=file_log_stream
+program="../file_log_stream"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/streams/runtime_path.test

@@ -1,4 +1,4 @@
-program=runtime_path
+program="../runtime_path"
 chronicles_sinks="textlines[file]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/streams/streams.test

@@ -1,4 +1,4 @@
-program=multiple_streams
+program="../multiple_streams"
 chronicles_streams="foo[textlines],bar[textlines]"
 chronicles_colors=None
 

tests/streams/streams_different_formats.test

@@ -1,4 +1,4 @@
-program=multiple_streams
+program="../multiple_streams"
 chronicles_streams="foo[textlines],bar[json[file]]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/streams/streams_different_formats2.test

@@ -1,4 +1,4 @@
-program=multiple_streams
+program="../multiple_streams"
 chronicles_streams="foo[textlines],bar[textblocks[file]]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/streams/streams_different_property.test

@@ -1,4 +1,4 @@
-program=multiple_streams
+program="../multiple_streams"
 chronicles_streams="foo[textlines[stdout,nocolors]],bar[textlines[file,notimestamps,ansicolors]]"
 
 [Output]

tests/streams/xml_stream_usage.test

@@ -1,4 +1,4 @@
-program=xml_stream_usage
+program="../xml_stream_usage"
 chronicles_colors=None
 chronicles_timestamps=None
 

tests/timestamps/no_timestamps.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[stdout,file]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/timestamps/ownpeg_timestamps.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[stdout,file]"
 chronicles_colors=None
 chronicles_timestamps=UnixTime

tests/timestamps/rfc_timestamps.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[stdout,file]"
 chronicles_colors=None
 chronicles_timestamps=RfcTime

tests/timestamps/unix_timestamps.test

@@ -1,4 +1,4 @@
-program=lexical_scopes
+program="../lexical_scopes"
 chronicles_sinks="textlines[stdout,file]"
 chronicles_colors=None
 chronicles_timestamps=UnixTime

tests/topics/disabled.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/topics/enabled.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/topics/enabled_vs_disabled.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/topics/enabled_vs_required.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/topics/required1.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/topics/required2.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/topics/required_vs_disabled.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None

tests/topics/required_vs_disabled2.test

@@ -1,4 +1,4 @@
-program=topics_and_loglvls
+program="../topics_and_loglvls"
 chronicles_sinks="textlines[stdout]"
 chronicles_colors=None
 chronicles_timestamps=None