activate_scenario.sh
Fri Feb 9 18:24:33 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'
Thomas Schreibtischlampe (/srv/www/viehai/shelly/log_scenarios/2024/02/09/_0.log)
vorher: 18:24:33.356
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: 18:24:33.389
Dauer: 33 msec
phName: 'origin:'dhcpcommit.sh-pchai7x''
scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'
urls : 1
vorher : 18:24:33.302
nachher: 18:24:33.396
Dauer : 95 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/02/09//scene_pcON_20240209_182433.txt'
syslog
Feb 9 18:21:00 srv4hai postfix/local[12313]: F2B1060244: to=, orig_to=, relay=local, delay=0.03, delays=0.01/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb 9 18:21:00 srv4hai postfix/qmgr[28610]: F2B1060244: removed
Feb 9 18:21:02 srv4hai CRON[12317]: (root) CMD (/etc/linetest/linetest.sh)
Feb 9 18:21:05 srv4hai ping_SP[12004]: SHELLY (0)- ping 192.168.12.61 3 not answered (1) @~1707499265 - 'ping_SP_0'
Feb 9 18:21:10 srv4hai dhcpd[5037]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Feb 9 18:21:10 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Feb 9 18:21:10 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Feb 9 18:21:10 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.61
Feb 9 18:21:10 srv4hai dhcpd[5037]: execute_statement argv[2] = fpThomas
Feb 9 18:21:10 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas'
Feb 9 18:21:10 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Feb 9 18:21:10 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Feb 9 18:21:10 srv4hai named[14530]: client @0x7fc31c0d0140 192.168.12.252#51489/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 9 18:21:10 srv4hai named[14530]: client @0x7fc320081f70 192.168.12.252#50199/key rndc-key: signer "rndc-key" approved
Feb 9 18:21:10 srv4hai named[14530]: client @0x7fc320081f70 192.168.12.252#50199/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Feb 9 18:21:10 srv4hai named[14530]: client @0x7fc320081f70 192.168.12.252#50199/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Feb 9 18:21:10 srv4hai named[14530]: client @0x7fc320081f70 192.168.12.252#50199/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Feb 9 18:21:10 srv4hai named[14530]: client @0x7fc320081f70 192.168.12.252#50199/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Feb 9 18:21:10 srv4hai dhcpd[5037]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Feb 9 18:21:10 srv4hai named[14530]: client @0x7fc324060480 192.168.12.252#59375/key rndc-key: signer "rndc-key" approved
Feb 9 18:21:10 srv4hai named[14530]: client @0x7fc324060480 192.168.12.252#59375/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Feb 9 18:21:10 srv4hai named[14530]: client @0x7fc324060480 192.168.12.252#59375/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Feb 9 18:21:10 srv4hai dhcpd[5037]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Feb 9 18:21:10 srv4hai ping_SP[12334]: SHELLY ping_SP.sh started from smartphone
Feb 9 18:21:10 srv4hai ping_SP[12334]: SHELLY check_presence.sh coming 0 ping_SP__smartphone
Feb 9 18:21:10 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:11 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:12 srv4hai ping_SP[12334]: SHELLY - running process-id(12334): '12004 /bin/bash /srv/www/viehai/shelly/ping_SP.sh 192.168.12.61 bt_scan#01212334 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.61 smartphone' - 'ping_SP_0' - exiting ==============
Feb 9 18:21:18 srv4hai ping_SP[12004]: SHELLY (0) - ping 192.168.12.61 4 sucessfully @~1707499278 - 'ping_SP_0'
Feb 9 18:21:18 srv4hai ping_SP[12004]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 9 18:21:22 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:31 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:33 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:36 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:37 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:38 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:39 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:40 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:41 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:42 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:43 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:44 srv4hai named[14530]: resolver priming query complete
Feb 9 18:21:52 srv4hai activate_scenario[12386]: SHELLY scenario: 'buero_UM(buero_um)' started
Feb 9 18:21:52 srv4hai activate_scenario[12386]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'
Feb 9 18:21:52 srv4hai activate_scenario[12386]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'Thomas Büro Licht'
Feb 9 18:21:52 srv4hai postfix/pickup[3661]: 2B89E60244: uid=33 from=
Feb 9 18:21:52 srv4hai postfix/cleanup[12098]: 2B89E60244: message-id=<20240209172152.2B89E60244@mail.viehai.at>
Feb 9 18:21:52 srv4hai postfix/qmgr[28610]: 2B89E60244: from=, size=14222, nrcpt=1 (queue active)
Feb 9 18:21:52 srv4hai postfix/local[12313]: 2B89E60244: to=, orig_to=, relay=local, delay=0.04, delays=0.01/0/0/0.03, dsn=5.1.1, status=bounced (unknown user: "null")
Feb 9 18:21:52 srv4hai postfix/cleanup[12098]: 34F5560245: message-id=<20240209172152.34F5560245@mail.viehai.at>
Feb 9 18:21:52 srv4hai postfix/bounce[12442]: 2B89E60244: sender non-delivery notification: 34F5560245
Feb 9 18:21:52 srv4hai postfix/qmgr[28610]: 34F5560245: from=<>, size=16141, nrcpt=1 (queue active)
Feb 9 18:21:52 srv4hai postfix/qmgr[28610]: 2B89E60244: removed
Feb 9 18:21:52 srv4hai postfix/local[12313]: 34F5560245: to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Feb 9 18:21:52 srv4hai postfix/qmgr[28610]: 34F5560245: removed
Feb 9 18:21:52 srv4hai activate_scenario[12386]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Feb 9 18:21:52 srv4hai proc_url[12455]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/02/09/_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 9 18:21:52 srv4hai activate_scenario[12386]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Feb 9 18:21:52 srv4hai proc_url[12466]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/02/09/_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 9 18:21:52 srv4hai activate_scenario[12386]: SHELLY scenario: 'buero_UM(buero_um)' took 127 msec, shelly-40:'Thomas Büro Licht'
Feb 9 18:21:53 srv4hai named[14530]: resolver priming query complete
Feb 9 18:22:01 srv4hai CRON[12507]: (root) CMD (/etc/linetest/linetest.sh)
Feb 9 18:22:21 srv4hai ping_SP[12004]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1707499341 - 'ping_SP_0'
Feb 9 18:22:21 srv4hai ping_SP[12004]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 9 18:22:34 srv4hai named[14530]: resolver priming query complete
Feb 9 18:22:38 srv4hai named[14530]: resolver priming query complete
Feb 9 18:22:43 srv4hai named[14530]: resolver priming query complete
Feb 9 18:23:01 srv4hai CRON[12541]: (root) CMD (/etc/linetest/linetest.sh)
Feb 9 18:23:04 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=12549, secured, session=
Feb 9 18:23:04 srv4hai dovecot: imap(miglincit)<12549>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 9 18:23:05 srv4hai named[14530]: resolver priming query complete
Feb 9 18:23:24 srv4hai ping_SP[12004]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1707499404 - 'ping_SP_0'
Feb 9 18:23:24 srv4hai ping_SP[12004]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 9 18:23:38 srv4hai named[14530]: resolver priming query complete
Feb 9 18:23:40 srv4hai trace_events[12588]: SHELLY common.sh inkludiert
Feb 9 18:23:41 srv4hai bt_scan[12588]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / fixAddr: '192.168.12.61;' - found: 'No'
Feb 9 18:23:41 srv4hai named[14530]: resolver priming query complete
Feb 9 18:23:41 srv4hai bt_scan[12588]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Feb 9 18:23:41 srv4hai trace_events[12621]: SHELLY common.sh inkludiert
Feb 9 18:23:41 srv4hai check_presence[12621]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/IP) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Feb 9 18:23:41 srv4hai check_presence[12621]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Feb 9 18:24:01 srv4hai CRON[12665]: (root) CMD (/etc/linetest/linetest.sh)
Feb 9 18:24:27 srv4hai named[14530]: resolver priming query complete
Feb 9 18:24:27 srv4hai ping_SP[12004]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1707499467 - 'ping_SP_0'
Feb 9 18:24:27 srv4hai ping_SP[12004]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Feb 9 18:24:28 srv4hai named[14530]: resolver priming query complete
Feb 9 18:24:33 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Feb 9 18:24:33 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.10
Feb 9 18:24:33 srv4hai dhcpd[5037]: execute_statement argv[2] = pchai7x
Feb 9 18:24:33 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Feb 9 18:24:33 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Feb 9 18:24:33 srv4hai named[14530]: client @0x7fc328100b10 192.168.12.252#56841/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Feb 9 18:24:33 srv4hai named[14530]: client @0x7fc3180de750 192.168.12.252#55919/key rndc-key: signer "rndc-key" approved
Feb 9 18:24:33 srv4hai named[14530]: client @0x7fc3180de750 192.168.12.252#55919/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Feb 9 18:24:33 srv4hai named[14530]: client @0x7fc3180de750 192.168.12.252#55919/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Feb 9 18:24:33 srv4hai named[14530]: client @0x7fc3180de750 192.168.12.252#55919/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Feb 9 18:24:33 srv4hai named[14530]: client @0x7fc3180de750 192.168.12.252#55919/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Feb 9 18:24:33 srv4hai dhcpd[5037]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Feb 9 18:24:33 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Feb 9 18:24:33 srv4hai named[14530]: client @0x7fc3200f8760 192.168.12.252#52085/key rndc-key: signer "rndc-key" approved
Feb 9 18:24:33 srv4hai named[14530]: client @0x7fc3200f8760 192.168.12.252#52085/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Feb 9 18:24:33 srv4hai named[14530]: client @0x7fc3200f8760 192.168.12.252#52085/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 9 18:24:33 srv4hai dhcpd[5037]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Feb 9 18:24:33 srv4hai activate_scenario[12708]: SHELLY scenario: 'pcON(pcon)' started
Feb 9 18:24:33 srv4hai activate_scenario[12708]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'
finished