activate_scenario.sh
Fri Oct 4 07:19:06 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/10/04/_0.log)

vorher: 07:19:06.288

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: 07:19:06.315
Dauer: 27 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 07:19:06.256
nachher: 07:19:06.321
Dauer : 66 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/10/04//scene_vorraumOn_20241004_071906.txt'


syslog

Oct  4 07:16:01 srv4hai CRON[29780]: (root) CMD (/etc/linetest/linetest.sh)
Oct  4 07:16:02 srv4hai ping_SP[22314]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1728018962 - 'ping_SP_0'
Oct  4 07:16:02 srv4hai ping_SP[22314]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Oct  4 07:16:26 srv4hai common[29802]: SHELLY common.sh inkludiert von ./bt_scan.sh
Oct  4 07:16:36 srv4hai bt_scan[29802]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Oct  4 07:16:36 srv4hai bt_scan[29802]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Oct  4 07:16:36 srv4hai common[29835]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Oct  4 07:16:37 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'11'=1728018997-1728018986
Oct  4 07:16:37 srv4hai check_presence[29835]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Oct  4 07:16:37 srv4hai check_presence[29835]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Oct  4 07:16:37 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'11'=1728018997-1728018986
Oct  4 07:16:37 srv4hai check_presence[29835]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Oct  4 07:16:37 srv4hai check_presence[29835]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Oct  4 07:16:37 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'11'=1728018997-1728018986
Oct  4 07:16:37 srv4hai check_presence[29835]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Oct  4 07:16:37 srv4hai check_presence[29835]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Oct  4 07:16:37 srv4hai check_presence[29835]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_offAll) - sceneOFF(offAll)
Oct  4 07:16:37 srv4hai check_presence[29835]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Oct  4 07:16:59 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=29995, secured, session=
Oct  4 07:16:59 srv4hai dovecot: imap(miglincit)<29995>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Oct  4 07:17:01 srv4hai CRON[29998]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Oct  4 07:17:01 srv4hai CRON[29999]: (root) CMD (/etc/linetest/linetest.sh)
Oct  4 07:17:03 srv4hai ping_SP[26611]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1728019023 - 'ping_SP_1'
Oct  4 07:17:03 srv4hai ping_SP[26611]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Oct  4 07:17:15 srv4hai ping_SP[22314]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1728019035 - 'ping_SP_0'
Oct  4 07:17:15 srv4hai ping_SP[22314]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Oct  4 07:18:01 srv4hai CRON[30049]: (root) CMD (/etc/linetest/linetest.sh)
Oct  4 07:18:15 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Oct  4 07:18:15 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Oct  4 07:18:15 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Oct  4 07:18:15 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Oct  4 07:18:15 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Oct  4 07:18:15 srv4hai common[30062]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Oct  4 07:18:16 srv4hai ping_SP[26611]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1728019096 - 'ping_SP_1'
Oct  4 07:18:16 srv4hai ping_SP[26611]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Oct  4 07:18:25 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Oct  4 07:18:25 srv4hai common[30092]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Oct  4 07:18:25 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Oct  4 07:18:25 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Oct  4 07:18:25 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:25 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:25 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Oct  4 07:18:25 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Oct  4 07:18:25 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Oct  4 07:18:25 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Oct  4 07:18:25 srv4hai common[30105]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Oct  4 07:18:25 srv4hai ping_SP[30092]: SHELLY ping_SP.sh started from smartphone, user:'root'
Oct  4 07:18:35 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Oct  4 07:18:35 srv4hai common[30135]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Oct  4 07:18:35 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Oct  4 07:18:35 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Oct  4 07:18:35 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:35 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:35 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Oct  4 07:18:35 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Oct  4 07:18:35 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Oct  4 07:18:35 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Oct  4 07:18:35 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: signer "rndc-key" approved
Oct  4 07:18:35 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Oct  4 07:18:35 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Oct  4 07:18:35 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Oct  4 07:18:35 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Oct  4 07:18:35 srv4hai common[30151]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Oct  4 07:18:35 srv4hai common[30155]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Oct  4 07:18:35 srv4hai ping_SP[30135]: SHELLY ping_SP.sh started from smartphone, user:'root'
Oct  4 07:18:35 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_older_60sec' dweetAge:'116'=1728019115-1728018999
Oct  4 07:18:35 srv4hai check_presence[30151]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Oct  4 07:18:35 srv4hai check_presence[30151]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Oct  4 07:18:35 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_older_60sec' dweetAge:'116'=1728019115-1728018999
Oct  4 07:18:35 srv4hai check_presence[30151]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Oct  4 07:18:35 srv4hai check_presence[30151]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Oct  4 07:18:35 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_older_60sec' dweetAge:'116'=1728019115-1728018999
Oct  4 07:18:35 srv4hai check_presence[30151]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Oct  4 07:18:35 srv4hai check_presence[30151]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Oct  4 07:18:36 srv4hai check_presence[30151]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
Oct  4 07:18:36 srv4hai check_presence[30151]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Oct  4 07:18:36 srv4hai activate_scenario[30310]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Oct  4 07:18:36 srv4hai activate_scenario[30310]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
Oct  4 07:18:36 srv4hai activate_scenario[30310]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
Oct  4 07:18:36 srv4hai postfix/pickup[25721]: 1BF1163463: uid=33 from=
Oct  4 07:18:36 srv4hai postfix/cleanup[30360]: 1BF1163463: message-id=<20241004051836.1BF1163463@mail.viehai.at>
Oct  4 07:18:36 srv4hai postfix/qmgr[8566]: 1BF1163463: from=, size=16481, nrcpt=1 (queue active)
Oct  4 07:18:36 srv4hai activate_scenario[30310]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Oct  4 07:18:36 srv4hai proc_url[30377]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/10/04/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
Oct  4 07:18:36 srv4hai activate_scenario[30310]: SHELLY scenario: 'vorraumOn(vorraumon)' took 76 msec, phoneName:'0'
Oct  4 07:18:36 srv4hai ping_SP[30092]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
Oct  4 07:18:37 srv4hai postfix/relay/smtp[30373]: 1BF1163463: to=, relay=mx04.nic.name[209.131.160.34]:25, delay=1.3, delays=0.05/0.01/0.83/0.41, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 0CDDC80057)
Oct  4 07:18:37 srv4hai postfix/qmgr[8566]: 1BF1163463: removed
Oct  4 07:18:38 srv4hai ping_SP[30092]: SHELLY - running process-id(30092): '22314 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01230092 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01230135 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01230155 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.61 fpThomas' - 'ping_SP_0' - exiting ==============
Oct  4 07:18:38 srv4hai ping_SP[22314]: SHELLY (0)- ping 192.168.12.61 1 not answered (1) @~1728019118 - 'ping_SP_0'
Oct  4 07:18:45 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Oct  4 07:18:45 srv4hai common[30449]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Oct  4 07:18:45 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Oct  4 07:18:45 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Oct  4 07:18:45 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:45 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:45 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Oct  4 07:18:45 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Oct  4 07:18:45 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Oct  4 07:18:45 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Oct  4 07:18:45 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: signer "rndc-key" approved
Oct  4 07:18:45 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Oct  4 07:18:45 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Oct  4 07:18:45 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Oct  4 07:18:45 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Oct  4 07:18:45 srv4hai common[30467]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Oct  4 07:18:45 srv4hai common[30470]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Oct  4 07:18:45 srv4hai ping_SP[30449]: SHELLY ping_SP.sh started from smartphone, user:'root'
Oct  4 07:18:45 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_older_60sec' dweetAge:'126'=1728019125-1728018999
Oct  4 07:18:45 srv4hai check_presence[30467]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Oct  4 07:18:45 srv4hai check_presence[30467]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Oct  4 07:18:45 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_older_60sec' dweetAge:'126'=1728019125-1728018999
Oct  4 07:18:45 srv4hai check_presence[30467]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Oct  4 07:18:45 srv4hai check_presence[30467]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Oct  4 07:18:45 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_older_60sec' dweetAge:'126'=1728019125-1728018999
Oct  4 07:18:45 srv4hai check_presence[30467]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Oct  4 07:18:45 srv4hai check_presence[30467]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Oct  4 07:18:46 srv4hai check_presence[30467]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Oct  4 07:18:46 srv4hai check_presence[30467]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Oct  4 07:18:46 srv4hai activate_scenario[30625]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Oct  4 07:18:46 srv4hai activate_scenario[30625]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
Oct  4 07:18:46 srv4hai activate_scenario[30625]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
Oct  4 07:18:46 srv4hai postfix/pickup[25721]: 11A5F63463: uid=33 from=
Oct  4 07:18:46 srv4hai postfix/cleanup[30360]: 11A5F63463: message-id=<20241004051846.11A5F63463@mail.viehai.at>
Oct  4 07:18:46 srv4hai postfix/qmgr[8566]: 11A5F63463: from=, size=22496, nrcpt=1 (queue active)
Oct  4 07:18:46 srv4hai activate_scenario[30625]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Oct  4 07:18:46 srv4hai proc_url[30689]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/10/04/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
Oct  4 07:18:46 srv4hai activate_scenario[30625]: SHELLY scenario: 'vorraumOn(vorraumon)' took 133 msec, phoneName:'0'
Oct  4 07:18:46 srv4hai ping_SP[30135]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
Oct  4 07:18:47 srv4hai postfix/relay/smtp[30373]: 11A5F63463: to=, relay=mx01.nic.name[209.131.159.47]:25, delay=0.94, delays=0.02/0/0.56/0.36, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as ACA3960023)
Oct  4 07:18:47 srv4hai postfix/qmgr[8566]: 11A5F63463: removed
Oct  4 07:18:48 srv4hai ping_SP[30135]: SHELLY - running process-id(30135): '22314 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01230135 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01230449 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01230470 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.61 fpThomas' - 'ping_SP_0' - exiting ==============
Oct  4 07:18:55 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Oct  4 07:18:55 srv4hai common[30736]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Oct  4 07:18:55 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: signer "rndc-key" approved
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/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.
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:55 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: signer "rndc-key" approved
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Oct  4 07:18:55 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: signer "rndc-key" approved
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/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.
Oct  4 07:18:55 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: signer "rndc-key" approved
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Oct  4 07:18:55 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Oct  4 07:18:55 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: signer "rndc-key" approved
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/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.
Oct  4 07:18:55 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: signer "rndc-key" approved
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/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.
Oct  4 07:18:55 srv4hai common[30755]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Oct  4 07:18:55 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Oct  4 07:18:55 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.5
Oct  4 07:18:55 srv4hai dhcpd[30731]: execute_statement argv[2] = btscan1
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.5 (192.168.12.252) from 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:55 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Oct  4 07:18:55 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f934c0aebf0 192.168.12.252#60465/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: btscan1.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Oct  4 07:18:55 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.5'(5) device 'btscan1'
Oct  4 07:18:55 srv4hai ping_SP[30736]: SHELLY ping_SP.sh started from smartphone, user:'root'
Oct  4 07:18:55 srv4hai dhcpcommit.sh: SHELLY device 'btscan1' known and accepted
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f932c021730 192.168.12.252#35095/key rndc-key: signer "rndc-key" approved
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f932c021730 192.168.12.252#35095/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' TXT
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f932c021730 192.168.12.252#35095/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' TXT "000118916176265854cff71f762ffe0635"
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f932c021730 192.168.12.252#35095/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' A
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f932c021730 192.168.12.252#35095/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' A 192.168.12.5
Oct  4 07:18:55 srv4hai dhcpd[30731]: Added new forward map from btscan1.viehai.at to 192.168.12.5
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#60425/key rndc-key: signer "rndc-key" approved
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#60425/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '5.12.168.192.in-addr.arpa' PTR
Oct  4 07:18:55 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#60425/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '5.12.168.192.in-addr.arpa' PTR btscan1.viehai.at.
Oct  4 07:18:55 srv4hai dhcpd[30731]: Added reverse map from 5.12.168.192.in-addr.arpa. to btscan1.viehai.at
Oct  4 07:18:55 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_older_60sec' dweetAge:'136'=1728019135-1728018999
Oct  4 07:18:55 srv4hai check_presence[30755]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Oct  4 07:18:55 srv4hai check_presence[30755]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Oct  4 07:18:55 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_older_60sec' dweetAge:'136'=1728019135-1728018999
Oct  4 07:18:55 srv4hai check_presence[30755]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Oct  4 07:18:55 srv4hai check_presence[30755]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Oct  4 07:18:55 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_older_60sec' dweetAge:'136'=1728019135-1728018999
Oct  4 07:18:55 srv4hai check_presence[30755]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and BTdweet_older_60sec//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Oct  4 07:18:55 srv4hai check_presence[30755]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Oct  4 07:18:56 srv4hai check_presence[30755]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Oct  4 07:18:56 srv4hai check_presence[30755]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Oct  4 07:18:56 srv4hai activate_scenario[30915]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Oct  4 07:18:56 srv4hai activate_scenario[30915]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
Oct  4 07:18:56 srv4hai activate_scenario[30915]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
Oct  4 07:18:56 srv4hai postfix/pickup[25721]: 1C81763463: uid=33 from=
Oct  4 07:18:56 srv4hai postfix/cleanup[30360]: 1C81763463: message-id=<20241004051856.1C81763463@mail.viehai.at>
Oct  4 07:18:56 srv4hai postfix/qmgr[8566]: 1C81763463: from=, size=34836, nrcpt=1 (queue active)
Oct  4 07:18:56 srv4hai activate_scenario[30915]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Oct  4 07:18:56 srv4hai proc_url[30985]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/10/04/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
Oct  4 07:18:56 srv4hai common[30991]: SHELLY common.sh inkludiert von ./bt_scan.sh
Oct  4 07:18:56 srv4hai activate_scenario[30915]: SHELLY scenario: 'vorraumOn(vorraumon)' took 121 msec, phoneName:'0'
Oct  4 07:18:56 srv4hai ping_SP[30449]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
Oct  4 07:18:56 srv4hai postfix/relay/smtp[30373]: 1C81763463: to=, relay=mx04.nic.name[209.131.160.34]:25, delay=0.89, delays=0.02/0/0.46/0.42, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 9F3F9800C7)
Oct  4 07:18:56 srv4hai postfix/qmgr[8566]: 1C81763463: removed
Oct  4 07:18:58 srv4hai ping_SP[30449]: SHELLY - running process-id(30449): '22314 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01230449 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01230736 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone' - 'ping_SP_0' - exiting ==============
Oct  4 07:19:01 srv4hai CRON[31035]: (root) CMD (/etc/linetest/linetest.sh)
Oct  4 07:19:01 srv4hai ping_SP[22314]: SHELLY (0) - ping 192.168.12.61 2 sucessfully  @~1728019141 - 'ping_SP_0'
Oct  4 07:19:01 srv4hai ping_SP[22314]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Oct  4 07:19:05 srv4hai common[31066]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Oct  4 07:19:06 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'9'=1728019145-1728019136
Oct  4 07:19:06 srv4hai check_presence[31066]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Oct  4 07:19:06 srv4hai check_presence[31066]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Oct  4 07:19:06 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'10'=1728019146-1728019136
Oct  4 07:19:06 srv4hai check_presence[31066]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Oct  4 07:19:06 srv4hai check_presence[31066]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Oct  4 07:19:06 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1728019146-1728019136
Oct  4 07:19:06 srv4hai check_presence[31066]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Oct  4 07:19:06 srv4hai check_presence[31066]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(BT/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Oct  4 07:19:06 srv4hai check_presence[31066]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Oct  4 07:19:06 srv4hai check_presence[31066]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Oct  4 07:19:06 srv4hai activate_scenario[31217]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Oct  4 07:19:06 srv4hai activate_scenario[31217]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished