activate_scenario.sh
Sat Dec 28 17:31:24 CET 2024
scenario: pcON
origin: dhcpcommit.sh-pchai7x
'night' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'null'
scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'
TB Schreibtischlampe (/srv/www/viehai/shelly/log_scenarios/2024/12/28/_0.log)
vorher: 17:31:24.886
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:31:24.914
Dauer: 27 msec
phName: 'origin:'dhcpcommit.sh-pchai7x''
scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'
urls : 1
vorher : 17:31:24.857
nachher: 17:31:24.920
Dauer : 63 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/12/28//scene_pcON_20241228_173124.txt'
syslog
Dec 28 17:28:01 srv4hai CRON[32207]: (root) CMD (/etc/linetest/linetest.sh)
Dec 28 17:28:04 srv4hai named[30406]: resolver priming query complete
Dec 28 17:28:11 srv4hai nmbd[2172]: [2024/12/28 17:28:11.516568, 0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
Dec 28 17:28:11 srv4hai nmbd[2172]: find_domain_master_name_query_fail:
Dec 28 17:28:11 srv4hai nmbd[2172]: Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
Dec 28 17:28:11 srv4hai nmbd[2172]: Unable to sync browse lists in this workgroup.
Dec 28 17:28:53 srv4hai ping_SP[27294]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1735403333 - 'ping_SP_0'
Dec 28 17:28:53 srv4hai ping_SP[27294]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Dec 28 17:28:55 srv4hai postfix/anvil[32051]: statistics: max connection rate 1/60s for (smtp:80.94.95.239) at Dec 28 17:25:35
Dec 28 17:28:55 srv4hai postfix/anvil[32051]: statistics: max connection count 1 for (smtp:80.94.95.239) at Dec 28 17:25:35
Dec 28 17:28:55 srv4hai postfix/anvil[32051]: statistics: max cache size 1 at Dec 28 17:25:35
Dec 28 17:29:01 srv4hai CRON[32272]: (root) CMD (/etc/linetest/linetest.sh)
Dec 28 17:29:04 srv4hai named[30406]: resolver priming query complete
Dec 28 17:29:11 srv4hai named[30406]: resolver priming query complete
Dec 28 17:29:31 srv4hai postfix/smtpd[32296]: connect from unknown[80.94.95.239]
Dec 28 17:29:34 srv4hai postfix/smtpd[32296]: warning: unknown[80.94.95.239]: SASL LOGIN authentication failed: Invalid authentication mechanism
Dec 28 17:29:35 srv4hai postfix/smtpd[32296]: disconnect from unknown[80.94.95.239] ehlo=1 auth=0/1 rset=1 quit=1 commands=3/4
Dec 28 17:30:01 srv4hai CRON[32329]: (root) CMD ([ -x /etc/init.d/anacron ] && if [ ! -d /run/systemd/system ]; then /usr/sbin/invoke-rc.d anacron start >/dev/null; fi)
Dec 28 17:30:01 srv4hai CRON[32330]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Dec 28 17:30:01 srv4hai CRON[32331]: (root) CMD (/etc/linetest/linetest.sh)
Dec 28 17:30:01 srv4hai common[32332]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/meter.sh
Dec 28 17:30:01 srv4hai meter.sh: SHELLY meter.sh started
Dec 28 17:30:02 srv4hai meter.sh: SHELLY 'shelly-29/KÜ Schalter Herdzeile' - type: 'shelly-i3' ignoring
Dec 28 17:30:03 srv4hai meter.sh: SHELLY 'shelly-28/KÜ Schalter Nasszeile' - type: 'shelly-i3' ignoring
Dec 28 17:30:06 srv4hai ping_SP[27294]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1735403406 - 'ping_SP_0'
Dec 28 17:30:06 srv4hai ping_SP[27294]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Dec 28 17:30:06 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster' - type: 'shelly-BTN' ignoring
Dec 28 17:30:06 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter' - type: 'shelly-BTN' ignoring
Dec 28 17:30:06 srv4hai meter.sh: SHELLY 'shelly-37/TB Klima' - type: 'shelly-ht' ignoring
Dec 28 17:30:06 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen' - status: 'OOS' ignoring
Dec 28 17:30:06 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon' - type: 'shelly-ht-plus' ignoring
Dec 28 17:30:09 srv4hai meter.sh: SHELLY 'shelly-18/18-Test Farbige LED': OFFLINE, resp. not answering within connect-timeout 2.500000s
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-15/15-Test Weiss': OFFLINE, resp. not answering within connect-timeout 2.500000s
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-30/30-TBD' - status: 'OOS' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-31/31-Test i3' - status: 'OOS' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-32/32-TBD' - status: 'OOS' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-33/33-TBD' - status: 'OOS' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-36/36-TBD' - status: 'OOS' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-09a/Inbetriebnahme - 20210720 - Defekt' - status: 'defect' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-09b/Sophie Licht - 20230404 - Defekt' - status: 'defect' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-26/20230404 - kein WLAN' - status: 'defect' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-27/Schalter Herdzeile - Defekt WLAN 20230417' - status: 'defect' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-21/Badezimmer - 20230720 - WLAN Problem' - status: 'defect' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-11/Ausgangstransistor defekt 20230722' - status: 'defect' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-01a/WZ Licht Esstisch - 20241208 kein WLAN' - status: 'DFC' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-43/43-tbd' - status: 'OOS' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-44/44-TBD' - status: 'OOS' ignoring
Dec 28 17:30:12 srv4hai meter.sh: SHELLY 'shelly-46/46-TBD' - status: 'OOS' ignoring
Dec 28 17:30:13 srv4hai meter.sh: SHELLY 'shelly-48/BT GW 1' - status: 'OOS' ignoring
Dec 28 17:30:14 srv4hai common[871]: SHELLY common.sh inkludiert von ./bt_scan.sh
Dec 28 17:30:14 srv4hai named[30406]: resolver priming query complete
Dec 28 17:30:15 srv4hai meter.sh: SHELLY 'shelly-50/50-TBD': OFFLINE, resp. not answering within connect-timeout 2.500000s
Dec 28 17:30:15 srv4hai meter.sh: SHELLY 'shelly-59/Werkstatt Schalter Kellertür' - type: 'shelly-i3' ignoring
Dec 28 17:30:15 srv4hai common[918]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_shelly.sh
Dec 28 17:30:15 srv4hai check_shelly.sh: SHELLY last scenery executed: 'vorraumOn'
Dec 28 17:30:15 srv4hai check_shelly.sh: SHELLY found '5' active shelly outputs
Dec 28 17:30:15 srv4hai meter.sh: SHELLY meter.sh ended
Dec 28 17:30:24 srv4hai bt_scan[871]: SHELLY - who: 'Grete' / phoneName: 'S20_Grete' / '1' / shellyIP: '192.168.12.62' - found: 'Yes'
Dec 28 17:30:24 srv4hai bt_scan[871]: SHELLY - ping_SP.sh started for BTmac: '1' - IPv4: '192.168.12.62'
Dec 28 17:30:24 srv4hai common[976]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Dec 28 17:30:24 srv4hai ping_SP[976]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Dec 28 17:30:24 srv4hai common[999]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Dec 28 17:30:24 srv4hai named[30406]: resolver priming query complete
Dec 28 17:30:24 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'4'=1735403424-1735403420
Dec 28 17:30:24 srv4hai check_presence[999]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Dec 28 17:30:24 srv4hai check_presence[999]: SHELLY (ping_SP__bt_scan)-(1) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Dec 28 17:30:25 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'5'=1735403425-1735403420
Dec 28 17:30:25 srv4hai check_presence[999]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Dec 28 17:30:25 srv4hai check_presence[999]: SHELLY (ping_SP__bt_scan)-(1) what: 'coming' - persPresent: '(BT/LIVE) (BT/__)' - anyPresent: 'true' - otherPresent:'true'
Dec 28 17:30:25 srv4hai check_presence[999]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_vorraumOn) - sceneONsmall(vorraumOn)
Dec 28 17:30:25 srv4hai check_presence[999]: SHELLY (ping_SP__bt_scan)-(1)-coming: activate_scenario.shtml: vorraumOn
Dec 28 17:30:25 srv4hai activate_scenario[1114]: SHELLY last scenario: 'vorraumOn' @ '171005' from 'scene_vorraumOn_20241228_171005.txt' - delta=-20
Dec 28 17:30:25 srv4hai activate_scenario[1114]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20241228173025 20241228171005 -f '%S'
Dec 28 17:30:25 srv4hai activate_scenario[1114]: SHELLY new scenario: 'vorraumOn' same - EXIT
Dec 28 17:30:25 srv4hai ping_SP[976]: SHELLY check_presence.sh coming 1 ping_SP__bt_scan
Dec 28 17:30:25 srv4hai ping_SP[976]: SHELLY - new process for '192.168.12.62' - '/srv/www/viehai/shelly//meter/ping_SP_1' @~1735403425
Dec 28 17:30:29 srv4hai systemd[1]: Started Run anacron jobs.
Dec 28 17:30:29 srv4hai anacron[1153]: Anacron 2.3 started on 2024-12-28
Dec 28 17:30:29 srv4hai anacron[1153]: Normal exit (0 jobs run)
Dec 28 17:30:29 srv4hai systemd[1]: anacron.service: Succeeded.
Dec 28 17:30:38 srv4hai ping_SP[976]: SHELLY (1) - ping 192.168.12.62 0 sucessfully @~1735403438 - 'ping_SP_1'
Dec 28 17:30:38 srv4hai ping_SP[976]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Dec 28 17:31:01 srv4hai CRON[1191]: (root) CMD (/etc/linetest/linetest.sh)
Dec 28 17:31:03 srv4hai named[30406]: resolver priming query complete
Dec 28 17:31:10 srv4hai activate_scenario[1207]: SHELLY last scenario: 'vorraumOn' @ '173025' from 'scene_vorraumOn_20241228_173025.txt' - delta=15
Dec 28 17:31:10 srv4hai activate_scenario[1207]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20241228173110 20241228173025 -f '%S'
Dec 28 17:31:10 srv4hai activate_scenario[1207]: SHELLY new scenario: 'buero_UM' different - GO ON
Dec 28 17:31:10 srv4hai activate_scenario[1207]: SHELLY scenario: 'buero_UM(buero_um)' started
Dec 28 17:31:10 srv4hai activate_scenario[1207]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-40:'TB Licht'
Dec 28 17:31:10 srv4hai activate_scenario[1207]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'TB Licht'
Dec 28 17:31:10 srv4hai postfix/pickup[28303]: A7E4F63463: uid=33 from=
Dec 28 17:31:10 srv4hai postfix/cleanup[1272]: A7E4F63463: message-id=<20241228163110.A7E4F63463@mail.viehai.at>
Dec 28 17:31:10 srv4hai postfix/qmgr[8566]: A7E4F63463: from=, size=9961, nrcpt=1 (queue active)
Dec 28 17:31:10 srv4hai activate_scenario[1207]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'TB Regallicht' --> '0?turn=toggle'
Dec 28 17:31:10 srv4hai proc_url[1290]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/12/28/_0.log' - shellyUsage:'TB Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
Dec 28 17:31:10 srv4hai postfix/local[1285]: A7E4F63463: to=, orig_to=, relay=local, delay=0.04, delays=0.02/0.01/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Dec 28 17:31:10 srv4hai postfix/cleanup[1272]: AED1D63464: message-id=<20241228163110.AED1D63464@mail.viehai.at>
Dec 28 17:31:10 srv4hai postfix/bounce[1286]: A7E4F63463: sender non-delivery notification: AED1D63464
Dec 28 17:31:10 srv4hai postfix/qmgr[8566]: AED1D63464: from=<>, size=11840, nrcpt=1 (queue active)
Dec 28 17:31:10 srv4hai postfix/qmgr[8566]: A7E4F63463: removed
Dec 28 17:31:10 srv4hai activate_scenario[1207]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'TB Licht' --> '0?turn=toggle'
Dec 28 17:31:10 srv4hai proc_url[1302]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/12/28/_1.log' - shellyUsage:'TB Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
Dec 28 17:31:10 srv4hai postfix/local[1285]: AED1D63464: to=, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Dec 28 17:31:10 srv4hai postfix/qmgr[8566]: AED1D63464: removed
Dec 28 17:31:10 srv4hai activate_scenario[1207]: SHELLY scenario: 'buero_UM(buero_um)' took 85 msec, shelly-40:'TB Licht'
Dec 28 17:31:19 srv4hai ping_SP[27294]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1735403479 - 'ping_SP_0'
Dec 28 17:31:19 srv4hai ping_SP[27294]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Dec 28 17:31:21 srv4hai named[30406]: resolver priming query complete
Dec 28 17:31:22 srv4hai named[30406]: resolver priming query complete
Dec 28 17:31:24 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Dec 28 17:31:24 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.10
Dec 28 17:31:24 srv4hai dhcpd[4995]: execute_statement argv[2] = pchai7x
Dec 28 17:31:24 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Dec 28 17:31:24 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Dec 28 17:31:24 srv4hai named[30406]: client @0x7f931c0a07f0 192.168.12.252#50609/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Dec 28 17:31:24 srv4hai named[30406]: client @0x7f934c0b2c60 192.168.12.252#54241/key rndc-key: signer "rndc-key" approved
Dec 28 17:31:24 srv4hai named[30406]: client @0x7f934c0b2c60 192.168.12.252#54241/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Dec 28 17:31:24 srv4hai named[30406]: client @0x7f934c0b2c60 192.168.12.252#54241/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Dec 28 17:31:24 srv4hai named[30406]: client @0x7f934c0b2c60 192.168.12.252#54241/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Dec 28 17:31:24 srv4hai named[30406]: client @0x7f934c0b2c60 192.168.12.252#54241/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Dec 28 17:31:24 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Dec 28 17:31:24 srv4hai dhcpd[4995]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Dec 28 17:31:24 srv4hai named[30406]: client @0x7f935011da30 192.168.12.252#37395/key rndc-key: signer "rndc-key" approved
Dec 28 17:31:24 srv4hai named[30406]: client @0x7f935011da30 192.168.12.252#37395/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Dec 28 17:31:24 srv4hai named[30406]: client @0x7f935011da30 192.168.12.252#37395/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.
Dec 28 17:31:24 srv4hai dhcpd[4995]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Dec 28 17:31:24 srv4hai activate_scenario[1374]: SHELLY last scenario: 'buero_UM' @ '173110' from 'scene_buero_UM_20241228_173110.txt' - delta=-14
Dec 28 17:31:24 srv4hai activate_scenario[1374]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20241228173124 20241228173110 -f '%S'
Dec 28 17:31:24 srv4hai activate_scenario[1374]: SHELLY new scenario: 'pcON' different - GO ON
Dec 28 17:31:24 srv4hai activate_scenario[1374]: SHELLY scenario: 'pcON(pcon)' started
Dec 28 17:31:24 srv4hai activate_scenario[1374]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'
finished