activate_scenario.sh
Sun Jan 26 08:06:46 CET 2025
scenario: sekr_UM
source: 192.168.12.252

'day' <--> 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/01/26/_0.log)

vorher: 08:06:46.475

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: 08:06:46.552
Dauer: 77 msec phName: 'source:'192.168.12.252''


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

urls : 1
vorher : 08:06:46.449
nachher: 08:06:46.559
Dauer : 110 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/26//scene_sekr_UM_20250126_080646.txt'


syslog

Jan 26 08:03:02 srv4hai CRON[4288]: (root) CMD (/etc/linetest/linetest.sh)
Jan 26 08:03:34 srv4hai ping_SP[19797]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1737875014 - 'ping_SP_1'
Jan 26 08:03:34 srv4hai ping_SP[19797]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 26 08:04:01 srv4hai CRON[4326]: (root) CMD (/etc/linetest/linetest.sh)
Jan 26 08:04:38 srv4hai ping_SP[19797]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1737875078 - 'ping_SP_1'
Jan 26 08:04:38 srv4hai ping_SP[19797]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 26 08:04:59 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4369, secured, session=
Jan 26 08:04:59 srv4hai dovecot: imap(miglincit)<4369>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 26 08:05:00 srv4hai common[4371]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 26 08:05:00 srv4hai bt_scan[4371]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Jan 26 08:05:00 srv4hai bt_scan[4371]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Jan 26 08:05:00 srv4hai common[4402]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 26 08:05:00 srv4hai ping_SP[4402]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jan 26 08:05:00 srv4hai common[4434]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 26 08:05:00 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'0'=1737875100-1737875100
Jan 26 08:05:00 srv4hai check_presence[4434]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY} and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jan 26 08:05:00 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'0'=1737875100-1737875100
Jan 26 08:05:00 srv4hai check_presence[4434]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jan 26 08:05:00 srv4hai check_presence[4434]: SHELLY (ping_SP__bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jan 26 08:05:00 srv4hai check_presence[4434]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(__/__) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Jan 26 08:05:01 srv4hai check_presence[4434]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_offDownstairs) - sceneONsmall(vorraumOn)
Jan 26 08:05:01 srv4hai check_presence[4434]: SHELLY (ping_SP__bt_scan)-(0)-coming: activate_scenario.shtml: vorraumOn
Jan 26 08:05:01 srv4hai activate_scenario[4557]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jan 26 08:05:01 srv4hai activate_scenario[4557]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
Jan 26 08:05:01 srv4hai activate_scenario[4557]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
Jan 26 08:05:01 srv4hai postfix/pickup[2822]: 1DC6163463: uid=33 from=
Jan 26 08:05:01 srv4hai CRON[4617]: (root) CMD (/etc/linetest/linetest.sh)
Jan 26 08:05:01 srv4hai postfix/cleanup[4608]: 1DC6163463: message-id=<20250126070501.1DC6163463@mail.viehai.at>
Jan 26 08:05:01 srv4hai postfix/qmgr[8566]: 1DC6163463: from=, size=8687, nrcpt=1 (queue active)
Jan 26 08:05:01 srv4hai activate_scenario[4557]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'VZ Licht' --> '0?turn=on'
Jan 26 08:05:01 srv4hai proc_url[4630]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/26/_0.log' - shellyUsage:'VZ Licht' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
Jan 26 08:05:01 srv4hai activate_scenario[4557]: SHELLY scenario: 'vorraumOn(vorraumon)' took 167 msec, phoneName:'0'
Jan 26 08:05:01 srv4hai ping_SP[4402]: SHELLY check_presence.sh coming 0 ping_SP__bt_scan
Jan 26 08:05:01 srv4hai ping_SP[4402]: SHELLY - new process for '192.168.12.61' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1737875101
Jan 26 08:05:02 srv4hai postfix/relay/smtp[4626]: 1DC6163463: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=1.1, delays=0.02/0.01/0.78/0.3, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as F2F49600C7)
Jan 26 08:05:02 srv4hai postfix/qmgr[8566]: 1DC6163463: removed
Jan 26 08:05:17 srv4hai ping_SP[4402]: SHELLY (0)- ping 192.168.12.61 0 not answered (1) @~1737875117 - 'ping_SP_0'
Jan 26 08:05:39 srv4hai postfix/anvil[4141]: statistics: max connection rate 1/60s for (smtp:172.245.129.231) at Jan 26 08:01:57
Jan 26 08:05:39 srv4hai postfix/anvil[4141]: statistics: max connection count 1 for (smtp:172.245.129.231) at Jan 26 08:01:57
Jan 26 08:05:39 srv4hai postfix/anvil[4141]: statistics: max cache size 2 at Jan 26 08:02:15
Jan 26 08:05:43 srv4hai ping_SP[4402]: SHELLY (0)- ping 192.168.12.61 1 not answered (1) @~1737875143 - 'ping_SP_0'
Jan 26 08:05:45 srv4hai postfix/smtpd[4716]: connect from starttls-virginia.securing-email.com[34.227.19.103]
Jan 26 08:05:46 srv4hai postfix/smtpd[4716]: disconnect from starttls-virginia.securing-email.com[34.227.19.103] ehlo=2 starttls=1 quit=1 commands=4
Jan 26 08:05:49 srv4hai dhcpd[4995]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
Jan 26 08:05:49 srv4hai dhcpd[4995]: DHCPDISCOVER from cc:8d:a2:60:52:b8 via enp2s0
Jan 26 08:05:49 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
Jan 26 08:05:49 srv4hai dhcpd[4995]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
Jan 26 08:05:49 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 26 08:05:49 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.101
Jan 26 08:05:49 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-01
Jan 26 08:05:49 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.101 (192.168.12.252) from cc:8d:a2:60:52:b8 via enp2s0
Jan 26 08:05:49 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
Jan 26 08:05:49 srv4hai named[30406]: client @0x7f93480deab0 192.168.12.252#41927/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-01.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 26 08:05:49 srv4hai named[30406]: client @0x7f93380793b0 192.168.12.252#46431/key rndc-key: signer "rndc-key" approved
Jan 26 08:05:49 srv4hai named[30406]: client @0x7f93380793b0 192.168.12.252#46431/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' TXT
Jan 26 08:05:49 srv4hai named[30406]: client @0x7f93380793b0 192.168.12.252#46431/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' TXT "31166740fe21d7ece7561d62986d2b8644"
Jan 26 08:05:49 srv4hai named[30406]: client @0x7f93380793b0 192.168.12.252#46431/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' A
Jan 26 08:05:49 srv4hai named[30406]: client @0x7f93380793b0 192.168.12.252#46431/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' A 192.168.12.101
Jan 26 08:05:49 srv4hai dhcpd[4995]: Added new forward map from shelly-01.viehai.at to 192.168.12.101
Jan 26 08:05:49 srv4hai named[30406]: client @0x7f935011da30 192.168.12.252#37625/key rndc-key: signer "rndc-key" approved
Jan 26 08:05:49 srv4hai named[30406]: client @0x7f935011da30 192.168.12.252#37625/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '101.12.168.192.in-addr.arpa' PTR
Jan 26 08:05:49 srv4hai named[30406]: client @0x7f935011da30 192.168.12.252#37625/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '101.12.168.192.in-addr.arpa' PTR shelly-01.viehai.at.
Jan 26 08:05:49 srv4hai dhcpd[4995]: Added reverse map from 101.12.168.192.in-addr.arpa. to shelly-01.viehai.at
Jan 26 08:05:49 srv4hai common[4720]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan 26 08:05:49 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-01' - shIP/2:'' perform:'conf'
Jan 26 08:05:50 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-01' - shIP/2:'192.168.12.101'
Jan 26 08:05:50 srv4hai conf_shelly.sh: SHELLY: usage/name 'WZ Licht Esstisch' already set for '192.168.12.101'
Jan 26 08:05:50 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(0)' - allready transmitted - skipping
Jan 26 08:05:50 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(1)' - allready transmitted - skipping
Jan 26 08:05:50 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(2)' - allready transmitted - skipping
Jan 26 08:05:51 srv4hai ping_SP[19797]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1737875151 - 'ping_SP_1'
Jan 26 08:05:51 srv4hai ping_SP[19797]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 26 08:06:01 srv4hai CRON[4826]: (root) CMD (/etc/linetest/linetest.sh)
Jan 26 08:06:09 srv4hai ping_SP[4402]: SHELLY (0)- ping 192.168.12.61 2 not answered (1) @~1737875169 - 'ping_SP_0'
Jan 26 08:06:36 srv4hai ping_SP[4402]: SHELLY (0)- ping 192.168.12.61 3 not answered (1) @~1737875196 - 'ping_SP_0'
Jan 26 08:06:37 srv4hai postfix/smtpd[4716]: warning: hostname 172-245-9-111-host.colocrossing.com does not resolve to address 172.245.9.111: Name or service not known
Jan 26 08:06:37 srv4hai postfix/smtpd[4716]: connect from unknown[172.245.9.111]
Jan 26 08:06:42 srv4hai postfix/smtpd[4716]: warning: unknown[172.245.9.111]: SASL PLAIN authentication failed: 
Jan 26 08:06:42 srv4hai postfix/smtpd[4716]: disconnect from unknown[172.245.9.111] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 26 08:06:45 srv4hai common[4874]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 26 08:06:46 srv4hai common[4904]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 26 08:06:46 srv4hai activate_scenario[4941]: SHELLY scenario: 'sekr_UM(sekr_um)' started
Jan 26 08:06:46 srv4hai activate_scenario[4941]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - source:'192.168.12.252'

finished