activate_scenario.sh
Wed Jan 17 22:41:57 CET 2024
scenario: bedlight_tom

'night' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'null'

scenario: 'Nachttischlampe Thomas UM-schalten' - 'bedlight_tom' - 'bedlight_tom'

Nachtkästchen Lampe Thomas (/srv/www/viehai/shelly/log_scenarios/2024/01/17/_0.log)

vorher: 22:41:57.235

http://192.168.12.107/relay/0?turn=toggle
  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "source": "http"

nachher: 22:41:57.279
Dauer: 43 msec


scenario: 'Nachttischlampe Thomas UM-schalten' - 'bedlight_tom' - 'bedlight_tom'

urls : 1
vorher : 22:41:57.216
nachher: 22:41:57.285
Dauer : 69 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/17//scene_bedlight_tom_20240117_224157.txt'


syslog

Jan 17 22:38:01 srv4hai named[14530]: resolver priming query complete
Jan 17 22:38:01 srv4hai CRON[5098]: (root) CMD (/etc/linetest/linetest.sh)
Jan 17 22:38:03 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1705527483 - 'ping_SP_1'
Jan 17 22:38:04 srv4hai bt_scan.sh: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' found: 'Yes'
Jan 17 22:38:04 srv4hai bt_scan.sh: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Jan 17 22:38:04 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan 17 22:38:04 srv4hai check_presence.sh: SHELLY (0) found './meter/ping_SP_0' more than one (1) line for what: 'coming'
Jan 17 22:38:04 srv4hai check_presence.sh: SHELLY (0) set what to 'presence'
Jan 17 22:38:04 srv4hai check_presence.sh: SHELLY (0) found './meter/ping_SP_1' more than one (1) line for what: 'presence'
Jan 17 22:38:04 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'scanBT/ping, scanBT/ping, false/no IP,' - anyPresent: 'true'
Jan 17 22:38:04 srv4hai ping_SP.sh: SHELLY - running process-id(5137): '5137 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61#01227034 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61' - 'ping_SP_0' - exiting ==============
Jan 17 22:38:04 srv4hai check_presence.sh: SHELLY (0)-presence: NOT activate_scenario.shtml: offAll
Jan 17 22:38:09 srv4hai named[14530]: resolver priming query complete
Jan 17 22:38:14 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=5165, secured, session=
Jan 17 22:38:14 srv4hai dovecot: imap(rozumm)<5165>: 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:38:17 srv4hai named[14530]: resolver priming query complete
Jan 17 22:38:17 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan 17 22:38:17 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan 17 22:38:22 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1705527502 - 'ping_SP_0'
Jan 17 22:38:33 srv4hai named[14530]: resolver priming query complete
Jan 17 22:38:33 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1705527513 - 'ping_SP_1'
Jan 17 22:38:43 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan 17 22:38:43 srv4hai named[14530]: resolver priming query complete
Jan 17 22:38:43 srv4hai fetchmail[1651]: 35836 messages (35836 seen) for tmiglinci at mail.akis.at (-1304885212 octets).
Jan 17 22:38:44 srv4hai fetchmail[1651]: 9773 messages (9773 seen) for srozum at mail.akis.at (1180858285 octets).
Jan 17 22:38:44 srv4hai fetchmail[1651]: 21128 messages (21128 seen) for mrozum at mail.akis.at (-722174462 octets).
Jan 17 22:38:44 srv4hai fetchmail[1651]: 45 messages (45 seen) for admin@bastelstube.wien at pop3.world4you.com (12035480 octets).
Jan 17 22:38:52 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1705527532 - 'ping_SP_0'
Jan 17 22:38:54 srv4hai named[14530]: resolver priming query complete
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'

finished