activate_scenario.sh
Fri Mar 15 18:15:10 CET 2024
scenario: vorraumOn
phoneName: 1

'night' <--> 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/03/15/_0.log)

vorher: 18:15:11.010

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: 18:15:11.049
Dauer: 38 msec phName: 'phoneName:'1''


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

urls : 1
vorher : 18:15:10.984
nachher: 18:15:11.055
Dauer : 72 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/15//scene_vorraumOn_20240315_181510.txt'


syslog

Mar 15 18:12:00 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=41&temp=22.50&id=shellyht-00B358
Mar 15 18:12:00 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv'
Mar 15 18:12:00 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv' modifed 142s ago - EXIT
Mar 15 18:12:01 srv4hai CRON[14326]: (root) CMD (/etc/linetest/linetest.sh)
Mar 15 18:12:04 srv4hai fetchmail[1651]: 22270 messages (22269 seen) for mrozum at mail.akis.at (-443970668 octets).
Mar 15 18:12:04 srv4hai postfix/smtpd[14331]: connect from localhost[127.0.0.1]
Mar 15 18:12:04 srv4hai postfix/smtpd[14331]: 122D46011D: client=localhost[127.0.0.1]
Mar 15 18:12:04 srv4hai postfix/cleanup[14065]: 122D46011D: message-id=<5a9be9fd-7771-4248-9d4d-d7279e1d8de3@repclub.at>
Mar 15 18:12:05 srv4hai fetchmail[1651]: reading message mrozum@mail.akis.at:22270 of 22270 (3894028 octets) not flushed
Mar 15 18:12:05 srv4hai postfix/qmgr[15291]: 122D46011D: from=, size=3894308, nrcpt=1 (queue active)
Mar 15 18:12:05 srv4hai postfix/smtpd[14331]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Mar 15 18:12:05 srv4hai postfix/local[14067]: 122D46011D: to=, relay=local, delay=1.3, delays=1.3/0/0/0.03, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 15 18:12:05 srv4hai postfix/qmgr[15291]: 122D46011D: removed
Mar 15 18:12:05 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Mar 15 18:12:06 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=41&temp=22.50&id=shellyht-00B358
Mar 15 18:12:06 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv'
Mar 15 18:12:06 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv' modifed 148s ago - EXIT
Mar 15 18:12:11 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=41&temp=22.50&id=shellyht-00B358
Mar 15 18:12:11 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv'
Mar 15 18:12:11 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv' modifed 153s ago - EXIT
Mar 15 18:12:16 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=41&temp=22.50&id=shellyht-00B358
Mar 15 18:12:16 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv'
Mar 15 18:12:16 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv' modifed 158s ago - EXIT
Mar 15 18:12:21 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=41&temp=22.50&id=shellyht-00B358
Mar 15 18:12:21 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv'
Mar 15 18:12:21 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv' modifed 163s ago - EXIT
Mar 15 18:12:26 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=41&temp=22.50&id=shellyht-00B358
Mar 15 18:12:26 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv'
Mar 15 18:12:26 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv' modifed 168s ago - EXIT
Mar 15 18:12:28 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=14427, secured, session=
Mar 15 18:12:28 srv4hai dovecot: imap(miglincit)<14427>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 15 18:12:31 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=41&temp=22.50&id=shellyht-00B358
Mar 15 18:12:31 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv'
Mar 15 18:12:31 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv' modifed 173s ago - EXIT
Mar 15 18:12:36 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=41&temp=22.50&id=shellyht-00B358
Mar 15 18:12:36 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv'
Mar 15 18:12:36 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv' modifed 178s ago - EXIT
Mar 15 18:12:41 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=41&temp=22.50&id=shellyht-00B358
Mar 15 18:12:41 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv'
Mar 15 18:12:41 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/03/shelly-37_20240315.csv' modifed 183s ago - EXIT
Mar 15 18:12:58 srv4hai dhcpd[5037]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:12:58 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:13:00 srv4hai dhcpd[5037]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:13:00 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:13:01 srv4hai CRON[14485]: (root) CMD (/etc/linetest/linetest.sh)
Mar 15 18:13:45 srv4hai dhcpd[5037]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:13:45 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:13:47 srv4hai dhcpd[5037]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:13:47 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:13:51 srv4hai dhcpd[5037]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:13:51 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:14:01 srv4hai CRON[14502]: (root) CMD (/etc/linetest/linetest.sh)
Mar 15 18:14:05 srv4hai nmbd[30864]: [2024/03/15 18:14:05.725193,  0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
Mar 15 18:14:05 srv4hai nmbd[30864]:   find_domain_master_name_query_fail:
Mar 15 18:14:05 srv4hai nmbd[30864]:   Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
Mar 15 18:14:05 srv4hai nmbd[30864]:   Unable to sync browse lists in this workgroup.
Mar 15 18:14:07 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=14510, secured, session=<+1G5IrYT5tAAAAAAAAAAAAAAAAAAAAAB>
Mar 15 18:14:07 srv4hai dovecot: imap(miglincit)<14510><+1G5IrYT5tAAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 15 18:14:35 srv4hai activate_scenario[14513]: SHELLY scenario: 'LOG_kommen(log_kommen)' started
Mar 15 18:14:35 srv4hai activate_scenario[14513]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-03:'Licht Vorzimmer'
Mar 15 18:14:35 srv4hai activate_scenario[14513]: SHELLY scenario: 'LOG_kommen(log_kommen)' TO BE EXECUTED, shelly-03:'Licht Vorzimmer'
Mar 15 18:14:35 srv4hai activate_scenario[14513]: SHELLY scenario: 'LOG_kommen(log_kommen)' took 6 msec, shelly-03:'Licht Vorzimmer'
Mar 15 18:14:39 srv4hai dhcpd[5037]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:14:39 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:14:41 srv4hai dhcpd[5037]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:14:41 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:14:45 srv4hai dhcpd[5037]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:14:45 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:14:49 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 15 18:14:49 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.5
Mar 15 18:14:49 srv4hai dhcpd[5037]: execute_statement argv[2] = btscan1
Mar 15 18:14:49 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.5 (192.168.12.252) from 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:14:49 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Mar 15 18:14:49 srv4hai named[15509]: client @0x7f931c157870 192.168.12.252#37103/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: btscan1.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 15 18:14:49 srv4hai named[15509]: client @0x7f931c6302d0 192.168.12.252#33841/key rndc-key: signer "rndc-key" approved
Mar 15 18:14:49 srv4hai named[15509]: client @0x7f931c6302d0 192.168.12.252#33841/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' TXT
Mar 15 18:14:49 srv4hai named[15509]: client @0x7f931c6302d0 192.168.12.252#33841/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' TXT "000118916176265854cff71f762ffe0635"
Mar 15 18:14:49 srv4hai named[15509]: client @0x7f931c6302d0 192.168.12.252#33841/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' A
Mar 15 18:14:49 srv4hai named[15509]: client @0x7f931c6302d0 192.168.12.252#33841/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' A 192.168.12.5
Mar 15 18:14:49 srv4hai dhcpd[5037]: Added new forward map from btscan1.viehai.at to 192.168.12.5
Mar 15 18:14:49 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.5'(5) device 'btscan1'
Mar 15 18:14:49 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#59045/key rndc-key: signer "rndc-key" approved
Mar 15 18:14:49 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#59045/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '5.12.168.192.in-addr.arpa' PTR
Mar 15 18:14:49 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#59045/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '5.12.168.192.in-addr.arpa' PTR btscan1.viehai.at.
Mar 15 18:14:49 srv4hai dhcpd[5037]: Added reverse map from 5.12.168.192.in-addr.arpa. to btscan1.viehai.at
Mar 15 18:14:49 srv4hai dhcpcommit.sh: SHELLY device 'btscan1' known and accepted
Mar 15 18:15:00 srv4hai dhcpd[5037]: DHCPDISCOVER from f0:39:65:25:8d:c7 via enp2s0
Mar 15 18:15:00 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Mar 15 18:15:00 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Mar 15 18:15:00 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.62
Mar 15 18:15:00 srv4hai dhcpd[5037]: execute_statement argv[2] = GreteS20
Mar 15 18:15:00 srv4hai common[14588]: SHELLY common.sh inkludiert
Mar 15 18:15:00 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Mar 15 18:15:00 srv4hai common[14600]: SHELLY common.sh inkludiert
Mar 15 18:15:00 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Mar 15 18:15:00 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Mar 15 18:15:00 srv4hai named[15509]: client @0x7f931c6b5500 192.168.12.252#40363/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 15 18:15:00 srv4hai named[15509]: client @0x7f930c0a53a0 192.168.12.252#50203/key rndc-key: signer "rndc-key" approved
Mar 15 18:15:00 srv4hai named[15509]: client @0x7f930c0a53a0 192.168.12.252#50203/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Mar 15 18:15:00 srv4hai named[15509]: client @0x7f930c0a53a0 192.168.12.252#50203/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Mar 15 18:15:00 srv4hai named[15509]: client @0x7f930c0a53a0 192.168.12.252#50203/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Mar 15 18:15:00 srv4hai named[15509]: client @0x7f930c0a53a0 192.168.12.252#50203/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Mar 15 18:15:00 srv4hai dhcpd[5037]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Mar 15 18:15:00 srv4hai named[15509]: client @0x7f930c03c330 192.168.12.252#35737/key rndc-key: signer "rndc-key" approved
Mar 15 18:15:00 srv4hai named[15509]: client @0x7f930c03c330 192.168.12.252#35737/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Mar 15 18:15:00 srv4hai named[15509]: client @0x7f930c03c330 192.168.12.252#35737/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '62.12.168.192.in-addr.arpa' PTR GreteS20.viehai.at.
Mar 15 18:15:00 srv4hai dhcpd[5037]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Mar 15 18:15:00 srv4hai ping_SP[14600]: SHELLY ping_SP.sh started from smartphone
Mar 15 18:15:01 srv4hai CRON[14618]: (root) CMD (/etc/linetest/linetest.sh)
Mar 15 18:15:10 srv4hai common[14636]: SHELLY common.sh inkludiert
Mar 15 18:15:10 srv4hai check_presence[14636]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Mar 15 18:15:10 srv4hai check_presence[14636]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and /srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Mar 15 18:15:10 srv4hai check_presence[14636]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Mar 15 18:15:10 srv4hai check_presence[14636]: SHELLY (ping_SP__smartphone)-(1) what: 'coming' - persPresent: '(BT/__) (__/IP) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Mar 15 18:15:10 srv4hai check_presence[14636]: SHELLY (ping_SP__smartphone)-(1)-coming: activate_scenario.shtml: vorraumOn
Mar 15 18:15:10 srv4hai activate_scenario[14687]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Mar 15 18:15:10 srv4hai activate_scenario[14687]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'1'

finished