activate_scenario.sh
Mon Jul 22 18:18:19 CEST 2024
scenario: vorraumOn
phoneName: 0
vorher: 18:18:19.896
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: 18:18:19.983
Dauer: 88 msec
phName: 'phoneName:'0''
urls : 1
vorher : 18:18:19.878
nachher: 18:18:19.989
Dauer : 111 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/07/22//scene_vorraumOn_20240722_181819.txt'
Jul 22 18:15:01 srv4hai CRON[13973]: (root) CMD (/etc/linetest/linetest.sh)
Jul 22 18:15:18 srv4hai dhcpd[30731]: DHCPDISCOVER from c0:49:ef:8a:c9:d8 via enp2s0
Jul 22 18:15:18 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jul 22 18:15:18 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jul 22 18:15:18 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.139
Jul 22 18:15:18 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-39
Jul 22 18:15:18 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.139 (192.168.12.252) from c0:49:ef:8a:c9:d8 via enp2s0
Jul 22 18:15:18 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jul 22 18:15:18 srv4hai named[30406]: client @0x7f9348081920 192.168.12.252#44359/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-39.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 22 18:15:18 srv4hai named[30406]: client @0x7f9338096e40 192.168.12.252#40525/key rndc-key: signer "rndc-key" approved
Jul 22 18:15:18 srv4hai named[30406]: client @0x7f9338096e40 192.168.12.252#40525/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' TXT
Jul 22 18:15:18 srv4hai named[30406]: client @0x7f9338096e40 192.168.12.252#40525/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' TXT "314be662bb43914e78b269d3f3bc9f38c7"
Jul 22 18:15:18 srv4hai named[30406]: client @0x7f9338096e40 192.168.12.252#40525/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' A
Jul 22 18:15:18 srv4hai named[30406]: client @0x7f9338096e40 192.168.12.252#40525/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' A 192.168.12.139
Jul 22 18:15:18 srv4hai dhcpd[30731]: Added new forward map from shelly-39.viehai.at to 192.168.12.139
Jul 22 18:15:18 srv4hai named[30406]: client @0x7f934c0733f0 192.168.12.252#47983/key rndc-key: signer "rndc-key" approved
Jul 22 18:15:18 srv4hai named[30406]: client @0x7f934c0733f0 192.168.12.252#47983/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '139.12.168.192.in-addr.arpa' PTR
Jul 22 18:15:18 srv4hai named[30406]: client @0x7f934c0733f0 192.168.12.252#47983/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.
Jul 22 18:15:18 srv4hai dhcpd[30731]: Added reverse map from 139.12.168.192.in-addr.arpa. to shelly-39.viehai.at
Jul 22 18:15:18 srv4hai common[13980]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jul 22 18:15:18 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-39' - shIP/2:'' perform:'conf'
Jul 22 18:15:18 srv4hai common[13993]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Jul 22 18:15:18 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: gen=2&temp=28.300000&hum=54.200000&id=C049EF8AC9D8&batt=100&volt=6.760000
Jul 22 18:15:18 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2024/07/shelly-39_20240722.csv'
Jul 22 18:15:18 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jul 22 18:15:18 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jul 22 18:15:18 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jul 22 18:15:18 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}'
Jul 22 18:15:18 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jul 22 18:15:18 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}'
Jul 22 18:15:18 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-cmd: 'curl --connect-timeout 3 --silent -X -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 '.''
Jul 22 18:15:18 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jul 22 18:15:18 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-cmd: 'curl --connect-timeout 3 --silent -X -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 '.''
Jul 22 18:15:18 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jul 22 18:15:18 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Jul 22 18:15:18 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Jul 22 18:15:18 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 28.3° - 54.2%
Jul 22 18:15:18 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 28.3°/28.8° - 54.2%/52% - SAVED
Jul 22 18:15:18 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: batt='100'°
Jul 22 18:15:18 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": "2024-07-22T16:15:18.826Z",#012 "content": {#012 "temp": 28.3,#012 "hum": 54.2,#012 "batt": 100,#012 "csvF": "shelly-39_20240722.csv"#012 },#012 "transaction": "99a1feef-66e6-4c22-971e-bb8aa6e4f824"#012 }#012}'°
Jul 22 18:16:01 srv4hai CRON[14147]: (root) CMD (/etc/linetest/linetest.sh)
Jul 22 18:16:05 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jul 22 18:16:12 srv4hai fetchmail[1651]: 49153 messages (49153 seen) for tmiglinci at mail.akis.at (-226374258 octets).
Jul 22 18:16:14 srv4hai fetchmail[1651]: 10493 messages (10493 seen) for srozum at mail.akis.at (1263085605 octets).
Jul 22 18:16:17 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=14159, secured, session=
Jul 22 18:16:17 srv4hai dovecot: imap(miglincit)<14159>: Logged out in=290 out=1640 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 22 18:16:18 srv4hai fetchmail[1651]: 24882 messages (24882 seen) for mrozum at mail.akis.at (58435390 octets).
Jul 22 18:16:19 srv4hai fetchmail[1651]: 1139 messages (1139 seen) for admin@bastelstube.wien at pop3.world4you.com (51570784 octets).
Jul 22 18:17:01 srv4hai CRON[14164]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jul 22 18:17:01 srv4hai CRON[14165]: (root) CMD (/etc/linetest/linetest.sh)
Jul 22 18:17:52 srv4hai dhcpd[30731]: DHCPDISCOVER from f0:39:65:25:8d:c7 via enp2s0
Jul 22 18:17:52 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jul 22 18:17:52 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 22 18:17:52 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.62
Jul 22 18:17:52 srv4hai dhcpd[30731]: execute_statement argv[2] = GreteS20
Jul 22 18:17:52 srv4hai common[14178]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 22 18:17:52 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jul 22 18:17:52 srv4hai common[14192]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jul 22 18:17:52 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jul 22 18:17:52 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jul 22 18:17:52 srv4hai named[30406]: client @0x7f932c0c7f00 192.168.12.252#51773/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 22 18:17:52 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#58391/key rndc-key: signer "rndc-key" approved
Jul 22 18:17:52 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#58391/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Jul 22 18:17:52 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#58391/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Jul 22 18:17:52 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#58391/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Jul 22 18:17:52 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#58391/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Jul 22 18:17:52 srv4hai dhcpd[30731]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Jul 22 18:17:52 srv4hai named[30406]: client @0x7f932c03e370 192.168.12.252#36891/key rndc-key: signer "rndc-key" approved
Jul 22 18:17:52 srv4hai named[30406]: client @0x7f932c03e370 192.168.12.252#36891/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Jul 22 18:17:52 srv4hai named[30406]: client @0x7f932c03e370 192.168.12.252#36891/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '62.12.168.192.in-addr.arpa' PTR GreteS20.viehai.at.
Jul 22 18:17:52 srv4hai dhcpd[30731]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Jul 22 18:17:52 srv4hai ping_SP[14192]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jul 22 18:17:55 srv4hai common[14214]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jul 22 18:18:01 srv4hai CRON[14228]: (root) CMD (/etc/linetest/linetest.sh)
Jul 22 18:18:02 srv4hai common[14241]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jul 22 18:18:02 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'7'=1721665082-1721665075
Jul 22 18:18:02 srv4hai check_presence[14241]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jul 22 18:18:02 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'7'=1721665082-1721665075
Jul 22 18:18:02 srv4hai check_presence[14241]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jul 22 18:18:02 srv4hai check_presence[14241]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jul 22 18:18:02 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'7'=1721665082-1721665075
Jul 22 18:18:02 srv4hai check_presence[14241]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jul 22 18:18:02 srv4hai check_presence[14241]: SHELLY (ping_SP__smartphone)-(1) what: 'coming' - persPresent: '(__/__) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Jul 22 18:18:02 srv4hai check_presence[14241]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
Jul 22 18:18:02 srv4hai check_presence[14241]: SHELLY (ping_SP__smartphone)-(1)-coming: activate_scenario.shtml: vorraumOn
Jul 22 18:18:02 srv4hai activate_scenario[14392]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jul 22 18:18:02 srv4hai activate_scenario[14392]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1'
Jul 22 18:18:02 srv4hai activate_scenario[14392]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'1'
Jul 22 18:18:02 srv4hai postfix/pickup[3931]: F36806018A: uid=33 from=
Jul 22 18:18:03 srv4hai postfix/cleanup[14442]: F36806018A: message-id=<20240722161802.F36806018A@mail.viehai.at>
Jul 22 18:18:03 srv4hai postfix/qmgr[8566]: F36806018A: from=, size=12615, nrcpt=1 (queue active)
Jul 22 18:18:03 srv4hai activate_scenario[14392]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Jul 22 18:18:03 srv4hai proc_url[14459]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/07/22/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'1''
Jul 22 18:18:03 srv4hai activate_scenario[14392]: SHELLY scenario: 'vorraumOn(vorraumon)' took 97 msec, phoneName:'1'
Jul 22 18:18:03 srv4hai ping_SP[14192]: SHELLY check_presence.sh coming 1 ping_SP__smartphone
Jul 22 18:18:03 srv4hai postfix/relay/smtp[14455]: F36806018A: to=, relay=mx02.nic.name[209.131.158.56]:25, delay=1, delays=0.05/0.01/0.69/0.27, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as C2B38800DE)
Jul 22 18:18:03 srv4hai postfix/qmgr[8566]: F36806018A: removed
Jul 22 18:18:05 srv4hai ping_SP[14192]: SHELLY - new process for '192.168.12.62' - '/srv/www/viehai/shelly//meter/ping_SP_1' @~1721665085
Jul 22 18:18:05 srv4hai bt_scan[14214]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Jul 22 18:18:05 srv4hai bt_scan[14214]: SHELLY - ping_SP.sh already running for BTmac: '1' - IPv4: '192.168.12.62'
Jul 22 18:18:09 srv4hai common[14522]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jul 22 18:18:16 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jul 22 18:18:16 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jul 22 18:18:16 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 22 18:18:16 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jul 22 18:18:16 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jul 22 18:18:16 srv4hai common[14535]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 22 18:18:18 srv4hai ping_SP[14192]: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1721665098 - 'ping_SP_1'
Jul 22 18:18:18 srv4hai ping_SP[14192]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 22 18:18:19 srv4hai bt_scan[14522]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Jul 22 18:18:19 srv4hai bt_scan[14522]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Jul 22 18:18:19 srv4hai common[14579]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jul 22 18:18:19 srv4hai ping_SP[14579]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jul 22 18:18:19 srv4hai common[14600]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jul 22 18:18:19 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'2'=1721665099-1721665097
Jul 22 18:18:19 srv4hai check_presence[14600]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jul 22 18:18:19 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'2'=1721665099-1721665097
Jul 22 18:18:19 srv4hai check_presence[14600]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jul 22 18:18:19 srv4hai check_presence[14600]: SHELLY (ping_SP__bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jul 22 18:18:19 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'2'=1721665099-1721665097
Jul 22 18:18:19 srv4hai check_presence[14600]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jul 22 18:18:19 srv4hai check_presence[14600]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(BT/__) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jul 22 18:18:19 srv4hai check_presence[14600]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Jul 22 18:18:19 srv4hai check_presence[14600]: SHELLY (ping_SP__bt_scan)-(0)-coming: activate_scenario.shtml: vorraumOn
Jul 22 18:18:19 srv4hai activate_scenario[14748]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jul 22 18:18:19 srv4hai activate_scenario[14748]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0' finished