I’m testing with a very simple setup of just the weather binding grabbing temp data from WeatherUnderground every minute.
I’m persisting to both rrd4j and jdbc but nothing seem to ever get written to the database.
On startup, this is what I get in the log. You can see that the JDBC manages to connect to my database… If I delete the “Items” table from my database then it does recreate it. You can also see temperatures getting stored to the rrd4j persistence but nothing to JDBC
11:06:56.114 [DEBUG] [o.p.j.i.JdbcPersistenceService:89 ] - JDBC::setItemRegistry
11:06:56.116 [DEBUG] [o.p.j.i.JdbcPersistenceService:59 ] - JDBC::activate: persistence service activated
11:06:56.119 [DEBUG] [o.p.j.i.JdbcPersistenceService:215 ] - JDBC::updateConfig
11:06:56.126 [DEBUG] [p.j.internal.JdbcConfiguration:64 ] - JDBC::JdbcConfiguration
11:06:56.128 [DEBUG] [p.j.internal.JdbcConfiguration:72 ] - JDBC::updateConfig: configuration.size = 8
11:06:56.133 [DEBUG] [p.j.internal.JdbcConfiguration:77 ] - JDBC::updateConfig: url=jdbc:mariadb://192.168.1.199:3306/OpenHAB
11:06:56.135 [DEBUG] [p.j.internal.JdbcConfiguration:87 ] - JDBC::updateConfig: found serviceName = ‘mariadb’
11:06:56.138 [DEBUG] [p.j.internal.JdbcConfiguration:98 ] - JDBC::updateConfig: Init Data Access Object Class: ‘org.openhab.persistence.jdbc.db.JdbcMariadbDAO’
11:06:56.162 [DEBUG] [ersistence.jdbc.db.JdbcBaseDAO:109 ] - JDBC::initSqlTypes: Initialize the type array
11:06:56.164 [DEBUG] [ersistence.jdbc.db.JdbcBaseDAO:82 ] - JDBC::initSqlQueries: ‘JdbcMariadbDAO’
11:06:56.166 [DEBUG] [o.o.p.jdbc.db.JdbcMariadbDAO :45 ] - JDBC::initSqlTypes: Initialize the type array
11:06:56.169 [DEBUG] [o.o.p.jdbc.db.JdbcMariadbDAO :38 ] - JDBC::initSqlQueries: ‘JdbcMariadbDAO’
11:06:56.171 [DEBUG] [p.j.internal.JdbcConfiguration:105 ] - JDBC::updateConfig: dBDAO ClassName=org.openhab.persistence.jdbc.db.JdbcMariadbDAO
11:06:56.175 [DEBUG] [p.j.internal.JdbcConfiguration:144 ] - JDBC::updateConfig: user=root
11:06:56.178 [DEBUG] [p.j.internal.JdbcConfiguration:157 ] - JDBC::updateConfig: password= password.length=16
11:06:56.181 [DEBUG] [p.j.internal.JdbcConfiguration:182 ] - JDBC::updateConfig: tableUseRealItemNames=true
11:06:56.184 [DEBUG] [p.j.internal.JdbcConfiguration:216 ] - JDBC::updateConfig: enableLogTime false
11:06:56.186 [WARN ] [p.j.internal.JdbcConfiguration:237 ] - JDBC::updateConfig: try to load JDBC-driverClass: ‘org.mariadb.jdbc.Driver’
11:06:56.193 [DEBUG] [p.j.internal.JdbcConfiguration:240 ] - JDBC::updateConfig: load JDBC-driverClass was successful: ‘org.mariadb.jdbc.Driver’
11:06:56.196 [DEBUG] [p.j.internal.JdbcConfiguration:266 ] - JDBC::updateConfig: configuration complete. service=jdbc
11:06:56.198 [DEBUG] [o.o.p.jdbc.internal.JdbcMapper:41 ] - JDBC::pingDB
11:06:56.200 [DEBUG] [o.o.p.jdbc.internal.JdbcMapper:161 ] - JDBC::openConnection isDriverAvailable: true
11:06:56.202 [WARN ] [o.o.p.jdbc.internal.JdbcMapper:163 ] - JDBC::openConnection: setupDataSource.
11:06:56.225 [INFO ] [zaxxer.hikari.HikariDataSource:70 ] - HikariPool-0 - is starting.
11:06:59.070 [INFO ] [.o.b.w.i.s.WeatherJobScheduler:147 ] - Starting and scheduling weatherJob-home with interval of 1 minutes
11:06:59.091 [DEBUG] [o.o.b.w.i.scheduler.WeatherJob:43 ] - Starting Weather job for location ‘home’
11:06:59.731 [DEBUG] [.w.i.p.AbstractWeatherProvider:75 ] - WUNDERGROUND[home]: Weather[Temperature[current=12.2,min=,max=,feel=12.2,dewpoint=8.0],Atmosphere[humidity=78,visibility=10.0,pressure=1026.0,pressureTrend=equal,ozone=,uvIndex=1],Clouds[percent=],Condition[text=Overcast,lastUpdate=Sat Jun 18 11:06:59 NZST 2016,observationTime=Sat Jun 18 11:05:16 NZST 2016,id=,icon=cloudy,commonId=cloudy],Precipitation[rain=0.0,snow=0.0,probability=40,total=1.0],Wind[speed=1.8,direction=NNW,degree=339,gust=4.0,chill=],Station[name=Redoubt North School Manukau, Auckland, AUCKLAND,id=IAUCKLAN452,latitude=-36.985687,longitude=174.889755],]
11:06:59.733 [DEBUG] [.w.i.p.AbstractWeatherProvider:77 ] - WUNDERGROUND[home]: Forecast[day=0,Temperature[current=,min=11.0,max=16.0,feel=,dewpoint=],Atmosphere[humidity=72,visibility=,pressure=,pressureTrend=,ozone=,uvIndex=],Clouds[percent=],Condition[text=Mostly Cloudy,lastUpdate=Sat Jun 18 11:06:59 NZST 2016,observationTime=Sat Jun 18 19:00:00 NZST 2016,id=,icon=mostlycloudy,commonId=mostly-cloudy-day],Precipitation[rain=0.0,snow=0.0,probability=0,total=],Wind[speed=18.0,direction=SW,degree=227,gust=,chill=],Station[name=,id=,latitude=,longitude=],]
11:06:59.734 [DEBUG] [.w.i.p.AbstractWeatherProvider:77 ] - WUNDERGROUND[home]: Forecast[day=1,Temperature[current=,min=9.0,max=17.0,feel=,dewpoint=],Atmosphere[humidity=77,visibility=,pressure=,pressureTrend=,ozone=,uvIndex=],Clouds[percent=],Condition[text=Clear,lastUpdate=Sat Jun 18 11:06:59 NZST 2016,observationTime=Sun Jun 19 19:00:00 NZST 2016,id=,icon=clear,commonId=sunny],Precipitation[rain=0.0,snow=0.0,probability=0,total=],Wind[speed=21.0,direction=SW,degree=222,gust=,chill=],Station[name=,id=,latitude=,longitude=],]
11:06:59.736 [DEBUG] [.w.i.p.AbstractWeatherProvider:77 ] - WUNDERGROUND[home]: Forecast[day=2,Temperature[current=,min=12.0,max=17.0,feel=,dewpoint=],Atmosphere[humidity=86,visibility=,pressure=,pressureTrend=,ozone=,uvIndex=],Clouds[percent=],Condition[text=Partly Cloudy,lastUpdate=Sat Jun 18 11:06:59 NZST 2016,observationTime=Mon Jun 20 19:00:00 NZST 2016,id=,icon=partlycloudy,commonId=partly-cloudy-day],Precipitation[rain=0.0,snow=0.0,probability=0,total=],Wind[speed=11.0,direction=NE,degree=36,gust=,chill=],Station[name=,id=,latitude=,longitude=],]
11:06:59.737 [DEBUG] [.w.i.p.AbstractWeatherProvider:77 ] - WUNDERGROUND[home]: Forecast[day=3,Temperature[current=,min=15.0,max=17.0,feel=,dewpoint=],Atmosphere[humidity=82,visibility=,pressure=,pressureTrend=,ozone=,uvIndex=],Clouds[percent=],Condition[text=Overcast,lastUpdate=Sat Jun 18 11:06:59 NZST 2016,observationTime=Tue Jun 21 19:00:00 NZST 2016,id=,icon=cloudy,commonId=cloudy],Precipitation[rain=8.0,snow=0.0,probability=10,total=],Wind[speed=27.0,direction=NNE,degree=27,gust=,chill=],Station[name=,id=,latitude=,longitude=],]
11:06:59.738 [DEBUG] [.w.i.p.AbstractWeatherProvider:77 ] - WUNDERGROUND[home]: Forecast[day=4,Temperature[current=,min=13.0,max=18.0,feel=,dewpoint=],Atmosphere[humidity=94,visibility=,pressure=,pressureTrend=,ozone=,uvIndex=],Clouds[percent=],Condition[text=Rain,lastUpdate=Sat Jun 18 11:06:59 NZST 2016,observationTime=Wed Jun 22 19:00:00 NZST 2016,id=,icon=rain,commonId=rain],Precipitation[rain=39.0,snow=0.0,probability=90,total=],Wind[speed=29.0,direction=N,degree=2,gust=,chill=],Station[name=,id=,latitude=,longitude=],]
11:06:59.739 [DEBUG] [.w.i.p.AbstractWeatherProvider:77 ] - WUNDERGROUND[home]: Forecast[day=5,Temperature[current=,min=11.0,max=17.0,feel=,dewpoint=],Atmosphere[humidity=90,visibility=,pressure=,pressureTrend=,ozone=,uvIndex=],Clouds[percent=],Condition[text=Rain,lastUpdate=Sat Jun 18 11:06:59 NZST 2016,observationTime=Thu Jun 23 19:00:00 NZST 2016,id=,icon=rain,commonId=rain],Precipitation[rain=7.0,snow=0.0,probability=90,total=],Wind[speed=14.0,direction=NW,degree=309,gust=,chill=],Station[name=,id=,latitude=,longitude=],]
11:06:59.741 [DEBUG] [.w.i.p.AbstractWeatherProvider:77 ] - WUNDERGROUND[home]: Forecast[day=6,Temperature[current=,min=11.0,max=17.0,feel=,dewpoint=],Atmosphere[humidity=87,visibility=,pressure=,pressureTrend=,ozone=,uvIndex=],Clouds[percent=],Condition[text=Partly Cloudy,lastUpdate=Sat Jun 18 11:06:59 NZST 2016,observationTime=Fri Jun 24 19:00:00 NZST 2016,id=,icon=partlycloudy,commonId=partly-cloudy-day],Precipitation[rain=0.0,snow=0.0,probability=20,total=],Wind[speed=11.0,direction=WNW,degree=291,gust=,chill=],Station[name=,id=,latitude=,longitude=],]
11:06:59.743 [DEBUG] [.w.i.p.AbstractWeatherProvider:77 ] - WUNDERGROUND[home]: Forecast[day=7,Temperature[current=,min=12.0,max=18.0,feel=,dewpoint=],Atmosphere[humidity=86,visibility=,pressure=,pressureTrend=,ozone=,uvIndex=],Clouds[percent=],Condition[text=Chance of Rain,lastUpdate=Sat Jun 18 11:06:59 NZST 2016,observationTime=Sat Jun 25 19:00:00 NZST 2016,id=,icon=chancerain,commonId=few-showers],Precipitation[rain=8.0,snow=0.0,probability=40,total=],Wind[speed=32.0,direction=N,degree=11,gust=,chill=],Station[name=,id=,latitude=,longitude=],]
11:06:59.744 [DEBUG] [.w.i.p.AbstractWeatherProvider:77 ] - WUNDERGROUND[home]: Forecast[day=8,Temperature[current=,min=11.0,max=17.0,feel=,dewpoint=],Atmosphere[humidity=80,visibility=,pressure=,pressureTrend=,ozone=,uvIndex=],Clouds[percent=],Condition[text=Chance of Rain,lastUpdate=Sat Jun 18 11:06:59 NZST 2016,observationTime=Sun Jun 26 19:00:00 NZST 2016,id=,icon=chancerain,commonId=few-showers],Precipitation[rain=8.0,snow=0.0,probability=60,total=],Wind[speed=29.0,direction=NW,degree=314,gust=,chill=],Station[name=,id=,latitude=,longitude=],]
11:06:59.745 [DEBUG] [.w.i.p.AbstractWeatherProvider:77 ] - WUNDERGROUND[home]: Forecast[day=9,Temperature[current=,min=10.0,max=15.0,feel=,dewpoint=],Atmosphere[humidity=80,visibility=,pressure=,pressureTrend=,ozone=,uvIndex=],Clouds[percent=],Condition[text=Chance of Rain,lastUpdate=Sat Jun 18 11:06:59 NZST 2016,observationTime=Mon Jun 27 19:00:00 NZST 2016,id=,icon=chancerain,commonId=few-showers],Precipitation[rain=2.0,snow=0.0,probability=40,total=],Wind[speed=31.0,direction=WNW,degree=283,gust=,chill=],Station[name=,id=,latitude=,longitude=],]
11:07:26.256 [INFO ] [.zaxxer.hikari.pool.HikariPool:214 ] - HikariPool-0 - is closing down.
11:07:31.268 [DEBUG] [o.p.j.i.JdbcPersistenceService:94 ] - JDBC::unsetItemRegistry
11:07:31.292 [DEBUG] [.p.rrd4j.internal.RRD4jService:132 ] - Stored ‘WTH_Temperature’ with state ‘12.20’ in rrd4j database
11:07:31.305 [DEBUG] [.p.rrd4j.internal.RRD4jService:132 ] - Stored ‘WTH_Temp_Feel’ with state ‘12.20’ in rrd4j database