activate_scenario.sh
Mon Jul 29 17:55:41 CEST 2024
scenario: vorraumOn
phoneName: 1
vorher: 17:55:41.653
http://192.168.12.103/relay/0?turn=on |
|---|
"ison": true, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "overpower": false, "source": "http" |
nachher: 17:55:41.784
Dauer: 131 msec
phName: 'phoneName:'1''
urls : 1
vorher : 17:55:41.617
nachher: 17:55:41.791
Dauer : 176 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/07/29//scene_vorraumOn_20240729_175541.txt'
Jul 29 17:52:01 srv4hai CRON[2783]: (root) CMD (/etc/linetest/linetest.sh) Jul 29 17:52:02 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1722268322 - 'ping_SP_0' Jul 29 17:52:02 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Jul 29 17:53:01 srv4hai CRON[2819]: (root) CMD (/etc/linetest/linetest.sh) Jul 29 17:53:15 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1722268395 - 'ping_SP_0' Jul 29 17:53:15 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Jul 29 17:53:47 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=2856, secured, session= Jul 29 17:53:47 srv4hai dovecot: imap(miglincit)<2856> : Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jul 29 17:54:01 srv4hai CRON[2861]: (root) CMD (/etc/linetest/linetest.sh) Jul 29 17:54:08 srv4hai common[2867]: SHELLY common.sh inkludiert von ./inventar.sh Jul 29 17:54:10 srv4hai common[2883]: SHELLY common.sh inkludiert von ./inventar.sh Jul 29 17:54:27 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24 Jul 29 17:54:27 srv4hai dhcpd[30731]: DHCPDISCOVER from ec:da:3b:c6:1d:3c via enp2s0 Jul 29 17:54:27 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0 Jul 29 17:54:27 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24 Jul 29 17:54:27 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Jul 29 17:54:27 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.150 Jul 29 17:54:27 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-50 Jul 29 17:54:27 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.150 (192.168.12.252) from ec:da:3b:c6:1d:3c via enp2s0 Jul 29 17:54:27 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0 Jul 29 17:54:27 srv4hai named[30406]: client @0x7f9310079c50 192.168.12.252#57955/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-50.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#46573/key rndc-key: signer "rndc-key" approved Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#46573/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' TXT Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#46573/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' TXT "31ddfcf6e79cbbdf4e55e03247020075f9" Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#46573/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' A Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#46573/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' A 192.168.12.150 Jul 29 17:54:27 srv4hai dhcpd[30731]: Added new forward map from shelly-50.viehai.at to 192.168.12.150 Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933805ba90 192.168.12.252#41575/key rndc-key: signer "rndc-key" approved Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933805ba90 192.168.12.252#41575/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '150.12.168.192.in-addr.arpa' PTR Jul 29 17:54:27 srv4hai named[30406]: client @0x7f933805ba90 192.168.12.252#41575/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '150.12.168.192.in-addr.arpa' PTR shelly-50.viehai.at. Jul 29 17:54:27 srv4hai dhcpd[30731]: Added reverse map from 150.12.168.192.in-addr.arpa. to shelly-50.viehai.at Jul 29 17:54:27 srv4hai common[2907]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh Jul 29 17:54:27 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-50' - shIP/2:'' perform:'conf' Jul 29 17:54:27 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-50' - shIP/2:'192.168.12.150' Jul 29 17:54:27 srv4hai mosquitto[18551]: New connection from 192.168.12.150 on port 1883. Jul 29 17:54:27 srv4hai mosquitto[18551]: Client shellypmminig3-ecda3bc61d3c already connected, closing old connection. Jul 29 17:54:27 srv4hai mosquitto[18551]: Socket error on client shellypmminig3-ecda3bc61d3c, disconnecting. Jul 29 17:54:27 srv4hai mosquitto[18551]: New client connected from 192.168.12.150 as shellypmminig3-ecda3bc61d3c (c1, k60, u'shmqtt'). Jul 29 17:54:28 srv4hai conf_shelly.sh: SHELLY: usage/name '50-TBD' already set for '192.168.12.150' Jul 29 17:54:28 srv4hai conf_shelly.sh: SHELLY:'shelly-50' no WebHook Jul 29 17:54:28 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1722268468 - 'ping_SP_0' Jul 29 17:54:28 srv4hai ping_SP[29545]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Jul 29 17:54:55 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24 Jul 29 17:54:55 srv4hai dhcpd[30731]: DHCPDISCOVER from ec:da:3b:c6:1d:3c via enp2s0 Jul 29 17:54:55 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0 Jul 29 17:54:56 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24 Jul 29 17:54:56 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Jul 29 17:54:56 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.150 Jul 29 17:54:56 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-50 Jul 29 17:54:56 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.150 (192.168.12.252) from ec:da:3b:c6:1d:3c via enp2s0 Jul 29 17:54:56 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0 Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c0733f0 192.168.12.252#55681/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-50.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#60927/key rndc-key: signer "rndc-key" approved Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#60927/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' TXT Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#60927/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' TXT "31ddfcf6e79cbbdf4e55e03247020075f9" Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#60927/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' A Jul 29 17:54:56 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#60927/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' A 192.168.12.150 Jul 29 17:54:56 srv4hai dhcpd[30731]: Added new forward map from shelly-50.viehai.at to 192.168.12.150 Jul 29 17:54:56 srv4hai named[30406]: client @0x7f93300fcc20 192.168.12.252#45929/key rndc-key: signer "rndc-key" approved Jul 29 17:54:56 srv4hai named[30406]: client @0x7f93300fcc20 192.168.12.252#45929/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '150.12.168.192.in-addr.arpa' PTR Jul 29 17:54:56 srv4hai named[30406]: client @0x7f93300fcc20 192.168.12.252#45929/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '150.12.168.192.in-addr.arpa' PTR shelly-50.viehai.at. Jul 29 17:54:56 srv4hai dhcpd[30731]: Added reverse map from 150.12.168.192.in-addr.arpa. to shelly-50.viehai.at Jul 29 17:54:56 srv4hai common[2979]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh Jul 29 17:54:56 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-50' - shIP/2:'' perform:'conf' Jul 29 17:54:56 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-50' - shIP/2:'192.168.12.150' Jul 29 17:54:56 srv4hai mosquitto[18551]: New connection from 192.168.12.150 on port 1883. Jul 29 17:54:56 srv4hai mosquitto[18551]: Client shellypmminig3-ecda3bc61d3c already connected, closing old connection. Jul 29 17:54:56 srv4hai mosquitto[18551]: Socket error on client shellypmminig3-ecda3bc61d3c, disconnecting. Jul 29 17:54:56 srv4hai mosquitto[18551]: New client connected from 192.168.12.150 as shellypmminig3-ecda3bc61d3c (c1, k60, u'shmqtt'). Jul 29 17:54:56 srv4hai conf_shelly.sh: SHELLY: usage/name '50-TBD' already set for '192.168.12.150' Jul 29 17:54:56 srv4hai conf_shelly.sh: SHELLY:'shelly-50' no WebHook Jul 29 17:54:57 srv4hai dovecot: imap-login: Login: user= , method=PLAIN, rip=::1, lip=::1, mpid=3018, secured, session= Jul 29 17:54:57 srv4hai dovecot: imap(miglincit)<3018> : Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jul 29 17:55:01 srv4hai CRON[3032]: (root) CMD (/etc/linetest/linetest.sh) Jul 29 17:55:30 srv4hai common[3041]: SHELLY common.sh inkludiert von ./bt_scan.sh Jul 29 17:55:40 srv4hai bt_scan[3041]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes' Jul 29 17:55:40 srv4hai bt_scan[3041]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62' Jul 29 17:55:40 srv4hai common[3082]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh Jul 29 17:55:40 srv4hai ping_SP[3082]: SHELLY ping_SP.sh started from bt_scan, user:'www-data' Jul 29 17:55:40 srv4hai common[3103]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh Jul 29 17:55:41 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'11'=1722268541-1722268530 Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (ping_SP__bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming' Jul 29 17:55:41 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'11'=1722268541-1722268530 Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes Jul 29 17:55:41 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'11'=1722268541-1722268530 Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(__/LIVE) (BT/__) (__/__)' - anyPresent: 'true' - otherPresent:'true' Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_pcON) - sceneONsmall(vorraumOn) Jul 29 17:55:41 srv4hai check_presence[3103]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn Jul 29 17:55:41 srv4hai activate_scenario[3249]: SHELLY scenario: 'vorraumOn(vorraumon)' started Jul 29 17:55:41 srv4hai activate_scenario[3249]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1'
finished