activate_scenario.sh
Sat Jan 4 21:48:45 CET 2025
scenario: vorraumOn
phoneName: 1

'night' <--> 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: 21:48:45.276

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: 21:48:45.352
Dauer: 76 msec phName: 'phoneName:'1''


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

urls : 1
vorher : 21:48:45.250
nachher: 21:48:45.359
Dauer : 108 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/04//scene_vorraumOn_20250104_214845.txt'


syslog

Jan  4 21:45:01 srv4hai CRON[28588]: (root) CMD (/etc/linetest/linetest.sh)
Jan  4 21:45:02 srv4hai dhcpd[4995]: DHCPDISCOVER from 98:cd:ac:2d:b6:db via enp2s0
Jan  4 21:45:02 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.125 to 98:cd:ac:2d:b6:db via enp2s0
Jan  4 21:45:02 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan  4 21:45:02 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.125
Jan  4 21:45:02 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-25
Jan  4 21:45:02 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.125 (192.168.12.252) from 98:cd:ac:2d:b6:db via enp2s0
Jan  4 21:45:02 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.125 to 98:cd:ac:2d:b6:db via enp2s0
Jan  4 21:45:02 srv4hai named[30406]: client @0x7f93300fcc20 192.168.12.252#44885/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-25.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  4 21:45:02 srv4hai named[30406]: client @0x7f93506770d0 192.168.12.252#41013/key rndc-key: signer "rndc-key" approved
Jan  4 21:45:02 srv4hai named[30406]: client @0x7f93506770d0 192.168.12.252#41013/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' TXT
Jan  4 21:45:02 srv4hai named[30406]: client @0x7f93506770d0 192.168.12.252#41013/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' TXT "00a4d627ad58f376691816e2e7457e7bae"
Jan  4 21:45:02 srv4hai named[30406]: client @0x7f93506770d0 192.168.12.252#41013/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' A
Jan  4 21:45:02 srv4hai named[30406]: client @0x7f93506770d0 192.168.12.252#41013/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' A 192.168.12.125
Jan  4 21:45:02 srv4hai dhcpd[4995]: Added new forward map from shelly-25.viehai.at to 192.168.12.125
Jan  4 21:45:02 srv4hai named[30406]: client @0x7f931c098670 192.168.12.252#40067/key rndc-key: signer "rndc-key" approved
Jan  4 21:45:02 srv4hai named[30406]: client @0x7f931c098670 192.168.12.252#40067/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '125.12.168.192.in-addr.arpa' PTR
Jan  4 21:45:02 srv4hai named[30406]: client @0x7f931c098670 192.168.12.252#40067/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '125.12.168.192.in-addr.arpa' PTR shelly-25.viehai.at.
Jan  4 21:45:02 srv4hai dhcpd[4995]: Added reverse map from 125.12.168.192.in-addr.arpa. to shelly-25.viehai.at
Jan  4 21:45:02 srv4hai common[28593]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan  4 21:45:02 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-25' - shIP/2:'' perform:'conf'
Jan  4 21:45:03 srv4hai mosquitto[29419]: New connection from 192.168.12.125 on port 1883.
Jan  4 21:45:03 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-25' - shIP/2:'192.168.12.125'
Jan  4 21:45:03 srv4hai mosquitto[29419]: Client shelly1-98CDAC2DB6DB already connected, closing old connection.
Jan  4 21:45:03 srv4hai mosquitto[29419]: Socket error on client shelly1-98CDAC2DB6DB, disconnecting.
Jan  4 21:45:03 srv4hai mosquitto[29419]: New client connected from 192.168.12.125 as shelly1-98CDAC2DB6DB (c1, k60, u'shmqtt').
Jan  4 21:45:03 srv4hai conf_shelly.sh: SHELLY: usage/name 'KÜ Licht' already set for '192.168.12.125'
Jan  4 21:45:03 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(0)' - allready transmitted - skipping
Jan  4 21:45:03 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(1)' - allready transmitted - skipping
Jan  4 21:45:03 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(2)' - allready transmitted - skipping
Jan  4 21:45:03 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(3)' - allready transmitted - skipping
Jan  4 21:45:03 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(4)' - allready transmitted - skipping
Jan  4 21:45:03 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(5)' - allready transmitted - skipping
Jan  4 21:45:58 srv4hai dhcpd[4995]: DHCPDISCOVER from c0:49:ef:8a:c9:d8 via enp2s0
Jan  4 21:45:58 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jan  4 21:45:58 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan  4 21:45:58 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.139
Jan  4 21:45:58 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-39
Jan  4 21:45:58 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.139 (192.168.12.252) from c0:49:ef:8a:c9:d8 via enp2s0
Jan  4 21:45:58 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jan  4 21:45:58 srv4hai named[30406]: client @0x7f931c094600 192.168.12.252#33159/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-39.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  4 21:45:58 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#45127/key rndc-key: signer "rndc-key" approved
Jan  4 21:45:58 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#45127/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' TXT
Jan  4 21:45:58 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#45127/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' TXT "314be662bb43914e78b269d3f3bc9f38c7"
Jan  4 21:45:58 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#45127/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' A
Jan  4 21:45:58 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#45127/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' A 192.168.12.139
Jan  4 21:45:58 srv4hai dhcpd[4995]: Added new forward map from shelly-39.viehai.at to 192.168.12.139
Jan  4 21:45:58 srv4hai named[30406]: client @0x7f934809f520 192.168.12.252#35857/key rndc-key: signer "rndc-key" approved
Jan  4 21:45:58 srv4hai named[30406]: client @0x7f934809f520 192.168.12.252#35857/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '139.12.168.192.in-addr.arpa' PTR
Jan  4 21:45:58 srv4hai named[30406]: client @0x7f934809f520 192.168.12.252#35857/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  4 21:45:58 srv4hai dhcpd[4995]: Added reverse map from 139.12.168.192.in-addr.arpa. to shelly-39.viehai.at
Jan  4 21:45:58 srv4hai common[28733]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan  4 21:45:58 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-39' - shIP/2:'' perform:'conf'
Jan  4 21:45:58 srv4hai common[28746]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jan  4 21:45:58 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: gen=2&temp=1.300000&hum=64.500000&id=C049EF8AC9D8&batt=95&volt=5.900000
Jan  4 21:45:58 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2025/01/shelly-39_20250104.csv'
Jan  4 21:45:58 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jan  4 21:45:58 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jan  4 21:45:58 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  4 21:45:58 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jan  4 21:45:58 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jan  4 21:45:58 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  4 21:45:58 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jan  4 21:45:58 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  4 21:45:58 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 1.3° - 64.5%
Jan  4 21:45:58 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 1.3°/1.8° - 64.5%/61.9% - SAVED
Jan  4 21:45:58 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: batt='94'°
Jan  4 21:45:58 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  4 21:45:58 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jan  4 21:45:59 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-04T20:45:59.187Z",#012    "content": {#012      "temp": 1.3,#012      "hum": 64.5,#012      "batt": 94,#012      "csvF": "shelly-39_20250104.csv"#012    },#012    "transaction": "dd2e7486-d93d-48c4-8969-7452cf7d37cb"#012  }#012}'°
Jan  4 21:46:00 srv4hai ping_SP[21602]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1736023560 - 'ping_SP_1'
Jan  4 21:46:00 srv4hai ping_SP[21602]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan  4 21:46:01 srv4hai CRON[28903]: (root) CMD (/etc/linetest/linetest.sh)
Jan  4 21:46:47 srv4hai named[30406]: validating at-w-atderstand-relay.iocnt.net/CNAME: no valid signature found
Jan  4 21:46:47 srv4hai named[30406]: validating relay-client-c03.iocnt.net/A: no valid signature found
Jan  4 21:46:49 srv4hai named[30406]: validating at.iocnt.net/A: no valid signature found
Jan  4 21:47:01 srv4hai CRON[28915]: (root) CMD (/etc/linetest/linetest.sh)
Jan  4 21:47:13 srv4hai ping_SP[21602]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1736023633 - 'ping_SP_1'
Jan  4 21:47:13 srv4hai ping_SP[21602]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan  4 21:48:01 srv4hai CRON[28945]: (root) CMD (/etc/linetest/linetest.sh)
Jan  4 21:48:15 srv4hai postfix/anvil[28583]: statistics: max connection rate 1/60s for (smtp:80.94.95.239) at Jan  4 21:44:52
Jan  4 21:48:15 srv4hai postfix/anvil[28583]: statistics: max connection count 1 for (smtp:80.94.95.239) at Jan  4 21:44:52
Jan  4 21:48:15 srv4hai postfix/anvil[28583]: statistics: max cache size 1 at Jan  4 21:44:52
Jan  4 21:48:23 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan  4 21:48:24 srv4hai dhcpd[4995]: DHCPDISCOVER from f0:39:65:25:8d:c7 via enp2s0
Jan  4 21:48:24 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jan  4 21:48:24 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan  4 21:48:24 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.62
Jan  4 21:48:24 srv4hai dhcpd[4995]: execute_statement argv[2] = GreteS20
Jan  4 21:48:24 srv4hai common[28954]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan  4 21:48:24 srv4hai fetchmail[1651]: 60786 messages (60786 seen) for tmiglinci at mail.akis.at (685596722 octets).
Jan  4 21:48:25 srv4hai fetchmail[1651]: 11339 messages (11339 seen) for srozum at mail.akis.at (1355274320 octets).
Jan  4 21:48:25 srv4hai fetchmail[1651]: 28164 messages (28164 seen) for mrozum at mail.akis.at (539253840 octets).
Jan  4 21:48:26 srv4hai fetchmail[1651]: 1162 messages (1162 seen) for admin@bastelstube.wien at pop3.world4you.com (52206525 octets).
Jan  4 21:48:34 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jan  4 21:48:34 srv4hai common[28973]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan  4 21:48:34 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jan  4 21:48:34 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jan  4 21:48:34 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan  4 21:48:34 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.62
Jan  4 21:48:34 srv4hai dhcpd[4995]: execute_statement argv[2] = GreteS20
Jan  4 21:48:34 srv4hai common[28986]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan  4 21:48:34 srv4hai ping_SP[28973]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jan  4 21:48:36 srv4hai ping_SP[21602]: SHELLY (1)- ping 192.168.12.62 1 not answered (1) @~1736023716 - 'ping_SP_1'
Jan  4 21:48:44 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jan  4 21:48:44 srv4hai common[29026]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan  4 21:48:44 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jan  4 21:48:44 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jan  4 21:48:44 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan  4 21:48:44 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.62
Jan  4 21:48:44 srv4hai dhcpd[4995]: execute_statement argv[2] = GreteS20
Jan  4 21:48:44 srv4hai named[30406]: client @0x7f931c098670 192.168.12.252#54729/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  4 21:48:44 srv4hai common[29044]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan  4 21:48:44 srv4hai common[29045]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan  4 21:48:44 srv4hai ping_SP[29026]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jan  4 21:48:45 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_older_60sec' dweetAge:'279'=1736023725-1736023446
Jan  4 21:48:45 srv4hai check_presence[29044]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jan  4 21:48:45 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_older_60sec' dweetAge:'279'=1736023725-1736023446
Jan  4 21:48:45 srv4hai check_presence[29044]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jan  4 21:48:45 srv4hai check_presence[29044]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jan  4 21:48:45 srv4hai check_presence[29044]: SHELLY (ping_SP__smartphone)-(1) what: 'coming' - persPresent: '(__/__) (__/LIVE)' - anyPresent: 'true' - otherPresent:'false'
Jan  4 21:48:45 srv4hai check_presence[29044]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_buero_UM) - sceneONsmall(vorraumOn)
Jan  4 21:48:45 srv4hai check_presence[29044]: SHELLY (ping_SP__smartphone)-(1)-coming: activate_scenario.shtml: vorraumOn
Jan  4 21:48:45 srv4hai activate_scenario[29173]: SHELLY last scenario: 'buero_UM' @ '202315' from 'scene_buero_UM_20250104_202315.txt' - delta=-30
Jan  4 21:48:45 srv4hai activate_scenario[29173]:        dateutils.ddiff -i '%Y%m%d%H%M%s' 20250104214845 20250104202315  -f '%S'
Jan  4 21:48:45 srv4hai activate_scenario[29173]: SHELLY  new scenario: 'vorraumOn' different - GO ON
Jan  4 21:48:45 srv4hai activate_scenario[29173]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jan  4 21:48:45 srv4hai activate_scenario[29173]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'1'

finished