activate_scenario.sh
Tue Jan 2 19:28:02 CET 2024
scenario: test_41_OFF
phoneName: NONE

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

scenario: 'test 41 AUS' - 'test_41_OFF' - 'test_41_off'

41-TBD-Dimmer (/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_192802_0.log)

vorher: 19:28:02.306

http://192.168.12.141/light/0?turn=off&brightness=50
  "ison": false,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 50,
  "transition": 0

nachher: 19:28:02.338
Dauer: 31 msec phName: 'NONE'


scenario: 'test 41 AUS' - 'test_41_OFF' - 'test_41_off'

urls : 1
vorher : 19:28:02.253
nachher: 19:28:02.345
Dauer : 93 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_192802.txt'


syslog

Jan  2 19:25:00 srv4hai sntp[23695]: sntp 4.2.8p12@1.3728-o (1)
Jan  2 19:25:00 srv4hai sntp[23695]: 2024-01-02 19:25:00.903460 (-0100) -0.001255 +/- 0.000928 time.google.com 216.239.35.0 s1 no-leap
Jan  2 19:25:01 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704219901 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:25:01 srv4hai CRON[23703]: (root) CMD (/etc/linetest/linetest.sh)
Jan  2 19:25:12 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704219912 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:25:14 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 1 not answered (1) @~1704219914 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:25:24 srv4hai systemd[1]: Started Session 976162 of user root.
Jan  2 19:25:27 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 2 not answered (1) @~1704219927 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:25:27 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 3 not answered - aborting (23680) @~1704219927 - rm '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:25:27 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:25:27 srv4hai check_presence.sh: SHELLY (0)-presence: activate_scenario.shtml: test_41_OFF
Jan  2 19:25:27 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' TO BE EXECUTED
Jan  2 19:25:27 srv4hai postfix/pickup[2387]: 4D05B6011E: uid=33 from=
Jan  2 19:25:27 srv4hai postfix/cleanup[23614]: 4D05B6011E: message-id=<20240102182527.4D05B6011E@mail.viehai.at>
Jan  2 19:25:27 srv4hai postfix/qmgr[28610]: 4D05B6011E: from=, size=32259, nrcpt=1 (queue active)
Jan  2 19:25:27 srv4hai postfix/local[23628]: 4D05B6011E: to=, orig_to=, relay=local, delay=0.03, delays=0.02/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan  2 19:25:27 srv4hai postfix/cleanup[23614]: 5280160244: message-id=<20240102182527.5280160244@mail.viehai.at>
Jan  2 19:25:27 srv4hai postfix/bounce[23631]: 4D05B6011E: sender non-delivery notification: 5280160244
Jan  2 19:25:27 srv4hai postfix/qmgr[28610]: 5280160244: from=<>, size=34138, nrcpt=1 (queue active)
Jan  2 19:25:27 srv4hai postfix/qmgr[28610]: 4D05B6011E: removed
Jan  2 19:25:27 srv4hai postfix/local[23628]: 5280160244: 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  2 19:25:27 srv4hai postfix/qmgr[28610]: 5280160244: removed
Jan  2 19:25:27 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=off&brightness=50'
Jan  2 19:25:27 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_192527_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=off&brightness=50' - phName:'NONE'
Jan  2 19:25:27 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' took 101 msec
Jan  2 19:25:27 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status'
Jan  2 19:25:27 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.141","rssi":-55},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"19:25","unixtime":1704219928,"serial":1,"has_update":false,"mac":"349454723B21","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"lights":[{"ison":false,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":50,"transition":0}],"meters":[{"power":0.00,"overpower":0.00,"is_valid":true, "timestamp":1704223528,"counters":[0.000, 0.000, 0.000],"total":36}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":44.66,"tF":112.38, "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-114
Jan  2 19:25:27 srv4hai dhcpd[1612]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:25:27 srv4hai dhcpd[1612]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:25:27 srv4hai dhcpd[1612]: execute_statement argv[0] = /usr/bin/curl
Jan  2 19:25:27 srv4hai dhcpd[1612]: execute_statement argv[1] = http://viehai.at/shelly/smartphone.shtml?phoneIP=192.168.12.61&phoneName=fpTom
Jan  2 19:25:27 srv4hai named[14530]: client @0x7fc3286414b0 192.168.12.252#53625/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpTom.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  2 19:25:27 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpTom'
Jan  2 19:25:27 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  2 19:25:27 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1704219927
Jan  2 19:25:27 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:25:27 srv4hai check_presence.sh: SHELLY (0)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  2 19:25:30 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704219930 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:25:33 srv4hai bt_scan.sh: SHELLY - phoneName: 'S20_Grete' / '1'
Jan  2 19:25:42 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704219942 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:25:43 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 1 not answered (1) @~1704219943 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:25:46 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=23910, secured, session=<5EGGoPoNDOkAAAAAAAAAAAAAAAAAAAAB>
Jan  2 19:25:46 srv4hai dovecot: imap(rozums)<23910><5EGGoPoNDOkAAAAAAAAAAAAAAAAAAAAB>: Logged out in=93 out=1021 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan  2 19:25:56 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 2 not answered (1) @~1704219956 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:25:56 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 3 not answered - aborting (23853) @~1704219956 - rm '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:25:56 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:25:56 srv4hai check_presence.sh: SHELLY (0)-presence: activate_scenario.shtml: test_41_OFF
Jan  2 19:25:56 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' TO BE EXECUTED
Jan  2 19:25:56 srv4hai postfix/pickup[2387]: C96AF6011E: uid=33 from=
Jan  2 19:25:56 srv4hai postfix/cleanup[23614]: C96AF6011E: message-id=<20240102182556.C96AF6011E@mail.viehai.at>
Jan  2 19:25:56 srv4hai postfix/qmgr[28610]: C96AF6011E: from=, size=37818, nrcpt=1 (queue active)
Jan  2 19:25:56 srv4hai postfix/local[23628]: C96AF6011E: to=, orig_to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan  2 19:25:56 srv4hai postfix/cleanup[23614]: CD5B160244: message-id=<20240102182556.CD5B160244@mail.viehai.at>
Jan  2 19:25:56 srv4hai postfix/bounce[23631]: C96AF6011E: sender non-delivery notification: CD5B160244
Jan  2 19:25:56 srv4hai postfix/qmgr[28610]: CD5B160244: from=<>, size=39697, nrcpt=1 (queue active)
Jan  2 19:25:56 srv4hai postfix/qmgr[28610]: C96AF6011E: removed
Jan  2 19:25:56 srv4hai postfix/local[23628]: CD5B160244: to=, relay=local, delay=0.03, delays=0.01/0/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan  2 19:25:56 srv4hai postfix/qmgr[28610]: CD5B160244: removed
Jan  2 19:25:56 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=off&brightness=50'
Jan  2 19:25:56 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_192556_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=off&brightness=50' - phName:'NONE'
Jan  2 19:25:56 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' took 91 msec
Jan  2 19:25:56 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status'
Jan  2 19:25:56 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.141","rssi":-58},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"19:25","unixtime":1704219957,"serial":1,"has_update":false,"mac":"349454723B21","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"lights":[{"ison":false,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":50,"transition":0}],"meters":[{"power":0.00,"overpower":0.00,"is_valid":true, "timestamp":1704223557,"counters":[0.000, 0.000, 0.000],"total":36}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":44.58,"tF":112.24, "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-114
Jan  2 19:25:56 srv4hai dhcpd[1612]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:25:56 srv4hai dhcpd[1612]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:25:56 srv4hai dhcpd[1612]: execute_statement argv[0] = /usr/bin/curl
Jan  2 19:25:56 srv4hai dhcpd[1612]: execute_statement argv[1] = http://viehai.at/shelly/smartphone.shtml?phoneIP=192.168.12.61&phoneName=fpTom
Jan  2 19:25:56 srv4hai named[14530]: client @0x7fc3180354e0 192.168.12.252#54487/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpTom.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  2 19:25:56 srv4hai named[14530]: client @0x7fc3286414b0 192.168.12.252#53625/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpTom.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  2 19:25:57 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpTom'
Jan  2 19:25:57 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  2 19:25:57 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1704219957
Jan  2 19:25:57 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:25:57 srv4hai check_presence.sh: SHELLY (0)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  2 19:25:59 srv4hai systemd[1]: Stopping LSB: DHCP server...
Jan  2 19:25:59 srv4hai isc-dhcp-server[24057]: Stopping ISC DHCPv4 server: dhcpd.
Jan  2 19:25:59 srv4hai systemd[1]: isc-dhcp-server.service: Succeeded.
Jan  2 19:25:59 srv4hai systemd[1]: Stopped LSB: DHCP server.
Jan  2 19:25:59 srv4hai systemd[1]: isc-dhcp-server.service: Found left-over process 1612 (dhcpd) in control group while starting unit. Ignoring.
Jan  2 19:25:59 srv4hai systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Jan  2 19:25:59 srv4hai systemd[1]: isc-dhcp-server.service: Found left-over process 24016 (curl) in control group while starting unit. Ignoring.
Jan  2 19:25:59 srv4hai systemd[1]: This usually indicates unclean termination of a previous run, or service implementation deficiencies.
Jan  2 19:25:59 srv4hai systemd[1]: Starting LSB: DHCP server...
Jan  2 19:25:59 srv4hai isc-dhcp-server[24070]: Launching IPv4 server only.
Jan  2 19:25:59 srv4hai dhcpd[24083]: Wrote 0 deleted host decls to leases file.
Jan  2 19:25:59 srv4hai dhcpd[24083]: Wrote 0 new dynamic host decls to leases file.
Jan  2 19:25:59 srv4hai dhcpd[24083]: Wrote 1 leases to leases file.
Jan  2 19:25:59 srv4hai dhcpd[24083]: Server starting service.
Jan  2 19:26:00 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704219960 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:26:01 srv4hai CRON[24089]: (root) CMD (/etc/linetest/linetest.sh)
Jan  2 19:26:01 srv4hai isc-dhcp-server[24070]: Starting ISC DHCPv4 server: dhcpd.
Jan  2 19:26:01 srv4hai systemd[1]: Started LSB: DHCP server.
Jan  2 19:26:05 srv4hai dhcpd[24083]: DHCPREQUEST for 192.168.12.30 from e8:78:29:c0:c2:4e via enp2s0: lease 192.168.12.30 unavailable.
Jan  2 19:26:05 srv4hai dhcpd[24083]: DHCPNAK on 192.168.12.30 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:26:05 srv4hai dhcpd[24083]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:26:05 srv4hai dhcpd[24083]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:26:05 srv4hai dhcpd[24083]: execute_statement argv[0] = /usr/bin/curl
Jan  2 19:26:05 srv4hai dhcpd[24083]: execute_statement argv[1] = http://viehai.at/shelly/smartphone.shtml?phoneIP=192.168.12.61&phoneName=fpTom
Jan  2 19:26:05 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpTom'
Jan  2 19:26:05 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  2 19:26:05 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:26:05 srv4hai check_presence.sh: SHELLY (0)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  2 19:26:05 srv4hai ping_SP.sh: SHELLY - running process: '24034' - '/srv/www/viehai/shelly//meter/ping_SP_0' - exiting
Jan  2 19:26:05 srv4hai dhcpd[24083]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:26:05 srv4hai dhcpd[24083]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:26:05 srv4hai named[14530]: client @0x7fc32810f2a0 192.168.12.252#37259/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpTom.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  2 19:26:05 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#34609/key rndc-key: signer "rndc-key" approved
Jan  2 19:26:05 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#34609/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' TXT
Jan  2 19:26:05 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#34609/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan  2 19:26:05 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#34609/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' A
Jan  2 19:26:05 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#34609/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' A 192.168.12.61
Jan  2 19:26:05 srv4hai dhcpd[24083]: Added new forward map from fpTom.viehai.at to 192.168.12.61
Jan  2 19:26:05 srv4hai named[14530]: client @0x7fc3240092c0 192.168.12.252#53183/key rndc-key: signer "rndc-key" approved
Jan  2 19:26:05 srv4hai named[14530]: client @0x7fc3240092c0 192.168.12.252#53183/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jan  2 19:26:05 srv4hai named[14530]: client @0x7fc3240092c0 192.168.12.252#53183/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  2 19:26:05 srv4hai dhcpd[24083]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpTom.viehai.at
Jan  2 19:26:10 srv4hai ping_SP.sh: SHELLY  (0) - pinging 192.168.12.61 1 sucessfully  @~1704219970 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:26:12 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704219972 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:26:34 srv4hai dhcpd[24083]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:26:34 srv4hai dhcpd[24083]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:26:43 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704220003 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:26:47 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=24173, secured, session=
Jan  2 19:26:47 srv4hai dovecot: imap(rozums)<24173>: Logged out in=93 out=1021 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan  2 19:26:50 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704220010 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:27:01 srv4hai CRON[24181]: (root) CMD (/etc/linetest/linetest.sh)
Jan  2 19:27:03 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 1 not answered (1) @~1704220023 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:27:03 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=24190, secured, session=
Jan  2 19:27:03 srv4hai dovecot: imap(miglincit)<24190>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan  2 19:27:13 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704220033 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:27:16 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 2 not answered (1) @~1704220036 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:27:16 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 3 not answered - aborting (24034) @~1704220036 - rm '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:27:16 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:27:16 srv4hai check_presence.sh: SHELLY (0)-presence: activate_scenario.shtml: test_41_OFF
Jan  2 19:27:16 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' TO BE EXECUTED
Jan  2 19:27:16 srv4hai postfix/pickup[2387]: 684746011E: uid=33 from=
Jan  2 19:27:16 srv4hai postfix/cleanup[23614]: 684746011E: message-id=<20240102182716.684746011E@mail.viehai.at>
Jan  2 19:27:16 srv4hai postfix/qmgr[28610]: 684746011E: from=, size=26980, nrcpt=1 (queue active)
Jan  2 19:27:16 srv4hai postfix/local[23628]: 684746011E: to=, orig_to=, relay=local, delay=0.04, delays=0.03/0/0/0, dsn=5.1.1, status=bounced (unknown user: "null")
Jan  2 19:27:16 srv4hai postfix/cleanup[23614]: 6A97460244: message-id=<20240102182716.6A97460244@mail.viehai.at>
Jan  2 19:27:16 srv4hai postfix/bounce[23631]: 684746011E: sender non-delivery notification: 6A97460244
Jan  2 19:27:16 srv4hai postfix/qmgr[28610]: 6A97460244: from=<>, size=28859, nrcpt=1 (queue active)
Jan  2 19:27:16 srv4hai postfix/qmgr[28610]: 684746011E: removed
Jan  2 19:27:16 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=off&brightness=50'
Jan  2 19:27:16 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_192716_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=off&brightness=50' - phName:'NONE'
Jan  2 19:27:16 srv4hai postfix/local[23628]: 6A97460244: to=, relay=local, delay=0.02, delays=0.01/0/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan  2 19:27:16 srv4hai postfix/qmgr[28610]: 6A97460244: removed
Jan  2 19:27:16 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' took 58 msec
Jan  2 19:27:16 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status'
Jan  2 19:27:16 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.141","rssi":-54},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"19:27","unixtime":1704220037,"serial":1,"has_update":false,"mac":"349454723B21","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"lights":[{"ison":false,"source":"http","has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"mode":"white","brightness":50,"transition":0}],"meters":[{"power":0.00,"overpower":0.00,"is_valid":true, "timestamp":1704223637,"counters":[0.000, 0.000, 0.000],"total":36}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":44.50,"tF":112.10, "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-114
Jan  2 19:27:32 srv4hai dhcpd[24083]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:27:32 srv4hai dhcpd[24083]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:27:32 srv4hai dhcpd[24083]: execute_statement argv[0] = /usr/bin/curl
Jan  2 19:27:32 srv4hai dhcpd[24083]: execute_statement argv[1] = http://viehai.at/shelly/smartphone.shtml?phoneIP=192.168.12.61&phoneName=fpTom
Jan  2 19:27:32 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpTom'
Jan  2 19:27:32 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  2 19:27:32 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1704220052
Jan  2 19:27:32 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:27:32 srv4hai check_presence.sh: SHELLY (0)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  2 19:27:35 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704220055 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:27:43 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704220063 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:27:49 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 1 not answered (1) @~1704220069 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:27:56 srv4hai bt_scan.sh: SHELLY - phoneName: 'iP_Sophie' / '2'
Jan  2 19:27:57 srv4hai bt_scan.sh: SHELLY - ping_SP.sh started for BTmac: '2'
Jan  2 19:27:57 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  2 19:27:57 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_2' @~1704220077
Jan  2 19:27:57 srv4hai check_presence.sh: SHELLY (2) what: 'coming' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:27:57 srv4hai check_presence.sh: SHELLY (2)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  2 19:28:00 srv4hai ping_SP.sh: SHELLY  (2)- pinging 192.168.12.63 0 not answered (1) @~1704220080 - '/srv/www/viehai/shelly//meter/ping_SP_2'
Jan  2 19:28:01 srv4hai CRON[24409]: (root) CMD (/etc/linetest/linetest.sh)
Jan  2 19:28:02 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 2 not answered (1) @~1704220082 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:28:02 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 3 not answered - aborting (24327) @~1704220082 - rm '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:28:02 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:28:02 srv4hai check_presence.sh: SHELLY (0)-presence: activate_scenario.shtml: test_41_OFF

finished