activate_scenario.sh
Fri Aug 2 11:40:28 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/08/02/_0.log)

vorher: 11:40:28.910

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: 11:40:28.983
Dauer: 73 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 11:40:28.859
nachher: 11:40:28.989
Dauer : 132 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/08/02//scene_vorraumOn_20240802_114028.txt'


syslog

Aug  2 11:37:02 srv4hai CRON[27787]: (root) CMD (/etc/linetest/linetest.sh)
Aug  2 11:37:03 srv4hai ping_SP[25327]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1722591423 - 'ping_SP_0'
Aug  2 11:37:03 srv4hai ping_SP[25327]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Aug  2 11:37:08 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27807, secured, session=<1MsvErAeaugAAAAAAAAAAAAAAAAAAAAB>
Aug  2 11:37:08 srv4hai dovecot: imap(rozumm)<27807><1MsvErAeaugAAAAAAAAAAAAAAAAAAAAB>: Logged out in=92 out=1060 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug  2 11:37:50 srv4hai ping_SP[14422]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1722591470 - 'ping_SP_1'
Aug  2 11:37:50 srv4hai ping_SP[14422]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug  2 11:38:01 srv4hai CRON[27833]: (root) CMD (/etc/linetest/linetest.sh)
Aug  2 11:38:08 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27842, secured, session=
Aug  2 11:38:08 srv4hai dovecot: imap(rozumm)<27842>: Logged out in=92 out=1060 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug  2 11:38:19 srv4hai ping_SP[25327]: SHELLY (0)- ping 192.168.12.61 1 not answered (1) @~1722591499 - 'ping_SP_0'
Aug  2 11:38:45 srv4hai ping_SP[25327]: SHELLY (0)- ping 192.168.12.61 2 not answered (1) @~1722591525 - 'ping_SP_0'
Aug  2 11:38:49 srv4hai common[27882]: SHELLY common.sh inkludiert von ./bt_scan.sh
Aug  2 11:38:59 srv4hai bt_scan[27882]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Aug  2 11:38:59 srv4hai bt_scan[27882]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Aug  2 11:38:59 srv4hai common[27922]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug  2 11:38:59 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1722591539-1722591529
Aug  2 11:38:59 srv4hai check_presence[27922]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug  2 11:38:59 srv4hai check_presence[27922]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.TRY' for what: 'presence'
Aug  2 11:38:59 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'10'=1722591539-1722591529
Aug  2 11:38:59 srv4hai check_presence[27922]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Aug  2 11:38:59 srv4hai check_presence[27922]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Aug  2 11:38:59 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1722591539-1722591529
Aug  2 11:38:59 srv4hai check_presence[27922]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug  2 11:38:59 srv4hai check_presence[27922]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/TRY) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug  2 11:39:00 srv4hai check_presence[27922]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_vorraumOn) - sceneOFF(offAll)
Aug  2 11:39:00 srv4hai check_presence[27922]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Aug  2 11:39:00 srv4hai systemd[1]: Starting Clean php session files...
Aug  2 11:39:00 srv4hai systemd[1]: phpsessionclean.service: Succeeded.
Aug  2 11:39:00 srv4hai systemd[1]: Started Clean php session files.
Aug  2 11:39:01 srv4hai CRON[28244]: (root) CMD (/etc/linetest/linetest.sh)
Aug  2 11:39:01 srv4hai CRON[28245]: (root) CMD (  [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi)
Aug  2 11:39:03 srv4hai ping_SP[14422]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1722591543 - 'ping_SP_1'
Aug  2 11:39:03 srv4hai ping_SP[14422]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug  2 11:39:08 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=28276, secured, session=
Aug  2 11:39:08 srv4hai dovecot: imap(rozumm)<28276>: Logged out in=92 out=1060 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug  2 11:39:11 srv4hai ping_SP[25327]: SHELLY (0)- ping 192.168.12.61 3 not answered (1) @~1722591551 - 'ping_SP_0'
Aug  2 11:39:19 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=28294, secured, session=
Aug  2 11:39:19 srv4hai dovecot: imap(miglincit)<28294>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug  2 11:39:38 srv4hai ping_SP[25327]: SHELLY (0)- ping 192.168.12.61 4 not answered (1) @~1722591578 - 'ping_SP_0'
Aug  2 11:39:46 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Aug  2 11:39:46 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug  2 11:39:46 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug  2 11:39:46 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug  2 11:39:46 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug  2 11:39:46 srv4hai common[28314]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug  2 11:39:56 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug  2 11:39:56 srv4hai common[28333]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Aug  2 11:39:56 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug  2 11:39:56 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug  2 11:39:56 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug  2 11:39:56 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug  2 11:39:56 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug  2 11:39:56 srv4hai common[28346]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug  2 11:39:56 srv4hai ping_SP[28333]: SHELLY ping_SP.sh started from smartphone, user:'root'
Aug  2 11:40:01 srv4hai CRON[28368]: (root) CMD (/etc/linetest/linetest.sh)
Aug  2 11:40:01 srv4hai CRON[28369]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Aug  2 11:40:01 srv4hai common[28373]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/meter.sh
Aug  2 11:40:01 srv4hai meter.sh: SHELLY meter.sh started
Aug  2 11:40:01 srv4hai meter.sh: SHELLY 'shelly-29/Schalter Herdzeile' - type: 'shelly-i3' ignoring
Aug  2 11:40:01 srv4hai meter.sh: SHELLY 'shelly-28/Schalter Nasszeile' - type: 'shelly-i3' ignoring
Aug  2 11:40:04 srv4hai ping_SP[25327]: SHELLY (0)- ping 192.168.12.61 5 not answered (1) @~1722591604 - 'ping_SP_0'
Aug  2 11:40:04 srv4hai ping_SP[25327]: SHELLY (0)- ping 192.168.12.61 5 not answered - abort (25327) @~1722591604 - rm 'ping_SP_0'
Aug  2 11:40:04 srv4hai common[28797]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug  2 11:40:04 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'8'=1722591604-1722591596
Aug  2 11:40:04 srv4hai check_presence[28797]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug  2 11:40:04 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'8'=1722591604-1722591596
Aug  2 11:40:04 srv4hai check_presence[28797]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Aug  2 11:40:04 srv4hai check_presence[28797]: SHELLY (ping_SP__NO_ping)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Aug  2 11:40:04 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'8'=1722591604-1722591596
Aug  2 11:40:04 srv4hai check_presence[28797]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug  2 11:40:04 srv4hai check_presence[28797]: SHELLY (ping_SP__NO_ping)-(0) what: 'presence' - persPresent: '(__/__) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug  2 11:40:05 srv4hai check_presence[28797]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_vorraumOn) - sceneOFF(offAll)
Aug  2 11:40:05 srv4hai check_presence[28797]: SHELLY (ping_SP__NO_ping)-(0)-presence: NOT activate_scenario.shtml: offAll
Aug  2 11:40:05 srv4hai ping_SP[25327]: SHELLY (0)- TERMINATING now
Aug  2 11:40:05 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug  2 11:40:05 srv4hai common[29007]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Aug  2 11:40:05 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug  2 11:40:05 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug  2 11:40:05 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug  2 11:40:05 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug  2 11:40:05 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug  2 11:40:05 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug  2 11:40:05 srv4hai common[29020]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug  2 11:40:05 srv4hai ping_SP[29007]: SHELLY ping_SP.sh started from smartphone, user:'root'
Aug  2 11:40:05 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster' - type: 'shelly-BTN' ignoring
Aug  2 11:40:05 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter' - type: 'shelly-BTN' ignoring
Aug  2 11:40:05 srv4hai meter.sh: SHELLY 'shelly-37/Klima Büro' - type: 'shelly-ht' ignoring
Aug  2 11:40:05 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen' - status: 'OOS' ignoring
Aug  2 11:40:05 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon' - type: 'shelly-ht-plus' ignoring
Aug  2 11:40:06 srv4hai common[29232]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug  2 11:40:06 srv4hai named[30406]: validating sdkapi.dsp-api.moloco.com/A: no valid signature found
Aug  2 11:40:06 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'2'=1722591606-1722591604
Aug  2 11:40:06 srv4hai check_presence[29232]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug  2 11:40:06 srv4hai check_presence[29232]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Aug  2 11:40:06 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'2'=1722591606-1722591604
Aug  2 11:40:06 srv4hai check_presence[29232]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Aug  2 11:40:06 srv4hai check_presence[29232]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Aug  2 11:40:06 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'2'=1722591606-1722591604
Aug  2 11:40:06 srv4hai check_presence[29232]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug  2 11:40:06 srv4hai check_presence[29232]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug  2 11:40:07 srv4hai check_presence[29232]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Aug  2 11:40:07 srv4hai check_presence[29232]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Aug  2 11:40:07 srv4hai activate_scenario[29384]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Aug  2 11:40:07 srv4hai activate_scenario[29384]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
Aug  2 11:40:07 srv4hai activate_scenario[29384]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
Aug  2 11:40:07 srv4hai postfix/pickup[27417]: 167676018A: uid=33 from=
Aug  2 11:40:07 srv4hai postfix/cleanup[29434]: 167676018A: message-id=<20240802094007.167676018A@mail.viehai.at>
Aug  2 11:40:07 srv4hai postfix/qmgr[8566]: 167676018A: from=, size=13212, nrcpt=1 (queue active)
Aug  2 11:40:07 srv4hai activate_scenario[29384]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Aug  2 11:40:07 srv4hai proc_url[29451]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/02/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
Aug  2 11:40:07 srv4hai activate_scenario[29384]: SHELLY scenario: 'vorraumOn(vorraumon)' took 85 msec, phoneName:'0'
Aug  2 11:40:07 srv4hai ping_SP[28333]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
Aug  2 11:40:07 srv4hai postfix/relay/smtp[29447]: 167676018A: to=, relay=mx02.nic.name[209.131.158.56]:25, delay=0.82, delays=0.02/0.01/0.54/0.25, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as AEB428003D)
Aug  2 11:40:07 srv4hai postfix/qmgr[8566]: 167676018A: removed
Aug  2 11:40:08 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Aug  2 11:40:09 srv4hai ping_SP[28333]: SHELLY - running process-id(28333): '28333 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01229007 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01229020 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.61 fpThomas' - 'ping_SP_0' - exiting ==============
Aug  2 11:40:09 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=29499, secured, session=
Aug  2 11:40:09 srv4hai dovecot: imap(rozumm)<29499>: Logged out in=92 out=1060 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD' - status: 'OOS' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3' - status: 'OOS' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD' - status: 'OOS' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD' - status: 'OOS' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD' - status: 'OOS' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-47/47-plus1-Test' - status: 'OOS' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-09a/Inbetriebnahme - 20210720 - Defekt' - status: 'defect' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-09b/Sophie Licht - 20230404 - Defekt' - status: 'defect' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN' - status: 'defect' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417' - status: 'defect' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem' - status: 'defect' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722' - status: 'defect' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-43/43-TBD' - status: 'OOS' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD' - status: 'OOS' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-45/45-TBD' - status: 'OOS' ignoring
Aug  2 11:40:11 srv4hai meter.sh: SHELLY 'shelly-46/46-TBD' - status: 'OOS' ignoring
Aug  2 11:40:14 srv4hai meter.sh: SHELLY 'shelly-48/BT GW 1':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Aug  2 11:40:15 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug  2 11:40:15 srv4hai common[29721]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Aug  2 11:40:15 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug  2 11:40:15 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug  2 11:40:15 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug  2 11:40:15 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug  2 11:40:15 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug  2 11:40:15 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug  2 11:40:15 srv4hai named[30406]: client @0x7f93100b4de0 192.168.12.252#60077/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug  2 11:40:15 srv4hai common[29740]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug  2 11:40:15 srv4hai common[29743]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug  2 11:40:15 srv4hai ping_SP[29721]: SHELLY ping_SP.sh started from smartphone, user:'root'
Aug  2 11:40:15 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'11'=1722591615-1722591604
Aug  2 11:40:15 srv4hai check_presence[29740]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug  2 11:40:15 srv4hai check_presence[29740]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Aug  2 11:40:15 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'11'=1722591615-1722591604
Aug  2 11:40:15 srv4hai check_presence[29740]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Aug  2 11:40:15 srv4hai check_presence[29740]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Aug  2 11:40:15 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'11'=1722591615-1722591604
Aug  2 11:40:15 srv4hai check_presence[29740]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug  2 11:40:15 srv4hai check_presence[29740]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug  2 11:40:15 srv4hai check_presence[29740]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Aug  2 11:40:15 srv4hai check_presence[29740]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Aug  2 11:40:15 srv4hai activate_scenario[29919]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Aug  2 11:40:15 srv4hai activate_scenario[29919]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
Aug  2 11:40:15 srv4hai activate_scenario[29919]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
Aug  2 11:40:15 srv4hai postfix/pickup[27417]: C839E6018A: uid=33 from=
Aug  2 11:40:15 srv4hai postfix/cleanup[29434]: C839E6018A: message-id=<20240802094015.C839E6018A@mail.viehai.at>
Aug  2 11:40:15 srv4hai postfix/qmgr[8566]: C839E6018A: from=, size=20449, nrcpt=1 (queue active)
Aug  2 11:40:15 srv4hai activate_scenario[29919]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Aug  2 11:40:15 srv4hai proc_url[29983]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/02/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
Aug  2 11:40:15 srv4hai activate_scenario[29919]: SHELLY scenario: 'vorraumOn(vorraumon)' took 150 msec, phoneName:'0'
Aug  2 11:40:16 srv4hai ping_SP[29007]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
Aug  2 11:40:16 srv4hai postfix/relay/smtp[29447]: C839E6018A: to=, relay=mx01.nic.name[209.131.159.47]:25, delay=0.91, delays=0.01/0/0.52/0.37, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 6830660174)
Aug  2 11:40:16 srv4hai postfix/qmgr[8566]: C839E6018A: removed
Aug  2 11:40:16 srv4hai meter.sh: SHELLY 'shelly-58/Werkstatt Licht':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Aug  2 11:40:16 srv4hai meter.sh: SHELLY 'shelly-59/Werkstatt Schalter Kellertür' - type: 'shelly-i3' ignoring
Aug  2 11:40:16 srv4hai common[30025]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_shelly.sh
Aug  2 11:40:16 srv4hai ping_SP[14422]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1722591616 - 'ping_SP_1'
Aug  2 11:40:16 srv4hai ping_SP[14422]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug  2 11:40:16 srv4hai check_shelly.sh: SHELLY last scenery executed: 'vorraumOn'
Aug  2 11:40:16 srv4hai check_shelly.sh: SHELLY found '7' active shelly outputs
Aug  2 11:40:16 srv4hai meter.sh: SHELLY meter.sh ended
Aug  2 11:40:18 srv4hai ping_SP[29007]: SHELLY - running process-id(29007): '29007 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01229721 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01229743 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.61 fpThomas' - 'ping_SP_0' - exiting ==============
Aug  2 11:40:18 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug  2 11:40:18 srv4hai common[30078]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug  2 11:40:18 srv4hai common[30079]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Aug  2 11:40:18 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug  2 11:40:18 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: signer "rndc-key" approved
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: signer "rndc-key" approved
Aug  2 11:40:18 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: signer "rndc-key" approved
Aug  2 11:40:18 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug  2 11:40:18 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: signer "rndc-key" approved
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug  2 11:40:18 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: signer "rndc-key" approved
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/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.
Aug  2 11:40:18 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: signer "rndc-key" approved
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/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.
Aug  2 11:40:18 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: signer "rndc-key" approved
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/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.
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: signer "rndc-key" approved
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug  2 11:40:18 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#42383/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.
Aug  2 11:40:18 srv4hai ping_SP[30079]: SHELLY ping_SP.sh started from smartphone, user:'root'
Aug  2 11:40:18 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug  2 11:40:18 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug  2 11:40:18 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'0'=1722591618-1722591618
Aug  2 11:40:18 srv4hai check_presence[30078]: 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
Aug  2 11:40:18 srv4hai check_presence[30078]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Aug  2 11:40:18 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'0'=1722591618-1722591618
Aug  2 11:40:18 srv4hai check_presence[30078]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Aug  2 11:40:18 srv4hai check_presence[30078]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Aug  2 11:40:18 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_not_set' dweetAge:'0'=1722591618-1722591618
Aug  2 11:40:18 srv4hai check_presence[30078]: 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
Aug  2 11:40:18 srv4hai check_presence[30078]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug  2 11:40:18 srv4hai check_presence[30078]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Aug  2 11:40:18 srv4hai check_presence[30078]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Aug  2 11:40:18 srv4hai activate_scenario[30230]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Aug  2 11:40:18 srv4hai activate_scenario[30230]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
Aug  2 11:40:18 srv4hai activate_scenario[30230]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
Aug  2 11:40:18 srv4hai postfix/pickup[27417]: C4AF56018A: uid=33 from=
Aug  2 11:40:18 srv4hai postfix/cleanup[29434]: C4AF56018A: message-id=<20240802094018.C4AF56018A@mail.viehai.at>
Aug  2 11:40:18 srv4hai postfix/qmgr[8566]: C4AF56018A: from=, size=31983, nrcpt=1 (queue active)
Aug  2 11:40:18 srv4hai activate_scenario[30230]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Aug  2 11:40:18 srv4hai proc_url[30294]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/02/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
Aug  2 11:40:18 srv4hai activate_scenario[30230]: SHELLY scenario: 'vorraumOn(vorraumon)' took 126 msec, phoneName:'0'
Aug  2 11:40:18 srv4hai ping_SP[29721]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
Aug  2 11:40:19 srv4hai postfix/relay/smtp[29447]: C4AF56018A: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=0.87, delays=0.02/0/0.46/0.39, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 52BDA800ED)
Aug  2 11:40:19 srv4hai postfix/qmgr[8566]: C4AF56018A: removed
Aug  2 11:40:21 srv4hai ping_SP[29721]: SHELLY - running process-id(29721): '29721 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01230079 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone' - 'ping_SP_0' - exiting ==============
Aug  2 11:40:28 srv4hai common[30339]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug  2 11:40:28 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'5'=1722591628-1722591623
Aug  2 11:40:28 srv4hai check_presence[30339]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug  2 11:40:28 srv4hai check_presence[30339]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Aug  2 11:40:28 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'5'=1722591628-1722591623
Aug  2 11:40:28 srv4hai check_presence[30339]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Aug  2 11:40:28 srv4hai check_presence[30339]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Aug  2 11:40:28 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'5'=1722591628-1722591623
Aug  2 11:40:28 srv4hai check_presence[30339]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug  2 11:40:28 srv4hai check_presence[30339]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug  2 11:40:28 srv4hai check_presence[30339]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Aug  2 11:40:28 srv4hai check_presence[30339]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Aug  2 11:40:28 srv4hai activate_scenario[30506]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Aug  2 11:40:28 srv4hai activate_scenario[30506]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished