Andras Salamon created OOZIE-3455:
-------------------------------------
Summary: Inconsistent CoordMaterializeTransitionXCommand logging
Key: OOZIE-3455
URL: https://issues.apache.org/jira/browse/OOZIE-3455
Project: Oozie
Issue Type: Bug
Reporter: Andras Salamon
Logging of {{CoordMaterializeTransitionXCommand}} lock acquiring is incomplete.
The following four lines is printed by
{{TestCoordMaterializeTransitionXCommand.testMaterializationLookupRelativeDays3()}}.
The first two lines does not contain the {{USER[test] GROUP[testg] TOKEN[]
APP[COORD-TEST] JOB[0000000-190327125652192-oozie-andr-C] ACTION[-]}}
{noformat}
12:56:52,866 DEBUG CoordMaterializeTransitionXCommand:526 - Acquired lock for
[0000000-190327125652192-oozie-andr-C] in [coord_mater]
12:56:52,899 DEBUG CoordMaterializeTransitionXCommand:526 - Materializing coord
job id=0000000-190327125652192-oozie-andr-C, start=2019-03-27T11:56Z,
end=2019-03-27T12:56Z, window=3600
12:56:52,900 DEBUG CoordMaterializeTransitionXCommand:526 - USER[test]
GROUP[testg] TOKEN[] APP[COORD-TEST] JOB[0000000-190327125652192-oozie-andr-C]
ACTION[-] Execute command [coord_mater] key
[0000000-190327125652192-oozie-andr-C]
12:56:52,916 INFO CoordMaterializeTransitionXCommand:520 - USER[test]
GROUP[testg] TOKEN[] APP[COORD-TEST] JOB[0000000-190327125652192-oozie-andr-C]
ACTION[-] materialize actions for tz=Pacific Standard Time,
{noformat}
Sometimes the information is not missing, but contains info from a previous
run, which is very confusing:
{noformat}
6:39:57,236 DEBUG CoordMaterializeTransitionXCommand:526 - USER[test]
GROUP[testg] TOKEN[] APP[COORD-TEST] JOB[0000000-190327163956391-oozie-andr-C]
ACTION[-] Acquired lock for [0000000-190327163956963-oozie-andr-C] in
[coord_mater]
16:39:57,252 DEBUG CoordMaterializeTransitionXCommand:526 - USER[test]
GROUP[testg] TOKEN[] APP[COORD-TEST] JOB[0000000-190327163956391-oozie-andr-C]
ACTION[-] Materializing coord job id=0000000-190327163956963-oozie-andr-C,
start=2013-07-18T00:00Z, end=2013-07-18T01:00Z, window=3600
16:39:57,252 DEBUG CoordMaterializeTransitionXCommand:526 - USER[test]
GROUP[testg] TOKEN[] APP[COORD-TEST] JOB[0000000-190327163956963-oozie-andr-C]
ACTION[-] Execute command [coord_mater] key
[0000000-190327163956963-oozie-andr-C]
16:39:57,255 INFO CoordMaterializeTransitionXCommand:520 - USER[test]
GROUP[testg] TOKEN[] APP[COORD-TEST] JOB[0000000-190327163956963-oozie-andr-C]
ACTION[-] materialize actions for tz=Pacific Standard Time,
{noformat}
--
This message was sent by Atlassian JIRA
(v7.6.3#76005)
