activate_scenario.sh
Thu Jan 23 12:50:09 CET 2025
scenario: pcON
origin: dhcpcommit.sh-pchai7x
vorher: 12:50:10.113
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: 12:50:10.144
Dauer: 32 msec
phName: 'origin:'dhcpcommit.sh-pchai7x''
urls : 1
vorher : 12:50:10.084
nachher: 12:50:10.150
Dauer : 66 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2025/01/23//scene_pcON_20250123_125009.txt'
Jan 23 12:47:01 srv4hai CRON[18694]: (root) CMD (/etc/linetest/linetest.sh) Jan 23 12:47:45 srv4hai ping_SP[8282]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1737632865 - 'ping_SP_0' Jan 23 12:47:45 srv4hai ping_SP[8282]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Jan 23 12:48:01 srv4hai CRON[18751]: (root) CMD (/etc/linetest/linetest.sh) Jan 23 12:48:15 srv4hai dovecot: imap(miglincit)<18580>: Logged out in=54932 out=565974 deleted=0 expunged=0 trashed=0 hdr_count=2 hdr_bytes=654 body_count=0 body_bytes=0 Jan 23 12:48:15 srv4hai dovecot: imap(miglincit)<18574> : Logged out in=554 out=298311 deleted=0 expunged=0 trashed=0 hdr_count=4 hdr_bytes=2063 body_count=4 body_bytes=210500 Jan 23 12:48:15 srv4hai dovecot: imap(miglincit)<18577><73PVJl4s8KHAqAwK>: Logged out in=53378 out=723970 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=2 body_bytes=31563 Jan 23 12:48:15 srv4hai dovecot: imap(miglincit)<18579> : Logged out in=54984 out=572977 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jan 23 12:48:15 srv4hai dovecot: imap(miglincit)<18576> : Logged out in=54952 out=492677 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY last scenario: 'pcON' @ '124535' from 'scene_pcON_20250123_124535.txt' - delta=20 Jan 23 12:48:15 srv4hai activate_scenario[18766]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250123124815 20250123124535 -f '%S' Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY new scenario: 'pcOFF' different - GO ON Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY scenario: 'pcOFF(pcoff)' started Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-0:'' Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY scenario: 'pcOFF(pcoff)' TO BE EXECUTED, shelly-0:'' Jan 23 12:48:15 srv4hai postfix/pickup[8764]: EB5D063463: uid=33 from= Jan 23 12:48:15 srv4hai postfix/cleanup[18831]: EB5D063463: message-id=<20250123114815.EB5D063463@mail.viehai.at> Jan 23 12:48:15 srv4hai postfix/qmgr[8566]: EB5D063463: from= , size=12908, nrcpt=1 (queue active) Jan 23 12:48:15 srv4hai activate_scenario[18766]: SHELLY: scenario: 'pcOFF(pcoff)'-'shelly-20'-'TB Schreibtischlampe' --> '0?turn=off' Jan 23 12:48:15 srv4hai postfix/local[18844]: EB5D063463: 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 23 12:48:15 srv4hai postfix/cleanup[18831]: F1B3A63464: message-id=<20250123114815.F1B3A63464@mail.viehai.at> Jan 23 12:48:15 srv4hai proc_url[18849]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/23/_0.log' - shellyUsage:'TB Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=off' - phName:'shelly-0:''' Jan 23 12:48:15 srv4hai postfix/bounce[18845]: EB5D063463: sender non-delivery notification: F1B3A63464 Jan 23 12:48:15 srv4hai postfix/qmgr[8566]: F1B3A63464: from=<>, size=14787, nrcpt=1 (queue active) Jan 23 12:48:15 srv4hai postfix/qmgr[8566]: EB5D063463: removed Jan 23 12:48:15 srv4hai postfix/local[18844]: F1B3A63464: to= , relay=local, delay=0.01, delays=0/0/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail) Jan 23 12:48:15 srv4hai postfix/qmgr[8566]: F1B3A63464: removed Jan 23 12:48:16 srv4hai activate_scenario[18766]: SHELLY scenario: 'pcOFF(pcoff)' took 58 msec, shelly-0:'' Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY last scenario: 'pcOFF' @ '124815' from 'scene_pcOFF_20250123_124815.txt' - delta=-17 Jan 23 12:48:32 srv4hai activate_scenario[18884]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250123124832 20250123124815 -f '%S' Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY new scenario: 'buero_UM' different - GO ON Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY scenario: 'buero_UM(buero_um)' started Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-40:'TB Licht' Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY scenario: 'buero_UM(buero_um)' TO BE EXECUTED, shelly-40:'TB Licht' Jan 23 12:48:32 srv4hai postfix/pickup[8764]: 2125663463: uid=33 from= Jan 23 12:48:32 srv4hai postfix/cleanup[18831]: 2125663463: message-id=<20250123114832.2125663463@mail.viehai.at> Jan 23 12:48:32 srv4hai postfix/qmgr[8566]: 2125663463: from= , size=15288, nrcpt=1 (queue active) Jan 23 12:48:32 srv4hai postfix/local[18844]: 2125663463: to= , orig_to= , relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null") Jan 23 12:48:32 srv4hai postfix/cleanup[18831]: 2513163464: message-id=<20250123114832.2513163464@mail.viehai.at> Jan 23 12:48:32 srv4hai postfix/bounce[18845]: 2125663463: sender non-delivery notification: 2513163464 Jan 23 12:48:32 srv4hai postfix/qmgr[8566]: 2513163464: from=<>, size=17167, nrcpt=1 (queue active) Jan 23 12:48:32 srv4hai postfix/qmgr[8566]: 2125663463: removed Jan 23 12:48:32 srv4hai postfix/local[18844]: 2513163464: to= , relay=local, delay=0.03, delays=0.01/0/0/0.02, dsn=2.0.0, status=sent (delivered to command: /bin/procmail) Jan 23 12:48:32 srv4hai postfix/qmgr[8566]: 2513163464: removed Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-08'-'TB Regallicht' --> '0?turn=toggle' Jan 23 12:48:32 srv4hai proc_url[18964]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/23/_0.log' - shellyUsage:'TB Regallicht' - scUrl:'http://192.168.12.108/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht'' Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY: scenario: 'buero_UM(buero_um)'-'shelly-40'-'TB Licht' --> '0?turn=toggle' Jan 23 12:48:32 srv4hai proc_url[18975]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2025/01/23/_1.log' - shellyUsage:'TB Licht' - scUrl:'http://192.168.12.140/relay/0?turn=toggle' - phName:'shelly-40:'TB Licht'' Jan 23 12:48:32 srv4hai activate_scenario[18884]: SHELLY scenario: 'buero_UM(buero_um)' took 163 msec, shelly-40:'TB Licht' Jan 23 12:48:50 srv4hai common[19034]: SHELLY common.sh inkludiert von ./bt_scan.sh Jan 23 12:48:58 srv4hai ping_SP[8282]: SHELLY (0) - ping 192.168.12.61 1 sucessfully @~1737632938 - 'ping_SP_0' Jan 23 12:48:58 srv4hai ping_SP[8282]: SHELLY (0) - ping 192.168.12.61 pCnt:'1' Jan 23 12:49:00 srv4hai bt_scan[19034]: SHELLY - who: 'Thomas' / phoneName: 'FP4_Thomas' / '0' / shellyIP: '192.168.12.61' - found: 'Yes' Jan 23 12:49:00 srv4hai bt_scan[19034]: SHELLY - ping_SP.sh already running for BTmac: '0' - IPv4: '192.168.12.61' Jan 23 12:49:01 srv4hai CRON[19090]: (root) CMD (/etc/linetest/linetest.sh) Jan 23 12:49:22 srv4hai postfix/anvil[16592]: statistics: max connection rate 1/60s for (smtp:107.173.89.162) at Jan 23 12:41:24 Jan 23 12:49:22 srv4hai postfix/anvil[16592]: statistics: max connection count 1 for (smtp:107.173.89.162) at Jan 23 12:41:24 Jan 23 12:49:22 srv4hai postfix/anvil[16592]: statistics: max cache size 3 at Jan 23 12:44:25 Jan 23 12:49:36 srv4hai dovecot: imap-login: Login: user= , method=PLAIN, rip=::1, lip=::1, mpid=19106, secured, session=<2jlRNF4sHscAAAAAAAAAAAAAAAAAAAAB> Jan 23 12:49:36 srv4hai dovecot: imap(miglincit)<19106><2jlRNF4sHscAAAAAAAAAAAAAAAAAAAAB>: Logged out in=137 out=1053 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0 Jan 23 12:49:43 srv4hai dhcpd[4995]: DHCPRELEASE of 192.168.12.2 from 24:5a:4c:1c:1e:f4 via enp2s0 (not found) Jan 23 12:49:43 srv4hai dhcpd[4995]: DHCPDISCOVER from 24:5a:4c:1c:1e:f4 via enp2s0 Jan 23 12:49:43 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0 Jan 23 12:49:43 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh Jan 23 12:49:43 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.2 Jan 23 12:49:43 srv4hai dhcpd[4995]: execute_statement argv[2] = ap2hai Jan 23 12:49:43 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.2 (192.168.12.252) from 24:5a:4c:1c:1e:f4 via enp2s0 Jan 23 12:49:43 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.2 to 24:5a:4c:1c:1e:f4 via enp2s0 Jan 23 12:49:43 srv4hai named[30406]: client @0x7f931c09c730 192.168.12.252#39479/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap2hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 23 12:49:43 srv4hai named[30406]: client @0x7f9330095370 192.168.12.252#45077/key rndc-key: signer "rndc-key" approved Jan 23 12:49:43 srv4hai named[30406]: client @0x7f9330095370 192.168.12.252#45077/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' TXT Jan 23 12:49:43 srv4hai named[30406]: client @0x7f9330095370 192.168.12.252#45077/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' TXT "31a0d441667de220424b7789941807db7d" Jan 23 12:49:43 srv4hai named[30406]: client @0x7f9330095370 192.168.12.252#45077/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap2hai.viehai.at' A Jan 23 12:49:43 srv4hai named[30406]: client @0x7f9330095370 192.168.12.252#45077/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap2hai.viehai.at' A 192.168.12.2 Jan 23 12:49:43 srv4hai dhcpd[4995]: Added new forward map from ap2hai.viehai.at to 192.168.12.2 Jan 23 12:49:43 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.2'(2) device 'ap2hai' Jan 23 12:49:43 srv4hai named[30406]: client @0x7f93380a5c40 192.168.12.252#51931/key rndc-key: signer "rndc-key" approved Jan 23 12:49:43 srv4hai named[30406]: client @0x7f93380a5c40 192.168.12.252#51931/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '2.12.168.192.in-addr.arpa' PTR Jan 23 12:49:43 srv4hai named[30406]: client @0x7f93380a5c40 192.168.12.252#51931/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 23 12:49:43 srv4hai dhcpd[4995]: Added reverse map from 2.12.168.192.in-addr.arpa. to ap2hai.viehai.at Jan 23 12:49:43 srv4hai dhcpcommit.sh: SHELLY device 'ap2hai' known and accepted Jan 23 12:49:49 srv4hai dhcpd[4995]: DHCPRELEASE of 192.168.12.3 from 70:a7:41:9a:7d:4e via enp2s0 (not found) Jan 23 12:49:49 srv4hai dhcpd[4995]: DHCPDISCOVER from 70:a7:41:9a:7d:4e via enp2s0 Jan 23 12:49:49 srv4hai dhcpd[4995]: DHCPOFFER on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0 Jan 23 12:49:49 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh Jan 23 12:49:49 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.3 Jan 23 12:49:49 srv4hai dhcpd[4995]: execute_statement argv[2] = ap3hai Jan 23 12:49:49 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.3 (192.168.12.252) from 70:a7:41:9a:7d:4e via enp2s0 Jan 23 12:49:49 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.3 to 70:a7:41:9a:7d:4e via enp2s0 Jan 23 12:49:49 srv4hai named[30406]: client @0x7f931c09a6d0 192.168.12.252#40797/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: ap3hai.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 23 12:49:49 srv4hai named[30406]: client @0x7f932c05b620 192.168.12.252#54381/key rndc-key: signer "rndc-key" approved Jan 23 12:49:49 srv4hai named[30406]: client @0x7f932c05b620 192.168.12.252#54381/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' TXT Jan 23 12:49:49 srv4hai named[30406]: client @0x7f932c05b620 192.168.12.252#54381/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' TXT "31763f1a8a980dd918aaf8fff3416a5028" Jan 23 12:49:49 srv4hai named[30406]: client @0x7f932c05b620 192.168.12.252#54381/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'ap3hai.viehai.at' A Jan 23 12:49:49 srv4hai named[30406]: client @0x7f932c05b620 192.168.12.252#54381/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'ap3hai.viehai.at' A 192.168.12.3 Jan 23 12:49:49 srv4hai dhcpd[4995]: Added new forward map from ap3hai.viehai.at to 192.168.12.3 Jan 23 12:49:49 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.3'(3) device 'ap3hai' Jan 23 12:49:49 srv4hai named[30406]: client @0x7f934c0645f0 192.168.12.252#53491/key rndc-key: signer "rndc-key" approved Jan 23 12:49:49 srv4hai named[30406]: client @0x7f934c0645f0 192.168.12.252#53491/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '3.12.168.192.in-addr.arpa' PTR Jan 23 12:49:49 srv4hai named[30406]: client @0x7f934c0645f0 192.168.12.252#53491/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 23 12:49:49 srv4hai dhcpd[4995]: Added reverse map from 3.12.168.192.in-addr.arpa. to ap3hai.viehai.at Jan 23 12:49:49 srv4hai dhcpcommit.sh: SHELLY device 'ap3hai' known and accepted Jan 23 12:50:01 srv4hai CRON[19140]: (www-data) CMD (/srv/www/viehai/shelly/meter.sh) Jan 23 12:50:01 srv4hai CRON[19141]: (root) CMD (/etc/linetest/linetest.sh) Jan 23 12:50:01 srv4hai common[19142]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/meter.sh Jan 23 12:50:01 srv4hai meter.sh: SHELLY meter.sh started Jan 23 12:50:02 srv4hai meter.sh: SHELLY 'shelly-29/KÜ Schalter Herdzeile' - type: 'shelly-i3' ignoring Jan 23 12:50:02 srv4hai meter.sh: SHELLY 'shelly-28/KÜ Schalter Nasszeile' - type: 'shelly-i3' ignoring Jan 23 12:50:08 srv4hai meter.sh: SHELLY 'shelly-54/GB Kugellampe': OFFLINE, resp. not answering within connect-timeout 2.500000s Jan 23 12:50:09 srv4hai meter.sh: SHELLY 'shelly-13/Thomas Taster' - type: 'shelly-BTN' ignoring Jan 23 12:50:09 srv4hai meter.sh: SHELLY 'shelly-14/AUS-Schalter' - type: 'shelly-BTN' ignoring Jan 23 12:50:09 srv4hai meter.sh: SHELLY 'shelly-37/TB Klima' - type: 'shelly-ht' ignoring Jan 23 12:50:09 srv4hai meter.sh: SHELLY 'shelly-38/Wetterwerte Innen' - status: 'OOS' ignoring Jan 23 12:50:09 srv4hai meter.sh: SHELLY 'shelly-39/Wetterwerte Balkon' - type: 'shelly-ht-plus' ignoring Jan 23 12:50:09 srv4hai dhcpd[4995]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh Jan 23 12:50:09 srv4hai dhcpd[4995]: execute_statement argv[1] = 192.168.12.10 Jan 23 12:50:09 srv4hai dhcpd[4995]: execute_statement argv[2] = pchai7x Jan 23 12:50:09 srv4hai dhcpd[4995]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0 Jan 23 12:50:09 srv4hai dhcpd[4995]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0 Jan 23 12:50:09 srv4hai named[30406]: client @0x7f931c076a00 192.168.12.252#42643/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN) Jan 23 12:50:09 srv4hai named[30406]: client @0x7f935013a950 192.168.12.252#39975/key rndc-key: signer "rndc-key" approved Jan 23 12:50:09 srv4hai named[30406]: client @0x7f935013a950 192.168.12.252#39975/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT Jan 23 12:50:09 srv4hai named[30406]: client @0x7f935013a950 192.168.12.252#39975/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52" Jan 23 12:50:09 srv4hai named[30406]: client @0x7f935013a950 192.168.12.252#39975/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A Jan 23 12:50:09 srv4hai named[30406]: client @0x7f935013a950 192.168.12.252#39975/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10 Jan 23 12:50:09 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x' Jan 23 12:50:09 srv4hai dhcpd[4995]: Added new forward map from pchai7x.viehai.at to 192.168.12.10 Jan 23 12:50:09 srv4hai named[30406]: client @0x7f93506c16d0 192.168.12.252#55363/key rndc-key: signer "rndc-key" approved Jan 23 12:50:09 srv4hai named[30406]: client @0x7f93506c16d0 192.168.12.252#55363/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR Jan 23 12:50:09 srv4hai named[30406]: client @0x7f93506c16d0 192.168.12.252#55363/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 23 12:50:09 srv4hai dhcpd[4995]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at Jan 23 12:50:09 srv4hai activate_scenario[19811]: SHELLY last scenario: 'buero_UM' @ '124832' from 'scene_buero_UM_20250123_124832.txt' - delta=23 Jan 23 12:50:09 srv4hai activate_scenario[19811]: dateutils.ddiff -i '%Y%m%d%H%M%s' 20250123125009 20250123124832 -f '%S' Jan 23 12:50:09 srv4hai activate_scenario[19811]: SHELLY new scenario: 'pcON' different - GO ON Jan 23 12:50:10 srv4hai activate_scenario[19811]: SHELLY scenario: 'pcON(pcon)' started Jan 23 12:50:10 srv4hai activate_scenario[19811]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'
finished