activate_scenario.sh
Tue Sep 17 09:20:05 CEST 2024
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'

Thomas Schreibtischlampe (/srv/www/viehai/shelly/log_scenarios/2024/09/17/_0.log)

vorher: 09:20:05.693

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: 09:20:05.826
Dauer: 133 msec phName: 'origin:'dhcpcommit.sh-pchai7x''


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

urls : 1
vorher : 09:20:05.668
nachher: 09:20:05.832
Dauer : 165 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/09/17//scene_pcON_20240917_092005.txt'


syslog

Sep 17 09:17:01 srv4hai CRON[11794]: (root) CMD (/etc/linetest/linetest.sh)
Sep 17 09:17:01 srv4hai CRON[11795]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Sep 17 09:17:16 srv4hai common[11810]: SHELLY common.sh inkludiert von ./bt_scan.sh
Sep 17 09:17:16 srv4hai bt_scan[11810]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Sep 17 09:17:16 srv4hai bt_scan[11810]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Sep 17 09:17:16 srv4hai common[11841]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Sep 17 09:17:16 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'0'=1726557436-1726557436
Sep 17 09:17:16 srv4hai check_presence[11841]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Sep 17 09:17:16 srv4hai check_presence[11841]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Sep 17 09:17:16 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'0'=1726557436-1726557436
Sep 17 09:17:16 srv4hai check_presence[11841]: 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
Sep 17 09:17:16 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_not_set' dweetAge:'0'=1726557436-1726557436
Sep 17 09:17:16 srv4hai check_presence[11841]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Sep 17 09:17:16 srv4hai check_presence[11841]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Sep 17 09:17:16 srv4hai check_presence[11841]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_vorraumOn) - sceneOFF(offAll)
Sep 17 09:17:16 srv4hai check_presence[11841]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Sep 17 09:17:38 srv4hai ping_SP[27352]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1726557458 - 'ping_SP_0'
Sep 17 09:17:38 srv4hai ping_SP[27352]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Sep 17 09:18:01 srv4hai CRON[12016]: (root) CMD (/etc/linetest/linetest.sh)
Sep 17 09:18:21 srv4hai mosquitto[18551]: Saving in-memory database to /var/lib/mosquitto/mosquitto.db.
Sep 17 09:18:41 srv4hai ping_SP[27352]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1726557521 - 'ping_SP_0'
Sep 17 09:18:41 srv4hai ping_SP[27352]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Sep 17 09:19:00 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Sep 17 09:19:00 srv4hai fetchmail[1651]: 52483 messages (52482 seen) for tmiglinci at mail.akis.at (21604653 octets).
Sep 17 09:19:01 srv4hai postfix/smtpd[12071]: connect from localhost[127.0.0.1]
Sep 17 09:19:01 srv4hai postfix/smtpd[12071]: 1118E6345A: client=localhost[127.0.0.1]
Sep 17 09:19:01 srv4hai postfix/cleanup[12074]: 1118E6345A: message-id=<01020191fed71cdc-8febad11-ce36-466b-9b25-bf287e29eb80-000000@eu-west-1.amazonses.com>
Sep 17 09:19:01 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:52483 of 52483 (77080 octets) not flushed
Sep 17 09:19:01 srv4hai postfix/qmgr[8566]: 1118E6345A: from=, size=77308, nrcpt=1 (queue active)
Sep 17 09:19:01 srv4hai postfix/smtpd[12071]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Sep 17 09:19:01 srv4hai postfix/local[12075]: 1118E6345A: to=, relay=local, delay=0.11, delays=0.08/0.02/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Sep 17 09:19:01 srv4hai postfix/qmgr[8566]: 1118E6345A: removed
Sep 17 09:19:01 srv4hai fetchmail[1651]: 10728 messages (10728 seen) for srozum at mail.akis.at (1302329459 octets).
Sep 17 09:19:01 srv4hai CRON[12078]: (root) CMD (/etc/linetest/linetest.sh)
Sep 17 09:19:02 srv4hai fetchmail[1651]: 25966 messages (25965 seen) for mrozum at mail.akis.at (220835216 octets).
Sep 17 09:19:02 srv4hai postfix/smtpd[12071]: connect from localhost[127.0.0.1]
Sep 17 09:19:02 srv4hai postfix/smtpd[12071]: 5A8FC6345A: client=localhost[127.0.0.1]
Sep 17 09:19:02 srv4hai postfix/cleanup[12074]: 5A8FC6345A: message-id=<4AFEEFF8-89A9-4A57-AAC9-AF21BDA3F971@gmail.com>
Sep 17 09:19:02 srv4hai fetchmail[1651]: reading message mrozum@mail.akis.at:25966 of 25966 (18538 octets) not flushed
Sep 17 09:19:02 srv4hai postfix/qmgr[8566]: 5A8FC6345A: from=, size=18818, nrcpt=1 (queue active)
Sep 17 09:19:02 srv4hai postfix/local[12075]: 5A8FC6345A: to=, relay=local, delay=0.07, delays=0.05/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Sep 17 09:19:02 srv4hai postfix/qmgr[8566]: 5A8FC6345A: removed
Sep 17 09:19:02 srv4hai postfix/smtpd[12071]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Sep 17 09:19:02 srv4hai fetchmail[1651]: 1143 messages (1143 seen) for admin@bastelstube.wien at pop3.world4you.com (51639660 octets).
Sep 17 09:19:28 srv4hai common[12101]: SHELLY common.sh inkludiert von ./bt_scan.sh
Sep 17 09:19:28 srv4hai bt_scan[12101]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Sep 17 09:19:28 srv4hai bt_scan[12101]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Sep 17 09:19:45 srv4hai ping_SP[27352]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1726557585 - 'ping_SP_0'
Sep 17 09:19:45 srv4hai ping_SP[27352]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Sep 17 09:19:53 srv4hai activate_scenario[12165]: SHELLY scenario: 'buero_UM(buero_um)' started
Sep 17 09:19:53 srv4hai activate_scenario[12165]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'
Sep 17 09:19:53 srv4hai activate_scenario[12165]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'Thomas Büro Licht'
Sep 17 09:19:53 srv4hai postfix/pickup[29232]: 7121863463: uid=33 from=
Sep 17 09:19:53 srv4hai postfix/cleanup[12074]: 7121863463: message-id=<20240917071953.7121863463@mail.viehai.at>
Sep 17 09:19:53 srv4hai postfix/qmgr[8566]: 7121863463: from=, size=7442, nrcpt=1 (queue active)
Sep 17 09:19:53 srv4hai postfix/local[12075]: 7121863463: to=, orig_to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Sep 17 09:19:53 srv4hai postfix/cleanup[12074]: 755C963464: message-id=<20240917071953.755C963464@mail.viehai.at>
Sep 17 09:19:53 srv4hai postfix/bounce[12222]: 7121863463: sender non-delivery notification: 755C963464
Sep 17 09:19:53 srv4hai postfix/qmgr[8566]: 755C963464: from=<>, size=9364, nrcpt=1 (queue active)
Sep 17 09:19:53 srv4hai postfix/qmgr[8566]: 7121863463: removed
Sep 17 09:19:53 srv4hai activate_scenario[12165]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Sep 17 09:19:53 srv4hai proc_url[12235]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/09/17/_0.log' - shellyUsage:'Thomas Büro Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Sep 17 09:19:53 srv4hai postfix/local[12075]: 755C963464: to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Sep 17 09:19:53 srv4hai postfix/qmgr[8566]: 755C963464: removed
Sep 17 09:19:53 srv4hai activate_scenario[12165]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Sep 17 09:19:53 srv4hai proc_url[12246]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/09/17/_1.log' - shellyUsage:'Thomas Büro Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Sep 17 09:19:53 srv4hai activate_scenario[12165]: SHELLY scenario: 'buero_UM(buero_um)' took 80 msec, shelly-40:'Thomas Büro Licht'
Sep 17 09:20:01 srv4hai CRON[12291]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh)
Sep 17 09:20:01 srv4hai CRON[12290]: (root) CMD (/etc/linetest/linetest.sh)
Sep 17 09:20:01 srv4hai common[12293]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/meter.sh
Sep 17 09:20:01 srv4hai meter.sh: SHELLY meter.sh started
Sep 17 09:20:02 srv4hai meter.sh: SHELLY 'shelly-29/Schalter Herdzeile' - type: 'shelly-i3' ignoring
Sep 17 09:20:02 srv4hai meter.sh: SHELLY 'shelly-28/Schalter Nasszeile' - type: 'shelly-i3' ignoring
Sep 17 09:20:05 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Sep 17 09:20:05 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.10
Sep 17 09:20:05 srv4hai dhcpd[30731]: execute_statement argv[2] = pchai7x
Sep 17 09:20:05 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Sep 17 09:20:05 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Sep 17 09:20:05 srv4hai named[30406]: client @0x7f931c076a00 192.168.12.252#57071/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Sep 17 09:20:05 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41299/key rndc-key: signer "rndc-key" approved
Sep 17 09:20:05 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41299/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Sep 17 09:20:05 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41299/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Sep 17 09:20:05 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41299/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Sep 17 09:20:05 srv4hai named[30406]: client @0x7f9338022410 192.168.12.252#41299/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Sep 17 09:20:05 srv4hai dhcpd[30731]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Sep 17 09:20:05 srv4hai named[30406]: client @0x7f932c012aa0 192.168.12.252#41031/key rndc-key: signer "rndc-key" approved
Sep 17 09:20:05 srv4hai named[30406]: client @0x7f932c012aa0 192.168.12.252#41031/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Sep 17 09:20:05 srv4hai named[30406]: client @0x7f932c012aa0 192.168.12.252#41031/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.
Sep 17 09:20:05 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Sep 17 09:20:05 srv4hai dhcpd[30731]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Sep 17 09:20:05 srv4hai activate_scenario[12756]: SHELLY scenario: 'pcON(pcon)' started
Sep 17 09:20:05 srv4hai activate_scenario[12756]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'

finished