activate_scenario.sh
Thu Jan 30 22:34:15 CET 2025
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'

SZ Nachtkästchen Thomas (/srv/www/viehai/shelly/log_scenarios/2025/01/30/_0.log)

vorher: 22:34:16.119

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:34:16.166
Dauer: 47 msec phName: 'shelly-12:'SZ Licht''


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

urls : 1
vorher : 22:34:16.094
nachher: 22:34:16.172
Dauer : 79 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/30//scene_bedlight_tom_20250130_223415.txt'


syslog

Jan 30 22:31:00 srv4hai common[9701]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:31:01 srv4hai CRON[9726]: (root) CMD (/etc/linetest/linetest.sh)
Jan 30 22:31:10 srv4hai systemd[1]: Started Run anacron jobs.
Jan 30 22:31:10 srv4hai anacron[9738]: Anacron 2.3 started on 2025-01-30
Jan 30 22:31:10 srv4hai anacron[9738]: Normal exit (0 jobs run)
Jan 30 22:31:10 srv4hai systemd[1]: anacron.service: Succeeded.
Jan 30 22:31:20 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=9745, secured, session=
Jan 30 22:31:20 srv4hai dovecot: imap(miglincit)<9745>: Logged out in=2123 out=168545 deleted=0 expunged=0 trashed=0 hdr_count=262 hdr_bytes=92616 body_count=0 body_bytes=0
Jan 30 22:31:21 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=9749, secured, session=
Jan 30 22:31:22 srv4hai dovecot: imap(miglincit)<9749>: Logged out in=441 out=7519 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=348 body_count=1 body_bytes=5629
Jan 30 22:31:23 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=9751, secured, session=<93HOJfMsBocAAAAAAAAAAAAAAAAAAAAB>
Jan 30 22:31:23 srv4hai dovecot: imap(miglincit)<9751><93HOJfMsBocAAAAAAAAAAAAAAAAAAAAB>: Logged out in=606 out=32674 deleted=0 expunged=0 trashed=1 hdr_count=1 hdr_bytes=165 body_count=0 body_bytes=0
Jan 30 22:31:23 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=9753, secured, session=<96nQJfMsCIcAAAAAAAAAAAAAAAAAAAAB>
Jan 30 22:31:23 srv4hai dovecot: imap(miglincit)<9753><96nQJfMsCIcAAAAAAAAAAAAAAAAAAAAB>: Logged out in=399 out=4585 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=461 body_count=1 body_bytes=2154
Jan 30 22:31:23 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=9755, secured, session=
Jan 30 22:31:23 srv4hai dovecot: imap(miglincit)<9755>: Logged out in=399 out=34753 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=461 body_count=1 body_bytes=32321
Jan 30 22:31:35 srv4hai postfix/smtpd[9576]: warning: hostname 107-173-154-138-host.colocrossing.com does not resolve to address 107.173.154.138: Name or service not known
Jan 30 22:31:35 srv4hai postfix/smtpd[9576]: connect from unknown[107.173.154.138]
Jan 30 22:31:39 srv4hai dovecot: imap(miglincit)<28260>: Logged out in=19998 out=5427110 deleted=0 expunged=0 trashed=0 hdr_count=41 hdr_bytes=17534 body_count=43 body_bytes=5251332
Jan 30 22:31:39 srv4hai dovecot: imap(miglincit)<28258><8YRW7e4s4L/AqAwK>: Logged out in=3448898 out=35531901 deleted=0 expunged=0 trashed=0 hdr_count=5 hdr_bytes=2561 body_count=0 body_bytes=0
Jan 30 22:31:39 srv4hai dovecot: imap(miglincit)<28251>: Logged out in=3448873 out=35476883 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=3111 body_count=4 body_bytes=26988
Jan 30 22:31:40 srv4hai postfix/smtpd[9576]: warning: unknown[107.173.154.138]: SASL PLAIN authentication failed: 
Jan 30 22:31:40 srv4hai ping_SP[8132]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1738272700 - 'ping_SP_1'
Jan 30 22:31:40 srv4hai ping_SP[8132]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 30 22:31:40 srv4hai postfix/smtpd[9576]: disconnect from unknown[107.173.154.138] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 30 22:31:40 srv4hai dovecot: imap(miglincit)<28263>: Connection closed (IDLE running for 0.001 + waiting input for 49.057 secs, 2 B in + 10 B out, state=wait-input) in=3440226 out=34767508 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=441 body_count=0 body_bytes=0
Jan 30 22:31:40 srv4hai dovecot: imap(miglincit)<28256>: Connection closed (IDLE running for 0.001 + waiting input for 50.430 secs, 2 B in + 10 B out, state=wait-input) in=3410646 out=40462878 deleted=0 expunged=0 trashed=0 hdr_count=4 hdr_bytes=2581 body_count=6 body_bytes=4395616
Jan 30 22:31:41 srv4hai activate_scenario[9786]: SHELLY scenario: 'pcOFF(pcoff)' started
Jan 30 22:31:41 srv4hai activate_scenario[9786]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-0:''
Jan 30 22:31:41 srv4hai activate_scenario[9786]: SHELLY scenario: 'pcOFF(pcoff)' TO BE EXECUTED, shelly-0:''
Jan 30 22:31:41 srv4hai postfix/pickup[13796]: B8A1F63465: uid=33 from=
Jan 30 22:31:41 srv4hai postfix/cleanup[8231]: B8A1F63465: message-id=<20250130213141.B8A1F63465@mail.viehai.at>
Jan 30 22:31:41 srv4hai postfix/qmgr[8566]: B8A1F63465: from=, size=26847, nrcpt=1 (queue active)
Jan 30 22:31:41 srv4hai postfix/local[9578]: B8A1F63465: to=, orig_to=, relay=local, delay=0.03, delays=0.02/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 30 22:31:41 srv4hai postfix/cleanup[8231]: BCD2F63466: message-id=<20250130213141.BCD2F63466@mail.viehai.at>
Jan 30 22:31:41 srv4hai postfix/bounce[9848]: B8A1F63465: sender non-delivery notification: BCD2F63466
Jan 30 22:31:41 srv4hai postfix/qmgr[8566]: BCD2F63466: from=<>, size=28726, nrcpt=1 (queue active)
Jan 30 22:31:41 srv4hai postfix/qmgr[8566]: B8A1F63465: removed
Jan 30 22:31:41 srv4hai activate_scenario[9786]: SHELLY: scenario: 'pcOFF(pcoff)'-'shelly-20'-'TB Schreibtischlampe' --> '0?turn=off'
Jan 30 22:31:41 srv4hai proc_url[9856]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/30/_0.log' - shellyUsage:'TB Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=off' - phName:'shelly-0:'''
Jan 30 22:31:41 srv4hai postfix/local[9578]: BCD2F63466: to=, relay=local, delay=0.02, delays=0/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 30 22:31:41 srv4hai postfix/qmgr[8566]: BCD2F63466: removed
Jan 30 22:31:41 srv4hai activate_scenario[9786]: SHELLY scenario: 'pcOFF(pcoff)' took 64 msec, shelly-0:''
Jan 30 22:31:54 srv4hai common[9892]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:31:54 srv4hai common[9916]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:32:00 srv4hai common[9941]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:32:00 srv4hai common[9967]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:32:00 srv4hai common[9991]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:32:01 srv4hai CRON[10016]: (root) CMD (/etc/linetest/linetest.sh)
Jan 30 22:32:05 srv4hai common[10023]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:32:05 srv4hai activate_scenario[10060]: SHELLY scenario: 'tvlampTOGGLE(tvlamptoggle)' started
Jan 30 22:32:05 srv4hai activate_scenario[10060]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - source:'192.168.12.252'
Jan 30 22:32:06 srv4hai activate_scenario[10060]: SHELLY scenario: 'tvlampTOGGLE(tvlamptoggle)' TO BE EXECUTED, source:'192.168.12.252'
Jan 30 22:32:06 srv4hai postfix/pickup[13796]: 2929063465: uid=33 from=
Jan 30 22:32:06 srv4hai postfix/cleanup[8231]: 2929063465: message-id=<20250130213206.2929063465@mail.viehai.at>
Jan 30 22:32:06 srv4hai postfix/qmgr[8566]: 2929063465: from=, size=28033, nrcpt=1 (queue active)
Jan 30 22:32:06 srv4hai postfix/local[9578]: 2929063465: to=, orig_to=, relay=local, delay=0.01, delays=0.01/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 30 22:32:06 srv4hai postfix/cleanup[8231]: 2BEF363466: message-id=<20250130213206.2BEF363466@mail.viehai.at>
Jan 30 22:32:06 srv4hai postfix/bounce[9848]: 2929063465: sender non-delivery notification: 2BEF363466
Jan 30 22:32:06 srv4hai postfix/qmgr[8566]: 2BEF363466: from=<>, size=29912, nrcpt=1 (queue active)
Jan 30 22:32:06 srv4hai postfix/qmgr[8566]: 2929063465: removed
Jan 30 22:32:06 srv4hai postfix/local[9578]: 2BEF363466: to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 30 22:32:06 srv4hai postfix/qmgr[8566]: 2BEF363466: removed
Jan 30 22:32:06 srv4hai activate_scenario[10060]: SHELLY: scenario: 'tvlampTOGGLE(tvlamptoggle)'-'shelly-06'-'WZ Licht Fernsehlampe klein' --> '0?turn=toggle'
Jan 30 22:32:06 srv4hai proc_url[10126]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/30/_0.log' - shellyUsage:'WZ Licht Fernsehlampe klein' - scUrl:'http://192.168.12.106/relay/0?turn=toggle' - phName:'source:'192.168.12.252''
Jan 30 22:32:06 srv4hai activate_scenario[10060]: SHELLY: scenario: 'tvlampTOGGLE(tvlamptoggle)'-'shelly-52'-'WZ ovale Lampe' --> '0?turn=toggle'
Jan 30 22:32:06 srv4hai proc_url[10137]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/30/_1.log' - shellyUsage:'WZ ovale Lampe' - scUrl:'http://192.168.12.152/relay/0?turn=toggle' - phName:'source:'192.168.12.252''
Jan 30 22:32:06 srv4hai activate_scenario[10060]: SHELLY scenario: 'tvlampTOGGLE(tvlamptoggle)' took 73 msec, source:'192.168.12.252'
Jan 30 22:32:06 srv4hai proc_url[10137]: SHELLY: status invalid - length:'9'
Jan 30 22:32:06 srv4hai common[10177]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:32:22 srv4hai common[10212]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 30 22:32:32 srv4hai bt_scan[10212]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes'
Jan 30 22:32:32 srv4hai bt_scan[10212]: SHELLY - ping_SP.sh started for BTmac: '0' - IPv4: '192.168.12.61'
Jan 30 22:32:32 srv4hai common[10251]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//ping_SP.sh
Jan 30 22:32:32 srv4hai ping_SP[10251]: SHELLY ping_SP.sh started from bt_scan, user:'www-data'
Jan 30 22:32:33 srv4hai common[10272]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 30 22:32:33 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'11'=1738272753-1738272742
Jan 30 22:32:33 srv4hai check_presence[10272]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.TRY} and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Jan 30 22:32:33 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'11'=1738272753-1738272742
Jan 30 22:32:33 srv4hai check_presence[10272]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jan 30 22:32:33 srv4hai check_presence[10272]: SHELLY (ping_SP__bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'coming'
Jan 30 22:32:33 srv4hai check_presence[10272]: SHELLY (ping_SP__bt_scan)-(0) what: 'coming' - persPresent: '(BT/__) (BT/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Jan 30 22:32:34 srv4hai check_presence[10272]: SHELLY - check 'coming': anyPresent(true) - lScene(scene_tvlampTOGGLE) - sceneONsmall(vorraumOn)
Jan 30 22:32:34 srv4hai check_presence[10272]: SHELLY (ping_SP__bt_scan)-(0)-coming: activate_scenario.shtml: vorraumOn
Jan 30 22:32:34 srv4hai activate_scenario[10389]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Jan 30 22:32:34 srv4hai activate_scenario[10389]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - phoneName:'0'
Jan 30 22:32:34 srv4hai activate_scenario[10389]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'0'
Jan 30 22:32:34 srv4hai postfix/pickup[13796]: ABC8F63465: uid=33 from=
Jan 30 22:32:34 srv4hai postfix/cleanup[8231]: ABC8F63465: message-id=<20250130213234.ABC8F63465@mail.viehai.at>
Jan 30 22:32:34 srv4hai postfix/qmgr[8566]: ABC8F63465: from=, size=32385, nrcpt=1 (queue active)
Jan 30 22:32:34 srv4hai activate_scenario[10389]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'VZ Licht' --> '0?turn=on'
Jan 30 22:32:34 srv4hai proc_url[10455]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/30/_0.log' - shellyUsage:'VZ Licht' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'0''
Jan 30 22:32:34 srv4hai activate_scenario[10389]: SHELLY scenario: 'vorraumOn(vorraumon)' took 59 msec, phoneName:'0'
Jan 30 22:32:34 srv4hai ping_SP[10251]: SHELLY check_presence.sh coming 0 ping_SP__bt_scan
Jan 30 22:32:34 srv4hai ping_SP[10251]: SHELLY - new process for '192.168.12.61' - '/srv/www/viehai/shelly//meter/ping_SP_0' @~1738272754
Jan 30 22:32:35 srv4hai postfix/relay/smtp[10448]: ABC8F63465: to=, relay=mx04.nic.name[209.131.160.34]:25, delay=0.93, delays=0.02/0.01/0.51/0.4, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 4E8986008C)
Jan 30 22:32:35 srv4hai postfix/qmgr[8566]: ABC8F63465: removed
Jan 30 22:32:47 srv4hai ping_SP[10251]: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1738272767 - 'ping_SP_0'
Jan 30 22:32:47 srv4hai ping_SP[10251]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 30 22:32:53 srv4hai ping_SP[8132]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1738272773 - 'ping_SP_1'
Jan 30 22:32:53 srv4hai ping_SP[8132]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 30 22:32:54 srv4hai common[10539]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:32:54 srv4hai common[10563]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:32:59 srv4hai common[10590]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:32:59 srv4hai common[10614]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:33:00 srv4hai common[10638]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:33:01 srv4hai CRON[10663]: (root) CMD (/etc/linetest/linetest.sh)
Jan 30 22:33:18 srv4hai dhcpd[4995]: DHCPRELEASE of 192.168.12.2 from 24:5a:4c:1c:1e:f4 via enp2s0 (not found)
Jan 30 22:33:18 srv4hai dhcpd[4995]: DHCPDISCOVER from 24:5a:4c:1c:1e:f4 via enp2s0
Jan 30 22:33:18 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0
Jan 30 22:33:18 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Jan 30 22:33:18 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.2
Jan 30 22:33:18 srv4hai dhcpd[4995]: execute_statement argv[2] = ap2hai
Jan 30 22:33:18 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.2 (192.168.12.252) from 24:5a:4c:1c:1e:f4 via enp2s0
Jan 30 22:33:18 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0
Jan 30 22:33:18 srv4hai named[30406]: client @0x7f932c0c7f00 192.168.12.252#36683/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap2hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 30 22:33:18 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#42187/key rndc-key: signer "rndc-key" approved
Jan 30 22:33:18 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#42187/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' TXT
Jan 30 22:33:18 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#42187/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' TXT "31a0d441667de220424b7789941807db7d"
Jan 30 22:33:18 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#42187/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' A
Jan 30 22:33:18 srv4hai named[30406]: client @0x7f934c046b60 192.168.12.252#42187/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' A 192.168.12.2
Jan 30 22:33:18 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.2'(2) device 'ap2hai'
Jan 30 22:33:18 srv4hai dhcpd[4995]: Added new forward map from ap2hai.viehai.at to 192.168.12.2
Jan 30 22:33:18 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#55459/key rndc-key: signer "rndc-key" approved
Jan 30 22:33:18 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#55459/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '2.12.168.192.in-addr.arpa' PTR
Jan 30 22:33:18 srv4hai named[30406]: client @0x7f935062dc00 192.168.12.252#55459/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '2.12.168.192.in-addr.arpa' PTR ap2hai.viehai.at.
Jan 30 22:33:18 srv4hai dhcpd[4995]: Added reverse map from 2.12.168.192.in-addr.arpa. to ap2hai.viehai.at
Jan 30 22:33:18 srv4hai dhcpcommit.sh: SHELLY device 'ap2hai' known and accepted
Jan 30 22:33:21 srv4hai postfix/smtpd[10688]: warning: hostname 172-245-9-111-host.colocrossing.com does not resolve to address 172.245.9.111: Name or service not known
Jan 30 22:33:21 srv4hai postfix/smtpd[10688]: connect from unknown[172.245.9.111]
Jan 30 22:33:22 srv4hai dhcpd[4995]: DHCPRELEASE of 192.168.12.3 from 70:a7:41:9a:7d:4e via enp2s0 (not found)
Jan 30 22:33:22 srv4hai dhcpd[4995]: DHCPDISCOVER from 70:a7:41:9a:7d:4e via enp2s0
Jan 30 22:33:22 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0
Jan 30 22:33:22 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Jan 30 22:33:22 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.3
Jan 30 22:33:22 srv4hai dhcpd[4995]: execute_statement argv[2] = ap3hai
Jan 30 22:33:22 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.3 (192.168.12.252) from 70:a7:41:9a:7d:4e via enp2s0
Jan 30 22:33:22 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0
Jan 30 22:33:22 srv4hai named[30406]: client @0x7f93300fcc20 192.168.12.252#56185/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap3hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 30 22:33:22 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#46223/key rndc-key: signer "rndc-key" approved
Jan 30 22:33:22 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#46223/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' TXT
Jan 30 22:33:22 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#46223/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' TXT "31763f1a8a980dd918aaf8fff3416a5028"
Jan 30 22:33:22 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#46223/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' A
Jan 30 22:33:22 srv4hai named[30406]: client @0x7f935012c1c0 192.168.12.252#46223/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' A 192.168.12.3
Jan 30 22:33:22 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.3'(3) device 'ap3hai'
Jan 30 22:33:22 srv4hai dhcpd[4995]: Added new forward map from ap3hai.viehai.at to 192.168.12.3
Jan 30 22:33:22 srv4hai named[30406]: client @0x7f93506770d0 192.168.12.252#51649/key rndc-key: signer "rndc-key" approved
Jan 30 22:33:22 srv4hai named[30406]: client @0x7f93506770d0 192.168.12.252#51649/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '3.12.168.192.in-addr.arpa' PTR
Jan 30 22:33:22 srv4hai named[30406]: client @0x7f93506770d0 192.168.12.252#51649/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '3.12.168.192.in-addr.arpa' PTR ap3hai.viehai.at.
Jan 30 22:33:22 srv4hai dhcpd[4995]: Added reverse map from 3.12.168.192.in-addr.arpa. to ap3hai.viehai.at
Jan 30 22:33:22 srv4hai dhcpcommit.sh: SHELLY device 'ap3hai' known and accepted
Jan 30 22:33:24 srv4hai common[10699]: SHELLY common.sh inkludiert von ./bt_scan.sh
Jan 30 22:33:25 srv4hai postfix/smtpd[10688]: warning: unknown[172.245.9.111]: SASL PLAIN authentication failed: 
Jan 30 22:33:25 srv4hai postfix/smtpd[10688]: disconnect from unknown[172.245.9.111] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 30 22:33:34 srv4hai bt_scan[10699]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'No'
Jan 30 22:33:34 srv4hai bt_scan[10699]: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Jan 30 22:33:34 srv4hai common[10736]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly//check_presence.sh
Jan 30 22:33:34 srv4hai common.sh: SHELLY: BTstatus[0]:'Off' dweetAge:'10'=1738272814-1738272804
Jan 30 22:33:34 srv4hai check_presence[10736]: SHELLY (0) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_0.No
Jan 30 22:33:34 srv4hai check_presence[10736]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_0.LIVE' for what: 'presence'
Jan 30 22:33:34 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'10'=1738272814-1738272804
Jan 30 22:33:34 srv4hai check_presence[10736]: SHELLY (1) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Jan 30 22:33:34 srv4hai check_presence[10736]: SHELLY (bt_scan)-(0) found '/srv/www/viehai/shelly//meter/ping_SP_1.LIVE' for what: 'presence'
Jan 30 22:33:34 srv4hai check_presence[10736]: SHELLY (bt_scan)-(0) what: 'presence' - persPresent: '(__/LIVE) (BT/LIVE)' - anyPresent: 'true' - otherPresent:'true'
Jan 30 22:33:35 srv4hai check_presence[10736]: SHELLY - check 'presence': anyPresent(true) - lScene(scene_vorraumOn) - sceneOFF(offAll)
Jan 30 22:33:35 srv4hai check_presence[10736]: SHELLY (bt_scan)-(0)-presence: NOT activate_scenario.shtml: offAll
Jan 30 22:33:54 srv4hai common[10874]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:33:54 srv4hai common[10898]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:34:00 srv4hai common[10928]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:34:00 srv4hai common[10952]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:34:00 srv4hai common[10976]: SHELLY common.sh inkludiert von ./mqtt_process.sh
Jan 30 22:34:00 srv4hai ping_SP[10251]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1738272840 - 'ping_SP_0'
Jan 30 22:34:00 srv4hai ping_SP[10251]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jan 30 22:34:01 srv4hai CRON[11015]: (root) CMD (/etc/linetest/linetest.sh)
Jan 30 22:34:06 srv4hai ping_SP[8132]: SHELLY (1) - ping 192.168.12.62 1 sucessfully  @~1738272846 - 'ping_SP_1'
Jan 30 22:34:06 srv4hai ping_SP[8132]: SHELLY (1) - ping 192.168.12.62 pCnt:'1'
Jan 30 22:34:10 srv4hai activate_scenario[11043]: SHELLY scenario: 'buero_UM(buero_um)' started
Jan 30 22:34:10 srv4hai activate_scenario[11043]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-40:'TB Licht'
Jan 30 22:34:10 srv4hai activate_scenario[11043]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'TB Licht'
Jan 30 22:34:10 srv4hai postfix/pickup[13796]: E026C63465: uid=33 from=
Jan 30 22:34:10 srv4hai postfix/cleanup[8231]: E026C63465: message-id=<20250130213410.E026C63465@mail.viehai.at>
Jan 30 22:34:10 srv4hai postfix/qmgr[8566]: E026C63465: from=, size=23215, nrcpt=1 (queue active)
Jan 30 22:34:10 srv4hai postfix/local[11101]: E026C63465: to=, orig_to=, relay=local, delay=0.03, delays=0.01/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jan 30 22:34:10 srv4hai postfix/cleanup[8231]: E56F263466: message-id=<20250130213410.E56F263466@mail.viehai.at>
Jan 30 22:34:10 srv4hai activate_scenario[11043]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'TB Regallicht' --> '0?turn=toggle'
Jan 30 22:34:10 srv4hai postfix/bounce[11107]: E026C63465: sender non-delivery notification: E56F263466
Jan 30 22:34:10 srv4hai postfix/qmgr[8566]: E56F263466: from=<>, size=25094, nrcpt=1 (queue active)
Jan 30 22:34:10 srv4hai postfix/qmgr[8566]: E026C63465: removed
Jan 30 22:34:10 srv4hai proc_url[11114]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/30/_0.log' - shellyUsage:'TB Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
Jan 30 22:34:10 srv4hai postfix/local[11101]: E56F263466: to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 30 22:34:10 srv4hai postfix/qmgr[8566]: E56F263466: removed
Jan 30 22:34:10 srv4hai activate_scenario[11043]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'TB Licht' --> '0?turn=toggle'
Jan 30 22:34:10 srv4hai proc_url[11126]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/30/_1.log' - shellyUsage:'TB Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht''
Jan 30 22:34:11 srv4hai activate_scenario[11043]: SHELLY scenario: 'buero_UM(buero_um)' took 102 msec, shelly-40:'TB Licht'
Jan 30 22:34:15 srv4hai activate_scenario[11169]: SHELLY scenario: 'bedlight_tom(bedlight_tom)' started
Jan 30 22:34:15 srv4hai activate_scenario[11169]: SHELLY dayState='night' <--> DayTime=checked NightTime=checked - shelly-12:'SZ Licht'

finished