activate_scenario.sh
Tue Jan 2 19:47:31 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_194731_0.log)

vorher: 19:47:31.446

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:47:31.474
Dauer: 29 msec phName: 'NONE'


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

urls : 1
vorher : 19:47:31.428
nachher: 19:47:31.481
Dauer : 53 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_194731.txt'


syslog

Jan  2 19:44:01 srv4hai CRON[28023]: (root) CMD (/etc/linetest/linetest.sh)
Jan  2 19:44:01 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704221041 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:44:14 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 1 not answered (1) @~1704221054 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:44:19 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704221059 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:44:26 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan  2 19:44:27 srv4hai fetchmail[1651]: 34782 messages (34782 seen) for tmiglinci at mail.akis.at (-1377658672 octets).
Jan  2 19:44:27 srv4hai fetchmail[1651]: 9721 messages (9721 seen) for srozum at mail.akis.at (1176841223 octets).
Jan  2 19:44:28 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 2 not answered (1) @~1704221068 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:44:28 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 3 not answered - aborting (28009) @~1704221068 - rm '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:44:28 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:44:28 srv4hai check_presence.sh: SHELLY (0)-presence: activate_scenario.shtml: test_41_OFF
Jan  2 19:44:28 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' TO BE EXECUTED
Jan  2 19:44:28 srv4hai postfix/pickup[2387]: 24D056011E: uid=33 from=
Jan  2 19:44:28 srv4hai postfix/cleanup[26283]: 24D056011E: message-id=<20240102184428.24D056011E@mail.viehai.at>
Jan  2 19:44:28 srv4hai postfix/qmgr[28610]: 24D056011E: from=, size=24774, nrcpt=1 (queue active)
Jan  2 19:44:28 srv4hai postfix/local[26294]: 24D056011E: to=, orig_to=, relay=local, delay=0.03, delays=0.02/0/0/0, dsn=5.1.1, status=bounced (unknown user: "null")
Jan  2 19:44:28 srv4hai postfix/cleanup[26283]: 285F360244: message-id=<20240102184428.285F360244@mail.viehai.at>
Jan  2 19:44:28 srv4hai postfix/bounce[26298]: 24D056011E: sender non-delivery notification: 285F360244
Jan  2 19:44:28 srv4hai postfix/qmgr[28610]: 285F360244: from=<>, size=26653, nrcpt=1 (queue active)
Jan  2 19:44:28 srv4hai postfix/qmgr[28610]: 24D056011E: removed
Jan  2 19:44:28 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=off&brightness=50'
Jan  2 19:44:28 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_194428_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=off&brightness=50' - phName:'NONE'
Jan  2 19:44:28 srv4hai postfix/local[26294]: 285F360244: to=, relay=local, delay=0.01, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan  2 19:44:28 srv4hai postfix/qmgr[28610]: 285F360244: removed
Jan  2 19:44:28 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' took 59 msec
Jan  2 19:44:28 srv4hai fetchmail[1651]: 20869 messages (20869 seen) for mrozum at mail.akis.at (-791114409 octets).
Jan  2 19:44:28 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status'
Jan  2 19:44:28 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:44","unixtime":1704221068,"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":1704224668,"counters":[0.000, 0.000, 5.758],"total":42}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":44.35,"tF":111.83, "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:44:28 srv4hai dhcpd[24585]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:28 srv4hai dhcpd[24585]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:28 srv4hai dhcpd[24585]: execute_statement argv[0] = /usr/bin/curl
Jan  2 19:44:28 srv4hai dhcpd[24585]: execute_statement argv[1] = http://viehai.at/shelly/smartphone.shtml?phoneIP=192.168.12.61&phoneName=fpTom
Jan  2 19:44:28 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpTom.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  2 19:44:28 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpTom'
Jan  2 19:44:28 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  2 19:44:28 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1704221068
Jan  2 19:44:28 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:44:28 srv4hai check_presence.sh: SHELLY (0)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  2 19:44:28 srv4hai fetchmail[1651]: 44 messages (44 seen) for admin@bastelstube.wien at pop3.world4you.com (12031668 octets).
Jan  2 19:44:31 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704221071 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:44:44 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 1 not answered (1) @~1704221084 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:44:49 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704221089 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:44:57 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 2 not answered (1) @~1704221097 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:44:57 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 3 not answered - aborting (28245) @~1704221097 - rm '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:44:57 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:44:57 srv4hai check_presence.sh: SHELLY (0)-presence: activate_scenario.shtml: test_41_OFF
Jan  2 19:44:57 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' TO BE EXECUTED
Jan  2 19:44:57 srv4hai postfix/pickup[2387]: A548B6011E: uid=33 from=
Jan  2 19:44:57 srv4hai postfix/cleanup[26283]: A548B6011E: message-id=<20240102184457.A548B6011E@mail.viehai.at>
Jan  2 19:44:57 srv4hai postfix/qmgr[28610]: A548B6011E: from=, size=30147, nrcpt=1 (queue active)
Jan  2 19:44:57 srv4hai postfix/local[26294]: A548B6011E: to=, orig_to=, relay=local, delay=0.02, delays=0.02/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan  2 19:44:57 srv4hai postfix/cleanup[26283]: A9E7160244: message-id=<20240102184457.A9E7160244@mail.viehai.at>
Jan  2 19:44:57 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=off&brightness=50'
Jan  2 19:44:57 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_194457_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=off&brightness=50' - phName:'NONE'
Jan  2 19:44:57 srv4hai postfix/bounce[26298]: A548B6011E: sender non-delivery notification: A9E7160244
Jan  2 19:44:57 srv4hai postfix/qmgr[28610]: A9E7160244: from=<>, size=32026, nrcpt=1 (queue active)
Jan  2 19:44:57 srv4hai postfix/qmgr[28610]: A548B6011E: removed
Jan  2 19:44:57 srv4hai postfix/local[26294]: A9E7160244: 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:44:57 srv4hai postfix/qmgr[28610]: A9E7160244: removed
Jan  2 19:44:57 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' took 68 msec
Jan  2 19:44:57 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status'
Jan  2 19:44:57 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.141","rssi":-53},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"19:44","unixtime":1704221098,"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":1704224698,"counters":[0.000, 0.000, 5.758],"total":42}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":44.35,"tF":111.83, "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:44:57 srv4hai dhcpd[24585]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpTom.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: Added new forward map from fpTom.viehai.at to 192.168.12.61
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: signer "rndc-key" approved
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' TXT
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' A
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' A 192.168.12.61
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: signer "rndc-key" approved
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' TXT
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' A
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' A 192.168.12.61
Jan  2 19:44:57 srv4hai dhcpd[24585]: Added new forward map from fpTom.viehai.at to 192.168.12.61
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: signer "rndc-key" approved
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/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:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/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:44:57 srv4hai dhcpd[24585]: Added new forward map from fpTom.viehai.at to 192.168.12.61
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: signer "rndc-key" approved
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' TXT
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' A
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' A 192.168.12.61
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpTom.viehai.at
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: signer "rndc-key" approved
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' TXT
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' A
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' A 192.168.12.61
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: signer "rndc-key" approved
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/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:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/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:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: signer "rndc-key" approved
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/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:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/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:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: Added new forward map from fpTom.viehai.at to 192.168.12.61
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: signer "rndc-key" approved
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/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:44:57 srv4hai dhcpd[24585]: Added new forward map from fpTom.viehai.at to 192.168.12.61
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/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:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/key rndc-key: signer "rndc-key" approved
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/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:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai named[14530]: client @0x7fc328650140 192.168.12.252#49737/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:44:57 srv4hai dhcpd[24585]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpTom.viehai.at
Jan  2 19:44:57 srv4hai dhcpd[24585]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpTom.viehai.at
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpTom.viehai.at
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:44:57 srv4hai dhcpd[24585]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpTom.viehai.at
Jan  2 19:45:01 srv4hai CRON[28411]: (root) CMD (/etc/linetest/linetest.sh)
Jan  2 19:45:03 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=28418, secured, session=
Jan  2 19:45:03 srv4hai dovecot: imap(miglincit)<28418>: 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:45:03 srv4hai dhcpd[24585]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:45:04 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:45:04 srv4hai dhcpd[24585]: execute_statement argv[0] = /usr/bin/curl
Jan  2 19:45:04 srv4hai dhcpd[24585]: execute_statement argv[1] = http://viehai.at/shelly/smartphone.shtml?phoneIP=192.168.12.61&phoneName=fpTom
Jan  2 19:45:04 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpTom'
Jan  2 19:45:04 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  2 19:45:04 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1704221104
Jan  2 19:45:04 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:45:04 srv4hai check_presence.sh: SHELLY (0)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  2 19:45:07 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704221107 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:45:20 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 1 not answered (1) @~1704221120 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:45:20 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704221120 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:45:33 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 2 not answered (1) @~1704221133 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:45:33 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 3 not answered - aborting (28437) @~1704221133 - rm '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:45:33 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:45:33 srv4hai check_presence.sh: SHELLY (0)-presence: activate_scenario.shtml: test_41_OFF
Jan  2 19:45:33 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' TO BE EXECUTED
Jan  2 19:45:33 srv4hai postfix/pickup[2387]: 6B1FC6011E: uid=33 from=
Jan  2 19:45:33 srv4hai postfix/cleanup[26283]: 6B1FC6011E: message-id=<20240102184533.6B1FC6011E@mail.viehai.at>
Jan  2 19:45:33 srv4hai postfix/qmgr[28610]: 6B1FC6011E: from=, size=44180, nrcpt=1 (queue active)
Jan  2 19:45:33 srv4hai postfix/local[26294]: 6B1FC6011E: 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:45:33 srv4hai postfix/cleanup[26283]: 6E10960244: message-id=<20240102184533.6E10960244@mail.viehai.at>
Jan  2 19:45:33 srv4hai postfix/bounce[26298]: 6B1FC6011E: sender non-delivery notification: 6E10960244
Jan  2 19:45:33 srv4hai postfix/qmgr[28610]: 6E10960244: from=<>, size=46059, nrcpt=1 (queue active)
Jan  2 19:45:33 srv4hai postfix/qmgr[28610]: 6B1FC6011E: removed
Jan  2 19:45:33 srv4hai postfix/local[26294]: 6E10960244: 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:45:33 srv4hai postfix/qmgr[28610]: 6E10960244: removed
Jan  2 19:45:33 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=off&brightness=50'
Jan  2 19:45:33 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_194533_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=off&brightness=50' - phName:'NONE'
Jan  2 19:45:33 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' took 75 msec
Jan  2 19:45:33 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status'
Jan  2 19:45:33 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.141","rssi":-53},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"19:45","unixtime":1704221134,"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":1704224734,"counters":[0.000, 0.000, 0.000],"total":42}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":44.27,"tF":111.69, "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:45:33 srv4hai dhcpd[24585]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:45:33 srv4hai dhcpd[24585]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:45:33 srv4hai dhcpd[24585]: execute_statement argv[0] = /usr/bin/curl
Jan  2 19:45:33 srv4hai dhcpd[24585]: execute_statement argv[1] = http://viehai.at/shelly/smartphone.shtml?phoneIP=192.168.12.61&phoneName=fpTom
Jan  2 19:45:33 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpTom'
Jan  2 19:45:33 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  2 19:45:33 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1704221133
Jan  2 19:45:33 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:45:33 srv4hai check_presence.sh: SHELLY (0)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  2 19:45:36 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704221136 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:45:49 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 1 not answered (1) @~1704221149 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:45:50 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704221150 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:46:01 srv4hai CRON[28637]: (root) CMD (/etc/linetest/linetest.sh)
Jan  2 19:46:02 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 2 not answered (1) @~1704221162 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:46:02 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 3 not answered - aborting (28592) @~1704221162 - rm '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:46:02 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:46:02 srv4hai check_presence.sh: SHELLY (0)-presence: activate_scenario.shtml: test_41_OFF
Jan  2 19:46:02 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' TO BE EXECUTED
Jan  2 19:46:02 srv4hai postfix/pickup[2387]: E35FB6011E: uid=33 from=
Jan  2 19:46:02 srv4hai postfix/cleanup[26283]: E35FB6011E: message-id=<20240102184602.E35FB6011E@mail.viehai.at>
Jan  2 19:46:02 srv4hai postfix/qmgr[28610]: E35FB6011E: from=, size=42749, nrcpt=1 (queue active)
Jan  2 19:46:02 srv4hai postfix/local[26294]: E35FB6011E: 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:46:02 srv4hai postfix/cleanup[26283]: E98CD60244: message-id=<20240102184602.E98CD60244@mail.viehai.at>
Jan  2 19:46:02 srv4hai postfix/bounce[26298]: E35FB6011E: sender non-delivery notification: E98CD60244
Jan  2 19:46:02 srv4hai postfix/qmgr[28610]: E98CD60244: from=<>, size=44628, nrcpt=1 (queue active)
Jan  2 19:46:02 srv4hai postfix/qmgr[28610]: E35FB6011E: removed
Jan  2 19:46:02 srv4hai postfix/local[26294]: E98CD60244: to=, relay=local, delay=0.02, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan  2 19:46:02 srv4hai postfix/qmgr[28610]: E98CD60244: removed
Jan  2 19:46:02 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=off&brightness=50'
Jan  2 19:46:02 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_194602_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=off&brightness=50' - phName:'NONE'
Jan  2 19:46:03 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' took 89 msec
Jan  2 19:46:03 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status'
Jan  2 19:46:03 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.141","rssi":-48},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"19:46","unixtime":1704221163,"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":1704224763,"counters":[0.000, 0.000, 0.000],"total":42}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":44.27,"tF":111.69, "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:46:03 srv4hai dhcpd[24585]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:46:03 srv4hai dhcpd[24585]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:46:03 srv4hai dhcpd[24585]: execute_statement argv[0] = /usr/bin/curl
Jan  2 19:46:03 srv4hai dhcpd[24585]: execute_statement argv[1] = http://viehai.at/shelly/smartphone.shtml?phoneIP=192.168.12.61&phoneName=fpTom
Jan  2 19:46:03 srv4hai named[14530]: client @0x7fc32813a950 192.168.12.252#33655/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpTom.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  2 19:46:03 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpTom'
Jan  2 19:46:03 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  2 19:46:03 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1704221163
Jan  2 19:46:03 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:46:03 srv4hai check_presence.sh: SHELLY (0)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  2 19:46:06 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704221166 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:46:19 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 1 not answered (1) @~1704221179 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:46:20 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704221180 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:46:32 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 2 not answered (1) @~1704221192 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:46:32 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 3 not answered - aborting (28763) @~1704221192 - rm '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:46:32 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:46:32 srv4hai check_presence.sh: SHELLY (0)-presence: activate_scenario.shtml: test_41_OFF
Jan  2 19:46:32 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' TO BE EXECUTED
Jan  2 19:46:32 srv4hai postfix/pickup[2387]: 69A396011E: uid=33 from=
Jan  2 19:46:32 srv4hai postfix/cleanup[26283]: 69A396011E: message-id=<20240102184632.69A396011E@mail.viehai.at>
Jan  2 19:46:32 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=off&brightness=50'
Jan  2 19:46:32 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_194632_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=off&brightness=50' - phName:'NONE'
Jan  2 19:46:32 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' took 64 msec
Jan  2 19:46:32 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status'
Jan  2 19:46:32 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.141","rssi":-48},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"19:46","unixtime":1704221193,"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":1704224793,"counters":[0.000, 0.000, 0.000],"total":42}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":44.27,"tF":111.69, "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:46:32 srv4hai postfix/qmgr[28610]: 69A396011E: from=, size=47871, nrcpt=1 (queue active)
Jan  2 19:46:32 srv4hai dhcpd[24585]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:46:32 srv4hai dhcpd[24585]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:46:32 srv4hai dhcpd[24585]: execute_statement argv[0] = /usr/bin/curl
Jan  2 19:46:32 srv4hai dhcpd[24585]: execute_statement argv[1] = http://viehai.at/shelly/smartphone.shtml?phoneIP=192.168.12.61&phoneName=fpTom
Jan  2 19:46:32 srv4hai named[14530]: client @0x7fc32813a950 192.168.12.252#33655/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpTom.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  2 19:46:32 srv4hai named[14530]: client @0x7fc328693a30 192.168.12.252#45421/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpTom.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  2 19:46:32 srv4hai postfix/local[26294]: 69A396011E: to=, orig_to=, relay=local, delay=0.15, delays=0.14/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan  2 19:46:32 srv4hai postfix/cleanup[26283]: 8D6AC60244: message-id=<20240102184632.8D6AC60244@mail.viehai.at>
Jan  2 19:46:32 srv4hai postfix/bounce[26298]: 69A396011E: sender non-delivery notification: 8D6AC60244
Jan  2 19:46:32 srv4hai postfix/qmgr[28610]: 8D6AC60244: from=<>, size=49750, nrcpt=1 (queue active)
Jan  2 19:46:32 srv4hai postfix/qmgr[28610]: 69A396011E: removed
Jan  2 19:46:32 srv4hai postfix/local[26294]: 8D6AC60244: to=, relay=local, delay=0.03, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan  2 19:46:32 srv4hai postfix/qmgr[28610]: 8D6AC60244: removed
Jan  2 19:46:32 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpTom'
Jan  2 19:46:32 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  2 19:46:32 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1704221192
Jan  2 19:46:32 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:46:32 srv4hai check_presence.sh: SHELLY (0)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  2 19:46:35 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704221195 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:46:48 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 1 not answered (1) @~1704221208 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:46:51 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704221211 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:47:01 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 2 not answered (1) @~1704221221 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:47:01 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 3 not answered - aborting (28917) @~1704221221 - rm '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:47:01 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:47:01 srv4hai check_presence.sh: SHELLY (0)-presence: activate_scenario.shtml: test_41_OFF
Jan  2 19:47:01 srv4hai CRON[29010]: (root) CMD (/etc/linetest/linetest.sh)
Jan  2 19:47:01 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' TO BE EXECUTED
Jan  2 19:47:01 srv4hai postfix/pickup[2387]: E424B6011E: uid=33 from=
Jan  2 19:47:01 srv4hai postfix/cleanup[26283]: E424B6011E: message-id=<20240102184701.E424B6011E@mail.viehai.at>
Jan  2 19:47:01 srv4hai postfix/qmgr[28610]: E424B6011E: from=, size=41285, nrcpt=1 (queue active)
Jan  2 19:47:01 srv4hai postfix/local[26294]: E424B6011E: 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:47:01 srv4hai postfix/cleanup[26283]: E7B3B60244: message-id=<20240102184701.E7B3B60244@mail.viehai.at>
Jan  2 19:47:01 srv4hai postfix/bounce[26298]: E424B6011E: sender non-delivery notification: E7B3B60244
Jan  2 19:47:01 srv4hai postfix/qmgr[28610]: E7B3B60244: from=<>, size=43164, nrcpt=1 (queue active)
Jan  2 19:47:01 srv4hai postfix/qmgr[28610]: E424B6011E: removed
Jan  2 19:47:01 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=off&brightness=50'
Jan  2 19:47:01 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/02/scene_test_41_OFF_20240102_194701_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=off&brightness=50' - phName:'NONE'
Jan  2 19:47:01 srv4hai postfix/local[26294]: E7B3B60244: to=, relay=local, delay=0.02, delays=0.01/0/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan  2 19:47:01 srv4hai postfix/qmgr[28610]: E7B3B60244: removed
Jan  2 19:47:01 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_OFF(test_41_off)' took 59 msec
Jan  2 19:47:02 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status'
Jan  2 19:47:02 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.141","rssi":-48},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":true},"time":"19:47","unixtime":1704221222,"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":1704224822,"counters":[0.000, 0.000, 0.000],"total":42}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":44.27,"tF":111.69, "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:47:02 srv4hai dhcpd[24585]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:47:02 srv4hai dhcpd[24585]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan  2 19:47:02 srv4hai dhcpd[24585]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:47:02 srv4hai dhcpd[24585]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan  2 19:47:02 srv4hai named[14530]: client @0x7fc32813a950 192.168.12.252#33655/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpTom.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan  2 19:47:02 srv4hai dhcpd[24585]: execute_statement argv[0] = /usr/bin/curl
Jan  2 19:47:02 srv4hai dhcpd[24585]: execute_statement argv[1] = http://viehai.at/shelly/smartphone.shtml?phoneIP=192.168.12.61&phoneName=fpTom
Jan  2 19:47:02 srv4hai named[14530]: client @0x7fc32813a950 192.168.12.252#33655/key rndc-key: signer "rndc-key" approved
Jan  2 19:47:02 srv4hai named[14530]: client @0x7fc32813a950 192.168.12.252#33655/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' TXT
Jan  2 19:47:02 srv4hai named[14530]: client @0x7fc32813a950 192.168.12.252#33655/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan  2 19:47:02 srv4hai named[14530]: client @0x7fc32813a950 192.168.12.252#33655/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpTom.viehai.at' A
Jan  2 19:47:02 srv4hai named[14530]: client @0x7fc32813a950 192.168.12.252#33655/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpTom.viehai.at' A 192.168.12.61
Jan  2 19:47:02 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpTom'
Jan  2 19:47:02 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan  2 19:47:02 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1704221222
Jan  2 19:47:02 srv4hai check_presence.sh: SHELLY (0) what: 'coming' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:47:02 srv4hai check_presence.sh: SHELLY (0)-coming: NOT activate_scenario.shtml: test_41_ON
Jan  2 19:47:05 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 0 not answered (1) @~1704221225 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:47:18 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 1 not answered (1) @~1704221238 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:47:21 srv4hai ping_SP.sh: SHELLY  (1) - pinging 192.168.12.62 0 sucessfully  @~1704221241 - '/srv/www/viehai/shelly//meter/ping_SP_1'
Jan  2 19:47:31 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 2 not answered (1) @~1704221251 - '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:47:31 srv4hai ping_SP.sh: SHELLY  (0)- pinging 192.168.12.61 3 not answered - aborting (29085) @~1704221251 - rm '/srv/www/viehai/shelly//meter/ping_SP_0'
Jan  2 19:47:31 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'false' - anyPresent: 'false'
Jan  2 19:47:31 srv4hai check_presence.sh: SHELLY (0)-presence: activate_scenario.shtml: test_41_OFF

finished