activate_scenario.sh
Wed Jan 29 22:25:19 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/29/_0.log)

vorher: 22:25:19.603

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:25:19.648
Dauer: 44 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 22:25:19.577
nachher: 22:25:19.654
Dauer : 78 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/29//scene_vorraumOn_20250129_222519.txt'


syslog

Jan 29 22:22:01 srv4hai CRON[32642]: (root) CMD (/etc/linetest/linetest.sh)
Jan 29 22:22:14 srv4hai postfix/smtpd[32462]: connect from unknown[193.32.162.97]
Jan 29 22:22:18 srv4hai postfix/smtpd[32462]: warning: unknown[193.32.162.97]: SASL PLAIN authentication failed: 
Jan 29 22:22:18 srv4hai postfix/smtpd[32462]: disconnect from unknown[193.32.162.97] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 29 22:22:30 srv4hai dhcpd[4995]: DHCPDISCOVER from c8:db:26:0c:f3:8e via enp2s0
Jan 29 22:22:30 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Jan 29 22:22:30 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Jan 29 22:22:30 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.28
Jan 29 22:22:30 srv4hai dhcpd[4995]: execute_statement argv[2] = harmonyhub
Jan 29 22:22:30 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.28 (192.168.12.252) from c8:db:26:0c:f3:8e via enp2s0
Jan 29 22:22:30 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Jan 29 22:22:30 srv4hai named[30406]: client @0x7f93506682d0 192.168.12.252#33235/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 29 22:22:30 srv4hai named[30406]: client @0x7f931c0a07f0 192.168.12.252#54671/key rndc-key: signer "rndc-key" approved
Jan 29 22:22:30 srv4hai named[30406]: client @0x7f931c0a07f0 192.168.12.252#54671/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Jan 29 22:22:30 srv4hai named[30406]: client @0x7f931c0a07f0 192.168.12.252#54671/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Jan 29 22:22:30 srv4hai named[30406]: client @0x7f931c0a07f0 192.168.12.252#54671/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Jan 29 22:22:30 srv4hai named[30406]: client @0x7f931c0a07f0 192.168.12.252#54671/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Jan 29 22:22:30 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Jan 29 22:22:30 srv4hai dhcpd[4995]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Jan 29 22:22:30 srv4hai named[30406]: client @0x7f93100b4de0 192.168.12.252#33527/key rndc-key: signer "rndc-key" approved
Jan 29 22:22:30 srv4hai named[30406]: client @0x7f93100b4de0 192.168.12.252#33527/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Jan 29 22:22:30 srv4hai named[30406]: client @0x7f93100b4de0 192.168.12.252#33527/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.
Jan 29 22:22:30 srv4hai dhcpd[4995]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Jan 29 22:22:30 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Jan 29 22:22:56 srv4hai common[32684]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:22:56 srv4hai common[32708]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:22:59 srv4hai common[32737]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:22:59 srv4hai common[32761]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:22:59 srv4hai common[320]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:23:01 srv4hai CRON[346]: (root) CMD (/etc/linetest/linetest.sh)
Jan 29 22:23:03 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=354, secured, session=
Jan 29 22:23:03 srv4hai dovecot: imap(miglincit)<354>: 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 29 22:23:03 srv4hai ping_SP[9165]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1738185783 - 'ping_SP_1'
Jan 29 22:23:03 srv4hai ping_SP[9165]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 29 22:23:06 srv4hai common[373]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 29 22:23:07 srv4hai ping_SP[14218]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1738185787 - 'ping_SP_0'
Jan 29 22:23:07 srv4hai ping_SP[14218]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 29 22:23:10 srv4hai postfix/smtpd[32462]: warning: hostname 23-94-59-160-host.colocrossing.com does not resolve to address 23.94.59.160: Name or service not known
Jan 29 22:23:10 srv4hai postfix/smtpd[32462]: connect from unknown[23.94.59.160]
Jan 29 22:23:14 srv4hai postfix/smtpd[32462]: warning: unknown[23.94.59.160]: SASL PLAIN authentication failed: 
Jan 29 22:23:14 srv4hai postfix/smtpd[32462]: disconnect from unknown[23.94.59.160] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 29 22:23:16 srv4hai bt_scan[373]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Jan 29 22:23:16 srv4hai bt_scan[373]: SHELLY - ping_SP.sh already running for BTmac: '1' - IPv4: '192.168.12.62'
Jan 29 22:23:56 srv4hai common[441]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:23:56 srv4hai common[467]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:23:59 srv4hai common[494]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:23:59 srv4hai common[518]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:24:00 srv4hai common[543]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:24:01 srv4hai CRON[568]: (root) CMD (/etc/linetest/linetest.sh)
Jan 29 22:24:17 srv4hai ping_SP[9165]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1738185857 - 'ping_SP_1'
Jan 29 22:24:17 srv4hai ping_SP[9165]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 29 22:24:20 srv4hai ping_SP[14218]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1738185860 - 'ping_SP_0'
Jan 29 22:24:20 srv4hai ping_SP[14218]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 29 22:24:56 srv4hai common[627]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:24:56 srv4hai common[651]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:24:57 srv4hai dhcpd[4995]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan 29 22:24:57 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 29 22:24:57 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 29 22:24:57 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 29 22:24:57 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 29 22:24:57 srv4hai common[675]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 29 22:24:59 srv4hai common[688]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:25:00 srv4hai common[712]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:25:00 srv4hai common[736]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 29 22:25:01 srv4hai CRON[762]: (root) CMD (/etc/linetest/linetest.sh)
Jan 29 22:25:08 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jan 29 22:25:08 srv4hai common[771]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 29 22:25:08 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 29 22:25:08 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 29 22:25:08 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 29 22:25:08 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 29 22:25:08 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 29 22:25:08 srv4hai common[784]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 29 22:25:08 srv4hai ping_SP[771]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jan 29 22:25:18 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jan 29 22:25:18 srv4hai common[823]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 29 22:25:18 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 29 22:25:18 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 29 22:25:18 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 29 22:25:18 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 29 22:25:18 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 29 22:25:18 srv4hai named[30406]: client @0x7f93100971e0 192.168.12.252#55515/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 29 22:25:18 srv4hai common[843]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 29 22:25:18 srv4hai common[847]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 29 22:25:18 srv4hai ping_SP[823]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jan 29 22:25:19 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'12'=1738185919-1738185907
Jan 29 22:25:19 srv4hai check_presence[843]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jan 29 22:25:19 srv4hai check_presence[843]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jan 29 22:25:19 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'12'=1738185919-1738185907
Jan 29 22:25:19 srv4hai check_presence[843]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jan 29 22:25:19 srv4hai check_presence[843]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jan 29 22:25:19 srv4hai check_presence[843]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (BT/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Jan 29 22:25:19 srv4hai check_presence[843]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_nasszeile_um) - sceneONsmall(vorraumOn)
Jan 29 22:25:19 srv4hai check_presence[843]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Jan 29 22:25:19 srv4hai activate_scenario[993]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jan 29 22:25:19 srv4hai activate_scenario[993]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished