activate_scenario.sh
Wed Jul 31 21:58:48 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/07/31/_0.log)

vorher: 21:58:48.701

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: 21:58:48.734
Dauer: 33 msec phName: 'shelly-12:'Schlafzimmer Licht''


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

urls : 1
vorher : 21:58:48.668
nachher: 21:58:48.741
Dauer : 73 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/07/31//scene_bedlight_tom_20240731_215848.txt'


syslog

Jul 31 21:55:01 srv4hai CRON[20822]: (root) CMD (/etc/linetest/linetest.sh)
Jul 31 21:55:06 srv4hai ping_SP[32727]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1722455706 - 'ping_SP_1'
Jul 31 21:55:06 srv4hai ping_SP[32727]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 31 21:55:19 srv4hai ping_SP[21729]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1722455719 - 'ping_SP_0'
Jul 31 21:55:19 srv4hai ping_SP[21729]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 31 21:55:41 srv4hai dhcpd[30731]: DHCPDISCOVER from f4:cf:a2:e3:b2:94 via enp2s0
Jul 31 21:55:41 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.101 to f4:cf:a2:e3:b2:94 via enp2s0
Jul 31 21:55:41 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jul 31 21:55:41 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.101
Jul 31 21:55:41 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-01
Jul 31 21:55:41 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.101 (192.168.12.252) from f4:cf:a2:e3:b2:94 via enp2s0
Jul 31 21:55:41 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.101 to f4:cf:a2:e3:b2:94 via enp2s0
Jul 31 21:55:41 srv4hai named[30406]: client @0x7f932c03e370 192.168.12.252#42777/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-01.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 31 21:55:41 srv4hai named[30406]: client @0x7f932c0c7f00 192.168.12.252#52285/key rndc-key: signer "rndc-key" approved
Jul 31 21:55:41 srv4hai named[30406]: client @0x7f932c0c7f00 192.168.12.252#52285/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' TXT
Jul 31 21:55:41 srv4hai named[30406]: client @0x7f932c0c7f00 192.168.12.252#52285/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' TXT "00c768089445c9f8f8e0a9ab6d602edfb6"
Jul 31 21:55:41 srv4hai named[30406]: client @0x7f932c0c7f00 192.168.12.252#52285/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' A
Jul 31 21:55:41 srv4hai named[30406]: client @0x7f932c0c7f00 192.168.12.252#52285/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' A 192.168.12.101
Jul 31 21:55:41 srv4hai dhcpd[30731]: Added new forward map from shelly-01.viehai.at to 192.168.12.101
Jul 31 21:55:41 srv4hai named[30406]: client @0x7f93480bd120 192.168.12.252#52965/key rndc-key: signer "rndc-key" approved
Jul 31 21:55:41 srv4hai named[30406]: client @0x7f93480bd120 192.168.12.252#52965/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '101.12.168.192.in-addr.arpa' PTR
Jul 31 21:55:41 srv4hai named[30406]: client @0x7f93480bd120 192.168.12.252#52965/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '101.12.168.192.in-addr.arpa' PTR shelly-01.viehai.at.
Jul 31 21:55:41 srv4hai dhcpd[30731]: Added reverse map from 101.12.168.192.in-addr.arpa. to shelly-01.viehai.at
Jul 31 21:55:41 srv4hai common[20905]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jul 31 21:55:41 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-01' - shIP/2:'' perform:'conf'
Jul 31 21:55:42 srv4hai mosquitto[18551]: New connection from 192.168.12.101 on port 1883.
Jul 31 21:55:42 srv4hai mosquitto[18551]: Client shelly1pm-F4CFA2E3B294 already connected, closing old connection.
Jul 31 21:55:42 srv4hai mosquitto[18551]: Socket error on client shelly1pm-F4CFA2E3B294, disconnecting.
Jul 31 21:55:42 srv4hai mosquitto[18551]: New client connected from 192.168.12.101 as shelly1pm-F4CFA2E3B294 (c1, k60, u'shmqtt').
Jul 31 21:55:42 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-01' - shIP/2:'192.168.12.101'
Jul 31 21:55:42 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wandlicht beim Esstisch' already set for '192.168.12.101'
Jul 31 21:55:43 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(0)' - allready transmitted - skipping
Jul 31 21:55:43 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(1)' - allready transmitted - skipping
Jul 31 21:55:43 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(2)' - allready transmitted - skipping
Jul 31 21:55:43 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(3)' - allready transmitted - skipping
Jul 31 21:55:43 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(4)' - allready transmitted - skipping
Jul 31 21:55:43 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(5)' - allready transmitted - skipping
Jul 31 21:55:43 srv4hai conf_shelly.sh: SHELLY:'shelly-01' out:0 ON : MISSING
Jul 31 21:55:43 srv4hai conf_shelly.sh: SHELLY:'shelly-01' out:0 OFF: MISSING
Jul 31 21:56:01 srv4hai CRON[21057]: (root) CMD (/etc/linetest/linetest.sh)
Jul 31 21:56:20 srv4hai ping_SP[32727]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1722455780 - 'ping_SP_1'
Jul 31 21:56:20 srv4hai ping_SP[32727]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 31 21:56:25 srv4hai postfix/anvil[20290]: statistics: max connection rate 2/60s for (smtp:178.215.236.184) at Jul 31 21:53:05
Jul 31 21:56:25 srv4hai postfix/anvil[20290]: statistics: max connection count 1 for (smtp:178.215.236.184) at Jul 31 21:52:29
Jul 31 21:56:25 srv4hai postfix/anvil[20290]: statistics: max cache size 1 at Jul 31 21:52:29
Jul 31 21:56:30 srv4hai nmbd[2172]: [2024/07/31 21:56:30.644972,  0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
Jul 31 21:56:30 srv4hai nmbd[2172]:   find_domain_master_name_query_fail:
Jul 31 21:56:30 srv4hai nmbd[2172]:   Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
Jul 31 21:56:30 srv4hai nmbd[2172]:   Unable to sync browse lists in this workgroup.
Jul 31 21:56:32 srv4hai ping_SP[21729]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1722455792 - 'ping_SP_0'
Jul 31 21:56:32 srv4hai ping_SP[21729]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 31 21:57:01 srv4hai CRON[21133]: (root) CMD (/etc/linetest/linetest.sh)
Jul 31 21:57:13 srv4hai named[30406]: validating adservfnt-eu.dsp-api.moloco.com/A: no valid signature found
Jul 31 21:57:33 srv4hai ping_SP[32727]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1722455853 - 'ping_SP_1'
Jul 31 21:57:33 srv4hai ping_SP[32727]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 31 21:57:45 srv4hai ping_SP[21729]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1722455865 - 'ping_SP_0'
Jul 31 21:57:45 srv4hai ping_SP[21729]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 31 21:57:55 srv4hai dhcpd[30731]: DHCPDISCOVER from f4:cf:a2:e3:b2:94 via enp2s0
Jul 31 21:57:55 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.101 to f4:cf:a2:e3:b2:94 via enp2s0
Jul 31 21:57:55 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jul 31 21:57:55 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.101
Jul 31 21:57:55 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-01
Jul 31 21:57:55 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.101 (192.168.12.252) from f4:cf:a2:e3:b2:94 via enp2s0
Jul 31 21:57:55 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.101 to f4:cf:a2:e3:b2:94 via enp2s0
Jul 31 21:57:55 srv4hai named[30406]: client @0x7f93480daa40 192.168.12.252#45585/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-01.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 31 21:57:55 srv4hai named[30406]: client @0x7f931001f430 192.168.12.252#50573/key rndc-key: signer "rndc-key" approved
Jul 31 21:57:55 srv4hai named[30406]: client @0x7f931001f430 192.168.12.252#50573/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' TXT
Jul 31 21:57:55 srv4hai named[30406]: client @0x7f931001f430 192.168.12.252#50573/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' TXT "00c768089445c9f8f8e0a9ab6d602edfb6"
Jul 31 21:57:55 srv4hai named[30406]: client @0x7f931001f430 192.168.12.252#50573/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' A
Jul 31 21:57:55 srv4hai named[30406]: client @0x7f931001f430 192.168.12.252#50573/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' A 192.168.12.101
Jul 31 21:57:55 srv4hai dhcpd[30731]: Added new forward map from shelly-01.viehai.at to 192.168.12.101
Jul 31 21:57:55 srv4hai named[30406]: client @0x7f931006ae50 192.168.12.252#53315/key rndc-key: signer "rndc-key" approved
Jul 31 21:57:55 srv4hai named[30406]: client @0x7f931006ae50 192.168.12.252#53315/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '101.12.168.192.in-addr.arpa' PTR
Jul 31 21:57:55 srv4hai named[30406]: client @0x7f931006ae50 192.168.12.252#53315/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '101.12.168.192.in-addr.arpa' PTR shelly-01.viehai.at.
Jul 31 21:57:55 srv4hai dhcpd[30731]: Added reverse map from 101.12.168.192.in-addr.arpa. to shelly-01.viehai.at
Jul 31 21:57:55 srv4hai common[21207]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jul 31 21:57:55 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-01' - shIP/2:'' perform:'conf'
Jul 31 21:57:57 srv4hai mosquitto[18551]: New connection from 192.168.12.101 on port 1883.
Jul 31 21:57:57 srv4hai mosquitto[18551]: Client shelly1pm-F4CFA2E3B294 already connected, closing old connection.
Jul 31 21:57:57 srv4hai mosquitto[18551]: Socket error on client shelly1pm-F4CFA2E3B294, disconnecting.
Jul 31 21:57:57 srv4hai mosquitto[18551]: New client connected from 192.168.12.101 as shelly1pm-F4CFA2E3B294 (c1, k60, u'shmqtt').
Jul 31 21:57:57 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-01' - shIP/2:'192.168.12.101'
Jul 31 21:57:57 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wandlicht beim Esstisch' already set for '192.168.12.101'
Jul 31 21:57:57 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(0)' - allready transmitted - skipping
Jul 31 21:57:57 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(1)' - allready transmitted - skipping
Jul 31 21:57:57 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(2)' - allready transmitted - skipping
Jul 31 21:57:57 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(3)' - allready transmitted - skipping
Jul 31 21:57:57 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(4)' - allready transmitted - skipping
Jul 31 21:57:57 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(5)' - allready transmitted - skipping
Jul 31 21:57:57 srv4hai conf_shelly.sh: SHELLY:'shelly-01' out:0 ON : MISSING
Jul 31 21:57:57 srv4hai conf_shelly.sh: SHELLY:'shelly-01' out:0 OFF: MISSING
Jul 31 21:58:01 srv4hai CRON[21349]: (root) CMD (/etc/linetest/linetest.sh)
Jul 31 21:58:26 srv4hai common[21366]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jul 31 21:58:36 srv4hai bt_scan[21366]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Jul 31 21:58:36 srv4hai bt_scan[21366]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Jul 31 21:58:36 srv4hai common[21402]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jul 31 21:58:37 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'11'=1722455917-1722455906
Jul 31 21:58:37 srv4hai check_presence[21402]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jul 31 21:58:37 srv4hai check_presence[21402]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Jul 31 21:58:37 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'11'=1722455917-1722455906
Jul 31 21:58:37 srv4hai check_presence[21402]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jul 31 21:58:37 srv4hai check_presence[21402]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Jul 31 21:58:37 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'11'=1722455917-1722455906
Jul 31 21:58:37 srv4hai check_presence[21402]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Jul 31 21:58:37 srv4hai check_presence[21402]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jul 31 21:58:37 srv4hai check_presence[21402]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_buero_UM) - sceneOFF(offAll)
Jul 31 21:58:37 srv4hai check_presence[21402]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Jul 31 21:58:41 srv4hai systemd[1]: Starting Certbot...
Jul 31 21:58:41 srv4hai systemd[1]: certbot.service: Succeeded.
Jul 31 21:58:41 srv4hai systemd[1]: Started Certbot.
Jul 31 21:58:47 srv4hai ping_SP[32727]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1722455927 - 'ping_SP_1'
Jul 31 21:58:47 srv4hai ping_SP[32727]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jul 31 21:58:48 srv4hai activate_scenario[21577]: SHELLY scenario: 'bedlight_tom(bedlight_tom)' started
Jul 31 21:58:48 srv4hai activate_scenario[21577]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-12:'Schlafzimmer Licht'

finished