activate_scenario.sh
Thu Feb 29 11:57:13 CET 2024
scenario: herdzeile_UM
source: 192.168.12.129
vorher: 11:57:13.902
http://192.168.12.117/white/0?turn=toggle&brightness=50 |
|---|
"ison": true, "source": "http", "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "mode": "white", "brightness": 50, "transition": 0, "power": 0, "overpower": false |
nachher: 11:57:13.935
Dauer: 33 msec
phName: 'shelly-29:'Schalter Herdzeile''
vorher: 11:57:13.924
http://192.168.12.117/white/1?turn=toggle&brightness=50 |
|---|
"ison": true, "source": "http", "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "mode": "white", "brightness": 50, "transition": 0, "power": 0, "overpower": false |
nachher: 11:57:13.952
Dauer: 28 msec
phName: 'shelly-29:'Schalter Herdzeile''
urls : 2
vorher : 11:57:13.864
nachher: 11:57:13.959
Dauer : 95 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/02/29//scene_herdzeile_UM_20240229_115713.txt'
Feb 29 11:54:01 srv4hai CRON[24999]: (root) CMD (/etc/linetest/linetest.sh)
Feb 29 11:54:21 srv4hai named[14530]: resolver priming query complete
Feb 29 11:55:01 srv4hai CRON[25013]: (root) CMD (/etc/linetest/linetest.sh)
Feb 29 11:55:27 srv4hai named[14530]: resolver priming query complete
Feb 29 11:55:46 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Feb 29 11:55:47 srv4hai fetchmail[1651]: 38983 messages (38983 seen) for tmiglinci at mail.akis.at (-1072327177 octets).
Feb 29 11:55:48 srv4hai fetchmail[1651]: 9950 messages (9950 seen) for srozum at mail.akis.at (1201562000 octets).
Feb 29 11:55:48 srv4hai fetchmail[1651]: 21931 messages (21931 seen) for mrozum at mail.akis.at (-532839419 octets).
Feb 29 11:55:49 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Feb 29 11:56:01 srv4hai CRON[25036]: (root) CMD (/etc/linetest/linetest.sh)
Feb 29 11:56:02 srv4hai named[14530]: resolver priming query complete
Feb 29 11:56:26 srv4hai dhcpd[5037]: DHCPDISCOVER from c0:49:ef:8a:c9:d8 via enp2s0
Feb 29 11:56:26 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Feb 29 11:56:26 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Feb 29 11:56:26 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.139
Feb 29 11:56:26 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-39
Feb 29 11:56:26 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.139 (192.168.12.252) from c0:49:ef:8a:c9:d8 via enp2s0
Feb 29 11:56:26 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Feb 29 11:56:26 srv4hai named[14530]: client @0x7fc328677140 192.168.12.252#42287/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-39.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 29 11:56:26 srv4hai named[14530]: client @0x7fc3200cc820 192.168.12.252#35141/key rndc-key: signer "rndc-key" approved
Feb 29 11:56:26 srv4hai named[14530]: client @0x7fc3200cc820 192.168.12.252#35141/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' TXT
Feb 29 11:56:26 srv4hai named[14530]: client @0x7fc3200cc820 192.168.12.252#35141/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' TXT "314be662bb43914e78b269d3f3bc9f38c7"
Feb 29 11:56:26 srv4hai named[14530]: client @0x7fc3200cc820 192.168.12.252#35141/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' A
Feb 29 11:56:26 srv4hai named[14530]: client @0x7fc3200cc820 192.168.12.252#35141/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' A 192.168.12.139
Feb 29 11:56:26 srv4hai dhcpd[5037]: Added new forward map from shelly-39.viehai.at to 192.168.12.139
Feb 29 11:56:26 srv4hai named[14530]: client @0x7fc3286e8290 192.168.12.252#34363/key rndc-key: signer "rndc-key" approved
Feb 29 11:56:26 srv4hai named[14530]: client @0x7fc3286e8290 192.168.12.252#34363/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '139.12.168.192.in-addr.arpa' PTR
Feb 29 11:56:26 srv4hai named[14530]: client @0x7fc3286e8290 192.168.12.252#34363/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.
Feb 29 11:56:26 srv4hai dhcpd[5037]: Added reverse map from 139.12.168.192.in-addr.arpa. to shelly-39.viehai.at
Feb 29 11:56:26 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-39' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Feb 29 11:56:26 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Feb 29 11:56:26 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: gen=2&temp=15.800000&hum=54.900000&id=C049EF8AC9D8&batt=100&volt=6.700000
Feb 29 11:56:26 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-39_20240229.csv'
Feb 29 11:56:26 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Feb 29 11:56:26 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Feb 29 11:56:26 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}'
Feb 29 11:56:26 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Feb 29 11:56:26 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}'
Feb 29 11:56:26 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 '.''
Feb 29 11:56:26 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Feb 29 11:56:26 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 '.''
Feb 29 11:56:26 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Feb 29 11:56:26 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Feb 29 11:56:26 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Feb 29 11:56:26 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 15.8° - 54.9%
Feb 29 11:56:26 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 15.8°/15.3° - 54.9%/58% - SAVED
Feb 29 11:56:26 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: batt='100'°
Feb 29 11:56:26 srv4hai named[14530]: resolver priming query complete
Feb 29 11:56:27 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-02-29T10:56:27.338Z",#012 "content": {#012 "temp": 15.8,#012 "hum": 54.9,#012 "batt": 100#012 },#012 "transaction": "317d2e1c-4573-44b8-9c31-e1cd0bcd22d1"#012 }#012}'°
Feb 29 11:56:30 srv4hai common[25197]: SHELLY common.sh inkludiert
Feb 29 11:56:30 srv4hai bt_scan[25197]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / fixAddr: '192.168.12.61;' - found: 'Yes'
Feb 29 11:56:30 srv4hai bt_scan[25197]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Feb 29 11:56:30 srv4hai common[25226]: SHELLY common.sh inkludiert
Feb 29 11:56:30 srv4hai ping_SP[25226]: SHELLY ping_SP.sh started from bt_scan
Feb 29 11:56:30 srv4hai common[25236]: SHELLY common.sh inkludiert
Feb 29 11:56:30 srv4hai check_presence[25236]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Feb 29 11:56:30 srv4hai check_presence[25236]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Feb 29 11:56:30 srv4hai check_presence[25236]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Feb 29 11:56:30 srv4hai check_presence[25236]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(BT/__) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Feb 29 11:56:30 srv4hai check_presence[25236]: SHELLY (ping_SP__bt_scan)-(0)-coming: activate_scenario.shtml: vorraumOn
Feb 29 11:56:30 srv4hai activate_scenario[25287]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Feb 29 11:56:30 srv4hai activate_scenario[25287]: SHELLY dayState='day' <--> DayTime=unchecked NightTime=checked - phoneName:'0'
Feb 29 11:56:30 srv4hai activate_scenario[25287]: SHELLY scenario: 'vorraumOn(vorraumon)' NOT EXECUTED, phoneName:'0'
Feb 29 11:56:30 srv4hai ping_SP[25226]: SHELLY check_presence.sh coming 0 ping_SP__bt_scan
Feb 29 11:56:30 srv4hai postfix/pickup[16860]: D788360244: uid=33 from=
Feb 29 11:56:30 srv4hai postfix/cleanup[25337]: D788360244: message-id=<20240229105630.D788360244@mail.viehai.at>
Feb 29 11:56:30 srv4hai ping_SP[25226]: SHELLY - new process for '192.168.12.61' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1709204190
Feb 29 11:56:30 srv4hai postfix/qmgr[28610]: D788360244: from=, size=9190, nrcpt=1 (queue active)
Feb 29 11:56:30 srv4hai named[14530]: resolver priming query complete
Feb 29 11:56:31 srv4hai postfix/relay/smtp[25347]: D788360244: to=, relay=mx04.nic.name[209.131.160.34]:25, delay=0.87, delays=0.02/0.01/0.61/0.24, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 8A2D980184)
Feb 29 11:56:31 srv4hai postfix/qmgr[28610]: D788360244: removed
Feb 29 11:56:40 srv4hai dhcpd[5037]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Feb 29 11:56:40 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Feb 29 11:56:40 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Feb 29 11:56:40 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.61
Feb 29 11:56:40 srv4hai dhcpd[5037]: execute_statement argv[2] = fpThomas
Feb 29 11:56:40 srv4hai common[25354]: SHELLY common.sh inkludiert
Feb 29 11:56:47 srv4hai ping_SP[25226]: SHELLY (0)- ping 192.168.12.61 0 not answered (1) @~1709204207 - 'ping_SP_0'
Feb 29 11:56:50 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Feb 29 11:56:50 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Feb 29 11:56:50 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Feb 29 11:56:50 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Feb 29 11:56:50 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.61
Feb 29 11:56:50 srv4hai dhcpd[5037]: execute_statement argv[2] = fpThomas
Feb 29 11:56:50 srv4hai common[25385]: SHELLY common.sh inkludiert
Feb 29 11:57:00 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Feb 29 11:57:00 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Feb 29 11:57:00 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Feb 29 11:57:00 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Feb 29 11:57:00 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.61
Feb 29 11:57:00 srv4hai dhcpd[5037]: execute_statement argv[2] = fpThomas
Feb 29 11:57:00 srv4hai named[14530]: client @0x7fc308070fe0 192.168.12.252#41885/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 29 11:57:00 srv4hai common[25409]: SHELLY common.sh inkludiert
Feb 29 11:57:01 srv4hai CRON[25420]: (root) CMD (/etc/linetest/linetest.sh)
Feb 29 11:57:05 srv4hai named[14530]: resolver priming query complete
Feb 29 11:57:07 srv4hai postfix/smtpd[25426]: connect from unknown[87.120.84.162]
Feb 29 11:57:07 srv4hai postfix/smtpd[25426]: warning: unknown[87.120.84.162]: SASL LOGIN authentication failed: Invalid authentication mechanism
Feb 29 11:57:07 srv4hai postfix/smtpd[25426]: disconnect from unknown[87.120.84.162] ehlo=1 auth=0/1 quit=1 commands=2/3
Feb 29 11:57:10 srv4hai ping_SP[25226]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1709204230 - 'ping_SP_0'
Feb 29 11:57:10 srv4hai ping_SP[25226]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 29 11:57:10 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Feb 29 11:57:10 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Feb 29 11:57:10 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Feb 29 11:57:10 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Feb 29 11:57:10 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.61
Feb 29 11:57:10 srv4hai dhcpd[5037]: execute_statement argv[2] = fpThomas
Feb 29 11:57:10 srv4hai named[14530]: client @0x7fc32869f410 192.168.12.252#56565/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 29 11:57:10 srv4hai named[14530]: client @0x7fc308070fe0 192.168.12.252#41885/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 29 11:57:10 srv4hai common[25451]: SHELLY common.sh inkludiert
Feb 29 11:57:13 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=25463, secured, session=<0eAxH4MSjJsAAAAAAAAAAAAAAAAAAAAB>
Feb 29 11:57:13 srv4hai dovecot: imap(miglincit)<25463><0eAxH4MSjJsAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 29 11:57:13 srv4hai activate_scenario[25465]: SHELLY scenario: 'herdzeile_UM(herdzeile_um)' started
Feb 29 11:57:13 srv4hai activate_scenario[25465]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-29:'Schalter Herdzeile' finished