activate_scenario.sh
Tue Aug 13 19:19:49 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/08/13/_0.log)

vorher: 19:19:49.300

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: 19:19:49.328
Dauer: 28 msec phName: 'origin:'dhcpcommit.sh-pchai7x''


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

urls : 1
vorher : 19:19:49.271
nachher: 19:19:49.335
Dauer : 64 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/08/13//scene_pcON_20240813_191949.txt'


syslog

Aug 13 19:16:01 srv4hai CRON[17793]: (root) CMD (/etc/linetest/linetest.sh)
Aug 13 19:16:07 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug 13 19:16:07 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug 13 19:16:07 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 13 19:16:07 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug 13 19:16:07 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug 13 19:16:07 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug 13 19:16:07 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 13 19:16:07 srv4hai named[30406]: client @0x7f93300c1420 192.168.12.252#53129/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 13 19:16:07 srv4hai common[17808]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug 13 19:16:09 srv4hai ping_SP[17543]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1723569369 - 'ping_SP_0'
Aug 13 19:16:09 srv4hai ping_SP[17543]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Aug 13 19:16:17 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug 13 19:16:17 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug 13 19:16:17 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: signer "rndc-key" approved
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: signer "rndc-key" approved
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug 13 19:16:17 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: signer "rndc-key" approved
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug 13 19:16:17 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: signer "rndc-key" approved
Aug 13 19:16:17 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' TXT
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' TXT "310ebd0eafccd9c2e311facf8a4b0e4ad2"
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'fpThomas.viehai.at' A
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'fpThomas.viehai.at' A 192.168.12.61
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: signer "rndc-key" approved
Aug 13 19:16:17 srv4hai dhcpd[30731]: Added new forward map from fpThomas.viehai.at to 192.168.12.61
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/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.
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: signer "rndc-key" approved
Aug 13 19:16:17 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/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.
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: signer "rndc-key" approved
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug 13 19:16:17 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/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.
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: signer "rndc-key" approved
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '61.12.168.192.in-addr.arpa' PTR
Aug 13 19:16:17 srv4hai named[30406]: client @0x7f932c04c990 192.168.12.252#57589/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.
Aug 13 19:16:17 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug 13 19:16:17 srv4hai dhcpd[30731]: Added reverse map from 61.12.168.192.in-addr.arpa. to fpThomas.viehai.at
Aug 13 19:16:54 srv4hai postfix/smtpd[17866]: connect from unknown[94.141.120.36]
Aug 13 19:16:54 srv4hai postfix/smtpd[17866]: warning: unknown[94.141.120.36]: SASL LOGIN authentication failed: Invalid authentication mechanism
Aug 13 19:16:54 srv4hai postfix/smtpd[17866]: lost connection after AUTH from unknown[94.141.120.36]
Aug 13 19:16:54 srv4hai postfix/smtpd[17866]: disconnect from unknown[94.141.120.36] ehlo=1 auth=0/1 commands=1/2
Aug 13 19:16:55 srv4hai activate_scenario[17871]: SHELLY scenario: 'buero_UM(buero_um)' started
Aug 13 19:16:55 srv4hai activate_scenario[17871]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'
Aug 13 19:16:55 srv4hai activate_scenario[17871]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'Thomas Büro Licht'
Aug 13 19:16:55 srv4hai postfix/pickup[7564]: C4A936345B: uid=33 from=
Aug 13 19:16:55 srv4hai postfix/cleanup[17668]: C4A936345B: message-id=<20240813171655.C4A936345B@mail.viehai.at>
Aug 13 19:16:55 srv4hai postfix/qmgr[8566]: C4A936345B: from=, size=16654, nrcpt=1 (queue active)
Aug 13 19:16:55 srv4hai postfix/local[17927]: C4A936345B: to=, orig_to=, relay=local, delay=0.03, delays=0.01/0.01/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Aug 13 19:16:55 srv4hai postfix/cleanup[17668]: CA0E763460: message-id=<20240813171655.CA0E763460@mail.viehai.at>
Aug 13 19:16:55 srv4hai postfix/bounce[17934]: C4A936345B: sender non-delivery notification: CA0E763460
Aug 13 19:16:55 srv4hai postfix/qmgr[8566]: CA0E763460: from=<>, size=18576, nrcpt=1 (queue active)
Aug 13 19:16:55 srv4hai postfix/qmgr[8566]: C4A936345B: removed
Aug 13 19:16:55 srv4hai activate_scenario[17871]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Aug 13 19:16:55 srv4hai proc_url[17941]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/13/_0.log' - shellyUsage:'Thomas Büro Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Aug 13 19:16:55 srv4hai postfix/local[17927]: CA0E763460: to=, relay=local, delay=0.02, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Aug 13 19:16:55 srv4hai postfix/qmgr[8566]: CA0E763460: removed
Aug 13 19:16:55 srv4hai activate_scenario[17871]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Aug 13 19:16:55 srv4hai proc_url[17952]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/13/_1.log' - shellyUsage:'Thomas Büro Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'Thomas Büro Licht''
Aug 13 19:16:55 srv4hai activate_scenario[17871]: SHELLY scenario: 'buero_UM(buero_um)' took 85 msec, shelly-40:'Thomas Büro Licht'
Aug 13 19:17:01 srv4hai CRON[17996]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Aug 13 19:17:01 srv4hai CRON[17997]: (root) CMD (/etc/linetest/linetest.sh)
Aug 13 19:17:22 srv4hai ping_SP[17543]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1723569442 - 'ping_SP_0'
Aug 13 19:17:22 srv4hai ping_SP[17543]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Aug 13 19:18:01 srv4hai CRON[18054]: (root) CMD (/etc/linetest/linetest.sh)
Aug 13 19:18:34 srv4hai common[18075]: SHELLY common.sh inkludiert von ./bt_scan.sh
Aug 13 19:18:35 srv4hai ping_SP[17543]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1723569515 - 'ping_SP_0'
Aug 13 19:18:35 srv4hai ping_SP[17543]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Aug 13 19:18:44 srv4hai bt_scan[18075]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Aug 13 19:18:44 srv4hai bt_scan[18075]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Aug 13 19:18:44 srv4hai common[18120]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug 13 19:18:45 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1723569525-1723569515
Aug 13 19:18:45 srv4hai check_presence[18120]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug 13 19:18:45 srv4hai check_presence[18120]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Aug 13 19:18:45 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'10'=1723569525-1723569515
Aug 13 19:18:45 srv4hai check_presence[18120]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Aug 13 19:18:45 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1723569525-1723569515
Aug 13 19:18:45 srv4hai check_presence[18120]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug 13 19:18:45 srv4hai check_presence[18120]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (__/__) (__/__)' - anyPresent: 'true' - otherPresent:'false'
Aug 13 19:18:45 srv4hai check_presence[18120]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_buero_UM) - sceneOFF(offAll)
Aug 13 19:18:45 srv4hai check_presence[18120]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Aug 13 19:19:01 srv4hai CRON[18270]: (root) CMD (/etc/linetest/linetest.sh)
Aug 13 19:19:48 srv4hai ping_SP[17543]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1723569588 - 'ping_SP_0'
Aug 13 19:19:48 srv4hai ping_SP[17543]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Aug 13 19:19:49 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Aug 13 19:19:49 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.10
Aug 13 19:19:49 srv4hai dhcpd[30731]: execute_statement argv[2] = pchai7x
Aug 13 19:19:49 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Aug 13 19:19:49 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Aug 13 19:19:49 srv4hai named[30406]: client @0x7f935063c890 192.168.12.252#58487/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 13 19:19:49 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#40033/key rndc-key: signer "rndc-key" approved
Aug 13 19:19:49 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#40033/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Aug 13 19:19:49 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#40033/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Aug 13 19:19:49 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#40033/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Aug 13 19:19:49 srv4hai named[30406]: client @0x7f9348054f20 192.168.12.252#40033/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Aug 13 19:19:49 srv4hai dhcpd[30731]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Aug 13 19:19:49 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#59481/key rndc-key: signer "rndc-key" approved
Aug 13 19:19:49 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#59481/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Aug 13 19:19:49 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#59481/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.
Aug 13 19:19:49 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Aug 13 19:19:49 srv4hai dhcpd[30731]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Aug 13 19:19:49 srv4hai activate_scenario[18305]: SHELLY scenario: 'pcON(pcon)' started
Aug 13 19:19:49 srv4hai activate_scenario[18305]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'

finished