Adapter SQL - Einstellungen

[Issi]

@paul53 sagte in Adapter SQL - Einstellungen:

@Issi Dann verhält sich der SQL-Adapter anders als der History-Adapter (siehe hier).

tatsächlich der History-Adapter zeichnet nix auf wen ich ihn mit den selben einstelungen wie den sql adapter laufen lasse

18 	true 		2019-05-29 15:43:10.002 	
null 	true 		2019-05-29 15:43:08.873

und beim sql hab ich grade noch ein wenig rumgespielt er logt z.B. wen ich 20sec Entprellzeit einstele alle 20sec auf usw. da kan doch was nicht stimmen
das sind die einstelungen in sql

[apollon77]

History, influxdb und sql verhalten sich hier alle gleich. Die Entprellzeit bedeutet das, wie oben schon korrekt dargestellt, die Werte nicht aufgezeichnet werden wenn sichdie Werte öfter ändern.
Falls das bei sql anders wäre, wäre das ein Bug, kann ich mir aber nicht vorstellen.
Hier würde eine Debug Log helfen, weil da sehr genau drin steht warum Dinge geloggt oder nicht geloggt werden.

[Issi]

@apollon77 sagte in Adapter SQL - Einstellungen:

History, influxdb und sql verhalten sich hier alle gleich. Die Entprellzeit bedeutet das, wie oben schon korrekt dargestellt, die Werte nicht aufgezeichnet werden wenn sichdie Werte öfter ändern.
Falls das bei sql anders wäre, wäre das ein Bug, kann ich mir aber nicht vorstellen.
Hier würde eine Debug Log helfen, weil da sehr genau drin steht warum Dinge geloggt oder nicht geloggt werden.

hab hir mal ein teil des log aus dem log ordner da es sehr viel im debug ist

2019-05-30 00:34:08.809  - debug: sql.0 init timed Relog: getState Temperaturen.0.Bad:  Value=20.35, ack=true, ts=1559162891759, lc=1559162891759
2019-05-30 00:34:08.809  - debug: sql.0 new value received for Temperaturen.0.Bad, new-value=20.35, ts=1559162891759, relog=true
2019-05-30 00:34:08.809  - debug: sql.0 timed-relog Temperaturen.0.Bad, value=20.35, lastLogTime=1559169188807, ts=1559169248809
2019-05-30 00:34:08.809  - debug: sql.0 Datatype Temperaturen.0.Bad: Currently: number, StorageType: Number
2019-05-30 00:34:08.809  - debug: sql.0 INSERT INTO `IoBroker`.ts_number (id, ts, val, ack, _from, q) VALUES(11, 1559169248809, 20.35, 1, 2, 0);
2019-05-30 00:34:10.003  - debug: sql.0 new value received for Test, new-value=193, ts=1559169250001, relog=false
2019-05-30 00:34:10.005  - debug: sql.0 Datatype Test: Currently: number, StorageType: false
2019-05-30 00:34:10.005  - debug: sql.0 INSERT INTO `IoBroker`.ts_number (id, ts, val, ack, _from, q) VALUES(94, 1559169250001, 193, 1, 2, 0);
2019-05-30 00:34:10.700  - debug: sql.0 new value received for cpu.temperature, new-value=52, ts=1559169250697, relog=false
2019-05-30 00:34:10.700  - debug: sql.0 value not changed relogcpu.temperature, last-value=52, new-value=52, ts=1559169250697
2019-05-30 00:34:11.018  - debug: sql.0 new value received for Ventilstelung.Kinderzimmer, new-value=0, ts=1559169196920, relog=true
2019-05-30 00:34:11.019  - debug: sql.0 timed-relog Ventilstelung.Kinderzimmer, value=0, lastLogTime=1559169191018, ts=1559169251019
2019-05-30 00:34:11.019  - debug: sql.0 Datatype Ventilstelung.Kinderzimmer: Currently: number, StorageType: Number
2019-05-30 00:34:11.019  - debug: sql.0 INSERT INTO `IoBroker`.ts_number (id, ts, val, ack, _from, q) VALUES(39, 1559169251019, 0, 1, 8, 0);

das ist der state der aufgezeichnet wird hab ein script das alle 10sec den wert um 1 erhöt und die Entprellzeit in sql hab ich auf 20000ms er dürfte dann ja nichts aufzeichnen

2019-05-30 00:34:10.003  - debug: sql.0 new value received for Test, new-value=193, ts=1559169250001, relog=false
2019-05-30 00:34:10.005  - debug: sql.0 Datatype Test: Currently: number, StorageType: false
2019-05-30 00:34:10.005  - debug: sql.0 INSERT INTO `IoBroker`.ts_number (id, ts, val, ack, _from, q) VALUES(94, 1559169250001, 193, 1, 2, 0);

2019-05-30 00:34:20.010  - debug: sql.0 new value received for Test, new-value=194, ts=1559169260006, relog=false

2019-05-30 00:34:40.007  - debug: sql.0 new value received for Test, new-value=196, ts=1559169280004, relog=false
2019-05-30 00:34:40.010  - debug: sql.0 Datatype Test: Currently: number, StorageType: false
2019-05-30 00:34:40.011  - debug: sql.0 INSERT INTO `IoBroker`.ts_number (id, ts, val, ack, _from, q) VALUES(94, 1559169280004, 196, 1, 2, 0);

[apollon77]

Das log sieht so aus als ob da keine Debounce-Zeit gesetzt ist. Starte bitte mal den Adapter neu. Im Code sieht generell alles ok aus. Sonst muss ich da mal ganz tief reinschauen. Ggf bitte mal ein GitHub Issue anlegen.

[Issi]

@apollon77 sagte in Adapter SQL - Einstellungen:

Das log sieht so aus als ob da keine Debounce-Zeit gesetzt ist. Starte bitte mal den Adapter neu. Im Code sieht generell alles ok aus. Sonst muss ich da mal ganz tief reinschauen. Ggf bitte mal ein GitHub Issue anlegen.

nach dem neustart läuft es wie es soll hab dan nur die Storage Vorhaltezeit von 2 Jaren auf 1 Jahr geändert und er fängt dan die werte aufzeichnen
hab ein test system eingerichtet und mal das ganze log vom start und die änderung der Storage Vorhaltezeit und bis er anfängt die werte aufzeichnen geholt.

2019-05-29 23:25:30.241  - info: sql.0 Connected to mysql
2019-05-29 23:25:30.242  - debug: sql.0 SELECT id, type, name FROM `IoBroker`.datapoints;
2019-05-29 23:25:30.256  - debug: sql.0 SELECT id, name FROM `IoBroker`.sources;
2019-05-29 23:25:30.267  - debug: sql.0 Found Alias: Mein_TV.0.Vis_Zahl --> Test
2019-05-29 23:25:30.268  - info: sql.0 enabled logging of Test, Alias=true, 1 points now activated
2019-05-29 23:25:30.275  - debug: sql.0 Initialization done
2019-05-29 23:25:34.488  - debug: sql.0 objectDB connected
2019-05-29 23:25:34.521  - debug: sql.0 statesDB connected
2019-05-29 23:25:34.636  - info: sql.0 starting. Version 1.9.5 in /opt/iobroker/node_modules/iobroker.sql, node: v8.15.1
2019-05-29 23:25:34.745  - debug: sql.0 CREATE DATABASE `IoBroker` DEFAULT CHARACTER SET utf8 DEFAULT COLLATE utf8_general_ci;
2019-05-29 23:25:34.751  - debug: sql.0 Response: {"code":"ER_DB_CREATE_EXISTS","errno":1007,"sqlMessage":"Can't create database 'IoBroker'; database exists","sqlState":"HY000","index":0,"sql":"CREATE DATABASE `IoBroker` DEFAULT CHARACTER SET utf8 DEFAULT COLLATE utf8_general_ci;"}
2019-05-29 23:25:34.760  - debug: sql.0 CREATE TABLE `IoBroker`.sources    (id INTEGER NOT NULL PRIMARY KEY AUTO_INCREMENT, name TEXT);
2019-05-29 23:25:34.763  - debug: sql.0 Response: {"code":"ER_TABLE_EXISTS_ERROR","errno":1050,"sqlMessage":"Table 'sources' already exists","sqlState":"42S01","index":0,"sql":"CREATE TABLE `IoBroker`.sources    (id INTEGER NOT NULL PRIMARY KEY AUTO_INCREMENT, name TEXT);"}
2019-05-29 23:25:34.766  - debug: sql.0 CREATE TABLE `IoBroker`.datapoints (id INTEGER NOT NULL PRIMARY KEY AUTO_INCREMENT, name TEXT, type INTEGER);
2019-05-29 23:25:34.768  - debug: sql.0 Response: {"code":"ER_TABLE_EXISTS_ERROR","errno":1050,"sqlMessage":"Table 'datapoints' already exists","sqlState":"42S01","index":0,"sql":"CREATE TABLE `IoBroker`.datapoints (id INTEGER NOT NULL PRIMARY KEY AUTO_INCREMENT, name TEXT, type INTEGER);"}
2019-05-29 23:25:34.772  - debug: sql.0 CREATE TABLE `IoBroker`.ts_number  (id INTEGER, ts BIGINT, val REAL,    ack BOOLEAN, _from INTEGER, q INTEGER, PRIMARY KEY(id, ts));
2019-05-29 23:25:34.773  - debug: sql.0 Response: {"code":"ER_TABLE_EXISTS_ERROR","errno":1050,"sqlMessage":"Table 'ts_number' already exists","sqlState":"42S01","index":0,"sql":"CREATE TABLE `IoBroker`.ts_number  (id INTEGER, ts BIGINT, val REAL,    ack BOOLEAN, _from INTEGER, q INTEGER, PRIMARY KEY(id, ts));"}
2019-05-29 23:25:34.777  - debug: sql.0 CREATE TABLE `IoBroker`.ts_string  (id INTEGER, ts BIGINT, val TEXT,    ack BOOLEAN, _from INTEGER, q INTEGER, PRIMARY KEY(id, ts));
2019-05-29 23:25:34.778  - debug: sql.0 Response: {"code":"ER_TABLE_EXISTS_ERROR","errno":1050,"sqlMessage":"Table 'ts_string' already exists","sqlState":"42S01","index":0,"sql":"CREATE TABLE `IoBroker`.ts_string  (id INTEGER, ts BIGINT, val TEXT,    ack BOOLEAN, _from INTEGER, q INTEGER, PRIMARY KEY(id, ts));"}
2019-05-29 23:25:34.782  - debug: sql.0 CREATE TABLE `IoBroker`.ts_bool    (id INTEGER, ts BIGINT, val BOOLEAN, ack BOOLEAN, _from INTEGER, q INTEGER, PRIMARY KEY(id, ts));
2019-05-29 23:25:34.784  - debug: sql.0 Response: {"code":"ER_TABLE_EXISTS_ERROR","errno":1050,"sqlMessage":"Table 'ts_bool' already exists","sqlState":"42S01","index":0,"sql":"CREATE TABLE `IoBroker`.ts_bool    (id INTEGER, ts BIGINT, val BOOLEAN, ack BOOLEAN, _from INTEGER, q INTEGER, PRIMARY KEY(id, ts));"}
2019-05-29 23:25:34.784  - info: sql.0 Connected to mysql
2019-05-29 23:25:34.785  - debug: sql.0 SELECT id, type, name FROM `IoBroker`.datapoints;
2019-05-29 23:25:34.797  - debug: sql.0 SELECT id, name FROM `IoBroker`.sources;
2019-05-29 23:25:34.808  - debug: sql.0 Found Alias: Mein_TV.0.Vis_Zahl --> Test
2019-05-29 23:25:34.808  - info: sql.0 enabled logging of Test, Alias=true, 1 points now activated
2019-05-29 23:25:34.816  - debug: sql.0 Initialization done
2019-05-29 23:25:35.029  - debug: sql.0 For getHistory for id Test: Type empty, use dbtype 0
2019-05-29 23:25:35.030  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172342751 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:25:35.031  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172342751 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:25:35.044  - debug: sql.0 Send: 50 of: 50 in: 16ms
2019-05-29 23:25:35.045  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:25:40.007  - debug: sql.0 new value received for Test, new-value=87, ts=1559172340005, relog=false
2019-05-29 23:25:46.593  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172354328 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:25:46.593  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172354328 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:25:46.601  - debug: sql.0 Send: 50 of: 50 in: 8ms
2019-05-29 23:25:46.601  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:25:50.003  - debug: sql.0 new value received for Test, new-value=88, ts=1559172350002, relog=false
2019-05-29 23:25:55.615  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172363343 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:25:55.615  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172363343 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:25:55.629  - debug: sql.0 Send: 50 of: 50 in: 14ms
2019-05-29 23:25:55.629  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:25:56.409  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172364145 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:25:56.409  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172364145 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:25:56.418  - debug: sql.0 Send: 50 of: 50 in: 9ms
2019-05-29 23:25:56.418  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:26:00.004  - debug: sql.0 new value received for Test, new-value=89, ts=1559172360002, relog=false
2019-05-29 23:26:04.687  - debug: sql.0 Registered Alias: Mein_TV.0.Vis_Zahl --> Test
2019-05-29 23:26:04.687  - debug: sql.0 remembered Index/Type 94 / 0
2019-05-29 23:26:04.688  - info: sql.0 enabled logging of Test, Alias=true
2019-05-29 23:26:05.015  - debug: sql.0 For getHistory for id Test: Type empty, use dbtype 0
2019-05-29 23:26:05.015  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172372751 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:05.015  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172372751 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:05.024  - debug: sql.0 Send: 50 of: 50 in: 9ms
2019-05-29 23:26:05.024  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:26:08.492  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172376229 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:08.493  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172376229 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:08.501  - debug: sql.0 Send: 50 of: 50 in: 9ms
2019-05-29 23:26:08.501  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:26:10.005  - debug: sql.0 new value received for Test, new-value=90, ts=1559172370003, relog=false
2019-05-29 23:26:15.017  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172382753 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:15.017  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172382753 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:15.026  - debug: sql.0 Send: 50 of: 50 in: 9ms
2019-05-29 23:26:15.027  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:26:20.005  - debug: sql.0 new value received for Test, new-value=91, ts=1559172380003, relog=false
2019-05-29 23:26:20.006  - debug: sql.0 Datatype Test: Currently: number, StorageType: false
2019-05-29 23:26:20.008  - debug: sql.0 INSERT INTO `IoBroker`.ts_number (id, ts, val, ack, _from, q) VALUES(94, 1559172380003, 91, 1, 2, 0);
2019-05-29 23:26:20.016  - debug: sql.0 DELETE FROM `IoBroker`.ts_number WHERE id=94 AND ts < 1527636360016;
2019-05-29 23:26:25.025  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172392761 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:25.025  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172392761 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:25.034  - debug: sql.0 Send: 50 of: 50 in: 10ms
2019-05-29 23:26:25.034  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:26:30.004  - debug: sql.0 new value received for Test, new-value=92, ts=1559172390002, relog=false
2019-05-29 23:26:36.608  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172404344 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:36.609  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172404344 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:36.618  - debug: sql.0 Send: 50 of: 50 in: 10ms
2019-05-29 23:26:36.618  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:26:40.005  - debug: sql.0 new value received for Test, new-value=93, ts=1559172400002, relog=false
2019-05-29 23:26:40.005  - debug: sql.0 Datatype Test: Currently: number, StorageType: false
2019-05-29 23:26:40.006  - debug: sql.0 INSERT INTO `IoBroker`.ts_number (id, ts, val, ack, _from, q) VALUES(94, 1559172400002, 93, 1, 2, 0);
2019-05-29 23:26:46.017  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172413753 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:46.017  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172413753 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:46.027  - debug: sql.0 Send: 50 of: 50 in: 10ms
2019-05-29 23:26:46.027  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:26:48.173  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172415910 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:48.173  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172415910 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:48.179  - debug: sql.0 Send: 50 of: 50 in: 6ms
2019-05-29 23:26:48.179  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:26:50.004  - debug: sql.0 new value received for Test, new-value=94, ts=1559172410002, relog=false
2019-05-29 23:26:55.013  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172422750 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:55.014  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172422750 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:26:55.020  - debug: sql.0 Send: 50 of: 50 in: 7ms
2019-05-29 23:26:55.020  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:27:00.006  - debug: sql.0 new value received for Test, new-value=95, ts=1559172420002, relog=false
2019-05-29 23:27:00.006  - debug: sql.0 Datatype Test: Currently: number, StorageType: false
2019-05-29 23:27:00.006  - debug: sql.0 INSERT INTO `IoBroker`.ts_number (id, ts, val, ack, _from, q) VALUES(94, 1559172420002, 95, 1, 2, 0);
2019-05-29 23:27:05.013  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172432750 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:27:05.014  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172432750 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:27:05.020  - debug: sql.0 Send: 50 of: 50 in: 7ms
2019-05-29 23:27:05.020  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:27:10.004  - debug: sql.0 new value received for Test, new-value=96, ts=1559172430002, relog=false
2019-05-29 23:27:15.018  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172442755 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:27:15.019  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172442755 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:27:15.026  - debug: sql.0 Send: 50 of: 50 in: 8ms
2019-05-29 23:27:15.026  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:27:20.006  - debug: sql.0 Datatype Test: Currently: number, StorageType: false
2019-05-29 23:27:20.007  - debug: sql.0 INSERT INTO `IoBroker`.ts_number (id, ts, val, ack, _from, q) VALUES(94, 1559172430002, 96, 1, 2, 0);
2019-05-29 23:27:20.011  - debug: sql.0 new value received for Test, new-value=97, ts=1559172440010, relog=false
2019-05-29 23:27:25.036  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172452772 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:27:25.036  - debug: sql.0 SELECT ts, val, ack, `IoBroker`.sources.name as 'from', q FROM `IoBroker`.ts_number INNER JOIN `IoBroker`.sources ON `IoBroker`.sources.id=`IoBroker`.ts_number._from WHERE  `IoBroker`.ts_number.id=94 AND `IoBroker`.ts_number.ts < 1559172452772 ORDER BY ts DESC LIMIT 50;
2019-05-29 23:27:25.043  - debug: sql.0 Send: 50 of: 50 in: 7ms
2019-05-29 23:27:25.043  - debug: sql.0 sendTo "getHistory" to system.adapter.admin.0 from system.adapter.sql.0
2019-05-29 23:27:30.004  - debug: sql.0 new value received for Test, new-value=98, ts=1559172450002, relog=false
2019-05-29 23:27:30.005  - debug: sql.0 Datatype Test: Currently: number, StorageType: false
2019-05-29 23:27:30.005  - debug: sql.0 INSERT INTO `IoBroker`.ts_number (id, ts, val, ack, _from, q) VALUES(94, 1559172450002, 98, 1, 2, 0);

edit: hatte das falsche log drin jetzt ist das richtige drin

[apollon77]

Interessant, dann scheint es wohl ein Bug zu sein wenn sich die Einstellungen eines OBjects während der laufzeit ändern. Dann weiss ich aber wo ich exakt schauen kann. Machst Du mir bitte dazu und vllt mit Link hierher ein GitHub Issue bitte auf? Danke

[Issi]

@apollon77 sagte in Adapter SQL - Einstellungen:

Interessant, dann scheint es wohl ein Bug zu sein wenn sich die Einstellungen eines OBjects während der laufzeit ändern. Dann weiss ich aber wo ich exakt schauen kann. Machst Du mir bitte dazu und vllt mit Link hierher ein GitHub Issue bitte auf? Danke

Issue ist erstellt
Issue

[apollon77]

Danke. Kannst du das bitte mal bei History checken ob es da auch do ist? Danke

[Issi]

@apollon77 sagte in Adapter SQL - Einstellungen:

Danke. Kannst du das bitte mal bei History checken ob es da auch do ist? Danke

beim History-Adapter ist es anscheint nicht der fall hab mehrmal einstellungen geändert und er logt nichts so wie es sein soll.

[apollon77]

Was meinst Du genau damit?

[Issi]

@apollon77 sagte in Adapter SQL - Einstellungen:

Was meinst Du genau damit?

wenn du damit mich meinst hab die selben einstelungen bei History-Adapter probirt und dan Storage Vorhaltezeit gewechselt während der laufzeit und er hat nicht angefangen zu logen so wie der SQL adapter

[paul53]

@apollon77 sagte am 13.4.2017:

Wenn innerhalb der Entprellzeit ein neuer Wert kommt, gilt der letzte Wert als "Nicht stabil" und die Entprellzeit wird für den neuen Wert neugestartet.

Der Neustart bei jeder Änderung erfolgt im History-Adapter, nicht aber im SQL-Adapter. Im SQL-Adapter läuft der Timer / Zähler weiter und gibt nach Zeitablauf wieder frei.

[apollon77]

ok. AUch eine wichtige Info. Also es geht alles korrekt bei history, aber sql nicht

[paul53]

@apollon77 Schau Dir mal die Änderung vom 10.Oktober 2018 an:

        if (timeoutTriggered) sqlDPs[_id].timeout = null;

[apollon77]

Das ist egal. wenn ein Timeout gesetzt ist dann läuft der auch wenn man da "null" setzt. Da geht es nur um korrekte Werte.

Meine Vermutung geht eher dahin das bei einem Object change die Werte ncht sauber korrekt eu initsialisiert werden und damit debounce vllt gar nicht gesetzt ist oder so

[paul53]

@apollon77 sagte:

wenn ein Timeout gesetzt ist dann läuft der auch wenn man da "null" setzt.

Ja, aber clearTimeout() wird vor setTimeout() nicht mehr ausgeführt.

            if (sqlDPs[id].timeout) clearTimeout(sqlDPs[id].timeout);

Wann ist diese Bedingung erfüllt ?

if (_settings) {

[apollon77]

@paul53 zu 1.) ja, würde maximal dazu führen das zwei Timer laufen. Daher die obige Änderung weil sonst fälschlicherweise Timer vergessen wurden weil immer auf "null" gesetzt wurde auch wenn es direkt aufgerufen wurde.

zu 2.) Sobald das "eine Wert" hat (also !== null && !== undefined && !==false) .. in dem Fall ist es dann ein Objekt

[paul53]

@apollon77 sagte:

zu 2.)

Das ist mir klar, aber was ist der Inhalt von ?

    var _settings = sqlDPs[_id][adapter.namespace];

[apollon77]

Das sind die Datenpunkt Spezifischen Einstellungen der sql Instanz. also das im Objekt unter common.custom["sql.0"]

[dtp]

Vielleicht darf ich mich hier mal ranhängen, obwohl ich ein etwas anderes Problem mit dem SQL-Adapter habe.

Ich beschreibe mit dem Adapter eine mariaDB-10-Datenbank auf meiner DiskStation. Kürzlich habe ich nun wegen Umstellung auf einen anderen Docker-Container (über Portainer mit MACVLAN) die IP-Adresse meines ioBroker ändern müssen. Die IP der mariaDB-10-Datenbank blieb gleich. Mir wird auch ein OK im SQL-Adapter angezeigt, wenn ich die Verbindung zur Datenbank überprüfe. Mein Problem ist aber, dass seit der Umstellung keine Datenpunkte mehr geloggt werden. Einmalig nach dem Neustart wird zwar ein neuer Wert geschrieben, aber das war's dann auch. Danach passiert nichts mehr. Nun muss ich wohl die komplette ioBroker-Datenbank unter phpMyAdmin löschen und neu anlegen.

Ist das Verhalten bekannt? Handelt es sich ggf. um einen Bug?