activate_scenario.sh
Fri Apr 18 11:12:42 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/04/18/_0.log)

vorher: 11:12:42.137

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: 11:12:42.168
Dauer: 30 msec phName: 'origin:'dhcpcommit.sh-pchai7x''


scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'

urls : 1
vorher : 11:12:42.116
nachher: 11:12:42.185
Dauer : 65 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/04/18//scene_pcON_20250418_111242.txt'


syslog

Apr 18 11:09:00 srv4hai mqtt_process[23880]: SHELLY - shellyType: 'shelly-PM-mini' not handled for 'shelly-49'/'49-TBD'!!
Apr 18 11:09:00 srv4hai mqtt_process[23905]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:09:00 srv4hai mqtt_process[23944]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:09:00 srv4hai check_shelly.sh: SHELLY last scenery executed: 'offAll'
Apr 18 11:09:00 srv4hai check_shelly.sh: SHELLY found '2' active shelly outputs
Apr 18 11:09:00 srv4hai common.sh: SHELLY: BTstatus[0]:'NO_BTdweet' dweetAge:''=-
Apr 18 11:09:00 srv4hai common.sh: SHELLY: BTstatus[1]:'NO_BTdweet' dweetAge:''=-
Apr 18 11:09:01 srv4hai CRON[24012]: (root) CMD (  [ -x /usr/lib/php/sessionclean ] && if [ ! -d /run/systemd/system ]; then /usr/lib/php/sessionclean; fi)
Apr 18 11:09:01 srv4hai CRON[24013]: (root) CMD (/etc/linetest/linetest.sh)
Apr 18 11:09:01 srv4hai systemd[1]: Starting Clean php session files...
Apr 18 11:09:02 srv4hai systemd[1]: phpsessionclean.service: Succeeded.
Apr 18 11:09:02 srv4hai systemd[1]: Started Clean php session files.
Apr 18 11:09:16 srv4hai named[30406]: validating cdn.mie.exponea.com/A: no valid signature found
Apr 18 11:09:34 srv4hai mqtt_process[24112]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:09:34 srv4hai mqtt_process[24137]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:09:56 srv4hai ping_SP[22990]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1744967396 - 'ping_SP_0'
Apr 18 11:09:56 srv4hai ping_SP[22990]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Apr 18 11:09:59 srv4hai mqtt_process[24183]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
Apr 18 11:09:59 srv4hai mqtt_process[24208]: SHELLY - shellyType: 'shelly-2PM' not handled for 'shelly-45'/'45-TBD'!!
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'

finished