activate_scenario.sh
Fri Mar 8 09:24:45 CET 2024
scenario: LOG_gehen
source: 192.168.12.103
'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to ''
scenario: 'LOG_AUS' - 'LOG_gehen' - 'log_gehen'
scenario: 'LOG_AUS' - 'LOG_gehen' - 'log_gehen'
urls : 0
vorher : 09:24:45.639
nachher: 09:24:45.646
Dauer : 7 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/08//scene_LOG_gehen_20240308_092445.txt'
syslog
Mar 8 09:21:00 srv4hai meter.sh: SHELLY 'shelly-45/45-TBD': OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 8 09:21:00 srv4hai meter.sh: SHELLY meter.sh ended
Mar 8 09:21:00 srv4hai CRON[679]: (root) CMD (/etc/linetest/linetest.sh)
Mar 8 09:21:00 srv4hai postfix/pickup[28443]: 5DC8F602B8: uid=33 from=
Mar 8 09:21:00 srv4hai postfix/cleanup[677]: 5DC8F602B8: message-id=<20240308082100.5DC8F602B8@mail.viehai.at>
Mar 8 09:21:00 srv4hai postfix/qmgr[15291]: 5DC8F602B8: from=, size=654, nrcpt=1 (queue active)
Mar 8 09:21:00 srv4hai postfix/local[684]: 5DC8F602B8: to=, orig_to=, relay=local, delay=0.04, delays=0.02/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 8 09:21:00 srv4hai postfix/qmgr[15291]: 5DC8F602B8: removed
Mar 8 09:21:10 srv4hai ping_SP[26982]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1709886070 - 'ping_SP_0'
Mar 8 09:21:10 srv4hai ping_SP[26982]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 8 09:21:13 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=707, secured, session=
Mar 8 09:21:13 srv4hai dovecot: imap(miglincit)<707>: Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 8 09:21:23 srv4hai postfix/smtpd[709]: connect from unknown[193.222.96.70]
Mar 8 09:21:24 srv4hai postfix/smtpd[709]: warning: unknown[193.222.96.70]: SASL LOGIN authentication failed: Invalid authentication mechanism
Mar 8 09:21:24 srv4hai postfix/smtpd[709]: disconnect from unknown[193.222.96.70] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4
Mar 8 09:22:01 srv4hai CRON[720]: (root) CMD (/etc/linetest/linetest.sh)
Mar 8 09:22:24 srv4hai ping_SP[26982]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1709886144 - 'ping_SP_0'
Mar 8 09:22:24 srv4hai ping_SP[26982]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 8 09:22:25 srv4hai dovecot: imap(miglincit)<28671>: Logged out in=2910 out=3782080 deleted=0 expunged=0 trashed=0 hdr_count=4 hdr_bytes=1656 body_count=4 body_bytes=3699062
Mar 8 09:22:25 srv4hai activate_scenario[751]: SHELLY scenario: 'pcOFF(pcoff)' started
Mar 8 09:22:25 srv4hai activate_scenario[751]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-0:''
Mar 8 09:22:25 srv4hai activate_scenario[751]: SHELLY scenario: 'pcOFF(pcoff)' TO BE EXECUTED, shelly-0:''
Mar 8 09:22:25 srv4hai postfix/pickup[28443]: 957B3602B8: uid=33 from=
Mar 8 09:22:25 srv4hai postfix/cleanup[677]: 957B3602B8: message-id=<20240308082225.957B3602B8@mail.viehai.at>
Mar 8 09:22:25 srv4hai postfix/qmgr[15291]: 957B3602B8: from=, size=7285, nrcpt=1 (queue active)
Mar 8 09:22:25 srv4hai postfix/local[684]: 957B3602B8: to=, orig_to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Mar 8 09:22:25 srv4hai postfix/cleanup[677]: 9A32C602B9: message-id=<20240308082225.9A32C602B9@mail.viehai.at>
Mar 8 09:22:25 srv4hai activate_scenario[751]: SHELLY: scenario: 'pcOFF(pcoff)'-'shelly-20'-'Thomas Schreibtischlampe' --> '0?turn=off'
Mar 8 09:22:25 srv4hai proc_url[824]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/03/08/_0.log' - shellyUsage:'Thomas Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=off' - phName:'shelly-0:'''
Mar 8 09:22:25 srv4hai postfix/bounce[814]: 957B3602B8: sender non-delivery notification: 9A32C602B9
Mar 8 09:22:25 srv4hai postfix/qmgr[15291]: 9A32C602B9: from=<>, size=9164, nrcpt=1 (queue active)
Mar 8 09:22:25 srv4hai postfix/qmgr[15291]: 957B3602B8: removed
Mar 8 09:22:25 srv4hai postfix/local[684]: 9A32C602B9: to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 8 09:22:25 srv4hai postfix/qmgr[15291]: 9A32C602B9: removed
Mar 8 09:22:25 srv4hai activate_scenario[751]: SHELLY scenario: 'pcOFF(pcoff)' took 61 msec, shelly-0:''
Mar 8 09:22:29 srv4hai activate_scenario[858]: SHELLY scenario: 'buero_UM(buero_um)' started
Mar 8 09:22:29 srv4hai activate_scenario[858]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'
Mar 8 09:22:29 srv4hai activate_scenario[858]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'Thomas Büro Licht'
Mar 8 09:22:29 srv4hai postfix/pickup[28443]: C05A9602B8: uid=33 from=
Mar 8 09:22:29 srv4hai postfix/cleanup[677]: C05A9602B8: message-id=<20240308082229.C05A9602B8@mail.viehai.at>
Mar 8 09:22:29 srv4hai postfix/qmgr[15291]: C05A9602B8: from=, size=9312, nrcpt=1 (queue active)
Mar 8 09:22:29 srv4hai postfix/local[684]: C05A9602B8: to=, orig_to=, relay=local, delay=0.02, delays=0.02/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Mar 8 09:22:29 srv4hai postfix/cleanup[677]: C3C21602B9: message-id=<20240308082229.C3C21602B9@mail.viehai.at>
Mar 8 09:22:29 srv4hai postfix/bounce[814]: C05A9602B8: sender non-delivery notification: C3C21602B9
Mar 8 09:22:29 srv4hai postfix/qmgr[15291]: C3C21602B9: from=<>, size=11231, nrcpt=1 (queue active)
Mar 8 09:22:29 srv4hai postfix/qmgr[15291]: C05A9602B8: removed
Mar 8 09:22:29 srv4hai postfix/local[684]: C3C21602B9: to=, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 8 09:22:29 srv4hai postfix/qmgr[15291]: C3C21602B9: removed
Mar 8 09:22:29 srv4hai activate_scenario[858]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Mar 8 09:22:29 srv4hai proc_url[931]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/03/08/_0.log' - shellyUsage:'Thomas Büro Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Mar 8 09:22:29 srv4hai activate_scenario[858]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Mar 8 09:22:29 srv4hai proc_url[943]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/03/08/_1.log' - shellyUsage:'Thomas Büro Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Mar 8 09:22:29 srv4hai activate_scenario[858]: SHELLY scenario: 'buero_UM(buero_um)' took 132 msec, shelly-40:'Thomas Büro Licht'
Mar 8 09:22:42 srv4hai activate_scenario[990]: SHELLY scenario: 'LOG_kommen(log_kommen)' started
Mar 8 09:22:42 srv4hai activate_scenario[990]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-03:'Licht Vorzimmer'
Mar 8 09:22:42 srv4hai activate_scenario[990]: SHELLY scenario: 'LOG_kommen(log_kommen)' TO BE EXECUTED, shelly-03:'Licht Vorzimmer'
Mar 8 09:22:42 srv4hai activate_scenario[990]: SHELLY scenario: 'LOG_kommen(log_kommen)' took 6 msec, shelly-03:'Licht Vorzimmer'
Mar 8 09:22:48 srv4hai common[1059]: SHELLY common.sh inkludiert
Mar 8 09:22:58 srv4hai bt_scan[1059]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / fixAddr: '192.168.12.61;' - found: 'Yes'
Mar 8 09:22:58 srv4hai bt_scan[1059]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Mar 8 09:23:01 srv4hai CRON[1091]: (root) CMD (/etc/linetest/linetest.sh)
Mar 8 09:23:37 srv4hai ping_SP[26982]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1709886217 - 'ping_SP_0'
Mar 8 09:23:37 srv4hai ping_SP[26982]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 8 09:23:56 srv4hai dhcpd[5037]: DHCPRELEASE of 192.168.12.2 from 24:5a:4c:1c:1e:f4 via enp2s0 (not found)
Mar 8 09:23:56 srv4hai dhcpd[5037]: DHCPDISCOVER from 24:5a:4c:1c:1e:f4 via enp2s0
Mar 8 09:23:56 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0
Mar 8 09:23:56 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 8 09:23:56 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.2
Mar 8 09:23:56 srv4hai dhcpd[5037]: execute_statement argv[2] = ap2hai
Mar 8 09:23:56 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.2 (192.168.12.252) from 24:5a:4c:1c:1e:f4 via enp2s0
Mar 8 09:23:56 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0
Mar 8 09:23:56 srv4hai named[15509]: client @0x7f930803b0f0 192.168.12.252#49219/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap2hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 8 09:23:56 srv4hai named[15509]: client @0x7f931c65d6a0 192.168.12.252#55939/key rndc-key: signer "rndc-key" approved
Mar 8 09:23:56 srv4hai named[15509]: client @0x7f931c65d6a0 192.168.12.252#55939/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' TXT
Mar 8 09:23:56 srv4hai named[15509]: client @0x7f931c65d6a0 192.168.12.252#55939/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' TXT "31a0d441667de220424b7789941807db7d"
Mar 8 09:23:56 srv4hai named[15509]: client @0x7f931c65d6a0 192.168.12.252#55939/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' A
Mar 8 09:23:56 srv4hai named[15509]: client @0x7f931c65d6a0 192.168.12.252#55939/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' A 192.168.12.2
Mar 8 09:23:56 srv4hai dhcpd[5037]: Added new forward map from ap2hai.viehai.at to 192.168.12.2
Mar 8 09:23:56 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.2'(2) device 'ap2hai'
Mar 8 09:23:56 srv4hai named[15509]: client @0x7f93100a9530 192.168.12.252#47605/key rndc-key: signer "rndc-key" approved
Mar 8 09:23:56 srv4hai named[15509]: client @0x7f93100a9530 192.168.12.252#47605/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '2.12.168.192.in-addr.arpa' PTR
Mar 8 09:23:56 srv4hai named[15509]: client @0x7f93100a9530 192.168.12.252#47605/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '2.12.168.192.in-addr.arpa' PTR ap2hai.viehai.at.
Mar 8 09:23:56 srv4hai dhcpd[5037]: Added reverse map from 2.12.168.192.in-addr.arpa. to ap2hai.viehai.at
Mar 8 09:23:56 srv4hai dhcpcommit.sh: SHELLY device 'ap2hai' known and accepted
Mar 8 09:24:01 srv4hai CRON[1130]: (root) CMD (/etc/linetest/linetest.sh)
Mar 8 09:24:09 srv4hai dhcpd[5037]: DHCPRELEASE of 192.168.12.3 from 70:a7:41:9a:7d:4e via enp2s0 (not found)
Mar 8 09:24:09 srv4hai dhcpd[5037]: DHCPDISCOVER from 70:a7:41:9a:7d:4e via enp2s0
Mar 8 09:24:09 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0
Mar 8 09:24:09 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 8 09:24:09 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.3
Mar 8 09:24:09 srv4hai dhcpd[5037]: execute_statement argv[2] = ap3hai
Mar 8 09:24:09 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.3 (192.168.12.252) from 70:a7:41:9a:7d:4e via enp2s0
Mar 8 09:24:09 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0
Mar 8 09:24:09 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#56623/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap3hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 8 09:24:09 srv4hai named[15509]: client @0x7f931801e8a0 192.168.12.252#43075/key rndc-key: signer "rndc-key" approved
Mar 8 09:24:09 srv4hai named[15509]: client @0x7f931801e8a0 192.168.12.252#43075/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' TXT
Mar 8 09:24:09 srv4hai named[15509]: client @0x7f931801e8a0 192.168.12.252#43075/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' TXT "31763f1a8a980dd918aaf8fff3416a5028"
Mar 8 09:24:09 srv4hai named[15509]: client @0x7f931801e8a0 192.168.12.252#43075/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' A
Mar 8 09:24:09 srv4hai named[15509]: client @0x7f931801e8a0 192.168.12.252#43075/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' A 192.168.12.3
Mar 8 09:24:09 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.3'(3) device 'ap3hai'
Mar 8 09:24:09 srv4hai dhcpd[5037]: Added new forward map from ap3hai.viehai.at to 192.168.12.3
Mar 8 09:24:09 srv4hai named[15509]: client @0x7f930c03c330 192.168.12.252#44815/key rndc-key: signer "rndc-key" approved
Mar 8 09:24:09 srv4hai named[15509]: client @0x7f930c03c330 192.168.12.252#44815/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '3.12.168.192.in-addr.arpa' PTR
Mar 8 09:24:09 srv4hai named[15509]: client @0x7f930c03c330 192.168.12.252#44815/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '3.12.168.192.in-addr.arpa' PTR ap3hai.viehai.at.
Mar 8 09:24:09 srv4hai dhcpd[5037]: Added reverse map from 3.12.168.192.in-addr.arpa. to ap3hai.viehai.at
Mar 8 09:24:09 srv4hai dhcpcommit.sh: SHELLY device 'ap3hai' known and accepted
Mar 8 09:24:13 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=1144, secured, session=
Mar 8 09:24:13 srv4hai dovecot: imap(miglincit)<1144>: Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 8 09:24:16 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Mar 8 09:24:17 srv4hai fetchmail[1651]: 39492 messages (39492 seen) for tmiglinci at mail.akis.at (-1029093374 octets).
Mar 8 09:24:17 srv4hai fetchmail[1651]: 9979 messages (9978 seen) for srozum at mail.akis.at (1209815697 octets).
Mar 8 09:24:17 srv4hai postfix/smtpd[1148]: connect from localhost[127.0.0.1]
Mar 8 09:24:17 srv4hai postfix/smtpd[1148]: A6CD46004F: client=localhost[127.0.0.1]
Mar 8 09:24:17 srv4hai postfix/cleanup[1151]: A6CD46004F: message-id=
Mar 8 09:24:17 srv4hai fetchmail[1651]: reading message srozum@mail.akis.at:9979 of 9979 (74314 octets) not flushed
Mar 8 09:24:17 srv4hai postfix/qmgr[15291]: A6CD46004F: from=, size=74581, nrcpt=1 (queue active)
Mar 8 09:24:17 srv4hai postfix/smtpd[1148]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Mar 8 09:24:17 srv4hai postfix/local[1152]: A6CD46004F: to=, relay=local, delay=0.1, delays=0.08/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 8 09:24:17 srv4hai postfix/qmgr[15291]: A6CD46004F: removed
Mar 8 09:24:18 srv4hai fetchmail[1651]: 22096 messages (22095 seen) for mrozum at mail.akis.at (-478214793 octets).
Mar 8 09:24:18 srv4hai postfix/smtpd[1148]: connect from localhost[127.0.0.1]
Mar 8 09:24:18 srv4hai postfix/smtpd[1148]: 8031B6004F: client=localhost[127.0.0.1]
Mar 8 09:24:18 srv4hai postfix/cleanup[1151]: 8031B6004F: message-id=
Mar 8 09:24:18 srv4hai postfix/qmgr[15291]: 8031B6004F: from=, size=562346, nrcpt=1 (queue active)
Mar 8 09:24:18 srv4hai fetchmail[1651]: reading message mrozum@mail.akis.at:22096 of 22096 (562062 octets) not flushed
Mar 8 09:24:18 srv4hai postfix/smtpd[1148]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Mar 8 09:24:18 srv4hai postfix/local[1152]: 8031B6004F: to=, relay=local, delay=0.37, delays=0.35/0/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 8 09:24:18 srv4hai postfix/qmgr[15291]: 8031B6004F: removed
Mar 8 09:24:19 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Mar 8 09:24:44 srv4hai postfix/anvil[711]: statistics: max connection rate 1/60s for (smtp:193.222.96.70) at Mar 8 09:21:23
Mar 8 09:24:44 srv4hai postfix/anvil[711]: statistics: max connection count 1 for (smtp:193.222.96.70) at Mar 8 09:21:23
Mar 8 09:24:44 srv4hai postfix/anvil[711]: statistics: max cache size 1 at Mar 8 09:21:23
Mar 8 09:24:45 srv4hai activate_scenario[1162]: SHELLY scenario: 'LOG_gehen(log_gehen)' started
Mar 8 09:24:45 srv4hai activate_scenario[1162]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-03:'Licht Vorzimmer'
finished