activate_scenario.sh
Fri Jun 7 23:35:19 CEST 2024
scenario: bedlight_tom
source: 192.168.12.112

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

scenario: 'Nachttischlampe Thomas UM-schalten' - 'bedlight_tom' - 'bedlight_tom'

Nachtkästchen Lampe Thomas (/srv/www/viehai/shelly/log_scenarios/2024/06/07/_0.log)

vorher: 23:35:19.893

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

nachher: 23:35:19.933
Dauer: 41 msec phName: 'shelly-12:'Schlafzimmer Licht''


scenario: 'Nachttischlampe Thomas UM-schalten' - 'bedlight_tom' - 'bedlight_tom'

urls : 1
vorher : 23:35:19.856
nachher: 23:35:19.939
Dauer : 86 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/06/07//scene_bedlight_tom_20240607_233519.txt'


syslog

Jun  7 23:32:00 srv4hai postfix/relay/smtp[7594]: E230D60197: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=1.3, delays=0.02/0.01/0.9/0.32, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as E000680093)
Jun  7 23:32:00 srv4hai postfix/qmgr[31004]: E230D60197: removed
Jun  7 23:32:01 srv4hai CRON[7633]: (root) CMD (/etc/linetest/linetest.sh)
Jun  7 23:32:05 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jun  7 23:32:05 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jun  7 23:32:05 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jun  7 23:32:05 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jun  7 23:32:05 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jun  7 23:32:05 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jun  7 23:32:05 srv4hai common[7648]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jun  7 23:32:15 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jun  7 23:32:15 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jun  7 23:32:15 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jun  7 23:32:15 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jun  7 23:32:15 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jun  7 23:32:15 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jun  7 23:32:15 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jun  7 23:32:15 srv4hai common[7673]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jun  7 23:32:25 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jun  7 23:32:25 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jun  7 23:32:25 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jun  7 23:32:25 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jun  7 23:32:25 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Jun  7 23:32:25 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Jun  7 23:32:25 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jun  7 23:32:25 srv4hai named[30406]: client @0x7f93480deab0 192.168.12.252#45529/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jun  7 23:32:25 srv4hai common[7707]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jun  7 23:32:27 srv4hai ping_SP[2876]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1717795947 - 'ping_SP_1'
Jun  7 23:32:27 srv4hai ping_SP[2876]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jun  7 23:32:35 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jun  7 23:32:35 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jun  7 23:32:35 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: signer "rndc-key" approved
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: signer "rndc-key" approved
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jun  7 23:32:35 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jun  7 23:32:35 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: signer "rndc-key" approved
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: signer "rndc-key" approved
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jun  7 23:32:35 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jun  7 23:32:35 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: signer "rndc-key" approved
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/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.
Jun  7 23:32:35 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: signer "rndc-key" approved
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/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.
Jun  7 23:32:35 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: signer "rndc-key" approved
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/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.
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: signer "rndc-key" approved
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jun  7 23:32:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#56109/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.
Jun  7 23:32:35 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jun  7 23:32:35 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jun  7 23:33:01 srv4hai CRON[7750]: (root) CMD (/etc/linetest/linetest.sh)
Jun  7 23:33:40 srv4hai ping_SP[2876]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1717796020 - 'ping_SP_1'
Jun  7 23:33:40 srv4hai ping_SP[2876]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jun  7 23:33:44 srv4hai named[30406]: validating chat.signal.org/CNAME: no valid signature found
Jun  7 23:33:54 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=7808, secured, session=
Jun  7 23:33:54 srv4hai dovecot: imap(miglincit)<7808>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jun  7 23:34:01 srv4hai CRON[7812]: (root) CMD (/etc/linetest/linetest.sh)
Jun  7 23:34:36 srv4hai postfix/smtpd[7832]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jun  7 23:34:36 srv4hai postfix/smtpd[7832]: connect from unknown[194.169.175.212]
Jun  7 23:34:37 srv4hai postfix/smtpd[7832]: warning: unknown[194.169.175.212]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jun  7 23:34:37 srv4hai postfix/smtpd[7832]: disconnect from unknown[194.169.175.212] ehlo=1 auth=0/1 quit=1 commands=2/3
Jun  7 23:34:53 srv4hai ping_SP[2876]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1717796093 - 'ping_SP_1'
Jun  7 23:34:53 srv4hai ping_SP[2876]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jun  7 23:35:01 srv4hai CRON[7863]: (root) CMD (/etc/linetest/linetest.sh)
Jun  7 23:35:05 srv4hai common[7871]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jun  7 23:35:15 srv4hai bt_scan[7871]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Jun  7 23:35:15 srv4hai bt_scan[7871]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Jun  7 23:35:15 srv4hai common[7911]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jun  7 23:35:16 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1717796116-1717796106
Jun  7 23:35:16 srv4hai check_presence[7911]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jun  7 23:35:16 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'10'=1717796116-1717796106
Jun  7 23:35:16 srv4hai check_presence[7911]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jun  7 23:35:16 srv4hai check_presence[7911]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Jun  7 23:35:16 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1717796116-1717796106
Jun  7 23:35:16 srv4hai check_presence[7911]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jun  7 23:35:16 srv4hai check_presence[7911]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/__) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jun  7 23:35:16 srv4hai check_presence[7911]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_vorraumOn) - sceneOFF(offAll)
Jun  7 23:35:16 srv4hai check_presence[7911]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Jun  7 23:35:19 srv4hai activate_scenario[8064]: SHELLY scenario: 'bedlight_tom(bedlight_tom)' started
Jun  7 23:35:19 srv4hai activate_scenario[8064]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-12:'Schlafzimmer Licht'

finished