activate_scenario.sh
Sun Jan 12 13:35:38 CET 2025
scenario: sekr_UM
source: 192.168.12.110

'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'null'

scenario: 'Sekretär Licht UM-schalten' - 'sekr_UM' - 'sekr_um'

WZ Licht Sofa (/srv/www/viehai/shelly/log_scenarios/2025/01/12/_0.log)

vorher: 13:35:38.846

http://192.168.12.123/relay/0?turn=toggle
  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "source": "http"

nachher: 13:35:38.936
Dauer: 90 msec phName: 'shelly-10:'WZ Licht Bücherregal''


scenario: 'Sekretär Licht UM-schalten' - 'sekr_UM' - 'sekr_um'

urls : 1
vorher : 13:35:38.815
nachher: 13:35:38.942
Dauer : 128 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/12//scene_sekr_UM_20250112_133538.txt'


syslog

Jan 12 13:32:01 srv4hai CRON[1855]: (root) CMD (/etc/linetest/linetest.sh)
Jan 12 13:32:03 srv4hai postfix/smtpd[1827]: connect from unknown[94.156.227.127]
Jan 12 13:32:03 srv4hai postfix/smtpd[1827]: warning: unknown[94.156.227.127]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jan 12 13:32:03 srv4hai postfix/smtpd[1827]: disconnect from unknown[94.156.227.127] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 12 13:32:03 srv4hai postfix/smtpd[1827]: connect from unknown[92.118.39.66]
Jan 12 13:32:08 srv4hai postfix/smtpd[1827]: warning: unknown[92.118.39.66]: SASL PLAIN authentication failed: 
Jan 12 13:32:08 srv4hai postfix/smtpd[1827]: disconnect from unknown[92.118.39.66] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 12 13:32:12 srv4hai dhcpd[4995]: DHCPDISCOVER from 8c:aa:b5:61:a9:20 via enp2s0
Jan 12 13:32:12 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.107 to 8c:aa:b5:61:a9:20 via enp2s0
Jan 12 13:32:12 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 12 13:32:12 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.107
Jan 12 13:32:12 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-07
Jan 12 13:32:12 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.107 (192.168.12.252) from 8c:aa:b5:61:a9:20 via enp2s0
Jan 12 13:32:12 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.107 to 8c:aa:b5:61:a9:20 via enp2s0
Jan 12 13:32:12 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#36599/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-07.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 12 13:32:12 srv4hai named[30406]: client @0x7f933004a8d0 192.168.12.252#42139/key rndc-key: signer "rndc-key" approved
Jan 12 13:32:12 srv4hai named[30406]: client @0x7f933004a8d0 192.168.12.252#42139/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-07.viehai.at' TXT
Jan 12 13:32:12 srv4hai named[30406]: client @0x7f933004a8d0 192.168.12.252#42139/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-07.viehai.at' TXT "00304107ff63db9ada5ee5a0bc2105bb05"
Jan 12 13:32:12 srv4hai named[30406]: client @0x7f933004a8d0 192.168.12.252#42139/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-07.viehai.at' A
Jan 12 13:32:12 srv4hai named[30406]: client @0x7f933004a8d0 192.168.12.252#42139/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-07.viehai.at' A 192.168.12.107
Jan 12 13:32:12 srv4hai dhcpd[4995]: Added new forward map from shelly-07.viehai.at to 192.168.12.107
Jan 12 13:32:12 srv4hai named[30406]: client @0x7f93100debd0 192.168.12.252#57121/key rndc-key: signer "rndc-key" approved
Jan 12 13:32:12 srv4hai named[30406]: client @0x7f93100debd0 192.168.12.252#57121/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '107.12.168.192.in-addr.arpa' PTR
Jan 12 13:32:12 srv4hai named[30406]: client @0x7f93100debd0 192.168.12.252#57121/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '107.12.168.192.in-addr.arpa' PTR shelly-07.viehai.at.
Jan 12 13:32:12 srv4hai dhcpd[4995]: Added reverse map from 107.12.168.192.in-addr.arpa. to shelly-07.viehai.at
Jan 12 13:32:12 srv4hai common[1864]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan 12 13:32:12 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-07' - shIP/2:'' perform:'conf'
Jan 12 13:32:13 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-07' - shIP/2:'192.168.12.107'
Jan 12 13:32:13 srv4hai mosquitto[29419]: New connection from 192.168.12.107 on port 1883.
Jan 12 13:32:13 srv4hai mosquitto[29419]: Client shelly1-8CAAB561A920 already connected, closing old connection.
Jan 12 13:32:13 srv4hai mosquitto[29419]: Socket error on client shelly1-8CAAB561A920, disconnecting.
Jan 12 13:32:13 srv4hai mosquitto[29419]: New client connected from 192.168.12.107 as shelly1-8CAAB561A920 (c1, k60, u'shmqtt').
Jan 12 13:32:13 srv4hai conf_shelly.sh: SHELLY: usage/name 'SZ Nachtkästchen Thomas' already set for '192.168.12.107'
Jan 12 13:32:13 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(0)' - allready transmitted - skipping
Jan 12 13:32:13 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(1)' - allready transmitted - skipping
Jan 12 13:32:13 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(2)' - allready transmitted - skipping
Jan 12 13:32:13 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(3)' - allready transmitted - skipping
Jan 12 13:32:13 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(4)' - allready transmitted - skipping
Jan 12 13:32:13 srv4hai systemd[1]: Started Run anacron jobs.
Jan 12 13:32:13 srv4hai anacron[1973]: Anacron 2.3 started on 2025-01-12
Jan 12 13:32:13 srv4hai anacron[1973]: Normal exit (0 jobs run)
Jan 12 13:32:13 srv4hai systemd[1]: anacron.service: Succeeded.
Jan 12 13:32:28 srv4hai ping_SP[11164]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1736685148 - 'ping_SP_1'
Jan 12 13:32:28 srv4hai ping_SP[11164]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 12 13:32:53 srv4hai common[2002]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 12 13:33:01 srv4hai CRON[2019]: (root) CMD (/etc/linetest/linetest.sh)
Jan 12 13:33:03 srv4hai bt_scan[2002]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'No'
Jan 12 13:33:03 srv4hai bt_scan[2002]: SHELLY - lost BT-connection to BTmac: '1' found: 'No' - check presence
Jan 12 13:33:03 srv4hai common[2042]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 12 13:33:04 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'1'=1736685184-1736685183
Jan 12 13:33:04 srv4hai check_presence[2042]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jan 12 13:33:04 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'1'=1736685184-1736685183
Jan 12 13:33:04 srv4hai check_presence[2042]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jan 12 13:33:04 srv4hai check_presence[2042]: SHELLY (bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Jan 12 13:33:04 srv4hai check_presence[2042]: SHELLY (bt_scan)-(1) what: 'presence' - persPresent: '(__/__) (__/LIVE)' - anyPresent: 'true' - otherPresent:'false'
Jan 12 13:33:04 srv4hai check_presence[2042]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_vorraumOn) - sceneOFF(offAll)
Jan 12 13:33:04 srv4hai check_presence[2042]: SHELLY (bt_scan)-(1)-presence: NOT activate_scenario.shtml: offAll
Jan 12 13:33:06 srv4hai common[2150]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 12 13:33:16 srv4hai bt_scan[2150]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Jan 12 13:33:16 srv4hai bt_scan[2150]: SHELLY - ping_SP.sh already running for BTmac: '1' - IPv4: '192.168.12.62'
Jan 12 13:33:42 srv4hai ping_SP[11164]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1736685222 - 'ping_SP_1'
Jan 12 13:33:42 srv4hai ping_SP[11164]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 12 13:33:45 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=2209, secured, session=
Jan 12 13:33:45 srv4hai dovecot: imap(miglincit)<2209>: Logged out in=137 out=1089 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 12 13:34:01 srv4hai CRON[2217]: (root) CMD (/etc/linetest/linetest.sh)
Jan 12 13:34:09 srv4hai dhcpd[4995]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0
Jan 12 13:34:09 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
Jan 12 13:34:09 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 12 13:34:09 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.147
Jan 12 13:34:09 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-47
Jan 12 13:34:09 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.147 (192.168.12.252) from 44:17:93:a5:8a:e4 via enp2s0
Jan 12 13:34:09 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
Jan 12 13:34:09 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#57903/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-47.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 12 13:34:09 srv4hai named[30406]: client @0x7f93100971e0 192.168.12.252#55597/key rndc-key: signer "rndc-key" approved
Jan 12 13:34:09 srv4hai named[30406]: client @0x7f93100971e0 192.168.12.252#55597/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' TXT
Jan 12 13:34:09 srv4hai named[30406]: client @0x7f93100971e0 192.168.12.252#55597/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' TXT "31f97534415d36e3a13ec57b0310c0867f"
Jan 12 13:34:09 srv4hai named[30406]: client @0x7f93100971e0 192.168.12.252#55597/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' A
Jan 12 13:34:09 srv4hai named[30406]: client @0x7f93100971e0 192.168.12.252#55597/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' A 192.168.12.147
Jan 12 13:34:09 srv4hai dhcpd[4995]: Added new forward map from shelly-47.viehai.at to 192.168.12.147
Jan 12 13:34:09 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#47447/key rndc-key: signer "rndc-key" approved
Jan 12 13:34:09 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#47447/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '147.12.168.192.in-addr.arpa' PTR
Jan 12 13:34:09 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#47447/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.
Jan 12 13:34:09 srv4hai dhcpd[4995]: Added reverse map from 147.12.168.192.in-addr.arpa. to shelly-47.viehai.at
Jan 12 13:34:09 srv4hai common[2223]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan 12 13:34:09 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-47' - shIP/2:'' perform:'conf'
Jan 12 13:34:10 srv4hai mosquitto[29419]: New connection from 192.168.12.147 on port 1883.
Jan 12 13:34:10 srv4hai mosquitto[29419]: New client connected from 192.168.12.147 as shellyplus1-441793a58ae4 (c1, k60, u'shmqtt').
Jan 12 13:34:10 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-47' - shIP/2:'192.168.12.147'
Jan 12 13:34:10 srv4hai conf_shelly.sh: SHELLY: usage/name 'GB Schreibtischlampe links' already set for '192.168.12.147'
Jan 12 13:34:10 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(0)' - allready transmitted - skipping
Jan 12 13:34:10 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(1)' - allready transmitted - skipping
Jan 12 13:34:10 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(2)' - allready transmitted - skipping
Jan 12 13:34:14 srv4hai mosquitto[29419]: Client shelly1-8CAAB561A920 has exceeded timeout, disconnecting.
Jan 12 13:34:14 srv4hai mosquitto[29419]: Socket error on client shelly1-8CAAB561A920, disconnecting.
Jan 12 13:34:46 srv4hai postfix/anvil[4274]: statistics: max connection rate 1/60s for (smtp:94.156.227.127) at Jan 12 13:25:42
Jan 12 13:34:46 srv4hai postfix/anvil[4274]: statistics: max connection count 1 for (smtp:94.156.227.127) at Jan 12 13:25:42
Jan 12 13:34:46 srv4hai postfix/anvil[4274]: statistics: max cache size 3 at Jan 12 13:32:03
Jan 12 13:34:55 srv4hai ping_SP[11164]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1736685295 - 'ping_SP_1'
Jan 12 13:34:55 srv4hai ping_SP[11164]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 12 13:35:01 srv4hai CRON[2336]: (root) CMD (/etc/linetest/linetest.sh)
Jan 12 13:35:11 srv4hai postfix/smtpd[2341]: connect from unknown[94.156.227.127]
Jan 12 13:35:11 srv4hai postfix/smtpd[2341]: warning: unknown[94.156.227.127]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jan 12 13:35:11 srv4hai postfix/smtpd[2341]: disconnect from unknown[94.156.227.127] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 12 13:35:20 srv4hai common[2345]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 12 13:35:25 srv4hai postfix/smtpd[2341]: connect from unknown[154.203.197.109]
Jan 12 13:35:25 srv4hai postfix/smtpd[2341]: warning: unknown[154.203.197.109]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jan 12 13:35:25 srv4hai postfix/smtpd[2341]: lost connection after AUTH from unknown[154.203.197.109]
Jan 12 13:35:25 srv4hai postfix/smtpd[2341]: disconnect from unknown[154.203.197.109] ehlo=1 auth=0/1 commands=1/2
Jan 12 13:35:30 srv4hai bt_scan[2345]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'No'
Jan 12 13:35:30 srv4hai bt_scan[2345]: SHELLY - lost BT-connection to BTmac: '1' found: 'No' - check presence
Jan 12 13:35:30 srv4hai common[2382]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 12 13:35:31 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'4'=1736685331-1736685327
Jan 12 13:35:31 srv4hai check_presence[2382]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jan 12 13:35:31 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'4'=1736685331-1736685327
Jan 12 13:35:31 srv4hai check_presence[2382]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jan 12 13:35:31 srv4hai check_presence[2382]: SHELLY (bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Jan 12 13:35:31 srv4hai check_presence[2382]: SHELLY (bt_scan)-(1) what: 'presence' - persPresent: '(BT/__) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Jan 12 13:35:31 srv4hai check_presence[2382]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_vorraumOn) - sceneOFF(offAll)
Jan 12 13:35:31 srv4hai check_presence[2382]: SHELLY (bt_scan)-(1)-presence: NOT activate_scenario.shtml: offAll
Jan 12 13:35:38 srv4hai activate_scenario[2531]: SHELLY last scenario: 'vorraumOn' @ '130205' from 'scene_vorraumOn_20250112_130205.txt' - delta=-33
Jan 12 13:35:38 srv4hai activate_scenario[2531]:        dateutils.ddiff -i '%Y%m%d%H%M%s' 20250112133538 20250112130205  -f '%S'
Jan 12 13:35:38 srv4hai activate_scenario[2531]: SHELLY  new scenario: 'sekr_UM' different - GO ON
Jan 12 13:35:38 srv4hai activate_scenario[2531]: SHELLY scenario: 'sekr_UM(sekr_um)' started
Jan 12 13:35:38 srv4hai activate_scenario[2531]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-10:'WZ Licht Bücherregal'

finished