[teiid-issues] [JBoss JIRA] Commented: (TEIID-1554) NullPointerException in NodeEditor

Mark Addleman (JIRA) jira-events at lists.jboss.org
Wed Apr 13 16:30:33 EDT 2011


    [ https://issues.jboss.org/browse/TEIID-1554?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=12595406#comment-12595406 ] 

Mark Addleman commented on TEIID-1554:
--------------------------------------

We've applied patches to 1492, 1529 and 1545.  I can test against stock 7.3 if that will help.  Below is the plan output (sorry about the bad log formatting)

[13:23:11.649][info][talledLocalContainer] 13:23:11,649 INFO  [PLANNER] 
[13:23:11.649][info][talledLocalContainer] ============================================================================
[13:23:11.649][info][talledLocalContainer] USER COMMAND:
[13:23:11.650][info][talledLocalContainer] SELECT C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__" FROM SECURITY.BASEUSER AS C LEFT OUTER JOIN security.sysinfo AS CHORUS_J0 ON CHORUS_J0.sysid = C.sysid ORDER BY C.NAME LIMIT 990, 10
[13:23:11.650][info][talledLocalContainer] 
[13:23:11.650][info][talledLocalContainer] ----------------------------------------------------------------------------
[13:23:11.650][info][talledLocalContainer] OPTIMIZE: 
[13:23:11.650][info][talledLocalContainer] SELECT C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__" FROM SECURITY.BASEUSER AS C LEFT OUTER JOIN security.sysinfo AS CHORUS_J0 ON CHORUS_J0.sysid = C.sysid ORDER BY C.NAME LIMIT 990, 10
[13:23:11.650][info][talledLocalContainer] 
[13:23:11.650][info][talledLocalContainer] ----------------------------------------------------------------------------
[13:23:11.650][info][talledLocalContainer] GENERATE CANONICAL: 
[13:23:11.650][info][talledLocalContainer] SELECT C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__" FROM SECURITY.BASEUSER AS C LEFT OUTER JOIN security.sysinfo AS CHORUS_J0 ON CHORUS_J0.sysid = C.sysid ORDER BY C.NAME LIMIT 990, 10
[13:23:11.650][info][talledLocalContainer] 
[13:23:11.650][info][talledLocalContainer] CANONICAL PLAN: 
[13:23:11.650][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.650][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.650][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.650][info][talledLocalContainer]       Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={JOIN_STRATEGY=NESTED_LOOP, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.650][info][talledLocalContainer]         Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.650][info][talledLocalContainer]         Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.650][info][talledLocalContainer] 
[13:23:11.650][info][talledLocalContainer] 
[13:23:11.650][info][talledLocalContainer] ----------------------------------------------------------------------------
[13:23:11.651][info][talledLocalContainer] OPTIMIZE: 
[13:23:11.651][info][talledLocalContainer] SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo
[13:23:11.651][info][talledLocalContainer] 
[13:23:11.651][info][talledLocalContainer] ----------------------------------------------------------------------------
[13:23:11.651][info][talledLocalContainer] GENERATE CANONICAL: 
[13:23:11.651][info][talledLocalContainer] SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo
[13:23:11.651][info][talledLocalContainer] 
[13:23:11.651][info][talledLocalContainer] CANONICAL PLAN: 
[13:23:11.651][info][talledLocalContainer] Project(groups=[], props={PROJECT_COLS=[COUNT(*)]})
[13:23:11.651][info][talledLocalContainer]   Group(groups=[])
[13:23:11.651][info][talledLocalContainer]     Source(groups=[foo], props={SYMBOL_MAP={FOO.ID=notes.RETRIEVE_NOTES.ID, FOO.NOTE=notes.RETRIEVE_NOTES.NOTE, FOO.USER_ID=notes.RETRIEVE_NOTES.USER_ID, FOO.NOTES_TYPE=notes.RETRIEVE_NOTES.NOTES_TYPE, FOO.ACCESS_MODE=notes.RETRIEVE_NOTES.ACCESS_MODE, FOO.CREATED_ON=notes.RETRIEVE_NOTES.CREATED_ON, FOO.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)})
[13:23:11.651][info][talledLocalContainer]       Project(groups=[notes.RETRIEVE_NOTES], props={PROJECT_COLS=[notes.RETRIEVE_NOTES.ID, notes.RETRIEVE_NOTES.NOTE, notes.RETRIEVE_NOTES.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY]})
[13:23:11.651][info][talledLocalContainer]         Select(groups=[notes.RETRIEVE_NOTES], props={SELECT_CRITERIA=OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)})
[13:23:11.651][info][talledLocalContainer]           Source(groups=[notes.RETRIEVE_NOTES], props={SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID, notes.RETRIEVE_NOTES.NOTE=X.NOTE, notes.RETRIEVE_NOTES.USER_ID=X.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE=X.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE=X.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON=X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.651][info][talledLocalContainer]             Project(groups=[X], props={PROJECT_COLS=[X.ID, X.NOTE, X.USER_ID, X.NOTES_TYPE, X.ACCESS_MODE, X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY]})
[13:23:11.651][info][talledLocalContainer]               Source(groups=[X], props={SYMBOL_MAP={X.ID=ID, X.NOTE=NOTE, X.USER_ID=USER_ID, X.NOTES_TYPE=NOTES_TYPE, X.ACCESS_MODE=ACCESS_MODE, X.CREATED_ON=CREATED_ON}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.651][info][talledLocalContainer]                 Project(groups=[], props={PROJECT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON]})
[13:23:11.651][info][talledLocalContainer]                   Source(groups=[notes.RETRIEVE_NOTES], props={VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.652][info][talledLocalContainer] 
[13:23:11.652][info][talledLocalContainer] 
[13:23:11.652][info][talledLocalContainer] ============================================================================
[13:23:11.652][info][talledLocalContainer] EXECUTING PlaceAccess
[13:23:11.652][info][talledLocalContainer] 
[13:23:11.652][info][talledLocalContainer] AFTER: 
[13:23:11.652][info][talledLocalContainer] Project(groups=[], props={PROJECT_COLS=[COUNT(*)]})
[13:23:11.652][info][talledLocalContainer]   Group(groups=[])
[13:23:11.652][info][talledLocalContainer]     Source(groups=[foo], props={SYMBOL_MAP={FOO.ID=notes.RETRIEVE_NOTES.ID, FOO.NOTE=notes.RETRIEVE_NOTES.NOTE, FOO.USER_ID=notes.RETRIEVE_NOTES.USER_ID, FOO.NOTES_TYPE=notes.RETRIEVE_NOTES.NOTES_TYPE, FOO.ACCESS_MODE=notes.RETRIEVE_NOTES.ACCESS_MODE, FOO.CREATED_ON=notes.RETRIEVE_NOTES.CREATED_ON, FOO.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)})
[13:23:11.652][info][talledLocalContainer]       Project(groups=[notes.RETRIEVE_NOTES], props={PROJECT_COLS=[notes.RETRIEVE_NOTES.ID, notes.RETRIEVE_NOTES.NOTE, notes.RETRIEVE_NOTES.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY]})
[13:23:11.652][info][talledLocalContainer]         Select(groups=[notes.RETRIEVE_NOTES], props={SELECT_CRITERIA=OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)})
[13:23:11.652][info][talledLocalContainer]           Source(groups=[notes.RETRIEVE_NOTES], props={ACCESS_PATTERNS=[Access Pattern: Unsatisfied [notes.RETRIEVE_NOTES.OBJECT_PKEY] History [[notes.RETRIEVE_NOTES.OBJECT_PKEY]]], SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID, notes.RETRIEVE_NOTES.NOTE=X.NOTE, notes.RETRIEVE_NOTES.USER_ID=X.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE=X.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE=X.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON=X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.652][info][talledLocalContainer]             Project(groups=[X], props={PROJECT_COLS=[X.ID, X.NOTE, X.USER_ID, X.NOTES_TYPE, X.ACCESS_MODE, X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY]})
[13:23:11.652][info][talledLocalContainer]               Source(groups=[X], props={SYMBOL_MAP={X.ID=ID, X.NOTE=NOTE, X.USER_ID=USER_ID, X.NOTES_TYPE=NOTES_TYPE, X.ACCESS_MODE=ACCESS_MODE, X.CREATED_ON=CREATED_ON}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.652][info][talledLocalContainer]                 Project(groups=[], props={PROJECT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON]})
[13:23:11.652][info][talledLocalContainer]                   Access(groups=[notes.RETRIEVE_NOTES])
[13:23:11.652][info][talledLocalContainer]                     Source(groups=[notes.RETRIEVE_NOTES], props={VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.652][info][talledLocalContainer] 
[13:23:11.652][info][talledLocalContainer] 
[13:23:11.652][info][talledLocalContainer] ============================================================================
[13:23:11.653][info][talledLocalContainer] EXECUTING PushSelectCriteria
[13:23:11.653][info][talledLocalContainer] 
[13:23:11.653][info][talledLocalContainer] AFTER: 
[13:23:11.653][info][talledLocalContainer] Project(groups=[], props={PROJECT_COLS=[COUNT(*)]})
[13:23:11.653][info][talledLocalContainer]   Group(groups=[])
[13:23:11.653][info][talledLocalContainer]     Source(groups=[foo], props={SYMBOL_MAP={FOO.ID=notes.RETRIEVE_NOTES.ID, FOO.NOTE=notes.RETRIEVE_NOTES.NOTE, FOO.USER_ID=notes.RETRIEVE_NOTES.USER_ID, FOO.NOTES_TYPE=notes.RETRIEVE_NOTES.NOTES_TYPE, FOO.ACCESS_MODE=notes.RETRIEVE_NOTES.ACCESS_MODE, FOO.CREATED_ON=notes.RETRIEVE_NOTES.CREATED_ON, FOO.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)})
[13:23:11.653][info][talledLocalContainer]       Project(groups=[notes.RETRIEVE_NOTES], props={PROJECT_COLS=[notes.RETRIEVE_NOTES.ID, notes.RETRIEVE_NOTES.NOTE, notes.RETRIEVE_NOTES.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY]})
[13:23:11.653][info][talledLocalContainer]         Select(groups=[notes.RETRIEVE_NOTES], props={SELECT_CRITERIA=OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String), IS_PHANTOM=true})
[13:23:11.653][info][talledLocalContainer]           Source(groups=[notes.RETRIEVE_NOTES], props={SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID, notes.RETRIEVE_NOTES.NOTE=X.NOTE, notes.RETRIEVE_NOTES.USER_ID=X.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE=X.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE=X.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON=X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.653][info][talledLocalContainer]             Project(groups=[X], props={PROJECT_COLS=[X.ID, X.NOTE, X.USER_ID, X.NOTES_TYPE, X.ACCESS_MODE, X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY]})
[13:23:11.653][info][talledLocalContainer]               Select(groups=[], props={SELECT_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)})
[13:23:11.653][info][talledLocalContainer]                 Source(groups=[X], props={SYMBOL_MAP={X.ID=ID, X.NOTE=NOTE, X.USER_ID=USER_ID, X.NOTES_TYPE=NOTES_TYPE, X.ACCESS_MODE=ACCESS_MODE, X.CREATED_ON=CREATED_ON}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.653][info][talledLocalContainer]                   Project(groups=[], props={PROJECT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON]})
[13:23:11.653][info][talledLocalContainer]                     Access(groups=[notes.RETRIEVE_NOTES])
[13:23:11.653][info][talledLocalContainer]                       Source(groups=[notes.RETRIEVE_NOTES], props={VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.653][info][talledLocalContainer] 
[13:23:11.653][info][talledLocalContainer] 
[13:23:11.653][info][talledLocalContainer] ============================================================================
[13:23:11.653][info][talledLocalContainer] EXECUTING MergeVirtual
[13:23:11.654][info][talledLocalContainer] 
[13:23:11.654][info][talledLocalContainer] AFTER: 
[13:23:11.654][info][talledLocalContainer] Project(groups=[], props={PROJECT_COLS=[COUNT(*)]})
[13:23:11.654][info][talledLocalContainer]   Group(groups=[])
[13:23:11.654][info][talledLocalContainer]     Select(groups=[notes.RETRIEVE_NOTES], props={SELECT_CRITERIA=OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String), IS_PHANTOM=true})
[13:23:11.654][info][talledLocalContainer]       Source(groups=[notes.RETRIEVE_NOTES], props={SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID, notes.RETRIEVE_NOTES.NOTE=X.NOTE, notes.RETRIEVE_NOTES.USER_ID=X.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE=X.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE=X.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON=X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.654][info][talledLocalContainer]         Project(groups=[X], props={PROJECT_COLS=[X.ID, X.NOTE, X.USER_ID, X.NOTES_TYPE, X.ACCESS_MODE, X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY]})
[13:23:11.654][info][talledLocalContainer]           Select(groups=[], props={SELECT_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)})
[13:23:11.654][info][talledLocalContainer]             Source(groups=[X], props={SYMBOL_MAP={X.ID=ID, X.NOTE=NOTE, X.USER_ID=USER_ID, X.NOTES_TYPE=NOTES_TYPE, X.ACCESS_MODE=ACCESS_MODE, X.CREATED_ON=CREATED_ON}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.654][info][talledLocalContainer]               Project(groups=[], props={PROJECT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON]})
[13:23:11.654][info][talledLocalContainer]                 Access(groups=[notes.RETRIEVE_NOTES])
[13:23:11.654][info][talledLocalContainer]                   Source(groups=[notes.RETRIEVE_NOTES], props={VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.654][info][talledLocalContainer] 
[13:23:11.654][info][talledLocalContainer] 
[13:23:11.654][info][talledLocalContainer] ============================================================================
[13:23:11.654][info][talledLocalContainer] EXECUTING CleanCriteria
[13:23:11.654][info][talledLocalContainer] 
[13:23:11.654][info][talledLocalContainer] AFTER: 
[13:23:11.654][info][talledLocalContainer] Project(groups=[], props={PROJECT_COLS=[COUNT(*)]})
[13:23:11.654][info][talledLocalContainer]   Group(groups=[])
[13:23:11.654][info][talledLocalContainer]     Source(groups=[notes.RETRIEVE_NOTES], props={SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID, notes.RETRIEVE_NOTES.NOTE=X.NOTE, notes.RETRIEVE_NOTES.USER_ID=X.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE=X.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE=X.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON=X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.655][info][talledLocalContainer]       Project(groups=[X], props={PROJECT_COLS=[X.ID, X.NOTE, X.USER_ID, X.NOTES_TYPE, X.ACCESS_MODE, X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY]})
[13:23:11.655][info][talledLocalContainer]         Select(groups=[], props={SELECT_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)})
[13:23:11.655][info][talledLocalContainer]           Source(groups=[X], props={SYMBOL_MAP={X.ID=ID, X.NOTE=NOTE, X.USER_ID=USER_ID, X.NOTES_TYPE=NOTES_TYPE, X.ACCESS_MODE=ACCESS_MODE, X.CREATED_ON=CREATED_ON}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.655][info][talledLocalContainer]             Project(groups=[], props={PROJECT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON]})
[13:23:11.655][info][talledLocalContainer]               Access(groups=[notes.RETRIEVE_NOTES])
[13:23:11.655][info][talledLocalContainer]                 Source(groups=[notes.RETRIEVE_NOTES], props={VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.655][info][talledLocalContainer] 
[13:23:11.655][info][talledLocalContainer] 
[13:23:11.655][info][talledLocalContainer] ============================================================================
[13:23:11.655][info][talledLocalContainer] EXECUTING RaiseAccess
[13:23:11.655][info][talledLocalContainer] 
[13:23:11.655][info][talledLocalContainer] AFTER: 
[13:23:11.655][info][talledLocalContainer] Project(groups=[], props={PROJECT_COLS=[COUNT(*)]})
[13:23:11.655][info][talledLocalContainer]   Group(groups=[])
[13:23:11.655][info][talledLocalContainer]     Source(groups=[notes.RETRIEVE_NOTES], props={SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID, notes.RETRIEVE_NOTES.NOTE=X.NOTE, notes.RETRIEVE_NOTES.USER_ID=X.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE=X.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE=X.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON=X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.655][info][talledLocalContainer]       Project(groups=[X], props={PROJECT_COLS=[X.ID, X.NOTE, X.USER_ID, X.NOTES_TYPE, X.ACCESS_MODE, X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY]})
[13:23:11.655][info][talledLocalContainer]         Select(groups=[], props={SELECT_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)})
[13:23:11.655][info][talledLocalContainer]           Source(groups=[X], props={SYMBOL_MAP={X.ID=ID, X.NOTE=NOTE, X.USER_ID=USER_ID, X.NOTES_TYPE=NOTES_TYPE, X.ACCESS_MODE=ACCESS_MODE, X.CREATED_ON=CREATED_ON}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.655][info][talledLocalContainer]             Project(groups=[], props={PROJECT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON]})
[13:23:11.656][info][talledLocalContainer]               Access(groups=[notes.RETRIEVE_NOTES], props={MODEL_ID=__TEMP__})
[13:23:11.656][info][talledLocalContainer]                 Source(groups=[notes.RETRIEVE_NOTES], props={VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.656][info][talledLocalContainer] 
[13:23:11.656][info][talledLocalContainer] 
[13:23:11.656][info][talledLocalContainer] ============================================================================
[13:23:11.656][info][talledLocalContainer] EXECUTING PushAggregates
[13:23:11.656][info][talledLocalContainer] 
[13:23:11.656][info][talledLocalContainer] AFTER: 
[13:23:11.656][info][talledLocalContainer] Project(groups=[], props={PROJECT_COLS=[COUNT(*)]})
[13:23:11.656][info][talledLocalContainer]   Group(groups=[])
[13:23:11.656][info][talledLocalContainer]     Source(groups=[notes.RETRIEVE_NOTES], props={SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID, notes.RETRIEVE_NOTES.NOTE=X.NOTE, notes.RETRIEVE_NOTES.USER_ID=X.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE=X.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE=X.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON=X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.656][info][talledLocalContainer]       Project(groups=[X], props={PROJECT_COLS=[X.ID, X.NOTE, X.USER_ID, X.NOTES_TYPE, X.ACCESS_MODE, X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY]})
[13:23:11.656][info][talledLocalContainer]         Select(groups=[], props={SELECT_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)})
[13:23:11.656][info][talledLocalContainer]           Source(groups=[X], props={SYMBOL_MAP={X.ID=ID, X.NOTE=NOTE, X.USER_ID=USER_ID, X.NOTES_TYPE=NOTES_TYPE, X.ACCESS_MODE=ACCESS_MODE, X.CREATED_ON=CREATED_ON}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.656][info][talledLocalContainer]             Project(groups=[], props={PROJECT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON]})
[13:23:11.656][info][talledLocalContainer]               Access(groups=[notes.RETRIEVE_NOTES], props={MODEL_ID=__TEMP__})
[13:23:11.656][info][talledLocalContainer]                 Source(groups=[notes.RETRIEVE_NOTES], props={VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.656][info][talledLocalContainer] 
[13:23:11.656][info][talledLocalContainer] 
[13:23:11.656][info][talledLocalContainer] ============================================================================
[13:23:11.656][info][talledLocalContainer] EXECUTING PlanProcedures
[13:23:11.657][info][talledLocalContainer] 
[13:23:11.657][info][talledLocalContainer] AFTER: 
[13:23:11.657][info][talledLocalContainer] Project(groups=[], props={PROJECT_COLS=[COUNT(*)]})
[13:23:11.657][info][talledLocalContainer]   Group(groups=[])
[13:23:11.657][info][talledLocalContainer]     Source(groups=[notes.RETRIEVE_NOTES], props={SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID, notes.RETRIEVE_NOTES.NOTE=X.NOTE, notes.RETRIEVE_NOTES.USER_ID=X.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE=X.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE=X.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON=X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.657][info][talledLocalContainer]       Project(groups=[X], props={PROJECT_COLS=[X.ID, X.NOTE, X.USER_ID, X.NOTES_TYPE, X.ACCESS_MODE, X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY]})
[13:23:11.657][info][talledLocalContainer]         Source(groups=[X], props={SYMBOL_MAP={X.ID=ID, X.NOTE=NOTE, X.USER_ID=USER_ID, X.NOTES_TYPE=NOTES_TYPE, X.ACCESS_MODE=ACCESS_MODE, X.CREATED_ON=CREATED_ON}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.657][info][talledLocalContainer]           Project(groups=[], props={PROJECT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON]})
[13:23:11.657][info][talledLocalContainer]             Access(groups=[notes.RETRIEVE_NOTES], props={PROCEDURE_DEFAULTS=[null], PROCEDURE_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String), MODEL_ID=__TEMP__, IS_DEPENDENT_SET=true, PROCEDURE_INPUTS=[notes.RETRIEVE_NOTES.OBJECT_PKEY]})
[13:23:11.657][info][talledLocalContainer]               Source(groups=[notes.RETRIEVE_NOTES], props={VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.657][info][talledLocalContainer] 
[13:23:11.657][info][talledLocalContainer] 
[13:23:11.657][info][talledLocalContainer] ============================================================================
[13:23:11.657][info][talledLocalContainer] EXECUTING CalculateCost
[13:23:11.657][info][talledLocalContainer] 
[13:23:11.657][info][talledLocalContainer] AFTER: 
[13:23:11.657][info][talledLocalContainer] Project(groups=[], props={EST_CARDINALITY=1.0, PROJECT_COLS=[COUNT(*)]})
[13:23:11.657][info][talledLocalContainer]   Group(groups=[], props={EST_CARDINALITY=1.0})
[13:23:11.657][info][talledLocalContainer]     Source(groups=[notes.RETRIEVE_NOTES], props={EST_CARDINALITY=-1.0, SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID, notes.RETRIEVE_NOTES.NOTE=X.NOTE, notes.RETRIEVE_NOTES.USER_ID=X.USER_ID, notes.RETRIEVE_NOTES.NOTES_TYPE=X.NOTES_TYPE, notes.RETRIEVE_NOTES.ACCESS_MODE=X.ACCESS_MODE, notes.RETRIEVE_NOTES.CREATED_ON=X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY=notes.RETRIEVE_NOTES.OBJECT_PKEY}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.658][info][talledLocalContainer]       Project(groups=[X], props={EST_CARDINALITY=-1.0, PROJECT_COLS=[X.ID, X.NOTE, X.USER_ID, X.NOTES_TYPE, X.ACCESS_MODE, X.CREATED_ON, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY]})
[13:23:11.658][info][talledLocalContainer]         Source(groups=[X], props={EST_CARDINALITY=-1.0, SYMBOL_MAP={X.ID=ID, X.NOTE=NOTE, X.USER_ID=USER_ID, X.NOTES_TYPE=NOTES_TYPE, X.ACCESS_MODE=ACCESS_MODE, X.CREATED_ON=CREATED_ON}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.658][info][talledLocalContainer]           Project(groups=[], props={EST_CARDINALITY=-1.0, PROJECT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON]})
[13:23:11.658][info][talledLocalContainer]             Access(groups=[notes.RETRIEVE_NOTES], props={PROCEDURE_DEFAULTS=[null], PROCEDURE_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String), MODEL_ID=__TEMP__, EST_CARDINALITY=-1.0, IS_DEPENDENT_SET=true, PROCEDURE_INPUTS=[notes.RETRIEVE_NOTES.OBJECT_PKEY]})
[13:23:11.658][info][talledLocalContainer]               Source(groups=[notes.RETRIEVE_NOTES], props={EST_CARDINALITY=-1.0, VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.658][info][talledLocalContainer] 
[13:23:11.658][info][talledLocalContainer] 
[13:23:11.658][info][talledLocalContainer] ============================================================================
[13:23:11.658][info][talledLocalContainer] EXECUTING AssignOutputElements
[13:23:11.658][info][talledLocalContainer] 
[13:23:11.658][info][talledLocalContainer] AFTER: 
[13:23:11.658][info][talledLocalContainer] Project(groups=[], props={EST_CARDINALITY=1.0, OUTPUT_COLS=[COUNT(*)], PROJECT_COLS=[COUNT(*)]})
[13:23:11.658][info][talledLocalContainer]   Group(groups=[], props={EST_CARDINALITY=1.0, OUTPUT_COLS=[COUNT(*)]})
[13:23:11.658][info][talledLocalContainer]     Source(groups=[notes.RETRIEVE_NOTES], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[notes.RETRIEVE_NOTES.ID], SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.658][info][talledLocalContainer]       Project(groups=[X], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[X.ID], PROJECT_COLS=[X.ID]})
[13:23:11.658][info][talledLocalContainer]         Source(groups=[X], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[X.ID], SYMBOL_MAP={X.ID=ID}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.658][info][talledLocalContainer]           Project(groups=[], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[ID], PROJECT_COLS=[ID]})
[13:23:11.658][info][talledLocalContainer]             Access(groups=[notes.RETRIEVE_NOTES], props={PROCEDURE_DEFAULTS=[null], PROCEDURE_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String), MODEL_ID=__TEMP__, EST_CARDINALITY=-1.0, IS_DEPENDENT_SET=true, OUTPUT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON], PROCEDURE_INPUTS=[notes.RETRIEVE_NOTES.OBJECT_PKEY]})
[13:23:11.659][info][talledLocalContainer]               Source(groups=[notes.RETRIEVE_NOTES], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[ID], VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.659][info][talledLocalContainer] 
[13:23:11.659][info][talledLocalContainer] 
[13:23:11.659][info][talledLocalContainer] ============================================================================
[13:23:11.659][info][talledLocalContainer] EXECUTING MergeCriteria
[13:23:11.659][info][talledLocalContainer] 
[13:23:11.659][info][talledLocalContainer] AFTER: 
[13:23:11.659][info][talledLocalContainer] Project(groups=[], props={EST_CARDINALITY=1.0, OUTPUT_COLS=[COUNT(*)], PROJECT_COLS=[COUNT(*)]})
[13:23:11.659][info][talledLocalContainer]   Group(groups=[], props={EST_CARDINALITY=1.0, OUTPUT_COLS=[COUNT(*)]})
[13:23:11.659][info][talledLocalContainer]     Source(groups=[notes.RETRIEVE_NOTES], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[notes.RETRIEVE_NOTES.ID], SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.659][info][talledLocalContainer]       Project(groups=[X], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[X.ID], PROJECT_COLS=[X.ID]})
[13:23:11.659][info][talledLocalContainer]         Source(groups=[X], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[X.ID], SYMBOL_MAP={X.ID=ID}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.659][info][talledLocalContainer]           Project(groups=[], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[ID], PROJECT_COLS=[ID]})
[13:23:11.659][info][talledLocalContainer]             Access(groups=[notes.RETRIEVE_NOTES], props={PROCEDURE_DEFAULTS=[null], PROCEDURE_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String), MODEL_ID=__TEMP__, EST_CARDINALITY=-1.0, IS_DEPENDENT_SET=true, OUTPUT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON], PROCEDURE_INPUTS=[notes.RETRIEVE_NOTES.OBJECT_PKEY]})
[13:23:11.659][info][talledLocalContainer]               Source(groups=[notes.RETRIEVE_NOTES], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[ID], VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.659][info][talledLocalContainer] 
[13:23:11.659][info][talledLocalContainer] 
[13:23:11.659][info][talledLocalContainer] ============================================================================
[13:23:11.659][info][talledLocalContainer] EXECUTING PlanSorts
[13:23:11.659][info][talledLocalContainer] 
[13:23:11.660][info][talledLocalContainer] AFTER: 
[13:23:11.660][info][talledLocalContainer] Project(groups=[], props={EST_CARDINALITY=1.0, OUTPUT_COLS=[COUNT(*)], PROJECT_COLS=[COUNT(*)]})
[13:23:11.660][info][talledLocalContainer]   Group(groups=[], props={EST_CARDINALITY=1.0, OUTPUT_COLS=[COUNT(*)]})
[13:23:11.660][info][talledLocalContainer]     Source(groups=[notes.RETRIEVE_NOTES], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[notes.RETRIEVE_NOTES.ID], SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.660][info][talledLocalContainer]       Project(groups=[X], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[X.ID], PROJECT_COLS=[X.ID]})
[13:23:11.660][info][talledLocalContainer]         Source(groups=[X], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[X.ID], SYMBOL_MAP={X.ID=ID}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.660][info][talledLocalContainer]           Project(groups=[], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[ID], PROJECT_COLS=[ID]})
[13:23:11.660][info][talledLocalContainer]             Access(groups=[notes.RETRIEVE_NOTES], props={PROCEDURE_DEFAULTS=[null], PROCEDURE_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String), MODEL_ID=__TEMP__, EST_CARDINALITY=-1.0, IS_DEPENDENT_SET=true, OUTPUT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON], PROCEDURE_INPUTS=[notes.RETRIEVE_NOTES.OBJECT_PKEY]})
[13:23:11.660][info][talledLocalContainer]               Source(groups=[notes.RETRIEVE_NOTES], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[ID], VIRTUAL_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.660][info][talledLocalContainer] 
[13:23:11.660][info][talledLocalContainer] 
[13:23:11.660][info][talledLocalContainer] ============================================================================
[13:23:11.660][info][talledLocalContainer] EXECUTING CollapseSource
[13:23:11.660][info][talledLocalContainer] 
[13:23:11.660][info][talledLocalContainer] AFTER: 
[13:23:11.660][info][talledLocalContainer] Project(groups=[], props={EST_CARDINALITY=1.0, OUTPUT_COLS=[COUNT(*)], PROJECT_COLS=[COUNT(*)]})
[13:23:11.660][info][talledLocalContainer]   Group(groups=[], props={EST_CARDINALITY=1.0, OUTPUT_COLS=[COUNT(*)]})
[13:23:11.660][info][talledLocalContainer]     Source(groups=[notes.RETRIEVE_NOTES], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[notes.RETRIEVE_NOTES.ID], SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.660][info][talledLocalContainer]       Project(groups=[X], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[X.ID], PROJECT_COLS=[X.ID]})
[13:23:11.660][info][talledLocalContainer]         Source(groups=[X], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[X.ID], SYMBOL_MAP={X.ID=ID}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.661][info][talledLocalContainer]           Project(groups=[], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[ID], PROJECT_COLS=[ID]})
[13:23:11.661][info][talledLocalContainer]             Access(groups=[notes.RETRIEVE_NOTES], props={ATOMIC_REQUEST=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY), PROCEDURE_DEFAULTS=[null], PROCEDURE_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String), MODEL_ID=__TEMP__, EST_CARDINALITY=-1.0, IS_DEPENDENT_SET=true, OUTPUT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON], PROCEDURE_INPUTS=[notes.RETRIEVE_NOTES.OBJECT_PKEY]})
[13:23:11.661][info][talledLocalContainer] 
[13:23:11.661][info][talledLocalContainer] 
[13:23:11.661][info][talledLocalContainer] ============================================================================
[13:23:11.661][info][talledLocalContainer] EXECUTING AccessPatternValidation
[13:23:11.661][info][talledLocalContainer] 
[13:23:11.661][info][talledLocalContainer] AFTER: 
[13:23:11.661][info][talledLocalContainer] Project(groups=[], props={EST_CARDINALITY=1.0, OUTPUT_COLS=[COUNT(*)], PROJECT_COLS=[COUNT(*)]})
[13:23:11.661][info][talledLocalContainer]   Group(groups=[], props={EST_CARDINALITY=1.0, OUTPUT_COLS=[COUNT(*)]})
[13:23:11.661][info][talledLocalContainer]     Source(groups=[notes.RETRIEVE_NOTES], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[notes.RETRIEVE_NOTES.ID], SYMBOL_MAP={notes.RETRIEVE_NOTES.ID=X.ID}, NESTED_COMMAND=SELECT X.*, notes.RETRIEVE_NOTES.OBJECT_PKEY AS OBJECT_PKEY FROM (EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)) AS X})
[13:23:11.661][info][talledLocalContainer]       Project(groups=[X], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[X.ID], PROJECT_COLS=[X.ID]})
[13:23:11.661][info][talledLocalContainer]         Source(groups=[X], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[X.ID], SYMBOL_MAP={X.ID=ID}, NESTED_COMMAND=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)})
[13:23:11.661][info][talledLocalContainer]           Project(groups=[], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[ID], PROJECT_COLS=[ID]})
[13:23:11.661][info][talledLocalContainer]             Access(groups=[notes.RETRIEVE_NOTES], props={ATOMIC_REQUEST=EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY), PROCEDURE_DEFAULTS=[null], PROCEDURE_CRITERIA=notes.RETRIEVE_NOTES.OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String), MODEL_ID=__TEMP__, EST_CARDINALITY=-1.0, IS_DEPENDENT_SET=true, OUTPUT_COLS=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON], PROCEDURE_INPUTS=[notes.RETRIEVE_NOTES.OBJECT_PKEY]})
[13:23:11.661][info][talledLocalContainer] 
[13:23:11.661][info][talledLocalContainer] 
[13:23:11.661][info][talledLocalContainer] ============================================================================
[13:23:11.661][info][talledLocalContainer] CONVERTING PLAN TREE TO PROCESS TREE
[13:23:11.661][info][talledLocalContainer] 
[13:23:11.661][info][talledLocalContainer] PROCESS PLAN = 
[13:23:11.662][info][talledLocalContainer] ProjectNode(1) output=[COUNT(*)] [COUNT(*)]
[13:23:11.662][info][talledLocalContainer]   GroupingNode(2) output=[COUNT(*)] null
[13:23:11.662][info][talledLocalContainer]     ProjectNode(3) output=[notes.RETRIEVE_NOTES.ID] [X.ID]
[13:23:11.662][info][talledLocalContainer]       ProjectNode(4) output=[X.ID] [ID]
[13:23:11.662][info][talledLocalContainer]         DependentProcedureAccessNode(5) output=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON] EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)
[13:23:11.662][info][talledLocalContainer] 
[13:23:11.662][info][talledLocalContainer] ============================================================================
[13:23:11.662][info][talledLocalContainer] 
[13:23:11.662][info][talledLocalContainer] ----------------------------------------------------------------------------
[13:23:11.662][info][talledLocalContainer] OPTIMIZATION COMPLETE:
[13:23:11.662][info][talledLocalContainer] PROCESSOR PLAN:
[13:23:11.662][info][talledLocalContainer] ProjectNode(1) output=[COUNT(*)] [COUNT(*)]
[13:23:11.662][info][talledLocalContainer]   GroupingNode(2) output=[COUNT(*)] null
[13:23:11.662][info][talledLocalContainer]     ProjectNode(3) output=[notes.RETRIEVE_NOTES.ID] [X.ID]
[13:23:11.662][info][talledLocalContainer]       ProjectNode(4) output=[X.ID] [ID]
[13:23:11.662][info][talledLocalContainer]         DependentProcedureAccessNode(5) output=[ID, NOTE, USER_ID, NOTES_TYPE, ACCESS_MODE, CREATED_ON] EXEC notes.RETRIEVE_NOTES(notes.RETRIEVE_NOTES.OBJECT_PKEY)
[13:23:11.662][info][talledLocalContainer] 
[13:23:11.662][info][talledLocalContainer] ============================================================================
[13:23:11.662][info][talledLocalContainer] 
[13:23:11.662][info][talledLocalContainer] ============================================================================
[13:23:11.662][info][talledLocalContainer] EXECUTING PlaceAccess
[13:23:11.663][info][talledLocalContainer] 
[13:23:11.663][info][talledLocalContainer] AFTER: 
[13:23:11.663][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.663][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.663][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.663][info][talledLocalContainer]       Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={JOIN_STRATEGY=NESTED_LOOP, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.663][info][talledLocalContainer]         Access(groups=[SECURITY.BASEUSER AS C])
[13:23:11.663][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.663][info][talledLocalContainer]         Access(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.663][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.663][info][talledLocalContainer] 
[13:23:11.663][info][talledLocalContainer] 
[13:23:11.663][info][talledLocalContainer] ============================================================================
[13:23:11.663][info][talledLocalContainer] EXECUTING RuleRemoveOptionalJoins
[13:23:11.663][info][talledLocalContainer] 
[13:23:11.663][info][talledLocalContainer] AFTER: 
[13:23:11.663][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.663][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.664][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.664][info][talledLocalContainer]       Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={JOIN_STRATEGY=NESTED_LOOP, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.664][info][talledLocalContainer]         Access(groups=[SECURITY.BASEUSER AS C])
[13:23:11.664][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.664][info][talledLocalContainer]         Access(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.664][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.664][info][talledLocalContainer] 
[13:23:11.664][info][talledLocalContainer] 
[13:23:11.664][info][talledLocalContainer] ============================================================================
[13:23:11.664][info][talledLocalContainer] EXECUTING PushNonJoinCriteria
[13:23:11.664][info][talledLocalContainer] 
[13:23:11.664][info][talledLocalContainer] AFTER: 
[13:23:11.664][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.664][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.664][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.664][info][talledLocalContainer]       Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={JOIN_STRATEGY=NESTED_LOOP, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.664][info][talledLocalContainer]         Access(groups=[SECURITY.BASEUSER AS C])
[13:23:11.664][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.664][info][talledLocalContainer]         Access(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.665][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.665][info][talledLocalContainer] 
[13:23:11.665][info][talledLocalContainer] 
[13:23:11.665][info][talledLocalContainer] ============================================================================
[13:23:11.665][info][talledLocalContainer] EXECUTING CopyCriteria
[13:23:11.665][info][talledLocalContainer] 
[13:23:11.665][info][talledLocalContainer] AFTER: 
[13:23:11.665][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.665][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.665][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.665][info][talledLocalContainer]       Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.665][info][talledLocalContainer]         Access(groups=[SECURITY.BASEUSER AS C])
[13:23:11.665][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.665][info][talledLocalContainer]         Access(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.665][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.665][info][talledLocalContainer] 
[13:23:11.665][info][talledLocalContainer] 
[13:23:11.665][info][talledLocalContainer] ============================================================================
[13:23:11.665][info][talledLocalContainer] EXECUTING CleanCriteria
[13:23:11.665][info][talledLocalContainer] 
[13:23:11.666][info][talledLocalContainer] AFTER: 
[13:23:11.666][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.666][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.666][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.666][info][talledLocalContainer]       Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.666][info][talledLocalContainer]         Access(groups=[SECURITY.BASEUSER AS C])
[13:23:11.666][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.666][info][talledLocalContainer]         Access(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.666][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.666][info][talledLocalContainer] 
[13:23:11.666][info][talledLocalContainer] 
[13:23:11.666][info][talledLocalContainer] ============================================================================
[13:23:11.666][info][talledLocalContainer] EXECUTING RaiseAccess
[13:23:11.666][info][talledLocalContainer] 
[13:23:11.666][info][talledLocalContainer] AFTER: 
[13:23:11.666][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.666][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.666][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.666][info][talledLocalContainer]       Access(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b})
[13:23:11.667][info][talledLocalContainer]         Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.667][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.667][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.667][info][talledLocalContainer] 
[13:23:11.667][info][talledLocalContainer] 
[13:23:11.667][info][talledLocalContainer] ============================================================================
[13:23:11.667][info][talledLocalContainer] EXECUTING PlanJoins
[13:23:11.667][info][talledLocalContainer] 
[13:23:11.667][info][talledLocalContainer] AFTER: 
[13:23:11.667][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.667][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.667][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.667][info][talledLocalContainer]       Access(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b})
[13:23:11.667][info][talledLocalContainer]         Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.667][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.667][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.667][info][talledLocalContainer] 
[13:23:11.667][info][talledLocalContainer] 
[13:23:11.667][info][talledLocalContainer] ============================================================================
[13:23:11.668][info][talledLocalContainer] EXECUTING PushSelectCriteria
[13:23:11.668][info][talledLocalContainer] 
[13:23:11.668][info][talledLocalContainer] AFTER: 
[13:23:11.668][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.668][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.668][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.668][info][talledLocalContainer]       Access(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b})
[13:23:11.668][info][talledLocalContainer]         Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.668][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.668][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.668][info][talledLocalContainer] 
[13:23:11.668][info][talledLocalContainer] 
[13:23:11.668][info][talledLocalContainer] ============================================================================
[13:23:11.668][info][talledLocalContainer] EXECUTING RaiseAccess
[13:23:11.668][info][talledLocalContainer] 
[13:23:11.668][info][talledLocalContainer] AFTER: 
[13:23:11.668][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.668][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.669][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.669][info][talledLocalContainer]       Access(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b})
[13:23:11.669][info][talledLocalContainer]         Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.669][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.669][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.669][info][talledLocalContainer] 
[13:23:11.669][info][talledLocalContainer] 
[13:23:11.669][info][talledLocalContainer] ============================================================================
[13:23:11.669][info][talledLocalContainer] EXECUTING ChooseJoinStrategy
[13:23:11.669][info][talledLocalContainer] 
[13:23:11.669][info][talledLocalContainer] AFTER: 
[13:23:11.669][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.669][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.669][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.669][info][talledLocalContainer]       Access(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b})
[13:23:11.669][info][talledLocalContainer]         Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.669][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.670][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.670][info][talledLocalContainer] 
[13:23:11.670][info][talledLocalContainer] 
[13:23:11.670][info][talledLocalContainer] ============================================================================
[13:23:11.670][info][talledLocalContainer] EXECUTING ChooseDependent
[13:23:11.670][info][talledLocalContainer] 
[13:23:11.670][info][talledLocalContainer] AFTER: 
[13:23:11.670][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.670][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.670][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.670][info][talledLocalContainer]       Access(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b})
[13:23:11.670][info][talledLocalContainer]         Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.670][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.670][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.670][info][talledLocalContainer] 
[13:23:11.670][info][talledLocalContainer] 
[13:23:11.670][info][talledLocalContainer] ============================================================================
[13:23:11.670][info][talledLocalContainer] EXECUTING PushLimit
[13:23:11.670][info][talledLocalContainer] 
[13:23:11.670][info][talledLocalContainer] AFTER: 
[13:23:11.670][info][talledLocalContainer] TupleLimit(groups=[], props={MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.670][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={SORT_ORDER=ORDER BY C.NAME})
[13:23:11.671][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.671][info][talledLocalContainer]       Access(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b})
[13:23:11.671][info][talledLocalContainer]         Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.671][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C])
[13:23:11.671][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0])
[13:23:11.671][info][talledLocalContainer] 
[13:23:11.671][info][talledLocalContainer] 
[13:23:11.671][info][talledLocalContainer] ============================================================================
[13:23:11.671][info][talledLocalContainer] EXECUTING CalculateCost
[13:23:11.671][info][talledLocalContainer] 
[13:23:11.671][info][talledLocalContainer] AFTER: 
[13:23:11.671][info][talledLocalContainer] TupleLimit(groups=[], props={EST_CARDINALITY=10.0, MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.671][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={EST_CARDINALITY=-1.0, SORT_ORDER=ORDER BY C.NAME})
[13:23:11.671][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={EST_CARDINALITY=-1.0, PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.671][info][talledLocalContainer]       Access(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, EST_CARDINALITY=-1.0})
[13:23:11.671][info][talledLocalContainer]         Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, EST_CARDINALITY=-1.0, JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.671][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C], props={EST_CARDINALITY=-1.0})
[13:23:11.671][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0], props={EST_CARDINALITY=-1.0})
[13:23:11.671][info][talledLocalContainer] 
[13:23:11.671][info][talledLocalContainer] 
[13:23:11.672][info][talledLocalContainer] ============================================================================
[13:23:11.672][info][talledLocalContainer] EXECUTING AssignOutputElements
[13:23:11.672][info][talledLocalContainer] 
[13:23:11.672][info][talledLocalContainer] AFTER: 
[13:23:11.672][info][talledLocalContainer] TupleLimit(groups=[], props={EST_CARDINALITY=10.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"], MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.672][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"], SORT_ORDER=ORDER BY C.NAME})
[13:23:11.672][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"], PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.672][info][talledLocalContainer]       Access(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, CHORUS_J0.APPNAME, C.UID, C.SUSPEND, C.PROC]})
[13:23:11.672][info][talledLocalContainer]         Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, CHORUS_J0.APPNAME, C.UID, C.SUSPEND, C.PROC], JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.672][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.sysid, C.USERID, C.NAME, C.UID, C.SUSPEND, C.PROC]})
[13:23:11.672][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[CHORUS_J0.sysid, CHORUS_J0.APPNAME]})
[13:23:11.672][info][talledLocalContainer] 
[13:23:11.672][info][talledLocalContainer] 
[13:23:11.672][info][talledLocalContainer] ============================================================================
[13:23:11.672][info][talledLocalContainer] EXECUTING ImplementJoinStrategy
[13:23:11.672][info][talledLocalContainer] 
[13:23:11.673][info][talledLocalContainer] AFTER: 
[13:23:11.673][info][talledLocalContainer] TupleLimit(groups=[], props={EST_CARDINALITY=10.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"], MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.673][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"], SORT_ORDER=ORDER BY C.NAME})
[13:23:11.673][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"], PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.673][info][talledLocalContainer]       Access(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, CHORUS_J0.APPNAME, C.UID, C.SUSPEND, C.PROC]})
[13:23:11.673][info][talledLocalContainer]         Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, CHORUS_J0.APPNAME, C.UID, C.SUSPEND, C.PROC], JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.673][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.sysid, C.USERID, C.NAME, C.UID, C.SUSPEND, C.PROC]})
[13:23:11.673][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[CHORUS_J0.sysid, CHORUS_J0.APPNAME]})
[13:23:11.673][info][talledLocalContainer] 
[13:23:11.673][info][talledLocalContainer] 
[13:23:11.673][info][talledLocalContainer] ============================================================================
[13:23:11.673][info][talledLocalContainer] EXECUTING MergeCriteria
[13:23:11.673][info][talledLocalContainer] 
[13:23:11.673][info][talledLocalContainer] AFTER: 
[13:23:11.673][info][talledLocalContainer] TupleLimit(groups=[], props={EST_CARDINALITY=10.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"], MAX_TUPLE_LIMIT=10, OFFSET_TUPLE_COUNT=990})
[13:23:11.673][info][talledLocalContainer]   Sort(groups=[SECURITY.BASEUSER AS C], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"], SORT_ORDER=ORDER BY C.NAME})
[13:23:11.673][info][talledLocalContainer]     Project(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"], PROJECT_COLS=[C.SYSID, C.USERID, C.NAME, (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT(NAME SECURITY.BASEUSER, XMLATTRIBUTES(C.SYSID AS SYSID, C.USERID AS USERID)) AS String)) AS foo) AS CHORUS_C_notesForObject, CHORUS_J0.APPNAME AS "SYSOFUSER at APPNAME", C.UID, C.SUSPEND, C.PROC, 'SECURITY.BASEUSER' AS "__objecttype__"]})
[13:23:11.673][info][talledLocalContainer]       Access(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, CHORUS_J0.APPNAME, C.UID, C.SUSPEND, C.PROC]})
[13:23:11.674][info][talledLocalContainer]         Join(groups=[SECURITY.BASEUSER AS C, security.sysinfo AS CHORUS_J0], props={IS_COPIED=true, JOIN_STRATEGY=NESTED_LOOP, MODEL_ID=Schema name=security, nameInSource=null, uuid=mmuuid:066587c1-3747-48dc-92fb-fc9a71acf11b, EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.SYSID, C.USERID, C.NAME, CHORUS_J0.APPNAME, C.UID, C.SUSPEND, C.PROC], JOIN_CRITERIA=[CHORUS_J0.sysid = C.sysid], JOIN_TYPE=LEFT OUTER JOIN})
[13:23:11.674][info][talledLocalContainer]           Source(groups=[SECURITY.BASEUSER AS C], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[C.sysid, C.USERID, C.NAME, C.UID, C.SUSPEND, C.PROC]})
[13:23:11.674][info][talledLocalContainer]           Source(groups=[security.sysinfo AS CHORUS_J0], props={EST_CARDINALITY=-1.0, OUTPUT_COLS=[CHORUS_J0.sysid, CHORUS_J0.APPNAME]})
[13:23:11.674][info][talledLocalContainer] 
[13:23:11.674][info][talledLocalContainer] 
[13:23:11.674][info][talledLocalContainer] ============================================================================
[13:23:11.674][info][talledLocalContainer] EXECUTING PlanSorts
[13:23:11.674][info][talledLocalContainer] 
[13:23:11.674][info][talledLocalContainer] AFTER: 
[13:23:11.674][info][talledLocalContainer] null
[13:23:11.674][info][talledLocalContainer] 
[13:23:11.674][info][talledLocalContainer] ============================================================================
[13:23:11.674][info][talledLocalContainer] EXECUTING CollapseSource
[13:23:11.674][info][talledLocalContainer] 
[13:23:11.674][info][talledLocalContainer] 13:23:11,673 ERROR [PROCESSOR] Unexpected exception for request d8e/tMDp2Hy3.0
[13:23:11.674][info][talledLocalContainer] java.lang.NullPointerException
[13:23:11.674][info][talledLocalContainer] 	at org.teiid.query.optimizer.relational.plantree.NodeEditor.findAllNodesHelper(NodeEditor.java:123)
[13:23:11.674][info][talledLocalContainer] 	at org.teiid.query.optimizer.relational.plantree.NodeEditor.findAllNodes(NodeEditor.java:102)
[13:23:11.674][info][talledLocalContainer] 	at org.teiid.query.optimizer.relational.rules.RuleCollapseSource.execute(RuleCollapseSource.java:85)
[13:23:11.675][info][talledLocalContainer] 	at org.teiid.query.optimizer.relational.RelationalPlanner.executeRules(RelationalPlanner.java:458)
[13:23:11.675][info][talledLocalContainer] 	at org.teiid.query.optimizer.relational.RelationalPlanner.optimize(RelationalPlanner.java:227)
[13:23:11.675][info][talledLocalContainer] 	at org.teiid.query.optimizer.QueryOptimizer.optimizePlan(QueryOptimizer.java:148)
[13:23:11.675][info][talledLocalContainer] 	at org.teiid.dqp.internal.process.Request.generatePlan(Request.java:429)
[13:23:11.675][info][talledLocalContainer] 	at org.teiid.dqp.internal.process.Request.processRequest(Request.java:452)
[13:23:11.675][info][talledLocalContainer] 	at org.teiid.dqp.internal.process.RequestWorkItem.processNew(RequestWorkItem.java:372)
[13:23:11.675][info][talledLocalContainer] 	at org.teiid.dqp.internal.process.RequestWorkItem.process(RequestWorkItem.java:174)
[13:23:11.675][info][talledLocalContainer] 	at org.teiid.dqp.internal.process.AbstractWorkItem.run(AbstractWorkItem.java:49)
[13:23:11.675][info][talledLocalContainer] 	at org.teiid.dqp.internal.process.DQPWorkContext.runInContext(DQPWorkContext.java:188)
[13:23:11.675][info][talledLocalContainer] 	at org.teiid.dqp.internal.process.ThreadReuseExecutor$RunnableWrapper.run(ThreadReuseExecutor.java:116)
[13:23:11.675][info][talledLocalContainer] 	at org.teiid.dqp.internal.process.ThreadReuseExecutor$3.run(ThreadReuseExecutor.java:290)
[13:23:11.675][info][talledLocalContainer] 	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
[13:23:11.675][info][talledLocalContainer] 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
[13:23:11.675][info][talledLocalContainer] 	at java.lang.Thread.run(Thread.java:619)


> NullPointerException in NodeEditor
> ----------------------------------
>
>                 Key: TEIID-1554
>                 URL: https://issues.jboss.org/browse/TEIID-1554
>             Project: Teiid
>          Issue Type: Bug
>          Components: Query Engine
>    Affects Versions: 7.3
>            Reporter: Mark Addleman
>            Assignee: Steven Hawkins
>
> NPE in NodeEditor with the following SQL:
> SQL SELECT B."SYSID", B."USERID", (SELECT COUNT(*) FROM (SELECT * FROM notes.RETRIEVE_NOTES WHERE OBJECT_PKEY = XMLSERIALIZE(XMLELEMENT("SECURITY.BASEUSER", XMLATTRIBUTES(B."SYSID",B."USERID")) as String)) as foo) as C_notesForObject, 'SECURITY.BASEUSER' as "_objecttype_" FROM "SECURITY.BASEUSER" as B ORDER BY B."USERID" ASC LIMIT 10
> Stack trace:
> org.teiid.jdbc.TeiidSQLException: org.teiid.core.TeiidException
> 	at org.teiid.jdbc.TeiidSQLException.create(TeiidSQLException.java:109)
> 	at org.teiid.jdbc.TeiidSQLException.create(TeiidSQLException.java:69)
> 	at org.teiid.jdbc.StatementImpl.executeSql(StatementImpl.java:497)
> 	at org.teiid.jdbc.PreparedStatementImpl.executeQuery(PreparedStatementImpl.java:214)
> 	at com.ca.chorus.db.DbExecutor.withResultSet(DbExecutor.java:198)
> 	at com.ca.chorus.db.DbExecutor.gatherResults(DbExecutor.java:367)
> 	at com.ca.chorus.db.DbExecutor.gatherResults(DbExecutor.java:361)
> 	at com.ca.chorus.teiidtest.TestTeiid.run(TestTeiid.java:72)
> 	at com.ca.chorus.teiidtest.TestTeiid.main(TestTeiid.java:24)
> Caused by: [TeiidException]
> 1 [NullPointerException]
> 	at org.teiid.client.ResultsMessage.setException(ResultsMessage.java:177)
> 	at org.teiid.dqp.internal.process.RequestWorkItem.sendError(RequestWorkItem.java:557)
> 	at org.teiid.dqp.internal.process.RequestWorkItem.attemptClose(RequestWorkItem.java:335)
> 	at org.teiid.dqp.internal.process.RequestWorkItem.process(RequestWorkItem.java:218)
> 	at org.teiid.dqp.internal.process.AbstractWorkItem.run(AbstractWorkItem.java:49)
> 	at org.teiid.dqp.internal.process.DQPWorkContext.runInContext(DQPWorkContext.java:188)
> 	at org.teiid.dqp.internal.process.ThreadReuseExecutor$RunnableWrapper.run(ThreadReuseExecutor.java:116)
> 	at org.teiid.dqp.internal.process.ThreadReuseExecutor$3.run(ThreadReuseExecutor.java:290)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
> 	at java.lang.Thread.run(Thread.java:619)
> Caused by: java.lang.NullPointerException
> 	at org.teiid.query.optimizer.relational.plantree.NodeEditor.findAllNodesHelper(NodeEditor.java:123)
> 	at org.teiid.query.optimizer.relational.plantree.NodeEditor.findAllNodes(NodeEditor.java:102)
> 	at org.teiid.query.optimizer.relational.rules.RuleCollapseSource.execute(RuleCollapseSource.java:85)
> 	at org.teiid.query.optimizer.relational.RelationalPlanner.executeRules(RelationalPlanner.java:458)
> 	at org.teiid.query.optimizer.relational.RelationalPlanner.optimize(RelationalPlanner.java:227)
> 	at org.teiid.query.optimizer.QueryOptimizer.optimizePlan(QueryOptimizer.java:148)
> 	at org.teiid.dqp.internal.process.Request.generatePlan(Request.java:429)
> 	at org.teiid.dqp.internal.process.PreparedStatementRequest.generatePlan(PreparedStatementRequest.java:138)
> 	at org.teiid.dqp.internal.process.Request.processRequest(Request.java:452)
> 	at org.teiid.dqp.internal.process.RequestWorkItem.processNew(RequestWorkItem.java:372)
> 	at org.teiid.dqp.internal.process.RequestWorkItem.process(RequestWorkItem.java:174)
> 	... 7 more

--
This message is automatically generated by JIRA.
For more information on JIRA, see: http://www.atlassian.com/software/jira


More information about the teiid-issues mailing list