activate_scenario.sh
Mon Jan 27 17:35:56 CET 2025
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/2025/01/27/_0.log)
vorher: 17:35:56.834
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:35:56.870
Dauer: 37 msec
phName: 'origin:'dhcpcommit.sh-pchai7x''
scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'
urls : 1
vorher : 17:35:56.801
nachher: 17:35:56.877
Dauer : 76 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/27//scene_pcON_20250127_173556.txt'
syslog
Jan 27 17:32:00 srv4hai common[4980]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:32:00 srv4hai common[5005]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:32:00 srv4hai common[5030]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:32:00 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=5056, secured, session=
Jan 27 17:32:00 srv4hai dovecot: imap(miglincit)<5056>: Logged out in=2095 out=166364 deleted=0 expunged=0 trashed=0 hdr_count=258 hdr_bytes=91337 body_count=0 body_bytes=0
Jan 27 17:32:01 srv4hai common[5057]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:32:01 srv4hai common[5081]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:32:01 srv4hai CRON[5106]: (root) CMD (/etc/linetest/linetest.sh)
Jan 27 17:32:23 srv4hai named[30406]: resolver priming query complete
Jan 27 17:32:29 srv4hai ping_SP[2816]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1737995549 - 'ping_SP_0'
Jan 27 17:32:29 srv4hai ping_SP[2816]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 27 17:32:29 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1737995549 - 'ping_SP_1'
Jan 27 17:32:29 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 27 17:32:39 srv4hai named[30406]: resolver priming query complete
Jan 27 17:33:00 srv4hai common[5159]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:33:00 srv4hai common[5183]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:33:00 srv4hai common[5207]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:33:01 srv4hai CRON[5232]: (root) CMD (/etc/linetest/linetest.sh)
Jan 27 17:33:01 srv4hai common[5236]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:33:01 srv4hai common[5260]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:33:15 srv4hai named[30406]: resolver priming query complete
Jan 27 17:33:19 srv4hai activate_scenario[5289]: SHELLY scenario: 'buero_UM(buero_um)' started
Jan 27 17:33:19 srv4hai activate_scenario[5289]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-40:'TB Licht'
Jan 27 17:33:19 srv4hai activate_scenario[5289]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'TB Licht'
Jan 27 17:33:19 srv4hai postfix/pickup[14987]: 9487E63463: uid=33 from=
Jan 27 17:33:19 srv4hai postfix/cleanup[5343]: 9487E63463: message-id=<20250127163319.9487E63463@mail.viehai.at>
Jan 27 17:33:19 srv4hai postfix/qmgr[8566]: 9487E63463: from=, size=19846, nrcpt=1 (queue active)
Jan 27 17:33:19 srv4hai activate_scenario[5289]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'TB Regallicht' --> '0?turn=toggle'
Jan 27 17:33:19 srv4hai proc_url[5362]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/27/_0.log' - shellyUsage:'TB Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
Jan 27 17:33:19 srv4hai postfix/local[5356]: 9487E63463: to=, orig_to=, relay=local, delay=0.05, delays=0.03/0/0/0.02, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 27 17:33:19 srv4hai postfix/cleanup[5343]: 9CB0C63464: message-id=<20250127163319.9CB0C63464@mail.viehai.at>
Jan 27 17:33:19 srv4hai postfix/bounce[5357]: 9487E63463: sender non-delivery notification: 9CB0C63464
Jan 27 17:33:19 srv4hai postfix/qmgr[8566]: 9CB0C63464: from=<>, size=21725, nrcpt=1 (queue active)
Jan 27 17:33:19 srv4hai postfix/qmgr[8566]: 9487E63463: removed
Jan 27 17:33:19 srv4hai postfix/local[5356]: 9CB0C63464: to=, relay=local, delay=0.01, delays=0/0/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 27 17:33:19 srv4hai postfix/qmgr[8566]: 9CB0C63464: removed
Jan 27 17:33:19 srv4hai activate_scenario[5289]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'TB Licht' --> '0?turn=toggle'
Jan 27 17:33:19 srv4hai proc_url[5374]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/27/_1.log' - shellyUsage:'TB Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
Jan 27 17:33:19 srv4hai activate_scenario[5289]: SHELLY scenario: 'buero_UM(buero_um)' took 141 msec, shelly-40:'TB Licht'
Jan 27 17:33:39 srv4hai named[30406]: resolver priming query complete
Jan 27 17:33:41 srv4hai systemd[1]: Started Run anacron jobs.
Jan 27 17:33:41 srv4hai anacron[5429]: Anacron 2.3 started on 2025-01-27
Jan 27 17:33:41 srv4hai anacron[5429]: Normal exit (0 jobs run)
Jan 27 17:33:41 srv4hai systemd[1]: anacron.service: Succeeded.
Jan 27 17:33:42 srv4hai ping_SP[2816]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1737995622 - 'ping_SP_0'
Jan 27 17:33:42 srv4hai ping_SP[2816]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 27 17:33:43 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1737995623 - 'ping_SP_1'
Jan 27 17:33:43 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 27 17:33:54 srv4hai named[30406]: resolver priming query complete
Jan 27 17:33:55 srv4hai named[30406]: resolver priming query complete
Jan 27 17:33:59 srv4hai common[5463]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:33:59 srv4hai common[5487]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:34:00 srv4hai common[5511]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:34:01 srv4hai CRON[5536]: (root) CMD (/etc/linetest/linetest.sh)
Jan 27 17:34:01 srv4hai common[5542]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:34:01 srv4hai common[5566]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:34:10 srv4hai dhcpd[4995]: DHCPDISCOVER from 00:22:61:78:ac:78 via enp2s0
Jan 27 17:34:10 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Jan 27 17:34:15 srv4hai dhcpd[4995]: DHCPDISCOVER from 00:22:61:78:ac:78 via enp2s0
Jan 27 17:34:15 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Jan 27 17:34:15 srv4hai common[5594]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 27 17:34:23 srv4hai dhcpd[4995]: DHCPDISCOVER from 00:22:61:78:ac:78 via enp2s0
Jan 27 17:34:23 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Jan 27 17:34:25 srv4hai bt_scan[5594]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Jan 27 17:34:25 srv4hai bt_scan[5594]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Jan 27 17:34:25 srv4hai common[5627]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 27 17:34:26 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'11'=1737995666-1737995655
Jan 27 17:34:26 srv4hai check_presence[5627]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jan 27 17:34:26 srv4hai check_presence[5627]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Jan 27 17:34:26 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'11'=1737995666-1737995655
Jan 27 17:34:26 srv4hai check_presence[5627]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jan 27 17:34:26 srv4hai check_presence[5627]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Jan 27 17:34:26 srv4hai check_presence[5627]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (BT/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Jan 27 17:34:26 srv4hai check_presence[5627]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_buero_UM) - sceneOFF(offAll)
Jan 27 17:34:26 srv4hai check_presence[5627]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Jan 27 17:34:39 srv4hai dhcpd[4995]: DHCPDISCOVER from 00:22:61:78:ac:78 via enp2s0
Jan 27 17:34:39 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Jan 27 17:34:40 srv4hai named[30406]: resolver priming query complete
Jan 27 17:34:55 srv4hai ping_SP[2816]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1737995695 - 'ping_SP_0'
Jan 27 17:34:55 srv4hai ping_SP[2816]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 27 17:34:56 srv4hai common[5767]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:34:56 srv4hai common[5791]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:34:56 srv4hai common[5815]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:34:56 srv4hai common[5840]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:34:57 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1737995697 - 'ping_SP_1'
Jan 27 17:34:57 srv4hai ping_SP[2006]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 27 17:35:00 srv4hai common[5878]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:35:00 srv4hai common[5905]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:35:00 srv4hai common[5931]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:35:00 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=5957, secured, session=
Jan 27 17:35:00 srv4hai dovecot: imap(miglincit)<5957>: Logged out in=1920 out=1284 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 27 17:35:01 srv4hai CRON[5959]: (root) CMD (/etc/linetest/linetest.sh)
Jan 27 17:35:01 srv4hai common[5963]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:35:01 srv4hai common[5987]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 27 17:35:11 srv4hai dhcpd[4995]: DHCPDISCOVER from 00:22:61:78:ac:78 via enp2s0
Jan 27 17:35:11 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.25 to 00:22:61:78:ac:78 via enp2s0
Jan 27 17:35:41 srv4hai named[30406]: resolver priming query complete
Jan 27 17:35:56 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Jan 27 17:35:56 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.10
Jan 27 17:35:56 srv4hai dhcpd[4995]: execute_statement argv[2] = pchai7x
Jan 27 17:35:56 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Jan 27 17:35:56 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Jan 27 17:35:56 srv4hai named[30406]: client @0x7f933010ba20 192.168.12.252#56221/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 27 17:35:56 srv4hai named[30406]: client @0x7f932c079890 192.168.12.252#60313/key rndc-key: signer "rndc-key" approved
Jan 27 17:35:56 srv4hai named[30406]: client @0x7f932c079890 192.168.12.252#60313/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Jan 27 17:35:56 srv4hai named[30406]: client @0x7f932c079890 192.168.12.252#60313/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Jan 27 17:35:56 srv4hai named[30406]: client @0x7f932c079890 192.168.12.252#60313/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Jan 27 17:35:56 srv4hai named[30406]: client @0x7f932c079890 192.168.12.252#60313/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Jan 27 17:35:56 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Jan 27 17:35:56 srv4hai dhcpd[4995]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Jan 27 17:35:56 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#59083/key rndc-key: signer "rndc-key" approved
Jan 27 17:35:56 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#59083/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Jan 27 17:35:56 srv4hai named[30406]: client @0x7f932c0cbfc0 192.168.12.252#59083/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.
Jan 27 17:35:56 srv4hai dhcpd[4995]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Jan 27 17:35:56 srv4hai activate_scenario[6028]: SHELLY scenario: 'pcON(pcon)' started
Jan 27 17:35:56 srv4hai activate_scenario[6028]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'
finished