activate_scenario.sh
Mon Jan 27 17:29:00 CET 2025
scenario: vorraumOn
phoneName: 0

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

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

VZ Licht (/srv/www/viehai/shelly/log_scenarios/2025/01/27/_0.log)

vorher: 17:29:00.385

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: 17:29:00.426
Dauer: 40 msec phName: 'phoneName:'0''


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

urls : 1
vorher : 17:29:00.321
nachher: 17:29:00.433
Dauer : 113 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/27//scene_vorraumOn_20250127_172900.txt'


syslog

Jan 27 17:26:00 srv4hai named[30406]: resolver priming query complete
Jan 27 17:26:00 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=2235, secured, session=
Jan 27 17:26:00 srv4hai dovecot: imap(miglincit)<2235>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 27 17:26:00 srv4hai common[2236]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:26:00 srv4hai common[2260]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:26:00 srv4hai ping_SP[2006]: SHELLY (1)- ping 192.168.12.62 1 not answered (1) @~1737995160 - 'ping_SP_1'
Jan 27 17:26:01 srv4hai CRON[2300]: (root) CMD (/etc/linetest/linetest.sh)
Jan 27 17:26:01 srv4hai common[2304]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:26:01 srv4hai common[2330]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:26:02 srv4hai named[30406]: resolver priming query complete
Jan 27 17:26:04 srv4hai named[30406]: resolver priming query complete
Jan 27 17:26:05 srv4hai named[30406]: resolver priming query complete
Jan 27 17:26:06 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jan 27 17:26:06 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jan 27 17:26:06 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jan 27 17:26:06 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 27 17:26:06 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.62
Jan 27 17:26:06 srv4hai dhcpd[4995]: execute_statement argv[2] = GreteS20
Jan 27 17:26:06 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 27 17:26:06 srv4hai common[2369]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 27 17:26:10 srv4hai named[30406]: resolver priming query complete
Jan 27 17:26:13 srv4hai named[30406]: resolver priming query complete
Jan 27 17:26:14 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan 27 17:26:15 srv4hai fetchmail[1651]: 62361 messages (62360 seen) for tmiglinci at mail.akis.at (805998066 octets).
Jan 27 17:26:15 srv4hai postfix/smtpd[2391]: connect from localhost[127.0.0.1]
Jan 27 17:26:15 srv4hai postfix/smtpd[2391]: 565C6631BE: client=localhost[127.0.0.1]
Jan 27 17:26:15 srv4hai postfix/cleanup[2108]: 565C6631BE: message-id=<20250127162518.6B2AF63463@mail.viehai.at>
Jan 27 17:26:15 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:62361 of 62361 (5917 octets) not flushed
Jan 27 17:26:15 srv4hai postfix/qmgr[8566]: 565C6631BE: from=, size=6203, nrcpt=1 (queue active)
Jan 27 17:26:15 srv4hai postfix/smtpd[2391]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Jan 27 17:26:15 srv4hai postfix/local[2393]: 565C6631BE: to=, relay=local, delay=0.06, delays=0.05/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 27 17:26:15 srv4hai postfix/qmgr[8566]: 565C6631BE: removed
Jan 27 17:26:15 srv4hai fetchmail[1651]: 11455 messages (11455 seen) for srozum at mail.akis.at (1363034596 octets).
Jan 27 17:26:16 srv4hai fetchmail[1651]: 28564 messages (28564 seen) for mrozum at mail.akis.at (597252535 octets).
Jan 27 17:26:16 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jan 27 17:26:16 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jan 27 17:26:16 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jan 27 17:26:16 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 27 17:26:16 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.62
Jan 27 17:26:16 srv4hai dhcpd[4995]: execute_statement argv[2] = GreteS20
Jan 27 17:26:16 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 27 17:26:16 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#53063/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 27 17:26:16 srv4hai fetchmail[1651]: 1162 messages (1162 seen) for admin@bastelstube.wien at pop3.world4you.com (52206525 octets).
Jan 27 17:26:16 srv4hai common[2413]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 27 17:26:18 srv4hai named[30406]: resolver priming query complete
Jan 27 17:26:23 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 2 sucessfully  @~1737995183 - 'ping_SP_1'
Jan 27 17:26:23 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 27 17:26:26 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.62' / 'GreteS20' / '1'
Jan 27 17:26:26 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.62 (192.168.12.252) from f0:39:65:25:8d:c7 via enp2s0
Jan 27 17:26:26 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.62 to f0:39:65:25:8d:c7 via enp2s0
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: GreteS20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: signer "rndc-key" approved
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: signer "rndc-key" approved
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Jan 27 17:26:26 srv4hai dhcpd[4995]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Jan 27 17:26:26 srv4hai dhcpd[4995]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: signer "rndc-key" approved
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Jan 27 17:26:26 srv4hai dhcpd[4995]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: signer "rndc-key" approved
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' TXT
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' TXT "318a9f974c0d8a2868f64397b15c3ed3a0"
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'GreteS20.viehai.at' A
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'GreteS20.viehai.at' A 192.168.12.62
Jan 27 17:26:26 srv4hai dhcpd[4995]: Added new forward map from GreteS20.viehai.at to 192.168.12.62
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: signer "rndc-key" approved
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '62.12.168.192.in-addr.arpa' PTR GreteS20.viehai.at.
Jan 27 17:26:26 srv4hai dhcpd[4995]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: signer "rndc-key" approved
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '62.12.168.192.in-addr.arpa' PTR GreteS20.viehai.at.
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: signer "rndc-key" approved
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '62.12.168.192.in-addr.arpa' PTR GreteS20.viehai.at.
Jan 27 17:26:26 srv4hai dhcpd[4995]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: signer "rndc-key" approved
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '62.12.168.192.in-addr.arpa' PTR
Jan 27 17:26:26 srv4hai named[30406]: client @0x7f933011e890 192.168.12.252#36537/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '62.12.168.192.in-addr.arpa' PTR GreteS20.viehai.at.
Jan 27 17:26:26 srv4hai dhcpd[4995]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Jan 27 17:26:26 srv4hai dhcpd[4995]: Added reverse map from 62.12.168.192.in-addr.arpa. to GreteS20.viehai.at
Jan 27 17:26:38 srv4hai named[30406]: resolver priming query complete
Jan 27 17:26:55 srv4hai named[30406]: resolver priming query complete
Jan 27 17:26:59 srv4hai common[2465]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:27:00 srv4hai common[2495]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:27:00 srv4hai common[2522]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:27:01 srv4hai common[2546]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:27:01 srv4hai common[2570]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:27:01 srv4hai CRON[2595]: (root) CMD (/etc/linetest/linetest.sh)
Jan 27 17:27:13 srv4hai mosquitto[29419]: Saving in-memory database to /var/lib/mosquitto/mosquitto.db.
Jan 27 17:27:37 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1737995257 - 'ping_SP_1'
Jan 27 17:27:37 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 27 17:27:59 srv4hai common[2627]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:28:00 srv4hai common[2651]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:28:00 srv4hai common[2675]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:28:01 srv4hai common[2699]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:28:01 srv4hai common[2723]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:28:01 srv4hai CRON[2748]: (root) CMD (/etc/linetest/linetest.sh)
Jan 27 17:28:07 srv4hai named[30406]: resolver priming query complete
Jan 27 17:28:19 srv4hai named[30406]: resolver priming query complete
Jan 27 17:28:32 srv4hai nmbd[2172]: [2025/01/27 17:28:32.857098,  0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
Jan 27 17:28:32 srv4hai nmbd[2172]:   find_domain_master_name_query_fail:
Jan 27 17:28:32 srv4hai nmbd[2172]:   Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
Jan 27 17:28:32 srv4hai nmbd[2172]:   Unable to sync browse lists in this workgroup.
Jan 27 17:28:49 srv4hai common[2765]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 27 17:28:50 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1737995330 - 'ping_SP_1'
Jan 27 17:28:50 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 27 17:28:59 srv4hai bt_scan[2765]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Jan 27 17:28:59 srv4hai bt_scan[2765]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Jan 27 17:28:59 srv4hai common[2816]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 27 17:28:59 srv4hai ping_SP[2816]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jan 27 17:28:59 srv4hai common[2837]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 27 17:28:59 srv4hai common[2850]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:29:00 srv4hai common[2878]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:29:00 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'5'=1737995340-1737995335
Jan 27 17:29:00 srv4hai check_presence[2837]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jan 27 17:29:00 srv4hai common[2936]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:29:00 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'5'=1737995340-1737995335
Jan 27 17:29:00 srv4hai check_presence[2837]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jan 27 17:29:00 srv4hai check_presence[2837]: SHELLY (ping_SP__bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jan 27 17:29:00 srv4hai check_presence[2837]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(BT/__) (__/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Jan 27 17:29:00 srv4hai check_presence[2837]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
Jan 27 17:29:00 srv4hai check_presence[2837]: SHELLY (ping_SP__bt_scan)-(0)-coming: activate_scenario.shtml: vorraumOn
Jan 27 17:29:00 srv4hai activate_scenario[3024]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jan 27 17:29:00 srv4hai activate_scenario[3024]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished