activate_scenario.sh
Mon Mar 11 11:10:07 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 : 11:10:07.280
nachher: 11:10:07.286
Dauer : 7 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/11//scene_LOG_gehen_20240311_111007.txt'
syslog
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'
Mar 11 11:08:57 srv4hai activate_scenario[19046]: SHELLY scenario: 'LOG_kommen(log_kommen)' TO BE EXECUTED, shelly-03:'Licht Vorzimmer'
Mar 11 11:08:57 srv4hai activate_scenario[19046]: SHELLY scenario: 'LOG_kommen(log_kommen)' took 4 msec, shelly-03:'Licht Vorzimmer'
Mar 11 11:09:01 srv4hai CRON[19114]: (root) CMD (/etc/linetest/linetest.sh)
Mar 11 11:09:01 srv4hai CRON[19115]: (root) CMD ( [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi)
Mar 11 11:09:01 srv4hai systemd[1]: Starting Clean php session files...
Mar 11 11:09:01 srv4hai systemd[1]: phpsessionclean.service: Succeeded.
Mar 11 11:09:01 srv4hai systemd[1]: Started Clean php session files.
Mar 11 11:09:18 srv4hai named[15509]: resolver priming query complete
Mar 11 11:09:19 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=19216, secured, session=<064dvF8TLqcAAAAAAAAAAAAAAAAAAAAB>
Mar 11 11:09:19 srv4hai dovecot: imap(miglincit)<19216><064dvF8TLqcAAAAAAAAAAAAAAAAAAAAB>: 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:09:20 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 11 11:09:20 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.28
Mar 11 11:09:20 srv4hai dhcpd[5037]: execute_statement argv[2] = harmonyhub
Mar 11 11:09:20 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.28 from c8:db:26:0c:f3:8e via enp2s0
Mar 11 11:09:20 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.28 to c8:db:26:0c:f3:8e via enp2s0
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c12c1c0 192.168.12.252#41313/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: harmonyhub.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c10f2a0 192.168.12.252#51615/key rndc-key: signer "rndc-key" approved
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c10f2a0 192.168.12.252#51615/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' TXT
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c10f2a0 192.168.12.252#51615/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' TXT "3122b5a8b4281156e6f217b32b7e260713"
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c10f2a0 192.168.12.252#51615/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'harmonyhub.viehai.at' A
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c10f2a0 192.168.12.252#51615/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'harmonyhub.viehai.at' A 192.168.12.28
Mar 11 11:09:20 srv4hai dhcpd[5037]: Added new forward map from harmonyhub.viehai.at to 192.168.12.28
Mar 11 11:09:20 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.28'(28) device 'harmonyhub'
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f930c0a53a0 192.168.12.252#36917/key rndc-key: signer "rndc-key" approved
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f930c0a53a0 192.168.12.252#36917/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '28.12.168.192.in-addr.arpa' PTR
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f930c0a53a0 192.168.12.252#36917/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 11 11:09:20 srv4hai dhcpd[5037]: Added reverse map from 28.12.168.192.in-addr.arpa. to harmonyhub.viehai.at
Mar 11 11:09:20 srv4hai dhcpcommit.sh: SHELLY device 'harmonyhub' known and accepted
Mar 11 11:09:20 srv4hai dhcpd[5037]: DHCPRELEASE of 192.168.12.2 from 24:5a:4c:1c:1e:f4 via enp2s0 (not found)
Mar 11 11:09:20 srv4hai dhcpd[5037]: DHCPDISCOVER from 24:5a:4c:1c:1e:f4 via enp2s0
Mar 11 11:09:20 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0
Mar 11 11:09:20 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 11 11:09:20 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.2
Mar 11 11:09:20 srv4hai dhcpd[5037]: execute_statement argv[2] = ap2hai
Mar 11 11:09:20 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.2 (192.168.12.252) from 24:5a:4c:1c:1e:f4 via enp2s0
Mar 11 11:09:20 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931007d0f0 192.168.12.252#60055/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap2hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#44089/key rndc-key: signer "rndc-key" approved
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#44089/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' TXT
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#44089/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' TXT "31a0d441667de220424b7789941807db7d"
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#44089/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' A
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#44089/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' A 192.168.12.2
Mar 11 11:09:20 srv4hai dhcpd[5037]: Added new forward map from ap2hai.viehai.at to 192.168.12.2
Mar 11 11:09:20 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.2'(2) device 'ap2hai'
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c166000 192.168.12.252#57345/key rndc-key: signer "rndc-key" approved
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c166000 192.168.12.252#57345/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '2.12.168.192.in-addr.arpa' PTR
Mar 11 11:09:20 srv4hai named[15509]: client @0x7f931c166000 192.168.12.252#57345/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 11 11:09:20 srv4hai dhcpd[5037]: Added reverse map from 2.12.168.192.in-addr.arpa. to ap2hai.viehai.at
Mar 11 11:09:20 srv4hai dhcpcommit.sh: SHELLY device 'ap2hai' known and accepted
Mar 11 11:09:27 srv4hai named[15509]: resolver priming query complete
Mar 11 11:09:46 srv4hai named[15509]: resolver priming query complete
Mar 11 11:10:01 srv4hai CRON[19237]: (root) CMD (/etc/linetest/linetest.sh)
Mar 11 11:10:01 srv4hai CRON[19238]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Mar 11 11:10:01 srv4hai meter.sh: SHELLY meter.sh started
Mar 11 11:10:04 srv4hai named[15509]: resolver priming query complete
Mar 11 11:10:07 srv4hai activate_scenario[19567]: SHELLY scenario: 'LOG_gehen(log_gehen)' started
Mar 11 11:10:07 srv4hai activate_scenario[19567]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-03:'Licht Vorzimmer'
finished