activate_scenario.sh
Sat Jan 27 17:33:11 CET 2024
scenario: tvlampTOGGLE
source: 192.168.12.105

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

scenario: 'TV Licht UM-schalten' - 'tvlampTOGGLE' - 'tvlamptoggle'

Fernsehlampe klein (/srv/www/viehai/shelly/log_scenarios/2024/01/27/_0.log)

vorher: 17:33:11.588

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

nachher: 17:33:11.638
Dauer: 50 msec phName: 'shelly-05:'Stehlampe Anne hell''

Fernsehlampe groß (/srv/www/viehai/shelly/log_scenarios/2024/01/27/_1.log)

vorher: 17:33:11.612

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

nachher: 17:33:11.652
Dauer: 39 msec phName: 'shelly-05:'Stehlampe Anne hell''

scenario: 'TV Licht UM-schalten' - 'tvlampTOGGLE' - 'tvlamptoggle'

urls : 2
vorher : 17:33:11.536
nachher: 17:33:11.658
Dauer : 123 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/27//scene_tvlampTOGGLE_20240127_173311.txt'

syslog

Jan 27 17:30:01 srv4hai CRON[16102]: (root) CMD ([ -x /etc/init.d/anacron ] && if [ ! -d /run/systemd/system ]; then /usr/sbin/invoke-rc.d anacron start >/dev/null; fi)
Jan 27 17:30:01 srv4hai CRON[16101]: (root) CMD (/etc/linetest/linetest.sh)
Jan 27 17:30:01 srv4hai CRON[16103]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Jan 27 17:30:01 srv4hai meter.sh: SHELLY meter.sh started
Jan 27 17:30:12 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706373012 - 'ping_SP_0'
Jan 27 17:30:26 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1706373026 - 'ping_SP_1'
Jan 27 17:30:37 srv4hai dhcpd[5037]: DHCPDISCOVER from c0:49:ef:8a:c9:d8 via enp2s0
Jan 27 17:30:37 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jan 27 17:30:37 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 27 17:30:37 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.139
Jan 27 17:30:37 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-39
Jan 27 17:30:37 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.139 (192.168.12.252) from c0:49:ef:8a:c9:d8 via enp2s0
Jan 27 17:30:37 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jan 27 17:30:37 srv4hai named[14530]: client @0x7fc32869f410 192.168.12.252#55257/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-39.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 27 17:30:37 srv4hai named[14530]: client @0x7fc31c0739e0 192.168.12.252#54291/key rndc-key: signer "rndc-key" approved
Jan 27 17:30:37 srv4hai named[14530]: client @0x7fc31c0739e0 192.168.12.252#54291/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' TXT
Jan 27 17:30:37 srv4hai named[14530]: client @0x7fc31c0739e0 192.168.12.252#54291/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' TXT "314be662bb43914e78b269d3f3bc9f38c7"
Jan 27 17:30:37 srv4hai named[14530]: client @0x7fc31c0739e0 192.168.12.252#54291/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' A
Jan 27 17:30:37 srv4hai named[14530]: client @0x7fc31c0739e0 192.168.12.252#54291/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' A 192.168.12.139
Jan 27 17:30:37 srv4hai dhcpd[5037]: Added new forward map from shelly-39.viehai.at to 192.168.12.139
Jan 27 17:30:37 srv4hai named[14530]: client @0x7fc328693a30 192.168.12.252#51789/key rndc-key: signer "rndc-key" approved
Jan 27 17:30:37 srv4hai named[14530]: client @0x7fc328693a30 192.168.12.252#51789/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '139.12.168.192.in-addr.arpa' PTR
Jan 27 17:30:37 srv4hai named[14530]: client @0x7fc328693a30 192.168.12.252#51789/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '139.12.168.192.in-addr.arpa' PTR shelly-39.viehai.at.
Jan 27 17:30:37 srv4hai dhcpd[5037]: Added reverse map from 139.12.168.192.in-addr.arpa. to shelly-39.viehai.at
Jan 27 17:30:37 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-39' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jan 27 17:30:38 srv4hai ht_shelly.sh: SHELLY - working dir '/srv/www/viehai/shelly/wetter/2024/01'
Jan 27 17:30:38 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: gen=2&temp=7.300000&hum=54.100000&id=C049EF8AC9D8&batt=100&volt=6.710000
Jan 27 17:30:38 srv4hai ht_shelly.sh: SHELLY id  => macID: '8A:C9:D8'
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-39' 'conf(0)' - 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}'
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-39' 'conf(0)' - 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}'
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-cmd: 'curl --connect-timeout 3 --silent -X -POST -d 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}' http://192.168.12.139/rpc | jq -r '.''
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-cmd: 'curl --connect-timeout 3 --silent -X -POST -d 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}' http://192.168.12.139/rpc | jq -r '.''
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jan 27 17:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Jan 27 17:30:38 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 7.3° - 54.1%
Jan 27 17:30:38 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/01/shelly-39_20240127.csv'
Jan 27 17:30:38 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 7.3°/7.8° - 54.1%/52.1% - SAVED
Jan 27 17:30:38 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: batt='100'°
Jan 27 17:30:39 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: dweetIO='{#012  "this": "succeeded",#012  "by": "dweeting",#012  "the": "dweet",#012  "with": {#012    "thing": "viehai-39",#012    "created": "2024-01-27T16:30:39.412Z",#012    "content": {#012      "temp": 7.3,#012      "hum": 54.1,#012      "batt": 100#012    },#012    "transaction": "3b5bda46-90da-4530-8ae6-67417186464c"#012  }#012}'°
Jan 27 17:30:40 srv4hai bt_scan.sh: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' found: 'Yes'
Jan 27 17:30:40 srv4hai bt_scan.sh: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Jan 27 17:30:40 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan 27 17:30:40 srv4hai check_presence.sh: SHELLY (0) found './meter/ping_SP_0' more than one (1) line for what: 'coming'
Jan 27 17:30:40 srv4hai check_presence.sh: SHELLY (0) set what to 'presence'
Jan 27 17:30:40 srv4hai check_presence.sh: SHELLY (0) found './meter/ping_SP_1' more than one (1) line for what: 'presence'
Jan 27 17:30:40 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'scanBT/ping, scanBT/ping, false/no IP,' - anyPresent: 'true'
Jan 27 17:30:40 srv4hai check_presence.sh: SHELLY (0)-presence: NOT activate_scenario.shtml: offAll
Jan 27 17:30:40 srv4hai ping_SP.sh: SHELLY - running process-id(16539): '15121 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61#01216539 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61' - 'ping_SP_0' - exiting ==============
Jan 27 17:30:42 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706373042 - 'ping_SP_0'
Jan 27 17:30:57 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1706373057 - 'ping_SP_1'
Jan 27 17:31:01 srv4hai CRON[16661]: (root) CMD (/etc/linetest/linetest.sh)
Jan 27 17:31:12 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706373072 - 'ping_SP_0'
Jan 27 17:31:15 srv4hai meter.sh: SHELLY meter.sh ended
Jan 27 17:31:27 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1706373087 - 'ping_SP_1'
Jan 27 17:31:42 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706373102 - 'ping_SP_0'
Jan 27 17:31:57 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1706373117 - 'ping_SP_1'
Jan 27 17:31:58 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=16729, secured, session=
Jan 27 17:31:58 srv4hai dovecot: imap(miglincit)<16729>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 27 17:32:01 srv4hai CRON[16731]: (root) CMD (/etc/linetest/linetest.sh)
Jan 27 17:32:11 srv4hai bt_scan.sh: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' found: 'No'
Jan 27 17:32:11 srv4hai bt_scan.sh: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Jan 27 17:32:11 srv4hai check_presence.sh: SHELLY () found './meter/ping_SP_0' more than one (1) line for what: 'presence'
Jan 27 17:32:11 srv4hai check_presence.sh: SHELLY () found './meter/ping_SP_1' more than one (1) line for what: 'presence'
Jan 27 17:32:11 srv4hai check_presence.sh: SHELLY () what: 'presence' - persPresent: 'false/ping, scanBT/ping, false/no IP,' - anyPresent: 'true'
Jan 27 17:32:11 srv4hai check_presence.sh: SHELLY ()-presence: NOT activate_scenario.shtml: offAll
Jan 27 17:32:12 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706373132 - 'ping_SP_0'
Jan 27 17:32:28 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1706373148 - 'ping_SP_1'
Jan 27 17:32:35 srv4hai systemd[1]: Started Run anacron jobs.
Jan 27 17:32:35 srv4hai anacron[16795]: Anacron 2.3 started on 2024-01-27
Jan 27 17:32:35 srv4hai anacron[16795]: Normal exit (0 jobs run)
Jan 27 17:32:35 srv4hai systemd[1]: anacron.service: Succeeded.
Jan 27 17:32:42 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706373162 - 'ping_SP_0'
Jan 27 17:32:58 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1706373178 - 'ping_SP_1'
Jan 27 17:33:00 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan 27 17:33:00 srv4hai fetchmail[1651]: 36575 messages (36575 seen) for tmiglinci at mail.akis.at (-1250970813 octets).
Jan 27 17:33:01 srv4hai fetchmail[1651]: 9814 messages (9814 seen) for srozum at mail.akis.at (1186837137 octets).
Jan 27 17:33:01 srv4hai fetchmail[1651]: 21328 messages (21328 seen) for mrozum at mail.akis.at (-682167633 octets).
Jan 27 17:33:01 srv4hai CRON[16819]: (root) CMD (/etc/linetest/linetest.sh)
Jan 27 17:33:02 srv4hai fetchmail[1651]: 45 messages (45 seen) for admin@bastelstube.wien at pop3.world4you.com (12035480 octets).
Jan 27 17:33:08 srv4hai activate_scenario.sh: SHELLY scenario: 'tvlampTOGGLE(tvlamptoggle)' TO BE EXECUTED, shelly-05:'Stehlampe Anne hell'
Jan 27 17:33:08 srv4hai postfix/pickup[10853]: 8494A60244: uid=33 from=
Jan 27 17:33:08 srv4hai postfix/cleanup[16873]: 8494A60244: message-id=<20240127163308.8494A60244@mail.viehai.at>
Jan 27 17:33:08 srv4hai postfix/qmgr[28610]: 8494A60244: from=, size=11549, nrcpt=1 (queue active)
Jan 27 17:33:08 srv4hai activate_scenario.sh: SHELLY: 'shelly-06'-'Fernsehlampe klein' --> '0?turn=toggle'
Jan 27 17:33:08 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/27/_0.log' - shellyUsage:'Fernsehlampe klein' - scUrl:'http://192.168.12.106/relay/0?turn=toggle' - phName:'shelly-05:'Stehlampe Anne hell''
Jan 27 17:33:08 srv4hai postfix/local[16886]: 8494A60244: to=, orig_to=, relay=local, delay=0.09, delays=0.05/0.02/0/0.02, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 27 17:33:08 srv4hai postfix/cleanup[16873]: 9332B60245: message-id=<20240127163308.9332B60245@mail.viehai.at>
Jan 27 17:33:08 srv4hai postfix/bounce[16887]: 8494A60244: sender non-delivery notification: 9332B60245
Jan 27 17:33:08 srv4hai postfix/qmgr[28610]: 9332B60245: from=<>, size=13428, nrcpt=1 (queue active)
Jan 27 17:33:08 srv4hai postfix/qmgr[28610]: 8494A60244: removed
Jan 27 17:33:08 srv4hai activate_scenario.sh: SHELLY: 'shelly-19'-'Fernsehlampe groß' --> '0?turn=toggle'
Jan 27 17:33:08 srv4hai postfix/local[16886]: 9332B60245: to=, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 27 17:33:08 srv4hai postfix/qmgr[28610]: 9332B60245: removed
Jan 27 17:33:08 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/27/_1.log' - shellyUsage:'Fernsehlampe groß' - scUrl:'http://192.168.12.119/relay/0?turn=toggle' - phName:'shelly-05:'Stehlampe Anne hell''
Jan 27 17:33:08 srv4hai activate_scenario.sh: SHELLY scenario: 'tvlampTOGGLE(tvlamptoggle)' took 137 msec, shelly-05:'Stehlampe Anne hell'
Jan 27 17:33:08 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.119/status'
Jan 27 17:33:08 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.119","rssi":-75},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"17:33","unixtime":1706373189,"serial":1,"has_update":false,"mac":"98CDAC2D5A11","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":false,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"source":"http"}],"meters":[{"power":0.00,"is_valid":true}],"inputs":[{"input":0,"event":"","event_cnt":15}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"update":{"status":"idle","has_update":false,"new_version":"20230503-095514/v1.13.0-g9aed950","old_version":"20230503-095514/v1.13.0-g9aed950"},"ram_total":51688,"ram_free":40536,"fs_size":233681,"fs_free":150851,"uptime":22806393}'
Jan 27 17:33:08 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.106/status'
Jan 27 17:33:08 srv4hai proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.106","rssi":-72},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"17:33","unixtime":1706373189,"serial":1,"has_update":true,"mac":"E8DB84D23B46","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":false,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"source":"http"}],"meters":[{"power":0.00,"is_valid":true}],"inputs":[{"input":0,"event":"","event_cnt":1}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"update":{"status":"pending","has_update":true,"new_version":"20230913-112003/v1.14.0-gcb84623","old_version":"20230503-095514/v1.13.0-g9aed950","beta_version":"20231107-162940/v1.14.1-rc1-g0617c15"},"ram_total":51688,"ram_free":40948,"fs_size":233681,"fs_free":150349,"uptime":2299703}'

finished