activate_scenario.sh
Mon Aug 26 07:34:39 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/08/26/_0.log)

vorher: 07:34:40.093

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: 07:34:40.146
Dauer: 53 msec phName: 'shelly-40:'Thomas Büro Licht''


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

vorher: 07:34:40.110

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: 07:34:40.166
Dauer: 56 msec phName: 'shelly-40:'Thomas Büro Licht''


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

urls : 2
vorher : 07:34:40.061
nachher: 07:34:40.172
Dauer : 112 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/08/26//scene_buero_UM_20240826_073439.txt'


syslog

Aug 26 07:31:01 srv4hai CRON[11154]: (root) CMD (/etc/linetest/linetest.sh)
Aug 26 07:31:03 srv4hai postfix/anvil[10077]: statistics: max connection rate 1/60s for (smtp:185.208.158.123) at Aug 26 07:27:42
Aug 26 07:31:03 srv4hai postfix/anvil[10077]: statistics: max connection count 1 for (smtp:185.208.158.123) at Aug 26 07:27:42
Aug 26 07:31:03 srv4hai postfix/anvil[10077]: statistics: max cache size 1 at Aug 26 07:27:42
Aug 26 07:31:06 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Aug 26 07:31:06 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 26 07:31:07 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug 26 07:31:07 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug 26 07:31:07 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug 26 07:31:07 srv4hai common[11160]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug 26 07:31:17 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug 26 07:31:17 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug 26 07:31:17 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 26 07:31:17 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug 26 07:31:17 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug 26 07:31:17 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug 26 07:31:17 srv4hai common[11182]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug 26 07:31:27 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug 26 07:31:27 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug 26 07:31:27 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 26 07:31:27 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug 26 07:31:27 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug 26 07:31:27 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug 26 07:31:27 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 26 07:31:27 srv4hai common[11206]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug 26 07:31:31 srv4hai ping_SP[3140]: SHELLY (0)- ping 192.168.12.61 1 not answered (1) @~1724650291 - 'ping_SP_0'
Aug 26 07:31:32 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=11233, secured, session=
Aug 26 07:31:32 srv4hai dovecot: imap(miglincit)<11233>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug 26 07:31:37 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug 26 07:31:37 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug 26 07:31:37 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 26 07:31:37 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug 26 07:31:37 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug 26 07:31:37 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug 26 07:31:37 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 26 07:31:37 srv4hai named[30406]: client @0x7f93506b28d0 192.168.12.252#41965/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 26 07:31:37 srv4hai common[11242]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug 26 07:31:47 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug 26 07:31:47 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug 26 07:31:47 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: signer "rndc-key" approved
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: signer "rndc-key" approved
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug 26 07:31:47 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: signer "rndc-key" approved
Aug 26 07:31:47 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: signer "rndc-key" approved
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug 26 07:31:47 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug 26 07:31:47 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: signer "rndc-key" approved
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/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 26 07:31:47 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: signer "rndc-key" approved
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/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 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: signer "rndc-key" approved
Aug 26 07:31:47 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/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 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: signer "rndc-key" approved
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug 26 07:31:47 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#36347/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 26 07:31:47 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug 26 07:31:47 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug 26 07:31:54 srv4hai ping_SP[3140]: SHELLY (0) - ping 192.168.12.61 2 sucessfully  @~1724650314 - 'ping_SP_0'
Aug 26 07:31:54 srv4hai ping_SP[3140]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Aug 26 07:32:01 srv4hai CRON[11291]: (root) CMD (/etc/linetest/linetest.sh)
Aug 26 07:32:04 srv4hai ping_SP[5729]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1724650324 - 'ping_SP_1'
Aug 26 07:32:04 srv4hai ping_SP[5729]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug 26 07:32:07 srv4hai systemd[1]: Started Run anacron jobs.
Aug 26 07:32:07 srv4hai anacron[11310]: Anacron 2.3 started on 2024-08-26
Aug 26 07:32:07 srv4hai anacron[11310]: Will run job `cron.daily' in 5 min.
Aug 26 07:32:07 srv4hai anacron[11310]: Jobs will be executed sequentially
Aug 26 07:32:22 srv4hai common[11312]: SHELLY common.sh inkludiert von ./bt_scan.sh
Aug 26 07:32:32 srv4hai bt_scan[11312]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Aug 26 07:32:32 srv4hai bt_scan[11312]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Aug 26 07:32:32 srv4hai common[11344]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug 26 07:32:33 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'11'=1724650353-1724650342
Aug 26 07:32:33 srv4hai check_presence[11344]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug 26 07:32:33 srv4hai check_presence[11344]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Aug 26 07:32:33 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'11'=1724650353-1724650342
Aug 26 07:32:33 srv4hai check_presence[11344]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Aug 26 07:32:33 srv4hai check_presence[11344]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Aug 26 07:32:33 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'11'=1724650353-1724650342
Aug 26 07:32:33 srv4hai check_presence[11344]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug 26 07:32:33 srv4hai check_presence[11344]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug 26 07:32:33 srv4hai check_presence[11344]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_offAll) - sceneOFF(offAll)
Aug 26 07:32:33 srv4hai check_presence[11344]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Aug 26 07:33:01 srv4hai CRON[11498]: (root) CMD (/etc/linetest/linetest.sh)
Aug 26 07:33:02 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Aug 26 07:33:03 srv4hai fetchmail[1651]: 50804 messages (50804 seen) for tmiglinci at mail.akis.at (-93032181 octets).
Aug 26 07:33:04 srv4hai fetchmail[1651]: 10624 messages (10624 seen) for srozum at mail.akis.at (1280838447 octets).
Aug 26 07:33:04 srv4hai fetchmail[1651]: 25521 messages (25521 seen) for mrozum at mail.akis.at (155268787 octets).
Aug 26 07:33:05 srv4hai fetchmail[1651]: 1141 messages (1141 seen) for admin@bastelstube.wien at pop3.world4you.com (51598561 octets).
Aug 26 07:33:07 srv4hai ping_SP[3140]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1724650387 - 'ping_SP_0'
Aug 26 07:33:07 srv4hai ping_SP[3140]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Aug 26 07:33:17 srv4hai ping_SP[5729]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1724650397 - 'ping_SP_1'
Aug 26 07:33:17 srv4hai ping_SP[5729]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug 26 07:33:29 srv4hai common[11542]: SHELLY common.sh inkludiert von ./bt_scan.sh
Aug 26 07:33:39 srv4hai bt_scan[11542]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Aug 26 07:33:39 srv4hai bt_scan[11542]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Aug 26 07:33:41 srv4hai named[30406]: resolver priming query complete
Aug 26 07:34:01 srv4hai CRON[11579]: (root) CMD (/etc/linetest/linetest.sh)
Aug 26 07:34:20 srv4hai ping_SP[3140]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1724650460 - 'ping_SP_0'
Aug 26 07:34:20 srv4hai ping_SP[3140]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Aug 26 07:34:31 srv4hai ping_SP[5729]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1724650471 - 'ping_SP_1'
Aug 26 07:34:31 srv4hai ping_SP[5729]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug 26 07:34:32 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=11625, secured, session=<5onMeo8gJuEAAAAAAAAAAAAAAAAAAAAB>
Aug 26 07:34:32 srv4hai dovecot: imap(miglincit)<11625><5onMeo8gJuEAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug 26 07:34:40 srv4hai activate_scenario[11628]: SHELLY scenario: 'buero_UM(buero_um)' started
Aug 26 07:34:40 srv4hai activate_scenario[11628]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'

finished