activate_scenario.sh
Thu May 1 22:43:11 CEST 2025
scenario: bedlight_tom
source: 192.168.12.112
dayState='night' <--> DayTime='checked' NightTime='checked' flag 'execute* set as '
-> execution of scenario
scenario: 'Nachttischlampe Thomas UM-schalten' - 'bedlight_tom' - 'bedlight_tom'
SZ Nachtkästchen Thomas (/srv/www/viehai/shelly/log_scenarios/2025/05/01/_0.log)
vorher: 22:43:12.121
http://192.168.12.107/relay/0?turn=toggle |
|---|
"ison": true,
"has_timer": false,
"timer_started": 0,
"timer_duration": 0,
"timer_remaining": 0,
"source": "http"
|
nachher: 22:43:12.162
Dauer: 41 msec
phName: 'shelly-12:'SZ Licht''
scenario: 'Nachttischlampe Thomas UM-schalten' - 'bedlight_tom' - 'bedlight_tom'
urls : 1
vorher : 22:43:12.072
nachher: 22:43:12.175
Dauer : 103 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/05/01//scene_bedlight_tom_20250501_224311.txt'
syslog
May 1 22:40:00 srv4hai mqtt_process[22244]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May 1 22:40:00 srv4hai mqtt_process[22269]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:40:00 srv4hai mqtt_process[22294]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:40:01 srv4hai CRON[22322]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
May 1 22:40:01 srv4hai CRON[22323]: (root) CMD (/etc/linetest/linetest.sh)
May 1 22:40:01 srv4hai meter.sh: SHELLY meter.sh started
May 1 22:40:02 srv4hai meter.sh: SHELLY 'shelly-29/KÜ Schalter Herdzeile' - type: 'shelly-i3' ignoring
May 1 22:40:02 srv4hai check_shelly.sh: SHELLY last scenery executed: 'offDownstairs'
May 1 22:40:02 srv4hai check_shelly.sh: SHELLY found '1' active shelly outputs
May 1 22:40:02 srv4hai meter.sh: SHELLY meter.sh ended
May 1 22:40:02 srv4hai postfix/pickup[22449]: 8152563464: uid=33 from=
May 1 22:40:02 srv4hai postfix/cleanup[22450]: 8152563464: message-id=<20250501204002.8152563464@mail.viehai.at>
May 1 22:40:02 srv4hai postfix/qmgr[8566]: 8152563464: from=, size=663, nrcpt=1 (queue active)
May 1 22:40:02 srv4hai postfix/local[22452]: 8152563464: to=, orig_to=, relay=local, delay=0.06, delays=0.05/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
May 1 22:40:02 srv4hai postfix/qmgr[8566]: 8152563464: removed
May 1 22:40:06 srv4hai mqtt_process[22455]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:40:06 srv4hai mqtt_process[22480]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:40:30 srv4hai named[30406]: resolver priming query complete
May 1 22:40:35 srv4hai ping_SP[17978]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1746132035 - 'ping_SP_1'
May 1 22:40:35 srv4hai ping_SP[17978]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May 1 22:40:39 srv4hai dhcpd[30231]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0
May 1 22:40:39 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
May 1 22:40:39 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
May 1 22:40:39 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.147
May 1 22:40:39 srv4hai dhcpd[30231]: execute_statement argv[2] = shelly-47
May 1 22:40:39 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.147 (192.168.12.252) from 44:17:93:a5:8a:e4 via enp2s0
May 1 22:40:39 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
May 1 22:40:39 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#48671/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-47.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May 1 22:40:39 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#35405/key rndc-key: signer "rndc-key" approved
May 1 22:40:39 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#35405/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' TXT
May 1 22:40:39 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#35405/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' TXT "31f97534415d36e3a13ec57b0310c0867f"
May 1 22:40:39 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#35405/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' A
May 1 22:40:39 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#35405/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' A 192.168.12.147
May 1 22:40:39 srv4hai dhcpd[30231]: Added new forward map from shelly-47.viehai.at to 192.168.12.147
May 1 22:40:39 srv4hai named[30406]: client @0x7f934c0b2c60 192.168.12.252#53091/key rndc-key: signer "rndc-key" approved
May 1 22:40:39 srv4hai named[30406]: client @0x7f934c0b2c60 192.168.12.252#53091/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '147.12.168.192.in-addr.arpa' PTR
May 1 22:40:39 srv4hai named[30406]: client @0x7f934c0b2c60 192.168.12.252#53091/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '147.12.168.192.in-addr.arpa' PTR shelly-47.viehai.at.
May 1 22:40:39 srv4hai dhcpd[30231]: Added reverse map from 147.12.168.192.in-addr.arpa. to shelly-47.viehai.at
May 1 22:40:39 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-47' - shIP/2:'' perform:'conf'
May 1 22:40:41 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-47' - shIP/2:'192.168.12.147'
May 1 22:40:41 srv4hai conf_shelly.sh: SHELLY: usage/name 'GB Schreibtischlampe links' already set for '192.168.12.147'
May 1 22:40:41 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(0)' - allready transmitted - skipping
May 1 22:40:41 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(1)' - allready transmitted - skipping
May 1 22:40:41 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(2)' - allready transmitted - skipping
May 1 22:40:41 srv4hai mosquitto[29419]: New connection from 192.168.12.147 on port 1883.
May 1 22:40:41 srv4hai mosquitto[29419]: Client shellyplus1-441793a58ae4 already connected, closing old connection.
May 1 22:40:41 srv4hai mosquitto[29419]: Socket error on client shellyplus1-441793a58ae4, disconnecting.
May 1 22:40:41 srv4hai mosquitto[29419]: New client connected from 192.168.12.147 as shellyplus1-441793a58ae4 (c1, k60, u'shmqtt').
May 1 22:40:41 srv4hai mqtt_process[22592]: SHELLY - shellyType: 'shelly-1plus' not handled for 'shelly-47'/'GB Schreibtischlampe links'!!
May 1 22:40:41 srv4hai mqtt_process[22617]: SHELLY - shellyType: 'shelly-1plus' not handled for 'shelly-47'/'GB Schreibtischlampe links'!!
May 1 22:41:00 srv4hai mqtt_process[22671]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May 1 22:41:00 srv4hai mqtt_process[22696]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:41:00 srv4hai mqtt_process[22721]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:41:01 srv4hai CRON[22747]: (root) CMD (/etc/linetest/linetest.sh)
May 1 22:41:06 srv4hai mqtt_process[22753]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:41:06 srv4hai mqtt_process[22778]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:41:08 srv4hai ping_SP[23404]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1746132068 - 'ping_SP_0'
May 1 22:41:08 srv4hai ping_SP[23404]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May 1 22:41:25 srv4hai named[30406]: resolver priming query complete
May 1 22:41:39 srv4hai named[30406]: resolver priming query complete
May 1 22:41:48 srv4hai ping_SP[17978]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1746132108 - 'ping_SP_1'
May 1 22:41:48 srv4hai ping_SP[17978]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May 1 22:41:52 srv4hai kernel: [92110239.327821] CPU0: Package temperature/speed normal
May 1 22:41:52 srv4hai kernel: [92110239.327822] CPU2: Package temperature/speed normal
May 1 22:41:52 srv4hai kernel: [92110239.327824] CPU1: Package temperature/speed normal
May 1 22:41:52 srv4hai kernel: [92110239.327825] CPU3: Package temperature/speed normal
May 1 22:41:52 srv4hai kernel: [92110239.327826] CPU5: Package temperature/speed normal
May 1 22:41:52 srv4hai kernel: [92110239.327827] CPU7: Package temperature/speed normal
May 1 22:41:52 srv4hai kernel: [92110239.327828] CPU6: Package temperature/speed normal
May 1 22:41:52 srv4hai kernel: [92110239.327829] CPU4: Package temperature/speed normal
May 1 22:41:58 srv4hai dhcpd[30231]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0
May 1 22:41:58 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
May 1 22:41:58 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
May 1 22:41:58 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.147
May 1 22:41:58 srv4hai dhcpd[30231]: execute_statement argv[2] = shelly-47
May 1 22:41:58 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.147 (192.168.12.252) from 44:17:93:a5:8a:e4 via enp2s0
May 1 22:41:58 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
May 1 22:41:58 srv4hai named[30406]: client @0x7f93100b4de0 192.168.12.252#46561/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-47.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May 1 22:41:58 srv4hai named[30406]: client @0x7f931c03b370 192.168.12.252#57161/key rndc-key: signer "rndc-key" approved
May 1 22:41:58 srv4hai named[30406]: client @0x7f931c03b370 192.168.12.252#57161/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' TXT
May 1 22:41:58 srv4hai named[30406]: client @0x7f931c03b370 192.168.12.252#57161/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' TXT "31f97534415d36e3a13ec57b0310c0867f"
May 1 22:41:58 srv4hai named[30406]: client @0x7f931c03b370 192.168.12.252#57161/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' A
May 1 22:41:58 srv4hai named[30406]: client @0x7f931c03b370 192.168.12.252#57161/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' A 192.168.12.147
May 1 22:41:58 srv4hai dhcpd[30231]: Added new forward map from shelly-47.viehai.at to 192.168.12.147
May 1 22:41:58 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#35969/key rndc-key: signer "rndc-key" approved
May 1 22:41:58 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#35969/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '147.12.168.192.in-addr.arpa' PTR
May 1 22:41:58 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#35969/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '147.12.168.192.in-addr.arpa' PTR shelly-47.viehai.at.
May 1 22:41:58 srv4hai dhcpd[30231]: Added reverse map from 147.12.168.192.in-addr.arpa. to shelly-47.viehai.at
May 1 22:41:58 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-47' - shIP/2:'' perform:'conf'
May 1 22:42:00 srv4hai mqtt_process[22853]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May 1 22:42:00 srv4hai grab_shelly.sh: SHELLY 'shelly-47': OFFLINE, resp. not answering within timeout 1.500000s
May 1 22:42:00 srv4hai mosquitto[29419]: New connection from 192.168.12.147 on port 1883.
May 1 22:42:00 srv4hai mosquitto[29419]: Client shellyplus1-441793a58ae4 already connected, closing old connection.
May 1 22:42:00 srv4hai mosquitto[29419]: Socket error on client shellyplus1-441793a58ae4, disconnecting.
May 1 22:42:00 srv4hai mosquitto[29419]: New client connected from 192.168.12.147 as shellyplus1-441793a58ae4 (c1, k60, u'shmqtt').
May 1 22:42:00 srv4hai mqtt_process[22884]: SHELLY - shellyType: 'shelly-1plus' not handled for 'shelly-47'/'GB Schreibtischlampe links'!!
May 1 22:42:00 srv4hai mqtt_process[22909]: SHELLY - shellyType: 'shelly-1plus' not handled for 'shelly-47'/'GB Schreibtischlampe links'!!
May 1 22:42:00 srv4hai mqtt_process[22934]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:42:00 srv4hai mqtt_process[22959]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:42:01 srv4hai CRON[22985]: (root) CMD (/etc/linetest/linetest.sh)
May 1 22:42:06 srv4hai mqtt_process[22991]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:42:06 srv4hai mqtt_process[23016]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:42:21 srv4hai ping_SP[23404]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1746132141 - 'ping_SP_0'
May 1 22:42:21 srv4hai ping_SP[23404]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May 1 22:42:30 srv4hai mosquitto[29419]: Saving in-memory database to /var/lib/mosquitto/mosquitto.db.
May 1 22:42:40 srv4hai bt_scan[23064]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
May 1 22:42:40 srv4hai bt_scan[23064]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
May 1 22:42:46 srv4hai named[30406]: resolver priming query complete
May 1 22:42:55 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
May 1 22:42:56 srv4hai fetchmail[1651]: 68855 messages (68855 seen) for tmiglinci at mail.akis.at (1383178683 octets).
May 1 22:42:57 srv4hai fetchmail[1651]: 11896 messages (11896 seen) for srozum at mail.akis.at (1401569144 octets).
May 1 22:42:57 srv4hai fetchmail[1651]: 30703 messages (30703 seen) for mrozum at mail.akis.at (992261115 octets).
May 1 22:42:58 srv4hai fetchmail[1651]: 1169 messages (1169 seen) for admin@bastelstube.wien at pop3.world4you.com (52284237 octets).
May 1 22:43:00 srv4hai mqtt_process[23106]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May 1 22:43:00 srv4hai mqtt_process[23131]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:43:00 srv4hai mqtt_process[23156]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:43:01 srv4hai CRON[23182]: (root) CMD (/etc/linetest/linetest.sh)
May 1 22:43:01 srv4hai ping_SP[17978]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1746132181 - 'ping_SP_1'
May 1 22:43:01 srv4hai ping_SP[17978]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May 1 22:43:06 srv4hai mqtt_process[23202]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:43:06 srv4hai mqtt_process[23227]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 1 22:43:12 srv4hai activate_scenario[23253]: SHELLY scenario: 'bedlight_tom(bedlight_tom)' started
May 1 22:43:12 srv4hai activate_scenario[23253]: SHELLY dayState='night' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - shelly-12:'SZ Licht'
finished