activate_scenario.sh
Sat Feb 10 10:19:20 CET 2024
scenario: welcomeLight
phoneName: 0

'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'thomas@miglinci.name'

scenario: 'Willkommen-Licht EIN-schalten' - 'welcomeLight' - 'welcomelight'

Licht Vorzimmer (/srv/www/viehai/shelly/log_scenarios/2024/02/10/_0.log)

vorher: 10:19:20.308

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

nachher: 10:19:20.418
Dauer: 110 msec phName: 'phoneName:'0''


Küche Licht Naßzeile (/srv/www/viehai/shelly/log_scenarios/2024/02/10/_1.log)

vorher: 10:19:20.327

http://192.168.12.116/white/0?turn=on&brightness=50
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 50,
  "transition": 0,
  "power": 8.87,
  "overpower": false

nachher: 10:19:20.406
Dauer: 78 msec phName: 'phoneName:'0''


Küche Licht Naßzeile (/srv/www/viehai/shelly/log_scenarios/2024/02/10/_2.log)

vorher: 10:19:20.343

http://192.168.12.116/white/1?turn=on&brightness=50
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 50,
  "transition": 0,
  "power": 8.87,
  "overpower": false

nachher: 10:19:20.407
Dauer: 64 msec phName: 'phoneName:'0''


Küche Licht Herdzeile (/srv/www/viehai/shelly/log_scenarios/2024/02/10/_3.log)

vorher: 10:19:20.360

http://192.168.12.117/white/0?turn=on&brightness=50
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 50,
  "transition": 0,
  "power": 0,
  "overpower": false

nachher: 10:19:20.428
Dauer: 67 msec phName: 'phoneName:'0''


Küche Licht Herdzeile (/srv/www/viehai/shelly/log_scenarios/2024/02/10/_4.log)

vorher: 10:19:20.377

http://192.168.12.117/white/1?turn=on&brightness=50
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 50,
  "transition": 0,
  "power": 0,
  "overpower": false

nachher: 10:19:20.434
Dauer: 57 msec phName: 'phoneName:'0''


scenario: 'Willkommen-Licht EIN-schalten' - 'welcomeLight' - 'welcomelight'

urls : 5
vorher : 10:19:20.284
nachher: 10:19:20.441
Dauer : 158 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/02/10//scene_welcomeLight_20240210_101920.txt'


syslog

Feb 10 10:16:00 srv4hai named[14530]: resolver priming query complete
Feb 10 10:16:01 srv4hai CRON[10852]: (root) CMD (/etc/linetest/linetest.sh)
Feb 10 10:16:05 srv4hai named[14530]: resolver priming query complete
Feb 10 10:16:11 srv4hai dhcpd[5037]: DHCPDISCOVER from c0:49:ef:8a:c9:d8 via enp2s0
Feb 10 10:16:11 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Feb 10 10:16:11 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Feb 10 10:16:11 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.139
Feb 10 10:16:11 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-39
Feb 10 10:16:11 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.139 (192.168.12.252) from c0:49:ef:8a:c9:d8 via enp2s0
Feb 10 10:16:11 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Feb 10 10:16:11 srv4hai named[14530]: client @0x7fc3180c14a0 192.168.12.252#56085/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-39.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 10 10:16:11 srv4hai named[14530]: client @0x7fc308005af0 192.168.12.252#39667/key rndc-key: signer "rndc-key" approved
Feb 10 10:16:11 srv4hai named[14530]: client @0x7fc308005af0 192.168.12.252#39667/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' TXT
Feb 10 10:16:11 srv4hai named[14530]: client @0x7fc308005af0 192.168.12.252#39667/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' TXT "314be662bb43914e78b269d3f3bc9f38c7"
Feb 10 10:16:11 srv4hai named[14530]: client @0x7fc308005af0 192.168.12.252#39667/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' A
Feb 10 10:16:11 srv4hai named[14530]: client @0x7fc308005af0 192.168.12.252#39667/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' A 192.168.12.139
Feb 10 10:16:11 srv4hai dhcpd[5037]: Added new forward map from shelly-39.viehai.at to 192.168.12.139
Feb 10 10:16:11 srv4hai named[14530]: client @0x7fc31c0a3b90 192.168.12.252#59219/key rndc-key: signer "rndc-key" approved
Feb 10 10:16:11 srv4hai named[14530]: client @0x7fc31c0a3b90 192.168.12.252#59219/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '139.12.168.192.in-addr.arpa' PTR
Feb 10 10:16:11 srv4hai named[14530]: client @0x7fc31c0a3b90 192.168.12.252#59219/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '139.12.168.192.in-addr.arpa' PTR shelly-39.viehai.at.
Feb 10 10:16:11 srv4hai dhcpd[5037]: Added reverse map from 139.12.168.192.in-addr.arpa. to shelly-39.viehai.at
Feb 10 10:16:11 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-39' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Feb 10 10:16:11 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Feb 10 10:16:11 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: gen=2&temp=12.900000&hum=67.100000&id=C049EF8AC9D8&batt=100&volt=6.710000
Feb 10 10:16:11 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-39_20240210.csv'
Feb 10 10:16:11 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/02/shelly-39_20240210.csv' modifed 548s ago - EXIT
Feb 10 10:16:11 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Feb 10 10:16:11 srv4hai conf_shelly.sh: SHELLY:'shelly-39' 'conf(0)' - 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}'
Feb 10 10:16:11 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-cmd: 'curl --connect-timeout 3 --silent -X -POST -d 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}' http://192.168.12.139/rpc | jq -r '.''
Feb 10 10:16:11 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Feb 10 10:16:11 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Feb 10 10:16:28 srv4hai named[14530]: resolver priming query complete
Feb 10 10:16:30 srv4hai ping_SP[27232]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1707556590 - 'ping_SP_0'
Feb 10 10:16:30 srv4hai ping_SP[27232]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 10 10:16:35 srv4hai named[14530]: resolver priming query complete
Feb 10 10:16:41 srv4hai named[14530]: resolver priming query complete
Feb 10 10:16:42 srv4hai named[14530]: resolver priming query complete
Feb 10 10:17:01 srv4hai CRON[10990]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Feb 10 10:17:01 srv4hai CRON[10991]: (root) CMD (/etc/linetest/linetest.sh)
Feb 10 10:17:04 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=11002, secured, session=
Feb 10 10:17:04 srv4hai dovecot: imap(miglincit)<11002>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 10 10:17:11 srv4hai named[14530]: resolver priming query complete
Feb 10 10:17:20 srv4hai named[14530]: resolver priming query complete
Feb 10 10:17:25 srv4hai postfix/anvil[10753]: statistics: max connection rate 1/60s for (smtp:193.222.96.116) at Feb 10 10:14:05
Feb 10 10:17:25 srv4hai postfix/anvil[10753]: statistics: max connection count 1 for (smtp:193.222.96.116) at Feb 10 10:14:05
Feb 10 10:17:25 srv4hai postfix/anvil[10753]: statistics: max cache size 1 at Feb 10 10:14:05
Feb 10 10:17:28 srv4hai named[14530]: resolver priming query complete
Feb 10 10:17:31 srv4hai postfix/smtpd[11008]: connect from unknown[91.215.85.17]
Feb 10 10:17:33 srv4hai ping_SP[27232]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1707556653 - 'ping_SP_0'
Feb 10 10:17:33 srv4hai ping_SP[27232]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 10 10:17:36 srv4hai postfix/smtpd[11008]: warning: unknown[91.215.85.17]: SASL PLAIN authentication failed: 
Feb 10 10:17:36 srv4hai postfix/smtpd[11008]: disconnect from unknown[91.215.85.17] ehlo=2 starttls=1 auth=0/1 quit=1 unknown=0/1 commands=4/6
Feb 10 10:17:39 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Feb 10 10:17:39 srv4hai fetchmail[1651]: 37798 messages (37798 seen) for tmiglinci at mail.akis.at (-1172536974 octets).
Feb 10 10:17:40 srv4hai fetchmail[1651]: 9883 messages (9883 seen) for srozum at mail.akis.at (1192825111 octets).
Feb 10 10:17:40 srv4hai fetchmail[1651]: 21575 messages (21575 seen) for mrozum at mail.akis.at (-593470966 octets).
Feb 10 10:17:40 srv4hai fetchmail[1651]: 45 messages (45 seen) for admin@bastelstube.wien at pop3.world4you.com (12035480 octets).
Feb 10 10:18:01 srv4hai CRON[11048]: (root) CMD (/etc/linetest/linetest.sh)
Feb 10 10:18:03 srv4hai named[14530]: resolver priming query complete
Feb 10 10:18:16 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=11059, secured, session=
Feb 10 10:18:16 srv4hai dovecot: imap(miglincit)<11059>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 10 10:18:17 srv4hai named[14530]: resolver priming query complete
Feb 10 10:18:19 srv4hai named[14530]: resolver priming query complete
Feb 10 10:18:21 srv4hai named[14530]: resolver priming query complete
Feb 10 10:18:23 srv4hai named[14530]: resolver priming query complete
Feb 10 10:18:28 srv4hai named[14530]: resolver priming query complete
Feb 10 10:18:36 srv4hai ping_SP[27232]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1707556716 - 'ping_SP_0'
Feb 10 10:18:36 srv4hai ping_SP[27232]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 10 10:19:01 srv4hai dovecot: imap(miglincit)<3173><0vfTeQIRxIzAqAwK>: Logged out in=6163 out=729926 deleted=0 expunged=0 trashed=0 hdr_count=29 hdr_bytes=10630 body_count=29 body_bytes=622046
Feb 10 10:19:01 srv4hai CRON[11100]: (root) CMD (/etc/linetest/linetest.sh)
Feb 10 10:19:01 srv4hai activate_scenario[11105]: SHELLY scenario: 'pcOFF(pcoff)' started
Feb 10 10:19:01 srv4hai activate_scenario[11105]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-0:''
Feb 10 10:19:01 srv4hai activate_scenario[11105]: SHELLY scenario: 'pcOFF(pcoff)' TO BE EXECUTED, shelly-0:''
Feb 10 10:19:01 srv4hai postfix/pickup[5471]: C3C2860244: uid=33 from=
Feb 10 10:19:01 srv4hai postfix/cleanup[11158]: C3C2860244: message-id=<20240210091901.C3C2860244@mail.viehai.at>
Feb 10 10:19:01 srv4hai postfix/qmgr[28610]: C3C2860244: from=, size=9173, nrcpt=1 (queue active)
Feb 10 10:19:01 srv4hai activate_scenario[11105]: SHELLY: scenario: 'pcOFF(pcoff)'-'shelly-20'-'Thomas Schreibtischlampe' --> '0?turn=off'
Feb 10 10:19:01 srv4hai proc_url[11176]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/02/10/_0.log' - shellyUsage:'Thomas Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=off' - phName:'shelly-0:'''
Feb 10 10:19:01 srv4hai postfix/local[11171]: C3C2860244: to=, orig_to=, relay=local, delay=0.06, delays=0.04/0.01/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Feb 10 10:19:01 srv4hai postfix/cleanup[11158]: CC8C060245: message-id=<20240210091901.CC8C060245@mail.viehai.at>
Feb 10 10:19:01 srv4hai postfix/bounce[11172]: C3C2860244: sender non-delivery notification: CC8C060245
Feb 10 10:19:01 srv4hai postfix/qmgr[28610]: CC8C060245: from=<>, size=11052, nrcpt=1 (queue active)
Feb 10 10:19:01 srv4hai postfix/qmgr[28610]: C3C2860244: removed
Feb 10 10:19:01 srv4hai postfix/local[11171]: CC8C060245: to=, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb 10 10:19:01 srv4hai postfix/qmgr[28610]: CC8C060245: removed
Feb 10 10:19:01 srv4hai activate_scenario[11105]: SHELLY scenario: 'pcOFF(pcoff)' took 92 msec, shelly-0:''
Feb 10 10:19:04 srv4hai named[14530]: resolver priming query complete
Feb 10 10:19:12 srv4hai named[14530]: resolver priming query complete
Feb 10 10:19:15 srv4hai named[14530]: resolver priming query complete
Feb 10 10:19:16 srv4hai named[14530]: resolver priming query complete
Feb 10 10:19:20 srv4hai trace_events[11211]: SHELLY common.sh inkludiert
Feb 10 10:19:20 srv4hai named[14530]: resolver priming query complete
Feb 10 10:19:20 srv4hai bt_scan[11211]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / fixAddr: '192.168.12.61;' - found: 'Yes'
Feb 10 10:19:20 srv4hai bt_scan[11211]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Feb 10 10:19:20 srv4hai trace_events[11244]: SHELLY common.sh inkludiert
Feb 10 10:19:20 srv4hai ping_SP[11244]: SHELLY ping_SP.sh started from bt_scan
Feb 10 10:19:20 srv4hai trace_events[11252]: SHELLY common.sh inkludiert
Feb 10 10:19:20 srv4hai check_presence[11252]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(BT/IP) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Feb 10 10:19:20 srv4hai check_presence[11252]: SHELLY (ping_SP__bt_scan)-(0)-coming: activate_scenario.shtml: welcomeLight
Feb 10 10:19:20 srv4hai activate_scenario[11288]: SHELLY scenario: 'welcomeLight(welcomelight)' started
Feb 10 10:19:20 srv4hai activate_scenario[11288]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished