activate_scenario.sh
Thu Jan 16 19:58:15 CET 2025
scenario: buero_UM
source: 192.168.12.140
'night' <--> 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/16/_0.log)
vorher: 19:58:15.430
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: 19:58:15.467
Dauer: 36 msec
phName: 'shelly-40:'TB Licht''
TB Licht (/srv/www/viehai/shelly/log_scenarios/2025/01/16/_1.log)
vorher: 19:58:15.448
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: 19:58:15.482
Dauer: 33 msec
phName: 'shelly-40:'TB Licht''
scenario: 'Büro UM-schalten' - 'buero_UM' - 'buero_um'
urls : 2
vorher : 19:58:15.406
nachher: 19:58:15.488
Dauer : 83 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/16//scene_buero_UM_20250116_195815.txt'
syslog
Jan 16 19:55:01 srv4hai CRON[27074]: (root) CMD (/etc/linetest/linetest.sh)
Jan 16 19:55:10 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27089, secured, session=
Jan 16 19:55:10 srv4hai dovecot: imap(miglincit)<27089>: Logged out in=285 out=1693 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 16 19:55:16 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27094, secured, session=
Jan 16 19:55:16 srv4hai dovecot: imap(miglincit)<27094>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 16 19:55:43 srv4hai mosquitto[29419]: Client shellyplus1-441793a58ae4 has exceeded timeout, disconnecting.
Jan 16 19:55:43 srv4hai mosquitto[29419]: Socket error on client shellyplus1-441793a58ae4, disconnecting.
Jan 16 19:55:45 srv4hai postfix/anvil[26791]: statistics: max connection rate 1/60s for (smtp:154.203.197.109) at Jan 16 19:51:24
Jan 16 19:55:45 srv4hai postfix/anvil[26791]: statistics: max connection count 1 for (smtp:154.203.197.109) at Jan 16 19:51:24
Jan 16 19:55:45 srv4hai postfix/anvil[26791]: statistics: max cache size 1 at Jan 16 19:51:24
Jan 16 19:55:46 srv4hai postfix/smtpd[27112]: connect from unknown[154.203.197.109]
Jan 16 19:55:46 srv4hai postfix/smtpd[27112]: warning: unknown[154.203.197.109]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jan 16 19:55:46 srv4hai postfix/smtpd[27112]: lost connection after AUTH from unknown[154.203.197.109]
Jan 16 19:55:46 srv4hai postfix/smtpd[27112]: disconnect from unknown[154.203.197.109] ehlo=1 auth=0/1 commands=1/2
Jan 16 19:55:51 srv4hai ping_SP[1653]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1737053751 - 'ping_SP_0'
Jan 16 19:55:51 srv4hai ping_SP[1653]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 16 19:56:01 srv4hai CRON[27134]: (root) CMD (/etc/linetest/linetest.sh)
Jan 16 19:56:09 srv4hai mosquitto[29419]: Socket error on client mosqsub|25522-srv4hai, disconnecting.
Jan 16 19:56:14 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27144, secured, session=
Jan 16 19:56:14 srv4hai dovecot: imap(miglincit)<27144>: Logged out in=443 out=61164 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=460 body_count=1 body_bytes=58957
Jan 16 19:56:15 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27146, secured, session=<19M8WdcrdsYAAAAAAAAAAAAAAAAAAAAB>
Jan 16 19:56:15 srv4hai dovecot: imap(miglincit)<27146><19M8WdcrdsYAAAAAAAAAAAAAAAAAAAAB>: Logged out in=606 out=32564 deleted=0 expunged=0 trashed=1 hdr_count=1 hdr_bytes=316 body_count=0 body_bytes=0
Jan 16 19:56:15 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27148, secured, session=
Jan 16 19:56:15 srv4hai dovecot: imap(miglincit)<27148>: Logged out in=397 out=144035 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=458 body_count=1 body_bytes=141889
Jan 16 19:56:38 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27156, secured, session=
Jan 16 19:56:38 srv4hai dovecot: imap(miglincit)<27156>: Logged out in=2102 out=167697 deleted=0 expunged=0 trashed=0 hdr_count=257 hdr_bytes=93051 body_count=0 body_bytes=0
Jan 16 19:56:56 srv4hai dhcpd[4995]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0
Jan 16 19:56:56 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
Jan 16 19:56:58 srv4hai dhcpd[4995]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0
Jan 16 19:56:58 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
Jan 16 19:56:58 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 16 19:56:58 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.147
Jan 16 19:56:58 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-47
Jan 16 19:56:58 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.147 (192.168.12.252) from 44:17:93:a5:8a:e4 via enp2s0
Jan 16 19:56:58 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
Jan 16 19:56:58 srv4hai named[30406]: client @0x7f93480cbdb0 192.168.12.252#47101/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-47.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 16 19:56:58 srv4hai named[30406]: client @0x7f9348048e40 192.168.12.252#53283/key rndc-key: signer "rndc-key" approved
Jan 16 19:56:58 srv4hai named[30406]: client @0x7f9348048e40 192.168.12.252#53283/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' TXT
Jan 16 19:56:58 srv4hai named[30406]: client @0x7f9348048e40 192.168.12.252#53283/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' TXT "31f97534415d36e3a13ec57b0310c0867f"
Jan 16 19:56:58 srv4hai named[30406]: client @0x7f9348048e40 192.168.12.252#53283/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' A
Jan 16 19:56:58 srv4hai named[30406]: client @0x7f9348048e40 192.168.12.252#53283/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' A 192.168.12.147
Jan 16 19:56:58 srv4hai dhcpd[4995]: Added new forward map from shelly-47.viehai.at to 192.168.12.147
Jan 16 19:56:58 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#38099/key rndc-key: signer "rndc-key" approved
Jan 16 19:56:58 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#38099/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '147.12.168.192.in-addr.arpa' PTR
Jan 16 19:56:58 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#38099/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '147.12.168.192.in-addr.arpa' PTR shelly-47.viehai.at.
Jan 16 19:56:58 srv4hai dhcpd[4995]: Added reverse map from 147.12.168.192.in-addr.arpa. to shelly-47.viehai.at
Jan 16 19:56:58 srv4hai common[27176]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan 16 19:56:58 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-47' - shIP/2:'' perform:'conf'
Jan 16 19:56:59 srv4hai mosquitto[29419]: New connection from 192.168.12.147 on port 1883.
Jan 16 19:56:59 srv4hai mosquitto[29419]: New client connected from 192.168.12.147 as shellyplus1-441793a58ae4 (c1, k60, u'shmqtt').
Jan 16 19:56:59 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-47' - shIP/2:'192.168.12.147'
Jan 16 19:56:59 srv4hai conf_shelly.sh: SHELLY: usage/name 'GB Schreibtischlampe links' already set for '192.168.12.147'
Jan 16 19:56:59 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(0)' - allready transmitted - skipping
Jan 16 19:56:59 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(1)' - allready transmitted - skipping
Jan 16 19:56:59 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(2)' - allready transmitted - skipping
Jan 16 19:57:01 srv4hai CRON[27263]: (root) CMD (/etc/linetest/linetest.sh)
Jan 16 19:57:04 srv4hai ping_SP[1653]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1737053824 - 'ping_SP_0'
Jan 16 19:57:04 srv4hai ping_SP[1653]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 16 19:57:59 srv4hai dhcpd[4995]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0
Jan 16 19:57:59 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
Jan 16 19:57:59 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 16 19:57:59 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.147
Jan 16 19:57:59 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-47
Jan 16 19:57:59 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.147 (192.168.12.252) from 44:17:93:a5:8a:e4 via enp2s0
Jan 16 19:57:59 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
Jan 16 19:57:59 srv4hai named[30406]: client @0x7f93100d29e0 192.168.12.252#34101/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-47.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 16 19:57:59 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#41929/key rndc-key: signer "rndc-key" approved
Jan 16 19:57:59 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#41929/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' TXT
Jan 16 19:57:59 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#41929/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' TXT "31f97534415d36e3a13ec57b0310c0867f"
Jan 16 19:57:59 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#41929/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' A
Jan 16 19:57:59 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#41929/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' A 192.168.12.147
Jan 16 19:57:59 srv4hai dhcpd[4995]: Added new forward map from shelly-47.viehai.at to 192.168.12.147
Jan 16 19:57:59 srv4hai named[30406]: client @0x7f93300df020 192.168.12.252#49895/key rndc-key: signer "rndc-key" approved
Jan 16 19:57:59 srv4hai named[30406]: client @0x7f93300df020 192.168.12.252#49895/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '147.12.168.192.in-addr.arpa' PTR
Jan 16 19:57:59 srv4hai named[30406]: client @0x7f93300df020 192.168.12.252#49895/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '147.12.168.192.in-addr.arpa' PTR shelly-47.viehai.at.
Jan 16 19:57:59 srv4hai dhcpd[4995]: Added reverse map from 147.12.168.192.in-addr.arpa. to shelly-47.viehai.at
Jan 16 19:57:59 srv4hai common[27309]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan 16 19:57:59 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-47' - shIP/2:'' perform:'conf'
Jan 16 19:58:00 srv4hai mosquitto[29419]: New connection from 192.168.12.147 on port 1883.
Jan 16 19:58:00 srv4hai mosquitto[29419]: Client shellyplus1-441793a58ae4 already connected, closing old connection.
Jan 16 19:58:00 srv4hai mosquitto[29419]: Socket error on client shellyplus1-441793a58ae4, disconnecting.
Jan 16 19:58:00 srv4hai mosquitto[29419]: New client connected from 192.168.12.147 as shellyplus1-441793a58ae4 (c1, k60, u'shmqtt').
Jan 16 19:58:00 srv4hai grab_shelly.sh: SHELLY 'shelly-47': OFFLINE, resp. not answering within timeout 1.500000s
Jan 16 19:58:01 srv4hai CRON[27326]: (root) CMD (/etc/linetest/linetest.sh)
Jan 16 19:58:09 srv4hai activate_scenario[27343]: SHELLY last scenario: 'pcON' @ '181130' from 'scene_pcON_20250116_181130.txt' - delta=21
Jan 16 19:58:09 srv4hai activate_scenario[27343]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250116195809 20250116181130 -f '%S'
Jan 16 19:58:09 srv4hai activate_scenario[27343]: SHELLY new scenario: 'pcOFF' different - GO ON
Jan 16 19:58:09 srv4hai activate_scenario[27343]: SHELLY scenario: 'pcOFF(pcoff)' started
Jan 16 19:58:09 srv4hai activate_scenario[27343]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-0:''
Jan 16 19:58:09 srv4hai activate_scenario[27343]: SHELLY scenario: 'pcOFF(pcoff)' TO BE EXECUTED, shelly-0:''
Jan 16 19:58:09 srv4hai postfix/pickup[12866]: E3DA963464: uid=33 from=
Jan 16 19:58:09 srv4hai postfix/cleanup[27408]: E3DA963464: message-id=<20250116185809.E3DA963464@mail.viehai.at>
Jan 16 19:58:09 srv4hai postfix/qmgr[8566]: E3DA963464: from=, size=12252, nrcpt=1 (queue active)
Jan 16 19:58:09 srv4hai postfix/local[27421]: E3DA963464: 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 16 19:58:09 srv4hai postfix/cleanup[27408]: E9CAA63465: message-id=<20250116185809.E9CAA63465@mail.viehai.at>
Jan 16 19:58:09 srv4hai activate_scenario[27343]: SHELLY: scenario: 'pcOFF(pcoff)'-'shelly-20'-'TB Schreibtischlampe' --> '0?turn=off'
Jan 16 19:58:09 srv4hai proc_url[27426]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/16/_0.log' - shellyUsage:'TB Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=off' - phName:'shelly-0:'''
Jan 16 19:58:09 srv4hai postfix/bounce[27422]: E3DA963464: sender non-delivery notification: E9CAA63465
Jan 16 19:58:09 srv4hai postfix/qmgr[8566]: E9CAA63465: from=<>, size=14131, nrcpt=1 (queue active)
Jan 16 19:58:09 srv4hai postfix/qmgr[8566]: E3DA963464: removed
Jan 16 19:58:09 srv4hai postfix/local[27421]: E9CAA63465: to=, relay=local, delay=0.01, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 16 19:58:09 srv4hai postfix/qmgr[8566]: E9CAA63465: removed
Jan 16 19:58:09 srv4hai activate_scenario[27343]: SHELLY scenario: 'pcOFF(pcoff)' took 59 msec, shelly-0:''
Jan 16 19:58:14 srv4hai postfix/smtpd[27453]: connect from unknown[92.118.39.66]
Jan 16 19:58:15 srv4hai activate_scenario[27458]: SHELLY last scenario: 'pcOFF' @ '195809' from 'scene_pcOFF_20250116_195809.txt' - delta=-6
Jan 16 19:58:15 srv4hai activate_scenario[27458]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250116195815 20250116195809 -f '%S'
Jan 16 19:58:15 srv4hai activate_scenario[27458]: SHELLY new scenario: 'buero_UM' different - GO ON
Jan 16 19:58:15 srv4hai activate_scenario[27458]: SHELLY scenario: 'buero_UM(buero_um)' started
Jan 16 19:58:15 srv4hai activate_scenario[27458]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-40:'TB Licht'
finished