activate_scenario.sh
Wed Feb 21 17:03:04 CET 2024
scenario: pcON
origin: dhcpcommit.sh-pchai7x

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

scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'

Thomas Schreibtischlampe (/srv/www/viehai/shelly/log_scenarios/2024/02/21/_0.log)

vorher: 17:03:04.779

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

nachher: 17:03:04.809
Dauer: 30 msec phName: 'origin:'dhcpcommit.sh-pchai7x''


scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'

urls : 1
vorher : 17:03:04.752
nachher: 17:03:04.815
Dauer : 64 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/02/21//scene_pcON_20240221_170304.txt'


syslog

Feb 21 17:00:01 srv4hai CRON[10989]: (root) CMD (/etc/linetest/linetest.sh)
Feb 21 17:00:01 srv4hai CRON[10990]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Feb 21 17:00:01 srv4hai meter.sh: SHELLY meter.sh started
Feb 21 17:00:04 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=45&temp=22.75&id=shellyht-00B358
Feb 21 17:00:04 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240221.csv'
Feb 21 17:00:04 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240221.csv' modifed 10s ago - EXIT
Feb 21 17:00:09 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=45&temp=22.75&id=shellyht-00B358
Feb 21 17:00:09 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240221.csv'
Feb 21 17:00:09 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240221.csv' modifed 15s ago - EXIT
Feb 21 17:00:10 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:12 srv4hai named[14530]: resolver priming query complete
Feb 21 17:00:13 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:14 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=45&temp=22.75&id=shellyht-00B358
Feb 21 17:00:14 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240221.csv'
Feb 21 17:00:14 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240221.csv' modifed 20s ago - EXIT
Feb 21 17:00:15 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:18 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:19 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: hum=45&temp=22.75&id=shellyht-00B358
Feb 21 17:00:19 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240221.csv'
Feb 21 17:00:19 srv4hai ht_shelly.sh: SHELLY - '/srv/www/viehai/shelly/wetter/2024/02/shelly-37_20240221.csv' modifed 25s ago - EXIT
Feb 21 17:00:21 srv4hai meter.sh: SHELLY 'shelly-58/Werkstatt Licht':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:22 srv4hai activate_scenario[11474]: SHELLY scenario: 'buero_UM(buero_um)' started
Feb 21 17:00:22 srv4hai activate_scenario[11474]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'
Feb 21 17:00:22 srv4hai activate_scenario[11474]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'Thomas Büro Licht'
Feb 21 17:00:22 srv4hai postfix/pickup[2544]: 519BE60244: uid=33 from=
Feb 21 17:00:22 srv4hai postfix/cleanup[10441]: 519BE60244: message-id=<20240221160022.519BE60244@mail.viehai.at>
Feb 21 17:00:22 srv4hai postfix/qmgr[28610]: 519BE60244: from=, size=26861, nrcpt=1 (queue active)
Feb 21 17:00:22 srv4hai postfix/local[11530]: 519BE60244: to=, orig_to=, relay=local, delay=0.06, delays=0.02/0.01/0/0.03, dsn=5.1.1, status=bounced (unknown user: "null")
Feb 21 17:00:22 srv4hai postfix/cleanup[10441]: 5DBD660245: message-id=<20240221160022.5DBD660245@mail.viehai.at>
Feb 21 17:00:22 srv4hai postfix/bounce[11536]: 519BE60244: sender non-delivery notification: 5DBD660245
Feb 21 17:00:22 srv4hai postfix/qmgr[28610]: 5DBD660245: from=<>, size=28780, nrcpt=1 (queue active)
Feb 21 17:00:22 srv4hai postfix/qmgr[28610]: 519BE60244: removed
Feb 21 17:00:22 srv4hai activate_scenario[11474]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Feb 21 17:00:22 srv4hai proc_url[11544]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/02/21/_0.log' - shellyUsage:'Thomas Büro Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Feb 21 17:00:22 srv4hai activate_scenario[11474]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Feb 21 17:00:22 srv4hai postfix/local[11530]: 5DBD660245: to=, relay=local, delay=0.02, delays=0.01/0/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb 21 17:00:22 srv4hai postfix/qmgr[28610]: 5DBD660245: removed
Feb 21 17:00:22 srv4hai proc_url[11555]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/02/21/_1.log' - shellyUsage:'Thomas Büro Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Feb 21 17:00:22 srv4hai activate_scenario[11474]: SHELLY scenario: 'buero_UM(buero_um)' took 190 msec, shelly-40:'Thomas Büro Licht'
Feb 21 17:00:23 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:26 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:28 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:31 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:34 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:36 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:39 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:41 srv4hai meter.sh: SHELLY 'shelly-47/47-plus1-Test':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:41 srv4hai dhcpd[5037]: DHCPREQUEST for 10.246.136.39 from 08:92:04:5f:12:67 via enp2s0: wrong network.
Feb 21 17:00:41 srv4hai dhcpd[5037]: DHCPNAK on 10.246.136.39 to 08:92:04:5f:12:67 via enp2s0
Feb 21 17:00:41 srv4hai dhcpd[5037]: DHCPDISCOVER from 08:92:04:5f:12:67 via enp2s0
Feb 21 17:00:41 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.20 to 08:92:04:5f:12:67 via enp2s0
Feb 21 17:00:41 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Feb 21 17:00:41 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.20
Feb 21 17:00:41 srv4hai dhcpd[5037]: execute_statement argv[2] = w-9626
Feb 21 17:00:41 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.20 (192.168.12.252) from 08:92:04:5f:12:67 via enp2s0
Feb 21 17:00:41 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.20 to 08:92:04:5f:12:67 via enp2s0
Feb 21 17:00:41 srv4hai named[14530]: client @0x7fc3286f6f20 192.168.12.252#47441/key rndc-key: signer "rndc-key" approved
Feb 21 17:00:41 srv4hai named[14530]: client @0x7fc3286f6f20 192.168.12.252#47441/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '20.12.168.192.in-addr.arpa' PTR
Feb 21 17:00:41 srv4hai named[14530]: client @0x7fc3286f6f20 192.168.12.252#47441/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '20.12.168.192.in-addr.arpa' PTR W-9626.ds1.internal.
Feb 21 17:00:41 srv4hai dhcpd[5037]: Added reverse map from 20.12.168.192.in-addr.arpa. to W-9626.ds1.internal
Feb 21 17:00:41 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.20'(20) device 'w-9626'
Feb 21 17:00:41 srv4hai dhcpcommit.sh: SHELLY device 'w-9626' known and accepted
Feb 21 17:00:42 srv4hai named[14530]: resolver priming query complete
Feb 21 17:00:43 srv4hai named[14530]: resolver priming query complete
Feb 21 17:00:44 srv4hai named[14530]: resolver priming query complete
Feb 21 17:00:44 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:46 srv4hai named[14530]: resolver priming query complete
Feb 21 17:00:47 srv4hai named[14530]: resolver priming query complete
Feb 21 17:00:47 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:47 srv4hai ping_SP[10330]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1708531247 - 'ping_SP_0'
Feb 21 17:00:47 srv4hai ping_SP[10330]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 21 17:00:48 srv4hai named[14530]: resolver priming query complete
Feb 21 17:00:49 srv4hai named[14530]: resolver priming query complete
Feb 21 17:00:49 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:50 srv4hai named[14530]: resolver priming query complete
Feb 21 17:00:51 srv4hai named[14530]: resolver priming query complete
Feb 21 17:00:52 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:53 srv4hai named[14530]: resolver priming query complete
Feb 21 17:00:55 srv4hai meter.sh: SHELLY 'shelly-43/43-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:57 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:00:59 srv4hai named[14530]: resolver priming query complete
Feb 21 17:01:00 srv4hai meter.sh: SHELLY 'shelly-45/45-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Feb 21 17:01:00 srv4hai meter.sh: SHELLY meter.sh ended
Feb 21 17:01:00 srv4hai postfix/pickup[2544]: 253DE60244: uid=33 from=
Feb 21 17:01:00 srv4hai postfix/cleanup[10441]: 253DE60244: message-id=<20240221160100.253DE60244@mail.viehai.at>
Feb 21 17:01:00 srv4hai CRON[11748]: (root) CMD (/etc/linetest/linetest.sh)
Feb 21 17:01:00 srv4hai postfix/qmgr[28610]: 253DE60244: from=, size=654, nrcpt=1 (queue active)
Feb 21 17:01:00 srv4hai postfix/local[11530]: 253DE60244: to=, orig_to=, relay=local, delay=0.03, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb 21 17:01:00 srv4hai postfix/qmgr[28610]: 253DE60244: removed
Feb 21 17:01:08 srv4hai named[14530]: resolver priming query complete
Feb 21 17:01:08 srv4hai dhcpd[5037]: DHCPINFORM from 192.168.12.20 via enp2s0
Feb 21 17:01:08 srv4hai dhcpd[5037]: DHCPACK to 192.168.12.20 (08:92:04:5f:12:67) via enp2s0
Feb 21 17:01:14 srv4hai named[14530]: resolver priming query complete
Feb 21 17:01:29 srv4hai named[14530]: resolver priming query complete
Feb 21 17:01:47 srv4hai named[14530]: resolver priming query complete
Feb 21 17:02:01 srv4hai ping_SP[10330]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1708531321 - 'ping_SP_0'
Feb 21 17:02:01 srv4hai ping_SP[10330]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 21 17:02:01 srv4hai CRON[11779]: (root) CMD (/etc/linetest/linetest.sh)
Feb 21 17:02:13 srv4hai common[11791]: SHELLY common.sh inkludiert
Feb 21 17:02:21 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Feb 21 17:02:21 srv4hai fetchmail[1651]: 38540 messages (38538 seen) for tmiglinci at mail.akis.at (-1120337324 octets).
Feb 21 17:02:22 srv4hai postfix/smtpd[11807]: connect from localhost[127.0.0.1]
Feb 21 17:02:22 srv4hai postfix/smtpd[11807]: 0718F60119: client=localhost[127.0.0.1]
Feb 21 17:02:22 srv4hai postfix/cleanup[10441]: 0718F60119: message-id=<20240221155855.2BD5760244@mail.viehai.at>
Feb 21 17:02:22 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:38539 of 38540 (5395 octets) not flushed
Feb 21 17:02:22 srv4hai postfix/qmgr[28610]: 0718F60119: from=, size=5685, nrcpt=1 (queue active)
Feb 21 17:02:22 srv4hai postfix/local[11530]: 0718F60119: to=, relay=local, delay=0.07, delays=0.05/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb 21 17:02:22 srv4hai postfix/qmgr[28610]: 0718F60119: removed
Feb 21 17:02:22 srv4hai postfix/smtpd[11807]: 1D42B60119: client=localhost[127.0.0.1]
Feb 21 17:02:22 srv4hai postfix/cleanup[10441]: 1D42B60119: message-id=
Feb 21 17:02:22 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:38540 of 38540 (24594 octets) not flushed
Feb 21 17:02:22 srv4hai postfix/qmgr[28610]: 1D42B60119: from=, size=24814, nrcpt=1 (queue active)
Feb 21 17:02:22 srv4hai postfix/smtpd[11807]: disconnect from localhost[127.0.0.1] ehlo=1 mail=2 rcpt=2 data=2 quit=1 commands=8
Feb 21 17:02:22 srv4hai postfix/local[11530]: 1D42B60119: to=, relay=local, delay=0.07, delays=0.06/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb 21 17:02:22 srv4hai postfix/qmgr[28610]: 1D42B60119: removed
Feb 21 17:02:22 srv4hai fetchmail[1651]: 9917 messages (9917 seen) for srozum at mail.akis.at (1196335028 octets).
Feb 21 17:02:23 srv4hai fetchmail[1651]: 21783 messages (21783 seen) for mrozum at mail.akis.at (-569507103 octets).
Feb 21 17:02:23 srv4hai bt_scan[11791]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / fixAddr: '192.168.12.61;' - found: 'No'
Feb 21 17:02:23 srv4hai bt_scan[11791]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Feb 21 17:02:23 srv4hai common[11829]: SHELLY common.sh inkludiert
Feb 21 17:02:23 srv4hai check_presence[11829]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and /srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Feb 21 17:02:23 srv4hai check_presence[11829]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and /srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Feb 21 17:02:23 srv4hai check_presence[11829]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and /srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Feb 21 17:02:23 srv4hai check_presence[11829]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/IP) (__/IP) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Feb 21 17:02:23 srv4hai check_presence[11829]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Feb 21 17:02:23 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Feb 21 17:02:35 srv4hai named[14530]: resolver priming query complete
Feb 21 17:03:01 srv4hai CRON[11886]: (root) CMD (/etc/linetest/linetest.sh)
Feb 21 17:03:02 srv4hai named[14530]: resolver priming query complete
Feb 21 17:03:04 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Feb 21 17:03:04 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.10
Feb 21 17:03:04 srv4hai dhcpd[5037]: execute_statement argv[2] = pchai7x
Feb 21 17:03:04 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Feb 21 17:03:04 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Feb 21 17:03:04 srv4hai named[14530]: client @0x7fc320081f70 192.168.12.252#50133/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 21 17:03:04 srv4hai named[14530]: client @0x7fc32405ba30 192.168.12.252#59513/key rndc-key: signer "rndc-key" approved
Feb 21 17:03:04 srv4hai named[14530]: client @0x7fc32405ba30 192.168.12.252#59513/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Feb 21 17:03:04 srv4hai named[14530]: client @0x7fc32405ba30 192.168.12.252#59513/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Feb 21 17:03:04 srv4hai named[14530]: client @0x7fc32405ba30 192.168.12.252#59513/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Feb 21 17:03:04 srv4hai named[14530]: client @0x7fc32405ba30 192.168.12.252#59513/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Feb 21 17:03:04 srv4hai dhcpd[5037]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Feb 21 17:03:04 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Feb 21 17:03:04 srv4hai named[14530]: client @0x7fc3080643f0 192.168.12.252#54289/key rndc-key: signer "rndc-key" approved
Feb 21 17:03:04 srv4hai named[14530]: client @0x7fc3080643f0 192.168.12.252#54289/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Feb 21 17:03:04 srv4hai named[14530]: client @0x7fc3080643f0 192.168.12.252#54289/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '10.12.168.192.in-addr.arpa' PTR pchai7x.viehai.at.
Feb 21 17:03:04 srv4hai dhcpd[5037]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Feb 21 17:03:04 srv4hai activate_scenario[11900]: SHELLY scenario: 'pcON(pcon)' started
Feb 21 17:03:04 srv4hai activate_scenario[11900]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'

finished