activate_scenario.sh
Sun Aug 11 08:10:19 CEST 2024
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'

Thomas Schreibtischlampe (/srv/www/viehai/shelly/log_scenarios/2024/08/11/_0.log)

vorher: 08:10:19.696

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: 08:10:19.728
Dauer: 32 msec phName: 'origin:'dhcpcommit.sh-pchai7x''


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

urls : 1
vorher : 08:10:19.676
nachher: 08:10:19.736
Dauer : 59 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/08/11//scene_pcON_20240811_081019.txt'


syslog

Aug 11 08:07:01 srv4hai CRON[28673]: (root) CMD (/etc/linetest/linetest.sh)
Aug 11 08:07:13 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Aug 11 08:07:14 srv4hai fetchmail[1651]: 49834 messages (49834 seen) for tmiglinci at mail.akis.at (-170905549 octets).
Aug 11 08:07:14 srv4hai fetchmail[1651]: 10571 messages (10570 seen) for srozum at mail.akis.at (1270645941 octets).
Aug 11 08:07:14 srv4hai postfix/smtpd[28641]: connect from localhost[127.0.0.1]
Aug 11 08:07:14 srv4hai postfix/smtpd[28641]: 8B1E76345A: client=localhost[127.0.0.1]
Aug 11 08:07:14 srv4hai postfix/cleanup[28680]: 8B1E76345A: message-id=
Aug 11 08:07:14 srv4hai postfix/qmgr[8566]: 8B1E76345A: from=, size=83545, nrcpt=1 (queue active)
Aug 11 08:07:14 srv4hai fetchmail[1651]: reading message srozum@mail.akis.at:10571 of 10571 (83276 octets) not flushed
Aug 11 08:07:14 srv4hai postfix/smtpd[28641]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Aug 11 08:07:14 srv4hai postfix/local[28681]: 8B1E76345A: to=, relay=local, delay=0.1, delays=0.08/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Aug 11 08:07:14 srv4hai postfix/qmgr[8566]: 8B1E76345A: removed
Aug 11 08:07:15 srv4hai fetchmail[1651]: 25245 messages (25245 seen) for mrozum at mail.akis.at (108424884 octets).
Aug 11 08:07:15 srv4hai fetchmail[1651]: 1139 messages (1139 seen) for admin@bastelstube.wien at pop3.world4you.com (51570784 octets).
Aug 11 08:08:01 srv4hai CRON[28701]: (root) CMD (/etc/linetest/linetest.sh)
Aug 11 08:08:08 srv4hai ping_SP[30347]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1723356488 - 'ping_SP_0'
Aug 11 08:08:08 srv4hai ping_SP[30347]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Aug 11 08:09:01 srv4hai CRON[28732]: (root) CMD (  [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi)
Aug 11 08:09:01 srv4hai CRON[28733]: (root) CMD (/etc/linetest/linetest.sh)
Aug 11 08:09:01 srv4hai systemd[1]: Starting Clean php session files...
Aug 11 08:09:01 srv4hai systemd[1]: phpsessionclean.service: Succeeded.
Aug 11 08:09:01 srv4hai systemd[1]: Started Clean php session files.
Aug 11 08:09:04 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=28834, secured, session=<5pSrNmIf9tUAAAAAAAAAAAAAAAAAAAAB>
Aug 11 08:09:04 srv4hai dovecot: imap(miglincit)<28834><5pSrNmIf9tUAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug 11 08:09:08 srv4hai postfix/smtpd[28837]: connect from unknown[178.215.236.216]
Aug 11 08:09:08 srv4hai postfix/smtpd[28837]: warning: unknown[178.215.236.216]: SASL LOGIN authentication failed: Invalid authentication mechanism
Aug 11 08:09:08 srv4hai postfix/smtpd[28837]: disconnect from unknown[178.215.236.216] ehlo=1 auth=0/1 quit=1 commands=2/3
Aug 11 08:09:21 srv4hai ping_SP[30347]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1723356561 - 'ping_SP_0'
Aug 11 08:09:21 srv4hai ping_SP[30347]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Aug 11 08:09:59 srv4hai common[28871]: SHELLY common.sh inkludiert von ./bt_scan.sh
Aug 11 08:10:01 srv4hai CRON[28889]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Aug 11 08:10:01 srv4hai CRON[28890]: (root) CMD (/etc/linetest/linetest.sh)
Aug 11 08:10:01 srv4hai common[28892]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/meter.sh
Aug 11 08:10:01 srv4hai meter.sh: SHELLY meter.sh started
Aug 11 08:10:02 srv4hai meter.sh: SHELLY 'shelly-29/Schalter Herdzeile' - type: 'shelly-i3' ignoring
Aug 11 08:10:02 srv4hai meter.sh: SHELLY 'shelly-28/Schalter Nasszeile' - type: 'shelly-i3' ignoring
Aug 11 08:10:04 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster' - type: 'shelly-BTN' ignoring
Aug 11 08:10:04 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter' - type: 'shelly-BTN' ignoring
Aug 11 08:10:04 srv4hai meter.sh: SHELLY 'shelly-37/Klima Büro' - type: 'shelly-ht' ignoring
Aug 11 08:10:04 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen' - status: 'OOS' ignoring
Aug 11 08:10:04 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon' - type: 'shelly-ht-plus' ignoring
Aug 11 08:10:07 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Aug 11 08:10:09 srv4hai bt_scan[28871]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Aug 11 08:10:09 srv4hai bt_scan[28871]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62'
Aug 11 08:10:09 srv4hai common[29554]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Aug 11 08:10:09 srv4hai ping_SP[29554]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Aug 11 08:10:09 srv4hai common[29575]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug 11 08:10:09 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'10'=1723356609-1723356599
Aug 11 08:10:09 srv4hai check_presence[29575]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Aug 11 08:10:09 srv4hai check_presence[29575]: SHELLY (ping_SP__bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Aug 11 08:10:09 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'10'=1723356609-1723356599
Aug 11 08:10:09 srv4hai check_presence[29575]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Aug 11 08:10:09 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1723356609-1723356599
Aug 11 08:10:09 srv4hai check_presence[29575]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug 11 08:10:09 srv4hai check_presence[29575]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(BT/LIVE) (BT/__) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug 11 08:10:09 srv4hai check_presence[29575]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
Aug 11 08:10:09 srv4hai check_presence[29575]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn
Aug 11 08:10:09 srv4hai activate_scenario[29723]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Aug 11 08:10:09 srv4hai activate_scenario[29723]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'1'
Aug 11 08:10:09 srv4hai activate_scenario[29723]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'1'
Aug 11 08:10:09 srv4hai postfix/pickup[29783]: D63556345B: uid=33 from=
Aug 11 08:10:09 srv4hai postfix/cleanup[29787]: D63556345B: message-id=<20240811061009.D63556345B@mail.viehai.at>
Aug 11 08:10:09 srv4hai postfix/qmgr[8566]: D63556345B: from=, size=7547, nrcpt=1 (queue active)
Aug 11 08:10:09 srv4hai activate_scenario[29723]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Aug 11 08:10:09 srv4hai proc_url[29801]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/11/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'1''
Aug 11 08:10:10 srv4hai activate_scenario[29723]: SHELLY scenario: 'vorraumOn(vorraumon)' took 173 msec, phoneName:'1'
Aug 11 08:10:10 srv4hai ping_SP[29554]: SHELLY check_presence.sh coming 1 ping_SP__bt_scan
Aug 11 08:10:10 srv4hai ping_SP[29554]: SHELLY - new process for '192.168.12.62' - '/srv/www/viehai/shelly//meter/ping_SP_1' @~1723356610
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD' - status: 'OOS' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3' - status: 'OOS' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD' - status: 'OOS' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD' - status: 'OOS' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD' - status: 'OOS' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-47/47-plus1-Test' - status: 'OOS' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-09a/Inbetriebnahme - 20210720 - Defekt' - status: 'defect' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-09b/Sophie Licht - 20230404 - Defekt' - status: 'defect' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN' - status: 'defect' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417' - status: 'defect' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem' - status: 'defect' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722' - status: 'defect' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-43/43-TBD' - status: 'OOS' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD' - status: 'OOS' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-45/45-TBD' - status: 'OOS' ignoring
Aug 11 08:10:10 srv4hai meter.sh: SHELLY 'shelly-46/46-TBD' - status: 'OOS' ignoring
Aug 11 08:10:11 srv4hai postfix/relay/smtp[29797]: D63556345B: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=1.7, delays=0.06/0.01/1.3/0.24, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 4AEBC80054)
Aug 11 08:10:11 srv4hai postfix/qmgr[8566]: D63556345B: removed
Aug 11 08:10:13 srv4hai meter.sh: SHELLY 'shelly-48/BT GW 1':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Aug 11 08:10:15 srv4hai meter.sh: SHELLY 'shelly-58/Werkstatt Licht':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Aug 11 08:10:15 srv4hai meter.sh: SHELLY 'shelly-59/Werkstatt Schalter Kellertür' - type: 'shelly-i3' ignoring
Aug 11 08:10:15 srv4hai common[30070]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_shelly.sh
Aug 11 08:10:15 srv4hai check_shelly.sh: SHELLY last scenery executed: 'vorraumOn'
Aug 11 08:10:15 srv4hai check_shelly.sh: SHELLY found '1' active shelly outputs
Aug 11 08:10:15 srv4hai meter.sh: SHELLY meter.sh ended
Aug 11 08:10:19 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Aug 11 08:10:19 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.10
Aug 11 08:10:19 srv4hai dhcpd[30731]: execute_statement argv[2] = pchai7x
Aug 11 08:10:19 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Aug 11 08:10:19 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Aug 11 08:10:19 srv4hai named[30406]: client @0x7f935011da30 192.168.12.252#58727/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 11 08:10:19 srv4hai named[30406]: client @0x7f93506d04d0 192.168.12.252#47121/key rndc-key: signer "rndc-key" approved
Aug 11 08:10:19 srv4hai named[30406]: client @0x7f93506d04d0 192.168.12.252#47121/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Aug 11 08:10:19 srv4hai named[30406]: client @0x7f93506d04d0 192.168.12.252#47121/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Aug 11 08:10:19 srv4hai named[30406]: client @0x7f93506d04d0 192.168.12.252#47121/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Aug 11 08:10:19 srv4hai named[30406]: client @0x7f93506d04d0 192.168.12.252#47121/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Aug 11 08:10:19 srv4hai dhcpd[30731]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Aug 11 08:10:19 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#43333/key rndc-key: signer "rndc-key" approved
Aug 11 08:10:19 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#43333/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Aug 11 08:10:19 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#43333/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.
Aug 11 08:10:19 srv4hai dhcpd[30731]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Aug 11 08:10:19 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Aug 11 08:10:19 srv4hai activate_scenario[30102]: SHELLY scenario: 'pcON(pcon)' started
Aug 11 08:10:19 srv4hai activate_scenario[30102]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'

finished