activate_scenario.sh
Sun May 4 09:44:47 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:44:48.052

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:44:48.114
Dauer: 61 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 09:44:48.033
nachher: 09:44:48.126
Dauer : 93 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/05/04//scene_vorraumOn_20250504_094447.txt'


syslog

May  4 09:41:00 srv4hai mqtt_process[14799]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  4 09:41:00 srv4hai mqtt_process[14824]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:41:00 srv4hai mqtt_process[14849]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:41:01 srv4hai mqtt_process[14874]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:41:01 srv4hai mqtt_process[14899]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:41:01 srv4hai CRON[14928]: (root) CMD (/etc/linetest/linetest.sh)
May  4 09:41:14 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1746344474 - 'ping_SP_1'
May  4 09:41:14 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May  4 09:41:46 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746344506 - 'ping_SP_0'
May  4 09:41:46 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  4 09:41:59 srv4hai mqtt_process[14981]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:41:59 srv4hai mqtt_process[15006]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:42:00 srv4hai mqtt_process[15031]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  4 09:42:01 srv4hai mqtt_process[15056]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:42:01 srv4hai mqtt_process[15081]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:42:01 srv4hai CRON[15107]: (root) CMD (/etc/linetest/linetest.sh)
May  4 09:42:06 srv4hai kernel: [92322655.317521] CPU4: Package temperature/speed normal
May  4 09:42:06 srv4hai kernel: [92322655.317523] CPU7: Package temperature/speed normal
May  4 09:42:06 srv4hai kernel: [92322655.317524] CPU1: Package temperature/speed normal
May  4 09:42:06 srv4hai kernel: [92322655.317526] CPU6: Package temperature/speed normal
May  4 09:42:06 srv4hai kernel: [92322655.317527] CPU3: Package temperature/speed normal
May  4 09:42:06 srv4hai kernel: [92322655.317527] CPU5: Package temperature/speed normal
May  4 09:42:06 srv4hai kernel: [92322655.317529] CPU2: Package temperature/speed normal
May  4 09:42:06 srv4hai kernel: [92322655.317530] CPU0: Package temperature/speed normal
May  4 09:42:27 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1746344547 - 'ping_SP_1'
May  4 09:42:27 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May  4 09:42:59 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746344579 - 'ping_SP_0'
May  4 09:42:59 srv4hai ping_SP[4534]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  4 09:43:00 srv4hai mqtt_process[15155]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  4 09:43:00 srv4hai mqtt_process[15180]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:43:00 srv4hai mqtt_process[15205]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:43:01 srv4hai mqtt_process[15230]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:43:01 srv4hai mqtt_process[15255]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:43:01 srv4hai CRON[15281]: (root) CMD (/etc/linetest/linetest.sh)
May  4 09:43:30 srv4hai kernel: [92322740.007560] CPU5: Core temperature/speed normal
May  4 09:43:30 srv4hai kernel: [92322740.007561] CPU1: Core temperature/speed normal
May  4 09:43:35 srv4hai bt_scan[15288]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
May  4 09:43:35 srv4hai bt_scan[15288]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
May  4 09:43:35 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
May  4 09:43:35 srv4hai check_presence[15329]: 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:43:35 srv4hai check_presence[15329]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_0.LIVE' for what: 'presence'
May  4 09:43:35 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
May  4 09:43:35 srv4hai check_presence[15329]: 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:43:35 srv4hai check_presence[15329]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_1.LIVE' for what: 'presence'
May  4 09:43:35 srv4hai check_presence[15329]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
May  4 09:43:36 srv4hai check_presence[15329]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_nasszeile_um) - sceneOFF(offAll)
May  4 09:43:36 srv4hai check_presence[15329]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
May  4 09:43:41 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1746344621 - 'ping_SP_1'
May  4 09:43:41 srv4hai ping_SP[13006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May  4 09:43:59 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
May  4 09:43:59 srv4hai mqtt_process[15431]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:43:59 srv4hai fetchmail[1651]: 68982 messages (68982 seen) for tmiglinci at mail.akis.at (1393071817 octets).
May  4 09:43:59 srv4hai mqtt_process[15456]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  4 09:43:59 srv4hai fetchmail[1651]: 11904 messages (11904 seen) for srozum at mail.akis.at (1402160874 octets).
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'

finished