eo:xmir-to-phi is too slow

volodya-lombrozo commented 4 months ago

I tried to run xmir-to-phi goal with the following configuration:

<plugin>
  <groupId>org.eolang</groupId>
  <artifactId>eo-maven-plugin</artifactId>
  <version>0.38.4</version>
  <executions>
    <execution>
      <id>convert-xmir-to-phi</id>
      <phase>process-classes</phase>
      <goals>
        <goal>xmir-to-phi</goal>
      </goals>
      <configuration>
        <phiInputDir>${project.build.directory}/generated-sources/jeo-xmir</phiInputDir>
        <phiOutputDir>${project.build.directory}/generated-sources/jeo-phi</phiOutputDir>
      </configuration>
    </execution>
  </executions>
</plugin>

I run this goal on the project with thousands of xmir files and it took me hours to convert only some xmir files (I haven't managed to wait until the end of printing and stopped the test.) Could you speed up the printing process somehow, please?

volodya-lombrozo commented 4 months ago

@maxonfjvipon Could you take a look please?

github-actions[bot] commented 4 months ago

@volodya-lombrozo thanks for the report, here is a feedback:

Problems

Lack of Specificity: The report fails to specify the exact number of xmir files tested, making the term 'thousands of xmir files' vague and potentially misleading.
Absence of Performance Metrics: There are no specific performance metrics in the report. The statement that the test took hours is imprecise without an exact time frame.
Not Reproducible: The report omits information about the environment where the bug was detected.

I would recommend including specific performance metrics, such as the exact time it took for the process to run.

Please fix the bug report in order it to get resolved faster. Analyzed with gpt-4

volodya-lombrozo commented 3 months ago

@yegor256 Could you help here please?

volodya-lombrozo commented 3 months ago

Here is the excerpt from the logs:

[INFO] [WARNING] XSL 'stars-to-tuples' took 2s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 2s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 6s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 6s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/IMarkerFactory.xmir (5Kb) -> org/slf4j/IMarkerFactory.phi (6Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/spi/LocationAwareLogger.xmir (6Kb)
[INFO] [INFO] Translated to phi: org/slf4j/Marker.xmir (12Kb) -> org/slf4j/Marker.phi (14Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/MDC.xmir (87Kb)
[INFO] [INFO] Translated to phi: org/slf4j/ILoggerFactory.xmir (2Kb) -> org/slf4j/ILoggerFactory.phi (2Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/MDC$MDCCloseable.xmir (13Kb)
[INFO] [WARNING] XSL 'same-line-names' took 702ms (over 500ms)
[INFO] [WARNING] XSL 'explicit-data' took 715ms (over 500ms)
[INFO] [WARNING] XSL 'explicit-data' took 717ms (over 500ms)
[INFO] [WARNING] XSL 'correct-package-meta' took 690ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 703ms (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/spi/LoggerFactoryBinder.xmir (3Kb) -> org/slf4j/spi/LoggerFactoryBinder.phi (3Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/Logger.xmir (70Kb)
[INFO] [INFO] Translated to phi: org/slf4j/spi/MarkerFactoryBinder.xmir (3Kb) -> org/slf4j/spi/MarkerFactoryBinder.phi (3Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/event/EventConstants.xmir (8Kb)
[INFO] [INFO] Translated to phi: org/slf4j/impl/StaticMDCBinder.xmir (13Kb) -> org/slf4j/impl/StaticMDCBinder.phi (19Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/event/Level.xmir (46Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 1s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 703ms (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/impl/StaticMarkerBinder.xmir (16Kb) -> org/slf4j/impl/StaticMarkerBinder.phi (24Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/event/EventRecodingLogger.xmir (314Kb)
[INFO] [INFO] Translated to phi: org/slf4j/spi/MDCAdapter.xmir (8Kb) -> org/slf4j/spi/MDCAdapter.phi (9Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/event/LoggingEvent.xmir (8Kb)
[INFO] [INFO] Translated to phi: org/slf4j/MarkerFactory.xmir (30Kb) -> org/slf4j/MarkerFactory.phi (47Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/event/SubstituteLoggingEvent.xmir (59Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 606ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 6s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 14s (over 500ms)
[INFO] [WARNING] XSL 'same-line-names' took 2s (over 500ms)
[INFO] [WARNING] XSL 'broken-refs' took 2s (over 500ms)
[INFO] [WARNING] XSL 'external-weak-typed-atoms' took 2s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/impl/StaticLoggerBinder.xmir (78Kb) -> org/slf4j/impl/StaticLoggerBinder.phi (153Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/NOPLogger.xmir (62Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 10s (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 548ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-version-meta' took 519ms (over 500ms)
[INFO] [WARNING] XSL 'prohibited-package' took 522ms (over 500ms)
[INFO] [WARNING] XSL 'expand-qqs' took 542ms (over 500ms)
[INFO] [WARNING] XSL 'duplicate-metas' took 559ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 11s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 2s (over 500ms)
[INFO] [WARNING] XSL 'many-free-attributes' took 503ms (over 500ms)
[INFO] [WARNING] XSL 'resolve-aliases' took 519ms (over 500ms)
[INFO] [WARNING] XSL 'prohibited-package' took 526ms (over 500ms)
[INFO] [WARNING] XSL 'duplicate-metas' took 551ms (over 500ms)
[INFO] [WARNING] XSL 'vars-float-up' took 543ms (over 500ms)
[INFO] [WARNING] XSL 'unused-aliases' took 1s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/bridge/SLF4JBridgeHandler.xmir (142Kb) -> org/slf4j/bridge/SLF4JBridgeHandler.phi (299Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/BasicMarkerFactory.xmir (37Kb)
[INFO] [WARNING] XSL 'sparse-decoration' took 2s (over 500ms)
[INFO] [WARNING] XSL 'add-default-package' took 2s (over 500ms)
[INFO] [WARNING] XSL 'mandatory-version-meta' took 2s (over 500ms)
[INFO] [WARNING] XSL 'duplicate-names' took 1s (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 572ms (over 500ms)
[INFO] [WARNING] XSL 'broken-aliases' took 629ms (over 500ms)
[INFO] [WARNING] XSL 'correct-package-meta' took 722ms (over 500ms)
[INFO] [WARNING] XSL 'broken-refs' took 692ms (over 500ms)
[INFO] [WARNING] XSL 'duplicate-aliases' took 705ms (over 500ms)
[INFO] [WARNING] XSL 'unit-test-without-phi' took 641ms (over 500ms)
[INFO] [WARNING] XSL 'prohibited-package' took 662ms (over 500ms)
[INFO] [WARNING] XSL 'same-line-names' took 2s (over 500ms)
[INFO] [WARNING] XSL 'unit-test-without-phi' took 2s (over 500ms)
[INFO] [WARNING] XSL 'duplicate-aliases' took 2s (over 500ms)
[INFO] [WARNING] XSL 'unused-aliases' took 2s (over 500ms)
[INFO] [WARNING] XSL 'incorrect-version' took 2s (over 500ms)
[INFO] [WARNING] XSL 'incorrect-home' took 2s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/MDC$MDCCloseable.xmir (13Kb) -> org/slf4j/MDC$MDCCloseable.phi (19Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/BasicMarker.xmir (112Kb)
[INFO] [INFO] Translated to phi: org/slf4j/spi/LocationAwareLogger.xmir (6Kb) -> org/slf4j/spi/LocationAwareLogger.phi (7Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/MessageFormatter.xmir (294Kb)
[INFO] [WARNING] XSL 'add-refs' took 672ms (over 500ms)
[INFO] [WARNING] XSL 'correct-package-meta' took 732ms (over 500ms)
[INFO] [WARNING] XSL 'wrap-method-calls' took 681ms (over 500ms)
[INFO] [WARNING] XSL 'expand-qqs' took 713ms (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/event/LoggingEvent.xmir (8Kb) -> org/slf4j/event/LoggingEvent.phi (10Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/NOPMDCAdapter.xmir (15Kb)
[INFO] [INFO] Translated to phi: org/slf4j/Logger.xmir (70Kb) -> org/slf4j/Logger.phi (85Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/FormattingTuple.xmir (25Kb)
[INFO] [WARNING] XSL 'add-default-package' took 862ms (over 500ms)
[INFO] [WARNING] XSL 'unknown-names' took 685ms (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/event/EventConstants.xmir (8Kb) -> org/slf4j/event/EventConstants.phi (10Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/SubstituteLoggerFactory.xmir (44Kb)
[INFO] [WARNING] XSL 'external-weak-typed-atoms' took 732ms (over 500ms)
[INFO] [WARNING] XSL 'broken-refs' took 626ms (over 500ms)
[INFO] [WARNING] XSL 'unused-aliases' took 584ms (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 710ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 2s (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 585ms (over 500ms)
[INFO] [WARNING] XSL 'vars-float-up' took 633ms (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/event/SubstituteLoggingEvent.xmir (59Kb) -> org/slf4j/event/SubstituteLoggingEvent.phi (91Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/Util$1.xmir (2Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 10s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 4s (over 500ms)
[INFO] [WARNING] XSL 'add-default-package' took 816ms (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 796ms (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/MDC.xmir (87Kb) -> org/slf4j/MDC.phi (152Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/NamedLoggerBase.xmir (11Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 6s (over 500ms)
[INFO] [WARNING] XSL 'broken-refs' took 800ms (over 500ms)
[INFO] [WARNING] XSL 'global-nonames' took 787ms (over 500ms)
[INFO] [WARNING] XSL 'global-nonames' took 828ms (over 500ms)
[INFO] [WARNING] XSL 'vars-float-up' took 537ms (over 500ms)
[INFO] [WARNING] XSL 'add-default-package' took 581ms (over 500ms)
[INFO] [WARNING] XSL 'set-locators' took 1s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 2s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/LoggerFactory.xmir (310Kb) -> org/slf4j/LoggerFactory.phi (637Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/SubstituteLogger.xmir (331Kb)
[INFO] [WARNING] XSL 'add-refs' took 5s (over 500ms)
[INFO] [WARNING] XSL 'not-empty-atoms' took 5s (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 5s (over 500ms)
[INFO] [WARNING] XSL 'incorrect-architect' took 5s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 16s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/event/Level.xmir (46Kb) -> org/slf4j/event/Level.phi (89Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/NOPLoggerFactory.xmir (7Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 674ms (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/event/EventRecodingLogger.xmir (314Kb) -> org/slf4j/event/EventRecodingLogger.phi (544Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/Util.xmir (70Kb)
[INFO] [WARNING] XSL 'broken-refs' took 3s (over 500ms)
[INFO] [WARNING] XSL 'prohibited-package' took 3s (over 500ms)
[INFO] [WARNING] XSL 'incorrect-version' took 3s (over 500ms)
[INFO] [WARNING] XSL 'duplicate-aliases' took 3s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/NOPLogger.xmir (62Kb) -> org/slf4j/helpers/NOPLogger.phi (89Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/Util$ClassContextSecurityManager.xmir (10Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 9s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/NOPMDCAdapter.xmir (15Kb) -> org/slf4j/helpers/NOPMDCAdapter.phi (20Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/BasicMDCAdapter$1.xmir (16Kb)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/Util$1.xmir (2Kb) -> org/slf4j/helpers/Util$1.phi (2Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/MarkerIgnoringBase.xmir (120Kb)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/FormattingTuple.xmir (25Kb) -> org/slf4j/helpers/FormattingTuple.phi (40Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/helpers/BasicMDCAdapter.xmir (61Kb)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/BasicMarkerFactory.xmir (37Kb) -> org/slf4j/helpers/BasicMarkerFactory.phi (69Kb)
[INFO] [INFO] Processing XMIR: org/slf4j/MDC$1.xmir (2Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 2s (over 500ms)
[INFO] [WARNING] XSL 'same-line-names' took 2s (over 500ms)
[INFO] [WARNING] XSL 'correct-package-meta' took 2s (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 2s (over 500ms)
[INFO] [WARNING] XSL 'const-to-dataized' took 2s (over 500ms)
[INFO] [WARNING] XSL 'not-empty-atoms' took 2s (over 500ms)
[INFO] [WARNING] XSL 'unknown-names' took 2s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/SubstituteLoggerFactory.xmir (44Kb) -> org/slf4j/helpers/SubstituteLoggerFactory.phi (75Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/RemoteLookupFailureException.xmir (8Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 695ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 4s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/NamedLoggerBase.xmir (11Kb) -> org/slf4j/helpers/NamedLoggerBase.phi (16Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/package-info.xmir (2Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 9s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 7s (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 533ms (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/BasicMarker.xmir (112Kb) -> org/slf4j/helpers/BasicMarker.phi (234Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/RemoteConnectFailureException.xmir (5Kb)
[INFO] [WARNING] XSL 'incorrect-home' took 826ms (over 500ms)
[INFO] [WARNING] XSL 'add-default-package' took 881ms (over 500ms)
[INFO] [WARNING] XSL 'incorrect-home' took 812ms (over 500ms)
[INFO] [WARNING] XSL 'wrap-method-calls' took 827ms (over 500ms)
[INFO] [WARNING] XSL 'same-line-names' took 866ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-version-meta' took 867ms (over 500ms)
[INFO] [WARNING] XSL 'duplicate-names' took 879ms (over 500ms)
[INFO] [WARNING] XSL 'incorrect-version' took 888ms (over 500ms)
[INFO] [WARNING] XSL 'duplicate-aliases' took 898ms (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/NOPLoggerFactory.xmir (7Kb) -> org/slf4j/helpers/NOPLoggerFactory.phi (9Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/soap/SoapFaultException.xmir (9Kb)
[INFO] [WARNING] XSL 'broken-refs' took 595ms (over 500ms)
[INFO] [WARNING] XSL 'incorrect-version' took 628ms (over 500ms)
[INFO] [WARNING] XSL 'expand-qqs' took 641ms (over 500ms)
[INFO] [WARNING] XSL 'self-naming' took 652ms (over 500ms)
[INFO] [WARNING] XSL 'correct-package-meta' took 654ms (over 500ms)
[INFO] [WARNING] XSL 'expand-aliases' took 615ms (over 500ms)
[INFO] [WARNING] XSL 'global-nonames' took 680ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 2s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 1s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/Util$ClassContextSecurityManager.xmir (10Kb) -> org/slf4j/helpers/Util$ClassContextSecurityManager.phi (15Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/RemoteInvocationFailureException.xmir (5Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 756ms (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 522ms (over 500ms)
[INFO] [WARNING] XSL 'correct-package-meta' took 4s (over 500ms)
[INFO] [WARNING] XSL 'same-line-names' took 4s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/SubstituteLogger.xmir (331Kb) -> org/slf4j/helpers/SubstituteLogger.phi (577Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/DefaultRemoteInvocationFactory.xmir (8Kb)
[INFO] [WARNING] XSL 'set-locators' took 4s (over 500ms)
[INFO] [WARNING] XSL 'unsorted-metas' took 4s (over 500ms)
[INFO] [WARNING] XSL 'incorrect-home' took 4s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/MDC$1.xmir (2Kb) -> org/slf4j/MDC$1.phi (1Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/DefaultRemoteInvocationExecutor.xmir (12Kb)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/BasicMDCAdapter$1.xmir (16Kb) -> org/slf4j/helpers/BasicMDCAdapter$1.phi (23Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemoteInvocationResult.xmir (51Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 594ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 45s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 1s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/RemoteLookupFailureException.xmir (8Kb) -> org/springframework/remoting/RemoteLookupFailureException.phi (12Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemoteInvocationBasedAccessor.xmir (28Kb)
[INFO] [WARNING] XSL 'same-line-names' took 2s (over 500ms)
[INFO] [WARNING] XSL 'duplicate-names' took 2s (over 500ms)
[INFO] [WARNING] XSL 'mandatory-home-meta' took 2s (over 500ms)
[INFO] [WARNING] XSL 'unused-aliases' took 2s (over 500ms)
[INFO] [WARNING] XSL 'mandatory-version-meta' took 2s (over 500ms)
[INFO] [WARNING] XSL 'cti-adds-errors' took 2s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/MarkerIgnoringBase.xmir (120Kb) -> org/slf4j/helpers/MarkerIgnoringBase.phi (194Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemoteExporter.xmir (105Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/package-info.xmir (2Kb) -> org/springframework/remoting/package-info.phi (2Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemoteInvocation.xmir (94Kb)
[INFO] [WARNING] XSL 'add-refs' took 505ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-version-meta' took 507ms (over 500ms)
[INFO] [WARNING] XSL 'set-locators' took 613ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 4s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 6s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/Util.xmir (70Kb) -> org/slf4j/helpers/Util.phi (137Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/UrlBasedRemoteAccessor.xmir (16Kb)
[INFO] [WARNING] XSL 'add-refs' took 603ms (over 500ms)
[INFO] [WARNING] XSL 'incorrect-version' took 560ms (over 500ms)
[INFO] [WARNING] XSL 'broken-aliases' took 548ms (over 500ms)
[INFO] [WARNING] XSL 'explicit-data' took 591ms (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/RemoteConnectFailureException.xmir (5Kb) -> org/springframework/remoting/RemoteConnectFailureException.phi (7Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemoteInvocationFactory.xmir (3Kb)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/BasicMDCAdapter.xmir (61Kb) -> org/slf4j/helpers/BasicMDCAdapter.phi (113Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemoteInvocationUtils.xmir (29Kb)
[INFO] [WARNING] XSL 'duplicate-aliases' took 509ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 2s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/soap/SoapFaultException.xmir (9Kb) -> org/springframework/remoting/soap/SoapFaultException.phi (12Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemoteAccessor.xmir (15Kb)
[INFO] [WARNING] XSL 'add-refs' took 819ms (over 500ms)
[INFO] [WARNING] XSL 'set-locators' took 742ms (over 500ms)
[INFO] [WARNING] XSL 'global-nonames' took 817ms (over 500ms)
[INFO] [WARNING] XSL 'add-default-package' took 817ms (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 805ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-version-meta' took 796ms (over 500ms)
[INFO] [WARNING] XSL 'broken-refs' took 631ms (over 500ms)
[INFO] [WARNING] XSL 'add-probes' took 594ms (over 500ms)
[INFO] [WARNING] XSL 'same-line-names' took 721ms (over 500ms)
[INFO] [WARNING] XSL 'correct-package-meta' took 617ms (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/RemoteInvocationFailureException.xmir (5Kb) -> org/springframework/remoting/RemoteInvocationFailureException.phi (7Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemotingSupport.xmir (26Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 3s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 7s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 1s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/DefaultRemoteInvocationFactory.xmir (8Kb) -> org/springframework/remoting/support/DefaultRemoteInvocationFactory.phi (11Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemoteInvocationBasedExporter.xmir (77Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/DefaultRemoteInvocationExecutor.xmir (12Kb) -> org/springframework/remoting/support/DefaultRemoteInvocationExecutor.phi (18Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemoteInvocationTraceInterceptor.xmir (80Kb)
[INFO] [WARNING] XSL 'set-locators' took 759ms (over 500ms)
[INFO] [WARNING] XSL 'wrap-method-calls' took 829ms (over 500ms)
[INFO] [WARNING] XSL 'vars-float-up' took 1s (over 500ms)
[INFO] [INFO] Translated to phi: org/slf4j/helpers/MessageFormatter.xmir (294Kb) -> org/slf4j/helpers/MessageFormatter.phi (775Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/SimpleHttpServerFactoryBean.xmir (120Kb)
[INFO] [WARNING] XSL 'cti-adds-errors' took 5s (over 500ms)
[INFO] [WARNING] XSL 'correct-package-meta' took 5s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 14s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 17s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/RemoteInvocationBasedAccessor.xmir (28Kb) -> org/springframework/remoting/support/RemoteInvocationBasedAccessor.phi (45Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemoteInvocationExecutor.xmir (3Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/RemoteInvocationResult.xmir (51Kb) -> org/springframework/remoting/support/RemoteInvocationResult.phi (90Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/RemoteProxyFailureException.xmir (5Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/UrlBasedRemoteAccessor.xmir (16Kb) -> org/springframework/remoting/support/UrlBasedRemoteAccessor.phi (26Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/RemoteTimeoutException.xmir (8Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 512ms (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/RemoteInvocationFactory.xmir (3Kb) -> org/springframework/remoting/support/RemoteInvocationFactory.phi (3Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/RemoteAccessException.xmir (9Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/RemoteAccessor.xmir (15Kb) -> org/springframework/remoting/support/RemoteAccessor.phi (23Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/JndiRmiProxyFactoryBean.xmir (31Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/RemoteInvocation.xmir (94Kb) -> org/springframework/remoting/support/RemoteInvocation.phi (170Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/RmiClientInterceptor.xmir (299Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/RemotingSupport.xmir (26Kb) -> org/springframework/remoting/support/RemotingSupport.phi (41Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/RemoteInvocationSerializingExporter.xmir (70Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 6s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 2s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 14s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 3s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/RemoteInvocationUtils.xmir (29Kb) -> org/springframework/remoting/support/RemoteInvocationUtils.phi (74Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/RmiRegistryFactoryBean.xmir (191Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/RemoteExporter.xmir (105Kb) -> org/springframework/remoting/support/RemoteExporter.phi (246Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/RmiServiceExporter.xmir (329Kb)
[INFO] [WARNING] XSL 'add-probes' took 569ms (over 500ms)
[INFO] [WARNING] XSL 'duplicate-metas' took 652ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 16s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/RemoteInvocationExecutor.xmir (3Kb) -> org/springframework/remoting/support/RemoteInvocationExecutor.phi (4Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/RmiProxyFactoryBean.xmir (25Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/RemoteProxyFailureException.xmir (5Kb) -> org/springframework/remoting/RemoteProxyFailureException.phi (7Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/RmiInvocationWrapper.xmir (28Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/RemoteTimeoutException.xmir (8Kb) -> org/springframework/remoting/RemoteTimeoutException.phi (12Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/JndiRmiClientInterceptor.xmir (298Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/RemoteAccessException.xmir (9Kb) -> org/springframework/remoting/RemoteAccessException.phi (13Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/RmiInvocationHandler.xmir (6Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 3s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 622ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 3s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/JndiRmiProxyFactoryBean.xmir (31Kb) -> org/springframework/remoting/rmi/JndiRmiProxyFactoryBean.phi (50Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/RmiClientInterceptor$1.xmir (2Kb)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/SimpleHttpServerFactoryBean.xmir (120Kb) -> org/springframework/remoting/support/SimpleHttpServerFactoryBean.phi (234Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/RmiBasedExporter.xmir (33Kb)
[INFO] [WARNING] XSL 'set-locators' took 814ms (over 500ms)
[INFO] [WARNING] XSL 'duplicate-metas' took 962ms (over 500ms)
[INFO] [WARNING] XSL 'broken-aliases' took 816ms (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/RemoteInvocationBasedExporter.xmir (77Kb) -> org/springframework/remoting/support/RemoteInvocationBasedExporter.phi (190Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/JndiRmiServiceExporter.xmir (112Kb)
[INFO] [WARNING] XSL 'mandatory-home-meta' took 574ms (over 500ms)
[INFO] [WARNING] XSL 'global-nonames' took 569ms (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/RemoteInvocationSerializingExporter.xmir (70Kb) -> org/springframework/remoting/rmi/RemoteInvocationSerializingExporter.phi (123Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/RmiClientInterceptor$DummyURLStreamHandler.xmir (12Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 682ms (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/support/RemoteInvocationTraceInterceptor.xmir (80Kb) -> org/springframework/remoting/support/RemoteInvocationTraceInterceptor.phi (219Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/RmiClientInterceptorUtils.xmir (106Kb)
[INFO] [WARNING] XSL 'self-naming' took 581ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 17s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/RmiInvocationHandler.xmir (6Kb) -> org/springframework/remoting/rmi/RmiInvocationHandler.phi (8Kb)
[INFO] [INFO] Processing XMIR: org/springframework/remoting/rmi/CodebaseAwareObjectInputStream.xmir (30Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 8s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/RmiProxyFactoryBean.xmir (25Kb) -> org/springframework/remoting/rmi/RmiProxyFactoryBean.phi (40Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/ModelMap.xmir (69Kb)
[INFO] [WARNING] XSL 'same-line-names' took 961ms (over 500ms)
[INFO] [WARNING] XSL 'many-free-attributes' took 815ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-package-meta' took 877ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 3s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 8s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/RmiInvocationWrapper.xmir (28Kb) -> org/springframework/remoting/rmi/RmiInvocationWrapper.phi (48Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/ExtendedModelMap.xmir (64Kb)
[INFO] [WARNING] XSL 'self-naming' took 550ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 21s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 2s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/RmiClientInterceptor$1.xmir (2Kb) -> org/springframework/remoting/rmi/RmiClientInterceptor$1.phi (2Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/context/Theme.xmir (3Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 5s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 31s (over 500ms)
[INFO] [WARNING] XSL 'same-line-names' took 2s (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 2s (over 500ms)
[INFO] [WARNING] XSL 'duplicate-aliases' took 2s (over 500ms)
[INFO] [WARNING] XSL 'self-naming' took 2s (over 500ms)
[INFO] [WARNING] XSL 'explicit-data' took 2s (over 500ms)
[INFO] [WARNING] XSL 'add-default-package' took 504ms (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/RmiClientInterceptor$DummyURLStreamHandler.xmir (12Kb) -> org/springframework/remoting/rmi/RmiClientInterceptor$DummyURLStreamHandler.phi (17Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/context/package-info.xmir (2Kb)
[INFO] [WARNING] XSL 'same-line-names' took 2s (over 500ms)
[INFO] [WARNING] XSL 'wrap-method-calls' took 2s (over 500ms)
[INFO] [WARNING] XSL 'duplicate-metas' took 2s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 2s (over 500ms)
[INFO] [WARNING] XSL 'duplicate-names' took 2s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 18s (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 510ms (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 914ms (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 915ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-version-meta' took 909ms (over 500ms)
[INFO] [WARNING] XSL 'unsorted-metas' took 932ms (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 660ms (over 500ms)
[INFO] [WARNING] XSL 'expand-aliases' took 539ms (over 500ms)
[INFO] [WARNING] XSL 'same-line-names' took 800ms (over 500ms)
[INFO] [WARNING] XSL 'incorrect-version' took 858ms (over 500ms)
[INFO] [WARNING] XSL 'cti-adds-errors' took 510ms (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 927ms (over 500ms)
[INFO] [WARNING] XSL 'incorrect-home' took 642ms (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 636ms (over 500ms)
[INFO] [WARNING] XSL 'unused-aliases' took 640ms (over 500ms)
[INFO] [WARNING] XSL 'add-default-package' took 819ms (over 500ms)
[INFO] [WARNING] XSL 'wrap-method-calls' took 677ms (over 500ms)
[INFO] [WARNING] XSL 'unit-test-without-phi' took 684ms (over 500ms)
[INFO] [WARNING] XSL 'incorrect-version' took 755ms (over 500ms)
[INFO] [WARNING] XSL 'noname-attributes' took 701ms (over 500ms)
[INFO] [WARNING] XSL 'add-probes' took 706ms (over 500ms)
[INFO] [WARNING] XSL 'unknown-names' took 707ms (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/RmiRegistryFactoryBean.xmir (191Kb) -> org/springframework/remoting/rmi/RmiRegistryFactoryBean.phi (454Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/context/ThemeSource.xmir (3Kb)
[INFO] [WARNING] XSL 'broken-refs' took 2s (over 500ms)
[INFO] [WARNING] XSL 'duplicate-names' took 2s (over 500ms)
[INFO] [WARNING] XSL 'explicit-data' took 2s (over 500ms)
[INFO] [WARNING] XSL 'expand-qqs' took 2s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/RmiBasedExporter.xmir (33Kb) -> org/springframework/remoting/rmi/RmiBasedExporter.phi (65Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/context/support/SimpleTheme.xmir (17Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 704ms (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 503ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-package-meta' took 528ms (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 640ms (over 500ms)
[INFO] [WARNING] XSL 'const-to-dataized' took 657ms (over 500ms)
[INFO] [WARNING] XSL 'add-probes' took 723ms (over 500ms)
[INFO] [WARNING] XSL 'add-default-package' took 632ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-home-meta' took 666ms (over 500ms)
[INFO] [WARNING] XSL 'const-to-dataized' took 693ms (over 500ms)
[INFO] [WARNING] XSL 'not-empty-atoms' took 763ms (over 500ms)
[INFO] [WARNING] XSL 'duplicate-metas' took 764ms (over 500ms)
[INFO] [WARNING] XSL 'noname-attributes' took 845ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-package-meta' took 760ms (over 500ms)
[INFO] [WARNING] XSL 'set-locators' took 640ms (over 500ms)
[INFO] [WARNING] XSL 'vars-float-up' took 681ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-version-meta' took 558ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-home-meta' took 559ms (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/JndiRmiServiceExporter.xmir (112Kb) -> org/springframework/remoting/rmi/JndiRmiServiceExporter.phi (226Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/context/support/package-info.xmir (2Kb)
[INFO] [WARNING] XSL 'prohibited-package' took 502ms (over 500ms)
[INFO] [WARNING] XSL 'correct-package-meta' took 611ms (over 500ms)
[INFO] [WARNING] XSL 'mandatory-package-meta' took 505ms (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/CodebaseAwareObjectInputStream.xmir (30Kb) -> org/springframework/remoting/rmi/CodebaseAwareObjectInputStream.phi (49Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/context/support/ResourceBundleThemeSource.xmir (140Kb)
[INFO] [WARNING] XSL 'duplicate-names' took 593ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 5s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/ui/ModelMap.xmir (69Kb) -> org/springframework/ui/ModelMap.phi (117Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/context/support/DelegatingThemeSource.xmir (20Kb)
[INFO] [WARNING] XSL 'set-locators' took 587ms (over 500ms)
[INFO] [WARNING] XSL 'unused-aliases' took 605ms (over 500ms)
[INFO] [WARNING] XSL 'unknown-names' took 722ms (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/ui/ExtendedModelMap.xmir (64Kb) -> org/springframework/ui/ExtendedModelMap.phi (98Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/context/support/UiApplicationContextUtils.xmir (56Kb)
[INFO] [INFO] Translated to phi: org/springframework/ui/context/Theme.xmir (3Kb) -> org/springframework/ui/context/Theme.phi (4Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/context/HierarchicalThemeSource.xmir (5Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 49s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/JndiRmiClientInterceptor.xmir (298Kb) -> org/springframework/remoting/rmi/JndiRmiClientInterceptor.phi (730Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/ConcurrentModel.xmir (114Kb)
[INFO] [WARNING] XSL 'mandatory-package-meta' took 4s (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 4s (over 500ms)
[INFO] [WARNING] XSL 'self-naming' took 4s (over 500ms)
[INFO] [WARNING] XSL 'explicit-data' took 4s (over 500ms)
[INFO] [WARNING] XSL 'wrap-method-calls' took 4s (over 500ms)
[INFO] [WARNING] XSL 'set-locators' took 761ms (over 500ms)
[INFO] [WARNING] XSL 'many-free-attributes' took 884ms (over 500ms)
[INFO] [WARNING] XSL 'add-probes' took 833ms (over 500ms)
[INFO] [WARNING] XSL 'stars-to-tuples' took 8s (over 500ms)
[INFO] [INFO] Translated to phi: org/springframework/remoting/rmi/RmiClientInterceptor.xmir (299Kb) -> org/springframework/remoting/rmi/RmiClientInterceptor.phi (826Kb)
[INFO] [INFO] Processing XMIR: org/springframework/ui/package-info.xmir (2Kb)
[INFO] [WARNING] XSL 'expand-qqs' took 5s (over 500ms)
[INFO] [WARNING] XSL 'mandatory-version-meta' took 5s (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 5s (over 500ms)
[INFO] [WARNING] XSL 'same-line-names' took 3s (over 500ms)
[INFO] [WARNING] XSL 'add-refs' took 3s (over 500ms)

yegor256 commented 1 month ago

@volodya-lombrozo we can't solve this problem in one step, since it's just a performance problem of XSL as a platform. The best we can do is to cache previously transformed XML documents and avoid repetitive transformations via XSL.

volodya-lombrozo commented 1 month ago

@yegor256 Why should we close this issue then? It might be a good starting point.

volodya-lombrozo commented 1 month ago

Otherwise you just hide it

volodya-lombrozo commented 1 month ago

@yegor256 I reopen this issue because it blocks the following issue: https://github.com/objectionary/jeo-maven-plugin/issues/633

yegor256 commented 1 month ago

@volodya-lombrozo it seems to be a duplicate of #1426

volodya-lombrozo commented 1 month ago

@yegor256 No, it's not a duplicate. The #1426 issue is related to EO compilation. This issue is related to PHI printing.

yegor256 commented 1 month ago

@volodya-lombrozo it's all the same: all XSL-related Maven steps can be made faster only by caching, which is what #1426 is about.

volodya-lombrozo commented 1 month ago

@yegor256 I don't think this issue might be solved by simple caching

yegor256 commented 1 month ago

@volodya-lombrozo caching will help, but that's all we can do. We can't make XSL faster and we can't get rid of XSL in this project.

volodya-lombrozo commented 1 month ago

@yegor256 Most probably, the implementation of xsl transformations is suboptimal and might be optimised. Why do you believe we can't make xsl faster?

yegor256 commented 1 month ago

@volodya-lombrozo we use Saxon, the state of the art XSL processor. Maybe it could be made faster, but this work is definitely outside of scope of this project.

volodya-lombrozo commented 1 month ago

@yegor256 Please, see the excerpt from the logs:

[INFO] [INFO] Processing XMIR: org/springframework/remoting/support/RemoteInvocationResult.xmir (51Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 594ms (over 500ms)
[INFO] [INFO] Processing XMIR: org/springframework/ui/ExtendedModelMap.xmir (64Kb)
[INFO] [WARNING] XSL 'stars-to-tuples' took 21s (over 500ms)

As you can see, there is a huge difference between XSL transformation times; however the size of the transformed files is approximately the same. I'm sure that stars-to-tuples transformation has quadratic or even worse complexity. I don't think the problem is related to the XSL processor. It is our algorithms that works, let's say, suboptimally.

yegor256 commented 1 month ago

I see this:

[INFO] >> [WARNING] XSL 'duplicate-aliases' took 7s (over 500ms)
[INFO] >> [WARNING] XSL 'incorrect-architect' took 7s (over 500ms)
[INFO] >> [WARNING] XSL 'incorrect-version' took 7s (over 500ms)
[INFO] >> [WARNING] XSL 'add-refs' took 17s (over 500ms)
[INFO] >> [WARNING] XSL 'duplicate-names' took 17s (over 500ms)
[INFO] >> [WARNING] XSL 'add-default-package' took 42s (over 500ms)
[INFO] >> [WARNING] XSL 'broken-refs' took 31s (over 500ms)
[INFO] >> [WARNING] XSL 'add-default-package' took 42s (over 500ms)
[INFO] >> [WARNING] XSL 'global-nonames' took 42s (over 500ms)
[INFO] >> [WARNING] XSL 'add-refs' took 31s (over 500ms)
[INFO] >> [WARNING] XSL 'duplicate-metas' took 31s (over 500ms)
[INFO] >> [WARNING] XSL 'sparse-decoration' took 32s (over 500ms)
[INFO] >> [WARNING] XSL 'broken-refs' took 9s (over 500ms)
[INFO] >> [WARNING] XSL 'unknown-names' took 9s (over 500ms)
[INFO] >> [WARNING] XSL 'unknown-names' took 9s (over 500ms)

It's absolutely impossible to image that an XSL processing would take 40+ seconds. Looks like we have some global state that is used as a lock for all threads. They all are simply waiting for its release.

volodya-lombrozo commented 1 month ago

@yegor256 @maxonfjvipon FYI:

[INFO] Translated to phi (#88/127): target/generated-sources/jeo-disassemble/com/sun/jna/NativeLibrary.xmir (2Mb) -> com/sun/jna/NativeLibrary.phi (2Mb) in 4min

What it can do for 4 minutes?

eo-maven-plugin:0.40.3

maxonfjvipon commented 1 month ago

@volodya-lombrozo could you please send me NativeLibrary.phi file?

volodya-lombrozo commented 1 month ago

@maxonfjvipon Sure, please NativeLibrary.phi.txt

maxonfjvipon commented 1 month ago

@volodya-lombrozo I tried to convert NativeLibrary.xmir (8mb, 200k lines of XML code) to phi and here's what I've got on my machine:

[INFO] Error stacktraces are turned on.
[INFO] Scanning for projects...
[INFO] 
[INFO] ---------------------------< org.eolang:eoc >---------------------------
[INFO] Building eoc 0.0.0
[INFO]   from pom.xml
[INFO] --------------------------------[ jar ]---------------------------------
[INFO] 
[INFO] --- eo:0.40.2:xmir-to-phi (default-cli) @ eoc ---
[WARNING] XSL 'stars-to-tuples' took 817ms (over 500ms)
[WARNING] XSL 'duplicate-names' took 533ms (over 500ms)
[WARNING] XSL 'add-refs' took 4s (over 500ms)
[WARNING] XSL 'add-probes' took 1s (over 500ms)
[WARNING] XSL 'add-refs' took 4s (over 500ms)
[WARNING] XSL 'resolve-aliases' took 862ms (over 500ms)
[WARNING] XSL 'add-refs' took 4s (over 500ms)
[WARNING] XSL 'add-default-package' took 1min (over 500ms)
[WARNING] XSL 'set-locators' took 3s (over 500ms)
[INFO] Translated to phi (#1/1): /Users/maxonfjvipon/code/eo/unphi/.eoc/2-optimize/some.xmir (8Mb) -> some.phi (2Mb) in 2min
[INFO] Translated 1 XMIR file(s) from /Users/maxonfjvipon/code/eo/unphi/.eoc/2-optimize to /Users/maxonfjvipon/code/eo/unphi/.eoc/phi
[INFO] ------------------------------------------------------------------------
[INFO] BUILD SUCCESS
[INFO] ------------------------------------------------------------------------
[INFO] Total time:  02:13 min
[INFO] Finished at: 2024-10-30T18:35:43+03:00
[INFO] ------------------------------------------------------------------------

As you can see [WARNING] XSL 'add-default-package' took 1min (over 500ms) we found candidate for optimization

yegor256 commented 4 weeks ago

@rultor release, tag is 0.40.4

rultor commented 4 weeks ago

@rultor release, tag is 0.40.4

@yegor256 OK, I will release it now. Please check the progress here.

rultor commented 4 weeks ago

@rultor release, tag is 0.40.4

@yegor256 Done! FYI, the full log is here (took me 12min).

yegor256 commented 3 weeks ago

@rultor release, tag is 0.40.5

rultor commented 3 weeks ago

@rultor release, tag is 0.40.5

@yegor256 OK, I will release it now. Please check the progress here.

rultor commented 3 weeks ago

@rultor release, tag is 0.40.5

@yegor256 Done! FYI, the full log is here (took me 12min).

objectionary / eo

eo:xmir-to-phi is too slow #3257

Problems