activate_scenario.sh
Thu Jan 23 15:38:27 CET 2025
scenario: vorraumOn
phoneName: 0

'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/23/_0.log)

vorher: 15:38:27.974

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": "input"

nachher: 15:38:28.088
Dauer: 113 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 15:38:27.949
nachher: 15:38:28.094
Dauer : 145 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/23//scene_vorraumOn_20250123_153827.txt'


syslog

Jan 23 15:35:01 srv4hai CRON[10819]: (root) CMD (/etc/linetest/linetest.sh)
Jan 23 15:35:11 srv4hai postfix/anvil[9555]: statistics: max connection rate 1/60s for (smtp:92.118.39.65) at Jan 23 15:25:11
Jan 23 15:35:11 srv4hai postfix/anvil[9555]: statistics: max connection count 1 for (smtp:92.118.39.65) at Jan 23 15:25:11
Jan 23 15:35:11 srv4hai postfix/anvil[9555]: statistics: max cache size 3 at Jan 23 15:27:21
Jan 23 15:35:38 srv4hai postfix/smtpd[10829]: connect from unknown[92.118.39.66]
Jan 23 15:35:41 srv4hai dhcpd[4995]: DHCPDISCOVER from c0:49:ef:8a:c9:d8 via enp2s0
Jan 23 15:35:41 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jan 23 15:35:41 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 23 15:35:41 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.139
Jan 23 15:35:41 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-39
Jan 23 15:35:41 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.139 (192.168.12.252) from c0:49:ef:8a:c9:d8 via enp2s0
Jan 23 15:35:41 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jan 23 15:35:41 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#41097/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-39.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 23 15:35:41 srv4hai named[30406]: client @0x7f931c01da50 192.168.12.252#41493/key rndc-key: signer "rndc-key" approved
Jan 23 15:35:41 srv4hai named[30406]: client @0x7f931c01da50 192.168.12.252#41493/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' TXT
Jan 23 15:35:41 srv4hai named[30406]: client @0x7f931c01da50 192.168.12.252#41493/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' TXT "314be662bb43914e78b269d3f3bc9f38c7"
Jan 23 15:35:41 srv4hai named[30406]: client @0x7f931c01da50 192.168.12.252#41493/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' A
Jan 23 15:35:41 srv4hai named[30406]: client @0x7f931c01da50 192.168.12.252#41493/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' A 192.168.12.139
Jan 23 15:35:41 srv4hai dhcpd[4995]: Added new forward map from shelly-39.viehai.at to 192.168.12.139
Jan 23 15:35:41 srv4hai named[30406]: client @0x7f932c06a420 192.168.12.252#37941/key rndc-key: signer "rndc-key" approved
Jan 23 15:35:41 srv4hai named[30406]: client @0x7f932c06a420 192.168.12.252#37941/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '139.12.168.192.in-addr.arpa' PTR
Jan 23 15:35:41 srv4hai named[30406]: client @0x7f932c06a420 192.168.12.252#37941/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.
Jan 23 15:35:41 srv4hai dhcpd[4995]: Added reverse map from 139.12.168.192.in-addr.arpa. to shelly-39.viehai.at
Jan 23 15:35:41 srv4hai common[10833]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan 23 15:35:41 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-39' - shIP/2:'' perform:'conf'
Jan 23 15:35:41 srv4hai common[10847]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan 23 15:35:41 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: gen=2&temp=1.600000&hum=93.600000&id=C049EF8AC9D8&batt=94&volt=5.890000
Jan 23 15:35:41 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-39_20250123.csv'
Jan 23 15:35:41 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jan 23 15:35:41 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jan 23 15:35:41 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jan 23 15:35:41 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}'
Jan 23 15:35:41 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jan 23 15:35:41 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}'
Jan 23 15:35:41 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-cmd: 'curl --connect-timeout 3 --silent -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 '.''
Jan 23 15:35:41 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jan 23 15:35:41 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-cmd: 'curl --connect-timeout 3 --silent -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 '.''
Jan 23 15:35:41 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jan 23 15:35:41 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 1.6° - 93.6%
Jan 23 15:35:41 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 1.6°/1.2° - 93.6%/95.4% - SAVED
Jan 23 15:35:41 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: batt='94'°
Jan 23 15:35:41 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: dweetIO='{#012  "this": "succeeded",#012  "by": "dweeting",#012  "the": "dweet",#012  "with": {#012    "thing": "viehai-39",#012    "created": "2025-01-23T14:35:41.707Z",#012    "content": {#012      "temp": 1.6,#012      "hum": 93.6,#012      "batt": 94,#012      "csvF": "shelly-39_20250123.csv"#012    },#012    "transaction": "12005397-ed74-4074-b53b-a6b77632bd4a"#012  }#012}'°
Jan 23 15:35:42 srv4hai postfix/smtpd[10829]: warning: unknown[92.118.39.66]: SASL PLAIN authentication failed: 
Jan 23 15:35:42 srv4hai postfix/smtpd[10829]: disconnect from unknown[92.118.39.66] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 23 15:36:01 srv4hai CRON[10997]: (root) CMD (/etc/linetest/linetest.sh)
Jan 23 15:37:01 srv4hai CRON[11017]: (root) CMD (/etc/linetest/linetest.sh)
Jan 23 15:37:36 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=11030, secured, session=
Jan 23 15:37:36 srv4hai dovecot: imap(miglincit)<11030>: Logged out in=1829 out=1285 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 23 15:38:01 srv4hai CRON[11041]: (root) CMD (/etc/linetest/linetest.sh)
Jan 23 15:38:10 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan 23 15:38:11 srv4hai fetchmail[1651]: 62097 messages (62097 seen) for tmiglinci at mail.akis.at (785348299 octets).
Jan 23 15:38:12 srv4hai fetchmail[1651]: 11434 messages (11433 seen) for srozum at mail.akis.at (1361603953 octets).
Jan 23 15:38:12 srv4hai postfix/smtpd[11047]: connect from localhost[127.0.0.1]
Jan 23 15:38:12 srv4hai postfix/smtpd[11047]: 631E96345A: client=localhost[127.0.0.1]
Jan 23 15:38:12 srv4hai postfix/cleanup[11050]: 631E96345A: message-id=
Jan 23 15:38:12 srv4hai fetchmail[1651]: reading message srozum@mail.akis.at:11434 of 11434 (40226 octets) not flushed
Jan 23 15:38:12 srv4hai postfix/qmgr[8566]: 631E96345A: from=, size=40504, nrcpt=1 (queue active)
Jan 23 15:38:12 srv4hai postfix/smtpd[11047]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Jan 23 15:38:12 srv4hai postfix/local[11051]: 631E96345A: to=, relay=local, delay=0.09, delays=0.07/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 23 15:38:12 srv4hai postfix/qmgr[8566]: 631E96345A: removed
Jan 23 15:38:13 srv4hai fetchmail[1651]: 28490 messages (28490 seen) for mrozum at mail.akis.at (587854643 octets).
Jan 23 15:38:13 srv4hai fetchmail[1651]: 1162 messages (1162 seen) for admin@bastelstube.wien at pop3.world4you.com (52206525 octets).
Jan 23 15:38:17 srv4hai dhcpd[4995]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan 23 15:38:17 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 23 15:38:17 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 23 15:38:17 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 23 15:38:17 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 23 15:38:17 srv4hai common[11053]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 23 15:38:17 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jan 23 15:38:17 srv4hai common[11068]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 23 15:38:17 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 23 15:38:17 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 23 15:38:17 srv4hai named[30406]: client @0x7f9350157870 192.168.12.252#54893/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 23 15:38:17 srv4hai named[30406]: client @0x7f93300ede20 192.168.12.252#48421/key rndc-key: signer "rndc-key" approved
Jan 23 15:38:17 srv4hai named[30406]: client @0x7f93300ede20 192.168.12.252#48421/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jan 23 15:38:17 srv4hai named[30406]: client @0x7f93300ede20 192.168.12.252#48421/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan 23 15:38:17 srv4hai named[30406]: client @0x7f93300ede20 192.168.12.252#48421/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jan 23 15:38:17 srv4hai named[30406]: client @0x7f93300ede20 192.168.12.252#48421/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jan 23 15:38:17 srv4hai dhcpd[4995]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jan 23 15:38:17 srv4hai named[30406]: client @0x7f934c0645f0 192.168.12.252#45197/key rndc-key: signer "rndc-key" approved
Jan 23 15:38:17 srv4hai named[30406]: client @0x7f934c0645f0 192.168.12.252#45197/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jan 23 15:38:17 srv4hai named[30406]: client @0x7f934c0645f0 192.168.12.252#45197/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Jan 23 15:38:17 srv4hai dhcpd[4995]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jan 23 15:38:17 srv4hai ping_SP[11068]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jan 23 15:38:17 srv4hai common[11091]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 23 15:38:27 srv4hai common[11114]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 23 15:38:27 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'3'=1737643107-1737643104
Jan 23 15:38:27 srv4hai bt_scan[11091]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Jan 23 15:38:27 srv4hai check_presence[11114]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On/
Jan 23 15:38:27 srv4hai bt_scan[11091]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Jan 23 15:38:27 srv4hai check_presence[11114]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jan 23 15:38:27 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'3'=1737643107-1737643104
Jan 23 15:38:27 srv4hai check_presence[11114]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jan 23 15:38:27 srv4hai check_presence[11114]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Jan 23 15:38:27 srv4hai check_presence[11114]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
Jan 23 15:38:27 srv4hai check_presence[11114]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Jan 23 15:38:27 srv4hai activate_scenario[11250]: SHELLY last scenario: 'offAll' @ '130139' from 'scene_offAll_20250123_130139.txt' - delta=12
Jan 23 15:38:27 srv4hai activate_scenario[11250]:        dateutils.ddiff -i '%Y%m%d%H%M%s' 20250123153827 20250123130139  -f '%S'
Jan 23 15:38:27 srv4hai activate_scenario[11250]: SHELLY  new scenario: 'vorraumOn' different - GO ON
Jan 23 15:38:27 srv4hai activate_scenario[11250]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jan 23 15:38:27 srv4hai activate_scenario[11250]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished