activate_scenario.sh
Thu Jul 11 18:38:58 CEST 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/07/11/_0.log)

vorher: 18:38:58.614

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: 18:38:58.666
Dauer: 52 msec phName: 'shelly-40:'Thomas Büro Licht''


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

vorher: 18:38:58.636

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: 18:38:58.686
Dauer: 49 msec phName: 'shelly-40:'Thomas Büro Licht''


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

urls : 2
vorher : 18:38:58.565
nachher: 18:38:58.692
Dauer : 129 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/07/11//scene_buero_UM_20240711_183858.txt'


syslog

Jul 11 18:35:01 srv4hai CRON[2338]: (root) CMD (/etc/linetest/linetest.sh)
Jul 11 18:36:01 srv4hai CRON[2394]: (root) CMD (/etc/linetest/linetest.sh)
Jul 11 18:36:13 srv4hai linetest.sh: ping to '95.129.201.1' failed
Jul 11 18:36:13 srv4hai ownCloud[20667]: [b478b9df-7487-4bf9-95b8-19221bb7f33e][192.168.12.252][miglincit][no app in context][GET][/remote.php/webdav/support/linetest/status.php] File with name support/linetest/status.php could not be located
Jul 11 18:36:14 srv4hai postfix/pickup[25929]: 3330A6018B: uid=0 from=
Jul 11 18:36:14 srv4hai postfix/cleanup[2428]: 3330A6018B: message-id=<20240711163614.3330A6018B@mail.viehai.at>
Jul 11 18:36:14 srv4hai postfix/qmgr[8566]: 3330A6018B: from=, size=629, nrcpt=1 (queue active)
Jul 11 18:36:14 srv4hai postfix/local[2434]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jul 11 18:36:14 srv4hai postfix/local[2434]: 3330A6018B: to=, orig_to=, relay=local, delay=0.03, delays=0.02/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jul 11 18:36:14 srv4hai postfix/qmgr[8566]: 3330A6018B: removed
Jul 11 18:36:45 srv4hai postfix/anvil[2084]: statistics: max connection rate 1/60s for (smtp:94.154.35.194) at Jul 11 18:33:25
Jul 11 18:36:45 srv4hai postfix/anvil[2084]: statistics: max connection count 1 for (smtp:94.154.35.194) at Jul 11 18:33:25
Jul 11 18:36:45 srv4hai postfix/anvil[2084]: statistics: max cache size 1 at Jul 11 18:33:25
Jul 11 18:37:01 srv4hai CRON[2480]: (root) CMD (/etc/linetest/linetest.sh)
Jul 11 18:37:25 srv4hai common[2509]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jul 11 18:37:25 srv4hai bt_scan[2509]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Jul 11 18:37:25 srv4hai bt_scan[2509]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Jul 11 18:37:25 srv4hai common[2543]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jul 11 18:37:25 srv4hai ping_SP[2543]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jul 11 18:37:25 srv4hai common[2565]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jul 11 18:37:25 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'0'=1720715845-1720715845
Jul 11 18:37:25 srv4hai check_presence[2565]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY} and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jul 11 18:37:26 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'1'=1720715846-1720715845
Jul 11 18:37:26 srv4hai check_presence[2565]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jul 11 18:37:26 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_not_set' dweetAge:'1'=1720715846-1720715845
Jul 11 18:37:26 srv4hai check_presence[2565]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_2.Yes
Jul 11 18:37:26 srv4hai check_presence[2565]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(__/__) (__/__) (__/__)' - anyPresent: 'false' - otherPresent:'false'
Jul 11 18:37:26 srv4hai postfix/pickup[25929]: 139776018B: uid=33 from=
Jul 11 18:37:26 srv4hai postfix/cleanup[2428]: 139776018B: message-id=<20240711163726.139776018B@mail.viehai.at>
Jul 11 18:37:26 srv4hai postfix/qmgr[8566]: 139776018B: from=, size=3912, nrcpt=1 (queue active)
Jul 11 18:37:26 srv4hai named[30406]: resolver priming query complete
Jul 11 18:37:26 srv4hai check_presence[2565]: SHELLY - check 'coming': anyPresent(false) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
Jul 11 18:37:26 srv4hai check_presence[2565]: SHELLY (ping_SP__bt_scan)-(0)-coming: NOT activate_scenario.shtml: vorraumOn
Jul 11 18:37:26 srv4hai ping_SP[2543]: SHELLY check_presence.sh coming 0 ping_SP__bt_scan
Jul 11 18:37:26 srv4hai ping_SP[2543]: SHELLY - new process for '192.168.12.61' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1720715846
Jul 11 18:37:27 srv4hai postfix/relay/smtp[2677]: 139776018B: to=, relay=mx02.nic.name[209.131.158.56]:25, delay=1, delays=0.01/0.02/0.71/0.3, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as E37C6800AF)
Jul 11 18:37:27 srv4hai postfix/qmgr[8566]: 139776018B: removed
Jul 11 18:37:37 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jul 11 18:37:37 srv4hai fetchmail[1651]: 48477 messages (48477 seen) for tmiglinci at mail.akis.at (-293860132 octets).
Jul 11 18:37:38 srv4hai fetchmail[1651]: 10436 messages (10436 seen) for srozum at mail.akis.at (1252342608 octets).
Jul 11 18:37:38 srv4hai fetchmail[1651]: 24688 messages (24688 seen) for mrozum at mail.akis.at (26166417 octets).
Jul 11 18:37:39 srv4hai fetchmail[1651]: 1139 messages (1139 seen) for admin@bastelstube.wien at pop3.world4you.com (51570784 octets).
Jul 11 18:37:40 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jul 11 18:37:40 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jul 11 18:37:40 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 11 18:37:40 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jul 11 18:37:40 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jul 11 18:37:40 srv4hai common[2722]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 11 18:37:42 srv4hai ping_SP[2543]: SHELLY (0)- ping 192.168.12.61 0 not answered (1) @~1720715862 - 'ping_SP_0'
Jul 11 18:37:50 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jul 11 18:37:50 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jul 11 18:37:50 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jul 11 18:37:50 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 11 18:37:50 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jul 11 18:37:50 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jul 11 18:37:50 srv4hai common[2764]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 11 18:37:51 srv4hai named[30406]: resolver priming query complete
Jul 11 18:38:00 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jul 11 18:38:00 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jul 11 18:38:00 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jul 11 18:38:00 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 11 18:38:00 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jul 11 18:38:00 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jul 11 18:38:00 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 11 18:38:00 srv4hai common[2796]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 11 18:38:01 srv4hai CRON[2813]: (root) CMD (/etc/linetest/linetest.sh)
Jul 11 18:38:05 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1720715885 - 'ping_SP_0'
Jul 11 18:38:05 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 11 18:38:10 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jul 11 18:38:10 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jul 11 18:38:10 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jul 11 18:38:10 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jul 11 18:38:10 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jul 11 18:38:10 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jul 11 18:38:10 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 11 18:38:10 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#55677/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 11 18:38:10 srv4hai common[2846]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jul 11 18:38:20 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jul 11 18:38:20 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jul 11 18:38:20 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: signer "rndc-key" approved
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jul 11 18:38:20 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: signer "rndc-key" approved
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jul 11 18:38:20 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: signer "rndc-key" approved
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jul 11 18:38:20 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: signer "rndc-key" approved
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jul 11 18:38:20 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: signer "rndc-key" approved
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/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.
Jul 11 18:38:20 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: signer "rndc-key" approved
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/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.
Jul 11 18:38:20 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: signer "rndc-key" approved
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/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.
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: signer "rndc-key" approved
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jul 11 18:38:20 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#36541/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.
Jul 11 18:38:20 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jul 11 18:38:20 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jul 11 18:38:39 srv4hai named[30406]: resolver priming query complete
Jul 11 18:38:58 srv4hai activate_scenario[2907]: SHELLY scenario: 'buero_UM(buero_um)' started
Jul 11 18:38:58 srv4hai activate_scenario[2907]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'

finished