activate_scenario.sh
Sat Apr 19 15:14:57 CEST 2025
scenario: vorraumOn
phoneName: 0

dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as '
-> execution of scenario

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

(/srv/www/viehai/shelly/log_scenarios/2025/04/19/_0.log)

vorher: 15:14:58.009

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: 15:14:58.145
Dauer: 136 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 15:14:57.990
nachher: 15:14:58.158
Dauer : 168 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/04/19//scene_vorraumOn_20250419_151457.txt'


syslog

Apr 19 15:11:00 srv4hai mqtt_process[26466]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 19 15:11:00 srv4hai mqtt_process[26491]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:11:00 srv4hai mqtt_process[26516]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:11:01 srv4hai CRON[26542]: (root) CMD (/etc/linetest/linetest.sh)
Apr 19 15:11:11 srv4hai named[30406]: connection refused resolving '116.140.65.176.in-addr.arpa/PTR/IN': 164.92.208.132#53
Apr 19 15:11:20 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=26560, secured, session=<0BzwXiEzbM0AAAAAAAAAAAAAAAAAAAAB>
Apr 19 15:11:20 srv4hai dovecot: imap(miglincit)<26560><0BzwXiEzbM0AAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 19 15:11:21 srv4hai named[30406]: connection refused resolving '116.140.65.176.in-addr.arpa/PTR/IN': 164.92.208.132#53
Apr 19 15:11:27 srv4hai postfix/smtpd[26548]: connect from unknown[176.65.140.116]
Apr 19 15:11:27 srv4hai postfix/smtpd[26548]: lost connection after CONNECT from unknown[176.65.140.116]
Apr 19 15:11:27 srv4hai postfix/smtpd[26548]: disconnect from unknown[176.65.140.116] commands=0/0
Apr 19 15:11:31 srv4hai mqtt_process[26566]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:11:31 srv4hai mqtt_process[26591]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:11:31 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=26617, secured, session=
Apr 19 15:11:31 srv4hai dovecot: imap(rozumm)<26617>: Logged out in=92 out=1062 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 19 15:11:32 srv4hai ping_SP[7291]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1745068292 - 'ping_SP_1'
Apr 19 15:11:32 srv4hai ping_SP[7291]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 19 15:11:34 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=26638, secured, session=
Apr 19 15:11:34 srv4hai dovecot: imap(miglincit)<26638>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 19 15:12:00 srv4hai mqtt_process[26646]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 19 15:12:00 srv4hai mqtt_process[26673]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:12:00 srv4hai mqtt_process[26698]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:12:01 srv4hai CRON[26724]: (root) CMD (/etc/linetest/linetest.sh)
Apr 19 15:12:12 srv4hai kernel: [91046446.822630] CPU5: Core temperature/speed normal
Apr 19 15:12:12 srv4hai kernel: [91046446.822631] CPU1: Core temperature/speed normal
Apr 19 15:12:31 srv4hai mqtt_process[26734]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:12:31 srv4hai mqtt_process[26759]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:12:31 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=26785, secured, session=
Apr 19 15:12:31 srv4hai dovecot: imap(rozumm)<26785>: Logged out in=92 out=1062 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 19 15:12:35 srv4hai ping_SP[7291]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1745068355 - 'ping_SP_1'
Apr 19 15:12:35 srv4hai ping_SP[7291]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 19 15:12:59 srv4hai mqtt_process[26809]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:13:00 srv4hai mqtt_process[26834]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:13:00 srv4hai mqtt_process[26859]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 19 15:13:01 srv4hai CRON[26885]: (root) CMD (/etc/linetest/linetest.sh)
Apr 19 15:13:31 srv4hai mqtt_process[26897]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:13:31 srv4hai mqtt_process[26922]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:13:32 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=26948, secured, session=
Apr 19 15:13:32 srv4hai dovecot: imap(rozumm)<26948>: Logged out in=92 out=1062 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 19 15:13:38 srv4hai ping_SP[7291]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1745068418 - 'ping_SP_1'
Apr 19 15:13:38 srv4hai ping_SP[7291]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 19 15:14:00 srv4hai mqtt_process[26973]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 19 15:14:00 srv4hai mqtt_process[26998]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:14:00 srv4hai mqtt_process[27023]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:14:01 srv4hai CRON[27049]: (root) CMD (/etc/linetest/linetest.sh)
Apr 19 15:14:20 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27064, secured, session=
Apr 19 15:14:20 srv4hai dovecot: imap(miglincit)<27064>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 19 15:14:21 srv4hai nmbd[2172]: [2025/04/19 15:14:21.680794,  0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
Apr 19 15:14:21 srv4hai nmbd[2172]:   find_domain_master_name_query_fail:
Apr 19 15:14:21 srv4hai nmbd[2172]:   Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
Apr 19 15:14:21 srv4hai nmbd[2172]:   Unable to sync browse lists in this workgroup.
Apr 19 15:14:31 srv4hai mqtt_process[27068]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:14:31 srv4hai mqtt_process[27093]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 19 15:14:32 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Apr 19 15:14:32 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27119, secured, session=
Apr 19 15:14:32 srv4hai dovecot: imap(rozumm)<27119>: Logged out in=92 out=1062 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 19 15:14:32 srv4hai fetchmail[1651]: 68099 messages (68099 seen) for tmiglinci at mail.akis.at (1316700329 octets).
Apr 19 15:14:33 srv4hai fetchmail[1651]: 11847 messages (11847 seen) for srozum at mail.akis.at (1395937177 octets).
Apr 19 15:14:33 srv4hai fetchmail[1651]: 30415 messages (30415 seen) for mrozum at mail.akis.at (955306480 octets).
Apr 19 15:14:34 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=27121, secured, session=
Apr 19 15:14:34 srv4hai dovecot: imap(miglincit)<27121>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 19 15:14:34 srv4hai fetchmail[1651]: 1169 messages (1169 seen) for admin@bastelstube.wien at pop3.world4you.com (52284237 octets).
Apr 19 15:14:42 srv4hai ping_SP[7291]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1745068482 - 'ping_SP_1'
Apr 19 15:14:42 srv4hai ping_SP[7291]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 19 15:14:47 srv4hai postfix/anvil[26563]: statistics: max connection rate 1/60s for (smtp:176.65.140.116) at Apr 19 15:11:27
Apr 19 15:14:47 srv4hai postfix/anvil[26563]: statistics: max connection count 1 for (smtp:176.65.140.116) at Apr 19 15:11:27
Apr 19 15:14:47 srv4hai postfix/anvil[26563]: statistics: max cache size 1 at Apr 19 15:11:27
Apr 19 15:14:47 srv4hai dhcpd[30231]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Apr 19 15:14:47 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr 19 15:14:47 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Apr 19 15:14:47 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.61
Apr 19 15:14:47 srv4hai dhcpd[30231]: execute_statement argv[2] = fpThomas
Apr 19 15:14:47 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Apr 19 15:14:47 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Apr 19 15:14:47 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr 19 15:14:47 srv4hai named[30406]: client @0x7f93480deab0 192.168.12.252#52743/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 19 15:14:47 srv4hai named[30406]: client @0x7f93100c3be0 192.168.12.252#32795/key rndc-key: signer "rndc-key" approved
Apr 19 15:14:47 srv4hai named[30406]: client @0x7f93100c3be0 192.168.12.252#32795/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Apr 19 15:14:47 srv4hai named[30406]: client @0x7f93100c3be0 192.168.12.252#32795/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Apr 19 15:14:47 srv4hai named[30406]: client @0x7f93100c3be0 192.168.12.252#32795/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Apr 19 15:14:47 srv4hai named[30406]: client @0x7f93100c3be0 192.168.12.252#32795/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Apr 19 15:14:47 srv4hai dhcpd[30231]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Apr 19 15:14:47 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#56193/key rndc-key: signer "rndc-key" approved
Apr 19 15:14:47 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#56193/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Apr 19 15:14:47 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#56193/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.
Apr 19 15:14:47 srv4hai dhcpd[30231]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Apr 19 15:14:47 srv4hai ping_SP[27156]: SHELLY ping_SP.sh started from smartphone, user:'root'
Apr 19 15:14:57 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
Apr 19 15:14:57 srv4hai check_presence[27203]: SHELLY (0) found /srv/www/viehai/shelly/meter/ping_SP_0.LIVE and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_0.No
Apr 19 15:14:57 srv4hai check_presence[27203]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_0.LIVE' for what: 'coming'
Apr 19 15:14:57 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
Apr 19 15:14:57 srv4hai check_presence[27203]: SHELLY (1) found /srv/www/viehai/shelly/meter/ping_SP_1.LIVE and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_1.Yes
Apr 19 15:14:57 srv4hai check_presence[27203]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_1.LIVE' for what: 'coming'
Apr 19 15:14:57 srv4hai check_presence[27203]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Apr 19 15:14:57 srv4hai check_presence[27203]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_SpeedTest) - sceneONsmall(vorraumOn)
Apr 19 15:14:57 srv4hai check_presence[27203]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Apr 19 15:14:57 srv4hai activate_scenario[27288]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Apr 19 15:14:57 srv4hai activate_scenario[27288]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - phoneName:'0'

finished