activate_scenario.sh
Tue Dec 24 17:36:10 CET 2024
scenario: herdzeile_UM
source: 192.168.12.129
'night' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'null'
scenario: 'Herdzeile UMschalten' - 'herdzeile_UM' - 'herdzeile_um'
KÜ Licht Herdzeile (/srv/www/viehai/shelly/log_scenarios/2024/12/24/_0.log)
vorher: 17:36:10.340
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: 17:36:10.446
Dauer: 106 msec
phName: 'shelly-29:'KÜ Schalter Herdzeile''
KÜ Licht Herdzeile (/srv/www/viehai/shelly/log_scenarios/2024/12/24/_1.log)
vorher: 17:36:10.358
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: 17:36:10.443
Dauer: 85 msec
phName: 'shelly-29:'KÜ Schalter Herdzeile''
scenario: 'Herdzeile UMschalten' - 'herdzeile_UM' - 'herdzeile_um'
urls : 2
vorher : 17:36:10.298
nachher: 17:36:10.454
Dauer : 158 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/12/24//scene_herdzeile_UM_20241224_173610.txt'
syslog
Dec 24 17:33:01 srv4hai CRON[23867]: (root) CMD (/etc/linetest/linetest.sh)
Dec 24 17:33:07 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=23876, secured, session=
Dec 24 17:33:07 srv4hai dovecot: imap(rozumm)<23876>: Logged out in=92 out=1062 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Dec 24 17:33:08 srv4hai dhcpd[4995]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
Dec 24 17:33:08 srv4hai dhcpd[4995]: DHCPDISCOVER from cc:8d:a2:60:52:b8 via enp2s0
Dec 24 17:33:08 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
Dec 24 17:33:08 srv4hai dhcpd[4995]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
Dec 24 17:33:08 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Dec 24 17:33:08 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.101
Dec 24 17:33:08 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-01
Dec 24 17:33:08 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.101 (192.168.12.252) from cc:8d:a2:60:52:b8 via enp2s0
Dec 24 17:33:08 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
Dec 24 17:33:08 srv4hai named[30406]: client @0x7f93100dab10 192.168.12.252#43657/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-01.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Dec 24 17:33:08 srv4hai named[30406]: client @0x7f931c098670 192.168.12.252#54097/key rndc-key: signer "rndc-key" approved
Dec 24 17:33:08 srv4hai named[30406]: client @0x7f931c098670 192.168.12.252#54097/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' TXT
Dec 24 17:33:08 srv4hai named[30406]: client @0x7f931c098670 192.168.12.252#54097/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' TXT "31166740fe21d7ece7561d62986d2b8644"
Dec 24 17:33:08 srv4hai named[30406]: client @0x7f931c098670 192.168.12.252#54097/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' A
Dec 24 17:33:08 srv4hai named[30406]: client @0x7f931c098670 192.168.12.252#54097/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' A 192.168.12.101
Dec 24 17:33:08 srv4hai dhcpd[4995]: Added new forward map from shelly-01.viehai.at to 192.168.12.101
Dec 24 17:33:08 srv4hai named[30406]: client @0x7f93480daa40 192.168.12.252#49401/key rndc-key: signer "rndc-key" approved
Dec 24 17:33:08 srv4hai named[30406]: client @0x7f93480daa40 192.168.12.252#49401/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '101.12.168.192.in-addr.arpa' PTR
Dec 24 17:33:08 srv4hai named[30406]: client @0x7f93480daa40 192.168.12.252#49401/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '101.12.168.192.in-addr.arpa' PTR shelly-01.viehai.at.
Dec 24 17:33:08 srv4hai dhcpd[4995]: Added reverse map from 101.12.168.192.in-addr.arpa. to shelly-01.viehai.at
Dec 24 17:33:08 srv4hai common[23879]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Dec 24 17:33:08 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-01' - shIP/2:'' perform:'conf'
Dec 24 17:33:10 srv4hai mosquitto[29419]: New connection from 192.168.12.101 on port 1883.
Dec 24 17:33:10 srv4hai mosquitto[29419]: Client shelly1minig3-cc8da26052b8 already connected, closing old connection.
Dec 24 17:33:10 srv4hai mosquitto[29419]: Socket error on client shelly1minig3-cc8da26052b8, disconnecting.
Dec 24 17:33:10 srv4hai mosquitto[29419]: New client connected from 192.168.12.101 as shelly1minig3-cc8da26052b8 (c1, k60, u'shmqtt').
Dec 24 17:33:10 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-01' - shIP/2:'192.168.12.101'
Dec 24 17:33:10 srv4hai conf_shelly.sh: SHELLY: usage/name 'WZ Licht Esstisch' already set for '192.168.12.101'
Dec 24 17:33:12 srv4hai ping_SP[21133]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1735057992 - 'ping_SP_1'
Dec 24 17:33:12 srv4hai ping_SP[21133]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Dec 24 17:33:30 srv4hai postfix/smtpd[23852]: connect from unknown[165.154.252.166]
Dec 24 17:33:30 srv4hai postfix/smtpd[23852]: NOQUEUE: reject: RCPT from unknown[165.154.252.166]: 554 5.7.1 : Relay access denied; from= to= proto=ESMTP helo=<10-50-28-130>
Dec 24 17:33:30 srv4hai postfix/smtpd[23852]: disconnect from unknown[165.154.252.166] ehlo=1 mail=1 rcpt=0/1 rset=1 quit=1 commands=4/5
Dec 24 17:33:33 srv4hai named[30406]: success resolving '22.13.48.134.in-addr.arpa/PTR' (in '48.134.in-addr.arpa'?) after reducing the advertised EDNS UDP packet size to 512 octets
Dec 24 17:33:38 srv4hai named[30406]: REFUSED unexpected RCODE resolving '22.1-126.13.48.134.in-addr.arpa/PTR/IN': 134.48.13.212#53
Dec 24 17:33:38 srv4hai named[30406]: lame server resolving '22.1-126.13.48.134.in-addr.arpa' (in '1-126.13.48.134.in-addr.arpa'?): 134.48.28.138#53
Dec 24 17:33:38 srv4hai named[30406]: REFUSED unexpected RCODE resolving '22.1-126.13.48.134.in-addr.arpa/PTR/IN': 134.48.13.211#53
Dec 24 17:33:38 srv4hai named[30406]: lame server resolving '22.1-126.13.48.134.in-addr.arpa' (in '1-126.13.48.134.in-addr.arpa'?): 134.48.1.32#53
Dec 24 17:33:40 srv4hai named[30406]: REFUSED unexpected RCODE resolving '22.1-126.13.48.134.in-addr.arpa/PTR/IN': 134.48.13.211#53
Dec 24 17:33:41 srv4hai named[30406]: REFUSED unexpected RCODE resolving '22.1-126.13.48.134.in-addr.arpa/PTR/IN': 134.48.13.212#53
Dec 24 17:33:41 srv4hai named[30406]: lame server resolving '22.1-126.13.48.134.in-addr.arpa' (in '1-126.13.48.134.in-addr.arpa'?): 134.48.28.138#53
Dec 24 17:33:41 srv4hai named[30406]: lame server resolving '22.1-126.13.48.134.in-addr.arpa' (in '1-126.13.48.134.in-addr.arpa'?): 134.48.1.32#53
Dec 24 17:33:41 srv4hai named[30406]: REFUSED unexpected RCODE resolving '22.1-126.13.48.134.in-addr.arpa/PTR/IN': 134.48.13.212#53
Dec 24 17:33:42 srv4hai named[30406]: REFUSED unexpected RCODE resolving '22.1-126.13.48.134.in-addr.arpa/PTR/IN': 134.48.13.211#53
Dec 24 17:33:42 srv4hai named[30406]: lame server resolving '22.1-126.13.48.134.in-addr.arpa' (in '1-126.13.48.134.in-addr.arpa'?): 134.48.28.138#53
Dec 24 17:33:42 srv4hai named[30406]: lame server resolving '22.1-126.13.48.134.in-addr.arpa' (in '1-126.13.48.134.in-addr.arpa'?): 134.48.1.32#53
Dec 24 17:34:01 srv4hai CRON[23957]: (root) CMD (/etc/linetest/linetest.sh)
Dec 24 17:34:07 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=23963, secured, session=
Dec 24 17:34:07 srv4hai dovecot: imap(rozumm)<23963>: Logged out in=92 out=1062 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Dec 24 17:34:25 srv4hai ping_SP[21133]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1735058065 - 'ping_SP_1'
Dec 24 17:34:25 srv4hai ping_SP[21133]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Dec 24 17:34:55 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Dec 24 17:34:56 srv4hai fetchmail[1651]: 60042 messages (60042 seen) for tmiglinci at mail.akis.at (639942709 octets).
Dec 24 17:34:56 srv4hai fetchmail[1651]: 11278 messages (11278 seen) for srozum at mail.akis.at (1351758903 octets).
Dec 24 17:34:57 srv4hai fetchmail[1651]: 28030 messages (28030 seen) for mrozum at mail.akis.at (520016902 octets).
Dec 24 17:34:57 srv4hai fetchmail[1651]: 1161 messages (1161 seen) for admin@bastelstube.wien at pop3.world4you.com (52202045 octets).
Dec 24 17:35:01 srv4hai CRON[24004]: (root) CMD (/etc/linetest/linetest.sh)
Dec 24 17:35:07 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=24010, secured, session=<0PsqsgYqGJYAAAAAAAAAAAAAAAAAAAAB>
Dec 24 17:35:07 srv4hai dovecot: imap(rozumm)<24010><0PsqsgYqGJYAAAAAAAAAAAAAAAAAAAAB>: Logged out in=92 out=1062 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Dec 24 17:35:33 srv4hai common[24026]: SHELLY common.sh inkludiert von ./bt_scan.sh
Dec 24 17:35:39 srv4hai ping_SP[21133]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1735058139 - 'ping_SP_1'
Dec 24 17:35:39 srv4hai ping_SP[21133]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Dec 24 17:35:43 srv4hai bt_scan[24026]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'No'
Dec 24 17:35:43 srv4hai bt_scan[24026]: SHELLY - lost BT-connection to BTmac: '1' found: 'No' - check presence
Dec 24 17:35:43 srv4hai common[24073]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Dec 24 17:35:43 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1735058143-1735058133
Dec 24 17:35:43 srv4hai check_presence[24073]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Dec 24 17:35:43 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'10'=1735058143-1735058133
Dec 24 17:35:43 srv4hai check_presence[24073]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Dec 24 17:35:43 srv4hai check_presence[24073]: SHELLY (bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Dec 24 17:35:43 srv4hai check_presence[24073]: SHELLY (bt_scan)-(1) what: 'presence' - persPresent: '(__/__) (__/LIVE)' - anyPresent: 'true' - otherPresent:'false'
Dec 24 17:35:44 srv4hai check_presence[24073]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_pcOFF) - sceneOFF(offAll)
Dec 24 17:35:44 srv4hai check_presence[24073]: SHELLY (bt_scan)-(1)-presence: NOT activate_scenario.shtml: offAll
Dec 24 17:36:01 srv4hai CRON[24188]: (root) CMD (/etc/linetest/linetest.sh)
Dec 24 17:36:07 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=24195, secured, session=
Dec 24 17:36:07 srv4hai dovecot: imap(rozumm)<24195>: Logged out in=92 out=1062 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Dec 24 17:36:07 srv4hai activate_scenario[24197]: SHELLY scenario: 'nasszeile_um(nasszeile_um)' started
Dec 24 17:36:07 srv4hai activate_scenario[24197]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-28:'KÜ Schalter Nasszeile'
Dec 24 17:36:07 srv4hai activate_scenario[24197]: SHELLY scenario: 'nasszeile_um(nasszeile_um)' TO BE EXECUTED, shelly-28:'KÜ Schalter Nasszeile'
Dec 24 17:36:07 srv4hai postfix/pickup[19265]: F13DC63463: uid=33 from=
Dec 24 17:36:08 srv4hai postfix/cleanup[24250]: F13DC63463: message-id=<20241224163607.F13DC63463@mail.viehai.at>
Dec 24 17:36:08 srv4hai postfix/qmgr[8566]: F13DC63463: from=, size=11459, nrcpt=1 (queue active)
Dec 24 17:36:08 srv4hai activate_scenario[24197]: SHELLY: scenario: 'nasszeile_um(nasszeile_um)'-'shelly-16'-'KÜ Licht Naßzeile' --> '0?turn=toggle&brightness=25'
Dec 24 17:36:08 srv4hai proc_url[24268]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/12/24/_0.log' - shellyUsage:'KÜ Licht Naßzeile' - scUrl:'http://192.168.12.116/white/0?turn=toggle&brightness=25' - phName:'shelly-28:'KÜ Schalter Nasszeile''
Dec 24 17:36:08 srv4hai postfix/local[24263]: F13DC63463: to=, orig_to=, relay=local, delay=0.07, delays=0.04/0.01/0/0.02, dsn=5.1.1, status=bounced (unknown user: "null")
Dec 24 17:36:08 srv4hai postfix/cleanup[24250]: 080F763464: message-id=<20241224163608.080F763464@mail.viehai.at>
Dec 24 17:36:08 srv4hai postfix/bounce[24264]: F13DC63463: sender non-delivery notification: 080F763464
Dec 24 17:36:08 srv4hai postfix/qmgr[8566]: 080F763464: from=<>, size=13378, nrcpt=1 (queue active)
Dec 24 17:36:08 srv4hai postfix/qmgr[8566]: F13DC63463: removed
Dec 24 17:36:08 srv4hai postfix/local[24263]: 080F763464: to=, relay=local, delay=0.01, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Dec 24 17:36:08 srv4hai postfix/qmgr[8566]: 080F763464: removed
Dec 24 17:36:08 srv4hai activate_scenario[24197]: SHELLY: scenario: 'nasszeile_um(nasszeile_um)'-'shelly-16'-'KÜ Licht Naßzeile' --> '1?turn=toggle&brightness=25'
Dec 24 17:36:08 srv4hai proc_url[24280]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/12/24/_1.log' - shellyUsage:'KÜ Licht Naßzeile' - scUrl:'http://192.168.12.116/white/1?turn=toggle&brightness=25' - phName:'shelly-28:'KÜ Schalter Nasszeile''
Dec 24 17:36:08 srv4hai activate_scenario[24197]: SHELLY scenario: 'nasszeile_um(nasszeile_um)' took 113 msec, shelly-28:'KÜ Schalter Nasszeile'
Dec 24 17:36:10 srv4hai activate_scenario[24322]: SHELLY scenario: 'herdzeile_UM(herdzeile_um)' started
Dec 24 17:36:10 srv4hai activate_scenario[24322]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-29:'KÜ Schalter Herdzeile'
finished