activate_scenario.sh
Wed Mar 6 17:33:26 CET 2024
scenario: buero_UM
source: 192.168.12.140

'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'null'

scenario: 'Büro UM-schalten' - 'buero_UM' - 'buero_um'

Thomas Büro Regallicht (/srv/www/viehai/shelly/log_scenarios/2024/03/06/_0.log)

vorher: 17:33:26.187

http://192.168.12.108/relay/0?turn=toggle
  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "source": "http"

nachher: 17:33:26.221
Dauer: 34 msec phName: 'shelly-40:'Thomas Büro Licht''


Thomas Büro Licht (/srv/www/viehai/shelly/log_scenarios/2024/03/06/_1.log)

vorher: 17:33:26.199

http://192.168.12.140/relay/0?turn=toggle
  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "source": "http"

nachher: 17:33:26.269
Dauer: 70 msec phName: 'shelly-40:'Thomas Büro Licht''


scenario: 'Büro UM-schalten' - 'buero_UM' - 'buero_um'

urls : 2
vorher : 17:33:26.169
nachher: 17:33:26.275
Dauer : 106 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/06//scene_buero_UM_20240306_173326.txt'


syslog

Mar  6 17:30:01 srv4hai CRON[8878]: (root) CMD ([ -x /etc/init.d/anacron ] && if [ ! -d /run/systemd/system ]; then /usr/sbin/invoke-rc.d anacron start >/dev/null; fi)
Mar  6 17:30:01 srv4hai CRON[8877]: (root) CMD (/etc/linetest/linetest.sh)
Mar  6 17:30:01 srv4hai CRON[8879]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Mar  6 17:30:01 srv4hai meter.sh: SHELLY meter.sh started
Mar  6 17:30:09 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:12 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:14 srv4hai meter.sh: SHELLY 'shelly-37/Wetter 1':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:17 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:19 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:22 srv4hai meter.sh: SHELLY 'shelly-58/Werkstatt Licht':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:23 srv4hai systemd[1]: Started Run anacron jobs.
Mar  6 17:30:23 srv4hai anacron[9288]: Anacron 2.3 started on 2024-03-06
Mar  6 17:30:23 srv4hai anacron[9288]: Normal exit (0 jobs run)
Mar  6 17:30:23 srv4hai systemd[1]: anacron.service: Succeeded.
Mar  6 17:30:25 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:27 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:30 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:32 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:35 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:37 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:40 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:42 srv4hai meter.sh: SHELLY 'shelly-47/47-plus1-Test':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:45 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:48 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:51 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:53 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:56 srv4hai meter.sh: SHELLY 'shelly-43/43-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:30:58 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:31:01 srv4hai meter.sh: SHELLY 'shelly-45/45-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar  6 17:31:01 srv4hai meter.sh: SHELLY meter.sh ended
Mar  6 17:31:01 srv4hai CRON[9417]: (root) CMD (/etc/linetest/linetest.sh)
Mar  6 17:31:01 srv4hai postfix/pickup[1332]: 3639560244: uid=33 from=
Mar  6 17:31:01 srv4hai postfix/cleanup[9415]: 3639560244: message-id=<20240306163101.3639560244@mail.viehai.at>
Mar  6 17:31:01 srv4hai postfix/qmgr[28610]: 3639560244: from=, size=654, nrcpt=1 (queue active)
Mar  6 17:31:01 srv4hai postfix/local[9422]: 3639560244: to=, orig_to=, relay=local, delay=0.06, delays=0.03/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar  6 17:31:01 srv4hai postfix/qmgr[28610]: 3639560244: removed
Mar  6 17:31:50 srv4hai postfix/smtpd[9433]: connect from unknown[193.222.96.70]
Mar  6 17:31:50 srv4hai postfix/smtpd[9433]: warning: unknown[193.222.96.70]: SASL LOGIN authentication failed: Invalid authentication mechanism
Mar  6 17:31:50 srv4hai postfix/smtpd[9433]: disconnect from unknown[193.222.96.70] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4
Mar  6 17:31:53 srv4hai activate_scenario[9436]: SHELLY scenario: 'LOG_kommen(log_kommen)' started
Mar  6 17:31:53 srv4hai activate_scenario[9436]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-03:'Licht Vorzimmer'
Mar  6 17:31:53 srv4hai activate_scenario[9436]: SHELLY scenario: 'LOG_kommen(log_kommen)' TO BE EXECUTED, shelly-03:'Licht Vorzimmer'
Mar  6 17:31:53 srv4hai activate_scenario[9436]: SHELLY scenario: 'LOG_kommen(log_kommen)' took 6 msec, shelly-03:'Licht Vorzimmer'
Mar  6 17:31:53 srv4hai dhcpd[5037]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Mar  6 17:31:53 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Mar  6 17:31:53 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Mar  6 17:31:53 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.61
Mar  6 17:31:53 srv4hai dhcpd[5037]: execute_statement argv[2] = fpThomas
Mar  6 17:31:53 srv4hai common[9502]: SHELLY common.sh inkludiert
Mar  6 17:31:53 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Mar  6 17:31:53 srv4hai common[9514]: SHELLY common.sh inkludiert
Mar  6 17:31:53 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Mar  6 17:31:53 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Mar  6 17:31:53 srv4hai named[14530]: client @0x7fc3200dae40 192.168.12.252#56359/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar  6 17:31:53 srv4hai named[14530]: client @0x7fc32810f2a0 192.168.12.252#46655/key rndc-key: signer "rndc-key" approved
Mar  6 17:31:53 srv4hai named[14530]: client @0x7fc32810f2a0 192.168.12.252#46655/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Mar  6 17:31:53 srv4hai named[14530]: client @0x7fc32810f2a0 192.168.12.252#46655/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Mar  6 17:31:53 srv4hai named[14530]: client @0x7fc32810f2a0 192.168.12.252#46655/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Mar  6 17:31:53 srv4hai named[14530]: client @0x7fc32810f2a0 192.168.12.252#46655/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Mar  6 17:31:53 srv4hai dhcpd[5037]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Mar  6 17:31:53 srv4hai named[14530]: client @0x7fc31c0b2820 192.168.12.252#39223/key rndc-key: signer "rndc-key" approved
Mar  6 17:31:53 srv4hai named[14530]: client @0x7fc31c0b2820 192.168.12.252#39223/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Mar  6 17:31:53 srv4hai named[14530]: client @0x7fc31c0b2820 192.168.12.252#39223/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.
Mar  6 17:31:53 srv4hai dhcpd[5037]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Mar  6 17:31:53 srv4hai ping_SP[9514]: SHELLY ping_SP.sh started from smartphone
Mar  6 17:32:00 srv4hai common[9535]: SHELLY common.sh inkludiert
Mar  6 17:32:01 srv4hai CRON[9547]: (root) CMD (/etc/linetest/linetest.sh)
Mar  6 17:32:03 srv4hai common[9564]: SHELLY common.sh inkludiert
Mar  6 17:32:04 srv4hai check_presence[9564]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and /srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Mar  6 17:32:04 srv4hai check_presence[9564]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Mar  6 17:32:04 srv4hai check_presence[9564]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Mar  6 17:32:04 srv4hai check_presence[9564]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/IP) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Mar  6 17:32:04 srv4hai check_presence[9564]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Mar  6 17:32:04 srv4hai activate_scenario[9614]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Mar  6 17:32:04 srv4hai activate_scenario[9614]: SHELLY dayState='day' <--> DayTime=unchecked NightTime=checked - phoneName:'0'
Mar  6 17:32:04 srv4hai activate_scenario[9614]: SHELLY scenario: 'vorraumOn(vorraumon)' NOT EXECUTED, phoneName:'0'
Mar  6 17:32:04 srv4hai postfix/pickup[1332]: 1DB6E60244: uid=33 from=
Mar  6 17:32:04 srv4hai postfix/cleanup[9415]: 1DB6E60244: message-id=<20240306163204.1DB6E60244@mail.viehai.at>
Mar  6 17:32:04 srv4hai ping_SP[9514]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
Mar  6 17:32:04 srv4hai postfix/qmgr[28610]: 1DB6E60244: from=, size=10100, nrcpt=1 (queue active)
Mar  6 17:32:05 srv4hai postfix/relay/smtp[9668]: 1DB6E60244: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=0.96, delays=0.01/0.01/0.54/0.4, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as B6183800C3)
Mar  6 17:32:05 srv4hai postfix/qmgr[28610]: 1DB6E60244: removed
Mar  6 17:32:06 srv4hai ping_SP[9514]: SHELLY - new process for '192.168.12.61' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1709742726
Mar  6 17:32:10 srv4hai bt_scan[9535]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / fixAddr: '192.168.12.61;' - found: 'Yes'
Mar  6 17:32:10 srv4hai bt_scan[9535]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Mar  6 17:32:20 srv4hai ping_SP[9514]: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1709742740 - 'ping_SP_0'
Mar  6 17:32:20 srv4hai ping_SP[9514]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar  6 17:32:49 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Mar  6 17:32:50 srv4hai fetchmail[1651]: 39371 messages (39370 seen) for tmiglinci at mail.akis.at (-1042178090 octets).
Mar  6 17:32:50 srv4hai postfix/smtpd[9433]: connect from localhost[127.0.0.1]
Mar  6 17:32:50 srv4hai postfix/smtpd[9433]: ED7176011E: client=localhost[127.0.0.1]
Mar  6 17:32:51 srv4hai postfix/cleanup[9415]: ED7176011E: message-id=<20240306163204.1DB6E60244@mail.viehai.at>
Mar  6 17:32:51 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:39371 of 39371 (11059 octets) not flushed
Mar  6 17:32:51 srv4hai postfix/qmgr[28610]: ED7176011E: from=, size=11368, nrcpt=1 (queue active)
Mar  6 17:32:51 srv4hai postfix/local[9740]: ED7176011E: to=, relay=local, delay=0.06, delays=0.05/0.01/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar  6 17:32:51 srv4hai postfix/qmgr[28610]: ED7176011E: removed
Mar  6 17:32:51 srv4hai postfix/smtpd[9433]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Mar  6 17:32:51 srv4hai fetchmail[1651]: 9971 messages (9971 seen) for srozum at mail.akis.at (1205697533 octets).
Mar  6 17:32:52 srv4hai fetchmail[1651]: 22047 messages (22047 seen) for mrozum at mail.akis.at (-491157114 octets).
Mar  6 17:32:52 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Mar  6 17:33:01 srv4hai CRON[9743]: (root) CMD (/etc/linetest/linetest.sh)
Mar  6 17:33:26 srv4hai activate_scenario[9764]: SHELLY scenario: 'buero_UM(buero_um)' started
Mar  6 17:33:26 srv4hai activate_scenario[9764]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'

finished