activate_scenario.sh
Tue Sep 3 21:27:37 CEST 2024
scenario: vorraumOn
phoneName: 0

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

vorher: 21:27:38.044

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: 21:27:38.162
Dauer: 119 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 21:27:38.013
nachher: 21:27:38.170
Dauer : 159 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/09/03//scene_vorraumOn_20240903_212737.txt'


syslog

Sep  3 21:24:01 srv4hai CRON[4879]: (root) CMD (/etc/linetest/linetest.sh)
Sep  3 21:24:14 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:14 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:16 srv4hai postfix/smtp[4779]: connect to prtimes.jp[151.101.193.55]:25: Connection timed out
Sep  3 21:24:16 srv4hai postfix/smtp[4779]: B33676345C: to=, relay=none, delay=309326, delays=309206/0.01/120/0, dsn=4.4.1, status=deferred (connect to prtimes.jp[151.101.193.55]:25: Connection timed out)
Sep  3 21:24:18 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:18 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:18 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Sep  3 21:24:18 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.5
Sep  3 21:24:18 srv4hai dhcpd[30731]: execute_statement argv[2] = btscan1
Sep  3 21:24:18 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.5 (192.168.12.252) from 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:18 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:18 srv4hai named[30406]: client @0x7f93300df020 192.168.12.252#56903/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: btscan1.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Sep  3 21:24:18 srv4hai named[30406]: client @0x7f933011a820 192.168.12.252#42233/key rndc-key: signer "rndc-key" approved
Sep  3 21:24:18 srv4hai named[30406]: client @0x7f933011a820 192.168.12.252#42233/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' TXT
Sep  3 21:24:18 srv4hai named[30406]: client @0x7f933011a820 192.168.12.252#42233/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' TXT "000118916176265854cff71f762ffe0635"
Sep  3 21:24:18 srv4hai named[30406]: client @0x7f933011a820 192.168.12.252#42233/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' A
Sep  3 21:24:18 srv4hai named[30406]: client @0x7f933011a820 192.168.12.252#42233/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' A 192.168.12.5
Sep  3 21:24:18 srv4hai dhcpd[30731]: Added new forward map from btscan1.viehai.at to 192.168.12.5
Sep  3 21:24:18 srv4hai named[30406]: client @0x7f93480ae320 192.168.12.252#56015/key rndc-key: signer "rndc-key" approved
Sep  3 21:24:18 srv4hai named[30406]: client @0x7f93480ae320 192.168.12.252#56015/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '5.12.168.192.in-addr.arpa' PTR
Sep  3 21:24:18 srv4hai named[30406]: client @0x7f93480ae320 192.168.12.252#56015/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.
Sep  3 21:24:18 srv4hai dhcpd[30731]: Added reverse map from 5.12.168.192.in-addr.arpa. to btscan1.viehai.at
Sep  3 21:24:18 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.5'(5) device 'btscan1'
Sep  3 21:24:18 srv4hai dhcpcommit.sh: SHELLY device 'btscan1' known and accepted
Sep  3 21:24:44 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:44 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:45 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:45 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:45 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Sep  3 21:24:45 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.5
Sep  3 21:24:45 srv4hai dhcpd[30731]: execute_statement argv[2] = btscan1
Sep  3 21:24:45 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.5 (192.168.12.252) from 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:45 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:24:45 srv4hai named[30406]: client @0x7f935013a950 192.168.12.252#41879/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: btscan1.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Sep  3 21:24:45 srv4hai named[30406]: client @0x7f93506e3340 192.168.12.252#50605/key rndc-key: signer "rndc-key" approved
Sep  3 21:24:45 srv4hai named[30406]: client @0x7f93506e3340 192.168.12.252#50605/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' TXT
Sep  3 21:24:45 srv4hai named[30406]: client @0x7f93506e3340 192.168.12.252#50605/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' TXT "000118916176265854cff71f762ffe0635"
Sep  3 21:24:45 srv4hai named[30406]: client @0x7f93506e3340 192.168.12.252#50605/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' A
Sep  3 21:24:45 srv4hai named[30406]: client @0x7f93506e3340 192.168.12.252#50605/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' A 192.168.12.5
Sep  3 21:24:45 srv4hai dhcpd[30731]: Added new forward map from btscan1.viehai.at to 192.168.12.5
Sep  3 21:24:45 srv4hai named[30406]: client @0x7f93100d8ab0 192.168.12.252#53273/key rndc-key: signer "rndc-key" approved
Sep  3 21:24:45 srv4hai named[30406]: client @0x7f93100d8ab0 192.168.12.252#53273/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '5.12.168.192.in-addr.arpa' PTR
Sep  3 21:24:45 srv4hai named[30406]: client @0x7f93100d8ab0 192.168.12.252#53273/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.
Sep  3 21:24:45 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.5'(5) device 'btscan1'
Sep  3 21:24:45 srv4hai dhcpd[30731]: Added reverse map from 5.12.168.192.in-addr.arpa. to btscan1.viehai.at
Sep  3 21:24:45 srv4hai dhcpcommit.sh: SHELLY device 'btscan1' known and accepted
Sep  3 21:25:01 srv4hai CRON[4937]: (root) CMD (/etc/linetest/linetest.sh)
Sep  3 21:26:01 srv4hai CRON[4986]: (root) CMD (/etc/linetest/linetest.sh)
Sep  3 21:26:27 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=5008, secured, session=<4RWwCDwh5rcAAAAAAAAAAAAAAAAAAAAB>
Sep  3 21:26:27 srv4hai dovecot: imap(miglincit)<5008><4RWwCDwh5rcAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Sep  3 21:26:34 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Sep  3 21:26:35 srv4hai fetchmail[1651]: 51490 messages (51490 seen) for tmiglinci at mail.akis.at (-49132751 octets).
Sep  3 21:26:35 srv4hai fetchmail[1651]: 10669 messages (10669 seen) for srozum at mail.akis.at (1287485929 octets).
Sep  3 21:26:36 srv4hai fetchmail[1651]: 25696 messages (25696 seen) for mrozum at mail.akis.at (183430370 octets).
Sep  3 21:26:36 srv4hai fetchmail[1651]: 1141 messages (1141 seen) for admin@bastelstube.wien at pop3.world4you.com (51598561 octets).
Sep  3 21:26:52 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:26:52 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:26:53 srv4hai nmbd[2172]: [2024/09/03 21:26:53.941830,  0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
Sep  3 21:26:53 srv4hai nmbd[2172]:   find_domain_master_name_query_fail:
Sep  3 21:26:53 srv4hai nmbd[2172]:   Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
Sep  3 21:26:53 srv4hai nmbd[2172]:   Unable to sync browse lists in this workgroup.
Sep  3 21:26:54 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:26:54 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:26:57 srv4hai postfix/anvil[4851]: statistics: max connection rate 1/60s for (smtp:94.141.120.77) at Sep  3 21:23:36
Sep  3 21:26:57 srv4hai postfix/anvil[4851]: statistics: max connection count 1 for (smtp:94.141.120.77) at Sep  3 21:23:36
Sep  3 21:26:57 srv4hai postfix/anvil[4851]: statistics: max cache size 1 at Sep  3 21:23:36
Sep  3 21:26:58 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:26:58 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:27:01 srv4hai CRON[5037]: (root) CMD (/etc/linetest/linetest.sh)
Sep  3 21:27:06 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:27:06 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Sep  3 21:27:27 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Sep  3 21:27:27 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Sep  3 21:27:27 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Sep  3 21:27:27 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Sep  3 21:27:27 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Sep  3 21:27:27 srv4hai common[5059]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Sep  3 21:27:27 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Sep  3 21:27:27 srv4hai common[5073]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Sep  3 21:27:27 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Sep  3 21:27:27 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Sep  3 21:27:27 srv4hai named[30406]: client @0x7f93300d0220 192.168.12.252#44809/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Sep  3 21:27:27 srv4hai named[30406]: client @0x7f9350694cd0 192.168.12.252#48303/key rndc-key: signer "rndc-key" approved
Sep  3 21:27:27 srv4hai named[30406]: client @0x7f9350694cd0 192.168.12.252#48303/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Sep  3 21:27:27 srv4hai named[30406]: client @0x7f9350694cd0 192.168.12.252#48303/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Sep  3 21:27:27 srv4hai named[30406]: client @0x7f9350694cd0 192.168.12.252#48303/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Sep  3 21:27:27 srv4hai named[30406]: client @0x7f9350694cd0 192.168.12.252#48303/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Sep  3 21:27:27 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Sep  3 21:27:27 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#40017/key rndc-key: signer "rndc-key" approved
Sep  3 21:27:27 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#40017/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Sep  3 21:27:27 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#40017/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Sep  3 21:27:27 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Sep  3 21:27:27 srv4hai ping_SP[5073]: SHELLY ping_SP.sh started from smartphone, user:'root'
Sep  3 21:27:37 srv4hai common[5111]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Sep  3 21:27:37 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_older_60sec' dweetAge:'99'=1725391657-1725391558
Sep  3 21:27:37 srv4hai check_presence[5111]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Sep  3 21:27:37 srv4hai check_presence[5111]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Sep  3 21:27:37 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_older_60sec' dweetAge:'99'=1725391657-1725391558
Sep  3 21:27:37 srv4hai check_presence[5111]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Sep  3 21:27:37 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_older_60sec' dweetAge:'99'=1725391657-1725391558
Sep  3 21:27:37 srv4hai check_presence[5111]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Sep  3 21:27:37 srv4hai check_presence[5111]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Sep  3 21:27:37 srv4hai check_presence[5111]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
Sep  3 21:27:37 srv4hai check_presence[5111]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Sep  3 21:27:37 srv4hai activate_scenario[5249]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Sep  3 21:27:37 srv4hai activate_scenario[5249]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished