v5 git 'install' and logging

[bell...@gmail.com]

I am using a v5 git 'install'. I have checked out 'tags/v5.0.0'. I am not using venv, I use pyenv so that I can easily change the python version I am using. I set debug = 1 in weewx.conf, but I don't seem to be getting any 'debug' logging.

Looking at the code, I see a default of 'False' is set in ~/weewx/src/weewx/__init__.py

In ~/weewx/src/weewxd.py there is a call to weeutil.logger.setup(namespace.log_label, config_dict) which does the following
    log_level = 'DEBUG' if weewx.debug else 'INFO'
    .
    .
    .
    logging.config.dictConfig(log_dict)

Later in ~/weewx/src/weewxd.py this is called, weewx_root, user_module = weeutil.startup.initialize(config_dict)
And it sets weewx.debug = to_int(config_dict.get('debug', 0))

Here the log I am seeing at startup
   weewxd[44781]: INFO __main__: Initializing weewxd version 5.0.0
   weewxd[44781]: INFO __main__: Command line: ~/weewx/src/weewxd.py
   weewxd[44781]: INFO __main__: Using Python 3.10.13 (main, Oct 23 2023, 11:48:50) [GCC 11.4.0]
   weewxd[44781]: INFO __main__: Located at ~/.pyenv/versions/3.10.13/bin/python3
   weewxd[44781]: INFO __main__: Platform Linux-5.15.0-92-generic-x86_64-with-glibc2.35
   weewxd[44781]: INFO __main__: Locale: 'en_US.UTF-8'
   weewxd[44781]: INFO __main__: Entry path: ~/weewx/src/weewxd.py
   weewxd[44781]: INFO __main__: WEEWX_ROOT: ~/weewx-data
   weewxd[44781]: INFO __main__: Configuration file: ~/weewx-data/weewx.conf
   weewxd[44781]: INFO __main__: User module: ~/weewx-data/bin/user
   weewxd[44781]: INFO __main__: Debug: 1
   weewxd[44781]: INFO weewx.engine: Loading station type Simulator (weewx.drivers.simulator)
   weewxd[44781]: INFO weewx.engine: StdConvert target unit is 0x1
   weewxd[44781]: INFO weewx.wxservices: StdWXCalculate will use data binding wx_binding
   weewxd[44781]: INFO weewx.engine: Archive will use data binding wx_binding
   weewxd[44781]: INFO weewx.engine: Record generation will be attempted in 'hardware'
   weewxd[44781]: INFO weewx.engine: Using archive interval of 300 seconds (specified in weewx configuration)
   weewxd[44781]: INFO weewx.restx: StationRegistry: Registration not requested.
   weewxd[44781]: INFO weewx.restx: Wunderground: Posting not enabled.
   weewxd[44781]: INFO weewx.restx: PWSweather: Posting not enabled.
   weewxd[44781]: INFO weewx.restx: CWOP: Posting not enabled.
   weewxd[44781]: INFO weewx.restx: WOW: Posting not enabled.
   weewxd[44781]: INFO weewx.restx: AWEKAS: Posting not enabled.
   weewxd[44781]: INFO weewx.engine: 'pyephem' detected, extended almanac data is available
   weewxd[44781]: INFO __main__: Starting up weewx version 5.0.0
   weewxd[44781]: INFO weewx.engine: Clock error is -0.03 seconds (positive is fast)
   weewxd[44781]: INFO weewx.engine: Using binding 'wx_binding' to database 'weewx.sdb'
   weewxd[44781]: INFO weewx.manager: Starting backfill of daily summaries
   weewxd[44781]: INFO weewx.manager: Empty database
   weewxd[44781]: INFO weewx.engine: Starting main packet loop.


If I set debug = True in ~/weewx/src/weewx/__init__.py, I get this log

   weewxd[45469]: INFO __main__: Initializing weewxd version 5.0.0
   weewxd[45469]: INFO __main__: Command line: ~/weewx/src/weewxd.py
   weewxd[45469]: INFO __main__: Using Python 3.10.13 (main, Oct 23 2023, 11:48:50) [GCC 11.4.0]
   weewxd[45469]: INFO __main__: Located at ~/.pyenv/versions/3.10.13/bin/python3
   weewxd[45469]: INFO __main__: Platform Linux-5.15.0-92-generic-x86_64-with-glibc2.35
   weewxd[45469]: INFO __main__: Locale: 'en_US.UTF-8'
   weewxd[45469]: INFO __main__: Entry path: ~/weewx/src/weewxd.py
   weewxd[45469]: INFO __main__: WEEWX_ROOT: ~/weewx-data
   weewxd[45469]: INFO __main__: Configuration file: ~/weewx-data/weewx.conf
   weewxd[45469]: INFO __main__: User module: ~/weewx-data/bin/user
   weewxd[45469]: INFO __main__: Debug: 1
   weewxd[45469]: DEBUG __main__: Initializing engine
   weewxd[45469]: INFO weewx.engine: Loading station type Simulator (weewx.drivers.simulator)
   weewxd[45469]: DEBUG weewx.engine: Loading service weewx.engine.StdTimeSynch
   weewxd[45469]: DEBUG weewx.engine: Finished loading service weewx.engine.StdTimeSynch
   weewxd[45469]: DEBUG weewx.engine: Loading service weewx.engine.StdConvert
   weewxd[45469]: INFO weewx.engine: StdConvert target unit is 0x1
   weewxd[45469]: DEBUG weewx.engine: Finished loading service weewx.engine.StdConvert
   weewxd[45469]: DEBUG weewx.engine: Loading service weewx.engine.StdCalibrate
   weewxd[45469]: DEBUG weewx.engine: Finished loading service weewx.engine.StdCalibrate
   weewxd[45469]: DEBUG weewx.engine: Loading service weewx.engine.StdQC
   weewxd[45469]: DEBUG weewx.engine: Finished loading service weewx.engine.StdQC
   weewxd[45469]: DEBUG weewx.engine: Loading service weewx.wxservices.StdWXCalculate
   weewxd[45469]: INFO weewx.wxservices: StdWXCalculate will use data binding wx_binding
   weewxd[45469]: DEBUG weewx.manager: Daily summary version is 4.0
   weewxd[45469]: DEBUG weewx.engine: Finished loading service weewx.wxservices.StdWXCalculate
   weewxd[45469]: DEBUG weewx.engine: Loading service weewx.wxxtypes.StdWXXTypes
   weewxd[45469]: DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdWXXTypes
   weewxd[45469]: DEBUG weewx.engine: Loading service weewx.wxxtypes.StdPressureCooker
   weewxd[45469]: DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdPressureCooker
   weewxd[45469]: DEBUG weewx.engine: Loading service weewx.wxxtypes.StdRainRater
   weewxd[45469]: DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdRainRater
   weewxd[45469]: DEBUG weewx.engine: Loading service weewx.wxxtypes.StdDelta
   weewxd[45469]: DEBUG weewx.engine: Finished loading service weewx.wxxtypes.StdDelta
   weewxd[45469]: DEBUG weewx.engine: Loading service weewx.engine.StdArchive
   weewxd[45469]: INFO weewx.engine: Archive will use data binding wx_binding
   weewxd[45469]: INFO weewx.engine: Record generation will be attempted in 'hardware'
   weewxd[45469]: INFO weewx.engine: Using archive interval of 300 seconds (specified in weewx configuration)
   weewxd[45469]: DEBUG weewx.engine: Use LOOP data in hi/low calculations: 1

Am I missing something obvious, or is this a bug?
Thanks. rich

[Tom Keffer]

You are not missing anything at all! It's a bug --- and a pretty obvious one that I should have caught a long time ago.

Thanks for pointing it out!

Fixed in commit 218085.