activate_scenario.sh
Fri Jul 12 08:14:23 CEST 2024
scenario: pcOFF
source: 192.168.12.10

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

scenario: 'Schreibtisch Thomas AUS-schalten' - 'pcOFF' - 'pcoff'

Thomas Schreibtischlampe (/srv/www/viehai/shelly/log_scenarios/2024/07/12/_0.log)

vorher: 08:14:23.611

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

nachher: 08:14:23.635
Dauer: 24 msec phName: 'shelly-0:'''


scenario: 'Schreibtisch Thomas AUS-schalten' - 'pcOFF' - 'pcoff'

urls : 1
vorher : 08:14:23.591
nachher: 08:14:23.642
Dauer : 50 msec
outfile: '/srv/www/viehai/shelly/log_scenarios/2024/07/12//scene_pcOFF_20240712_081423.txt'


syslog

Jul 12 08:11:01 srv4hai CRON[3709]: (root) CMD (/etc/linetest/linetest.sh)
Jul 12 08:11:17 srv4hai nmbd[2172]: [2024/07/12 08:11:17.062889,  0] ../source3/nmbd/nmbd_browsesync.c:354(find_domain_master_name_query_fail)
Jul 12 08:11:17 srv4hai nmbd[2172]:   find_domain_master_name_query_fail:
Jul 12 08:11:17 srv4hai nmbd[2172]:   Unable to find the Domain Master Browser name WORKGROUP<1b> for the workgroup WORKGROUP.
Jul 12 08:11:17 srv4hai nmbd[2172]:   Unable to sync browse lists in this workgroup.
Jul 12 08:11:17 srv4hai postfix/smtpd[3727]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jul 12 08:11:17 srv4hai postfix/smtpd[3727]: connect from mail.shadowserver.org[154.9.2.12]
Jul 12 08:11:18 srv4hai postfix/smtpd[3729]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jul 12 08:11:18 srv4hai postfix/smtpd[3729]: connect from mail.shadowserver.org[154.9.2.12]
Jul 12 08:11:18 srv4hai postfix/smtpd[3727]: F12196000F: client=mail.shadowserver.org[154.9.2.12]
Jul 12 08:11:19 srv4hai postfix/smtpd[3729]: 188CE6018B: client=mail.shadowserver.org[154.9.2.12]
Jul 12 08:11:19 srv4hai postfix/cleanup[3731]: F12196000F: message-id=<20240712061108.XN4jc-autoreports@shadowserver.org>
Jul 12 08:11:19 srv4hai postfix/qmgr[8566]: F12196000F: from=, size=5618, nrcpt=1 (queue active)
Jul 12 08:11:19 srv4hai postfix/smtpd[3727]: disconnect from mail.shadowserver.org[154.9.2.12] ehlo=2 starttls=1 mail=1 rcpt=1 data=1 quit=1 commands=7
Jul 12 08:11:19 srv4hai postfix/local[3733]: warning: database /etc/aliases.db is older than source file /etc/aliases
Jul 12 08:11:19 srv4hai postfix/local[3733]: F12196000F: to=, orig_to=, relay=local, delay=0.2, delays=0.18/0.01/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jul 12 08:11:19 srv4hai postfix/qmgr[8566]: F12196000F: removed
Jul 12 08:11:19 srv4hai postfix/cleanup[3732]: 188CE6018B: message-id=<20240712061110.Ikv2r-autoreports@shadowserver.org>
Jul 12 08:11:19 srv4hai postfix/qmgr[8566]: 188CE6018B: from=, size=5481, nrcpt=1 (queue active)
Jul 12 08:11:19 srv4hai postfix/smtpd[3729]: disconnect from mail.shadowserver.org[154.9.2.12] ehlo=2 starttls=1 mail=1 rcpt=1 data=1 quit=1 commands=7
Jul 12 08:11:19 srv4hai postfix/local[3733]: 188CE6018B: to=, orig_to=, relay=local, delay=0.21, delays=0.2/0/0/0.01, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jul 12 08:11:19 srv4hai postfix/qmgr[8566]: 188CE6018B: removed
Jul 12 08:11:45 srv4hai common[3743]: SHELLY common.sh inkludiert von ./shelly/check_shelly.sh
Jul 12 08:11:45 srv4hai check_shelly.sh: SHELLY last scenery executed: 'buero_UM'
Jul 12 08:11:45 srv4hai check_shelly.sh: SHELLY found '3' active shelly outputs
Jul 12 08:11:45 srv4hai common[3767]: SHELLY common.sh inkludiert von ./shelly/prep_viehai.sh
Jul 12 08:11:45 srv4hai common.sh: SHELLY: BTstatus[0]:'On' dweetAge:'10'=1720764705-1720764695
Jul 12 08:11:45 srv4hai common.sh: SHELLY: BTstatus[1]:'Off' dweetAge:'10'=1720764705-1720764695
Jul 12 08:11:45 srv4hai common.sh: SHELLY: BTstatus[2]:'Off' dweetAge:'10'=1720764705-1720764695
Jul 12 08:12:01 srv4hai CRON[3846]: (root) CMD (/etc/linetest/linetest.sh)
Jul 12 08:12:12 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1720764732 - 'ping_SP_0'
Jul 12 08:12:12 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 12 08:12:45 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/dhcpcommit.sh
Jul 12 08:12:45 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.10
Jul 12 08:12:45 srv4hai dhcpd[30731]: execute_statement argv[2] = pchai7x
Jul 12 08:12:45 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.10 from 70:54:d2:7b:fe:a7 via enp2s0
Jul 12 08:12:45 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.10 to 70:54:d2:7b:fe:a7 via enp2s0
Jul 12 08:12:45 srv4hai named[30406]: client @0x7f931006ae50 192.168.12.252#43137/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: pchai7x.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 12 08:12:45 srv4hai named[30406]: client @0x7f9348081920 192.168.12.252#41799/key rndc-key: signer "rndc-key" approved
Jul 12 08:12:45 srv4hai named[30406]: client @0x7f9348081920 192.168.12.252#41799/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' TXT
Jul 12 08:12:45 srv4hai named[30406]: client @0x7f9348081920 192.168.12.252#41799/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' TXT "001e3ad86ca86e10b8e2aaf2e2ade54f52"
Jul 12 08:12:45 srv4hai named[30406]: client @0x7f9348081920 192.168.12.252#41799/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'pchai7x.viehai.at' A
Jul 12 08:12:45 srv4hai named[30406]: client @0x7f9348081920 192.168.12.252#41799/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'pchai7x.viehai.at' A 192.168.12.10
Jul 12 08:12:45 srv4hai dhcpd[30731]: Added new forward map from pchai7x.viehai.at to 192.168.12.10
Jul 12 08:12:45 srv4hai dhcpcommit.sh: SHELLY ip:'192.168.12.10'(10) device 'pchai7x'
Jul 12 08:12:45 srv4hai named[30406]: client @0x7f932c097490 192.168.12.252#41377/key rndc-key: signer "rndc-key" approved
Jul 12 08:12:45 srv4hai named[30406]: client @0x7f932c097490 192.168.12.252#41377/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '10.12.168.192.in-addr.arpa' PTR
Jul 12 08:12:45 srv4hai named[30406]: client @0x7f932c097490 192.168.12.252#41377/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.
Jul 12 08:12:45 srv4hai dhcpd[30731]: Added reverse map from 10.12.168.192.in-addr.arpa. to pchai7x.viehai.at
Jul 12 08:12:45 srv4hai activate_scenario[3887]: SHELLY scenario: 'pcON(pcon)' started
Jul 12 08:12:45 srv4hai activate_scenario[3887]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - origin:'dhcpcommit.sh-pchai7x'
Jul 12 08:12:45 srv4hai activate_scenario[3887]: SHELLY scenario: 'pcON(pcon)' TO BE EXECUTED, origin:'dhcpcommit.sh-pchai7x'
Jul 12 08:12:45 srv4hai postfix/pickup[23170]: 681DF6018B: uid=33 from=
Jul 12 08:12:45 srv4hai postfix/cleanup[3731]: 681DF6018B: message-id=<20240712061245.681DF6018B@mail.viehai.at>
Jul 12 08:12:45 srv4hai postfix/qmgr[8566]: 681DF6018B: from=, size=12412, nrcpt=1 (queue active)
Jul 12 08:12:45 srv4hai postfix/local[3733]: 681DF6018B: to=, orig_to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "null")
Jul 12 08:12:45 srv4hai postfix/cleanup[3732]: 6C1ED601BF: message-id=<20240712061245.6C1ED601BF@mail.viehai.at>
Jul 12 08:12:45 srv4hai postfix/bounce[3941]: 681DF6018B: sender non-delivery notification: 6C1ED601BF
Jul 12 08:12:45 srv4hai postfix/qmgr[8566]: 6C1ED601BF: from=<>, size=14294, nrcpt=1 (queue active)
Jul 12 08:12:45 srv4hai postfix/qmgr[8566]: 681DF6018B: removed
Jul 12 08:12:45 srv4hai activate_scenario[3887]: SHELLY: scenario: 'pcON(pcon)'-'shelly-20'-'Thomas Schreibtischlampe' --> '0?turn=on'
Jul 12 08:12:45 srv4hai postfix/local[3733]: 6C1ED601BF: to=, relay=local, delay=0.01, delays=0/0/0/0, dsn=2.0.0, status=sent (delivered to command: /bin/procmail)
Jul 12 08:12:45 srv4hai postfix/qmgr[8566]: 6C1ED601BF: removed
Jul 12 08:12:45 srv4hai proc_url[3954]: SHELLY: OF:'/srv/www/viehai/shelly/log_scenarios/2024/07/12/_0.log' - shellyUsage:'Thomas Schreibtischlampe' - scUrl:'http://192.168.12.120/relay/0?turn=on' - phName:'origin:'dhcpcommit.sh-pchai7x''
Jul 12 08:12:45 srv4hai activate_scenario[3887]: SHELLY scenario: 'pcON(pcon)' took 54 msec, origin:'dhcpcommit.sh-pchai7x'
Jul 12 08:13:01 srv4hai CRON[3988]: (root) CMD (/etc/linetest/linetest.sh)
Jul 12 08:13:01 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=3994, secured, session=
Jul 12 08:13:01 srv4hai dovecot: imap(miglincit)<3994>: Logged out in=29 out=529 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 12 08:13:01 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=3996, secured, session=
Jul 12 08:13:01 srv4hai dovecot: imap(miglincit)<3996>: Logged out in=44 out=186901 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 12 08:13:02 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4002, secured, session=
Jul 12 08:13:02 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4003, secured, session=
Jul 12 08:13:02 srv4hai dovecot: imap(miglincit)<4002>: Logged out in=422 out=44782 deleted=0 expunged=0 trashed=0 hdr_count=50 hdr_bytes=18331 body_count=0 body_bytes=0
Jul 12 08:13:03 srv4hai dovecot: imap(miglincit)<4003>: Logged out in=269803 out=1175812 deleted=0 expunged=0 trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Jul 12 08:13:05 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4008, secured, session=
Jul 12 08:13:05 srv4hai dovecot: imap(miglincit)<4008>: Logged out in=480 out=3043 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=551 body_count=2 body_bytes=450
Jul 12 08:13:09 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4011, secured, session=
Jul 12 08:13:09 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4013, secured, session=
Jul 12 08:13:09 srv4hai dovecot: imap(miglincit)<4013>: Logged out in=441 out=20255 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=379 body_count=1 body_bytes=18169
Jul 12 08:13:09 srv4hai dovecot: imap(miglincit)<4011>: Logged out in=739 out=39954 deleted=0 expunged=0 trashed=10 hdr_count=11 hdr_bytes=6801 body_count=0 body_bytes=0
Jul 12 08:13:13 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4020, secured, session=
Jul 12 08:13:13 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4022, secured, session=
Jul 12 08:13:13 srv4hai dovecot: imap(miglincit)<4020>: Logged out in=746 out=36720 deleted=0 expunged=0 trashed=10 hdr_count=12 hdr_bytes=3478 body_count=0 body_bytes=0
Jul 12 08:13:13 srv4hai dovecot: imap(miglincit)<4022>: Logged out in=480 out=3052 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=552 body_count=2 body_bytes=450
Jul 12 08:13:16 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4036, secured, session=
Jul 12 08:13:17 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4038, secured, session=
Jul 12 08:13:17 srv4hai dovecot: imap(miglincit)<4036>: Logged out in=774 out=41166 deleted=0 expunged=0 trashed=10 hdr_count=16 hdr_bytes=7180 body_count=0 body_bytes=0
Jul 12 08:13:17 srv4hai dovecot: imap(miglincit)<4038>: Logged out in=441 out=3629 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=704 body_count=1 body_bytes=1383
Jul 12 08:13:21 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4045, secured, session=
Jul 12 08:13:21 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4047, secured, session=
Jul 12 08:13:21 srv4hai dovecot: imap(miglincit)<4045>: Logged out in=753 out=44409 deleted=0 expunged=0 trashed=8 hdr_count=15 hdr_bytes=10833 body_count=0 body_bytes=0
Jul 12 08:13:21 srv4hai dovecot: imap(miglincit)<4047>: Logged out in=397 out=153411 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=533 body_count=1 body_bytes=151190
Jul 12 08:13:22 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4049, secured, session=<6aDFxgYdzOkAAAAAAAAAAAAAAAAAAAAB>
Jul 12 08:13:22 srv4hai dovecot: imap(miglincit)<4049><6aDFxgYdzOkAAAAAAAAAAAAAAAAAAAAB>: Logged out in=443 out=53004 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=387 body_count=1 body_bytes=51064
Jul 12 08:13:23 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4051, secured, session=
Jul 12 08:13:24 srv4hai dovecot: imap-login: Login: user=, method=PLAIN, rip=::1, lip=::1, mpid=4053, secured, session=
Jul 12 08:13:24 srv4hai dovecot: imap(miglincit)<4051>: Logged out in=620 out=30881 deleted=0 expunged=0 trashed=2 hdr_count=2 hdr_bytes=533 body_count=0 body_bytes=0
Jul 12 08:13:24 srv4hai dovecot: imap(miglincit)<4053>: Logged out in=397 out=16308 deleted=0 expunged=0 trashed=0 hdr_count=1 hdr_bytes=1681 body_count=1 body_bytes=12983
Jul 12 08:13:25 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 1 sucessfully  @~1720764805 - 'ping_SP_0'
Jul 12 08:13:25 srv4hai ping_SP[2543]: SHELLY (0) - ping 192.168.12.61 pCnt:'1'
Jul 12 08:13:37 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
Jul 12 08:13:37 srv4hai dhcpd[30731]: DHCPDISCOVER from ec:da:3b:c6:1d:3c via enp2s0
Jul 12 08:13:37 srv4hai dhcpd[30731]: DHCPOFFER on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Jul 12 08:13:37 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
Jul 12 08:13:37 srv4hai dhcpd[30731]: execute_statement argv[0] = /srv/www/viehai/shelly/json.sh
Jul 12 08:13:37 srv4hai dhcpd[30731]: execute_statement argv[1] = 192.168.12.150
Jul 12 08:13:37 srv4hai dhcpd[30731]: execute_statement argv[2] = shelly-50
Jul 12 08:13:37 srv4hai dhcpd[30731]: DHCPREQUEST for 192.168.12.150 (192.168.12.252) from ec:da:3b:c6:1d:3c via enp2s0
Jul 12 08:13:37 srv4hai dhcpd[30731]: DHCPACK on 192.168.12.150 to ec:da:3b:c6:1d:3c via enp2s0
Jul 12 08:13:37 srv4hai named[30406]: client @0x7f93501490e0 192.168.12.252#50391/key rndc-key: updating zone 'viehai.at/IN': update unsuccessful: shelly-50.viehai.at: 'name not in use' prerequisite not satisfied (YXDOMAIN)
Jul 12 08:13:37 srv4hai named[30406]: client @0x7f931c09c730 192.168.12.252#53849/key rndc-key: signer "rndc-key" approved
Jul 12 08:13:37 srv4hai named[30406]: client @0x7f931c09c730 192.168.12.252#53849/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' TXT
Jul 12 08:13:37 srv4hai named[30406]: client @0x7f931c09c730 192.168.12.252#53849/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' TXT "31ddfcf6e79cbbdf4e55e03247020075f9"
Jul 12 08:13:37 srv4hai named[30406]: client @0x7f931c09c730 192.168.12.252#53849/key rndc-key: updating zone 'viehai.at/IN': deleting rrset at 'shelly-50.viehai.at' A
Jul 12 08:13:37 srv4hai named[30406]: client @0x7f931c09c730 192.168.12.252#53849/key rndc-key: updating zone 'viehai.at/IN': adding an RR at 'shelly-50.viehai.at' A 192.168.12.150
Jul 12 08:13:37 srv4hai dhcpd[30731]: Added new forward map from shelly-50.viehai.at to 192.168.12.150
Jul 12 08:13:37 srv4hai named[30406]: client @0x7f931c0a07f0 192.168.12.252#33153/key rndc-key: signer "rndc-key" approved
Jul 12 08:13:37 srv4hai named[30406]: client @0x7f931c0a07f0 192.168.12.252#33153/key rndc-key: updating zone '12.168.192.in-addr.arpa/IN': deleting rrset at '150.12.168.192.in-addr.arpa' PTR
Jul 12 08:13:37 srv4hai named[30406]: client @0x7f931c0a07f0 192.168.12.252#33153/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.
Jul 12 08:13:37 srv4hai dhcpd[30731]: Added reverse map from 150.12.168.192.in-addr.arpa. to shelly-50.viehai.at
Jul 12 08:13:37 srv4hai common[4069]: SHELLY common.sh inkludiert von /srv/www/viehai/shelly/grab_shelly.sh
Jul 12 08:13:37 srv4hai grab_shelly.sh: SHELLY shellyName/1:'shelly-50' - shIP/2:'' perform:'conf'
Jul 12 08:13:37 srv4hai mosquitto[18551]: New connection from 192.168.12.150 on port 1883.
Jul 12 08:13:37 srv4hai mosquitto[18551]: Client shellypmminig3-ecda3bc61d3c already connected, closing old connection.
Jul 12 08:13:37 srv4hai mosquitto[18551]: Socket error on client shellypmminig3-ecda3bc61d3c, disconnecting.
Jul 12 08:13:37 srv4hai mosquitto[18551]: New client connected from 192.168.12.150 as shellypmminig3-ecda3bc61d3c (c1, k60, u'shmqtt').
Jul 12 08:13:38 srv4hai conf_shelly.sh: SHELLY: PARAMS  shName/1:'shelly-50' - shIP/2:'192.168.12.150'
Jul 12 08:13:38 srv4hai conf_shelly.sh: SHELLY: usage/name '50-TBD' already set for '192.168.12.150'
Jul 12 08:13:38 srv4hai conf_shelly.sh: SHELLY:'shelly-50' no WebHook
Jul 12 08:14:01 srv4hai CRON[4131]: (root) CMD (/etc/linetest/linetest.sh)
Jul 12 08:14:23 srv4hai activate_scenario[4146]: SHELLY scenario: 'pcOFF(pcoff)' started
Jul 12 08:14:23 srv4hai activate_scenario[4146]: SHELLY dayState='day' <--> DayTime=checked NightTime=checked - shelly-0:''

finished