MQTTSubscribe with WeeWX 4.0.0.b8

108 views
Skip to first unread message

Ralph Underwood

unread,
Jan 14, 2020, 6:51:01 PM1/14/20
to weewx-development
I have been working on getting MQTTSubscribe working on my development station (RPi3 with Buster) running WeeWx 4.0.0.b8. I think I have managed to get Python3 versions of all of the prerequisites for WeeWx and MQTTSubscribe. I am using the Simulator as the driver, MQTTSubscribe as a service.


Thanks for any help!
Ralph


I'm getting a lot of messages - these standout to me:
Jan 14 15:29:19 TestPi weewx[5118] DEBUG user.MQTTSubscribe: MessageCallbackProvider For weather has QOS of 0 and retain of 0 received: b'TIME:0,soilTemp3:14.68,INHU:40.00'
Jan 14 15:29:19 TestPi weewx[5118] ERROR user.MQTTSubscribe: MessageCallbackProvider on_message_keyword failed with: must be str or None, not list
Jan 14 15:29:19 TestPi weewx[5118] ERROR user.MQTTSubscribe: **** MessageCallbackProvider Ignoring topic=weather and payload=b'TIME:0,soilTemp3:14.68,INHU:40.00'


This is log after a WeeWx restart:
Jan 14 15:39:39 TestPi systemd[1]: Starting LSB: weewx weather system...
Jan 14 15:39:39 TestPi weewx[5252] INFO weewx.engine: Initializing weewx version 4.0.0b8
Jan 14 15:39:39 TestPi weewx[5252] INFO weewx.engine: Using Python 3.7.3 (default, Apr  3 2019, 05:39:12) #012[GCC 8.2.0]
Jan 14 15:39:39 TestPi weewx[5252] INFO weewx.engine: Platform Linux-4.19.75-v7+-armv7l-with-debian-10.1
Jan 14 15:39:39 TestPi weewx[5252] INFO weewx.engine: Locale is 'en_US.UTF-8'
Jan 14 15:39:39 TestPi weewx[5252] INFO weewx.engine: PID file is /var/run/weewx.pid
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.engine: Using configuration file /home/weewx/weewx.conf
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Debug is 1
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Initializing engine
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.engine: Loading station type Simulator (weewx.drivers.simulator)
Jan 14 15:39:40 TestPi weewx[5241]: Starting weewx weather system: weewx.
Jan 14 15:39:40 TestPi systemd[1]: Started LSB: weewx weather system.
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.engine.StdTimeSynch
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.engine.StdTimeSynch
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service user.MQTTSubscribe.MQTTSubscribeService
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Service binding is loop
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Overlap is 0.0
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: TopicManager config is {'unit_system': 'US', 'overlap': 0.0, 'weather': {}}
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Message callback config is {'type': 'keyword', 'keyword_delimiter': [], 'keyword_separator': ':', 'label_map': {'soilTemp3': 'soilTemp3', 'soilTemp2': 'soilTemp2', 'tempSoil1': 'soilTemp1'}}
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Message callback provider is user.MQTTSubscribe.MessageCallbackProvider
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Client id is MQTTSubscribe-7942
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Clean session is True
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: MQTTSubscribe version is 1.4.0
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Host is 192.168.7.37
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Port is 1883
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Keep alive is 60
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Username is None
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Password is not set
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Archive topic is None
Jan 14 15:39:40 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Starting loop
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service user.MQTTSubscribe.MQTTSubscribeService
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.engine.StdConvert
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.engine: StdConvert target unit is 0x1
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.engine.StdConvert
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.engine.StdCalibrate
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.engine.StdCalibrate
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.engine.StdQC
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.engine.StdQC
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.wxservices.StdWXCalculate
Jan 14 15:39:40 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Connected with result code 0
Jan 14 15:39:40 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Connected flags {'session present': 0}
Jan 14 15:39:40 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Subscribe to weather has a mid 1 and rc 0
Jan 14 15:39:40 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Subscribed to topic mid: 1 is size 1 has a QOS of 0
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.manager: Daily summary version is 2.0
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.wxservices: The following values will be calculated: altimeter=prefer_hardware, appTemp=prefer_hardware, barometer=prefer_hardware, beaufort=prefer_hardware, cloudbase=prefer_hardware, dewpoint=prefer_hardware, ET=prefer_hardware, heatindex=prefer_hardware, humidex=prefer_hardware, inDewpoint=prefer_hardware, maxSolarRad=prefer_hardware, pressure=prefer_hardware, rainRate=prefer_hardware, windchill=prefer_hardware, windrun=prefer_hardware
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.wxservices: The following algorithms will be used for calculations: altimeter=aaASOS, maxSolarRad=RS
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.wxservices.StdWXCalculate
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.engine.StdArchive
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.engine: Archive will use data binding wx_binding
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.engine: Record generation will be attempted in 'hardware'
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.engine: Using archive interval of 300 seconds (specified in weewx configuration)
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Use LOOP data in hi/low calculations: 1
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.engine.StdArchive
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.restx.StdStationRegistry
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.restx: StationRegistry: Registration not requested.
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.restx.StdStationRegistry
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.restx.StdWunderground
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.restx: Wunderground: Posting not enabled.
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.restx.StdWunderground
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.restx.StdPWSweather
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.restx: PWSweather: Posting not enabled.
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.restx.StdPWSweather
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.restx.StdCWOP
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.restx: CWOP: Posting not enabled.
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.restx.StdCWOP
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.restx.StdWOW
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.restx: WOW: Posting not enabled.
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.restx.StdWOW
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.restx.StdAWEKAS
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.restx: AWEKAS: Posting not enabled.
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.restx.StdAWEKAS
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.engine.StdPrint
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.engine.StdPrint
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Loading service weewx.engine.StdReport
Jan 14 15:39:40 TestPi weewx[5256] DEBUG weewx.engine: Finished loading service weewx.engine.StdReport
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.engine: Starting up weewx version 4.0.0b8
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.engine: Clock error is -0.39 seconds (positive is fast)
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.engine: Using binding 'wx_binding' to database 'weewx.sdb'
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.manager: Starting backfill of daily summaries
Jan 14 15:39:40 TestPi weewx[5256] INFO weewx.engine: Starting main packet loop.
Jan 14 15:39:42 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:39:43 PST (1579045183) barometer: 31.099999998967093, consBatteryVoltage: 11.88335956474874, dateTime: 1579045183, heatingVoltage: 12.806815204975587, inHumidity: 29.999999958683617, inTemp: 63.00000002065819, inTempBatteryStatus: 0, outHumidity: 79.99999996901272, outTemp: 32.67858297022247, outTempBatteryStatus: 0, pressure: 31.099999998967093, radiation: 330.2889707910561, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.497150104067403, rxCheckPercent: 20.716608834615236, supplyVoltage: 10.967038025551402, txBatteryStatus: 0, usUnits: 1, UV: 4.624045591074786, windBatteryStatus: 0, windDir: 359.9999998140763, windGust: 6.197456769996279e-09, windGustDir: 359.9999998140763, windSpeed: 5.164547900449179e-09
Jan 14 15:39:42 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 0.000000 1579045183.000000
Jan 14 15:39:42 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:39:42 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:39:42 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:39:43 PST (1579045183) barometer: 31.099999998967093, consBatteryVoltage: 11.88335956474874, dateTime: 1579045183, heatingVoltage: 12.806815204975587, inHumidity: 29.999999958683617, inTemp: 63.00000002065819, inTempBatteryStatus: 0, outHumidity: 79.99999996901272, outTemp: 32.67858297022247, outTempBatteryStatus: 0, pressure: 31.099999998967093, radiation: 330.2889707910561, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.497150104067403, rxCheckPercent: 20.716608834615236, supplyVoltage: 10.967038025551402, txBatteryStatus: 0, usUnits: 1, UV: 4.624045591074786, windBatteryStatus: 0, windDir: 359.9999998140763, windGust: 6.197456769996279e-09, windGustDir: 359.9999998140763, windSpeed: 5.164547900449179e-09
Jan 14 15:39:45 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:39:45 PST (1579045185) barometer: 31.099999990703814, consBatteryVoltage: 12.64341440210935, dateTime: 1579045185, heatingVoltage: 12.24303854605409, inHumidity: 29.999999628152565, inTemp: 63.00000018592372, inTempBatteryStatus: 0, outHumidity: 79.99999972111442, outTemp: 32.67676549144743, outTempBatteryStatus: 0, pressure: 31.099999990703814, radiation: 330.1521682768618, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.0, rxCheckPercent: 27.233391149677, supplyVoltage: 11.707151993402364, txBatteryStatus: 0, usUnits: 1, UV: 4.622130355876065, windBatteryStatus: 0, windDir: 359.9999983266865, windGust: 5.577711537085861e-08, windGustDir: 359.9999983266865, windSpeed: 4.648092932768577e-08
Jan 14 15:39:45 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045183.000000 1579045185.000000
Jan 14 15:39:45 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:39:45 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:39:45 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:39:45 PST (1579045185) barometer: 31.099999990703814, consBatteryVoltage: 12.64341440210935, dateTime: 1579045185, heatingVoltage: 12.24303854605409, inHumidity: 29.999999628152565, inTemp: 63.00000018592372, inTempBatteryStatus: 0, outHumidity: 79.99999972111442, outTemp: 32.67676549144743, outTempBatteryStatus: 0, pressure: 31.099999990703814, radiation: 330.1521682768618, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.0, rxCheckPercent: 27.233391149677, supplyVoltage: 11.707151993402364, txBatteryStatus: 0, usUnits: 1, UV: 4.622130355876065, windBatteryStatus: 0, windDir: 359.9999983266865, windGust: 5.577711537085861e-08, windGustDir: 359.9999983266865, windSpeed: 4.648092932768577e-08
Jan 14 15:39:47 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:39:48 PST (1579045188) barometer: 31.099999974177262, consBatteryVoltage: 12.655127243101656, dateTime: 1579045188, heatingVoltage: 12.0, inHumidity: 29.99999896709047, inTemp: 63.00000051645476, inTempBatteryStatus: 0, outHumidity: 79.99999922531785, outTemp: 32.6749485852591, outTempBatteryStatus: 0, pressure: 31.099999974177262, radiation: 329.94699145637884, rain: 0, rainBatteryStatus: 0, referenceVoltage: 10.966136715781145, rxCheckPercent: 27.233391149677, supplyVoltage: 11.122319602805767, txBatteryStatus: 0, usUnits: 1, UV: 4.619257880389304, windBatteryStatus: 0, windDir: 359.99999535190705, windGust: 1.5493643079622643e-07, windGustDir: 359.99999535190705, windSpeed: 1.2911369218215896e-07
Jan 14 15:39:47 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045185.000000 1579045188.000000
Jan 14 15:39:47 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:39:47 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:39:47 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:39:48 PST (1579045188) barometer: 31.099999974177262, consBatteryVoltage: 12.655127243101656, dateTime: 1579045188, heatingVoltage: 12.0, inHumidity: 29.99999896709047, inTemp: 63.00000051645476, inTempBatteryStatus: 0, outHumidity: 79.99999922531785, outTemp: 32.6749485852591, outTempBatteryStatus: 0, pressure: 31.099999974177262, radiation: 329.94699145637884, rain: 0, rainBatteryStatus: 0, referenceVoltage: 10.966136715781145, rxCheckPercent: 27.233391149677, supplyVoltage: 11.122319602805767, txBatteryStatus: 0, usUnits: 1, UV: 4.619257880389304, windBatteryStatus: 0, windDir: 359.99999535190705, windGust: 1.5493643079622643e-07, windGustDir: 359.99999535190705, windSpeed: 1.2911369218215896e-07
Jan 14 15:39:48 TestPi weewx[5256] DEBUG user.MQTTSubscribe: MessageCallbackProvider For weather has QOS of 0 and retain of 0 received: b'TIME:0,tempSoil1:61.61'
Jan 14 15:39:48 TestPi weewx[5256] ERROR user.MQTTSubscribe: MessageCallbackProvider on_message_keyword failed with: must be str or None, not list
Jan 14 15:39:48 TestPi weewx[5256] ERROR user.MQTTSubscribe: **** MessageCallbackProvider Ignoring topic=weather and payload=b'TIME:0,tempSoil1:61.61'
Jan 14 15:39:49 TestPi weewx[5256] DEBUG user.MQTTSubscribe: MessageCallbackProvider For weather has QOS of 0 and retain of 0 received: b'TIME:0,soilTemp3:14.69,INHU:39.88'
Jan 14 15:39:49 TestPi weewx[5256] ERROR user.MQTTSubscribe: MessageCallbackProvider on_message_keyword failed with: must be str or None, not list
Jan 14 15:39:49 TestPi weewx[5256] ERROR user.MQTTSubscribe: **** MessageCallbackProvider Ignoring topic=weather and payload=b'TIME:0,soilTemp3:14.69,INHU:39.88'
Jan 14 15:39:50 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:39:50 PST (1579045190) barometer: 31.099999949387435, consBatteryVoltage: 12.730130894589271, dateTime: 1579045190, heatingVoltage: 12.672007652154061, inHumidity: 29.999997975497358, inTemp: 63.00000101225132, inTempBatteryStatus: 0, outHumidity: 79.99999848162298, outTemp: 32.673132251717504, outTempBatteryStatus: 0, pressure: 31.099999949387435, radiation: 329.810224893475, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.954526388075115, rxCheckPercent: 35.50272477814994, supplyVoltage: 12.322318814631855, txBatteryStatus: 0, usUnits: 1, UV: 4.61734314850865, windBatteryStatus: 0, windDir: 359.9999908897379, windGust: 3.0367540304609975e-07, windGustDir: 359.9999908897379, windSpeed: 2.5306283646386873e-07
Jan 14 15:39:50 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045188.000000 1579045190.000000
Jan 14 15:39:50 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:39:50 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:39:50 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:39:50 PST (1579045190) barometer: 31.099999949387435, consBatteryVoltage: 12.730130894589271, dateTime: 1579045190, heatingVoltage: 12.672007652154061, inHumidity: 29.999997975497358, inTemp: 63.00000101225132, inTempBatteryStatus: 0, outHumidity: 79.99999848162298, outTemp: 32.673132251717504, outTempBatteryStatus: 0, pressure: 31.099999949387435, radiation: 329.810224893475, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.954526388075115, rxCheckPercent: 35.50272477814994, supplyVoltage: 12.322318814631855, txBatteryStatus: 0, usUnits: 1, UV: 4.61734314850865, windBatteryStatus: 0, windDir: 359.9999908897379, windGust: 3.0367540304609975e-07, windGustDir: 359.9999908897379, windSpeed: 2.5306283646386873e-07
Jan 14 15:39:52 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:39:53 PST (1579045193) barometer: 31.09999991633433, consBatteryVoltage: 10.902202179908011, dateTime: 1579045193, heatingVoltage: 12.081796897981828, inHumidity: 29.99999665337326, inTemp: 63.00000167331337, inTempBatteryStatus: 0, outHumidity: 79.99999749002984, outTemp: 32.6713164908827, outTempBatteryStatus: 0, pressure: 31.09999991633433, radiation: 329.6051020541779, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.316956664777273, rxCheckPercent: 35.50272477814994, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.614471428758491, windBatteryStatus: 0, windDir: 359.99998494017905, windGust: 5.019940321204786e-07, windGustDir: 359.99998494017905, windSpeed: 4.1832835950827985e-07
Jan 14 15:39:52 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045190.000000 1579045193.000000
Jan 14 15:39:52 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:39:52 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:39:52 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:39:53 PST (1579045193) barometer: 31.09999991633433, consBatteryVoltage: 10.902202179908011, dateTime: 1579045193, heatingVoltage: 12.081796897981828, inHumidity: 29.99999665337326, inTemp: 63.00000167331337, inTempBatteryStatus: 0, outHumidity: 79.99999749002984, outTemp: 32.6713164908827, outTempBatteryStatus: 0, pressure: 31.09999991633433, radiation: 329.6051020541779, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.316956664777273, rxCheckPercent: 35.50272477814994, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.614471428758491, windBatteryStatus: 0, windDir: 359.99998494017905, windGust: 5.019940321204786e-07, windGustDir: 359.99998494017905, windSpeed: 4.1832835950827985e-07
Jan 14 15:39:55 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:39:55 PST (1579045195) barometer: 31.09999987501795, consBatteryVoltage: 12.406628189125396, dateTime: 1579045195, heatingVoltage: 11.772596201097292, inHumidity: 29.99999500071822, inTemp: 63.00000249964089, inTempBatteryStatus: 0, outHumidity: 79.99999625053843, outTemp: 32.669501302814695, outTempBatteryStatus: 0, pressure: 31.09999987501795, radiation: 329.4683715148936, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.0, rxCheckPercent: 27.256983154322405, supplyVoltage: 13.19659212066792, txBatteryStatus: 0, usUnits: 1, UV: 4.61255720120851, windBatteryStatus: 0, windDir: 359.9999775032306, windGust: 7.498923144666492e-07, windGustDir: 359.9999775032306, windSpeed: 6.249102622035707e-07
Jan 14 15:39:55 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045193.000000 1579045195.000000
Jan 14 15:39:55 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:39:55 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:39:55 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:39:55 PST (1579045195) barometer: 31.09999987501795, consBatteryVoltage: 12.406628189125396, dateTime: 1579045195, heatingVoltage: 11.772596201097292, inHumidity: 29.99999500071822, inTemp: 63.00000249964089, inTempBatteryStatus: 0, outHumidity: 79.99999625053843, outTemp: 32.669501302814695, outTempBatteryStatus: 0, pressure: 31.09999987501795, radiation: 329.4683715148936, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.0, rxCheckPercent: 27.256983154322405, supplyVoltage: 13.19659212066792, txBatteryStatus: 0, usUnits: 1, UV: 4.61255720120851, windBatteryStatus: 0, windDir: 359.9999775032306, windGust: 7.498923144666492e-07, windGustDir: 359.9999775032306, windSpeed: 6.249102622035707e-07
Jan 14 15:39:57 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:39:58 PST (1579045198) barometer: 31.099999825438292, consBatteryVoltage: 11.137360347150015, dateTime: 1579045198, heatingVoltage: 12.077388633404615, inHumidity: 29.999993017532287, inTemp: 63.000003491233855, inTempBatteryStatus: 0, outHumidity: 79.99999476314875, outTemp: 32.66768668757349, outTempBatteryStatus: 0, pressure: 31.099999825438292, radiation: 329.2633027652615, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.41992665408367, rxCheckPercent: 32.59791222609935, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.609686238713661, windBatteryStatus: 0, windDir: 359.99996857889255, windGust: 1.0473702483082548e-06, windGustDir: 359.99996857889255, windSpeed: 8.728085401088492e-07
Jan 14 15:39:57 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045195.000000 1579045198.000000
Jan 14 15:39:57 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:39:57 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:39:57 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:39:58 PST (1579045198) barometer: 31.099999825438292, consBatteryVoltage: 11.137360347150015, dateTime: 1579045198, heatingVoltage: 12.077388633404615, inHumidity: 29.999993017532287, inTemp: 63.000003491233855, inTempBatteryStatus: 0, outHumidity: 79.99999476314875, outTemp: 32.66768668757349, outTempBatteryStatus: 0, pressure: 31.099999825438292, radiation: 329.2633027652615, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.41992665408367, rxCheckPercent: 32.59791222609935, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.609686238713661, windBatteryStatus: 0, windDir: 359.99996857889255, windGust: 1.0473702483082548e-06, windGustDir: 359.99996857889255, windSpeed: 8.728085401088492e-07
Jan 14 15:39:59 TestPi weewx[5256] DEBUG user.MQTTSubscribe: MessageCallbackProvider For weather has QOS of 0 and retain of 0 received: b'TIME:0,soilTemp3:14.67,INHU:39.96'
Jan 14 15:39:59 TestPi weewx[5256] ERROR user.MQTTSubscribe: MessageCallbackProvider on_message_keyword failed with: must be str or None, not list
Jan 14 15:39:59 TestPi weewx[5256] ERROR user.MQTTSubscribe: **** MessageCallbackProvider Ignoring topic=weather and payload=b'TIME:0,soilTemp3:14.67,INHU:39.96'
Jan 14 15:40:00 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:00 PST (1579045200) barometer: 31.099999767595364, consBatteryVoltage: 11.78062448352706, dateTime: 1579045200, heatingVoltage: 12.529688665561181, inHumidity: 29.999990703815534, inTemp: 63.00000464809223, inTempBatteryStatus: 0, outHumidity: 79.99999302786084, outTemp: 32.66587264521907, outTempBatteryStatus: 0, pressure: 31.099999767595364, radiation: 329.1266083219062, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.58684442821385, rxCheckPercent: 32.59791222609935, supplyVoltage: 11.5771777581334, txBatteryStatus: 0, usUnits: 1, UV: 4.607772516506687, windBatteryStatus: 0, windDir: 359.999958167165, windGust: 1.3944278318689385e-06, windGustDir: 359.999958167165, windSpeed: 1.1620231932241154e-06
Jan 14 15:40:00 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045198.000000 1579045200.000000
Jan 14 15:40:00 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:00 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:00 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:00 PST (1579045200) barometer: 31.099999767595364, consBatteryVoltage: 11.78062448352706, dateTime: 1579045200, heatingVoltage: 12.529688665561181, inHumidity: 29.999990703815534, inTemp: 63.00000464809223, inTempBatteryStatus: 0, outHumidity: 79.99999302786084, outTemp: 32.66587264521907, outTempBatteryStatus: 0, pressure: 31.099999767595364, radiation: 329.1266083219062, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.58684442821385, rxCheckPercent: 32.59791222609935, supplyVoltage: 11.5771777581334, txBatteryStatus: 0, usUnits: 1, UV: 4.607772516506687, windBatteryStatus: 0, windDir: 359.999958167165, windGust: 1.3944278318689385e-06, windGustDir: 359.999958167165, windSpeed: 1.1620231932241154e-06
Jan 14 15:40:02 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:03 PST (1579045203) barometer: 31.099999701489157, consBatteryVoltage: 12.0, dateTime: 1579045203, heatingVoltage: 13.15672494008633, inHumidity: 29.999988059568032, inTemp: 63.00000597021598, inTempBatteryStatus: 0, outHumidity: 79.99999104467469, outTemp: 32.66405917581138, outTempBatteryStatus: 0, pressure: 31.099999701489157, radiation: 328.92159377038996, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.0, rxCheckPercent: 30.294379823543142, supplyVoltage: 11.64503676854075, txBatteryStatus: 0, usUnits: 1, UV: 4.60490231278546, windBatteryStatus: 0, windDir: 359.9999462680481, windGust: 1.791065062484165e-06, windGustDir: 359.9999462680481, windSpeed: 1.492554218884834e-06
Jan 14 15:40:02 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045200.000000 1579045203.000000
Jan 14 15:40:02 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:02 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:02 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:03 PST (1579045203) barometer: 31.099999701489157, consBatteryVoltage: 12.0, dateTime: 1579045203, heatingVoltage: 13.15672494008633, inHumidity: 29.999988059568032, inTemp: 63.00000597021598, inTempBatteryStatus: 0, outHumidity: 79.99999104467469, outTemp: 32.66405917581138, outTempBatteryStatus: 0, pressure: 31.099999701489157, radiation: 328.92159377038996, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.0, rxCheckPercent: 30.294379823543142, supplyVoltage: 11.64503676854075, txBatteryStatus: 0, usUnits: 1, UV: 4.60490231278546, windBatteryStatus: 0, windDir: 359.9999462680481, windGust: 1.791065062484165e-06, windGustDir: 359.9999462680481, windSpeed: 1.492554218884834e-06
Jan 14 15:40:05 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:05 PST (1579045205) barometer: 31.09999962711968, consBatteryVoltage: 12.0, dateTime: 1579045205, heatingVoltage: 11.147536077679872, inHumidity: 29.999985084789877, inTemp: 63.000007457605065, inTempBatteryStatus: 0, outHumidity: 79.99998881359032, outTemp: 32.66224627941037, outTempBatteryStatus: 0, pressure: 31.09999962711968, radiation: 328.78493549525496, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.0, rxCheckPercent: 21.007487309252255, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.60298909693357, windBatteryStatus: 0, windDir: 359.9999328815419, windGust: 2.2372819357130425e-06, windGustDir: 359.9999328815419, windSpeed: 1.8644016126501128e-06
Jan 14 15:40:05 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045203.000000 1579045205.000000
Jan 14 15:40:05 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:05 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:05 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:05 PST (1579045205) barometer: 31.09999962711968, consBatteryVoltage: 12.0, dateTime: 1579045205, heatingVoltage: 11.147536077679872, inHumidity: 29.999985084789877, inTemp: 63.000007457605065, inTempBatteryStatus: 0, outHumidity: 79.99998881359032, outTemp: 32.66224627941037, outTempBatteryStatus: 0, pressure: 31.09999962711968, radiation: 328.78493549525496, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.0, rxCheckPercent: 21.007487309252255, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.60298909693357, windBatteryStatus: 0, windDir: 359.9999328815419, windGust: 2.2372819357130425e-06, windGustDir: 359.9999328815419, windSpeed: 1.8644016126501128e-06
Jan 14 15:40:07 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:08 PST (1579045208) barometer: 31.099999544486927, consBatteryVoltage: 11.761770443743437, dateTime: 1579045208, heatingVoltage: 12.665556542129204, inHumidity: 29.999981779481157, inTemp: 63.00000911025942, inTempBatteryStatus: 0, outHumidity: 79.99998633460775, outTemp: 32.66043395607596, outTempBatteryStatus: 0, pressure: 31.099999544486927, radiation: 328.5799752502758, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.868525980519923, rxCheckPercent: 28.453844839567477, supplyVoltage: 12.167904491577605, txBatteryStatus: 0, usUnits: 1, UV: 4.600119653503862, windBatteryStatus: 0, windDir: 359.99991800764656, windGust: 2.7330784488910354e-06, windGustDir: 359.99991800764656, windSpeed: 2.2775653736317736e-06
Jan 14 15:40:07 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045205.000000 1579045208.000000
Jan 14 15:40:07 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:07 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:07 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:08 PST (1579045208) barometer: 31.099999544486927, consBatteryVoltage: 11.761770443743437, dateTime: 1579045208, heatingVoltage: 12.665556542129204, inHumidity: 29.999981779481157, inTemp: 63.00000911025942, inTempBatteryStatus: 0, outHumidity: 79.99998633460775, outTemp: 32.66043395607596, outTempBatteryStatus: 0, pressure: 31.099999544486927, radiation: 328.5799752502758, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.868525980519923, rxCheckPercent: 28.453844839567477, supplyVoltage: 12.167904491577605, txBatteryStatus: 0, usUnits: 1, UV: 4.600119653503862, windBatteryStatus: 0, windDir: 359.99991800764656, windGust: 2.7330784488910354e-06, windGustDir: 359.99991800764656, windSpeed: 2.2775653736317736e-06
Jan 14 15:40:09 TestPi weewx[5256] DEBUG user.MQTTSubscribe: MessageCallbackProvider For weather has QOS of 0 and retain of 0 received: b'TIME:0,soilTemp3:14.67,INHU:39.89'
Jan 14 15:40:09 TestPi weewx[5256] ERROR user.MQTTSubscribe: MessageCallbackProvider on_message_keyword failed with: must be str or None, not list
Jan 14 15:40:09 TestPi weewx[5256] ERROR user.MQTTSubscribe: **** MessageCallbackProvider Ignoring topic=weather and payload=b'TIME:0,soilTemp3:14.67,INHU:39.89'
Jan 14 15:40:10 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:10 PST (1579045210) barometer: 31.0999994535909, consBatteryVoltage: 12.507139839150403, dateTime: 1579045210, heatingVoltage: 12.0, inHumidity: 29.999978143641986, inTemp: 63.00001092817901, inTempBatteryStatus: 0, outHumidity: 79.99998360772702, outTemp: 32.658622205868056, outTempBatteryStatus: 0, pressure: 31.0999994535909, radiation: 328.443353215633, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.0, rxCheckPercent: 28.453844839567477, supplyVoltage: 12.075244085912379, txBatteryStatus: 0, usUnits: 1, UV: 4.5982069450188625, windBatteryStatus: 0, windDir: 359.9999016463621, windGust: 3.2784545975772517e-06, windGustDir: 359.9999016463621, windSpeed: 2.7320454982771025e-06
Jan 14 15:40:10 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045208.000000 1579045210.000000
Jan 14 15:40:10 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:10 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:10 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:10 PST (1579045210) barometer: 31.0999994535909, consBatteryVoltage: 12.507139839150403, dateTime: 1579045210, heatingVoltage: 12.0, inHumidity: 29.999978143641986, inTemp: 63.00001092817901, inTempBatteryStatus: 0, outHumidity: 79.99998360772702, outTemp: 32.658622205868056, outTempBatteryStatus: 0, pressure: 31.0999994535909, radiation: 328.443353215633, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.0, rxCheckPercent: 28.453844839567477, supplyVoltage: 12.075244085912379, txBatteryStatus: 0, usUnits: 1, UV: 4.5982069450188625, windBatteryStatus: 0, windDir: 359.9999016463621, windGust: 3.2784545975772517e-06, windGustDir: 359.9999016463621, windSpeed: 2.7320454982771025e-06
Jan 14 15:40:10 TestPi kernel: [ 7545.053790] w1_master_driver w1_bus_master1: Attaching one wire slave 00.890000000000 crc 10
Jan 14 15:40:10 TestPi kernel: [ 7545.072123] w1_master_driver w1_bus_master1: Family 0 for 00.890000000000.10 is not registered.
Jan 14 15:40:12 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:13 PST (1579045213) barometer: 31.099999354431606, consBatteryVoltage: 11.99501002548651, dateTime: 1579045213, heatingVoltage: 13.05914782831054, inHumidity: 29.999974177272485, inTemp: 63.000012911363754, inTempBatteryStatus: 0, outHumidity: 79.99998063294811, outTemp: 32.65681102884653, outTempBatteryStatus: 0, pressure: 31.099999354431606, radiation: 328.2384473855844, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.816105451806518, rxCheckPercent: 28.453844839567477, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.595338263398181, windBatteryStatus: 0, windDir: 359.99988379768865, windGust: 3.873410378218978e-06, windGustDir: 359.99988379768865, windSpeed: 3.227841981257029e-06
Jan 14 15:40:12 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045210.000000 1579045213.000000
Jan 14 15:40:12 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:12 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:12 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:13 PST (1579045213) barometer: 31.099999354431606, consBatteryVoltage: 11.99501002548651, dateTime: 1579045213, heatingVoltage: 13.05914782831054, inHumidity: 29.999974177272485, inTemp: 63.000012911363754, inTempBatteryStatus: 0, outHumidity: 79.99998063294811, outTemp: 32.65681102884653, outTempBatteryStatus: 0, pressure: 31.099999354431606, radiation: 328.2384473855844, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.816105451806518, rxCheckPercent: 28.453844839567477, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.595338263398181, windBatteryStatus: 0, windDir: 359.99988379768865, windGust: 3.873410378218978e-06, windGustDir: 359.99988379768865, windSpeed: 3.227841981257029e-06
Jan 14 15:40:14 TestPi weewx[5256] DEBUG user.MQTTSubscribe: MessageCallbackProvider For weather has QOS of 0 and retain of 0 received: b'TIME:0,tempSoil1:61.63'
Jan 14 15:40:14 TestPi weewx[5256] ERROR user.MQTTSubscribe: MessageCallbackProvider on_message_keyword failed with: must be str or None, not list
Jan 14 15:40:14 TestPi weewx[5256] ERROR user.MQTTSubscribe: **** MessageCallbackProvider Ignoring topic=weather and payload=b'TIME:0,tempSoil1:61.63'
Jan 14 15:40:15 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:15 PST (1579045215) barometer: 31.099999247009038, consBatteryVoltage: 12.0, dateTime: 1579045215, heatingVoltage: 11.136645236287233, inHumidity: 29.99996988037278, inTemp: 63.000015059813606, inTempBatteryStatus: 0, outHumidity: 79.99997741027109, outTemp: 32.655000425071265, outTempBatteryStatus: 0, pressure: 31.099999247009038, radiation: 328.10186166368595, rain: 0, rainBatteryStatus: 0, referenceVoltage: 10.840862837577852, rxCheckPercent: 29.44654145316917, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.593426063291603, windBatteryStatus: 0, windDir: 359.9998644616265, windGust: 4.517945783710786e-06, windGustDir: 359.9998644616265, windSpeed: 3.764954819907018e-06
Jan 14 15:40:15 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045213.000000 1579045215.000000
Jan 14 15:40:15 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:15 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:15 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:15 PST (1579045215) barometer: 31.099999247009038, consBatteryVoltage: 12.0, dateTime: 1579045215, heatingVoltage: 11.136645236287233, inHumidity: 29.99996988037278, inTemp: 63.000015059813606, inTempBatteryStatus: 0, outHumidity: 79.99997741027109, outTemp: 32.655000425071265, outTempBatteryStatus: 0, pressure: 31.099999247009038, radiation: 328.10186166368595, rain: 0, rainBatteryStatus: 0, referenceVoltage: 10.840862837577852, rxCheckPercent: 29.44654145316917, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.593426063291603, windBatteryStatus: 0, windDir: 359.9998644616265, windGust: 4.517945783710786e-06, windGustDir: 359.9998644616265, windSpeed: 3.764954819907018e-06
Jan 14 15:40:15 TestPi weewx[5256] INFO weewx.manager: Added record 2020-01-14 15:40:00 PST (1579045200) to database 'weewx.sdb'
Jan 14 15:40:15 TestPi weewx[5256] INFO weewx.manager: Added record 2020-01-14 15:40:00 PST (1579045200) to daily summary in 'weewx.sdb'
Jan 14 15:40:15 TestPi weewx[5256] DEBUG weewx.reportengine: reportengine: Running reports for latest time in the database.
Jan 14 15:40:15 TestPi weewx[5256] DEBUG weewx.reportengine: reportengine: Running report 'SeasonsReport'
Jan 14 15:40:15 TestPi weewx[5256] DEBUG weewx.reportengine: reportengine: Found configuration file /home/weewx/skins/Seasons/skin.conf for report 'SeasonsReport'
Jan 14 15:40:16 TestPi weewx[5256] DEBUG weewx.cheetahgenerator: Using search list ['weewx.cheetahgenerator.Almanac', 'weewx.cheetahgenerator.Station', 'weewx.cheetahgenerator.Current', 'weewx.cheetahgenerator.Stats', 'weewx.cheetahgenerator.UnitInfo', 'weewx.cheetahgenerator.Extras']
Jan 14 15:40:16 TestPi weewx[5256] DEBUG weewx.manager: Daily summary version is 2.0
Jan 14 15:40:17 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:18 PST (1579045218) barometer: 31.099999131323198, consBatteryVoltage: 11.39349223632838, dateTime: 1579045218, heatingVoltage: 12.0, inHumidity: 29.99996525294302, inTemp: 63.000017373528486, inTempBatteryStatus: 0, outHumidity: 79.99997393969595, outTemp: 32.65319039460209, outTempBatteryStatus: 0, pressure: 31.099999131323198, radiation: 327.8970103569324, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.770105125250666, rxCheckPercent: 28.554791345207565, supplyVoltage: 12.414224061877523, txBatteryStatus: 0, usUnits: 1, UV: 4.590558144997054, windBatteryStatus: 0, windDir: 359.99984363817566, windGust: 5.212060810499963e-06, windGustDir: 359.99984363817566, windSpeed: 4.343384008897999e-06
Jan 14 15:40:17 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045215.000000 1579045218.000000
Jan 14 15:40:17 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:17 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:17 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:18 PST (1579045218) barometer: 31.099999131323198, consBatteryVoltage: 11.39349223632838, dateTime: 1579045218, heatingVoltage: 12.0, inHumidity: 29.99996525294302, inTemp: 63.000017373528486, inTempBatteryStatus: 0, outHumidity: 79.99997393969595, outTemp: 32.65319039460209, outTempBatteryStatus: 0, pressure: 31.099999131323198, radiation: 327.8970103569324, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.770105125250666, rxCheckPercent: 28.554791345207565, supplyVoltage: 12.414224061877523, txBatteryStatus: 0, usUnits: 1, UV: 4.590558144997054, windBatteryStatus: 0, windDir: 359.99984363817566, windGust: 5.212060810499963e-06, windGustDir: 359.99984363817566, windSpeed: 4.343384008897999e-06
Jan 14 15:40:19 TestPi weewx[5256] DEBUG user.MQTTSubscribe: MessageCallbackProvider For weather has QOS of 0 and retain of 0 received: b'TIME:0,soilTemp3:14.65,INHU:39.88'
Jan 14 15:40:19 TestPi weewx[5256] ERROR user.MQTTSubscribe: MessageCallbackProvider on_message_keyword failed with: must be str or None, not list
Jan 14 15:40:19 TestPi weewx[5256] ERROR user.MQTTSubscribe: **** MessageCallbackProvider Ignoring topic=weather and payload=b'TIME:0,soilTemp3:14.65,INHU:39.88'
Jan 14 15:40:20 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:20 PST (1579045220) barometer: 31.09999900737409, consBatteryVoltage: 11.277342361860383, dateTime: 1579045220, heatingVoltage: 12.0, inHumidity: 29.99996029498336, inTemp: 63.00001985250832, inTempBatteryStatus: 0, outHumidity: 79.99997022122274, outTemp: 32.65138093749886, outTempBatteryStatus: 0, pressure: 31.09999900737409, radiation: 327.7604610200117, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.491062403251485, rxCheckPercent: 22.003554141072865, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.5886464542801635, windBatteryStatus: 0, windDir: 359.99982132733646, windGust: 5.95575545236926e-06, windGustDir: 359.99982132733646, windSpeed: 4.96312954378908e-06
Jan 14 15:40:20 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045218.000000 1579045220.000000
Jan 14 15:40:20 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:20 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:20 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:20 PST (1579045220) barometer: 31.09999900737409, consBatteryVoltage: 11.277342361860383, dateTime: 1579045220, heatingVoltage: 12.0, inHumidity: 29.99996029498336, inTemp: 63.00001985250832, inTempBatteryStatus: 0, outHumidity: 79.99997022122274, outTemp: 32.65138093749886, outTempBatteryStatus: 0, pressure: 31.09999900737409, radiation: 327.7604610200117, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.491062403251485, rxCheckPercent: 22.003554141072865, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.5886464542801635, windBatteryStatus: 0, windDir: 359.99982132733646, windGust: 5.95575545236926e-06, windGustDir: 359.99982132733646, windSpeed: 4.96312954378908e-06
Jan 14 15:40:21 TestPi weewx[5256] INFO weewx.cheetahgenerator: Generated 8 files for report SeasonsReport in 5.14 seconds
Jan 14 15:40:21 TestPi weewx[5256] DEBUG weewx.manager: Daily summary version is 2.0
Jan 14 15:40:22 TestPi weewx[5256] INFO weewx.imagegenerator: Generated 14 images for SeasonsReport in 1.13 seconds
Jan 14 15:40:22 TestPi weewx[5256] INFO weewx.reportengine: Copied 5 files to /home/weewx/public_html
Jan 14 15:40:22 TestPi weewx[5256] DEBUG weewx.reportengine: reportengine: Report 'SmartphoneReport' not enabled. Skipping.
Jan 14 15:40:22 TestPi weewx[5256] DEBUG weewx.reportengine: reportengine: Report 'MobileReport' not enabled. Skipping.
Jan 14 15:40:22 TestPi weewx[5256] DEBUG weewx.reportengine: reportengine: Report 'StandardReport' not enabled. Skipping.
Jan 14 15:40:22 TestPi weewx[5256] DEBUG weewx.reportengine: reportengine: Report 'FTP' not enabled. Skipping.
Jan 14 15:40:22 TestPi weewx[5256] DEBUG weewx.reportengine: reportengine: Report 'RSYNC' not enabled. Skipping.
Jan 14 15:40:22 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:23 PST (1579045223) barometer: 31.099998875161717, consBatteryVoltage: 12.62967806466167, dateTime: 1579045223, heatingVoltage: 11.900361307636372, inHumidity: 29.999955006493952, inTemp: 63.000022496753026, inTempBatteryStatus: 0, outHumidity: 79.99996625485149, outTemp: 32.64957205382135, outTempBatteryStatus: 0, pressure: 31.099998875161717, radiation: 327.55566434488856, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.580857662919252, rxCheckPercent: 23.034837190872, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.585779300828439, windBatteryStatus: 0, windDir: 359.99979752910895, windGust: 6.749029703101428e-06, windGustDir: 359.99979752910895, windSpeed: 5.62419141925119e-06
Jan 14 15:40:22 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045220.000000 1579045223.000000
Jan 14 15:40:22 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:22 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:22 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:23 PST (1579045223) barometer: 31.099998875161717, consBatteryVoltage: 12.62967806466167, dateTime: 1579045223, heatingVoltage: 11.900361307636372, inHumidity: 29.999955006493952, inTemp: 63.000022496753026, inTempBatteryStatus: 0, outHumidity: 79.99996625485149, outTemp: 32.64957205382135, outTempBatteryStatus: 0, pressure: 31.099998875161717, radiation: 327.55566434488856, rain: 0, rainBatteryStatus: 0, referenceVoltage: 11.580857662919252, rxCheckPercent: 23.034837190872, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.585779300828439, windBatteryStatus: 0, windDir: 359.99979752910895, windGust: 6.749029703101428e-06, windGustDir: 359.99979752910895, windSpeed: 5.62419141925119e-06
Jan 14 15:40:25 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:25 PST (1579045225) barometer: 31.099998734686075, consBatteryVoltage: 12.0, dateTime: 1579045225, heatingVoltage: 12.460133476002804, inHumidity: 29.99994938747498, inTemp: 63.00002530626251, inTempBatteryStatus: 0, outHumidity: 79.99996204058222, outTemp: 32.647763743629355, outTempBatteryStatus: 0, pressure: 31.099998734686075, radiation: 327.4191514651596, rain: 0, rainBatteryStatus: 0, referenceVoltage: 10.991311691761664, rxCheckPercent: 23.034837190872, supplyVoltage: 11.07579293094148, txBatteryStatus: 0, usUnits: 1, UV: 4.583868120512235, windBatteryStatus: 0, windDir: 359.99977224349334, windGust: 7.591883555591039e-06, windGustDir: 359.99977224349334, windSpeed: 6.326569629955259e-06
Jan 14 15:40:25 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045223.000000 1579045225.000000
Jan 14 15:40:25 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:25 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:25 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:25 PST (1579045225) barometer: 31.099998734686075, consBatteryVoltage: 12.0, dateTime: 1579045225, heatingVoltage: 12.460133476002804, inHumidity: 29.99994938747498, inTemp: 63.00002530626251, inTempBatteryStatus: 0, outHumidity: 79.99996204058222, outTemp: 32.647763743629355, outTempBatteryStatus: 0, pressure: 31.099998734686075, radiation: 327.4191514651596, rain: 0, rainBatteryStatus: 0, referenceVoltage: 10.991311691761664, rxCheckPercent: 23.034837190872, supplyVoltage: 11.07579293094148, txBatteryStatus: 0, usUnits: 1, UV: 4.583868120512235, windBatteryStatus: 0, windDir: 359.99977224349334, windGust: 7.591883555591039e-06, windGustDir: 359.99977224349334, windSpeed: 6.326569629955259e-06
Jan 14 15:40:27 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet prior to update is: 2020-01-14 15:40:28 PST (1579045228) barometer: 31.099998585947166, consBatteryVoltage: 12.731252026279002, dateTime: 1579045228, heatingVoltage: 11.540428975851661, inHumidity: 29.999943437926625, inTemp: 63.000028281036684, inTempBatteryStatus: 0, outHumidity: 79.99995757841498, outTemp: 32.64595600698267, outTempBatteryStatus: 0, pressure: 31.099998585947166, radiation: 327.21440952997364, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.884390115357537, rxCheckPercent: 23.034837190872, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.581001733419631, windBatteryStatus: 0, windDir: 359.99974547048987, windGust: 8.484317004509023e-06, windGustDir: 359.99974547048987, windSpeed: 7.070264170572216e-06
Jan 14 15:40:27 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service processing interval: 1579045225.000000 1579045228.000000
Jan 14 15:40:27 TestPi weewx[5256] DEBUG user.MQTTSubscribe: TopicManager starting queue weather size is: 0
Jan 14 15:40:27 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Dervice queue was empty
Jan 14 15:40:27 TestPi weewx[5256] DEBUG user.MQTTSubscribe: Service packet after update is: 2020-01-14 15:40:28 PST (1579045228) barometer: 31.099998585947166, consBatteryVoltage: 12.731252026279002, dateTime: 1579045228, heatingVoltage: 11.540428975851661, inHumidity: 29.999943437926625, inTemp: 63.000028281036684, inTempBatteryStatus: 0, outHumidity: 79.99995757841498, outTemp: 32.64595600698267, outTempBatteryStatus: 0, pressure: 31.099998585947166, radiation: 327.21440952997364, rain: 0, rainBatteryStatus: 0, referenceVoltage: 12.884390115357537, rxCheckPercent: 23.034837190872, supplyVoltage: 12.0, txBatteryStatus: 0, usUnits: 1, UV: 4.581001733419631, windBatteryStatus: 0, windDir: 359.99974547048987, windGust: 8.484317004509023e-06, windGustDir: 359.99974547048987, windSpeed: 7.070264170572216e-06
Jan 14 15:40:29 TestPi weewx[5256] DEBUG user.MQTTSubscribe: MessageCallbackProvider For weather has QOS of 0 and retain of 0 received: b'TIME:0,soilTemp3:14.67,INHU:39.87'

This is the MQTTSubscribe section of my weewx.conf file:

# Options for extension 'MQTTSubscribe'

[MQTTSubscribeService]
    # This section is for the MQTTSubscribe service.
    
    # Turn the service on and off.
    # Default is: true
    # Only used by the service.
    enable = true
    
    # The MQTT server.
    # Default is: localhost
    host = 192.168.7.37
    
    # The port to connect to.
    # Default is: 1883
    port = 1883
    
    # Maximum period in seconds allowed between communications with the broker.
    # Default is: 60
    keepalive = 60
    
    # The binding, loop or archive.
    # Default is: loop
    # Only used by the service.
    binding = loop


    
    # The message handler to use
    [[message_callback]]
        # The format of the MQTT payload.
        # Currently support: individual, json, keyword
        # Must be specified.
        type = keyword
        keyword_delimiter = ,
        keyword_separator = :
        
       [[[label_map]]]
            soilTemp3 = soilTemp3
            soilTemp2 = soilTemp2
            tempSoil1 = soilTemp1
          
    # The topics to subscribe to.
    [[topics]]
        # Units for MQTT payloads without unit value.
        # Valid values: US, METRIC, METRICWX
        # Default is: US
        unit_system = US
        
        [[[weather]]]
        #[[[SECOND/REPLACE_ME]]


Rich Bell

unread,
Jan 14, 2020, 7:37:56 PM1/14/20
to weewx-development
Ralph,
My first guess is that it doesn’t like the comma in the config for the delimiter. This is based on this line the log.
Jan 14 15:39:40 TestPi weewx[5256] INFO user.MQTTSubscribe: Message callback config is {'type': 'keyword', 'keyword_delimiter': [], 'keyword_separator': ':', 'label_map': {'soilTemp3': 'soilTemp3', 'soilTemp2': 'soilTemp2', 'tempSoil1': 'soilTemp1'}}
It is showing the delimiter as an empty list. I’d have to run a few tests to confirm and determine what is needed to change. Unfortunately a busy few days here. In the meantime you could try quoting it...
Rich

...

Rich Bell

unread,
Jan 14, 2020, 7:53:59 PM1/14/20
to weewx-development
Or since a comma is the default, comment it out for now.
Rich
...

Ralph Underwood

unread,
Jan 14, 2020, 8:11:33 PM1/14/20
to weewx-development
I put both the ' and : in quotes ( "," and ":")  and I am getting some data from MQTT! 

I have another Rpi running NodeRed to watch the mqtt data and it is showing a continuous stream of data from two of the sensors with an occasional message from the third. Something else to sort out.

My memory is getting bad - in the message below  I see the "b"  which I think indicates a unicode problem, which I solved in my standalone subscription program by adding 'decode' here and there a month ago a suggestion from Tom K.
DEBUG user.MQTTSubscribe: MessageCallbackProvider For weather has QOS of 0 and retain of 0 received: b'TIME:0,soilTemp3:14.68,INHU:40.00'

Thanks for the help!

Rich Bell

unread,
Jan 14, 2020, 8:30:11 PM1/14/20
to weewx-development
Great news!
Your memory is correct. But, in this case I am logging the exact payload - before I decode it when running under python 3.  
Since you are getting data, I will assume all is good until I hear otherwise.  And thank you for taking the leap and giving this a try.
Rich

Ralph Underwood

unread,
Jan 14, 2020, 8:33:45 PM1/14/20
to weewx-development
 I am now getting data from two of my MQTT sensors so I am not going to worry about the "b".

Thanks again.
Reply all
Reply to author
Forward
0 new messages