You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@oozie.apache.org by "Julia Kinga Marton (JIRA)" <ji...@apache.org> on 2019/04/02 13:45:00 UTC

[jira] [Commented] (OOZIE-3455) Inconsistent CoordMaterializeTransitionXCommand logging

    [ https://issues.apache.org/jira/browse/OOZIE-3455?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16807766#comment-16807766 ] 

Julia Kinga Marton commented on OOZIE-3455:
-------------------------------------------

Thank you [~asalamon74] for reporting and fixing it. The test error is a known flaky test (OOZIE-3105)

Just a small note: it would be nice to add some cleanup when the Xcommand call ends. It is still better to have empty fields in the log header than to have some false information.

> Inconsistent CoordMaterializeTransitionXCommand logging 
> --------------------------------------------------------
>
>                 Key: OOZIE-3455
>                 URL: https://issues.apache.org/jira/browse/OOZIE-3455
>             Project: Oozie
>          Issue Type: Bug
>            Reporter: Andras Salamon
>            Assignee: Andras Salamon
>            Priority: Major
>         Attachments: OOZIE-3455-01.patch
>
>
> 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)