activate_scenario.sh
Sun Jan 14 16:05:34 CET 2024
scenario: pcON

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

scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'

Thomas Schreibtischlampe (/srv/www/viehai/shelly/log_scenarios/2024/01/14/_0.log)

vorher: 16:05:34.972

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

nachher: 16:05:35.000
Dauer: 27 msec


scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'

urls : 1
vorher : 16:05:34.955
nachher: 16:05:35.006
Dauer : 51 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/14//scene_pcON_20240114_160534.txt'


syslog

Jan 14 16:03:00 srv4hai named[14530]: resolver priming query complete
Jan 14 16:03:01 srv4hai CRON[25630]: (root) CMD (/etc/linetest/linetest.sh)
Jan 14 16:03:15 srv4hai named[14530]: resolver priming query complete
Jan 14 16:03:16 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1705244596 - 'ping_SP_0'
Jan 14 16:03:20 srv4hai activate_scenario.sh: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED
Jan 14 16:03:20 srv4hai postfix/pickup[17810]: 77B8760244: uid=33 from=
Jan 14 16:03:20 srv4hai postfix/cleanup[25526]: 77B8760244: message-id=<20240114150320.77B8760244@mail.viehai.at>
Jan 14 16:03:20 srv4hai postfix/qmgr[28610]: 77B8760244: from=, size=8073, nrcpt=1 (queue active)
Jan 14 16:03:20 srv4hai postfix/local[25692]: 77B8760244: to=, orig_to=, relay=local, delay=0.05, delays=0.01/0.02/0/0.03, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 14 16:03:20 srv4hai postfix/cleanup[25526]: 835BA60245: message-id=<20240114150320.835BA60245@mail.viehai.at>
Jan 14 16:03:20 srv4hai postfix/bounce[25696]: 77B8760244: sender non-delivery notification: 835BA60245
Jan 14 16:03:20 srv4hai postfix/qmgr[28610]: 835BA60245: from=<>, size=9952, nrcpt=1 (queue active)
Jan 14 16:03:20 srv4hai postfix/qmgr[28610]: 77B8760244: removed
Jan 14 16:03:20 srv4hai postfix/local[25692]: 835BA60245: to=, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 14 16:03:20 srv4hai postfix/qmgr[28610]: 835BA60245: removed
Jan 14 16:03:20 srv4hai activate_scenario.sh: SHELLY: 'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Jan 14 16:03:20 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/14/_0.log' - shellyUsage:'Thomas Büro Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'noHandy'
Jan 14 16:03:20 srv4hai activate_scenario.sh: SHELLY: 'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Jan 14 16:03:20 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/14/_1.log' - shellyUsage:'Thomas Büro Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'noHandy'
Jan 14 16:03:20 srv4hai activate_scenario.sh: SHELLY scenario: 'buero_UM(buero_um)' took 173 msec
Jan 14 16:03:20 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.108/status'
Jan 14 16:03:20 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.108","rssi":-63},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"16:03","unixtime":1705244601,"serial":1,"has_update":false,"mac":"8CAAB56203DF","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":true,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"source":"http"}],"meters":[{"power":0.00,"is_valid":true}],"inputs":[{"input":1,"event":"","event_cnt":0}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"update":{"status":"idle","has_update":false,"new_version":"20230913-112003/v1.14.0-gcb84623","old_version":"20230913-112003/v1.14.0-gcb84623","beta_version":"20231107-162940/v1.14.1-rc1-g0617c15"},"ram_total":51688,"ram_free":40364,"fs_size":233681,"fs_free":150600,"uptime":6312795}'
Jan 14 16:03:20 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.140/status'
Jan 14 16:03:20 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.140","rssi":-61},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"16:03","unixtime":1705244601,"serial":730,"has_update":false,"mac":"98CDAC307B4F","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":true,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"source":"http"}],"meters":[{"power":0.00,"is_valid":false,"timestamp":1705248201,"counters":[0.000, 0.000, 0.000],"total":0}],"inputs":[{"input":0,"event":"S","event_cnt":295},{"input":0,"event":"","event_cnt":0}],"temperature":44.56,"overtemperature":false,"tmp":{"tC":44.56,"tF":112.20,"is_valid":true},"update":{"status":"idle","has_update":false,"new_version":"20230913-112054/v1.14.0-gcb84623","old_version":"20230913-112054/v1.14.0-gcb84623","beta_version":"20231107-163031/v1.14.1-rc1-g0617c15"},"ram_total":51912,"ram_free":36780,"fs_size":233681,"fs_free":162648,"uptime":6312742}'
Jan 14 16:03:50 srv4hai dhcpd[1107]: DHCPDISCOVER from e0:98:06:a9:f3:81 via enp2s0
Jan 14 16:03:50 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.104 to e0:98:06:a9:f3:81 via enp2s0
Jan 14 16:03:50 srv4hai dhcpd[1107]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 14 16:03:50 srv4hai dhcpd[1107]: execute_statement argv[1] = 192.168.12.104
Jan 14 16:03:50 srv4hai dhcpd[1107]: execute_statement argv[2] = shelly-04
Jan 14 16:03:50 srv4hai dhcpd[1107]: DHCPREQUEST for 192.168.12.104 (192.168.12.252) from e0:98:06:a9:f3:81 via enp2s0
Jan 14 16:03:50 srv4hai dhcpd[1107]: DHCPACK on 192.168.12.104 to e0:98:06:a9:f3:81 via enp2s0
Jan 14 16:03:50 srv4hai named[14530]: client @0x7fc3200cc820 192.168.12.252#48129/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-04.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 14 16:03:50 srv4hai named[14530]: client @0x7fc31c0640a0 192.168.12.252#55629/key rndc-key: signer "rndc-key" approved
Jan 14 16:03:50 srv4hai named[14530]: client @0x7fc31c0640a0 192.168.12.252#55629/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-04.viehai.at' TXT
Jan 14 16:03:50 srv4hai named[14530]: client @0x7fc31c0640a0 192.168.12.252#55629/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-04.viehai.at' TXT "008d1b202806eda236ba1bc6f43dd868cf"
Jan 14 16:03:50 srv4hai named[14530]: client @0x7fc31c0640a0 192.168.12.252#55629/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-04.viehai.at' A
Jan 14 16:03:50 srv4hai named[14530]: client @0x7fc31c0640a0 192.168.12.252#55629/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-04.viehai.at' A 192.168.12.104
Jan 14 16:03:50 srv4hai dhcpd[1107]: Added new forward map from shelly-04.viehai.at to 192.168.12.104
Jan 14 16:03:50 srv4hai named[14530]: client @0x7fc32406bb80 192.168.12.252#32827/key rndc-key: signer "rndc-key" approved
Jan 14 16:03:50 srv4hai named[14530]: client @0x7fc32406bb80 192.168.12.252#32827/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '104.12.168.192.in-addr.arpa' PTR
Jan 14 16:03:50 srv4hai named[14530]: client @0x7fc32406bb80 192.168.12.252#32827/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '104.12.168.192.in-addr.arpa' PTR shelly-04.viehai.at.
Jan 14 16:03:50 srv4hai dhcpd[1107]: Added reverse map from 104.12.168.192.in-addr.arpa. to shelly-04.viehai.at
Jan 14 16:03:50 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-04' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Jan 14 16:03:50 srv4hai named[14530]: resolver priming query complete
Jan 14 16:03:51 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-04' - shIP/2:'192.168.12.104'
Jan 14 16:03:51 srv4hai conf_shelly.sh: SHELLY: usage/name 'Badezimmer' already set for '192.168.12.104'
Jan 14 16:03:51 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(0)' - allready transmitted - skipping
Jan 14 16:03:51 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(1)' - allready transmitted - skipping
Jan 14 16:03:51 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(2)' - allready transmitted - skipping
Jan 14 16:03:51 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(3)' - allready transmitted - skipping
Jan 14 16:03:51 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(4)' - allready transmitted - skipping
Jan 14 16:03:51 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(5)' - allready transmitted - skipping
Jan 14 16:03:51 srv4hai conf_shelly.sh: SHELLY:'shelly-04' out:0 ON : MISSING
Jan 14 16:03:51 srv4hai conf_shelly.sh: SHELLY:'shelly-04' out:0 OFF: MISSING
Jan 14 16:03:51 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan 14 16:03:51 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan 14 16:03:56 srv4hai ping_SP.sh: SHELLY (0)- ping 192.168.12.61 0 not answered (1) @~1705244636 - 'ping_SP_0'
Jan 14 16:03:59 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan 14 16:04:00 srv4hai named[14530]: resolver priming query complete
Jan 14 16:04:00 srv4hai fetchmail[1651]: 35578 messages (35575 seen) for tmiglinci at mail.akis.at (-1320465439 octets).
Jan 14 16:04:00 srv4hai postfix/smtpd[25916]: connect from localhost[127.0.0.1]
Jan 14 16:04:00 srv4hai postfix/smtpd[25916]: BB6F26011A: client=localhost[127.0.0.1]
Jan 14 16:04:00 srv4hai postfix/cleanup[25526]: BB6F26011A: message-id=
Jan 14 16:04:00 srv4hai postfix/qmgr[28610]: BB6F26011A: from=, size=56580, nrcpt=1 (queue active)
Jan 14 16:04:00 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:35576 of 35578 (56349 octets) not flushed
Jan 14 16:04:00 srv4hai postfix/local[25692]: BB6F26011A: to=, relay=local, delay=0.07, delays=0.05/0/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 14 16:04:00 srv4hai postfix/qmgr[28610]: BB6F26011A: removed
Jan 14 16:04:00 srv4hai postfix/smtpd[25916]: CDB146011A: client=localhost[127.0.0.1]
Jan 14 16:04:00 srv4hai postfix/cleanup[25526]: CDB146011A: message-id=<20240114150132.66BA060244@mail.viehai.at>
Jan 14 16:04:00 srv4hai postfix/qmgr[28610]: CDB146011A: from=, size=3532, nrcpt=1 (queue active)
Jan 14 16:04:00 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:35577 of 35578 (3250 octets) not flushed
Jan 14 16:04:00 srv4hai postfix/local[25692]: CDB146011A: to=, relay=local, delay=0.08, delays=0.07/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 14 16:04:00 srv4hai postfix/qmgr[28610]: CDB146011A: removed
Jan 14 16:04:00 srv4hai postfix/smtpd[25916]: F06EB6011A: client=localhost[127.0.0.1]
Jan 14 16:04:01 srv4hai postfix/cleanup[25526]: F06EB6011A: message-id=<20240114150146.58FD860244@mail.viehai.at>
Jan 14 16:04:01 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:35578 of 35578 (1475 octets) not flushed
Jan 14 16:04:01 srv4hai postfix/qmgr[28610]: F06EB6011A: from=, size=1759, nrcpt=1 (queue active)
Jan 14 16:04:01 srv4hai postfix/smtpd[25916]: disconnect from localhost[127.0.0.1] ehlo=1 mail=3 rcpt=3 data=3 quit=1 commands=11
Jan 14 16:04:01 srv4hai postfix/local[25692]: F06EB6011A: to=, relay=local, delay=0.06, delays=0.05/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 14 16:04:01 srv4hai postfix/qmgr[28610]: F06EB6011A: removed
Jan 14 16:04:01 srv4hai fetchmail[1651]: 9765 messages (9765 seen) for srozum at mail.akis.at (1180305293 octets).
Jan 14 16:04:01 srv4hai CRON[25922]: (root) CMD (/etc/linetest/linetest.sh)
Jan 14 16:04:02 srv4hai fetchmail[1651]: 21075 messages (21075 seen) for mrozum at mail.akis.at (-729562172 octets).
Jan 14 16:04:02 srv4hai named[14530]: resolver priming query complete
Jan 14 16:04:02 srv4hai fetchmail[1651]: 45 messages (45 seen) for admin@bastelstube.wien at pop3.world4you.com (12035480 octets).
Jan 14 16:04:06 srv4hai named[14530]: resolver priming query complete
Jan 14 16:04:06 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1705244646 - 'ping_SP_0'
Jan 14 16:04:09 srv4hai named[14530]: resolver priming query complete
Jan 14 16:04:22 srv4hai named[14530]: resolver priming query complete
Jan 14 16:04:37 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1705244677 - 'ping_SP_0'
Jan 14 16:04:55 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan 14 16:04:55 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan 14 16:04:57 srv4hai named[14530]: resolver priming query complete
Jan 14 16:05:00 srv4hai named[14530]: resolver priming query complete
Jan 14 16:05:01 srv4hai CRON[25952]: (root) CMD (/etc/linetest/linetest.sh)
Jan 14 16:05:07 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1705244707 - 'ping_SP_0'
Jan 14 16:05:17 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=25967, secured, session=
Jan 14 16:05:17 srv4hai dovecot: imap(miglincit)<25967>: Logged out in=420 out=36944 deleted=0 expunged=0 trashed=0 hdr_count=50 hdr_bytes=13580 body_count=0 body_bytes=0
Jan 14 16:05:24 srv4hai named[14530]: resolver priming query complete
Jan 14 16:05:34 srv4hai dhcpd[1107]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Jan 14 16:05:34 srv4hai dhcpd[1107]: execute_statement argv[1] = 192.168.12.10
Jan 14 16:05:34 srv4hai dhcpd[1107]: execute_statement argv[2] = pchai7x
Jan 14 16:05:34 srv4hai dhcpd[1107]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Jan 14 16:05:34 srv4hai dhcpd[1107]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Jan 14 16:05:34 srv4hai named[14530]: client @0x7fc3180a5240 192.168.12.252#39921/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 14 16:05:34 srv4hai named[14530]: client @0x7fc31405bd50 192.168.12.252#46601/key rndc-key: signer "rndc-key" approved
Jan 14 16:05:34 srv4hai named[14530]: client @0x7fc31405bd50 192.168.12.252#46601/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Jan 14 16:05:34 srv4hai named[14530]: client @0x7fc31405bd50 192.168.12.252#46601/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Jan 14 16:05:34 srv4hai named[14530]: client @0x7fc31405bd50 192.168.12.252#46601/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Jan 14 16:05:34 srv4hai named[14530]: client @0x7fc31405bd50 192.168.12.252#46601/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Jan 14 16:05:34 srv4hai dhcpd[1107]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Jan 14 16:05:34 srv4hai named[14530]: client @0x7fc32811da30 192.168.12.252#58091/key rndc-key: signer "rndc-key" approved
Jan 14 16:05:34 srv4hai named[14530]: client @0x7fc32811da30 192.168.12.252#58091/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Jan 14 16:05:34 srv4hai named[14530]: client @0x7fc32811da30 192.168.12.252#58091/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '10.12.168.192.in-addr.arpa' PTR pchai7x.viehai.at.
Jan 14 16:05:34 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Jan 14 16:05:34 srv4hai dhcpd[1107]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at

finished