activate_scenario.sh
Sat May 3 15:51:52 CEST 2025
scenario: vorraumOn
phoneName: 0

dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as '
-> execution of scenario

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

(/srv/www/viehai/shelly/log_scenarios/2025/05/03/_0.log)

vorher: 15:51:52.394

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: 15:51:52.424
Dauer: 30 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 15:51:52.374
nachher: 15:51:52.437
Dauer : 63 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/05/03//scene_vorraumOn_20250503_155152.txt'


syslog

May  3 15:48:00 srv4hai mqtt_process[12018]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  3 15:48:01 srv4hai CRON[12047]: (root) CMD (/etc/linetest/linetest.sh)
May  3 15:48:02 srv4hai mqtt_process[12052]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:48:03 srv4hai mqtt_process[12077]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:48:06 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  3 15:48:06 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  3 15:48:06 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  3 15:48:06 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  3 15:48:06 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  3 15:48:06 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  3 15:48:06 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  3 15:48:10 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746280090 - 'ping_SP_0'
May  3 15:48:10 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  3 15:48:16 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  3 15:48:16 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  3 15:48:16 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  3 15:48:16 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  3 15:48:16 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  3 15:48:16 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  3 15:48:16 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  3 15:48:16 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#59261/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  3 15:48:23 srv4hai postfix/anvil[11535]: statistics: max connection rate 1/60s for (smtp:195.211.191.81) at May  3 15:45:02
May  3 15:48:23 srv4hai postfix/anvil[11535]: statistics: max connection count 1 for (smtp:195.211.191.81) at May  3 15:45:02
May  3 15:48:23 srv4hai postfix/anvil[11535]: statistics: max cache size 1 at May  3 15:45:02
May  3 15:48:25 srv4hai kernel: [92258234.151076] CPU5: Core temperature above threshold, cpu clock throttled (total events = 895138089)
May  3 15:48:25 srv4hai kernel: [92258234.151077] CPU1: Core temperature above threshold, cpu clock throttled (total events = 895138089)
May  3 15:48:26 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPDISCOVER from cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPDISCOVER from cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPDISCOVER from cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPDISCOVER from cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPDISCOVER from cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPDISCOVER from cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: signer "rndc-key" approved
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: signer "rndc-key" approved
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: signer "rndc-key" approved
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
May  3 15:48:26 srv4hai dhcpd[30231]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
May  3 15:48:26 srv4hai dhcpd[30231]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
May  3 15:48:26 srv4hai dhcpd[30231]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: signer "rndc-key" approved
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: signer "rndc-key" approved
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/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.
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: signer "rndc-key" approved
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/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.
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: signer "rndc-key" approved
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/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.
May  3 15:48:26 srv4hai dhcpd[30231]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
May  3 15:48:26 srv4hai dhcpd[30231]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: signer "rndc-key" approved
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/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.
May  3 15:48:26 srv4hai dhcpd[30231]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
May  3 15:48:26 srv4hai dhcpd[30231]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
May  3 15:48:26 srv4hai dhcpd[30231]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
May  3 15:48:26 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
May  3 15:48:26 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.101
May  3 15:48:26 srv4hai dhcpd[30231]: execute_statement argv[2] = shelly-01
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.101 (192.168.12.252) from cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
May  3 15:48:26 srv4hai dhcpd[30231]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
May  3 15:48:26 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58337/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-01.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  3 15:48:26 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-01' - shIP/2:'' perform:'conf'
May  3 15:48:26 srv4hai named[30406]: client @0x7f93506682d0 192.168.12.252#35151/key rndc-key: signer "rndc-key" approved
May  3 15:48:26 srv4hai named[30406]: client @0x7f93506682d0 192.168.12.252#35151/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' TXT
May  3 15:48:26 srv4hai named[30406]: client @0x7f93506682d0 192.168.12.252#35151/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' TXT "31166740fe21d7ece7561d62986d2b8644"
May  3 15:48:26 srv4hai named[30406]: client @0x7f93506682d0 192.168.12.252#35151/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' A
May  3 15:48:26 srv4hai named[30406]: client @0x7f93506682d0 192.168.12.252#35151/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' A 192.168.12.101
May  3 15:48:26 srv4hai dhcpd[30231]: Added new forward map from shelly-01.viehai.at to 192.168.12.101
May  3 15:48:26 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#35815/key rndc-key: signer "rndc-key" approved
May  3 15:48:26 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#35815/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '101.12.168.192.in-addr.arpa' PTR
May  3 15:48:26 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#35815/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '101.12.168.192.in-addr.arpa' PTR shelly-01.viehai.at.
May  3 15:48:26 srv4hai dhcpd[30231]: Added reverse map from 101.12.168.192.in-addr.arpa. to shelly-01.viehai.at
May  3 15:48:27 srv4hai mosquitto[29419]: New connection from 192.168.12.101 on port 1883.
May  3 15:48:27 srv4hai mosquitto[29419]: Client shelly1minig3-cc8da26052b8 already connected, closing old connection.
May  3 15:48:27 srv4hai mosquitto[29419]: Socket error on client shelly1minig3-cc8da26052b8, disconnecting.
May  3 15:48:27 srv4hai mosquitto[29419]: New client connected from 192.168.12.101 as shelly1minig3-cc8da26052b8 (c1, k60, u'shmqtt').
May  3 15:48:27 srv4hai mqtt_process[12181]: SHELLY shMqtt:'shelly1minig3-cc8da26052b8'/'WZ Licht Esstisch' - btn: '{btn}' ignored and  discarded !!
May  3 15:48:27 srv4hai mqtt_process[12209]: SHELLY shMqtt:'shelly1minig3-cc8da26052b8'/'WZ Licht Esstisch' - btn: '{btn}' ignored and  discarded !!
May  3 15:48:27 srv4hai mqtt_process[12237]: SHELLY shMqtt:'shelly1minig3-cc8da26052b8'/'WZ Licht Esstisch' - btn: '{btn}' ignored and  discarded !!
May  3 15:48:27 srv4hai mqtt_process[12265]: SHELLY shMqtt:'shelly1minig3-cc8da26052b8'/'WZ Licht Esstisch' - btn: '{btn}' ignored and  discarded !!
May  3 15:48:28 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-01' - shIP/2:'192.168.12.101'
May  3 15:48:28 srv4hai conf_shelly.sh: SHELLY: usage/name 'WZ Licht Esstisch' already set for '192.168.12.101'
May  3 15:48:28 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(0)' - allready transmitted - skipping
May  3 15:48:28 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(1)' - allready transmitted - skipping
May  3 15:48:28 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(2)' - allready transmitted - skipping
May  3 15:48:52 srv4hai bt_scan[12376]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
May  3 15:48:52 srv4hai bt_scan[12376]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
May  3 15:48:52 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
May  3 15:48:52 srv4hai check_presence[12408]: SHELLY (0) found /srv/www/viehai/shelly/meter/ping_SP_0.LIVE and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_0.No
May  3 15:48:52 srv4hai check_presence[12408]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_0.LIVE' for what: 'presence'
May  3 15:48:52 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
May  3 15:48:52 srv4hai check_presence[12408]: SHELLY (1) found /srv/www/viehai/shelly/meter/ping_SP_1.DEAD and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_1.No
May  3 15:48:52 srv4hai check_presence[12408]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'false'
May  3 15:48:53 srv4hai check_presence[12408]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_offAll) - sceneOFF(offAll)
May  3 15:48:53 srv4hai check_presence[12408]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
May  3 15:48:59 srv4hai mqtt_process[12493]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:49:00 srv4hai mqtt_process[12518]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:49:00 srv4hai mqtt_process[12543]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  3 15:49:01 srv4hai CRON[12569]: (root) CMD (/etc/linetest/linetest.sh)
May  3 15:49:02 srv4hai mqtt_process[12574]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:49:03 srv4hai mqtt_process[12599]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:49:23 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746280163 - 'ping_SP_0'
May  3 15:49:23 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  3 15:50:00 srv4hai mqtt_process[12657]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  3 15:50:00 srv4hai mqtt_process[12682]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:50:00 srv4hai mqtt_process[12707]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:50:01 srv4hai CRON[12734]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
May  3 15:50:01 srv4hai CRON[12735]: (root) CMD (/etc/linetest/linetest.sh)
May  3 15:50:01 srv4hai meter.sh: SHELLY meter.sh started
May  3 15:50:01 srv4hai meter.sh: SHELLY 'shelly-29/KÜ Schalter Herdzeile' - type: 'shelly-i3' ignoring
May  3 15:50:01 srv4hai check_shelly.sh: SHELLY last scenery executed: 'offAll'
May  3 15:50:01 srv4hai check_shelly.sh: SHELLY found '0' active shelly outputs
May  3 15:50:01 srv4hai meter.sh: SHELLY meter.sh ended
May  3 15:50:01 srv4hai postfix/pickup[8356]: C4AC863463: uid=33 from=
May  3 15:50:01 srv4hai postfix/cleanup[12860]: C4AC863463: message-id=<20250503135001.C4AC863463@mail.viehai.at>
May  3 15:50:01 srv4hai postfix/qmgr[8566]: C4AC863463: from=, size=663, nrcpt=1 (queue active)
May  3 15:50:01 srv4hai postfix/local[12862]: C4AC863463: to=, orig_to=, relay=local, delay=0.04, delays=0.03/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
May  3 15:50:01 srv4hai postfix/qmgr[8566]: C4AC863463: removed
May  3 15:50:02 srv4hai mqtt_process[12865]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:50:03 srv4hai mqtt_process[12890]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:50:08 srv4hai postfix/smtpd[12915]: connect from unknown[195.211.191.81]
May  3 15:50:08 srv4hai postfix/smtpd[12915]: warning: unknown[195.211.191.81]: SASL LOGIN authentication failed: Invalid authentication mechanism
May  3 15:50:08 srv4hai postfix/smtpd[12915]: disconnect from unknown[195.211.191.81] ehlo=1 auth=0/1 quit=1 commands=2/3
May  3 15:50:36 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746280236 - 'ping_SP_0'
May  3 15:50:36 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  3 15:50:59 srv4hai mqtt_process[12953]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:50:59 srv4hai mqtt_process[12978]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:51:00 srv4hai mqtt_process[13003]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  3 15:51:01 srv4hai CRON[13029]: (root) CMD (/etc/linetest/linetest.sh)
May  3 15:51:02 srv4hai mqtt_process[13034]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:51:03 srv4hai mqtt_process[13059]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  3 15:51:21 srv4hai dhcpd[30231]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
May  3 15:51:21 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  3 15:51:21 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  3 15:51:21 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  3 15:51:21 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  3 15:51:31 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  3 15:51:31 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  3 15:51:31 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  3 15:51:31 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  3 15:51:31 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  3 15:51:31 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  3 15:51:31 srv4hai ping_SP[13122]: SHELLY ping_SP.sh started from smartphone, user:'root'
May  3 15:51:41 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  3 15:51:41 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  3 15:51:41 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  3 15:51:41 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  3 15:51:41 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  3 15:51:41 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  3 15:51:41 srv4hai named[30406]: client @0x7f933000d2b0 192.168.12.252#45543/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  3 15:51:41 srv4hai ping_SP[13179]: SHELLY ping_SP.sh started from smartphone, user:'root'
May  3 15:51:41 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
May  3 15:51:41 srv4hai check_presence[13185]: SHELLY (0) found /srv/www/viehai/shelly/meter/ping_SP_0.LIVE and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_0.No
May  3 15:51:41 srv4hai check_presence[13185]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_0.LIVE' for what: 'coming'
May  3 15:51:41 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
May  3 15:51:41 srv4hai check_presence[13185]: SHELLY (1) found /srv/www/viehai/shelly/meter/ping_SP_1.DEAD and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_1.No
May  3 15:51:41 srv4hai check_presence[13185]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'false'
May  3 15:51:42 srv4hai check_presence[13185]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
May  3 15:51:42 srv4hai check_presence[13185]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
May  3 15:51:42 srv4hai activate_scenario[13300]: SHELLY scenario: 'vorraumOn(vorraumon)' started
May  3 15:51:42 srv4hai activate_scenario[13300]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - phoneName:'0'
May  3 15:51:42 srv4hai activate_scenario[13300]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
May  3 15:51:42 srv4hai activate_scenario[13300]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'' --> '0?turn=on'
May  3 15:51:42 srv4hai proc_url[13356]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/05/03/_0.log' - shellyUsage:'' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
May  3 15:51:42 srv4hai activate_scenario[13300]: SHELLY scenario: 'vorraumOn(vorraumon)' took 66 msec, phoneName:'0'
May  3 15:51:42 srv4hai ping_SP[13122]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
May  3 15:51:44 srv4hai ping_SP[13122]: SHELLY - running process-id(13122): '4534 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 bt_scan#01213122 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01213179 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01213198 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.61 fpThomas' - 'ping_SP_0' - exiting ==============
May  3 15:51:49 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746280309 - 'ping_SP_0'
May  3 15:51:49 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  3 15:51:51 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  3 15:51:51 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  3 15:51:51 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  3 15:51:51 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  3 15:51:51 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  3 15:51:51 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  3 15:51:51 srv4hai named[30406]: client @0x7f933000d2b0 192.168.12.252#45543/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  3 15:51:51 srv4hai named[30406]: client @0x7f932c0d1ae0 192.168.12.252#59683/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  3 15:51:51 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
May  3 15:51:51 srv4hai ping_SP[13426]: SHELLY ping_SP.sh started from smartphone, user:'root'
May  3 15:51:51 srv4hai check_presence[13417]: SHELLY (0) found /srv/www/viehai/shelly/meter/ping_SP_0.LIVE and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_0.No
May  3 15:51:51 srv4hai check_presence[13417]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_0.LIVE' for what: 'coming'
May  3 15:51:52 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
May  3 15:51:52 srv4hai check_presence[13417]: SHELLY (1) found /srv/www/viehai/shelly/meter/ping_SP_1.DEAD and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_1.No
May  3 15:51:52 srv4hai check_presence[13417]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'false'
May  3 15:51:52 srv4hai check_presence[13417]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
May  3 15:51:52 srv4hai check_presence[13417]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
May  3 15:51:52 srv4hai activate_scenario[13540]: SHELLY scenario: 'vorraumOn(vorraumon)' started
May  3 15:51:52 srv4hai activate_scenario[13540]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - phoneName:'0'

finished