activate_scenario.sh
Sat Apr 13 14:39:40 CEST 2024
scenario: vorraumOn
phoneName: 2

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

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

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

vorher: 14:39:40.852

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: 14:39:40.915
Dauer: 64 msec phName: 'phoneName:'2''


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

urls : 1
vorher : 14:39:40.832
nachher: 14:39:40.922
Dauer : 89 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/04/13//scene_vorraumOn_20240413_143940.txt'


syslog

Apr 13 14:36:01 srv4hai CRON[25584]: (root) CMD (/etc/linetest/linetest.sh)
Apr 13 14:36:03 srv4hai postfix/anvil[25444]: statistics: max connection rate 1/60s for (smtp:87.121.105.109) at Apr 13 14:32:43
Apr 13 14:36:03 srv4hai postfix/anvil[25444]: statistics: max connection count 1 for (smtp:87.121.105.109) at Apr 13 14:32:43
Apr 13 14:36:03 srv4hai postfix/anvil[25444]: statistics: max cache size 1 at Apr 13 14:32:43
Apr 13 14:36:08 srv4hai ping_SP[10075]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1713011768 - 'ping_SP_0'
Apr 13 14:36:08 srv4hai ping_SP[10075]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 13 14:36:09 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=25604, secured, session=
Apr 13 14:36:09 srv4hai dovecot: imap(miglincit)<25604>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 13 14:36:28 srv4hai ping_SP[22043]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1713011788 - 'ping_SP_1'
Apr 13 14:36:28 srv4hai ping_SP[22043]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 13 14:37:01 srv4hai CRON[25633]: (root) CMD (/etc/linetest/linetest.sh)
Apr 13 14:37:13 srv4hai dhcpd[28085]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Apr 13 14:37:13 srv4hai dhcpd[28085]: execute_statement argv[1] = 192.168.12.28
Apr 13 14:37:13 srv4hai dhcpd[28085]: execute_statement argv[2] = harmonyhub
Apr 13 14:37:13 srv4hai dhcpd[28085]: DHCPREQUEST for 192.168.12.28 from c8:db:26:0c:f3:8e via enp2s0
Apr 13 14:37:13 srv4hai dhcpd[28085]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Apr 13 14:37:13 srv4hai named[15509]: client @0x7f930801c730 192.168.12.252#39347/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 13 14:37:13 srv4hai named[15509]: client @0x7f931c6b5500 192.168.12.252#42213/key rndc-key: signer "rndc-key" approved
Apr 13 14:37:13 srv4hai named[15509]: client @0x7f931c6b5500 192.168.12.252#42213/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Apr 13 14:37:13 srv4hai named[15509]: client @0x7f931c6b5500 192.168.12.252#42213/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Apr 13 14:37:13 srv4hai named[15509]: client @0x7f931c6b5500 192.168.12.252#42213/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Apr 13 14:37:13 srv4hai named[15509]: client @0x7f931c6b5500 192.168.12.252#42213/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Apr 13 14:37:13 srv4hai dhcpd[28085]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Apr 13 14:37:13 srv4hai named[15509]: client @0x7f930808a950 192.168.12.252#53547/key rndc-key: signer "rndc-key" approved
Apr 13 14:37:13 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Apr 13 14:37:13 srv4hai named[15509]: client @0x7f930808a950 192.168.12.252#53547/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Apr 13 14:37:13 srv4hai named[15509]: client @0x7f930808a950 192.168.12.252#53547/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '28.12.168.192.in-addr.arpa' PTR harmonyhub.viehai.at.
Apr 13 14:37:13 srv4hai dhcpd[28085]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Apr 13 14:37:13 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Apr 13 14:37:15 srv4hai dhcpd[28085]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Apr 13 14:37:15 srv4hai dhcpd[28085]: execute_statement argv[1] = 192.168.12.28
Apr 13 14:37:15 srv4hai dhcpd[28085]: execute_statement argv[2] = harmonyhub
Apr 13 14:37:15 srv4hai dhcpd[28085]: DHCPREQUEST for 192.168.12.28 from c8:db:26:0c:f3:8e via enp2s0
Apr 13 14:37:15 srv4hai dhcpd[28085]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Apr 13 14:37:15 srv4hai named[15509]: client @0x7f931c6410a0 192.168.12.252#58581/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 13 14:37:15 srv4hai named[15509]: client @0x7f930805ddf0 192.168.12.252#49509/key rndc-key: signer "rndc-key" approved
Apr 13 14:37:15 srv4hai named[15509]: client @0x7f930805ddf0 192.168.12.252#49509/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Apr 13 14:37:15 srv4hai named[15509]: client @0x7f930805ddf0 192.168.12.252#49509/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Apr 13 14:37:15 srv4hai named[15509]: client @0x7f930805ddf0 192.168.12.252#49509/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Apr 13 14:37:15 srv4hai named[15509]: client @0x7f930805ddf0 192.168.12.252#49509/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Apr 13 14:37:15 srv4hai dhcpd[28085]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Apr 13 14:37:15 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Apr 13 14:37:15 srv4hai named[15509]: client @0x7f92fc030df0 192.168.12.252#42531/key rndc-key: signer "rndc-key" approved
Apr 13 14:37:15 srv4hai named[15509]: client @0x7f92fc030df0 192.168.12.252#42531/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Apr 13 14:37:15 srv4hai named[15509]: client @0x7f92fc030df0 192.168.12.252#42531/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '28.12.168.192.in-addr.arpa' PTR harmonyhub.viehai.at.
Apr 13 14:37:15 srv4hai dhcpd[28085]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Apr 13 14:37:15 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Apr 13 14:37:21 srv4hai ping_SP[10075]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1713011841 - 'ping_SP_0'
Apr 13 14:37:21 srv4hai ping_SP[10075]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 13 14:37:42 srv4hai ping_SP[22043]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1713011862 - 'ping_SP_1'
Apr 13 14:37:42 srv4hai ping_SP[22043]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 13 14:37:46 srv4hai postfix/smtpd[25692]: connect from unknown[87.121.105.109]
Apr 13 14:37:46 srv4hai postfix/smtpd[25692]: warning: unknown[87.121.105.109]: SASL LOGIN authentication failed: Invalid authentication mechanism
Apr 13 14:37:46 srv4hai postfix/smtpd[25692]: disconnect from unknown[87.121.105.109] ehlo=1 auth=0/1 quit=1 commands=2/3
Apr 13 14:38:01 srv4hai CRON[25699]: (root) CMD (/etc/linetest/linetest.sh)
Apr 13 14:38:34 srv4hai ping_SP[10075]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1713011914 - 'ping_SP_0'
Apr 13 14:38:34 srv4hai ping_SP[10075]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 13 14:38:53 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=25737, secured, session=
Apr 13 14:38:53 srv4hai dovecot: imap(miglincit)<25737>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 13 14:38:55 srv4hai ping_SP[22043]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1713011935 - 'ping_SP_1'
Apr 13 14:38:55 srv4hai ping_SP[22043]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 13 14:39:00 srv4hai systemd[1]: Starting Clean php session files...
Apr 13 14:39:00 srv4hai common[25753]: SHELLY common.sh inkludiert von ./bt_scan.sh
Apr 13 14:39:00 srv4hai systemd[1]: phpsessionclean.service: Succeeded.
Apr 13 14:39:00 srv4hai systemd[1]: Started Clean php session files.
Apr 13 14:39:01 srv4hai CRON[25857]: (root) CMD (/etc/linetest/linetest.sh)
Apr 13 14:39:01 srv4hai CRON[25858]: (root) CMD (  [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi)
Apr 13 14:39:09 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=25864, secured, session=
Apr 13 14:39:09 srv4hai dovecot: imap(miglincit)<25864>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 13 14:39:10 srv4hai bt_scan[25753]: SHELLY - who: 'Sophie' / phoneName: 'iP_Sophie' / '2' / shellyIP: '192.168.12.63' - found: 'No'
Apr 13 14:39:10 srv4hai bt_scan[25753]: SHELLY - lost BT-connection to BTmac: '2' found: 'No' - check presence
Apr 13 14:39:10 srv4hai common[25883]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Apr 13 14:39:10 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1713011950-1713011940
Apr 13 14:39:10 srv4hai check_presence[25883]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Apr 13 14:39:10 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'10'=1713011950-1713011940
Apr 13 14:39:10 srv4hai check_presence[25883]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Apr 13 14:39:10 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1713011950-1713011940
Apr 13 14:39:10 srv4hai check_presence[25883]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Apr 13 14:39:10 srv4hai check_presence[25883]: SHELLY (bt_scan)-(2) what: 'presence' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Apr 13 14:39:10 srv4hai check_presence[25883]: SHELLY (bt_scan)-(2)-presence: NOT activate_scenario.shtml: offAll
Apr 13 14:39:30 srv4hai common[26004]: SHELLY common.sh inkludiert von ./bt_scan.sh
Apr 13 14:39:40 srv4hai bt_scan[26004]: SHELLY - who: 'Sophie' / phoneName: 'iP_Sophie' / '2' / shellyIP: '192.168.12.63' - found: 'Yes'
Apr 13 14:39:40 srv4hai bt_scan[26004]: SHELLY - ping_SP.sh started for BTmac: '2' - IPv4: '192.168.12.63'
Apr 13 14:39:40 srv4hai common[26041]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Apr 13 14:39:40 srv4hai ping_SP[26041]: SHELLY ping_SP.sh started from bt_scan
Apr 13 14:39:40 srv4hai common[26059]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Apr 13 14:39:40 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1713011980-1713011970
Apr 13 14:39:40 srv4hai check_presence[26059]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Apr 13 14:39:40 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'10'=1713011980-1713011970
Apr 13 14:39:40 srv4hai check_presence[26059]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Apr 13 14:39:40 srv4hai common.sh: SHELLY: BTstatus[2]:'On' dweetAge:'10'=1713011980-1713011970
Apr 13 14:39:40 srv4hai check_presence[26059]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_2.Yes
Apr 13 14:39:40 srv4hai check_presence[26059]: SHELLY (ping_SP__bt_scan)-(2) what: 'coming' - persPresent: '(__/LIVE) (BT/LIVE) (BT/__)' - anyPresent: 'true' - otherPresent:'true'
Apr 13 14:39:40 srv4hai check_presence[26059]: SHELLY (ping_SP__bt_scan)-(2)-coming: activate_scenario.shtml: vorraumOn
Apr 13 14:39:40 srv4hai activate_scenario[26177]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Apr 13 14:39:40 srv4hai activate_scenario[26177]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'2'

finished