activate_scenario.sh
Thu Jan 2 09:05:05 CET 2025
scenario: buero_UM
source: 192.168.12.140
vorher: 09:05:05.997
http://192.168.12.108/relay/0?turn=toggle |
|---|
"ison": true, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "source": "http" |
nachher: 09:05:06.033
Dauer: 36 msec
phName: 'shelly-40:'TB Licht''
vorher: 09:05:06.015
http://192.168.12.140/relay/0?turn=toggle |
|---|
"ison": true, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "source": "http" |
nachher: 09:05:06.050
Dauer: 34 msec
phName: 'shelly-40:'TB Licht''
urls : 2
vorher : 09:05:05.940
nachher: 09:05:06.056
Dauer : 118 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/02//scene_buero_UM_20250102_090505.txt'
Jan 2 09:02:00 srv4hai bt_scan[8924]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes' Jan 2 09:02:00 srv4hai bt_scan[8924]: SHELLY - ping_SP.sh already running for BTmac: '1' - IPv4: '192.168.12.62' Jan 2 09:02:01 srv4hai CRON[8964]: (root) CMD (/etc/linetest/linetest.sh) Jan 2 09:02:28 srv4hai ping_SP[23851]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1735804948 - 'ping_SP_1' Jan 2 09:02:28 srv4hai ping_SP[23851]: SHELLY (1) - ping 192.168.12.62 pCnt:'1' Jan 2 09:02:29 srv4hai dhcpd[4995]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0 Jan 2 09:02:29 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0 Jan 2 09:02:29 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Jan 2 09:02:29 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.147 Jan 2 09:02:29 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-47 Jan 2 09:02:29 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.147 (192.168.12.252) from 44:17:93:a5:8a:e4 via enp2s0 Jan 2 09:02:29 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0 Jan 2 09:02:29 srv4hai named[30406]: client @0x7f932c0c7f00 192.168.12.252#51769/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-47.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 2 09:02:29 srv4hai named[30406]: client @0x7f9348035d30 192.168.12.252#58879/key rndc-key: signer "rndc-key" approved Jan 2 09:02:29 srv4hai named[30406]: client @0x7f9348035d30 192.168.12.252#58879/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' TXT Jan 2 09:02:29 srv4hai named[30406]: client @0x7f9348035d30 192.168.12.252#58879/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' TXT "31f97534415d36e3a13ec57b0310c0867f" Jan 2 09:02:29 srv4hai named[30406]: client @0x7f9348035d30 192.168.12.252#58879/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' A Jan 2 09:02:29 srv4hai named[30406]: client @0x7f9348035d30 192.168.12.252#58879/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' A 192.168.12.147 Jan 2 09:02:29 srv4hai dhcpd[4995]: Added new forward map from shelly-47.viehai.at to 192.168.12.147 Jan 2 09:02:29 srv4hai named[30406]: client @0x7f93100e1310 192.168.12.252#39121/key rndc-key: signer "rndc-key" approved Jan 2 09:02:29 srv4hai named[30406]: client @0x7f93100e1310 192.168.12.252#39121/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '147.12.168.192.in-addr.arpa' PTR Jan 2 09:02:29 srv4hai named[30406]: client @0x7f93100e1310 192.168.12.252#39121/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 2 09:02:29 srv4hai dhcpd[4995]: Added reverse map from 147.12.168.192.in-addr.arpa. to shelly-47.viehai.at Jan 2 09:02:29 srv4hai common[9005]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh Jan 2 09:02:29 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-47' - shIP/2:'' perform:'conf' Jan 2 09:02:29 srv4hai ping_SP[8624]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1735804949 - 'ping_SP_0' Jan 2 09:02:29 srv4hai ping_SP[8624]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Jan 2 09:02:30 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-47' - shIP/2:'192.168.12.147' Jan 2 09:02:30 srv4hai mosquitto[29419]: New connection from 192.168.12.147 on port 1883. Jan 2 09:02:30 srv4hai mosquitto[29419]: Client shellyplus1-441793a58ae4 already connected, closing old connection. Jan 2 09:02:30 srv4hai mosquitto[29419]: Socket error on client shellyplus1-441793a58ae4, disconnecting. Jan 2 09:02:30 srv4hai mosquitto[29419]: New client connected from 192.168.12.147 as shellyplus1-441793a58ae4 (c1, k60, u'shmqtt'). Jan 2 09:02:30 srv4hai conf_shelly.sh: SHELLY: usage/name 'GB Schreibtischlampe links' already set for '192.168.12.147' Jan 2 09:02:30 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(0)' - allready transmitted - skipping Jan 2 09:02:30 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(1)' - allready transmitted - skipping Jan 2 09:02:30 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(2)' - allready transmitted - skipping Jan 2 09:02:49 srv4hai postfix/smtpd[9114]: connect from unknown[154.203.197.235] Jan 2 09:02:49 srv4hai postfix/smtpd[9114]: warning: unknown[154.203.197.235]: SASL LOGIN authentication failed: Invalid authentication mechanism Jan 2 09:02:49 srv4hai postfix/smtpd[9114]: disconnect from unknown[154.203.197.235] ehlo=1 auth=0/1 quit=1 commands=2/3 Jan 2 09:03:01 srv4hai CRON[9119]: (root) CMD (/etc/linetest/linetest.sh) Jan 2 09:03:12 srv4hai common[9131]: SHELLY common.sh inkludiert von ./bt_scan.sh Jan 2 09:03:22 srv4hai bt_scan[9131]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'No' Jan 2 09:03:22 srv4hai bt_scan[9131]: SHELLY - lost BT-connection to BTmac: '1' found: 'No' - check presence Jan 2 09:03:22 srv4hai common[9166]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh Jan 2 09:03:23 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'4'=1735805003-1735804999 Jan 2 09:03:23 srv4hai check_presence[9166]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes Jan 2 09:03:23 srv4hai check_presence[9166]: SHELLY (bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence' Jan 2 09:03:23 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'4'=1735805003-1735804999 Jan 2 09:03:23 srv4hai check_presence[9166]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No Jan 2 09:03:23 srv4hai check_presence[9166]: SHELLY (bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence' Jan 2 09:03:23 srv4hai check_presence[9166]: SHELLY (bt_scan)-(1) what: 'presence' - persPresent: '(BT/LIVE) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true' Jan 2 09:03:23 srv4hai check_presence[9166]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_offAll) - sceneOFF(offAll) Jan 2 09:03:23 srv4hai check_presence[9166]: SHELLY (bt_scan)-(1)-presence: NOT activate_scenario.shtml: offAll Jan 2 09:03:41 srv4hai ping_SP[23851]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1735805021 - 'ping_SP_1' Jan 2 09:03:41 srv4hai ping_SP[23851]: SHELLY (1) - ping 192.168.12.62 pCnt:'1' Jan 2 09:03:42 srv4hai ping_SP[8624]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1735805022 - 'ping_SP_0' Jan 2 09:03:43 srv4hai ping_SP[8624]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Jan 2 09:04:01 srv4hai mosquitto[29419]: Client shellyplus1-441793a58ae4 has exceeded timeout, disconnecting. Jan 2 09:04:01 srv4hai mosquitto[29419]: Socket error on client shellyplus1-441793a58ae4, disconnecting. Jan 2 09:04:01 srv4hai CRON[9341]: (root) CMD (/etc/linetest/linetest.sh) Jan 2 09:04:06 srv4hai dhcpd[4995]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0 Jan 2 09:04:06 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0 Jan 2 09:04:06 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Jan 2 09:04:06 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.147 Jan 2 09:04:06 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-47 Jan 2 09:04:06 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.147 (192.168.12.252) from 44:17:93:a5:8a:e4 via enp2s0 Jan 2 09:04:06 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0 Jan 2 09:04:06 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#40513/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-47.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 2 09:04:06 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#34007/key rndc-key: signer "rndc-key" approved Jan 2 09:04:06 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#34007/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' TXT Jan 2 09:04:06 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#34007/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' TXT "31f97534415d36e3a13ec57b0310c0867f" Jan 2 09:04:06 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#34007/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' A Jan 2 09:04:06 srv4hai named[30406]: client @0x7f9310088a50 192.168.12.252#34007/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' A 192.168.12.147 Jan 2 09:04:06 srv4hai dhcpd[4995]: Added new forward map from shelly-47.viehai.at to 192.168.12.147 Jan 2 09:04:06 srv4hai named[30406]: client @0x7f9350157870 192.168.12.252#60253/key rndc-key: signer "rndc-key" approved Jan 2 09:04:06 srv4hai named[30406]: client @0x7f9350157870 192.168.12.252#60253/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '147.12.168.192.in-addr.arpa' PTR Jan 2 09:04:06 srv4hai named[30406]: client @0x7f9350157870 192.168.12.252#60253/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 2 09:04:06 srv4hai dhcpd[4995]: Added reverse map from 147.12.168.192.in-addr.arpa. to shelly-47.viehai.at Jan 2 09:04:06 srv4hai common[9352]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh Jan 2 09:04:06 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-47' - shIP/2:'' perform:'conf' Jan 2 09:04:07 srv4hai mosquitto[29419]: New connection from 192.168.12.147 on port 1883. Jan 2 09:04:07 srv4hai mosquitto[29419]: New client connected from 192.168.12.147 as shellyplus1-441793a58ae4 (c1, k60, u'shmqtt'). Jan 2 09:04:08 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-47' - shIP/2:'192.168.12.147' Jan 2 09:04:08 srv4hai conf_shelly.sh: SHELLY: usage/name 'GB Schreibtischlampe links' already set for '192.168.12.147' Jan 2 09:04:08 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(0)' - allready transmitted - skipping Jan 2 09:04:08 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(1)' - allready transmitted - skipping Jan 2 09:04:08 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(2)' - allready transmitted - skipping Jan 2 09:04:08 srv4hai postfix/smtpd[9114]: connect from unknown[157.245.80.80] Jan 2 09:04:08 srv4hai postfix/smtpd[9114]: lost connection after CONNECT from unknown[157.245.80.80] Jan 2 09:04:08 srv4hai postfix/smtpd[9114]: disconnect from unknown[157.245.80.80] commands=0/0 Jan 2 09:04:41 srv4hai postfix/smtpd[9114]: connect from unknown[80.94.95.239] Jan 2 09:04:44 srv4hai postfix/smtpd[9114]: warning: unknown[80.94.95.239]: SASL LOGIN authentication failed: Invalid authentication mechanism Jan 2 09:04:45 srv4hai postfix/smtpd[9114]: disconnect from unknown[80.94.95.239] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4 Jan 2 09:04:50 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=9464, secured, session= Jan 2 09:04:50 srv4hai dovecot: imap(rozumm)<9464> : Logged out in=3682 out=1170 deleted=1 expunged=1 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jan 2 09:04:54 srv4hai ping_SP[23851]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1735805094 - 'ping_SP_1' Jan 2 09:04:54 srv4hai ping_SP[23851]: SHELLY (1) - ping 192.168.12.62 pCnt:'1' Jan 2 09:04:56 srv4hai ping_SP[8624]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1735805096 - 'ping_SP_0' Jan 2 09:04:56 srv4hai ping_SP[8624]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Jan 2 09:05:01 srv4hai CRON[9496]: (root) CMD (/etc/linetest/linetest.sh) Jan 2 09:05:05 srv4hai activate_scenario[9505]: SHELLY last scenario: 'offAll' @ '000827' from 'scene_offAll_20250102_000827.txt' - delta=22 Jan 2 09:05:05 srv4hai activate_scenario[9505]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250102090505 20250102000827 -f '%S' Jan 2 09:05:05 srv4hai activate_scenario[9505]: SHELLY new scenario: 'buero_UM' different - GO ON Jan 2 09:05:05 srv4hai activate_scenario[9505]: SHELLY scenario: 'buero_UM(buero_um)' started Jan 2 09:05:05 srv4hai activate_scenario[9505]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'TB Licht'
finished