activate_scenario.sh
Sat May 3 10:41:54 CEST 2025
scenario: pcON
origin: dhcpcommit.sh-pchai7x
dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as '
-> execution of scenario
scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'
(/srv/www/viehai/shelly/log_scenarios/2025/05/03/_0.log)
vorher: 10:41:54.357
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: 10:41:54.386
Dauer: 29 msec
phName: 'origin:'dhcpcommit.sh-pchai7x''
scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'
urls : 1
vorher : 10:41:54.337
nachher: 10:41:54.398
Dauer : 61 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/05/03//scene_pcON_20250503_104154.txt'
syslog
May 3 10:38:00 srv4hai mqtt_process[5001]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May 3 10:38:00 srv4hai mqtt_process[5026]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:38:00 srv4hai mqtt_process[5051]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:38:01 srv4hai CRON[5077]: (root) CMD (/etc/linetest/linetest.sh)
May 3 10:38:03 srv4hai mqtt_process[5082]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:38:03 srv4hai mqtt_process[5107]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:38:07 srv4hai ping_SP[22768]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1746261487 - 'ping_SP_0'
May 3 10:38:07 srv4hai ping_SP[22768]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May 3 10:38:24 srv4hai kernel: [92239632.691892] CPU5: Core temperature above threshold, cpu clock throttled (total events = 892896627)
May 3 10:38:24 srv4hai kernel: [92239632.691893] CPU1: Core temperature above threshold, cpu clock throttled (total events = 892896627)
May 3 10:38:59 srv4hai mqtt_process[5161]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:38:59 srv4hai mqtt_process[5186]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:39:00 srv4hai mqtt_process[5211]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May 3 10:39:00 srv4hai systemd[1]: Starting Clean php session files...
May 3 10:39:00 srv4hai systemd[1]: phpsessionclean.service: Succeeded.
May 3 10:39:00 srv4hai systemd[1]: Started Clean php session files.
May 3 10:39:01 srv4hai CRON[5328]: (root) CMD ( [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi)
May 3 10:39:01 srv4hai CRON[5329]: (root) CMD (/etc/linetest/linetest.sh)
May 3 10:39:03 srv4hai mqtt_process[5334]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:39:03 srv4hai mqtt_process[5359]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:39:04 srv4hai dhcpd[30231]: DHCPDISCOVER from 08:3a:8d:d0:46:5a via enp2s0
May 3 10:39:04 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
May 3 10:39:04 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
May 3 10:39:04 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.5
May 3 10:39:04 srv4hai dhcpd[30231]: execute_statement argv[2] = btscan1
May 3 10:39:04 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.5 (192.168.12.252) from 08:3a:8d:d0:46:5a via enp2s0
May 3 10:39:04 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.5 to 08:3a:8d:d0:46:5a via enp2s0
May 3 10:39:04 srv4hai named[30406]: client @0x7f93506df2d0 192.168.12.252#57037/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: btscan1.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May 3 10:39:04 srv4hai named[30406]: client @0x7f93300d0220 192.168.12.252#49847/key rndc-key: signer "rndc-key" approved
May 3 10:39:04 srv4hai named[30406]: client @0x7f93300d0220 192.168.12.252#49847/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' TXT
May 3 10:39:04 srv4hai named[30406]: client @0x7f93300d0220 192.168.12.252#49847/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' TXT "000118916176265854cff71f762ffe0635"
May 3 10:39:04 srv4hai named[30406]: client @0x7f93300d0220 192.168.12.252#49847/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'btscan1.viehai.at' A
May 3 10:39:04 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.5'(5) device 'btscan1'
May 3 10:39:04 srv4hai named[30406]: client @0x7f93300d0220 192.168.12.252#49847/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'btscan1.viehai.at' A 192.168.12.5
May 3 10:39:04 srv4hai dhcpd[30231]: Added new forward map from btscan1.viehai.at to 192.168.12.5
May 3 10:39:04 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58631/key rndc-key: signer "rndc-key" approved
May 3 10:39:04 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58631/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '5.12.168.192.in-addr.arpa' PTR
May 3 10:39:04 srv4hai named[30406]: client @0x7f9348090720 192.168.12.252#58631/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '5.12.168.192.in-addr.arpa' PTR btscan1.viehai.at.
May 3 10:39:04 srv4hai dhcpd[30231]: Added reverse map from 5.12.168.192.in-addr.arpa. to btscan1.viehai.at
May 3 10:39:04 srv4hai dhcpcommit.sh: SHELLY device 'btscan1' known and accepted
May 3 10:39:07 srv4hai ping_SP[24811]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1746261547 - 'ping_SP_1'
May 3 10:39:07 srv4hai ping_SP[24811]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May 3 10:39:20 srv4hai ping_SP[22768]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1746261560 - 'ping_SP_0'
May 3 10:39:20 srv4hai ping_SP[22768]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May 3 10:39:51 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
May 3 10:39:52 srv4hai fetchmail[1651]: 68935 messages (68935 seen) for tmiglinci at mail.akis.at (1390133884 octets).
May 3 10:39:53 srv4hai fetchmail[1651]: 11901 messages (11901 seen) for srozum at mail.akis.at (1402036552 octets).
May 3 10:39:53 srv4hai fetchmail[1651]: 30735 messages (30735 seen) for mrozum at mail.akis.at (994687964 octets).
May 3 10:39:54 srv4hai fetchmail[1651]: 1169 messages (1169 seen) for admin@bastelstube.wien at pop3.world4you.com (52284237 octets).
May 3 10:39:59 srv4hai mqtt_process[5436]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:39:59 srv4hai mqtt_process[5461]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:40:00 srv4hai mqtt_process[5486]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May 3 10:40:01 srv4hai CRON[5513]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
May 3 10:40:01 srv4hai CRON[5514]: (root) CMD (/etc/linetest/linetest.sh)
May 3 10:40:01 srv4hai meter.sh: SHELLY meter.sh started
May 3 10:40:01 srv4hai meter.sh: SHELLY 'shelly-29/KÜ Schalter Herdzeile' - type: 'shelly-i3' ignoring
May 3 10:40:01 srv4hai check_shelly.sh: SHELLY last scenery executed: 'offAll'
May 3 10:40:01 srv4hai check_shelly.sh: SHELLY found '1' active shelly outputs
May 3 10:40:01 srv4hai meter.sh: SHELLY meter.sh ended
May 3 10:40:01 srv4hai postfix/pickup[22594]: CD8B663463: uid=33 from=
May 3 10:40:01 srv4hai postfix/cleanup[5640]: CD8B663463: message-id=<20250503084001.CD8B663463@mail.viehai.at>
May 3 10:40:01 srv4hai postfix/qmgr[8566]: CD8B663463: from=, size=663, nrcpt=1 (queue active)
May 3 10:40:01 srv4hai postfix/local[5642]: CD8B663463: to=, orig_to=, relay=local, delay=0.04, delays=0.03/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
May 3 10:40:01 srv4hai postfix/qmgr[8566]: CD8B663463: removed
May 3 10:40:03 srv4hai mqtt_process[5645]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:40:03 srv4hai mqtt_process[5670]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:40:20 srv4hai ping_SP[24811]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1746261620 - 'ping_SP_1'
May 3 10:40:20 srv4hai ping_SP[24811]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May 3 10:40:33 srv4hai ping_SP[22768]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1746261633 - 'ping_SP_0'
May 3 10:40:33 srv4hai ping_SP[22768]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May 3 10:40:59 srv4hai mqtt_process[5739]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:40:59 srv4hai mqtt_process[5764]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:41:00 srv4hai mqtt_process[5791]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
May 3 10:41:01 srv4hai CRON[5817]: (root) CMD (/etc/linetest/linetest.sh)
May 3 10:41:03 srv4hai mqtt_process[5822]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:41:03 srv4hai mqtt_process[5847]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
May 3 10:41:33 srv4hai ping_SP[24811]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1746261693 - 'ping_SP_1'
May 3 10:41:33 srv4hai ping_SP[24811]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
May 3 10:41:35 srv4hai dhcpd[30231]: DHCPDISCOVER from 44:17:93:a5:8a:e4 via enp2s0
May 3 10:41:35 srv4hai dhcpd[30231]: DHCPOFFER on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
May 3 10:41:35 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
May 3 10:41:35 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.147
May 3 10:41:35 srv4hai dhcpd[30231]: execute_statement argv[2] = shelly-47
May 3 10:41:35 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.147 (192.168.12.252) from 44:17:93:a5:8a:e4 via enp2s0
May 3 10:41:35 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.147 to 44:17:93:a5:8a:e4 via enp2s0
May 3 10:41:35 srv4hai named[30406]: client @0x7f932c0a6290 192.168.12.252#39315/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-47.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May 3 10:41:35 srv4hai named[30406]: client @0x7f93380e94e0 192.168.12.252#43551/key rndc-key: signer "rndc-key" approved
May 3 10:41:35 srv4hai named[30406]: client @0x7f93380e94e0 192.168.12.252#43551/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' TXT
May 3 10:41:35 srv4hai named[30406]: client @0x7f93380e94e0 192.168.12.252#43551/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' TXT "31f97534415d36e3a13ec57b0310c0867f"
May 3 10:41:35 srv4hai named[30406]: client @0x7f93380e94e0 192.168.12.252#43551/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-47.viehai.at' A
May 3 10:41:35 srv4hai named[30406]: client @0x7f93380e94e0 192.168.12.252#43551/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-47.viehai.at' A 192.168.12.147
May 3 10:41:35 srv4hai dhcpd[30231]: Added new forward map from shelly-47.viehai.at to 192.168.12.147
May 3 10:41:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#47119/key rndc-key: signer "rndc-key" approved
May 3 10:41:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#47119/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '147.12.168.192.in-addr.arpa' PTR
May 3 10:41:35 srv4hai named[30406]: client @0x7f935010f2a0 192.168.12.252#47119/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '147.12.168.192.in-addr.arpa' PTR shelly-47.viehai.at.
May 3 10:41:35 srv4hai dhcpd[30231]: Added reverse map from 147.12.168.192.in-addr.arpa. to shelly-47.viehai.at
May 3 10:41:35 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-47' - shIP/2:'' perform:'conf'
May 3 10:41:36 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-47' - shIP/2:'192.168.12.147'
May 3 10:41:37 srv4hai mosquitto[29419]: New connection from 192.168.12.147 on port 1883.
May 3 10:41:37 srv4hai mosquitto[29419]: New client connected from 192.168.12.147 as shellyplus1-441793a58ae4 (c1, k60, u'shmqtt').
May 3 10:41:37 srv4hai conf_shelly.sh: SHELLY: usage/name 'GB Schreibtischlampe links' already set for '192.168.12.147'
May 3 10:41:37 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(0)' - allready transmitted - skipping
May 3 10:41:37 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(1)' - allready transmitted - skipping
May 3 10:41:37 srv4hai conf_shelly.sh: SHELLY:'shelly-47' 'conf(2)' - allready transmitted - skipping
May 3 10:41:37 srv4hai mqtt_process[5978]: SHELLY - shellyType: 'shelly-1plus' not handled for 'shelly-47'/'GB Schreibtischlampe links'!!
May 3 10:41:37 srv4hai mqtt_process[6003]: SHELLY - shellyType: 'shelly-1plus' not handled for 'shelly-47'/'GB Schreibtischlampe links'!!
May 3 10:41:38 srv4hai activate_scenario[6029]: SHELLY scenario: 'buero_UM(buero_um)' started
May 3 10:41:38 srv4hai activate_scenario[6029]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - shelly-40:'TB Licht'
May 3 10:41:38 srv4hai activate_scenario[6029]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'TB Licht'
May 3 10:41:38 srv4hai activate_scenario[6029]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'TB Regallicht' --> '0?turn=toggle'
May 3 10:41:38 srv4hai proc_url[6105]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/05/03/_0.log' - shellyUsage:'TB Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
May 3 10:41:38 srv4hai activate_scenario[6029]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'TB Licht' --> '0?turn=toggle'
May 3 10:41:38 srv4hai proc_url[6116]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/05/03/_1.log' - shellyUsage:'TB Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
May 3 10:41:38 srv4hai activate_scenario[6029]: SHELLY scenario: 'buero_UM(buero_um)' took 162 msec, shelly-40:'TB Licht'
May 3 10:41:46 srv4hai ping_SP[22768]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1746261706 - 'ping_SP_0'
May 3 10:41:46 srv4hai ping_SP[22768]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May 3 10:41:54 srv4hai dhcpd[30231]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
May 3 10:41:54 srv4hai dhcpd[30231]: execute_statement argv[1] = 192.168.12.10
May 3 10:41:54 srv4hai dhcpd[30231]: execute_statement argv[2] = pchai7x
May 3 10:41:54 srv4hai dhcpd[30231]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
May 3 10:41:54 srv4hai dhcpd[30231]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
May 3 10:41:54 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#52521/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
May 3 10:41:54 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
May 3 10:41:54 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#33461/key rndc-key: signer "rndc-key" approved
May 3 10:41:54 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#33461/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
May 3 10:41:54 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#33461/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
May 3 10:41:54 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#33461/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
May 3 10:41:54 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#33461/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
May 3 10:41:54 srv4hai dhcpd[30231]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
May 3 10:41:54 srv4hai named[30406]: client @0x7f933805ba90 192.168.12.252#43995/key rndc-key: signer "rndc-key" approved
May 3 10:41:54 srv4hai named[30406]: client @0x7f933805ba90 192.168.12.252#43995/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
May 3 10:41:54 srv4hai named[30406]: client @0x7f933805ba90 192.168.12.252#43995/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.
May 3 10:41:54 srv4hai dhcpd[30231]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
May 3 10:41:54 srv4hai activate_scenario[6178]: SHELLY scenario: 'pcON(pcon)' started
May 3 10:41:54 srv4hai activate_scenario[6178]: SHELLY dayState='day' <--> DayTime='checked' NightTime='checked' flag 'execute* set as ' - origin:'dhcpcommit.sh-pchai7x'
finished