activate_scenario.sh
Fri May 31 10:34:21 CEST 2024
scenario: vorraumOn
phoneName: 0

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

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

Licht Vorzimmer (/srv/www/viehai/shelly/log_scenarios/2024/05/31/_0.log)

vorher: 10:34:21.427

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: 10:34:21.453
Dauer: 27 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 10:34:21.406
nachher: 10:34:21.459
Dauer : 53 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/05/31//scene_vorraumOn_20240531_103421.txt'


syslog

May 31 10:31:01 srv4hai CRON[20534]: (root) CMD (/etc/linetest/linetest.sh)
May 31 10:31:08 srv4hai ping_SP[21596]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1717144268 - 'ping_SP_0'
May 31 10:31:08 srv4hai ping_SP[21596]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May 31 10:32:01 srv4hai CRON[20591]: (root) CMD (/etc/linetest/linetest.sh)
May 31 10:32:21 srv4hai ping_SP[21596]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1717144341 - 'ping_SP_0'
May 31 10:32:21 srv4hai ping_SP[21596]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May 31 10:33:01 srv4hai CRON[20648]: (root) CMD (/etc/linetest/linetest.sh)
May 31 10:33:36 srv4hai dhcpd[30731]: DHCPDISCOVER from 30:83:98:8c:05:9d via enp2s0
May 31 10:33:36 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.123 to 30:83:98:8c:05:9d via enp2s0
May 31 10:33:36 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
May 31 10:33:36 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.123
May 31 10:33:36 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-23
May 31 10:33:36 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.123 (192.168.12.252) from 30:83:98:8c:05:9d via enp2s0
May 31 10:33:36 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.123 to 30:83:98:8c:05:9d via enp2s0
May 31 10:33:36 srv4hai dhcpd[30731]: DDNS: cleaning up lease pointer for a cancel cb=0x55bb12b04300
May 31 10:33:36 srv4hai dhcpd[30731]: Unable to add forward map from shelly-23.viehai.at to 192.168.12.123: operation canceled
May 31 10:33:36 srv4hai common[20676]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
May 31 10:33:36 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-23' - shIP/2:'' perform:'conf'
May 31 10:33:37 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-23' - shIP/2:'192.168.12.123'
May 31 10:33:37 srv4hai mosquitto[18551]: New connection from 192.168.12.123 on port 1883.
May 31 10:33:37 srv4hai mosquitto[18551]: New client connected from 192.168.12.123 as shelly1-3083988C059D (c1, k60, u'shmqtt').
May 31 10:33:37 srv4hai conf_shelly.sh: SHELLY: usage/name 'Licht Sekretär' already set for '192.168.12.123'
May 31 10:33:37 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(0)' - allready transmitted - skipping
May 31 10:33:37 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(1)' - allready transmitted - skipping
May 31 10:33:37 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(2)' - allready transmitted - skipping
May 31 10:33:37 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(3)' - allready transmitted - skipping
May 31 10:33:37 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(4)' - allready transmitted - skipping
May 31 10:33:37 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(5)' - allready transmitted - skipping
May 31 10:33:37 srv4hai conf_shelly.sh: SHELLY:'shelly-23' out:0 ON : MISSING
May 31 10:33:37 srv4hai conf_shelly.sh: SHELLY:'shelly-23' out:0 OFF: MISSING
May 31 10:33:40 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
May 31 10:33:40 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 31 10:33:40 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May 31 10:33:40 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
May 31 10:33:40 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
May 31 10:33:40 srv4hai common[20818]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
May 31 10:33:44 srv4hai ping_SP[21596]: SHELLY (0)- ping 192.168.12.61 1 not answered (1) @~1717144424 - 'ping_SP_0'
May 31 10:33:50 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May 31 10:33:50 srv4hai common[20850]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
May 31 10:33:50 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May 31 10:33:50 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 31 10:33:50 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May 31 10:33:50 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
May 31 10:33:50 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
May 31 10:33:50 srv4hai common[20863]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
May 31 10:33:50 srv4hai ping_SP[20850]: SHELLY ping_SP.sh started from smartphone, user:'root'
May 31 10:34:00 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May 31 10:34:00 srv4hai common[20901]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
May 31 10:34:00 srv4hai common[20910]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
May 31 10:34:00 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May 31 10:34:00 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 31 10:34:00 srv4hai dhcpd[30731]: DDNS: cleaning up lease pointer for a cancel cb=0x55bb12b04300
May 31 10:34:00 srv4hai dhcpd[30731]: Unable to add forward map from fpThomas.viehai.at to 192.168.12.61: operation canceled
May 31 10:34:00 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May 31 10:34:00 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
May 31 10:34:00 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
May 31 10:34:00 srv4hai common[20921]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
May 31 10:34:00 srv4hai ping_SP[20901]: SHELLY ping_SP.sh started from smartphone, user:'root'
May 31 10:34:01 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1717144441-1717144431
May 31 10:34:01 srv4hai check_presence[20910]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
May 31 10:34:01 srv4hai check_presence[20910]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
May 31 10:34:01 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'10'=1717144441-1717144431
May 31 10:34:01 srv4hai check_presence[20910]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
May 31 10:34:01 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1717144441-1717144431
May 31 10:34:01 srv4hai check_presence[20910]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
May 31 10:34:01 srv4hai check_presence[20910]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
May 31 10:34:01 srv4hai check_presence[20910]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_sekr_UM) - sceneONsmall(vorraumOn)
May 31 10:34:01 srv4hai check_presence[20910]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
May 31 10:34:01 srv4hai activate_scenario[21084]: SHELLY scenario: 'vorraumOn(vorraumon)' started
May 31 10:34:01 srv4hai activate_scenario[21084]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
May 31 10:34:01 srv4hai activate_scenario[21084]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
May 31 10:34:01 srv4hai postfix/pickup[10665]: 520D2631A0: uid=33 from=
May 31 10:34:01 srv4hai postfix/cleanup[21134]: 520D2631A0: message-id=<20240531083401.520D2631A0@mail.viehai.at>
May 31 10:34:01 srv4hai postfix/qmgr[31004]: 520D2631A0: from=, size=8099, nrcpt=1 (queue active)
May 31 10:34:01 srv4hai activate_scenario[21084]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
May 31 10:34:01 srv4hai proc_url[21151]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/05/31/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
May 31 10:34:01 srv4hai activate_scenario[21084]: SHELLY scenario: 'vorraumOn(vorraumon)' took 61 msec, phoneName:'0'
May 31 10:34:01 srv4hai ping_SP[20850]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
May 31 10:34:01 srv4hai CRON[21182]: (root) CMD (/etc/linetest/linetest.sh)
May 31 10:34:02 srv4hai postfix/relay/smtp[21147]: 520D2631A0: to=, relay=mx01.nic.name[209.131.159.47]:25, delay=1, delays=0.02/0.01/0.73/0.27, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 23E7A202FE)
May 31 10:34:02 srv4hai postfix/qmgr[31004]: 520D2631A0: removed
May 31 10:34:03 srv4hai ping_SP[20850]: SHELLY - running process-id(20850): '20850 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01220901 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01220921 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.61 fpThomas#01221596 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 bt_scan' - 'ping_SP_0' - exiting ==============
May 31 10:34:07 srv4hai ping_SP[21596]: SHELLY (0) - ping 192.168.12.61 2 sucessfully  @~1717144447 - 'ping_SP_0'
May 31 10:34:07 srv4hai ping_SP[21596]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May 31 10:34:10 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May 31 10:34:10 srv4hai common[21216]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
May 31 10:34:10 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May 31 10:34:10 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 31 10:34:10 srv4hai dhcpd[30731]: DDNS: cleaning up lease pointer for a cancel cb=0x55bb12b448d0
May 31 10:34:10 srv4hai dhcpd[30731]: Unable to add forward map from fpThomas.viehai.at to 192.168.12.61: operation canceled
May 31 10:34:10 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May 31 10:34:10 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
May 31 10:34:10 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
May 31 10:34:10 srv4hai common[21231]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
May 31 10:34:10 srv4hai common[21237]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
May 31 10:34:10 srv4hai ping_SP[21216]: SHELLY ping_SP.sh started from smartphone, user:'root'
May 31 10:34:11 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'4'=1717144451-1717144447
May 31 10:34:11 srv4hai check_presence[21231]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
May 31 10:34:11 srv4hai check_presence[21231]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
May 31 10:34:11 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'4'=1717144451-1717144447
May 31 10:34:11 srv4hai check_presence[21231]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
May 31 10:34:11 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'4'=1717144451-1717144447
May 31 10:34:11 srv4hai check_presence[21231]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
May 31 10:34:11 srv4hai check_presence[21231]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
May 31 10:34:11 srv4hai check_presence[21231]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
May 31 10:34:11 srv4hai check_presence[21231]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
May 31 10:34:11 srv4hai activate_scenario[21401]: SHELLY scenario: 'vorraumOn(vorraumon)' started
May 31 10:34:11 srv4hai activate_scenario[21401]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
May 31 10:34:11 srv4hai activate_scenario[21401]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
May 31 10:34:11 srv4hai postfix/pickup[10665]: 58903631A0: uid=33 from=
May 31 10:34:11 srv4hai postfix/cleanup[21134]: 58903631A0: message-id=<20240531083411.58903631A0@mail.viehai.at>
May 31 10:34:11 srv4hai postfix/qmgr[31004]: 58903631A0: from=, size=12977, nrcpt=1 (queue active)
May 31 10:34:11 srv4hai activate_scenario[21401]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
May 31 10:34:11 srv4hai proc_url[21465]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/05/31/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
May 31 10:34:11 srv4hai activate_scenario[21401]: SHELLY scenario: 'vorraumOn(vorraumon)' took 56 msec, phoneName:'0'
May 31 10:34:11 srv4hai ping_SP[20901]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
May 31 10:34:12 srv4hai postfix/relay/smtp[21147]: 58903631A0: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=0.83, delays=0.02/0/0.55/0.26, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as F18E68005A)
May 31 10:34:12 srv4hai postfix/qmgr[31004]: 58903631A0: removed
May 31 10:34:13 srv4hai ping_SP[20901]: SHELLY - running process-id(20901): '20901 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01221216 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01221237 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.61 fpThomas#01221596 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 bt_scan' - 'ping_SP_0' - exiting ==============
May 31 10:34:20 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May 31 10:34:20 srv4hai common[21512]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
May 31 10:34:20 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May 31 10:34:20 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 31 10:34:20 srv4hai dhcpd[30731]: DDNS: cleaning up lease pointer for a cancel cb=0x55bb12b04350
May 31 10:34:20 srv4hai dhcpd[30731]: Unable to add forward map from fpThomas.viehai.at to 192.168.12.61: operation canceled
May 31 10:34:20 srv4hai dhcpd[30731]: DDNS: cleaning up lease pointer for a cancel cb=0x55bb12b44920
May 31 10:34:20 srv4hai dhcpd[30731]: Unable to add forward map from fpThomas.viehai.at to 192.168.12.61: operation canceled
May 31 10:34:20 srv4hai common[21527]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
May 31 10:34:20 srv4hai ping_SP[21512]: SHELLY ping_SP.sh started from smartphone, user:'root'
May 31 10:34:21 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'14'=1717144461-1717144447
May 31 10:34:21 srv4hai check_presence[21527]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
May 31 10:34:21 srv4hai check_presence[21527]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
May 31 10:34:21 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'14'=1717144461-1717144447
May 31 10:34:21 srv4hai check_presence[21527]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
May 31 10:34:21 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'14'=1717144461-1717144447
May 31 10:34:21 srv4hai check_presence[21527]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
May 31 10:34:21 srv4hai check_presence[21527]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
May 31 10:34:21 srv4hai check_presence[21527]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
May 31 10:34:21 srv4hai check_presence[21527]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
May 31 10:34:21 srv4hai activate_scenario[21686]: SHELLY scenario: 'vorraumOn(vorraumon)' started
May 31 10:34:21 srv4hai activate_scenario[21686]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished