activate_scenario.sh
Sat Jan 11 22:02:45 CET 2025
scenario: vorraumOn
phoneName: 0

'night' <--> 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/01/11/_0.log)

vorher: 22:02:45.804

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: 22:02:45.914
Dauer: 109 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 22:02:45.773
nachher: 22:02:45.920
Dauer : 147 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/11//scene_vorraumOn_20250111_220245.txt'


syslog

Jan 11 21:59:01 srv4hai CRON[23552]: (root) CMD (/etc/linetest/linetest.sh)
Jan 11 21:59:23 srv4hai ping_SP[11828]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1736629163 - 'ping_SP_1'
Jan 11 21:59:23 srv4hai ping_SP[11828]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 11 21:59:36 srv4hai named[30406]: resolver priming query complete
Jan 11 22:00:01 srv4hai postfix/smtpd[23595]: connect from unknown[94.156.227.127]
Jan 11 22:00:01 srv4hai postfix/smtpd[23595]: warning: unknown[94.156.227.127]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jan 11 22:00:01 srv4hai postfix/smtpd[23595]: disconnect from unknown[94.156.227.127] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 11 22:00:01 srv4hai CRON[23599]: (root) CMD (/etc/linetest/linetest.sh)
Jan 11 22:00:01 srv4hai CRON[23600]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Jan 11 22:00:01 srv4hai common[23601]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/meter.sh
Jan 11 22:00:01 srv4hai meter.sh: SHELLY meter.sh started
Jan 11 22:00:02 srv4hai meter.sh: SHELLY 'shelly-29/KÜ Schalter Herdzeile' - type: 'shelly-i3' ignoring
Jan 11 22:00:02 srv4hai meter.sh: SHELLY 'shelly-28/KÜ Schalter Nasszeile' - type: 'shelly-i3' ignoring
Jan 11 22:00:06 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster' - type: 'shelly-BTN' ignoring
Jan 11 22:00:06 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter' - type: 'shelly-BTN' ignoring
Jan 11 22:00:06 srv4hai meter.sh: SHELLY 'shelly-37/TB Klima' - type: 'shelly-ht' ignoring
Jan 11 22:00:06 srv4hai ping_SP[19866]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1736629206 - 'ping_SP_0'
Jan 11 22:00:06 srv4hai ping_SP[19866]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 11 22:00:06 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen' - status: 'OOS' ignoring
Jan 11 22:00:06 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon' - type: 'shelly-ht-plus' ignoring
Jan 11 22:00:09 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD' - status: 'OOS' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3' - status: 'OOS' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD' - status: 'OOS' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD' - status: 'OOS' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD' - status: 'OOS' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-09a/Inbetriebnahme - 20210720 - Defekt' - status: 'defect' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-09b/Sophie Licht - 20230404 - Defekt' - status: 'defect' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN' - status: 'defect' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417' - status: 'defect' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem' - status: 'defect' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722' - status: 'defect' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-01a/WZ Licht Esstisch - 20241208 kein WLAN' - status: 'DFC' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-43/43-tbd' - status: 'OOS' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD' - status: 'OOS' ignoring
Jan 11 22:00:12 srv4hai meter.sh: SHELLY 'shelly-46/46-TBD' - status: 'OOS' ignoring
Jan 11 22:00:15 srv4hai meter.sh: SHELLY 'shelly-50/50-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Jan 11 22:00:15 srv4hai meter.sh: SHELLY 'shelly-59/Werkstatt Schalter Kellertür' - type: 'shelly-i3' ignoring
Jan 11 22:00:16 srv4hai common[24615]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_shelly.sh
Jan 11 22:00:16 srv4hai check_shelly.sh: SHELLY last scenery executed: 'vorraumOn'
Jan 11 22:00:16 srv4hai check_shelly.sh: SHELLY found '3' active shelly outputs
Jan 11 22:00:16 srv4hai meter.sh: SHELLY meter.sh ended
Jan 11 22:00:34 srv4hai named[30406]: resolver priming query complete
Jan 11 22:00:37 srv4hai ping_SP[11828]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1736629237 - 'ping_SP_1'
Jan 11 22:00:37 srv4hai ping_SP[11828]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 11 22:00:40 srv4hai named[30406]: resolver priming query complete
Jan 11 22:00:45 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=24664, secured, session=
Jan 11 22:00:45 srv4hai dovecot: imap(miglincit)<24664>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 11 22:00:47 srv4hai named[30406]: resolver priming query complete
Jan 11 22:01:01 srv4hai CRON[24672]: (root) CMD (/etc/linetest/linetest.sh)
Jan 11 22:01:08 srv4hai named[30406]: resolver priming query complete
Jan 11 22:01:19 srv4hai ping_SP[19866]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1736629279 - 'ping_SP_0'
Jan 11 22:01:19 srv4hai ping_SP[19866]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 11 22:01:44 srv4hai named[30406]: resolver priming query complete
Jan 11 22:01:49 srv4hai activate_scenario[24710]: SHELLY last scenario: 'vorraumOn' @ '213757' from 'scene_vorraumOn_20250111_213757.txt' - delta=8
Jan 11 22:01:49 srv4hai activate_scenario[24710]:        dateutils.ddiff -i '%Y%m%d%H%M%s' 20250111220149 20250111213757  -f '%S'
Jan 11 22:01:49 srv4hai activate_scenario[24710]: SHELLY  new scenario: 'bedlight_tom' different - GO ON
Jan 11 22:01:49 srv4hai activate_scenario[24710]: SHELLY scenario: 'bedlight_tom(bedlight_tom)' started
Jan 11 22:01:49 srv4hai activate_scenario[24710]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-12:'SZ Licht'
Jan 11 22:01:49 srv4hai activate_scenario[24710]: SHELLY scenario: 'bedlight_tom(bedlight_tom)' TO BE EXECUTED, shelly-12:'SZ Licht'
Jan 11 22:01:49 srv4hai postfix/pickup[16780]: AA80D63463: uid=33 from=
Jan 11 22:01:49 srv4hai postfix/cleanup[24775]: AA80D63463: message-id=<20250111210149.AA80D63463@mail.viehai.at>
Jan 11 22:01:49 srv4hai postfix/qmgr[8566]: AA80D63463: from=, size=10383, nrcpt=1 (queue active)
Jan 11 22:01:49 srv4hai activate_scenario[24710]: SHELLY: scenario: 'bedlight_tom(bedlight_tom)'-'shelly-07'-'SZ Nachtkästchen Thomas' --> '0?turn=toggle'
Jan 11 22:01:49 srv4hai proc_url[24793]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/11/_0.log' - shellyUsage:'SZ Nachtkästchen Thomas' - scUrl:'http://192.168.12.107/relay/0?turn=toggle' - phName:'shelly-12:'SZ Licht''
Jan 11 22:01:49 srv4hai postfix/local[24788]: AA80D63463: to=, orig_to=, relay=local, delay=0.04, delays=0.02/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 11 22:01:49 srv4hai postfix/cleanup[24775]: B12D263464: message-id=<20250111210149.B12D263464@mail.viehai.at>
Jan 11 22:01:49 srv4hai postfix/bounce[24789]: AA80D63463: sender non-delivery notification: B12D263464
Jan 11 22:01:49 srv4hai postfix/qmgr[8566]: B12D263464: from=<>, size=12262, nrcpt=1 (queue active)
Jan 11 22:01:49 srv4hai postfix/qmgr[8566]: AA80D63463: removed
Jan 11 22:01:49 srv4hai postfix/local[24788]: B12D263464: to=, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 11 22:01:49 srv4hai postfix/qmgr[8566]: B12D263464: removed
Jan 11 22:01:49 srv4hai activate_scenario[24710]: SHELLY scenario: 'bedlight_tom(bedlight_tom)' took 129 msec, shelly-12:'SZ Licht'
Jan 11 22:01:50 srv4hai ping_SP[11828]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1736629310 - 'ping_SP_1'
Jan 11 22:01:50 srv4hai ping_SP[11828]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 11 22:02:01 srv4hai CRON[24838]: (root) CMD (/etc/linetest/linetest.sh)
Jan 11 22:02:16 srv4hai common[24845]: SHELLY common.sh inkludiert von ./shelly/check_shelly.sh
Jan 11 22:02:16 srv4hai check_shelly.sh: SHELLY last scenery executed: 'bedlight_tom'
Jan 11 22:02:16 srv4hai check_shelly.sh: SHELLY found '4' active shelly outputs
Jan 11 22:02:16 srv4hai common[24868]: SHELLY common.sh inkludiert von ./shelly/prep_viehai.sh
Jan 11 22:02:17 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'8'=1736629337-1736629329
Jan 11 22:02:17 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'8'=1736629337-1736629329
Jan 11 22:02:24 srv4hai dhcpd[4995]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan 11 22:02:24 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 11 22:02:24 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 11 22:02:24 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 11 22:02:24 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 11 22:02:24 srv4hai common[24931]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 11 22:02:33 srv4hai common[24947]: SHELLY common.sh inkludiert von ./shelly/check_shelly.sh
Jan 11 22:02:33 srv4hai check_shelly.sh: SHELLY last scenery executed: 'bedlight_tom'
Jan 11 22:02:33 srv4hai check_shelly.sh: SHELLY found '4' active shelly outputs
Jan 11 22:02:33 srv4hai common[24970]: SHELLY common.sh inkludiert von ./shelly/prep_viehai.sh
Jan 11 22:02:33 srv4hai ping_SP[19866]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1736629353 - 'ping_SP_0'
Jan 11 22:02:33 srv4hai ping_SP[19866]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 11 22:02:34 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'1'=1736629354-1736629353
Jan 11 22:02:34 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'1'=1736629354-1736629353
Jan 11 22:02:34 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jan 11 22:02:34 srv4hai common[25035]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 11 22:02:34 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 11 22:02:34 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 11 22:02:34 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 11 22:02:34 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 11 22:02:34 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 11 22:02:34 srv4hai common[25048]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 11 22:02:34 srv4hai ping_SP[25035]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jan 11 22:02:35 srv4hai named[30406]: resolver priming query complete
Jan 11 22:02:44 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jan 11 22:02:44 srv4hai common[25077]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 11 22:02:44 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 11 22:02:44 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 11 22:02:44 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 11 22:02:44 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 11 22:02:44 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 11 22:02:44 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#44443/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 11 22:02:44 srv4hai common[25094]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 11 22:02:44 srv4hai common[25097]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 11 22:02:45 srv4hai ping_SP[25077]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jan 11 22:02:45 srv4hai named[30406]: resolver priming query complete
Jan 11 22:02:45 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'0'=1736629365-1736629365
Jan 11 22:02:45 srv4hai check_presence[25094]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jan 11 22:02:45 srv4hai check_presence[25094]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jan 11 22:02:45 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'0'=1736629365-1736629365
Jan 11 22:02:45 srv4hai check_presence[25094]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jan 11 22:02:45 srv4hai check_presence[25094]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jan 11 22:02:45 srv4hai check_presence[25094]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Jan 11 22:02:45 srv4hai check_presence[25094]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_bedlight_tom) - sceneONsmall(vorraumOn)
Jan 11 22:02:45 srv4hai check_presence[25094]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Jan 11 22:02:45 srv4hai activate_scenario[25219]: SHELLY last scenario: 'bedlight_tom' @ '220149' from 'scene_bedlight_tom_20250111_220149.txt' - delta=4
Jan 11 22:02:45 srv4hai activate_scenario[25219]:        dateutils.ddiff -i '%Y%m%d%H%M%s' 20250111220245 20250111220149  -f '%S'
Jan 11 22:02:45 srv4hai activate_scenario[25219]: SHELLY  new scenario: 'vorraumOn' different - GO ON
Jan 11 22:02:45 srv4hai activate_scenario[25219]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jan 11 22:02:45 srv4hai activate_scenario[25219]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished