activate_scenario.sh
Thu Jan 25 13:04:51 CET 2024
scenario: pcON

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

scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'

Thomas Schreibtischlampe (/srv/www/viehai/shelly/log_scenarios/2024/01/25/_0.log)

vorher: 13:04:52.043

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

nachher: 13:04:52.071
Dauer: 27 msec


scenario: 'Schreibtisch Thomas EIN-schalten' - 'pcON' - 'pcon'

urls : 1
vorher : 13:04:52.007
nachher: 13:04:52.078
Dauer : 72 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/01/25//scene_pcON_20240125_130451.txt'


syslog

Jan 25 13:01:01 srv4hai CRON[12741]: (root) CMD (/etc/linetest/linetest.sh)
Jan 25 13:01:04 srv4hai bash[4449]: Send diag info: {"uuid":"a3222b39-51b7-8745-76f6-0c88571a66bc","language":"de","country":"Austria","hosts":[{"version":"5.0.16","platform":"Javascript/Node.js","type":"linux"}],"node":"v20.10.0","arch":"x64","docker":false,"adapters":{"admin":{"version":"6.12.0","platform":"Javascript/Node.js"},"discovery":{"version":"4.2.0","platform":"Javascript/Node.js"},"backitup":{"version":"2.8.7","platform":"Javascript/Node.js"},"shelly":{"version":"6.6.1","platform":"Javascript/Node.js"},"philips-tv":{"version":"0.5.3","platform":"Javascript/Node.js"},"web":{"version":"6.1.10","platform":"Javascript/Node.js"},"vis":{"version":"1.4.16","platform":"Javascript/Node.js"}},"statesType":"jsonl","objectsType":"jsonl","noInstances":7,"compactMode":false,"noCompactInstances":0,"model":"Intel(R) Core(TM) i3-10100T CPU @ 3.00GHz","cpus":8,"mem":16652111872,"ostype":"Linux","city":"Wien","vis":7}
Jan 25 13:01:07 srv4hai meter.sh: SHELLY meter.sh ended
Jan 25 13:01:08 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706184068 - 'ping_SP_0'
Jan 25 13:01:38 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706184098 - 'ping_SP_0'
Jan 25 13:02:01 srv4hai CRON[12819]: (root) CMD (/etc/linetest/linetest.sh)
Jan 25 13:02:08 srv4hai dhcpd[5037]: DHCPDISCOVER from c0:49:ef:8a:c9:d8 via enp2s0
Jan 25 13:02:08 srv4hai dhcpd[5037]: DHCPOFFER on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jan 25 13:02:08 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jan 25 13:02:08 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.139
Jan 25 13:02:08 srv4hai dhcpd[5037]: execute_statement argv[2] = shelly-39
Jan 25 13:02:08 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.139 (192.168.12.252) from c0:49:ef:8a:c9:d8 via enp2s0
Jan 25 13:02:08 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.139 to c0:49:ef:8a:c9:d8 via enp2s0
Jan 25 13:02:08 srv4hai named[14530]: client @0x7fc314035d20 192.168.12.252#33817/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-39.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 25 13:02:08 srv4hai named[14530]: client @0x7fc31405bd50 192.168.12.252#36087/key rndc-key: signer "rndc-key" approved
Jan 25 13:02:08 srv4hai named[14530]: client @0x7fc31405bd50 192.168.12.252#36087/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' TXT
Jan 25 13:02:08 srv4hai named[14530]: client @0x7fc31405bd50 192.168.12.252#36087/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' TXT "314be662bb43914e78b269d3f3bc9f38c7"
Jan 25 13:02:08 srv4hai named[14530]: client @0x7fc31405bd50 192.168.12.252#36087/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-39.viehai.at' A
Jan 25 13:02:08 srv4hai named[14530]: client @0x7fc31405bd50 192.168.12.252#36087/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-39.viehai.at' A 192.168.12.139
Jan 25 13:02:08 srv4hai dhcpd[5037]: Added new forward map from shelly-39.viehai.at to 192.168.12.139
Jan 25 13:02:08 srv4hai named[14530]: client @0x7fc328677140 192.168.12.252#42313/key rndc-key: signer "rndc-key" approved
Jan 25 13:02:08 srv4hai named[14530]: client @0x7fc328677140 192.168.12.252#42313/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '139.12.168.192.in-addr.arpa' PTR
Jan 25 13:02:08 srv4hai named[14530]: client @0x7fc328677140 192.168.12.252#42313/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': adding an RR at '139.12.168.192.in-addr.arpa' PTR shelly-39.viehai.at.
Jan 25 13:02:08 srv4hai dhcpd[5037]: Added reverse map from 139.12.168.192.in-addr.arpa. to shelly-39.viehai.at
Jan 25 13:02:08 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-39' - shIP/2:'' workdir:'/srv/www/viehai/shelly' perform:'conf'
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jan 25 13:02:08 srv4hai ht_shelly.sh: SHELLY - working dir '/srv/www/viehai/shelly/wetter/2024/01'
Jan 25 13:02:08 srv4hai ht_shelly.sh: SHELLY - QUERY_STRING: gen=2&temp=11.900000&hum=51&id=C049EF8AC9D8&batt=100&volt=6.720000
Jan 25 13:02:08 srv4hai ht_shelly.sh: SHELLY id  => macID: '8A:C9:D8'
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-39' - shIP/2:'192.168.12.139'
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY:'shelly-39' 'conf(0)' - 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}'
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY: usage/name 'Wetterwerte Balkon' already set for '192.168.12.139'
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY:'shelly-39' 'conf(0)' - 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}'
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-cmd: 'curl --connect-timeout 3 --silent -X -POST -d 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}' http://192.168.12.139/rpc | jq -r '.''
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-cmd: 'curl --connect-timeout 3 --silent -X -POST -d 'settings/actions?index=0&name=report_url&enabled=true&urls[]=http://www.viehai.at/shelly/ht_shelly.shtml?gen=2&temp=${ev.tC}&hum=${status["humidity:0"].rH}&id=${config.sys.device.mac}' http://192.168.12.139/rpc | jq -r '.''
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY:'shelly-39' conf(0)-ret: ''
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Jan 25 13:02:08 srv4hai conf_shelly.sh: SHELLY:'shelly-39' no WebHook
Jan 25 13:02:08 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 11.9° - 51%
Jan 25 13:02:08 srv4hai ht_shelly.sh: SHELLY - storing into '/srv/www/viehai/shelly/wetter/2024/01/shelly-39_20240125.csv'
Jan 25 13:02:08 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: 11.9°/12.4° - 51%/51.1% - SAVED
Jan 25 13:02:08 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: batt='100'°
Jan 25 13:02:09 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706184129 - 'ping_SP_0'
Jan 25 13:02:09 srv4hai ht_shelly.sh: SHELLY C049EF8AC9D8 / shelly-39 / Wetterwerte Balkon: dweetIO='{#012  "this": "succeeded",#012  "by": "dweeting",#012  "the": "dweet",#012  "with": {#012    "thing": "viehai-39",#012    "created": "2024-01-25T12:02:09.096Z",#012    "content": {#012      "temp": 11.9,#012      "hum": 51,#012      "batt": 100#012    },#012    "transaction": "3bac3e0d-13b4-48e6-9e0c-5c0b9f95e744"#012  }#012}'°
Jan 25 13:02:29 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=13006, secured, session=
Jan 25 13:02:29 srv4hai dovecot: imap(miglincit)<13006>: Logged out in=137 out=1087 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jan 25 13:02:36 srv4hai bt_scan.sh: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' found: 'No'
Jan 25 13:02:36 srv4hai bt_scan.sh: SHELLY - lost BT-connection to BTmac: '0' found: 'No' - check presence
Jan 25 13:02:36 srv4hai check_presence.sh: SHELLY () found './meter/ping_SP_0' more than one (1) line for what: 'presence'
Jan 25 13:02:36 srv4hai check_presence.sh: SHELLY () what: 'presence' - persPresent: 'false/ping, false/no IP, false/no IP,' - anyPresent: 'true'
Jan 25 13:02:37 srv4hai check_presence.sh: SHELLY ()-presence: NOT activate_scenario.shtml: offAll
Jan 25 13:02:39 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706184159 - 'ping_SP_0'
Jan 25 13:02:39 srv4hai fetchmail[1651]: 7 messages (7 seen) for rozmig at mail.akis.at (1753652 octets).
Jan 25 13:02:40 srv4hai fetchmail[1651]: 36410 messages (36408 seen) for tmiglinci at mail.akis.at (-1262752846 octets).
Jan 25 13:02:40 srv4hai postfix/smtpd[13058]: connect from localhost[127.0.0.1]
Jan 25 13:02:40 srv4hai postfix/smtpd[13058]: E3D226011D: client=localhost[127.0.0.1]
Jan 25 13:02:40 srv4hai postfix/cleanup[13060]: E3D226011D: message-id=
Jan 25 13:02:40 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:36409 of 36410 (62540 octets) not flushed
Jan 25 13:02:40 srv4hai postfix/qmgr[28610]: E3D226011D: from=, size=62766, nrcpt=1 (queue active)
Jan 25 13:02:41 srv4hai postfix/local[13061]: E3D226011D: to=, relay=local, delay=0.08, delays=0.06/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 25 13:02:41 srv4hai postfix/qmgr[28610]: E3D226011D: removed
Jan 25 13:02:41 srv4hai postfix/smtpd[13058]: 03ADE6011D: client=localhost[127.0.0.1]
Jan 25 13:02:41 srv4hai postfix/cleanup[13060]: 03ADE6011D: message-id=
Jan 25 13:02:41 srv4hai postfix/qmgr[28610]: 03ADE6011D: from=, size=23912, nrcpt=1 (queue active)
Jan 25 13:02:41 srv4hai fetchmail[1651]: reading message tmiglinci@mail.akis.at:36410 of 36410 (23679 octets) not flushed
Jan 25 13:02:41 srv4hai postfix/local[13061]: 03ADE6011D: to=, relay=local, delay=0.07, delays=0.06/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jan 25 13:02:41 srv4hai postfix/qmgr[28610]: 03ADE6011D: removed
Jan 25 13:02:41 srv4hai postfix/smtpd[13058]: disconnect from localhost[127.0.0.1] ehlo=1 mail=2 rcpt=2 data=2 quit=1 commands=8
Jan 25 13:02:41 srv4hai fetchmail[1651]: 9802 messages (9802 seen) for srozum at mail.akis.at (1183731989 octets).
Jan 25 13:02:44 srv4hai fetchmail[1651]: 21280 messages (21280 seen) for mrozum at mail.akis.at (-688902843 octets).
Jan 25 13:02:44 srv4hai fetchmail[1651]: 45 messages (45 seen) for admin@bastelstube.wien at pop3.world4you.com (12035480 octets).
Jan 25 13:03:01 srv4hai CRON[13080]: (root) CMD (/etc/linetest/linetest.sh)
Jan 25 13:03:04 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=13098, secured, session=
Jan 25 13:03:04 srv4hai dovecot: imap(miglincit)<13098>: Logged out in=443 out=111914 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=530 body_count=1 body_bytes=109614
Jan 25 13:03:09 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706184189 - 'ping_SP_0'
Jan 25 13:03:10 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=13113, secured, session=
Jan 25 13:03:10 srv4hai dovecot: imap(miglincit)<13113>: Logged out in=644 out=14996 deleted=0 expunged=0 trashed=3 hdr_count=3 hdr_bytes=861 body_count=0 body_bytes=0
Jan 25 13:03:10 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=13115, secured, session=<3rKX9sMPKIYAAAAAAAAAAAAAAAAAAAAB>
Jan 25 13:03:10 srv4hai dovecot: imap(miglincit)<13115><3rKX9sMPKIYAAAAAAAAAAAAAAAAAAAAB>: Logged out in=443 out=23008 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=351 body_count=1 body_bytes=21025
Jan 25 13:03:11 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=13117, secured, session=<9y6n9sMPLIYAAAAAAAAAAAAAAAAAAAAB>
Jan 25 13:03:11 srv4hai dovecot: imap(miglincit)<13117><9y6n9sMPLIYAAAAAAAAAAAAAAAAAAAAB>: Logged out in=672 out=99462 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=521 body_count=7 body_bytes=95419
Jan 25 13:03:11 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=13119, secured, session=
Jan 25 13:03:11 srv4hai dovecot: imap(miglincit)<13119>: Logged out in=544 out=126148 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=521 body_count=5 body_bytes=122343
Jan 25 13:03:39 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706184219 - 'ping_SP_0'
Jan 25 13:04:01 srv4hai CRON[13165]: (root) CMD (/etc/linetest/linetest.sh)
Jan 25 13:04:02 srv4hai postfix/smtpd[13058]: connect from unknown[193.222.96.92]
Jan 25 13:04:02 srv4hai postfix/smtpd[13058]: warning: unknown[193.222.96.92]: SASL LOGIN authentication failed: Invalid authentication mechanism
Jan 25 13:04:02 srv4hai postfix/smtpd[13058]: disconnect from unknown[193.222.96.92] ehlo=1 auth=0/1 quit=1 commands=2/3
Jan 25 13:04:09 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706184249 - 'ping_SP_0'
Jan 25 13:04:39 srv4hai ping_SP.sh: SHELLY (0) - ping 192.168.12.61 0 sucessfully  @~1706184279 - 'ping_SP_0'
Jan 25 13:04:51 srv4hai dhcpd[5037]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Jan 25 13:04:51 srv4hai dhcpd[5037]: execute_statement argv[1] = 192.168.12.10
Jan 25 13:04:51 srv4hai dhcpd[5037]: execute_statement argv[2] = pchai7x
Jan 25 13:04:51 srv4hai dhcpd[5037]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Jan 25 13:04:51 srv4hai dhcpd[5037]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Jan 25 13:04:51 srv4hai named[14530]: client @0x7fc328166000 192.168.12.252#40413/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jan 25 13:04:51 srv4hai named[14530]: client @0x7fc3286414b0 192.168.12.252#53993/key rndc-key: signer "rndc-key" approved
Jan 25 13:04:51 srv4hai named[14530]: client @0x7fc3286414b0 192.168.12.252#53993/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Jan 25 13:04:51 srv4hai named[14530]: client @0x7fc3286414b0 192.168.12.252#53993/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Jan 25 13:04:51 srv4hai named[14530]: client @0x7fc3286414b0 192.168.12.252#53993/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Jan 25 13:04:51 srv4hai named[14530]: client @0x7fc3286414b0 192.168.12.252#53993/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Jan 25 13:04:51 srv4hai dhcpd[5037]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Jan 25 13:04:51 srv4hai named[14530]: client @0x7fc32407a810 192.168.12.252#36123/key rndc-key: signer "rndc-key" approved
Jan 25 13:04:51 srv4hai named[14530]: client @0x7fc32407a810 192.168.12.252#36123/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Jan 25 13:04:51 srv4hai named[14530]: client @0x7fc32407a810 192.168.12.252#36123/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.
Jan 25 13:04:51 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Jan 25 13:04:51 srv4hai dhcpd[5037]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at

finished