activate_scenario.sh
Wed Jan 22 16:54:03 CET 2025
scenario: buero_UM
source: 192.168.12.140

'night' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'null'

scenario: 'Büro UM-schalten' - 'buero_UM' - 'buero_um'

TB Regallicht (/srv/www/viehai/shelly/log_scenarios/2025/01/22/_0.log)

vorher: 16:54:03.579

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: 16:54:03.616
Dauer: 36 msec phName: 'shelly-40:'TB Licht''


TB Licht (/srv/www/viehai/shelly/log_scenarios/2025/01/22/_1.log)

vorher: 16:54:03.598

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: 16:54:03.674
Dauer: 75 msec phName: 'shelly-40:'TB Licht''


scenario: 'Büro UM-schalten' - 'buero_UM' - 'buero_um'

urls : 2
vorher : 16:54:03.553
nachher: 16:54:03.680
Dauer : 128 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/22//scene_buero_UM_20250122_165403.txt'


syslog

Jan 22 16:51:01 srv4hai CRON[17347]: (root) CMD (/etc/linetest/linetest.sh)
Jan 22 16:51:13 srv4hai common[17353]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 22 16:51:13 srv4hai bt_scan[17353]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Jan 22 16:51:13 srv4hai bt_scan[17353]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Jan 22 16:51:14 srv4hai common[17384]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 22 16:51:14 srv4hai ping_SP[17384]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jan 22 16:51:14 srv4hai common[17405]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 22 16:51:14 srv4hai named[30406]: resolver priming query complete
Jan 22 16:51:14 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'0'=1737561074-1737561074
Jan 22 16:51:14 srv4hai check_presence[17405]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY} and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jan 22 16:51:14 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'0'=1737561074-1737561074
Jan 22 16:51:14 srv4hai check_presence[17405]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Jan 22 16:51:14 srv4hai check_presence[17405]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(__/__) (__/__)' - anyPresent: 'false' - otherPresent:'false'
Jan 22 16:51:14 srv4hai postfix/pickup[13117]: 9AA5663463: uid=33 from=
Jan 22 16:51:14 srv4hai postfix/cleanup[17481]: 9AA5663463: message-id=<20250122155114.9AA5663463@mail.viehai.at>
Jan 22 16:51:14 srv4hai postfix/qmgr[8566]: 9AA5663463: from=, size=16568, nrcpt=1 (queue active)
Jan 22 16:51:14 srv4hai check_presence[17405]: SHELLY - check 'coming': anyPresent(false) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
Jan 22 16:51:14 srv4hai check_presence[17405]: SHELLY (ping_SP__bt_scan)-(0)-coming: NOT activate_scenario.shtml: vorraumOn
Jan 22 16:51:14 srv4hai ping_SP[17384]: SHELLY check_presence.sh coming 0 ping_SP__bt_scan
Jan 22 16:51:14 srv4hai ping_SP[17384]: SHELLY - new process for '192.168.12.61' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1737561074
Jan 22 16:51:16 srv4hai postfix/relay/smtp[17488]: 9AA5663463: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=2, delays=0.03/0.01/1.6/0.35, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 49B8A6017B)
Jan 22 16:51:16 srv4hai postfix/qmgr[8566]: 9AA5663463: removed
Jan 22 16:51:30 srv4hai ping_SP[17384]: SHELLY (0)- ping 192.168.12.61 0 not answered (1) @~1737561090 - 'ping_SP_0'
Jan 22 16:51:57 srv4hai named[30406]: resolver priming query complete
Jan 22 16:51:57 srv4hai ping_SP[17384]: SHELLY (0)- ping 192.168.12.61 1 not answered (1) @~1737561117 - 'ping_SP_0'
Jan 22 16:52:01 srv4hai CRON[17562]: (root) CMD (/etc/linetest/linetest.sh)
Jan 22 16:52:08 srv4hai dhcpd[4995]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Jan 22 16:52:08 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 22 16:52:08 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 22 16:52:08 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 22 16:52:08 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 22 16:52:08 srv4hai common[17569]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 22 16:52:14 srv4hai postfix/anvil[14584]: statistics: max connection rate 1/60s for (smtp:195.178.110.214) at Jan 22 16:46:19
Jan 22 16:52:14 srv4hai postfix/anvil[14584]: statistics: max connection count 1 for (smtp:195.178.110.214) at Jan 22 16:46:19
Jan 22 16:52:14 srv4hai postfix/anvil[14584]: statistics: max cache size 2 at Jan 22 16:48:50
Jan 22 16:52:18 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jan 22 16:52:18 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 22 16:52:18 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 22 16:52:18 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 22 16:52:18 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 22 16:52:18 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 22 16:52:18 srv4hai common[17596]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 22 16:52:19 srv4hai named[30406]: resolver priming query complete
Jan 22 16:52:20 srv4hai named[30406]: resolver priming query complete
Jan 22 16:52:23 srv4hai named[30406]: resolver priming query complete
Jan 22 16:52:23 srv4hai ping_SP[17384]: SHELLY (0)- ping 192.168.12.61 2 not answered (1) @~1737561143 - 'ping_SP_0'
Jan 22 16:52:24 srv4hai named[30406]: resolver priming query complete
Jan 22 16:52:27 srv4hai named[30406]: resolver priming query complete
Jan 22 16:52:28 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jan 22 16:52:28 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 22 16:52:28 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 22 16:52:28 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 22 16:52:28 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 22 16:52:28 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 22 16:52:28 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 22 16:52:28 srv4hai common[17637]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 22 16:52:28 srv4hai named[30406]: resolver priming query complete
Jan 22 16:52:38 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jan 22 16:52:38 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 22 16:52:38 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 22 16:52:38 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Jan 22 16:52:38 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.61
Jan 22 16:52:38 srv4hai dhcpd[4995]: execute_statement argv[2] = fpThomas
Jan 22 16:52:38 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 22 16:52:38 srv4hai named[30406]: client @0x7f932c079890 192.168.12.252#42903/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 22 16:52:38 srv4hai common[17663]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Jan 22 16:52:46 srv4hai ping_SP[17384]: SHELLY (0) - ping 192.168.12.61 3 sucessfully  @~1737561166 - 'ping_SP_0'
Jan 22 16:52:46 srv4hai ping_SP[17384]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 22 16:52:48 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Jan 22 16:52:48 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Jan 22 16:52:48 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: signer "rndc-key" approved
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: signer "rndc-key" approved
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan 22 16:52:48 srv4hai dhcpd[4995]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: signer "rndc-key" approved
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jan 22 16:52:48 srv4hai dhcpd[4995]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: signer "rndc-key" approved
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Jan 22 16:52:48 srv4hai dhcpd[4995]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: signer "rndc-key" approved
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jan 22 16:52:48 srv4hai dhcpd[4995]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Jan 22 16:52:48 srv4hai dhcpd[4995]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: signer "rndc-key" approved
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Jan 22 16:52:48 srv4hai dhcpd[4995]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: signer "rndc-key" approved
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: signer "rndc-key" approved
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Jan 22 16:52:48 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41951/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '61.12.168.192.in-addr.arpa' PTR fpThomas.viehai.at.
Jan 22 16:52:48 srv4hai dhcpd[4995]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jan 22 16:52:48 srv4hai dhcpd[4995]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Jan 22 16:52:58 srv4hai named[30406]: resolver priming query complete
Jan 22 16:53:01 srv4hai CRON[17706]: (root) CMD (/etc/linetest/linetest.sh)
Jan 22 16:53:12 srv4hai mosquitto[29419]: Saving in-memory database to /var/lib/mosquitto/mosquitto.db.
Jan 22 16:53:45 srv4hai mosquitto[29419]: Client shellyplus1-441793a58ae4 has exceeded timeout, disconnecting.
Jan 22 16:53:45 srv4hai mosquitto[29419]: Socket error on client shellyplus1-441793a58ae4, disconnecting.
Jan 22 16:53:58 srv4hai named[30406]: resolver priming query complete
Jan 22 16:53:59 srv4hai ping_SP[17384]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1737561239 - 'ping_SP_0'
Jan 22 16:53:59 srv4hai ping_SP[17384]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 22 16:54:01 srv4hai CRON[17744]: (root) CMD (/etc/linetest/linetest.sh)
Jan 22 16:54:03 srv4hai activate_scenario[17750]: SHELLY last scenario: 'offAll' @ '080120' from 'scene_offAll_20250122_080120.txt' - delta=17
Jan 22 16:54:03 srv4hai activate_scenario[17750]:        dateutils.ddiff -i '%Y%m%d%H%M%s' 20250122165403 20250122080120  -f '%S'
Jan 22 16:54:03 srv4hai activate_scenario[17750]: SHELLY  new scenario: 'buero_UM' different - GO ON
Jan 22 16:54:03 srv4hai activate_scenario[17750]: SHELLY scenario: 'buero_UM(buero_um)' started
Jan 22 16:54:03 srv4hai activate_scenario[17750]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-40:'TB Licht'

finished