activate_scenario.sh
Fri Apr 26 16:56:04 CEST 2024
scenario: vorraumOn
phoneName: 0

'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/04/26/_0.log)

vorher: 16:56:04.646

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": "input"

nachher: 16:56:04.749
Dauer: 103 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 16:56:04.598
nachher: 16:56:04.755
Dauer : 159 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/04/26//scene_vorraumOn_20240426_165604.txt'


syslog

Apr 26 16:53:01 srv4hai CRON[32136]: (root) CMD (/etc/linetest/linetest.sh)
Apr 26 16:53:14 srv4hai ping_SP[25002]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1714143194 - 'ping_SP_1'
Apr 26 16:53:14 srv4hai ping_SP[25002]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 26 16:53:16 srv4hai named[15509]: resolver priming query complete
Apr 26 16:53:28 srv4hai mosquitto[18551]: Saving in-memory database to /var/lib/mosquitto/mosquitto.db.
Apr 26 16:53:40 srv4hai named[15509]: resolver priming query complete
Apr 26 16:53:45 srv4hai named[15509]: resolver priming query complete
Apr 26 16:54:01 srv4hai CRON[32170]: (root) CMD (/etc/linetest/linetest.sh)
Apr 26 16:54:05 srv4hai postfix/smtpd[32175]: connect from unknown[87.121.105.221]
Apr 26 16:54:05 srv4hai postfix/smtpd[32175]: warning: unknown[87.121.105.221]: SASL LOGIN authentication failed: Invalid authentication mechanism
Apr 26 16:54:05 srv4hai postfix/smtpd[32175]: disconnect from unknown[87.121.105.221] ehlo=1 auth=0/1 quit=1 commands=2/3
Apr 26 16:54:16 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=32185, secured, session=
Apr 26 16:54:16 srv4hai dovecot: imap(miglincit)<32185>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 26 16:54:17 srv4hai ping_SP[25002]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1714143257 - 'ping_SP_1'
Apr 26 16:54:17 srv4hai ping_SP[25002]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 26 16:54:18 srv4hai named[15509]: resolver priming query complete
Apr 26 16:54:18 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Apr 26 16:54:19 srv4hai fetchmail[1651]: 42957 messages (42956 seen) for tmiglinci at mail.akis.at (-712019972 octets).
Apr 26 16:54:19 srv4hai postfix/smtpd[32175]: connect from localhost[127.0.0.1]
Apr 26 16:54:19 srv4hai postfix/smtpd[32175]: 70A3E6319A: client=localhost[127.0.0.1]
Apr 26 16:54:19 srv4hai postfix/cleanup[32204]: 70A3E6319A: message-id=
Apr 26 16:54:19 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:42957 of 42957 (85304 octets) not flushed
Apr 26 16:54:19 srv4hai postfix/qmgr[15291]: 70A3E6319A: from=, size=85526, nrcpt=1 (queue active)
Apr 26 16:54:19 srv4hai postfix/smtpd[32175]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Apr 26 16:54:19 srv4hai postfix/local[32205]: 70A3E6319A: to=, relay=local, delay=0.12, delays=0.09/0.01/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Apr 26 16:54:19 srv4hai postfix/qmgr[15291]: 70A3E6319A: removed
Apr 26 16:54:19 srv4hai fetchmail[1651]: 10174 messages (10174 seen) for srozum at mail.akis.at (1227801485 octets).
Apr 26 16:54:20 srv4hai fetchmail[1651]: 23124 messages (23124 seen) for mrozum at mail.akis.at (-295299177 octets).
Apr 26 16:54:20 srv4hai named[15509]: resolver priming query complete
Apr 26 16:54:20 srv4hai fetchmail[1651]: 50 messages (50 seen) for admin@bastelstube.wien at pop3.world4you.com (12362835 octets).
Apr 26 16:54:21 srv4hai named[15509]: resolver priming query complete
Apr 26 16:54:26 srv4hai named[15509]: resolver priming query complete
Apr 26 16:54:38 srv4hai named[15509]: resolver priming query complete
Apr 26 16:55:01 srv4hai CRON[32213]: (root) CMD (/etc/linetest/linetest.sh)
Apr 26 16:55:08 srv4hai named[15509]: resolver priming query complete
Apr 26 16:55:19 srv4hai named[15509]: resolver priming query complete
Apr 26 16:55:21 srv4hai ping_SP[25002]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1714143321 - 'ping_SP_1'
Apr 26 16:55:21 srv4hai ping_SP[25002]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 26 16:55:22 srv4hai named[15509]: resolver priming query complete
Apr 26 16:55:28 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=32246, secured, session=
Apr 26 16:55:28 srv4hai dovecot: imap(miglincit)<32246>: Logged out in=721 out=40022 deleted=0 expunged=0 trashed=0 hdr_count=50 hdr_bytes=15764 body_count=0 body_bytes=0
Apr 26 16:55:49 srv4hai named[15509]: resolver priming query complete
Apr 26 16:55:52 srv4hai named[15509]: resolver priming query complete
Apr 26 16:55:53 srv4hai dhcpd[22856]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Apr 26 16:55:53 srv4hai dhcpd[22856]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr 26 16:55:53 srv4hai dhcpd[22856]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Apr 26 16:55:53 srv4hai dhcpd[22856]: execute_statement argv[1] = 192.168.12.61
Apr 26 16:55:53 srv4hai dhcpd[22856]: execute_statement argv[2] = fpThomas
Apr 26 16:55:53 srv4hai common[32253]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Apr 26 16:55:53 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Apr 26 16:55:53 srv4hai common[32267]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Apr 26 16:55:53 srv4hai dhcpd[22856]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Apr 26 16:55:53 srv4hai dhcpd[22856]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr 26 16:55:53 srv4hai named[15509]: client @0x7f930c069dc0 192.168.12.252#57143/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 26 16:55:53 srv4hai named[15509]: client @0x7f93100017f0 192.168.12.252#34231/key rndc-key: signer "rndc-key" approved
Apr 26 16:55:53 srv4hai named[15509]: client @0x7f93100017f0 192.168.12.252#34231/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Apr 26 16:55:53 srv4hai named[15509]: client @0x7f93100017f0 192.168.12.252#34231/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Apr 26 16:55:53 srv4hai named[15509]: client @0x7f93100017f0 192.168.12.252#34231/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Apr 26 16:55:53 srv4hai named[15509]: client @0x7f93100017f0 192.168.12.252#34231/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Apr 26 16:55:53 srv4hai dhcpd[22856]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Apr 26 16:55:53 srv4hai named[15509]: client @0x7f931007d0f0 192.168.12.252#46339/key rndc-key: signer "rndc-key" approved
Apr 26 16:55:53 srv4hai named[15509]: client @0x7f931007d0f0 192.168.12.252#46339/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Apr 26 16:55:53 srv4hai named[15509]: client @0x7f931007d0f0 192.168.12.252#46339/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 26 16:55:53 srv4hai dhcpd[22856]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Apr 26 16:55:53 srv4hai ping_SP[32267]: SHELLY ping_SP.sh started from smartphone, user:'root'
Apr 26 16:55:54 srv4hai named[15509]: resolver priming query complete
Apr 26 16:55:55 srv4hai named[15509]: resolver priming query complete
Apr 26 16:55:59 srv4hai named[15509]: resolver priming query complete
Apr 26 16:56:01 srv4hai CRON[32289]: (root) CMD (/etc/linetest/linetest.sh)
Apr 26 16:56:02 srv4hai named[15509]: resolver priming query complete
Apr 26 16:56:02 srv4hai common[32294]: SHELLY common.sh inkludiert von ./bt_scan.sh
Apr 26 16:56:03 srv4hai common[32317]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Apr 26 16:56:04 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'2'=1714143364-1714143362
Apr 26 16:56:04 srv4hai check_presence[32317]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Apr 26 16:56:04 srv4hai check_presence[32317]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Apr 26 16:56:04 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'2'=1714143364-1714143362
Apr 26 16:56:04 srv4hai check_presence[32317]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Apr 26 16:56:04 srv4hai check_presence[32317]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Apr 26 16:56:04 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'2'=1714143364-1714143362
Apr 26 16:56:04 srv4hai check_presence[32317]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Apr 26 16:56:04 srv4hai check_presence[32317]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(BT/LIVE) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Apr 26 16:56:04 srv4hai check_presence[32317]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Apr 26 16:56:04 srv4hai activate_scenario[32442]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Apr 26 16:56:04 srv4hai activate_scenario[32442]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished