activate_scenario.sh
Thu Jan 4 20:12:41 CET 2024
scenario: LOG_gehen
urls : 0
vorher : 20:12:41.442
nachher: 20:12:41.448
Dauer : 7 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/04/scene_LOG_gehen_20240104_201241.txt'
Jan 4 20:09:01 srv4hai CRON[3548]: (root) CMD (/etc/linetest/linetest.sh) Jan 4 20:09:01 srv4hai CRON[3549]: (root) CMD ( [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi) Jan 4 20:09:01 srv4hai systemd[1]: Starting Clean php session files... Jan 4 20:09:01 srv4hai systemd[1]: phpsessionclean.service: Succeeded. Jan 4 20:09:01 srv4hai systemd[1]: Started Clean php session files. Jan 4 20:09:01 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:02 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:08 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:13 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:13 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=3647, secured, session= Jan 4 20:09:13 srv4hai dovecot: imap(rozumm)<3647> : Logged out in=92 out=1059 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jan 4 20:09:14 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704395354 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 4 20:09:15 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:17 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:20 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:22 srv4hai ping_SP.sh: SHELLY (1) - pinging 192.168.12.62 0 sucessfully @~1704395362 - '/srv/www/viehai/shelly//meter/ping_SP_1' Jan 4 20:09:29 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:30 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:32 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:33 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:34 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:35 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:36 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:36 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 4 20:09:36 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 4 20:09:41 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:44 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704395384 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 4 20:09:45 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:50 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:51 srv4hai named[14530]: resolver priming query complete Jan 4 20:09:52 srv4hai ping_SP.sh: SHELLY (1) - pinging 192.168.12.62 0 sucessfully @~1704395392 - '/srv/www/viehai/shelly//meter/ping_SP_1' Jan 4 20:09:55 srv4hai named[14530]: resolver priming query complete Jan 4 20:10:00 srv4hai named[14530]: resolver priming query complete Jan 4 20:10:01 srv4hai CRON[3676]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh) Jan 4 20:10:01 srv4hai CRON[3677]: (root) CMD (/etc/linetest/linetest.sh) Jan 4 20:10:01 srv4hai meter.sh: SHELLY meter.sh started Jan 4 20:10:01 srv4hai named[14530]: resolver priming query complete Jan 4 20:10:05 srv4hai named[14530]: resolver priming query complete Jan 4 20:10:07 srv4hai named[14530]: resolver priming query complete Jan 4 20:10:13 srv4hai dovecot: imap-login: Login: user= , method=PLAIN, rip=::1, lip=::1, mpid=3878, secured, session=<0YgxeyMOjpMAAAAAAAAAAAAAAAAAAAAB> Jan 4 20:10:13 srv4hai dovecot: imap(rozumm)<3878><0YgxeyMOjpMAAAAAAAAAAAAAAAAAAAAB>: Logged out in=92 out=1059 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jan 4 20:10:14 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704395414 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 4 20:10:22 srv4hai ping_SP.sh: SHELLY (1) - pinging 192.168.12.62 0 sucessfully @~1704395422 - '/srv/www/viehai/shelly//meter/ping_SP_1' Jan 4 20:10:30 srv4hai named[14530]: resolver priming query complete Jan 4 20:10:31 srv4hai named[14530]: resolver priming query complete Jan 4 20:10:39 srv4hai named[14530]: resolver priming query complete Jan 4 20:10:40 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 4 20:10:40 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 4 20:10:44 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704395444 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 4 20:10:46 srv4hai named[14530]: resolver priming query complete Jan 4 20:10:52 srv4hai ping_SP.sh: SHELLY (1) - pinging 192.168.12.62 0 sucessfully @~1704395452 - '/srv/www/viehai/shelly//meter/ping_SP_1' Jan 4 20:11:01 srv4hai CRON[4044]: (root) CMD (/etc/linetest/linetest.sh) Jan 4 20:11:01 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:08 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:09 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:11 srv4hai meter.sh: SHELLY meter.sh ended Jan 4 20:11:13 srv4hai dovecot: imap-login: Login: user= , method=PLAIN, rip=::1, lip=::1, mpid=4073, secured, session= Jan 4 20:11:13 srv4hai dovecot: imap(rozumm)<4073> : Logged out in=92 out=1059 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jan 4 20:11:14 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704395474 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 4 20:11:21 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:22 srv4hai ping_SP.sh: SHELLY (1) - pinging 192.168.12.62 0 sucessfully @~1704395482 - '/srv/www/viehai/shelly//meter/ping_SP_1' Jan 4 20:11:28 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:29 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:29 srv4hai postfix/smtpd[4087]: connect from smtp.akis.at[95.129.200.85] Jan 4 20:11:29 srv4hai postfix/smtpd[4087]: EA2DA6011E: client=smtp.akis.at[95.129.200.85] Jan 4 20:11:30 srv4hai postfix/cleanup[4091]: EA2DA6011E: message-id=<23f1d4b8-3e92-4ecb-a9b7-c5cc8439b1ea@email.android.com> Jan 4 20:11:30 srv4hai postfix/qmgr[28610]: EA2DA6011E: from= , size=1432, nrcpt=1 (queue active) Jan 4 20:11:30 srv4hai postfix/smtpd[4087]: disconnect from smtp.akis.at[95.129.200.85] ehlo=2 starttls=1 mail=1 rcpt=1 data=1 quit=1 commands=7 Jan 4 20:11:30 srv4hai postfix/local[4092]: EA2DA6011E: to= , orig_to= , relay=local, delay=0.12, delays=0.09/0.01/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail) Jan 4 20:11:30 srv4hai postfix/qmgr[28610]: EA2DA6011E: removed Jan 4 20:11:33 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:37 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:41 srv4hai bt_scan.sh: SHELLY - phoneName: 'FP4_Thomas' / '0' Jan 4 20:11:41 srv4hai bt_scan.sh: SHELLY - ping_SP.sh started for BTmac: '0' Jan 4 20:11:41 srv4hai ping_SP.sh: SHELLY ping_SP.sh started Jan 4 20:11:41 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:41 srv4hai check_presence.sh: SHELLY (0) found './meter/ping_SP_0' more than one (1) line for what: 'coming' Jan 4 20:11:41 srv4hai check_presence.sh: SHELLY (0) set what to 'presence' Jan 4 20:11:41 srv4hai check_presence.sh: SHELLY (0) found './meter/ping_SP_1' more than one (1) line for what: 'presence' Jan 4 20:11:41 srv4hai check_presence.sh: SHELLY (0) what: 'presence' - persPresent: 'scanBT/ping, scanBT/ping, false/no IP,' - anyPresent: 'true' Jan 4 20:11:41 srv4hai check_presence.sh: SHELLY (0)-presence: NOT activate_scenario.shtml: test_41_OFF Jan 4 20:11:41 srv4hai ping_SP.sh: SHELLY - running process: '17436' - '/srv/www/viehai/shelly//meter/ping_SP_0' - exiting Jan 4 20:11:43 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:44 srv4hai dhcpd[1107]: DHCPDISCOVER from 00:22:61:a1:fb:40 via enp2s0 Jan 4 20:11:44 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.17 to 00:22:61:a1:fb:40 via enp2s0 Jan 4 20:11:45 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704395505 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 4 20:11:52 srv4hai ping_SP.sh: SHELLY (1) - pinging 192.168.12.62 0 sucessfully @~1704395512 - '/srv/www/viehai/shelly//meter/ping_SP_1' Jan 4 20:11:54 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:55 srv4hai named[14530]: resolver priming query complete Jan 4 20:11:58 srv4hai named[14530]: resolver priming query complete Jan 4 20:12:01 srv4hai named[14530]: resolver priming query complete Jan 4 20:12:01 srv4hai CRON[4154]: (root) CMD (/etc/linetest/linetest.sh) Jan 4 20:12:11 srv4hai named[14530]: resolver priming query complete Jan 4 20:12:13 srv4hai dovecot: imap-login: Login: user= , method=PLAIN, rip=::1, lip=::1, mpid=4162, secured, session= Jan 4 20:12:13 srv4hai dovecot: imap(rozumm)<4162> : Logged out in=92 out=1059 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jan 4 20:12:14 srv4hai named[14530]: resolver priming query complete Jan 4 20:12:15 srv4hai ping_SP.sh: SHELLY (0) - pinging 192.168.12.61 0 sucessfully @~1704395535 - '/srv/www/viehai/shelly//meter/ping_SP_0' Jan 4 20:12:17 srv4hai dhcpd[1107]: DHCPDISCOVER from 98:cd:ac:2d:b6:db via enp2s0 Jan 4 20:12:17 srv4hai dhcpd[1107]: DHCPOFFER on 192.168.12.125 to 98:cd:ac:2d:b6:db via enp2s0 Jan 4 20:12:17 srv4hai dhcpd[1107]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh Jan 4 20:12:17 srv4hai dhcpd[1107]: execute_statement argv[1] = 192.168.12.125 Jan 4 20:12:17 srv4hai dhcpd[1107]: execute_statement argv[2] = shelly-25 Jan 4 20:12:17 srv4hai dhcpd[1107]: DHCPREQUEST for 192.168.12.125 (192.168.12.252) from 98:cd:ac:2d:b6:db via enp2s0 Jan 4 20:12:17 srv4hai dhcpd[1107]: DHCPACK on 192.168.12.125 to 98:cd:ac:2d:b6:db via enp2s0 Jan 4 20:12:17 srv4hai named[14530]: client @0x7fc32811da30 192.168.12.252#37587/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-25.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 4 20:12:17 srv4hai named[14530]: client @0x7fc31405af30 192.168.12.252#53649/key rndc-key: signer "rndc-key" approved Jan 4 20:12:17 srv4hai named[14530]: client @0x7fc31405af30 192.168.12.252#53649/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' TXT Jan 4 20:12:17 srv4hai named[14530]: client @0x7fc31405af30 192.168.12.252#53649/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' TXT "00a4d627ad58f376691816e2e7457e7bae" Jan 4 20:12:17 srv4hai named[14530]: client @0x7fc31405af30 192.168.12.252#53649/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-25.viehai.at' A Jan 4 20:12:17 srv4hai named[14530]: client @0x7fc31405af30 192.168.12.252#53649/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-25.viehai.at' A 192.168.12.125 Jan 4 20:12:17 srv4hai dhcpd[1107]: Added new forward map from shelly-25.viehai.at to 192.168.12.125 Jan 4 20:12:17 srv4hai named[14530]: client @0x7fc314083510 192.168.12.252#36073/key rndc-key: signer "rndc-key" approved Jan 4 20:12:17 srv4hai named[14530]: client @0x7fc314083510 192.168.12.252#36073/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '125.12.168.192.in-addr.arpa' PTR Jan 4 20:12:17 srv4hai named[14530]: client @0x7fc314083510 192.168.12.252#36073/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. Jan 4 20:12:17 srv4hai dhcpd[1107]: Added reverse map from 125.12.168.192.in-addr.arpa. to shelly-25.viehai.at Jan 4 20:12:17 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-25' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf' Jan 4 20:12:18 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-25' - shIP/2:'192.168.12.125' Jan 4 20:12:18 srv4hai conf_shelly.sh: SHELLY: usage/name 'Küchenlicht' already set for '192.168.12.125' Jan 4 20:12:18 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(0)' - allready transmitted - skipping Jan 4 20:12:18 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(1)' - allready transmitted - skipping Jan 4 20:12:18 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(2)' - allready transmitted - skipping Jan 4 20:12:18 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(3)' - allready transmitted - skipping Jan 4 20:12:18 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(4)' - allready transmitted - skipping Jan 4 20:12:18 srv4hai conf_shelly.sh: SHELLY:'shelly-25' 'conf(5)' - allready transmitted - skipping Jan 4 20:12:18 srv4hai conf_shelly.sh: SHELLY:'shelly-25' out:0 ON : MISSING Jan 4 20:12:18 srv4hai conf_shelly.sh: SHELLY:'shelly-25' out:0 OFF: MISSING Jan 4 20:12:22 srv4hai ping_SP.sh: SHELLY (1) - pinging 192.168.12.62 0 sucessfully @~1704395542 - '/srv/www/viehai/shelly//meter/ping_SP_1' Jan 4 20:12:29 srv4hai named[14530]: resolver priming query complete
finished