activate_scenario.sh
Sun Apr 13 16:48:16 CEST 2025
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'
TB Schreibtischlampe (/srv/www/viehai/shelly/log_scenarios/2025/04/13/_0.log)
vorher: 16:48:16.597
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:48:16.647
Dauer: 50 msec
phName: 'origin:'dhcpcommit.sh-pchai7x''
scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'
urls : 1
vorher : 16:48:16.547
nachher: 16:48:16.660
Dauer : 112 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/04/13//scene_pcON_20250413_164816.txt'
syslog
Apr 13 16:45:00 srv4hai mqtt_process[21832]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:45:00 srv4hai mqtt_process[21857]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:45:00 srv4hai mqtt_process[21882]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 13 16:45:00 srv4hai smartd[27489]: Device: /dev/sda [SAT], SMART Usage Attribute: 194 Temperature_Celsius changed from 41 to 40
Apr 13 16:45:01 srv4hai CRON[21908]: (root) CMD (/etc/linetest/linetest.sh)
Apr 13 16:45:09 srv4hai kernel: [90533617.573855] CPU6: Package temperature/speed normal
Apr 13 16:45:09 srv4hai kernel: [90533617.573857] CPU1: Package temperature/speed normal
Apr 13 16:45:09 srv4hai kernel: [90533617.573858] CPU4: Package temperature/speed normal
Apr 13 16:45:09 srv4hai kernel: [90533617.573859] CPU3: Package temperature/speed normal
Apr 13 16:45:09 srv4hai kernel: [90533617.573861] CPU5: Package temperature/speed normal
Apr 13 16:45:09 srv4hai kernel: [90533617.573862] CPU7: Package temperature/speed normal
Apr 13 16:45:09 srv4hai kernel: [90533617.573862] CPU0: Package temperature/speed normal
Apr 13 16:45:09 srv4hai kernel: [90533617.573863] CPU2: Package temperature/speed normal
Apr 13 16:45:17 srv4hai ping_SP[11898]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1744555517 - 'ping_SP_1'
Apr 13 16:45:17 srv4hai ping_SP[11898]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 13 16:45:25 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=21936, secured, session=
Apr 13 16:45:25 srv4hai dovecot: imap(miglincit)<21936>: Logged out in=137 out=1089 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Apr 13 16:45:43 srv4hai ping_SP[7988]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1744555543 - 'ping_SP_0'
Apr 13 16:45:43 srv4hai ping_SP[7988]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 13 16:45:44 srv4hai mqtt_process[21961]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:45:44 srv4hai mqtt_process[21986]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:46:00 srv4hai mqtt_process[22016]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 13 16:46:00 srv4hai mqtt_process[22041]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:46:00 srv4hai mqtt_process[22066]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:46:01 srv4hai CRON[22092]: (root) CMD (/etc/linetest/linetest.sh)
Apr 13 16:46:31 srv4hai ping_SP[11898]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1744555591 - 'ping_SP_1'
Apr 13 16:46:31 srv4hai ping_SP[11898]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 13 16:46:35 srv4hai kernel: [90533703.890905] CPU5: Core temperature/speed normal
Apr 13 16:46:35 srv4hai kernel: [90533703.890906] CPU1: Core temperature/speed normal
Apr 13 16:46:44 srv4hai mqtt_process[22127]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:46:44 srv4hai mqtt_process[22152]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:46:57 srv4hai ping_SP[7988]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1744555617 - 'ping_SP_0'
Apr 13 16:46:57 srv4hai ping_SP[7988]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 13 16:46:59 srv4hai mqtt_process[22195]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:46:59 srv4hai mqtt_process[22220]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:47:00 srv4hai mqtt_process[22245]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 13 16:47:01 srv4hai CRON[22271]: (root) CMD (/etc/linetest/linetest.sh)
Apr 13 16:47:12 srv4hai bt_scan[22277]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Apr 13 16:47:12 srv4hai bt_scan[22277]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Apr 13 16:47:44 srv4hai mqtt_process[22326]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:47:44 srv4hai mqtt_process[22351]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:47:44 srv4hai ping_SP[11898]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1744555664 - 'ping_SP_1'
Apr 13 16:47:44 srv4hai ping_SP[11898]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Apr 13 16:47:46 srv4hai named[30406]: resolver priming query complete
Apr 13 16:47:46 srv4hai postfix/anvil[21758]: statistics: max connection rate 1/60s for (smtp:176.65.140.116) at Apr 13 16:44:26
Apr 13 16:47:46 srv4hai postfix/anvil[21758]: statistics: max connection count 1 for (smtp:176.65.140.116) at Apr 13 16:44:26
Apr 13 16:47:46 srv4hai postfix/anvil[21758]: statistics: max cache size 1 at Apr 13 16:44:26
Apr 13 16:47:47 srv4hai named[30406]: resolver priming query complete
Apr 13 16:47:47 srv4hai activate_scenario[22391]: SHELLY scenario: 'buero_UM(buero_um)' started
Apr 13 16:47:47 srv4hai activate_scenario[22391]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'TB Licht'
Apr 13 16:47:47 srv4hai activate_scenario[22391]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'TB Licht'
Apr 13 16:47:47 srv4hai postfix/pickup[2792]: 9966063463: uid=33 from=
Apr 13 16:47:47 srv4hai postfix/cleanup[22445]: 9966063463: message-id=<20250413144747.9966063463@mail.viehai.at>
Apr 13 16:47:47 srv4hai postfix/qmgr[8566]: 9966063463: from=, size=8747, nrcpt=1 (queue active)
Apr 13 16:47:47 srv4hai postfix/local[22458]: 9966063463: to=, orig_to=, relay=local, delay=0.06, delays=0.03/0.01/0/0.02, dsn=5.1.1, status=bounced (unknown user: "null")
Apr 13 16:47:47 srv4hai postfix/cleanup[22445]: A5B1A63464: message-id=<20250413144747.A5B1A63464@mail.viehai.at>
Apr 13 16:47:47 srv4hai activate_scenario[22391]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'TB Regallicht' --> '0?turn=toggle'
Apr 13 16:47:47 srv4hai postfix/bounce[22459]: 9966063463: sender non-delivery notification: A5B1A63464
Apr 13 16:47:47 srv4hai postfix/qmgr[8566]: A5B1A63464: from=<>, size=10629, nrcpt=1 (queue active)
Apr 13 16:47:47 srv4hai postfix/qmgr[8566]: 9966063463: removed
Apr 13 16:47:47 srv4hai proc_url[22464]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/04/13/_0.log' - shellyUsage:'TB Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
Apr 13 16:47:47 srv4hai postfix/local[22458]: A5B1A63464: to=, relay=local, delay=0.02, delays=0.01/0/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Apr 13 16:47:47 srv4hai postfix/qmgr[8566]: A5B1A63464: removed
Apr 13 16:47:47 srv4hai activate_scenario[22391]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'TB Licht' --> '0?turn=toggle'
Apr 13 16:47:47 srv4hai proc_url[22485]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/04/13/_1.log' - shellyUsage:'TB Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
Apr 13 16:47:47 srv4hai check_shelly.sh: SHELLY last scenery executed: ''
Apr 13 16:47:47 srv4hai check_shelly.sh: SHELLY found '3' active shelly outputs
Apr 13 16:47:47 srv4hai activate_scenario[22391]: SHELLY scenario: 'buero_UM(buero_um)' took 252 msec, shelly-40:'TB Licht'
Apr 13 16:47:47 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
Apr 13 16:47:47 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
Apr 13 16:47:50 srv4hai named[30406]: resolver priming query complete
Apr 13 16:47:51 srv4hai named[30406]: resolver priming query complete
Apr 13 16:47:52 srv4hai named[30406]: resolver priming query complete
Apr 13 16:48:00 srv4hai mqtt_process[22572]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 13 16:48:00 srv4hai mqtt_process[22600]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:48:00 srv4hai mqtt_process[22625]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 13 16:48:01 srv4hai CRON[22651]: (root) CMD (/etc/linetest/linetest.sh)
Apr 13 16:48:10 srv4hai ping_SP[7988]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1744555690 - 'ping_SP_0'
Apr 13 16:48:10 srv4hai ping_SP[7988]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 13 16:48:16 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Apr 13 16:48:16 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.10
Apr 13 16:48:16 srv4hai dhcpd[30231]: execute_statement argv[2] = pchai7x
Apr 13 16:48:16 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Apr 13 16:48:16 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Apr 13 16:48:16 srv4hai named[30406]: client @0x7f932c012aa0 192.168.12.252#48115/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 13 16:48:16 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Apr 13 16:48:16 srv4hai named[30406]: client @0x7f932c0ce020 192.168.12.252#45971/key rndc-key: signer "rndc-key" approved
Apr 13 16:48:16 srv4hai named[30406]: client @0x7f932c0ce020 192.168.12.252#45971/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Apr 13 16:48:16 srv4hai named[30406]: client @0x7f932c0ce020 192.168.12.252#45971/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Apr 13 16:48:16 srv4hai named[30406]: client @0x7f932c0ce020 192.168.12.252#45971/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Apr 13 16:48:16 srv4hai named[30406]: client @0x7f932c0ce020 192.168.12.252#45971/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Apr 13 16:48:16 srv4hai dhcpd[30231]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Apr 13 16:48:16 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#44007/key rndc-key: signer "rndc-key" approved
Apr 13 16:48:16 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#44007/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Apr 13 16:48:16 srv4hai named[30406]: client @0x7f931c058e00 192.168.12.252#44007/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.
Apr 13 16:48:16 srv4hai dhcpd[30231]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Apr 13 16:48:16 srv4hai activate_scenario[22682]: SHELLY scenario: 'pcON(pcon)' started
Apr 13 16:48:16 srv4hai activate_scenario[22682]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'
finished