activate_scenario.sh
Thu Jan 23 12:48:32 CET 2025
scenario: buero_UM
source: 192.168.12.140
'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'null'
scenario: 'Büro UM-schalten' - 'buero_UM' - 'buero_um'
TB Regallicht (/srv/www/viehai/shelly/log_scenarios/2025/01/23/_0.log)
vorher: 12:48:32.209
http://192.168.12.108/relay/0?turn=toggle |
|---|
"ison": false,
"has_timer": false,
"timer_started": 0,
"timer_duration": 0,
"timer_remaining": 0,
"source": "http"
|
nachher: 12:48:32.234
Dauer: 25 msec
phName: 'shelly-40:'TB Licht''
TB Licht (/srv/www/viehai/shelly/log_scenarios/2025/01/23/_1.log)
vorher: 12:48:32.227
http://192.168.12.140/relay/0?turn=toggle |
|---|
"ison": false,
"has_timer": false,
"timer_started": 0,
"timer_duration": 0,
"timer_remaining": 0,
"source": "http"
|
nachher: 12:48:32.312
Dauer: 85 msec
phName: 'shelly-40:'TB Licht''
scenario: 'Büro UM-schalten' - 'buero_UM' - 'buero_um'
urls : 2
vorher : 12:48:32.158
nachher: 12:48:32.318
Dauer : 163 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/23//scene_buero_UM_20250123_124832.txt'
syslog
Jan 23 12:45:01 srv4hai CRON[18405]: (root) CMD (/etc/linetest/linetest.sh)
Jan 23 12:45:19 srv4hai ping_SP[8282]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1737632719 - 'ping_SP_0'
Jan 23 12:45:19 srv4hai ping_SP[8282]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 23 12:45:35 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Jan 23 12:45:35 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.10
Jan 23 12:45:35 srv4hai dhcpd[4995]: execute_statement argv[2] = pchai7x
Jan 23 12:45:35 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Jan 23 12:45:35 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Jan 23 12:45:35 srv4hai named[30406]: client @0x7f93506c16d0 192.168.12.252#39543/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 23 12:45:35 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#58369/key rndc-key: signer "rndc-key" approved
Jan 23 12:45:35 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#58369/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Jan 23 12:45:35 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#58369/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Jan 23 12:45:35 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#58369/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Jan 23 12:45:35 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#58369/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Jan 23 12:45:35 srv4hai dhcpd[4995]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Jan 23 12:45:35 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Jan 23 12:45:35 srv4hai named[30406]: client @0x7f93506d04d0 192.168.12.252#47393/key rndc-key: signer "rndc-key" approved
Jan 23 12:45:35 srv4hai named[30406]: client @0x7f93506d04d0 192.168.12.252#47393/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Jan 23 12:45:35 srv4hai named[30406]: client @0x7f93506d04d0 192.168.12.252#47393/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '10.12.168.192.in-addr.arpa' PTR pchai7x.viehai.at.
Jan 23 12:45:35 srv4hai dhcpd[4995]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Jan 23 12:45:35 srv4hai activate_scenario[18454]: SHELLY last scenario: 'buero_UM' @ '122322' from 'scene_buero_UM_20250123_122322.txt' - delta=-13
Jan 23 12:45:35 srv4hai activate_scenario[18454]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250123124535 20250123122322 -f '%S'
Jan 23 12:45:35 srv4hai activate_scenario[18454]: SHELLY new scenario: 'pcON' different - GO ON
Jan 23 12:45:35 srv4hai activate_scenario[18454]: SHELLY scenario: 'pcON(pcon)' started
Jan 23 12:45:35 srv4hai activate_scenario[18454]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'
Jan 23 12:45:35 srv4hai activate_scenario[18454]: SHELLY scenario: 'pcON(pcon)' TO BE EXECUTED, origin:'dhcpcommit.sh-pchai7x'
Jan 23 12:45:35 srv4hai postfix/pickup[8764]: 40C2163463: uid=33 from=
Jan 23 12:45:35 srv4hai postfix/cleanup[18349]: 40C2163463: message-id=<20250123114535.40C2163463@mail.viehai.at>
Jan 23 12:45:35 srv4hai postfix/qmgr[8566]: 40C2163463: from=, size=6876, nrcpt=1 (queue active)
Jan 23 12:45:35 srv4hai postfix/local[18350]: 40C2163463: to=, orig_to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 23 12:45:35 srv4hai postfix/cleanup[18349]: 43FFC63464: message-id=<20250123114535.43FFC63464@mail.viehai.at>
Jan 23 12:45:35 srv4hai postfix/bounce[18519]: 40C2163463: sender non-delivery notification: 43FFC63464
Jan 23 12:45:35 srv4hai postfix/qmgr[8566]: 43FFC63464: from=<>, size=8755, nrcpt=1 (queue active)
Jan 23 12:45:35 srv4hai postfix/qmgr[8566]: 40C2163463: removed
Jan 23 12:45:35 srv4hai postfix/local[18350]: 43FFC63464: to=, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 23 12:45:35 srv4hai postfix/qmgr[8566]: 43FFC63464: removed
Jan 23 12:45:35 srv4hai activate_scenario[18454]: SHELLY: scenario: 'pcON(pcon)'-'shelly-20'-'TB Schreibtischlampe' --> '0?turn=on'
Jan 23 12:45:35 srv4hai proc_url[18532]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/23/_0.log' - shellyUsage:'TB Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=on' - phName:'origin:'dhcpcommit.sh-pchai7x''
Jan 23 12:45:35 srv4hai activate_scenario[18454]: SHELLY scenario: 'pcON(pcon)' took 62 msec, origin:'dhcpcommit.sh-pchai7x'
Jan 23 12:45:50 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=192.168.12.10, lip=192.168.12.252, mpid=18574, TLS, session=
Jan 23 12:45:50 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=192.168.12.10, lip=192.168.12.252, mpid=18576, TLS, session=
Jan 23 12:45:50 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=192.168.12.10, lip=192.168.12.252, mpid=18577, TLS, session=<73PVJl4s8KHAqAwK>
Jan 23 12:45:50 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=192.168.12.10, lip=192.168.12.252, mpid=18579, TLS, session=
Jan 23 12:45:50 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=192.168.12.10, lip=192.168.12.252, mpid=18580, TLS, session=
Jan 23 12:45:58 srv4hai postfix/smtpd[18343]: warning: hostname 172-245-9-111-host.colocrossing.com does not resolve to address 172.245.9.111: Name or service not known
Jan 23 12:45:58 srv4hai postfix/smtpd[18343]: connect from unknown[172.245.9.111]
Jan 23 12:46:01 srv4hai CRON[18587]: (root) CMD (/etc/linetest/linetest.sh)
Jan 23 12:46:02 srv4hai postfix/smtpd[18343]: warning: unknown[172.245.9.111]: SASL PLAIN authentication failed:
Jan 23 12:46:02 srv4hai postfix/smtpd[18343]: disconnect from unknown[172.245.9.111] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 23 12:46:31 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan 23 12:46:31 srv4hai fetchmail[1651]: 62080 messages (62080 seen) for tmiglinci at mail.akis.at (783933388 octets).
Jan 23 12:46:32 srv4hai fetchmail[1651]: 11432 messages (11432 seen) for srozum at mail.akis.at (1361267489 octets).
Jan 23 12:46:32 srv4hai ping_SP[8282]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1737632792 - 'ping_SP_0'
Jan 23 12:46:32 srv4hai ping_SP[8282]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 23 12:46:32 srv4hai fetchmail[1651]: 28487 messages (28487 seen) for mrozum at mail.akis.at (586853955 octets).
Jan 23 12:46:33 srv4hai fetchmail[1651]: 1162 messages (1162 seen) for admin@bastelstube.wien at pop3.world4you.com (52206525 octets).
Jan 23 12:46:36 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=18631, secured, session=<8zSWKV4s8sYAAAAAAAAAAAAAAAAAAAAB>
Jan 23 12:46:36 srv4hai dovecot: imap(miglincit)<18631><8zSWKV4s8sYAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 23 12:46:54 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 23 12:46:54 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.135
Jan 23 12:46:54 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-35
Jan 23 12:46:54 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.135 (192.168.12.252) from e0:98:06:a4:16:96 via enp2s0
Jan 23 12:46:54 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.135 to e0:98:06:a4:16:96 via enp2s0
Jan 23 12:46:54 srv4hai named[30406]: client @0x7f93501490e0 192.168.12.252#57819/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-35.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 23 12:46:54 srv4hai named[30406]: client @0x7f93100c3be0 192.168.12.252#40459/key rndc-key: signer "rndc-key" approved
Jan 23 12:46:54 srv4hai named[30406]: client @0x7f93100c3be0 192.168.12.252#40459/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-35.viehai.at' TXT
Jan 23 12:46:54 srv4hai named[30406]: client @0x7f93100c3be0 192.168.12.252#40459/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-35.viehai.at' TXT "0097f19417e437d98074a9b21f576434d2"
Jan 23 12:46:54 srv4hai named[30406]: client @0x7f93100c3be0 192.168.12.252#40459/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-35.viehai.at' A
Jan 23 12:46:54 srv4hai named[30406]: client @0x7f93100c3be0 192.168.12.252#40459/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-35.viehai.at' A 192.168.12.135
Jan 23 12:46:54 srv4hai dhcpd[4995]: Added new forward map from shelly-35.viehai.at to 192.168.12.135
Jan 23 12:46:54 srv4hai named[30406]: client @0x7f932c03e370 192.168.12.252#48101/key rndc-key: signer "rndc-key" approved
Jan 23 12:46:54 srv4hai named[30406]: client @0x7f932c03e370 192.168.12.252#48101/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '135.12.168.192.in-addr.arpa' PTR
Jan 23 12:46:54 srv4hai named[30406]: client @0x7f932c03e370 192.168.12.252#48101/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '135.12.168.192.in-addr.arpa' PTR shelly-35.viehai.at.
Jan 23 12:46:54 srv4hai dhcpd[4995]: Added reverse map from 135.12.168.192.in-addr.arpa. to shelly-35.viehai.at
Jan 23 12:46:54 srv4hai common[18647]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan 23 12:46:54 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-35' - shIP/2:'' perform:'conf'
Jan 23 12:46:54 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-35' - shIP/2:'192.168.12.135'
Jan 23 12:46:54 srv4hai conf_shelly.sh: SHELLY: usage/name 'Zwischenstecker 35' already set for '192.168.12.135'
Jan 23 12:47:01 srv4hai CRON[18694]: (root) CMD (/etc/linetest/linetest.sh)
Jan 23 12:47:45 srv4hai ping_SP[8282]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1737632865 - 'ping_SP_0'
Jan 23 12:47:45 srv4hai ping_SP[8282]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 23 12:48:01 srv4hai CRON[18751]: (root) CMD (/etc/linetest/linetest.sh)
Jan 23 12:48:15 srv4hai dovecot: imap(miglincit)<18580>: Logged out in=54932 out=565974 deleted=0 expunged=0 trashed=0 hdr_count=2 hdr_bytes=654 body_count=0 body_bytes=0
Jan 23 12:48:15 srv4hai dovecot: imap(miglincit)<18574>: Logged out in=554 out=298311 deleted=0 expunged=0 trashed=0 hdr_count=4 hdr_bytes=2063 body_count=4 body_bytes=210500
Jan 23 12:48:15 srv4hai dovecot: imap(miglincit)<18577><73PVJl4s8KHAqAwK>: Logged out in=53378 out=723970 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=2 body_bytes=31563
Jan 23 12:48:15 srv4hai dovecot: imap(miglincit)<18579>: Logged out in=54984 out=572977 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 23 12:48:15 srv4hai dovecot: imap(miglincit)<18576>: Logged out in=54952 out=492677 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY last scenario: 'pcON' @ '124535' from 'scene_pcON_20250123_124535.txt' - delta=20
Jan 23 12:48:15 srv4hai activate_scenario[18766]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250123124815 20250123124535 -f '%S'
Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY new scenario: 'pcOFF' different - GO ON
Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY scenario: 'pcOFF(pcoff)' started
Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-0:''
Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY scenario: 'pcOFF(pcoff)' TO BE EXECUTED, shelly-0:''
Jan 23 12:48:15 srv4hai postfix/pickup[8764]: EB5D063463: uid=33 from=
Jan 23 12:48:15 srv4hai postfix/cleanup[18831]: EB5D063463: message-id=<20250123114815.EB5D063463@mail.viehai.at>
Jan 23 12:48:15 srv4hai postfix/qmgr[8566]: EB5D063463: from=, size=12908, nrcpt=1 (queue active)
Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY: scenario: 'pcOFF(pcoff)'-'shelly-20'-'TB Schreibtischlampe' --> '0?turn=off'
Jan 23 12:48:15 srv4hai postfix/local[18844]: EB5D063463: to=, orig_to=, relay=local, delay=0.03, delays=0.02/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 23 12:48:15 srv4hai postfix/cleanup[18831]: F1B3A63464: message-id=<20250123114815.F1B3A63464@mail.viehai.at>
Jan 23 12:48:15 srv4hai proc_url[18849]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/23/_0.log' - shellyUsage:'TB Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=off' - phName:'shelly-0:'''
Jan 23 12:48:15 srv4hai postfix/bounce[18845]: EB5D063463: sender non-delivery notification: F1B3A63464
Jan 23 12:48:15 srv4hai postfix/qmgr[8566]: F1B3A63464: from=<>, size=14787, nrcpt=1 (queue active)
Jan 23 12:48:15 srv4hai postfix/qmgr[8566]: EB5D063463: removed
Jan 23 12:48:15 srv4hai postfix/local[18844]: F1B3A63464: to=, relay=local, delay=0.01, delays=0/0/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 23 12:48:15 srv4hai postfix/qmgr[8566]: F1B3A63464: removed
Jan 23 12:48:16 srv4hai activate_scenario[18766]: SHELLY scenario: 'pcOFF(pcoff)' took 58 msec, shelly-0:''
Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY last scenario: 'pcOFF' @ '124815' from 'scene_pcOFF_20250123_124815.txt' - delta=-17
Jan 23 12:48:32 srv4hai activate_scenario[18884]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250123124832 20250123124815 -f '%S'
Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY new scenario: 'buero_UM' different - GO ON
Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY scenario: 'buero_UM(buero_um)' started
Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'TB Licht'
finished