activate_scenario.sh
Wed Jan 3 18:42:13 CET 2024
scenario: test_41_ON
phoneName: 1
vorher: 18:42:13.238
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: 18:42:13.266
Dauer: 28 msec
phName: '1'
urls : 1
vorher : 18:42:13.220
nachher: 18:42:13.272
Dauer : 51 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/03/scene_test_41_ON_20240103_184213.txt'
Jan 3 18:39:00 srv4hai systemd[1]: Starting Clean php session files... Jan 3 18:39:01 srv4hai systemd[1]: phpsessionclean.service: Succeeded. Jan 3 18:39:01 srv4hai systemd[1]: Started Clean php session files. Jan 3 18:39:01 srv4hai CRON[30912]: (root) CMD ( [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi) Jan 3 18:39:01 srv4hai CRON[30913]: (root) CMD (/etc/linetest/linetest.sh) Jan 3 18:39:32 srv4hai named[14530]: resolver priming query complete Jan 3 18:39:45 srv4hai named[14530]: resolver priming query complete Jan 3 18:39:51 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 3 18:39:51 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 3 18:40:01 srv4hai CRON[30927]: (root) CMD (/etc/linetest/linetest.sh) Jan 3 18:40:01 srv4hai CRON[30928]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh) Jan 3 18:40:01 srv4hai meter.sh: SHELLY meter.sh started Jan 3 18:40:19 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets). Jan 3 18:40:20 srv4hai fetchmail[1651]: 34841 messages (34841 seen) for tmiglinci at mail.akis.at (-1374703096 octets). Jan 3 18:40:20 srv4hai fetchmail[1651]: 9723 messages (9723 seen) for srozum at mail.akis.at (1176937585 octets). Jan 3 18:40:21 srv4hai fetchmail[1651]: 20885 messages (20885 seen) for mrozum at mail.akis.at (-787852273 octets). Jan 3 18:40:21 srv4hai fetchmail[1651]: 44 messages (44 seen) for admin@bastelstube.wien at pop3.world4you.com (12031668 octets). Jan 3 18:40:38 srv4hai named[14530]: resolver priming query complete Jan 3 18:40:45 srv4hai named[14530]: resolver priming query complete Jan 3 18:40:53 srv4hai bt_scan.sh: SHELLY - phoneName: 'S20_Grete' / '1' Jan 3 18:40:53 srv4hai bt_scan.sh: SHELLY - ping_SP.sh started for BTmac: '1' Jan 3 18:40:53 srv4hai ping_SP.sh: SHELLY ping_SP.sh started Jan 3 18:40:53 srv4hai named[14530]: resolver priming query complete Jan 3 18:40:53 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_1' @~1704303653 Jan 3 18:40:53 srv4hai check_presence.sh: SHELLY (1) what: 'coming' - persPresent: 'false/no IP, scanBT/no ping, false/no IP,' - anyPresent: 'true' Jan 3 18:40:53 srv4hai check_presence.sh: SHELLY (1)-coming: activate_scenario.shtml: test_41_ON Jan 3 18:40:53 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_ON(test_41_on)' TO BE EXECUTED Jan 3 18:40:53 srv4hai postfix/pickup[21857]: BCA1060244: uid=33 from=Jan 3 18:40:53 srv4hai postfix/cleanup[31341]: BCA1060244: message-id=<20240103174053.BCA1060244@mail.viehai.at> Jan 3 18:40:53 srv4hai postfix/qmgr[28610]: BCA1060244: from= , size=17006, nrcpt=1 (queue active) Jan 3 18:40:53 srv4hai activate_scenario.sh: SHELLY: 'shelly-41'-'41-TBD-Dimmer' --> '0?turn=on&brightness=25' Jan 3 18:40:53 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/03/scene_test_41_ON_20240103_184053_0.log' - shellyUsage:'41-TBD-Dimmer' - scUrl:'http://192.168.12.141/light/0?turn=on&brightness=25' - phName:'1' Jan 3 18:40:53 srv4hai postfix/local[31355]: BCA1060244: to= , orig_to= , relay=local, delay=0.05, delays=0.03/0.01/0/0.02, dsn=5.1.1, status=bounced (unknown user: "null") Jan 3 18:40:53 srv4hai postfix/cleanup[31341]: C60E860245: message-id=<20240103174053.C60E860245@mail.viehai.at> Jan 3 18:40:53 srv4hai postfix/bounce[31356]: BCA1060244: sender non-delivery notification: C60E860245 Jan 3 18:40:53 srv4hai postfix/qmgr[28610]: C60E860245: from=<>, size=18885, nrcpt=1 (queue active) Jan 3 18:40:53 srv4hai postfix/qmgr[28610]: BCA1060244: removed Jan 3 18:40:53 srv4hai postfix/local[31355]: C60E860245: to= , relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail) Jan 3 18:40:53 srv4hai postfix/qmgr[28610]: C60E860245: removed Jan 3 18:40:53 srv4hai activate_scenario.sh: SHELLY scenario: 'test_41_ON(test_41_on)' took 70 msec Jan 3 18:40:53 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.141/status' Jan 3 18:40:53 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":"18:40","unixtime":1704303654,"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":1704307254,"counters":[0.000, 0.000, 0.000],"total":1866}],"inputs":[{"input":0,"event":"","event_cnt":0},{"input":0,"event":"","event_cnt":0}],"tmp":{"tC":42.71,"tF":108.88, "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 3 18:40:55 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 3 18:40:55 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 3 18:40:56 srv4hai ping_SP.sh: SHELLY (1)- pinging 192.168.12.62 0 not answered (1) @~1704303656 - '/srv/www/viehai/shelly//meter/ping_SP_1' Jan 3 18:41:01 srv4hai CRON[31406]: (root) CMD (/etc/linetest/linetest.sh) Jan 3 18:41:09 srv4hai ping_SP.sh: SHELLY (1)- pinging 192.168.12.62 1 not answered (1) @~1704303669 - '/srv/www/viehai/shelly//meter/ping_SP_1' Jan 3 18:41:10 srv4hai meter.sh: SHELLY meter.sh ended Jan 3 18:41:22 srv4hai ping_SP.sh: SHELLY (1)- pinging 192.168.12.62 2 not answered (1) @~1704303682 - '/srv/www/viehai/shelly//meter/ping_SP_1' Jan 3 18:41:22 srv4hai ping_SP.sh: SHELLY (1)- pinging 192.168.12.62 3 not answered - aborting (31276) @~1704303682 - rm '/srv/www/viehai/shelly//meter/ping_SP_1' Jan 3 18:41:22 srv4hai check_presence.sh: SHELLY (1) what: 'presence' - persPresent: 'false/no IP, scanBT/no IP, false/no IP,' - anyPresent: 'true' Jan 3 18:41:22 srv4hai check_presence.sh: SHELLY (1)-presence: NOT activate_scenario.shtml: test_41_OFF Jan 3 18:41:45 srv4hai named[14530]: resolver priming query complete Jan 3 18:41:59 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 3 18:41:59 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 3 18:41:59 srv4hai named[14530]: resolver priming query complete Jan 3 18:42:01 srv4hai CRON[31459]: (root) CMD (/etc/linetest/linetest.sh) Jan 3 18:42:13 srv4hai dhcpd[1107]: DHCPDISCOVER from f0:39:65:25:8d:c7 via enp2s0 Jan 3 18:42:13 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0 Jan 3 18:42:13 srv4hai dhcpd[1107]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh Jan 3 18:42:13 srv4hai dhcpd[1107]: execute_statement argv[1] = 192.168.12.62 Jan 3 18:42:13 srv4hai dhcpd[1107]: execute_statement argv[2] = GreteS20 Jan 3 18:42:13 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' Jan 3 18:42:13 srv4hai dhcpd[1107]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0 Jan 3 18:42:13 srv4hai dhcpd[1107]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0 Jan 3 18:42:13 srv4hai named[14530]: client @0x7fc328166000 192.168.12.252#51197/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 3 18:42:13 srv4hai named[14530]: client @0x7fc31803cbb0 192.168.12.252#33459/key rndc-key: signer "rndc-key" approved Jan 3 18:42:13 srv4hai named[14530]: client @0x7fc31803cbb0 192.168.12.252#33459/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT Jan 3 18:42:13 srv4hai named[14530]: client @0x7fc31803cbb0 192.168.12.252#33459/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0" Jan 3 18:42:13 srv4hai named[14530]: client @0x7fc31803cbb0 192.168.12.252#33459/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A Jan 3 18:42:13 srv4hai named[14530]: client @0x7fc31803cbb0 192.168.12.252#33459/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62 Jan 3 18:42:13 srv4hai ping_SP.sh: SHELLY ping_SP.sh started Jan 3 18:42:13 srv4hai dhcpd[1107]: Added new forward map from GreteS20.viehai.at to 192.168.12.62 Jan 3 18:42:13 srv4hai named[14530]: client @0x7fc3200cc820 192.168.12.252#55235/key rndc-key: signer "rndc-key" approved Jan 3 18:42:13 srv4hai named[14530]: client @0x7fc3200cc820 192.168.12.252#55235/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR Jan 3 18:42:13 srv4hai named[14530]: client @0x7fc3200cc820 192.168.12.252#55235/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '62.12.168.192.in-addr.arpa' PTR GreteS20.viehai.at. Jan 3 18:42:13 srv4hai dhcpd[1107]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at Jan 3 18:42:13 srv4hai ping_SP.sh: SHELLY - new process: '' - '/srv/www/viehai/shelly//meter/ping_SP_1' @~1704303733 Jan 3 18:42:13 srv4hai check_presence.sh: SHELLY (1) what: 'coming' - persPresent: 'false/no IP, scanBT/no ping, false/no IP,' - anyPresent: 'true' Jan 3 18:42:13 srv4hai check_presence.sh: SHELLY (1)-coming: activate_scenario.shtml: test_41_ON
finished