activate_scenario.sh
Fri Feb 28 19:28:56 CET 2025
scenario: vorraumOn
phoneName: 1

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

VZ Licht (/srv/www/viehai/shelly/log_scenarios/2025/02/28/_0.log)

vorher: 19:28:56.567

  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "overpower": false,
  "source": "input"

nachher: 19:28:58.420
Dauer: 1853 msec phName: 'phoneName:'1''

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

urls : 1
vorher : 19:28:56.520
nachher: 19:28:58.434
Dauer : 1914 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/02/28//scene_vorraumOn_20250228_192856.txt'

syslog

Feb 28 19:25:00 srv4hai common[27482]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:25:00 srv4hai common[27507]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:25:00 srv4hai common[27531]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:25:01 srv4hai CRON[27556]: (root) CMD (/etc/linetest/linetest.sh)
Feb 28 19:25:15 srv4hai common[27564]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:25:15 srv4hai common[27588]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:25:59 srv4hai common[27629]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:25:59 srv4hai common[27653]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:26:00 srv4hai common[27677]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:26:01 srv4hai CRON[27705]: (root) CMD (/etc/linetest/linetest.sh)
Feb 28 19:26:10 srv4hai ping_SP[9292]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1740767170 - 'ping_SP_0'
Feb 28 19:26:10 srv4hai ping_SP[9292]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 28 19:26:15 srv4hai common[27724]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:26:15 srv4hai common[27748]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:26:19 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27780, secured, session=
Feb 28 19:26:19 srv4hai dovecot: imap(miglincit)<27780>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 28 19:26:24 srv4hai postfix/smtpd[27781]: connect from unknown[195.178.110.216]
Feb 28 19:26:29 srv4hai postfix/smtpd[27781]: warning: unknown[195.178.110.216]: SASL PLAIN authentication failed: 
Feb 28 19:26:29 srv4hai postfix/smtpd[27781]: disconnect from unknown[195.178.110.216] ehlo=1 auth=0/1 quit=1 commands=2/3
Feb 28 19:26:59 srv4hai common[27795]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:27:00 srv4hai common[27819]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:27:00 srv4hai common[27843]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:27:01 srv4hai CRON[27868]: (root) CMD (/etc/linetest/linetest.sh)
Feb 28 19:27:12 srv4hai kernel: [86745295.239538] CPU5: Package temperature above threshold, cpu clock throttled (total events = 109054968)
Feb 28 19:27:12 srv4hai kernel: [86745295.239539] CPU4: Package temperature above threshold, cpu clock throttled (total events = 109054968)
Feb 28 19:27:12 srv4hai kernel: [86745295.239540] CPU3: Package temperature above threshold, cpu clock throttled (total events = 109054968)
Feb 28 19:27:12 srv4hai kernel: [86745295.239542] CPU2: Package temperature above threshold, cpu clock throttled (total events = 109054968)
Feb 28 19:27:12 srv4hai kernel: [86745295.239543] CPU7: Package temperature above threshold, cpu clock throttled (total events = 109054968)
Feb 28 19:27:12 srv4hai kernel: [86745295.239544] CPU6: Package temperature above threshold, cpu clock throttled (total events = 109054968)
Feb 28 19:27:12 srv4hai kernel: [86745295.239545] CPU0: Package temperature above threshold, cpu clock throttled (total events = 109054968)
Feb 28 19:27:12 srv4hai kernel: [86745295.239547] CPU1: Package temperature above threshold, cpu clock throttled (total events = 109054968)
Feb 28 19:27:15 srv4hai common[27880]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:27:15 srv4hai common[27904]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:27:23 srv4hai ping_SP[9292]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1740767243 - 'ping_SP_0'
Feb 28 19:27:23 srv4hai ping_SP[9292]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 28 19:27:59 srv4hai common[27952]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:28:00 srv4hai common[27977]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:28:00 srv4hai common[28011]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:28:01 srv4hai CRON[28036]: (root) CMD (/etc/linetest/linetest.sh)
Feb 28 19:28:15 srv4hai common[28045]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:28:15 srv4hai common[28077]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Feb 28 19:28:25 srv4hai dhcpd[4995]: DHCPDISCOVER from f0:39:65:25:8d:c7 via enp2s0
Feb 28 19:28:25 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Feb 28 19:28:25 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Feb 28 19:28:25 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.62
Feb 28 19:28:25 srv4hai dhcpd[4995]: execute_statement argv[2] = GreteS20
Feb 28 19:28:25 srv4hai common[28128]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Feb 28 19:28:30 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Feb 28 19:28:31 srv4hai fetchmail[1651]: 64684 messages (64683 seen) for tmiglinci at mail.akis.at (996043688 octets).
Feb 28 19:28:31 srv4hai postfix/smtpd[28160]: connect from localhost[127.0.0.1]
Feb 28 19:28:31 srv4hai postfix/smtpd[28160]: 401596000F: client=localhost[127.0.0.1]
Feb 28 19:28:31 srv4hai postfix/cleanup[28166]: 401596000F: message-id=<20250228181527.3306.1434223197.swift@newsletter02.headroom.at>
Feb 28 19:28:31 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:64684 of 64684 (68980 octets) not flushed
Feb 28 19:28:31 srv4hai postfix/qmgr[8566]: 401596000F: from=, size=69268, nrcpt=1 (queue active)
Feb 28 19:28:31 srv4hai postfix/smtpd[28160]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Feb 28 19:28:31 srv4hai postfix/local[28167]: 401596000F: to=, relay=local, delay=0.1, delays=0.09/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb 28 19:28:31 srv4hai postfix/qmgr[8566]: 401596000F: removed
Feb 28 19:28:31 srv4hai fetchmail[1651]: 11610 messages (11610 seen) for srozum at mail.akis.at (1375200275 octets).
Feb 28 19:28:32 srv4hai fetchmail[1651]: 29255 messages (29255 seen) for mrozum at mail.akis.at (719102556 octets).
Feb 28 19:28:32 srv4hai fetchmail[1651]: 1164 messages (1164 seen) for admin@bastelstube.wien at pop3.world4you.com (52226354 octets).
Feb 28 19:28:35 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Feb 28 19:28:35 srv4hai common[28178]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Feb 28 19:28:35 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Feb 28 19:28:35 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Feb 28 19:28:35 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Feb 28 19:28:35 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.62
Feb 28 19:28:35 srv4hai dhcpd[4995]: execute_statement argv[2] = GreteS20
Feb 28 19:28:35 srv4hai common[28209]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Feb 28 19:28:35 srv4hai ping_SP[28178]: SHELLY ping_SP.sh started from smartphone, user:'root'
Feb 28 19:28:36 srv4hai ping_SP[9292]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1740767316 - 'ping_SP_0'
Feb 28 19:28:36 srv4hai ping_SP[9292]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 28 19:28:37 srv4hai kernel: [86745380.551552] CPU1: Core temperature/speed normal
Feb 28 19:28:37 srv4hai kernel: [86745380.551553] CPU5: Core temperature/speed normal
Feb 28 19:28:45 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Feb 28 19:28:45 srv4hai common[28263]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Feb 28 19:28:45 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Feb 28 19:28:45 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Feb 28 19:28:45 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Feb 28 19:28:45 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.62
Feb 28 19:28:45 srv4hai dhcpd[4995]: execute_statement argv[2] = GreteS20
Feb 28 19:28:45 srv4hai named[30406]: client @0x7f932c097490 192.168.12.252#47337/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 28 19:28:45 srv4hai common[28275]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Feb 28 19:28:45 srv4hai common[28280]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Feb 28 19:28:45 srv4hai ping_SP[28263]: SHELLY ping_SP.sh started from smartphone, user:'root'
Feb 28 19:28:46 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'2'=1740767326-1740767324
Feb 28 19:28:46 srv4hai check_presence[28275]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Feb 28 19:28:46 srv4hai check_presence[28275]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Feb 28 19:28:46 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'2'=1740767326-1740767324
Feb 28 19:28:46 srv4hai check_presence[28275]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Feb 28 19:28:46 srv4hai check_presence[28275]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Feb 28 19:28:46 srv4hai check_presence[28275]: SHELLY (ping_SP__smartphone)-(1) what: 'coming' - persPresent: '(BT/LIVE) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Feb 28 19:28:46 srv4hai check_presence[28275]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_buero_UM) - sceneONsmall(vorraumOn)
Feb 28 19:28:46 srv4hai check_presence[28275]: SHELLY (ping_SP__smartphone)-(1)-coming: activate_scenario.shtml: vorraumOn
Feb 28 19:28:46 srv4hai activate_scenario[28437]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Feb 28 19:28:46 srv4hai activate_scenario[28437]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'1'
Feb 28 19:28:46 srv4hai activate_scenario[28437]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'1'
Feb 28 19:28:46 srv4hai postfix/pickup[22965]: 76B0463463: uid=33 from=
Feb 28 19:28:46 srv4hai postfix/cleanup[28166]: 76B0463463: message-id=<20250228182846.76B0463463@mail.viehai.at>
Feb 28 19:28:46 srv4hai postfix/qmgr[8566]: 76B0463463: from=, size=11170, nrcpt=1 (queue active)
Feb 28 19:28:46 srv4hai activate_scenario[28437]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'VZ Licht' --> '0?turn=on'
Feb 28 19:28:46 srv4hai proc_url[28503]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/02/28/_0.log' - shellyUsage:'VZ Licht' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'1''
Feb 28 19:28:46 srv4hai activate_scenario[28437]: SHELLY scenario: 'vorraumOn(vorraumon)' took 191 msec, phoneName:'1'
Feb 28 19:28:46 srv4hai ping_SP[28178]: SHELLY check_presence.sh coming 1 ping_SP__smartphone
Feb 28 19:28:47 srv4hai postfix/relay/smtp[28491]: 76B0463463: to=, relay=mx04.nic.name[209.131.160.34]:25, delay=1.1, delays=0.01/0.01/0.82/0.27, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 618F2601AB)
Feb 28 19:28:47 srv4hai postfix/qmgr[8566]: 76B0463463: removed
Feb 28 19:28:48 srv4hai ping_SP[28178]: SHELLY - running process-id(28178): '28178 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.62 smartphone#01228263 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.62 smartphone#01228280 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.62 GreteS20' - 'ping_SP_1' - exiting ==============
Feb 28 19:28:49 srv4hai kernel: [86745392.240566] CPU7: Core temperature above threshold, cpu clock throttled (total events = 9431593)
Feb 28 19:28:49 srv4hai kernel: [86745392.240567] CPU3: Core temperature above threshold, cpu clock throttled (total events = 9431593)
Feb 28 19:28:49 srv4hai kernel: [86745392.241593] CPU7: Core temperature/speed normal
Feb 28 19:28:49 srv4hai kernel: [86745392.241593] CPU3: Core temperature/speed normal
Feb 28 19:28:54 srv4hai nmbd[2172]: [2025/02/28 19:28:54.297422,  0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
Feb 28 19:28:54 srv4hai nmbd[2172]:   find_domain_master_name_query_fail:
Feb 28 19:28:54 srv4hai nmbd[2172]:   Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
Feb 28 19:28:54 srv4hai nmbd[2172]:   Unable to sync browse lists in this workgroup.
Feb 28 19:28:55 srv4hai common[28556]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Feb 28 19:28:55 srv4hai common[28564]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Feb 28 19:28:55 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Feb 28 19:28:55 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Feb 28 19:28:55 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Feb 28 19:28:55 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Feb 28 19:28:55 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.62
Feb 28 19:28:55 srv4hai dhcpd[4995]: execute_statement argv[2] = GreteS20
Feb 28 19:28:55 srv4hai named[30406]: client @0x7f932c097490 192.168.12.252#47337/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 28 19:28:55 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#37225/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 28 19:28:55 srv4hai common[28581]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Feb 28 19:28:55 srv4hai ping_SP[28564]: SHELLY ping_SP.sh started from smartphone, user:'root'
Feb 28 19:28:56 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'5'=1740767336-1740767331
Feb 28 19:28:56 srv4hai check_presence[28556]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Feb 28 19:28:56 srv4hai check_presence[28556]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Feb 28 19:28:56 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'5'=1740767336-1740767331
Feb 28 19:28:56 srv4hai check_presence[28556]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Feb 28 19:28:56 srv4hai check_presence[28556]: SHELLY (ping_SP__smartphone)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Feb 28 19:28:56 srv4hai check_presence[28556]: SHELLY (ping_SP__smartphone)-(1) what: 'coming' - persPresent: '(BT/LIVE) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Feb 28 19:28:56 srv4hai check_presence[28556]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Feb 28 19:28:56 srv4hai check_presence[28556]: SHELLY (ping_SP__smartphone)-(1)-coming: activate_scenario.shtml: vorraumOn
Feb 28 19:28:56 srv4hai activate_scenario[28711]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Feb 28 19:28:56 srv4hai activate_scenario[28711]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'1'

finished