activate_scenario.sh
Fri Apr 5 11:49:03 CEST 2024
scenario: sekr_UM
source: 192.168.12.101

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

scenario: 'Sekretär Licht UM-schalten' - 'sekr_UM' - 'sekr_um'

Licht Sekretär (/srv/www/viehai/shelly/log_scenarios/2024/04/05/_0.log)

vorher: 11:49:03.755

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

nachher: 11:49:03.797
Dauer: 42 msec phName: 'shelly-01:'Wandlicht beim Esstisch''


scenario: 'Sekretär Licht UM-schalten' - 'sekr_UM' - 'sekr_um'

urls : 1
vorher : 11:49:03.732
nachher: 11:49:03.803
Dauer : 71 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/04/05//scene_sekr_UM_20240405_114903.txt'


syslog

Apr  5 11:46:01 srv4hai CRON[24894]: (root) CMD (/etc/linetest/linetest.sh)
Apr  5 11:46:14 srv4hai named[15509]: resolver priming query complete
Apr  5 11:46:37 srv4hai auditd[579]: Audit daemon rotating log files
Apr  5 11:46:52 srv4hai postfix/anvil[24725]: statistics: max connection rate 2/60s for (smtp:154.9.2.12) at Apr  5 11:43:30
Apr  5 11:46:52 srv4hai postfix/anvil[24725]: statistics: max connection count 1 for (smtp:87.120.84.171) at Apr  5 11:42:44
Apr  5 11:46:52 srv4hai postfix/anvil[24725]: statistics: max cache size 2 at Apr  5 11:42:51
Apr  5 11:46:59 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Apr  5 11:47:00 srv4hai fetchmail[1651]: 41419 messages (41419 seen) for tmiglinci at mail.akis.at (-851642432 octets).
Apr  5 11:47:00 srv4hai fetchmail[1651]: 10090 messages (10090 seen) for srozum at mail.akis.at (1218215535 octets).
Apr  5 11:47:01 srv4hai fetchmail[1651]: 22677 messages (22677 seen) for mrozum at mail.akis.at (-375448651 octets).
Apr  5 11:47:01 srv4hai CRON[24947]: (root) CMD (/etc/linetest/linetest.sh)
Apr  5 11:47:01 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Apr  5 11:47:16 srv4hai common[24961]: SHELLY common.sh inkludiert von ./bt_scan.sh
Apr  5 11:47:16 srv4hai bt_scan[24961]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / fixAddr: '192.168.12.61;' - found: 'Yes'
Apr  5 11:47:16 srv4hai bt_scan[24961]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Apr  5 11:47:16 srv4hai common[24991]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Apr  5 11:47:16 srv4hai ping_SP[24991]: SHELLY ping_SP.sh started from bt_scan
Apr  5 11:47:16 srv4hai common[25002]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Apr  5 11:47:17 srv4hai named[15509]: resolver priming query complete
Apr  5 11:47:18 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'0'=1712310438-1712310438
Apr  5 11:47:18 srv4hai check_presence[25002]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Apr  5 11:47:18 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'0'=1712310438-1712310438
Apr  5 11:47:18 srv4hai check_presence[25002]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Apr  5 11:47:18 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_not_set' dweetAge:'0'=1712310438-1712310438
Apr  5 11:47:18 srv4hai check_presence[25002]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Apr  5 11:47:18 srv4hai check_presence[25002]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(__/__) (__/__) (__/__)' - anyPresent: 'false' - otherPresent:'false'
Apr  5 11:47:18 srv4hai check_presence[25002]: SHELLY (ping_SP__bt_scan)-(0)-coming: NOT activate_scenario.shtml: welcomeLight
Apr  5 11:47:18 srv4hai ping_SP[24991]: SHELLY check_presence.sh coming 0 ping_SP__bt_scan
Apr  5 11:47:18 srv4hai postfix/pickup[2455]: 7C8BA60245: uid=33 from=
Apr  5 11:47:18 srv4hai postfix/cleanup[25098]: 7C8BA60245: message-id=<20240405094718.7C8BA60245@mail.viehai.at>
Apr  5 11:47:18 srv4hai postfix/qmgr[15291]: 7C8BA60245: from=, size=5096, nrcpt=1 (queue active)
Apr  5 11:47:18 srv4hai ping_SP[24991]: SHELLY - new process for '192.168.12.61' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1712310438
Apr  5 11:47:19 srv4hai postfix/relay/smtp[25107]: 7C8BA60245: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=1.2, delays=0.02/0.01/0.95/0.25, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 88C748001A)
Apr  5 11:47:19 srv4hai postfix/qmgr[15291]: 7C8BA60245: removed
Apr  5 11:47:20 srv4hai dhcpd[13813]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Apr  5 11:47:20 srv4hai dhcpd[13813]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr  5 11:47:20 srv4hai dhcpd[13813]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Apr  5 11:47:20 srv4hai dhcpd[13813]: execute_statement argv[1] = 192.168.12.61
Apr  5 11:47:20 srv4hai dhcpd[13813]: execute_statement argv[2] = fpThomas
Apr  5 11:47:20 srv4hai common[25116]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Apr  5 11:47:31 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Apr  5 11:47:31 srv4hai dhcpd[13813]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Apr  5 11:47:31 srv4hai dhcpd[13813]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr  5 11:47:31 srv4hai dhcpd[13813]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Apr  5 11:47:31 srv4hai dhcpd[13813]: execute_statement argv[1] = 192.168.12.61
Apr  5 11:47:31 srv4hai dhcpd[13813]: execute_statement argv[2] = fpThomas
Apr  5 11:47:31 srv4hai common[25146]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Apr  5 11:47:34 srv4hai ping_SP[24991]: SHELLY (0)- ping 192.168.12.61 0 not answered (1) @~1712310454 - 'ping_SP_0'
Apr  5 11:47:41 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Apr  5 11:47:41 srv4hai dhcpd[13813]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Apr  5 11:47:41 srv4hai dhcpd[13813]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr  5 11:47:41 srv4hai dhcpd[13813]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Apr  5 11:47:41 srv4hai dhcpd[13813]: execute_statement argv[1] = 192.168.12.61
Apr  5 11:47:41 srv4hai dhcpd[13813]: execute_statement argv[2] = fpThomas
Apr  5 11:47:41 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr  5 11:47:41 srv4hai common[25185]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Apr  5 11:47:43 srv4hai postfix/smtpd[25200]: connect from unknown[45.88.90.157]
Apr  5 11:47:43 srv4hai postfix/smtpd[25200]: warning: unknown[45.88.90.157]: SASL LOGIN authentication failed: Invalid authentication mechanism
Apr  5 11:47:43 srv4hai postfix/smtpd[25200]: disconnect from unknown[45.88.90.157] ehlo=1 auth=0/1 quit=1 commands=2/3
Apr  5 11:47:51 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Apr  5 11:47:51 srv4hai dhcpd[13813]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Apr  5 11:47:51 srv4hai dhcpd[13813]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr  5 11:47:51 srv4hai dhcpd[13813]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Apr  5 11:47:51 srv4hai dhcpd[13813]: execute_statement argv[1] = 192.168.12.61
Apr  5 11:47:51 srv4hai dhcpd[13813]: execute_statement argv[2] = fpThomas
Apr  5 11:47:51 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr  5 11:47:51 srv4hai named[15509]: client @0x7f9314001390 192.168.12.252#35873/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr  5 11:47:51 srv4hai common[25216]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Apr  5 11:47:55 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=25233, secured, session=
Apr  5 11:47:55 srv4hai dovecot: imap(miglincit)<25233>: Logged out in=492 out=1380 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr  5 11:47:57 srv4hai ping_SP[24991]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1712310477 - 'ping_SP_0'
Apr  5 11:47:57 srv4hai ping_SP[24991]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr  5 11:48:01 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Apr  5 11:48:01 srv4hai dhcpd[13813]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Apr  5 11:48:01 srv4hai dhcpd[13813]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: signer "rndc-key" approved
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Apr  5 11:48:01 srv4hai dhcpd[13813]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: signer "rndc-key" approved
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: signer "rndc-key" approved
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Apr  5 11:48:01 srv4hai dhcpd[13813]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: signer "rndc-key" approved
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Apr  5 11:48:01 srv4hai dhcpd[13813]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: signer "rndc-key" approved
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Apr  5 11:48:01 srv4hai dhcpd[13813]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: signer "rndc-key" approved
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Apr  5 11:48:01 srv4hai dhcpd[13813]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: signer "rndc-key" approved
Apr  5 11:48:01 srv4hai dhcpd[13813]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: signer "rndc-key" approved
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Apr  5 11:48:01 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#45211/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Apr  5 11:48:01 srv4hai dhcpd[13813]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Apr  5 11:48:01 srv4hai dhcpd[13813]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Apr  5 11:48:01 srv4hai CRON[25262]: (root) CMD (/etc/linetest/linetest.sh)
Apr  5 11:48:51 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=25306, secured, session=
Apr  5 11:48:51 srv4hai dovecot: imap(miglincit)<25306>: Logged out in=492 out=1380 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr  5 11:49:01 srv4hai CRON[25319]: (root) CMD (/etc/linetest/linetest.sh)
Apr  5 11:49:03 srv4hai activate_scenario[25327]: SHELLY scenario: 'sekr_UM(sekr_um)' started
Apr  5 11:49:03 srv4hai activate_scenario[25327]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-01:'Wandlicht beim Esstisch'

finished