activate_scenario.sh
Fri Jul 26 16:09:09 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/07/26/_0.log)

vorher: 16:09:09.550

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: 16:09:09.601
Dauer: 51 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 16:09:09.525
nachher: 16:09:09.607
Dauer : 82 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/07/26//scene_vorraumOn_20240726_160909.txt'


syslog

Jul 26 16:06:01 srv4hai CRON[4151]: (root) CMD (/etc/linetest/linetest.sh)
Jul 26 16:06:07 srv4hai named[30406]: resolver priming query complete
Jul 26 16:06:13 srv4hai mosquitto[18551]: Saving in-memory database to /var/lib/mosquitto/mosquitto.db.
Jul 26 16:06:15 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4171, secured, session=<2dy2AycewoUAAAAAAAAAAAAAAAAAAAAB>
Jul 26 16:06:15 srv4hai dovecot: imap(miglincit)<4171><2dy2AycewoUAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 26 16:06:20 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4175, secured, session=
Jul 26 16:06:20 srv4hai dovecot: imap(rozums)<4175>: Logged out in=93 out=1021 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 26 16:06:23 srv4hai ping_SP[32037]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1722002783 - 'ping_SP_0'
Jul 26 16:06:23 srv4hai ping_SP[32037]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 26 16:06:47 srv4hai named[30406]: resolver priming query complete
Jul 26 16:07:01 srv4hai CRON[4213]: (root) CMD (/etc/linetest/linetest.sh)
Jul 26 16:07:13 srv4hai ping_SP[1414]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1722002833 - 'ping_SP_1'
Jul 26 16:07:13 srv4hai ping_SP[1414]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 26 16:07:20 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4248, secured, session=
Jul 26 16:07:20 srv4hai dovecot: imap(rozums)<4248>: Logged out in=93 out=1021 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 26 16:07:36 srv4hai ping_SP[32037]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1722002856 - 'ping_SP_0'
Jul 26 16:07:36 srv4hai ping_SP[32037]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 26 16:07:52 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jul 26 16:07:52 srv4hai fetchmail[1651]: 49425 messages (49425 seen) for tmiglinci at mail.akis.at (-205614544 octets).
Jul 26 16:07:53 srv4hai fetchmail[1651]: 10513 messages (10513 seen) for srozum at mail.akis.at (1264869333 octets).
Jul 26 16:07:53 srv4hai fetchmail[1651]: 24963 messages (24963 seen) for mrozum at mail.akis.at (69496196 octets).
Jul 26 16:07:53 srv4hai named[30406]: resolver priming query complete
Jul 26 16:07:54 srv4hai fetchmail[1651]: 1139 messages (1139 seen) for admin@bastelstube.wien at pop3.world4you.com (51570784 octets).
Jul 26 16:08:01 srv4hai CRON[4307]: (root) CMD (/etc/linetest/linetest.sh)
Jul 26 16:08:15 srv4hai postfix/anvil[4057]: statistics: max connection rate 1/60s for (smtp:94.141.120.192) at Jul 26 16:04:55
Jul 26 16:08:15 srv4hai postfix/anvil[4057]: statistics: max connection count 1 for (smtp:94.141.120.192) at Jul 26 16:04:55
Jul 26 16:08:15 srv4hai postfix/anvil[4057]: statistics: max cache size 1 at Jul 26 16:04:55
Jul 26 16:08:20 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4329, secured, session=
Jul 26 16:08:20 srv4hai dovecot: imap(rozums)<4329>: Logged out in=93 out=1021 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 26 16:08:26 srv4hai ping_SP[1414]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1722002906 - 'ping_SP_1'
Jul 26 16:08:26 srv4hai ping_SP[1414]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 26 16:08:36 srv4hai named[30406]: resolver priming query complete
Jul 26 16:08:38 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jul 26 16:08:38 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jul 26 16:08:38 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 26 16:08:38 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jul 26 16:08:38 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jul 26 16:08:38 srv4hai common[4358]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 26 16:08:48 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jul 26 16:08:48 srv4hai common[4376]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jul 26 16:08:48 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jul 26 16:08:48 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jul 26 16:08:48 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 26 16:08:48 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jul 26 16:08:48 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jul 26 16:08:48 srv4hai common[4389]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 26 16:08:48 srv4hai ping_SP[4376]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jul 26 16:08:58 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jul 26 16:08:58 srv4hai common[4433]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jul 26 16:08:58 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jul 26 16:08:58 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jul 26 16:08:58 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 26 16:08:58 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jul 26 16:08:58 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jul 26 16:08:58 srv4hai named[30406]: client @0x7f93501490e0 192.168.12.252#39989/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 26 16:08:58 srv4hai common[4451]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jul 26 16:08:58 srv4hai common[4453]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 26 16:08:58 srv4hai ping_SP[4433]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jul 26 16:08:58 srv4hai named[30406]: resolver priming query complete
Jul 26 16:08:59 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'6'=1722002939-1722002933
Jul 26 16:08:59 srv4hai check_presence[4451]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jul 26 16:08:59 srv4hai check_presence[4451]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jul 26 16:08:59 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'6'=1722002939-1722002933
Jul 26 16:08:59 srv4hai check_presence[4451]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jul 26 16:08:59 srv4hai check_presence[4451]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jul 26 16:08:59 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'6'=1722002939-1722002933
Jul 26 16:08:59 srv4hai check_presence[4451]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jul 26 16:08:59 srv4hai ping_SP[32037]: SHELLY (0)- ping 192.168.12.61 1 not answered (1) @~1722002939 - 'ping_SP_0'
Jul 26 16:08:59 srv4hai check_presence[4451]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jul 26 16:08:59 srv4hai check_presence[4451]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Jul 26 16:08:59 srv4hai check_presence[4451]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Jul 26 16:08:59 srv4hai activate_scenario[4656]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jul 26 16:08:59 srv4hai activate_scenario[4656]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
Jul 26 16:08:59 srv4hai activate_scenario[4656]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
Jul 26 16:08:59 srv4hai postfix/pickup[4292]: 9FF256018A: uid=33 from=
Jul 26 16:08:59 srv4hai postfix/cleanup[4706]: 9FF256018A: message-id=<20240726140859.9FF256018A@mail.viehai.at>
Jul 26 16:08:59 srv4hai postfix/qmgr[8566]: 9FF256018A: from=, size=10052, nrcpt=1 (queue active)
Jul 26 16:08:59 srv4hai activate_scenario[4656]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Jul 26 16:08:59 srv4hai proc_url[4723]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/07/26/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
Jul 26 16:08:59 srv4hai named[30406]: resolver priming query complete
Jul 26 16:08:59 srv4hai activate_scenario[4656]: SHELLY scenario: 'vorraumOn(vorraumon)' took 130 msec, phoneName:'0'
Jul 26 16:08:59 srv4hai ping_SP[4376]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
Jul 26 16:09:00 srv4hai postfix/relay/smtp[4719]: 9FF256018A: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=0.97, delays=0.05/0.01/0.66/0.25, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 63909800EC)
Jul 26 16:09:00 srv4hai postfix/qmgr[8566]: 9FF256018A: removed
Jul 26 16:09:00 srv4hai systemd[1]: Starting Clean php session files...
Jul 26 16:09:01 srv4hai systemd[1]: phpsessionclean.service: Succeeded.
Jul 26 16:09:01 srv4hai systemd[1]: Started Clean php session files.
Jul 26 16:09:01 srv4hai CRON[4849]: (root) CMD (/etc/linetest/linetest.sh)
Jul 26 16:09:01 srv4hai CRON[4850]: (root) CMD (  [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi)
Jul 26 16:09:01 srv4hai ping_SP[4376]: SHELLY - running process-id(4376): '4376 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#0124433 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#0124453 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.61 fpThomas#01232037 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 bt_scan' - 'ping_SP_0' - exiting ==============
Jul 26 16:09:08 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jul 26 16:09:08 srv4hai common[4870]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jul 26 16:09:08 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jul 26 16:09:08 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jul 26 16:09:08 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 26 16:09:08 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jul 26 16:09:08 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jul 26 16:09:08 srv4hai named[30406]: client @0x7f931c09e790 192.168.12.252#34839/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 26 16:09:08 srv4hai named[30406]: client @0x7f93501490e0 192.168.12.252#39989/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 26 16:09:08 srv4hai common[4888]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jul 26 16:09:08 srv4hai common[4890]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 26 16:09:08 srv4hai ping_SP[4870]: SHELLY ping_SP.sh started from smartphone, user:'root'
Jul 26 16:09:09 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'5'=1722002949-1722002944
Jul 26 16:09:09 srv4hai check_presence[4888]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jul 26 16:09:09 srv4hai check_presence[4888]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jul 26 16:09:09 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'5'=1722002949-1722002944
Jul 26 16:09:09 srv4hai check_presence[4888]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jul 26 16:09:09 srv4hai check_presence[4888]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jul 26 16:09:09 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'5'=1722002949-1722002944
Jul 26 16:09:09 srv4hai check_presence[4888]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jul 26 16:09:09 srv4hai check_presence[4888]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jul 26 16:09:09 srv4hai check_presence[4888]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Jul 26 16:09:09 srv4hai check_presence[4888]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Jul 26 16:09:09 srv4hai activate_scenario[5060]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jul 26 16:09:09 srv4hai activate_scenario[5060]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished