activate_scenario.sh
Sat Jan 18 23:27:33 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/18/_0.log)
vorher: 23:27:33.384
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: 23:27:33.516
Dauer: 132 msec
phName: 'phoneName:'1''
scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'
urls : 1
vorher : 23:27:33.339
nachher: 23:27:33.523
Dauer : 186 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/18//scene_vorraumOn_20250118_232733.txt'
syslog
Jan 18 23:24:01 srv4hai CRON[21304]: (root) CMD (/etc/linetest/linetest.sh)
Jan 18 23:24:52 srv4hai dhcpd[4995]: DHCPDISCOVER from 8c:aa:b5:61:a9:20 via enp2s0
Jan 18 23:24:52 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.107 to 8c:aa:b5:61:a9:20 via enp2s0
Jan 18 23:24:52 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 18 23:24:52 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.107
Jan 18 23:24:52 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-07
Jan 18 23:24:52 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.107 (192.168.12.252) from 8c:aa:b5:61:a9:20 via enp2s0
Jan 18 23:24:52 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.107 to 8c:aa:b5:61:a9:20 via enp2s0
Jan 18 23:24:52 srv4hai named[30406]: client @0x7f9348035d30 192.168.12.252#50837/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-07.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 18 23:24:52 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#49227/key rndc-key: signer "rndc-key" approved
Jan 18 23:24:52 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#49227/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-07.viehai.at' TXT
Jan 18 23:24:52 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#49227/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-07.viehai.at' TXT "00304107ff63db9ada5ee5a0bc2105bb05"
Jan 18 23:24:52 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#49227/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-07.viehai.at' A
Jan 18 23:24:52 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#49227/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-07.viehai.at' A 192.168.12.107
Jan 18 23:24:52 srv4hai dhcpd[4995]: Added new forward map from shelly-07.viehai.at to 192.168.12.107
Jan 18 23:24:52 srv4hai named[30406]: client @0x7f931002f1e0 192.168.12.252#51841/key rndc-key: signer "rndc-key" approved
Jan 18 23:24:52 srv4hai named[30406]: client @0x7f931002f1e0 192.168.12.252#51841/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '107.12.168.192.in-addr.arpa' PTR
Jan 18 23:24:52 srv4hai named[30406]: client @0x7f931002f1e0 192.168.12.252#51841/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '107.12.168.192.in-addr.arpa' PTR shelly-07.viehai.at.
Jan 18 23:24:52 srv4hai dhcpd[4995]: Added reverse map from 107.12.168.192.in-addr.arpa. to shelly-07.viehai.at
Jan 18 23:24:52 srv4hai common[21340]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan 18 23:24:52 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-07' - shIP/2:'' perform:'conf'
Jan 18 23:24:54 srv4hai mosquitto[29419]: New connection from 192.168.12.107 on port 1883.
Jan 18 23:24:54 srv4hai mosquitto[29419]: Client shelly1-8CAAB561A920 already connected, closing old connection.
Jan 18 23:24:54 srv4hai mosquitto[29419]: Socket error on client shelly1-8CAAB561A920, disconnecting.
Jan 18 23:24:54 srv4hai mosquitto[29419]: New client connected from 192.168.12.107 as shelly1-8CAAB561A920 (c1, k60, u'shmqtt').
Jan 18 23:24:54 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-07' - shIP/2:'192.168.12.107'
Jan 18 23:24:54 srv4hai conf_shelly.sh: SHELLY: usage/name 'SZ Nachtkästchen Thomas' already set for '192.168.12.107'
Jan 18 23:24:54 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(0)' - allready transmitted - skipping
Jan 18 23:24:54 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(1)' - allready transmitted - skipping
Jan 18 23:24:54 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(2)' - allready transmitted - skipping
Jan 18 23:24:54 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(3)' - allready transmitted - skipping
Jan 18 23:24:54 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(4)' - allready transmitted - skipping
Jan 18 23:25:01 srv4hai CRON[21458]: (root) CMD (/etc/linetest/linetest.sh)
Jan 18 23:25:51 srv4hai postfix/smtpd[21488]: connect from unknown[193.32.162.83]
Jan 18 23:25:55 srv4hai postfix/smtpd[21488]: warning: unknown[193.32.162.83]: SASL PLAIN authentication failed:
Jan 18 23:25:55 srv4hai postfix/smtpd[21488]: disconnect from unknown[193.32.162.83] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 18 23:26:01 srv4hai CRON[21502]: (root) CMD (/etc/linetest/linetest.sh)
Jan 18 23:26:24 srv4hai mosquitto[29419]: Client shelly1-8CAAB561A920 has exceeded timeout, disconnecting.
Jan 18 23:26:24 srv4hai mosquitto[29419]: Socket error on client shelly1-8CAAB561A920, disconnecting.
Jan 18 23:26:31 srv4hai postfix/smtpd[21488]: connect from unknown[193.32.162.73]
Jan 18 23:26:35 srv4hai postfix/smtpd[21518]: connect from unknown[193.32.162.81]
Jan 18 23:26:35 srv4hai postfix/smtpd[21488]: warning: unknown[193.32.162.73]: SASL PLAIN authentication failed:
Jan 18 23:26:35 srv4hai postfix/smtpd[21488]: disconnect from unknown[193.32.162.73] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 18 23:26:38 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=21527, secured, session=<2ahPhQIsDLgAAAAAAAAAAAAAAAAAAAAB>
Jan 18 23:26:38 srv4hai dovecot: imap(miglincit)<21527><2ahPhQIsDLgAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 18 23:26:39 srv4hai postfix/smtpd[21518]: warning: unknown[193.32.162.81]: SASL PLAIN authentication failed:
Jan 18 23:26:39 srv4hai postfix/smtpd[21518]: disconnect from unknown[193.32.162.81] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 18 23:26:52 srv4hai postfix/smtpd[21488]: connect from unknown[193.32.162.97]
Jan 18 23:26:57 srv4hai postfix/smtpd[21488]: warning: unknown[193.32.162.97]: SASL PLAIN authentication failed:
Jan 18 23:26:57 srv4hai postfix/smtpd[21488]: disconnect from unknown[193.32.162.97] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 18 23:27:00 srv4hai common[21540]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 18 23:27:00 srv4hai bt_scan[21540]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Jan 18 23:27:00 srv4hai bt_scan[21540]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Jan 18 23:27:00 srv4hai common[21571]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 18 23:27:00 srv4hai ping_SP[21571]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jan 18 23:27:00 srv4hai common[21592]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 18 23:27:00 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'0'=1737239220-1737239220
Jan 18 23:27:00 srv4hai check_presence[21592]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY} and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jan 18 23:27:00 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'0'=1737239220-1737239220
Jan 18 23:27:00 srv4hai check_presence[21592]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jan 18 23:27:00 srv4hai check_presence[21592]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(__/__) (__/__)' - anyPresent: 'false' - otherPresent:'false'
Jan 18 23:27:01 srv4hai postfix/pickup[19546]: 08F5C63463: uid=33 from=
Jan 18 23:27:01 srv4hai postfix/cleanup[21669]: 08F5C63463: message-id=<20250118222701.08F5C63463@mail.viehai.at>
Jan 18 23:27:01 srv4hai postfix/qmgr[8566]: 08F5C63463: from=, size=7910, nrcpt=1 (queue active)
Jan 18 23:27:01 srv4hai check_presence[21592]: SHELLY - check 'coming': anyPresent(false) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
Jan 18 23:27:01 srv4hai check_presence[21592]: SHELLY (ping_SP__bt_scan)-(0)-coming: NOT activate_scenario.shtml: vorraumOn
Jan 18 23:27:01 srv4hai ping_SP[21571]: SHELLY check_presence.sh coming 0 ping_SP__bt_scan
Jan 18 23:27:01 srv4hai ping_SP[21571]: SHELLY - new process for '192.168.12.61' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1737239221
Jan 18 23:27:01 srv4hai CRON[21710]: (root) CMD (/etc/linetest/linetest.sh)
Jan 18 23:27:02 srv4hai postfix/relay/smtp[21676]: 08F5C63463: to=, relay=mx01.nic.name[209.131.159.47]:25, delay=0.99, delays=0.03/0.01/0.69/0.27, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as C64D060017)
Jan 18 23:27:02 srv4hai postfix/qmgr[8566]: 08F5C63463: removed
Jan 18 23:27:02 srv4hai postfix/smtpd[21518]: connect from unknown[193.32.162.66]
Jan 18 23:27:06 srv4hai postfix/smtpd[21518]: warning: unknown[193.32.162.66]: SASL PLAIN authentication failed:
Jan 18 23:27:06 srv4hai postfix/smtpd[21518]: disconnect from unknown[193.32.162.66] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 18 23:27:11 srv4hai dhcpd[4995]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan 18 23:27:11 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 18 23:27:11 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 18 23:27:11 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 18 23:27:11 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 18 23:27:11 srv4hai common[21723]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 18 23:27:14 srv4hai ping_SP[21571]: SHELLY (0)- ping 192.168.12.61 0 not answered (1) @~1737239234 - 'ping_SP_0'
Jan 18 23:27:16 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan 18 23:27:17 srv4hai fetchmail[1651]: 61735 messages (61734 seen) for tmiglinci at mail.akis.at (762433709 octets).
Jan 18 23:27:17 srv4hai postfix/smtpd[21488]: connect from localhost[127.0.0.1]
Jan 18 23:27:17 srv4hai postfix/smtpd[21488]: A4060631BE: client=localhost[127.0.0.1]
Jan 18 23:27:17 srv4hai postfix/cleanup[21669]: A4060631BE: message-id=<20250118222701.08F5C63463@mail.viehai.at>
Jan 18 23:27:17 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:61735 of 61735 (8886 octets) not flushed
Jan 18 23:27:17 srv4hai postfix/qmgr[8566]: A4060631BE: from=, size=9180, nrcpt=1 (queue active)
Jan 18 23:27:17 srv4hai postfix/smtpd[21488]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Jan 18 23:27:17 srv4hai postfix/local[21751]: A4060631BE: to=, relay=local, delay=0.06, delays=0.05/0.01/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 18 23:27:17 srv4hai postfix/qmgr[8566]: A4060631BE: removed
Jan 18 23:27:18 srv4hai fetchmail[1651]: 11404 messages (11404 seen) for srozum at mail.akis.at (1359477688 octets).
Jan 18 23:27:18 srv4hai fetchmail[1651]: 28398 messages (28398 seen) for mrozum at mail.akis.at (575451719 octets).
Jan 18 23:27:19 srv4hai fetchmail[1651]: 1162 messages (1162 seen) for admin@bastelstube.wien at pop3.world4you.com (52206525 octets).
Jan 18 23:27:21 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jan 18 23:27:21 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 18 23:27:21 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 18 23:27:21 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 18 23:27:21 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 18 23:27:21 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 18 23:27:21 srv4hai common[21764]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 18 23:27:22 srv4hai common[21778]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 18 23:27:31 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jan 18 23:27:31 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 18 23:27:31 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 18 23:27:31 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 18 23:27:31 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 18 23:27:31 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 18 23:27:31 srv4hai named[30406]: client @0x7f932c0b5090 192.168.12.252#47119/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 18 23:27:31 srv4hai common[21811]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 18 23:27:32 srv4hai bt_scan[21778]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Jan 18 23:27:32 srv4hai bt_scan[21778]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62'
Jan 18 23:27:32 srv4hai common[21842]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 18 23:27:32 srv4hai ping_SP[21842]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jan 18 23:27:32 srv4hai common[21863]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 18 23:27:33 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'3'=1737239253-1737239250
Jan 18 23:27:33 srv4hai check_presence[21863]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jan 18 23:27:33 srv4hai check_presence[21863]: SHELLY (ping_SP__bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.TRY' for what: 'coming'
Jan 18 23:27:33 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'3'=1737239253-1737239250
Jan 18 23:27:33 srv4hai check_presence[21863]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jan 18 23:27:33 srv4hai check_presence[21863]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(BT/TRY) (BT/__)' - anyPresent: 'true' - otherPresent:'true'
Jan 18 23:27:33 srv4hai check_presence[21863]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
Jan 18 23:27:33 srv4hai check_presence[21863]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn
Jan 18 23:27:33 srv4hai activate_scenario[21978]: SHELLY last scenario: 'offAll' @ '174945' from 'scene_offAll_20250118_174945.txt' - delta=12
Jan 18 23:27:33 srv4hai activate_scenario[21978]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250118232733 20250118174945 -f '%S'
Jan 18 23:27:33 srv4hai activate_scenario[21978]: SHELLY new scenario: 'vorraumOn' different - GO ON
Jan 18 23:27:33 srv4hai activate_scenario[21978]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jan 18 23:27:33 srv4hai activate_scenario[21978]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'1'
finished