activate_scenario.sh
Tue Jul 23 06:47:50 CEST 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/07/23/_0.log)

vorher: 06:47:50.893

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: 06:47:50.926
Dauer: 33 msec phName: 'shelly-40:'Thomas Büro Licht''


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

vorher: 06:47:50.909

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: 06:47:50.939
Dauer: 30 msec phName: 'shelly-40:'Thomas Büro Licht''


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

urls : 2
vorher : 06:47:50.869
nachher: 06:47:50.946
Dauer : 77 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/07/23//scene_buero_UM_20240723_064750.txt'


syslog

Jul 23 06:44:01 srv4hai CRON[29601]: (root) CMD (/etc/linetest/linetest.sh)
Jul 23 06:44:03 srv4hai ping_SP[15063]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1721709843 - 'ping_SP_1'
Jul 23 06:44:03 srv4hai ping_SP[15063]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 23 06:44:33 srv4hai ping_SP[22811]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1721709873 - 'ping_SP_0'
Jul 23 06:44:33 srv4hai ping_SP[22811]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 23 06:44:39 srv4hai postfix/anvil[28503]: statistics: max connection rate 1/60s for (smtp:157.52.230.223) at Jul 23 06:39:14
Jul 23 06:44:39 srv4hai postfix/anvil[28503]: statistics: max connection count 1 for (smtp:157.52.230.223) at Jul 23 06:39:14
Jul 23 06:44:39 srv4hai postfix/anvil[28503]: statistics: max cache size 1 at Jul 23 06:39:14
Jul 23 06:45:01 srv4hai CRON[29644]: (root) CMD (/etc/linetest/linetest.sh)
Jul 23 06:45:16 srv4hai ping_SP[15063]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1721709916 - 'ping_SP_1'
Jul 23 06:45:16 srv4hai ping_SP[15063]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 23 06:45:47 srv4hai ping_SP[22811]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1721709947 - 'ping_SP_0'
Jul 23 06:45:47 srv4hai ping_SP[22811]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 23 06:45:56 srv4hai common[29692]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jul 23 06:46:01 srv4hai CRON[29706]: (root) CMD (/etc/linetest/linetest.sh)
Jul 23 06:46:06 srv4hai bt_scan[29692]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Jul 23 06:46:06 srv4hai bt_scan[29692]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Jul 23 06:46:06 srv4hai common[29730]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jul 23 06:46:07 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'3'=1721709967-1721709964
Jul 23 06:46:07 srv4hai check_presence[29730]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jul 23 06:46:07 srv4hai check_presence[29730]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Jul 23 06:46:07 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'3'=1721709967-1721709964
Jul 23 06:46:07 srv4hai check_presence[29730]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jul 23 06:46:07 srv4hai check_presence[29730]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Jul 23 06:46:07 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'3'=1721709967-1721709964
Jul 23 06:46:07 srv4hai check_presence[29730]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jul 23 06:46:07 srv4hai check_presence[29730]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(BT/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jul 23 06:46:07 srv4hai check_presence[29730]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_offAll) - sceneOFF(offAll)
Jul 23 06:46:07 srv4hai check_presence[29730]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Jul 23 06:46:09 srv4hai common[29889]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jul 23 06:46:17 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=29907, secured, session=
Jul 23 06:46:17 srv4hai dovecot: imap(miglincit)<29907>: Logged out in=290 out=1641 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 23 06:46:19 srv4hai bt_scan[29889]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Jul 23 06:46:19 srv4hai bt_scan[29889]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Jul 23 06:46:30 srv4hai ping_SP[15063]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1721709990 - 'ping_SP_1'
Jul 23 06:46:30 srv4hai ping_SP[15063]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 23 06:46:52 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jul 23 06:46:53 srv4hai fetchmail[1651]: 49178 messages (49178 seen) for tmiglinci at mail.akis.at (-225477761 octets).
Jul 23 06:46:53 srv4hai fetchmail[1651]: 10494 messages (10494 seen) for srozum at mail.akis.at (1263129436 octets).
Jul 23 06:46:54 srv4hai fetchmail[1651]: 24891 messages (24891 seen) for mrozum at mail.akis.at (61849353 octets).
Jul 23 06:46:54 srv4hai fetchmail[1651]: 1139 messages (1139 seen) for admin@bastelstube.wien at pop3.world4you.com (51570784 octets).
Jul 23 06:47:00 srv4hai ping_SP[22811]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1721710020 - 'ping_SP_0'
Jul 23 06:47:00 srv4hai ping_SP[22811]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 23 06:47:01 srv4hai CRON[29971]: (root) CMD (/etc/linetest/linetest.sh)
Jul 23 06:47:27 srv4hai activate_scenario[29980]: SHELLY scenario: 'buero_UM(buero_um)' started
Jul 23 06:47:27 srv4hai activate_scenario[29980]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'
Jul 23 06:47:27 srv4hai activate_scenario[29980]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'Thomas Büro Licht'
Jul 23 06:47:27 srv4hai postfix/pickup[25360]: F09936018A: uid=33 from=
Jul 23 06:47:27 srv4hai postfix/cleanup[30033]: F09936018A: message-id=<20240723044727.F09936018A@mail.viehai.at>
Jul 23 06:47:27 srv4hai postfix/qmgr[8566]: F09936018A: from=, size=6081, nrcpt=1 (queue active)
Jul 23 06:47:28 srv4hai postfix/local[30046]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jul 23 06:47:28 srv4hai activate_scenario[29980]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Jul 23 06:47:28 srv4hai proc_url[30051]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/07/23/_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 23 06:47:28 srv4hai postfix/local[30046]: F09936018A: to=, orig_to=, relay=local, delay=0.04, delays=0.02/0.01/0/0.02, dsn=5.1.1, status=bounced (unknown user: "null")
Jul 23 06:47:28 srv4hai postfix/cleanup[30033]: 044276018B: message-id=<20240723044728.044276018B@mail.viehai.at>
Jul 23 06:47:28 srv4hai postfix/bounce[30047]: F09936018A: sender non-delivery notification: 044276018B
Jul 23 06:47:28 srv4hai postfix/qmgr[8566]: 044276018B: from=<>, size=8003, nrcpt=1 (queue active)
Jul 23 06:47:28 srv4hai postfix/qmgr[8566]: F09936018A: removed
Jul 23 06:47:28 srv4hai activate_scenario[29980]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Jul 23 06:47:28 srv4hai postfix/local[30046]: 044276018B: to=, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jul 23 06:47:28 srv4hai postfix/qmgr[8566]: 044276018B: removed
Jul 23 06:47:28 srv4hai proc_url[30063]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/07/23/_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 23 06:47:28 srv4hai activate_scenario[29980]: SHELLY scenario: 'buero_UM(buero_um)' took 299 msec, shelly-40:'Thomas Büro Licht'
Jul 23 06:47:47 srv4hai dhcpd[30731]: DHCPDISCOVER from 98:cd:ac:1e:65:28 via enp2s0
Jul 23 06:47:47 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.113 to 98:cd:ac:1e:65:28 via enp2s0
Jul 23 06:47:47 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jul 23 06:47:47 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.113
Jul 23 06:47:47 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-13
Jul 23 06:47:47 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.113 (192.168.12.252) from 98:cd:ac:1e:65:28 via enp2s0
Jul 23 06:47:47 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.113 to 98:cd:ac:1e:65:28 via enp2s0
Jul 23 06:47:47 srv4hai named[30406]: client @0x7f931c03b370 192.168.12.252#35195/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-13.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 23 06:47:47 srv4hai named[30406]: client @0x7f932c079890 192.168.12.252#40435/key rndc-key: signer "rndc-key" approved
Jul 23 06:47:47 srv4hai named[30406]: client @0x7f932c079890 192.168.12.252#40435/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-13.viehai.at' TXT
Jul 23 06:47:47 srv4hai named[30406]: client @0x7f932c079890 192.168.12.252#40435/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-13.viehai.at' TXT "00003d87d7ce132fb28c24bab993e73221"
Jul 23 06:47:47 srv4hai named[30406]: client @0x7f932c079890 192.168.12.252#40435/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-13.viehai.at' A
Jul 23 06:47:47 srv4hai named[30406]: client @0x7f932c079890 192.168.12.252#40435/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-13.viehai.at' A 192.168.12.113
Jul 23 06:47:47 srv4hai dhcpd[30731]: Added new forward map from shelly-13.viehai.at to 192.168.12.113
Jul 23 06:47:47 srv4hai named[30406]: client @0x7f93380c3840 192.168.12.252#58683/key rndc-key: signer "rndc-key" approved
Jul 23 06:47:47 srv4hai named[30406]: client @0x7f93380c3840 192.168.12.252#58683/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '113.12.168.192.in-addr.arpa' PTR
Jul 23 06:47:47 srv4hai named[30406]: client @0x7f93380c3840 192.168.12.252#58683/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '113.12.168.192.in-addr.arpa' PTR shelly-13.viehai.at.
Jul 23 06:47:47 srv4hai dhcpd[30731]: Added reverse map from 113.12.168.192.in-addr.arpa. to shelly-13.viehai.at
Jul 23 06:47:47 srv4hai common[30111]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jul 23 06:47:47 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-13' - shIP/2:'' perform:'conf'
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-13' - shIP/2:'192.168.12.113'
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY: usage/name 'Thomas Taster' already set for '192.168.12.113'
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY:'shelly-13' 'conf(0)' - allready transmitted - skipping
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY:'shelly-13' 'conf(1)' - allready transmitted - skipping
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY:'shelly-13' 'conf(2)' - IGNORED
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY:'shelly-13' 'conf(3)' - allready transmitted - skipping
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY:'shelly-13' 'conf(4)' - allready transmitted - skipping
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY:'shelly-13' 'conf(5)' - allready transmitted - skipping
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY:'shelly-13' 'conf(6)' - allready transmitted - skipping
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY:'shelly-13' 'conf(7)' - allready transmitted - skipping
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY:'shelly-13' 'conf(8)' - allready transmitted - skipping
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY:'shelly-13' 'conf(9)' - allready transmitted - skipping
Jul 23 06:47:48 srv4hai conf_shelly.sh: SHELLY:'shelly-13' 'conf(10)' - allready transmitted - skipping
Jul 23 06:47:48 srv4hai ag: grab_shelly.sh SHELLY shelly-13 - (shelly-BTN): 100% - 4.15V
Jul 23 06:47:50 srv4hai activate_scenario[30317]: SHELLY scenario: 'buero_UM(buero_um)' started
Jul 23 06:47:50 srv4hai activate_scenario[30317]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'

finished