activate_scenario.sh
Mon Mar 11 11:08:57 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'
scenario: 'LOG_EIN' - 'LOG_kommen' - 'log_kommen'
urls : 0
vorher : 11:08:57.525
nachher: 11:08:57.530
Dauer : 4 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/11//scene_LOG_kommen_20240311_110857.txt'
syslog
Mar 11 11:05:01 srv4hai CRON[18747]: (root) CMD (/etc/linetest/linetest.sh)
Mar 11 11:05:15 srv4hai named[15509]: resolver priming query complete
Mar 11 11:05:26 srv4hai named[15509]: resolver priming query complete
Mar 11 11:05:45 srv4hai named[15509]: resolver priming query complete
Mar 11 11:06:01 srv4hai CRON[18756]: (root) CMD (/etc/linetest/linetest.sh)
Mar 11 11:06:04 srv4hai named[15509]: resolver priming query complete
Mar 11 11:06:06 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=18763, secured, session=<0RCdsF8TbKYAAAAAAAAAAAAAAAAAAAAB>
Mar 11 11:06:06 srv4hai dovecot: imap(miglincit)<18763><0RCdsF8TbKYAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 11 11:06:16 srv4hai postfix/anvil[18717]: statistics: max connection rate 1/60s for (smtp:193.222.96.70) at Mar 11 11:02:55
Mar 11 11:06:16 srv4hai postfix/anvil[18717]: statistics: max connection count 1 for (smtp:193.222.96.70) at Mar 11 11:02:55
Mar 11 11:06:16 srv4hai postfix/anvil[18717]: statistics: max cache size 1 at Mar 11 11:02:55
Mar 11 11:06:19 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=18768, secured, session=
Mar 11 11:06:19 srv4hai dovecot: imap(miglincit)<18768>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 11 11:06:27 srv4hai named[15509]: resolver priming query complete
Mar 11 11:06:28 srv4hai named[15509]: resolver priming query complete
Mar 11 11:06:31 srv4hai named[15509]: resolver priming query complete
Mar 11 11:06:32 srv4hai named[15509]: resolver priming query complete
Mar 11 11:06:33 srv4hai named[15509]: resolver priming query complete
Mar 11 11:06:35 srv4hai dhcpd[5037]: DHCPDISCOVER from 98:cd:ac:2d:c5:cd via enp2s0
Mar 11 11:06:35 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.120 to 98:cd:ac:2d:c5:cd via enp2s0
Mar 11 11:06:35 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Mar 11 11:06:35 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.120
Mar 11 11:06:35 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-20
Mar 11 11:06:35 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.120 (192.168.12.252) from 98:cd:ac:2d:c5:cd via enp2s0
Mar 11 11:06:35 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.120 to 98:cd:ac:2d:c5:cd via enp2s0
Mar 11 11:06:35 srv4hai named[15509]: client @0x7f93100604b0 192.168.12.252#35725/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-20.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 11 11:06:35 srv4hai named[15509]: client @0x7f931c6410a0 192.168.12.252#39555/key rndc-key: signer "rndc-key" approved
Mar 11 11:06:35 srv4hai named[15509]: client @0x7f931c6410a0 192.168.12.252#39555/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-20.viehai.at' TXT
Mar 11 11:06:35 srv4hai named[15509]: client @0x7f931c6410a0 192.168.12.252#39555/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-20.viehai.at' TXT "009bbe3438977123c398f031397c5087ad"
Mar 11 11:06:35 srv4hai named[15509]: client @0x7f931c6410a0 192.168.12.252#39555/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-20.viehai.at' A
Mar 11 11:06:35 srv4hai named[15509]: client @0x7f931c6410a0 192.168.12.252#39555/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-20.viehai.at' A 192.168.12.120
Mar 11 11:06:35 srv4hai dhcpd[5037]: Added new forward map from shelly-20.viehai.at to 192.168.12.120
Mar 11 11:06:35 srv4hai named[15509]: client @0x7f931008c780 192.168.12.252#37789/key rndc-key: signer "rndc-key" approved
Mar 11 11:06:35 srv4hai named[15509]: client @0x7f931008c780 192.168.12.252#37789/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '120.12.168.192.in-addr.arpa' PTR
Mar 11 11:06:35 srv4hai named[15509]: client @0x7f931008c780 192.168.12.252#37789/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '120.12.168.192.in-addr.arpa' PTR shelly-20.viehai.at.
Mar 11 11:06:35 srv4hai dhcpd[5037]: Added reverse map from 120.12.168.192.in-addr.arpa. to shelly-20.viehai.at
Mar 11 11:06:35 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-20' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Mar 11 11:06:36 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-20' - shIP/2:'192.168.12.120'
Mar 11 11:06:36 srv4hai conf_shelly.sh: SHELLY: usage/name 'Thomas Schreibtischlampe' already set for '192.168.12.120'
Mar 11 11:06:36 srv4hai conf_shelly.sh: SHELLY:'shelly-20' 'conf(0)' - allready transmitted - skipping
Mar 11 11:06:36 srv4hai conf_shelly.sh: SHELLY:'shelly-20' 'conf(1)' - allready transmitted - skipping
Mar 11 11:06:36 srv4hai conf_shelly.sh: SHELLY:'shelly-20' 'conf(2)' - allready transmitted - skipping
Mar 11 11:06:36 srv4hai conf_shelly.sh: SHELLY:'shelly-20' 'conf(3)' - allready transmitted - skipping
Mar 11 11:06:36 srv4hai conf_shelly.sh: SHELLY:'shelly-20' out:0 ON : MISSING
Mar 11 11:06:36 srv4hai conf_shelly.sh: SHELLY:'shelly-20' out:0 OFF: MISSING
Mar 11 11:06:37 srv4hai named[15509]: resolver priming query complete
Mar 11 11:06:39 srv4hai named[15509]: resolver priming query complete
Mar 11 11:06:43 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Mar 11 11:06:43 srv4hai fetchmail[1651]: 39665 messages (39665 seen) for tmiglinci at mail.akis.at (-1018165509 octets).
Mar 11 11:06:44 srv4hai fetchmail[1651]: 9986 messages (9986 seen) for srozum at mail.akis.at (1210239044 octets).
Mar 11 11:06:45 srv4hai fetchmail[1651]: 22164 messages (22164 seen) for mrozum at mail.akis.at (-470356818 octets).
Mar 11 11:06:45 srv4hai named[15509]: resolver priming query complete
Mar 11 11:06:45 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Mar 11 11:06:53 srv4hai named[15509]: resolver priming query complete
Mar 11 11:07:01 srv4hai CRON[18881]: (root) CMD (/etc/linetest/linetest.sh)
Mar 11 11:07:05 srv4hai named[15509]: resolver priming query complete
Mar 11 11:07:15 srv4hai dovecot: imap(miglincit)<13008><4XZmFV8TKoHAqAwK>: Logged out in=3391 out=257090 deleted=0 expunged=0 trashed=0 hdr_count=9 hdr_bytes=4121 body_count=9 body_bytes=168901
Mar 11 11:07:15 srv4hai named[15509]: resolver priming query complete
Mar 11 11:07:16 srv4hai activate_scenario[18888]: SHELLY scenario: 'pcOFF(pcoff)' started
Mar 11 11:07:16 srv4hai activate_scenario[18888]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-0:''
Mar 11 11:07:16 srv4hai activate_scenario[18888]: SHELLY scenario: 'pcOFF(pcoff)' TO BE EXECUTED, shelly-0:''
Mar 11 11:07:16 srv4hai postfix/pickup[9610]: 115C7602B8: uid=33 from=
Mar 11 11:07:16 srv4hai postfix/cleanup[18941]: 115C7602B8: message-id=<20240311100716.115C7602B8@mail.viehai.at>
Mar 11 11:07:16 srv4hai postfix/qmgr[15291]: 115C7602B8: from=, size=7853, nrcpt=1 (queue active)
Mar 11 11:07:16 srv4hai activate_scenario[18888]: SHELLY: scenario: 'pcOFF(pcoff)'-'shelly-20'-'Thomas Schreibtischlampe' --> '0?turn=off'
Mar 11 11:07:16 srv4hai proc_url[18958]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/03/11/_0.log' - shellyUsage:'Thomas Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=off' - phName:'shelly-0:'''
Mar 11 11:07:16 srv4hai postfix/local[18954]: 115C7602B8: to=, orig_to=, relay=local, delay=0.04, delays=0.02/0/0/0.02, dsn=5.1.1, status=bounced (unknown user: "null")
Mar 11 11:07:16 srv4hai postfix/cleanup[18941]: 19837602B9: message-id=<20240311100716.19837602B9@mail.viehai.at>
Mar 11 11:07:16 srv4hai postfix/bounce[18959]: 115C7602B8: sender non-delivery notification: 19837602B9
Mar 11 11:07:16 srv4hai postfix/qmgr[15291]: 19837602B9: from=<>, size=9732, nrcpt=1 (queue active)
Mar 11 11:07:16 srv4hai postfix/qmgr[15291]: 115C7602B8: removed
Mar 11 11:07:16 srv4hai postfix/local[18954]: 19837602B9: to=, relay=local, delay=0.01, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 11 11:07:16 srv4hai postfix/qmgr[15291]: 19837602B9: removed
Mar 11 11:07:16 srv4hai activate_scenario[18888]: SHELLY scenario: 'pcOFF(pcoff)' took 52 msec, shelly-0:''
Mar 11 11:07:27 srv4hai named[15509]: resolver priming query complete
Mar 11 11:07:41 srv4hai common[18990]: SHELLY common.sh inkludiert
Mar 11 11:07:41 srv4hai bt_scan[18990]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / fixAddr: '192.168.12.61;' - found: 'Yes'
Mar 11 11:07:41 srv4hai bt_scan[18990]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Mar 11 11:07:57 srv4hai named[15509]: resolver priming query complete
Mar 11 11:08:01 srv4hai CRON[19024]: (root) CMD (/etc/linetest/linetest.sh)
Mar 11 11:08:27 srv4hai named[15509]: resolver priming query complete
Mar 11 11:08:50 srv4hai postfix/smtpd[19034]: connect from unknown[193.222.96.70]
Mar 11 11:08:50 srv4hai postfix/smtpd[19034]: warning: unknown[193.222.96.70]: SASL LOGIN authentication failed: Invalid authentication mechanism
Mar 11 11:08:50 srv4hai postfix/smtpd[19034]: disconnect from unknown[193.222.96.70] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4
Mar 11 11:08:51 srv4hai named[15509]: resolver priming query complete
Mar 11 11:08:56 srv4hai dhcpd[5037]: DHCPRELEASE of 192.168.12.3 from 70:a7:41:9a:7d:4e via enp2s0 (not found)
Mar 11 11:08:56 srv4hai dhcpd[5037]: DHCPDISCOVER from 70:a7:41:9a:7d:4e via enp2s0
Mar 11 11:08:56 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0
Mar 11 11:08:56 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 11 11:08:56 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.3
Mar 11 11:08:56 srv4hai dhcpd[5037]: execute_statement argv[2] = ap3hai
Mar 11 11:08:56 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.3 (192.168.12.252) from 70:a7:41:9a:7d:4e via enp2s0
Mar 11 11:08:56 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0
Mar 11 11:08:56 srv4hai named[15509]: client @0x7f931c6b5500 192.168.12.252#60213/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap3hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 11 11:08:56 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#51067/key rndc-key: signer "rndc-key" approved
Mar 11 11:08:56 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#51067/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' TXT
Mar 11 11:08:56 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#51067/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' TXT "31763f1a8a980dd918aaf8fff3416a5028"
Mar 11 11:08:56 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#51067/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' A
Mar 11 11:08:56 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#51067/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' A 192.168.12.3
Mar 11 11:08:56 srv4hai dhcpd[5037]: Added new forward map from ap3hai.viehai.at to 192.168.12.3
Mar 11 11:08:56 srv4hai named[15509]: client @0x7f93180a69a0 192.168.12.252#52513/key rndc-key: signer "rndc-key" approved
Mar 11 11:08:56 srv4hai named[15509]: client @0x7f93180a69a0 192.168.12.252#52513/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '3.12.168.192.in-addr.arpa' PTR
Mar 11 11:08:56 srv4hai named[15509]: client @0x7f93180a69a0 192.168.12.252#52513/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 11 11:08:56 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.3'(3) device 'ap3hai'
Mar 11 11:08:56 srv4hai dhcpd[5037]: Added reverse map from 3.12.168.192.in-addr.arpa. to ap3hai.viehai.at
Mar 11 11:08:56 srv4hai dhcpcommit.sh: SHELLY device 'ap3hai' known and accepted
Mar 11 11:08:57 srv4hai activate_scenario[19046]: SHELLY scenario: 'LOG_kommen(log_kommen)' started
Mar 11 11:08:57 srv4hai activate_scenario[19046]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-03:'Licht Vorzimmer'
finished