activate_scenario.sh
Sun Feb 11 16:08:06 CET 2024
scenario: SophieZimmerOFF
source: 192.168.12.109

'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'null'

scenario: 'Sophie Zimmer AUS-schalten' - 'SophieZimmerOFF' - 'sophiezimmeroff'

Sophie Licht (/srv/www/viehai/shelly/log_scenarios/2024/02/11/_0.log)

vorher: 16:08:06.863

http://192.168.12.109/relay/0?turn=off
  "ison": false,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "source": "http"

nachher: 16:08:06.926
Dauer: 63 msec phName: 'shelly-09:'Sophie Licht''


Stehlampe dimmbar (/srv/www/viehai/shelly/log_scenarios/2024/02/11/_1.log)

vorher: 16:08:06.878

http://192.168.12.142/light/0?turn=off&brightness=50
  "ison": false,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 50,
  "transition": 0

nachher: 16:08:06.920
Dauer: 42 msec phName: 'shelly-09:'Sophie Licht''


scenario: 'Sophie Zimmer AUS-schalten' - 'SophieZimmerOFF' - 'sophiezimmeroff'

urls : 2
vorher : 16:08:06.814
nachher: 16:08:06.934
Dauer : 121 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/02/11//scene_SophieZimmerOFF_20240211_160806.txt'


syslog

Feb 11 16:05:00 srv4hai named[14530]: resolver priming query complete
Feb 11 16:05:01 srv4hai CRON[13043]: (root) CMD (/etc/linetest/linetest.sh)
Feb 11 16:05:02 srv4hai activate_scenario[13051]: SHELLY scenario: 'pcOFF(pcoff)' started
Feb 11 16:05:02 srv4hai activate_scenario[13051]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-0:''
Feb 11 16:05:02 srv4hai activate_scenario[13051]: SHELLY scenario: 'pcOFF(pcoff)' TO BE EXECUTED, shelly-0:''
Feb 11 16:05:02 srv4hai postfix/pickup[26347]: D1ECC60244: uid=33 from=
Feb 11 16:05:02 srv4hai postfix/cleanup[12935]: D1ECC60244: message-id=<20240211150502.D1ECC60244@mail.viehai.at>
Feb 11 16:05:02 srv4hai postfix/qmgr[28610]: D1ECC60244: from=, size=26264, nrcpt=1 (queue active)
Feb 11 16:05:02 srv4hai postfix/local[12936]: D1ECC60244: to=, orig_to=, relay=local, delay=0.05, delays=0.01/0/0/0.04, dsn=5.1.1, status=bounced (unknown user: "null")
Feb 11 16:05:02 srv4hai postfix/cleanup[12935]: DD54F60245: message-id=<20240211150502.DD54F60245@mail.viehai.at>
Feb 11 16:05:02 srv4hai postfix/bounce[13119]: D1ECC60244: sender non-delivery notification: DD54F60245
Feb 11 16:05:02 srv4hai postfix/qmgr[28610]: DD54F60245: from=<>, size=28143, nrcpt=1 (queue active)
Feb 11 16:05:02 srv4hai postfix/qmgr[28610]: D1ECC60244: removed
Feb 11 16:05:02 srv4hai activate_scenario[13051]: SHELLY: scenario: 'pcOFF(pcoff)'-'shelly-20'-'Thomas Schreibtischlampe' --> '0?turn=off'
Feb 11 16:05:02 srv4hai postfix/local[12936]: DD54F60245: to=, relay=local, delay=0.03, delays=0.01/0/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb 11 16:05:02 srv4hai postfix/qmgr[28610]: DD54F60245: removed
Feb 11 16:05:02 srv4hai proc_url[13132]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/02/11/_0.log' - shellyUsage:'Thomas Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=off' - phName:'shelly-0:'''
Feb 11 16:05:02 srv4hai activate_scenario[13051]: SHELLY scenario: 'pcOFF(pcoff)' took 90 msec, shelly-0:''
Feb 11 16:05:04 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=13163, secured, session=
Feb 11 16:05:05 srv4hai dovecot: imap(miglincit)<13163>: Logged out in=756 out=48673 deleted=0 expunged=0 trashed=0 hdr_count=50 hdr_bytes=25212 body_count=0 body_bytes=0
Feb 11 16:05:16 srv4hai ping_SP[28456]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1707663916 - 'ping_SP_0'
Feb 11 16:05:16 srv4hai ping_SP[28456]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 11 16:05:40 srv4hai activate_scenario[13223]: SHELLY scenario: 'LOG_kommen(log_kommen)' started
Feb 11 16:05:40 srv4hai activate_scenario[13223]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-03:'Licht Vorzimmer'
Feb 11 16:05:40 srv4hai activate_scenario[13223]: SHELLY scenario: 'LOG_kommen(log_kommen)' TO BE EXECUTED, shelly-03:'Licht Vorzimmer'
Feb 11 16:05:40 srv4hai activate_scenario[13223]: SHELLY scenario: 'LOG_kommen(log_kommen)' took 5 msec, shelly-03:'Licht Vorzimmer'
Feb 11 16:05:45 srv4hai common[13297]: SHELLY common.sh inkludiert
Feb 11 16:05:45 srv4hai bt_scan[13297]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / fixAddr: '192.168.12.61;' - found: 'Yes'
Feb 11 16:05:45 srv4hai named[14530]: resolver priming query complete
Feb 11 16:05:46 srv4hai bt_scan[13297]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Feb 11 16:05:50 srv4hai named[14530]: resolver priming query complete
Feb 11 16:06:01 srv4hai CRON[13343]: (root) CMD (/etc/linetest/linetest.sh)
Feb 11 16:06:10 srv4hai named[14530]: resolver priming query complete
Feb 11 16:06:10 srv4hai named[14530]: resolver priming query complete
Feb 11 16:06:11 srv4hai named[14530]: resolver priming query complete
Feb 11 16:06:19 srv4hai ping_SP[28456]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1707663979 - 'ping_SP_0'
Feb 11 16:06:19 srv4hai ping_SP[28456]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 11 16:06:31 srv4hai named[14530]: resolver priming query complete
Feb 11 16:06:37 srv4hai dhcpd[5037]: DHCPRELEASE of 192.168.12.3 from 70:a7:41:9a:7d:4e via enp2s0 (not found)
Feb 11 16:06:37 srv4hai dhcpd[5037]: DHCPDISCOVER from 70:a7:41:9a:7d:4e via enp2s0
Feb 11 16:06:37 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0
Feb 11 16:06:37 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Feb 11 16:06:37 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.3
Feb 11 16:06:37 srv4hai dhcpd[5037]: execute_statement argv[2] = ap3hai
Feb 11 16:06:37 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.3 (192.168.12.252) from 70:a7:41:9a:7d:4e via enp2s0
Feb 11 16:06:37 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0
Feb 11 16:06:37 srv4hai named[14530]: client @0x7fc31405bd50 192.168.12.252#60133/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap3hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 11 16:06:37 srv4hai named[14530]: client @0x7fc3080643f0 192.168.12.252#48487/key rndc-key: signer "rndc-key" approved
Feb 11 16:06:37 srv4hai named[14530]: client @0x7fc3080643f0 192.168.12.252#48487/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' TXT
Feb 11 16:06:37 srv4hai named[14530]: client @0x7fc3080643f0 192.168.12.252#48487/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' TXT "31763f1a8a980dd918aaf8fff3416a5028"
Feb 11 16:06:37 srv4hai named[14530]: client @0x7fc3080643f0 192.168.12.252#48487/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' A
Feb 11 16:06:37 srv4hai named[14530]: client @0x7fc3080643f0 192.168.12.252#48487/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' A 192.168.12.3
Feb 11 16:06:37 srv4hai dhcpd[5037]: Added new forward map from ap3hai.viehai.at to 192.168.12.3
Feb 11 16:06:37 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.3'(3) device 'ap3hai'
Feb 11 16:06:37 srv4hai named[14530]: client @0x7fc30807f600 192.168.12.252#54759/key rndc-key: signer "rndc-key" approved
Feb 11 16:06:37 srv4hai named[14530]: client @0x7fc30807f600 192.168.12.252#54759/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '3.12.168.192.in-addr.arpa' PTR
Feb 11 16:06:37 srv4hai named[14530]: client @0x7fc30807f600 192.168.12.252#54759/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.
Feb 11 16:06:37 srv4hai dhcpd[5037]: Added reverse map from 3.12.168.192.in-addr.arpa. to ap3hai.viehai.at
Feb 11 16:06:37 srv4hai dhcpcommit.sh: SHELLY device 'ap3hai' known and accepted
Feb 11 16:06:38 srv4hai dhcpd[5037]: DHCPRELEASE of 192.168.12.2 from 24:5a:4c:1c:1e:f4 via enp2s0 (not found)
Feb 11 16:06:38 srv4hai dhcpd[5037]: DHCPDISCOVER from 24:5a:4c:1c:1e:f4 via enp2s0
Feb 11 16:06:38 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0
Feb 11 16:06:38 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Feb 11 16:06:38 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.2
Feb 11 16:06:38 srv4hai dhcpd[5037]: execute_statement argv[2] = ap2hai
Feb 11 16:06:38 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.2 (192.168.12.252) from 24:5a:4c:1c:1e:f4 via enp2s0
Feb 11 16:06:38 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0
Feb 11 16:06:38 srv4hai named[14530]: client @0x7fc324060480 192.168.12.252#60207/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap2hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 11 16:06:38 srv4hai named[14530]: client @0x7fc3080657b0 192.168.12.252#38263/key rndc-key: signer "rndc-key" approved
Feb 11 16:06:38 srv4hai named[14530]: client @0x7fc3080657b0 192.168.12.252#38263/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' TXT
Feb 11 16:06:38 srv4hai named[14530]: client @0x7fc3080657b0 192.168.12.252#38263/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' TXT "31a0d441667de220424b7789941807db7d"
Feb 11 16:06:38 srv4hai named[14530]: client @0x7fc3080657b0 192.168.12.252#38263/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' A
Feb 11 16:06:38 srv4hai named[14530]: client @0x7fc3080657b0 192.168.12.252#38263/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' A 192.168.12.2
Feb 11 16:06:38 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.2'(2) device 'ap2hai'
Feb 11 16:06:38 srv4hai dhcpd[5037]: Added new forward map from ap2hai.viehai.at to 192.168.12.2
Feb 11 16:06:38 srv4hai named[14530]: client @0x7fc32813a950 192.168.12.252#57901/key rndc-key: signer "rndc-key" approved
Feb 11 16:06:38 srv4hai named[14530]: client @0x7fc32813a950 192.168.12.252#57901/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '2.12.168.192.in-addr.arpa' PTR
Feb 11 16:06:38 srv4hai named[14530]: client @0x7fc32813a950 192.168.12.252#57901/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.
Feb 11 16:06:38 srv4hai dhcpd[5037]: Added reverse map from 2.12.168.192.in-addr.arpa. to ap2hai.viehai.at
Feb 11 16:06:38 srv4hai dhcpcommit.sh: SHELLY device 'ap2hai' known and accepted
Feb 11 16:06:42 srv4hai named[14530]: resolver priming query complete
Feb 11 16:06:45 srv4hai named[14530]: resolver priming query complete
Feb 11 16:06:45 srv4hai postfix/anvil[8599]: statistics: max connection rate 1/60s for (smtp:193.222.96.116) at Feb 11 16:02:09
Feb 11 16:06:45 srv4hai postfix/anvil[8599]: statistics: max connection count 1 for (smtp:193.222.96.116) at Feb 11 16:02:09
Feb 11 16:06:45 srv4hai postfix/anvil[8599]: statistics: max cache size 2 at Feb 11 16:02:10
Feb 11 16:06:50 srv4hai named[14530]: resolver priming query complete
Feb 11 16:07:01 srv4hai CRON[13432]: (root) CMD (/etc/linetest/linetest.sh)
Feb 11 16:07:05 srv4hai named[14530]: resolver priming query complete
Feb 11 16:07:22 srv4hai ping_SP[28456]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1707664042 - 'ping_SP_0'
Feb 11 16:07:22 srv4hai ping_SP[28456]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 11 16:07:49 srv4hai named[14530]: resolver priming query complete
Feb 11 16:07:50 srv4hai named[14530]: resolver priming query complete
Feb 11 16:08:01 srv4hai CRON[13530]: (root) CMD (/etc/linetest/linetest.sh)
Feb 11 16:08:04 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=13538, secured, session=
Feb 11 16:08:05 srv4hai dovecot: imap(miglincit)<13538>: Logged out in=534 out=1224 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 11 16:08:06 srv4hai activate_scenario[13542]: SHELLY scenario: 'SophieZimmerOFF(sophiezimmeroff)' started
Feb 11 16:08:06 srv4hai activate_scenario[13542]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-09:'Sophie Licht'

finished