activate_scenario.sh
Mon Jan 13 07:37:51 CET 2025
scenario: vorraumOn
phoneName: 1
'night' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'thomas@miglinci.name'
scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'
VZ Licht (/srv/www/viehai/shelly/log_scenarios/2025/01/13/_0.log)
vorher: 07:37:51.929
http://192.168.12.103/relay/0?turn=on |
|---|
"ison": true,
"has_timer": false,
"timer_started": 0,
"timer_duration": 0,
"timer_remaining": 0,
"overpower": false,
"source": "input"
|
nachher: 07:37:51.971
Dauer: 42 msec
phName: 'phoneName:'1''
scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'
urls : 1
vorher : 07:37:51.904
nachher: 07:37:51.977
Dauer : 73 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/13//scene_vorraumOn_20250113_073751.txt'
syslog
Jan 13 07:34:01 srv4hai CRON[20984]: (root) CMD (/etc/linetest/linetest.sh)
Jan 13 07:34:10 srv4hai ping_SP[31426]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1736750050 - 'ping_SP_0'
Jan 13 07:34:10 srv4hai ping_SP[31426]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 13 07:34:27 srv4hai systemd[1]: Started Run anacron jobs.
Jan 13 07:34:27 srv4hai anacron[21021]: Anacron 2.3 started on 2025-01-13
Jan 13 07:34:27 srv4hai anacron[21021]: Will run job `cron.daily' in 5 min.
Jan 13 07:34:27 srv4hai anacron[21021]: Jobs will be executed sequentially
Jan 13 07:34:48 srv4hai postfix/anvil[4274]: statistics: max connection rate 2/60s for (smtp:154.9.2.12) at Jan 13 07:30:55
Jan 13 07:34:48 srv4hai postfix/anvil[4274]: statistics: max connection count 1 for (smtp:123.117.155.84) at Jan 13 07:25:06
Jan 13 07:34:48 srv4hai postfix/anvil[4274]: statistics: max cache size 3 at Jan 13 07:25:06
Jan 13 07:35:01 srv4hai CRON[21036]: (root) CMD (/etc/linetest/linetest.sh)
Jan 13 07:35:13 srv4hai ping_SP[31426]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1736750113 - 'ping_SP_0'
Jan 13 07:35:13 srv4hai ping_SP[31426]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 13 07:35:29 srv4hai postfix/smtpd[21076]: connect from unknown[94.156.227.127]
Jan 13 07:35:29 srv4hai postfix/smtpd[21076]: warning: unknown[94.156.227.127]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jan 13 07:35:29 srv4hai postfix/smtpd[21076]: disconnect from unknown[94.156.227.127] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 13 07:36:01 srv4hai CRON[21092]: (root) CMD (/etc/linetest/linetest.sh)
Jan 13 07:36:16 srv4hai ping_SP[31426]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1736750176 - 'ping_SP_0'
Jan 13 07:36:16 srv4hai ping_SP[31426]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 13 07:36:45 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=21137, secured, session=
Jan 13 07:36:45 srv4hai dovecot: imap(miglincit)<21137>: Logged out in=1906 out=1284 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 13 07:36:51 srv4hai postfix/smtpd[21076]: connect from unknown[92.118.39.63]
Jan 13 07:36:55 srv4hai postfix/smtpd[21076]: warning: unknown[92.118.39.63]: SASL PLAIN authentication failed:
Jan 13 07:36:55 srv4hai postfix/smtpd[21076]: disconnect from unknown[92.118.39.63] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 13 07:37:01 srv4hai CRON[21149]: (root) CMD (/etc/linetest/linetest.sh)
Jan 13 07:37:19 srv4hai ping_SP[31426]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1736750239 - 'ping_SP_0'
Jan 13 07:37:19 srv4hai ping_SP[31426]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 13 07:37:24 srv4hai dhcpd[4995]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Jan 13 07:37:24 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Jan 13 07:37:27 srv4hai postfix/smtpd[21076]: connect from unknown[154.203.197.109]
Jan 13 07:37:27 srv4hai postfix/smtpd[21076]: warning: unknown[154.203.197.109]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jan 13 07:37:27 srv4hai postfix/smtpd[21076]: lost connection after AUTH from unknown[154.203.197.109]
Jan 13 07:37:27 srv4hai postfix/smtpd[21076]: disconnect from unknown[154.203.197.109] ehlo=1 auth=0/1 commands=1/2
Jan 13 07:37:37 srv4hai dhcpd[4995]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Jan 13 07:37:37 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Jan 13 07:37:37 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Jan 13 07:37:37 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.5
Jan 13 07:37:37 srv4hai dhcpd[4995]: execute_statement argv[2] = btscan1
Jan 13 07:37:37 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.5 (192.168.12.252) from 08:3a:8d:d0:46:5a via enp2s0
Jan 13 07:37:37 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Jan 13 07:37:37 srv4hai named[30406]: client @0x7f9348063d20 192.168.12.252#45327/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: btscan1.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 13 07:37:37 srv4hai named[30406]: client @0x7f931c09c730 192.168.12.252#40297/key rndc-key: signer "rndc-key" approved
Jan 13 07:37:37 srv4hai named[30406]: client @0x7f931c09c730 192.168.12.252#40297/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' TXT
Jan 13 07:37:37 srv4hai named[30406]: client @0x7f931c09c730 192.168.12.252#40297/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' TXT "000118916176265854cff71f762ffe0635"
Jan 13 07:37:37 srv4hai named[30406]: client @0x7f931c09c730 192.168.12.252#40297/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' A
Jan 13 07:37:37 srv4hai named[30406]: client @0x7f931c09c730 192.168.12.252#40297/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' A 192.168.12.5
Jan 13 07:37:37 srv4hai dhcpd[4995]: Added new forward map from btscan1.viehai.at to 192.168.12.5
Jan 13 07:37:37 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.5'(5) device 'btscan1'
Jan 13 07:37:37 srv4hai named[30406]: client @0x7f933010ba20 192.168.12.252#57763/key rndc-key: signer "rndc-key" approved
Jan 13 07:37:37 srv4hai named[30406]: client @0x7f933010ba20 192.168.12.252#57763/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '5.12.168.192.in-addr.arpa' PTR
Jan 13 07:37:37 srv4hai named[30406]: client @0x7f933010ba20 192.168.12.252#57763/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '5.12.168.192.in-addr.arpa' PTR btscan1.viehai.at.
Jan 13 07:37:37 srv4hai dhcpd[4995]: Added reverse map from 5.12.168.192.in-addr.arpa. to btscan1.viehai.at
Jan 13 07:37:37 srv4hai dhcpcommit.sh: SHELLY device 'btscan1' known and accepted
Jan 13 07:37:45 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan 13 07:37:46 srv4hai fetchmail[1651]: 61324 messages (61322 seen) for tmiglinci at mail.akis.at (729875119 octets).
Jan 13 07:37:46 srv4hai postfix/smtpd[21076]: connect from localhost[127.0.0.1]
Jan 13 07:37:46 srv4hai postfix/smtpd[21076]: 5275B6345A: client=localhost[127.0.0.1]
Jan 13 07:37:46 srv4hai postfix/cleanup[21205]: 5275B6345A: message-id=<20250113063240.f2863a66eeaa1e46@mail.gallupforum.at>
Jan 13 07:37:46 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:61323 of 61324 (11407 octets) not flushed
Jan 13 07:37:46 srv4hai postfix/qmgr[8566]: 5275B6345A: from=, size=11653, nrcpt=1 (queue active)
Jan 13 07:37:46 srv4hai postfix/local[21206]: 5275B6345A: to=, relay=local, delay=0.08, delays=0.06/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 13 07:37:46 srv4hai postfix/qmgr[8566]: 5275B6345A: removed
Jan 13 07:37:46 srv4hai postfix/smtpd[21076]: 657356345A: client=localhost[127.0.0.1]
Jan 13 07:37:46 srv4hai postfix/cleanup[21205]: 657356345A: message-id=
Jan 13 07:37:46 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:61324 of 61324 (33880 octets) not flushed
Jan 13 07:37:46 srv4hai postfix/qmgr[8566]: 657356345A: from=, size=34122, nrcpt=1 (queue active)
Jan 13 07:37:46 srv4hai postfix/smtpd[21076]: disconnect from localhost[127.0.0.1] ehlo=1 mail=2 rcpt=2 data=2 quit=1 commands=8
Jan 13 07:37:46 srv4hai postfix/local[21206]: 657356345A: to=, relay=local, delay=0.07, delays=0.05/0/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 13 07:37:46 srv4hai postfix/qmgr[8566]: 657356345A: removed
Jan 13 07:37:46 srv4hai fetchmail[1651]: 11372 messages (11372 seen) for srozum at mail.akis.at (1357284808 octets).
Jan 13 07:37:47 srv4hai fetchmail[1651]: 28299 messages (28299 seen) for mrozum at mail.akis.at (561585758 octets).
Jan 13 07:37:47 srv4hai fetchmail[1651]: 1162 messages (1162 seen) for admin@bastelstube.wien at pop3.world4you.com (52206525 octets).
Jan 13 07:37:51 srv4hai common[21212]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 13 07:37:51 srv4hai bt_scan[21212]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Jan 13 07:37:51 srv4hai bt_scan[21212]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62'
Jan 13 07:37:51 srv4hai common[21243]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 13 07:37:51 srv4hai ping_SP[21243]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jan 13 07:37:51 srv4hai common[21264]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 13 07:37:51 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'0'=1736750271-1736750271
Jan 13 07:37:51 srv4hai check_presence[21264]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jan 13 07:37:51 srv4hai check_presence[21264]: SHELLY (ping_SP__bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Jan 13 07:37:51 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'0'=1736750271-1736750271
Jan 13 07:37:51 srv4hai check_presence[21264]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY} and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jan 13 07:37:51 srv4hai check_presence[21264]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Jan 13 07:37:51 srv4hai check_presence[21264]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_bedlight_tom) - sceneONsmall(vorraumOn)
Jan 13 07:37:51 srv4hai check_presence[21264]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn
Jan 13 07:37:51 srv4hai activate_scenario[21369]: SHELLY last scenario: 'bedlight_tom' @ '070248' from 'scene_bedlight_tom_20250113_070248.txt' - delta=-3
Jan 13 07:37:51 srv4hai activate_scenario[21369]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250113073751 20250113070248 -f '%S'
Jan 13 07:37:51 srv4hai activate_scenario[21369]: SHELLY new scenario: 'vorraumOn' different - GO ON
Jan 13 07:37:51 srv4hai activate_scenario[21369]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jan 13 07:37:51 srv4hai activate_scenario[21369]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'1'
finished