activate_scenario.sh
Sun Mar 31 18:56:47 CEST 2024
scenario: vorraumOn
phoneName: 2

scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

Licht Vorzimmer (/srv/www/viehai/shelly/log_scenarios/2024/03/31/_0.log)

vorher: 18:56:47.667

  "ison": true,
  "has_timer": false,
  "timer_started": 0,
  "timer_duration": 0,
  "timer_remaining": 0,
  "overpower": false,
  "source": "http"

nachher: 18:56:47.788
Dauer: 121 msec phName: 'phoneName:'2''

scenario: 'Vorzimmer EIN' - 'vorraumOn' - 'vorraumon'

urls : 1
vorher : 18:56:47.649
nachher: 18:56:47.795
Dauer : 146 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/03/31//scene_vorraumOn_20240331_185647.txt'

syslog

Mar 31 18:53:01 srv4hai CRON[7962]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 18:53:46 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711904026 - 'ping_SP_0'
Mar 31 18:53:46 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 31 18:53:48 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=7994, secured, session=<2b5+t/cURtsAAAAAAAAAAAAAAAAAAAAB>
Mar 31 18:53:48 srv4hai dovecot: imap(miglincit)<7994><2b5+t/cURtsAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 31 18:54:01 srv4hai CRON[7998]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 18:54:59 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=8015, secured, session=
Mar 31 18:54:59 srv4hai dovecot: imap(miglincit)<8015>: Logged out in=137 out=1088 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Mar 31 18:55:00 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711904100 - 'ping_SP_0'
Mar 31 18:55:00 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 31 18:55:01 srv4hai CRON[8031]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 18:55:02 srv4hai dhcpd[5037]: reuse_lease: lease age 1583 (secs) under 25% threshold, reply with unaltered, existing lease for 192.168.12.37
Mar 31 18:55:02 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.37 from 1e:5c:4a:7e:11:5f via enp2s0
Mar 31 18:55:02 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.37 to 1e:5c:4a:7e:11:5f via enp2s0
Mar 31 18:55:04 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Mar 31 18:55:05 srv4hai fetchmail[1651]: 41000 messages (41000 seen) for tmiglinci at mail.akis.at (-878282400 octets).
Mar 31 18:55:05 srv4hai fetchmail[1651]: 10073 messages (10073 seen) for srozum at mail.akis.at (1216303919 octets).
Mar 31 18:55:06 srv4hai fetchmail[1651]: 22568 messages (22568 seen) for mrozum at mail.akis.at (-385574053 octets).
Mar 31 18:55:06 srv4hai fetchmail[1651]: 46 messages (46 seen) for admin@bastelstube.wien at pop3.world4you.com (12059834 octets).
Mar 31 18:55:32 srv4hai dhcpd[5037]: DHCPINFORM from 192.168.12.20 via enp2s0
Mar 31 18:55:32 srv4hai dhcpd[5037]: DHCPACK to 192.168.12.20 (08:92:04:5f:12:67) via enp2s0
Mar 31 18:56:01 srv4hai CRON[8050]: (root) CMD (/etc/linetest/linetest.sh)
Mar 31 18:56:13 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1711904173 - 'ping_SP_0'
Mar 31 18:56:13 srv4hai ping_SP[23578]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Mar 31 18:56:16 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Mar 31 18:56:16 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.63
Mar 31 18:56:16 srv4hai dhcpd[5037]: execute_statement argv[2] = iPhoneSophie
Mar 31 18:56:16 srv4hai common[8073]: SHELLY common.sh inkludiert
Mar 31 18:56:26 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.63' / 'iPhoneSophie' / '2'
Mar 31 18:56:26 srv4hai common[8085]: SHELLY common.sh inkludiert
Mar 31 18:56:26 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.63 from 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:26 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.63 to 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:26 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Mar 31 18:56:26 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.63
Mar 31 18:56:26 srv4hai dhcpd[5037]: execute_statement argv[2] = iPhoneSophie
Mar 31 18:56:26 srv4hai ping_SP[8085]: SHELLY ping_SP.sh started from smartphone
Mar 31 18:56:26 srv4hai common[8098]: SHELLY common.sh inkludiert
Mar 31 18:56:37 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.63' / 'iPhoneSophie' / '2'
Mar 31 18:56:37 srv4hai common[8124]: SHELLY common.sh inkludiert
Mar 31 18:56:37 srv4hai common[8126]: SHELLY common.sh inkludiert
Mar 31 18:56:37 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.63 from 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:37 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.63 to 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:37 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/smartphone.sh
Mar 31 18:56:37 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.63
Mar 31 18:56:37 srv4hai dhcpd[5037]: execute_statement argv[2] = iPhoneSophie
Mar 31 18:56:37 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: iPhoneSophie.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 31 18:56:37 srv4hai ping_SP[8124]: SHELLY ping_SP.sh started from smartphone
Mar 31 18:56:37 srv4hai common[8143]: SHELLY common.sh inkludiert
Mar 31 18:56:37 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'3'=1711904197-1711904194
Mar 31 18:56:37 srv4hai check_presence[8126]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Mar 31 18:56:37 srv4hai common.sh: SHELLY: BTstatus[1]:'On' dweetAge:'3'=1711904197-1711904194
Mar 31 18:56:37 srv4hai check_presence[8126]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and On//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Mar 31 18:56:37 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'3'=1711904197-1711904194
Mar 31 18:56:37 srv4hai check_presence[8126]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.LIVE and Off//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Mar 31 18:56:37 srv4hai check_presence[8126]: SHELLY (ping_SP__smartphone)-(2) what: 'coming' - persPresent: '(BT/IP) (BT/IP) (__/IP)' - anyPresent: 'true' - otherPresent:'true'
Mar 31 18:56:37 srv4hai check_presence[8126]: SHELLY (ping_SP__smartphone)-(2)-coming: activate_scenario.shtml: vorraumOn
Mar 31 18:56:37 srv4hai activate_scenario[8259]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Mar 31 18:56:37 srv4hai activate_scenario[8259]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'2'
Mar 31 18:56:37 srv4hai activate_scenario[8259]: SHELLY scenario: 'vorraumOn(vorraumon)' TO BE EXECUTED, phoneName:'2'
Mar 31 18:56:37 srv4hai postfix/pickup[7828]: BD20B60245: uid=33 from=
Mar 31 18:56:37 srv4hai postfix/cleanup[8309]: BD20B60245: message-id=<20240331165637.BD20B60245@mail.viehai.at>
Mar 31 18:56:37 srv4hai postfix/qmgr[15291]: BD20B60245: from=, size=6981, nrcpt=1 (queue active)
Mar 31 18:56:37 srv4hai activate_scenario[8259]: SHELLY: scenario: 'vorraumOn(vorraumon)'-'shelly-03'-'Licht Vorzimmer' --> '0?turn=on'
Mar 31 18:56:37 srv4hai proc_url[8326]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/03/31/_0.log' - shellyUsage:'Licht Vorzimmer' - scUrl:'http://192.168.12.103/relay/0?turn=on' - phName:'phoneName:'2''
Mar 31 18:56:37 srv4hai activate_scenario[8259]: SHELLY scenario: 'vorraumOn(vorraumon)' took 60 msec, phoneName:'2'
Mar 31 18:56:37 srv4hai ping_SP[8085]: SHELLY check_presence.sh coming 2 ping_SP__smartphone
Mar 31 18:56:38 srv4hai postfix/relay/smtp[8322]: BD20B60245: to=, relay=mx02.nic.name[209.131.158.56]:25, delay=0.8, delays=0.02/0.01/0.51/0.26, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 5CC2120105)
Mar 31 18:56:38 srv4hai postfix/qmgr[15291]: BD20B60245: removed
Mar 31 18:56:39 srv4hai ping_SP[8085]: SHELLY - running process-id(8085): '8085 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.63 smartphone#0128124 /bin/bash /srv/www/viehai/shelly//ping_SP.sh 192.168.12.63 smartphone#0128143 /bin/bash /srv/www/viehai/shelly/smartphone.sh 192.168.12.63 iPhoneSophie' - 'ping_SP_2' - exiting ==============
Mar 31 18:56:47 srv4hai smartphone.sh: SHELLY - ping_SP.sh started for phoneIP: '192.168.12.63' / 'iPhoneSophie' / '2'
Mar 31 18:56:47 srv4hai common[8369]: SHELLY common.sh inkludiert
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.63 from 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.63 to 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPDISCOVER from 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.63 to 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: iPhoneSophie.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f93080b8190 192.168.12.252#34989/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: iPhoneSophie.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPDISCOVER from 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.63 to 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPDISCOVER from 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.63 to 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: signer "rndc-key" approved
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'iPhoneSophie.viehai.at' TXT
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'iPhoneSophie.viehai.at' TXT "31bf0fb452f28d5b707b5b66ceeaf6c2a6"
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'iPhoneSophie.viehai.at' A
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPDISCOVER from 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'iPhoneSophie.viehai.at' A 192.168.12.63
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.63 to 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: signer "rndc-key" approved
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'iPhoneSophie.viehai.at' TXT
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'iPhoneSophie.viehai.at' TXT "31bf0fb452f28d5b707b5b66ceeaf6c2a6"
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'iPhoneSophie.viehai.at' A
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'iPhoneSophie.viehai.at' A 192.168.12.63
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPDISCOVER from 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.63 to 22:1e:8c:a4:80:db via enp2s0
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: signer "rndc-key" approved
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'iPhoneSophie.viehai.at' TXT
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'iPhoneSophie.viehai.at' TXT "31bf0fb452f28d5b707b5b66ceeaf6c2a6"
Mar 31 18:56:47 srv4hai dhcpd[5037]: Added new forward map from iPhoneSophie.viehai.at to 192.168.12.63
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'iPhoneSophie.viehai.at' A
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'iPhoneSophie.viehai.at' A 192.168.12.63
Mar 31 18:56:47 srv4hai dhcpd[5037]: Added new forward map from iPhoneSophie.viehai.at to 192.168.12.63
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: signer "rndc-key" approved
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '63.12.168.192.in-addr.arpa' PTR
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '63.12.168.192.in-addr.arpa' PTR iPhoneSophie.viehai.at.
Mar 31 18:56:47 srv4hai dhcpd[5037]: Added new forward map from iPhoneSophie.viehai.at to 192.168.12.63
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: signer "rndc-key" approved
Mar 31 18:56:47 srv4hai dhcpd[5037]: Added reverse map from 63.12.168.192.in-addr.arpa. to iPhoneSophie.viehai.at
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '63.12.168.192.in-addr.arpa' PTR
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '63.12.168.192.in-addr.arpa' PTR iPhoneSophie.viehai.at.
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: signer "rndc-key" approved
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '63.12.168.192.in-addr.arpa' PTR
Mar 31 18:56:47 srv4hai named[15509]: client @0x7f931c688d80 192.168.12.252#42161/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '63.12.168.192.in-addr.arpa' PTR iPhoneSophie.viehai.at.
Mar 31 18:56:47 srv4hai dhcpd[5037]: Added reverse map from 63.12.168.192.in-addr.arpa. to iPhoneSophie.viehai.at
Mar 31 18:56:47 srv4hai common[8385]: SHELLY common.sh inkludiert
Mar 31 18:56:47 srv4hai dhcpd[5037]: Added reverse map from 63.12.168.192.in-addr.arpa. to iPhoneSophie.viehai.at
Mar 31 18:56:47 srv4hai ping_SP[8369]: SHELLY ping_SP.sh started from smartphone
Mar 31 18:56:47 srv4hai common.sh: SHELLY: BTstatus[0]:'BTdweet_not_set' dweetAge:'0'=1711904207-1711904207
Mar 31 18:56:47 srv4hai check_presence[8385]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_0.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_0.Yes
Mar 31 18:56:47 srv4hai common.sh: SHELLY: BTstatus[1]:'BTdweet_not_set' dweetAge:'0'=1711904207-1711904207
Mar 31 18:56:47 srv4hai check_presence[8385]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_1.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_1.Yes
Mar 31 18:56:47 srv4hai common.sh: SHELLY: BTstatus[2]:'BTdweet_not_set' dweetAge:'0'=1711904207-1711904207
Mar 31 18:56:47 srv4hai check_presence[8385]: SHELLY (2) found /srv/www/viehai/shelly//meter/ping_SP_2.LIVE and BTdweet_not_set//srv/www/viehai/shelly//meter/BTscan_BTid_2.No
Mar 31 18:56:47 srv4hai check_presence[8385]: SHELLY (ping_SP__smartphone)-(2) what: 'coming' - persPresent: '(__/IP) (__/IP) (__/IP)' - anyPresent: 'true' - otherPresent:'true'
Mar 31 18:56:47 srv4hai check_presence[8385]: SHELLY (ping_SP__smartphone)-(2)-coming: activate_scenario.shtml: vorraumOn
Mar 31 18:56:47 srv4hai activate_scenario[8477]: SHELLY scenario: 'vorraumOn(vorraumon)' started
Mar 31 18:56:47 srv4hai activate_scenario[8477]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - phoneName:'2'

finished