activate_scenario.sh
Thu Sep 12 22:16:03 CEST 2024
scenario: bedlight_tom
source: 192.168.12.112

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

scenario: 'Nachttischlampe Thomas UM-schalten' - 'bedlight_tom' - 'bedlight_tom'

Nachtkästchen Lampe Thomas (/srv/www/viehai/shelly/log_scenarios/2024/09/12/_0.log)

vorher: 22:16:03.688

http://192.168.12.107/relay/0?turn=toggle
  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "source": "http"

nachher: 22:16:03.722
Dauer: 34 msec phName: 'shelly-12:'Schlafzimmer Licht''


scenario: 'Nachttischlampe Thomas UM-schalten' - 'bedlight_tom' - 'bedlight_tom'

urls : 1
vorher : 22:16:03.665
nachher: 22:16:03.729
Dauer : 63 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/09/12//scene_bedlight_tom_20240912_221603.txt'


syslog

Sep 12 22:13:01 srv4hai CRON[6164]: (root) CMD (/etc/linetest/linetest.sh)
Sep 12 22:13:13 srv4hai ping_SP[29963]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1726171993 - 'ping_SP_1'
Sep 12 22:13:13 srv4hai ping_SP[29963]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Sep 12 22:13:55 srv4hai ping_SP[2558]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1726172035 - 'ping_SP_0'
Sep 12 22:13:55 srv4hai ping_SP[2558]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Sep 12 22:14:01 srv4hai CRON[6228]: (root) CMD (/etc/linetest/linetest.sh)
Sep 12 22:14:12 srv4hai common[6235]: SHELLY common.sh inkludiert von ./bt_scan.sh
Sep 12 22:14:22 srv4hai bt_scan[6235]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Sep 12 22:14:22 srv4hai bt_scan[6235]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61'
Sep 12 22:14:27 srv4hai ping_SP[29963]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1726172067 - 'ping_SP_1'
Sep 12 22:14:27 srv4hai ping_SP[29963]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Sep 12 22:14:47 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=6300, secured, session=
Sep 12 22:14:47 srv4hai dovecot: imap(miglincit)<6300>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Sep 12 22:14:47 srv4hai mosquitto[18551]: Saving in-memory database to /var/lib/mosquitto/mosquitto.db.
Sep 12 22:15:00 srv4hai smartd[27489]: Device: /dev/sda [SAT], SMART Usage Attribute: 194 Temperature_Celsius changed from 52 to 51
Sep 12 22:15:01 srv4hai CRON[6313]: (root) CMD (/etc/linetest/linetest.sh)
Sep 12 22:15:03 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Sep 12 22:15:03 srv4hai fetchmail[1651]: 52193 messages (52193 seen) for tmiglinci at mail.akis.at (733035 octets).
Sep 12 22:15:04 srv4hai fetchmail[1651]: 10715 messages (10715 seen) for srozum at mail.akis.at (1301269243 octets).
Sep 12 22:15:04 srv4hai fetchmail[1651]: 25870 messages (25869 seen) for mrozum at mail.akis.at (205172708 octets).
Sep 12 22:15:04 srv4hai postfix/smtpd[6320]: connect from localhost[127.0.0.1]
Sep 12 22:15:04 srv4hai postfix/smtpd[6320]: F01906000F: client=localhost[127.0.0.1]
Sep 12 22:15:04 srv4hai postfix/cleanup[6323]: F01906000F: message-id=<000901db0550$33fe2da0$9bfa88e0$@wlsv.at>
Sep 12 22:15:05 srv4hai fetchmail[1651]: reading message mrozum@mail.akis.at:25870 of 25870 (618560 octets) not flushed
Sep 12 22:15:05 srv4hai postfix/qmgr[8566]: F01906000F: from=, size=618847, nrcpt=1 (queue active)
Sep 12 22:15:05 srv4hai postfix/smtpd[6320]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Sep 12 22:15:05 srv4hai postfix/local[6324]: F01906000F: to=, relay=local, delay=0.26, delays=0.23/0.01/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Sep 12 22:15:05 srv4hai postfix/qmgr[8566]: F01906000F: removed
Sep 12 22:15:05 srv4hai fetchmail[1651]: 1143 messages (1143 seen) for admin@bastelstube.wien at pop3.world4you.com (51639660 octets).
Sep 12 22:15:08 srv4hai ping_SP[2558]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1726172108 - 'ping_SP_0'
Sep 12 22:15:08 srv4hai ping_SP[2558]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Sep 12 22:15:08 srv4hai activate_scenario[6343]: SHELLY scenario: 'nasszeile_um(nasszeile_um)' started
Sep 12 22:15:08 srv4hai activate_scenario[6343]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-28:'Schalter Nasszeile'
Sep 12 22:15:08 srv4hai activate_scenario[6343]: SHELLY scenario: 'nasszeile_um(nasszeile_um)' TO BE EXECUTED, shelly-28:'Schalter Nasszeile'
Sep 12 22:15:08 srv4hai postfix/pickup[26854]: A71C36345B: uid=33 from=
Sep 12 22:15:08 srv4hai postfix/cleanup[6323]: A71C36345B: message-id=<20240912201508.A71C36345B@mail.viehai.at>
Sep 12 22:15:08 srv4hai postfix/qmgr[8566]: A71C36345B: from=, size=5463, nrcpt=1 (queue active)
Sep 12 22:15:08 srv4hai postfix/local[6324]: A71C36345B: to=, orig_to=, relay=local, delay=0.04, delays=0.01/0/0/0.03, dsn=5.1.1, status=bounced (unknown user: "null")
Sep 12 22:15:08 srv4hai postfix/cleanup[6323]: AFF7D6345C: message-id=<20240912201508.AFF7D6345C@mail.viehai.at>
Sep 12 22:15:08 srv4hai postfix/bounce[6399]: A71C36345B: sender non-delivery notification: AFF7D6345C
Sep 12 22:15:08 srv4hai postfix/qmgr[8566]: AFF7D6345C: from=<>, size=7345, nrcpt=1 (queue active)
Sep 12 22:15:08 srv4hai postfix/qmgr[8566]: A71C36345B: removed
Sep 12 22:15:08 srv4hai postfix/local[6324]: AFF7D6345C: to=, relay=local, delay=0.02, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Sep 12 22:15:08 srv4hai postfix/qmgr[8566]: AFF7D6345C: removed
Sep 12 22:15:08 srv4hai activate_scenario[6343]: SHELLY: scenario: 'nasszeile_um(nasszeile_um)'-'shelly-16'-'Küche Licht Naßzeile' --> '0?turn=toggle&brightness=25'
Sep 12 22:15:08 srv4hai proc_url[6412]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/09/12/_0.log' - shellyUsage:'Küche Licht Naßzeile' - scUrl:'http://192.168.12.116/white/0?turn=toggle&brightness=25' - phName:'shelly-28:'Schalter Nasszeile''
Sep 12 22:15:08 srv4hai activate_scenario[6343]: SHELLY: scenario: 'nasszeile_um(nasszeile_um)'-'shelly-16'-'Küche Licht Naßzeile' --> '1?turn=toggle&brightness=25'
Sep 12 22:15:08 srv4hai proc_url[6423]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/09/12/_1.log' - shellyUsage:'Küche Licht Naßzeile' - scUrl:'http://192.168.12.116/white/1?turn=toggle&brightness=25' - phName:'shelly-28:'Schalter Nasszeile''
Sep 12 22:15:08 srv4hai activate_scenario[6343]: SHELLY scenario: 'nasszeile_um(nasszeile_um)' took 168 msec, shelly-28:'Schalter Nasszeile'
Sep 12 22:15:12 srv4hai activate_scenario[6464]: SHELLY scenario: 'nasszeile_um(nasszeile_um)' started
Sep 12 22:15:12 srv4hai activate_scenario[6464]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-28:'Schalter Nasszeile'
Sep 12 22:15:12 srv4hai activate_scenario[6464]: SHELLY scenario: 'nasszeile_um(nasszeile_um)' TO BE EXECUTED, shelly-28:'Schalter Nasszeile'
Sep 12 22:15:12 srv4hai postfix/pickup[26854]: 2D0CF6345B: uid=33 from=
Sep 12 22:15:12 srv4hai postfix/cleanup[6323]: 2D0CF6345B: message-id=<20240912201512.2D0CF6345B@mail.viehai.at>
Sep 12 22:15:12 srv4hai postfix/qmgr[8566]: 2D0CF6345B: from=, size=8012, nrcpt=1 (queue active)
Sep 12 22:15:12 srv4hai postfix/local[6324]: 2D0CF6345B: 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 12 22:15:12 srv4hai postfix/cleanup[6323]: 302BA6345C: message-id=<20240912201512.302BA6345C@mail.viehai.at>
Sep 12 22:15:12 srv4hai postfix/bounce[6399]: 2D0CF6345B: sender non-delivery notification: 302BA6345C
Sep 12 22:15:12 srv4hai postfix/qmgr[8566]: 302BA6345C: from=<>, size=9894, nrcpt=1 (queue active)
Sep 12 22:15:12 srv4hai postfix/qmgr[8566]: 2D0CF6345B: removed
Sep 12 22:15:12 srv4hai postfix/local[6324]: 302BA6345C: to=, relay=local, delay=0.02, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Sep 12 22:15:12 srv4hai postfix/qmgr[8566]: 302BA6345C: removed
Sep 12 22:15:12 srv4hai activate_scenario[6464]: SHELLY: scenario: 'nasszeile_um(nasszeile_um)'-'shelly-16'-'Küche Licht Naßzeile' --> '0?turn=toggle&brightness=25'
Sep 12 22:15:12 srv4hai proc_url[6532]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/09/12/_0.log' - shellyUsage:'Küche Licht Naßzeile' - scUrl:'http://192.168.12.116/white/0?turn=toggle&brightness=25' - phName:'shelly-28:'Schalter Nasszeile''
Sep 12 22:15:12 srv4hai activate_scenario[6464]: SHELLY: scenario: 'nasszeile_um(nasszeile_um)'-'shelly-16'-'Küche Licht Naßzeile' --> '1?turn=toggle&brightness=25'
Sep 12 22:15:12 srv4hai proc_url[6543]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/09/12/_1.log' - shellyUsage:'Küche Licht Naßzeile' - scUrl:'http://192.168.12.116/white/1?turn=toggle&brightness=25' - phName:'shelly-28:'Schalter Nasszeile''
Sep 12 22:15:12 srv4hai activate_scenario[6464]: SHELLY scenario: 'nasszeile_um(nasszeile_um)' took 116 msec, shelly-28:'Schalter Nasszeile'
Sep 12 22:15:12 srv4hai dhcpd[30731]: DHCPDISCOVER from e0:98:06:a9:f3:81 via enp2s0
Sep 12 22:15:12 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.104 to e0:98:06:a9:f3:81 via enp2s0
Sep 12 22:15:12 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Sep 12 22:15:12 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.104
Sep 12 22:15:12 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-04
Sep 12 22:15:12 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.104 (192.168.12.252) from e0:98:06:a9:f3:81 via enp2s0
Sep 12 22:15:12 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.104 to e0:98:06:a9:f3:81 via enp2s0
Sep 12 22:15:12 srv4hai named[30406]: client @0x7f93501490e0 192.168.12.252#60459/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-04.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Sep 12 22:15:12 srv4hai named[30406]: client @0x7f93506682d0 192.168.12.252#49343/key rndc-key: signer "rndc-key" approved
Sep 12 22:15:12 srv4hai named[30406]: client @0x7f93506682d0 192.168.12.252#49343/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-04.viehai.at' TXT
Sep 12 22:15:12 srv4hai named[30406]: client @0x7f93506682d0 192.168.12.252#49343/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-04.viehai.at' TXT "008d1b202806eda236ba1bc6f43dd868cf"
Sep 12 22:15:12 srv4hai named[30406]: client @0x7f93506682d0 192.168.12.252#49343/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-04.viehai.at' A
Sep 12 22:15:12 srv4hai named[30406]: client @0x7f93506682d0 192.168.12.252#49343/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-04.viehai.at' A 192.168.12.104
Sep 12 22:15:12 srv4hai dhcpd[30731]: Added new forward map from shelly-04.viehai.at to 192.168.12.104
Sep 12 22:15:12 srv4hai named[30406]: client @0x7f9348022510 192.168.12.252#44913/key rndc-key: signer "rndc-key" approved
Sep 12 22:15:12 srv4hai named[30406]: client @0x7f9348022510 192.168.12.252#44913/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '104.12.168.192.in-addr.arpa' PTR
Sep 12 22:15:12 srv4hai named[30406]: client @0x7f9348022510 192.168.12.252#44913/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '104.12.168.192.in-addr.arpa' PTR shelly-04.viehai.at.
Sep 12 22:15:12 srv4hai dhcpd[30731]: Added reverse map from 104.12.168.192.in-addr.arpa. to shelly-04.viehai.at
Sep 12 22:15:12 srv4hai common[6584]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Sep 12 22:15:12 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-04' - shIP/2:'' perform:'conf'
Sep 12 22:15:13 srv4hai mosquitto[18551]: New connection from 192.168.12.104 on port 1883.
Sep 12 22:15:13 srv4hai mosquitto[18551]: Client shelly1pm-E09806A9F381 already connected, closing old connection.
Sep 12 22:15:13 srv4hai mosquitto[18551]: Socket error on client shelly1pm-E09806A9F381, disconnecting.
Sep 12 22:15:13 srv4hai mosquitto[18551]: New client connected from 192.168.12.104 as shelly1pm-E09806A9F381 (c1, k60, u'shmqtt').
Sep 12 22:15:13 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-04' - shIP/2:'192.168.12.104'
Sep 12 22:15:13 srv4hai conf_shelly.sh: SHELLY: usage/name 'Badezimmer' already set for '192.168.12.104'
Sep 12 22:15:13 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(0)' - allready transmitted - skipping
Sep 12 22:15:13 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(1)' - allready transmitted - skipping
Sep 12 22:15:13 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(2)' - allready transmitted - skipping
Sep 12 22:15:13 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(3)' - allready transmitted - skipping
Sep 12 22:15:13 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(4)' - allready transmitted - skipping
Sep 12 22:15:14 srv4hai conf_shelly.sh: SHELLY:'shelly-04' 'conf(5)' - allready transmitted - skipping
Sep 12 22:15:14 srv4hai conf_shelly.sh: SHELLY:'shelly-04' out:0 ON : MISSING
Sep 12 22:15:14 srv4hai conf_shelly.sh: SHELLY:'shelly-04' out:0 OFF: MISSING
Sep 12 22:15:40 srv4hai ping_SP[29963]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1726172140 - 'ping_SP_1'
Sep 12 22:15:40 srv4hai ping_SP[29963]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Sep 12 22:15:43 srv4hai common[6763]: SHELLY common.sh inkludiert von ./bt_scan.sh
Sep 12 22:15:53 srv4hai bt_scan[6763]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Sep 12 22:15:53 srv4hai bt_scan[6763]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Sep 12 22:15:53 srv4hai common[6803]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Sep 12 22:15:53 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1726172153-1726172143
Sep 12 22:15:53 srv4hai check_presence[6803]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Sep 12 22:15:53 srv4hai check_presence[6803]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Sep 12 22:15:53 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'10'=1726172153-1726172143
Sep 12 22:15:53 srv4hai check_presence[6803]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Sep 12 22:15:53 srv4hai check_presence[6803]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Sep 12 22:15:53 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1726172153-1726172143
Sep 12 22:15:53 srv4hai check_presence[6803]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Sep 12 22:15:53 srv4hai check_presence[6803]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (BT/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Sep 12 22:15:54 srv4hai check_presence[6803]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_nasszeile_um) - sceneOFF(offAll)
Sep 12 22:15:54 srv4hai check_presence[6803]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Sep 12 22:16:01 srv4hai CRON[6957]: (root) CMD (/etc/linetest/linetest.sh)
Sep 12 22:16:03 srv4hai activate_scenario[6965]: SHELLY scenario: 'bedlight_tom(bedlight_tom)' started
Sep 12 22:16:03 srv4hai activate_scenario[6965]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-12:'Schlafzimmer Licht'

finished