activate_scenario.sh
Wed Mar 13 16:51:00 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/03/13/_0.log)

vorher: 16:51:00.940

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: 16:51:00.972
Dauer: 32 msec phName: 'origin:'dhcpcommit.sh-pchai7x''


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

urls : 1
vorher : 16:51:00.912
nachher: 16:51:00.979
Dauer : 66 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/13//scene_pcON_20240313_165100.txt'


syslog

Mar 13 16:48:01 srv4hai CRON[3161]: (root) CMD (/etc/linetest/linetest.sh)
Mar 13 16:48:28 srv4hai activate_scenario[3169]: SHELLY scenario: 'buero_UM(buero_um)' started
Mar 13 16:48:28 srv4hai activate_scenario[3169]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'
Mar 13 16:48:28 srv4hai activate_scenario[3169]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'Thomas Büro Licht'
Mar 13 16:48:28 srv4hai postfix/pickup[26449]: 3A1D5602B8: uid=33 from=
Mar 13 16:48:28 srv4hai postfix/cleanup[2973]: 3A1D5602B8: message-id=<20240313154828.3A1D5602B8@mail.viehai.at>
Mar 13 16:48:28 srv4hai postfix/qmgr[15291]: 3A1D5602B8: from=, size=18795, nrcpt=1 (queue active)
Mar 13 16:48:28 srv4hai activate_scenario[3169]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Mar 13 16:48:28 srv4hai proc_url[3238]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/03/13/_0.log' - shellyUsage:'Thomas Büro Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Mar 13 16:48:28 srv4hai postfix/local[3233]: 3A1D5602B8: to=, orig_to=, relay=local, delay=0.04, delays=0.02/0.01/0/0.02, dsn=5.1.1, status=bounced (unknown user: "null")
Mar 13 16:48:28 srv4hai postfix/cleanup[2973]: 43ABC602B9: message-id=<20240313154828.43ABC602B9@mail.viehai.at>
Mar 13 16:48:28 srv4hai postfix/bounce[3234]: 3A1D5602B8: sender non-delivery notification: 43ABC602B9
Mar 13 16:48:28 srv4hai postfix/qmgr[15291]: 43ABC602B9: from=<>, size=20714, nrcpt=1 (queue active)
Mar 13 16:48:28 srv4hai postfix/qmgr[15291]: 3A1D5602B8: removed
Mar 13 16:48:28 srv4hai activate_scenario[3169]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Mar 13 16:48:28 srv4hai proc_url[3250]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/03/13/_1.log' - shellyUsage:'Thomas Büro Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Mar 13 16:48:28 srv4hai postfix/local[3233]: 43ABC602B9: 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 13 16:48:28 srv4hai postfix/qmgr[15291]: 43ABC602B9: removed
Mar 13 16:48:28 srv4hai activate_scenario[3169]: SHELLY scenario: 'buero_UM(buero_um)' took 81 msec, shelly-40:'Thomas Büro Licht'
Mar 13 16:48:30 srv4hai named[15509]: resolver priming query complete
Mar 13 16:48:46 srv4hai dhcpd[5037]: DHCPREQUEST for 10.246.136.24 from 08:92:04:5f:12:67 via enp2s0: wrong network.
Mar 13 16:48:46 srv4hai dhcpd[5037]: DHCPNAK on 10.246.136.24 to 08:92:04:5f:12:67 via enp2s0
Mar 13 16:48:46 srv4hai dhcpd[5037]: DHCPDISCOVER from 08:92:04:5f:12:67 via enp2s0
Mar 13 16:48:46 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.20 to 08:92:04:5f:12:67 via enp2s0
Mar 13 16:48:46 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 13 16:48:46 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.20
Mar 13 16:48:46 srv4hai dhcpd[5037]: execute_statement argv[2] = w-9626
Mar 13 16:48:46 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.20 (192.168.12.252) from 08:92:04:5f:12:67 via enp2s0
Mar 13 16:48:46 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.20 to 08:92:04:5f:12:67 via enp2s0
Mar 13 16:48:46 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#56987/key rndc-key: signer "rndc-key" approved
Mar 13 16:48:46 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#56987/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '20.12.168.192.in-addr.arpa' PTR
Mar 13 16:48:46 srv4hai named[15509]: client @0x7f9318034020 192.168.12.252#56987/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.
Mar 13 16:48:46 srv4hai dhcpd[5037]: Added reverse map from 20.12.168.192.in-addr.arpa. to W-9626.ds1.internal
Mar 13 16:48:46 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.20'(20) device 'w-9626'
Mar 13 16:48:46 srv4hai dhcpcommit.sh: SHELLY device 'w-9626' known and accepted
Mar 13 16:48:47 srv4hai named[15509]: resolver priming query complete
Mar 13 16:48:48 srv4hai named[15509]: resolver priming query complete
Mar 13 16:48:49 srv4hai named[15509]: resolver priming query complete
Mar 13 16:48:51 srv4hai named[15509]: resolver priming query complete
Mar 13 16:48:52 srv4hai named[15509]: resolver priming query complete
Mar 13 16:48:53 srv4hai named[15509]: resolver priming query complete
Mar 13 16:48:54 srv4hai named[15509]: resolver priming query complete
Mar 13 16:48:55 srv4hai named[15509]: resolver priming query complete
Mar 13 16:48:57 srv4hai named[15509]: resolver priming query complete
Mar 13 16:48:58 srv4hai named[15509]: resolver priming query complete
Mar 13 16:49:01 srv4hai ping_SP[30893]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1710344941 - 'ping_SP_1'
Mar 13 16:49:01 srv4hai ping_SP[30893]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Mar 13 16:49:01 srv4hai CRON[3322]: (root) CMD (/etc/linetest/linetest.sh)
Mar 13 16:49:12 srv4hai dhcpd[5037]: DHCPINFORM from 192.168.12.20 via enp2s0
Mar 13 16:49:12 srv4hai dhcpd[5037]: DHCPACK to 192.168.12.20 (08:92:04:5f:12:67) via enp2s0
Mar 13 16:50:01 srv4hai CRON[3335]: (root) CMD (/etc/linetest/linetest.sh)
Mar 13 16:50:01 srv4hai CRON[3336]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Mar 13 16:50:01 srv4hai meter.sh: SHELLY meter.sh started
Mar 13 16:50:09 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:11 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:14 srv4hai meter.sh: SHELLY 'shelly-37/Wetter 1':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:14 srv4hai ping_SP[30893]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1710345014 - 'ping_SP_1'
Mar 13 16:50:14 srv4hai ping_SP[30893]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Mar 13 16:50:16 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:19 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:20 srv4hai common[3750]: SHELLY common.sh inkludiert
Mar 13 16:50:21 srv4hai meter.sh: SHELLY 'shelly-58/Werkstatt Licht':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:24 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:27 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:29 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:30 srv4hai bt_scan[3750]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / fixAddr: '192.168.12.61;' - found: 'No'
Mar 13 16:50:30 srv4hai bt_scan[3750]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Mar 13 16:50:30 srv4hai common[3802]: SHELLY common.sh inkludiert
Mar 13 16:50:30 srv4hai check_presence[3802]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and /srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Mar 13 16:50:30 srv4hai check_presence[3802]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and /srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Mar 13 16:50:30 srv4hai check_presence[3802]: SHELLY (0) found  and 
Mar 13 16:50:30 srv4hai check_presence[3802]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/IP) (__/IP) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Mar 13 16:50:30 srv4hai check_presence[3802]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Mar 13 16:50:32 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:34 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:37 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:39 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:42 srv4hai meter.sh: SHELLY 'shelly-47/47-plus1-Test':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:45 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:47 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:50 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:52 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:54 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Mar 13 16:50:55 srv4hai meter.sh: SHELLY 'shelly-43/43-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:50:55 srv4hai fetchmail[1651]: 39820 messages (39819 seen) for tmiglinci at mail.akis.at (-1003722366 octets).
Mar 13 16:50:55 srv4hai postfix/smtpd[3933]: connect from localhost[127.0.0.1]
Mar 13 16:50:55 srv4hai postfix/smtpd[3933]: A8D2160119: client=localhost[127.0.0.1]
Mar 13 16:50:55 srv4hai postfix/cleanup[3936]: A8D2160119: message-id=<20240313154709.1ED52602B8@mail.viehai.at>
Mar 13 16:50:55 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:39820 of 39820 (8063 octets) not flushed
Mar 13 16:50:55 srv4hai postfix/qmgr[15291]: A8D2160119: from=, size=8349, nrcpt=1 (queue active)
Mar 13 16:50:55 srv4hai postfix/smtpd[3933]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Mar 13 16:50:55 srv4hai postfix/local[3937]: A8D2160119: to=, relay=local, delay=0.07, delays=0.05/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 13 16:50:55 srv4hai postfix/qmgr[15291]: A8D2160119: removed
Mar 13 16:50:56 srv4hai fetchmail[1651]: 9996 messages (9996 seen) for srozum at mail.akis.at (1211147720 octets).
Mar 13 16:50:56 srv4hai fetchmail[1651]: 22220 messages (22220 seen) for mrozum at mail.akis.at (-457372378 octets).
Mar 13 16:50:57 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Mar 13 16:50:57 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:51:00 srv4hai meter.sh: SHELLY 'shelly-45/45-TBD':  OFFLINE, resp. not answering within connect-timeout 2.500000s
Mar 13 16:51:00 srv4hai meter.sh: SHELLY meter.sh ended
Mar 13 16:51:00 srv4hai postfix/pickup[26449]: 78184602B8: uid=33 from=
Mar 13 16:51:00 srv4hai postfix/cleanup[3936]: 78184602B8: message-id=<20240313155100.78184602B8@mail.viehai.at>
Mar 13 16:51:00 srv4hai CRON[3957]: (root) CMD (/etc/linetest/linetest.sh)
Mar 13 16:51:00 srv4hai postfix/qmgr[15291]: 78184602B8: from=, size=654, nrcpt=1 (queue active)
Mar 13 16:51:00 srv4hai postfix/local[3937]: 78184602B8: to=, orig_to=, relay=local, delay=0.03, delays=0.02/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Mar 13 16:51:00 srv4hai postfix/qmgr[15291]: 78184602B8: removed
Mar 13 16:51:00 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Mar 13 16:51:00 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.10
Mar 13 16:51:00 srv4hai dhcpd[5037]: execute_statement argv[2] = pchai7x
Mar 13 16:51:00 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Mar 13 16:51:00 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Mar 13 16:51:00 srv4hai named[15509]: client @0x7f931c6b5500 192.168.12.252#53065/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 13 16:51:00 srv4hai named[15509]: client @0x7f9310045f00 192.168.12.252#32853/key rndc-key: signer "rndc-key" approved
Mar 13 16:51:00 srv4hai named[15509]: client @0x7f9310045f00 192.168.12.252#32853/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Mar 13 16:51:00 srv4hai named[15509]: client @0x7f9310045f00 192.168.12.252#32853/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Mar 13 16:51:00 srv4hai named[15509]: client @0x7f9310045f00 192.168.12.252#32853/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Mar 13 16:51:00 srv4hai named[15509]: client @0x7f9310045f00 192.168.12.252#32853/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Mar 13 16:51:00 srv4hai dhcpd[5037]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Mar 13 16:51:00 srv4hai named[15509]: client @0x7f931007d0f0 192.168.12.252#33421/key rndc-key: signer "rndc-key" approved
Mar 13 16:51:00 srv4hai named[15509]: client @0x7f931007d0f0 192.168.12.252#33421/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Mar 13 16:51:00 srv4hai named[15509]: client @0x7f931007d0f0 192.168.12.252#33421/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.
Mar 13 16:51:00 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Mar 13 16:51:00 srv4hai dhcpd[5037]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Mar 13 16:51:00 srv4hai activate_scenario[3968]: SHELLY scenario: 'pcON(pcon)' started
Mar 13 16:51:00 srv4hai activate_scenario[3968]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'

finished