activate_scenario.sh
Sun Feb 4 19:56:40 CET 2024
scenario: LOG_gehen
source: 192.168.12.103
urls : 0
vorher : 19:56:40.569
nachher: 19:56:40.574
Dauer : 5 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/02/04//scene_LOG_gehen_20240204_195640.txt'
Feb 4 19:53:00 srv4hai conf_shelly.sh: SHELLY:'shelly-25' out:0 ON : MISSING Feb 4 19:53:00 srv4hai conf_shelly.sh: SHELLY:'shelly-25' out:0 OFF: MISSING Feb 4 19:53:01 srv4hai named[14530]: resolver priming query complete Feb 4 19:53:01 srv4hai CRON[15429]: (root) CMD (/etc/linetest/linetest.sh) Feb 4 19:53:21 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1707072801 - 'ping_SP_0' Feb 4 19:53:21 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Feb 4 19:53:22 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=15455, secured, session= Feb 4 19:53:22 srv4hai dovecot: imap(miglincit)<15455> : Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Feb 4 19:53:39 srv4hai named[14530]: resolver priming query complete Feb 4 19:53:46 srv4hai named[14530]: resolver priming query complete Feb 4 19:53:50 srv4hai named[14530]: resolver priming query complete Feb 4 19:53:51 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1707072831 - 'ping_SP_0' Feb 4 19:53:51 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Feb 4 19:53:53 srv4hai named[14530]: resolver priming query complete Feb 4 19:53:54 srv4hai named[14530]: resolver priming query complete Feb 4 19:53:55 srv4hai named[14530]: resolver priming query complete Feb 4 19:53:57 srv4hai named[14530]: resolver priming query complete Feb 4 19:53:58 srv4hai named[14530]: resolver priming query complete Feb 4 19:53:59 srv4hai named[14530]: resolver priming query complete Feb 4 19:54:00 srv4hai named[14530]: resolver priming query complete Feb 4 19:54:01 srv4hai named[14530]: resolver priming query complete Feb 4 19:54:01 srv4hai CRON[15478]: (root) CMD (/etc/linetest/linetest.sh) Feb 4 19:54:02 srv4hai named[14530]: resolver priming query complete Feb 4 19:54:09 srv4hai dhcpd[5037]: DHCPDISCOVER from 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:54:09 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.125 to 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:54:09 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Feb 4 19:54:09 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.125 Feb 4 19:54:09 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-25 Feb 4 19:54:09 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.125 (192.168.12.252) from 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:54:09 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.125 to 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:54:09 srv4hai named[14530]: client @0x7fc31c0d0140 192.168.12.252#52403/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-25.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Feb 4 19:54:09 srv4hai named[14530]: client @0x7fc31403baf0 192.168.12.252#46113/key rndc-key: signer "rndc-key" approved Feb 4 19:54:09 srv4hai named[14530]: client @0x7fc31403baf0 192.168.12.252#46113/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' TXT Feb 4 19:54:09 srv4hai named[14530]: client @0x7fc31403baf0 192.168.12.252#46113/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' TXT "00a4d627ad58f376691816e2e7457e7bae" Feb 4 19:54:09 srv4hai named[14530]: client @0x7fc31403baf0 192.168.12.252#46113/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' A Feb 4 19:54:09 srv4hai named[14530]: client @0x7fc31403baf0 192.168.12.252#46113/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' A 192.168.12.125 Feb 4 19:54:09 srv4hai dhcpd[5037]: Added new forward map from shelly-25.viehai.at to 192.168.12.125 Feb 4 19:54:09 srv4hai named[14530]: client @0x7fc3180cfac0 192.168.12.252#36813/key rndc-key: signer "rndc-key" approved Feb 4 19:54:09 srv4hai named[14530]: client @0x7fc3180cfac0 192.168.12.252#36813/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '125.12.168.192.in-addr.arpa' PTR Feb 4 19:54:09 srv4hai named[14530]: client @0x7fc3180cfac0 192.168.12.252#36813/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '125.12.168.192.in-addr.arpa' PTR shelly-25.viehai.at. Feb 4 19:54:09 srv4hai dhcpd[5037]: Added reverse map from 125.12.168.192.in-addr.arpa. to shelly-25.viehai.at Feb 4 19:54:09 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-25' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf' Feb 4 19:54:13 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-25' - shIP/2:'192.168.12.125' Feb 4 19:54:13 srv4hai conf_shelly.sh: SHELLY: usage/name 'Küchenlicht' already set for '192.168.12.125' Feb 4 19:54:13 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(0)' - allready transmitted - skipping Feb 4 19:54:13 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(1)' - allready transmitted - skipping Feb 4 19:54:13 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(2)' - allready transmitted - skipping Feb 4 19:54:13 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(3)' - allready transmitted - skipping Feb 4 19:54:13 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(4)' - allready transmitted - skipping Feb 4 19:54:13 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(5)' - allready transmitted - skipping Feb 4 19:54:13 srv4hai conf_shelly.sh: SHELLY:'shelly-25' out:0 ON : MISSING Feb 4 19:54:13 srv4hai conf_shelly.sh: SHELLY:'shelly-25' out:0 OFF: MISSING Feb 4 19:54:21 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1707072861 - 'ping_SP_0' Feb 4 19:54:21 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Feb 4 19:54:41 srv4hai dhcpd[5037]: DHCPDISCOVER from 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:54:41 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.125 to 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:54:41 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Feb 4 19:54:41 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.125 Feb 4 19:54:41 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-25 Feb 4 19:54:41 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.125 (192.168.12.252) from 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:54:41 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.125 to 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:54:41 srv4hai named[14530]: client @0x7fc32812c1c0 192.168.12.252#46871/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-25.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Feb 4 19:54:41 srv4hai named[14530]: client @0x7fc3140ea1f0 192.168.12.252#50549/key rndc-key: signer "rndc-key" approved Feb 4 19:54:41 srv4hai named[14530]: client @0x7fc3140ea1f0 192.168.12.252#50549/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' TXT Feb 4 19:54:41 srv4hai named[14530]: client @0x7fc3140ea1f0 192.168.12.252#50549/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' TXT "00a4d627ad58f376691816e2e7457e7bae" Feb 4 19:54:41 srv4hai named[14530]: client @0x7fc3140ea1f0 192.168.12.252#50549/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' A Feb 4 19:54:41 srv4hai named[14530]: client @0x7fc3140ea1f0 192.168.12.252#50549/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' A 192.168.12.125 Feb 4 19:54:41 srv4hai dhcpd[5037]: Added new forward map from shelly-25.viehai.at to 192.168.12.125 Feb 4 19:54:41 srv4hai named[14530]: client @0x7fc3200e9ad0 192.168.12.252#40991/key rndc-key: signer "rndc-key" approved Feb 4 19:54:41 srv4hai named[14530]: client @0x7fc3200e9ad0 192.168.12.252#40991/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '125.12.168.192.in-addr.arpa' PTR Feb 4 19:54:41 srv4hai named[14530]: client @0x7fc3200e9ad0 192.168.12.252#40991/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '125.12.168.192.in-addr.arpa' PTR shelly-25.viehai.at. Feb 4 19:54:41 srv4hai dhcpd[5037]: Added reverse map from 125.12.168.192.in-addr.arpa. to shelly-25.viehai.at Feb 4 19:54:41 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-25' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf' Feb 4 19:54:42 srv4hai grab_shelly.sh: SHELLY 'shelly-25': OFFLINE, resp. not answering within connect-timeout 1.500000s Feb 4 19:54:42 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Feb 4 19:54:42 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.125 Feb 4 19:54:42 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-25 Feb 4 19:54:42 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.125 (192.168.12.252) from 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:54:42 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.125 to 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:54:42 srv4hai named[14530]: client @0x7fc3286e8290 192.168.12.252#47017/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-25.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Feb 4 19:54:42 srv4hai named[14530]: client @0x7fc328157870 192.168.12.252#51997/key rndc-key: signer "rndc-key" approved Feb 4 19:54:42 srv4hai named[14530]: client @0x7fc328157870 192.168.12.252#51997/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' TXT Feb 4 19:54:42 srv4hai named[14530]: client @0x7fc328157870 192.168.12.252#51997/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' TXT "00a4d627ad58f376691816e2e7457e7bae" Feb 4 19:54:42 srv4hai named[14530]: client @0x7fc328157870 192.168.12.252#51997/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' A Feb 4 19:54:42 srv4hai named[14530]: client @0x7fc328157870 192.168.12.252#51997/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' A 192.168.12.125 Feb 4 19:54:42 srv4hai dhcpd[5037]: Added new forward map from shelly-25.viehai.at to 192.168.12.125 Feb 4 19:54:42 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#44377/key rndc-key: signer "rndc-key" approved Feb 4 19:54:42 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#44377/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '125.12.168.192.in-addr.arpa' PTR Feb 4 19:54:42 srv4hai named[14530]: client @0x7fc318086600 192.168.12.252#44377/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '125.12.168.192.in-addr.arpa' PTR shelly-25.viehai.at. Feb 4 19:54:42 srv4hai dhcpd[5037]: Added reverse map from 125.12.168.192.in-addr.arpa. to shelly-25.viehai.at Feb 4 19:54:42 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-25' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf' Feb 4 19:54:44 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-25' - shIP/2:'192.168.12.125' Feb 4 19:54:44 srv4hai conf_shelly.sh: SHELLY: usage/name 'Küchenlicht' already set for '192.168.12.125' Feb 4 19:54:44 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(0)' - allready transmitted - skipping Feb 4 19:54:44 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(1)' - allready transmitted - skipping Feb 4 19:54:44 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(2)' - allready transmitted - skipping Feb 4 19:54:44 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(3)' - allready transmitted - skipping Feb 4 19:54:44 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(4)' - allready transmitted - skipping Feb 4 19:54:44 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(5)' - allready transmitted - skipping Feb 4 19:54:44 srv4hai conf_shelly.sh: SHELLY:'shelly-25' out:0 ON : MISSING Feb 4 19:54:44 srv4hai conf_shelly.sh: SHELLY:'shelly-25' out:0 OFF: MISSING Feb 4 19:54:52 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1707072892 - 'ping_SP_0' Feb 4 19:54:52 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Feb 4 19:54:53 srv4hai named[14530]: resolver priming query complete Feb 4 19:55:01 srv4hai CRON[15879]: (root) CMD (/etc/linetest/linetest.sh) Feb 4 19:55:02 srv4hai named[14530]: resolver priming query complete Feb 4 19:55:22 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1707072922 - 'ping_SP_0' Feb 4 19:55:22 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Feb 4 19:55:52 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1707072952 - 'ping_SP_0' Feb 4 19:55:52 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Feb 4 19:55:59 srv4hai named[14530]: resolver priming query complete Feb 4 19:56:01 srv4hai CRON[15927]: (root) CMD (/etc/linetest/linetest.sh) Feb 4 19:56:02 srv4hai named[14530]: resolver priming query complete Feb 4 19:56:22 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1707072982 - 'ping_SP_0' Feb 4 19:56:22 srv4hai ping_SP[13380]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Feb 4 19:56:22 srv4hai dovecot: imap-login: Login: user= , method=PLAIN, rip=::1, lip=::1, mpid=15954, secured, session= Feb 4 19:56:22 srv4hai dovecot: imap(miglincit)<15954> : Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Feb 4 19:56:29 srv4hai postfix/smtpd[15955]: connect from unknown[194.48.251.112] Feb 4 19:56:29 srv4hai postfix/smtpd[15955]: warning: unknown[194.48.251.112]: SASL LOGIN authentication failed: Invalid authentication mechanism Feb 4 19:56:29 srv4hai postfix/smtpd[15955]: disconnect from unknown[194.48.251.112] ehlo=1 auth=0/1 quit=1 commands=2/3 Feb 4 19:56:38 srv4hai dhcpd[5037]: DHCPDISCOVER from 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:56:38 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.125 to 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:56:38 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Feb 4 19:56:38 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.125 Feb 4 19:56:38 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-25 Feb 4 19:56:38 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.125 (192.168.12.252) from 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:56:38 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.125 to 98:cd:ac:2d:b6:db via enp2s0 Feb 4 19:56:38 srv4hai named[14530]: client @0x7fc3201073f0 192.168.12.252#54337/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-25.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Feb 4 19:56:38 srv4hai named[14530]: client @0x7fc32811da30 192.168.12.252#37089/key rndc-key: signer "rndc-key" approved Feb 4 19:56:38 srv4hai named[14530]: client @0x7fc32811da30 192.168.12.252#37089/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' TXT Feb 4 19:56:38 srv4hai named[14530]: client @0x7fc32811da30 192.168.12.252#37089/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' TXT "00a4d627ad58f376691816e2e7457e7bae" Feb 4 19:56:38 srv4hai named[14530]: client @0x7fc32811da30 192.168.12.252#37089/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' A Feb 4 19:56:38 srv4hai named[14530]: client @0x7fc32811da30 192.168.12.252#37089/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' A 192.168.12.125 Feb 4 19:56:38 srv4hai dhcpd[5037]: Added new forward map from shelly-25.viehai.at to 192.168.12.125 Feb 4 19:56:38 srv4hai named[14530]: client @0x7fc3140255c0 192.168.12.252#46099/key rndc-key: signer "rndc-key" approved Feb 4 19:56:38 srv4hai named[14530]: client @0x7fc3140255c0 192.168.12.252#46099/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '125.12.168.192.in-addr.arpa' PTR Feb 4 19:56:38 srv4hai named[14530]: client @0x7fc3140255c0 192.168.12.252#46099/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '125.12.168.192.in-addr.arpa' PTR shelly-25.viehai.at. Feb 4 19:56:38 srv4hai dhcpd[5037]: Added reverse map from 125.12.168.192.in-addr.arpa. to shelly-25.viehai.at Feb 4 19:56:38 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-25' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf' Feb 4 19:56:39 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-25' - shIP/2:'192.168.12.125' Feb 4 19:56:39 srv4hai conf_shelly.sh: SHELLY: usage/name 'Küchenlicht' already set for '192.168.12.125' Feb 4 19:56:39 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(0)' - allready transmitted - skipping Feb 4 19:56:39 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(1)' - allready transmitted - skipping Feb 4 19:56:39 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(2)' - allready transmitted - skipping Feb 4 19:56:40 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(3)' - allready transmitted - skipping Feb 4 19:56:40 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(4)' - allready transmitted - skipping Feb 4 19:56:40 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(5)' - allready transmitted - skipping Feb 4 19:56:40 srv4hai conf_shelly.sh: SHELLY:'shelly-25' out:0 ON : MISSING Feb 4 19:56:40 srv4hai conf_shelly.sh: SHELLY:'shelly-25' out:0 OFF: MISSING Feb 4 19:56:40 srv4hai trace_events[16096]: SHELLY trace_events.sh inkludiert: TRCF:'/srv/www/viehai/shelly/meter/trace_20240204.txt' Feb 4 19:56:40 srv4hai activate_scenario[16096]: SHELLY scenario: 'LOG_gehen(log_gehen)' started Feb 4 19:56:40 srv4hai activate_scenario[16096]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-03:'Licht Vorzimmer'
finished