activate_scenario.sh
Mon Aug 19 09:25:46 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/19/_0.log)

vorher: 09:25:46.354

http://192.168.12.103/relay/0?turn=on
  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "overpower": false,
  "source": "input"

nachher: 09:25:46.379
Dauer: 25 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 09:25:46.335
nachher: 09:25:46.386
Dauer : 51 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/08/19//scene_vorraumOn_20240819_092546.txt'


syslog

Aug 19 09:22:01 srv4hai CRON[409]: (root) CMD (/etc/linetest/linetest.sh)
Aug 19 09:22:08 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Aug 19 09:22:09 srv4hai fetchmail[1651]: 50293 messages (50292 seen) for tmiglinci at mail.akis.at (-138023156 octets).
Aug 19 09:22:09 srv4hai postfix/smtpd[414]: connect from localhost[127.0.0.1]
Aug 19 09:22:09 srv4hai postfix/smtpd[414]: 7F550631BE: client=localhost[127.0.0.1]
Aug 19 09:22:09 srv4hai postfix/cleanup[32668]: 7F550631BE: message-id=<20240819072046.A99566345B@mail.viehai.at>
Aug 19 09:22:09 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:50293 of 50293 (9670 octets) not flushed
Aug 19 09:22:09 srv4hai postfix/qmgr[8566]: 7F550631BE: from=, size=9964, nrcpt=1 (queue active)
Aug 19 09:22:09 srv4hai postfix/smtpd[414]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Aug 19 09:22:09 srv4hai postfix/local[416]: 7F550631BE: to=, relay=local, delay=0.07, delays=0.05/0.02/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Aug 19 09:22:09 srv4hai postfix/qmgr[8566]: 7F550631BE: removed
Aug 19 09:22:10 srv4hai fetchmail[1651]: 10596 messages (10596 seen) for srozum at mail.akis.at (1273032502 octets).
Aug 19 09:22:10 srv4hai fetchmail[1651]: 25387 messages (25387 seen) for mrozum at mail.akis.at (134350730 octets).
Aug 19 09:22:11 srv4hai fetchmail[1651]: 1141 messages (1141 seen) for admin@bastelstube.wien at pop3.world4you.com (51598561 octets).
Aug 19 09:22:49 srv4hai ping_SP[32467]: SHELLY (0)- ping 192.168.12.61 1 not answered (1) @~1724052169 - 'ping_SP_0'
Aug 19 09:23:01 srv4hai CRON[446]: (root) CMD (/etc/linetest/linetest.sh)
Aug 19 09:23:12 srv4hai ping_SP[32467]: SHELLY (0)- ping 192.168.12.61 2 not answered (1) @~1724052192 - 'ping_SP_0'
Aug 19 09:23:13 srv4hai ping_SP[12277]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1724052193 - 'ping_SP_1'
Aug 19 09:23:13 srv4hai ping_SP[12277]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug 19 09:23:27 srv4hai common[492]: SHELLY common.sh inkludiert von ./bt_scan.sh
Aug 19 09:23:37 srv4hai bt_scan[492]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Aug 19 09:23:37 srv4hai bt_scan[492]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Aug 19 09:23:37 srv4hai common[528]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug 19 09:23:38 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1724052218-1724052208
Aug 19 09:23:38 srv4hai check_presence[528]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug 19 09:23:38 srv4hai check_presence[528]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.TRY' for what: 'presence'
Aug 19 09:23:38 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'10'=1724052218-1724052208
Aug 19 09:23:38 srv4hai check_presence[528]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Aug 19 09:23:38 srv4hai check_presence[528]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Aug 19 09:23:38 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1724052218-1724052208
Aug 19 09:23:38 srv4hai check_presence[528]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug 19 09:23:38 srv4hai check_presence[528]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/TRY) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug 19 09:23:38 srv4hai ping_SP[32467]: SHELLY (0)- ping 192.168.12.61 3 not answered (1) @~1724052218 - 'ping_SP_0'
Aug 19 09:23:38 srv4hai check_presence[528]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_vorraumOn) - sceneOFF(offAll)
Aug 19 09:23:38 srv4hai check_presence[528]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Aug 19 09:24:02 srv4hai CRON[699]: (root) CMD (/etc/linetest/linetest.sh)
Aug 19 09:24:04 srv4hai ping_SP[32467]: SHELLY (0)- ping 192.168.12.61 4 not answered (1) @~1724052244 - 'ping_SP_0'
Aug 19 09:24:27 srv4hai ping_SP[12277]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1724052267 - 'ping_SP_1'
Aug 19 09:24:27 srv4hai ping_SP[12277]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug 19 09:24:27 srv4hai ping_SP[32467]: SHELLY (0)- ping 192.168.12.61 5 not answered (1) @~1724052267 - 'ping_SP_0'
Aug 19 09:24:27 srv4hai ping_SP[32467]: SHELLY (0)- ping 192.168.12.61 5 not answered - abort (32467) @~1724052267 - rm 'ping_SP_0'
Aug 19 09:24:27 srv4hai common[755]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug 19 09:24:28 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'6'=1724052268-1724052262
Aug 19 09:24:28 srv4hai check_presence[755]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug 19 09:24:28 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'6'=1724052268-1724052262
Aug 19 09:24:28 srv4hai check_presence[755]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Aug 19 09:24:28 srv4hai check_presence[755]: SHELLY (ping_SP__NO_ping)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Aug 19 09:24:28 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'6'=1724052268-1724052262
Aug 19 09:24:28 srv4hai check_presence[755]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug 19 09:24:28 srv4hai check_presence[755]: SHELLY (ping_SP__NO_ping)-(0) what: 'presence' - persPresent: '(__/__) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug 19 09:24:28 srv4hai check_presence[755]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_vorraumOn) - sceneOFF(offAll)
Aug 19 09:24:28 srv4hai check_presence[755]: SHELLY (ping_SP__NO_ping)-(0)-presence: NOT activate_scenario.shtml: offAll
Aug 19 09:24:28 srv4hai ping_SP[32467]: SHELLY (0)- TERMINATING now
Aug 19 09:24:46 srv4hai postfix/smtpd[912]: connect from unknown[178.215.236.137]
Aug 19 09:24:46 srv4hai postfix/smtpd[912]: warning: unknown[178.215.236.137]: SASL LOGIN authentication failed: Invalid authentication mechanism
Aug 19 09:24:46 srv4hai postfix/smtpd[912]: disconnect from unknown[178.215.236.137] ehlo=1 auth=0/1 quit=1 commands=2/3
Aug 19 09:25:01 srv4hai CRON[917]: (root) CMD (/etc/linetest/linetest.sh)
Aug 19 09:25:10 srv4hai mosquitto[18551]: Saving in-memory database to /var/lib/mosquitto/mosquitto.db.
Aug 19 09:25:30 srv4hai ping_SP[12277]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1724052330 - 'ping_SP_1'
Aug 19 09:25:30 srv4hai ping_SP[12277]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug 19 09:25:35 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Aug 19 09:25:35 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 19 09:25:35 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug 19 09:25:35 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug 19 09:25:35 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug 19 09:25:35 srv4hai common[947]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug 19 09:25:35 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug 19 09:25:35 srv4hai common[962]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Aug 19 09:25:35 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug 19 09:25:35 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 19 09:25:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#42553/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 19 09:25:35 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#55895/key rndc-key: signer "rndc-key" approved
Aug 19 09:25:35 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#55895/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug 19 09:25:35 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#55895/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug 19 09:25:35 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#55895/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug 19 09:25:35 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#55895/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug 19 09:25:35 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug 19 09:25:35 srv4hai named[30406]: client @0x7f933000d2b0 192.168.12.252#59939/key rndc-key: signer "rndc-key" approved
Aug 19 09:25:35 srv4hai named[30406]: client @0x7f933000d2b0 192.168.12.252#59939/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug 19 09:25:35 srv4hai named[30406]: client @0x7f933000d2b0 192.168.12.252#59939/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 19 09:25:35 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug 19 09:25:35 srv4hai ping_SP[962]: SHELLY ping_SP.sh started from smartphone, user:'root'
Aug 19 09:25:41 srv4hai common[990]: SHELLY common.sh inkludiert von ./bt_scan.sh
Aug 19 09:25:42 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Aug 19 09:25:42 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 19 09:25:42 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug 19 09:25:42 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug 19 09:25:42 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug 19 09:25:42 srv4hai common[1005]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug 19 09:25:45 srv4hai common[1028]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug 19 09:25:46 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'5'=1724052346-1724052341
Aug 19 09:25:46 srv4hai check_presence[1028]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug 19 09:25:46 srv4hai check_presence[1028]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Aug 19 09:25:46 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'5'=1724052346-1724052341
Aug 19 09:25:46 srv4hai check_presence[1028]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Aug 19 09:25:46 srv4hai check_presence[1028]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Aug 19 09:25:46 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'5'=1724052346-1724052341
Aug 19 09:25:46 srv4hai check_presence[1028]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug 19 09:25:46 srv4hai check_presence[1028]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(BT/LIVE) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug 19 09:25:46 srv4hai check_presence[1028]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Aug 19 09:25:46 srv4hai check_presence[1028]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Aug 19 09:25:46 srv4hai activate_scenario[1176]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Aug 19 09:25:46 srv4hai activate_scenario[1176]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished