activate_scenario.sh
Thu Jan 4 17:21:36 CET 2024
scenario: test_41_ON
phoneName: 2
'night' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'null'
scenario: 'test 41 EIN' - 'test_41_ON' - 'test_41_on'
41-TBD-Dimmer (/srv/www/viehai/shelly/log_scenarios/2024/01/04/scene_test_41_ON_20240104_172136_0.log)
vorher: 17:21:36.732
http://192.168.12.141/light/0?turn=on&brightness=25 |
|---|
"ison": true,
"source": "http",
"has_timer": false,
"timer_started": 0,
"timer_duration": 0,
"timer_remaining": 0,
"mode": "white",
"brightness": 25,
"transition": 0
|
nachher: 17:21:36.789
Dauer: 57 msec
phName: '2'
scenario: 'test 41 EIN' - 'test_41_ON' - 'test_41_on'
urls : 1
vorher : 17:21:36.669
nachher: 17:21:36.795
Dauer : 129 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/04/scene_test_41_ON_20240104_172136.txt'
syslog
Jan 4 17:18:01 srv4hai CRON[9465]: (root) CMD (/etc/linetest/linetest.sh)
Jan 4 17:18:17 srv4hai named[14530]: resolver priming query complete
Jan 4 17:18:25 srv4hai named[14530]: resolver priming query complete
Jan 4 17:19:01 srv4hai CRON[9486]: (root) CMD (/etc/linetest/linetest.sh)
Jan 4 17:19:03 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan 4 17:19:03 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan 4 17:19:17 srv4hai named[14530]: resolver priming query complete
Jan 4 17:19:31 srv4hai named[14530]: resolver priming query complete
Jan 4 17:20:01 srv4hai CRON[9510]: (root) CMD (/etc/linetest/linetest.sh)
Jan 4 17:20:01 srv4hai CRON[9511]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Jan 4 17:20:01 srv4hai meter.sh: SHELLY meter.sh started
Jan 4 17:20:07 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan 4 17:20:07 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan 4 17:20:17 srv4hai named[14530]: resolver priming query complete
Jan 4 17:20:33 srv4hai bt_scan.sh: SHELLY - phoneName: 'iP_Sophie' / '2'
Jan 4 17:20:33 srv4hai bt_scan.sh: SHELLY - ping_SP.sh started for BTmac: '2'
Jan 4 17:20:33 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan 4 17:20:33 srv4hai named[14530]: resolver priming query complete
Jan 4 17:20:33 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_2' @~1704385233
Jan 4 17:20:33 srv4hai check_presence.sh: SHELLY (2) what: 'coming' - persPresent: 'false/no IP, false/no IP, scanBT/no ping,' - anyPresent: 'true'
Jan 4 17:20:33 srv4hai check_presence.sh: SHELLY (2)-coming: activate_scenario.shtml: test_41_ON
Jan 4 17:20:33 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_ON(test_41_on)' TO BE EXECUTED
Jan 4 17:20:33 srv4hai postfix/pickup[30251]: 8192960244: uid=33 from=
Jan 4 17:20:33 srv4hai postfix/cleanup[9865]: 8192960244: message-id=<20240104162033.8192960244@mail.viehai.at>
Jan 4 17:20:33 srv4hai postfix/qmgr[28610]: 8192960244: from=, size=3525, nrcpt=1 (queue active)
Jan 4 17:20:33 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=on&brightness=25'
Jan 4 17:20:33 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/04/scene_test_41_ON_20240104_172033_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=on&brightness=25' - phName:'2'
Jan 4 17:20:33 srv4hai postfix/local[9879]: 8192960244: to=, orig_to=, relay=local, delay=0.04, delays=0.02/0.01/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 4 17:20:33 srv4hai postfix/cleanup[9865]: 87DC060245: message-id=<20240104162033.87DC060245@mail.viehai.at>
Jan 4 17:20:33 srv4hai postfix/bounce[9880]: 8192960244: sender non-delivery notification: 87DC060245
Jan 4 17:20:33 srv4hai postfix/qmgr[28610]: 87DC060245: from=<>, size=5404, nrcpt=1 (queue active)
Jan 4 17:20:33 srv4hai postfix/qmgr[28610]: 8192960244: removed
Jan 4 17:20:33 srv4hai postfix/local[9879]: 87DC060245: to=, relay=local, delay=0.01, delays=0/0/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 4 17:20:33 srv4hai postfix/qmgr[28610]: 87DC060245: removed
Jan 4 17:20:33 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_ON(test_41_on)' took 56 msec
Jan 4 17:20:33 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status'
Jan 4 17:20:33 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":"17:20","unixtime":1704385234,"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":1704388834,"counters":[0.000, 0.000, 0.000],"total":6671}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":42.57,"tF":108.62, "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-11
Jan 4 17:20:36 srv4hai ping_SP.sh: SHELLY (2)- pinging 192.168.12.63 0 not answered (1) @~1704385236 - '/srv/www/viehai/shelly//meter/ping_SP_2'
Jan 4 17:20:39 srv4hai activate_scenario.sh: SHELLY scenario: 'LOG_kommen(log_kommen)' TO BE EXECUTED
Jan 4 17:20:39 srv4hai postfix/pickup[30251]: 068D960244: uid=33 from=
Jan 4 17:20:39 srv4hai postfix/cleanup[9865]: 068D960244: message-id=<20240104162039.068D960244@mail.viehai.at>
Jan 4 17:20:39 srv4hai postfix/qmgr[28610]: 068D960244: from=, size=6616, nrcpt=1 (queue active)
Jan 4 17:20:39 srv4hai activate_scenario.sh: SHELLY scenario: 'LOG_kommen(log_kommen)' took 7 msec
Jan 4 17:20:39 srv4hai named[14530]: resolver priming query complete
Jan 4 17:20:40 srv4hai postfix/relay/smtp[9974]: 068D960244: to=, relay=mx01.nic.name[209.131.159.47]:25, delay=1.1, delays=0.01/0.01/0.68/0.41, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as BDEF220479)
Jan 4 17:20:40 srv4hai postfix/qmgr[28610]: 068D960244: removed
Jan 4 17:20:49 srv4hai ping_SP.sh: SHELLY (2)- pinging 192.168.12.63 1 not answered (1) @~1704385249 - '/srv/www/viehai/shelly//meter/ping_SP_2'
Jan 4 17:21:01 srv4hai CRON[10067]: (root) CMD (/etc/linetest/linetest.sh)
Jan 4 17:21:02 srv4hai ping_SP.sh: SHELLY (2)- pinging 192.168.12.63 2 not answered (1) @~1704385262 - '/srv/www/viehai/shelly//meter/ping_SP_2'
Jan 4 17:21:02 srv4hai ping_SP.sh: SHELLY (2)- pinging 192.168.12.63 3 not answered - aborting (9800) @~1704385262 - rm '/srv/www/viehai/shelly//meter/ping_SP_2'
Jan 4 17:21:02 srv4hai check_presence.sh: SHELLY (2) what: 'presence' - persPresent: 'false/no IP, false/no IP, scanBT/no IP,' - anyPresent: 'true'
Jan 4 17:21:02 srv4hai check_presence.sh: SHELLY (2)-presence: NOT activate_scenario.shtml: test_41_OFF
Jan 4 17:21:07 srv4hai named[14530]: resolver priming query complete
Jan 4 17:21:09 srv4hai meter.sh: SHELLY meter.sh ended
Jan 4 17:21:11 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0
Jan 4 17:21:11 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0
Jan 4 17:21:17 srv4hai named[14530]: resolver priming query complete
Jan 4 17:21:24 srv4hai named[14530]: resolver priming query complete
Jan 4 17:21:35 srv4hai dhcpd[1107]: DHCPDISCOVER from 22:1e:8c:a4:80:db via enp2s0
Jan 4 17:21:35 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.63 to 22:1e:8c:a4:80:db via enp2s0
Jan 4 17:21:36 srv4hai dhcpd[1107]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 4 17:21:36 srv4hai dhcpd[1107]: execute_statement argv[1] = 192.168.12.63
Jan 4 17:21:36 srv4hai dhcpd[1107]: execute_statement argv[2] = iPhoneSophie
Jan 4 17:21:36 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.63' / 'iPhoneSophie'
Jan 4 17:21:36 srv4hai dhcpd[1107]: DHCPREQUEST for 192.168.12.63 (192.168.12.252) from 22:1e:8c:a4:80:db via enp2s0
Jan 4 17:21:36 srv4hai dhcpd[1107]: DHCPACK on 192.168.12.63 to 22:1e:8c:a4:80:db via enp2s0
Jan 4 17:21:36 srv4hai named[14530]: client @0x7fc32406bb80 192.168.12.252#57587/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: iPhoneSophie.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 4 17:21:36 srv4hai named[14530]: client @0x7fc32810f2a0 192.168.12.252#47971/key rndc-key: signer "rndc-key" approved
Jan 4 17:21:36 srv4hai named[14530]: client @0x7fc32810f2a0 192.168.12.252#47971/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'iPhoneSophie.viehai.at' TXT
Jan 4 17:21:36 srv4hai named[14530]: client @0x7fc32810f2a0 192.168.12.252#47971/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'iPhoneSophie.viehai.at' TXT "31bf0fb452f28d5b707b5b66ceeaf6c2a6"
Jan 4 17:21:36 srv4hai named[14530]: client @0x7fc32810f2a0 192.168.12.252#47971/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'iPhoneSophie.viehai.at' A
Jan 4 17:21:36 srv4hai named[14530]: client @0x7fc32810f2a0 192.168.12.252#47971/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'iPhoneSophie.viehai.at' A 192.168.12.63
Jan 4 17:21:36 srv4hai ping_SP.sh: SHELLY ping_SP.sh started
Jan 4 17:21:36 srv4hai dhcpd[1107]: Added new forward map from iPhoneSophie.viehai.at to 192.168.12.63
Jan 4 17:21:36 srv4hai named[14530]: client @0x7fc328677140 192.168.12.252#55413/key rndc-key: signer "rndc-key" approved
Jan 4 17:21:36 srv4hai named[14530]: client @0x7fc328677140 192.168.12.252#55413/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '63.12.168.192.in-addr.arpa' PTR
Jan 4 17:21:36 srv4hai named[14530]: client @0x7fc328677140 192.168.12.252#55413/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '63.12.168.192.in-addr.arpa' PTR iPhoneSophie.viehai.at.
Jan 4 17:21:36 srv4hai dhcpd[1107]: Added reverse map from 63.12.168.192.in-addr.arpa. to iPhoneSophie.viehai.at
Jan 4 17:21:36 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_2' @~1704385296
Jan 4 17:21:36 srv4hai check_presence.sh: SHELLY (2) what: 'coming' - persPresent: 'false/no IP, false/no IP, scanBT/no ping,' - anyPresent: 'true'
Jan 4 17:21:36 srv4hai check_presence.sh: SHELLY (2)-coming: activate_scenario.shtml: test_41_ON
finished