activate_scenario.sh
Wed Jan 3 08:09:57 CET 2024
scenario: nasszeile_um

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

scenario: 'Nasszeile UM-schalten' - 'nasszeile_um' - 'nasszeile_um'

Küche Licht Naßzeile (/srv/www/viehai/shelly/log_scenarios/2024/01/03/scene_nasszeile_um_20240103_080957_0.log)

vorher: 08:09:57.328

http://192.168.12.116/white/0?turn=toggle&brightness=25
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 25,
  "transition": 0,
  "power": 0,
  "overpower": false

nachher: 08:09:57.359
Dauer: 31 msec


Küche Licht Naßzeile (/srv/www/viehai/shelly/log_scenarios/2024/01/03/scene_nasszeile_um_20240103_080957_1.log)

vorher: 08:09:57.346

http://192.168.12.116/white/1?turn=toggle&brightness=25
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 25,
  "transition": 0,
  "power": 0,
  "overpower": false

nachher: 08:09:57.373
Dauer: 27 msec


scenario: 'Nasszeile UM-schalten' - 'nasszeile_um' - 'nasszeile_um'

urls : 2
vorher : 08:09:57.289
nachher: 08:09:57.380
Dauer : 93 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/03/scene_nasszeile_um_20240103_080957.txt'


syslog

Jan  3 08:06:01 srv4hai CRON[9564]: (root) CMD (/etc/linetest/linetest.sh)
Jan  3 08:06:32 srv4hai named[14530]: resolver priming query complete
Jan  3 08:06:38 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan  3 08:06:38 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan  3 08:06:54 srv4hai dhcpd[1107]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  3 08:06:54 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  3 08:06:54 srv4hai dhcpd[1107]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan  3 08:06:54 srv4hai dhcpd[1107]: execute_statement argv[1] = 192.168.12.61
Jan  3 08:06:54 srv4hai dhcpd[1107]: execute_statement argv[2] = fpTom
Jan  3 08:06:54 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpTom'
Jan  3 08:06:54 srv4hai dhcpd[1107]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan  3 08:06:54 srv4hai dhcpd[1107]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  3 08:06:54 srv4hai named[14530]: client @0x7fc32865edd0 192.168.12.252#57769/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpTom.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  3 08:06:54 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  3 08:06:54 srv4hai named[14530]: client @0x7fc328693a30 192.168.12.252#46763/key rndc-key: signer "rndc-key" approved
Jan  3 08:06:54 srv4hai named[14530]: client @0x7fc328693a30 192.168.12.252#46763/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' TXT
Jan  3 08:06:54 srv4hai named[14530]: client @0x7fc328693a30 192.168.12.252#46763/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan  3 08:06:54 srv4hai named[14530]: client @0x7fc328693a30 192.168.12.252#46763/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' A
Jan  3 08:06:54 srv4hai named[14530]: client @0x7fc328693a30 192.168.12.252#46763/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' A 192.168.12.61
Jan  3 08:06:54 srv4hai dhcpd[1107]: Added new forward map from fpTom.viehai.at to 192.168.12.61
Jan  3 08:06:54 srv4hai named[14530]: resolver priming query complete
Jan  3 08:06:54 srv4hai named[14530]: client @0x7fc32000a250 192.168.12.252#36451/key rndc-key: signer "rndc-key" approved
Jan  3 08:06:54 srv4hai named[14530]: client @0x7fc32000a250 192.168.12.252#36451/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jan  3 08:06:54 srv4hai named[14530]: client @0x7fc32000a250 192.168.12.252#36451/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpTom.viehai.at.
Jan  3 08:06:54 srv4hai dhcpd[1107]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpTom.viehai.at
Jan  3 08:06:54 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1704265614
Jan  3 08:06:54 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'false/no ping, false/no IP, false/no IP,' - anyPresent: 'false'
Jan  3 08:06:54 srv4hai check_presence.sh: SHELLY (0)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  3 08:06:55 srv4hai named[14530]: resolver priming query complete
Jan  3 08:06:56 srv4hai named[14530]: resolver priming query complete
Jan  3 08:07:00 srv4hai activate_scenario.sh: SHELLY scenario: 'LOG_kommen(log_kommen)' TO BE EXECUTED
Jan  3 08:07:00 srv4hai postfix/pickup[2462]: 23A2460244: uid=33 from=
Jan  3 08:07:00 srv4hai postfix/cleanup[9656]: 23A2460244: message-id=<20240103070700.23A2460244@mail.viehai.at>
Jan  3 08:07:00 srv4hai activate_scenario.sh: SHELLY scenario: 'LOG_kommen(log_kommen)' took 6 msec
Jan  3 08:07:00 srv4hai postfix/qmgr[28610]: 23A2460244: from=, size=5592, nrcpt=1 (queue active)
Jan  3 08:07:00 srv4hai named[14530]: resolver priming query complete
Jan  3 08:07:01 srv4hai postfix/relay/smtp[9672]: 23A2460244: to=, relay=mx02.nic.name[209.131.158.56]:25, delay=1.2, delays=0.02/0.01/0.89/0.24, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 1C9D92007F)
Jan  3 08:07:01 srv4hai postfix/qmgr[28610]: 23A2460244: removed
Jan  3 08:07:01 srv4hai CRON[9677]: (root) CMD (/etc/linetest/linetest.sh)
Jan  3 08:07:04 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704265624 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  3 08:07:06 srv4hai bt_scan.sh: SHELLY - phoneName: 'FP4_Thomas' / '0'
Jan  3 08:07:06 srv4hai bt_scan.sh: SHELLY - ping_SP.sh started for BTmac: '0'
Jan  3 08:07:06 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  3 08:07:06 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'scanBT/no ping, false/no IP, false/no IP,' - anyPresent: 'true'
Jan  3 08:07:06 srv4hai check_presence.sh: SHELLY (0)-coming: activate_scenario.shtml: test_41_ON
Jan  3 08:07:06 srv4hai ping_SP.sh: SHELLY - running process: '9592' - '/srv/www/viehai/shelly//meter/ping_SP_0' - exiting
Jan  3 08:07:06 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_ON(test_41_on)' TO BE EXECUTED
Jan  3 08:07:06 srv4hai postfix/pickup[2462]: A1DD160244: uid=33 from=
Jan  3 08:07:06 srv4hai postfix/cleanup[9656]: A1DD160244: message-id=<20240103070706.A1DD160244@mail.viehai.at>
Jan  3 08:07:06 srv4hai postfix/qmgr[28610]: A1DD160244: from=, size=7314, nrcpt=1 (queue active)
Jan  3 08:07:06 srv4hai postfix/local[9779]: A1DD160244: to=, orig_to=, relay=local, delay=0.05, delays=0.01/0.01/0/0.03, dsn=5.1.1, status=bounced (unknown user: "null")
Jan  3 08:07:06 srv4hai postfix/cleanup[9656]: ADF9C60245: message-id=<20240103070706.ADF9C60245@mail.viehai.at>
Jan  3 08:07:06 srv4hai postfix/bounce[9786]: A1DD160244: sender non-delivery notification: ADF9C60245
Jan  3 08:07:06 srv4hai postfix/qmgr[28610]: ADF9C60245: from=<>, size=9193, nrcpt=1 (queue active)
Jan  3 08:07:06 srv4hai postfix/qmgr[28610]: A1DD160244: removed
Jan  3 08:07:06 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=on&brightness=25'
Jan  3 08:07:06 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/03/scene_test_41_ON_20240103_080706_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=on&brightness=25' - phName:'0'
Jan  3 08:07:06 srv4hai postfix/local[9779]: ADF9C60245: to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan  3 08:07:06 srv4hai postfix/qmgr[28610]: ADF9C60245: removed
Jan  3 08:07:06 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_ON(test_41_on)' took 85 msec
Jan  3 08:07:06 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status'
Jan  3 08:07:06 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.141","rssi":-45},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"08:07","unixtime":1704265627,"serial":1,"has_update":false,"mac":"349454723B21","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"lights":[{"ison":true,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":25,"transition":0}],"meters":[{"power":0.00,"overpower":0.00,"is_valid":true, "timestamp":1704269227,"counters":[0.000, 0.000, 0.000],"total":42}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":41.43,"tF":106.58, "is_valid":true},"calibrated":true,"calib_progress":0,"calib_status":0,"calib_running":0,"wire_mode":1,"forced_neutral":false,"overtemperature":false,"loaderror":0,"overpower":false,"debug":0,"update":{"status":"idle","has_update":false,"new_version":"20230913-114008/v1.14.0-gcb84623","old_version":"20230913-1140
Jan  3 08:07:14 srv4hai ping_SP.sh: SHELLY  (0) - pinging 192.168.12.61 1 sucessfully  @~1704265634 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  3 08:07:25 srv4hai named[14530]: resolver priming query complete
Jan  3 08:07:32 srv4hai named[14530]: resolver priming query complete
Jan  3 08:07:38 srv4hai named[14530]: resolver priming query complete
Jan  3 08:07:42 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan  3 08:07:42 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan  3 08:07:42 srv4hai named[14530]: resolver priming query complete
Jan  3 08:07:44 srv4hai ping_SP.sh: SHELLY  (0) - pinging 192.168.12.61 0 sucessfully  @~1704265664 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  3 08:07:59 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:00 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:01 srv4hai CRON[9852]: (root) CMD (/etc/linetest/linetest.sh)
Jan  3 08:08:04 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:06 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:08 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:11 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:15 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:15 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:15 srv4hai ping_SP.sh: SHELLY  (0) - pinging 192.168.12.61 0 sucessfully  @~1704265695 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  3 08:08:17 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:19 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:20 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:24 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:25 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:32 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:33 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:36 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:41 srv4hai named[14530]: resolver priming query complete
Jan  3 08:08:45 srv4hai ping_SP.sh: SHELLY  (0) - pinging 192.168.12.61 0 sucessfully  @~1704265725 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  3 08:08:46 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan  3 08:08:46 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan  3 08:09:01 srv4hai CRON[9895]: (root) CMD (/etc/linetest/linetest.sh)
Jan  3 08:09:01 srv4hai CRON[9896]: (root) CMD (  [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi)
Jan  3 08:09:01 srv4hai systemd[1]: Starting Clean php session files...
Jan  3 08:09:01 srv4hai systemd[1]: phpsessionclean.service: Succeeded.
Jan  3 08:09:01 srv4hai systemd[1]: Started Clean php session files.
Jan  3 08:09:16 srv4hai ping_SP.sh: SHELLY  (0) - pinging 192.168.12.61 0 sucessfully  @~1704265756 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  3 08:09:29 srv4hai named[14530]: resolver priming query complete
Jan  3 08:09:32 srv4hai named[14530]: resolver priming query complete
Jan  3 08:09:35 srv4hai named[14530]: resolver priming query complete
Jan  3 08:09:46 srv4hai named[14530]: resolver priming query complete
Jan  3 08:09:46 srv4hai ping_SP.sh: SHELLY  (0) - pinging 192.168.12.61 0 sucessfully  @~1704265786 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  3 08:09:49 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan  3 08:09:49 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0

finished