activate_scenario.sh
Mon Mar 25 18:04:50 CET 2024
scenario: LOG_kommen
source: 192.168.12.103
'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to ''
scenario: 'LOG_EIN' - 'LOG_kommen' - 'log_kommen'

urls : 0
vorher : 18:04:50.115
nachher: 18:04:50.121
Dauer : 5 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/25//scene_LOG_kommen_20240325_180450.txt'
syslog

Mar 25 18:01:00 srv4hai meter.sh: SHELLY 'shelly-45/45-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 25 18:01:00 srv4hai meter.sh: SHELLY meter.sh ended
Mar 25 18:01:00 srv4hai CRON[549]: (root) CMD (/etc/linetest/linetest.sh)
Mar 25 18:01:00 srv4hai postfix/pickup[18808]: 406616027D: uid=33 from=
Mar 25 18:01:00 srv4hai postfix/cleanup[547]: 406616027D: message-id=<20240325170100.406616027D@mail.viehai.at>
Mar 25 18:01:00 srv4hai postfix/qmgr[15291]: 406616027D: from=, size=654, nrcpt=1 (queue active)
Mar 25 18:01:00 srv4hai postfix/local[554]: 406616027D: to=, orig_to=, relay=local, delay=0.05, delays=0.04/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 25 18:01:00 srv4hai postfix/qmgr[15291]: 406616027D: removed
Mar 25 18:01:35 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Mar 25 18:01:36 srv4hai fetchmail[1651]: 40552 messages (40552 seen) for tmiglinci at mail.akis.at (-934184575 octets).
Mar 25 18:01:36 srv4hai fetchmail[1651]: 10049 messages (10049 seen) for srozum at mail.akis.at (1214823692 octets).
Mar 25 18:01:37 srv4hai fetchmail[1651]: 22471 messages (22471 seen) for mrozum at mail.akis.at (-403616113 octets).
Mar 25 18:01:37 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Mar 25 18:01:48 srv4hai ping_SP[21898]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711386108 - 'ping_SP_0'
Mar 25 18:01:48 srv4hai ping_SP[21898]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 25 18:02:01 srv4hai CRON[588]: (root) CMD (/etc/linetest/linetest.sh)
Mar 25 18:02:02 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=594, secured, session=
Mar 25 18:02:02 srv4hai dovecot: imap(miglincit)<594>: Logged out in=29 out=529 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 25 18:02:02 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=597, secured, session=
Mar 25 18:02:02 srv4hai dovecot: imap(miglincit)<597>: Logged out in=44 out=183378 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 25 18:02:03 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=599, secured, session=
Mar 25 18:02:03 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=601, secured, session=<7AL3IX8UvskAAAAAAAAAAAAAAAAAAAAB>
Mar 25 18:02:03 srv4hai dovecot: imap(miglincit)<599>: Logged out in=653 out=43018 deleted=0 expunged=0 trashed=0 hdr_count=50 hdr_bytes=19299 body_count=0 body_bytes=0
Mar 25 18:02:04 srv4hai dovecot: imap(miglincit)<601><7AL3IX8UvskAAAAAAAAAAAAAAAAAAAAB>: Logged out in=265524 out=1160160 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 25 18:02:06 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=603, secured, session=
Mar 25 18:02:06 srv4hai dovecot: imap(miglincit)<603>: Logged out in=443 out=3907 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=450 body_count=1 body_bytes=1904
Mar 25 18:02:11 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=606, secured, session=
Mar 25 18:02:11 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=608, secured, session=
Mar 25 18:02:11 srv4hai dovecot: imap(miglincit)<608>: Logged out in=441 out=14037 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=382 body_count=1 body_bytes=12100
Mar 25 18:02:11 srv4hai dovecot: imap(miglincit)<606>: Logged out in=630 out=15178 deleted=0 expunged=0 trashed=2 hdr_count=2 hdr_bytes=790 body_count=0 body_bytes=0
Mar 25 18:02:14 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=610, secured, session=<8ZaiIn8UxskAAAAAAAAAAAAAAAAAAAAB>
Mar 25 18:02:14 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=612, secured, session=<0oCjIn8UyMkAAAAAAAAAAAAAAAAAAAAB>
Mar 25 18:02:14 srv4hai dovecot: imap(miglincit)<610><8ZaiIn8UxskAAAAAAAAAAAAAAAAAAAAB>: Logged out in=630 out=14974 deleted=0 expunged=0 trashed=2 hdr_count=2 hdr_bytes=626 body_count=0 body_bytes=0
Mar 25 18:02:14 srv4hai dovecot: imap(miglincit)<612><0oCjIn8UyMkAAAAAAAAAAAAAAAAAAAAB>: Logged out in=563 out=4303 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=418 body_count=4 body_bytes=1776
Mar 25 18:02:16 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=614, secured, session=
Mar 25 18:02:16 srv4hai dovecot: imap(miglincit)<614>: Logged out in=395 out=13944 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=382 body_count=1 body_bytes=12100
Mar 25 18:02:19 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 25 18:02:19 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.28
Mar 25 18:02:19 srv4hai dhcpd[5037]: execute_statement argv[2] = harmonyhub
Mar 25 18:02:19 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.28 from c8:db:26:0c:f3:8e via enp2s0
Mar 25 18:02:19 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Mar 25 18:02:19 srv4hai named[15509]: client @0x7f93180676c0 192.168.12.252#35233/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 25 18:02:19 srv4hai named[15509]: client @0x7f931c13a950 192.168.12.252#52397/key rndc-key: signer "rndc-key" approved
Mar 25 18:02:19 srv4hai named[15509]: client @0x7f931c13a950 192.168.12.252#52397/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Mar 25 18:02:19 srv4hai named[15509]: client @0x7f931c13a950 192.168.12.252#52397/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Mar 25 18:02:19 srv4hai named[15509]: client @0x7f931c13a950 192.168.12.252#52397/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Mar 25 18:02:19 srv4hai named[15509]: client @0x7f931c13a950 192.168.12.252#52397/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Mar 25 18:02:19 srv4hai dhcpd[5037]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Mar 25 18:02:19 srv4hai named[15509]: client @0x7f93100604b0 192.168.12.252#51423/key rndc-key: signer "rndc-key" approved
Mar 25 18:02:19 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Mar 25 18:02:19 srv4hai named[15509]: client @0x7f93100604b0 192.168.12.252#51423/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Mar 25 18:02:19 srv4hai named[15509]: client @0x7f93100604b0 192.168.12.252#51423/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '28.12.168.192.in-addr.arpa' PTR harmonyhub.viehai.at.
Mar 25 18:02:19 srv4hai dhcpd[5037]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Mar 25 18:02:19 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Mar 25 18:02:57 srv4hai activate_scenario[4890]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Mar 25 18:02:57 srv4hai activate_scenario[4890]: SHELLY dayState='day' <--> DayTime=unchecked NightTime=checked - shelly-0:''
Mar 25 18:02:57 srv4hai activate_scenario[4890]: SHELLY scenario: 'vorraumOn(vorraumon)' NOT EXECUTED, shelly-0:''
Mar 25 18:02:57 srv4hai postfix/pickup[18808]: E68AD6027D: uid=33 from=
Mar 25 18:02:57 srv4hai postfix/cleanup[4943]: E68AD6027D: message-id=<20240325170257.E68AD6027D@mail.viehai.at>
Mar 25 18:02:57 srv4hai postfix/qmgr[15291]: E68AD6027D: from=, size=13614, nrcpt=1 (queue active)
Mar 25 18:02:59 srv4hai postfix/relay/smtp[4945]: E68AD6027D: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=1.2, delays=0.02/0.02/0.82/0.34, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as D030880163)
Mar 25 18:02:59 srv4hai postfix/qmgr[15291]: E68AD6027D: removed
Mar 25 18:03:01 srv4hai CRON[5964]: (root) CMD (/etc/linetest/linetest.sh)
Mar 25 18:03:01 srv4hai ping_SP[21898]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711386181 - 'ping_SP_0'
Mar 25 18:03:01 srv4hai ping_SP[21898]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 25 18:03:58 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=7486, secured, session=
Mar 25 18:03:58 srv4hai dovecot: imap(miglincit)<7486>: Logged out in=735 out=43414 deleted=0 expunged=0 trashed=0 hdr_count=50 hdr_bytes=19611 body_count=0 body_bytes=0
Mar 25 18:04:01 srv4hai CRON[7489]: (root) CMD (/etc/linetest/linetest.sh)
Mar 25 18:04:14 srv4hai ping_SP[21898]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711386254 - 'ping_SP_0'
Mar 25 18:04:14 srv4hai ping_SP[21898]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 25 18:04:39 srv4hai common[7519]: SHELLY common.sh inkludiert
Mar 25 18:04:49 srv4hai bt_scan[7519]: SHELLY - who: 'Sophie' / phoneName: 'iP_Sophie' / '2' / fixAddr: '192.168.12.63;' - found: 'Yes'
Mar 25 18:04:49 srv4hai bt_scan[7519]: SHELLY - ping_SP.sh started for BTmac: '2' - IPv4: '192.168.12.63'
Mar 25 18:04:49 srv4hai common[7550]: SHELLY common.sh inkludiert
Mar 25 18:04:49 srv4hai ping_SP[7550]: SHELLY ping_SP.sh started from bt_scan
Mar 25 18:04:49 srv4hai common[7560]: SHELLY common.sh inkludiert
Mar 25 18:04:49 srv4hai check_presence[7560]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Mar 25 18:04:49 srv4hai check_presence[7560]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Mar 25 18:04:49 srv4hai check_presence[7560]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and On//srv/www/viehai/shelly//meter/BTscan_BTid_2.Yes
Mar 25 18:04:49 srv4hai check_presence[7560]: SHELLY (ping_SP__bt_scan)-(2) what: 'coming' - persPresent: '(__/IP) (__/__) (BT/__)' - anyPresent: 'true' - otherPresent:'true'
Mar 25 18:04:49 srv4hai check_presence[7560]: SHELLY (ping_SP__bt_scan)-(2)-coming: activate_scenario.shtml: vorraumOn
Mar 25 18:04:49 srv4hai activate_scenario[7624]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Mar 25 18:04:49 srv4hai activate_scenario[7624]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'2'
Mar 25 18:04:49 srv4hai activate_scenario[7624]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'2'
Mar 25 18:04:49 srv4hai postfix/pickup[18808]: EF1BB6027D: uid=33 from=
Mar 25 18:04:49 srv4hai postfix/cleanup[7674]: EF1BB6027D: message-id=<20240325170449.EF1BB6027D@mail.viehai.at>
Mar 25 18:04:49 srv4hai postfix/qmgr[15291]: EF1BB6027D: from=, size=12009, nrcpt=1 (queue active)
Mar 25 18:04:50 srv4hai activate_scenario[7624]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Mar 25 18:04:50 srv4hai proc_url[7691]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/03/25/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'2''
Mar 25 18:04:50 srv4hai activate_scenario[7624]: SHELLY scenario: 'vorraumOn(vorraumon)' took 73 msec, phoneName:'2'
Mar 25 18:04:50 srv4hai activate_scenario[7716]: SHELLY scenario: 'LOG_kommen(log_kommen)' started
Mar 25 18:04:50 srv4hai activate_scenario[7716]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-03:'Licht Vorzimmer'
Mar 25 18:04:50 srv4hai ping_SP[7550]: SHELLY check_presence.sh coming 2 ping_SP__bt_scan
finished