activate_scenario.sh
Thu Apr 10 20:07:08 CEST 2025
scenario: sekr_UM
source: 192.168.12.110

'night' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'null'

scenario: 'Sekretär Licht UM-schalten' - 'sekr_UM' - 'sekr_um'

WZ Licht Sofa (/srv/www/viehai/shelly/log_scenarios/2025/04/10/_0.log)

vorher: 20:07:09.168

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

nachher: 20:07:09.312
Dauer: 143 msec phName: 'shelly-10:'WZ Licht Bücherregal''

scenario: 'Sekretär Licht UM-schalten' - 'sekr_UM' - 'sekr_um'

urls : 1
vorher : 20:07:09.121
nachher: 20:07:09.323
Dauer : 202 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/04/10//scene_sekr_UM_20250410_200708.txt'

syslog

Apr 10 20:04:00 srv4hai mqtt_process[26926]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 10 20:04:00 srv4hai mqtt_process[26951]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:04:00 srv4hai mqtt_process[26976]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:04:01 srv4hai CRON[27002]: (root) CMD (/etc/linetest/linetest.sh)
Apr 10 20:04:07 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Apr 10 20:04:07 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Apr 10 20:04:07 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Apr 10 20:04:07 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Apr 10 20:04:07 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.62
Apr 10 20:04:07 srv4hai dhcpd[30231]: execute_statement argv[2] = GreteS20
Apr 10 20:04:07 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 10 20:04:07 srv4hai named[30406]: client @0x7f931c09a6d0 192.168.12.252#46199/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 10 20:04:17 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Apr 10 20:04:17 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Apr 10 20:04:17 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: signer "rndc-key" approved
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: signer "rndc-key" approved
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Apr 10 20:04:17 srv4hai dhcpd[30231]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Apr 10 20:04:17 srv4hai dhcpd[30231]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: signer "rndc-key" approved
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Apr 10 20:04:17 srv4hai dhcpd[30231]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: signer "rndc-key" approved
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: signer "rndc-key" approved
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/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.
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: signer "rndc-key" approved
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/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.
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: signer "rndc-key" approved
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/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.
Apr 10 20:04:17 srv4hai dhcpd[30231]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Apr 10 20:04:17 srv4hai dhcpd[30231]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Apr 10 20:04:17 srv4hai dhcpd[30231]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Apr 10 20:04:17 srv4hai dhcpd[30231]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: signer "rndc-key" approved
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Apr 10 20:04:17 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#36785/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.
Apr 10 20:04:17 srv4hai dhcpd[30231]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Apr 10 20:04:26 srv4hai mqtt_process[27043]: SHELLY shMqtt:'shelly1minig3-cc8da26052b8'/'WZ Licht Esstisch' - btn: '{btn}' ignored and  discarded !!
Apr 10 20:04:26 srv4hai mqtt_process[27071]: SHELLY shMqtt:'shelly1minig3-cc8da26052b8'/'WZ Licht Esstisch' - btn: '{btn}' ignored and  discarded !!
Apr 10 20:04:26 srv4hai mqtt_process[27099]: SHELLY - BTN[1]='S' ->  NOTHING TO DO ;-)
Apr 10 20:04:26 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Apr 10 20:04:26 srv4hai mqtt_process[27130]: SHELLY shMqtt:'shelly1minig3-cc8da26052b8'/'WZ Licht Esstisch' - btn: '{btn}' ignored and  discarded !!
Apr 10 20:04:27 srv4hai ping_SP[7833]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1744308267 - 'ping_SP_0'
Apr 10 20:04:27 srv4hai ping_SP[7833]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 10 20:04:27 srv4hai fetchmail[1651]: 67539 messages (67539 seen) for tmiglinci at mail.akis.at (1264493241 octets).
Apr 10 20:04:28 srv4hai fetchmail[1651]: 11815 messages (11815 seen) for srozum at mail.akis.at (1392971347 octets).
Apr 10 20:04:28 srv4hai fetchmail[1651]: 30226 messages (30226 seen) for mrozum at mail.akis.at (926155861 octets).
Apr 10 20:04:29 srv4hai fetchmail[1651]: 1167 messages (1167 seen) for admin@bastelstube.wien at pop3.world4you.com (52265871 octets).
Apr 10 20:04:50 srv4hai mqtt_process[27175]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:04:50 srv4hai mqtt_process[27200]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:04:54 srv4hai kernel: [90286400.177551] CPU4: Package temperature/speed normal
Apr 10 20:04:54 srv4hai kernel: [90286400.177553] CPU3: Package temperature/speed normal
Apr 10 20:04:54 srv4hai kernel: [90286400.177554] CPU6: Package temperature/speed normal
Apr 10 20:04:54 srv4hai kernel: [90286400.177555] CPU7: Package temperature/speed normal
Apr 10 20:04:54 srv4hai kernel: [90286400.177556] CPU1: Package temperature/speed normal
Apr 10 20:04:54 srv4hai kernel: [90286400.177557] CPU5: Package temperature/speed normal
Apr 10 20:04:54 srv4hai kernel: [90286400.177558] CPU0: Package temperature/speed normal
Apr 10 20:04:54 srv4hai kernel: [90286400.177559] CPU2: Package temperature/speed normal
Apr 10 20:05:00 srv4hai mqtt_process[27228]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 10 20:05:00 srv4hai mqtt_process[27253]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:05:00 srv4hai mqtt_process[27278]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:05:01 srv4hai CRON[27307]: (root) CMD (/etc/linetest/linetest.sh)
Apr 10 20:05:10 srv4hai ping_SP[25994]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1744308310 - 'ping_SP_1'
Apr 10 20:05:10 srv4hai ping_SP[25994]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 10 20:05:40 srv4hai ping_SP[7833]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1744308340 - 'ping_SP_0'
Apr 10 20:05:40 srv4hai ping_SP[7833]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 10 20:05:50 srv4hai mqtt_process[27354]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:05:50 srv4hai mqtt_process[27379]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:06:00 srv4hai mqtt_process[27407]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:06:00 srv4hai mqtt_process[27432]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:06:00 srv4hai mqtt_process[27457]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 10 20:06:01 srv4hai CRON[27483]: (root) CMD (/etc/linetest/linetest.sh)
Apr 10 20:06:22 srv4hai kernel: [90286488.202565] CPU1: Core temperature/speed normal
Apr 10 20:06:22 srv4hai kernel: [90286488.202566] CPU5: Core temperature/speed normal
Apr 10 20:06:23 srv4hai ping_SP[25994]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1744308383 - 'ping_SP_1'
Apr 10 20:06:23 srv4hai ping_SP[25994]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 10 20:06:25 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27520, secured, session=
Apr 10 20:06:25 srv4hai dovecot: imap(miglincit)<27520>: Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 10 20:06:50 srv4hai mqtt_process[27535]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:06:50 srv4hai mqtt_process[27560]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:06:53 srv4hai ping_SP[7833]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1744308413 - 'ping_SP_0'
Apr 10 20:06:53 srv4hai ping_SP[7833]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 10 20:07:00 srv4hai mqtt_process[27604]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 10 20:07:00 srv4hai mqtt_process[27629]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:07:00 srv4hai mqtt_process[27654]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 10 20:07:01 srv4hai CRON[27680]: (root) CMD (/etc/linetest/linetest.sh)
Apr 10 20:07:06 srv4hai activate_scenario[27689]: SHELLY scenario: 'sekr_UM(sekr_um)' started
Apr 10 20:07:06 srv4hai activate_scenario[27689]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-10:'WZ Licht Bücherregal'
Apr 10 20:07:06 srv4hai activate_scenario[27689]: SHELLY scenario: 'sekr_UM(sekr_um)' TO BE EXECUTED, shelly-10:'WZ Licht Bücherregal'
Apr 10 20:07:06 srv4hai postfix/pickup[24133]: 0C16B63463: uid=33 from=
Apr 10 20:07:06 srv4hai postfix/cleanup[27743]: 0C16B63463: message-id=<20250410180706.0C16B63463@mail.viehai.at>
Apr 10 20:07:06 srv4hai postfix/qmgr[8566]: 0C16B63463: from=, size=14824, nrcpt=1 (queue active)
Apr 10 20:07:06 srv4hai postfix/local[27759]: 0C16B63463: to=, orig_to=, relay=local, delay=0.06, delays=0.03/0.01/0/0.02, dsn=5.1.1, status=bounced (unknown user: "null")
Apr 10 20:07:06 srv4hai postfix/cleanup[27743]: 1643F63464: message-id=<20250410180706.1643F63464@mail.viehai.at>
Apr 10 20:07:06 srv4hai activate_scenario[27689]: SHELLY: scenario: 'sekr_UM(sekr_um)'-'shelly-23'-'WZ Licht Sofa' --> '0?turn=toggle'
Apr 10 20:07:06 srv4hai postfix/qmgr[8566]: 1643F63464: from=<>, size=16746, nrcpt=1 (queue active)
Apr 10 20:07:06 srv4hai postfix/bounce[27760]: 0C16B63463: sender non-delivery notification: 1643F63464
Apr 10 20:07:06 srv4hai postfix/qmgr[8566]: 0C16B63463: removed
Apr 10 20:07:06 srv4hai proc_url[27764]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/04/10/_0.log' - shellyUsage:'WZ Licht Sofa' - scUrl:'http://192.168.12.123/relay/0?turn=toggle' - phName:'shelly-10:'WZ Licht Bücherregal''
Apr 10 20:07:06 srv4hai postfix/local[27759]: 1643F63464: to=, relay=local, delay=0.06, delays=0.01/0/0/0.05, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Apr 10 20:07:06 srv4hai postfix/qmgr[8566]: 1643F63464: removed
Apr 10 20:07:06 srv4hai activate_scenario[27689]: SHELLY scenario: 'sekr_UM(sekr_um)' took 137 msec, shelly-10:'WZ Licht Bücherregal'
Apr 10 20:07:09 srv4hai activate_scenario[27795]: SHELLY scenario: 'sekr_UM(sekr_um)' started
Apr 10 20:07:09 srv4hai activate_scenario[27795]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-10:'WZ Licht Bücherregal'

finished