activate_scenario.sh
Tue Jan 14 19:43:58 CET 2025
scenario: vorraumOn
phoneName: 0
'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/14/_0.log)
vorher: 19:43:58.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: 19:43:58.500
Dauer: 115 msec
phName: 'phoneName:'0''
scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'
urls : 1
vorher : 19:43:58.337
nachher: 19:43:58.506
Dauer : 171 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/14//scene_vorraumOn_20250114_194358.txt'
syslog
Jan 14 19:40:01 srv4hai CRON[14837]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Jan 14 19:40:01 srv4hai CRON[14836]: (root) CMD (/etc/linetest/linetest.sh)
Jan 14 19:40:01 srv4hai common[14838]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/meter.sh
Jan 14 19:40:01 srv4hai meter.sh: SHELLY meter.sh started
Jan 14 19:40:04 srv4hai meter.sh: SHELLY 'shelly-29/KÜ Schalter Herdzeile' - type: 'shelly-i3' ignoring
Jan 14 19:40:04 srv4hai meter.sh: SHELLY 'shelly-28/KÜ Schalter Nasszeile' - type: 'shelly-i3' ignoring
Jan 14 19:40:10 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster' - type: 'shelly-BTN' ignoring
Jan 14 19:40:11 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter' - type: 'shelly-BTN' ignoring
Jan 14 19:40:11 srv4hai meter.sh: SHELLY 'shelly-37/TB Klima' - type: 'shelly-ht' ignoring
Jan 14 19:40:11 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen' - status: 'OOS' ignoring
Jan 14 19:40:11 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon' - type: 'shelly-ht-plus' ignoring
Jan 14 19:40:14 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED': OFFLINE, resp. not answering within connect-timeout 2.500000s
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss': OFFLINE, resp. not answering within connect-timeout 2.500000s
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD' - status: 'OOS' ignoring
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3' - status: 'OOS' ignoring
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD' - status: 'OOS' ignoring
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD' - status: 'OOS' ignoring
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD' - status: 'OOS' ignoring
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-09a/Inbetriebnahme - 20210720 - Defekt' - status: 'defect' ignoring
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-09b/Sophie Licht - 20230404 - Defekt' - status: 'defect' ignoring
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN' - status: 'defect' ignoring
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417' - status: 'defect' ignoring
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem' - status: 'defect' ignoring
Jan 14 19:40:16 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722' - status: 'defect' ignoring
Jan 14 19:40:17 srv4hai meter.sh: SHELLY 'shelly-01a/WZ Licht Esstisch - 20241208 kein WLAN' - status: 'DFC' ignoring
Jan 14 19:40:17 srv4hai meter.sh: SHELLY 'shelly-43/43-tbd' - status: 'OOS' ignoring
Jan 14 19:40:17 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD' - status: 'OOS' ignoring
Jan 14 19:40:17 srv4hai meter.sh: SHELLY 'shelly-46/46-TBD' - status: 'OOS' ignoring
Jan 14 19:40:20 srv4hai meter.sh: SHELLY 'shelly-50/50-TBD': OFFLINE, resp. not answering within connect-timeout 2.500000s
Jan 14 19:40:20 srv4hai meter.sh: SHELLY 'shelly-59/Werkstatt Schalter Kellertür' - type: 'shelly-i3' ignoring
Jan 14 19:40:20 srv4hai common[15847]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_shelly.sh
Jan 14 19:40:20 srv4hai check_shelly.sh: SHELLY last scenery executed: 'offAll'
Jan 14 19:40:20 srv4hai check_shelly.sh: SHELLY found '1' active shelly outputs
Jan 14 19:40:20 srv4hai meter.sh: SHELLY meter.sh ended
Jan 14 19:40:23 srv4hai activate_scenario[15901]: SHELLY last scenario: 'offAll' @ '191739' from 'scene_offAll_20250114_191739.txt' - delta=16
Jan 14 19:40:23 srv4hai activate_scenario[15901]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250114194023 20250114191739 -f '%S'
Jan 14 19:40:23 srv4hai activate_scenario[15901]: SHELLY new scenario: 'sekr_UM' different - GO ON
Jan 14 19:40:23 srv4hai activate_scenario[15901]: SHELLY scenario: 'sekr_UM(sekr_um)' started
Jan 14 19:40:23 srv4hai activate_scenario[15901]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-10:'WZ Licht Bücherregal'
Jan 14 19:40:23 srv4hai activate_scenario[15901]: SHELLY scenario: 'sekr_UM(sekr_um)' TO BE EXECUTED, shelly-10:'WZ Licht Bücherregal'
Jan 14 19:40:23 srv4hai postfix/pickup[14187]: 2C59D63463: uid=33 from=
Jan 14 19:40:23 srv4hai postfix/cleanup[15966]: 2C59D63463: message-id=<20250114184023.2C59D63463@mail.viehai.at>
Jan 14 19:40:23 srv4hai postfix/qmgr[8566]: 2C59D63463: from=, size=6772, nrcpt=1 (queue active)
Jan 14 19:40:23 srv4hai postfix/local[15979]: 2C59D63463: to=, orig_to=, relay=local, delay=0.03, delays=0.02/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 14 19:40:23 srv4hai postfix/cleanup[15966]: 313AD63464: message-id=<20250114184023.313AD63464@mail.viehai.at>
Jan 14 19:40:23 srv4hai activate_scenario[15901]: SHELLY: scenario: 'sekr_UM(sekr_um)'-'shelly-23'-'WZ Licht Sofa' --> '0?turn=toggle'
Jan 14 19:40:23 srv4hai postfix/bounce[15980]: 2C59D63463: sender non-delivery notification: 313AD63464
Jan 14 19:40:23 srv4hai postfix/qmgr[8566]: 313AD63464: from=<>, size=8691, nrcpt=1 (queue active)
Jan 14 19:40:23 srv4hai postfix/qmgr[8566]: 2C59D63463: removed
Jan 14 19:40:23 srv4hai proc_url[15984]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/14/_0.log' - shellyUsage:'WZ Licht Sofa' - scUrl:'http://192.168.12.123/relay/0?turn=toggle' - phName:'shelly-10:'WZ Licht Bücherregal''
Jan 14 19:40:23 srv4hai postfix/local[15979]: 313AD63464: to=, relay=local, delay=0.01, delays=0/0/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 14 19:40:23 srv4hai postfix/qmgr[8566]: 313AD63464: removed
Jan 14 19:40:23 srv4hai activate_scenario[15901]: SHELLY scenario: 'sekr_UM(sekr_um)' took 64 msec, shelly-10:'WZ Licht Bücherregal'
Jan 14 19:40:23 srv4hai postfix/anvil[14171]: statistics: max connection rate 1/60s for (smtp:154.203.197.109) at Jan 14 19:32:38
Jan 14 19:40:23 srv4hai postfix/anvil[14171]: statistics: max connection count 1 for (smtp:154.203.197.109) at Jan 14 19:32:38
Jan 14 19:40:23 srv4hai postfix/anvil[14171]: statistics: max cache size 1 at Jan 14 19:32:38
Jan 14 19:40:58 srv4hai ping_SP[14237]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1736880058 - 'ping_SP_1'
Jan 14 19:40:58 srv4hai ping_SP[14237]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 14 19:41:01 srv4hai CRON[16051]: (root) CMD (/etc/linetest/linetest.sh)
Jan 14 19:41:15 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan 14 19:41:25 srv4hai fetchmail[1651]: 61458 messages (61457 seen) for tmiglinci at mail.akis.at (740712590 octets).
Jan 14 19:41:25 srv4hai postfix/smtpd[16068]: connect from localhost[127.0.0.1]
Jan 14 19:41:25 srv4hai postfix/smtpd[16068]: 82D1C6004E: client=localhost[127.0.0.1]
Jan 14 19:41:25 srv4hai postfix/cleanup[15966]: 82D1C6004E: message-id=
Jan 14 19:41:25 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:61458 of 61458 (63643 octets) not flushed
Jan 14 19:41:25 srv4hai postfix/qmgr[8566]: 82D1C6004E: from=, size=63920, nrcpt=1 (queue active)
Jan 14 19:41:25 srv4hai postfix/local[15979]: 82D1C6004E: to=, relay=local, delay=0.08, delays=0.07/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 14 19:41:25 srv4hai postfix/qmgr[8566]: 82D1C6004E: removed
Jan 14 19:41:25 srv4hai postfix/smtpd[16068]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Jan 14 19:41:27 srv4hai postfix/smtpd[16068]: connect from unknown[154.203.197.109]
Jan 14 19:41:28 srv4hai postfix/smtpd[16068]: warning: unknown[154.203.197.109]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jan 14 19:41:28 srv4hai postfix/smtpd[16068]: lost connection after AUTH from unknown[154.203.197.109]
Jan 14 19:41:28 srv4hai postfix/smtpd[16068]: disconnect from unknown[154.203.197.109] ehlo=1 auth=0/1 commands=1/2
Jan 14 19:41:30 srv4hai fetchmail[1651]: 11378 messages (11378 seen) for srozum at mail.akis.at (1357658555 octets).
Jan 14 19:41:32 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=16082, secured, session=
Jan 14 19:41:32 srv4hai dovecot: imap(miglincit)<16082>: Logged out in=2004 out=167488 deleted=0 expunged=0 trashed=0 hdr_count=257 hdr_bytes=92758 body_count=0 body_bytes=0
Jan 14 19:41:35 srv4hai fetchmail[1651]: 28330 messages (28330 seen) for mrozum at mail.akis.at (569573002 octets).
Jan 14 19:41:36 srv4hai fetchmail[1651]: 1162 messages (1162 seen) for admin@bastelstube.wien at pop3.world4you.com (52206525 octets).
Jan 14 19:42:01 srv4hai CRON[16101]: (root) CMD (/etc/linetest/linetest.sh)
Jan 14 19:42:12 srv4hai ping_SP[14237]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1736880132 - 'ping_SP_1'
Jan 14 19:42:12 srv4hai ping_SP[14237]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 14 19:43:01 srv4hai CRON[16153]: (root) CMD (/etc/linetest/linetest.sh)
Jan 14 19:43:20 srv4hai mosquitto[29419]: Client shellyplus1-441793a58ae4 has exceeded timeout, disconnecting.
Jan 14 19:43:20 srv4hai mosquitto[29419]: Socket error on client shellyplus1-441793a58ae4, disconnecting.
Jan 14 19:43:20 srv4hai dhcpd[4995]: DHCPDISCOVER from e0:98:06:a9:f3:81 via enp2s0
Jan 14 19:43:20 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.104 to e0:98:06:a9:f3:81 via enp2s0
Jan 14 19:43:21 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 14 19:43:21 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.104
Jan 14 19:43:21 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-04
Jan 14 19:43:21 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.104 (192.168.12.252) from e0:98:06:a9:f3:81 via enp2s0
Jan 14 19:43:21 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.104 to e0:98:06:a9:f3:81 via enp2s0
Jan 14 19:43:21 srv4hai named[30406]: client @0x7f93480ae320 192.168.12.252#50323/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-04.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 14 19:43:21 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#45739/key rndc-key: signer "rndc-key" approved
Jan 14 19:43:21 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#45739/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-04.viehai.at' TXT
Jan 14 19:43:21 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#45739/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-04.viehai.at' TXT "008d1b202806eda236ba1bc6f43dd868cf"
Jan 14 19:43:21 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#45739/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-04.viehai.at' A
Jan 14 19:43:21 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#45739/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-04.viehai.at' A 192.168.12.104
Jan 14 19:43:21 srv4hai dhcpd[4995]: Added new forward map from shelly-04.viehai.at to 192.168.12.104
Jan 14 19:43:21 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#50763/key rndc-key: signer "rndc-key" approved
Jan 14 19:43:21 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#50763/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '104.12.168.192.in-addr.arpa' PTR
Jan 14 19:43:21 srv4hai named[30406]: client @0x7f934c0557f0 192.168.12.252#50763/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '104.12.168.192.in-addr.arpa' PTR shelly-04.viehai.at.
Jan 14 19:43:21 srv4hai dhcpd[4995]: Added reverse map from 104.12.168.192.in-addr.arpa. to shelly-04.viehai.at
Jan 14 19:43:21 srv4hai common[16171]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jan 14 19:43:21 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-04' - shIP/2:'' perform:'conf'
Jan 14 19:43:22 srv4hai mosquitto[29419]: New connection from 192.168.12.104 on port 1883.
Jan 14 19:43:22 srv4hai mosquitto[29419]: Client shelly1pm-E09806A9F381 already connected, closing old connection.
Jan 14 19:43:22 srv4hai mosquitto[29419]: Socket error on client shelly1pm-E09806A9F381, disconnecting.
Jan 14 19:43:22 srv4hai mosquitto[29419]: New client connected from 192.168.12.104 as shelly1pm-E09806A9F381 (c1, k60, u'shmqtt').
Jan 14 19:43:22 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-04' - shIP/2:'192.168.12.104'
Jan 14 19:43:22 srv4hai conf_shelly.sh: SHELLY: usage/name 'BAD Licht' already set for '192.168.12.104'
Jan 14 19:43:22 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(0)' - allready transmitted - skipping
Jan 14 19:43:22 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(1)' - allready transmitted - skipping
Jan 14 19:43:22 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(2)' - allready transmitted - skipping
Jan 14 19:43:22 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(3)' - allready transmitted - skipping
Jan 14 19:43:22 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(4)' - allready transmitted - skipping
Jan 14 19:43:22 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(5)' - allready transmitted - skipping
Jan 14 19:43:23 srv4hai nmbd[2172]: [2025/01/14 19:43:23.628059, 0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
Jan 14 19:43:23 srv4hai nmbd[2172]: find_domain_master_name_query_fail:
Jan 14 19:43:23 srv4hai nmbd[2172]: Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
Jan 14 19:43:23 srv4hai nmbd[2172]: Unable to sync browse lists in this workgroup.
Jan 14 19:43:25 srv4hai ping_SP[14237]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1736880205 - 'ping_SP_1'
Jan 14 19:43:25 srv4hai ping_SP[14237]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 14 19:43:47 srv4hai common[16321]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 14 19:43:48 srv4hai dhcpd[4995]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan 14 19:43:48 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 14 19:43:48 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 14 19:43:48 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 14 19:43:48 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 14 19:43:48 srv4hai common[16335]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 14 19:43:57 srv4hai bt_scan[16321]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Jan 14 19:43:57 srv4hai bt_scan[16321]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Jan 14 19:43:57 srv4hai common[16373]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 14 19:43:57 srv4hai ping_SP[16373]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jan 14 19:43:57 srv4hai common[16394]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 14 19:43:58 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'2'=1736880238-1736880236
Jan 14 19:43:58 srv4hai check_presence[16394]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jan 14 19:43:58 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'2'=1736880238-1736880236
Jan 14 19:43:58 srv4hai check_presence[16394]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jan 14 19:43:58 srv4hai check_presence[16394]: SHELLY (ping_SP__bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jan 14 19:43:58 srv4hai check_presence[16394]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(BT/__) (BT/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Jan 14 19:43:58 srv4hai check_presence[16394]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_sekr_UM) - sceneONsmall(vorraumOn)
Jan 14 19:43:58 srv4hai check_presence[16394]: SHELLY (ping_SP__bt_scan)-(0)-coming: activate_scenario.shtml: vorraumOn
Jan 14 19:43:58 srv4hai activate_scenario[16510]: SHELLY last scenario: 'sekr_UM' @ '194023' from 'scene_sekr_UM_20250114_194023.txt' - delta=-35
Jan 14 19:43:58 srv4hai activate_scenario[16510]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250114194358 20250114194023 -f '%S'
Jan 14 19:43:58 srv4hai activate_scenario[16510]: SHELLY new scenario: 'vorraumOn' different - GO ON
Jan 14 19:43:58 srv4hai activate_scenario[16510]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jan 14 19:43:58 srv4hai activate_scenario[16510]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'0'
finished