activate_scenario.sh
Sun Feb 16 15:07:44 CET 2025
scenario: pcON
origin: dhcpcommit.sh-pchai7x

'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'null'

scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'

TB Schreibtischlampe (/srv/www/viehai/shelly/log_scenarios/2025/02/16/_0.log)

vorher: 15:07:44.539

http://192.168.12.120/relay/0?turn=on
  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "source": "http"

nachher: 15:07:44.570
Dauer: 30 msec phName: 'origin:'dhcpcommit.sh-pchai7x''


scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'

urls : 1
vorher : 15:07:44.514
nachher: 15:07:44.576
Dauer : 62 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/02/16//scene_pcON_20250216_150744.txt'


syslog

Feb 16 15:04:00 srv4hai common[13913]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:04:00 srv4hai common[13937]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:04:00 srv4hai common[13961]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:04:01 srv4hai CRON[13986]: (root) CMD (/etc/linetest/linetest.sh)
Feb 16 15:04:08 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=13998, secured, session=
Feb 16 15:04:08 srv4hai dovecot: imap(miglincit)<13998>: Logged out in=380 out=1234 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 16 15:04:20 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Feb 16 15:04:21 srv4hai fetchmail[1651]: 63774 messages (63773 seen) for tmiglinci at mail.akis.at (931383962 octets).
Feb 16 15:04:21 srv4hai postfix/smtpd[14005]: connect from localhost[127.0.0.1]
Feb 16 15:04:21 srv4hai postfix/smtpd[14005]: 533C96345A: client=localhost[127.0.0.1]
Feb 16 15:04:21 srv4hai postfix/cleanup[14008]: 533C96345A: message-id=<4upf2wu91awb.bHdCCwuHBwg89A1OMAjKKA2@tracking.kickstargo.com>
Feb 16 15:04:21 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:63774 of 63774 (61338 octets) not flushed
Feb 16 15:04:21 srv4hai postfix/qmgr[8566]: 533C96345A: from=, size=61622, nrcpt=1 (queue active)
Feb 16 15:04:21 srv4hai postfix/smtpd[14005]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Feb 16 15:04:21 srv4hai postfix/local[14009]: 533C96345A: to=, relay=local, delay=0.11, delays=0.08/0.02/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb 16 15:04:21 srv4hai postfix/qmgr[8566]: 533C96345A: removed
Feb 16 15:04:21 srv4hai fetchmail[1651]: 11546 messages (11546 seen) for srozum at mail.akis.at (1370379044 octets).
Feb 16 15:04:22 srv4hai fetchmail[1651]: 28985 messages (28984 seen) for mrozum at mail.akis.at (675775049 octets).
Feb 16 15:04:22 srv4hai postfix/smtpd[14005]: connect from localhost[127.0.0.1]
Feb 16 15:04:22 srv4hai postfix/smtpd[14005]: 699B96345A: client=localhost[127.0.0.1]
Feb 16 15:04:22 srv4hai postfix/cleanup[14008]: 699B96345A: message-id=
Feb 16 15:04:22 srv4hai fetchmail[1651]: reading message mrozum@mail.akis.at:28985 of 28985 (19343 octets) not flushed
Feb 16 15:04:22 srv4hai postfix/qmgr[8566]: 699B96345A: from=, size=19612, nrcpt=1 (queue active)
Feb 16 15:04:22 srv4hai postfix/smtpd[14005]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Feb 16 15:04:22 srv4hai postfix/local[14009]: 699B96345A: to=, relay=local, delay=0.07, delays=0.05/0/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb 16 15:04:22 srv4hai postfix/qmgr[8566]: 699B96345A: removed
Feb 16 15:04:22 srv4hai fetchmail[1651]: 1163 messages (1163 seen) for admin@bastelstube.wien at pop3.world4you.com (52216311 octets).
Feb 16 15:04:24 srv4hai postfix/anvil[13330]: statistics: max connection rate 1/60s for (smtp:193.32.162.66) at Feb 16 15:01:00
Feb 16 15:04:24 srv4hai postfix/anvil[13330]: statistics: max connection count 1 for (smtp:193.32.162.66) at Feb 16 15:01:00
Feb 16 15:04:24 srv4hai postfix/anvil[13330]: statistics: max cache size 1 at Feb 16 15:01:00
Feb 16 15:04:41 srv4hai common[14017]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:04:41 srv4hai common[14041]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:04:59 srv4hai common[14071]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:04:59 srv4hai common[14095]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:05:00 srv4hai common[14119]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:05:01 srv4hai CRON[14144]: (root) CMD (/etc/linetest/linetest.sh)
Feb 16 15:05:41 srv4hai dhcpd[4995]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Feb 16 15:05:41 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Feb 16 15:05:41 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Feb 16 15:05:41 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.5
Feb 16 15:05:41 srv4hai dhcpd[4995]: execute_statement argv[2] = btscan1
Feb 16 15:05:41 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.5 (192.168.12.252) from 08:3a:8d:d0:46:5a via enp2s0
Feb 16 15:05:41 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Feb 16 15:05:41 srv4hai named[30406]: client @0x7f934c0165b0 192.168.12.252#58087/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: btscan1.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 16 15:05:41 srv4hai named[30406]: client @0x7f932c0d1ae0 192.168.12.252#40779/key rndc-key: signer "rndc-key" approved
Feb 16 15:05:41 srv4hai named[30406]: client @0x7f932c0d1ae0 192.168.12.252#40779/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' TXT
Feb 16 15:05:41 srv4hai named[30406]: client @0x7f932c0d1ae0 192.168.12.252#40779/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' TXT "000118916176265854cff71f762ffe0635"
Feb 16 15:05:41 srv4hai named[30406]: client @0x7f932c0d1ae0 192.168.12.252#40779/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' A
Feb 16 15:05:41 srv4hai named[30406]: client @0x7f932c0d1ae0 192.168.12.252#40779/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' A 192.168.12.5
Feb 16 15:05:41 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.5'(5) device 'btscan1'
Feb 16 15:05:41 srv4hai dhcpd[4995]: Added new forward map from btscan1.viehai.at to 192.168.12.5
Feb 16 15:05:41 srv4hai named[30406]: client @0x7f9330095370 192.168.12.252#45421/key rndc-key: signer "rndc-key" approved
Feb 16 15:05:41 srv4hai named[30406]: client @0x7f9330095370 192.168.12.252#45421/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '5.12.168.192.in-addr.arpa' PTR
Feb 16 15:05:41 srv4hai named[30406]: client @0x7f9330095370 192.168.12.252#45421/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.
Feb 16 15:05:41 srv4hai dhcpd[4995]: Added reverse map from 5.12.168.192.in-addr.arpa. to btscan1.viehai.at
Feb 16 15:05:41 srv4hai dhcpcommit.sh: SHELLY device 'btscan1' known and accepted
Feb 16 15:05:41 srv4hai common[14163]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:05:41 srv4hai common[14187]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:06:00 srv4hai common[14220]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:06:00 srv4hai common[14244]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:06:00 srv4hai common[14268]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:06:01 srv4hai CRON[14293]: (root) CMD (/etc/linetest/linetest.sh)
Feb 16 15:06:12 srv4hai postfix/smtpd[14298]: connect from unknown[195.178.110.209]
Feb 16 15:06:16 srv4hai postfix/smtpd[14298]: warning: unknown[195.178.110.209]: SASL PLAIN authentication failed: 
Feb 16 15:06:16 srv4hai postfix/smtpd[14298]: disconnect from unknown[195.178.110.209] ehlo=1 auth=0/1 quit=1 commands=2/3
Feb 16 15:06:37 srv4hai dhcpd[4995]: DHCPDISCOVER from 8c:aa:b5:61:a9:20 via enp2s0
Feb 16 15:06:37 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.107 to 8c:aa:b5:61:a9:20 via enp2s0
Feb 16 15:06:37 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Feb 16 15:06:37 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.107
Feb 16 15:06:37 srv4hai dhcpd[4995]: execute_statement argv[2] = shelly-07
Feb 16 15:06:37 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.107 (192.168.12.252) from 8c:aa:b5:61:a9:20 via enp2s0
Feb 16 15:06:37 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.107 to 8c:aa:b5:61:a9:20 via enp2s0
Feb 16 15:06:37 srv4hai named[30406]: client @0x7f932c021730 192.168.12.252#45755/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-07.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 16 15:06:37 srv4hai named[30406]: client @0x7f9350694cd0 192.168.12.252#60705/key rndc-key: signer "rndc-key" approved
Feb 16 15:06:37 srv4hai named[30406]: client @0x7f9350694cd0 192.168.12.252#60705/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-07.viehai.at' TXT
Feb 16 15:06:37 srv4hai named[30406]: client @0x7f9350694cd0 192.168.12.252#60705/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-07.viehai.at' TXT "00304107ff63db9ada5ee5a0bc2105bb05"
Feb 16 15:06:37 srv4hai named[30406]: client @0x7f9350694cd0 192.168.12.252#60705/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-07.viehai.at' A
Feb 16 15:06:37 srv4hai named[30406]: client @0x7f9350694cd0 192.168.12.252#60705/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-07.viehai.at' A 192.168.12.107
Feb 16 15:06:37 srv4hai dhcpd[4995]: Added new forward map from shelly-07.viehai.at to 192.168.12.107
Feb 16 15:06:37 srv4hai named[30406]: client @0x7f93380d6d20 192.168.12.252#34253/key rndc-key: signer "rndc-key" approved
Feb 16 15:06:37 srv4hai named[30406]: client @0x7f93380d6d20 192.168.12.252#34253/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '107.12.168.192.in-addr.arpa' PTR
Feb 16 15:06:37 srv4hai named[30406]: client @0x7f93380d6d20 192.168.12.252#34253/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.
Feb 16 15:06:37 srv4hai dhcpd[4995]: Added reverse map from 107.12.168.192.in-addr.arpa. to shelly-07.viehai.at
Feb 16 15:06:37 srv4hai common[14311]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Feb 16 15:06:37 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-07' - shIP/2:'' perform:'conf'
Feb 16 15:06:38 srv4hai mosquitto[29419]: New connection from 192.168.12.107 on port 1883.
Feb 16 15:06:38 srv4hai mosquitto[29419]: Client shelly1-8CAAB561A920 already connected, closing old connection.
Feb 16 15:06:38 srv4hai mosquitto[29419]: Socket error on client shelly1-8CAAB561A920, disconnecting.
Feb 16 15:06:38 srv4hai mosquitto[29419]: New client connected from 192.168.12.107 as shelly1-8CAAB561A920 (c1, k60, u'shmqtt').
Feb 16 15:06:38 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-07' - shIP/2:'192.168.12.107'
Feb 16 15:06:38 srv4hai conf_shelly.sh: SHELLY: usage/name 'SZ Nachtkästchen Thomas' already set for '192.168.12.107'
Feb 16 15:06:38 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(0)' - allready transmitted - skipping
Feb 16 15:06:38 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(1)' - allready transmitted - skipping
Feb 16 15:06:38 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(2)' - allready transmitted - skipping
Feb 16 15:06:38 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(3)' - allready transmitted - skipping
Feb 16 15:06:38 srv4hai conf_shelly.sh: SHELLY:'shelly-07' 'conf(4)' - allready transmitted - skipping
Feb 16 15:06:41 srv4hai common[14424]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:06:41 srv4hai common[14448]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:07:00 srv4hai common[14478]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:07:00 srv4hai common[14502]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:07:00 srv4hai common[14526]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:07:01 srv4hai CRON[14551]: (root) CMD (/etc/linetest/linetest.sh)
Feb 16 15:07:08 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=14559, secured, session=
Feb 16 15:07:08 srv4hai dovecot: imap(miglincit)<14559>: Logged out in=534 out=122196 deleted=0 expunged=0 trashed=0 hdr_count=200 hdr_bytes=60231 body_count=0 body_bytes=0
Feb 16 15:07:20 srv4hai postfix/smtpd[14298]: connect from unknown[61.108.83.139]
Feb 16 15:07:27 srv4hai postfix/smtpd[14298]: warning: unknown[61.108.83.139]: SASL PLAIN authentication failed: 
Feb 16 15:07:27 srv4hai postfix/smtpd[14298]: lost connection after AUTH from unknown[61.108.83.139]
Feb 16 15:07:27 srv4hai postfix/smtpd[14298]: disconnect from unknown[61.108.83.139] ehlo=1 auth=0/1 commands=1/2
Feb 16 15:07:30 srv4hai postfix/smtpd[14298]: connect from p173020-obmd01.osaka.ocn.ne.jp[61.118.248.19]
Feb 16 15:07:33 srv4hai postfix/smtpd[14298]: lost connection after CONNECT from p173020-obmd01.osaka.ocn.ne.jp[61.118.248.19]
Feb 16 15:07:33 srv4hai postfix/smtpd[14298]: disconnect from p173020-obmd01.osaka.ocn.ne.jp[61.118.248.19] commands=0/0
Feb 16 15:07:34 srv4hai postfix/smtpd[14298]: connect from unknown[83.136.176.12]
Feb 16 15:07:40 srv4hai postfix/smtpd[14298]: warning: unknown[83.136.176.12]: SASL PLAIN authentication failed: 
Feb 16 15:07:40 srv4hai postfix/smtpd[14298]: lost connection after AUTH from unknown[83.136.176.12]
Feb 16 15:07:40 srv4hai postfix/smtpd[14298]: disconnect from unknown[83.136.176.12] ehlo=1 auth=0/1 commands=1/2
Feb 16 15:07:41 srv4hai common[14576]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:07:41 srv4hai common[14600]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 16 15:07:41 srv4hai postfix/smtpd[14298]: connect from unknown[115.44.141.199]
Feb 16 15:07:44 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Feb 16 15:07:44 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.10
Feb 16 15:07:44 srv4hai dhcpd[4995]: execute_statement argv[2] = pchai7x
Feb 16 15:07:44 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Feb 16 15:07:44 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Feb 16 15:07:44 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#51889/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 16 15:07:44 srv4hai named[30406]: client @0x7f934c037ed0 192.168.12.252#60049/key rndc-key: signer "rndc-key" approved
Feb 16 15:07:44 srv4hai named[30406]: client @0x7f934c037ed0 192.168.12.252#60049/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Feb 16 15:07:44 srv4hai named[30406]: client @0x7f934c037ed0 192.168.12.252#60049/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Feb 16 15:07:44 srv4hai named[30406]: client @0x7f934c037ed0 192.168.12.252#60049/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Feb 16 15:07:44 srv4hai named[30406]: client @0x7f934c037ed0 192.168.12.252#60049/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Feb 16 15:07:44 srv4hai dhcpd[4995]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Feb 16 15:07:44 srv4hai named[30406]: client @0x7f935013a950 192.168.12.252#50849/key rndc-key: signer "rndc-key" approved
Feb 16 15:07:44 srv4hai named[30406]: client @0x7f935013a950 192.168.12.252#50849/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Feb 16 15:07:44 srv4hai named[30406]: client @0x7f935013a950 192.168.12.252#50849/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '10.12.168.192.in-addr.arpa' PTR pchai7x.viehai.at.
Feb 16 15:07:44 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Feb 16 15:07:44 srv4hai dhcpd[4995]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Feb 16 15:07:44 srv4hai activate_scenario[14631]: SHELLY scenario: 'pcON(pcon)' started
Feb 16 15:07:44 srv4hai activate_scenario[14631]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'

finished