activate_scenario.sh
Wed Jan 17 22:42:01 CET 2024
scenario: offDownstairs
vorher: 22:42:01.896
http://192.168.12.101/relay/0?turn=off |
---|
"ison": false, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "overpower": false, "source": "http" |
nachher: 22:42:01.932
Dauer: 37 msec
vorher: 22:42:01.909
http://192.168.12.102/relay/0?turn=off |
---|
"ison": false, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "overpower": false, "source": "http" |
nachher: 22:42:01.932
Dauer: 24 msec
vorher: 22:42:01.921
http://192.168.12.103/relay/0?turn=off |
---|
"ison": false, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "overpower": false, "source": "http" |
nachher: 22:42:01.965
Dauer: 44 msec
vorher: 22:42:01.934
http://192.168.12.105/relay/0?turn=off |
---|
"ison": false, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "source": "http" |
nachher: 22:42:01.973
Dauer: 39 msec
vorher: 22:42:01.950
http://192.168.12.106/relay/0?turn=off |
---|
"ison": false, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "source": "http" |
nachher: 22:42:02.055
Dauer: 106 msec
vorher: 22:42:01.963
http://192.168.12.110/relay/0?turn=off |
---|
"ison": false, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "source": "http" |
nachher: 22:42:01.999
Dauer: 37 msec
vorher: 22:42:01.976
http://192.168.12.116/white/0?turn=off&brightness=70 |
---|
"ison": false, "source": "http", "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "mode": "white", "brightness": 70, "transition": 0, "power": 10.8, "overpower": false |
nachher: 22:42:02.033
Dauer: 56 msec
vorher: 22:42:01.989
http://192.168.12.116/white/1?turn=off&brightness=70 |
---|
"ison": false, "source": "http", "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "mode": "white", "brightness": 70, "transition": 0, "power": 10.8, "overpower": false |
nachher: 22:42:02.032
Dauer: 42 msec
vorher: 22:42:02.002
http://192.168.12.117/white/0?turn=off&brightness=50 |
---|
"ison": false, "source": "http", "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "mode": "white", "brightness": 50, "transition": 0, "power": 7.13, "overpower": false |
nachher: 22:42:02.036
Dauer: 33 msec
vorher: 22:42:02.017
http://192.168.12.117/white/1?turn=off&brightness=50 |
---|
"ison": false, "source": "http", "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "mode": "white", "brightness": 50, "transition": 0, "power": 7.13, "overpower": false |
nachher: 22:42:02.170
Dauer: 153 msec
vorher: 22:42:02.030
http://192.168.12.119/relay/0?turn=off |
---|
"ison": false, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "source": "input" |
nachher: 22:42:02.069
Dauer: 38 msec
vorher: 22:42:02.046
http://192.168.12.122/relay/0?turn=off |
---|
nachher: 22:42:05.118
Dauer: 3072 msec
vorher: 22:42:02.064
http://192.168.12.123/relay/0?turn=off |
---|
"ison": false, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "source": "http" |
nachher: 22:42:02.103
Dauer: 40 msec
vorher: 22:42:02.073
http://192.168.12.125/relay/0?turn=off |
---|
"ison": false, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "source": "http" |
nachher: 22:42:02.125
Dauer: 52 msec
urls : 14
vorher : 22:42:01.878
nachher: 22:42:05.126
Dauer : 3249 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/17//scene_offDownstairs_20240117_224201.txt'
Jan 17 22:39:02 srv4hai CRON[5200]: (root) CMD ( [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi) Jan 17 22:39:02 srv4hai CRON[5201]: (root) CMD (/etc/linetest/linetest.sh) Jan 17 22:39:02 srv4hai systemd[1]: Starting Clean php session files... Jan 17 22:39:02 srv4hai systemd[1]: phpsessionclean.service: Succeeded. Jan 17 22:39:02 srv4hai systemd[1]: Started Clean php session files. Jan 17 22:39:04 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705527544 - 'ping_SP_1' Jan 17 22:39:14 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=5307, secured, session= Jan 17 22:39:14 srv4hai dovecot: imap(rozumm)<5307> : Logged out in=92 out=1059 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jan 17 22:39:14 srv4hai named[14530]: resolver priming query complete Jan 17 22:39:17 srv4hai named[14530]: resolver priming query complete Jan 17 22:39:18 srv4hai named[14530]: resolver priming query complete Jan 17 22:39:21 srv4hai named[14530]: resolver priming query complete Jan 17 22:39:21 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 17 22:39:21 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 17 22:39:22 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705527562 - 'ping_SP_0' Jan 17 22:39:24 srv4hai named[14530]: resolver priming query complete Jan 17 22:39:34 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705527574 - 'ping_SP_1' Jan 17 22:39:52 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705527592 - 'ping_SP_0' Jan 17 22:40:01 srv4hai CRON[5342]: (root) CMD (/etc/linetest/linetest.sh) Jan 17 22:40:01 srv4hai CRON[5343]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh) Jan 17 22:40:01 srv4hai meter.sh: SHELLY meter.sh started Jan 17 22:40:04 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705527604 - 'ping_SP_1' Jan 17 22:40:14 srv4hai dovecot: imap-login: Login: user= , method=PLAIN, rip=::1, lip=::1, mpid=5549, secured, session=<+JqcFysPKrcAAAAAAAAAAAAAAAAAAAAB> Jan 17 22:40:14 srv4hai dovecot: imap(rozumm)<5549><+JqcFysPKrcAAAAAAAAAAAAAAAAAAAAB>: Logged out in=92 out=1059 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jan 17 22:40:22 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705527622 - 'ping_SP_0' Jan 17 22:40:23 srv4hai named[14530]: resolver priming query complete Jan 17 22:40:25 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 17 22:40:25 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 17 22:40:35 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705527635 - 'ping_SP_1' Jan 17 22:40:47 srv4hai named[14530]: resolver priming query complete Jan 17 22:40:52 srv4hai dhcpd[8095]: DHCPDISCOVER from 98:cd:ac:1e:39:5f via enp2s0 Jan 17 22:40:52 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.114 to 98:cd:ac:1e:39:5f via enp2s0 Jan 17 22:40:52 srv4hai dhcpd[8095]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Jan 17 22:40:52 srv4hai dhcpd[8095]: execute_statement argv[1] = 192.168.12.114 Jan 17 22:40:52 srv4hai dhcpd[8095]: execute_statement argv[2] = shelly-14 Jan 17 22:40:52 srv4hai dhcpd[8095]: DHCPREQUEST for 192.168.12.114 (192.168.12.252) from 98:cd:ac:1e:39:5f via enp2s0 Jan 17 22:40:52 srv4hai dhcpd[8095]: DHCPACK on 192.168.12.114 to 98:cd:ac:1e:39:5f via enp2s0 Jan 17 22:40:52 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#40891/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-14.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 17 22:40:52 srv4hai named[14530]: client @0x7fc320081f70 192.168.12.252#50995/key rndc-key: signer "rndc-key" approved Jan 17 22:40:52 srv4hai named[14530]: client @0x7fc320081f70 192.168.12.252#50995/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-14.viehai.at' TXT Jan 17 22:40:52 srv4hai named[14530]: client @0x7fc320081f70 192.168.12.252#50995/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-14.viehai.at' TXT "001691a966cf4dd6d72071525ebef5ee4e" Jan 17 22:40:52 srv4hai named[14530]: client @0x7fc320081f70 192.168.12.252#50995/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-14.viehai.at' A Jan 17 22:40:52 srv4hai named[14530]: client @0x7fc320081f70 192.168.12.252#50995/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-14.viehai.at' A 192.168.12.114 Jan 17 22:40:52 srv4hai dhcpd[8095]: Added new forward map from shelly-14.viehai.at to 192.168.12.114 Jan 17 22:40:52 srv4hai named[14530]: client @0x7fc328677140 192.168.12.252#37469/key rndc-key: signer "rndc-key" approved Jan 17 22:40:52 srv4hai named[14530]: client @0x7fc328677140 192.168.12.252#37469/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '114.12.168.192.in-addr.arpa' PTR Jan 17 22:40:52 srv4hai named[14530]: client @0x7fc328677140 192.168.12.252#37469/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '114.12.168.192.in-addr.arpa' PTR shelly-14.viehai.at. Jan 17 22:40:52 srv4hai dhcpd[8095]: Added reverse map from 114.12.168.192.in-addr.arpa. to shelly-14.viehai.at Jan 17 22:40:52 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-14' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf' Jan 17 22:40:52 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705527652 - 'ping_SP_0' Jan 17 22:40:53 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-14' - shIP/2:'192.168.12.114' Jan 17 22:40:53 srv4hai conf_shelly.sh: SHELLY: usage/name 'AUS-Schalter' already set for '192.168.12.114' Jan 17 22:40:53 srv4hai conf_shelly.sh: SHELLY:'shelly-14' 'conf(0)' - allready transmitted - skipping Jan 17 22:40:53 srv4hai conf_shelly.sh: SHELLY:'shelly-14' 'conf(1)' - allready transmitted - skipping Jan 17 22:40:53 srv4hai conf_shelly.sh: SHELLY:'shelly-14' 'conf(2)' - allready transmitted - skipping Jan 17 22:40:53 srv4hai conf_shelly.sh: SHELLY:'shelly-14' 'conf(3)' - allready transmitted - skipping Jan 17 22:40:53 srv4hai conf_shelly.sh: SHELLY:'shelly-14' 'conf(4)' - allready transmitted - skipping Jan 17 22:40:53 srv4hai conf_shelly.sh: SHELLY:'shelly-14' 'conf(5)' - allready transmitted - skipping Jan 17 22:41:01 srv4hai CRON[5843]: (root) CMD (/etc/linetest/linetest.sh) Jan 17 22:41:05 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705527665 - 'ping_SP_1' Jan 17 22:41:07 srv4hai named[14530]: resolver priming query complete Jan 17 22:41:14 srv4hai dovecot: imap-login: Login: user= , method=PLAIN, rip=::1, lip=::1, mpid=5877, secured, session= Jan 17 22:41:14 srv4hai dovecot: imap(rozumm)<5877> : Logged out in=92 out=1059 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jan 17 22:41:15 srv4hai meter.sh: SHELLY meter.sh ended Jan 17 22:41:23 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705527683 - 'ping_SP_0' Jan 17 22:41:29 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 17 22:41:29 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 17 22:41:33 srv4hai dhcpd[8095]: DHCPDISCOVER from 30:83:98:8c:05:9d via enp2s0 Jan 17 22:41:33 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.123 to 30:83:98:8c:05:9d via enp2s0 Jan 17 22:41:33 srv4hai dhcpd[8095]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Jan 17 22:41:33 srv4hai dhcpd[8095]: execute_statement argv[1] = 192.168.12.123 Jan 17 22:41:33 srv4hai dhcpd[8095]: execute_statement argv[2] = shelly-23 Jan 17 22:41:33 srv4hai dhcpd[8095]: DHCPREQUEST for 192.168.12.123 (192.168.12.252) from 30:83:98:8c:05:9d via enp2s0 Jan 17 22:41:33 srv4hai dhcpd[8095]: DHCPACK on 192.168.12.123 to 30:83:98:8c:05:9d via enp2s0 Jan 17 22:41:33 srv4hai named[14530]: client @0x7fc318077970 192.168.12.252#46219/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-23.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 17 22:41:33 srv4hai named[14530]: client @0x7fc320090c00 192.168.12.252#54661/key rndc-key: signer "rndc-key" approved Jan 17 22:41:33 srv4hai named[14530]: client @0x7fc320090c00 192.168.12.252#54661/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-23.viehai.at' TXT Jan 17 22:41:33 srv4hai named[14530]: client @0x7fc320090c00 192.168.12.252#54661/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-23.viehai.at' TXT "0067c4eae5f3400bd02ff9ebe320262416" Jan 17 22:41:33 srv4hai named[14530]: client @0x7fc320090c00 192.168.12.252#54661/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-23.viehai.at' A Jan 17 22:41:33 srv4hai named[14530]: client @0x7fc320090c00 192.168.12.252#54661/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-23.viehai.at' A 192.168.12.123 Jan 17 22:41:33 srv4hai dhcpd[8095]: Added new forward map from shelly-23.viehai.at to 192.168.12.123 Jan 17 22:41:33 srv4hai named[14530]: client @0x7fc3180965b0 192.168.12.252#58061/key rndc-key: signer "rndc-key" approved Jan 17 22:41:33 srv4hai named[14530]: client @0x7fc3180965b0 192.168.12.252#58061/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '123.12.168.192.in-addr.arpa' PTR Jan 17 22:41:33 srv4hai named[14530]: client @0x7fc3180965b0 192.168.12.252#58061/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '123.12.168.192.in-addr.arpa' PTR shelly-23.viehai.at. Jan 17 22:41:33 srv4hai dhcpd[8095]: Added reverse map from 123.12.168.192.in-addr.arpa. to shelly-23.viehai.at Jan 17 22:41:33 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-23' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf' Jan 17 22:41:35 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-23' - shIP/2:'192.168.12.123' Jan 17 22:41:35 srv4hai conf_shelly.sh: SHELLY: usage/name 'Licht Sekretär' already set for '192.168.12.123' Jan 17 22:41:35 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(0)' - allready transmitted - skipping Jan 17 22:41:35 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(1)' - allready transmitted - skipping Jan 17 22:41:35 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(2)' - allready transmitted - skipping Jan 17 22:41:35 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(3)' - allready transmitted - skipping Jan 17 22:41:35 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(4)' - allready transmitted - skipping Jan 17 22:41:35 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(5)' - allready transmitted - skipping Jan 17 22:41:35 srv4hai conf_shelly.sh: SHELLY:'shelly-23' out:0 ON : MISSING Jan 17 22:41:35 srv4hai conf_shelly.sh: SHELLY:'shelly-23' out:0 OFF: MISSING Jan 17 22:41:35 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705527695 - 'ping_SP_1' Jan 17 22:41:53 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705527713 - 'ping_SP_0' Jan 17 22:41:57 srv4hai activate_scenario.sh: SHELLY scenario: 'bedlight_tom(bedlight_tom)' TO BE EXECUTED, phone='' Jan 17 22:41:57 srv4hai postfix/pickup[32535]: 34B8760244: uid=33 from= Jan 17 22:41:57 srv4hai postfix/cleanup[6103]: 34B8760244: message-id=<20240117214157.34B8760244@mail.viehai.at> Jan 17 22:41:57 srv4hai postfix/qmgr[28610]: 34B8760244: from= , size=15261, nrcpt=1 (queue active) Jan 17 22:41:57 srv4hai activate_scenario.sh: SHELLY: 'shelly-07'-'Nachtkästchen Lampe Thomas' --> '0?turn=toggle' Jan 17 22:41:57 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/17/_0.log' - shellyUsage:'Nachtkästchen Lampe Thomas' - scUrl:'http://192.168.12.107/relay/0?turn=toggle' - phName:'noHandy' Jan 17 22:41:57 srv4hai postfix/local[6117]: 34B8760244: to= , orig_to= , relay=local, delay=0.04, delays=0.03/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null") Jan 17 22:41:57 srv4hai postfix/cleanup[6103]: 3B7F860245: message-id=<20240117214157.3B7F860245@mail.viehai.at> Jan 17 22:41:57 srv4hai postfix/bounce[6125]: 34B8760244: sender non-delivery notification: 3B7F860245 Jan 17 22:41:57 srv4hai postfix/qmgr[28610]: 3B7F860245: from=<>, size=17140, nrcpt=1 (queue active) Jan 17 22:41:57 srv4hai postfix/qmgr[28610]: 34B8760244: removed Jan 17 22:41:57 srv4hai postfix/local[6117]: 3B7F860245: 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 17 22:41:57 srv4hai postfix/qmgr[28610]: 3B7F860245: removed Jan 17 22:41:57 srv4hai activate_scenario.sh: SHELLY scenario: 'bedlight_tom(bedlight_tom)' took 69 msec, phone='' Jan 17 22:41:57 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.107/status' Jan 17 22:41:57 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.107","rssi":-78},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"22:41","unixtime":1705527718,"serial":1,"has_update":false,"mac":"8CAAB561A920","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":true,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"source":"http"}],"meters":[{"power":0.00,"is_valid":true}],"inputs":[{"input":0,"event":"","event_cnt":87}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"update":{"status":"idle","has_update":false,"new_version":"20230913-112003/v1.14.0-gcb84623","old_version":"20230913-112003/v1.14.0-gcb84623","beta_version":"20231107-162940/v1.14.1-rc1-g0617c15"},"ram_total":51688,"ram_free":40004,"fs_size":233681,"fs_free":149596,"uptime":6595955}' Jan 17 22:42:01 srv4hai CRON[6152]: (root) CMD (/etc/linetest/linetest.sh)
finished