activate_scenario.sh
Sun Aug 4 18:37:53 CEST 2024
scenario: vorraumOn
phoneName: 0
'day' <--> DayTime=checked , NightTime=checked
-> execution of scenario
-> sending email(s) to 'thomas@miglinci.name'
scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'
Licht Vorzimmer (/srv/www/viehai/shelly/log_scenarios/2024/08/04/_0.log)
vorher: 18:37:53.707
http://192.168.12.103/relay/0?turn=on |
|---|
"ison": true,
"has_timer": false,
"timer_started": 0,
"timer_duration": 0,
"timer_remaining": 0,
"overpower": false,
"source": "http"
|
nachher: 18:37:53.851
Dauer: 144 msec
phName: 'phoneName:'0''
scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'
urls : 1
vorher : 18:37:53.689
nachher: 18:37:53.858
Dauer : 168 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/08/04//scene_vorraumOn_20240804_183753.txt'
syslog
Aug 4 18:34:01 srv4hai activate_scenario[11347]: SHELLY scenario: 'vorraumOff(vorraumoff)' started
Aug 4 18:34:01 srv4hai activate_scenario[11347]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-25:'Küchenlicht'
Aug 4 18:34:01 srv4hai activate_scenario[11347]: SHELLY scenario: 'vorraumOff(vorraumoff)' TO BE EXECUTED, shelly-25:'Küchenlicht'
Aug 4 18:34:01 srv4hai postfix/pickup[352]: 960FB6018A: uid=33 from=
Aug 4 18:34:01 srv4hai postfix/cleanup[11400]: 960FB6018A: message-id=<20240804163401.960FB6018A@mail.viehai.at>
Aug 4 18:34:01 srv4hai postfix/qmgr[8566]: 960FB6018A: from=, size=12723, nrcpt=1 (queue active)
Aug 4 18:34:01 srv4hai postfix/local[11413]: warning: database /etc/aliases.db is older than source file /etc/aliases
Aug 4 18:34:01 srv4hai activate_scenario[11347]: SHELLY: scenario: 'vorraumOff(vorraumoff)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=off'
Aug 4 18:34:01 srv4hai proc_url[11418]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/04/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=off' - phName:'shelly-25:'Küchenlicht''
Aug 4 18:34:01 srv4hai postfix/local[11413]: 960FB6018A: to=, orig_to=, relay=local, delay=0.03, delays=0.02/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Aug 4 18:34:01 srv4hai postfix/cleanup[11400]: 9BDCB6018B: message-id=<20240804163401.9BDCB6018B@mail.viehai.at>
Aug 4 18:34:01 srv4hai postfix/bounce[11414]: 960FB6018A: sender non-delivery notification: 9BDCB6018B
Aug 4 18:34:01 srv4hai postfix/qmgr[8566]: 9BDCB6018B: from=<>, size=14645, nrcpt=1 (queue active)
Aug 4 18:34:01 srv4hai postfix/qmgr[8566]: 960FB6018A: removed
Aug 4 18:34:01 srv4hai activate_scenario[11347]: SHELLY: scenario: 'vorraumOff(vorraumoff)'-'shelly-16'-'Küche Licht Naßzeile' --> '0?turn=off&brightness=70'
Aug 4 18:34:01 srv4hai proc_url[11430]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/04/_1.log' - shellyUsage:'Küche Licht Naßzeile' - scUrl:'http://192.168.12.116/white/0?turn=off&brightness=70' - phName:'shelly-25:'Küchenlicht''
Aug 4 18:34:01 srv4hai postfix/local[11413]: 9BDCB6018B: to=, relay=local, delay=0.01, delays=0.01/0/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Aug 4 18:34:01 srv4hai postfix/qmgr[8566]: 9BDCB6018B: removed
Aug 4 18:34:01 srv4hai activate_scenario[11347]: SHELLY: scenario: 'vorraumOff(vorraumoff)'-'shelly-16'-'Küche Licht Naßzeile' --> '1?turn=off&brightness=70'
Aug 4 18:34:01 srv4hai proc_url[11441]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/04/_2.log' - shellyUsage:'Küche Licht Naßzeile' - scUrl:'http://192.168.12.116/white/1?turn=off&brightness=70' - phName:'shelly-25:'Küchenlicht''
Aug 4 18:34:01 srv4hai activate_scenario[11347]: SHELLY: scenario: 'vorraumOff(vorraumoff)'-'shelly-17'-'Küche Licht Herdzeile' --> '0?turn=off&brightness=50'
Aug 4 18:34:01 srv4hai proc_url[11452]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/04/_3.log' - shellyUsage:'Küche Licht Herdzeile' - scUrl:'http://192.168.12.117/white/0?turn=off&brightness=50' - phName:'shelly-25:'Küchenlicht''
Aug 4 18:34:01 srv4hai CRON[11461]: (root) CMD (/etc/linetest/linetest.sh)
Aug 4 18:34:01 srv4hai activate_scenario[11347]: SHELLY: scenario: 'vorraumOff(vorraumoff)'-'shelly-17'-'Küche Licht Herdzeile' --> '1?turn=off&brightness=50'
Aug 4 18:34:01 srv4hai proc_url[11468]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/04/_4.log' - shellyUsage:'Küche Licht Herdzeile' - scUrl:'http://192.168.12.117/white/1?turn=off&brightness=50' - phName:'shelly-25:'Küchenlicht''
Aug 4 18:34:01 srv4hai activate_scenario[11347]: SHELLY: scenario: 'vorraumOff(vorraumoff)'-'shelly-22'-'WC' --> '0?turn=off'
Aug 4 18:34:01 srv4hai proc_url[11479]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/04/_5.log' - shellyUsage:'WC' - scUrl:'http://192.168.12.122/relay/0?turn=off' - phName:'shelly-25:'Küchenlicht''
Aug 4 18:34:01 srv4hai activate_scenario[11347]: SHELLY: scenario: 'vorraumOff(vorraumoff)'-'shelly-25'-'Küchenlicht' --> '0?turn=off'
Aug 4 18:34:01 srv4hai proc_url[11490]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/04/_6.log' - shellyUsage:'Küchenlicht' - scUrl:'http://192.168.12.125/relay/0?turn=off' - phName:'shelly-25:'Küchenlicht''
Aug 4 18:34:01 srv4hai activate_scenario[11347]: SHELLY scenario: 'vorraumOff(vorraumoff)' took 290 msec, shelly-25:'Küchenlicht'
Aug 4 18:34:03 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Aug 4 18:34:04 srv4hai fetchmail[1651]: 50057 messages (50056 seen) for tmiglinci at mail.akis.at (-162200322 octets).
Aug 4 18:34:04 srv4hai postfix/smtpd[11281]: connect from localhost[127.0.0.1]
Aug 4 18:34:04 srv4hai postfix/smtpd[11281]: 94B3C6000F: client=localhost[127.0.0.1]
Aug 4 18:34:04 srv4hai postfix/cleanup[11400]: 94B3C6000F: message-id=<20240804163017.3D40D6018A@mail.viehai.at>
Aug 4 18:34:04 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:50057 of 50057 (27899 octets) not flushed
Aug 4 18:34:04 srv4hai postfix/qmgr[8566]: 94B3C6000F: from=, size=28273, nrcpt=1 (queue active)
Aug 4 18:34:04 srv4hai postfix/smtpd[11281]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Aug 4 18:34:04 srv4hai postfix/local[11413]: 94B3C6000F: to=, relay=local, delay=0.07, delays=0.06/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Aug 4 18:34:04 srv4hai postfix/qmgr[8566]: 94B3C6000F: removed
Aug 4 18:34:05 srv4hai fetchmail[1651]: 10546 messages (10546 seen) for srozum at mail.akis.at (1267443076 octets).
Aug 4 18:34:05 srv4hai fetchmail[1651]: 25125 messages (25125 seen) for mrozum at mail.akis.at (86478240 octets).
Aug 4 18:34:06 srv4hai fetchmail[1651]: 1139 messages (1139 seen) for admin@bastelstube.wien at pop3.world4you.com (51570784 octets).
Aug 4 18:34:10 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1722789250 - 'ping_SP_1'
Aug 4 18:34:10 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug 4 18:35:01 srv4hai CRON[11629]: (root) CMD (/etc/linetest/linetest.sh)
Aug 4 18:35:23 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1722789323 - 'ping_SP_1'
Aug 4 18:35:23 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug 4 18:35:30 srv4hai mosquitto[18551]: Client shellypmminig3-ecda3bc61d3c has exceeded timeout, disconnecting.
Aug 4 18:35:30 srv4hai mosquitto[18551]: Socket error on client shellypmminig3-ecda3bc61d3c, disconnecting.
Aug 4 18:35:44 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24
Aug 4 18:35:44 srv4hai dhcpd[30731]: DHCPDISCOVER from ec:da:3b:c6:1d:3c via enp2s0
Aug 4 18:35:44 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Aug 4 18:35:44 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24
Aug 4 18:35:44 srv4hai dhcpd[30731]: DHCPDISCOVER from ec:da:3b:c6:1d:3c via enp2s0
Aug 4 18:35:44 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Aug 4 18:35:44 srv4hai dhcpd[30731]: uid lease 192.168.12.40 for client ec:da:3b:c6:1d:3c is duplicate on 192.168.12.0/24
Aug 4 18:35:44 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Aug 4 18:35:44 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.150
Aug 4 18:35:44 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-50
Aug 4 18:35:44 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.150 (192.168.12.252) from ec:da:3b:c6:1d:3c via enp2s0
Aug 4 18:35:44 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Aug 4 18:35:44 srv4hai named[30406]: client @0x7f93506d04d0 192.168.12.252#46613/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-50.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 4 18:35:44 srv4hai named[30406]: client @0x7f93100e3a50 192.168.12.252#49191/key rndc-key: signer "rndc-key" approved
Aug 4 18:35:44 srv4hai named[30406]: client @0x7f93100e3a50 192.168.12.252#49191/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' TXT
Aug 4 18:35:44 srv4hai named[30406]: client @0x7f93100e3a50 192.168.12.252#49191/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' TXT "31ddfcf6e79cbbdf4e55e03247020075f9"
Aug 4 18:35:44 srv4hai named[30406]: client @0x7f93100e3a50 192.168.12.252#49191/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' A
Aug 4 18:35:44 srv4hai named[30406]: client @0x7f93100e3a50 192.168.12.252#49191/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' A 192.168.12.150
Aug 4 18:35:44 srv4hai dhcpd[30731]: Added new forward map from shelly-50.viehai.at to 192.168.12.150
Aug 4 18:35:44 srv4hai named[30406]: client @0x7f93300a3990 192.168.12.252#36643/key rndc-key: signer "rndc-key" approved
Aug 4 18:35:44 srv4hai named[30406]: client @0x7f93300a3990 192.168.12.252#36643/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '150.12.168.192.in-addr.arpa' PTR
Aug 4 18:35:44 srv4hai named[30406]: client @0x7f93300a3990 192.168.12.252#36643/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '150.12.168.192.in-addr.arpa' PTR shelly-50.viehai.at.
Aug 4 18:35:44 srv4hai dhcpd[30731]: Added reverse map from 150.12.168.192.in-addr.arpa. to shelly-50.viehai.at
Aug 4 18:35:44 srv4hai common[11663]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Aug 4 18:35:44 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-50' - shIP/2:'' perform:'conf'
Aug 4 18:35:45 srv4hai mosquitto[18551]: New connection from 192.168.12.150 on port 1883.
Aug 4 18:35:45 srv4hai mosquitto[18551]: New client connected from 192.168.12.150 as shellypmminig3-ecda3bc61d3c (c1, k60, u'shmqtt').
Aug 4 18:35:45 srv4hai conf_shelly.sh: SHELLY: PARAMS shName/1:'shelly-50' - shIP/2:'192.168.12.150'
Aug 4 18:35:45 srv4hai conf_shelly.sh: SHELLY: usage/name '50-TBD' already set for '192.168.12.150'
Aug 4 18:35:45 srv4hai conf_shelly.sh: SHELLY:'shelly-50' no WebHook
Aug 4 18:36:01 srv4hai CRON[11717]: (root) CMD (/etc/linetest/linetest.sh)
Aug 4 18:36:19 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=11725, secured, session=
Aug 4 18:36:19 srv4hai dovecot: imap(miglincit)<11725>: Logged out in=373 out=41869 deleted=0 expunged=0 trashed=0 hdr_count=50 hdr_bytes=15284 body_count=0 body_bytes=0
Aug 4 18:36:24 srv4hai activate_scenario[11731]: SHELLY scenario: 'buero_UM(buero_um)' started
Aug 4 18:36:24 srv4hai activate_scenario[11731]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'Thomas Büro Licht'
Aug 4 18:36:24 srv4hai activate_scenario[11731]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'Thomas Büro Licht'
Aug 4 18:36:24 srv4hai postfix/pickup[352]: 9DB816018A: uid=33 from=
Aug 4 18:36:24 srv4hai postfix/cleanup[11784]: 9DB816018A: message-id=<20240804163624.9DB816018A@mail.viehai.at>
Aug 4 18:36:24 srv4hai postfix/qmgr[8566]: 9DB816018A: from=, size=17361, nrcpt=1 (queue active)
Aug 4 18:36:24 srv4hai postfix/local[11796]: warning: database /etc/aliases.db is older than source file /etc/aliases
Aug 4 18:36:24 srv4hai activate_scenario[11731]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'Thomas Büro Regallicht' --> '0?turn=toggle'
Aug 4 18:36:24 srv4hai proc_url[11801]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/04/_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 4 18:36:24 srv4hai postfix/local[11796]: 9DB816018A: to=, orig_to=, relay=local, delay=0.04, delays=0.02/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Aug 4 18:36:24 srv4hai postfix/cleanup[11784]: A50A26018B: message-id=<20240804163624.A50A26018B@mail.viehai.at>
Aug 4 18:36:24 srv4hai activate_scenario[11731]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'Thomas Büro Licht' --> '0?turn=toggle'
Aug 4 18:36:24 srv4hai postfix/bounce[11799]: 9DB816018A: sender non-delivery notification: A50A26018B
Aug 4 18:36:24 srv4hai postfix/qmgr[8566]: A50A26018B: from=<>, size=19283, nrcpt=1 (queue active)
Aug 4 18:36:24 srv4hai postfix/qmgr[8566]: 9DB816018A: removed
Aug 4 18:36:24 srv4hai proc_url[11812]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/04/_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 4 18:36:24 srv4hai postfix/local[11796]: A50A26018B: to=, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Aug 4 18:36:24 srv4hai postfix/qmgr[8566]: A50A26018B: removed
Aug 4 18:36:24 srv4hai activate_scenario[11731]: SHELLY scenario: 'buero_UM(buero_um)' took 77 msec, shelly-40:'Thomas Büro Licht'
Aug 4 18:36:33 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Aug 4 18:36:33 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.10
Aug 4 18:36:33 srv4hai dhcpd[30731]: execute_statement argv[2] = pchai7x
Aug 4 18:36:33 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Aug 4 18:36:33 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Aug 4 18:36:33 srv4hai named[30406]: client @0x7f9350100b10 192.168.12.252#41435/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 4 18:36:33 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#41099/key rndc-key: signer "rndc-key" approved
Aug 4 18:36:33 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#41099/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Aug 4 18:36:33 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#41099/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Aug 4 18:36:33 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#41099/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Aug 4 18:36:33 srv4hai named[30406]: client @0x7f933806a720 192.168.12.252#41099/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Aug 4 18:36:33 srv4hai dhcpd[30731]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Aug 4 18:36:33 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Aug 4 18:36:33 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#51009/key rndc-key: signer "rndc-key" approved
Aug 4 18:36:33 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#51009/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Aug 4 18:36:33 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#51009/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 4 18:36:33 srv4hai dhcpd[30731]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Aug 4 18:36:33 srv4hai activate_scenario[11867]: SHELLY scenario: 'pcON(pcon)' started
Aug 4 18:36:33 srv4hai activate_scenario[11867]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'
Aug 4 18:36:33 srv4hai activate_scenario[11867]: SHELLY scenario: 'pcON(pcon)' TO BE EXECUTED, origin:'dhcpcommit.sh-pchai7x'
Aug 4 18:36:33 srv4hai postfix/pickup[352]: AF67D6018A: uid=33 from=
Aug 4 18:36:33 srv4hai postfix/cleanup[11784]: AF67D6018A: message-id=<20240804163633.AF67D6018A@mail.viehai.at>
Aug 4 18:36:33 srv4hai postfix/qmgr[8566]: AF67D6018A: from=, size=22270, nrcpt=1 (queue active)
Aug 4 18:36:33 srv4hai postfix/local[11796]: AF67D6018A: to=, orig_to=, relay=local, delay=0.03, delays=0.02/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Aug 4 18:36:33 srv4hai postfix/cleanup[11784]: B41B66018B: message-id=<20240804163633.B41B66018B@mail.viehai.at>
Aug 4 18:36:33 srv4hai postfix/bounce[11799]: AF67D6018A: sender non-delivery notification: B41B66018B
Aug 4 18:36:33 srv4hai postfix/qmgr[8566]: B41B66018B: from=<>, size=24152, nrcpt=1 (queue active)
Aug 4 18:36:33 srv4hai postfix/qmgr[8566]: AF67D6018A: removed
Aug 4 18:36:33 srv4hai postfix/local[11796]: B41B66018B: to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Aug 4 18:36:33 srv4hai postfix/qmgr[8566]: B41B66018B: removed
Aug 4 18:36:33 srv4hai activate_scenario[11867]: SHELLY: scenario: 'pcON(pcon)'-'shelly-20'-'Thomas Schreibtischlampe' --> '0?turn=on'
Aug 4 18:36:33 srv4hai proc_url[11932]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/08/04/_0.log' - shellyUsage:'Thomas Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=on' - phName:'origin:'dhcpcommit.sh-pchai7x''
Aug 4 18:36:33 srv4hai activate_scenario[11867]: SHELLY scenario: 'pcON(pcon)' took 87 msec, origin:'dhcpcommit.sh-pchai7x'
Aug 4 18:36:36 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1722789396 - 'ping_SP_1'
Aug 4 18:36:36 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug 4 18:36:40 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=192.168.12.10, lip=192.168.12.252, mpid=11975, TLS, session=
Aug 4 18:36:46 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=11981, secured, session=<7ASYKt4eUp0AAAAAAAAAAAAAAAAAAAAB>
Aug 4 18:36:46 srv4hai dovecot: imap(miglincit)<11981><7ASYKt4eUp0AAAAAAAAAAAAAAAAAAAAB>: Logged out in=29 out=529 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug 4 18:36:46 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=11983, secured, session=
Aug 4 18:36:46 srv4hai dovecot: imap(miglincit)<11983>: Logged out in=44 out=187754 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug 4 18:36:48 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=11991, secured, session=
Aug 4 18:36:48 srv4hai dovecot: imap(miglincit)<11991>: Logged out in=345 out=42162 deleted=0 expunged=0 trashed=0 hdr_count=50 hdr_bytes=15284 body_count=0 body_bytes=0
Aug 4 18:36:48 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=11993, secured, session=
Aug 4 18:36:49 srv4hai dovecot: imap(miglincit)<11993>: Logged out in=271064 out=1181660 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Aug 4 18:36:52 srv4hai common[11996]: SHELLY common.sh inkludiert von ./bt_scan.sh
Aug 4 18:36:54 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=12011, secured, session=
Aug 4 18:36:54 srv4hai dovecot: imap(miglincit)<12011>: Logged out in=441 out=12437 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=349 body_count=1 body_bytes=10543
Aug 4 18:37:01 srv4hai CRON[12017]: (root) CMD (/etc/linetest/linetest.sh)
Aug 4 18:37:02 srv4hai bt_scan[11996]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Aug 4 18:37:02 srv4hai bt_scan[11996]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Aug 4 18:37:02 srv4hai common[12039]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug 4 18:37:02 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1722789422-1722789412
Aug 4 18:37:02 srv4hai check_presence[12039]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug 4 18:37:03 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'10'=1722789422-1722789412
Aug 4 18:37:03 srv4hai check_presence[12039]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Aug 4 18:37:03 srv4hai check_presence[12039]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Aug 4 18:37:03 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'11'=1722789423-1722789412
Aug 4 18:37:03 srv4hai check_presence[12039]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug 4 18:37:03 srv4hai check_presence[12039]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/__) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug 4 18:37:03 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=12153, secured, session=
Aug 4 18:37:03 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=12175, secured, session=
Aug 4 18:37:03 srv4hai check_presence[12039]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_pcON) - sceneOFF(offAll)
Aug 4 18:37:03 srv4hai check_presence[12039]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Aug 4 18:37:03 srv4hai dovecot: imap(miglincit)<12153>: Logged out in=641 out=33811 deleted=0 expunged=0 trashed=5 hdr_count=5 hdr_bytes=1325 body_count=0 body_bytes=0
Aug 4 18:37:03 srv4hai dovecot: imap(miglincit)<12175>: Logged out in=443 out=80914 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=525 body_count=1 body_bytes=78625
Aug 4 18:37:17 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=12199, secured, session=
Aug 4 18:37:17 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=12201, secured, session=
Aug 4 18:37:18 srv4hai dovecot: imap(miglincit)<12199>: Logged out in=669 out=36287 deleted=0 expunged=0 trashed=9 hdr_count=9 hdr_bytes=2932 body_count=0 body_bytes=0
Aug 4 18:37:18 srv4hai dovecot: imap(miglincit)<12201>: Logged out in=443 out=90036 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=463 body_count=1 body_bytes=88020
Aug 4 18:37:24 srv4hai postfix/anvil[11315]: statistics: max connection rate 1/60s for (smtp:80.94.92.151) at Aug 4 18:33:42
Aug 4 18:37:24 srv4hai postfix/anvil[11315]: statistics: max connection count 1 for (smtp:80.94.92.151) at Aug 4 18:33:42
Aug 4 18:37:24 srv4hai postfix/anvil[11315]: statistics: max cache size 2 at Aug 4 18:33:42
Aug 4 18:37:30 srv4hai mosquitto[18551]: Client shellypmminig3-ecda3bc61d3c has exceeded timeout, disconnecting.
Aug 4 18:37:30 srv4hai mosquitto[18551]: Socket error on client shellypmminig3-ecda3bc61d3c, disconnecting.
Aug 4 18:37:32 srv4hai dhcpd[30731]: DHCPDISCOVER from e8:78:29:c0:c2:4e via enp2s0
Aug 4 18:37:32 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 4 18:37:32 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug 4 18:37:32 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug 4 18:37:32 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug 4 18:37:32 srv4hai common[12205]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug 4 18:37:42 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug 4 18:37:42 srv4hai common[12224]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Aug 4 18:37:42 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug 4 18:37:42 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 4 18:37:42 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug 4 18:37:42 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug 4 18:37:42 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug 4 18:37:42 srv4hai common[12237]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug 4 18:37:42 srv4hai ping_SP[12224]: SHELLY ping_SP.sh started from smartphone, user:'root'
Aug 4 18:37:50 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 1 sucessfully @~1722789470 - 'ping_SP_1'
Aug 4 18:37:50 srv4hai ping_SP[10639]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Aug 4 18:37:52 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.61' / 'fpThomas' / '0'
Aug 4 18:37:52 srv4hai common[12280]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Aug 4 18:37:52 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.61 (192.168.12.252) from e8:78:29:c0:c2:4e via enp2s0
Aug 4 18:37:52 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.61 to e8:78:29:c0:c2:4e via enp2s0
Aug 4 18:37:52 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Aug 4 18:37:52 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.61
Aug 4 18:37:52 srv4hai dhcpd[30731]: execute_statement argv[2] = fpThomas
Aug 4 18:37:52 srv4hai named[30406]: client @0x7f9338013780 192.168.12.252#55233/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: fpThomas.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Aug 4 18:37:52 srv4hai common[12298]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Aug 4 18:37:52 srv4hai common[12300]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/smartphone.sh
Aug 4 18:37:52 srv4hai ping_SP[12280]: SHELLY ping_SP.sh started from smartphone, user:'root'
Aug 4 18:37:53 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'6'=1722789473-1722789467
Aug 4 18:37:53 srv4hai check_presence[12298]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Aug 4 18:37:53 srv4hai check_presence[12298]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'coming'
Aug 4 18:37:53 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'6'=1722789473-1722789467
Aug 4 18:37:53 srv4hai check_presence[12298]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_1.No
Aug 4 18:37:53 srv4hai check_presence[12298]: SHELLY (ping_SP__smartphone)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Aug 4 18:37:53 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'6'=1722789473-1722789467
Aug 4 18:37:53 srv4hai check_presence[12298]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.DEAD and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Aug 4 18:37:53 srv4hai check_presence[12298]: SHELLY (ping_SP__smartphone)-(0) what: 'coming' - persPresent: '(__/LIVE) (__/LIVE) (__/__)' - anyPresent: 'true' - otherPresent:'true'
Aug 4 18:37:53 srv4hai check_presence[12298]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_pcON) - sceneONsmall(vorraumOn)
Aug 4 18:37:53 srv4hai check_presence[12298]: SHELLY (ping_SP__smartphone)-(0)-coming: activate_scenario.shtml: vorraumOn
Aug 4 18:37:53 srv4hai activate_scenario[12467]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Aug 4 18:37:53 srv4hai activate_scenario[12467]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'0'
finished