activate_scenario.sh
Mon Jan 22 08:02:19 CET 2024
scenario: LOG_gehen

scenario: 'LOG_aus' - 'LOG_gehen' - 'log_gehen'

scenario: 'LOG_aus' - 'LOG_gehen' - 'log_gehen'

urls : 0
vorher : 08:02:20.057
nachher: 08:02:20.063
Dauer : 6 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/22//scene_LOG_gehen_20240122_080219.txt'

syslog

Jan 22 07:59:01 srv4hai CRON[11795]: (root) CMD (/etc/linetest/linetest.sh)
Jan 22 07:59:25 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1705906765 - 'ping_SP_1'
Jan 22 07:59:55 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1705906795 - 'ping_SP_1'
Jan 22 08:00:01 srv4hai CRON[11837]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Jan 22 08:00:01 srv4hai CRON[11838]: (root) CMD (/etc/linetest/linetest.sh)
Jan 22 08:00:01 srv4hai meter.sh: SHELLY meter.sh started
Jan 22 08:00:05 srv4hai dhcpd[5037]: DHCPDISCOVER from 98:cd:ac:2e:1c:da via enp2s0
Jan 22 08:00:05 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0
Jan 22 08:00:05 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 22 08:00:05 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.122
Jan 22 08:00:05 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-22
Jan 22 08:00:05 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.122 (192.168.12.252) from 98:cd:ac:2e:1c:da via enp2s0
Jan 22 08:00:05 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0
Jan 22 08:00:05 srv4hai named[14530]: client @0x7fc31803cbb0 192.168.12.252#43033/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-22.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 22 08:00:05 srv4hai named[14530]: client @0x7fc320090c00 192.168.12.252#46631/key rndc-key: signer "rndc-key" approved
Jan 22 08:00:05 srv4hai named[14530]: client @0x7fc320090c00 192.168.12.252#46631/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' TXT
Jan 22 08:00:05 srv4hai named[14530]: client @0x7fc320090c00 192.168.12.252#46631/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' TXT "0051fce7ef7edfb3d29643aefa7bc5b7f2"
Jan 22 08:00:05 srv4hai named[14530]: client @0x7fc320090c00 192.168.12.252#46631/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' A
Jan 22 08:00:05 srv4hai named[14530]: client @0x7fc320090c00 192.168.12.252#46631/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' A 192.168.12.122
Jan 22 08:00:05 srv4hai dhcpd[5037]: Added new forward map from shelly-22.viehai.at to 192.168.12.122
Jan 22 08:00:05 srv4hai named[14530]: client @0x7fc32409b3f0 192.168.12.252#37315/key rndc-key: signer "rndc-key" approved
Jan 22 08:00:05 srv4hai named[14530]: client @0x7fc32409b3f0 192.168.12.252#37315/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '122.12.168.192.in-addr.arpa' PTR
Jan 22 08:00:05 srv4hai named[14530]: client @0x7fc32409b3f0 192.168.12.252#37315/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 22 08:00:05 srv4hai dhcpd[5037]: Added reverse map from 122.12.168.192.in-addr.arpa. to shelly-22.viehai.at
Jan 22 08:00:05 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-22' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Jan 22 08:00:06 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-22' - shIP/2:'192.168.12.122'
Jan 22 08:00:06 srv4hai conf_shelly.sh: SHELLY: usage/name 'WC' already set for '192.168.12.122'
Jan 22 08:00:06 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(0)' - allready transmitted - skipping
Jan 22 08:00:06 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(1)' - allready transmitted - skipping
Jan 22 08:00:06 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(2)' - allready transmitted - skipping
Jan 22 08:00:06 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(3)' - allready transmitted - skipping
Jan 22 08:00:06 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(4)' - allready transmitted - skipping
Jan 22 08:00:06 srv4hai conf_shelly.sh: SHELLY:'shelly-22' out:0 ON : MISSING
Jan 22 08:00:06 srv4hai conf_shelly.sh: SHELLY:'shelly-22' out:0 OFF: MISSING
Jan 22 08:00:25 srv4hai activate_scenario.sh: SHELLY scenario: 'sekr_UM(sekr_um)' TO BE EXECUTED, phone=''
Jan 22 08:00:25 srv4hai postfix/pickup[3879]: 7C6D460244: uid=33 from=
Jan 22 08:00:25 srv4hai postfix/cleanup[12263]: 7C6D460244: message-id=<20240122070025.7C6D460244@mail.viehai.at>
Jan 22 08:00:25 srv4hai postfix/qmgr[28610]: 7C6D460244: from=, size=14141, nrcpt=1 (queue active)
Jan 22 08:00:25 srv4hai postfix/local[12277]: 7C6D460244: to=, orig_to=, relay=local, delay=0.08, delays=0.05/0.01/0/0.02, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 22 08:00:25 srv4hai postfix/cleanup[12263]: 8AD9B60245: message-id=<20240122070025.8AD9B60245@mail.viehai.at>
Jan 22 08:00:25 srv4hai activate_scenario.sh: SHELLY: 'shelly-23'-'Licht Sekretär' --> '0?turn=toggle'
Jan 22 08:00:25 srv4hai proc_url.sh: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/01/22/_0.log' - shellyUsage:'Licht Sekretär' - scUrl:'http://192.168.12.123/relay/0?turn=toggle' - phName:'noHandy'
Jan 22 08:00:25 srv4hai postfix/bounce[12278]: 7C6D460244: sender non-delivery notification: 8AD9B60245
Jan 22 08:00:25 srv4hai postfix/qmgr[28610]: 8AD9B60245: from=<>, size=16020, nrcpt=1 (queue active)
Jan 22 08:00:25 srv4hai postfix/qmgr[28610]: 7C6D460244: removed
Jan 22 08:00:25 srv4hai postfix/local[12277]: 8AD9B60245: 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 22 08:00:25 srv4hai postfix/qmgr[28610]: 8AD9B60245: removed
Jan 22 08:00:25 srv4hai activate_scenario.sh: SHELLY scenario: 'sekr_UM(sekr_um)' took 112 msec, phone=''
Jan 22 08:00:25 srv4hai proc_url.sh: SHELLY: grab status via - 'http://192.168.12.123/status'
Jan 22 08:00:25 srv4hai 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":"08:00","unixtime":1705906826,"serial":1,"has_update":false,"mac":"3083988C059D","cfg_changed_cnt":0,"actions_stats":{"skipped":0},"relays":[{"ison":false,"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":98}],"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":40060,"fs_size":233681,"fs_free":150098,"uptime":2306750}'
Jan 22 08:00:26 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1705906826 - 'ping_SP_1'
Jan 22 08:00:42 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=12348, secured, session=
Jan 22 08:00:42 srv4hai dovecot: imap(miglincit)<12348>: Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 22 08:00:56 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1705906856 - 'ping_SP_1'
Jan 22 08:01:01 srv4hai CRON[12419]: (root) CMD (/etc/linetest/linetest.sh)
Jan 22 08:01:11 srv4hai meter.sh: SHELLY meter.sh ended
Jan 22 08:01:11 srv4hai dhcpd[5037]: DHCPDISCOVER from 98:cd:ac:2e:1c:da via enp2s0
Jan 22 08:01:11 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0
Jan 22 08:01:11 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 22 08:01:11 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.122
Jan 22 08:01:11 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-22
Jan 22 08:01:11 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.122 (192.168.12.252) from 98:cd:ac:2e:1c:da via enp2s0
Jan 22 08:01:11 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.122 to 98:cd:ac:2e:1c:da via enp2s0
Jan 22 08:01:11 srv4hai named[14530]: client @0x7fc3080643f0 192.168.12.252#55785/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-22.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 22 08:01:11 srv4hai named[14530]: client @0x7fc32000a250 192.168.12.252#39031/key rndc-key: signer "rndc-key" approved
Jan 22 08:01:11 srv4hai named[14530]: client @0x7fc32000a250 192.168.12.252#39031/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' TXT
Jan 22 08:01:11 srv4hai named[14530]: client @0x7fc32000a250 192.168.12.252#39031/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' TXT "0051fce7ef7edfb3d29643aefa7bc5b7f2"
Jan 22 08:01:11 srv4hai named[14530]: client @0x7fc32000a250 192.168.12.252#39031/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-22.viehai.at' A
Jan 22 08:01:11 srv4hai named[14530]: client @0x7fc32000a250 192.168.12.252#39031/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-22.viehai.at' A 192.168.12.122
Jan 22 08:01:11 srv4hai dhcpd[5037]: Added new forward map from shelly-22.viehai.at to 192.168.12.122
Jan 22 08:01:11 srv4hai named[14530]: client @0x7fc32812c1c0 192.168.12.252#47857/key rndc-key: signer "rndc-key" approved
Jan 22 08:01:11 srv4hai named[14530]: client @0x7fc32812c1c0 192.168.12.252#47857/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '122.12.168.192.in-addr.arpa' PTR
Jan 22 08:01:11 srv4hai named[14530]: client @0x7fc32812c1c0 192.168.12.252#47857/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 22 08:01:11 srv4hai dhcpd[5037]: Added reverse map from 122.12.168.192.in-addr.arpa. to shelly-22.viehai.at
Jan 22 08:01:11 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-22' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Jan 22 08:01:12 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-22' - shIP/2:'192.168.12.122'
Jan 22 08:01:12 srv4hai conf_shelly.sh: SHELLY: usage/name 'WC' already set for '192.168.12.122'
Jan 22 08:01:12 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(0)' - allready transmitted - skipping
Jan 22 08:01:12 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(1)' - allready transmitted - skipping
Jan 22 08:01:12 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(2)' - allready transmitted - skipping
Jan 22 08:01:12 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(3)' - allready transmitted - skipping
Jan 22 08:01:12 srv4hai conf_shelly.sh: SHELLY:'shelly-22' 'conf(4)' - allready transmitted - skipping
Jan 22 08:01:12 srv4hai conf_shelly.sh: SHELLY:'shelly-22' out:0 ON : MISSING
Jan 22 08:01:12 srv4hai conf_shelly.sh: SHELLY:'shelly-22' out:0 OFF: MISSING
Jan 22 08:01:26 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1705906886 - 'ping_SP_1'
Jan 22 08:01:57 srv4hai ping_SP.sh: SHELLY (1) - ping 192.168.12.62 0 sucessfully  @~1705906917 - 'ping_SP_1'
Jan 22 08:02:01 srv4hai CRON[12601]: (root) CMD (/etc/linetest/linetest.sh)

finished