activate_scenario.sh
Thu May 1 09:09:28 CEST 2025
scenario: buero_UM
source: 192.168.12.140

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

scenario: 'Büro UM-schalten' - 'buero_UM' - 'buero_um'

TB Regallicht (/srv/www/viehai/shelly/log_scenarios/2025/05/01/_0.log)

vorher: 09:09:28.626

http://192.168.12.108/relay/0?turn=toggle
  "ison": false,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "source": "http"

nachher: 09:09:28.682
Dauer: 56 msec phName: 'shelly-40:'TB Licht''


TB Licht (/srv/www/viehai/shelly/log_scenarios/2025/05/01/_1.log)

vorher: 09:09:28.665

http://192.168.12.140/relay/0?turn=toggle
  "ison": false,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "source": "http"

nachher: 09:09:28.747
Dauer: 82 msec phName: 'shelly-40:'TB Licht''


scenario: 'Büro UM-schalten' - 'buero_UM' - 'buero_um'

urls : 2
vorher : 09:09:28.576
nachher: 09:09:28.760
Dauer : 184 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/05/01//scene_buero_UM_20250501_090928.txt'


syslog

May  1 09:06:00 srv4hai mqtt_process[21699]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  1 09:06:00 srv4hai mqtt_process[21724]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:06:00 srv4hai mqtt_process[21749]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:06:01 srv4hai CRON[21775]: (root) CMD (/etc/linetest/linetest.sh)
May  1 09:06:07 srv4hai mqtt_process[21786]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:06:07 srv4hai mqtt_process[21811]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:06:15 srv4hai ping_SP[820]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746083175 - 'ping_SP_0'
May  1 09:06:15 srv4hai ping_SP[820]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  1 09:06:37 srv4hai mqtt_process[21855]: SHELLY shMqtt:'shelly1minig3-cc8da25b9000'/'WZ ovale Lampe' - btn: '{btn}' ignored and  discarded !!
May  1 09:06:49 srv4hai kernel: [92061335.840500] CPU4: Package temperature/speed normal
May  1 09:06:49 srv4hai kernel: [92061335.840501] CPU5: Package temperature/speed normal
May  1 09:06:49 srv4hai kernel: [92061335.840502] CPU7: Package temperature/speed normal
May  1 09:06:49 srv4hai kernel: [92061335.840504] CPU3: Package temperature/speed normal
May  1 09:06:49 srv4hai kernel: [92061335.840505] CPU2: Package temperature/speed normal
May  1 09:06:49 srv4hai kernel: [92061335.840505] CPU6: Package temperature/speed normal
May  1 09:06:49 srv4hai kernel: [92061335.840506] CPU1: Package temperature/speed normal
May  1 09:06:49 srv4hai kernel: [92061335.840508] CPU0: Package temperature/speed normal
May  1 09:06:59 srv4hai mqtt_process[21886]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:06:59 srv4hai mqtt_process[21911]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:07:00 srv4hai mqtt_process[21939]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  1 09:07:01 srv4hai CRON[21965]: (root) CMD (/etc/linetest/linetest.sh)
May  1 09:07:07 srv4hai mqtt_process[21971]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:07:07 srv4hai mqtt_process[21996]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:07:09 srv4hai ping_SP[17978]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1746083229 - 'ping_SP_1'
May  1 09:07:09 srv4hai ping_SP[17978]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May  1 09:07:28 srv4hai ping_SP[820]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746083248 - 'ping_SP_0'
May  1 09:07:28 srv4hai ping_SP[820]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  1 09:08:00 srv4hai mqtt_process[22063]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  1 09:08:00 srv4hai mqtt_process[22088]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:08:00 srv4hai mqtt_process[22113]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:08:01 srv4hai CRON[22139]: (root) CMD (/etc/linetest/linetest.sh)
May  1 09:08:07 srv4hai kernel: [92061413.848551] CPU0: Core temperature/speed normal
May  1 09:08:07 srv4hai kernel: [92061413.848552] CPU4: Core temperature/speed normal
May  1 09:08:07 srv4hai mqtt_process[22144]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:08:07 srv4hai mqtt_process[22169]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:08:08 srv4hai check_shelly.sh: SHELLY last scenery executed: 'offAll'
May  1 09:08:08 srv4hai check_shelly.sh: SHELLY found '3' active shelly outputs
May  1 09:08:08 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
May  1 09:08:08 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
May  1 09:08:12 srv4hai kernel: [92061419.093549] CPU5: Core temperature above threshold, cpu clock throttled (total events = 869175668)
May  1 09:08:12 srv4hai kernel: [92061419.093550] CPU1: Core temperature above threshold, cpu clock throttled (total events = 869175668)
May  1 09:08:22 srv4hai ping_SP[17978]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1746083302 - 'ping_SP_1'
May  1 09:08:22 srv4hai ping_SP[17978]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May  1 09:08:41 srv4hai ping_SP[820]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1746083321 - 'ping_SP_0'
May  1 09:08:41 srv4hai ping_SP[820]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May  1 09:08:42 srv4hai mosquitto[29419]: Client shellyplus1-441793a58ae4 has exceeded timeout, disconnecting.
May  1 09:08:42 srv4hai mosquitto[29419]: Socket error on client shellyplus1-441793a58ae4, disconnecting.
May  1 09:08:59 srv4hai mqtt_process[22285]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:08:59 srv4hai mqtt_process[22310]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:09:00 srv4hai mqtt_process[22336]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May  1 09:09:01 srv4hai CRON[22363]: (root) CMD (/etc/linetest/linetest.sh)
May  1 09:09:01 srv4hai CRON[22364]: (root) CMD (  [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi)
May  1 09:09:01 srv4hai systemd[1]: Starting Clean php session files...
May  1 09:09:01 srv4hai systemd[1]: phpsessionclean.service: Succeeded.
May  1 09:09:01 srv4hai systemd[1]: Started Clean php session files.
May  1 09:09:07 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
May  1 09:09:07 srv4hai mqtt_process[22459]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:09:07 srv4hai mqtt_process[22484]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May  1 09:09:08 srv4hai fetchmail[1651]: 68817 messages (68815 seen) for tmiglinci at mail.akis.at (1380664395 octets).
May  1 09:09:08 srv4hai postfix/smtpd[22509]: connect from localhost[127.0.0.1]
May  1 09:09:08 srv4hai postfix/smtpd[22509]: B0896631BE: client=localhost[127.0.0.1]
May  1 09:09:08 srv4hai postfix/cleanup[22512]: B0896631BE: message-id=<25mgctvcqty2h9qvbfztow.10416803530427004713@therme-laa.at>
May  1 09:09:08 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:68816 of 68817 (241117 octets) not flushed
May  1 09:09:08 srv4hai postfix/qmgr[8566]: B0896631BE: from=, size=241384, nrcpt=1 (queue active)
May  1 09:09:08 srv4hai postfix/local[22513]: B0896631BE: to=, relay=local, delay=0.12, delays=0.1/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
May  1 09:09:08 srv4hai postfix/qmgr[8566]: B0896631BE: removed
May  1 09:09:08 srv4hai postfix/smtpd[22509]: CE709631BE: client=localhost[127.0.0.1]
May  1 09:09:08 srv4hai postfix/cleanup[22512]: CE709631BE: message-id=<33.DC.38403.06D13186@i-0ee9c3542f0217b44.mta3vrest.sd.prd.sparkpost>
May  1 09:09:08 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:68817 of 68817 (285262 octets) not flushed
May  1 09:09:08 srv4hai postfix/qmgr[8566]: CE709631BE: from=, size=285514, nrcpt=1 (queue active)
May  1 09:09:08 srv4hai postfix/local[22513]: CE709631BE: to=, relay=local, delay=0.14, delays=0.13/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
May  1 09:09:08 srv4hai postfix/qmgr[8566]: CE709631BE: removed
May  1 09:09:08 srv4hai postfix/smtpd[22509]: disconnect from localhost[127.0.0.1] ehlo=1 mail=2 rcpt=2 data=2 quit=1 commands=8
May  1 09:09:09 srv4hai activate_scenario[22517]: SHELLY scenario: 'buero_UM(buero_um)' started
May  1 09:09:09 srv4hai activate_scenario[22517]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - shelly-40:'TB Licht'
May  1 09:09:09 srv4hai activate_scenario[22517]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'TB Licht'
May  1 09:09:09 srv4hai fetchmail[1651]: 11891 messages (11891 seen) for srozum at mail.akis.at (1398803883 octets).
May  1 09:09:09 srv4hai activate_scenario[22517]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'TB Regallicht' --> '0?turn=toggle'
May  1 09:09:09 srv4hai proc_url[22577]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/05/01/_0.log' - shellyUsage:'TB Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
May  1 09:09:09 srv4hai activate_scenario[22517]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'TB Licht' --> '0?turn=toggle'
May  1 09:09:09 srv4hai proc_url[22588]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/05/01/_1.log' - shellyUsage:'TB Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
May  1 09:09:09 srv4hai activate_scenario[22517]: SHELLY scenario: 'buero_UM(buero_um)' took 162 msec, shelly-40:'TB Licht'
May  1 09:09:10 srv4hai fetchmail[1651]: 30687 messages (30687 seen) for mrozum at mail.akis.at (988507553 octets).
May  1 09:09:10 srv4hai fetchmail[1651]: 1169 messages (1169 seen) for admin@bastelstube.wien at pop3.world4you.com (52284237 octets).
May  1 09:09:12 srv4hai dhcpd[30231]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0
May  1 09:09:12 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
May  1 09:09:12 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
May  1 09:09:12 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.147
May  1 09:09:12 srv4hai dhcpd[30231]: execute_statement argv[2] = shelly-47
May  1 09:09:12 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.147 (192.168.12.252) from 44:17:93:a5:8a:e4 via enp2s0
May  1 09:09:12 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
May  1 09:09:12 srv4hai named[30406]: client @0x7f93100a5fe0 192.168.12.252#45697/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-47.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May  1 09:09:12 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#58617/key rndc-key: signer "rndc-key" approved
May  1 09:09:12 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#58617/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' TXT
May  1 09:09:12 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#58617/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' TXT "31f97534415d36e3a13ec57b0310c0867f"
May  1 09:09:12 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#58617/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' A
May  1 09:09:12 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#58617/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' A 192.168.12.147
May  1 09:09:12 srv4hai dhcpd[30231]: Added new forward map from shelly-47.viehai.at to 192.168.12.147
May  1 09:09:12 srv4hai named[30406]: client @0x7f93506df2d0 192.168.12.252#58183/key rndc-key: signer "rndc-key" approved
May  1 09:09:12 srv4hai named[30406]: client @0x7f93506df2d0 192.168.12.252#58183/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '147.12.168.192.in-addr.arpa' PTR
May  1 09:09:12 srv4hai named[30406]: client @0x7f93506df2d0 192.168.12.252#58183/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '147.12.168.192.in-addr.arpa' PTR shelly-47.viehai.at.
May  1 09:09:12 srv4hai dhcpd[30231]: Added reverse map from 147.12.168.192.in-addr.arpa. to shelly-47.viehai.at
May  1 09:09:12 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-47' - shIP/2:'' perform:'conf'
May  1 09:09:13 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-47' - shIP/2:'192.168.12.147'
May  1 09:09:13 srv4hai conf_shelly.sh: SHELLY: usage/name 'GB Schreibtischlampe links' already set for '192.168.12.147'
May  1 09:09:13 srv4hai mosquitto[29419]: New connection from 192.168.12.147 on port 1883.
May  1 09:09:13 srv4hai mosquitto[29419]: New client connected from 192.168.12.147 as shellyplus1-441793a58ae4 (c1, k60, u'shmqtt').
May  1 09:09:13 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(0)' - allready transmitted - skipping
May  1 09:09:13 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(1)' - allready transmitted - skipping
May  1 09:09:13 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(2)' - allready transmitted - skipping
May  1 09:09:13 srv4hai mqtt_process[22696]: SHELLY - shellyType: 'shelly-1plus' not handled for 'shelly-47'/'GB Schreibtischlampe links'!!
May  1 09:09:14 srv4hai mqtt_process[22721]: SHELLY - shellyType: 'shelly-1plus' not handled for 'shelly-47'/'GB Schreibtischlampe links'!!
May  1 09:09:28 srv4hai activate_scenario[22770]: SHELLY scenario: 'buero_UM(buero_um)' started
May  1 09:09:28 srv4hai activate_scenario[22770]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - shelly-40:'TB Licht'

finished