Validate & Fix Links Issue

Having problems with IHMC CmapTools? Think you have found a bug? Let us know!
Forum rules
Before you post a problem or bug, please be sure you have included the version number of IHMC CmapTools, the operating system and version, the amount of RAM, and any other information that allows us to be able to replicate the problem you are having. (i.e. what were you doing when the problem occur? were you running another program (application) by the time you have the problem?)
Post Reply
DChrome
Posts: 3
Joined: Fri Nov 06, 2020 6:59 am

Validate & Fix Links Issue

Post by DChrome »

Hi,

I've just started using CmapTools and while getting familiar with the tool I've encountered some strange behavior in the "Validate & Fix Links" functionality.

In a new concept map I add a concept and attach a URL resource to it. The URL is functioning normally and I am able to navigate to the destination successfully. However, when I run "Validate & Fix Links" -> "Search Only", I am getting a message about a broken link. The problem description says: "Input error".
CmapTools-Broken-Link.jpg
I've tried the automatic fix, removing and reattaching the resource to the concept, completely deleting and re-creating it, but I'm getting the same issue on running "Validate & Fix Links".

I am adding the client side log that shows the following operations in order:
  1. Create a new concept map
  2. Add a new concept
  3. Right click on the concept -> Add web address
  4. Fill in Resource Name and a valid Web Address
  5. Save the concept map
  6. Run Tools -> Validate & Fix Links
The log

Code: Select all

***>>> AddVectorOfGraphicalEntities was called.
RM::handleSaveResourceEvt: rid 1WB21MS4T-12RVR5Q-87S resId 1WB21MS4T-XG32Y4-87R
RM::saveResource: url == file:/var/folders/4q/j_dxbksn5t54fgp1ghg4z4cc0000gn/T/Test.url and resource == null
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket) RS::handleHashtable: function == BeginWritingResource
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket) Resource::beginWritingResource:
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket) Resource::beginWritingResource: savePrincipalPart == true
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket) Resource::beginWritingResource: They have WRITE perms, so we will proceed to save.
WM::beginWritingResource: folderId 1W9PB32CW-20HFN3S-Z resourceInfo._resourceId 1WB21MS4T-12RVR5Q-87S
WM::beginWritingResource: resourceId 1WB21MS4T-12RVR5Q-87S doesn't exist yet. Must create Test
WM::checkForConflictingNameAndMIMEType: (folderId 1W9PB32CW-20HFN3S-Z, resourceInfo._resourceId 1WB21MS4T-12RVR5Q-87S)
WM::beginWritingNewResource: resourceInfo._resourceId 1WB21MS4T-12RVR5Q-87S
WriteInfo::<init>: We will use directory /Users/paul/Documents/My Cmaps/.temp for copying and creating resources.
WriteInfo::<init>: _folderId == 1W9PB32CW-20HFN3S-Z
WriteInfo::<init>: _parentPathname = /Users/paul/Documents/My Cmaps
WriteInfo::<init>: _resourceInfoFilename = /Users/paul/Documents/My Cmaps/Test.url
WriteInfo::<init>: _resourceInfo.getResourceMIMETypeRef() = text/x-url
WriteInfo::<init>: returning with no errors.
WriteInfo::createTmpDir: Trying to create tmpdir in the cmap root folder's scratch directory /Users/paul/Documents/My Cmaps/.temp
WriteInfo::createTmpDir: Trying to create tmpdir /Users/paul/Documents/My Cmaps/.temp/cmap163814472309618301.dir
WriteInfo::createTmpDir: Created tmpdir /Users/paul/Documents/My Cmaps/.temp/cmap163814472309618301.dir on first try.
RawClient: DID NOT catch anything!
ClientWriter::writeResource (InputStream is): writing 176 bytes.
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket)::Resource::BeginWritingResource::Send reply: (5 ms.)
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket) RS::handleHashtable: function == writePart
WM::writePart: (writeToken==1WB21MS6G-1R9R6DB-87V, partName==cmap, contentType==text/x-url, data==[B@1d085de9)
WriteInfo::writePart: partName == cmap contentType == text/x-url 176 bytes.
RM::writePartsWithPartWriters: resource == file:/var/folders/4q/j_dxbksn5t54fgp1ghg4z4cc0000gn/T/Test.url
RM::writePartsWithPartWriters: This must not be a multipart resource. Its partWriterInfos hashtable is null
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket)::Reused::Resource::writePart::Send reply: (2 ms.)
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket) RS::handleHashtable: function == doneWritingResource
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket) Resource::doneWritingResource:
WM::doneWritingResource:
WriteInfo::doneWritingResource: principalContentType = text/x-url
WriteInfo::doneWritingResource: Since the principalContentType (text/x-url) is not equal to application/cmap+xml or x-cmap/x-storable we won't even check to see if we need to generate HTML.
WriteInfo::doneWritingResource: npartsWritten == 1
WriteInfo::doneWritingResource: npartsToDelete == 0
WriteInfo::doneWritingResource: _existingResourceFileIsMultipart == false
WriteInfo::doneWritingResource: is x-cmap == false
WriteInfo::doneWritingResource: Won't zip cmap
WriteInfo::doneWritingResource: Renamed '/Users/paul/Documents/My Cmaps/.temp/cmap163814472309618301.dir/cmap' to '/Users/paul/Documents/My Cmaps/Test.url'
WriteInfo::doneWritingResource: The resource /Users/paul/Documents/My Cmaps/Test.url did not already exist. Adding its ResourceInfo now.
PM::addResourceInfoToFolder: folderId == 1W9PB32CW-20HFN3S-Z
PM::addResourceInfoEntry: Adding resourceEntry (rid 1WB21MS4T-12RVR5Q-87S, parentId 1W9PB32CW-20HFN3S-Z, name Test.url) with 0 children
PM::saveProject: (/Users/paul/Documents/My Cmaps)
PM::saveProject: We'll save to /Users/paul/Documents/My Cmaps/.project.idx and then rename it to /Users/paul/Documents/My Cmaps/project.idx
PM::saveProject: Successfully opened tmpfile /Users/paul/Documents/My Cmaps/.project.idx
PM::saveProject: Successfully saved Project to /Users/paul/Documents/My Cmaps/.project.idx
PM::saveProject: Successfully deleted /Users/paul/Documents/My Cmaps/project.idx or it didn't exist; now rename /Users/paul/Documents/My Cmaps/.project.idx to /Users/paul/Documents/My Cmaps/project.idx
PM::saveProject: Successfully renamed /Users/paul/Documents/My Cmaps/.project.idx to /Users/paul/Documents/My Cmaps/project.idx
WriteInfo::addResourceInfoToProject: Successfully added new ResourceInfo for /Users/paul/Documents/My Cmaps/Test.url
WriteInfo::deleteDirectory: '/Users/paul/Documents/My Cmaps/.temp/cmap163814472309618301.dir'
WriteInfo::doneWritingResource: Successfully deleted temporary directory /Users/paul/Documents/My Cmaps/.temp/cmap163814472309618301.dir
PM::saveProject: (/Users/paul/Documents/My Cmaps)
PM::saveProject: We'll save to /Users/paul/Documents/My Cmaps/.project.idx and then rename it to /Users/paul/Documents/My Cmaps/project.idx
PM::saveProject: Successfully opened tmpfile /Users/paul/Documents/My Cmaps/.project.idx
PM::saveProject: Successfully saved Project to /Users/paul/Documents/My Cmaps/.project.idx
PM::saveProject: Successfully deleted /Users/paul/Documents/My Cmaps/project.idx or it didn't exist; now rename /Users/paul/Documents/My Cmaps/.project.idx to /Users/paul/Documents/My Cmaps/project.idx
PM::saveProject: Successfully renamed /Users/paul/Documents/My Cmaps/.project.idx to /Users/paul/Documents/My Cmaps/project.idx
[06/Nov/2020:14:23:46] ICS::IndexChangeService::IndexChangedListener::resourceAdded: ****
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket) Resource::doneWritingResource: has marked the folder 1W9PB32CW-20HFN3S-Z /Users/paul/Documents/My Cmaps for recaching, because this change affects the folder.
[06/Nov/2020:14:23:46] ICS::TPImpl::run: Pool:IndexChange_0 Indexing resource 18 with 0 pending.
[06/Nov/2020:14:23:46] ICS::TPImpl::run: Resource 18 indexed.
[06/Nov/2020:14:23:46] ICS::TPImpl::run: Pool:IndexChange_0 Indexing resource 19 with 0 pending.
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket) Resource::doneWritingResource: Saved /Users/paul/Documents/My Cmaps/Test.url (176 bytes in 0 ms.)
[06/Nov/2020:14:23:46] ICS::DocumentBuilder::run: S IndexChange_0 1WB21MS4T-12RVR5Q-87S  Starting document build for Test
[06/Nov/2020:14:23:46] ICS::DocumentBuilder::findOrCreateDoc: The "url" and "shorturl" fields will contain file:////Users/paul/Documents/My Cmaps/Test.url
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket)::Reused::Resource::doneWritingResource::Send reply::CLOSED: (15 ms.)
[06/Nov/2020:14:23:46] ICS::CMIndex::startRead: Trying to acquire index read lock...
[06/Nov/2020:14:23:46] ICS::CMIndex::startRead: Acquired index read lock.
[06/Nov/2020:14:23:46] ICS::CMIndex::writeIndex: Writing to iw org.apache.lucene.index.IndexWriter@1e4dc18f
[06/Nov/2020:14:23:46] ICS::CMIndex::writeIndex: Number of documents before write is 0
posting vnse for My Cmaps
Voting on menu items for My Cmaps
posting vnse for My Cmaps
Voting on menu items for My Cmaps
posting vnse for My Cmaps
Voting on menu items for My Cmaps
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket) RS::handleHashtable: function == getMetaData
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-1] (pseudo-socket)::Resource::getMetaData::Send reply::CLOSED: (3 ms.)
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getResourceInfoPathToResource
[06/Nov/2020:14:23:46] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getResourceInfoPathToResource::Send reply::CLOSED: (3 ms.)
***>>> AddVectorOfGraphicalEntities was called.
***>>> Added a NON-Trans RL 'Test' to rg:text/html
[06/Nov/2020:14:23:46] ICS::CMIndex::writeIndex: Number of documents after write is 1
[06/Nov/2020:14:23:46] ICS::CMIndex::writeIndex:  isRemote: false ready: true
[06/Nov/2020:14:23:46] ICS::CMIndex::finishRead: Released index read lock.
[06/Nov/2020:14:23:46] ICS::DocumentBuilder::run: E IndexChange_0 1WB21MS4T-12RVR5Q-87S Ending document build for Test
[06/Nov/2020:14:23:46] ICS::TPImpl::run: Resource 19 indexed.
[SpellCheckHelper] beginChecking.
[CMapSpellChecker] beginChecking.
[SpellCheckHelper] endChecking.
***>>> hndlSaveEvt RI.id = 1WB21KQWL-6FJK4J-800
SD: Id of the five ri 1W9PB32CW-20HFN3S-Z
[06/Nov/2020:14:24:56] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getRootResourceInfo
[06/Nov/2020:14:24:56] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getRootResourceInfo::Send reply::CLOSED: (2 ms.)
|||||||||||||||||||||||||||||||this| nlk.util.LayerManagerComponent[,0,0,502x502,alignmentX=0.0,alignmentY=0.0,border=,flags=0,maximumSize=,minimumSize=,preferredSize=java.awt.Dimension[width=502,height=502]]
|||||||||||||||||||||||||||||||source| nlk.util.LayerManagerComponent[,0,0,502x502,alignmentX=0.0,alignmentY=0.0,border=,flags=0,maximumSize=,minimumSize=,preferredSize=java.awt.Dimension[width=502,height=502]]
|||||||||||||||||||||||||||||||ancestor| javax.swing.JScrollPane[,0,0,491x497,layout=javax.swing.ScrollPaneLayout$UIResource,alignmentX=0.0,alignmentY=0.0,border=com.apple.laf.AquaScrollRegionBorder@2cefe7f3,flags=268435784,maximumSize=,minimumSize=java.awt.Dimension[width=185,height=574],preferredSize=java.awt.Dimension[width=185,height=574],columnHeader=,horizontalScrollBar=javax.swing.JScrollPane$ScrollBar[,2,480,472x15,alignmentX=0.0,alignmentY=0.0,border=,flags=4194304,maximumSize=,minimumSize=,preferredSize=,blockIncrement=10,orientation=HORIZONTAL,unitIncrement=1],horizontalScrollBarPolicy=HORIZONTAL_SCROLLBAR_ALWAYS,lowerLeft=,lowerRight=,rowHeader=,upperLeft=,upperRight=,verticalScrollBar=javax.swing.JScrollPane$ScrollBar[,474,2,15x478,alignmentX=0.0,alignmentY=0.0,border=,flags=4194304,maximumSize=,minimumSize=,preferredSize=,blockIncrement=10,orientation=VERTICAL,unitIncrement=1],verticalScrollBarPolicy=VERTICAL_SCROLLBAR_ALWAYS,viewport=javax.swing.JViewport[,2,2,472x478,layout=javax.swing.ViewportLayout,alignmentX=0.0,alignmentY=0.0,border=,flags=25165832,maximumSize=,minimumSize=,preferredSize=,isViewSizeSet=true,lastPaintPosition=java.awt.Point[x=0,y=0],scrollUnderway=false],viewportBorder=]
[06/Nov/2020:14:24:56] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getRootFolderId
[06/Nov/2020:14:24:56] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getRootFolderId::Send reply::CLOSED: (1 ms.)
[06/Nov/2020:14:24:56] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getFolderTOC
[06/Nov/2020:14:24:56] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getFolderTOC::Send SerializableObject::CLOSED::Sent 1145 bytes::1145 Kbytes/sec: (1 ms.)
***>>> OrigResInfo = nlk.base.ResourceInfo@70f1524c
***>>>          ri = nlk.base.ResourceInfo@70f1524c
***>>> OrigResInfo.rid = 1WB21KQWL-6FJK4J-800
***>>>          ri.rid = 1WB21KQWL-6FJK4J-800
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getRootResourceInfo
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getRootResourceInfo::Send reply::CLOSED: (3 ms.)
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getRootFolderId
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getRootFolderId::Send reply::CLOSED: (1 ms.)
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getFolderTOC
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getFolderTOC::Send SerializableObject::CLOSED::Sent 1145 bytes::572 Kbytes/sec: (2 ms.)
***>>>       newRI = nlk.base.ResourceInfo@69f2530a
***>>>       newRI.rid = 1WB21KQWL-6FJK4J-800
***>>>     oLtOrig = null
***>>> Saving Map OldRI id = 1WB21KQWL-6FJK4J-800
***>>>               RI id = 1WB21KQWL-6FJK4J-800
RM::handleSaveResourceEvt: rid 1WB21KQWL-6FJK4J-800 resId 1WB21QR33-DTC49G-8D5
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getResourceInfoPathToResource
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getResourceInfoPathToResource::Send reply::CLOSED: (1 ms.)
nlk.exception.resio.ResioXcp: 1WB21KQWL-6FJK4J-800: code==39 (Could not find resource Id )
RequestHandler::sendServerRequest: Received a GenericXcp from My CMaps (127.0.0.1)
(CLASS: nlk.resio.RawClient METHOD: getResourceInfoPathToResource LINE: 1021)
nlk.exception.resio.ResioXcp: 1WB21KQWL-6FJK4J-800
	at nlk.resio.ProjectManager.getResourceInfoPathToResource(ProjectManager.java:2373)
	at nlk.resio.PrivServer.getResourceInfoPathToResource(PrivServer.java:1896)
	at nlk.resio.ResourceService.getResourceInfoPathToResource(ResourceService.java:2488)
	at nlk.resio.ResourceService.handleHashtable(ResourceService.java:212)
	at nlk.resio.ResourceService.requestToService(ResourceService.java:96)
	at edu.uwf.server.ServiceManager.requestToService(ServiceManager.java:317)
	at edu.uwf.server.ConnManager.handleConnection(ConnManager.java:244)
	at edu.uwf.net.socket.ConnHandlerThreadCache$HandlerThread.run(ConnHandlerThreadCache.java:142)
ResourceManagerMod::handleSaveResourceEvt: Unable to getFolderPath to original the cmap in Save As.
RM::saveResource: url == null and resource == nlk.base.ConceptMap@70deaa46
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == BeginWritingResource
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::beginWritingResource:
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::beginWritingResource: savePrincipalPart == true
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::beginWritingResource: They have WRITE perms, so we will proceed to save.
WM::beginWritingResource: folderId 1W9PB32CW-20HFN3S-Z resourceInfo._resourceId 1WB21KQWL-6FJK4J-800
WM::beginWritingResource: resourceId 1WB21KQWL-6FJK4J-800 doesn't exist yet. Must create Test-Cmap
WM::checkForConflictingNameAndMIMEType: (folderId 1W9PB32CW-20HFN3S-Z, resourceInfo._resourceId 1WB21KQWL-6FJK4J-800)
WM::beginWritingNewResource: resourceInfo._resourceId 1WB21KQWL-6FJK4J-800
WriteInfo::<init>: We will use directory /Users/paul/Documents/My Cmaps/.temp for copying and creating resources.
WriteInfo::<init>: _folderId == 1W9PB32CW-20HFN3S-Z
WriteInfo::<init>: _parentPathname = /Users/paul/Documents/My Cmaps
WriteInfo::<init>: _resourceInfoFilename = /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
WriteInfo::<init>: _resourceInfo.getResourceMIMETypeRef() = x-cmap/x-storable
WriteInfo::<init>: returning with no errors.
WriteInfo::createTmpDir: Trying to create tmpdir in the cmap root folder's scratch directory /Users/paul/Documents/My Cmaps/.temp
WriteInfo::createTmpDir: Trying to create tmpdir /Users/paul/Documents/My Cmaps/.temp/cmap3537134625296880859.dir
WriteInfo::createTmpDir: Created tmpdir /Users/paul/Documents/My Cmaps/.temp/cmap3537134625296880859.dir on first try.
RawClient: DID NOT catch anything!
***>>> Fixed a resourceURL [Test]: file:////Users/paul/Documents/My Cmaps/Test.url
RM::saveResource: cmapRepresentation == serialized
ClientWriter::writeResource (InputStream is): writing 7581 bytes.
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::BeginWritingResource::Send reply: (6 ms.)
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == writePart
WM::writePart: (writeToken==1WB21QR5F-1F7D2F9-8D8, partName==cmap, contentType==x-cmap/x-storable, data==[B@21a3c1d0)
WriteInfo::writePart: partName == cmap contentType == x-cmap/x-storable 7581 bytes.
RM::writePartsWithPartWriters: resource == nlk.base.ConceptMap@70deaa46
RM::writePartsWithPartWriters: This must be a multipart resource. Its partWriterInfos hashtable is not null
RM::writePartsWithPartWriters: Examining instructions from partWriter soup_client_registrant
HTMLExportMod::getData:
HTMLExportMod::getData: moduleEvt == nlk.event.resourceManager.SaveResourceEvt@4d5f5a4f
HTMLExportMod::getData: The destination for the cmap is My Cmaps. Hence we should not save any HTML parts.
RM::writePartsWithPartWriters: Examining instructions from partWriter htmltextRegistrant
RM::writePartsWithPartWriters: (htmltextRegistrant): partWriter for htmltext part with mimeType text/html returned data of type nlk.util.DeleteResourcePart@2f222038
RM::writePartsWithPartWriters: (htmltextRegistrant): partWriter for htmljpeg part with mimeType image/jpeg returned data of type nlk.util.DeleteResourcePart@697154b4
RM::writePartsWithPartWriters: (htmltextRegistrant): partWriter for htmlindex part with mimeType text/html returned data of type nlk.util.DeleteResourcePart@f702b81
RM::writePartsWithPartWriters: (htmltextRegistrant): partWriter for htmlhead part with mimeType text/html returned data of type nlk.util.DeleteResourcePart@d382a12
RM::writePartsWithPartWriters: (htmltextRegistrant): partWriter for htmlfoot part with mimeType text/html returned data of type nlk.util.DeleteResourcePart@62520a85
 DTClientMod::getData:
 DTClientMod::getData: DT part written
RM::writePartsWithPartWriters: Examining instructions from partWriter DTPartWriter
RM::writePartsWithPartWriters: (DTPartWriter): DTPartWriter returned NULL for the data to be saved. Preserve existing partName DiscussionThreadInfo mimeType x-cmap/x-discussionthread
MapHistoryMod:::***** DELETING MAPHISTORY PART ***** [nlk.base.PartWriterData@7830d430]
RM::writePartsWithPartWriters: Examining instructions from partWriter mapHistoryPartWriter
RM::writePartsWithPartWriters: (mapHistoryPartWriter): partWriter for MapHistory part with mimeType x-mapHistory/x-storable returned data of type nlk.util.DeleteResourcePart@4dbad8f5
RM::writePartsWithPartWriters: Examining instructions from partWriter presentationPartWriter
RM::writePartsWithPartWriters: (presentationPartWriter): presentationPartWriter returned NULL for the data to be saved. Preserve existing partName presentation mimeType x-presentation/x-storable
RM::writePartsWithPartWriters: Examining instructions from partWriter annotationPartWriter
RM::writePartsWithPartWriters: (annotationPartWriter): annotationPartWriter returned NULL for the data to be saved. Preserve existing partName Annotations mimeType x-annotations/x-storable
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Reused::Resource::writePart::Send reply: (6 ms.)
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == doneWritingResource
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::doneWritingResource:
WM::doneWritingResource:
WriteInfo::determineIfPlaceHolderCmap:
WriteInfo::determineIfPlaceHolderCmap: _isPlaceHolderCmap is already set (to false) so a new client must be saving this Cmap whose destination will be /Users/paul/Documents/My Cmaps/Test-Cmap.cmap; its length is 7581
WriteInfo::doneWritingResource: principalContentType = x-cmap/x-storable
WriteInfo::doneWritingResource: Since we are saving this Cmap to a CmapTools "client", we will not generate any HTML.
WriteInfo::convertPartToXML: _saveAsXML == false so just return.
WriteInfo::doneWritingResource: npartsWritten == 1
WriteInfo::doneWritingResource: npartsToDelete == 6
WriteInfo::doneWritingResource: WriteInfo::doneWritingResource: Will delete the following parts: 'htmlfoot' : 'htmltext' : 'MapHistory' : 'htmlindex' : 'htmlhead' : 'htmljpeg'
WriteInfo::doneWritingResource: _existingResourceFileIsMultipart == false
WriteInfo::doneWritingResource: is x-cmap == true
WriteInfo::doneWritingResource: Will zip the only existing part into /Users/paul/Documents/My Cmaps/.temp/cmap3537134625296880859.dir/cmap3029309486034927810.tmp and rename it to /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
WriteInfo::doneWritingResource: Renamed '/Users/paul/Documents/My Cmaps/.temp/cmap3537134625296880859.dir/cmap3029309486034927810.tmp' to '/Users/paul/Documents/My Cmaps/Test-Cmap.cmap'
WriteInfo::doneWritingResource: The resource /Users/paul/Documents/My Cmaps/Test-Cmap.cmap did not already exist. Adding its ResourceInfo now.
PM::addResourceInfoToFolder: folderId == 1W9PB32CW-20HFN3S-Z
PM::addResourceInfoEntry: Adding resourceEntry (rid 1WB21KQWL-6FJK4J-800, parentId 1W9PB32CW-20HFN3S-Z, name Test-Cmap.cmap) with 0 children
PM::saveProject: (/Users/paul/Documents/My Cmaps)
PM::saveProject: We'll save to /Users/paul/Documents/My Cmaps/.project.idx and then rename it to /Users/paul/Documents/My Cmaps/project.idx
PM::saveProject: Successfully opened tmpfile /Users/paul/Documents/My Cmaps/.project.idx
PM::saveProject: Successfully saved Project to /Users/paul/Documents/My Cmaps/.project.idx
PM::saveProject: Successfully deleted /Users/paul/Documents/My Cmaps/project.idx or it didn't exist; now rename /Users/paul/Documents/My Cmaps/.project.idx to /Users/paul/Documents/My Cmaps/project.idx
PM::saveProject: Successfully renamed /Users/paul/Documents/My Cmaps/.project.idx to /Users/paul/Documents/My Cmaps/project.idx
ProjectManager::checkForMissingThumbnail: No thumbnail exists yet for RID 1WB21KQWL-6FJK4J-800 with pathname /Users/paul/Documents/My Cmaps/Test-Cmap.cmap so we will enqueue it for thumbnail generation.
WriteInfo::addResourceInfoToProject: Successfully added new ResourceInfo for /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
WriteInfo::deleteDirectory: '/Users/paul/Documents/My Cmaps/.temp/cmap3537134625296880859.dir'
GregTG::run: Examining thumbnail element for RID 1WB21KQWL-6FJK4J-800
WriteInfo::deleteDirectory: /Users/paul/Documents/My Cmaps/.temp/cmap3537134625296880859.dir/cmap is just a file; so just delete it.
GregTG::run: Trying to generate a non-empty thumbnail for RID 1WB21KQWL-6FJK4J-800 : /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
WriteInfo::createTmpFile: Trying to create tmpfile in the cmap root folder's scratch directory /Users/paul/Documents/My Cmaps/.temp
WriteInfo::doneWritingResource: Successfully deleted temporary directory /Users/paul/Documents/My Cmaps/.temp/cmap3537134625296880859.dir
PM::saveProject: (/Users/paul/Documents/My Cmaps)
GregTG::run: Created path /Users/paul/Documents/My Cmaps/.temp/cmap5047382638927234593.gif exists == true
PM::saveProject: We'll save to /Users/paul/Documents/My Cmaps/.project.idx and then rename it to /Users/paul/Documents/My Cmaps/project.idx
PM::saveProject: Successfully opened tmpfile /Users/paul/Documents/My Cmaps/.project.idx
WriteInfo::createTmpFile: Trying to create tmpfile in the cmap root folder's scratch directory /Users/paul/Documents/My Cmaps/.temp
SBR::getTokensAndPartnames: cmapRepresentation == serialized
SBR::getTokensAndPartnames: The tokens are:
1WB21QR65-1T939Z4-8DX:cmap
SBR::readResource(): Attempting to read the cmap part.
SBR::readResource(): Successfully read the 7581 bytes of the cmap part.
SBR::readResource(): Successfully deserialized the cmap part.
SBR::readResource(): READ: cmap: 3: 7581: Test-Cmap
SBR::readResource(): Returning res nlk.base.ConceptMap@378c404c, having gotten the cmap via its cmap part.

***>>> Saving Map to Image File : [0]
***>>>        /Users/paul/Documents/My Cmaps/.temp/cmap5073633569482076742.jpg
***>>>        areAllImagesRaterized = True
***>>>        Unfinished Images [0]:
***>>>        Size = java.awt.Dimension[width=45,height=42]

*** Trying in Memory Image because: 7560 bytes, is less than 1048576.
PM::saveProject: Successfully saved Project to /Users/paul/Documents/My Cmaps/.project.idx
***>>>   Finished Saving Map to Image File:
***>>>        /Users/paul/Documents/My Cmaps/.temp/cmap5073633569482076742.jpg
GregTG::createTmpJPEG: Apparently successfully created jpeg tmpfile /Users/paul/Documents/My Cmaps/.temp/cmap5073633569482076742.jpg from the "cmap" part of srcPath  /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
ResourceTokenManager::releaseToken: Didn't expect this.removeToken (1WB21QR65-1T939Z4-8DX) to return null.
PM::saveProject: Successfully deleted /Users/paul/Documents/My Cmaps/project.idx or it didn't exist; now rename /Users/paul/Documents/My Cmaps/.project.idx to /Users/paul/Documents/My Cmaps/project.idx
GregAlarm::startTimer: Timer started for 40000 ms.
PM::saveProject: Successfully renamed /Users/paul/Documents/My Cmaps/.project.idx to /Users/paul/Documents/My Cmaps/project.idx
WriteInfo::doneWritingResource: Queueing non-empty resource /Users/paul/Documents/My Cmaps/Test-Cmap.cmap for thumbnail generation.
GregAlarm::run: Woke up from wait()
GregAlarm::run: Calling timed wait(40000)
[06/Nov/2020:14:25:14] ICS::IndexChangeService::IndexChangedListener::resourceAdded: ****
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::doneWritingResource: has marked the folder 1W9PB32CW-20HFN3S-Z /Users/paul/Documents/My Cmaps for recaching, because this change affects the folder.
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::doneWritingResource: Saved /Users/paul/Documents/My Cmaps/Test-Cmap.cmap (7581 bytes in 1 ms. -- 7581KBytes/sec)
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Pool:IndexChange_0 Indexing resource 20 with 0 pending.
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Resource 20 indexed.
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Pool:IndexChange_0 Indexing resource 21 with 0 pending.
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::run: S IndexChange_0 1WB21KQWL-6FJK4J-800  Starting document build for Test-Cmap
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::findOrCreateDoc: The "url" and "shorturl" fields will contain file:////Users/paul/Documents/My Cmaps/Test-Cmap.cmap
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::processResourceInfo: Got a cmap
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::addConceptMap: Building document for Test-Cmap
PS::getResourceReader: secondaryRR == null for secondaryPartName cmap
SBR::getTokensAndPartnames: cmapRepresentation == serialized
SBR::getTokensAndPartnames: The tokens are:
1WB21QR6L-1PFC494-8FJ:cmap
SBR::readResource(): Attempting to read the cmap part.
SBR::readResource(): Successfully read the 7581 bytes of the cmap part.
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Reused::Resource::doneWritingResource::Send reply::CLOSED: (28 ms.)
SBR::readResource(): Successfully deserialized the cmap part.
SBR::readResource(): READ: cmap: 2: 7581: Test-Cmap
SBR::readResource(): Returning res nlk.base.ConceptMap@3efd0ac2, having gotten the cmap via its cmap part.
[06/Nov/2020:14:25:14] ICS::CMIndex::startRead: Trying to acquire index read lock...
[06/Nov/2020:14:25:14] ICS::CMIndex::startRead: Acquired index read lock.
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex: Writing to iw org.apache.lucene.index.IndexWriter@1e4dc18f
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex: Number of documents before write is 1
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getResourceInfoPathToResource
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getResourceInfoPathToResource::Send reply::CLOSED: (4 ms.)
GregTG::run: Calling imgman and calling waitFor.
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex: Number of documents after write is 2
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex:  isRemote: false ready: true
[06/Nov/2020:14:25:14] ICS::CMIndex::finishRead: Released index read lock.
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::run: E IndexChange_0 1WB21KQWL-6FJK4J-800 Ending document build for Test-Cmap
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Resource 21 indexed.
StreamGobbler::run: 4>Will terminate after 30 seconds and 0 uSecs
StreamGobbler::run: 4> - Creating 128x128 square thumbnail of /Users/paul/Documents/My Cmaps/.temp/cmap5073633569482076742.jpg -> /Users/paul/Documents/My Cmaps/.temp/cmap5047382638927234593.gif
StreamGobbler::run: 4>   - 27ms to process image.
GregAlarm::cancelTimer: Timer cancelled after 65 ms.
GregTG::run: Primary call to imgman returned 0 for /Users/paul/Documents/My Cmaps/.temp/cmap5073633569482076742.jpg
GregTG::run: path:/Users/paul/Documents/My Cmaps/Test-Cmap.cmap:(1) Command succeeded after 66 ms.:/Applications/IHMC CmapTools/bin/imgman -m 128x128 none /Users/paul/Documents/My Cmaps/.temp/cmap5073633569482076742.jpg /Users/paul/Documents/My Cmaps/.temp/cmap5047382638927234593.gif 30000
GregTG::run: Total processing time for /Users/paul/Documents/My Cmaps/Test-Cmap.cmap was 217217 ms.
GregAlarm::run: _timeToInterrupt now 0 Woke up from timed wait(40000) after 65 ms.
GregAlarm::run: NOT Interrupting ThumbnailGeneration thread.
GregAlarm::run: Calling wait()
PS::setThumbnail: renamed tmpfile /Users/paul/Documents/My Cmaps/.temp/cmap5047382638927234593.gif to final destination /Users/paul/Documents/My Cmaps/.cmapthumbs/1WB21KQWL-6FJK4J-800.gif
[06/Nov/2020:14:25:14] ICS::IndexChangeService::IndexChangedListener::resourceInfoChanged: ****
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Pool:IndexChange_0 Indexing resource 22 with 0 pending.
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Resource 22 indexed.
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Pool:IndexChange_0 Indexing resource 23 with 0 pending.
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::run: S IndexChange_0 1WB21KQWL-6FJK4J-800  Starting document build for Test-Cmap
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::findOrCreateDoc: The "url" and "shorturl" fields will contain file:////Users/paul/Documents/My Cmaps/Test-Cmap.cmap
GregTG::run: Examining thumbnail element for RID 1WB21KQWL-6FJK4J-800
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::findOrCreateDoc: Adding thumbnail for /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
GregTG::run: Trying to generate a non-empty thumbnail for RID 1WB21KQWL-6FJK4J-800 : /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
WriteInfo::createTmpFile: Trying to create tmpfile in the cmap root folder's scratch directory /Users/paul/Documents/My Cmaps/.temp
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::processResourceInfo: Got a cmap
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::addConceptMap: Building document for Test-Cmap
GregTG::run: Created path /Users/paul/Documents/My Cmaps/.temp/cmap2478052295666060187.gif exists == true
PS::getResourceReader: secondaryRR == null for secondaryPartName cmap
SBR::getTokensAndPartnames: cmapRepresentation == serialized
SBR::getTokensAndPartnames: The tokens are:
1WB21QR8Q-6DL337-8FN:cmap
SBR::readResource(): Attempting to read the cmap part.
posting vnse for My Cmaps
Voting on menu items for My Cmaps
WriteInfo::createTmpFile: Trying to create tmpfile in the cmap root folder's scratch directory /Users/paul/Documents/My Cmaps/.temp
SBR::readResource(): Successfully read the 7581 bytes of the cmap part.
posting vnse for My Cmaps
Voting on menu items for My Cmaps
SBR::getTokensAndPartnames: cmapRepresentation == serialized
SBR::getTokensAndPartnames: The tokens are:
1WB21QR8R-1BZJ10T-8FQ:cmap
SBR::readResource(): Attempting to read the cmap part.
SBR::readResource(): Successfully read the 7581 bytes of the cmap part.
SBR::readResource(): Successfully deserialized the cmap part.
SBR::readResource(): READ: cmap: 2: 7581: Test-Cmap
SBR::readResource(): Returning res nlk.base.ConceptMap@773a59d3, having gotten the cmap via its cmap part.
[06/Nov/2020:14:25:14] ICS::CMIndex::startRead: Trying to acquire index read lock...
[06/Nov/2020:14:25:14] ICS::CMIndex::startRead: Acquired index read lock.
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex: Writing to iw org.apache.lucene.index.IndexWriter@1e4dc18f
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex: Number of documents before write is 2
SBR::readResource(): Successfully deserialized the cmap part.
SBR::readResource(): READ: cmap: 2: 7581: Test-Cmap
SBR::readResource(): Returning res nlk.base.ConceptMap@17df68cc, having gotten the cmap via its cmap part.

***>>> Saving Map to Image File : [0]
***>>>        /Users/paul/Documents/My Cmaps/.temp/cmap228215383938085477.jpg
***>>>        areAllImagesRaterized = True
***>>>        Unfinished Images [0]:
***>>>        Size = java.awt.Dimension[width=45,height=42]

*** Trying in Memory Image because: 7560 bytes, is less than 1048576.
***>>>   Finished Saving Map to Image File:
***>>>        /Users/paul/Documents/My Cmaps/.temp/cmap228215383938085477.jpg
GregTG::createTmpJPEG: Apparently successfully created jpeg tmpfile /Users/paul/Documents/My Cmaps/.temp/cmap228215383938085477.jpg from the "cmap" part of srcPath  /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
ResourceTokenManager::releaseToken: Didn't expect this.removeToken (1WB21QR8R-1BZJ10T-8FQ) to return null.
GregAlarm::startTimer: Timer started for 40000 ms.
GregAlarm::run: Woke up from wait()
GregAlarm::run: Calling timed wait(40000)
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getMetaData
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getMetaData::Send reply::CLOSED: (7 ms.)
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex: Number of documents after write is 2
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex:  isRemote: false ready: true
[06/Nov/2020:14:25:14] ICS::CMIndex::finishRead: Released index read lock.
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::run: E IndexChange_0 1WB21KQWL-6FJK4J-800 Ending document build for Test-Cmap
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Resource 23 indexed.
GregTG::run: Calling imgman and calling waitFor.
***>>>            newRI id = 1WB21KQWL-6FJK4J-800
>>> CMVM - Requesting a write lock.
RLM::getResourceLockInfo: rli == null
RM::handleGetResourceLockEvt:
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == GetResourceLock
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::getResourceLock: checkPermission for folderId 1W9PB32CW-20HFN3S-Z returned Principal admin
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::createLock:
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::createLock: Must create an EditLock for resourceId 1WB21KQWL-6FJK4J-800 pathname /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::createLock: Setting the access time for newClientId '1WB08KHT7-20B5T44-9'
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::createLock: Updated the LockInfo's resourceInfo.
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::createLock: ri.getTimeModifiedRef    == 1604665514742
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::createLock: clone.getTimeModifiedRef == 1604665514742
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::createLock: returning LockToken 1W9PB2ZZ8-TVHJ41-1+1WB21KQWL-6FJK4J-800 for resourceId 1WB21KQWL-6FJK4J-800 pathname /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::getResourceLock: 1. returning LockToken for resourceId 1WB21KQWL-6FJK4J-800 pathname /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::GetResourceLock::Send reply::CLOSED: (21 ms.)
RM::handleGetResourceLockEvt: newRI ModifiedTime = 06/Nov/2020:14:25:14
lockToken.getServerId() == 1W9PB2ZZ8-TVHJ41-1
lockToken.getResourceId() == 1WB21KQWL-6FJK4J-800
>>> CMVM - Got a LockReqReply
>>> CMVM -    Handling reply for lock of 1W9PB2ZZ8-TVHJ41-1 : 1W9PB32CW-20HFN3S-Z : 1WB21KQWL-6FJK4J-800
>>> CMVM -    I got the Lock.
>>> CMVM -    lockToken = 1W9PB2ZZ8-TVHJ41-1+1WB21KQWL-6FJK4J-800
>>> CMVM -    lockType = Edit
StreamGobbler::run: 5>Will terminate after 30 seconds and 0 uSecs
StreamGobbler::run: 5> - Creating 128x128 square thumbnail of /Users/paul/Documents/My Cmaps/.temp/cmap228215383938085477.jpg -> /Users/paul/Documents/My Cmaps/.temp/cmap2478052295666060187.gif
StreamGobbler::run: 5>   - 27ms to process image.
GregAlarm::cancelTimer: Timer cancelled after 59 ms.
GregTG::run: Primary call to imgman returned 0 for /Users/paul/Documents/My Cmaps/.temp/cmap228215383938085477.jpg
GregTG::run: path:/Users/paul/Documents/My Cmaps/Test-Cmap.cmap:(1) Command succeeded after 59 ms.:/Applications/IHMC CmapTools/bin/imgman -m 128x128 none /Users/paul/Documents/My Cmaps/.temp/cmap228215383938085477.jpg /Users/paul/Documents/My Cmaps/.temp/cmap2478052295666060187.gif 30000
GregTG::run: Total processing time for /Users/paul/Documents/My Cmaps/Test-Cmap.cmap was 69 ms.
GregAlarm::run: _timeToInterrupt now 0 Woke up from timed wait(40000) after 60 ms.
GregAlarm::run: NOT Interrupting ThumbnailGeneration thread.
GregAlarm::run: Calling wait()
PS::setThumbnail: renamed tmpfile /Users/paul/Documents/My Cmaps/.temp/cmap2478052295666060187.gif to final destination /Users/paul/Documents/My Cmaps/.cmapthumbs/1WB21KQWL-6FJK4J-800.gif
[06/Nov/2020:14:25:14] ICS::IndexChangeService::IndexChangedListener::resourceInfoChanged: ****
GregTG::run: The thumbnail stack is empty, so we will sleep for 10000 ms. and then try to get rid of any temp files mistakenly left behind by the image processing routines.
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Pool:IndexChange_0 Indexing resource 24 with 0 pending.
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getResourceInfo
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Resource 24 indexed.
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket) Resource::getResourceInfo: checkPermission for folderId 1WB21KQWL-6FJK4J-800 returned Principal admin
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Pool:IndexChange_0 Indexing resource 25 with 0 pending.
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::run: S IndexChange_0 1WB21KQWL-6FJK4J-800  Starting document build for Test-Cmap
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::findOrCreateDoc: The "url" and "shorturl" fields will contain file:////Users/paul/Documents/My Cmaps/Test-Cmap.cmap
[06/Nov/2020:14:25:14] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getResourceInfo::Send reply::CLOSED: (4 ms.)
>>> CMVM - Got the newRI via the rawClient.
>>> CMVM - oldRI ID       = 1WB21KQWL-6FJK4J-800
>>> CMVM - newRI ID       = 1WB21KQWL-6FJK4J-800
>>> CMVM - oldRI ModifiedTime = 1604665514742 == 06/Nov/2020:14:25:14
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::findOrCreateDoc: Adding thumbnail for /Users/paul/Documents/My Cmaps/Test-Cmap.cmap
>>> CMVM - newRI ModifiedTime = 1604665514742 == 06/Nov/2020:14:25:14
>>> CMVM - Finished handling LockReqReply
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::processResourceInfo: Got a cmap
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::addConceptMap: Building document for Test-Cmap
PS::getResourceReader: secondaryRR == null for secondaryPartName cmap
SBR::getTokensAndPartnames: cmapRepresentation == serialized
SBR::getTokensAndPartnames: The tokens are:
1WB21QRC0-16CZF6X-8FZ:cmap
SBR::readResource(): Attempting to read the cmap part.
SBR::readResource(): Successfully read the 7581 bytes of the cmap part.
SBR::readResource(): Successfully deserialized the cmap part.
SBR::readResource(): READ: cmap: 7: 7581: Test-Cmap
SBR::readResource(): Returning res nlk.base.ConceptMap@12e75a9a, having gotten the cmap via its cmap part.
[06/Nov/2020:14:25:14] ICS::CMIndex::startRead: Trying to acquire index read lock...
[06/Nov/2020:14:25:14] ICS::CMIndex::startRead: Acquired index read lock.
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex: Writing to iw org.apache.lucene.index.IndexWriter@1e4dc18f
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex: Number of documents before write is 2
GregTG::cleanOutTempFiles: Making the cleanup call to imgman to delete temp files that look like "magick*" and calling waitFor.
***> Ignored MenuItemChosenEvt: [File/SaveMap] The CMapComponent does not have the focus.
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex: Number of documents after write is 2
[06/Nov/2020:14:25:14] ICS::CMIndex::writeIndex:  isRemote: false ready: true
[06/Nov/2020:14:25:14] ICS::CMIndex::finishRead: Released index read lock.
[06/Nov/2020:14:25:14] ICS::DocumentBuilder::run: E IndexChange_0 1WB21KQWL-6FJK4J-800 Ending document build for Test-Cmap
[06/Nov/2020:14:25:14] ICS::TPImpl::run: Resource 25 indexed.
GregTG::cleanOutTempFiles: Cleanup call to imgman returned 23
ResourceTokenManager::LockTimeoutTask::run: There are 0 tokens allocated.





Finder ending and notifying
Validator waiting getting url to validate
RM::handleGetResourceReaderEvt: evt._serverID 1W9PB2ZZ8-TVHJ41-1
RM::handleGetResourceReaderEvt: evt._folderID 1W9PB32CW-20HFN3S-Z
RM::handleGetResourceReaderEvt: evt._resourceID 1WB21MS4T-12RVR5Q-87S
[06/Nov/2020:14:25:42] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == GetResourceReader
[06/Nov/2020:14:25:42] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::GetResourceReader::Send reply::CLOSED: (3 ms.)
RM::handleGetResourceReaderEvt: mimeType == text/x-url
RM::handleGetResourceReaderEvt: partReaderInfos == null
RM::handleGetResourceReaderEvt: URL file:////Users/paul/Documents/My Cmaps/Test.url
[06/Nov/2020:14:25:42] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == getResourceInfoPathToResource
[06/Nov/2020:14:25:42] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::getResourceInfoPathToResource::Send reply::CLOSED: (1 ms.)
Validator resuming getting url to validate
Validator ending
Validating url: Test on Map: Test-Cmap
RM::handleGetResourceReaderEvt: evt._serverID 1W9PB2ZZ8-TVHJ41-1
RM::handleGetResourceReaderEvt: evt._folderID 1W9PB32CW-20HFN3S-Z
RM::handleGetResourceReaderEvt: evt._resourceID 1WB21MS4T-12RVR5Q-87S
[06/Nov/2020:14:25:42] [ConnHandlerCache-1-Thread-0] (pseudo-socket) RS::handleHashtable: function == GetResourceReader
[06/Nov/2020:14:25:42] [ConnHandlerCache-1-Thread-0] (pseudo-socket)::Resource::GetResourceReader::Send reply::CLOSED: (1 ms.)
RM::handleGetResourceReaderEvt: mimeType == text/x-url
RM::handleGetResourceReaderEvt: partReaderInfos == null
RM::handleGetResourceReaderEvt: URL file:////Users/paul/Documents/My Cmaps/Test.url
URL Validator ending and notifying
Finder ending and notifying
URL Validator ending and notifying
Fixer ended and notify
Opening the result dialog
ResourceTokenManager::LockTimeoutTask::run: There are 2 tokens allocated.
[06/Nov/2020:14:26:04] SLP: next DA is mesh-enhanced: 184.182.233.158:80:8001
[06/Nov/2020:14:26:04] SLP: (UA) could not send multicast request: Can't assign requested address
[06/Nov/2020:14:26:04] SLP: (UA) contacting DA: 184.182.233.158:80:8001
[06/Nov/2020:14:26:04] SLP: (UA) could not send multicast request: Can't assign requested address
[06/Nov/2020:14:26:05] SLP: (UA) could not send multicast request: Can't assign requested address
[06/Nov/2020:14:26:05] SLP: (UA) could not send multicast request: Can't assign requested address
[06/Nov/2020:14:26:07] SLP: (UA) could not send multicast request: Can't assign requested address
[06/Nov/2020:14:26:07] SLP: (UA) could not send multicast request: Can't assign requested address
[06/Nov/2020:14:26:11] SLP: (UA) could not send multicast request: Can't assign requested address
[06/Nov/2020:14:26:11] SLP: (UA) could not send multicast request: Can't assign requested address
BasicMod::hndlWndEvts: Not exiting because there are still apparently windows opened.
BasicMod::hndlWndEvts: Here is what we have in our table of opened windows.
BasicMod::hndlWndEvts: ==================================
    nlk.cmap.CMapWnd
    nlk.folderBrowser.FolderBrowserWnd
    nlk.folderBrowser.FolderBrowserWnd
    nlk.cmap.CMapWnd
BasicMod::hndlWndEvts: ==================================
Is there a bug or am I doing something wrong?

System info

OS: macOS Catalina v10.15.7
CmapTools: v6.04

I'd appreciate your help.
Thanks
cmapadmin
Site Admin
Posts: 793
Joined: Sat Dec 13, 2008 2:22 pm

Re: Validate & Fix Links Issue

Post by cmapadmin »

Hi,

The URL you are using is

file:/var/folders/4q/j_dxbksn5t54fgp1ghg4z4cc0000gn/T/Test.url

Correct? Just confirming.

Does the validate and fix links work ok with web URLs?
DChrome
Posts: 3
Joined: Fri Nov 06, 2020 6:59 am

Re: Validate & Fix Links Issue

Post by DChrome »

It looks to me like some kind of internal path manipulation by the application. I have no idea what this path is.

I am trying to add a simple web URL. Here are some screenshots:

https://www.imgpaste.net/image/IIThe

Edit: Updated the screenshot image link.
Last edited by DChrome on Fri Nov 06, 2020 9:10 am, edited 1 time in total.
DChrome
Posts: 3
Joined: Fri Nov 06, 2020 6:59 am

Re: Validate & Fix Links Issue

Post by DChrome »

The forum configuration didn't allow me to add the second screenshot to the post.
Here it is: https://www.imgpaste.net/image/IIs4T
cmapadmin
Site Admin
Posts: 793
Joined: Sat Dec 13, 2008 2:22 pm

Re: Validate & Fix Links Issue

Post by cmapadmin »

OK, we were able to reproduce the problem. There definitely is a bug here. Thanks for reporting it.
Post Reply