Events are resetting

Posted on
Sun Jan 19, 2020 4:31 pm
vtmikel offline
Posts: 628
Joined: Aug 31, 2012
Location: Boston, MA

Events are resetting

Hi kw123,

After upgrading to the Catalina version, I've twice had my events reset. The first time I re-set them up, and found that they disappeared the day later. All events are cleared, no IP devices. Help!

Posted on
Sun Jan 19, 2020 10:12 pm
kw123 offline
User avatar
Posts: 8333
Joined: May 12, 2013
Location: Dallas, TX

Re: Events are resetting

Looks like Catalina does some wired things w file rights.

I need to look Into it .. this might take a little time.


Karl


Sent from my iPhone using Tapatalk

Posted on
Mon Jan 20, 2020 5:21 am
kw123 offline
User avatar
Posts: 8333
Joined: May 12, 2013
Location: Dallas, TX

Re: Events are resetting

.. and could you check if there is anything in the plugin.log file?


Sent from my iPhone using Tapatalk

Posted on
Wed Jan 22, 2020 5:49 pm
vtmikel offline
Posts: 628
Joined: Aug 31, 2012
Location: Boston, MA

Re: Events are resetting

Sorry for the delay. No, there doesn't appear to be anything of significance in the logs. But here is the log from the 18th of January:

Everything was working perfectly (on Catalina) using 7.30.41 (I think) before the upgrade to 7.31.50.

Code: Select all
2020-01-18 00:19:01.719   ERROR          Plugin.dorunConcurrentThread     -->  setup config, save then a manual reload of plugin
2020-01-18 00:19:01 --> while loop break  stopping ...  quitNOW was: please setup config , waiting
2020-01-18 00:19:01.729   ERROR          Plugin.dorunConcurrentThread     --> you have 2 minutes to fix config, before restart
2020-01-18 00:19:01.729   ERROR          Plugin.dorunConcurrentThread     --> do a manual reload of plugin
2020-01-18 00:19:01 stopConcurrentThread called 2
2020-01-18 00:19:04 =========================   initializing   ==============================================
2020-01-18 00:19:04 !!!!INFO ONLY!!!!  logger  enabled for   THREADDEBUG   !!!!INFO ONLY!!!!
2020-01-18 00:19:04 !!!!INFO ONLY!!!!  logger  enabled for   DEBUG         !!!!INFO ONLY!!!!
2020-01-18 00:19:04 !!!!INFO ONLY!!!!  logger  enabled for   INFO          !!!!INFO ONLY!!!!
2020-01-18 00:19:04 !!!!INFO ONLY!!!!  logger  enabled for   WARNING       !!!!INFO ONLY!!!!
2020-01-18 00:19:04.874   ERROR          Plugin.__init__                  !!!!INFO ONLY!!!!  logger  enabled for   ERROR         !!!!INFO ONLY!!!!
2020-01-18 00:19:04.874   CRITICAL       Plugin.__init__                  !!!!INFO ONLY!!!!  logger  enabled for   CRITICAL      !!!!INFO ONLY!!!!
2020-01-18 00:19:05 leaving WiFi parameters at default, not configured in 'fingscan/Configure...'
2020-01-18 00:19:05 indigo variables initialized
2020-01-18 00:19:05 getting password
2020-01-18 00:19:05 get password done;  checking if FING is installed
2020-01-18 00:19:07 fing install check done
2020-01-18 00:19:08 loaded indigo data
2020-01-18 00:19:08 network info: {'netWorkId': '10.66.0.0', 'broadcast': '10.66.0.255', 'netMask': '255.255.255.0', 'maxHosts': 254, 'hostRange': '10.66.0.1 - 10.66.0.254'}
2020-01-18 00:19:08 ifind plugin: com.corporatechameleon.iFindplugBeta
2020-01-18 00:19:08 MAP2Vendor initializing
2020-01-18 00:19:09 FING initializing parameters
startfing               L:237 Lv:20 ========= start   @ 2020-01-18 00:19:10.670348   ===========
startfing               L: 74 Lv:20 into doFingV5 with yearTag: 2020/01, netTag: 10., version: 5.4;  opsys: 10.15
2020-01-18 00:19:12 FING waiting for first data
startfing               L: 98 Lv:20 fing.bin launched
2020-01-18 00:19:32 FING initializing checking if output created, old timeStamp:1579324731.69; new timeStamp:1579324756.3
2020-01-18 00:19:32 FING initialized ..  created new data   waiting ~ 1 minute for stable operation
2020-01-18 00:19:32   FING pids after step3 = ['26915']
2020-01-18 00:19:32 (re)started FING
2020-01-18 00:19:32 FING initialized
2020-01-18 00:19:32 settings:  iDevicesEnabled              False
2020-01-18 00:19:32 settings:  inbetweenPingType            parallel
2020-01-18 00:19:32 settings:  wifiRouter                   0
2020-01-18 00:19:32 settings:  wait seconds between cycles  1
2020-01-18 00:19:32 settings:  password entered             True
2020-01-18 00:19:32 settings:  debugLevel                   []
2020-01-18 00:19:32 settings:  FINGSCAN will scan Network   10.66.0....  # fixed bits in ip range:24
2020-01-18 00:19:32

2020-01-18 00:19:32
EVENT defs::::::::::::::::::


2020-01-18 00:19:32 getting vendor info
2020-01-18 00:20:15 FINGSCAN initialized
2020-01-18 22:08:32 stopConcurrentThread called 1
2020-01-18 22:08:32 -->  exception StopThread triggered ... stopped,  quitNOW was: please setup config
2020-01-18 22:08:32 stopConcurrentThread called 2
2020-01-18 22:08:32 shutdown called
2020-01-18 22:09:33 =========================   initializing   ==============================================
2020-01-18 22:09:33 !!!!INFO ONLY!!!!  logger  enabled for   THREADDEBUG   !!!!INFO ONLY!!!!
2020-01-18 22:09:33 !!!!INFO ONLY!!!!  logger  enabled for   DEBUG         !!!!INFO ONLY!!!!
2020-01-18 22:09:33 !!!!INFO ONLY!!!!  logger  enabled for   INFO          !!!!INFO ONLY!!!!
2020-01-18 22:09:33 !!!!INFO ONLY!!!!  logger  enabled for   WARNING       !!!!INFO ONLY!!!!
2020-01-18 22:09:33.693   ERROR          Plugin.__init__                  !!!!INFO ONLY!!!!  logger  enabled for   ERROR         !!!!INFO ONLY!!!!
2020-01-18 22:09:33.694   CRITICAL       Plugin.__init__                  !!!!INFO ONLY!!!!  logger  enabled for   CRITICAL      !!!!INFO ONLY!!!!
2020-01-18 22:09:35 leaving WiFi parameters at default, not configured in 'fingscan/Configure...'
2020-01-18 22:09:36 indigo variables initialized
2020-01-18 22:09:36 getting password
2020-01-18 22:09:36 get password done;  checking if FING is installed
2020-01-18 22:09:40 fing install check done
2020-01-18 22:09:44 loaded indigo data
2020-01-18 22:09:44 network info: {'netWorkId': '10.66.0.0', 'broadcast': '10.66.0.255', 'netMask': '255.255.255.0', 'maxHosts': 254, 'hostRange': '10.66.0.1 - 10.66.0.254'}
2020-01-18 22:09:44 ifind plugin: com.corporatechameleon.iFindplugBeta
2020-01-18 22:09:44 MAP2Vendor initializing
2020-01-18 22:09:44 MAP2Vendor  downloading raw files, will take some minutes
2020-01-18 22:09:44 /usr/bin/curl -L https://standards.ieee.org/develop/regauth/oui/oui.csv      |  tail -n +2  | cut -d',' -f'2,3' | sed 's/"//'> '/Library/Application Support/Perceptive Automation/Indigo 7.4/Preferences/Plugins/com.karlwachs.fingscan/mac2Vendor/oui' &
2020-01-18 22:09:44 /usr/bin/curl -L https://standards.ieee.org/develop/regauth/oui28/mam.csv    |  tail -n +2  | cut -d',' -f'2,3' | sed 's/"//'> '/Library/Application Support/Perceptive Automation/Indigo 7.4/Preferences/Plugins/com.karlwachs.fingscan/mac2Vendor/mam' &
2020-01-18 22:09:44 /usr/bin/curl -L https://standards.ieee.org/develop/regauth/oui36/oui36.csv  |  tail -n +2  | cut -d',' -f'2,3' | sed 's/"//'> '/Library/Application Support/Perceptive Automation/Indigo 7.4/Preferences/Plugins/com.karlwachs.fingscan/mac2Vendor/oui36' &
2020-01-18 22:09:44 MAP2Vendor initializing  still waitinmg for download
2020-01-18 22:09:48 FING initializing parameters
startfing               L:237 Lv:20 ========= start   @ 2020-01-18 22:09:49.490759   ===========
2020-01-18 22:09:50 FING waiting for first data
startfing               L: 74 Lv:20 into doFingV5 with yearTag: 2020/01, netTag: 10., version: 5.4;  opsys: 10.15
startfing               L: 98 Lv:20 fing.bin launched
2020-01-18 22:10:10 FING initializing checking if output created, old timeStamp:1579403298.97; new timeStamp:1579403395.74
2020-01-18 22:10:10 FING initialized ..  created new data   waiting ~ 1 minute for stable operation
2020-01-18 22:10:10   FING pids after step3 = ['61594']
2020-01-18 22:10:10 (re)started FING
2020-01-18 22:10:10 FING initialized
2020-01-18 22:10:10 settings:  iDevicesEnabled              False
2020-01-18 22:10:10 settings:  inbetweenPingType            parallel
2020-01-18 22:10:10 settings:  wifiRouter                   0
2020-01-18 22:10:10 settings:  wait seconds between cycles  1
2020-01-18 22:10:10 settings:  password entered             True
2020-01-18 22:10:10 settings:  debugLevel                   []
2020-01-18 22:10:10 settings:  FINGSCAN will scan Network   10.66.0....  # fixed bits in ip range:24
2020-01-18 22:10:10

2020-01-18 22:10:10
EVENT defs::::::::::::::::::


2020-01-18 22:10:10 getting vendor info
2020-01-18 22:10:52 FINGSCAN initialized
2020-01-18 22:13:17 stopConcurrentThread called 1
2020-01-18 22:13:18 -->  exception StopThread triggered ... stopped,  quitNOW was: please setup config
2020-01-18 22:13:18 stopConcurrentThread called 2
2020-01-18 22:13:18 shutdown called
2020-01-18 22:13:21 =========================   initializing   ==============================================
2020-01-18 22:13:21 !!!!INFO ONLY!!!!  logger  enabled for   THREADDEBUG   !!!!INFO ONLY!!!!
2020-01-18 22:13:21 !!!!INFO ONLY!!!!  logger  enabled for   DEBUG         !!!!INFO ONLY!!!!
2020-01-18 22:13:21 !!!!INFO ONLY!!!!  logger  enabled for   INFO          !!!!INFO ONLY!!!!
2020-01-18 22:13:21 !!!!INFO ONLY!!!!  logger  enabled for   WARNING       !!!!INFO ONLY!!!!
2020-01-18 22:13:21.481   ERROR          Plugin.__init__                  !!!!INFO ONLY!!!!  logger  enabled for   ERROR         !!!!INFO ONLY!!!!
2020-01-18 22:13:21.481   CRITICAL       Plugin.__init__                  !!!!INFO ONLY!!!!  logger  enabled for   CRITICAL      !!!!INFO ONLY!!!!
2020-01-18 22:13:22 leaving WiFi parameters at default, not configured in 'fingscan/Configure...'
2020-01-18 22:13:22 indigo variables initialized
2020-01-18 22:13:22 getting password
2020-01-18 22:13:22 get password done;  checking if FING is installed
2020-01-18 22:13:24 fing install check done
2020-01-18 22:13:26 loaded indigo data
2020-01-18 22:13:26 network info: {'netWorkId': '10.66.0.0', 'broadcast': '10.66.0.255', 'netMask': '255.255.255.0', 'maxHosts': 254, 'hostRange': '10.66.0.1 - 10.66.0.254'}
2020-01-18 22:13:26 ifind plugin: com.corporatechameleon.iFindplugBeta
2020-01-18 22:13:26 MAP2Vendor initializing
2020-01-18 22:13:26 FING initializing parameters
startfing               L:237 Lv:20 ========= start   @ 2020-01-18 22:13:28.052064   ===========
startfing               L: 74 Lv:20 into doFingV5 with yearTag: 2020/01, netTag: 10., version: 5.4;  opsys: 10.15
2020-01-18 22:13:30 FING waiting for first data
startfing               L: 98 Lv:20 fing.bin launched
2020-01-18 22:13:50 FING initializing checking if output created, old timeStamp:1579403575.67; new timeStamp:1579403613.7
2020-01-18 22:13:50 FING initialized ..  created new data   waiting ~ 1 minute for stable operation
2020-01-18 22:13:50   FING pids after step3 = ['62509']
2020-01-18 22:13:50 (re)started FING
2020-01-18 22:13:50 FING initialized
2020-01-18 22:13:50 settings:  iDevicesEnabled              False
2020-01-18 22:13:50 settings:  inbetweenPingType            parallel
2020-01-18 22:13:50 settings:  wifiRouter                   0
2020-01-18 22:13:50 settings:  wait seconds between cycles  1
2020-01-18 22:13:50 settings:  password entered             True
2020-01-18 22:13:50 settings:  debugLevel                   []
2020-01-18 22:13:50 settings:  FINGSCAN will scan Network   10.66.0....  # fixed bits in ip range:24
2020-01-18 22:13:50

2020-01-18 22:13:50
EVENT defs::::::::::::::::::


2020-01-18 22:13:50 getting vendor info
2020-01-18 22:14:25 FINGSCAN initialized


Posted on
Wed Jan 22, 2020 7:51 pm
kw123 offline
User avatar
Posts: 8333
Joined: May 12, 2013
Location: Dallas, TX

Re: Events are resetting

There are 2 places where events are emptied:

1. when EVENTS is read from pluginProps
Code: Select all
         try:
            self.EVENTS=json.loads(self.pluginPrefs["EVENTS"])
         except:
            self.EVENTS = {}


2. in routine cleanup
Code: Select all
                     try:
                        indigo.devices[int(self.EVENTS[n]["IPdeviceMACnumber"][nDev])]
                     except:
                        self.indiLOG.log(40, u"cleanupEVENTS removing device from evants as indigo device does not exist:"+ unicode(self.EVENTS[n]["IPdeviceMACnumber"][nDev]) )
                        self.EVENTS[n]["IPdeviceMACnumber"][nDev] = "0"   


as there is no entry in the log file it seems that reading the EVENT dict from pluginprops seems to not work.

so could you:
1. create a new event with at least one device Events#1 and use device#1
2. check file /Library/Application Support/Perceptive Automation/Indigo 7.4/Preferences/Plugins/com.karlwachs.fingscan.indiPref

look for: <EVENTS type="string">{&quot;11&quot;: {&quot;iDeviceUseForAway&q

copy that line to an editor (BBEDIT) and do a find/replace "}" with "}\n" and "{" with "\n{" w/o the "
that makes it readable

Check before, after creating event, after 5 minutes, if the event defs are fine, then restart the plugin and check again (just once)

==> it should contain the events definitions with MAC# timers .. ...
the EVENTS dict is VVVVVERY long
try to
find MAC#
where MAC#are some of your devices that should be in the event it should look like:
>> &quot;1&quot;: &quot;B8:27:EB:38:F2:31&quot;, <<

if they are not present then the plugin /indigo does not save the defs.
if they are the json.loads fails.

Mine works fine. I need to be able to find where it goes wrong .. gets deleted or don't get loaded

Karl

Posted on
Wed Jan 22, 2020 9:21 pm
kw123 offline
User avatar
Posts: 8333
Joined: May 12, 2013
Location: Dallas, TX

Re: Events are resetting

And also very simple
1 define an event
2 print event config( menu )
3 wait 3 minutes
4 print event config
5 Reload plugin
6 print event config

Karl


Sent from my iPhone using Tapatalk

Posted on
Thu Jan 23, 2020 5:53 pm
vtmikel offline
Posts: 628
Joined: Aug 31, 2012
Location: Boston, MA

Re: Events are resetting

I've been trying a number of these combinations to recreate the issue. The plugin has held a single event for 24 hours without a problem. I've now re-created the four events I typically use, and done the print and restart steps you suggested. So far no problems. Will keep monitoring.

Posted on
Thu Jan 23, 2020 5:56 pm
kw123 offline
User avatar
Posts: 8333
Joined: May 12, 2013
Location: Dallas, TX

Re: Events are resetting

Could you do a reload and check if the events are still there?

That’s the only ways it could lose the contents w/o log entry when the read fAils.

I will add an error check to that read.

Karl.


Sent from my iPhone using Tapatalk

Posted on
Thu Jan 23, 2020 5:57 pm
vtmikel offline
Posts: 628
Joined: Aug 31, 2012
Location: Boston, MA

Re: Events are resetting

Restarted the plugin several times. Loading the events just fine.

Posted on
Thu Jan 23, 2020 6:11 pm
kw123 offline
User avatar
Posts: 8333
Joined: May 12, 2013
Location: Dallas, TX

Re: Events are resetting

Then I don’t understand.

So let’s wait. I will post a version with more logging.

Karl


Sent from my iPhone using Tapatalk

Posted on
Thu Jan 23, 2020 8:07 pm
kw123 offline
User avatar
Posts: 8333
Joined: May 12, 2013
Location: Dallas, TX

Events are resetting

please install v .52. it will tell if the read from indigo prefs file is bad or empty.

Karl

Posted on
Sat Jan 25, 2020 7:56 am
vtmikel offline
Posts: 628
Joined: Aug 31, 2012
Location: Boston, MA

Re: Events are resetting

I'm baffled as well, but glad that it has not returned. The only thing that I can think of is -- when I was previously re-creating my events after the removal, I renamed several of my IP devices during the process of setting the events.

All seems stable now, but will continue to monitor.

Thanks for your help.

Page 1 of 1

Who is online

Users browsing this forum: No registered users and 1 guest