activate_scenario.sh
Mon Jul 29 17:57:53 CEST 2024
scenario: vorraumOn
phoneName: 1

'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/07/29/_0.log)

vorher: 17:57:53.249

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: 17:57:53.368
Dauer: 119 msec phName: 'phoneName:'1''


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

urls : 1
vorher : 17:57:53.230
nachher: 17:57:53.374
Dauer : 144 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/07/29//scene_vorraumOn_20240729_175753.txt'


syslog

Jul 29 17:54:01 srv4hai CRON[2861]: (root) CMD (/etc/linetest/linetest.sh)
Jul 29 17:54:08 srv4hai common[2867]: SHELLY common.sh inkludiert von ./inventar.sh
Jul 29 17:54:10 srv4hai common[2883]: SHELLY common.sh inkludiert von ./inventar.sh
Jul 29 17:54:27 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24
Jul 29 17:54:27 srv4hai dhcpd[30731]: DHCPDISCOVER from ec:da:3b:c6:1d:3c via enp2s0
Jul 29 17:54:27 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Jul 29 17:54:27 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24
Jul 29 17:54:27 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jul 29 17:54:27 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.150
Jul 29 17:54:27 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-50
Jul 29 17:54:27 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.150 (192.168.12.252) from ec:da:3b:c6:1d:3c via enp2s0
Jul 29 17:54:27 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Jul 29 17:54:27 srv4hai named[30406]: client @0x7f9310079c50 192.168.12.252#57955/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-50.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#46573/key rndc-key: signer "rndc-key" approved
Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#46573/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' TXT
Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#46573/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' TXT "31ddfcf6e79cbbdf4e55e03247020075f9"
Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#46573/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' A
Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#46573/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' A 192.168.12.150
Jul 29 17:54:27 srv4hai dhcpd[30731]: Added new forward map from shelly-50.viehai.at to 192.168.12.150
Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933805ba90 192.168.12.252#41575/key rndc-key: signer "rndc-key" approved
Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933805ba90 192.168.12.252#41575/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '150.12.168.192.in-addr.arpa' PTR
Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933805ba90 192.168.12.252#41575/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '150.12.168.192.in-addr.arpa' PTR shelly-50.viehai.at.
Jul 29 17:54:27 srv4hai dhcpd[30731]: Added reverse map from 150.12.168.192.in-addr.arpa. to shelly-50.viehai.at
Jul 29 17:54:27 srv4hai common[2907]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jul 29 17:54:27 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-50' - shIP/2:'' perform:'conf'
Jul 29 17:54:27 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-50' - shIP/2:'192.168.12.150'
Jul 29 17:54:27 srv4hai mosquitto[18551]: New connection from 192.168.12.150 on port 1883.
Jul 29 17:54:27 srv4hai mosquitto[18551]: Client shellypmminig3-ecda3bc61d3c already connected, closing old connection.
Jul 29 17:54:27 srv4hai mosquitto[18551]: Socket error on client shellypmminig3-ecda3bc61d3c, disconnecting.
Jul 29 17:54:27 srv4hai mosquitto[18551]: New client connected from 192.168.12.150 as shellypmminig3-ecda3bc61d3c (c1, k60, u'shmqtt').
Jul 29 17:54:28 srv4hai conf_shelly.sh: SHELLY: usage/name '50-TBD' already set for '192.168.12.150'
Jul 29 17:54:28 srv4hai conf_shelly.sh: SHELLY:'shelly-50' no WebHook
Jul 29 17:54:28 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1722268468 - 'ping_SP_0'
Jul 29 17:54:28 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 29 17:54:55 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24
Jul 29 17:54:55 srv4hai dhcpd[30731]: DHCPDISCOVER from ec:da:3b:c6:1d:3c via enp2s0
Jul 29 17:54:55 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Jul 29 17:54:56 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24
Jul 29 17:54:56 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jul 29 17:54:56 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.150
Jul 29 17:54:56 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-50
Jul 29 17:54:56 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.150 (192.168.12.252) from ec:da:3b:c6:1d:3c via enp2s0
Jul 29 17:54:56 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c0733f0 192.168.12.252#55681/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-50.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#60927/key rndc-key: signer "rndc-key" approved
Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#60927/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' TXT
Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#60927/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' TXT "31ddfcf6e79cbbdf4e55e03247020075f9"
Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#60927/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' A
Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#60927/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' A 192.168.12.150
Jul 29 17:54:56 srv4hai dhcpd[30731]: Added new forward map from shelly-50.viehai.at to 192.168.12.150
Jul 29 17:54:56 srv4hai named[30406]: client @0x7f93300fcc20 192.168.12.252#45929/key rndc-key: signer "rndc-key" approved
Jul 29 17:54:56 srv4hai named[30406]: client @0x7f93300fcc20 192.168.12.252#45929/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '150.12.168.192.in-addr.arpa' PTR
Jul 29 17:54:56 srv4hai named[30406]: client @0x7f93300fcc20 192.168.12.252#45929/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '150.12.168.192.in-addr.arpa' PTR shelly-50.viehai.at.
Jul 29 17:54:56 srv4hai dhcpd[30731]: Added reverse map from 150.12.168.192.in-addr.arpa. to shelly-50.viehai.at
Jul 29 17:54:56 srv4hai common[2979]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jul 29 17:54:56 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-50' - shIP/2:'' perform:'conf'
Jul 29 17:54:56 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-50' - shIP/2:'192.168.12.150'
Jul 29 17:54:56 srv4hai mosquitto[18551]: New connection from 192.168.12.150 on port 1883.
Jul 29 17:54:56 srv4hai mosquitto[18551]: Client shellypmminig3-ecda3bc61d3c already connected, closing old connection.
Jul 29 17:54:56 srv4hai mosquitto[18551]: Socket error on client shellypmminig3-ecda3bc61d3c, disconnecting.
Jul 29 17:54:56 srv4hai mosquitto[18551]: New client connected from 192.168.12.150 as shellypmminig3-ecda3bc61d3c (c1, k60, u'shmqtt').
Jul 29 17:54:56 srv4hai conf_shelly.sh: SHELLY: usage/name '50-TBD' already set for '192.168.12.150'
Jul 29 17:54:56 srv4hai conf_shelly.sh: SHELLY:'shelly-50' no WebHook
Jul 29 17:54:57 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=3018, secured, session=
Jul 29 17:54:57 srv4hai dovecot: imap(miglincit)<3018>: Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 29 17:55:01 srv4hai CRON[3032]: (root) CMD (/etc/linetest/linetest.sh)
Jul 29 17:55:30 srv4hai common[3041]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jul 29 17:55:40 srv4hai bt_scan[3041]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Jul 29 17:55:40 srv4hai bt_scan[3041]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62'
Jul 29 17:55:40 srv4hai common[3082]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jul 29 17:55:40 srv4hai ping_SP[3082]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jul 29 17:55:40 srv4hai common[3103]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jul 29 17:55:41 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'11'=1722268541-1722268530
Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (ping_SP__bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jul 29 17:55:41 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'11'=1722268541-1722268530
Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jul 29 17:55:41 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'11'=1722268541-1722268530
Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(__/LIVE) (BT/__) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_pcON) - sceneONsmall(vorraumOn)
Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn
Jul 29 17:55:41 srv4hai activate_scenario[3249]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jul 29 17:55:41 srv4hai activate_scenario[3249]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1'
Jul 29 17:55:41 srv4hai activate_scenario[3249]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'1'
Jul 29 17:55:41 srv4hai postfix/pickup[30969]: 955BE6018A: uid=33 from=
Jul 29 17:55:41 srv4hai postfix/cleanup[3299]: 955BE6018A: message-id=<20240729155541.955BE6018A@mail.viehai.at>
Jul 29 17:55:41 srv4hai postfix/qmgr[8566]: 955BE6018A: from=, size=12121, nrcpt=1 (queue active)
Jul 29 17:55:41 srv4hai activate_scenario[3249]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Jul 29 17:55:41 srv4hai proc_url[3316]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/07/29/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'1''
Jul 29 17:55:41 srv4hai activate_scenario[3249]: SHELLY scenario: 'vorraumOn(vorraumon)' took 176 msec, phoneName:'1'
Jul 29 17:55:41 srv4hai ping_SP[3082]: SHELLY check_presence.sh coming 1 ping_SP__bt_scan
Jul 29 17:55:41 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1722268541 - 'ping_SP_0'
Jul 29 17:55:41 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 29 17:55:41 srv4hai ping_SP[3082]: SHELLY - new process for '192.168.12.62' - '/srv/www/viehai/shelly//meter/ping_SP_1' @~1722268541
Jul 29 17:55:42 srv4hai postfix/relay/smtp[3312]: 955BE6018A: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=0.96, delays=0.04/0.01/0.66/0.25, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 581248000D)
Jul 29 17:55:42 srv4hai postfix/qmgr[8566]: 955BE6018A: removed
Jul 29 17:55:51 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jul 29 17:55:58 srv4hai ping_SP[3082]: SHELLY (1)- ping 192.168.12.62 0 not answered (1) @~1722268558 - 'ping_SP_1'
Jul 29 17:56:01 srv4hai CRON[3385]: (root) CMD (/etc/linetest/linetest.sh)
Jul 29 17:56:07 srv4hai fetchmail[1651]: 49620 messages (49618 seen) for tmiglinci at mail.akis.at (-192648518 octets).
Jul 29 17:56:07 srv4hai postfix/smtpd[3392]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jul 29 17:56:07 srv4hai postfix/smtpd[3392]: connect from localhost[127.0.0.1]
Jul 29 17:56:07 srv4hai postfix/smtpd[3392]: EC4FE60189: client=localhost[127.0.0.1]
Jul 29 17:56:07 srv4hai postfix/cleanup[3299]: EC4FE60189: message-id=
Jul 29 17:56:08 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:49619 of 49620 (44819 octets) not flushed
Jul 29 17:56:08 srv4hai postfix/qmgr[8566]: EC4FE60189: from=, size=45098, nrcpt=1 (queue active)
Jul 29 17:56:08 srv4hai postfix/local[3394]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jul 29 17:56:08 srv4hai postfix/local[3394]: EC4FE60189: to=, relay=local, delay=0.11, delays=0.07/0.01/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jul 29 17:56:08 srv4hai postfix/qmgr[8566]: EC4FE60189: removed
Jul 29 17:56:08 srv4hai postfix/smtpd[3392]: 1420260189: client=localhost[127.0.0.1]
Jul 29 17:56:08 srv4hai postfix/cleanup[3299]: 1420260189: message-id=<20240729155541.955BE6018A@mail.viehai.at>
Jul 29 17:56:08 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:49620 of 49620 (13086 octets) not flushed
Jul 29 17:56:08 srv4hai postfix/qmgr[8566]: 1420260189: from=, size=13395, nrcpt=1 (queue active)
Jul 29 17:56:08 srv4hai postfix/local[3394]: 1420260189: to=, relay=local, delay=0.06, delays=0.05/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jul 29 17:56:08 srv4hai postfix/qmgr[8566]: 1420260189: removed
Jul 29 17:56:08 srv4hai postfix/smtpd[3392]: disconnect from localhost[127.0.0.1] ehlo=1 mail=2 rcpt=2 data=2 quit=1 commands=8
Jul 29 17:56:14 srv4hai fetchmail[1651]: 10525 messages (10525 seen) for srozum at mail.akis.at (1265904086 octets).
Jul 29 17:56:24 srv4hai ping_SP[3082]: SHELLY (1)- ping 192.168.12.62 1 not answered (1) @~1722268584 - 'ping_SP_1'
Jul 29 17:56:29 srv4hai nmbd[2172]: [2024/07/29 17:56:29.217909,  0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
Jul 29 17:56:29 srv4hai nmbd[2172]:   find_domain_master_name_query_fail:
Jul 29 17:56:29 srv4hai nmbd[2172]:   Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
Jul 29 17:56:29 srv4hai nmbd[2172]:   Unable to sync browse lists in this workgroup.
Jul 29 17:56:34 srv4hai fetchmail[1651]: 25018 messages (25018 seen) for mrozum at mail.akis.at (75546976 octets).
Jul 29 17:56:35 srv4hai fetchmail[1651]: 1139 messages (1139 seen) for admin@bastelstube.wien at pop3.world4you.com (51570784 octets).
Jul 29 17:56:47 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=3438, secured, session=
Jul 29 17:56:47 srv4hai dovecot: imap(miglincit)<3438>: Logged out in=751 out=53766 deleted=0 expunged=0 trashed=0 hdr_count=57 hdr_bytes=25899 body_count=0 body_bytes=0
Jul 29 17:56:50 srv4hai ping_SP[3082]: SHELLY (1)- ping 192.168.12.62 2 not answered (1) @~1722268610 - 'ping_SP_1'
Jul 29 17:56:54 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1722268614 - 'ping_SP_0'
Jul 29 17:56:54 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 29 17:57:01 srv4hai CRON[3469]: (root) CMD (/etc/linetest/linetest.sh)
Jul 29 17:57:12 srv4hai dhcpd[30731]: DHCPDISCOVER from f0:39:65:25:8d:c7 via enp2s0
Jul 29 17:57:12 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jul 29 17:57:12 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 29 17:57:12 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.62
Jul 29 17:57:12 srv4hai dhcpd[30731]: execute_statement argv[2] = GreteS20
Jul 29 17:57:12 srv4hai common[3480]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 29 17:57:13 srv4hai ping_SP[3082]: SHELLY (1)- ping 192.168.12.62 3 not answered (1) @~1722268633 - 'ping_SP_1'
Jul 29 17:57:21 srv4hai common[3509]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jul 29 17:57:22 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jul 29 17:57:22 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jul 29 17:57:22 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jul 29 17:57:22 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 29 17:57:22 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.62
Jul 29 17:57:22 srv4hai dhcpd[30731]: execute_statement argv[2] = GreteS20
Jul 29 17:57:22 srv4hai common[3530]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 29 17:57:31 srv4hai bt_scan[3509]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'No'
Jul 29 17:57:31 srv4hai bt_scan[3509]: SHELLY - lost BT-connection to BTmac: '1' found: 'No' - check presence
Jul 29 17:57:31 srv4hai common[3566]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jul 29 17:57:32 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'11'=1722268652-1722268641
Jul 29 17:57:32 srv4hai check_presence[3566]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jul 29 17:57:32 srv4hai check_presence[3566]: SHELLY (bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Jul 29 17:57:32 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'11'=1722268652-1722268641
Jul 29 17:57:32 srv4hai check_presence[3566]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jul 29 17:57:32 srv4hai check_presence[3566]: SHELLY (bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.TRY' for what: 'presence'
Jul 29 17:57:32 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'11'=1722268652-1722268641
Jul 29 17:57:32 srv4hai check_presence[3566]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jul 29 17:57:32 srv4hai check_presence[3566]: SHELLY (bt_scan)-(1) what: 'presence' - persPresent: '(__/LIVE) (__/TRY) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jul 29 17:57:32 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jul 29 17:57:32 srv4hai common[3679]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jul 29 17:57:32 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jul 29 17:57:32 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jul 29 17:57:32 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 29 17:57:32 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.62
Jul 29 17:57:32 srv4hai dhcpd[30731]: execute_statement argv[2] = GreteS20
Jul 29 17:57:32 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 29 17:57:32 srv4hai common[3697]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 29 17:57:32 srv4hai ping_SP[3679]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jul 29 17:57:32 srv4hai check_presence[3566]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_vorraumOn) - sceneOFF(offAll)
Jul 29 17:57:32 srv4hai check_presence[3566]: SHELLY (bt_scan)-(1)-presence: NOT activate_scenario.shtml: offAll
Jul 29 17:57:36 srv4hai ping_SP[3082]: SHELLY (1) - ping 192.168.12.62 4 sucessfully  @~1722268656 - 'ping_SP_1'
Jul 29 17:57:36 srv4hai ping_SP[3082]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 29 17:57:42 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jul 29 17:57:42 srv4hai common[3775]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jul 29 17:57:42 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jul 29 17:57:42 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jul 29 17:57:42 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 29 17:57:42 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.62
Jul 29 17:57:42 srv4hai dhcpd[30731]: execute_statement argv[2] = GreteS20
Jul 29 17:57:42 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 29 17:57:42 srv4hai named[30406]: client @0x7f93506d04d0 192.168.12.252#51369/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 29 17:57:42 srv4hai common[3791]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jul 29 17:57:42 srv4hai common[3795]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 29 17:57:42 srv4hai ping_SP[3775]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jul 29 17:57:42 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'21'=1722268662-1722268641
Jul 29 17:57:42 srv4hai check_presence[3791]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jul 29 17:57:42 srv4hai check_presence[3791]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jul 29 17:57:42 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'21'=1722268662-1722268641
Jul 29 17:57:42 srv4hai check_presence[3791]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jul 29 17:57:42 srv4hai check_presence[3791]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jul 29 17:57:42 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'21'=1722268662-1722268641
Jul 29 17:57:42 srv4hai check_presence[3791]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jul 29 17:57:42 srv4hai check_presence[3791]: SHELLY (ping_SP__smartphone)-(1) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jul 29 17:57:43 srv4hai check_presence[3791]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Jul 29 17:57:43 srv4hai check_presence[3791]: SHELLY (ping_SP__smartphone)-(1)-coming: activate_scenario.shtml: vorraumOn
Jul 29 17:57:43 srv4hai activate_scenario[3960]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jul 29 17:57:43 srv4hai activate_scenario[3960]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1'
Jul 29 17:57:43 srv4hai activate_scenario[3960]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'1'
Jul 29 17:57:43 srv4hai postfix/pickup[30969]: 163BF6018A: uid=33 from=
Jul 29 17:57:43 srv4hai postfix/cleanup[3299]: 163BF6018A: message-id=<20240729155743.163BF6018A@mail.viehai.at>
Jul 29 17:57:43 srv4hai postfix/qmgr[8566]: 163BF6018A: from=, size=24751, nrcpt=1 (queue active)
Jul 29 17:57:43 srv4hai activate_scenario[3960]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Jul 29 17:57:43 srv4hai proc_url[4025]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/07/29/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'1''
Jul 29 17:57:43 srv4hai activate_scenario[3960]: SHELLY scenario: 'vorraumOn(vorraumon)' took 125 msec, phoneName:'1'
Jul 29 17:57:43 srv4hai ping_SP[3679]: SHELLY check_presence.sh coming 1 ping_SP__smartphone
Jul 29 17:57:44 srv4hai postfix/relay/smtp[4013]: 163BF6018A: to=, relay=mx01.nic.name[209.131.159.47]:25, delay=0.97, delays=0.01/0.02/0.55/0.39, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as B7F6060031)
Jul 29 17:57:44 srv4hai postfix/qmgr[8566]: 163BF6018A: removed
Jul 29 17:57:45 srv4hai ping_SP[3679]: SHELLY - running process-id(3679): '3082 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.62 bt_scan#0123679 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.62 smartphone#0123775 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.62 smartphone#0123795 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.62 GreteS20' - 'ping_SP_1' - exiting ==============
Jul 29 17:57:52 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jul 29 17:57:52 srv4hai common[4069]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jul 29 17:57:52 srv4hai common[4080]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jul 29 17:57:52 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jul 29 17:57:52 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: signer "rndc-key" approved
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: signer "rndc-key" approved
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Jul 29 17:57:52 srv4hai dhcpd[30731]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: signer "rndc-key" approved
Jul 29 17:57:52 srv4hai dhcpd[30731]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: signer "rndc-key" approved
Jul 29 17:57:52 srv4hai dhcpd[30731]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: signer "rndc-key" approved
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Jul 29 17:57:52 srv4hai dhcpd[30731]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/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.
Jul 29 17:57:52 srv4hai dhcpd[30731]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: signer "rndc-key" approved
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/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.
Jul 29 17:57:52 srv4hai dhcpd[30731]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: signer "rndc-key" approved
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/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.
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: signer "rndc-key" approved
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Jul 29 17:57:52 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#35595/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.
Jul 29 17:57:52 srv4hai ping_SP[4069]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jul 29 17:57:52 srv4hai dhcpd[30731]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Jul 29 17:57:52 srv4hai dhcpd[30731]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Jul 29 17:57:52 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'9'=1722268672-1722268663
Jul 29 17:57:52 srv4hai check_presence[4080]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jul 29 17:57:52 srv4hai check_presence[4080]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jul 29 17:57:53 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'9'=1722268672-1722268663
Jul 29 17:57:53 srv4hai check_presence[4080]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jul 29 17:57:53 srv4hai check_presence[4080]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jul 29 17:57:53 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1722268673-1722268663
Jul 29 17:57:53 srv4hai check_presence[4080]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jul 29 17:57:53 srv4hai check_presence[4080]: SHELLY (ping_SP__smartphone)-(1) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jul 29 17:57:53 srv4hai check_presence[4080]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Jul 29 17:57:53 srv4hai check_presence[4080]: SHELLY (ping_SP__smartphone)-(1)-coming: activate_scenario.shtml: vorraumOn
Jul 29 17:57:53 srv4hai activate_scenario[4239]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jul 29 17:57:53 srv4hai activate_scenario[4239]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1'

finished