activate_scenario.sh
Fri Mar 8 18:23:48 CET 2024
scenario: LOG_kommen
source: 192.168.12.103

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

scenario: 'LOG_EIN' - 'LOG_kommen' - 'log_kommen'

scenario: 'LOG_EIN' - 'LOG_kommen' - 'log_kommen'

urls : 0
vorher : 18:23:48.718
nachher: 18:23:48.723
Dauer : 4 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/08//scene_LOG_kommen_20240308_182348.txt'


syslog

Mar  8 18:20:01 srv4hai CRON[30547]: (root) CMD (/etc/linetest/linetest.sh)
Mar  8 18:20:01 srv4hai CRON[30548]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Mar  8 18:20:01 srv4hai meter.sh: SHELLY meter.sh started
Mar  8 18:20:07 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:10 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:12 srv4hai meter.sh: SHELLY 'shelly-37/Wetter 1':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:15 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:17 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:20 srv4hai meter.sh: SHELLY 'shelly-58/Werkstatt Licht':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:23 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:25 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:28 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:30 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:33 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:35 srv4hai ping_SP[25292]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1709918435 - 'ping_SP_0'
Mar  8 18:20:35 srv4hai ping_SP[25292]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar  8 18:20:35 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:38 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:40 srv4hai meter.sh: SHELLY 'shelly-47/47-plus1-Test':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:43 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:46 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:48 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:51 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:53 srv4hai meter.sh: SHELLY 'shelly-43/43-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:56 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:57 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar  8 18:20:57 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.28
Mar  8 18:20:57 srv4hai dhcpd[5037]: execute_statement argv[2] = harmonyhub
Mar  8 18:20:57 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.28 from c8:db:26:0c:f3:8e via enp2s0
Mar  8 18:20:57 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Mar  8 18:20:57 srv4hai named[15509]: client @0x7f9314033170 192.168.12.252#48181/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar  8 18:20:57 srv4hai named[15509]: client @0x7f931c6410a0 192.168.12.252#53195/key rndc-key: signer "rndc-key" approved
Mar  8 18:20:57 srv4hai named[15509]: client @0x7f931c6410a0 192.168.12.252#53195/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Mar  8 18:20:57 srv4hai named[15509]: client @0x7f931c6410a0 192.168.12.252#53195/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Mar  8 18:20:57 srv4hai named[15509]: client @0x7f931c6410a0 192.168.12.252#53195/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Mar  8 18:20:57 srv4hai named[15509]: client @0x7f931c6410a0 192.168.12.252#53195/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Mar  8 18:20:57 srv4hai dhcpd[5037]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Mar  8 18:20:57 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Mar  8 18:20:57 srv4hai named[15509]: client @0x7f931c697a10 192.168.12.252#52643/key rndc-key: signer "rndc-key" approved
Mar  8 18:20:57 srv4hai named[15509]: client @0x7f931c697a10 192.168.12.252#52643/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Mar  8 18:20:57 srv4hai named[15509]: client @0x7f931c697a10 192.168.12.252#52643/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.
Mar  8 18:20:57 srv4hai dhcpd[5037]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Mar  8 18:20:57 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Mar  8 18:20:58 srv4hai meter.sh: SHELLY 'shelly-45/45-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  8 18:20:59 srv4hai meter.sh: SHELLY meter.sh ended
Mar  8 18:20:59 srv4hai postfix/pickup[24607]: 0B4DE602B8: uid=33 from=
Mar  8 18:20:59 srv4hai postfix/cleanup[31098]: 0B4DE602B8: message-id=<20240308172059.0B4DE602B8@mail.viehai.at>
Mar  8 18:20:59 srv4hai postfix/qmgr[15291]: 0B4DE602B8: from=, size=654, nrcpt=1 (queue active)
Mar  8 18:20:59 srv4hai postfix/local[31100]: 0B4DE602B8: to=, orig_to=, relay=local, delay=0.03, delays=0.02/0/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar  8 18:20:59 srv4hai postfix/qmgr[15291]: 0B4DE602B8: removed
Mar  8 18:21:01 srv4hai CRON[31103]: (root) CMD (/etc/linetest/linetest.sh)
Mar  8 18:21:06 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Mar  8 18:21:07 srv4hai fetchmail[1651]: 39524 messages (39524 seen) for tmiglinci at mail.akis.at (-1026027290 octets).
Mar  8 18:21:07 srv4hai fetchmail[1651]: 9981 messages (9981 seen) for srozum at mail.akis.at (1209953790 octets).
Mar  8 18:21:08 srv4hai fetchmail[1651]: 22119 messages (22119 seen) for mrozum at mail.akis.at (-475498256 octets).
Mar  8 18:21:08 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Mar  8 18:21:13 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=31111, secured, session=
Mar  8 18:21:13 srv4hai dovecot: imap(miglincit)<31111>: Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar  8 18:21:48 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar  8 18:21:48 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.28
Mar  8 18:21:48 srv4hai dhcpd[5037]: execute_statement argv[2] = harmonyhub
Mar  8 18:21:48 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.28 from c8:db:26:0c:f3:8e via enp2s0
Mar  8 18:21:48 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Mar  8 18:21:48 srv4hai named[15509]: client @0x7f93100a9530 192.168.12.252#51947/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar  8 18:21:48 srv4hai named[15509]: client @0x7f93180107e0 192.168.12.252#60497/key rndc-key: signer "rndc-key" approved
Mar  8 18:21:48 srv4hai named[15509]: client @0x7f93180107e0 192.168.12.252#60497/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Mar  8 18:21:48 srv4hai named[15509]: client @0x7f93180107e0 192.168.12.252#60497/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Mar  8 18:21:48 srv4hai named[15509]: client @0x7f93180107e0 192.168.12.252#60497/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Mar  8 18:21:48 srv4hai named[15509]: client @0x7f93180107e0 192.168.12.252#60497/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Mar  8 18:21:48 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Mar  8 18:21:48 srv4hai dhcpd[5037]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Mar  8 18:21:48 srv4hai named[15509]: client @0x7f931801e8a0 192.168.12.252#53511/key rndc-key: signer "rndc-key" approved
Mar  8 18:21:48 srv4hai named[15509]: client @0x7f931801e8a0 192.168.12.252#53511/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Mar  8 18:21:48 srv4hai named[15509]: client @0x7f931801e8a0 192.168.12.252#53511/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.
Mar  8 18:21:48 srv4hai dhcpd[5037]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Mar  8 18:21:48 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Mar  8 18:21:48 srv4hai ping_SP[25292]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1709918508 - 'ping_SP_0'
Mar  8 18:21:48 srv4hai ping_SP[25292]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar  8 18:22:01 srv4hai CRON[31142]: (root) CMD (/etc/linetest/linetest.sh)
Mar  8 18:22:14 srv4hai postfix/anvil[30475]: statistics: max connection rate 1/60s for (smtp:193.222.96.70) at Mar  8 18:17:43
Mar  8 18:22:14 srv4hai postfix/anvil[30475]: statistics: max connection count 1 for (smtp:193.222.96.70) at Mar  8 18:17:43
Mar  8 18:22:14 srv4hai postfix/anvil[30475]: statistics: max cache size 2 at Mar  8 18:18:37
Mar  8 18:22:29 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar  8 18:22:29 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.28
Mar  8 18:22:29 srv4hai dhcpd[5037]: execute_statement argv[2] = harmonyhub
Mar  8 18:22:29 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.28 from c8:db:26:0c:f3:8e via enp2s0
Mar  8 18:22:29 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Mar  8 18:22:29 srv4hai named[15509]: client @0x7f9314001390 192.168.12.252#42529/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar  8 18:22:29 srv4hai named[15509]: client @0x7f9318040aa0 192.168.12.252#34167/key rndc-key: signer "rndc-key" approved
Mar  8 18:22:29 srv4hai named[15509]: client @0x7f9318040aa0 192.168.12.252#34167/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Mar  8 18:22:29 srv4hai named[15509]: client @0x7f9318040aa0 192.168.12.252#34167/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Mar  8 18:22:29 srv4hai named[15509]: client @0x7f9318040aa0 192.168.12.252#34167/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Mar  8 18:22:29 srv4hai named[15509]: client @0x7f9318040aa0 192.168.12.252#34167/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Mar  8 18:22:29 srv4hai dhcpd[5037]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Mar  8 18:22:29 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Mar  8 18:22:29 srv4hai named[15509]: client @0x7f931c166000 192.168.12.252#46585/key rndc-key: signer "rndc-key" approved
Mar  8 18:22:29 srv4hai named[15509]: client @0x7f931c166000 192.168.12.252#46585/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Mar  8 18:22:29 srv4hai named[15509]: client @0x7f931c166000 192.168.12.252#46585/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.
Mar  8 18:22:29 srv4hai dhcpd[5037]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Mar  8 18:22:29 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Mar  8 18:22:49 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=31162, secured, session=
Mar  8 18:22:49 srv4hai dovecot: imap(miglincit)<31162>: Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar  8 18:23:01 srv4hai CRON[31168]: (root) CMD (/etc/linetest/linetest.sh)
Mar  8 18:23:01 srv4hai ping_SP[25292]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1709918581 - 'ping_SP_0'
Mar  8 18:23:01 srv4hai ping_SP[25292]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar  8 18:23:27 srv4hai postfix/smtpd[31191]: connect from unknown[193.222.96.70]
Mar  8 18:23:27 srv4hai postfix/smtpd[31191]: warning: unknown[193.222.96.70]: SASL LOGIN authentication failed: Invalid authentication mechanism
Mar  8 18:23:27 srv4hai postfix/smtpd[31191]: disconnect from unknown[193.222.96.70] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4
Mar  8 18:23:38 srv4hai common[31197]: SHELLY common.sh inkludiert
Mar  8 18:23:48 srv4hai bt_scan[31197]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / fixAddr: '192.168.12.62;' - found: 'Yes'
Mar  8 18:23:48 srv4hai bt_scan[31197]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62'
Mar  8 18:23:48 srv4hai common[31227]: SHELLY common.sh inkludiert
Mar  8 18:23:48 srv4hai ping_SP[31227]: SHELLY ping_SP.sh started from bt_scan
Mar  8 18:23:48 srv4hai common[31237]: SHELLY common.sh inkludiert
Mar  8 18:23:48 srv4hai check_presence[31237]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and /srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Mar  8 18:23:48 srv4hai check_presence[31237]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Mar  8 18:23:48 srv4hai check_presence[31237]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Mar  8 18:23:48 srv4hai check_presence[31237]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(__/IP) (BT/__) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Mar  8 18:23:48 srv4hai check_presence[31237]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn
Mar  8 18:23:48 srv4hai activate_scenario[31288]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Mar  8 18:23:48 srv4hai activate_scenario[31288]: SHELLY dayState='night' <--> DayTime=unchecked NightTime=checked - phoneName:'1'
Mar  8 18:23:48 srv4hai activate_scenario[31288]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'1'
Mar  8 18:23:48 srv4hai postfix/pickup[24607]: 74617602B8: uid=33 from=
Mar  8 18:23:48 srv4hai postfix/cleanup[31338]: 74617602B8: message-id=<20240308172348.74617602B8@mail.viehai.at>
Mar  8 18:23:48 srv4hai postfix/qmgr[15291]: 74617602B8: from=, size=16223, nrcpt=1 (queue active)
Mar  8 18:23:48 srv4hai activate_scenario[31288]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Mar  8 18:23:48 srv4hai proc_url[31355]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/03/08/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'1''
Mar  8 18:23:48 srv4hai activate_scenario[31288]: SHELLY scenario: 'vorraumOn(vorraumon)' took 178 msec, phoneName:'1'
Mar  8 18:23:48 srv4hai ping_SP[31227]: SHELLY check_presence.sh coming 1 ping_SP__bt_scan
Mar  8 18:23:48 srv4hai activate_scenario[31380]: SHELLY scenario: 'LOG_kommen(log_kommen)' started
Mar  8 18:23:48 srv4hai activate_scenario[31380]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-03:'Licht Vorzimmer'

finished