activate_scenario.sh
Sun Aug 4 18:34:01 CEST 2024
scenario: vorraumOff
source: 192.168.12.125

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

scenario: 'Vorraum/Küche AUS-schalten' - 'vorraumOff' - 'vorraumoff'

Licht Vorzimmer (/srv/www/viehai/shelly/log_scenarios/2024/08/04/_0.log)

vorher: 18:34:01.636

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

nachher: 18:34:01.737
Dauer: 101 msec phName: 'shelly-25:'Küchenlicht''


Küche Licht Naßzeile (/srv/www/viehai/shelly/log_scenarios/2024/08/04/_1.log)

vorher: 18:34:01.649

http://192.168.12.116/white/0?turn=off&brightness=70
  "ison": false,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 70,
  "transition": 0,
  "power": 0,
  "overpower": false

nachher: 18:34:01.730
Dauer: 82 msec phName: 'shelly-25:'Küchenlicht''


Küche Licht Naßzeile (/srv/www/viehai/shelly/log_scenarios/2024/08/04/_2.log)

vorher: 18:34:01.661

http://192.168.12.116/white/1?turn=off&brightness=70
  "ison": false,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 70,
  "transition": 0,
  "power": 0,
  "overpower": false

nachher: 18:34:01.753
Dauer: 92 msec phName: 'shelly-25:'Küchenlicht''


Küche Licht Herdzeile (/srv/www/viehai/shelly/log_scenarios/2024/08/04/_3.log)

vorher: 18:34:01.674

http://192.168.12.117/white/0?turn=off&brightness=50
  "ison": false,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 50,
  "transition": 0,
  "power": 0,
  "overpower": false

nachher: 18:34:01.806
Dauer: 132 msec phName: 'shelly-25:'Küchenlicht''


Küche Licht Herdzeile (/srv/www/viehai/shelly/log_scenarios/2024/08/04/_4.log)

vorher: 18:34:01.687

http://192.168.12.117/white/1?turn=off&brightness=50
  "ison": false,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 50,
  "transition": 0,
  "power": 0,
  "overpower": false

nachher: 18:34:01.896
Dauer: 209 msec phName: 'shelly-25:'Küchenlicht''


WC (/srv/www/viehai/shelly/log_scenarios/2024/08/04/_5.log)

vorher: 18:34:01.700

http://192.168.12.122/relay/0?turn=off
  "ison": false,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "source": "http"

nachher: 18:34:01.782
Dauer: 83 msec phName: 'shelly-25:'Küchenlicht''


Küchenlicht (/srv/www/viehai/shelly/log_scenarios/2024/08/04/_6.log)

vorher: 18:34:01.712

http://192.168.12.125/relay/0?turn=off
  "ison": false,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "source": "http"

nachher: 18:34:01.795
Dauer: 83 msec phName: 'shelly-25:'Küchenlicht''


scenario: 'Vorraum/Küche AUS-schalten' - 'vorraumOff' - 'vorraumoff'

urls : 7
vorher : 18:34:01.615
nachher: 18:34:01.905
Dauer : 290 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/08/04//scene_vorraumOff_20240804_183401.txt'


syslog

Aug  4 18:31:01 srv4hai CRON[10879]: (root) CMD (/etc/linetest/linetest.sh)
Aug  4 18:31:44 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1722789103 - 'ping_SP_1'
Aug  4 18:31:44 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug  4 18:32:01 srv4hai CRON[10917]: (root) CMD (/etc/linetest/linetest.sh)
Aug  4 18:32:01 srv4hai common[10922]: SHELLY common.sh inkludiert von ./bt_scan.sh
Aug  4 18:32:11 srv4hai bt_scan[10922]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'No'
Aug  4 18:32:11 srv4hai bt_scan[10922]: SHELLY - lost BT-connection to BTmac: '1' found: 'No' - check presence
Aug  4 18:32:11 srv4hai common[10954]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug  4 18:32:12 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'4'=1722789132-1722789128
Aug  4 18:32:12 srv4hai check_presence[10954]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Aug  4 18:32:12 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'4'=1722789132-1722789128
Aug  4 18:32:12 srv4hai check_presence[10954]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Aug  4 18:32:12 srv4hai check_presence[10954]: SHELLY (bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Aug  4 18:32:12 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'4'=1722789132-1722789128
Aug  4 18:32:12 srv4hai check_presence[10954]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug  4 18:32:12 srv4hai check_presence[10954]: SHELLY (bt_scan)-(1) what: 'presence' - persPresent: '(BT/__) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug  4 18:32:12 srv4hai check_presence[10954]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_offAll) - sceneOFF(offAll)
Aug  4 18:32:12 srv4hai check_presence[10954]: SHELLY (bt_scan)-(1)-presence: NOT activate_scenario.shtml: offAll
Aug  4 18:32:34 srv4hai systemd[1]: Started Run anacron jobs.
Aug  4 18:32:34 srv4hai anacron[11111]: Anacron 2.3 started on 2024-08-04
Aug  4 18:32:34 srv4hai anacron[11111]: Normal exit (0 jobs run)
Aug  4 18:32:34 srv4hai systemd[1]: anacron.service: Succeeded.
Aug  4 18:32:36 srv4hai dhcpd[30731]: DHCPDISCOVER from 98:cd:ac:2e:1c:da via enp2s0
Aug  4 18:32:36 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0
Aug  4 18:32:36 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Aug  4 18:32:36 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.122
Aug  4 18:32:36 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-22
Aug  4 18:32:36 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.122 (192.168.12.252) from 98:cd:ac:2e:1c:da via enp2s0
Aug  4 18:32:36 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0
Aug  4 18:32:36 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#52519/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-22.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug  4 18:32:36 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#46869/key rndc-key: signer "rndc-key" approved
Aug  4 18:32:36 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#46869/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' TXT
Aug  4 18:32:36 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#46869/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' TXT "0051fce7ef7edfb3d29643aefa7bc5b7f2"
Aug  4 18:32:36 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#46869/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' A
Aug  4 18:32:36 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#46869/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' A 192.168.12.122
Aug  4 18:32:36 srv4hai dhcpd[30731]: Added new forward map from shelly-22.viehai.at to 192.168.12.122
Aug  4 18:32:36 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#43955/key rndc-key: signer "rndc-key" approved
Aug  4 18:32:36 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#43955/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '122.12.168.192.in-addr.arpa' PTR
Aug  4 18:32:36 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#43955/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.
Aug  4 18:32:36 srv4hai dhcpd[30731]: Added reverse map from 122.12.168.192.in-addr.arpa. to shelly-22.viehai.at
Aug  4 18:32:36 srv4hai common[11115]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Aug  4 18:32:36 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-22' - shIP/2:'' perform:'conf'
Aug  4 18:32:37 srv4hai mosquitto[18551]: New connection from 192.168.12.122 on port 1883.
Aug  4 18:32:37 srv4hai mosquitto[18551]: New client connected from 192.168.12.122 as shelly1-98CDAC2E1CDA (c1, k60, u'shmqtt').
Aug  4 18:32:37 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-22' - shIP/2:'192.168.12.122'
Aug  4 18:32:37 srv4hai conf_shelly.sh: SHELLY: usage/name 'WC' already set for '192.168.12.122'
Aug  4 18:32:37 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(0)' - allready transmitted - skipping
Aug  4 18:32:37 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(1)' - allready transmitted - skipping
Aug  4 18:32:37 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(2)' - allready transmitted - skipping
Aug  4 18:32:37 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(3)' - allready transmitted - skipping
Aug  4 18:32:37 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(4)' - allready transmitted - skipping
Aug  4 18:32:38 srv4hai conf_shelly.sh: SHELLY:'shelly-22' out:0 ON : MISSING
Aug  4 18:32:38 srv4hai conf_shelly.sh: SHELLY:'shelly-22' out:0 OFF: MISSING
Aug  4 18:32:57 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1722789177 - 'ping_SP_1'
Aug  4 18:32:57 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug  4 18:33:01 srv4hai CRON[11262]: (root) CMD (/etc/linetest/linetest.sh)
Aug  4 18:33:19 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=11276, secured, session=
Aug  4 18:33:19 srv4hai dovecot: imap(miglincit)<11276>: Logged out in=198 out=1285 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug  4 18:33:29 srv4hai postfix/smtpd[11279]: warning: database /etc/aliases.db is older than source file /etc/aliases
Aug  4 18:33:29 srv4hai postfix/smtpd[11281]: warning: database /etc/aliases.db is older than source file /etc/aliases
Aug  4 18:33:31 srv4hai named[30406]: connection refused resolving '156.92.94.80.in-addr.arpa/PTR/IN': 95.129.202.2#53
Aug  4 18:33:31 srv4hai named[30406]: connection refused resolving '151.92.94.80.in-addr.arpa/PTR/IN': 95.129.202.2#53
Aug  4 18:33:41 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24
Aug  4 18:33:41 srv4hai dhcpd[30731]: DHCPDISCOVER from ec:da:3b:c6:1d:3c via enp2s0
Aug  4 18:33:41 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Aug  4 18:33:41 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24
Aug  4 18:33:41 srv4hai dhcpd[30731]: DHCPDISCOVER from ec:da:3b:c6:1d:3c via enp2s0
Aug  4 18:33:41 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Aug  4 18:33:41 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24
Aug  4 18:33:41 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Aug  4 18:33:41 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.150
Aug  4 18:33:41 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-50
Aug  4 18:33:41 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.150 (192.168.12.252) from ec:da:3b:c6:1d:3c via enp2s0
Aug  4 18:33:41 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Aug  4 18:33:41 srv4hai named[30406]: client @0x7f9310079c50 192.168.12.252#39125/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-50.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug  4 18:33:41 srv4hai named[30406]: client @0x7f93100dab10 192.168.12.252#40183/key rndc-key: signer "rndc-key" approved
Aug  4 18:33:41 srv4hai named[30406]: client @0x7f93100dab10 192.168.12.252#40183/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' TXT
Aug  4 18:33:41 srv4hai named[30406]: client @0x7f93100dab10 192.168.12.252#40183/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' TXT "31ddfcf6e79cbbdf4e55e03247020075f9"
Aug  4 18:33:41 srv4hai named[30406]: client @0x7f93100dab10 192.168.12.252#40183/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' A
Aug  4 18:33:41 srv4hai named[30406]: client @0x7f93100dab10 192.168.12.252#40183/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' A 192.168.12.150
Aug  4 18:33:41 srv4hai dhcpd[30731]: Added new forward map from shelly-50.viehai.at to 192.168.12.150
Aug  4 18:33:41 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#44437/key rndc-key: signer "rndc-key" approved
Aug  4 18:33:41 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#44437/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '150.12.168.192.in-addr.arpa' PTR
Aug  4 18:33:41 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#44437/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '150.12.168.192.in-addr.arpa' PTR shelly-50.viehai.at.
Aug  4 18:33:41 srv4hai dhcpd[30731]: Added reverse map from 150.12.168.192.in-addr.arpa. to shelly-50.viehai.at
Aug  4 18:33:41 srv4hai common[11283]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Aug  4 18:33:41 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-50' - shIP/2:'' perform:'conf'
Aug  4 18:33:42 srv4hai mosquitto[18551]: New connection from 192.168.12.150 on port 1883.
Aug  4 18:33:42 srv4hai mosquitto[18551]: New client connected from 192.168.12.150 as shellypmminig3-ecda3bc61d3c (c1, k60, u'shmqtt').
Aug  4 18:33:42 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-50' - shIP/2:'192.168.12.150'
Aug  4 18:33:42 srv4hai conf_shelly.sh: SHELLY: usage/name '50-TBD' already set for '192.168.12.150'
Aug  4 18:33:42 srv4hai conf_shelly.sh: SHELLY:'shelly-50' no WebHook
Aug  4 18:33:42 srv4hai postfix/smtpd[11279]: connect from unknown[80.94.92.151]
Aug  4 18:33:42 srv4hai postfix/smtpd[11281]: connect from unknown[80.94.92.156]
Aug  4 18:33:46 srv4hai postfix/smtpd[11281]: warning: unknown[80.94.92.156]: SASL PLAIN authentication failed: 
Aug  4 18:33:46 srv4hai postfix/smtpd[11279]: warning: unknown[80.94.92.151]: SASL PLAIN authentication failed: 
Aug  4 18:33:46 srv4hai postfix/smtpd[11281]: disconnect from unknown[80.94.92.156] ehlo=1 auth=0/1 quit=1 commands=2/3
Aug  4 18:33:46 srv4hai postfix/smtpd[11279]: disconnect from unknown[80.94.92.151] ehlo=1 auth=0/1 quit=1 commands=2/3
Aug  4 18:34:01 srv4hai activate_scenario[11347]: SHELLY scenario: 'vorraumOff(vorraumoff)' started
Aug  4 18:34:01 srv4hai activate_scenario[11347]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-25:'Küchenlicht'

finished