activate_scenario.sh
Sat May 25 11:09:22 CEST 2024
scenario: vorraumOn
phoneName: 0

'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'thomas@miglinci.name'

scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

Licht Vorzimmer (/srv/www/viehai/shelly/log_scenarios/2024/05/25/_0.log)

vorher: 11:09:22.899

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: 11:09:22.936
Dauer: 37 msec phName: 'phoneName:'0''


scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

urls : 1
vorher : 11:09:22.880
nachher: 11:09:22.942
Dauer : 61 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/05/25//scene_vorraumOn_20240525_110922.txt'


syslog

May 25 11:06:01 srv4hai CRON[29292]: (root) CMD (/etc/linetest/linetest.sh)
May 25 11:07:01 srv4hai CRON[29303]: (root) CMD (/etc/linetest/linetest.sh)
May 25 11:07:03 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=29310, secured, session=
May 25 11:07:03 srv4hai dovecot: imap(miglincit)<29310>: Logged out in=513 out=1232 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
May 25 11:07:31 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
May 25 11:07:32 srv4hai fetchmail[1651]: 45002 messages (45001 seen) for tmiglinci at mail.akis.at (-572564487 octets).
May 25 11:07:32 srv4hai postfix/smtpd[29312]: warning: database /etc/aliases.db is older than source file /etc/aliases
May 25 11:07:32 srv4hai postfix/smtpd[29312]: connect from localhost[127.0.0.1]
May 25 11:07:32 srv4hai postfix/smtpd[29312]: C20F4631F0: client=localhost[127.0.0.1]
May 25 11:07:32 srv4hai postfix/cleanup[29315]: C20F4631F0: message-id=<20240525090358.15194631F4@mail.viehai.at>
May 25 11:07:32 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:45002 of 45002 (12846 octets) not flushed
May 25 11:07:32 srv4hai postfix/qmgr[15291]: C20F4631F0: from=, size=13159, nrcpt=1 (queue active)
May 25 11:07:32 srv4hai postfix/smtpd[29312]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
May 25 11:07:32 srv4hai postfix/local[29316]: warning: database /etc/aliases.db is older than source file /etc/aliases
May 25 11:07:32 srv4hai postfix/local[29316]: C20F4631F0: to=, relay=local, delay=0.08, delays=0.06/0.02/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
May 25 11:07:32 srv4hai postfix/qmgr[15291]: C20F4631F0: removed
May 25 11:07:33 srv4hai fetchmail[1651]: 10255 messages (10255 seen) for srozum at mail.akis.at (1235547836 octets).
May 25 11:07:33 srv4hai fetchmail[1651]: 23685 messages (23685 seen) for mrozum at mail.akis.at (-201159428 octets).
May 25 11:07:34 srv4hai fetchmail[1651]: 66 messages (66 seen) for admin@bastelstube.wien at pop3.world4you.com (19109474 octets).
May 25 11:07:42 srv4hai postfix/qmgr[15291]: C643D631EE: from=, size=21673, nrcpt=1 (queue active)
May 25 11:07:42 srv4hai postfix/qmgr[15291]: AEC74631D2: from=, size=21761, nrcpt=1 (queue active)
May 25 11:07:42 srv4hai postfix/qmgr[15291]: 404AB631CA: from=, size=21704, nrcpt=1 (queue active)
May 25 11:07:42 srv4hai postfix/qmgr[15291]: 83DDE631BB: from=, size=21771, nrcpt=1 (queue active)
May 25 11:07:42 srv4hai postfix/qmgr[15291]: 6A2B2631A9: from=, size=21736, nrcpt=1 (queue active)
May 25 11:07:42 srv4hai postfix/qmgr[15291]: 6C2AD631AC: from=, size=21760, nrcpt=1 (queue active)
May 25 11:07:42 srv4hai postfix/qmgr[15291]: D6197631F5: from=, size=21755, nrcpt=1 (queue active)
May 25 11:07:42 srv4hai postfix/qmgr[15291]: EB168631AB: from=, size=21719, nrcpt=1 (queue active)
May 25 11:07:43 srv4hai postfix/smtp[29324]: 6C2AD631AC: to=, relay=ketera.com[208.91.197.27]:25, delay=290393, delays=290392/0.03/0.25/0, dsn=4.4.2, status=deferred (lost connection with ketera.com[208.91.197.27] while receiving the initial server greeting)
May 25 11:07:43 srv4hai postfix/smtp[29321]: 404AB631CA: host ip.lmi.org[104.152.72.100] refused to talk to me: 554-ip.lmi.org 554 Your access to this mail system has been rejected due to the sending MTA's poor reputation. If you believe that this failure is in error, please contact the intended recipient via alternate means.
May 25 11:07:43 srv4hai postfix/smtp[29321]: 404AB631CA: to=, relay=ip2.lmi.org[104.152.72.101]:25, delay=256648, delays=256648/0.02/0.65/0, dsn=4.0.0, status=deferred (host ip2.lmi.org[104.152.72.101] refused to talk to me: 554-ip2.lmi.org 554 Your access to this mail system has been rejected due to the sending MTA's poor reputation. If you believe that this failure is in error, please contact the intended recipient via alternate means.)
May 25 11:07:44 srv4hai postfix/smtp[29325]: D6197631F5: host barneys-com.mail.protection.outlook.com[52.101.11.9] said: 451 4.4.4 Mail received as unauthenticated, incoming to a recipient domain configured in a hosted tenant which has no mail-enabled subscriptions. ATTR5 [SN1PEPF0002636D.namprd02.prod.outlook.com 2024-05-25T09:07:43.989Z 08DC7AC9E7071D8C] (in reply to end of DATA command)
May 25 11:07:44 srv4hai postfix/smtp[29322]: 83DDE631BB: host mx1-us.emailsecurity.app[52.179.17.190] said: 450 4.1.1 : Recipient address rejected: unverified address: Recipient address lookup failed (in reply to RCPT TO command)
May 25 11:07:44 srv4hai postfix/smtp[29319]: C643D631EE: host mx2.forwardemail.net[104.248.224.170] said: 421 Your message had a temporary delivery error and will be automatically retried; Your message must contain one valid email address in the "From" header (in reply to end of DATA command)
May 25 11:07:44 srv4hai postfix/smtp[29322]: 83DDE631BB: to=, relay=mx2-us.emailsecurity.app[52.179.17.190]:25, delay=265043, delays=265041/0.02/1.8/0.12, dsn=4.1.1, status=deferred (host mx2-us.emailsecurity.app[52.179.17.190] said: 450 4.1.1 : Recipient address rejected: unverified address: Recipient address lookup failed (in reply to RCPT TO command))
May 25 11:07:45 srv4hai postfix/smtp[29325]: D6197631F5: to=, relay=barneys-com.mail.protection.outlook.com[52.101.41.4]:25, delay=227211, delays=227208/0.04/1.7/0.87, dsn=4.4.4, status=deferred (host barneys-com.mail.protection.outlook.com[52.101.41.4] said: 451 4.4.4 Mail received as unauthenticated, incoming to a recipient domain configured in a hosted tenant which has no mail-enabled subscriptions. ATTR5 [SJ5PEPF000001D7.namprd05.prod.outlook.com 2024-05-25T09:07:45.395Z 08DC76EFD562995D] (in reply to end of DATA command))
May 25 11:07:46 srv4hai postfix/smtp[29319]: C643D631EE: to=, relay=mx1.forwardemail.net[138.197.213.185]:25, delay=229520, delays=229517/0.01/2.6/0.77, dsn=4.0.0, status=deferred (host mx1.forwardemail.net[138.197.213.185] said: 421 Your message had a temporary delivery error and will be automatically retried; Your message must contain one valid email address in the "From" header (in reply to end of DATA command))
May 25 11:08:01 srv4hai CRON[29330]: (root) CMD (/etc/linetest/linetest.sh)
May 25 11:08:13 srv4hai postfix/smtp[29320]: connect to mackemployment.com[199.59.243.225]:25: Connection timed out
May 25 11:08:13 srv4hai postfix/smtp[29320]: AEC74631D2: to=, relay=none, delay=254700, delays=254670/0.01/30/0, dsn=4.4.1, status=deferred (connect to mackemployment.com[199.59.243.225]:25: Connection timed out)
May 25 11:08:13 srv4hai postfix/smtp[29326]: connect to vogueintl.com[54.209.32.212]:25: Connection timed out
May 25 11:08:13 srv4hai postfix/smtp[29323]: connect to newfish.sagchip.org[64.186.47.180]:25: Connection timed out
May 25 11:08:13 srv4hai postfix/smtp[29323]: 6A2B2631A9: to=, relay=none, delay=292520, delays=292490/0.03/31/0, dsn=4.4.1, status=deferred (connect to newfish.sagchip.org[64.186.47.180]:25: Connection timed out)
May 25 11:08:43 srv4hai postfix/smtp[29326]: connect to vogueintl.com[52.71.57.184]:25: Connection timed out
May 25 11:08:43 srv4hai postfix/smtp[29326]: EB168631AB: to=, relay=none, delay=233719, delays=233659/0.04/60/0, dsn=4.4.1, status=deferred (connect to vogueintl.com[52.71.57.184]:25: Connection timed out)
May 25 11:09:01 srv4hai CRON[29340]: (root) CMD (  [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi)
May 25 11:09:01 srv4hai CRON[29341]: (root) CMD (/etc/linetest/linetest.sh)
May 25 11:09:01 srv4hai systemd[1]: Starting Clean php session files...
May 25 11:09:02 srv4hai systemd[1]: phpsessionclean.service: Succeeded.
May 25 11:09:02 srv4hai systemd[1]: Started Clean php session files.
May 25 11:09:11 srv4hai dhcpd[22856]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
May 25 11:09:11 srv4hai dhcpd[22856]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 25 11:09:11 srv4hai dhcpd[22856]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May 25 11:09:11 srv4hai dhcpd[22856]: execute_statement argv[1] = 192.168.12.61
May 25 11:09:11 srv4hai dhcpd[22856]: execute_statement argv[2] = fpThomas
May 25 11:09:11 srv4hai common[29437]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
May 25 11:09:11 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May 25 11:09:11 srv4hai common[29451]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
May 25 11:09:11 srv4hai dhcpd[22856]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May 25 11:09:11 srv4hai dhcpd[22856]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 25 11:09:11 srv4hai named[15509]: client @0x7f930c0b39c0 192.168.12.252#39273/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May 25 11:09:11 srv4hai named[15509]: client @0x7f93040506c0 192.168.12.252#60659/key rndc-key: signer "rndc-key" approved
May 25 11:09:11 srv4hai named[15509]: client @0x7f93040506c0 192.168.12.252#60659/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
May 25 11:09:11 srv4hai named[15509]: client @0x7f93040506c0 192.168.12.252#60659/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
May 25 11:09:11 srv4hai named[15509]: client @0x7f93040506c0 192.168.12.252#60659/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
May 25 11:09:11 srv4hai named[15509]: client @0x7f93040506c0 192.168.12.252#60659/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
May 25 11:09:11 srv4hai dhcpd[22856]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
May 25 11:09:11 srv4hai named[15509]: client @0x7f930806d890 192.168.12.252#49841/key rndc-key: signer "rndc-key" approved
May 25 11:09:11 srv4hai named[15509]: client @0x7f930806d890 192.168.12.252#49841/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
May 25 11:09:11 srv4hai named[15509]: client @0x7f930806d890 192.168.12.252#49841/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
May 25 11:09:11 srv4hai dhcpd[22856]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
May 25 11:09:11 srv4hai ping_SP[29451]: SHELLY ping_SP.sh started from smartphone, user:'root'
May 25 11:09:21 srv4hai common[29482]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
May 25 11:09:22 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'9'=1716628162-1716628153
May 25 11:09:22 srv4hai check_presence[29482]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
May 25 11:09:22 srv4hai check_presence[29482]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
May 25 11:09:22 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'9'=1716628162-1716628153
May 25 11:09:22 srv4hai check_presence[29482]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
May 25 11:09:22 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'9'=1716628162-1716628153
May 25 11:09:22 srv4hai check_presence[29482]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
May 25 11:09:22 srv4hai check_presence[29482]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
May 25 11:09:22 srv4hai check_presence[29482]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
May 25 11:09:22 srv4hai check_presence[29482]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
May 25 11:09:22 srv4hai activate_scenario[29630]: SHELLY scenario: 'vorraumOn(vorraumon)' started
May 25 11:09:22 srv4hai activate_scenario[29630]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished