activate_scenario.sh
Sun Mar 31 18:20:14 CEST 2024
scenario: vorraumOn
phoneName: 2

'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'thomas@miglinci.name'

scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

Licht Vorzimmer (/srv/www/viehai/shelly/log_scenarios/2024/03/31/_0.log)

vorher: 18:20:14.196

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: 18:20:14.290
Dauer: 93 msec phName: 'phoneName:'2''


scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

urls : 1
vorher : 18:20:14.178
nachher: 18:20:14.296
Dauer : 119 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/31//scene_vorraumOn_20240331_182014.txt'


syslog

Mar 31 18:17:01 srv4hai CRON[29125]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Mar 31 18:17:01 srv4hai CRON[29124]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 18:17:12 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711901832 - 'ping_SP_0'
Mar 31 18:17:12 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 31 18:17:20 srv4hai ping_SP[27304]: SHELLY (2)- ping 192.168.12.63 1 not answered (1) @~1711901840 - 'ping_SP_2'
Mar 31 18:17:48 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=29179, secured, session=
Mar 31 18:17:48 srv4hai dovecot: imap(miglincit)<29179>: Logged out in=198 out=1232 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 31 18:17:53 srv4hai ping_SP[27304]: SHELLY (2)- ping 192.168.12.63 2 not answered (1) @~1711901873 - 'ping_SP_2'
Mar 31 18:18:01 srv4hai CRON[29194]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 18:18:25 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711901905 - 'ping_SP_0'
Mar 31 18:18:25 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 31 18:18:26 srv4hai ping_SP[27304]: SHELLY (2)- ping 192.168.12.63 3 not answered (1) @~1711901906 - 'ping_SP_2'
Mar 31 18:18:58 srv4hai dhcpd[5037]: DHCPDISCOVER from e8:db:84:d2:3b:46 via enp2s0
Mar 31 18:18:58 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.106 to e8:db:84:d2:3b:46 via enp2s0
Mar 31 18:18:58 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Mar 31 18:18:58 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.106
Mar 31 18:18:58 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-06
Mar 31 18:18:58 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.106 (192.168.12.252) from e8:db:84:d2:3b:46 via enp2s0
Mar 31 18:18:58 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.106 to e8:db:84:d2:3b:46 via enp2s0
Mar 31 18:18:58 srv4hai named[15509]: client @0x7f931c65d6a0 192.168.12.252#54329/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-06.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 31 18:18:58 srv4hai named[15509]: client @0x7f931405fa30 192.168.12.252#58789/key rndc-key: signer "rndc-key" approved
Mar 31 18:18:58 srv4hai named[15509]: client @0x7f931405fa30 192.168.12.252#58789/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-06.viehai.at' TXT
Mar 31 18:18:58 srv4hai named[15509]: client @0x7f931405fa30 192.168.12.252#58789/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-06.viehai.at' TXT "00e5b4e36e36fc00550f574d5b1f0bfd3e"
Mar 31 18:18:58 srv4hai named[15509]: client @0x7f931405fa30 192.168.12.252#58789/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-06.viehai.at' A
Mar 31 18:18:58 srv4hai named[15509]: client @0x7f931405fa30 192.168.12.252#58789/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-06.viehai.at' A 192.168.12.106
Mar 31 18:18:58 srv4hai dhcpd[5037]: Added new forward map from shelly-06.viehai.at to 192.168.12.106
Mar 31 18:18:58 srv4hai named[15509]: client @0x7f931c697a10 192.168.12.252#53633/key rndc-key: signer "rndc-key" approved
Mar 31 18:18:58 srv4hai named[15509]: client @0x7f931c697a10 192.168.12.252#53633/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '106.12.168.192.in-addr.arpa' PTR
Mar 31 18:18:58 srv4hai named[15509]: client @0x7f931c697a10 192.168.12.252#53633/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '106.12.168.192.in-addr.arpa' PTR shelly-06.viehai.at.
Mar 31 18:18:58 srv4hai dhcpd[5037]: Added reverse map from 106.12.168.192.in-addr.arpa. to shelly-06.viehai.at
Mar 31 18:18:58 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-06' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Mar 31 18:18:58 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=29258, secured, session=
Mar 31 18:18:58 srv4hai dovecot: imap(miglincit)<29258>: Logged out in=198 out=1232 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 31 18:18:59 srv4hai ping_SP[27304]: SHELLY (2)- ping 192.168.12.63 4 not answered (1) @~1711901939 - 'ping_SP_2'
Mar 31 18:18:59 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-06' - shIP/2:'192.168.12.106'
Mar 31 18:18:59 srv4hai conf_shelly.sh: SHELLY: usage/name 'Fernsehlampe klein' already set for '192.168.12.106'
Mar 31 18:18:59 srv4hai conf_shelly.sh: SHELLY:'shelly-06' 'conf(0)' - allready transmitted - skipping
Mar 31 18:18:59 srv4hai conf_shelly.sh: SHELLY:'shelly-06' 'conf(1)' - allready transmitted - skipping
Mar 31 18:18:59 srv4hai conf_shelly.sh: SHELLY:'shelly-06' 'conf(2)' - allready transmitted - skipping
Mar 31 18:18:59 srv4hai conf_shelly.sh: SHELLY:'shelly-06' 'conf(3)' - allready transmitted - skipping
Mar 31 18:19:00 srv4hai conf_shelly.sh: SHELLY:'shelly-06' out:0 ON : MISSING
Mar 31 18:19:00 srv4hai conf_shelly.sh: SHELLY:'shelly-06' out:0 OFF: MISSING
Mar 31 18:19:01 srv4hai CRON[29378]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 18:19:32 srv4hai ping_SP[27304]: SHELLY (2)- ping 192.168.12.63 5 not answered (1) @~1711901972 - 'ping_SP_2'
Mar 31 18:19:32 srv4hai ping_SP[27304]: SHELLY (2)- ping 192.168.12.63 5 not answered - abort (27304) @~1711901972 - rm 'ping_SP_2'
Mar 31 18:19:32 srv4hai common[29409]: SHELLY common.sh inkludiert
Mar 31 18:19:32 srv4hai dhcpd[5037]: DHCPINFORM from 192.168.12.20 via enp2s0
Mar 31 18:19:32 srv4hai dhcpd[5037]: DHCPACK to 192.168.12.20 (08:92:04:5f:12:67) via enp2s0
Mar 31 18:19:33 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'5'=1711901973-1711901968
Mar 31 18:19:33 srv4hai check_presence[29409]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Mar 31 18:19:33 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'5'=1711901973-1711901968
Mar 31 18:19:33 srv4hai check_presence[29409]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Mar 31 18:19:33 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'5'=1711901973-1711901968
Mar 31 18:19:33 srv4hai check_presence[29409]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Mar 31 18:19:33 srv4hai check_presence[29409]: SHELLY (ping_SP__NO_ping)-(2) what: 'presence' - persPresent: '(__/IP) (BT/IP) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Mar 31 18:19:33 srv4hai check_presence[29409]: SHELLY (ping_SP__NO_ping)-(2)-presence: NOT activate_scenario.shtml: offAll
Mar 31 18:19:38 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711901978 - 'ping_SP_0'
Mar 31 18:19:38 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 31 18:19:47 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Mar 31 18:19:48 srv4hai fetchmail[1651]: 40996 messages (40996 seen) for tmiglinci at mail.akis.at (-878349268 octets).
Mar 31 18:19:49 srv4hai fetchmail[1651]: 10073 messages (10073 seen) for srozum at mail.akis.at (1216303919 octets).
Mar 31 18:19:49 srv4hai fetchmail[1651]: 22568 messages (22568 seen) for mrozum at mail.akis.at (-385574053 octets).
Mar 31 18:19:50 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Mar 31 18:20:01 srv4hai CRON[29542]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 18:20:01 srv4hai CRON[29543]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Mar 31 18:20:01 srv4hai common[29544]: SHELLY common.sh inkludiert
Mar 31 18:20:01 srv4hai meter.sh: SHELLY meter.sh started
Mar 31 18:20:02 srv4hai meter.sh: SHELLY 'shelly-29/Schalter Herdzeile' - type: 'shelly-i3' ignoring
Mar 31 18:20:02 srv4hai meter.sh: SHELLY 'shelly-28/Schalter Nasszeile' - type: 'shelly-i3' ignoring
Mar 31 18:20:03 srv4hai common[29769]: SHELLY common.sh inkludiert
Mar 31 18:20:03 srv4hai common[29777]: SHELLY common.sh inkludiert
Mar 31 18:20:05 srv4hai meter.sh: SHELLY 'shelly-23/Licht Sekretär':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 31 18:20:07 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster' - type: 'shelly-BTN' ignoring
Mar 31 18:20:08 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter' - type: 'shelly-BTN' ignoring
Mar 31 18:20:08 srv4hai meter.sh: SHELLY 'shelly-37/Klima Büro' - type: 'shelly-ht' ignoring
Mar 31 18:20:08 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen' - status: 'OOS' ignoring
Mar 31 18:20:08 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon' - type: 'shelly-ht-plus' ignoring
Mar 31 18:20:09 srv4hai dhcpd[5037]: DHCPDISCOVER from 30:83:98:8c:05:9d via enp2s0
Mar 31 18:20:09 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.123 to 30:83:98:8c:05:9d via enp2s0
Mar 31 18:20:09 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Mar 31 18:20:09 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.123
Mar 31 18:20:09 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-23
Mar 31 18:20:09 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.123 (192.168.12.252) from 30:83:98:8c:05:9d via enp2s0
Mar 31 18:20:09 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.123 to 30:83:98:8c:05:9d via enp2s0
Mar 31 18:20:09 srv4hai named[15509]: client @0x7f92fc0061b0 192.168.12.252#50633/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-23.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 31 18:20:09 srv4hai named[15509]: client @0x7f931c166000 192.168.12.252#49431/key rndc-key: signer "rndc-key" approved
Mar 31 18:20:09 srv4hai named[15509]: client @0x7f931c166000 192.168.12.252#49431/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-23.viehai.at' TXT
Mar 31 18:20:09 srv4hai named[15509]: client @0x7f931c166000 192.168.12.252#49431/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-23.viehai.at' TXT "0067c4eae5f3400bd02ff9ebe320262416"
Mar 31 18:20:09 srv4hai named[15509]: client @0x7f931c166000 192.168.12.252#49431/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-23.viehai.at' A
Mar 31 18:20:09 srv4hai named[15509]: client @0x7f931c166000 192.168.12.252#49431/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-23.viehai.at' A 192.168.12.123
Mar 31 18:20:09 srv4hai dhcpd[5037]: Added new forward map from shelly-23.viehai.at to 192.168.12.123
Mar 31 18:20:09 srv4hai named[15509]: client @0x7f931c67a760 192.168.12.252#47807/key rndc-key: signer "rndc-key" approved
Mar 31 18:20:09 srv4hai named[15509]: client @0x7f931c67a760 192.168.12.252#47807/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '123.12.168.192.in-addr.arpa' PTR
Mar 31 18:20:09 srv4hai named[15509]: client @0x7f931c67a760 192.168.12.252#47807/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.
Mar 31 18:20:09 srv4hai dhcpd[5037]: Added reverse map from 123.12.168.192.in-addr.arpa. to shelly-23.viehai.at
Mar 31 18:20:09 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-23' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Mar 31 18:20:11 srv4hai meter.sh: SHELLY 'shelly-58/Werkstatt Licht':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 31 18:20:11 srv4hai meter.sh: SHELLY 'shelly-59/Werkstatt Schalter Kellertür' - type: 'shelly-i3' ignoring
Mar 31 18:20:11 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-23' - shIP/2:'192.168.12.123'
Mar 31 18:20:11 srv4hai conf_shelly.sh: SHELLY: usage/name 'Licht Sekretär' already set for '192.168.12.123'
Mar 31 18:20:11 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(0)' - allready transmitted - skipping
Mar 31 18:20:11 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(1)' - allready transmitted - skipping
Mar 31 18:20:11 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(2)' - allready transmitted - skipping
Mar 31 18:20:11 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(3)' - allready transmitted - skipping
Mar 31 18:20:11 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(4)' - allready transmitted - skipping
Mar 31 18:20:11 srv4hai conf_shelly.sh: SHELLY:'shelly-23' 'conf(5)' - allready transmitted - skipping
Mar 31 18:20:11 srv4hai conf_shelly.sh: SHELLY:'shelly-23' out:0 ON : MISSING
Mar 31 18:20:11 srv4hai conf_shelly.sh: SHELLY:'shelly-23' out:0 OFF: MISSING
Mar 31 18:20:13 srv4hai bt_scan[29769]: SHELLY - who: 'Sophie' / phoneName: 'iP_Sophie' / '2' / fixAddr: '192.168.12.63;' - found: 'Yes'
Mar 31 18:20:13 srv4hai bt_scan[29777]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / fixAddr: '192.168.12.61;' - found: 'No'
Mar 31 18:20:13 srv4hai bt_scan[29769]: SHELLY - ping_SP.sh started for BTmac: '2' - IPv4: '192.168.12.63'
Mar 31 18:20:13 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 31 18:20:13 srv4hai common[30414]: SHELLY common.sh inkludiert
Mar 31 18:20:13 srv4hai bt_scan[29777]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Mar 31 18:20:13 srv4hai common[30427]: SHELLY common.sh inkludiert
Mar 31 18:20:13 srv4hai ping_SP[30414]: SHELLY ping_SP.sh started from bt_scan
Mar 31 18:20:13 srv4hai common[30433]: SHELLY common.sh inkludiert
Mar 31 18:20:13 srv4hai common[30463]: SHELLY common.sh inkludiert
Mar 31 18:20:14 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
Mar 31 18:20:14 srv4hai check_presence[30433]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and NO_BTdweet//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Mar 31 18:20:14 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'1'=1711902014-1711902013
Mar 31 18:20:14 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
Mar 31 18:20:14 srv4hai check_presence[30427]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Mar 31 18:20:14 srv4hai check_presence[30433]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and NO_BTdweet//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Mar 31 18:20:14 srv4hai common.sh: SHELLY: BTstatus[2]:'NO_BTdweet' dweetAge:''=-
Mar 31 18:20:14 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'1'=1711902014-1711902013
Mar 31 18:20:14 srv4hai check_presence[30433]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and NO_BTdweet//srv/www/viehai/shelly//meter/BTscan_BTid_2.Yes
Mar 31 18:20:14 srv4hai check_presence[30433]: SHELLY (ping_SP__bt_scan)-(2) what: 'coming' - persPresent: '(__/IP) (__/IP) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Mar 31 18:20:14 srv4hai check_presence[30427]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Mar 31 18:20:14 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_not_set' dweetAge:'1'=1711902014-1711902013
Mar 31 18:20:14 srv4hai check_presence[30433]: SHELLY (ping_SP__bt_scan)-(2)-coming: activate_scenario.shtml: vorraumOn
Mar 31 18:20:14 srv4hai check_presence[30427]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_2.Yes
Mar 31 18:20:14 srv4hai check_presence[30427]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/IP) (__/IP) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Mar 31 18:20:14 srv4hai check_presence[30427]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Mar 31 18:20:14 srv4hai activate_scenario[30591]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Mar 31 18:20:14 srv4hai activate_scenario[30591]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'2'

finished