activate_scenario.sh
Thu Jan 18 07:32:43 CET 2024
scenario: LOG_kommen
urls : 0
vorher : 07:32:43.337
nachher: 07:32:43.345
Dauer : 8 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/18//scene_LOG_kommen_20240118_073243.txt'
Jan 18 07:29:01 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705559341 - 'ping_SP_1' Jan 18 07:29:01 srv4hai CRON[21179]: (root) CMD (/etc/linetest/linetest.sh) Jan 18 07:29:03 srv4hai postfix/anvil[20966]: statistics: max connection rate 1/60s for (smtp:194.33.191.197) at Jan 18 07:25:43 Jan 18 07:29:03 srv4hai postfix/anvil[20966]: statistics: max connection count 1 for (smtp:194.33.191.197) at Jan 18 07:25:43 Jan 18 07:29:03 srv4hai postfix/anvil[20966]: statistics: max cache size 1 at Jan 18 07:25:43 Jan 18 07:29:06 srv4hai named[14530]: resolver priming query complete Jan 18 07:29:07 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 18 07:29:07 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 18 07:29:25 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705559365 - 'ping_SP_0' Jan 18 07:29:31 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705559371 - 'ping_SP_1' Jan 18 07:29:42 srv4hai named[14530]: resolver priming query complete Jan 18 07:29:55 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705559395 - 'ping_SP_0' Jan 18 07:30:01 srv4hai CRON[21221]: (root) CMD ([ -x /etc/init.d/anacron ] && if [ ! -d /run/systemd/system ]; then /usr/sbin/invoke-rc.d anacron start >/dev/null; fi) Jan 18 07:30:01 srv4hai CRON[21222]: (root) CMD (/etc/linetest/linetest.sh) Jan 18 07:30:01 srv4hai CRON[21223]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh) Jan 18 07:30:02 srv4hai meter.sh: SHELLY meter.sh started Jan 18 07:30:02 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705559402 - 'ping_SP_1' Jan 18 07:30:11 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 18 07:30:11 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 18 07:30:25 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705559425 - 'ping_SP_0' Jan 18 07:30:32 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705559432 - 'ping_SP_1' Jan 18 07:30:35 srv4hai systemd[1]: Started Run anacron jobs. Jan 18 07:30:35 srv4hai anacron[21514]: Anacron 2.3 started on 2024-01-18 Jan 18 07:30:35 srv4hai anacron[21514]: Will run job `cron.daily' in 5 min. Jan 18 07:30:35 srv4hai anacron[21514]: Jobs will be executed sequentially Jan 18 07:30:37 srv4hai dhcpd[8095]: DHCPDISCOVER from 98:cd:ac:2e:1c:da via enp2s0 Jan 18 07:30:37 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0 Jan 18 07:30:37 srv4hai dhcpd[8095]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Jan 18 07:30:37 srv4hai dhcpd[8095]: execute_statement argv[1] = 192.168.12.122 Jan 18 07:30:37 srv4hai dhcpd[8095]: execute_statement argv[2] = shelly-22 Jan 18 07:30:37 srv4hai dhcpd[8095]: DHCPREQUEST for 192.168.12.122 (192.168.12.252) from 98:cd:ac:2e:1c:da via enp2s0 Jan 18 07:30:37 srv4hai dhcpd[8095]: DHCPACK on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0 Jan 18 07:30:37 srv4hai named[14530]: client @0x7fc320090c00 192.168.12.252#50723/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-22.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 18 07:30:37 srv4hai named[14530]: client @0x7fc32003af00 192.168.12.252#33467/key rndc-key: signer "rndc-key" approved Jan 18 07:30:37 srv4hai named[14530]: client @0x7fc32003af00 192.168.12.252#33467/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' TXT Jan 18 07:30:37 srv4hai named[14530]: client @0x7fc32003af00 192.168.12.252#33467/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' TXT "0051fce7ef7edfb3d29643aefa7bc5b7f2" Jan 18 07:30:37 srv4hai named[14530]: client @0x7fc32003af00 192.168.12.252#33467/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' A Jan 18 07:30:37 srv4hai named[14530]: client @0x7fc32003af00 192.168.12.252#33467/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' A 192.168.12.122 Jan 18 07:30:37 srv4hai dhcpd[8095]: Added new forward map from shelly-22.viehai.at to 192.168.12.122 Jan 18 07:30:37 srv4hai named[14530]: client @0x7fc31001d550 192.168.12.252#57521/key rndc-key: signer "rndc-key" approved Jan 18 07:30:37 srv4hai named[14530]: client @0x7fc31001d550 192.168.12.252#57521/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '122.12.168.192.in-addr.arpa' PTR Jan 18 07:30:37 srv4hai named[14530]: client @0x7fc31001d550 192.168.12.252#57521/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '122.12.168.192.in-addr.arpa' PTR shelly-22.viehai.at. Jan 18 07:30:37 srv4hai dhcpd[8095]: Added reverse map from 122.12.168.192.in-addr.arpa. to shelly-22.viehai.at Jan 18 07:30:37 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-22' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf' Jan 18 07:30:38 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-22' - shIP/2:'192.168.12.122' Jan 18 07:30:38 srv4hai conf_shelly.sh: SHELLY: usage/name 'WC' already set for '192.168.12.122' Jan 18 07:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(0)' - allready transmitted - skipping Jan 18 07:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(1)' - allready transmitted - skipping Jan 18 07:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(2)' - allready transmitted - skipping Jan 18 07:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(3)' - allready transmitted - skipping Jan 18 07:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(4)' - allready transmitted - skipping Jan 18 07:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-22' out:0 ON : MISSING Jan 18 07:30:38 srv4hai conf_shelly.sh: SHELLY:'shelly-22' out:0 OFF: MISSING Jan 18 07:30:43 srv4hai named[14530]: resolver priming query complete Jan 18 07:30:55 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705559455 - 'ping_SP_0' Jan 18 07:30:57 srv4hai named[14530]: resolver priming query complete Jan 18 07:31:01 srv4hai CRON[21713]: (root) CMD (/etc/linetest/linetest.sh) Jan 18 07:31:03 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705559463 - 'ping_SP_1' Jan 18 07:31:11 srv4hai meter.sh: SHELLY meter.sh ended Jan 18 07:31:15 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 18 07:31:15 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 18 07:31:25 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705559485 - 'ping_SP_0' Jan 18 07:31:33 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705559493 - 'ping_SP_1' Jan 18 07:31:38 srv4hai bt_scan.sh: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' found: 'No' Jan 18 07:31:38 srv4hai bt_scan.sh: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence Jan 18 07:31:38 srv4hai check_presence.sh: SHELLY () found './meter/ping_SP_0' more than one (1) line for what: 'presence' Jan 18 07:31:38 srv4hai check_presence.sh: SHELLY () found './meter/ping_SP_1' more than one (1) line for what: 'presence' Jan 18 07:31:38 srv4hai check_presence.sh: SHELLY () what: 'presence' - persPresent: 'false/ping, scanBT/ping, false/no IP,' - anyPresent: 'true' Jan 18 07:31:38 srv4hai check_presence.sh: SHELLY ()-presence: NOT activate_scenario.shtml: offAll Jan 18 07:31:50 srv4hai named[14530]: resolver priming query complete Jan 18 07:31:55 srv4hai dhcpd[8095]: DHCPDISCOVER from 98:cd:ac:2e:1c:da via enp2s0 Jan 18 07:31:55 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0 Jan 18 07:31:55 srv4hai dhcpd[8095]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Jan 18 07:31:55 srv4hai dhcpd[8095]: execute_statement argv[1] = 192.168.12.122 Jan 18 07:31:55 srv4hai dhcpd[8095]: execute_statement argv[2] = shelly-22 Jan 18 07:31:55 srv4hai dhcpd[8095]: DHCPREQUEST for 192.168.12.122 (192.168.12.252) from 98:cd:ac:2e:1c:da via enp2s0 Jan 18 07:31:55 srv4hai dhcpd[8095]: DHCPACK on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0 Jan 18 07:31:55 srv4hai named[14530]: client @0x7fc31400b700 192.168.12.252#51889/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-22.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 18 07:31:55 srv4hai named[14530]: client @0x7fc3140a1100 192.168.12.252#50977/key rndc-key: signer "rndc-key" approved Jan 18 07:31:55 srv4hai named[14530]: client @0x7fc3140a1100 192.168.12.252#50977/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' TXT Jan 18 07:31:55 srv4hai named[14530]: client @0x7fc3140a1100 192.168.12.252#50977/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' TXT "0051fce7ef7edfb3d29643aefa7bc5b7f2" Jan 18 07:31:55 srv4hai named[14530]: client @0x7fc3140a1100 192.168.12.252#50977/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' A Jan 18 07:31:55 srv4hai named[14530]: client @0x7fc3140a1100 192.168.12.252#50977/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' A 192.168.12.122 Jan 18 07:31:55 srv4hai dhcpd[8095]: Added new forward map from shelly-22.viehai.at to 192.168.12.122 Jan 18 07:31:55 srv4hai named[14530]: client @0x7fc31c0739e0 192.168.12.252#44667/key rndc-key: signer "rndc-key" approved Jan 18 07:31:55 srv4hai named[14530]: client @0x7fc31c0739e0 192.168.12.252#44667/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '122.12.168.192.in-addr.arpa' PTR Jan 18 07:31:55 srv4hai named[14530]: client @0x7fc31c0739e0 192.168.12.252#44667/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '122.12.168.192.in-addr.arpa' PTR shelly-22.viehai.at. Jan 18 07:31:55 srv4hai dhcpd[8095]: Added reverse map from 122.12.168.192.in-addr.arpa. to shelly-22.viehai.at Jan 18 07:31:55 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-22' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf' Jan 18 07:31:55 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705559515 - 'ping_SP_0' Jan 18 07:31:56 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-22' - shIP/2:'192.168.12.122' Jan 18 07:31:56 srv4hai conf_shelly.sh: SHELLY: usage/name 'WC' already set for '192.168.12.122' Jan 18 07:31:56 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(0)' - allready transmitted - skipping Jan 18 07:31:56 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(1)' - allready transmitted - skipping Jan 18 07:31:56 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(2)' - allready transmitted - skipping Jan 18 07:31:56 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(3)' - allready transmitted - skipping Jan 18 07:31:56 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(4)' - allready transmitted - skipping Jan 18 07:31:56 srv4hai conf_shelly.sh: SHELLY:'shelly-22' out:0 ON : MISSING Jan 18 07:31:56 srv4hai conf_shelly.sh: SHELLY:'shelly-22' out:0 OFF: MISSING Jan 18 07:32:01 srv4hai CRON[21940]: (root) CMD (/etc/linetest/linetest.sh) Jan 18 07:32:03 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705559523 - 'ping_SP_1' Jan 18 07:32:19 srv4hai dhcpd[8095]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 18 07:32:19 srv4hai dhcpd[8095]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 18 07:32:26 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully @~1705559546 - 'ping_SP_0' Jan 18 07:32:28 srv4hai bt_scan.sh: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' found: 'Yes' Jan 18 07:32:28 srv4hai bt_scan.sh: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61' Jan 18 07:32:28 srv4hai ping_SP.sh: SHELLY ping_SP.sh started Jan 18 07:32:28 srv4hai check_presence.sh: SHELLY (0) found './meter/ping_SP_0' more than one (1) line for what: 'coming' Jan 18 07:32:28 srv4hai check_presence.sh: SHELLY (0) set what to 'presence' Jan 18 07:32:28 srv4hai check_presence.sh: SHELLY (0) found './meter/ping_SP_1' more than one (1) line for what: 'presence' Jan 18 07:32:28 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'scanBT/ping, scanBT/ping, false/no IP,' - anyPresent: 'true' Jan 18 07:32:28 srv4hai check_presence.sh: SHELLY (0)-presence: NOT activate_scenario.shtml: offAll Jan 18 07:32:28 srv4hai ping_SP.sh: SHELLY - running process-id(21988): '21988 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61#01227034 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61' - 'ping_SP_0' - exiting ============== Jan 18 07:32:34 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1705559554 - 'ping_SP_1'
finished