activate_scenario.sh
Thu Jul 11 21:47:36 CEST 2024
scenario: buero_UM
source: 192.168.12.140

'night' <--> 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/07/11/_0.log)

vorher: 21:47:36.146

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: 21:47:36.560
Dauer: 413 msec phName: 'shelly-40:'Thomas Büro Licht''


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

vorher: 21:47:36.162

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: 21:47:36.197
Dauer: 35 msec phName: 'shelly-40:'Thomas Büro Licht''


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

urls : 2
vorher : 21:47:36.095
nachher: 21:47:36.567
Dauer : 475 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/07/11//scene_buero_UM_20240711_214736.txt'


syslog

Jul 11 21:44:01 srv4hai CRON[2859]: (root) CMD (/etc/linetest/linetest.sh)
Jul 11 21:44:29 srv4hai ping_SP[23260]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1720727069 - 'ping_SP_1'
Jul 11 21:44:29 srv4hai ping_SP[23260]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 11 21:44:37 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1720727077 - 'ping_SP_0'
Jul 11 21:44:37 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 11 21:44:43 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=2919, secured, session=<6RSR/v0ckr8AAAAAAAAAAAAAAAAAAAAB>
Jul 11 21:44:43 srv4hai dovecot: imap(rozumm)<2919><6RSR/v0ckr8AAAAAAAAAAAAAAAAAAAAB>: Logged out in=92 out=1060 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 11 21:44:44 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jul 11 21:44:44 srv4hai fetchmail[1651]: 48490 messages (48489 seen) for tmiglinci at mail.akis.at (-291971260 octets).
Jul 11 21:44:44 srv4hai postfix/smtpd[2920]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jul 11 21:44:44 srv4hai postfix/smtpd[2920]: connect from localhost[127.0.0.1]
Jul 11 21:44:44 srv4hai postfix/smtpd[2920]: BF5B46004E: client=localhost[127.0.0.1]
Jul 11 21:44:44 srv4hai postfix/cleanup[2923]: BF5B46004E: message-id=<5cc07fc0e1efe88b7ebe5ba2eeef7297@news.top10-deals.de>
Jul 11 21:44:44 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:48490 of 48490 (65540 octets) not flushed
Jul 11 21:44:44 srv4hai postfix/qmgr[8566]: BF5B46004E: from=, size=65775, nrcpt=1 (queue active)
Jul 11 21:44:44 srv4hai postfix/smtpd[2920]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Jul 11 21:44:44 srv4hai postfix/local[2924]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jul 11 21:44:44 srv4hai postfix/local[2924]: BF5B46004E: to=, relay=local, delay=0.1, delays=0.07/0.02/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jul 11 21:44:44 srv4hai postfix/qmgr[8566]: BF5B46004E: removed
Jul 11 21:44:45 srv4hai fetchmail[1651]: 10439 messages (10439 seen) for srozum at mail.akis.at (1252767597 octets).
Jul 11 21:44:45 srv4hai fetchmail[1651]: 24691 messages (24691 seen) for mrozum at mail.akis.at (26854828 octets).
Jul 11 21:44:46 srv4hai fetchmail[1651]: 1139 messages (1139 seen) for admin@bastelstube.wien at pop3.world4you.com (51570784 octets).
Jul 11 21:44:57 srv4hai postfix/smtpd[2920]: connect from 94-154-35-194.virtualine.org[94.154.35.194]
Jul 11 21:44:57 srv4hai postfix/smtpd[2920]: warning: 94-154-35-194.virtualine.org[94.154.35.194]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jul 11 21:44:58 srv4hai postfix/smtpd[2920]: disconnect from 94-154-35-194.virtualine.org[94.154.35.194] ehlo=1 auth=0/1 quit=1 commands=2/3
Jul 11 21:44:58 srv4hai mosquitto[18551]: Client shelly1pm-84CCA8A8557D has exceeded timeout, disconnecting.
Jul 11 21:44:58 srv4hai mosquitto[18551]: Socket error on client shelly1pm-84CCA8A8557D, disconnecting.
Jul 11 21:45:01 srv4hai CRON[2931]: (root) CMD (/etc/linetest/linetest.sh)
Jul 11 21:45:42 srv4hai ping_SP[23260]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1720727142 - 'ping_SP_1'
Jul 11 21:45:42 srv4hai ping_SP[23260]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 11 21:45:43 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=2974, secured, session=
Jul 11 21:45:43 srv4hai dovecot: imap(rozumm)<2974>: Logged out in=92 out=1060 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 11 21:45:50 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1720727150 - 'ping_SP_0'
Jul 11 21:45:50 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 11 21:46:01 srv4hai CRON[2991]: (root) CMD (/etc/linetest/linetest.sh)
Jul 11 21:46:44 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=3013, secured, session=
Jul 11 21:46:44 srv4hai dovecot: imap(rozumm)<3013>: Logged out in=92 out=1060 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 11 21:46:56 srv4hai ping_SP[23260]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1720727216 - 'ping_SP_1'
Jul 11 21:46:56 srv4hai ping_SP[23260]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 11 21:47:01 srv4hai CRON[3039]: (root) CMD (/etc/linetest/linetest.sh)
Jul 11 21:47:04 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1720727224 - 'ping_SP_0'
Jul 11 21:47:04 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 11 21:47:05 srv4hai dhcpd[30731]: DHCPDISCOVER from 84:cc:a8:a8:55:7d via enp2s0
Jul 11 21:47:05 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.102 to 84:cc:a8:a8:55:7d via enp2s0
Jul 11 21:47:05 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jul 11 21:47:05 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.102
Jul 11 21:47:05 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-02
Jul 11 21:47:05 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.102 (192.168.12.252) from 84:cc:a8:a8:55:7d via enp2s0
Jul 11 21:47:05 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.102 to 84:cc:a8:a8:55:7d via enp2s0
Jul 11 21:47:05 srv4hai named[30406]: client @0x7f931c085800 192.168.12.252#47525/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-02.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 11 21:47:05 srv4hai named[30406]: client @0x7f93506c16d0 192.168.12.252#49465/key rndc-key: signer "rndc-key" approved
Jul 11 21:47:05 srv4hai named[30406]: client @0x7f93506c16d0 192.168.12.252#49465/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-02.viehai.at' TXT
Jul 11 21:47:05 srv4hai named[30406]: client @0x7f93506c16d0 192.168.12.252#49465/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-02.viehai.at' TXT "005dc8ffbb18e92d4c1a5981a9354b73fe"
Jul 11 21:47:05 srv4hai named[30406]: client @0x7f93506c16d0 192.168.12.252#49465/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-02.viehai.at' A
Jul 11 21:47:05 srv4hai named[30406]: client @0x7f93506c16d0 192.168.12.252#49465/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-02.viehai.at' A 192.168.12.102
Jul 11 21:47:05 srv4hai dhcpd[30731]: Added new forward map from shelly-02.viehai.at to 192.168.12.102
Jul 11 21:47:05 srv4hai named[30406]: client @0x7f9348063d20 192.168.12.252#52839/key rndc-key: signer "rndc-key" approved
Jul 11 21:47:05 srv4hai named[30406]: client @0x7f9348063d20 192.168.12.252#52839/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '102.12.168.192.in-addr.arpa' PTR
Jul 11 21:47:05 srv4hai named[30406]: client @0x7f9348063d20 192.168.12.252#52839/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '102.12.168.192.in-addr.arpa' PTR shelly-02.viehai.at.
Jul 11 21:47:05 srv4hai dhcpd[30731]: Added reverse map from 102.12.168.192.in-addr.arpa. to shelly-02.viehai.at
Jul 11 21:47:05 srv4hai common[3059]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jul 11 21:47:05 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-02' - shIP/2:'' perform:'conf'
Jul 11 21:47:06 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-02' - shIP/2:'192.168.12.102'
Jul 11 21:47:06 srv4hai mosquitto[18551]: New connection from 192.168.12.102 on port 1883.
Jul 11 21:47:06 srv4hai mosquitto[18551]: New client connected from 192.168.12.102 as shelly1pm-84CCA8A8557D (c1, k60, u'shmqtt').
Jul 11 21:47:06 srv4hai conf_shelly.sh: SHELLY: usage/name 'Balkon-Licht' already set for '192.168.12.102'
Jul 11 21:47:06 srv4hai conf_shelly.sh: SHELLY:'shelly-02' 'conf(0)' - allready transmitted - skipping
Jul 11 21:47:06 srv4hai conf_shelly.sh: SHELLY:'shelly-02' 'conf(1)' - allready transmitted - skipping
Jul 11 21:47:06 srv4hai conf_shelly.sh: SHELLY:'shelly-02' 'conf(2)' - allready transmitted - skipping
Jul 11 21:47:06 srv4hai conf_shelly.sh: SHELLY:'shelly-02' 'conf(3)' - allready transmitted - skipping
Jul 11 21:47:06 srv4hai conf_shelly.sh: SHELLY:'shelly-02' 'conf(4)' - allready transmitted - skipping
Jul 11 21:47:07 srv4hai conf_shelly.sh: SHELLY:'shelly-02' out:0 ON : MISSING
Jul 11 21:47:07 srv4hai conf_shelly.sh: SHELLY:'shelly-02' out:0 OFF: MISSING
Jul 11 21:47:26 srv4hai activate_scenario[3189]: SHELLY scenario: 'buero_UM(buero_um)' started
Jul 11 21:47:26 srv4hai activate_scenario[3189]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'
Jul 11 21:47:26 srv4hai activate_scenario[3189]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'Thomas Büro Licht'
Jul 11 21:47:26 srv4hai postfix/pickup[26417]: 8FF796018B: uid=33 from=
Jul 11 21:47:26 srv4hai postfix/cleanup[3242]: 8FF796018B: message-id=<20240711194726.8FF796018B@mail.viehai.at>
Jul 11 21:47:26 srv4hai postfix/qmgr[8566]: 8FF796018B: from=, size=9829, nrcpt=1 (queue active)
Jul 11 21:47:26 srv4hai postfix/local[3255]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jul 11 21:47:26 srv4hai activate_scenario[3189]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Jul 11 21:47:26 srv4hai proc_url[3260]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/07/11/_0.log' - shellyUsage:'Thomas Büro Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Jul 11 21:47:26 srv4hai postfix/local[3255]: 8FF796018B: to=, orig_to=, relay=local, delay=0.05, delays=0.02/0.01/0/0.02, dsn=5.1.1, status=bounced (unknown user: "null")
Jul 11 21:47:26 srv4hai postfix/cleanup[3242]: 986C1601BE: message-id=<20240711194726.986C1601BE@mail.viehai.at>
Jul 11 21:47:26 srv4hai postfix/bounce[3256]: 8FF796018B: sender non-delivery notification: 986C1601BE
Jul 11 21:47:26 srv4hai postfix/qmgr[8566]: 986C1601BE: from=<>, size=11751, nrcpt=1 (queue active)
Jul 11 21:47:26 srv4hai postfix/qmgr[8566]: 8FF796018B: removed
Jul 11 21:47:26 srv4hai postfix/local[3255]: 986C1601BE: to=, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jul 11 21:47:26 srv4hai postfix/qmgr[8566]: 986C1601BE: removed
Jul 11 21:47:26 srv4hai activate_scenario[3189]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Jul 11 21:47:26 srv4hai proc_url[3272]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/07/11/_1.log' - shellyUsage:'Thomas Büro Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Jul 11 21:47:26 srv4hai activate_scenario[3189]: SHELLY scenario: 'buero_UM(buero_um)' took 140 msec, shelly-40:'Thomas Büro Licht'
Jul 11 21:47:36 srv4hai activate_scenario[3316]: SHELLY scenario: 'buero_UM(buero_um)' started
Jul 11 21:47:36 srv4hai activate_scenario[3316]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'

finished