activate_scenario.sh
Fri Apr 18 11:13:04 CEST 2025
scenario: buero_UM
source: 192.168.12.140
dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as '
-> execution of scenario
scenario: 'Büro UM-schalten' - 'buero_UM' - 'buero_um'
TB Regallicht (/srv/www/viehai/shelly/log_scenarios/2025/04/18/_0.log)
vorher: 11:13:04.714
http://192.168.12.108/relay/0?turn=toggle |
|---|
"ison": true,
"has_timer": false,
"timer_started": 0,
"timer_duration": 0,
"timer_remaining": 0,
"source": "http"
|
nachher: 11:13:04.750
Dauer: 36 msec
phName: 'shelly-40:'TB Licht''
TB Licht (/srv/www/viehai/shelly/log_scenarios/2025/04/18/_1.log)
vorher: 11:13:04.750
http://192.168.12.140/relay/0?turn=toggle |
|---|
"ison": true,
"has_timer": false,
"timer_started": 0,
"timer_duration": 0,
"timer_remaining": 0,
"source": "http"
|
nachher: 11:13:04.785
Dauer: 33 msec
phName: 'shelly-40:'TB Licht''
scenario: 'Büro UM-schalten' - 'buero_UM' - 'buero_um'
urls : 2
vorher : 11:13:04.663
nachher: 11:13:04.797
Dauer : 134 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/04/18//scene_buero_UM_20250418_111304.txt'
syslog
Apr 18 11:10:00 srv4hai mqtt_process[24233]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 18 11:10:02 srv4hai CRON[24260]: (root) CMD (/etc/linetest/linetest.sh)
Apr 18 11:10:02 srv4hai CRON[24261]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Apr 18 11:10:02 srv4hai meter.sh: SHELLY meter.sh started
Apr 18 11:10:02 srv4hai meter.sh: SHELLY 'shelly-29/KÜ Schalter Herdzeile' - type: 'shelly-i3' ignoring
Apr 18 11:10:02 srv4hai check_shelly.sh: SHELLY last scenery executed: 'offAll'
Apr 18 11:10:02 srv4hai check_shelly.sh: SHELLY found '2' active shelly outputs
Apr 18 11:10:02 srv4hai meter.sh: SHELLY meter.sh ended
Apr 18 11:10:02 srv4hai postfix/pickup[19560]: 8C7E863463: uid=33 from=
Apr 18 11:10:02 srv4hai postfix/cleanup[23876]: 8C7E863463: message-id=<20250418091002.8C7E863463@mail.viehai.at>
Apr 18 11:10:02 srv4hai postfix/qmgr[8566]: 8C7E863463: from=, size=663, nrcpt=1 (queue active)
Apr 18 11:10:02 srv4hai postfix/local[23877]: 8C7E863463: to=, orig_to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Apr 18 11:10:02 srv4hai postfix/qmgr[8566]: 8C7E863463: removed
Apr 18 11:10:34 srv4hai mqtt_process[24390]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:10:34 srv4hai mqtt_process[24415]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:10:40 srv4hai kernel: [90945553.380037] CPU1: Package temperature/speed normal
Apr 18 11:10:40 srv4hai kernel: [90945553.380038] CPU6: Package temperature/speed normal
Apr 18 11:10:40 srv4hai kernel: [90945553.380039] CPU4: Package temperature/speed normal
Apr 18 11:10:40 srv4hai kernel: [90945553.380040] CPU2: Package temperature/speed normal
Apr 18 11:10:40 srv4hai kernel: [90945553.380042] CPU7: Package temperature/speed normal
Apr 18 11:10:40 srv4hai kernel: [90945553.380042] CPU5: Package temperature/speed normal
Apr 18 11:10:40 srv4hai kernel: [90945553.380043] CPU0: Package temperature/speed normal
Apr 18 11:10:40 srv4hai kernel: [90945553.380045] CPU3: Package temperature/speed normal
Apr 18 11:11:00 srv4hai mqtt_process[24449]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 18 11:11:00 srv4hai mqtt_process[24474]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:11:00 srv4hai mqtt_process[24499]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:11:01 srv4hai CRON[24525]: (root) CMD (/etc/linetest/linetest.sh)
Apr 18 11:11:09 srv4hai ping_SP[22990]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1744967469 - 'ping_SP_0'
Apr 18 11:11:09 srv4hai ping_SP[22990]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 18 11:11:16 srv4hai bt_scan[24531]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Apr 18 11:11:16 srv4hai bt_scan[24531]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Apr 18 11:11:16 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
Apr 18 11:11:16 srv4hai check_presence[24577]: SHELLY (0) found /srv/www/viehai/shelly/meter/ping_SP_0.LIVE and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_0.No
Apr 18 11:11:16 srv4hai check_presence[24577]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly/meter/ping_SP_0.LIVE' for what: 'presence'
Apr 18 11:11:16 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
Apr 18 11:11:16 srv4hai check_presence[24577]: SHELLY (1) found /srv/www/viehai/shelly/meter/ping_SP_1.DEAD and NO_BTdweet//srv/www/viehai/shelly/meter/BTscan_BTid_1.No
Apr 18 11:11:16 srv4hai check_presence[24577]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Apr 18 11:11:17 srv4hai check_presence[24577]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_offAll) - sceneOFF(offAll)
Apr 18 11:11:17 srv4hai check_presence[24577]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Apr 18 11:11:19 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=24664, secured, session=
Apr 18 11:11:19 srv4hai dovecot: imap(miglincit)<24664>: Logged out in=1913 out=170584 deleted=0 expunged=0 trashed=0 hdr_count=267 hdr_bytes=93753 body_count=0 body_bytes=0
Apr 18 11:11:34 srv4hai mqtt_process[24666]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:11:34 srv4hai mqtt_process[24691]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:11:59 srv4hai mqtt_process[24720]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:11:59 srv4hai mqtt_process[24745]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:12:00 srv4hai mqtt_process[24771]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 18 11:12:01 srv4hai CRON[24797]: (root) CMD (/etc/linetest/linetest.sh)
Apr 18 11:12:04 srv4hai kernel: [90945637.843016] CPU5: Core temperature/speed normal
Apr 18 11:12:04 srv4hai kernel: [90945637.843017] CPU1: Core temperature/speed normal
Apr 18 11:12:22 srv4hai ping_SP[22990]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1744967542 - 'ping_SP_0'
Apr 18 11:12:22 srv4hai ping_SP[22990]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 18 11:12:29 srv4hai bt_scan[24808]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Apr 18 11:12:29 srv4hai bt_scan[24808]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Apr 18 11:12:34 srv4hai mqtt_process[24858]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:12:34 srv4hai mqtt_process[24883]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:12:42 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Apr 18 11:12:42 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.10
Apr 18 11:12:42 srv4hai dhcpd[30231]: execute_statement argv[2] = pchai7x
Apr 18 11:12:42 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Apr 18 11:12:42 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Apr 18 11:12:42 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Apr 18 11:12:42 srv4hai named[30406]: client @0x7f93380b4a40 192.168.12.252#39873/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 18 11:12:42 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57851/key rndc-key: signer "rndc-key" approved
Apr 18 11:12:42 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57851/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Apr 18 11:12:42 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57851/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Apr 18 11:12:42 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57851/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Apr 18 11:12:42 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57851/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Apr 18 11:12:42 srv4hai dhcpd[30231]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Apr 18 11:12:42 srv4hai named[30406]: client @0x7f932c021730 192.168.12.252#54463/key rndc-key: signer "rndc-key" approved
Apr 18 11:12:42 srv4hai named[30406]: client @0x7f932c021730 192.168.12.252#54463/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Apr 18 11:12:42 srv4hai named[30406]: client @0x7f932c021730 192.168.12.252#54463/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 18 11:12:42 srv4hai dhcpd[30231]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Apr 18 11:12:42 srv4hai activate_scenario[24918]: SHELLY scenario: 'pcON(pcon)' started
Apr 18 11:12:42 srv4hai activate_scenario[24918]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - origin:'dhcpcommit.sh-pchai7x'
Apr 18 11:12:42 srv4hai activate_scenario[24918]: SHELLY scenario: 'pcON(pcon)' TO BE EXECUTED, origin:'dhcpcommit.sh-pchai7x'
Apr 18 11:12:42 srv4hai activate_scenario[24918]: SHELLY: scenario: 'pcON(pcon)'-'shelly-20'-'' --> '0?turn=on'
Apr 18 11:12:42 srv4hai proc_url[24974]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/04/18/_0.log' - shellyUsage:'' - scUrl:'http://192.168.12.120/relay/0?turn=on' - phName:'origin:'dhcpcommit.sh-pchai7x''
Apr 18 11:12:42 srv4hai activate_scenario[24918]: SHELLY scenario: 'pcON(pcon)' took 65 msec, origin:'dhcpcommit.sh-pchai7x'
Apr 18 11:12:42 srv4hai dhcpd[30231]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
Apr 18 11:12:42 srv4hai dhcpd[30231]: DHCPDISCOVER from cc:8d:a2:60:52:b8 via enp2s0
Apr 18 11:12:42 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
Apr 18 11:12:44 srv4hai dhcpd[30231]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
Apr 18 11:12:44 srv4hai dhcpd[30231]: DHCPDISCOVER from cc:8d:a2:60:52:b8 via enp2s0
Apr 18 11:12:44 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
Apr 18 11:12:44 srv4hai dhcpd[30231]: uid lease 192.168.12.56 for client cc:8d:a2:60:52:b8 is duplicate on 192.168.12.0/24
Apr 18 11:12:44 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Apr 18 11:12:44 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.101
Apr 18 11:12:44 srv4hai dhcpd[30231]: execute_statement argv[2] = shelly-01
Apr 18 11:12:44 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.101 (192.168.12.252) from cc:8d:a2:60:52:b8 via enp2s0
Apr 18 11:12:44 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.101 to cc:8d:a2:60:52:b8 via enp2s0
Apr 18 11:12:44 srv4hai named[30406]: client @0x7f933001df50 192.168.12.252#51959/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-01.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Apr 18 11:12:44 srv4hai named[30406]: client @0x7f9348072b20 192.168.12.252#54775/key rndc-key: signer "rndc-key" approved
Apr 18 11:12:44 srv4hai named[30406]: client @0x7f9348072b20 192.168.12.252#54775/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' TXT
Apr 18 11:12:44 srv4hai named[30406]: client @0x7f9348072b20 192.168.12.252#54775/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' TXT "31166740fe21d7ece7561d62986d2b8644"
Apr 18 11:12:44 srv4hai named[30406]: client @0x7f9348072b20 192.168.12.252#54775/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-01.viehai.at' A
Apr 18 11:12:44 srv4hai named[30406]: client @0x7f9348072b20 192.168.12.252#54775/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-01.viehai.at' A 192.168.12.101
Apr 18 11:12:44 srv4hai dhcpd[30231]: Added new forward map from shelly-01.viehai.at to 192.168.12.101
Apr 18 11:12:44 srv4hai named[30406]: client @0x7f9350157870 192.168.12.252#59867/key rndc-key: signer "rndc-key" approved
Apr 18 11:12:44 srv4hai named[30406]: client @0x7f9350157870 192.168.12.252#59867/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '101.12.168.192.in-addr.arpa' PTR
Apr 18 11:12:44 srv4hai named[30406]: client @0x7f9350157870 192.168.12.252#59867/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '101.12.168.192.in-addr.arpa' PTR shelly-01.viehai.at.
Apr 18 11:12:44 srv4hai dhcpd[30231]: Added reverse map from 101.12.168.192.in-addr.arpa. to shelly-01.viehai.at
Apr 18 11:12:44 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-01' - shIP/2:'' perform:'conf'
Apr 18 11:12:45 srv4hai mosquitto[29419]: New connection from 192.168.12.101 on port 1883.
Apr 18 11:12:45 srv4hai mosquitto[29419]: Client shelly1minig3-cc8da26052b8 already connected, closing old connection.
Apr 18 11:12:45 srv4hai mosquitto[29419]: Socket error on client shelly1minig3-cc8da26052b8, disconnecting.
Apr 18 11:12:45 srv4hai mosquitto[29419]: New client connected from 192.168.12.101 as shelly1minig3-cc8da26052b8 (c1, k60, u'shmqtt').
Apr 18 11:12:45 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-01' - shIP/2:'192.168.12.101'
Apr 18 11:12:45 srv4hai conf_shelly.sh: SHELLY: usage/name 'WZ Licht Esstisch' already set for '192.168.12.101'
Apr 18 11:12:45 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(0)' - allready transmitted - skipping
Apr 18 11:12:45 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(1)' - allready transmitted - skipping
Apr 18 11:12:45 srv4hai conf_shelly.sh: SHELLY:'shelly-01' 'conf(2)' - allready transmitted - skipping
Apr 18 11:12:45 srv4hai mqtt_process[25054]: SHELLY shMqtt:'shelly1minig3-cc8da26052b8'/'WZ Licht Esstisch' - btn: '{btn}' ignored and discarded !!
Apr 18 11:12:45 srv4hai mqtt_process[25096]: SHELLY shMqtt:'shelly1minig3-cc8da26052b8'/'WZ Licht Esstisch' - btn: '{btn}' ignored and discarded !!
Apr 18 11:13:00 srv4hai mqtt_process[25141]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:13:00 srv4hai mqtt_process[25166]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:13:00 srv4hai mqtt_process[25191]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 18 11:13:01 srv4hai CRON[25219]: (root) CMD (/etc/linetest/linetest.sh)
Apr 18 11:13:04 srv4hai activate_scenario[25225]: SHELLY scenario: 'buero_UM(buero_um)' started
Apr 18 11:13:04 srv4hai activate_scenario[25225]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - shelly-40:'TB Licht'
finished