activate_scenario.sh
Wed Oct 9 17:06:49 CEST 2024
scenario: vorraumOn
phoneName: 1
vorher: 17:06:49.415
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: 17:06:49.476
Dauer: 61 msec
phName: 'phoneName:'1''
urls : 1
vorher : 17:06:49.381
nachher: 17:06:49.482
Dauer : 104 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/10/09//scene_vorraumOn_20241009_170649.txt'
Oct 9 17:03:01 srv4hai CRON[27950]: (root) CMD (/etc/linetest/linetest.sh)
Oct 9 17:03:42 srv4hai dhcpd[30731]: DHCPDISCOVER from c0:49:ef:8a:c9:d8 via enp2s0
Oct 9 17:03:42 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Oct 9 17:03:42 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Oct 9 17:03:42 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.139
Oct 9 17:03:42 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-39
Oct 9 17:03:42 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.139 (192.168.12.252) from c0:49:ef:8a:c9:d8 via enp2s0
Oct 9 17:03:42 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Oct 9 17:03:42 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#35851/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-39.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Oct 9 17:03:42 srv4hai named[30406]: client @0x7f934809f520 192.168.12.252#57821/key rndc-key: signer "rndc-key" approved
Oct 9 17:03:42 srv4hai named[30406]: client @0x7f934809f520 192.168.12.252#57821/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' TXT
Oct 9 17:03:42 srv4hai named[30406]: client @0x7f934809f520 192.168.12.252#57821/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' TXT "314be662bb43914e78b269d3f3bc9f38c7"
Oct 9 17:03:42 srv4hai named[30406]: client @0x7f934809f520 192.168.12.252#57821/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' A
Oct 9 17:03:42 srv4hai named[30406]: client @0x7f934809f520 192.168.12.252#57821/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' A 192.168.12.139
Oct 9 17:03:42 srv4hai dhcpd[30731]: Added new forward map from shelly-39.viehai.at to 192.168.12.139
Oct 9 17:03:42 srv4hai named[30406]: client @0x7f93300fcc20 192.168.12.252#57367/key rndc-key: signer "rndc-key" approved
Oct 9 17:03:42 srv4hai named[30406]: client @0x7f93300fcc20 192.168.12.252#57367/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '139.12.168.192.in-addr.arpa' PTR
Oct 9 17:03:42 srv4hai named[30406]: client @0x7f93300fcc20 192.168.12.252#57367/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.
Oct 9 17:03:42 srv4hai dhcpd[30731]: Added reverse map from 139.12.168.192.in-addr.arpa. to shelly-39.viehai.at
Oct 9 17:03:42 srv4hai common[27957]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Oct 9 17:03:42 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-39' - shIP/2:'' perform:'conf'
Oct 9 17:03:45 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Oct 9 17:03:45 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Oct 9 17:03:45 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}'
Oct 9 17:03:45 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 '.''
Oct 9 17:03:45 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Oct 9 17:03:45 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Oct 9 17:03:45 srv4hai common[28019]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Oct 9 17:03:45 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: gen=2&temp=19.500000&hum=65.400000&id=C049EF8AC9D8&batt=100&volt=6.140000
Oct 9 17:03:45 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2024/10/shelly-39_20241009.csv'
Oct 9 17:03:45 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Oct 9 17:03:45 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Oct 9 17:03:45 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}'
Oct 9 17:03:45 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 '.''
Oct 9 17:03:45 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Oct 9 17:03:46 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Oct 9 17:03:46 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 19.5° - 65.4%
Oct 9 17:03:46 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 19.5°/20° - 65.4%/67.1% - SAVED
Oct 9 17:03:46 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: batt='100'°
Oct 9 17:03:46 srv4hai named[30406]: resolver priming query complete
Oct 9 17:03:46 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-10-09T15:03:46.559Z",#012 "content": {#012 "temp": 19.5,#012 "hum": 65.4,#012 "batt": 100,#012 "csvF": "shelly-39_20241009.csv"#012 },#012 "transaction": "134f15ec-c96d-4808-b08a-d62e27e51c33"#012 }#012}'°
Oct 9 17:03:51 srv4hai common[28194]: SHELLY common.sh inkludiert von ./ht_shelly.sh
Oct 9 17:03:51 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: gen=2&temp=19.500000&hum=65.400000&id=C049EF8AC9D8&batt=100&volt=6.140000
Oct 9 17:03:51 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly//wetter/2024/10/shelly-39_20241009.csv'
Oct 9 17:03:51 srv4hai ht_shelly.sh: SHELLY - 'shelly-39_20241009.csv' modifed 5s ago - EXIT
Oct 9 17:04:01 srv4hai CRON[28235]: (root) CMD (/etc/linetest/linetest.sh)
Oct 9 17:04:17 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Oct 9 17:04:18 srv4hai fetchmail[1651]: 54151 messages (54149 seen) for tmiglinci at mail.akis.at (148863478 octets).
Oct 9 17:04:18 srv4hai postfix/smtpd[28241]: connect from localhost[127.0.0.1]
Oct 9 17:04:18 srv4hai postfix/smtpd[28241]: C3CD36345A: client=localhost[127.0.0.1]
Oct 9 17:04:18 srv4hai postfix/cleanup[28244]: C3CD36345A: message-id=<4uoba272bqcn.9VV74Xs0VeHfCUIeQhPz5g2@tracking.kickstargo.com>
Oct 9 17:04:18 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:54150 of 54151 (66608 octets) not flushed
Oct 9 17:04:18 srv4hai postfix/qmgr[8566]: C3CD36345A: from=, size=66894, nrcpt=1 (queue active)
Oct 9 17:04:18 srv4hai postfix/local[28245]: C3CD36345A: to=, relay=local, delay=0.12, delays=0.11/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Oct 9 17:04:18 srv4hai postfix/qmgr[8566]: C3CD36345A: removed
Oct 9 17:04:18 srv4hai postfix/smtpd[28241]: E6C286345A: client=localhost[127.0.0.1]
Oct 9 17:04:18 srv4hai postfix/cleanup[28244]: E6C286345A: message-id=<6A.D3.42287.A6B96076@hj.mta1vrest.cc.prd.sparkpost>
Oct 9 17:04:19 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:54151 of 54151 (125545 octets) not flushed
Oct 9 17:04:19 srv4hai postfix/qmgr[8566]: E6C286345A: from=, size=125793, nrcpt=1 (queue active)
Oct 9 17:04:19 srv4hai postfix/smtpd[28241]: disconnect from localhost[127.0.0.1] ehlo=1 mail=2 rcpt=2 data=2 quit=1 commands=8
Oct 9 17:04:19 srv4hai postfix/local[28245]: E6C286345A: to=, relay=local, delay=0.13, delays=0.11/0/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Oct 9 17:04:19 srv4hai postfix/qmgr[8566]: E6C286345A: removed
Oct 9 17:04:19 srv4hai fetchmail[1651]: 10810 messages (10810 seen) for srozum at mail.akis.at (1309938021 octets).
Oct 9 17:04:20 srv4hai fetchmail[1651]: 26463 messages (26463 seen) for mrozum at mail.akis.at (288636518 octets).
Oct 9 17:04:20 srv4hai fetchmail[1651]: 1147 messages (1147 seen) for admin@bastelstube.wien at pop3.world4you.com (51928753 octets).
Oct 9 17:04:58 srv4hai named[30406]: resolver priming query complete
Oct 9 17:05:01 srv4hai CRON[28253]: (root) CMD (/etc/linetest/linetest.sh)
Oct 9 17:05:29 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Oct 9 17:05:29 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct 9 17:05:33 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Oct 9 17:05:33 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct 9 17:05:41 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Oct 9 17:05:41 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct 9 17:05:41 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Oct 9 17:05:41 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.5
Oct 9 17:05:41 srv4hai dhcpd[30731]: execute_statement argv[2] = btscan1
Oct 9 17:05:41 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.5 (192.168.12.252) from 08:3a:8d:d0:46:5a via enp2s0
Oct 9 17:05:41 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct 9 17:05:41 srv4hai named[30406]: client @0x7f93506770d0 192.168.12.252#48153/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: btscan1.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Oct 9 17:05:41 srv4hai named[30406]: client @0x7f932c05b620 192.168.12.252#56609/key rndc-key: signer "rndc-key" approved
Oct 9 17:05:41 srv4hai named[30406]: client @0x7f932c05b620 192.168.12.252#56609/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' TXT
Oct 9 17:05:41 srv4hai named[30406]: client @0x7f932c05b620 192.168.12.252#56609/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' TXT "000118916176265854cff71f762ffe0635"
Oct 9 17:05:41 srv4hai named[30406]: client @0x7f932c05b620 192.168.12.252#56609/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' A
Oct 9 17:05:41 srv4hai named[30406]: client @0x7f932c05b620 192.168.12.252#56609/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' A 192.168.12.5
Oct 9 17:05:41 srv4hai dhcpd[30731]: Added new forward map from btscan1.viehai.at to 192.168.12.5
Oct 9 17:05:41 srv4hai named[30406]: client @0x7f93506a3ad0 192.168.12.252#41047/key rndc-key: signer "rndc-key" approved
Oct 9 17:05:41 srv4hai named[30406]: client @0x7f93506a3ad0 192.168.12.252#41047/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '5.12.168.192.in-addr.arpa' PTR
Oct 9 17:05:41 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.5'(5) device 'btscan1'
Oct 9 17:05:41 srv4hai named[30406]: client @0x7f93506a3ad0 192.168.12.252#41047/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '5.12.168.192.in-addr.arpa' PTR btscan1.viehai.at.
Oct 9 17:05:41 srv4hai dhcpd[30731]: Added reverse map from 5.12.168.192.in-addr.arpa. to btscan1.viehai.at
Oct 9 17:05:41 srv4hai dhcpcommit.sh: SHELLY device 'btscan1' known and accepted
Oct 9 17:05:41 srv4hai named[30406]: resolver priming query complete
Oct 9 17:06:01 srv4hai CRON[28275]: (root) CMD (/etc/linetest/linetest.sh)
Oct 9 17:06:13 srv4hai mosquitto[18551]: Saving in-memory database to /var/lib/mosquitto/mosquitto.db.
Oct 9 17:06:38 srv4hai dhcpd[30731]: DHCPDISCOVER from f0:39:65:25:8d:c7 via enp2s0
Oct 9 17:06:38 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Oct 9 17:06:38 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Oct 9 17:06:38 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.62
Oct 9 17:06:38 srv4hai dhcpd[30731]: execute_statement argv[2] = GreteS20
Oct 9 17:06:38 srv4hai common[28282]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Oct 9 17:06:38 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Oct 9 17:06:38 srv4hai common[28296]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Oct 9 17:06:38 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Oct 9 17:06:38 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Oct 9 17:06:38 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#50293/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Oct 9 17:06:38 srv4hai named[30406]: client @0x7f935063c890 192.168.12.252#53073/key rndc-key: signer "rndc-key" approved
Oct 9 17:06:38 srv4hai named[30406]: client @0x7f935063c890 192.168.12.252#53073/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Oct 9 17:06:38 srv4hai named[30406]: client @0x7f935063c890 192.168.12.252#53073/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Oct 9 17:06:38 srv4hai named[30406]: client @0x7f935063c890 192.168.12.252#53073/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Oct 9 17:06:38 srv4hai named[30406]: client @0x7f935063c890 192.168.12.252#53073/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Oct 9 17:06:38 srv4hai dhcpd[30731]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Oct 9 17:06:38 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#38173/key rndc-key: signer "rndc-key" approved
Oct 9 17:06:38 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#38173/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Oct 9 17:06:38 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#38173/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.
Oct 9 17:06:38 srv4hai dhcpd[30731]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Oct 9 17:06:38 srv4hai ping_SP[28296]: SHELLY ping_SP.sh started from smartphone, user:'root'
Oct 9 17:06:38 srv4hai named[30406]: resolver priming query complete
Oct 9 17:06:39 srv4hai named[30406]: resolver priming query complete
Oct 9 17:06:40 srv4hai named[30406]: resolver priming query complete
Oct 9 17:06:42 srv4hai named[30406]: resolver priming query complete
Oct 9 17:06:48 srv4hai common[28326]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Oct 9 17:06:48 srv4hai named[30406]: resolver priming query complete
Oct 9 17:06:49 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_older_60sec' dweetAge:'2227'=1728486409-1728484182
Oct 9 17:06:49 srv4hai check_presence[28326]: 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
Oct 9 17:06:49 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_older_60sec' dweetAge:'2227'=1728486409-1728484182
Oct 9 17:06:49 srv4hai check_presence[28326]: 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
Oct 9 17:06:49 srv4hai check_presence[28326]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Oct 9 17:06:49 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_older_60sec' dweetAge:'2227'=1728486409-1728484182
Oct 9 17:06:49 srv4hai check_presence[28326]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Oct 9 17:06:49 srv4hai check_presence[28326]: SHELLY (ping_SP__smartphone)-(1) what: 'coming' - persPresent: '(__/__) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Oct 9 17:06:49 srv4hai check_presence[28326]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
Oct 9 17:06:49 srv4hai check_presence[28326]: SHELLY (ping_SP__smartphone)-(1)-coming: activate_scenario.shtml: vorraumOn
Oct 9 17:06:49 srv4hai activate_scenario[28486]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Oct 9 17:06:49 srv4hai activate_scenario[28486]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1' finished