Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Intellij crashes after running Perl test coverage (OSX only) #2863

Open
OlegLoewen opened this issue Jun 22, 2024 · 14 comments
Open

Intellij crashes after running Perl test coverage (OSX only) #2863

OlegLoewen opened this issue Jun 22, 2024 · 14 comments

Comments

@OlegLoewen
Copy link

OlegLoewen commented Jun 22, 2024 •
edited
Loading

If run test with coverage, the tests are executed and I get the test results, however coverage is not shown. Sometimes it's shown after 5 minutes. If I run the test coverage the 2nd time, Intellij crashes while the dialog "Loading Coverage data" appears, after clicking on "replace existing coverage".
The exactly same project in intellij with same plugin on a Windows machine, provides the test coverage in a few seconds without any trouble. Please help to resolve this issue.

Logs:

2024-06-22 21:06:45,566 [ 731848]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   working dir: /Users/blubber/dev/afroc
2024-06-22 21:06:45,567 [ 731849]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   host = local; vm = system; pty = false; charset: UTF-8
2024-06-22 21:06:49,939 [ 736221]   INFO - #com.perl5.lang.perl.coverage.PerlCoverageRunner - Loading coverage by: /opt/homebrew/Cellar/perl/5.38.2_1/bin/perl -I/Users/blubber/dev/afroc/SHARED//SHARED -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module/t "-I/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1/plugins/plugin/perl/lib" /Users/blubber/perl5/bin/cover --silent --nosummary -report camelcade /Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/coverage/afroc_S_Tests_from__GetDiskInfo_t_
2024-06-22 21:06:49,939 [ 736221]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine - Executing: /opt/homebrew/Cellar/perl/5.38.2_1/bin/perl -I/Users/blubber/dev/afroc/SHARED//SHARED -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module/t "-I/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1/plugins/plugin/perl/lib" /Users/blubber/perl5/bin/cover --silent --nosummary -report camelcade /Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/coverage/afroc_S_Tests_from__GetDiskInfo_t_
2024-06-22 21:06:49,939 [ 736221]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   environment: {} (+CONSOLE)
2024-06-22 21:06:49,939 [ 736221]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   working dir: null
2024-06-22 21:06:49,939 [ 736221]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   host = local; vm = system; pty = false; charset: UTF-8
2024-06-22 21:07:18,227 [ 764509]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.SdkEntity to files
2024-06-22 21:07:18,227 [ 764509]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.LibraryEntity to files
2024-06-22 21:07:18,248 [ 764530]   INFO - #c.i.c.ComponentStoreImpl - Saving Project(name=afroc, containerState=COMPONENT_CREATED, componentStore=/Users/blubber/dev/afroc)RunManager took 11 ms
2024-06-22 21:09:04,216 [ 870498]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.SdkEntity to files
2024-06-22 21:09:04,216 [ 870498]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.LibraryEntity to files
2024-06-22 21:09:42,058 [ 908340]   WARN - #c.i.e.p.BaseOSProcessHandler - Process hasn't generated any output for a long time.
If it's a long-running mostly idle daemon process, consider overriding OSProcessHandler#readerOptions with 'BaseOutputReader.Options.forMostlySilentProcess()' to reduce CPU usage.
Command line: /opt/homebrew/Cellar/perl/5.38.2_1/bin/perl -I/Users/blubber/dev/afroc/SHARED//SHARED -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module/t "-I/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1/plugins/plugin/perl/lib" /Users/blubber/perl5/bin/cover --silent --nosummary -report camelcade /Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/coverage/afroc_S_Tests_from__GetDiskInfo_t_
java.lang.Throwable: Process creation:
	at com.intellij.execution.process.BaseOSProcessHandler.<init>(BaseOSProcessHandler.java:32)
	at com.intellij.execution.process.OSProcessHandler.<init>(OSProcessHandler.java:78)
	at com.intellij.execution.process.KillableProcessHandler.<init>(KillableProcessHandler.java:77)
	at com.intellij.execution.process.KillableProcessHandler.<init>(KillableProcessHandler.java:70)
	at com.perl5.lang.perl.idea.sdk.host.PerlHostData.doCreateProcessHandler(PerlHostData.java:131)
	at com.perl5.lang.perl.idea.sdk.host.PerlHostData.createProcessHandler(PerlHostData.java:272)
	at com.perl5.lang.perl.idea.sdk.host.PerlHostData.execAndGetOutput(PerlHostData.java:249)
	at com.perl5.lang.perl.coverage.PerlCoverageRunner.doLoadCoverageData(PerlCoverageRunner.java:148)
	at com.perl5.lang.perl.coverage.PerlCoverageRunner.loadCoverageData(PerlCoverageRunner.java:76)
	at com.intellij.coverage.BaseCoverageSuite.loadProjectInfo(BaseCoverageSuite.java:197)
	at com.intellij.coverage.BaseCoverageSuite.getCoverageData(BaseCoverageSuite.java:162)
	at com.intellij.coverage.CoverageSuitesBundle.lambda$getCoverageData$0(CoverageSuitesBundle.java:97)
	at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197)
	at java.base/java.util.Spliterators$ArraySpliterator.forEachRemaining(Spliterators.java:992)
	at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509)
	at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499)
	at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:575)
	at java.base/java.util.stream.AbstractPipeline.evaluateToArrayNode(AbstractPipeline.java:260)
	at java.base/java.util.stream.ReferencePipeline.toArray(ReferencePipeline.java:616)
	at java.base/java.util.stream.ReferencePipeline.toArray(ReferencePipeline.java:622)
	at java.base/java.util.stream.ReferencePipeline.toList(ReferencePipeline.java:627)
	at com.intellij.coverage.CoverageSuitesBundle.getCoverageData(CoverageSuitesBundle.java:99)
	at com.intellij.coverage.SimpleCoverageAnnotator.createRenewRequest(SimpleCoverageAnnotator.java:300)
	at com.intellij.coverage.BaseCoverageAnnotator.renewCoverageData(BaseCoverageAnnotator.java:30)
	at com.intellij.coverage.CoverageDataManagerImpl.renewCoverageData(CoverageDataManagerImpl.java:384)
	at com.intellij.coverage.CoverageDataManagerImpl.updateCoverageData(CoverageDataManagerImpl.java:278)
	at com.intellij.coverage.CoverageDataManagerImpl.chooseSuitesBundle(CoverageDataManagerImpl.java:263)
	at com.intellij.coverage.CoverageDataManagerImpl.coverageGathered(CoverageDataManagerImpl.java:291)
	at com.intellij.coverage.CoverageDataManagerImpl.processGatheredCoverage(CoverageDataManagerImpl.java:379)
	at com.intellij.coverage.CoverageDataManagerImpl.processGatheredCoverage(CoverageDataManagerImpl.java:367)
	at com.intellij.coverage.CoverageDataManagerImpl$5.processTerminated(CoverageDataManagerImpl.java:358)
	at com.intellij.execution.process.ProcessHandler$2.processTerminated(ProcessHandler.java:262)
	at com.intellij.execution.process.ProcessHandler.lambda$notifyTerminated$2(ProcessHandler.java:207)
	at com.intellij.execution.process.ProcessHandler$TasksRunner.execute(ProcessHandler.java:325)
	at com.intellij.execution.process.ProcessHandler.notifyTerminated(ProcessHandler.java:190)
	at com.intellij.execution.process.ProcessHandler.notifyProcessTerminated(ProcessHandler.java:186)
	at com.intellij.execution.process.BaseProcessHandler.onOSProcessTerminated(BaseProcessHandler.java:59)
	at com.intellij.execution.process.OSProcessHandler.onOSProcessTerminated(OSProcessHandler.java:188)
	at com.intellij.execution.process.BaseOSProcessHandler$1.lambda$startNotified$0(BaseOSProcessHandler.java:82)
	at com.intellij.execution.process.ProcessWaitFor.lambda$new$0(ProcessWaitFor.java:45)
	at com.intellij.util.ConcurrencyUtil.runUnderThreadName(ConcurrencyUtil.java:218)
	at com.intellij.execution.process.ProcessWaitFor.lambda$new$1(ProcessWaitFor.java:23)
	at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539)
	at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
	at com.intellij.util.concurrency.ContextRunnable.run(ContextRunnable.java:27)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
	at java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1$1.run(Executors.java:702)
	at java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1$1.run(Executors.java:699)
	at java.base/java.security.AccessController.doPrivileged(AccessController.java:399)
	at java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1.run(Executors.java:699)
	at java.base/java.lang.Thread.run(Thread.java:840)
2024-06-22 21:10:47,187 [ 973469]   WARN - oshi.util.platform.mac.SysctlUtil - Failed sysctl call: hw.cpufrequency, Error code: 2
2024-06-22 21:10:48,194 [ 974476]   WARN - oshi.util.platform.mac.SysctlUtil - Failed sysctl call: hw.cpufrequency_max, Error code: 2
2024-06-22 21:10:49,097 [ 975379]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.SdkEntity to files
2024-06-22 21:10:49,097 [ 975379]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.LibraryEntity to files
2024-06-22 21:20:28,317 [1554599]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.SdkEntity to files
2024-06-22 21:20:28,317 [1554599]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.LibraryEntity to files
2024-06-22 21:20:37,243 [1563525]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.SdkEntity to files
2024-06-22 21:20:37,243 [1563525]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.LibraryEntity to files
2024-06-22 21:26:38,563 [1924845]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine - Executing: /opt/homebrew/Cellar/perl/5.38.2_1/bin/perl -I/Users/blubber/dev/afroc/SHARED//SHARED -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module/t /opt/homebrew/opt/perl/bin/prove --merge --recurse /Users/blubber/dev/afroc/HEC//LVM/lib/execution_modules/t/GetDiskInfo.t
2024-06-22 21:26:38,563 [1924845]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   environment: {HARNESS_OPTIONS=>j1:fTAP-Formatter-Camelcade, HARNESS_PERL_SWITCHES=>-MDevel::Cover=-silent,1,-db,/Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/coverage/afroc_S_Tests_from__GetDiskInfo_t_,-dir,.,-blib,0 -I/Users/blubber/dev/afroc/SHARED//SHARED -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module/t} (+CONSOLE)
2024-06-22 21:26:38,563 [1924845]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   working dir: /Users/blubber/dev/afroc
2024-06-22 21:26:38,563 [1924845]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   host = local; vm = system; pty = false; charset: UTF-8
2024-06-22 21:26:47,167 [1933449]   INFO - #com.perl5.lang.perl.coverage.PerlCoverageRunner - Loading coverage by: /opt/homebrew/Cellar/perl/5.38.2_1/bin/perl -I/Users/blubber/dev/afroc/SHARED//SHARED -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module/t "-I/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1/plugins/plugin/perl/lib" /Users/blubber/perl5/bin/cover --silent --nosummary -report camelcade /Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/coverage/afroc_S_Tests_from__GetDiskInfo_t_
2024-06-22 21:26:47,167 [1933449]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine - Executing: /opt/homebrew/Cellar/perl/5.38.2_1/bin/perl -I/Users/blubber/dev/afroc/SHARED//SHARED -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module/t "-I/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1/plugins/plugin/perl/lib" /Users/blubber/perl5/bin/cover --silent --nosummary -report camelcade /Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/coverage/afroc_S_Tests_from__GetDiskInfo_t_
2024-06-22 21:26:47,167 [1933449]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   environment: {} (+CONSOLE)
2024-06-22 21:26:47,167 [1933449]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   working dir: null
2024-06-22 21:26:47,167 [1933449]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   host = local; vm = system; pty = false; charset: UTF-8
2024-06-22 21:29:34,902 [2101184]   WARN - #c.i.e.p.BaseOSProcessHandler - Process hasn't generated any output for a long time.
If it's a long-running mostly idle daemon process, consider overriding OSProcessHandler#readerOptions with 'BaseOutputReader.Options.forMostlySilentProcess()' to reduce CPU usage.
Command line: /opt/homebrew/Cellar/perl/5.38.2_1/bin/perl -I/Users/blubber/dev/afroc/SHARED//SHARED -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module/t "-I/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1/plugins/plugin/perl/lib" /Users/blubber/perl5/bin/cover --silent --nosummary -report camelcade /Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/coverage/afroc_S_Tests_from__GetDiskInfo_t_
java.lang.Throwable: Process creation:
	at com.intellij.execution.process.BaseOSProcessHandler.<init>(BaseOSProcessHandler.java:32)
	at com.intellij.execution.process.OSProcessHandler.<init>(OSProcessHandler.java:78)
	at com.intellij.execution.process.KillableProcessHandler.<init>(KillableProcessHandler.java:77)
	at com.intellij.execution.process.KillableProcessHandler.<init>(KillableProcessHandler.java:70)
	at com.perl5.lang.perl.idea.sdk.host.PerlHostData.doCreateProcessHandler(PerlHostData.java:131)
	at com.perl5.lang.perl.idea.sdk.host.PerlHostData.createProcessHandler(PerlHostData.java:272)
	at com.perl5.lang.perl.idea.sdk.host.PerlHostData.execAndGetOutput(PerlHostData.java:249)
	at com.perl5.lang.perl.coverage.PerlCoverageRunner.doLoadCoverageData(PerlCoverageRunner.java:148)
	at com.perl5.lang.perl.coverage.PerlCoverageRunner.lambda$loadCoverageData$0(PerlCoverageRunner.java:70)
	at com.intellij.openapi.progress.impl.CoreProgressManager$2.run(CoreProgressManager.java:328)
	at com.intellij.openapi.progress.impl.CoreProgressManager.startTask(CoreProgressManager.java:477)
	at com.intellij.openapi.progress.impl.ProgressManagerImpl.startTask(ProgressManagerImpl.java:133)
	at com.intellij.openapi.progress.impl.CoreProgressManager.lambda$runProcessWithProgressSynchronously$9(CoreProgressManager.java:567)
	at com.intellij.openapi.progress.impl.ProgressRunner.lambda$new$0(ProgressRunner.java:86)
	at com.intellij.openapi.progress.impl.ProgressRunner.lambda$submit$4(ProgressRunner.java:250)
	at com.intellij.openapi.progress.ProgressManager.lambda$runProcess$0(ProgressManager.java:100)
	at com.intellij.openapi.progress.impl.CoreProgressManager.lambda$runProcess$1(CoreProgressManager.java:221)
	at com.intellij.platform.diagnostic.telemetry.helpers.TraceKt.use(trace.kt:46)
	at com.intellij.openapi.progress.impl.CoreProgressManager.lambda$runProcess$2(CoreProgressManager.java:220)
	at com.intellij.openapi.progress.impl.CoreProgressManager.lambda$executeProcessUnderProgress$13(CoreProgressManager.java:660)
	at com.intellij.openapi.progress.impl.CoreProgressManager.registerIndicatorAndRun(CoreProgressManager.java:735)
	at com.intellij.openapi.progress.impl.CoreProgressManager.computeUnderProgress(CoreProgressManager.java:691)
	at com.intellij.openapi.progress.impl.CoreProgressManager.executeProcessUnderProgress(CoreProgressManager.java:659)
	at com.intellij.openapi.progress.impl.ProgressManagerImpl.executeProcessUnderProgress(ProgressManagerImpl.java:79)
	at com.intellij.openapi.progress.impl.CoreProgressManager.runProcess(CoreProgressManager.java:202)
	at com.intellij.openapi.progress.ProgressManager.runProcess(ProgressManager.java:100)
	at com.intellij.openapi.progress.impl.ProgressRunner.lambda$submit$5(ProgressRunner.java:250)
	at com.intellij.openapi.progress.impl.ProgressRunner$ProgressRunnable.run(ProgressRunner.java:500)
	at com.intellij.util.concurrency.ChildContext$runAsCoroutine$1.invoke(propagation.kt:81)
	at com.intellij.util.concurrency.ChildContext$runAsCoroutine$1.invoke(propagation.kt:81)
	at com.intellij.util.concurrency.ChildContext.runAsCoroutine(propagation.kt:86)
	at com.intellij.util.concurrency.ChildContext.runAsCoroutine(propagation.kt:81)
	at com.intellij.openapi.progress.impl.ProgressRunner.lambda$launchTask$18(ProgressRunner.java:466)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
	at java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1$1.run(Executors.java:702)
	at java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1$1.run(Executors.java:699)
	at java.base/java.security.AccessController.doPrivileged(AccessController.java:399)
	at java.base/java.util.concurrent.Executors$PrivilegedThreadFactory$1.run(Executors.java:699)
	at java.base/java.lang.Thread.run(Thread.java:840)
2024-06-22 21:52:13,299 [3459581]   INFO - #c.i.u.i.FileBasedIndexImpl - Index dispose started
2024-06-22 21:52:13,335 [3459617]   INFO - #c.i.p.s.StubIndexImpl - StubIndexExtension-s were unloaded
2024-06-22 21:52:13,335 [3459617]   INFO - #c.i.p.s.SerializationManagerImpl - Start shutting down /Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/index/rep.names
2024-06-22 21:52:13,336 [3459618]   INFO - #c.i.p.s.SerializationManagerImpl - Finished shutting down /Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/index/rep.names
2024-06-22 21:52:13,337 [3459619]   INFO - #c.i.u.i.FileBasedIndexImpl - Index dispose completed in 37ms.
2024-06-22 21:52:13,337 [3459619]   INFO - #c.i.o.v.n.p.PersistentFSImpl - VFS dispose started
2024-06-22 21:52:13,337 [3459619]   INFO - #c.i.o.v.n.p.FSRecordsImpl - VFS closing
2024-06-22 21:52:13,338 [3459620]   INFO - #c.i.o.v.n.p.PersistentFSImpl - VFS dispose completed in 0 ms.
2024-06-22 21:52:13,343 [3459625]   INFO - #c.i.p.i.b.AppStarter - ------------------------------------------------------ IDE SHUTDOWN ------------------------------------------------------
2024-06-22 21:52:16,957 [      2]   INFO - #c.i.p.i.b.AppStarter - ------------------------------------------------------ IDE STARTED ------------------------------------------------------
2024-06-22 21:52:16,962 [      7]   INFO - #c.i.i.p.PluginManager - Plugin PluginDescriptor(name=Groovy, id=org.intellij.groovy, descriptorPath=plugin.xml, path=/Applications/IntelliJ IDEA CE.app/Contents/plugins/Groovy, version=241.17890.1, package=org.jetbrains.plugins.groovy, isBundled=true) misses optional descriptor duplicates-groovy.xml
2024-06-22 21:52:16,990 [     35]   INFO - #c.i.i.p.PluginManager - Plugin PluginDescriptor(name=Groovy, id=org.intellij.groovy, descriptorPath=plugin.xml, path=/Applications/IntelliJ IDEA CE.app/Contents/plugins/Groovy, version=241.17890.1, package=org.jetbrains.plugins.groovy, isBundled=true) misses optional descriptor duplicates-detection-groovy.xml
2024-06-22 21:52:16,994 [     39]   INFO - #c.i.u.i.PageCacheUtils - File page caching params:
2024-06-22 21:52:16,994 [     39]   INFO - #c.i.u.i.PageCacheUtils - 	DEFAULT_PAGE_SIZE: 10485760
2024-06-22 21:52:16,994 [     39]   INFO - #c.i.u.EnvironmentUtil - loading shell env: /bin/zsh -l -i -c '/Applications/IntelliJ IDEA CE.app/Contents/bin/printenv' > '/var/folders/p0/rzn93mn120l2l5z0qd3rzv3w0000gn/T/ij-env-tmp-dir16520789215963916281/ij-shell-env-data.tmp'
2024-06-22 21:52:16,994 [     39]   INFO - #c.i.u.i.PageCacheUtils - 	Direct memory to use, max: 4273995776
2024-06-22 21:52:16,995 [     40]   INFO - #c.i.u.i.PageCacheUtils - 	FilePageCache: regular + lock-free (LOCK_FREE_PAGE_CACHE_ENABLED:true)
2024-06-22 21:52:16,996 [     41]   INFO - #c.i.u.i.PageCacheUtils - 	NEW_PAGE_CACHE_MEMORY_FRACTION: 0.20000000298023224
2024-06-22 21:52:16,996 [     41]   INFO - #c.i.u.i.PageCacheUtils - 	Regular FilePageCache: 503316478 bytes
2024-06-22 21:52:16,996 [     41]   INFO - #c.i.u.i.PageCacheUtils - 	New     FilePageCache: 125829122 bytes (+ up to 10.0% overflow)
2024-06-22 21:52:16,996 [     41]   INFO - #c.i.u.i.PageCacheUtils - 	DirectByteBuffers pool: 104857600 bytes
2024-06-22 21:52:16,997 [     42]   INFO - #c.i.p.i.b.AppStarter - JNA library (64-bit) loaded in 6 ms
2024-06-22 21:52:16,998 [     43]   INFO - #c.i.p.i.b.AppStarter - IDE: IntelliJ IDEA (build #IC-241.17890.1, Tue, 4 Jun 2024 03:25:00 GMT)
2024-06-22 21:52:16,998 [     43]   INFO - #c.i.p.i.b.AppStarter - OS: Mac OS X (14.5)
2024-06-22 21:52:16,998 [     43]   INFO - #c.i.p.i.b.AppStarter - JRE: 17.0.11+1-b1207.24, aarch64 (JetBrains s.r.o.)
2024-06-22 21:52:16,998 [     43]   INFO - #c.i.p.i.b.AppStarter - JVM: 17.0.11+1-b1207.24 (OpenJDK 64-Bit Server VM)
2024-06-22 21:52:17,000 [     45]   INFO - #c.i.p.i.b.AppStarter - PID: 19890
2024-06-22 21:52:17,006 [     51]   INFO - #c.i.p.i.b.AppStarter - JVM options: [abort, vfprintf, -XX:ErrorFile=/Users/blubber/java_error_in_idea_%p.log, -XX:HeapDumpPath=/Users/blubber/java_error_in_idea.hprof, -Xms128m, -Xmx2048m, -XX:+HeapDumpOnOutOfMemoryError, -XX:-OmitStackTraceInFastThrow, -XX:+IgnoreUnrecognizedVMOptions, -ea, -Dsun.io.useCanonCaches=false, -Dsun.java2d.metal=true, -Djbr.catch.SIGABRT=true, -Djdk.http.auth.tunneling.disabledSchemes="", -Djdk.attach.allowAttachSelf=true, -Djdk.module.illegalAccess.silent=true, -Dkotlinx.coroutines.debug=off, -XX:CICompilerCount=2, -XX:ReservedCodeCacheSize=512m, -XX:CompileCommand=exclude,com/intellij/openapi/vfs/impl/FilePartNodeRoot,trieDescend, -XX:SoftRefLRUPolicyMSPerMB=50, -Dide.show.tips.on.startup.default.value=false, -Dapple.awt.application.appearance=system, -Xmx4096m, -Djb.vmOptionsFile=/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1/idea.vmoptions, -Djava.system.class.loader=com.intellij.util.lang.PathClassLoader, -Didea.vendor.name=JetBrains, -Didea.paths.selector=IdeaIC2024.1, -Djna.boot.library.path=/Applications/IntelliJ IDEA CE.app/Contents/lib/jna/aarch64, -Dpty4j.preferred.native.folder=/Applications/IntelliJ IDEA CE.app/Contents/lib/pty4j, -Djna.nosys=true, -Djna.noclasspath=true, -Dintellij.platform.runtime.repository.path=/Applications/IntelliJ IDEA CE.app/Contents/modules/module-descriptors.jar, -Didea.platform.prefix=Idea, -Dsplash=true, -Daether.connector.resumeDownloads=false, --add-opens=java.base/java.io=ALL-UNNAMED, --add-opens=java.base/java.lang=ALL-UNNAMED, --add-opens=java.base/java.lang.ref=ALL-UNNAMED, --add-opens=java.base/java.lang.reflect=ALL-UNNAMED, --add-opens=java.base/java.net=ALL-UNNAMED, --add-opens=java.base/java.nio=ALL-UNNAMED, --add-opens=java.base/java.nio.charset=ALL-UNNAMED, --add-opens=java.base/java.text=ALL-UNNAMED, --add-opens=java.base/java.time=ALL-UNNAMED, --add-opens=java.base/java.util=ALL-UNNAMED, --add-opens=java.base/java.util.concurrent=ALL-UNNAMED, --add-opens=java.base/java.util.concurrent.atomic=ALL-UNNAMED, --add-opens=java.base/java.util.concurrent.locks=ALL-UNNAMED, --add-opens=java.base/jdk.internal.vm=ALL-UNNAMED, --add-opens=java.base/sun.nio.ch=ALL-UNNAMED, --add-opens=java.base/sun.nio.fs=ALL-UNNAMED, --add-opens=java.base/sun.security.ssl=ALL-UNNAMED, --add-opens=java.base/sun.security.util=ALL-UNNAMED, --add-opens=java.base/sun.net.dns=ALL-UNNAMED, --add-opens=java.desktop/com.apple.eawt=ALL-UNNAMED, --add-opens=java.desktop/com.apple.eawt.event=ALL-UNNAMED, --add-opens=java.desktop/com.apple.laf=ALL-UNNAMED, --add-opens=java.desktop/java.awt=ALL-UNNAMED, --add-opens=java.desktop/java.awt.dnd.peer=ALL-UNNAMED, --add-opens=java.desktop/java.awt.event=ALL-UNNAMED, --add-opens=java.desktop/java.awt.image=ALL-UNNAMED, --add-opens=java.desktop/java.awt.peer=ALL-UNNAMED, --add-opens=java.desktop/java.awt.font=ALL-UNNAMED, --add-opens=java.desktop/javax.swing=ALL-UNNAMED, --add-opens=java.desktop/javax.swing.plaf.basic=ALL-UNNAMED, --add-opens=java.desktop/javax.swing.text=ALL-UNNAMED, --add-opens=java.desktop/javax.swing.text.html=ALL-UNNAMED, --add-opens=java.desktop/sun.awt.datatransfer=ALL-UNNAMED, --add-opens=java.desktop/sun.awt.image=ALL-UNNAMED, --add-opens=java.desktop/sun.awt=ALL-UNNAMED, --add-opens=java.desktop/sun.font=ALL-UNNAMED, --add-opens=java.desktop/sun.java2d=ALL-UNNAMED, --add-opens=java.desktop/sun.lwawt=ALL-UNNAMED, --add-opens=java.desktop/sun.lwawt.macosx=ALL-UNNAMED, --add-opens=java.desktop/sun.swing=ALL-UNNAMED, --add-opens=java.desktop/com.sun.java.swing=ALL-UNNAMED, --add-opens=jdk.attach/sun.tools.attach=ALL-UNNAMED, --add-opens=jdk.compiler/com.sun.tools.javac.api=ALL-UNNAMED, --add-opens=jdk.internal.jvmstat/sun.jvmstat.monitor=ALL-UNNAMED, --add-opens=jdk.jdi/com.sun.tools.jdi=ALL-UNNAMED]
2024-06-22 21:52:17,007 [     52]   INFO - #c.i.p.i.b.AppStarter - args: 
2024-06-22 21:52:17,007 [     52]   INFO - #c.i.p.i.b.AppStarter - library path: /Users/blubber/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.
2024-06-22 21:52:17,007 [     52]   INFO - #c.i.p.i.b.AppStarter - boot library path: /Applications/IntelliJ IDEA CE.app/Contents/jbr/Contents/Home/lib
2024-06-22 21:52:17,009 [     54]   INFO - #c.i.i.p.PluginManager - Module intellij.sh.python is not enabled because dependency intellij.python.community.impl is not available
Module intellij.llmInstaller.pycharm.community is not enabled because dependency intellij.pycharm.community.ide.impl.promotion is not available
Module intellij.groovy/ant is not enabled because dependency AntSupport is not available
Module intellij.qodana.jvm.swagger is not enabled because dependency com.intellij.swagger is not available
Module intellij.qodana.python is not enabled because dependency intellij.python is not available
Module intellij.qodana.php is not enabled because dependency com.jetbrains.php is not available
Module intellij.qodana.js is not enabled because dependency JavaScript is not available
Module intellij.qodana.inspectionKts.js is not enabled because dependency JavaScript is not available
Module intellij.qodana.go is not enabled because dependency intellij.go.coverage is not available
Module intellij.cwm.plugin.elevation is not enabled because dependency intellij.execution.process.elevation is not available
Module intellij.packageChecker.php is not enabled because dependency com.jetbrains.php is not available
Module intellij.packageChecker.python is not enabled because dependency intellij.python.community.impl is not available
Module intellij.packageChecker.javascript is not enabled because dependency JavaScript is not available
Module intellij.packageChecker.go is not enabled because dependency org.jetbrains.plugins.go is not available
Module perl5.plugin.wsl is not enabled because dependency com.intellij.modules.ultimate is not available
Module perl5.plugin.profiler is not enabled because dependency com.intellij.modules.ultimate is not available
Module perl5.plugin.docker is not enabled because dependency org.jetbrains.plugins.remote-run is not available
2024-06-22 21:52:17,012 [     57]   INFO - #c.i.p.i.b.AppStarter - locale=en_US JNU=UTF-8 file.encoding=UTF-8
    idea.config.path=/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1
    idea.system.path=/Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1
    idea.plugins.path=/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1/plugins
    idea.log.path=/Users/blubber/Library/Logs/JetBrains/IdeaIC2024.1
2024-06-22 21:52:17,014 [     59]   INFO - #c.i.p.i.b.AppStarter - CPU cores: 12; ForkJoinPool.commonPool: java.util.concurrent.ForkJoinPool@254dda20[Running, parallelism = 11, size = 0, active = 0, running = 0, steals = 0, tasks = 0, submissions = 0]; factory: com.intellij.concurrency.IdeaForkJoinWorkerThreadFactory@57924c0d
2024-06-22 21:52:17,017 [     62]   INFO - #c.i.i.p.PluginManager - Loaded bundled plugins: IDEA CORE (241.17890.1), TextMate Bundles (241.17890.1), Images (241.17890.1), Copyright (241.17890.1), EditorConfig (241.17890.1), IDE Services / Provisioner API (241.17890.1), Machine Learning in Search Everywhere (241.17890.1), YAML (241.17890.1), JetBrains maven model api classes (241.17890.1), JetBrains Repository Search (241.17890.1), Maven server api classes (241.17890.1), Markdown (241.17890.1), Terminal (241.17890.1), Mercurial (241.17890.1), Properties (241.17890.1), Gradle (241.17890.1), NetBeans Keymap (241.17890.1), JetBrains Marketplace Licensing (241.17890.1), com.intellij.dev (241.17890.1), Remote Execution Agent (241.17890.1), Shell Script (241.17890.1), HTML Tools (241.17890.1), Visual Studio Keymap (241.17890.1), Machine Learning Code Completion (241.17890.1), Toml (241.17890.1), WebP Support (241.17890.1), Performance Testing (241.17890.1), Grazie Lite (241.17890.1), Eclipse Keymap (241.17890.1), Perforce Helix Core (241.17890.1), LLM Installer (241.17890.1), GitLab (241.17890.1), IDE Features Trainer (241.17890.1), Java (241.17890.1), com.intellij.tracing.ide (241.17890.1), Java Bytecode Decompiler (241.17890.1), Java Stream Debugger (241.17890.1), Task Management (241.17890.1), GitHub (241.17890.1), JUnit (241.17890.1), Eclipse Interoperability (241.17890.1), IntelliLang (241.17890.1), Groovy (241.17890.1), JavaFX (241.17890.1), Turbo Complete (241.17890.1), Kotlin (241.17890.1-IJ), Gradle DSL API (241.17890.1), Java Internationalization (241.17890.1), UI Designer (241.17890.1), Bytecode Viewer (241.17890.1), Maven (241.17890.1), TestNG (241.17890.1), Code Coverage for Java (241.17890.1), Gradle-Java (241.17890.1), Gradle-Java-Analysis (241.17890.1), Gradle-Maven (241.17890.1), Java IDE Customization (241.17890.1), Settings Sync (241.17890.1), Git (241.17890.1), Qodana (241.17890.1), Configuration Script (241.17890.1), Shared Indexes (241.17890.1), Code With Me (241.17890.1), Subversion (241.17890.1), Package Checker (241.17890.1), Gradle Dependency Updater Implementation (241.17890.1), Async Profiler for IDE Performance Testing (241.17890.1)
2024-06-22 21:52:17,017 [     62]   INFO - #c.i.i.p.PluginManager - Loaded custom plugins: Perl (2024.1)
2024-06-22 21:52:17,126 [    171]   INFO - c.i.p.i.IdeFingerprint - Calculated dependencies fingerprint in 6 ms (hash=1rxd8544m4f0x, buildTime=1717471500, appVersion=IC-241.17890.1)
2024-06-22 21:52:17,162 [    207]   INFO - #c.i.o.v.n.p.FSRecords - VFS health-check enabled: first after 600000 ms, and each following 43200000 ms, wrap in RA: true
2024-06-22 21:52:17,203 [    248]   INFO - #c.i.a.o.PathMacrosImpl - Loaded path macros: {MAVEN_REPOSITORY=/Users/blubber/.m2/repository}
2024-06-22 21:52:17,206 [    251]   INFO - #c.i.o.v.n.p.PersistentFSLoader - VFS uses 'fast' names enumerator (over mmapped file)
2024-06-22 21:52:17,206 [    251]   INFO - #c.i.o.v.n.p.PersistentFSLoader - VFS uses content storage over memory-mapped file, with compression algo: LZ4[ > 8000b ]
2024-06-22 21:52:17,207 [    252]   INFO - #c.i.o.v.n.p.PersistentFSLoader - VFS uses streamlined attributes storage (over mmapped file)
2024-06-22 21:52:17,226 [    271]   INFO - #c.i.o.u.r.RegistryManager - Registry values changed by user: ide.experimental.ui = true, ide.experimental.ui.inter.font = false, idea.plugins.compatible.build = 
2024-06-22 21:52:17,228 [    273]   INFO - #c.i.i.p.ExpiredPluginsState - Plugins to skip: []
2024-06-22 21:52:17,266 [    311]   INFO - #c.i.u.m.s.Menu - use new ScreenMenuBar implementation
2024-06-22 21:52:17,267 [    312]   INFO - #c.i.o.v.n.p.PersistentFSLoader - VFS: impl (expected) version=846397, 77995 file records, 3147 content blobs
2024-06-22 21:52:17,289 [    334]   INFO - #c.i.o.v.n.p.FSRecordsImpl - VFS initialized: 82 ms, 0 failed attempts, 0 error(s) were recovered
2024-06-22 21:52:17,318 [    363]   INFO - #c.i.o.v.n.p.FSRecordsImpl - VFS scanned: file-by-name index was populated
2024-06-22 21:52:17,351 [    396]   INFO - #o.j.i.BuiltInServerManager - built-in server started, port 63342
2024-06-22 21:52:17,396 [    441]   INFO - #c.i.u.n.s.CertificateManager - Default SSL context initialized
2024-06-22 21:52:17,429 [    474]   INFO - #c.i.o.v.i.l.NativeFileWatcherImpl - Starting file watcher: /Applications/IntelliJ IDEA CE.app/Contents/bin/fsnotifier
2024-06-22 21:52:17,438 [    483]   INFO - #c.i.o.v.i.l.NativeFileWatcherImpl - Native file watcher is operational.
2024-06-22 21:52:17,454 [    499]   INFO - #c.i.i.s.p.i.SharedIndexMainZipStorage - Shared Indexes Storage is opened and empty
2024-06-22 21:52:17,456 [    501]   WARN - #c.i.i.s.p.i.BundledSharedIndexProvider - Bundled shared index is not found at: /Applications/IntelliJ IDEA CE.app/Contents/jdk-shared-indexes
2024-06-22 21:52:17,535 [    580]   INFO - #c.i.u.i.FileBasedIndexImpl - Indices to be built:FilenameIndex(v = 258)
2024-06-22 21:52:17,536 [    581]   INFO - #c.i.u.i.FileBasedIndexImpl - Using nice flusher for indexes
2024-06-22 21:52:17,540 [    585]   INFO - #c.i.u.i.IndexDataInitializer - Index data initialization done: 115 ms. Initialized indexes: [FilenameIndex, filetypes, RelaxSymbolIndex, XmlTagNames, XmlNamespaces, DomFileIndex, Trigram.Index, html5.custom.attributes.index, TodoIndex, java.auto.module.name, FrameworkDetectionIndex, xmlProperties, editorconfig.index.name, fileIncludes, SchemaTypeInheritance, json.file.root.values, IdIndex, java.source.module.name, java.null.method.argument, yaml.keys.name, HtmlTagIdIndex, java.fun.expression, java.binary.plus.expression, JavaFxControllerClassIndex, javafx.custom.component, javafx.id.name, org.jetbrains.kotlin.idea.vfilefinder.KotlinPartialPackageNamesIndex, bytecodeAnalysis, org.jetbrains.kotlin.idea.versions.KotlinJvmMetadataVersionIndex, org.jetbrains.kotlin.idea.versions.KotlinJsMetadataVersionIndex, org.jetbrains.kotlin.idea.vfilefinder.KotlinClassFileIndex, org.jetbrains.kotlin.idea.vfilefinder.KotlinJavaScriptMetaFileIndex, org.jetbrains.kotlin.idea.vfilefinder.KotlinMetadataFileIndex, org.jetbrains.kotlin.idea.vfilefinder.KotlinMetadataFilePackageIndex, org.jetbrains.kotlin.idea.vfilefinder.KotlinModuleMappingIndex, KotlinPackageSourcesMemberNamesIndex, org.jetbrains.kotlin.idea.vfilefinder.KotlinStdlibIndex, org.jetbrains.kotlin.idea.vfilefinder.KotlinShortClassNameFileIndex, KotlinTopLevelClassLikeDeclarationByPackageShortNameIndex, org.jetbrains.kotlin.idea.vfilefinder.KotlinBuiltInsMetadataIndex, KotlinBinaryRootToPackageIndex, org.jetbrains.kotlin.idea.vfilefinder.KotlinJvmModuleAnnotationsIndex, org.jetbrains.kotlin.idea.vfilefinder.KlibMetaFileIndex, KotlinTopLevelCallableByPackageShortNameIndex, Stubs, com.intellij.uiDesigner.FormClassIndex].
2024-06-22 21:52:17,593 [    638]   INFO - #c.i.i.ConversionServiceImpl - conversion will be performed because at least /Users/blubber/dev/afroc/.idea/perl5shared.xml is changed (oldLastModified=-1, newLastModified=1718997625)
2024-06-22 21:52:17,616 [    661]   INFO - #c.i.j.JdkEx - === TabbingMode: available ===
2024-06-22 21:52:17,653 [    698]   INFO - #c.i.j.JdkEx - === TabbingMode: on ===
2024-06-22 21:52:17,665 [    710]   INFO - #c.i.u.i.IndexDataInitializer - Index data initialization done: 124 ms. Initialized stub indexes: {perl.sub.polynamed, perl.package.definition, org.jetbrains.kotlin.idea.stubindex.KotlinFullClassNameIndex, org.jetbrains.kotlin.idea.stubindex.KotlinInnerTypeAliasClassIdIndex, perl.glob, gr.annot.method.name, perl.global.scalar, perl.package.light.descendants, gr.script.fqn.s, org.jetbrains.kotlin.idea.stubindex.KotlinMultifileClassPartIndex, perl.package.light.direct, perl.global.hash.in.namespace, perl.sub.declaration.reverse, org.jetbrains.kotlin.idea.stubindex.KotlinSubclassObjectNameIndex, org.jetbrains.kotlin.idea.stubindex.KotlinFilePartClassIndex, kotlin.primeIndexKey, dom.namespaceKey, jvm.static.member.type, jvm.static.member.name, org.jetbrains.kotlin.idea.stubindex.KotlinExactPackagesIndex, KotlinOverridableInternalMembersShortNameIndex, perl.glob.in.namespace, KotlinFileFacadeClassByPackageIndex, org.jetbrains.kotlin.idea.stubindex.KotlinFileFacadeShortNameIndex, perl.package.descendants, perl.sub.polynamed.reverse, perl.callable.names.light, java.field.name, org.jetbrains.kotlin.idea.stubindex.KotlinFunctionShortNameIndex, org.jetbrains.kotlin.idea.stubindex.KotlinPropertyShortNameIndex, java.module.name, perl.sub.declaration, gr.annot.members, gr.anonymous.class, gr.script.class, KotlinTopLevelPropertyByPackageIndex, properties.index, org.jetbrains.kotlin.idea.stubindex.KotlinTypeAliasShortNameIndex, java.method.parameter.types, gr.class.super, java.class.fqn, org.jetbrains.kotlin.idea.stubindex.KotlinTopLevelClassByPackageIndex, perl.sub.definition.reverse, markdown.header, org.jetbrains.kotlin.idea.stubindex.KotlinFileFacadeFqNameIndex, gr.method.name, java.class.shortname, java.anonymous.baseref, KotlinTopLevelTypeAliasByPackageIndex, org.jetbrains.kotlin.idea.stubindex.KotlinTopLevelPropertyFqnNameIndex, org.jetbrains.kotlin.idea.stubindex.KotlinAnnotationsIndex, KotlinProbablyContractedFunctionShortNameIndex, org.jetbrains.kotlin.idea.stubindex.KotlinTopLevelTypeAliasFqNameIndex, perl.global.scalar.in.namespace, perl.sub.definition, KotlinProbablyNothingPropertyShortNameIndex, dom.elementClass, perl.callable.names, java.annotations, KotlinTopLevelExtensionsByReceiverTypeIndex, org.jetbrains.kotlin.idea.stubindex.KotlinJvmNameAnnotationIndex, KotlinTypeAliasByExpansionShortNameIndex, org.jetbrains.kotlin.idea.stubindex.KotlinSuperClassIndex, markdown.header.anchor, perl.global.array, perl.global.hash, perl.use.statements, KotlinTopLevelFunctionByPackageIndex, perl.global.array.in.namespace, gr.class.fqn.s, org.jetbrains.kotlin.idea.stubindex.KotlinScriptFqnIndex, java.class.extlist, KotlinProbablyNothingFunctionShortNameIndex, org.jetbrains.kotlin.idea.stubindex.KotlinTopLevelFunctionFqnNameIndex, org.jetbrains.kotlin.idea.stubindex.KotlinClassShortNameIndex, gr.field.name, java.method.name, KotlinExtensionsInObjectsByReceiverTypeIndex, java.unnamed.class}.
2024-06-22 21:52:17,690 [    735]   INFO - #c.i.w.i.i.WorkspaceModelImpl - Load workspace model from cache in 61 ms
2024-06-22 21:52:17,743 [    788]   INFO - #c.i.w.i.i.WorkspaceModelImpl - Project model updated silently to version 1 in 2 ms: Add module mapping
2024-06-22 21:52:17,789 [    834]   INFO - #c.i.w.i.i.WorkspaceModelImpl - Project model updated silently to version 2 in 0 ms: Add project library mapping
2024-06-22 21:52:17,801 [    846]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Loading global entities com.intellij.platform.workspace.jps.entities.SdkEntity from files
2024-06-22 21:52:17,802 [    847]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Loading global entities com.intellij.platform.workspace.jps.entities.LibraryEntity from files
2024-06-22 21:52:17,851 [    896]   INFO - #c.i.w.i.i.EntitiesOrphanageImpl - Update orphanage. 0 modules added
2024-06-22 21:52:17,855 [    900]   INFO - #c.i.w.i.i.WorkspaceModelImpl - Project model updated to version 3 in 17 ms: Sync global entities with project: afroc
2024-06-22 21:52:17,914 [    959]   INFO - PerformancePlugin - Performance Plugin is in silent mode
2024-06-22 21:52:17,925 [    970]   INFO - #c.i.r.OsRegistryConfigProvider - Looking for 'enabled' value in [/Library/Application Support/JetBrains/portForwarding/enabled, /Library/Application Support/JetBrains/portForwarding/config.json, /Users/blubber/Library/Application Support/JetBrains/portForwarding/enabled, /Users/blubber/Library/Application Support/JetBrains/portForwarding/config.json]
2024-06-22 21:52:17,925 [    970]   INFO - #c.i.r.OsRegistryConfigProvider - OS provided value for 'enabled' is not found
2024-06-22 21:52:17,938 [    983]   INFO - #c.i.p.c.ProjectCodeStyleSettingsManager - Initialized from default code style settings.
2024-06-22 21:52:17,972 [   1017]   INFO - #c.i.u.i.ManagedPersistentCache - created persistent map persistent-code-vision-afroc-146b0edd with size 0
2024-06-22 21:52:17,972 [   1017]   INFO - #c.i.u.i.ManagedPersistentCache - created persistent map persistent-markup-afroc-146b0edd with size 4
2024-06-22 21:52:17,972 [   1017]   INFO - #c.i.u.i.ManagedPersistentCache - created persistent map persistent-folding-afroc-146b0edd with size 6
2024-06-22 21:52:17,977 [   1022]   INFO - #c.i.u.i.ManagedPersistentCache - created persistent map persistent-declarative-hints-afroc-146b0edd with size 0
2024-06-22 21:52:17,977 [   1022]   INFO - #c.i.u.i.ManagedPersistentCache - created persistent map persistent-parameter-hints-afroc-146b0edd with size 0
2024-06-22 21:52:18,005 [   1050]   WARN - #c.i.s.ComponentManagerImpl - com.perl5.lang.perl.lexer.PerlBaseLexer <clinit> requests com.perl5.lang.perl.fileTypes.PerlFileTypeService instance. Class initialization must not depend on services. Consider using instance of the service on-demand instead.
2024-06-22 21:52:18,016 [   1061]   INFO - #c.j.r.f.FollowMeManager - Register new user (name: 'blubber', client id: Host)
2024-06-22 21:52:18,056 [   1101]   WARN - #c.i.u.x.Binding - No accessors for com.perl5.lang.perl.idea.sdk.host.local.PerlLocalHostData. This means that state class cannot be serialized properly. Please see https://jb.gg/ij-psoc
2024-06-22 21:52:18,064 [   1109]   INFO - #c.i.u.EnvironmentUtil - shell environment loaded (34 vars)
2024-06-22 21:52:18,065 [   1110]   WARN - #c.i.u.x.Binding - No accessors for com.perl5.lang.perl.idea.sdk.versionManager.system.PerlSystemData. This means that state class cannot be serialized properly. Please see https://jb.gg/ij-psoc
2024-06-22 21:52:18,069 [   1114]   WARN - #c.i.u.x.Binding - No accessors for com.perl5.lang.perl.idea.sdk.implementation.porters.PerlPortersData. This means that state class cannot be serialized properly. Please see https://jb.gg/ij-psoc
2024-06-22 21:52:18,076 [   1121]   INFO - #c.i.u.EnvironmentUtil - LC_CTYPE=en_US.UTF-8
2024-06-22 21:52:18,165 [   1210]   INFO - #c.i.o.a.i.NonBlockingReadActionImpl - OTel monitoring for NonBlockingReadAction is enabled
2024-06-22 21:52:18,258 [   1303]   INFO - #c.i.o.p.MergingQueueGuiExecutor - Running task: (dumb mode task) com.intellij.openapi.project.InitialDumbTaskRequiredForSmartMode@786666b2
2024-06-22 21:52:18,264 [   1309]   INFO - #c.i.o.p.DumbServiceMergingTaskQueue - Initializing DumbServiceMergingTaskQueue...
2024-06-22 21:52:18,267 [   1312]   INFO - #c.i.o.p.DumbServiceMergingTaskQueue - Running initialization condition: com.intellij.indexing.shared.download.SharedIndexDownloadedCondition@335bdc95
2024-06-22 21:52:18,268 [   1313]   INFO - #c.i.o.p.DumbServiceMergingTaskQueue - Finished: com.intellij.indexing.shared.download.SharedIndexDownloadedCondition@335bdc95
2024-06-22 21:52:18,282 [   1327]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Running task required for smart mode: com.intellij.indexing.shared.platform.impl.OnDiskSharedIndexChunkLocator@2d8da24f
2024-06-22 21:52:18,286 [   1331]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Finished task required for smart mode: com.intellij.indexing.shared.platform.impl.OnDiskSharedIndexChunkLocator@2d8da24f
2024-06-22 21:52:18,287 [   1332]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Running task required for smart mode: com.intellij.util.indexing.ProjectFileBasedIndexStartupActivity@69cfc6d7
2024-06-22 21:52:18,335 [   1380]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Finished task required for smart mode: com.intellij.util.indexing.ProjectFileBasedIndexStartupActivity@69cfc6d7
2024-06-22 21:52:18,337 [   1382]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Running task required for smart mode: com.intellij.util.indexing.FileBasedIndexInfrastructureExtensionStartup@5f4b4514
2024-06-22 21:52:18,338 [   1383]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Finished task required for smart mode: com.intellij.util.indexing.FileBasedIndexInfrastructureExtensionStartup@5f4b4514
2024-06-22 21:52:18,340 [   1385]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Running task required for smart mode: com.intellij.externalDependencies.impl.CheckRequiredPluginsActivity@4778025
2024-06-22 21:52:18,347 [   1392]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Finished task required for smart mode: com.intellij.externalDependencies.impl.CheckRequiredPluginsActivity@4778025
2024-06-22 21:52:18,349 [   1394]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Running task required for smart mode: com.intellij.util.indexing.DumbModeWhileScanningSubscriber@2cdf3650
2024-06-22 21:52:18,351 [   1396]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Finished task required for smart mode: com.intellij.util.indexing.DumbModeWhileScanningSubscriber@2cdf3650
2024-06-22 21:52:18,353 [   1398]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Running task required for smart mode: com.intellij.ide.projectWizard.generators.SdkPreIndexingRequiredForSmartModeActivity@4f7cb832
2024-06-22 21:52:18,354 [   1399]   INFO - #c.i.o.p.InitialDumbTaskRequiredForSmartMode - Finished task required for smart mode: com.intellij.ide.projectWizard.generators.SdkPreIndexingRequiredForSmartModeActivity@4f7cb832
2024-06-22 21:52:18,354 [   1399]   INFO - #c.i.o.p.MergingQueueGuiExecutor - Task finished: (dumb mode task) com.intellij.openapi.project.InitialDumbTaskRequiredForSmartMode@786666b2
2024-06-22 21:52:18,519 [   1564]   INFO - #c.i.o.a.i.ActionUpdater - 340 ms to grab EDT for ToolWindowHeader$2#children@ToolwindowTitle (com.intellij.toolWindow.ToolWindowHeader$2)
2024-06-22 21:52:18,655 [   1700]   INFO - #c.i.o.p.MergingQueueGuiExecutor - Running task: (dumb mode task) com.intellij.util.indexing.UnindexedFilesScanner$2@5b09061c
2024-06-22 21:52:18,656 [   1701]   INFO - #c.i.o.p.MergingQueueGuiExecutor - Task finished: (dumb mode task) com.intellij.util.indexing.UnindexedFilesScanner$2@5b09061c
2024-06-22 21:52:18,656 [   1701]   INFO - #c.i.o.p.MergingQueueGuiExecutor - Running task: UnindexedFilesScanner[afroc]
2024-06-22 21:52:18,661 [   1706]   INFO - #c.i.u.i.UnindexedFilesScanner - Started scanning for indexing of afroc. Reason: On project open
2024-06-22 21:52:18,669 [   1714]   INFO - #c.i.u.i.UnindexedFilesScanner - Performing delayed pushing properties tasks for afroc took 4ms; general responsiveness: ok; EDT responsiveness: ok
2024-06-22 21:52:18,706 [   1751]   INFO - #c.i.o.p.DumbServiceImpl - exit dumb mode [afroc]
2024-06-22 21:52:18,706 [   1751]   INFO - #c.i.u.i.UnindexedFilesScanner - Scanning of afroc uses 11 scanning threads
2024-06-22 21:52:19,045 [   2090]   INFO - #c.i.o.u.i.UpdateCheckerService - channel: release
2024-06-22 21:52:19,047 [   2092]   INFO - #c.i.u.m.MergeAllWindowsAction - === FullScreenTabSupport: frames: 1 ===
2024-06-22 21:52:19,081 [   2126]   INFO - #c.i.u.m.t.TouchbarSupport - touchbar disabled: touchbar-server isn't running
2024-06-22 21:52:19,095 [   2140]   INFO - #c.i.u.i.UnindexedFilesScanner - Scanning completed for afroc. Number of scanned files: 24295; number of files for indexing: 0 took 425ms; general responsiveness: ok; EDT responsiveness: ok
2024-06-22 21:52:19,098 [   2143]   INFO - #c.i.u.i.PerProjectIndexingQueue - Finished for afroc. No files to index with loading content.
2024-06-22 21:52:19,098 [   2143]   INFO - #c.i.o.p.InitialVfsRefreshService - 146b0edd: marking roots for initial VFS refresh
2024-06-22 21:52:19,101 [   2146]   INFO - #c.i.o.v.i.p.NewMappings - VCS Root: [Git] - [<Project>]
2024-06-22 21:52:19,102 [   2147]   INFO - #c.i.o.p.MergingQueueGuiExecutor - Task finished: UnindexedFilesScanner[afroc]
2024-06-22 21:52:19,104 [   2149]   INFO - #c.i.o.p.InitialVfsRefreshService - 146b0edd: starting initial VFS refresh of 1 roots
2024-06-22 21:52:19,113 [   2158]   INFO - #c.i.o.e.s.p.m.ExternalProjectsDataStorage - Load external projects data in 4 millis (read time: 1)
2024-06-22 21:52:19,137 [   2182]   INFO - #c.i.o.p.SmartModeScheduler - Post-startup activity executed. Current mode: 4
2024-06-22 21:52:19,145 [   2190]   INFO - #c.i.d.PerformanceWatcherImpl - Post-startup activities under progress took 61ms; general responsiveness: ok; EDT responsiveness: ok
2024-06-22 21:52:19,145 [   2190]   INFO - #c.i.i.s.IdeStartupScripts - 0 startup script(s) found
2024-06-22 21:52:19,154 [   2199]   INFO - #git4idea.commands.GitHandler - [.] git version
2024-06-22 21:52:19,169 [   2214]   INFO - #c.i.o.v.i.p.NewMappings - Mapped Roots: 1
2024-06-22 21:52:19,169 [   2214]   INFO - #c.i.o.v.i.p.NewMappings - Detected mapped Root: [Git] - [/Users/blubber/dev/afroc]
2024-06-22 21:52:19,180 [   2225]   INFO - #git4idea.commands.GitHandler - git version 2.39.3 (Apple Git-146)
2024-06-22 21:52:19,185 [   2230]   INFO - #git4idea.config.GitExecutableManager - Git version for /usr/bin/git: 2.39.3.0 (UNIX)
2024-06-22 21:52:19,590 [   2635]   INFO - #c.i.o.p.InitialVfsRefreshService - 146b0edd: initial VFS refresh finished in 481 ms
2024-06-22 21:52:19,600 [   2645]   INFO - #c.i.o.v.n.p.d.e.DurableEnumeratorFactory - [enumerator.mmapped]: .valueHashToId (in memory) was filled (22 records)
2024-06-22 21:52:20,603 [   3648]   INFO - #c.i.v.l.d.i.IndexDiagnosticRunner - Index diagnostic for 28 commits in [file:///Users/blubber/dev/afroc] is completed
2024-06-22 21:52:24,157 [   7202]   INFO - #o.j.j.b.i.CompilerReferenceIndex - backward reference index version doesn't exist
2024-06-22 21:52:24,160 [   7205]   INFO - #c.i.c.b.IsUpToDateCheckStartupActivity - suitable consumer is not found
2024-06-22 21:52:24,176 [   7221]   INFO - #c.i.w.i.i.GlobalWorkspaceModel - Sync global entities with mutable entity storage
2024-06-22 21:52:24,177 [   7222]   INFO - #c.i.w.i.i.j.s.JpsProjectModelSynchronizer - Attempt 1: Apply JPS storage (iml files)

IntelliJ IDEA 2024.1.3 (Community Edition)
Build #IC-241.17890.1, built on June 4, 2024
Runtime version: 17.0.11+1-b1207.24 aarch64
VM: OpenJDK 64-Bit Server VM by JetBrains s.r.o.
macOS 14.5
GC: G1 Young Generation, G1 Old Generation
Memory: 4096M
Cores: 12
Metal Rendering is ON
Registry:
ide.experimental.ui=true
Non-Bundled Plugins:
com.perl5 (2024.1)
Kotlin: 241.17890.1-IJ
OS: OSX 14.5
Hardware: Macbook M3 Pro
Perl: 5.38.2
@hurricup
Copy link
Collaborator

To load coverage IDE runs external process:

/opt/homebrew/Cellar/perl/5.38.2_1/bin/perl -I/Users/blubber/dev/afroc/SHARED//SHARED -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module -I/Users/blubber/dev/afroc/SHARED//SHARED/lib/execution_module/t "-I/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1/plugins/plugin/perl/lib" /Users/blubber/perl5/bin/cover --silent --nosummary -report camelcade /Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/coverage/afroc_S_Tests_from__GetDiskInfo_t_

You may try to run one from the command line. Basically it should give a machine readable coverage information.
Also, if you have an application crash, it should be reported to the JetBrains, because it indicates some JBR issue, plugin can't do that.

@OlegLoewen
Copy link
Author

The listed command works just fine in terminal.
Looks like the issue is Apple ARM chip related. I see similar issues for other applications
Similar warnings:

oshi.util.platform.mac.SysctlUtil - Failed sysctl call: hw.cpufrequency, Error code: 2
oshi.util.platform.mac.SysctlUtil - Failed sysctl call: hw.cpufrequency_max, Error code: 2

[MacOS] psutil.cpu_freq() broken on Apple M1 · Issue #1892 · giampaolo/psutil

@hurricup
Copy link
Collaborator

Not sure this is the cause. I will try to reproduce this on my side, but not sure when I'll be able to.
Or you may try to run the plugin from sources and debug on your side if you are familiar with Java

@OlegLoewen
Copy link
Author

yes, I have some Java experience. Do you have a small description how to debug the plugin?

@hurricup
Copy link
Collaborator

  • Clone the repo.
  • Open it in IDEA
  • wait till project is imported
  • Run/Debug Run Plugin run configuration. It just runs the second IDE with plugin from the sources.
  • There you can reproduce the thing you have
  • Coverage data loading here com.perl5.lang.perl.coverage.PerlCoverageRunner#doLoadCoverageData. Basically it runs the command ^^ and desearilizes json with Gson libarary. Btw, worth trying to:
    • create a file with output from terminal
    • make a simple script deserializing that data. May be there is some Gson issue.

@OlegLoewen
Copy link
Author

it's strange. I was able to follow your instructions. I opened same project and ran the same test coverage, but I wasn't able to reproduce it. While debugging, the coverage provides fast results as expected.
Not sure how to resolve my issue. All of my team members have the same issue as me. Any advice or idea?

@hurricup
Copy link
Collaborator

Interesting. Yes, have a few:

  • try to run plugin from sources (not debug) and see if problem persists. Debugging itself may cause/fix some concurrency-related issues.
  • you are running 2024.1.3 but plugin from sources runs 2024.1, something could broke in IDE in 4.1.3, worth trying to install 4.1 and check
  • plugin set. Some plugins may cause unpredictable side effects. worth trying same plugins set. up while running from sources or in your production IDE.

@OlegLoewen
Copy link
Author

OlegLoewen commented Jun 25, 2024 •
edited
Loading

  • Running the plugin from sources (not debug) hasn't reproduced the issue.
  • Using Intellij 2024.1 hasn't resolved the issue
  • I removed all plugins but perl, that also didn't help

That's the output of diagnostic logs. As you see, there is a big time gap after PerlCommandLine - host = local; vm = system; pty = false; charset: UTF-8

2024-06-25 10:57:17,503 [1010293]   WARN - oshi.util.platform.mac.SysctlUtil - Failed sysctl call: hw.cpufrequency, Error code: 2
2024-06-25 10:57:18,512 [1011302]   WARN - oshi.util.platform.mac.SysctlUtil - Failed sysctl call: hw.cpufrequency_max, Error code: 2
2024-06-25 10:57:19,016 [1011806] SEVERE - oshi.software.os.mac.MacNetworkParams - Failed getaddrinfo(): nodename nor servname provided, or not known
2024-06-25 10:57:19,580 [1012370]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.SdkEntity to files
2024-06-25 10:57:19,580 [1012370]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.LibraryEntity to files
2024-06-25 10:59:06,403 [1119193]   WARN - #c.i.o.o.e.ConfigurableExtensionPointUtil - ignore deprecated groupId: language for id: preferences.language.Kotlin.scripting
2024-06-25 10:59:25,672 [1138462]   INFO - #com.perl5.lang.perl.coverage.PerlCoverageRunner - Loading coverage by: /opt/homebrew/Cellar/perl/5.38.2_1/bin/perl -I/Users/blubber/myapp/SHARED -I/Users/blubber/myapp/SHARED/lib/execution_module -I/Users/blubber/myapp/SHARED/lib/execution_module/t "-I/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1/plugins/plugin/perl/lib" /Users/blubber/perl5/bin/cover --silent --nosummary -report camelcade /Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/coverage/hostctrl_S_Tests_from__GetDiskInfo_t_
2024-06-25 10:59:25,673 [1138463]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine - Executing: /opt/homebrew/Cellar/perl/5.38.2_1/bin/perl -I/Users/blubber/myapp/SHARED -I/Users/blubber/myapp/SHARED/lib/execution_module -I/Users/blubber/myapp/SHARED/lib/execution_module/t "-I/Users/blubber/Library/Application Support/JetBrains/IdeaIC2024.1/plugins/plugin/perl/lib" /Users/blubber/perl5/bin/cover --silent --nosummary -report camelcade /Users/blubber/Library/Caches/JetBrains/IdeaIC2024.1/coverage/hostctrl_S_Tests_from__GetDiskInfo_t_
2024-06-25 10:59:25,673 [1138463]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   environment: {} (+CONSOLE)
2024-06-25 10:59:25,673 [1138463]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   working dir: null
2024-06-25 10:59:25,673 [1138463]   INFO - #com.perl5.lang.perl.idea.execution.PerlCommandLine -   host = local; vm = system; pty = false; charset: UTF-8
2024-06-25 11:03:17,723 [1370513]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.SdkEntity to files
2024-06-25 11:03:17,723 [1370513]   INFO - #c.i.w.i.i.j.s.JpsGlobalModelSynchronizerImpl - Saving global entities com.intellij.platform.workspace.jps.entities.LibraryEntity to files
2024-06-25 11:03:17,731 [1370521]   INFO - #c.i.a.o.PathMacrosImpl - Saved path macros: {MAVEN_REPOSITORY=/Users/blubber/.m2/repository}

@hurricup
Copy link
Collaborator

Hm. total mystery for now. you could send me your zipped logs dir to the email hurricup in gmail and i'll look into them.

@OlegLoewen
Copy link
Author

maybe before that:
How can I build the plugin locally and install it via local plugin file to test, whether this will work?

@hurricup
Copy link
Collaborator

hurricup commented Jul 2, 2024

Use buildPlugin run configuration. It should create a zip files in the build/...something/ dir

@hurricup
Copy link
Collaborator

Any updates on this? Did you have a chance to check with 2024.2?

@OlegLoewen
Copy link
Author

Unfortunately, the issue is still there. Not sure, how I provide additional information to resolve this.

@hurricup
Copy link
Collaborator

we may try recording a performance snapshot like described here https://intellij-support.jetbrains.com/hc/en-us/articles/207241235-Reporting-performance-problems
may be i'll find something in the recording

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@hurricup @OlegLoewen