activate_scenario.sh
Tue Dec 31 13:55:42 CET 2024
scenario: vorraumOn
phoneName: 1

'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'thomas@miglinci.name'

scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

VZ Licht (/srv/www/viehai/shelly/log_scenarios/2024/12/31/_0.log)

vorher: 13:55:42.630

http://192.168.12.103/relay/0?turn=on
  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "overpower": false,
  "source": "input"

nachher: 13:55:42.742
Dauer: 113 msec phName: 'phoneName:'1''


scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

urls : 1
vorher : 13:55:42.604
nachher: 13:55:42.749
Dauer : 144 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/12/31//scene_vorraumOn_20241231_135542.txt'


syslog

Dec 31 13:52:01 srv4hai CRON[18903]: (root) CMD (/etc/linetest/linetest.sh)
Dec 31 13:52:19 srv4hai dhcpd[4995]: DHCPDISCOVER from 00:22:61:78:ac:78 via enp2s0
Dec 31 13:52:19 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Dec 31 13:52:43 srv4hai ping_SP[25571]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1735649563 - 'ping_SP_0'
Dec 31 13:52:43 srv4hai ping_SP[25571]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Dec 31 13:52:44 srv4hai postfix/smtpd[18894]: connect from unknown[80.94.95.239]
Dec 31 13:52:47 srv4hai postfix/smtpd[18894]: warning: unknown[80.94.95.239]: SASL LOGIN authentication failed: Invalid authentication mechanism
Dec 31 13:52:48 srv4hai postfix/smtpd[18894]: disconnect from unknown[80.94.95.239] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4
Dec 31 13:53:01 srv4hai CRON[18964]: (root) CMD (/etc/linetest/linetest.sh)
Dec 31 13:53:22 srv4hai dhcpd[4995]: DHCPDISCOVER from 00:22:61:78:ac:78 via enp2s0
Dec 31 13:53:22 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Dec 31 13:53:28 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Dec 31 13:53:29 srv4hai fetchmail[1651]: 60490 messages (60490 seen) for tmiglinci at mail.akis.at (670148680 octets).
Dec 31 13:53:30 srv4hai fetchmail[1651]: 11314 messages (11314 seen) for srozum at mail.akis.at (1353898973 octets).
Dec 31 13:53:30 srv4hai fetchmail[1651]: 28105 messages (28105 seen) for mrozum at mail.akis.at (527719054 octets).
Dec 31 13:53:31 srv4hai fetchmail[1651]: 1162 messages (1162 seen) for admin@bastelstube.wien at pop3.world4you.com (52206525 octets).
Dec 31 13:53:57 srv4hai ping_SP[25571]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1735649637 - 'ping_SP_0'
Dec 31 13:53:57 srv4hai ping_SP[25571]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Dec 31 13:54:01 srv4hai CRON[19025]: (root) CMD (/etc/linetest/linetest.sh)
Dec 31 13:54:02 srv4hai postfix/smtpd[18894]: connect from unknown[193.32.162.73]
Dec 31 13:54:06 srv4hai postfix/smtpd[19035]: connect from unknown[193.32.162.83]
Dec 31 13:54:07 srv4hai postfix/smtpd[18894]: warning: unknown[193.32.162.73]: SASL PLAIN authentication failed: 
Dec 31 13:54:07 srv4hai postfix/smtpd[18894]: disconnect from unknown[193.32.162.73] ehlo=1 auth=0/1 quit=1 commands=2/3
Dec 31 13:54:10 srv4hai postfix/smtpd[19035]: warning: unknown[193.32.162.83]: SASL PLAIN authentication failed: 
Dec 31 13:54:10 srv4hai postfix/smtpd[19035]: disconnect from unknown[193.32.162.83] ehlo=1 auth=0/1 quit=1 commands=2/3
Dec 31 13:54:18 srv4hai dhcpd[4995]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
Dec 31 13:54:18 srv4hai dhcpd[4995]: DHCPDISCOVER from cc:8d:a2:60:52:b8 via enp2s0
Dec 31 13:54:18 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
Dec 31 13:54:18 srv4hai dhcpd[4995]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
Dec 31 13:54:18 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Dec 31 13:54:18 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.101
Dec 31 13:54:18 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-01
Dec 31 13:54:18 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.101 (192.168.12.252) from cc:8d:a2:60:52:b8 via enp2s0
Dec 31 13:54:18 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
Dec 31 13:54:18 srv4hai named[30406]: client @0x7f932c021730 192.168.12.252#57837/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-01.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Dec 31 13:54:18 srv4hai named[30406]: client @0x7f931002f1e0 192.168.12.252#39463/key rndc-key: signer "rndc-key" approved
Dec 31 13:54:18 srv4hai named[30406]: client @0x7f931002f1e0 192.168.12.252#39463/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' TXT
Dec 31 13:54:18 srv4hai named[30406]: client @0x7f931002f1e0 192.168.12.252#39463/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' TXT "31166740fe21d7ece7561d62986d2b8644"
Dec 31 13:54:18 srv4hai named[30406]: client @0x7f931002f1e0 192.168.12.252#39463/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' A
Dec 31 13:54:18 srv4hai named[30406]: client @0x7f931002f1e0 192.168.12.252#39463/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' A 192.168.12.101
Dec 31 13:54:18 srv4hai dhcpd[4995]: Added new forward map from shelly-01.viehai.at to 192.168.12.101
Dec 31 13:54:18 srv4hai named[30406]: client @0x7f93501490e0 192.168.12.252#34069/key rndc-key: signer "rndc-key" approved
Dec 31 13:54:18 srv4hai named[30406]: client @0x7f93501490e0 192.168.12.252#34069/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '101.12.168.192.in-addr.arpa' PTR
Dec 31 13:54:18 srv4hai named[30406]: client @0x7f93501490e0 192.168.12.252#34069/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '101.12.168.192.in-addr.arpa' PTR shelly-01.viehai.at.
Dec 31 13:54:18 srv4hai dhcpd[4995]: Added reverse map from 101.12.168.192.in-addr.arpa. to shelly-01.viehai.at
Dec 31 13:54:18 srv4hai common[19045]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Dec 31 13:54:18 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-01' - shIP/2:'' perform:'conf'
Dec 31 13:54:20 srv4hai grab_shelly.sh: SHELLY 'shelly-01':  OFFLINE, resp. not answering within timeout 1.500000s
Dec 31 13:54:25 srv4hai dhcpd[4995]: DHCPDISCOVER from 00:22:61:78:ac:78 via enp2s0
Dec 31 13:54:25 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Dec 31 13:55:01 srv4hai CRON[19089]: (root) CMD (/etc/linetest/linetest.sh)
Dec 31 13:55:10 srv4hai ping_SP[25571]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1735649710 - 'ping_SP_0'
Dec 31 13:55:10 srv4hai ping_SP[25571]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Dec 31 13:55:11 srv4hai dhcpd[4995]: DHCPDISCOVER from e8:db:84:d2:3b:46 via enp2s0
Dec 31 13:55:11 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.106 to e8:db:84:d2:3b:46 via enp2s0
Dec 31 13:55:11 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Dec 31 13:55:11 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.106
Dec 31 13:55:11 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-06
Dec 31 13:55:11 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.106 (192.168.12.252) from e8:db:84:d2:3b:46 via enp2s0
Dec 31 13:55:11 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.106 to e8:db:84:d2:3b:46 via enp2s0
Dec 31 13:55:11 srv4hai named[30406]: client @0x7f935011da30 192.168.12.252#60027/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-06.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Dec 31 13:55:11 srv4hai named[30406]: client @0x7f9348048e40 192.168.12.252#43443/key rndc-key: signer "rndc-key" approved
Dec 31 13:55:11 srv4hai named[30406]: client @0x7f9348048e40 192.168.12.252#43443/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-06.viehai.at' TXT
Dec 31 13:55:11 srv4hai named[30406]: client @0x7f9348048e40 192.168.12.252#43443/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-06.viehai.at' TXT "00e5b4e36e36fc00550f574d5b1f0bfd3e"
Dec 31 13:55:11 srv4hai named[30406]: client @0x7f9348048e40 192.168.12.252#43443/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-06.viehai.at' A
Dec 31 13:55:11 srv4hai named[30406]: client @0x7f9348048e40 192.168.12.252#43443/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-06.viehai.at' A 192.168.12.106
Dec 31 13:55:11 srv4hai dhcpd[4995]: Added new forward map from shelly-06.viehai.at to 192.168.12.106
Dec 31 13:55:11 srv4hai named[30406]: client @0x7f9350685ed0 192.168.12.252#52717/key rndc-key: signer "rndc-key" approved
Dec 31 13:55:11 srv4hai named[30406]: client @0x7f9350685ed0 192.168.12.252#52717/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '106.12.168.192.in-addr.arpa' PTR
Dec 31 13:55:11 srv4hai named[30406]: client @0x7f9350685ed0 192.168.12.252#52717/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '106.12.168.192.in-addr.arpa' PTR shelly-06.viehai.at.
Dec 31 13:55:11 srv4hai dhcpd[4995]: Added reverse map from 106.12.168.192.in-addr.arpa. to shelly-06.viehai.at
Dec 31 13:55:11 srv4hai common[19114]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Dec 31 13:55:11 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-06' - shIP/2:'' perform:'conf'
Dec 31 13:55:12 srv4hai mosquitto[29419]: New connection from 192.168.12.106 on port 1883.
Dec 31 13:55:12 srv4hai mosquitto[29419]: Client shelly1-E8DB84D23B46 already connected, closing old connection.
Dec 31 13:55:12 srv4hai mosquitto[29419]: Socket error on client shelly1-E8DB84D23B46, disconnecting.
Dec 31 13:55:12 srv4hai mosquitto[29419]: New client connected from 192.168.12.106 as shelly1-E8DB84D23B46 (c1, k60, u'shmqtt').
Dec 31 13:55:12 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-06' - shIP/2:'192.168.12.106'
Dec 31 13:55:12 srv4hai conf_shelly.sh: SHELLY: usage/name 'WZ Licht Fernsehlampe klein' already set for '192.168.12.106'
Dec 31 13:55:12 srv4hai conf_shelly.sh: SHELLY:'shelly-06' 'conf(0)' - allready transmitted - skipping
Dec 31 13:55:12 srv4hai conf_shelly.sh: SHELLY:'shelly-06' 'conf(1)' - allready transmitted - skipping
Dec 31 13:55:12 srv4hai conf_shelly.sh: SHELLY:'shelly-06' 'conf(2)' - allready transmitted - skipping
Dec 31 13:55:12 srv4hai conf_shelly.sh: SHELLY:'shelly-06' 'conf(3)' - allready transmitted - skipping
Dec 31 13:55:29 srv4hai dhcpd[4995]: DHCPDISCOVER from 00:22:61:78:ac:78 via enp2s0
Dec 31 13:55:29 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Dec 31 13:55:31 srv4hai common[19225]: SHELLY common.sh inkludiert von ./bt_scan.sh
Dec 31 13:55:32 srv4hai dhcpd[4995]: DHCPDISCOVER from f0:39:65:25:8d:c7 via enp2s0
Dec 31 13:55:32 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Dec 31 13:55:32 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Dec 31 13:55:32 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.62
Dec 31 13:55:32 srv4hai dhcpd[4995]: execute_statement argv[2] = GreteS20
Dec 31 13:55:32 srv4hai common[19238]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Dec 31 13:55:41 srv4hai bt_scan[19225]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Dec 31 13:55:41 srv4hai bt_scan[19225]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62'
Dec 31 13:55:41 srv4hai common[19275]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Dec 31 13:55:41 srv4hai ping_SP[19275]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Dec 31 13:55:41 srv4hai common[19296]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Dec 31 13:55:42 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'3'=1735649742-1735649739
Dec 31 13:55:42 srv4hai check_presence[19296]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Dec 31 13:55:42 srv4hai check_presence[19296]: SHELLY (ping_SP__bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Dec 31 13:55:42 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'3'=1735649742-1735649739
Dec 31 13:55:42 srv4hai check_presence[19296]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Dec 31 13:55:42 srv4hai check_presence[19296]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(BT/LIVE) (BT/__)' - anyPresent: 'true' - otherPresent:'true'
Dec 31 13:55:42 srv4hai check_presence[19296]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_pcOFF) - sceneONsmall(vorraumOn)
Dec 31 13:55:42 srv4hai check_presence[19296]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn
Dec 31 13:55:42 srv4hai activate_scenario[19411]: SHELLY last scenario: 'pcOFF' @ '134844' from 'scene_pcOFF_20241231_134844.txt' - delta=2
Dec 31 13:55:42 srv4hai activate_scenario[19411]:        dateutils.ddiff -i '%Y%m%d%H%M%s' 20241231135542 20241231134844  -f '%S'
Dec 31 13:55:42 srv4hai activate_scenario[19411]: SHELLY  new scenario: 'vorraumOn' different - GO ON
Dec 31 13:55:42 srv4hai activate_scenario[19411]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Dec 31 13:55:42 srv4hai activate_scenario[19411]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1'

finished