activate_scenario.sh
Thu May 30 07:36:59 CEST 2024
scenario: herdzeile_UM
source: 192.168.12.129

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

scenario: 'Herdzeile UMschalten' - 'herdzeile_UM' - 'herdzeile_um'

Küche Licht Herdzeile (/srv/www/viehai/shelly/log_scenarios/2024/05/30/_0.log)

vorher: 07:36:59.741

http://192.168.12.117/white/0?turn=toggle&brightness=50
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 50,
  "transition": 0,
  "power": 0,
  "overpower": false

nachher: 07:36:59.770
Dauer: 29 msec phName: 'shelly-29:'Schalter Herdzeile''


Küche Licht Herdzeile (/srv/www/viehai/shelly/log_scenarios/2024/05/30/_1.log)

vorher: 07:36:59.767

http://192.168.12.117/white/1?turn=toggle&brightness=50
  "ison": true,
  "source": "http",
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "mode": "white",
  "brightness": 50,
  "transition": 0,
  "power": 0,
  "overpower": false

nachher: 07:36:59.804
Dauer: 36 msec phName: 'shelly-29:'Schalter Herdzeile''


scenario: 'Herdzeile UMschalten' - 'herdzeile_UM' - 'herdzeile_um'

urls : 2
vorher : 07:36:59.695
nachher: 07:36:59.811
Dauer : 117 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/05/30//scene_herdzeile_UM_20240530_073659.txt'


syslog

May 30 07:33:01 srv4hai CRON[10767]: (root) CMD (/etc/linetest/linetest.sh)
May 30 07:33:43 srv4hai common[10778]: SHELLY common.sh inkludiert von ./bt_scan.sh
May 30 07:33:43 srv4hai bt_scan[10778]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
May 30 07:33:43 srv4hai bt_scan[10778]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
May 30 07:33:43 srv4hai common[10809]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
May 30 07:33:43 srv4hai ping_SP[10809]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
May 30 07:33:43 srv4hai common[10830]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
May 30 07:33:44 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'1'=1717047224-1717047223
May 30 07:33:44 srv4hai check_presence[10830]: 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
May 30 07:33:44 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'1'=1717047224-1717047223
May 30 07:33:44 srv4hai check_presence[10830]: 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
May 30 07:33:44 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_not_set' dweetAge:'1'=1717047224-1717047223
May 30 07:33:44 srv4hai check_presence[10830]: 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
May 30 07:33:44 srv4hai check_presence[10830]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(__/__) (__/__) (__/__)' - anyPresent: 'false' - otherPresent:'false'
May 30 07:33:44 srv4hai postfix/pickup[31535]: 59A32631A0: uid=33 from=
May 30 07:33:44 srv4hai postfix/cleanup[10935]: 59A32631A0: message-id=<20240530053344.59A32631A0@mail.viehai.at>
May 30 07:33:44 srv4hai postfix/qmgr[31004]: 59A32631A0: from=, size=22737, nrcpt=1 (queue active)
May 30 07:33:44 srv4hai check_presence[10830]: SHELLY - check 'coming': anyPresent(false) - lScene(scene_offAll) - sceneONsmall(vorraumOn)
May 30 07:33:44 srv4hai check_presence[10830]: SHELLY (ping_SP__bt_scan)-(0)-coming: NOT activate_scenario.shtml: vorraumOn
May 30 07:33:44 srv4hai ping_SP[10809]: SHELLY check_presence.sh coming 0 ping_SP__bt_scan
May 30 07:33:44 srv4hai ping_SP[10809]: SHELLY - new process for '192.168.12.61' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1717047224
May 30 07:33:44 srv4hai mosquitto[18551]: Client shellyht-00B358 has exceeded timeout, disconnecting.
May 30 07:33:44 srv4hai mosquitto[18551]: Socket error on client shellyht-00B358, disconnecting.
May 30 07:33:45 srv4hai postfix/relay/smtp[10947]: 59A32631A0: to=, relay=mx03.nic.name[209.131.161.54]:25, delay=1.1, delays=0.03/0.01/0.65/0.38, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 1CDE98004E)
May 30 07:33:45 srv4hai postfix/qmgr[31004]: 59A32631A0: removed
May 30 07:34:00 srv4hai ping_SP[10809]: SHELLY (0)- ping 192.168.12.61 0 not answered (1) @~1717047240 - 'ping_SP_0'
May 30 07:34:01 srv4hai CRON[10993]: (root) CMD (/etc/linetest/linetest.sh)
May 30 07:34:23 srv4hai ping_SP[10809]: SHELLY (0)- ping 192.168.12.61 1 not answered (1) @~1717047263 - 'ping_SP_0'
May 30 07:34:27 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
May 30 07:34:27 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 30 07:34:27 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May 30 07:34:27 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
May 30 07:34:27 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
May 30 07:34:27 srv4hai common[11021]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
May 30 07:34:37 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May 30 07:34:37 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May 30 07:34:37 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 30 07:34:37 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May 30 07:34:37 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
May 30 07:34:37 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
May 30 07:34:37 srv4hai common[11043]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
May 30 07:34:39 srv4hai common[11056]: SHELLY common.sh inkludiert von ./switch.sh
May 30 07:34:39 srv4hai switch.sh: SHELLY   QUERY_STRING: 'shelly=shelly-04&id=0&generation=1&action=toggle&postAction=html'
May 30 07:34:39 srv4hai switch.sh: SHELLY   scUrl: 'http://192.168.12.104/relay/0?turn=toggle'
May 30 07:34:39 srv4hai switch.sh: SHELLY   aJson: '{"ison":false,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"overpower":false,"source":"http"}'
May 30 07:34:47 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May 30 07:34:47 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May 30 07:34:47 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 30 07:34:47 srv4hai dhcpd[30731]: DDNS: cleaning up lease pointer for a cancel cb=0x55bb12b04300
May 30 07:34:47 srv4hai dhcpd[30731]: Unable to add forward map from fpThomas.viehai.at to 192.168.12.61: operation canceled
May 30 07:34:47 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May 30 07:34:47 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
May 30 07:34:47 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
May 30 07:34:47 srv4hai common[11106]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
May 30 07:34:56 srv4hai ping_SP[10809]: SHELLY (0)- ping 192.168.12.61 2 not answered (1) @~1717047296 - 'ping_SP_0'
May 30 07:34:57 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May 30 07:34:57 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May 30 07:34:57 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 30 07:34:57 srv4hai dhcpd[30731]: DDNS: cleaning up lease pointer for a cancel cb=0x55bb12b448d0
May 30 07:34:57 srv4hai dhcpd[30731]: Unable to add forward map from fpThomas.viehai.at to 192.168.12.61: operation canceled
May 30 07:34:57 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
May 30 07:34:57 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
May 30 07:34:57 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
May 30 07:34:57 srv4hai common[11140]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
May 30 07:35:01 srv4hai CRON[11153]: (root) CMD (/etc/linetest/linetest.sh)
May 30 07:35:07 srv4hai smartphone.sh: SHELLY - ping_SP.sh already started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
May 30 07:35:07 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
May 30 07:35:07 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
May 30 07:35:07 srv4hai dhcpd[30731]: DDNS: cleaning up lease pointer for a cancel cb=0x55bb12b04350
May 30 07:35:07 srv4hai dhcpd[30731]: Unable to add forward map from fpThomas.viehai.at to 192.168.12.61: operation canceled
May 30 07:35:07 srv4hai dhcpd[30731]: DDNS: cleaning up lease pointer for a cancel cb=0x55bb12b44920
May 30 07:35:07 srv4hai dhcpd[30731]: Unable to add forward map from fpThomas.viehai.at to 192.168.12.61: operation canceled
May 30 07:35:19 srv4hai ping_SP[10809]: SHELLY (0) - ping 192.168.12.61 3 sucessfully  @~1717047319 - 'ping_SP_0'
May 30 07:35:19 srv4hai ping_SP[10809]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May 30 07:35:37 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
May 30 07:35:37 srv4hai fetchmail[1651]: 45338 messages (45337 seen) for tmiglinci at mail.akis.at (-548428456 octets).
May 30 07:35:37 srv4hai postfix/smtpd[11189]: warning: database /etc/aliases.db is older than source file /etc/aliases
May 30 07:35:37 srv4hai postfix/smtpd[11189]: connect from localhost[127.0.0.1]
May 30 07:35:37 srv4hai postfix/smtpd[11189]: D79BC6319F: client=localhost[127.0.0.1]
May 30 07:35:37 srv4hai postfix/cleanup[11192]: D79BC6319F: message-id=<20240530053344.59A32631A0@mail.viehai.at>
May 30 07:35:37 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:45338 of 45338 (23713 octets) not flushed
May 30 07:35:37 srv4hai postfix/qmgr[31004]: D79BC6319F: from=, size=24011, nrcpt=1 (queue active)
May 30 07:35:37 srv4hai postfix/smtpd[11189]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
May 30 07:35:37 srv4hai postfix/local[11193]: warning: database /etc/aliases.db is older than source file /etc/aliases
May 30 07:35:37 srv4hai postfix/local[11193]: D79BC6319F: to=, relay=local, delay=0.08, delays=0.06/0.02/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
May 30 07:35:37 srv4hai postfix/qmgr[31004]: D79BC6319F: removed
May 30 07:35:38 srv4hai fetchmail[1651]: 10272 messages (10272 seen) for srozum at mail.akis.at (1237345514 octets).
May 30 07:35:38 srv4hai fetchmail[1651]: 23777 messages (23776 seen) for mrozum at mail.akis.at (-185980235 octets).
May 30 07:35:38 srv4hai postfix/smtpd[11189]: connect from localhost[127.0.0.1]
May 30 07:35:38 srv4hai postfix/smtpd[11189]: DF3566319F: client=localhost[127.0.0.1]
May 30 07:35:38 srv4hai postfix/cleanup[11192]: DF3566319F: message-id=
May 30 07:35:38 srv4hai fetchmail[1651]: reading message mrozum@mail.akis.at:23777 of 23777 (52891 octets) not flushed
May 30 07:35:38 srv4hai postfix/qmgr[31004]: DF3566319F: from=, size=53119, nrcpt=1 (queue active)
May 30 07:35:38 srv4hai postfix/local[11193]: DF3566319F: to=, relay=local, delay=0.08, delays=0.07/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
May 30 07:35:38 srv4hai postfix/qmgr[31004]: DF3566319F: removed
May 30 07:35:38 srv4hai postfix/smtpd[11189]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
May 30 07:35:39 srv4hai fetchmail[1651]: 77 messages (77 seen) for admin@bastelstube.wien at pop3.world4you.com (27541636 octets).
May 30 07:35:45 srv4hai common[11197]: SHELLY common.sh inkludiert von ./switch.sh
May 30 07:35:45 srv4hai switch.sh: SHELLY   QUERY_STRING: 'shelly=shelly-01&id=0&generation=1&action=toggle&postAction=html'
May 30 07:35:45 srv4hai switch.sh: SHELLY   scUrl: 'http://192.168.12.101/relay/0?turn=toggle'
May 30 07:35:45 srv4hai switch.sh: SHELLY   aJson: '{"ison":true,"has_timer":false,"timer_started":0,"timer_duration":0,"timer_remaining":0,"overpower":false,"source":"http"}'
May 30 07:36:01 srv4hai CRON[11240]: (root) CMD (/etc/linetest/linetest.sh)
May 30 07:36:04 srv4hai anacron[10102]: Job `cron.daily' started
May 30 07:36:04 srv4hai anacron[11249]: Updated timestamp for job `cron.daily' to 2024-05-30
May 30 07:36:04 srv4hai anacron[10102]: Job `cron.daily' terminated
May 30 07:36:04 srv4hai anacron[10102]: Normal exit (1 job run)
May 30 07:36:04 srv4hai systemd[1]: anacron.service: Succeeded.
May 30 07:36:33 srv4hai ping_SP[10809]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1717047393 - 'ping_SP_0'
May 30 07:36:33 srv4hai ping_SP[10809]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
May 30 07:36:59 srv4hai activate_scenario[11369]: SHELLY scenario: 'herdzeile_UM(herdzeile_um)' started
May 30 07:36:59 srv4hai activate_scenario[11369]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-29:'Schalter Herdzeile'

finished