activate_scenario.sh
Sun Apr 21 16:06:23 CEST 2024
scenario: vorraumOn
phoneName: 0

'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'thomas@miglinci.name'

scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

Licht Vorzimmer (/srv/www/viehai/shelly/log_scenarios/2024/04/21/_0.log)

vorher: 16:06:23.532

http://192.168.12.103/relay/0?turn=on
  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "overpower": false,
  "source": "http"

nachher: 16:06:23.600
Dauer: 67 msec phName: 'phoneName:'0''


scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

urls : 1
vorher : 16:06:23.492
nachher: 16:06:23.606
Dauer : 115 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/04/21//scene_vorraumOn_20240421_160623.txt'


syslog

Apr 21 16:03:01 srv4hai CRON[17442]: (root) CMD (/etc/linetest/linetest.sh)
Apr 21 16:03:07 srv4hai ping_SP[8936]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1713708187 - 'ping_SP_0'
Apr 21 16:03:07 srv4hai ping_SP[8936]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 21 16:03:11 srv4hai ping_SP[15365]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1713708191 - 'ping_SP_1'
Apr 21 16:03:11 srv4hai ping_SP[15365]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 21 16:03:37 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=17483, secured, session=
Apr 21 16:03:37 srv4hai dovecot: imap(miglincit)<17483>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 21 16:03:47 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Apr 21 16:03:48 srv4hai fetchmail[1651]: 42619 messages (42619 seen) for tmiglinci at mail.akis.at (-746412280 octets).
Apr 21 16:03:48 srv4hai fetchmail[1651]: 10158 messages (10158 seen) for srozum at mail.akis.at (1226622622 octets).
Apr 21 16:03:48 srv4hai fetchmail[1651]: 23006 messages (23006 seen) for mrozum at mail.akis.at (-309385396 octets).
Apr 21 16:03:49 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Apr 21 16:04:01 srv4hai CRON[17494]: (root) CMD (/etc/linetest/linetest.sh)
Apr 21 16:04:21 srv4hai ping_SP[8936]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1713708261 - 'ping_SP_0'
Apr 21 16:04:21 srv4hai ping_SP[8936]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 21 16:04:25 srv4hai ping_SP[15365]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1713708265 - 'ping_SP_1'
Apr 21 16:04:25 srv4hai ping_SP[15365]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 21 16:04:31 srv4hai postfix/anvil[17373]: statistics: max connection rate 1/60s for (smtp:193.222.96.12) at Apr 21 16:01:11
Apr 21 16:04:31 srv4hai postfix/anvil[17373]: statistics: max connection count 1 for (smtp:193.222.96.12) at Apr 21 16:01:11
Apr 21 16:04:31 srv4hai postfix/anvil[17373]: statistics: max cache size 1 at Apr 21 16:01:11
Apr 21 16:04:40 srv4hai dhcpd[22856]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Apr 21 16:04:40 srv4hai dhcpd[22856]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Apr 21 16:04:42 srv4hai dhcpd[22856]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
Apr 21 16:04:42 srv4hai dhcpd[22856]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Apr 21 16:04:42 srv4hai dhcpd[22856]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Apr 21 16:04:42 srv4hai dhcpd[22856]: execute_statement argv[1] = 192.168.12.5
Apr 21 16:04:42 srv4hai dhcpd[22856]: execute_statement argv[2] = btscan1
Apr 21 16:04:42 srv4hai dhcpd[22856]: DHCPREQUEST for 192.168.12.5 (192.168.12.252) from 08:3a:8d:d0:46:5a via enp2s0
Apr 21 16:04:42 srv4hai dhcpd[22856]: DHCPACK on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
Apr 21 16:04:42 srv4hai named[15509]: client @0x7f931c12c1c0 192.168.12.252#52409/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: btscan1.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 21 16:04:42 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#43903/key rndc-key: signer "rndc-key" approved
Apr 21 16:04:42 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#43903/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' TXT
Apr 21 16:04:42 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#43903/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' TXT "000118916176265854cff71f762ffe0635"
Apr 21 16:04:42 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#43903/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' A
Apr 21 16:04:42 srv4hai named[15509]: client @0x7f930c088170 192.168.12.252#43903/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' A 192.168.12.5
Apr 21 16:04:42 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.5'(5) device 'btscan1'
Apr 21 16:04:42 srv4hai dhcpd[22856]: Added new forward map from btscan1.viehai.at to 192.168.12.5
Apr 21 16:04:42 srv4hai named[15509]: client @0x7f930807c330 192.168.12.252#46001/key rndc-key: signer "rndc-key" approved
Apr 21 16:04:42 srv4hai named[15509]: client @0x7f930807c330 192.168.12.252#46001/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '5.12.168.192.in-addr.arpa' PTR
Apr 21 16:04:42 srv4hai named[15509]: client @0x7f930807c330 192.168.12.252#46001/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '5.12.168.192.in-addr.arpa' PTR btscan1.viehai.at.
Apr 21 16:04:42 srv4hai dhcpd[22856]: Added reverse map from 5.12.168.192.in-addr.arpa. to btscan1.viehai.at
Apr 21 16:04:42 srv4hai dhcpcommit.sh: SHELLY device 'btscan1' known and accepted
Apr 21 16:05:01 srv4hai CRON[17556]: (root) CMD (/etc/linetest/linetest.sh)
Apr 21 16:05:34 srv4hai ping_SP[8936]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1713708334 - 'ping_SP_0'
Apr 21 16:05:34 srv4hai ping_SP[8936]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 21 16:05:38 srv4hai ping_SP[15365]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1713708338 - 'ping_SP_1'
Apr 21 16:05:38 srv4hai ping_SP[15365]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 21 16:05:52 srv4hai dhcpd[22856]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Apr 21 16:05:52 srv4hai dhcpd[22856]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr 21 16:05:52 srv4hai dhcpd[22856]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Apr 21 16:05:52 srv4hai dhcpd[22856]: execute_statement argv[1] = 192.168.12.61
Apr 21 16:05:52 srv4hai dhcpd[22856]: execute_statement argv[2] = fpThomas
Apr 21 16:05:52 srv4hai common[17637]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Apr 21 16:06:01 srv4hai CRON[17657]: (root) CMD (/etc/linetest/linetest.sh)
Apr 21 16:06:02 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Apr 21 16:06:02 srv4hai common[17667]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Apr 21 16:06:02 srv4hai dhcpd[22856]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Apr 21 16:06:02 srv4hai dhcpd[22856]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr 21 16:06:02 srv4hai dhcpd[22856]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Apr 21 16:06:02 srv4hai dhcpd[22856]: execute_statement argv[1] = 192.168.12.61
Apr 21 16:06:02 srv4hai dhcpd[22856]: execute_statement argv[2] = fpThomas
Apr 21 16:06:02 srv4hai common[17681]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Apr 21 16:06:02 srv4hai ping_SP[17667]: SHELLY ping_SP.sh started from smartphone, user:'root'
Apr 21 16:06:12 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Apr 21 16:06:12 srv4hai common[17714]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Apr 21 16:06:12 srv4hai common[17723]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Apr 21 16:06:12 srv4hai dhcpd[22856]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Apr 21 16:06:12 srv4hai dhcpd[22856]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr 21 16:06:12 srv4hai dhcpd[22856]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Apr 21 16:06:12 srv4hai dhcpd[22856]: execute_statement argv[1] = 192.168.12.61
Apr 21 16:06:12 srv4hai dhcpd[22856]: execute_statement argv[2] = fpThomas
Apr 21 16:06:12 srv4hai named[15509]: client @0x7f93080202a0 192.168.12.252#37265/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 21 16:06:12 srv4hai common[17736]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Apr 21 16:06:12 srv4hai ping_SP[17714]: SHELLY ping_SP.sh started from smartphone, user:'root'
Apr 21 16:06:13 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'11'=1713708373-1713708362
Apr 21 16:06:13 srv4hai check_presence[17723]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Apr 21 16:06:13 srv4hai check_presence[17723]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Apr 21 16:06:13 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'11'=1713708373-1713708362
Apr 21 16:06:13 srv4hai check_presence[17723]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Apr 21 16:06:13 srv4hai check_presence[17723]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Apr 21 16:06:13 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'11'=1713708373-1713708362
Apr 21 16:06:13 srv4hai check_presence[17723]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Apr 21 16:06:13 srv4hai check_presence[17723]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Apr 21 16:06:13 srv4hai check_presence[17723]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Apr 21 16:06:13 srv4hai activate_scenario[17874]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Apr 21 16:06:13 srv4hai activate_scenario[17874]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
Apr 21 16:06:13 srv4hai activate_scenario[17874]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
Apr 21 16:06:13 srv4hai postfix/pickup[2734]: 914646022F: uid=33 from=
Apr 21 16:06:13 srv4hai postfix/cleanup[17924]: 914646022F: message-id=<20240421140613.914646022F@mail.viehai.at>
Apr 21 16:06:13 srv4hai postfix/qmgr[15291]: 914646022F: from=, size=10658, nrcpt=1 (queue active)
Apr 21 16:06:13 srv4hai activate_scenario[17874]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Apr 21 16:06:13 srv4hai proc_url[17941]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/04/21/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
Apr 21 16:06:13 srv4hai activate_scenario[17874]: SHELLY scenario: 'vorraumOn(vorraumon)' took 72 msec, phoneName:'0'
Apr 21 16:06:13 srv4hai ping_SP[17667]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
Apr 21 16:06:14 srv4hai postfix/relay/smtp[17937]: 914646022F: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=1, delays=0.02/0.01/0.72/0.26, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 5F2B38010F)
Apr 21 16:06:14 srv4hai postfix/qmgr[15291]: 914646022F: removed
Apr 21 16:06:15 srv4hai ping_SP[17667]: SHELLY - running process-id(17667): '8936 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01217667 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01217714 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone#01217736 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.61 fpThomas' - 'ping_SP_0' - exiting ==============
Apr 21 16:06:22 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Apr 21 16:06:22 srv4hai common[17988]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Apr 21 16:06:22 srv4hai dhcpd[22856]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Apr 21 16:06:22 srv4hai dhcpd[22856]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Apr 21 16:06:22 srv4hai dhcpd[22856]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Apr 21 16:06:22 srv4hai dhcpd[22856]: execute_statement argv[1] = 192.168.12.61
Apr 21 16:06:22 srv4hai dhcpd[22856]: execute_statement argv[2] = fpThomas
Apr 21 16:06:22 srv4hai named[15509]: client @0x7f931c13a950 192.168.12.252#58757/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 21 16:06:22 srv4hai named[15509]: client @0x7f93080202a0 192.168.12.252#37265/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 21 16:06:22 srv4hai common[18006]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Apr 21 16:06:22 srv4hai common[18009]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Apr 21 16:06:22 srv4hai ping_SP[17988]: SHELLY ping_SP.sh started from smartphone, user:'root'
Apr 21 16:06:23 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'3'=1713708383-1713708380
Apr 21 16:06:23 srv4hai check_presence[18006]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Apr 21 16:06:23 srv4hai check_presence[18006]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Apr 21 16:06:23 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'3'=1713708383-1713708380
Apr 21 16:06:23 srv4hai check_presence[18006]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Apr 21 16:06:23 srv4hai check_presence[18006]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Apr 21 16:06:23 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'3'=1713708383-1713708380
Apr 21 16:06:23 srv4hai check_presence[18006]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Apr 21 16:06:23 srv4hai check_presence[18006]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Apr 21 16:06:23 srv4hai check_presence[18006]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Apr 21 16:06:23 srv4hai activate_scenario[18152]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Apr 21 16:06:23 srv4hai activate_scenario[18152]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'

finished