activate_scenario.sh
Fri Mar 22 16:56:07 CET 2024
scenario: buero_UM
source: 192.168.12.140

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

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

Thomas Büro Regallicht (/srv/www/viehai/shelly/log_scenarios/2024/03/22/_0.log)

vorher: 16:56:08.073

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: 16:56:08.135
Dauer: 61 msec phName: 'shelly-40:'Thomas Büro Licht''


Thomas Büro Licht (/srv/www/viehai/shelly/log_scenarios/2024/03/22/_1.log)

vorher: 16:56:08.089

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: 16:56:08.143
Dauer: 53 msec phName: 'shelly-40:'Thomas Büro Licht''


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

urls : 2
vorher : 16:56:08.050
nachher: 16:56:08.149
Dauer : 99 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/22//scene_buero_UM_20240322_165607.txt'


syslog

Mar 22 16:53:01 srv4hai CRON[14458]: (root) CMD (/etc/linetest/linetest.sh)
Mar 22 16:53:01 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 22 16:53:01 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.28
Mar 22 16:53:01 srv4hai dhcpd[5037]: execute_statement argv[2] = harmonyhub
Mar 22 16:53:01 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.28 from c8:db:26:0c:f3:8e via enp2s0
Mar 22 16:53:01 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Mar 22 16:53:01 srv4hai named[15509]: client @0x7f930c0a53a0 192.168.12.252#50387/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 22 16:53:01 srv4hai named[15509]: client @0x7f92fc0061b0 192.168.12.252#49735/key rndc-key: signer "rndc-key" approved
Mar 22 16:53:01 srv4hai named[15509]: client @0x7f92fc0061b0 192.168.12.252#49735/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Mar 22 16:53:01 srv4hai named[15509]: client @0x7f92fc0061b0 192.168.12.252#49735/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Mar 22 16:53:01 srv4hai named[15509]: client @0x7f92fc0061b0 192.168.12.252#49735/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Mar 22 16:53:01 srv4hai named[15509]: client @0x7f92fc0061b0 192.168.12.252#49735/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Mar 22 16:53:01 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Mar 22 16:53:01 srv4hai dhcpd[5037]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Mar 22 16:53:01 srv4hai named[15509]: client @0x7f9314041790 192.168.12.252#52963/key rndc-key: signer "rndc-key" approved
Mar 22 16:53:01 srv4hai named[15509]: client @0x7f9314041790 192.168.12.252#52963/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Mar 22 16:53:01 srv4hai named[15509]: client @0x7f9314041790 192.168.12.252#52963/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '28.12.168.192.in-addr.arpa' PTR harmonyhub.viehai.at.
Mar 22 16:53:01 srv4hai dhcpd[5037]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Mar 22 16:53:01 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Mar 22 16:53:40 srv4hai postfix/anvil[14171]: statistics: max connection rate 1/60s for (smtp:109.206.237.234) at Mar 22 16:50:19
Mar 22 16:53:40 srv4hai postfix/anvil[14171]: statistics: max connection count 1 for (smtp:109.206.237.234) at Mar 22 16:50:19
Mar 22 16:53:40 srv4hai postfix/anvil[14171]: statistics: max cache size 1 at Mar 22 16:50:19
Mar 22 16:54:01 srv4hai CRON[14500]: (root) CMD (/etc/linetest/linetest.sh)
Mar 22 16:54:02 srv4hai postfix/smtpd[14506]: connect from unknown[109.206.237.234]
Mar 22 16:54:03 srv4hai postfix/smtpd[14506]: warning: unknown[109.206.237.234]: SASL LOGIN authentication failed: Invalid authentication mechanism
Mar 22 16:54:03 srv4hai postfix/smtpd[14506]: disconnect from unknown[109.206.237.234] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4
Mar 22 16:54:14 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=14515, secured, session=
Mar 22 16:54:14 srv4hai dovecot: imap(miglincit)<14515>: Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 22 16:54:27 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 22 16:54:27 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.28
Mar 22 16:54:27 srv4hai dhcpd[5037]: execute_statement argv[2] = harmonyhub
Mar 22 16:54:27 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.28 from c8:db:26:0c:f3:8e via enp2s0
Mar 22 16:54:27 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Mar 22 16:54:27 srv4hai named[15509]: client @0x7f931c1490e0 192.168.12.252#58163/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 22 16:54:27 srv4hai named[15509]: client @0x7f931c65d6a0 192.168.12.252#60995/key rndc-key: signer "rndc-key" approved
Mar 22 16:54:27 srv4hai named[15509]: client @0x7f931c65d6a0 192.168.12.252#60995/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Mar 22 16:54:27 srv4hai named[15509]: client @0x7f931c65d6a0 192.168.12.252#60995/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Mar 22 16:54:27 srv4hai named[15509]: client @0x7f931c65d6a0 192.168.12.252#60995/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Mar 22 16:54:27 srv4hai named[15509]: client @0x7f931c65d6a0 192.168.12.252#60995/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Mar 22 16:54:27 srv4hai dhcpd[5037]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Mar 22 16:54:27 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Mar 22 16:54:27 srv4hai named[15509]: client @0x7f930807c330 192.168.12.252#50419/key rndc-key: signer "rndc-key" approved
Mar 22 16:54:27 srv4hai named[15509]: client @0x7f930807c330 192.168.12.252#50419/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Mar 22 16:54:27 srv4hai named[15509]: client @0x7f930807c330 192.168.12.252#50419/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '28.12.168.192.in-addr.arpa' PTR harmonyhub.viehai.at.
Mar 22 16:54:27 srv4hai dhcpd[5037]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Mar 22 16:54:27 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Mar 22 16:54:29 srv4hai dhcpd[5037]: DHCPDISCOVER from 30:83:98:8c:05:9d via enp2s0
Mar 22 16:54:29 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.123 to 30:83:98:8c:05:9d via enp2s0
Mar 22 16:54:29 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Mar 22 16:54:29 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.123
Mar 22 16:54:29 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-23
Mar 22 16:54:29 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.123 (192.168.12.252) from 30:83:98:8c:05:9d via enp2s0
Mar 22 16:54:29 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.123 to 30:83:98:8c:05:9d via enp2s0
Mar 22 16:54:29 srv4hai named[15509]: client @0x7f9310045f00 192.168.12.252#37037/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-23.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 22 16:54:29 srv4hai named[15509]: client @0x7f93100604b0 192.168.12.252#53201/key rndc-key: signer "rndc-key" approved
Mar 22 16:54:29 srv4hai named[15509]: client @0x7f93100604b0 192.168.12.252#53201/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-23.viehai.at' TXT
Mar 22 16:54:29 srv4hai named[15509]: client @0x7f93100604b0 192.168.12.252#53201/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-23.viehai.at' TXT "0067c4eae5f3400bd02ff9ebe320262416"
Mar 22 16:54:29 srv4hai named[15509]: client @0x7f93100604b0 192.168.12.252#53201/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-23.viehai.at' A
Mar 22 16:54:29 srv4hai named[15509]: client @0x7f93100604b0 192.168.12.252#53201/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-23.viehai.at' A 192.168.12.123
Mar 22 16:54:29 srv4hai dhcpd[5037]: Added new forward map from shelly-23.viehai.at to 192.168.12.123
Mar 22 16:54:29 srv4hai named[15509]: client @0x7f931801e8a0 192.168.12.252#37851/key rndc-key: signer "rndc-key" approved
Mar 22 16:54:29 srv4hai named[15509]: client @0x7f931801e8a0 192.168.12.252#37851/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '123.12.168.192.in-addr.arpa' PTR
Mar 22 16:54:29 srv4hai named[15509]: client @0x7f931801e8a0 192.168.12.252#37851/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '123.12.168.192.in-addr.arpa' PTR shelly-23.viehai.at.
Mar 22 16:54:29 srv4hai dhcpd[5037]: Added reverse map from 123.12.168.192.in-addr.arpa. to shelly-23.viehai.at
Mar 22 16:54:29 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-23' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Mar 22 16:54:31 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-23' - shIP/2:'192.168.12.123'
Mar 22 16:54:31 srv4hai conf_shelly.sh: SHELLY: usage/name 'Licht Sekretär' already set for '192.168.12.123'
Mar 22 16:54:31 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(0)' - allready transmitted - skipping
Mar 22 16:54:31 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(1)' - allready transmitted - skipping
Mar 22 16:54:31 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(2)' - allready transmitted - skipping
Mar 22 16:54:31 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(3)' - allready transmitted - skipping
Mar 22 16:54:31 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(4)' - allready transmitted - skipping
Mar 22 16:54:31 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(5)' - allready transmitted - skipping
Mar 22 16:54:31 srv4hai conf_shelly.sh: SHELLY:'shelly-23' out:0 ON : MISSING
Mar 22 16:54:31 srv4hai conf_shelly.sh: SHELLY:'shelly-23' out:0 OFF: MISSING
Mar 22 16:54:36 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Mar 22 16:54:36 srv4hai fetchmail[1651]: 40391 messages (40390 seen) for tmiglinci at mail.akis.at (-955665095 octets).
Mar 22 16:54:36 srv4hai postfix/smtpd[14506]: connect from localhost[127.0.0.1]
Mar 22 16:54:36 srv4hai postfix/smtpd[14506]: B464160119: client=localhost[127.0.0.1]
Mar 22 16:54:36 srv4hai postfix/cleanup[14681]: B464160119: message-id=<20240322155419.b7b45aa4f90dbfed@backercity.com>
Mar 22 16:54:36 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:40391 of 40391 (12146 octets) not flushed
Mar 22 16:54:36 srv4hai postfix/qmgr[15291]: B464160119: from=, size=12431, nrcpt=1 (queue active)
Mar 22 16:54:36 srv4hai postfix/smtpd[14506]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Mar 22 16:54:36 srv4hai postfix/local[14682]: B464160119: to=, relay=local, delay=0.08, delays=0.05/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 22 16:54:36 srv4hai postfix/qmgr[15291]: B464160119: removed
Mar 22 16:54:37 srv4hai fetchmail[1651]: 10037 messages (10037 seen) for srozum at mail.akis.at (1214096424 octets).
Mar 22 16:54:37 srv4hai fetchmail[1651]: 22412 messages (22412 seen) for mrozum at mail.akis.at (-412094004 octets).
Mar 22 16:54:37 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Mar 22 16:55:01 srv4hai CRON[14707]: (root) CMD (/etc/linetest/linetest.sh)
Mar 22 16:55:05 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=14715, secured, session=
Mar 22 16:55:05 srv4hai dovecot: imap(miglincit)<14715>: Logged out in=735 out=43617 deleted=0 expunged=0 trashed=0 hdr_count=50 hdr_bytes=19826 body_count=0 body_bytes=0
Mar 22 16:55:35 srv4hai postfix/smtpd[14506]: connect from unknown[45.128.96.5]
Mar 22 16:55:35 srv4hai postfix/smtpd[14737]: connect from unknown[45.128.96.5]
Mar 22 16:55:35 srv4hai postfix/smtpd[14506]: lost connection after CONNECT from unknown[45.128.96.5]
Mar 22 16:55:35 srv4hai postfix/smtpd[14506]: disconnect from unknown[45.128.96.5] commands=0/0
Mar 22 16:55:35 srv4hai postfix/smtpd[14737]: NOQUEUE: reject: RCPT from unknown[45.128.96.5]: 550 5.1.1 : Recipient address rejected: User unknown in local recipient table; from= to= proto=ESMTP helo=<[45.128.96.5]>
Mar 22 16:55:35 srv4hai postfix/smtpd[14737]: lost connection after RSET from unknown[45.128.96.5]
Mar 22 16:55:35 srv4hai postfix/smtpd[14737]: disconnect from unknown[45.128.96.5] ehlo=1 mail=1 rcpt=0/1 rset=1 commands=3/4
Mar 22 16:56:01 srv4hai CRON[14747]: (root) CMD (/etc/linetest/linetest.sh)
Mar 22 16:56:01 srv4hai activate_scenario[14752]: SHELLY scenario: 'pcOFF(pcoff)' started
Mar 22 16:56:01 srv4hai activate_scenario[14752]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-0:''
Mar 22 16:56:01 srv4hai activate_scenario[14752]: SHELLY scenario: 'pcOFF(pcoff)' TO BE EXECUTED, shelly-0:''
Mar 22 16:56:01 srv4hai postfix/pickup[14512]: BBD856027D: uid=33 from=
Mar 22 16:56:01 srv4hai postfix/cleanup[14681]: BBD856027D: message-id=<20240322155601.BBD856027D@mail.viehai.at>
Mar 22 16:56:01 srv4hai postfix/qmgr[15291]: BBD856027D: from=, size=13652, nrcpt=1 (queue active)
Mar 22 16:56:01 srv4hai postfix/local[14682]: BBD856027D: to=, orig_to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Mar 22 16:56:01 srv4hai postfix/cleanup[14681]: BF84F602B8: message-id=<20240322155601.BF84F602B8@mail.viehai.at>
Mar 22 16:56:01 srv4hai postfix/bounce[14810]: BBD856027D: sender non-delivery notification: BF84F602B8
Mar 22 16:56:01 srv4hai postfix/qmgr[15291]: BF84F602B8: from=<>, size=15531, nrcpt=1 (queue active)
Mar 22 16:56:01 srv4hai postfix/qmgr[15291]: BBD856027D: removed
Mar 22 16:56:01 srv4hai postfix/local[14682]: BF84F602B8: to=, relay=local, delay=0.01, delays=0/0/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 22 16:56:01 srv4hai postfix/qmgr[15291]: BF84F602B8: removed
Mar 22 16:56:01 srv4hai activate_scenario[14752]: SHELLY: scenario: 'pcOFF(pcoff)'-'shelly-20'-'Thomas Schreibtischlampe' --> '0?turn=off'
Mar 22 16:56:01 srv4hai proc_url[14821]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/03/22/_0.log' - shellyUsage:'Thomas Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=off' - phName:'shelly-0:'''
Mar 22 16:56:01 srv4hai activate_scenario[14752]: SHELLY scenario: 'pcOFF(pcoff)' took 61 msec, shelly-0:''
Mar 22 16:56:08 srv4hai activate_scenario[14849]: SHELLY scenario: 'buero_UM(buero_um)' started
Mar 22 16:56:08 srv4hai activate_scenario[14849]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'

finished