activate_scenario.sh
Wed Jan 3 17:51:58 CET 2024
scenario: sekr_UM
vorher: 17:51:58.288
http://192.168.12.123/relay/0?turn=toggle |
---|
"ison": false, "has_timer": false, "timer_started": 0, "timer_duration": 0, "timer_remaining": 0, "source": "http" |
nachher: 17:51:58.330
Dauer: 42 msec
urls : 1
vorher : 17:51:58.239
nachher: 17:51:58.336
Dauer : 100 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/03/scene_sekr_UM_20240103_175158.txt'
Jan 3 17:48:00 srv4hai bt_scan.sh: SHELLY - phoneName: 'FP4_Thomas' / '0' Jan 3 17:48:00 srv4hai bt_scan.sh: SHELLY - ping_SP.sh started for BTmac: '0' Jan 3 17:48:00 srv4hai ping_SP.sh: SHELLY ping_SP.sh started Jan 3 17:48:00 srv4hai check_presence.sh: SHELLY (0) found './meter/ping_SP_0' more than one (1) line for what: 'coming' Jan 3 17:48:00 srv4hai check_presence.sh: SHELLY (0) set what to 'presence' Jan 3 17:48:00 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'scanBT/ping, false/no IP, false/no IP,' - anyPresent: 'true' Jan 3 17:48:00 srv4hai check_presence.sh: SHELLY (0)-presence: NOT activate_scenario.shtml: test_41_OFF Jan 3 17:48:00 srv4hai ping_SP.sh: SHELLY - running process: '5804' - '/srv/www/viehai/shelly//meter/ping_SP_0' - exiting Jan 3 17:48:01 srv4hai CRON[25735]: (root) CMD (/etc/linetest/linetest.sh) Jan 3 17:48:16 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704300496 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 3 17:48:19 srv4hai named[14530]: resolver priming query complete Jan 3 17:48:24 srv4hai named[14530]: resolver priming query complete Jan 3 17:48:35 srv4hai named[14530]: resolver priming query complete Jan 3 17:48:41 srv4hai named[14530]: resolver priming query complete Jan 3 17:48:42 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 3 17:48:42 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 3 17:48:46 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704300526 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 3 17:48:50 srv4hai dhcpd[1107]: DHCPRELEASE of 192.168.12.2 from 24:5a:4c:1c:1e:f4 via enp2s0 (not found) Jan 3 17:48:50 srv4hai dhcpd[1107]: DHCPDISCOVER from 24:5a:4c:1c:1e:f4 via enp2s0 Jan 3 17:48:50 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0 Jan 3 17:48:51 srv4hai dhcpd[1107]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh Jan 3 17:48:51 srv4hai dhcpd[1107]: execute_statement argv[1] = 192.168.12.2 Jan 3 17:48:51 srv4hai dhcpd[1107]: execute_statement argv[2] = ap2hai Jan 3 17:48:51 srv4hai dhcpd[1107]: DHCPREQUEST for 192.168.12.2 (192.168.12.252) from 24:5a:4c:1c:1e:f4 via enp2s0 Jan 3 17:48:51 srv4hai dhcpd[1107]: DHCPACK on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0 Jan 3 17:48:51 srv4hai named[14530]: client @0x7fc314083510 192.168.12.252#47203/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap2hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 3 17:48:51 srv4hai named[14530]: client @0x7fc318077970 192.168.12.252#54659/key rndc-key: signer "rndc-key" approved Jan 3 17:48:51 srv4hai named[14530]: client @0x7fc318077970 192.168.12.252#54659/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' TXT Jan 3 17:48:51 srv4hai named[14530]: client @0x7fc318077970 192.168.12.252#54659/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' TXT "31a0d441667de220424b7789941807db7d" Jan 3 17:48:51 srv4hai named[14530]: client @0x7fc318077970 192.168.12.252#54659/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' A Jan 3 17:48:51 srv4hai named[14530]: client @0x7fc318077970 192.168.12.252#54659/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' A 192.168.12.2 Jan 3 17:48:51 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.2'(2) device 'ap2hai' Jan 3 17:48:51 srv4hai dhcpd[1107]: Added new forward map from ap2hai.viehai.at to 192.168.12.2 Jan 3 17:48:51 srv4hai named[14530]: client @0x7fc3281490e0 192.168.12.252#42863/key rndc-key: signer "rndc-key" approved Jan 3 17:48:51 srv4hai named[14530]: client @0x7fc3281490e0 192.168.12.252#42863/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '2.12.168.192.in-addr.arpa' PTR Jan 3 17:48:51 srv4hai named[14530]: client @0x7fc3281490e0 192.168.12.252#42863/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '2.12.168.192.in-addr.arpa' PTR ap2hai.viehai.at. Jan 3 17:48:51 srv4hai dhcpd[1107]: Added reverse map from 2.12.168.192.in-addr.arpa. to ap2hai.viehai.at Jan 3 17:48:51 srv4hai dhcpcommit.sh: SHELLY device 'ap2hai' known and accepted Jan 3 17:48:56 srv4hai dhcpd[1107]: DHCPRELEASE of 192.168.12.3 from 70:a7:41:9a:7d:4e via enp2s0 (not found) Jan 3 17:48:56 srv4hai dhcpd[1107]: DHCPDISCOVER from 70:a7:41:9a:7d:4e via enp2s0 Jan 3 17:48:56 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0 Jan 3 17:48:56 srv4hai dhcpd[1107]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh Jan 3 17:48:56 srv4hai dhcpd[1107]: execute_statement argv[1] = 192.168.12.3 Jan 3 17:48:56 srv4hai dhcpd[1107]: execute_statement argv[2] = ap3hai Jan 3 17:48:56 srv4hai dhcpd[1107]: DHCPREQUEST for 192.168.12.3 (192.168.12.252) from 70:a7:41:9a:7d:4e via enp2s0 Jan 3 17:48:56 srv4hai dhcpd[1107]: DHCPACK on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0 Jan 3 17:48:56 srv4hai named[14530]: client @0x7fc308070fe0 192.168.12.252#34615/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap3hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 3 17:48:56 srv4hai named[14530]: client @0x7fc32869f410 192.168.12.252#46077/key rndc-key: signer "rndc-key" approved Jan 3 17:48:56 srv4hai named[14530]: client @0x7fc32869f410 192.168.12.252#46077/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' TXT Jan 3 17:48:56 srv4hai named[14530]: client @0x7fc32869f410 192.168.12.252#46077/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' TXT "31763f1a8a980dd918aaf8fff3416a5028" Jan 3 17:48:56 srv4hai named[14530]: client @0x7fc32869f410 192.168.12.252#46077/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' A Jan 3 17:48:56 srv4hai named[14530]: client @0x7fc32869f410 192.168.12.252#46077/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' A 192.168.12.3 Jan 3 17:48:56 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.3'(3) device 'ap3hai' Jan 3 17:48:56 srv4hai dhcpd[1107]: Added new forward map from ap3hai.viehai.at to 192.168.12.3 Jan 3 17:48:56 srv4hai named[14530]: client @0x7fc32003af00 192.168.12.252#40293/key rndc-key: signer "rndc-key" approved Jan 3 17:48:56 srv4hai named[14530]: client @0x7fc32003af00 192.168.12.252#40293/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '3.12.168.192.in-addr.arpa' PTR Jan 3 17:48:56 srv4hai named[14530]: client @0x7fc32003af00 192.168.12.252#40293/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '3.12.168.192.in-addr.arpa' PTR ap3hai.viehai.at. Jan 3 17:48:56 srv4hai dhcpd[1107]: Added reverse map from 3.12.168.192.in-addr.arpa. to ap3hai.viehai.at Jan 3 17:48:56 srv4hai dhcpcommit.sh: SHELLY device 'ap3hai' known and accepted Jan 3 17:49:01 srv4hai named[14530]: resolver priming query complete Jan 3 17:49:01 srv4hai CRON[25780]: (root) CMD (/etc/linetest/linetest.sh) Jan 3 17:49:16 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704300556 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 3 17:49:34 srv4hai named[14530]: resolver priming query complete Jan 3 17:49:42 srv4hai named[14530]: resolver priming query complete Jan 3 17:49:46 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 3 17:49:46 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 3 17:49:46 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704300586 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 3 17:49:54 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets). Jan 3 17:49:55 srv4hai fetchmail[1651]: 34836 messages (34836 seen) for tmiglinci at mail.akis.at (-1375138935 octets). Jan 3 17:49:55 srv4hai fetchmail[1651]: 9723 messages (9723 seen) for srozum at mail.akis.at (1176937585 octets). Jan 3 17:49:56 srv4hai fetchmail[1651]: 20884 messages (20884 seen) for mrozum at mail.akis.at (-790306325 octets). Jan 3 17:49:56 srv4hai named[14530]: resolver priming query complete Jan 3 17:49:56 srv4hai fetchmail[1651]: 44 messages (44 seen) for admin@bastelstube.wien at pop3.world4you.com (12031668 octets). Jan 3 17:50:01 srv4hai CRON[25814]: (root) CMD (/etc/linetest/linetest.sh) Jan 3 17:50:01 srv4hai CRON[25815]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh) Jan 3 17:50:01 srv4hai meter.sh: SHELLY meter.sh started Jan 3 17:50:17 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704300617 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 3 17:50:39 srv4hai named[14530]: resolver priming query complete Jan 3 17:50:42 srv4hai named[14530]: resolver priming query complete Jan 3 17:50:47 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704300647 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 3 17:50:50 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 3 17:50:50 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 3 17:51:01 srv4hai CRON[26178]: (root) CMD (/etc/linetest/linetest.sh) Jan 3 17:51:07 srv4hai meter.sh: SHELLY meter.sh ended Jan 3 17:51:17 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704300677 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 3 17:51:29 srv4hai named[14530]: resolver priming query complete Jan 3 17:51:33 srv4hai named[14530]: resolver priming query complete Jan 3 17:51:42 srv4hai named[14530]: resolver priming query complete Jan 3 17:51:47 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704300707 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 3 17:51:54 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 3 17:51:54 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 3 17:51:55 srv4hai activate_scenario.sh: SHELLY scenario: 'sekr_UM(sekr_um)' TO BE EXECUTED Jan 3 17:51:55 srv4hai postfix/pickup[21857]: 13EB560244: uid=33 from=Jan 3 17:51:55 srv4hai postfix/cleanup[26266]: 13EB560244: message-id=<20240103165155.13EB560244@mail.viehai.at> Jan 3 17:51:55 srv4hai postfix/qmgr[28610]: 13EB560244: from= , size=10825, nrcpt=1 (queue active) Jan 3 17:51:55 srv4hai activate_scenario.sh: SHELLY: 'shelly-23'-'Licht Sekretär' --> '0?turn=toggle' Jan 3 17:51:55 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/03/scene_sekr_UM_20240103_175155_0.log' - shellyUsage:'Licht Sekretär' - scUrl:'http://192.168.12.123/relay/0?turn=toggle' - phName:'noHandy' Jan 3 17:51:55 srv4hai postfix/local[26280]: 13EB560244: 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 3 17:51:55 srv4hai postfix/cleanup[26266]: 1A19860245: message-id=<20240103165155.1A19860245@mail.viehai.at> Jan 3 17:51:55 srv4hai postfix/bounce[26281]: 13EB560244: sender non-delivery notification: 1A19860245 Jan 3 17:51:55 srv4hai postfix/qmgr[28610]: 1A19860245: from=<>, size=12704, nrcpt=1 (queue active) Jan 3 17:51:55 srv4hai postfix/qmgr[28610]: 13EB560244: removed Jan 3 17:51:55 srv4hai postfix/local[26280]: 1A19860245: 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 17:51:55 srv4hai postfix/qmgr[28610]: 1A19860245: removed Jan 3 17:51:55 srv4hai activate_scenario.sh: SHELLY scenario: 'sekr_UM(sekr_um)' took 77 msec Jan 3 17:51:55 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: grab status via - 'http://192.168.12.123/status' Jan 3 17:51:55 srv4hai /srv/www/viehai/shelly/proc_url.sh: SHELLY: status: '{"wifi_sta":{"connected":true,"ssid":"viehai","ip":"192.168.12.123","rssi":-68},"cloud":{"enabled":false,"connected":false},"mqtt":{"connected":false},"time":"17:51","unixtime":1704300715,"serial":1,"has_update":false,"mac":"3083988C059D","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":true,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"source":"http"}],"meters":[{"power":0.00,"is_valid":true}],"inputs":[{"input":0,"event":"","event_cnt":26}],"ext_sensors":{},"ext_temperature":{},"ext_humidity":{},"update":{"status":"idle","has_update":false,"new_version":"20230913-112003/v1.14.0-gcb84623","old_version":"20230913-112003/v1.14.0-gcb84623","beta_version":"20231107-162940/v1.14.1-rc1-g0617c15"},"ram_total":51688,"ram_free":40304,"fs_size":233681,"fs_free":150098,"uptime":700680}'
finished