activate_scenario.sh
Thu Dec 19 17:18:52 CET 2024
scenario: vorraumOn
phoneName: 0
'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/2024/12/19/_0.log)
vorher: 17:18:52.238
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: 17:18:52.304
Dauer: 66 msec
phName: 'phoneName:'0''
scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'
urls : 1
vorher : 17:18:52.214
nachher: 17:18:52.311
Dauer : 98 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/12/19//scene_vorraumOn_20241219_171852.txt'
syslog
Dec 19 17:15:01 srv4hai CRON[30970]: (root) CMD (/etc/linetest/linetest.sh)
Dec 19 17:15:06 srv4hai named[30406]: resolver priming query complete
Dec 19 17:15:07 srv4hai mosquitto[29419]: New connection from 192.168.12.101 on port 1883.
Dec 19 17:15:07 srv4hai mosquitto[29419]: Socket error on client , disconnecting.
Dec 19 17:15:30 srv4hai postfix/smtpd[30980]: connect from unknown[154.203.197.200]
Dec 19 17:15:30 srv4hai postfix/smtpd[30980]: warning: unknown[154.203.197.200]: SASL LOGIN authentication failed: Invalid authentication mechanism
Dec 19 17:15:30 srv4hai postfix/smtpd[30980]: disconnect from unknown[154.203.197.200] ehlo=1 auth=0/1 quit=1 commands=2/3
Dec 19 17:15:40 srv4hai ping_SP[7075]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1734624940 - 'ping_SP_0'
Dec 19 17:15:40 srv4hai ping_SP[7075]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Dec 19 17:16:01 srv4hai CRON[31004]: (root) CMD (/etc/linetest/linetest.sh)
Dec 19 17:16:03 srv4hai named[30406]: resolver priming query complete
Dec 19 17:16:07 srv4hai mosquitto[29419]: New connection from 192.168.12.101 on port 1883.
Dec 19 17:16:07 srv4hai mosquitto[29419]: Socket error on client , disconnecting.
Dec 19 17:16:08 srv4hai named[30406]: resolver priming query complete
Dec 19 17:16:08 srv4hai dhcpd[4995]: DHCPDISCOVER from 84:cc:a8:a8:55:7d via enp2s0
Dec 19 17:16:08 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.102 to 84:cc:a8:a8:55:7d via enp2s0
Dec 19 17:16:08 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Dec 19 17:16:08 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.102
Dec 19 17:16:08 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-02
Dec 19 17:16:08 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.102 (192.168.12.252) from 84:cc:a8:a8:55:7d via enp2s0
Dec 19 17:16:08 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.102 to 84:cc:a8:a8:55:7d via enp2s0
Dec 19 17:16:08 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#51467/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-02.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Dec 19 17:16:08 srv4hai named[30406]: client @0x7f93380793b0 192.168.12.252#34229/key rndc-key: signer "rndc-key" approved
Dec 19 17:16:08 srv4hai named[30406]: client @0x7f93380793b0 192.168.12.252#34229/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-02.viehai.at' TXT
Dec 19 17:16:08 srv4hai named[30406]: client @0x7f93380793b0 192.168.12.252#34229/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-02.viehai.at' TXT "005dc8ffbb18e92d4c1a5981a9354b73fe"
Dec 19 17:16:08 srv4hai named[30406]: client @0x7f93380793b0 192.168.12.252#34229/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-02.viehai.at' A
Dec 19 17:16:08 srv4hai named[30406]: client @0x7f93380793b0 192.168.12.252#34229/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-02.viehai.at' A 192.168.12.102
Dec 19 17:16:08 srv4hai dhcpd[4995]: Added new forward map from shelly-02.viehai.at to 192.168.12.102
Dec 19 17:16:08 srv4hai named[30406]: client @0x7f932c0c3e90 192.168.12.252#34393/key rndc-key: signer "rndc-key" approved
Dec 19 17:16:08 srv4hai named[30406]: client @0x7f932c0c3e90 192.168.12.252#34393/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '102.12.168.192.in-addr.arpa' PTR
Dec 19 17:16:08 srv4hai named[30406]: client @0x7f932c0c3e90 192.168.12.252#34393/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '102.12.168.192.in-addr.arpa' PTR shelly-02.viehai.at.
Dec 19 17:16:08 srv4hai dhcpd[4995]: Added reverse map from 102.12.168.192.in-addr.arpa. to shelly-02.viehai.at
Dec 19 17:16:08 srv4hai common[31015]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Dec 19 17:16:08 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-02' - shIP/2:'' perform:'conf'
Dec 19 17:16:09 srv4hai mosquitto[29419]: New connection from 192.168.12.102 on port 1883.
Dec 19 17:16:09 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-02' - shIP/2:'192.168.12.102'
Dec 19 17:16:09 srv4hai mosquitto[29419]: Client shelly1pm-84CCA8A8557D already connected, closing old connection.
Dec 19 17:16:09 srv4hai mosquitto[29419]: Socket error on client shelly1pm-84CCA8A8557D, disconnecting.
Dec 19 17:16:09 srv4hai mosquitto[29419]: New client connected from 192.168.12.102 as shelly1pm-84CCA8A8557D (c1, k60, u'shmqtt').
Dec 19 17:16:09 srv4hai conf_shelly.sh: SHELLY: usage/name 'Balkon Licht' already set for '192.168.12.102'
Dec 19 17:16:09 srv4hai conf_shelly.sh: SHELLY:'shelly-02' 'conf(0)' - allready transmitted - skipping
Dec 19 17:16:09 srv4hai conf_shelly.sh: SHELLY:'shelly-02' 'conf(1)' - allready transmitted - skipping
Dec 19 17:16:10 srv4hai conf_shelly.sh: SHELLY:'shelly-02' 'conf(2)' - allready transmitted - skipping
Dec 19 17:16:10 srv4hai conf_shelly.sh: SHELLY:'shelly-02' 'conf(3)' - allready transmitted - skipping
Dec 19 17:16:10 srv4hai conf_shelly.sh: SHELLY:'shelly-02' 'conf(4)' - allready transmitted - skipping
Dec 19 17:16:11 srv4hai common[31125]: SHELLY common.sh inkludiert von ./bt_scan.sh
Dec 19 17:16:21 srv4hai bt_scan[31125]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Dec 19 17:16:21 srv4hai bt_scan[31125]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Dec 19 17:16:26 srv4hai postfix/smtpd[30980]: connect from unknown[80.94.95.239]
Dec 19 17:16:29 srv4hai postfix/smtpd[30980]: warning: unknown[80.94.95.239]: SASL LOGIN authentication failed: Invalid authentication mechanism
Dec 19 17:16:29 srv4hai postfix/smtpd[30980]: disconnect from unknown[80.94.95.239] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4
Dec 19 17:16:30 srv4hai named[30406]: resolver priming query complete
Dec 19 17:17:01 srv4hai mosquitto[29419]: New connection from 192.168.12.101 on port 1883.
Dec 19 17:17:01 srv4hai mosquitto[29419]: Socket error on client , disconnecting.
Dec 19 17:17:01 srv4hai CRON[31170]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Dec 19 17:17:01 srv4hai CRON[31171]: (root) CMD (/etc/linetest/linetest.sh)
Dec 19 17:17:03 srv4hai ping_SP[7075]: SHELLY (0)- ping 192.168.12.61 1 not answered (1) @~1734625023 - 'ping_SP_0'
Dec 19 17:17:29 srv4hai ping_SP[7075]: SHELLY (0)- ping 192.168.12.61 2 not answered (1) @~1734625049 - 'ping_SP_0'
Dec 19 17:17:39 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=31216, secured, session=<28yB3qEpTsQAAAAAAAAAAAAAAAAAAAAB>
Dec 19 17:17:39 srv4hai dovecot: imap(miglincit)<31216><28yB3qEpTsQAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Dec 19 17:17:40 srv4hai named[30406]: resolver priming query complete
Dec 19 17:17:56 srv4hai ping_SP[7075]: SHELLY (0)- ping 192.168.12.61 3 not answered (1) @~1734625076 - 'ping_SP_0'
Dec 19 17:17:56 srv4hai common[31240]: SHELLY common.sh inkludiert von ./bt_scan.sh
Dec 19 17:17:57 srv4hai mosquitto[29419]: New connection from 192.168.12.101 on port 1883.
Dec 19 17:17:57 srv4hai mosquitto[29419]: Socket error on client , disconnecting.
Dec 19 17:18:01 srv4hai CRON[31255]: (root) CMD (/etc/linetest/linetest.sh)
Dec 19 17:18:06 srv4hai bt_scan[31240]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Dec 19 17:18:06 srv4hai bt_scan[31240]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Dec 19 17:18:06 srv4hai common[31280]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Dec 19 17:18:06 srv4hai named[30406]: resolver priming query complete
Dec 19 17:18:07 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'11'=1734625087-1734625076
Dec 19 17:18:07 srv4hai check_presence[31280]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Dec 19 17:18:07 srv4hai check_presence[31280]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.TRY' for what: 'presence'
Dec 19 17:18:07 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'11'=1734625087-1734625076
Dec 19 17:18:07 srv4hai check_presence[31280]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Dec 19 17:18:07 srv4hai common.sh: SHELLY: BTstatus[2]:'null' dweetAge:'11'=1734625087-1734625076
Dec 19 17:18:07 srv4hai check_presence[31280]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and null//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Dec 19 17:18:07 srv4hai check_presence[31280]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/TRY) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Dec 19 17:18:07 srv4hai check_presence[31280]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_pcON) - sceneOFF(offAll)
Dec 19 17:18:07 srv4hai check_presence[31280]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Dec 19 17:18:22 srv4hai ping_SP[7075]: SHELLY (0)- ping 192.168.12.61 4 not answered (1) @~1734625102 - 'ping_SP_0'
Dec 19 17:18:25 srv4hai postfix/smtpd[31445]: connect from unknown[165.154.240.54]
Dec 19 17:18:26 srv4hai postfix/smtpd[31445]: 97AD4631BE: client=unknown[165.154.240.54]
Dec 19 17:18:27 srv4hai postfix/cleanup[31448]: 97AD4631BE: message-id=<2024122094637496138876@rd264.repica.jp>
Dec 19 17:18:27 srv4hai postfix/qmgr[8566]: 97AD4631BE: from=, size=40937, nrcpt=1 (queue active)
Dec 19 17:18:27 srv4hai postfix/smtpd[31445]: disconnect from unknown[165.154.240.54] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Dec 19 17:18:27 srv4hai postfix/local[31449]: 97AD4631BE: to=, orig_to=, relay=local, delay=0.95, delays=0.93/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Dec 19 17:18:27 srv4hai postfix/qmgr[8566]: 97AD4631BE: removed
Dec 19 17:18:40 srv4hai dhcpd[4995]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Dec 19 17:18:40 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Dec 19 17:18:40 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Dec 19 17:18:40 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Dec 19 17:18:40 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Dec 19 17:18:40 srv4hai common[31457]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Dec 19 17:18:41 srv4hai common[31471]: SHELLY common.sh inkludiert von ./bt_scan.sh
Dec 19 17:18:41 srv4hai named[30406]: resolver priming query complete
Dec 19 17:18:44 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Dec 19 17:18:44 srv4hai named[30406]: resolver priming query complete
Dec 19 17:18:45 srv4hai named[30406]: resolver priming query complete
Dec 19 17:18:45 srv4hai fetchmail[1651]: 59699 messages (59699 seen) for tmiglinci at mail.akis.at (613398002 octets).
Dec 19 17:18:45 srv4hai fetchmail[1651]: 11252 messages (11252 seen) for srozum at mail.akis.at (1348065671 octets).
Dec 19 17:18:46 srv4hai fetchmail[1651]: 27948 messages (27948 seen) for mrozum at mail.akis.at (512704941 octets).
Dec 19 17:18:46 srv4hai fetchmail[1651]: 1161 messages (1161 seen) for admin@bastelstube.wien at pop3.world4you.com (52202045 octets).
Dec 19 17:18:48 srv4hai ping_SP[7075]: SHELLY (0)- ping 192.168.12.61 5 not answered (1) @~1734625128 - 'ping_SP_0'
Dec 19 17:18:48 srv4hai ping_SP[7075]: SHELLY (0)- ping 192.168.12.61 5 not answered - abort (7075) @~1734625128 - rm 'ping_SP_0'
Dec 19 17:18:48 srv4hai common[31496]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Dec 19 17:18:48 srv4hai named[30406]: resolver priming query complete
Dec 19 17:18:49 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'2'=1734625129-1734625127
Dec 19 17:18:49 srv4hai check_presence[31496]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Dec 19 17:18:49 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'2'=1734625129-1734625127
Dec 19 17:18:49 srv4hai check_presence[31496]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Dec 19 17:18:49 srv4hai common.sh: SHELLY: BTstatus[2]:'null' dweetAge:'2'=1734625129-1734625127
Dec 19 17:18:49 srv4hai check_presence[31496]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and null//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Dec 19 17:18:49 srv4hai check_presence[31496]: SHELLY (ping_SP__NO_ping)-(0) what: 'presence' - persPresent: '(BT/__) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Dec 19 17:18:49 srv4hai check_presence[31496]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_pcON) - sceneOFF(offAll)
Dec 19 17:18:49 srv4hai check_presence[31496]: SHELLY (ping_SP__NO_ping)-(0)-presence: NOT activate_scenario.shtml: offAll
Dec 19 17:18:49 srv4hai ping_SP[7075]: SHELLY (0)- TERMINATING now
Dec 19 17:18:49 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Dec 19 17:18:49 srv4hai common[31647]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Dec 19 17:18:49 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Dec 19 17:18:49 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Dec 19 17:18:49 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Dec 19 17:18:49 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Dec 19 17:18:49 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Dec 19 17:18:49 srv4hai common[31660]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Dec 19 17:18:49 srv4hai ping_SP[31647]: SHELLY ping_SP.sh started from smartphone, user:'root'
Dec 19 17:18:51 srv4hai bt_scan[31471]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Dec 19 17:18:51 srv4hai bt_scan[31471]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Dec 19 17:18:51 srv4hai common[31699]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Dec 19 17:18:51 srv4hai ping_SP[31699]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Dec 19 17:18:51 srv4hai common[31720]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Dec 19 17:18:51 srv4hai mosquitto[29419]: New connection from 192.168.12.101 on port 1883.
Dec 19 17:18:51 srv4hai mosquitto[29419]: Socket error on client , disconnecting.
Dec 19 17:18:51 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'4'=1734625131-1734625127
Dec 19 17:18:51 srv4hai check_presence[31720]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Dec 19 17:18:52 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'5'=1734625132-1734625127
Dec 19 17:18:52 srv4hai check_presence[31720]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Dec 19 17:18:52 srv4hai common.sh: SHELLY: BTstatus[2]:'null' dweetAge:'5'=1734625132-1734625127
Dec 19 17:18:52 srv4hai check_presence[31720]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and null//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Dec 19 17:18:52 srv4hai check_presence[31720]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(BT/__) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Dec 19 17:18:52 srv4hai check_presence[31720]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_pcON) - sceneONsmall(vorraumOn)
Dec 19 17:18:52 srv4hai check_presence[31720]: SHELLY (ping_SP__bt_scan)-(0)-coming: activate_scenario.shtml: vorraumOn
Dec 19 17:18:52 srv4hai activate_scenario[31869]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Dec 19 17:18:52 srv4hai activate_scenario[31869]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'0'
finished