activate_scenario.sh
Sat Jan 4 13:29:09 CET 2025
scenario: vorraumOn
phoneName: 1

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

scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

VZ Licht (/srv/www/viehai/shelly/log_scenarios/2025/01/04/_0.log)

vorher: 13:29:09.906

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: 13:29:09.988
Dauer: 82 msec phName: 'phoneName:'1''


scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

urls : 1
vorher : 13:29:09.879
nachher: 13:29:09.994
Dauer : 116 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/04//scene_vorraumOn_20250104_132909.txt'


syslog

Jan  4 13:26:01 srv4hai CRON[20617]: (root) CMD (/etc/linetest/linetest.sh)
Jan  4 13:26:23 srv4hai named[30406]: resolver priming query complete
Jan  4 13:26:25 srv4hai ping_SP[27557]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1735993585 - 'ping_SP_0'
Jan  4 13:26:25 srv4hai ping_SP[27557]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan  4 13:27:01 srv4hai CRON[20649]: (root) CMD (/etc/linetest/linetest.sh)
Jan  4 13:27:27 srv4hai common[20659]: SHELLY common.sh inkludiert von ./modify_shelly.sh
Jan  4 13:27:27 srv4hai modify_shelly.sh: SHELLY QUERY_STRING='shelly=shelly-51'
Jan  4 13:27:27 srv4hai modify_shelly.sh: SHELLY shelly='shelly-51'
Jan  4 13:27:27 srv4hai common[20812]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//grab_shelly.sh
Jan  4 13:27:27 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-51' - shIP/2:'' perform:'dont_conf'
Jan  4 13:27:28 srv4hai ping_SP[27557]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1735993648 - 'ping_SP_0'
Jan  4 13:27:28 srv4hai ping_SP[27557]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan  4 13:27:30 srv4hai named[30406]: resolver priming query complete
Jan  4 13:28:01 srv4hai CRON[20878]: (root) CMD (/etc/linetest/linetest.sh)
Jan  4 13:28:03 srv4hai named[30406]: resolver priming query complete
Jan  4 13:28:14 srv4hai dhcpd[4995]: DHCPDISCOVER from 48:55:19:00:b3:58 via enp2s0
Jan  4 13:28:14 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.137 to 48:55:19:00:b3:58 via enp2s0
Jan  4 13:28:15 srv4hai postfix/anvil[20414]: statistics: max connection rate 1/60s for (smtp:80.94.95.239) at Jan  4 13:24:52
Jan  4 13:28:15 srv4hai postfix/anvil[20414]: statistics: max connection count 1 for (smtp:80.94.95.239) at Jan  4 13:24:52
Jan  4 13:28:15 srv4hai postfix/anvil[20414]: statistics: max cache size 1 at Jan  4 13:24:52
Jan  4 13:28:16 srv4hai nmbd[2172]: [2025/01/04 13:28:16.319186,  0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
Jan  4 13:28:16 srv4hai nmbd[2172]:   find_domain_master_name_query_fail:
Jan  4 13:28:16 srv4hai nmbd[2172]:   Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
Jan  4 13:28:16 srv4hai nmbd[2172]:   Unable to sync browse lists in this workgroup.
Jan  4 13:28:16 srv4hai dhcpd[4995]: DHCPDISCOVER from 48:55:19:00:b3:58 via enp2s0
Jan  4 13:28:16 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.137 to 48:55:19:00:b3:58 via enp2s0
Jan  4 13:28:16 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan  4 13:28:16 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.137
Jan  4 13:28:16 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-37
Jan  4 13:28:16 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.137 (192.168.12.252) from 48:55:19:00:b3:58 via enp2s0
Jan  4 13:28:16 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.137 to 48:55:19:00:b3:58 via enp2s0
Jan  4 13:28:16 srv4hai named[30406]: client @0x7f933805ba90 192.168.12.252#39085/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-37.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  4 13:28:16 srv4hai named[30406]: client @0x7f93380d2cb0 192.168.12.252#50831/key rndc-key: signer "rndc-key" approved
Jan  4 13:28:16 srv4hai named[30406]: client @0x7f93380d2cb0 192.168.12.252#50831/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-37.viehai.at' TXT
Jan  4 13:28:16 srv4hai named[30406]: client @0x7f93380d2cb0 192.168.12.252#50831/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-37.viehai.at' TXT "001bc21ebc20088cb6a311248591ab7101"
Jan  4 13:28:16 srv4hai named[30406]: client @0x7f93380d2cb0 192.168.12.252#50831/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-37.viehai.at' A
Jan  4 13:28:16 srv4hai named[30406]: client @0x7f93380d2cb0 192.168.12.252#50831/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-37.viehai.at' A 192.168.12.137
Jan  4 13:28:16 srv4hai dhcpd[4995]: Added new forward map from shelly-37.viehai.at to 192.168.12.137
Jan  4 13:28:16 srv4hai named[30406]: client @0x7f93480bd120 192.168.12.252#36161/key rndc-key: signer "rndc-key" approved
Jan  4 13:28:16 srv4hai named[30406]: client @0x7f93480bd120 192.168.12.252#36161/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '137.12.168.192.in-addr.arpa' PTR
Jan  4 13:28:16 srv4hai named[30406]: client @0x7f93480bd120 192.168.12.252#36161/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '137.12.168.192.in-addr.arpa' PTR shelly-37.viehai.at.
Jan  4 13:28:16 srv4hai dhcpd[4995]: Added reverse map from 137.12.168.192.in-addr.arpa. to shelly-37.viehai.at
Jan  4 13:28:16 srv4hai common[20886]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan  4 13:28:16 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-37' - shIP/2:'' perform:'conf'
Jan  4 13:28:17 srv4hai mosquitto[29419]: New connection from 192.168.12.137 on port 1883.
Jan  4 13:28:17 srv4hai mosquitto[29419]: New client connected from 192.168.12.137 as shellyht-00B358 (c1, k60, u'shmqtt').
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-37' - shIP/2:'192.168.12.137'
Jan  4 13:28:17 srv4hai common[20911]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 13:28:17 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=19.88&id=shellyht-00B358
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY: usage/name 'TB Klima' already set for '192.168.12.137'
Jan  4 13:28:17 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-37_20250104.csv'
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-37' - shIP/2:'192.168.12.137'
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(0)' - allready transmitted - skipping
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(1)' - allready transmitted - skipping
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(2)' - allready transmitted - skipping
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY: usage/name 'TB Klima' already set for '192.168.12.137'
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(3)' - ''
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(0)' - allready transmitted - skipping
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(1)' - allready transmitted - skipping
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(2)' - allready transmitted - skipping
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' 'conf(3)' - ''
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' conf(3)-cmd: 'curl --connect-timeout 3 --silent 'http://192.168.12.137/' | jq -r '.''
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' conf(3)-ret: ''
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' conf(3)-cmd: 'curl --connect-timeout 3 --silent 'http://192.168.12.137/' | jq -r '.''
Jan  4 13:28:17 srv4hai conf_shelly.sh: SHELLY:'shelly-37' conf(3)-ret: ''
Jan  4 13:28:17 srv4hai ht_shelly.sh: SHELLY shellyht-00B358 / shelly-37 / TB Klima: 19.88° - 40%
Jan  4 13:28:17 srv4hai ht_shelly.sh: SHELLY shellyht-00B358 / shelly-37 / TB Klima: 19.88°/19.62° - 40%/41% - SAVED
Jan  4 13:28:17 srv4hai ht_shelly.sh: SHELLY shellyht-00B358 / shelly-37 / TB Klima: batt='91'°
Jan  4 13:28:17 srv4hai named[30406]: resolver priming query complete
Jan  4 13:28:18 srv4hai ht_shelly.sh: SHELLY shellyht-00B358 / shelly-37 / TB Klima: dweetIO='{#012  "this": "succeeded",#012  "by": "dweeting",#012  "the": "dweet",#012  "with": {#012    "thing": "viehai-37",#012    "created": "2025-01-04T12:28:18.245Z",#012    "content": {#012      "temp": 19.88,#012      "hum": 40,#012      "batt": 91,#012      "csvF": "shelly-37_20250104.csv"#012    },#012    "transaction": "931a77cb-4e4b-4076-8f36-03af1877381b"#012  }#012}'°
Jan  4 13:28:19 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=21118, secured, session=
Jan  4 13:28:19 srv4hai dovecot: imap(miglincit)<21118>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan  4 13:28:22 srv4hai common[21121]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 13:28:22 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=19.88&id=shellyht-00B358
Jan  4 13:28:22 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-37_20250104.csv'
Jan  4 13:28:22 srv4hai ht_shelly.sh: SHELLY - 'shelly-37_20250104.csv' modifed 5s ago - EXIT
Jan  4 13:28:23 srv4hai common[21146]: SHELLY common.sh inkludiert von ./modify_shelly.sh
Jan  4 13:28:23 srv4hai modify_shelly.sh: SHELLY QUERY_STRING='shelly=shelly-49'
Jan  4 13:28:23 srv4hai modify_shelly.sh: SHELLY shelly='shelly-49'
Jan  4 13:28:23 srv4hai common[21270]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//grab_shelly.sh
Jan  4 13:28:23 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-49' - shIP/2:'' perform:'dont_conf'
Jan  4 13:28:27 srv4hai common[21309]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 13:28:27 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=19.88&id=shellyht-00B358
Jan  4 13:28:27 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-37_20250104.csv'
Jan  4 13:28:27 srv4hai ht_shelly.sh: SHELLY - 'shelly-37_20250104.csv' modifed 10s ago - EXIT
Jan  4 13:28:31 srv4hai ping_SP[27557]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1735993711 - 'ping_SP_0'
Jan  4 13:28:31 srv4hai ping_SP[27557]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan  4 13:28:32 srv4hai common[21353]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 13:28:32 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=19.88&id=shellyht-00B358
Jan  4 13:28:32 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-37_20250104.csv'
Jan  4 13:28:32 srv4hai ht_shelly.sh: SHELLY - 'shelly-37_20250104.csv' modifed 15s ago - EXIT
Jan  4 13:28:33 srv4hai named[30406]: resolver priming query complete
Jan  4 13:28:37 srv4hai common[21380]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 13:28:37 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=19.88&id=shellyht-00B358
Jan  4 13:28:37 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-37_20250104.csv'
Jan  4 13:28:37 srv4hai ht_shelly.sh: SHELLY - 'shelly-37_20250104.csv' modifed 20s ago - EXIT
Jan  4 13:28:43 srv4hai common[21405]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 13:28:43 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=19.88&id=shellyht-00B358
Jan  4 13:28:43 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-37_20250104.csv'
Jan  4 13:28:43 srv4hai ht_shelly.sh: SHELLY - 'shelly-37_20250104.csv' modifed 26s ago - EXIT
Jan  4 13:28:48 srv4hai common[21432]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 13:28:48 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=19.88&id=shellyht-00B358
Jan  4 13:28:48 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-37_20250104.csv'
Jan  4 13:28:48 srv4hai ht_shelly.sh: SHELLY - 'shelly-37_20250104.csv' modifed 31s ago - EXIT
Jan  4 13:28:48 srv4hai postfix/smtpd[21456]: connect from unknown[80.94.95.239]
Jan  4 13:28:51 srv4hai postfix/smtpd[21456]: warning: unknown[80.94.95.239]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jan  4 13:28:52 srv4hai postfix/smtpd[21456]: disconnect from unknown[80.94.95.239] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4
Jan  4 13:28:53 srv4hai common[21463]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 13:28:53 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=19.88&id=shellyht-00B358
Jan  4 13:28:53 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-37_20250104.csv'
Jan  4 13:28:53 srv4hai ht_shelly.sh: SHELLY - 'shelly-37_20250104.csv' modifed 36s ago - EXIT
Jan  4 13:28:57 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan  4 13:28:57 srv4hai fetchmail[1651]: 60773 messages (60773 seen) for tmiglinci at mail.akis.at (684267076 octets).
Jan  4 13:28:58 srv4hai common[21488]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 13:28:58 srv4hai fetchmail[1651]: 11337 messages (11337 seen) for srozum at mail.akis.at (1355180900 octets).
Jan  4 13:28:58 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=19.88&id=shellyht-00B358
Jan  4 13:28:58 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-37_20250104.csv'
Jan  4 13:28:58 srv4hai ht_shelly.sh: SHELLY - 'shelly-37_20250104.csv' modifed 41s ago - EXIT
Jan  4 13:28:58 srv4hai fetchmail[1651]: 28163 messages (28163 seen) for mrozum at mail.akis.at (539221132 octets).
Jan  4 13:28:59 srv4hai named[30406]: resolver priming query complete
Jan  4 13:28:59 srv4hai fetchmail[1651]: 1162 messages (1162 seen) for admin@bastelstube.wien at pop3.world4you.com (52206525 octets).
Jan  4 13:29:01 srv4hai CRON[21515]: (root) CMD (/etc/linetest/linetest.sh)
Jan  4 13:29:03 srv4hai common[21521]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 13:29:03 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=19.88&id=shellyht-00B358
Jan  4 13:29:03 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-37_20250104.csv'
Jan  4 13:29:03 srv4hai ht_shelly.sh: SHELLY - 'shelly-37_20250104.csv' modifed 46s ago - EXIT
Jan  4 13:29:08 srv4hai common[21546]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 13:29:08 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=40&temp=19.88&id=shellyht-00B358
Jan  4 13:29:08 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-37_20250104.csv'
Jan  4 13:29:08 srv4hai ht_shelly.sh: SHELLY - 'shelly-37_20250104.csv' modifed 51s ago - EXIT
Jan  4 13:29:09 srv4hai common[21571]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan  4 13:29:09 srv4hai bt_scan[21571]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Jan  4 13:29:09 srv4hai bt_scan[21571]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62'
Jan  4 13:29:09 srv4hai common[21602]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan  4 13:29:09 srv4hai ping_SP[21602]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jan  4 13:29:09 srv4hai common[21623]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan  4 13:29:09 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'0'=1735993749-1735993749
Jan  4 13:29:09 srv4hai check_presence[21623]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jan  4 13:29:09 srv4hai check_presence[21623]: SHELLY (ping_SP__bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jan  4 13:29:09 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'0'=1735993749-1735993749
Jan  4 13:29:09 srv4hai check_presence[21623]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY} and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jan  4 13:29:09 srv4hai check_presence[21623]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jan  4 13:29:09 srv4hai check_presence[21623]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_sekr_UM) - sceneONsmall(vorraumOn)
Jan  4 13:29:09 srv4hai check_presence[21623]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn
Jan  4 13:29:09 srv4hai activate_scenario[21724]: SHELLY last scenario: 'sekr_UM' @ '125645' from 'scene_sekr_UM_20250104_125645.txt' - delta=36
Jan  4 13:29:09 srv4hai activate_scenario[21724]:        dateutils.ddiff -i '%Y%m%d%H%M%s' 20250104132909 20250104125645  -f '%S'
Jan  4 13:29:09 srv4hai activate_scenario[21724]: SHELLY  new scenario: 'vorraumOn' different - GO ON
Jan  4 13:29:09 srv4hai activate_scenario[21724]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jan  4 13:29:09 srv4hai activate_scenario[21724]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1'

finished