activate_scenario.sh
Thu Jun 20 17:34:51 CEST 2024
scenario: vorraumOn
phoneName: 1

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

Licht Vorzimmer (/srv/www/viehai/shelly/log_scenarios/2024/06/20/_0.log)

vorher: 17:34:51.533

  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "overpower": false,
  "source": "input"

nachher: 17:34:51.586
Dauer: 53 msec phName: 'phoneName:'1''

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

urls : 1
vorher : 17:34:51.515
nachher: 17:34:51.592
Dauer : 77 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/06/20//scene_vorraumOn_20240620_173451.txt'

syslog

Jun 20 17:31:01 srv4hai CRON[31302]: (root) CMD (/etc/linetest/linetest.sh)
Jun 20 17:31:10 srv4hai common[31312]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jun 20 17:31:15 srv4hai fetchmail[1651]: 46882 messages (46882 seen) for tmiglinci at mail.akis.at (-419902184 octets).
Jun 20 17:31:19 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=31331, secured, session=
Jun 20 17:31:19 srv4hai dovecot: imap(miglincit)<31331>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jun 20 17:31:20 srv4hai bt_scan[31312]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Jun 20 17:31:20 srv4hai bt_scan[31312]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Jun 20 17:31:20 srv4hai common[31350]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jun 20 17:31:20 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1718897480-1718897470
Jun 20 17:31:20 srv4hai check_presence[31350]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jun 20 17:31:20 srv4hai check_presence[31350]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Jun 20 17:31:20 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'10'=1718897480-1718897470
Jun 20 17:31:20 srv4hai check_presence[31350]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jun 20 17:31:20 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1718897480-1718897470
Jun 20 17:31:20 srv4hai check_presence[31350]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jun 20 17:31:20 srv4hai check_presence[31350]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Jun 20 17:31:20 srv4hai check_presence[31350]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_vorraumOn) - sceneOFF(offAll)
Jun 20 17:31:20 srv4hai check_presence[31350]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Jun 20 17:31:21 srv4hai ping_SP[22444]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1718897481 - 'ping_SP_0'
Jun 20 17:31:21 srv4hai ping_SP[22444]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jun 20 17:31:24 srv4hai fetchmail[1651]: 10345 messages (10345 seen) for srozum at mail.akis.at (1245611923 octets).
Jun 20 17:31:45 srv4hai fetchmail[1651]: 24233 messages (24233 seen) for mrozum at mail.akis.at (-81493226 octets).
Jun 20 17:31:45 srv4hai fetchmail[1651]: 1135 messages (1135 seen) for admin@bastelstube.wien at pop3.world4you.com (51504712 octets).
Jun 20 17:32:01 srv4hai CRON[31519]: (root) CMD (/etc/linetest/linetest.sh)
Jun 20 17:32:17 srv4hai common[31526]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jun 20 17:32:27 srv4hai bt_scan[31526]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Jun 20 17:32:27 srv4hai bt_scan[31526]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Jun 20 17:32:34 srv4hai ping_SP[22444]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1718897554 - 'ping_SP_0'
Jun 20 17:32:34 srv4hai ping_SP[22444]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jun 20 17:32:35 srv4hai postfix/smtpd[31580]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jun 20 17:32:35 srv4hai postfix/smtpd[31580]: warning: hostname mail.whatami.co does not resolve to address 193.32.162.27
Jun 20 17:32:35 srv4hai postfix/smtpd[31580]: connect from unknown[193.32.162.27]
Jun 20 17:32:35 srv4hai postfix/smtpd[31580]: warning: unknown[193.32.162.27]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jun 20 17:32:35 srv4hai postfix/smtpd[31580]: lost connection after AUTH from unknown[193.32.162.27]
Jun 20 17:32:35 srv4hai postfix/smtpd[31580]: disconnect from unknown[193.32.162.27] ehlo=1 auth=0/1 commands=1/2
Jun 20 17:33:01 srv4hai CRON[31587]: (root) CMD (/etc/linetest/linetest.sh)
Jun 20 17:33:47 srv4hai ping_SP[22444]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1718897627 - 'ping_SP_0'
Jun 20 17:33:47 srv4hai ping_SP[22444]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jun 20 17:33:52 srv4hai postfix/scache[31159]: statistics: start interval Jun 20 17:30:20
Jun 20 17:33:52 srv4hai postfix/scache[31159]: statistics: domain lookup hits=5 miss=58 success=7%
Jun 20 17:33:52 srv4hai postfix/scache[31159]: statistics: address lookup hits=0 miss=942 success=0%
Jun 20 17:33:52 srv4hai postfix/scache[31159]: statistics: max simultaneous domains=2 addresses=4 connection=4
Jun 20 17:34:01 srv4hai CRON[31617]: (root) CMD (/etc/linetest/linetest.sh)
Jun 20 17:34:19 srv4hai systemd[1]: Started Run anacron jobs.
Jun 20 17:34:19 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=31626, secured, session=
Jun 20 17:34:19 srv4hai anacron[31627]: Anacron 2.3 started on 2024-06-20
Jun 20 17:34:19 srv4hai anacron[31627]: Normal exit (0 jobs run)
Jun 20 17:34:19 srv4hai systemd[1]: anacron.service: Succeeded.
Jun 20 17:34:19 srv4hai dovecot: imap(miglincit)<31626>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jun 20 17:34:20 srv4hai dhcpd[30731]: DHCPDISCOVER from f0:39:65:25:8d:c7 via enp2s0
Jun 20 17:34:20 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jun 20 17:34:20 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jun 20 17:34:20 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.62
Jun 20 17:34:20 srv4hai dhcpd[30731]: execute_statement argv[2] = GreteS20
Jun 20 17:34:20 srv4hai common[31629]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jun 20 17:34:30 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jun 20 17:34:30 srv4hai common[31643]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jun 20 17:34:30 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jun 20 17:34:30 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jun 20 17:34:30 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jun 20 17:34:30 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.62
Jun 20 17:34:30 srv4hai dhcpd[30731]: execute_statement argv[2] = GreteS20
Jun 20 17:34:30 srv4hai common[31656]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jun 20 17:34:30 srv4hai ping_SP[31643]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jun 20 17:34:40 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jun 20 17:34:40 srv4hai common[31682]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jun 20 17:34:40 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jun 20 17:34:40 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jun 20 17:34:40 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jun 20 17:34:40 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.62
Jun 20 17:34:40 srv4hai dhcpd[30731]: execute_statement argv[2] = GreteS20
Jun 20 17:34:40 srv4hai named[30406]: client @0x7f93501490e0 192.168.12.252#43135/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jun 20 17:34:40 srv4hai common[31700]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jun 20 17:34:40 srv4hai common[31703]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jun 20 17:34:40 srv4hai ping_SP[31682]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jun 20 17:34:41 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'21'=1718897681-1718897660
Jun 20 17:34:41 srv4hai check_presence[31700]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jun 20 17:34:41 srv4hai check_presence[31700]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jun 20 17:34:41 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'21'=1718897681-1718897660
Jun 20 17:34:41 srv4hai check_presence[31700]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jun 20 17:34:41 srv4hai check_presence[31700]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jun 20 17:34:41 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'21'=1718897681-1718897660
Jun 20 17:34:41 srv4hai check_presence[31700]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jun 20 17:34:41 srv4hai check_presence[31700]: SHELLY (ping_SP__smartphone)-(1) what: 'coming' - persPresent: '(BT/LIVE) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jun 20 17:34:41 srv4hai check_presence[31700]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Jun 20 17:34:41 srv4hai check_presence[31700]: SHELLY (ping_SP__smartphone)-(1)-coming: activate_scenario.shtml: vorraumOn
Jun 20 17:34:41 srv4hai activate_scenario[31869]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jun 20 17:34:41 srv4hai activate_scenario[31869]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1'
Jun 20 17:34:41 srv4hai activate_scenario[31869]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'1'
Jun 20 17:34:41 srv4hai postfix/pickup[22330]: 69F3863706: uid=33 from=
Jun 20 17:34:41 srv4hai postfix/cleanup[31920]: 69F3863706: message-id=<20240620153441.69F3863706@mail.viehai.at>
Jun 20 17:34:41 srv4hai postfix/qmgr[31004]: 69F3863706: from=, size=10838, nrcpt=1 (queue active)
Jun 20 17:34:41 srv4hai activate_scenario[31869]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Jun 20 17:34:41 srv4hai proc_url[31937]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/06/20/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'1''
Jun 20 17:34:41 srv4hai activate_scenario[31869]: SHELLY scenario: 'vorraumOn(vorraumon)' took 60 msec, phoneName:'1'
Jun 20 17:34:41 srv4hai ping_SP[31643]: SHELLY check_presence.sh coming 1 ping_SP__smartphone
Jun 20 17:34:42 srv4hai postfix/relay/smtp[31933]: 69F3863706: to=, relay=mx01.nic.name[209.131.159.47]:25, delay=0.91, delays=0.03/0.01/0.58/0.29, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 18BA120247)
Jun 20 17:34:42 srv4hai postfix/qmgr[31004]: 69F3863706: removed
Jun 20 17:34:43 srv4hai ping_SP[31643]: SHELLY - running process-id(31643): '31643 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.62 smartphone#01231682 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.62 smartphone#01231703 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.62 GreteS20' - 'ping_SP_1' - exiting ==============
Jun 20 17:34:50 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jun 20 17:34:50 srv4hai common[31981]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jun 20 17:34:50 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jun 20 17:34:50 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jun 20 17:34:50 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jun 20 17:34:50 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.62
Jun 20 17:34:50 srv4hai dhcpd[30731]: execute_statement argv[2] = GreteS20
Jun 20 17:34:50 srv4hai named[30406]: client @0x7f93501490e0 192.168.12.252#43135/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jun 20 17:34:50 srv4hai named[30406]: client @0x7f932c0a6290 192.168.12.252#47949/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jun 20 17:34:50 srv4hai common[31993]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jun 20 17:34:50 srv4hai common[32001]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jun 20 17:34:50 srv4hai ping_SP[31981]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jun 20 17:34:51 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'9'=1718897691-1718897682
Jun 20 17:34:51 srv4hai check_presence[31993]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jun 20 17:34:51 srv4hai check_presence[31993]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jun 20 17:34:51 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'9'=1718897691-1718897682
Jun 20 17:34:51 srv4hai check_presence[31993]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jun 20 17:34:51 srv4hai check_presence[31993]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jun 20 17:34:51 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'9'=1718897691-1718897682
Jun 20 17:34:51 srv4hai check_presence[31993]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jun 20 17:34:51 srv4hai check_presence[31993]: SHELLY (ping_SP__smartphone)-(1) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jun 20 17:34:51 srv4hai check_presence[31993]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Jun 20 17:34:51 srv4hai check_presence[31993]: SHELLY (ping_SP__smartphone)-(1)-coming: activate_scenario.shtml: vorraumOn
Jun 20 17:34:51 srv4hai activate_scenario[32168]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jun 20 17:34:51 srv4hai activate_scenario[32168]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1'

finished