activate_scenario.sh
Sat Feb 1 09:13:00 CET 2025
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/2025/02/01/_0.log)

vorher: 09:13:00.567

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": "http"

nachher: 09:13:00.691
Dauer: 125 msec phName: 'phoneName:'1''


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

urls : 1
vorher : 09:13:00.509
nachher: 09:13:00.699
Dauer : 192 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/02/01//scene_vorraumOn_20250201_091300.txt'


syslog

Feb  1 09:10:00 srv4hai common[21296]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:10:00 srv4hai common[21320]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:10:00 srv4hai common[21344]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:10:01 srv4hai CRON[21370]: (root) CMD (/etc/linetest/linetest.sh)
Feb  1 09:10:01 srv4hai CRON[21371]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Feb  1 09:10:01 srv4hai common[21373]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/meter.sh
Feb  1 09:10:01 srv4hai meter.sh: SHELLY meter.sh started
Feb  1 09:10:02 srv4hai meter.sh: SHELLY 'shelly-29/KÜ Schalter Herdzeile' - type: 'shelly-i3' ignoring
Feb  1 09:10:02 srv4hai meter.sh: SHELLY 'shelly-28/KÜ Schalter Nasszeile' - type: 'shelly-i3' ignoring
Feb  1 09:10:07 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster' - type: 'shelly-BTN' ignoring
Feb  1 09:10:07 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter' - type: 'shelly-BTN' ignoring
Feb  1 09:10:07 srv4hai meter.sh: SHELLY 'shelly-37/TB Klima' - type: 'shelly-ht' ignoring
Feb  1 09:10:07 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen' - status: 'OOS' ignoring
Feb  1 09:10:07 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon' - type: 'shelly-ht-plus' ignoring
Feb  1 09:10:10 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb  1 09:10:12 srv4hai postfix/smtpd[20821]: warning: hostname 107-174-68-151-host.colocrossing.com does not resolve to address 107.174.68.151: Name or service not known
Feb  1 09:10:12 srv4hai postfix/smtpd[20821]: connect from unknown[107.174.68.151]
Feb  1 09:10:12 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb  1 09:10:12 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD' - status: 'OOS' ignoring
Feb  1 09:10:12 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3' - status: 'OOS' ignoring
Feb  1 09:10:12 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD' - status: 'OOS' ignoring
Feb  1 09:10:12 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD' - status: 'OOS' ignoring
Feb  1 09:10:12 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD' - status: 'OOS' ignoring
Feb  1 09:10:13 srv4hai meter.sh: SHELLY 'shelly-09a/Inbetriebnahme - 20210720 - Defekt' - status: 'defect' ignoring
Feb  1 09:10:13 srv4hai meter.sh: SHELLY 'shelly-09b/Sophie Licht - 20230404 - Defekt' - status: 'defect' ignoring
Feb  1 09:10:13 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN' - status: 'defect' ignoring
Feb  1 09:10:13 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417' - status: 'defect' ignoring
Feb  1 09:10:13 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem' - status: 'defect' ignoring
Feb  1 09:10:13 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722' - status: 'defect' ignoring
Feb  1 09:10:13 srv4hai meter.sh: SHELLY 'shelly-01a/WZ Licht Esstisch - 20241208 kein WLAN' - status: 'DFC' ignoring
Feb  1 09:10:13 srv4hai meter.sh: SHELLY 'shelly-43/43-tbd' - status: 'OOS' ignoring
Feb  1 09:10:13 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD' - status: 'OOS' ignoring
Feb  1 09:10:13 srv4hai meter.sh: SHELLY 'shelly-46/46-TBD' - status: 'OOS' ignoring
Feb  1 09:10:16 srv4hai postfix/smtpd[20821]: warning: unknown[107.174.68.151]: SASL PLAIN authentication failed: 
Feb  1 09:10:16 srv4hai meter.sh: SHELLY 'shelly-50/50-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb  1 09:10:16 srv4hai meter.sh: SHELLY 'shelly-59/Werkstatt Schalter Kellertür' - type: 'shelly-i3' ignoring
Feb  1 09:10:16 srv4hai postfix/smtpd[20821]: disconnect from unknown[107.174.68.151] ehlo=1 auth=0/1 quit=1 commands=2/3
Feb  1 09:10:17 srv4hai ping_SP[27816]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1738397417 - 'ping_SP_0'
Feb  1 09:10:17 srv4hai ping_SP[27816]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb  1 09:10:19 srv4hai meter.sh: SHELLY 'shelly-99/99-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb  1 09:10:19 srv4hai common[22404]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_shelly.sh
Feb  1 09:10:19 srv4hai check_shelly.sh: SHELLY last scenery executed: 'nasszeile_um'
Feb  1 09:10:19 srv4hai check_shelly.sh: SHELLY found '3' active shelly outputs
Feb  1 09:10:19 srv4hai meter.sh: SHELLY meter.sh ended
Feb  1 09:10:46 srv4hai named[30406]: resolver priming query complete
Feb  1 09:10:51 srv4hai common[22434]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:10:51 srv4hai common[22458]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:11:00 srv4hai common[22485]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:11:00 srv4hai common[22511]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:11:00 srv4hai common[22535]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:11:01 srv4hai CRON[22560]: (root) CMD (/etc/linetest/linetest.sh)
Feb  1 09:11:02 srv4hai common[22566]: SHELLY common.sh inkludiert von ./bt_scan.sh
Feb  1 09:11:12 srv4hai bt_scan[22566]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Feb  1 09:11:12 srv4hai bt_scan[22566]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Feb  1 09:11:12 srv4hai common[22601]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Feb  1 09:11:13 srv4hai named[30406]: resolver priming query complete
Feb  1 09:11:13 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1738397473-1738397463
Feb  1 09:11:13 srv4hai check_presence[22601]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Feb  1 09:11:13 srv4hai check_presence[22601]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Feb  1 09:11:13 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'10'=1738397473-1738397463
Feb  1 09:11:13 srv4hai check_presence[22601]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Feb  1 09:11:13 srv4hai check_presence[22601]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Feb  1 09:11:13 srv4hai check_presence[22601]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_nasszeile_um) - sceneOFF(offAll)
Feb  1 09:11:13 srv4hai check_presence[22601]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Feb  1 09:11:18 srv4hai common[22720]: SHELLY common.sh inkludiert von ./bt_scan.sh
Feb  1 09:11:28 srv4hai bt_scan[22720]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Feb  1 09:11:28 srv4hai bt_scan[22720]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Feb  1 09:11:30 srv4hai ping_SP[27816]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1738397490 - 'ping_SP_0'
Feb  1 09:11:30 srv4hai ping_SP[27816]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb  1 09:11:31 srv4hai named[30406]: resolver priming query complete
Feb  1 09:11:51 srv4hai common[22782]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:11:51 srv4hai common[22807]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:11:55 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=22834, secured, session=
Feb  1 09:11:55 srv4hai dovecot: imap(miglincit)<22834>: Logged out in=1605 out=1233 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb  1 09:12:00 srv4hai common[22835]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:12:00 srv4hai common[22859]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:12:00 srv4hai common[22883]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:12:01 srv4hai CRON[22908]: (root) CMD (/etc/linetest/linetest.sh)
Feb  1 09:12:11 srv4hai named[30406]: resolver priming query complete
Feb  1 09:12:12 srv4hai named[30406]: resolver priming query complete
Feb  1 09:12:13 srv4hai named[30406]: resolver priming query complete
Feb  1 09:12:17 srv4hai postfix/smtpd[22919]: connect from vps-7468a46f.vps.ovh.net[51.83.71.116]
Feb  1 09:12:22 srv4hai postfix/smtpd[22919]: warning: vps-7468a46f.vps.ovh.net[51.83.71.116]: SASL PLAIN authentication failed: 
Feb  1 09:12:22 srv4hai postfix/smtpd[22919]: disconnect from vps-7468a46f.vps.ovh.net[51.83.71.116] ehlo=1 auth=0/1 quit=1 commands=2/3
Feb  1 09:12:24 srv4hai named[30406]: resolver priming query complete
Feb  1 09:12:43 srv4hai ping_SP[27816]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1738397563 - 'ping_SP_0'
Feb  1 09:12:43 srv4hai ping_SP[27816]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb  1 09:12:48 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Feb  1 09:12:48 srv4hai fetchmail[1651]: 62688 messages (62688 seen) for tmiglinci at mail.akis.at (833991330 octets).
Feb  1 09:12:49 srv4hai fetchmail[1651]: 11473 messages (11473 seen) for srozum at mail.akis.at (1364318319 octets).
Feb  1 09:12:49 srv4hai common[22956]: SHELLY common.sh inkludiert von ./bt_scan.sh
Feb  1 09:12:49 srv4hai fetchmail[1651]: 28667 messages (28666 seen) for mrozum at mail.akis.at (617292892 octets).
Feb  1 09:12:49 srv4hai postfix/smtpd[22919]: connect from localhost[127.0.0.1]
Feb  1 09:12:49 srv4hai postfix/smtpd[22919]: E1341631BE: client=localhost[127.0.0.1]
Feb  1 09:12:49 srv4hai postfix/cleanup[22970]: E1341631BE: message-id=
Feb  1 09:12:50 srv4hai fetchmail[1651]: reading message mrozum@mail.akis.at:28667 of 28667 (198311 octets) not flushed
Feb  1 09:12:50 srv4hai postfix/qmgr[8566]: E1341631BE: from=, size=198546, nrcpt=1 (queue active)
Feb  1 09:12:50 srv4hai postfix/smtpd[22919]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Feb  1 09:12:50 srv4hai postfix/local[22971]: E1341631BE: to=, relay=local, delay=0.13, delays=0.12/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb  1 09:12:50 srv4hai postfix/qmgr[8566]: E1341631BE: removed
Feb  1 09:12:50 srv4hai fetchmail[1651]: 1162 messages (1162 seen) for admin@bastelstube.wien at pop3.world4you.com (52206525 octets).
Feb  1 09:12:51 srv4hai dhcpd[4995]: DHCPDISCOVER from 98:cd:ac:2e:1c:da via enp2s0
Feb  1 09:12:51 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0
Feb  1 09:12:51 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Feb  1 09:12:51 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.122
Feb  1 09:12:51 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-22
Feb  1 09:12:51 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.122 (192.168.12.252) from 98:cd:ac:2e:1c:da via enp2s0
Feb  1 09:12:51 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0
Feb  1 09:12:51 srv4hai named[30406]: client @0x7f932c012aa0 192.168.12.252#42121/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-22.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb  1 09:12:51 srv4hai named[30406]: client @0x7f93300ede20 192.168.12.252#59695/key rndc-key: signer "rndc-key" approved
Feb  1 09:12:51 srv4hai named[30406]: client @0x7f93300ede20 192.168.12.252#59695/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' TXT
Feb  1 09:12:51 srv4hai named[30406]: client @0x7f93300ede20 192.168.12.252#59695/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' TXT "0051fce7ef7edfb3d29643aefa7bc5b7f2"
Feb  1 09:12:51 srv4hai named[30406]: client @0x7f93300ede20 192.168.12.252#59695/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' A
Feb  1 09:12:51 srv4hai named[30406]: client @0x7f93300ede20 192.168.12.252#59695/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' A 192.168.12.122
Feb  1 09:12:51 srv4hai dhcpd[4995]: Added new forward map from shelly-22.viehai.at to 192.168.12.122
Feb  1 09:12:51 srv4hai named[30406]: client @0x7f934c037ed0 192.168.12.252#42557/key rndc-key: signer "rndc-key" approved
Feb  1 09:12:51 srv4hai named[30406]: client @0x7f934c037ed0 192.168.12.252#42557/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '122.12.168.192.in-addr.arpa' PTR
Feb  1 09:12:51 srv4hai named[30406]: client @0x7f934c037ed0 192.168.12.252#42557/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '122.12.168.192.in-addr.arpa' PTR shelly-22.viehai.at.
Feb  1 09:12:51 srv4hai dhcpd[4995]: Added reverse map from 122.12.168.192.in-addr.arpa. to shelly-22.viehai.at
Feb  1 09:12:51 srv4hai common[22974]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Feb  1 09:12:51 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-22' - shIP/2:'' perform:'conf'
Feb  1 09:12:51 srv4hai common[22986]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:12:51 srv4hai common[23010]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:12:52 srv4hai mosquitto[29419]: New connection from 192.168.12.122 on port 1883.
Feb  1 09:12:52 srv4hai mosquitto[29419]: Client shelly1-98CDAC2E1CDA already connected, closing old connection.
Feb  1 09:12:52 srv4hai mosquitto[29419]: Socket error on client shelly1-98CDAC2E1CDA, disconnecting.
Feb  1 09:12:52 srv4hai mosquitto[29419]: New client connected from 192.168.12.122 as shelly1-98CDAC2E1CDA (c1, k60, u'shmqtt').
Feb  1 09:12:52 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-22' - shIP/2:'192.168.12.122'
Feb  1 09:12:52 srv4hai conf_shelly.sh: SHELLY: usage/name 'WC Licht' already set for '192.168.12.122'
Feb  1 09:12:52 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(0)' - allready transmitted - skipping
Feb  1 09:12:52 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(1)' - allready transmitted - skipping
Feb  1 09:12:52 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(2)' - allready transmitted - skipping
Feb  1 09:12:52 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(3)' - allready transmitted - skipping
Feb  1 09:12:52 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(4)' - allready transmitted - skipping
Feb  1 09:12:59 srv4hai bt_scan[22956]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Feb  1 09:12:59 srv4hai bt_scan[22956]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62'
Feb  1 09:12:59 srv4hai common[23152]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Feb  1 09:12:59 srv4hai ping_SP[23152]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Feb  1 09:12:59 srv4hai common[23173]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Feb  1 09:13:00 srv4hai common[23186]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb  1 09:13:00 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'1'=1738397580-1738397579
Feb  1 09:13:00 srv4hai check_presence[23173]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Feb  1 09:13:00 srv4hai check_presence[23173]: SHELLY (ping_SP__bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Feb  1 09:13:00 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'1'=1738397580-1738397579
Feb  1 09:13:00 srv4hai check_presence[23173]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY} and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Feb  1 09:13:00 srv4hai check_presence[23173]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Feb  1 09:13:00 srv4hai check_presence[23173]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_nasszeile_um) - sceneONsmall(vorraumOn)
Feb  1 09:13:00 srv4hai check_presence[23173]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn
Feb  1 09:13:00 srv4hai activate_scenario[23298]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Feb  1 09:13:00 srv4hai activate_scenario[23298]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1'

finished