activate_scenario.sh
Sun May 4 09:47:58 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/04/_0.log)

vorher: 09:47:58.700

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: 09:47:58.784
Dauer: 84 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 09:47:58.680
nachher: 09:47:58.797
Dauer : 117 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/05/04//scene_vorraumOn_20250504_094758.txt'


syslog

May  4 09:44:00 srv4hai mqtt_process[15483]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  4 09:44:00 srv4hai fetchmail[1651]: 30749 messages (30749 seen) for mrozum at mail.akis.at (1001634414 octets).
May  4 09:44:00 srv4hai fetchmail[1651]: 1169 messages (1169 seen) for admin@bastelstube.wien at pop3.world4you.com (52284237 octets).
May  4 09:44:01 srv4hai CRON[15510]: (root) CMD (/etc/linetest/linetest.sh)
May  4 09:44:01 srv4hai mqtt_process[15514]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:44:01 srv4hai mqtt_process[15539]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:44:12 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746344652 - 'ping_SP_0'
May  4 09:44:12 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  4 09:44:13 srv4hai postfix/anvil[14798]: statistics: max connection rate 1/60s for (smtp:195.211.191.81) at May  4 09:40:52
May  4 09:44:13 srv4hai postfix/anvil[14798]: statistics: max connection count 1 for (smtp:195.211.191.81) at May  4 09:40:52
May  4 09:44:13 srv4hai postfix/anvil[14798]: statistics: max cache size 1 at May  4 09:40:52
May  4 09:44:17 srv4hai dhcpd[30231]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
May  4 09:44:17 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  4 09:44:17 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  4 09:44:17 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  4 09:44:17 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  4 09:44:27 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  4 09:44:27 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  4 09:44:27 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  4 09:44:27 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  4 09:44:27 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  4 09:44:27 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  4 09:44:27 srv4hai ping_SP[15598]: SHELLY ping_SP.sh started from smartphone, user:'root'
May  4 09:44:29 srv4hai mosquitto[29419]: Saving in-memory database to /var/lib/mosquitto/mosquitto.db.
May  4 09:44:29 srv4hai nmbd[2172]: [2025/05/04 09:44:29.613400,  0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
May  4 09:44:29 srv4hai nmbd[2172]:   find_domain_master_name_query_fail:
May  4 09:44:29 srv4hai nmbd[2172]:   Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
May  4 09:44:29 srv4hai nmbd[2172]:   Unable to sync browse lists in this workgroup.
May  4 09:44:37 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  4 09:44:37 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  4 09:44:37 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  4 09:44:37 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  4 09:44:37 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  4 09:44:37 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  4 09:44:37 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  4 09:44:37 srv4hai ping_SP[15648]: SHELLY ping_SP.sh started from smartphone, user:'root'
May  4 09:44:37 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
May  4 09:44:37 srv4hai check_presence[15657]: 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  4 09:44:37 srv4hai check_presence[15657]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_0.LIVE' for what: 'coming'
May  4 09:44:37 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
May  4 09:44:37 srv4hai check_presence[15657]: SHELLY (1) found /srv/www/viehai/shelly/meter/ping_SP_1.LIVE and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_1.Yes
May  4 09:44:37 srv4hai check_presence[15657]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_1.LIVE' for what: 'coming'
May  4 09:44:37 srv4hai check_presence[15657]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
May  4 09:44:37 srv4hai check_presence[15657]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_nasszeile_um) - sceneONsmall(vorraumOn)
May  4 09:44:37 srv4hai check_presence[15657]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
May  4 09:44:37 srv4hai activate_scenario[15769]: SHELLY scenario: 'vorraumOn(vorraumon)' started
May  4 09:44:37 srv4hai activate_scenario[15769]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - phoneName:'0'
May  4 09:44:37 srv4hai activate_scenario[15769]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
May  4 09:44:38 srv4hai activate_scenario[15769]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'' --> '0?turn=on'
May  4 09:44:38 srv4hai proc_url[15825]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/05/04/_0.log' - shellyUsage:'' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
May  4 09:44:38 srv4hai activate_scenario[15769]: SHELLY scenario: 'vorraumOn(vorraumon)' took 95 msec, phoneName:'0'
May  4 09:44:38 srv4hai ping_SP[15598]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
May  4 09:44:40 srv4hai ping_SP[15598]: SHELLY - running process-id(15598): '4534 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 bt_scan#01215598 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01215648 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01215666 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.61 fpThomas' - 'ping_SP_0' - exiting ==============
May  4 09:44:47 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  4 09:44:47 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  4 09:44:47 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  4 09:44:47 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  4 09:44:47 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  4 09:44:47 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  4 09:44:47 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  4 09:44:47 srv4hai named[30406]: client @0x7f93506a3ad0 192.168.12.252#35709/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  4 09:44:47 srv4hai ping_SP[15905]: SHELLY ping_SP.sh started from smartphone, user:'root'
May  4 09:44:47 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
May  4 09:44:47 srv4hai check_presence[15913]: 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  4 09:44:47 srv4hai check_presence[15913]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_0.LIVE' for what: 'coming'
May  4 09:44:47 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
May  4 09:44:47 srv4hai check_presence[15913]: SHELLY (1) found /srv/www/viehai/shelly/meter/ping_SP_1.LIVE and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_1.Yes
May  4 09:44:47 srv4hai check_presence[15913]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_1.LIVE' for what: 'coming'
May  4 09:44:47 srv4hai check_presence[15913]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
May  4 09:44:47 srv4hai check_presence[15913]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
May  4 09:44:47 srv4hai check_presence[15913]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
May  4 09:44:48 srv4hai activate_scenario[16025]: SHELLY scenario: 'vorraumOn(vorraumon)' started
May  4 09:44:48 srv4hai activate_scenario[16025]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - phoneName:'0'
May  4 09:44:48 srv4hai activate_scenario[16025]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
May  4 09:44:48 srv4hai activate_scenario[16025]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'' --> '0?turn=on'
May  4 09:44:48 srv4hai proc_url[16082]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/05/04/_0.log' - shellyUsage:'' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
May  4 09:44:48 srv4hai activate_scenario[16025]: SHELLY scenario: 'vorraumOn(vorraumon)' took 93 msec, phoneName:'0'
May  4 09:44:48 srv4hai ping_SP[15648]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
May  4 09:44:50 srv4hai ping_SP[15648]: SHELLY - running process-id(15648): '4534 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 bt_scan#01215648 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01215905 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01215923 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.61 fpThomas' - 'ping_SP_0' - exiting ==============
May  4 09:44:54 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1746344694 - 'ping_SP_1'
May  4 09:44:54 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May  4 09:44:57 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  4 09:44:57 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  4 09:44:57 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: signer "rndc-key" approved
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: signer "rndc-key" approved
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: signer "rndc-key" approved
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
May  4 09:44:57 srv4hai dhcpd[30231]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
May  4 09:44:57 srv4hai dhcpd[30231]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
May  4 09:44:57 srv4hai dhcpd[30231]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: signer "rndc-key" approved
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: signer "rndc-key" approved
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/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  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: signer "rndc-key" approved
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/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  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: signer "rndc-key" approved
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/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  4 09:44:57 srv4hai dhcpd[30231]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
May  4 09:44:57 srv4hai dhcpd[30231]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: signer "rndc-key" approved
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
May  4 09:44:57 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#33795/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  4 09:44:57 srv4hai dhcpd[30231]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
May  4 09:44:57 srv4hai dhcpd[30231]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
May  4 09:44:57 srv4hai ping_SP[16135]: SHELLY ping_SP.sh started from smartphone, user:'root'
May  4 09:44:57 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
May  4 09:44:57 srv4hai check_presence[16161]: 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  4 09:44:57 srv4hai dhcpd[30231]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
May  4 09:44:57 srv4hai check_presence[16161]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_0.LIVE' for what: 'coming'
May  4 09:44:57 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
May  4 09:44:57 srv4hai check_presence[16161]: SHELLY (1) found /srv/www/viehai/shelly/meter/ping_SP_1.LIVE and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_1.Yes
May  4 09:44:57 srv4hai check_presence[16161]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_1.LIVE' for what: 'coming'
May  4 09:44:57 srv4hai check_presence[16161]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
May  4 09:44:57 srv4hai check_presence[16161]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
May  4 09:44:57 srv4hai check_presence[16161]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
May  4 09:44:58 srv4hai activate_scenario[16251]: SHELLY scenario: 'vorraumOn(vorraumon)' started
May  4 09:44:58 srv4hai activate_scenario[16251]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - phoneName:'0'
May  4 09:44:58 srv4hai activate_scenario[16251]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
May  4 09:44:58 srv4hai activate_scenario[16251]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'' --> '0?turn=on'
May  4 09:44:58 srv4hai proc_url[16307]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/05/04/_0.log' - shellyUsage:'' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
May  4 09:44:58 srv4hai activate_scenario[16251]: SHELLY scenario: 'vorraumOn(vorraumon)' took 75 msec, phoneName:'0'
May  4 09:44:58 srv4hai ping_SP[15905]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
May  4 09:45:00 srv4hai mqtt_process[16337]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:45:00 srv4hai mqtt_process[16363]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:45:00 srv4hai mqtt_process[16388]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  4 09:45:00 srv4hai ping_SP[15905]: SHELLY - running process-id(15905): '4534 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 bt_scan#01215905 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01216135 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone' - 'ping_SP_0' - exiting ==============
May  4 09:45:01 srv4hai CRON[16419]: (root) CMD (/etc/linetest/linetest.sh)
May  4 09:45:01 srv4hai mqtt_process[16425]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:45:01 srv4hai mqtt_process[16452]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:45:07 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
May  4 09:45:07 srv4hai check_presence[16487]: 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  4 09:45:07 srv4hai check_presence[16487]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_0.LIVE' for what: 'coming'
May  4 09:45:07 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
May  4 09:45:07 srv4hai check_presence[16487]: SHELLY (1) found /srv/www/viehai/shelly/meter/ping_SP_1.LIVE and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_1.Yes
May  4 09:45:07 srv4hai check_presence[16487]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_1.LIVE' for what: 'coming'
May  4 09:45:07 srv4hai check_presence[16487]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
May  4 09:45:07 srv4hai check_presence[16487]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
May  4 09:45:07 srv4hai check_presence[16487]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
May  4 09:45:08 srv4hai activate_scenario[16572]: SHELLY scenario: 'vorraumOn(vorraumon)' started
May  4 09:45:08 srv4hai activate_scenario[16572]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - phoneName:'0'
May  4 09:45:08 srv4hai activate_scenario[16572]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
May  4 09:45:08 srv4hai activate_scenario[16572]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'' --> '0?turn=on'
May  4 09:45:08 srv4hai proc_url[16628]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/05/04/_0.log' - shellyUsage:'' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
May  4 09:45:08 srv4hai activate_scenario[16572]: SHELLY scenario: 'vorraumOn(vorraumon)' took 63 msec, phoneName:'0'
May  4 09:45:08 srv4hai ping_SP[16135]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
May  4 09:45:10 srv4hai ping_SP[16135]: SHELLY - running process-id(16135): '4534 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 bt_scan#01216135 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone' - 'ping_SP_0' - exiting ==============
May  4 09:45:25 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746344725 - 'ping_SP_0'
May  4 09:45:25 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  4 09:45:56 srv4hai postfix/smtpd[16710]: connect from unknown[195.211.191.81]
May  4 09:45:56 srv4hai postfix/smtpd[16710]: warning: unknown[195.211.191.81]: SASL LOGIN authentication failed: Invalid authentication mechanism
May  4 09:45:56 srv4hai postfix/smtpd[16710]: disconnect from unknown[195.211.191.81] ehlo=1 auth=0/1 quit=1 commands=2/3
May  4 09:46:00 srv4hai mqtt_process[16716]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  4 09:46:00 srv4hai mqtt_process[16744]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:46:00 srv4hai mqtt_process[16771]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:46:01 srv4hai CRON[16797]: (root) CMD (/etc/linetest/linetest.sh)
May  4 09:46:01 srv4hai mqtt_process[16801]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:46:01 srv4hai mqtt_process[16826]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:46:07 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1746344767 - 'ping_SP_1'
May  4 09:46:07 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May  4 09:46:39 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746344799 - 'ping_SP_0'
May  4 09:46:39 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  4 09:46:59 srv4hai mqtt_process[16906]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:46:59 srv4hai mqtt_process[16933]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:47:00 srv4hai mqtt_process[16958]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  4 09:47:01 srv4hai CRON[16984]: (root) CMD (/etc/linetest/linetest.sh)
May  4 09:47:01 srv4hai mqtt_process[16988]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:47:01 srv4hai mqtt_process[17013]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:47:06 srv4hai kernel: [92322955.325594] CPU3: Package temperature/speed normal
May  4 09:47:06 srv4hai kernel: [92322955.325595] CPU4: Package temperature/speed normal
May  4 09:47:06 srv4hai kernel: [92322955.325596] CPU2: Package temperature/speed normal
May  4 09:47:06 srv4hai kernel: [92322955.325597] CPU7: Package temperature/speed normal
May  4 09:47:06 srv4hai kernel: [92322955.325598] CPU5: Package temperature/speed normal
May  4 09:47:06 srv4hai kernel: [92322955.325599] CPU6: Package temperature/speed normal
May  4 09:47:06 srv4hai kernel: [92322955.325600] CPU1: Package temperature/speed normal
May  4 09:47:06 srv4hai kernel: [92322955.325601] CPU0: Package temperature/speed normal
May  4 09:47:20 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1746344840 - 'ping_SP_1'
May  4 09:47:20 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May  4 09:47:36 srv4hai check_shelly.sh: SHELLY last scenery executed: 'vorraumOn'
May  4 09:47:36 srv4hai check_shelly.sh: SHELLY found '4' active shelly outputs
May  4 09:47:36 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
May  4 09:47:36 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
May  4 09:47:38 srv4hai dhcpd[30231]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
May  4 09:47:38 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  4 09:47:38 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  4 09:47:38 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  4 09:47:38 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  4 09:47:40 srv4hai mosquitto[29419]: Client shellyrgbw2-A891C9 has exceeded timeout, disconnecting.
May  4 09:47:40 srv4hai mosquitto[29419]: Socket error on client shellyrgbw2-A891C9, disconnecting.
May  4 09:47:48 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  4 09:47:48 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  4 09:47:48 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  4 09:47:48 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  4 09:47:48 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  4 09:47:48 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  4 09:47:48 srv4hai ping_SP[17135]: SHELLY ping_SP.sh started from smartphone, user:'root'
May  4 09:47:58 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May  4 09:47:58 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May  4 09:47:58 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May  4 09:47:58 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May  4 09:47:58 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
May  4 09:47:58 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
May  4 09:47:58 srv4hai named[30406]: client @0x7f93300ede20 192.168.12.252#51573/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  4 09:47:58 srv4hai ping_SP[17184]: SHELLY ping_SP.sh started from smartphone, user:'root'
May  4 09:47:58 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
May  4 09:47:58 srv4hai check_presence[17188]: 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  4 09:47:58 srv4hai check_presence[17188]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_0.LIVE' for what: 'coming'
May  4 09:47:58 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
May  4 09:47:58 srv4hai check_presence[17188]: SHELLY (1) found /srv/www/viehai/shelly/meter/ping_SP_1.LIVE and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_1.Yes
May  4 09:47:58 srv4hai check_presence[17188]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_1.LIVE' for what: 'coming'
May  4 09:47:58 srv4hai check_presence[17188]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
May  4 09:47:58 srv4hai check_presence[17188]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
May  4 09:47:58 srv4hai check_presence[17188]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
May  4 09:47:58 srv4hai activate_scenario[17305]: SHELLY scenario: 'vorraumOn(vorraumon)' started
May  4 09:47:58 srv4hai activate_scenario[17305]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - phoneName:'0'

finished