JsSecuritySensorV2 Stalls

Previosuly we were able to skip this by -Dsonar.jasmin.internal.disabled=true or via UI , now UI option is not available and Dsonar.jasmin.internal.disabled=true also seems not working , but sonar scan is still stuck on
sonar.sarifReportPaths:
17:57:06.071 DEBUG ‘JavaArchitectureSensor’ skipped because there is no related file in current project
17:57:06.072 DEBUG ‘TsArchitectureSensor’ skipped because there is no related file in current project
17:57:06.072 DEBUG ‘CSharpArchitectureSensor’ skipped because there is no related file in current project
17:57:06.073 DEBUG ‘PythonArchitectureSensor’ skipped because there is no related file in current project
17:57:06.074 DEBUG ‘Java CPD Block Indexer’ skipped because there is no related file in current project
17:57:06.074 DEBUG Sensors : JsSecuritySensorV2 → JsArchitectureSensor → Zero Coverage Sensor
17:57:06.075 INFO Sensor JsSecuritySensorV2 [jasmin]
17:57:06.119 DEBUG JsSecuritySensorV2 is enabled
17:57:06.120 DEBUG Enabled JS/TS taint analysis rules: S2076,S2083,S2631,S3649,S5131,S5144,S5146,S5147,S5334,S5696,S5883,S6096,S6105,S6287,S6350,S7044
17:57:06.122 INFO 3 file(s) will be analysed by SonarJasmin.
17:57:09.797 DEBUG Starting analysis of 3 files
17:57:09.800 DEBUG Analyzing /builds/aaaaa/abc/aze/abc/product-core/qe/ae-test-service/src/app.js (1/3)

@ThomasVThomas Just to confirm – are you using SonarQube Cloud?

Yes we are on sonarqube cloud , this particular js file around 1k loc

Hello, thanks for reaching out.

As a first quick check: can you check earlier in the logs the memory available during the analysis?

Scanner max available memory:

JVM max available memory:

Even though you have a small project, the analysis requires a decent amount of memory to perform the initialization. Have too little memory available have shown to slow down a lot this part of the analysis. Can you try to increase it?

xms was set to 2g and xmx was set to 8g

@ThomasVThomas Can you check for these exact log lines and report back?

05:28:48.351 DEBUG SONAR_SCANNER_OPTS=-Xmx8g -Xms2g

05:28:48.359 DEBUG Scanner max available memory: 8 GB

05:28:54.465 INFO Starting SonarScanner Engine…

05:28:54.468 INFO Java 17.0.11 Eclipse Adoptium (64-bit)

05:28:54.538 DEBUG JVM max available memory: 1 GB

Try setting this to SONAR_SCANNER_JAVA_OPTS instead.

@Colin do we any specific recommended value for JAVA_OPTS ?

tried with 2g for SONAR_SCANNER_JAVA_OPTS

11:54:10.004 INFO Starting SonarScanner Engine…

11:54:10.010 INFO Java 17.0.11 Eclipse Adoptium (64-bit)

11:54:10.075 DEBUG JVM max available memory: 2 GB

Still stuck the same point

Out of curiosity, could you try with 7GB, since the memory seems available anyway.

I don’t think we have a recommended memory, it should be adapted with the performance observed.

In any case, I agree that your project, containing only 3 files, should run smoothly without requiring more than this.

I have some questions to continue the investigation:

  • Is the project available somewhere by any chance? Could you share it privately?
  • Could you run the analysis with -Dsonar.jasmin.internal.enable.metrics=true and-Dsonar.jasmin.internal.enable.stacktracing=true, and share the logs? I will reach out to you privately in case. In addition, please enable debug logs.

In addition, here are a few additional question. Feel free to only answer the one that seems relevant:

  • Is it mostly JS or TS, frontend or backend code?
  • Does it contain any exceptionally huge files?
  • What module system does it use? `import`s? `require`s?
  • Does it contain any dynamic imports (e.g. `import` or `require` inside of control flow, such as `if`-`else`s)?
  • Does it attempt to modify or override anything in the built-in objects or functions (e.g. Object.prototype, Function.prototype, require)
  • Does it attempt to perform tricky reflection or instrumentation operations of some sort
  • Does it contain any tricky recursions?
  • Since the obfuscated path you provided starts with `/builds` - can you confirm that this is intentional, and that this directory contains the original _source_ code (not transpiled / bundled / minified / uglified code)?
  • It is just node js back end code alone no ts
  • only 1 sizeable file around 1k lines
  • it uses require(“express”)
  • no dynamic imports
  • no modification on built-in objects, or complex reflections or recursions
  • Path is so as the build happens from GitLab CI pipeline else wise path is normal

increased SONAR_SCANNER_JAVA_OPTS to 8g and SONAR_SCANNER_OPTS=-Xmx16g -Xms2g enabled strack tracing and metrics , observed below error

15:02:59.720 INFO  sonarjs/S1090                         |     0.044 |     0.0%
15:02:59.720 INFO  sonarjs/S2310                         |     0.044 |     0.0%
15:02:59.729 INFO  sonarjs/S6836                         |     0.043 |     0.0%
15:02:59.729 INFO  sonarjs/S3696                         |     0.043 |     0.0%
15:02:59.737 INFO  sonarjs/S6522                         |     0.042 |     0.0%
15:02:59.738 INFO  sonarjs/S6861                         |     0.042 |     0.0%
15:02:59.753 INFO  sonarjs/S3785                         |     0.042 |     0.0%
15:02:59.753 INFO  sonarjs/S6793                         |     0.042 |     0.0%
15:02:59.760 INFO  sonarjs/S6843                         |     0.041 |     0.0%
15:02:59.760 INFO  sonarjs/S5256                         |     0.040 |     0.0%
15:02:59.760 INFO  sonarjs/S6819                         |     0.039 |     0.0%
15:02:59.760 INFO  sonarjs/S888                          |     0.038 |     0.0%
15:02:59.761 INFO  sonarjs/S6486                         |     0.037 |     0.0%
15:02:59.762 INFO  sonarjs/S6823                         |     0.035 |     0.0%
15:02:59.762 INFO  sonarjs/S1479                         |     0.034 |     0.0%
15:02:59.762 INFO  sonarjs/S6825                         |     0.031 |     0.0%
15:02:59.778 INFO  sonarjs/S2990                         |     0.030 |     0.0%
15:02:59.838 INFO  sonarjs/S1533                         |     0.029 |     0.0%
15:02:59.855 INFO  sonarjs/S3735                         |     0.028 |     0.0%
15:02:59.917 INFO  sonarjs/S6841                         |     0.027 |     0.0%
15:02:59.918 INFO  sonarjs/S3358                         |     0.027 |     0.0%
15:02:59.925 INFO  sonarjs/S1321                         |     0.027 |     0.0%
15:02:59.926 INFO  sonarjs/S6846                         |     0.026 |     0.0%
15:02:59.926 INFO  sonarjs/S3984                         |     0.023 |     0.0%
15:02:59.928 INFO  sonarjs/S4524                         |     0.023 |     0.0%
15:02:59.928 INFO  sonarjs/S1119                         |     0.023 |     0.0%
15:02:59.929 INFO  sonarjs/S1439                         |     0.022 |     0.0%
15:02:59.935 INFO  sonarjs/S4634                         |     0.021 |     0.0%
15:02:59.956 INFO  sonarjs/S1264                         |     0.021 |     0.0%
15:02:59.967 INFO  sonarjs/S1301                         |     0.020 |     0.0%
15:02:59.967 INFO  sonarjs/S5257                         |     0.019 |     0.0%
15:02:59.967 DEBUG The worker thread exited with code 0
15:02:59.968 DEBUG Closing server
15:02:59.968 DEBUG WebSocket client disconnected:  with code 1006
15:02:59.969 DEBUG Closed WebSocket connection
15:02:59.970 DEBUG The bridge server shut down
15:02:59.974 INFO  ╔═══╤══════╤═══════════╤══════════╗
15:02:59.975 INFO  ║ # │ Rule │ Time (ms) │ Relative ║
15:02:59.975 INFO  ╚═══╧══════╧═══════════╧══════════╝
15:02:59.976 INFO
15:02:59.976 DEBUG WebSocket connection closed:  (code: 1006)
1 Like

While I agree 15:02:59.968 DEBUG WebSocket client disconnected: with code 1006 looks suspicious at first glance, this is reported under the debug flag, it seems to behave as expected.

I guess if you reached this point, it is a good sign that the analysis did not stall? Or did it, and we are missing more context around these logs?

it stalled there and got sonar stage got timeout after 1 h (which is the limit set)

it seems waiting in that step it got timeout after 1 h

09:25:24.232 INFO   Metrics:
AbstractArray.hasIntersection (timer)-duration-s;0
AbstractArray.hasIntersection (timer)-activations;279
AbstractArray.size (monitor)-max;26
AbstractArray.size (monitor)-current;2
AbstractArray.size (monitor)-updates;5433
AbstractMap.hasIntersection (timer)-duration-s;0
AbstractMap.hasIntersection (timer)-activations;6464
AbstractMap.size (monitor)-max;92
AbstractMap.size (monitor)-current;5
AbstractMap.size (monitor)-updates;39589
Address.size (monitor)-max;11
Address.size (monitor)-current;0
Address.size (monitor)-updates;226362
Closure.size (monitor)-max;3
Closure.size (monitor)-current;0
Closure.size (monitor)-updates;221633
EsTreeConverter.filesConverted (distinct)-distinct-values-count;2
EsTreeConverter.filesConverted (distinct)-updates;3
EsTreeConverter.treeConversion (timer)-duration-s;0
EsTreeConverter.treeConversion (timer)-activations;2
Heap.lookup-depth (monitor)-max;3
Heap.lookup-depth (monitor)-current;2
Heap.lookup-depth (monitor)-updates;8289
Heap.lookup-depth.limit-exceeded (counter);3
Heap.size (monitor)-max;4350
Heap.size (monitor)-current;4350
Heap.size (monitor)-updates;11579
LazyCache.size (monitor)-max;48
LazyCache.size (monitor)-current;48
LazyCache.size (monitor)-updates;95
PolarStr.MayBe.size (monitor)-max;192
PolarStr.MayBe.size (monitor)-current;0
PolarStr.MayBe.size (monitor)-updates;1662412
PolarStr.MayBe.size.limit-exceeded (counter);82
PolarStr.MustNotBe.size (monitor)-max;2
PolarStr.MustNotBe.size (monitor)-current;0
PolarStr.MustNotBe.size (monitor)-updates;12611
SimpleMetrics.generate_snapshot (timer)-duration-s;0
SimpleMetrics.generate_snapshot (timer)-activations;2
Stack.call-recursion-depth-stubs-code (monitor)-max;1
Stack.call-recursion-depth-stubs-code (monitor)-current;1
Stack.call-recursion-depth-stubs-code (monitor)-updates;1809
Stack.call-recursion-depth-user-code (monitor)-max;1
Stack.call-recursion-depth-user-code (monitor)-current;1
Stack.call-recursion-depth-user-code (monitor)-updates;135
Stack.frames (monitor)-max;35
Stack.frames (monitor)-current;15
Stack.frames (monitor)-updates;6673
TaintRuntime.run (timer)-duration-s;6
TaintRuntime.run (timer)-activations;1
bjslForC\[ollection\].join (timer)-duration-s;0
bjslForC\[ollection\].join (timer)-activations;6517
bjslForConstraint.join (timer)-duration-s;0
bjslForConstraint.join (timer)-activations;62430
bjslForFlow.join (timer)-duration-s;0
bjslForFlow.join (timer)-activations;62474
bjslForHeap.join (timer)-duration-s;0
bjslForHeap.join (timer)-activations;218
bjslForSet.join (timer)-duration-s;0
bjslForSet.join (timer)-activations;542985
bjslForStack.join (timer)-duration-s;0
bjslForStack.join (timer)-activations;218
blForB4.join (timer)-duration-s;0
blForB4.join (timer)-activations;62430
currentProgram (context);/builds/products/products/app1/applications/product-core/module-1/service/src/utils/validation.js
dlForIntegerInterval.join (timer)-duration-s;0
dlForIntegerInterval.join (timer)-activations;62491
dlForIntegerInterval.meet (timer)-duration-s;0
dlForIntegerInterval.meet (timer)-activations;855
handleArrayExpression (timer)-duration-s;0
handleArrayExpression (timer)-activations;46
handleArrowFunctionExpression (timer)-duration-s;0
handleArrowFunctionExpression (timer)-activations;283
handleAssignmentExpression (timer)-duration-s;4
handleAssignmentExpression (timer)-activations;1430
handleAwaitExpression (timer)-duration-s;0
handleAwaitExpression (timer)-activations;34
handleBinaryExpression (timer)-duration-s;1
handleBinaryExpression (timer)-activations;207
handleBlockStatement (timer)-duration-s;4
handleBlockStatement (timer)-activations;318
handleBoolean (timer)-duration-s;0
handleBoolean (timer)-activations;7
handleCallExpression (timer)-duration-s;4
handleCallExpression (timer)-activations;1470
handleConditionalExpression (timer)-duration-s;0
handleConditionalExpression (timer)-activations;4
handleExpressionStatement (timer)-duration-s;4
handleExpressionStatement (timer)-activations;2158
handleForInStatement (timer)-duration-s;2
handleForInStatement (timer)-activations;72
handleFunctionDeclaration (timer)-duration-s;0
handleFunctionDeclaration (timer)-activations;31
handleFunctionExpression (timer)-duration-s;1
handleFunctionExpression (timer)-activations;1207
handleIdentifier (timer)-duration-s;3
handleIdentifier (timer)-activations;4352
handleIfStatement (timer)-duration-s;2
handleIfStatement (timer)-activations;71
handleLogicalExpression (timer)-duration-s;0
handleLogicalExpression (timer)-activations;11
handleMemberExpression (timer)-duration-s;3
handleMemberExpression (timer)-activations;1128
handleNewExpression (timer)-duration-s;0
handleNewExpression (timer)-activations;116
handleNull (timer)-duration-s;0
handleNull (timer)-activations;3
handleNumber (timer)-duration-s;0
handleNumber (timer)-activations;62
handleObjectExpression (timer)-duration-s;1
handleObjectExpression (timer)-activations;240
handleReturnStatement (timer)-duration-s;4
handleReturnStatement (timer)-activations;409
handleString (timer)-duration-s;2
handleString (timer)-activations;815
handleTemplateLiteral (timer)-duration-s;0
handleTemplateLiteral (timer)-activations;78
handleThisExpr (timer)-duration-s;2
handleThisExpr (timer)-activations;1018
handleTryStatement (timer)-duration-s;1
handleTryStatement (timer)-activations;51
handleUnaryExpression (timer)-duration-s;0
handleUnaryExpression (timer)-activations;3
handleVariableDeclaration (timer)-duration-s;2
handleVariableDeclaration (timer)-activations;601
scopeAnalysis (timer)-duration-s;0
scopeAnalysis (timer)-activations;42
unsupported.object-expression.non-constant-key (counter);6
09:25:24.239 DEBUG     \[STACK:12\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:804:48
09:25:24.240 DEBUG       \[STACK:13\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:804:68
09:25:24.240 DEBUG         \[STACK:14\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:705:0
09:25:24.241 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:705:41
09:25:24.241 DEBUG             \[STACK:16\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:706:6
09:25:24.257 DEBUG               \[STACK:17\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:757:29
09:25:24.257 DEBUG                 \[STACK:18\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:794:2
09:25:24.257 DEBUG                   \[STACK:19\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:794:56
09:25:24.263 DEBUG                 \[STACK:18\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:794:56
09:25:24.263 DEBUG               \[STACK:17\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:794:2
09:25:24.263 DEBUG             \[STACK:16\] POP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:757:29
09:25:24.264 DEBUG               \[STACK:17\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:759:35
09:25:24.264 DEBUG                 \[STACK:18\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:794:2
09:25:24.265 DEBUG                   \[STACK:19\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:794:56
09:25:24.270 DEBUG                 \[STACK:18\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:794:56
09:25:24.271 DEBUG               \[STACK:17\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:794:2
09:25:24.271 DEBUG             \[STACK:16\] POP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:759:35
09:25:24.272 DEBUG               \[STACK:17\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:772:28
09:25:24.274 DEBUG             \[STACK:16\] POP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:772:28
09:25:24.295 DEBUG               \[STACK:19\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:782:29
09:25:24.295 DEBUG                 \[STACK:20\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:782:52
09:25:24.296 DEBUG                   \[STACK:21\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:783:17
09:25:24.297 DEBUG                 \[STACK:20\] POP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:783:17
09:25:24.297 DEBUG                   \[STACK:21\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:785:15
09:25:24.298 DEBUG                 \[STACK:20\] POP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:785:15
09:25:24.298 DEBUG               \[STACK:19\] POP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:782:52
09:25:24.298 DEBUG             \[STACK:18\] POP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:782:29
09:25:24.299 DEBUG           \[STACK:15\] POP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:706:6
09:25:24.303 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:705:41
09:25:24.303 DEBUG       \[STACK:13\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:705:0
09:25:24.319 DEBUG     \[STACK:12\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:804:68
09:25:24.319 DEBUG   \[STACK:11\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:804:48
09:25:24.348 DEBUG     \[STACK:12\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:808:47
09:25:24.348 DEBUG       \[STACK:13\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:808:67
09:25:24.348 DEBUG         \[STACK:14\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:809:6
09:25:24.349 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/utils/validation.js:1:0
09:25:24.351 DEBUG             \[STACK:16\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/utils/validation.js:1:46
09:25:24.355 DEBUG           \[STACK:15\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/utils/validation.js:1:46
09:25:24.355 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/utils/validation.js:1:0
09:25:24.358 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:813:19
09:25:24.360 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:813:19
09:25:24.372 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:835:44
09:25:24.374 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:835:44
09:25:24.459 DEBUG       \[STACK:13\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:809:6
09:25:24.459 DEBUG       \[STACK:13\] POP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:809:6
09:25:24.469 DEBUG     \[STACK:12\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:808:67
09:25:24.470 DEBUG   \[STACK:11\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:808:47
09:25:24.513 DEBUG     \[STACK:12\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:857:57
09:25:24.514 DEBUG       \[STACK:13\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:857:77
09:25:24.515 DEBUG         \[STACK:14\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:858:6
09:25:24.532 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:25:24.532 DEBUG             \[STACK:16\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:24.577 DEBUG           \[STACK:15\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:24.577 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:25:24.597 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:25:24.598 DEBUG             \[STACK:16\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:24.618 DEBUG           \[STACK:15\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:24.618 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:25:24.761 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:863:62
09:25:24.764 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:863:62
09:25:24.790 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:885:44
09:25:24.793 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:885:44
09:25:24.819 DEBUG       \[STACK:13\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:858:6
09:25:24.826 DEBUG       \[STACK:13\] POP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:858:6
09:25:24.838 DEBUG     \[STACK:12\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:857:77
09:25:24.839 DEBUG   \[STACK:11\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:857:57
09:25:24.909 DEBUG     \[STACK:12\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:910:45
09:25:24.909 DEBUG       \[STACK:13\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:910:65
09:25:24.910 DEBUG         \[STACK:14\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:911:6
09:25:24.939 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:25:24.940 DEBUG             \[STACK:16\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:24.951 DEBUG           \[STACK:15\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:24.951 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:25:24.962 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:25:24.963 DEBUG             \[STACK:16\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:24.975 DEBUG           \[STACK:15\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:24.976 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:25:25.188 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:25:25.189 DEBUG             \[STACK:16\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:25.202 DEBUG           \[STACK:15\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:25.202 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:25:29.356 DEBUG           \[STACK:15\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:25:29.358 INFO   Metrics:
AbstractArray.hasIntersection (timer)-duration-s;0
AbstractArray.hasIntersection (timer)-activations;336
AbstractArray.size (monitor)-max;26
AbstractArray.size (monitor)-current;1
AbstractArray.size (monitor)-updates;6097
AbstractMap.hasIntersection (timer)-duration-s;0
AbstractMap.hasIntersection (timer)-activations;7057
AbstractMap.size (monitor)-max;92
AbstractMap.size (monitor)-current;0
AbstractMap.size (monitor)-updates;43439
Address.size (monitor)-max;11
Address.size (monitor)-current;0
Address.size (monitor)-updates;251211
Closure.size (monitor)-max;3
Closure.size (monitor)-current;0
Closure.size (monitor)-updates;245541
EsTreeConverter.filesConverted (distinct)-distinct-values-count;2
EsTreeConverter.filesConverted (distinct)-updates;3
EsTreeConverter.treeConversion (timer)-duration-s;0
EsTreeConverter.treeConversion (timer)-activations;2
Heap.lookup-depth (monitor)-max;3
Heap.lookup-depth (monitor)-current;1
Heap.lookup-depth (monitor)-updates;9140
Heap.lookup-depth.limit-exceeded (counter);3
Heap.size (monitor)-max;4793
Heap.size (monitor)-current;4793
Heap.size (monitor)-updates;12776
LazyCache.size (monitor)-max;48
LazyCache.size (monitor)-current;48
LazyCache.size (monitor)-updates;95
PolarStr.MayBe.size (monitor)-max;192
PolarStr.MayBe.size (monitor)-current;0
PolarStr.MayBe.size (monitor)-updates;1823576
PolarStr.MayBe.size.limit-exceeded (counter);82
PolarStr.MustNotBe.size (monitor)-max;6
PolarStr.MustNotBe.size (monitor)-current;0
PolarStr.MustNotBe.size (monitor)-updates;28862
SimpleMetrics.generate_snapshot (timer)-duration-s;0
SimpleMetrics.generate_snapshot (timer)-activations;3
Stack.call-recursion-depth-stubs-code (monitor)-max;1
Stack.call-recursion-depth-stubs-code (monitor)-current;1
Stack.call-recursion-depth-stubs-code (monitor)-updates;2129
Stack.call-recursion-depth-user-code (monitor)-max;1
Stack.call-recursion-depth-user-code (monitor)-current;1
Stack.call-recursion-depth-user-code (monitor)-updates;177
Stack.frames (monitor)-max;35
Stack.frames (monitor)-current;15
Stack.frames (monitor)-updates;7936
TaintRuntime.run (timer)-duration-s;11
TaintRuntime.run (timer)-activations;1
bjslForC\[ollection\].join (timer)-duration-s;0
bjslForC\[ollection\].join (timer)-activations;7144
bjslForConstraint.join (timer)-duration-s;0
bjslForConstraint.join (timer)-activations;68918
bjslForFlow.join (timer)-duration-s;0
bjslForFlow.join (timer)-activations;68991
bjslForHeap.join (timer)-duration-s;0
bjslForHeap.join (timer)-activations;281
bjslForSet.join (timer)-duration-s;0
bjslForSet.join (timer)-activations;618835
bjslForStack.join (timer)-duration-s;0
bjslForStack.join (timer)-activations;281
blForB4.join (timer)-duration-s;0
blForB4.join (timer)-activations;68918
currentProgram (context);/builds/products/products/app1/applications/product-core/module-1/service/src/utils/validation.js
dlForIntegerInterval.join (timer)-duration-s;0
dlForIntegerInterval.join (timer)-activations;69007
dlForIntegerInterval.meet (timer)-duration-s;0
dlForIntegerInterval.meet (timer)-activations;1098
handleArrayExpression (timer)-duration-s;0
handleArrayExpression (timer)-activations;55
handleArrowFunctionExpression (timer)-duration-s;0
handleArrowFunctionExpression (timer)-activations;336
handleAssignmentExpression (timer)-duration-s;9
handleAssignmentExpression (timer)-activations;1583
handleAwaitExpression (timer)-duration-s;0
handleAwaitExpression (timer)-activations;41
handleBinaryExpression (timer)-duration-s;6
handleBinaryExpression (timer)-activations;291
handleBlockStatement (timer)-duration-s;10
handleBlockStatement (timer)-activations;375
handleBoolean (timer)-duration-s;0
handleBoolean (timer)-activations;7
handleCallExpression (timer)-duration-s;9
handleCallExpression (timer)-activations;1725
handleConditionalExpression (timer)-duration-s;0
handleConditionalExpression (timer)-activations;5
handleExpressionStatement (timer)-duration-s;9
handleExpressionStatement (timer)-activations;2405
handleForInStatement (timer)-duration-s;7
handleForInStatement (timer)-activations;83
handleFunctionDeclaration (timer)-duration-s;0
handleFunctionDeclaration (timer)-activations;32
handleFunctionExpression (timer)-duration-s;1
handleFunctionExpression (timer)-activations;1288
handleIdentifier (timer)-duration-s;8
handleIdentifier (timer)-activations;4959
handleIfStatement (timer)-duration-s;8
handleIfStatement (timer)-activations;96
handleLogicalExpression (timer)-duration-s;4
handleLogicalExpression (timer)-activations;29
handleMemberExpression (timer)-duration-s;8
handleMemberExpression (timer)-activations;1268
handleNewExpression (timer)-duration-s;0
handleNewExpression (timer)-activations;134
handleNull (timer)-duration-s;0
handleNull (timer)-activations;3
handleNumber (timer)-duration-s;0
handleNumber (timer)-activations;72
handleObjectExpression (timer)-duration-s;1
handleObjectExpression (timer)-activations;268
handleRegExp (timer)-duration-s;0
handleRegExp (timer)-activations;6
handleReturnStatement (timer)-duration-s;10
handleReturnStatement (timer)-activations;522
handleString (timer)-duration-s;7
handleString (timer)-activations;987
handleTemplateLiteral (timer)-duration-s;0
handleTemplateLiteral (timer)-activations;100
handleThisExpr (timer)-duration-s;7
handleThisExpr (timer)-activations;1191
handleTryStatement (timer)-duration-s;6
handleTryStatement (timer)-activations;63
handleUnaryExpression (timer)-duration-s;5
handleUnaryExpression (timer)-activations;23
handleVariableDeclaration (timer)-duration-s;2
handleVariableDeclaration (timer)-activations;691
scopeAnalysis (timer)-duration-s;0
scopeAnalysis (timer)-activations;42
unsupported.object-expression.non-constant-key (counter);6
09:25:29.358 DEBUG             \[STACK:16\] PUSH /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:29.385 DEBUG           \[STACK:15\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:29
09:25:29.386 DEBUG         \[STACK:14\] DROP /builds/products/products/app1/applications/product-core/module-1/service/src/app.js:967:0
09:30:46.590 DEBUG Shutting down the worker
09:30:48.507 INFO  ╔═══╤══════╤═══════════╤══════════╗
09:30:48.661 INFO  ║ # │ Rule │ Time (ms) │ Relative ║
09:30:48.796 INFO  ╚═══╧══════╧═══════════╧══════════╝
09:30:48.797 INFO
09:30:48.810 INFO  Rule                                  | Time (ms) | Relative
09:30:48.810 INFO  :-------------------------------------|----------:|--------:
09:30:48.811 INFO  sonarjs/S1874                         |   264.041 |    29.8%
09:30:48.824 INFO  sonarjs/sonar-architecture-ir         |    99.737 |    11.2%
09:30:48.838 INFO  sonarjs/S4165                         |    48.978 |     5.5%
09:30:48.839 INFO  sonarjs/S1854                         |    23.110 |     2.6%
09:30:48.852 INFO  sonarjs/S2092                         |    17.329 |     2.0%
09:30:48.853 INFO  sonarjs/S3782                         |    15.506 |     1.7%
09:30:48.868 INFO  sonarjs/S6544                         |    14.254 |     1.6%
09:30:48.882 INFO  sonarjs/S5332                         |    12.116 |     1.4%
09:30:48.883 INFO  sonarjs/S6551                         |    11.716 |     1.3%
09:30:48.896 INFO  sonarjs/S7059                         |    11.267 |     1.3%
09:30:48.896 INFO  sonarjs/S2814                         |     9.888 |     1.1%
09:30:49.027 INFO  sonarjs/S7739                         |     9.593 |     1.1%
09:30:49.030 INFO  sonarjs/S3776                         |     7.891 |     0.9%
09:30:49.046 INFO  sonarjs/S2589                         |     7.835 |     0.9%
09:30:49.046 INFO  sonarjs/S2259                         |     7.646 |     0.9%
09:30:49.067 INFO  sonarjs/S4822                         |     6.879 |     0.8%
09:30:49.088 INFO  sonarjs/S1313                         |     6.766 |     0.8%
09:30:49.088 INFO  sonarjs/S5860                         |     6.760 |     0.8%
09:30:49.088 INFO  sonarjs/S2201                         |     6.674 |     0.8%
09:30:49.123 INFO  sonarjs/S5122                         |     6.311 |     0.7%
09:30:49.138 INFO  sonarjs/internal-symbol-highlighting  |     6.275 |     0.7%
09:30:49.139 INFO  sonarjs/S5856                         |     5.750 |     0.6%
09:30:49.160 INFO  sonarjs/S7060                         |     5.687 |     0.6%
09:30:49.171 INFO  sonarjs/S3330                         |     4.912 |     0.6%
09:30:49.171 INFO  sonarjs/S7750                         |     4.763 |     0.5%
09:30:49.171 INFO  sonarjs/S7751                         |     4.612 |     0.5%
09:30:49.195 INFO  sonarjs/S7776                         |     4.592 |     0.5%
09:30:49.203 INFO  sonarjs/S4123                         |     4.408 |     0.5%
09:30:49.224 INFO  sonarjs/S6535                         |     4.344 |     0.5%
09:30:49.224 INFO  sonarjs/S5527                         |     4.185 |     0.5%
09:30:49.238 INFO  sonarjs/S7784                         |     4.115 |     0.5%
09:30:49.238 INFO  sonarjs/S7755                         |     4.043 |     0.5%
09:30:49.253 INFO  sonarjs/S6328                         |     3.968 |     0.4%
09:30:49.254 INFO  sonarjs/S6582                         |     3.889 |     0.4%
09:30:49.254 INFO  sonarjs/S6418                         |     3.876 |     0.4%
09:30:49.254 INFO  sonarjs/S7778                         |     3.661 |     0.4%
09:30:49.337 INFO  sonarjs/S6479                         |     3.597 |     0.4%
09:30:49.338 INFO  sonarjs/S7718                         |     3.580 |     0.4%
09:30:49.338 INFO  sonarjs/S2189                         |     3.551 |     0.4%
09:30:49.338 INFO  sonarjs/S7781                         |     3.503 |     0.4%
09:30:49.338 INFO  sonarjs/S4502                         |     3.379 |     0.4%
09:30:49.338 INFO  sonarjs/S6035                         |     3.350 |     0.4%
09:30:49.339 INFO  sonarjs/S1472                         |     3.021 |     0.3%
09:30:49.405 INFO  sonarjs/internal-cognitive-complexity |     3.020 |     0.3%
09:30:49.432 INFO  sonarjs/S1226                         |     2.951 |     0.3%
09:30:49.433 INFO  sonarjs/S1186                         |     2.889 |     0.3%
09:30:49.436 INFO  sonarjs/S7780                         |     2.872 |     0.3%
09:30:49.436 INFO  sonarjs/S5852                         |     2.690 |     0.3%
09:30:49.436 INFO  sonarjs/S5693                         |     2.613 |     0.3%
09:30:49.436 INFO  sonarjs/S7774                         |     2.553 |     0.3%
09:30:49.450 INFO  sonarjs/S7772                         |     2.539 |     0.3%
09:30:49.450 INFO  sonarjs/S7745                         |     2.534 |     0.3%
09:30:49.450 INFO  sonarjs/S4275                         |     2.375 |     0.3%
09:30:49.561 INFO  sonarjs/S5443                         |     2.280 |     0.3%
09:30:49.568 INFO  sonarjs/S7785                         |     2.259 |     0.3%
09:30:49.568 INFO  sonarjs/S7758                         |     2.204 |     0.2%
09:30:49.575 INFO  sonarjs/S2234                         |     2.200 |     0.2%
09:30:49.575 INFO  sonarjs/S2068                         |     2.182 |     0.2%
09:30:49.597 INFO  sonarjs/S3800                         |     2.113 |     0.2%
09:30:49.597 INFO  sonarjs/S2755                         |     2.054 |     0.2%
09:30:49.597 INFO  sonarjs/S4721                         |     2.054 |     0.2%
09:30:49.597 INFO  sonarjs/S7769                         |     2.053 |     0.2%
09:30:49.611 INFO  sonarjs/S7759                         |     2.042 |     0.2%
09:30:49.639 INFO  sonarjs/S3854                         |     2.017 |     0.2%
09:30:49.653 INFO  sonarjs/S7777                         |     2.009 |     0.2%
09:30:49.653 INFO  sonarjs/S5869                         |     2.008 |     0.2%
09:30:49.673 INFO  sonarjs/S7761                         |     1.964 |     0.2%
09:30:49.673 INFO  sonarjs/S2612                         |     1.881 |     0.2%
09:30:49.673 INFO  sonarjs/S5542                         |     1.867 |     0.2%
09:30:49.674 INFO  sonarjs/S7736                         |     1.838 |     0.2%
09:30:49.687 INFO  sonarjs/S7760                         |     1.776 |     0.2%
09:30:49.687 INFO  sonarjs/S7729                         |     1.715 |     0.2%
09:30:49.688 INFO  sonarjs/S5042                         |     1.709 |     0.2%
09:30:49.688 INFO  sonarjs/S5691                         |     1.709 |     0.2%
09:30:49.826 INFO  sonarjs/S7754                         |     1.705 |     0.2%
09:30:49.867 INFO  sonarjs/S6351                         |     1.691 |     0.2%
09:30:49.881 INFO  sonarjs/S6534                         |     1.685 |     0.2%
09:30:49.881 INFO  sonarjs/S4036                         |     1.680 |     0.2%
09:30:49.882 INFO  sonarjs/S5868                         |     1.641 |     0.2%
09:30:49.909 INFO  sonarjs/S6661                         |     1.639 |     0.2%
09:30:50.063 INFO  sonarjs/S5759                         |     1.573 |     0.2%
09:30:50.153 INFO  sonarjs/S6671                         |     1.567 |     0.2%
09:30:50.168 INFO  sonarjs/S5843                         |     1.565 |     0.2%
09:30:50.168 INFO  sonarjs/S2681                         |     1.559 |     0.2%
09:30:50.174 INFO  sonarjs/S6645                         |     1.559 |     0.2%
09:30:50.174 INFO  sonarjs/S1763                         |     1.556 |     0.2%
09:30:50.174 INFO  sonarjs/S7721                         |     1.544 |     0.2%
09:30:50.174 INFO  sonarjs/S2245                         |     1.520 |     0.2%
09:30:50.182 INFO  sonarjs/S5247                         |     1.514 |     0.2%
09:30:50.182 INFO  sonarjs/S7738                         |     1.496 |     0.2%
09:30:50.182 INFO  sonarjs/S7783                         |     1.476 |     0.2%
09:30:50.211 INFO  sonarjs/S7768                         |     1.474 |     0.2%
09:30:50.225 INFO  sonarjs/S3403                         |     1.466 |     0.2%
09:30:50.225 INFO  sonarjs/S7749                         |     1.447 |     0.2%
09:30:50.238 INFO  sonarjs/S4790                         |     1.444 |     0.2%
09:30:50.238 INFO  sonarjs/S7765                         |     1.432 |     0.2%
09:30:50.252 INFO  sonarjs/S5876                         |     1.427 |     0.2%
09:30:50.252 INFO  sonarjs/S7753                         |     1.415 |     0.2%
09:30:50.252 INFO  sonarjs/S905                          |     1.409 |     0.2%
09:30:50.280 INFO  sonarjs/S7722                         |     1.400 |     0.2%
09:30:50.280 INFO  sonarjs/S1534                         |     1.377 |     0.2%
09:30:50.308 INFO  sonarjs/S2137                         |     1.367 |     0.2%
09:30:50.309 INFO  sonarjs/S7733                         |     1.364 |     0.2%
09:30:50.323 INFO  sonarjs/S5659                         |     1.358 |     0.2%
09:30:50.323 INFO  sonarjs/S7746                         |     1.312 |     0.1%
09:30:50.331 INFO  sonarjs/S4030                         |     1.310 |     0.1%
09:30:50.331 INFO  sonarjs/S5547                         |     1.304 |     0.1%
09:30:50.331 INFO  sonarjs/S4830                         |     1.298 |     0.1%
09:30:50.332 INFO  sonarjs/S2301                         |     1.292 |     0.1%
09:30:50.345 INFO  sonarjs/S7743                         |     1.288 |     0.1%
09:30:50.346 INFO  sonarjs/S7764                         |     1.281 |     0.1%
09:30:50.346 INFO  sonarjs/S7762                         |     1.270 |     0.1%
09:30:50.346 INFO  sonarjs/S6557                         |     1.262 |     0.1%
09:30:50.347 INFO  sonarjs/S6353                         |     1.261 |     0.1%
09:30:50.347 INFO  sonarjs/S7756                         |     1.245 |     0.1%
09:30:50.347 INFO  sonarjs/S2598                         |     1.227 |     0.1%
09:30:50.348 INFO  sonarjs/S128                          |     1.197 |     0.1%
09:30:50.349 INFO  sonarjs/S930                          |     1.190 |     0.1%
09:30:50.349 INFO  sonarjs/S4143                         |     1.186 |     0.1%
09:30:50.350 INFO  sonarjs/S7752                         |     1.180 |     0.1%
09:30:50.350 INFO  sonarjs/S1523                         |     1.145 |     0.1%
09:30:50.351 INFO  sonarjs/S7748                         |     1.119 |     0.1%
09:30:50.351 INFO  sonarjs/S6638                         |     1.111 |     0.1%
09:30:50.351 INFO  sonarjs/S4158                         |     1.109 |     0.1%
09:30:50.351 INFO  sonarjs/S7771                         |     1.103 |     0.1%
09:30:50.351 INFO  sonarjs/S3699                         |     1.101 |     0.1%
09:30:50.351 INFO  sonarjs/S3516                         |     1.090 |     0.1%
09:30:50.380 INFO  sonarjs/S125                          |     1.088 |     0.1%
09:30:50.380 INFO  sonarjs/S4043                         |     1.045 |     0.1%
09:30:50.380 INFO  sonarjs/S6523                         |     1.025 |     0.1%
09:30:50.381 INFO  sonarjs/S5725                         |     0.996 |     0.1%
09:30:50.394 INFO  sonarjs/S5730                         |     0.890 |     0.1%
09:30:50.394 INFO  sonarjs/S6331                         |     0.880 |     0.1%
09:30:50.394 INFO  sonarjs/S7767                         |     0.872 |     0.1%
09:30:50.394 INFO  sonarjs/S1527                         |     0.839 |     0.1%
09:30:50.450 INFO  sonarjs/S3686                         |     0.828 |     0.1%
09:30:50.493 INFO  sonarjs/S1871                         |     0.815 |     0.1%
09:30:50.494 INFO  sonarjs/S3796                         |     0.764 |     0.1%
09:30:50.494 INFO  sonarjs/S3972                         |     0.763 |     0.1%
09:30:50.508 INFO  sonarjs/S6325                         |     0.763 |     0.1%
09:30:50.508 INFO  sonarjs/S5850                         |     0.740 |     0.1%
09:30:50.508 INFO  sonarjs/S7747                         |     0.723 |     0.1%
09:30:50.508 INFO  sonarjs/S6859                         |     0.721 |     0.1%
09:30:50.529 INFO  sonarjs/S1751                         |     0.700 |     0.1%
09:30:50.529 INFO  sonarjs/S1481                         |     0.696 |     0.1%
09:30:50.530 INFO  sonarjs/S6326                         |     0.683 |     0.1%
09:30:50.530 INFO  sonarjs/S7740                         |     0.661 |     0.1%
09:30:50.550 INFO  sonarjs/S1862                         |     0.657 |     0.1%
09:30:50.551 INFO  sonarjs/S7770                         |     0.656 |     0.1%
09:30:50.551 INFO  sonarjs/S1536                         |     0.653 |     0.1%
09:30:50.551 INFO  sonarjs/S6442                         |     0.647 |     0.1%
09:30:50.558 INFO  sonarjs/S5842                         |     0.641 |     0.1%
09:30:50.558 INFO  sonarjs/S6666                         |     0.630 |     0.1%
09:30:50.558 INFO  sonarjs/S7773                         |     0.629 |     0.1%
09:30:50.558 INFO  sonarjs/S7723                         |     0.585 |     0.1%
09:30:50.574 INFO  sonarjs/S6657                         |     0.584 |     0.1%
09:30:50.575 INFO  sonarjs/S1764                         |     0.583 |     0.1%
09:30:50.588 INFO  sonarjs/S6323                         |     0.581 |     0.1%
09:30:50.588 INFO  sonarjs/S5604                         |     0.571 |     0.1%
09:30:50.610 INFO  sonarjs/S6676                         |     0.561 |     0.1%
09:30:50.610 INFO  sonarjs/S2688                         |     0.547 |     0.1%
09:30:50.610 INFO  sonarjs/S2392                         |     0.544 |     0.1%
09:30:50.624 INFO  sonarjs/S1128                         |     0.539 |     0.1%
09:30:50.651 INFO  sonarjs/S6324                         |     0.538 |     0.1%
09:30:50.652 INFO  sonarjs/S1199                         |     0.532 |     0.1%
09:30:50.665 INFO  sonarjs/S2639                         |     0.514 |     0.1%
09:30:50.665 INFO  sonarjs/S6679                         |     0.503 |     0.1%
09:30:50.686 INFO  sonarjs/S6397                         |     0.500 |     0.1%
09:30:50.686 INFO  sonarjs/S2871                         |     0.480 |     0.1%
09:30:50.686 INFO  sonarjs/S6019                         |     0.478 |     0.1%
09:30:50.687 INFO  sonarjs/S4507                         |     0.475 |     0.1%
09:30:50.694 INFO  sonarjs/S4144                         |     0.461 |     0.1%
09:30:50.694 INFO  sonarjs/S6654                         |     0.452 |     0.1%
09:30:50.702 INFO  sonarjs/S7742                         |     0.450 |     0.1%
09:30:50.702 INFO  sonarjs/S5689                         |     0.449 |     0.1%
09:30:50.703 INFO  sonarjs/S6637                         |     0.443 |     0.0%
09:30:50.703 INFO  sonarjs/S7766                         |     0.442 |     0.0%
09:30:50.704 INFO  sonarjs/S6749                         |     0.429 |     0.0%
09:30:50.704 INFO  sonarjs/S3500                         |     0.420 |     0.0%
09:30:50.705 INFO  sonarjs/S7735                         |     0.397 |     0.0%
09:30:50.705 INFO  sonarjs/S6653                         |     0.394 |     0.0%
09:30:50.706 INFO  sonarjs/S7741                         |     0.390 |     0.0%
09:30:50.712 INFO  sonarjs/S6643                         |     0.388 |     0.0%
09:30:50.713 INFO  sonarjs/S1314                         |     0.382 |     0.0%
09:30:50.713 INFO  sonarjs/S1143                         |     0.377 |     0.0%
09:30:50.714 INFO  sonarjs/S1788                         |     0.377 |     0.0%
09:30:50.714 INFO  sonarjs/S1516                         |     0.371 |     0.0%
09:30:50.715 INFO  sonarjs/S2077                         |     0.367 |     0.0%
09:30:50.716 INFO  sonarjs/S2432                         |     0.364 |     0.0%
09:30:50.716 INFO  sonarjs/S6268                         |     0.348 |     0.0%
09:30:50.716 INFO  sonarjs/S5148                         |     0.346 |     0.0%
09:30:50.735 INFO  sonarjs/S6959                         |     0.335 |     0.0%
09:30:50.776 INFO  sonarjs/S1515                         |     0.334 |     0.0%
09:30:50.777 INFO  sonarjs/S6958                         |     0.328 |     0.0%
09:30:50.777 INFO  sonarjs/S6509                         |     0.325 |     0.0%
09:30:50.790 INFO  sonarjs/S6660                         |     0.322 |     0.0%
09:30:50.791 INFO  sonarjs/S7724                         |     0.315 |     0.0%
09:30:50.791 INFO  sonarjs/S4426                         |     0.309 |     0.0%
09:30:50.791 INFO  sonarjs/S3923                         |     0.305 |     0.0%
09:30:50.811 INFO  sonarjs/S1656                         |     0.291 |     0.0%
09:30:50.811 INFO  sonarjs/S7744                         |     0.280 |     0.0%
09:30:50.811 INFO  sonarjs/S2685                         |     0.278 |     0.0%
09:30:50.812 INFO  sonarjs/S107                          |     0.278 |     0.0%
09:30:50.826 INFO  sonarjs/S7732                         |     0.272 |     0.0%
09:30:50.870 INFO  sonarjs/S4125                         |     0.266 |     0.0%
09:30:50.870 INFO  sonarjs/S7726                         |     0.259 |     0.0%
09:30:50.870 INFO  sonarjs/S2757                         |     0.257 |     0.0%
09:30:50.876 INFO  sonarjs/S1125                         |     0.254 |     0.0%
09:30:50.876 INFO  sonarjs/S6627                         |     0.251 |     0.0%
09:30:50.876 INFO  sonarjs/S1121                         |     0.236 |     0.0%
09:30:50.876 INFO  sonarjs/S5732                         |     0.230 |     0.0%
09:30:50.883 INFO  sonarjs/S5734                         |     0.228 |     0.0%
09:30:50.883 INFO  sonarjs/S1126                         |     0.220 |     0.0%
09:30:50.884 INFO  sonarjs/S4140                         |     0.214 |     0.0%
09:30:50.884 INFO  sonarjs/S7763                         |     0.213 |     0.0%
09:30:50.885 INFO  sonarjs/S2004                         |     0.204 |     0.0%
09:30:50.885 INFO  sonarjs/S5728                         |     0.199 |     0.0%
09:30:50.885 INFO  sonarjs/S5254                         |     0.197 |     0.0%
09:30:50.885 INFO  sonarjs/S1529                         |     0.191 |     0.0%
09:30:50.892 INFO  sonarjs/S6443                         |     0.183 |     0.0%
09:30:50.892 INFO  sonarjs/S2430                         |     0.181 |     0.0%
09:30:50.893 INFO  sonarjs/S5739                         |     0.178 |     0.0%
09:30:50.893 INFO  sonarjs/S5736                         |     0.175 |     0.0%
09:30:50.907 INFO  sonarjs/S6644                         |     0.174 |     0.0%
09:30:50.907 INFO  sonarjs/S1940                         |     0.169 |     0.0%
09:30:50.937 INFO  sonarjs/S6853                         |     0.167 |     0.0%
09:30:50.937 INFO  sonarjs/S3812                         |     0.166 |     0.0%
09:30:50.943 INFO  sonarjs/S3981                         |     0.166 |     0.0%
09:30:50.951 INFO  sonarjs/S3799                         |     0.165 |     0.0%
09:30:50.971 INFO  sonarjs/S2486                         |     0.156 |     0.0%
09:30:50.971 INFO  sonarjs/S7720                         |     0.154 |     0.0%
09:30:50.979 INFO  sonarjs/S2094                         |     0.154 |     0.0%
09:30:50.979 INFO  sonarjs/S3504                         |     0.152 |     0.0%
09:30:50.980 INFO  sonarjs/S6844                         |     0.147 |     0.0%
09:30:50.987 INFO  sonarjs/S108                          |     0.144 |     0.0%
09:30:50.987 INFO  sonarjs/S3626                         |     0.144 |     0.0%
09:30:50.988 INFO  sonarjs/S6650                         |     0.138 |     0.0%
09:30:50.988 INFO  sonarjs/S6635                         |     0.137 |     0.0%
09:30:50.988 INFO  sonarjs/S1082                         |     0.129 |     0.0%
09:30:50.988 INFO  sonarjs/S7787                         |     0.128 |     0.0%
09:30:50.989 INFO  sonarjs/S2692                         |     0.120 |     0.0%
09:30:50.989 INFO  sonarjs/S3579                         |     0.116 |     0.0%
09:30:50.990 INFO  sonarjs/S4624                         |     0.115 |     0.0%
09:30:50.990 INFO  sonarjs/S2737                         |     0.115 |     0.0%
09:30:50.996 INFO  sonarjs/S3863                         |     0.115 |     0.0%
09:30:50.996 INFO  sonarjs/S1219                         |     0.114 |     0.0%
09:30:50.996 INFO  sonarjs/S5260                         |     0.112 |     0.0%
09:30:50.996 INFO  sonarjs/S2123                         |     0.105 |     0.0%
09:30:50.996 INFO  sonarjs/S2870                         |     0.102 |     0.0%
09:30:50.997 INFO  sonarjs/S1077                         |     0.100 |     0.0%
09:30:50.997 INFO  sonarjs/S1135                         |     0.100 |     0.0%
09:30:50.997 INFO  sonarjs/S7757                         |     0.098 |     0.0%
09:30:50.998 INFO  sonarjs/S4138                         |     0.092 |     0.0%
09:30:51.012 INFO  sonarjs/S6647                         |     0.091 |     0.0%
09:30:51.039 INFO  sonarjs/S3834                         |     0.090 |     0.0%
09:30:51.053 INFO  sonarjs/S6851                         |     0.087 |     0.0%
09:30:51.053 INFO  sonarjs/S6850                         |     0.085 |     0.0%
09:30:51.082 INFO  sonarjs/S1994                         |     0.080 |     0.0%
09:30:51.082 INFO  sonarjs/S2999                         |     0.080 |     0.0%
09:30:51.084 INFO  sonarjs/S878                          |     0.077 |     0.0%
09:30:51.084 INFO  sonarjs/S6852                         |     0.077 |     0.0%
09:30:51.084 INFO  sonarjs/S6845                         |     0.075 |     0.0%
09:30:51.084 INFO  sonarjs/S1068                         |     0.075 |     0.0%
09:30:51.097 INFO  sonarjs/S6847                         |     0.069 |     0.0%
09:30:51.097 INFO  sonarjs/S7786                         |     0.068 |     0.0%
09:30:51.098 INFO  sonarjs/S2703                         |     0.067 |     0.0%
09:30:51.126 INFO  sonarjs/S6811                         |     0.066 |     0.0%
09:30:51.127 INFO  sonarjs/S2819                         |     0.065 |     0.0%
09:30:51.148 INFO  sonarjs/S6772                         |     0.063 |     0.0%
09:30:51.148 INFO  sonarjs/S7737                         |     0.062 |     0.0%
09:30:51.176 INFO  sonarjs/S6848                         |     0.060 |     0.0%
09:30:51.176 INFO  sonarjs/S7734                         |     0.058 |     0.0%
09:30:51.176 INFO  sonarjs/S1848                         |     0.057 |     0.0%
09:30:51.176 INFO  sonarjs/S101                          |     0.056 |     0.0%
09:30:51.177 INFO  sonarjs/S7725                         |     0.055 |     0.0%
09:30:51.183 INFO  sonarjs/S1134                         |     0.054 |     0.0%
09:30:51.183 INFO  sonarjs/S6842                         |     0.053 |     0.0%
09:30:51.183 INFO  sonarjs/S4619                         |     0.053 |     0.0%
09:30:51.183 INFO  sonarjs/S6821                         |     0.053 |     0.0%
09:30:51.184 INFO  sonarjs/S5264                         |     0.051 |     0.0%
09:30:51.184 INFO  sonarjs/S7719                         |     0.051 |     0.0%
09:30:51.184 INFO  sonarjs/S3001                         |     0.050 |     0.0%
09:30:51.185 INFO  sonarjs/S6822                         |     0.050 |     0.0%
09:30:51.186 INFO  sonarjs/S6770                         |     0.049 |     0.0%
09:30:51.186 INFO  sonarjs/S3616                         |     0.049 |     0.0%
09:30:51.186 INFO  sonarjs/S2251                         |     0.048 |     0.0%
09:30:51.186 INFO  sonarjs/S2310                         |     0.047 |     0.0%
09:30:51.213 INFO  sonarjs/S6594                         |     0.047 |     0.0%
09:30:51.214 INFO  sonarjs/S4084                         |     0.045 |     0.0%
09:30:51.221 INFO  sonarjs/S6793                         |     0.045 |     0.0%
09:30:51.222 INFO  sonarjs/S5757                         |     0.045 |     0.0%
09:30:51.228 INFO  sonarjs/S3696                         |     0.043 |     0.0%
09:30:51.229 INFO  sonarjs/S6861                         |     0.042 |     0.0%
09:30:51.229 INFO  sonarjs/S6807                         |     0.042 |     0.0%
09:30:51.230 INFO  sonarjs/S3785                         |     0.042 |     0.0%
09:30:51.231 INFO  sonarjs/S6439                         |     0.042 |     0.0%
09:30:51.231 INFO  sonarjs/S6824                         |     0.041 |     0.0%
09:30:51.231 INFO  sonarjs/S6827                         |     0.041 |     0.0%
09:30:51.237 INFO  sonarjs/S5256                         |     0.041 |     0.0%
09:30:51.238 INFO  sonarjs/S6843                         |     0.039 |     0.0%
09:30:51.239 INFO  sonarjs/S6836                         |     0.039 |     0.0%
09:30:51.240 INFO  sonarjs/S6840                         |     0.038 |     0.0%
09:30:51.241 INFO  sonarjs/S6819                         |     0.037 |     0.0%
09:30:51.241 INFO  sonarjs/S6522                         |     0.036 |     0.0%
09:30:51.242 INFO  sonarjs/S1090                         |     0.036 |     0.0%
09:30:51.242 INFO  sonarjs/S6823                         |     0.034 |     0.0%
09:30:51.251 INFO  sonarjs/S6486                         |     0.033 |     0.0%
09:30:51.266 INFO  sonarjs/S888                          |     0.033 |     0.0%
09:30:51.281 INFO  sonarjs/S1479                         |     0.031 |     0.0%
09:30:51.281 INFO  sonarjs/S3984                         |     0.031 |     0.0%
09:30:51.282 INFO  sonarjs/S2990                         |     0.029 |     0.0%
09:30:51.283 INFO  sonarjs/S3735                         |     0.029 |     0.0%
09:30:51.349 INFO  sonarjs/S3531                         |     0.027 |     0.0%
09:30:51.377 INFO  sonarjs/S3358                         |     0.026 |     0.0%
09:30:51.377 INFO  sonarjs/S6825                         |     0.026 |     0.0%
09:30:51.377 INFO  sonarjs/S1321                         |     0.026 |     0.0%
09:30:51.378 INFO  sonarjs/S1119                         |     0.024 |     0.0%
09:30:51.391 INFO  sonarjs/S1439                         |     0.024 |     0.0%
09:30:51.391 INFO  sonarjs/S4634                         |     0.024 |     0.0%
09:30:51.391 INFO  sonarjs/S1533                         |     0.023 |     0.0%
09:30:51.391 INFO  sonarjs/S6841                         |     0.023 |     0.0%
09:30:51.412 INFO  sonarjs/S4524                         |     0.023 |     0.0%
09:30:51.426 INFO  sonarjs/S6846                         |     0.022 |     0.0%
09:30:51.440 INFO  sonarjs/S1264                         |     0.018 |     0.0%
09:30:51.440 INFO  sonarjs/S5257                         |     0.018 |     0.0%
09:30:51.454 INFO  sonarjs/S1301                         |     0.016 |     0.0%
09:30:51.455 DEBUG The worker thread exited with code 0
09:30:51.455 DEBUG Closing server
09:30:51.468 DEBUG WebSocket client disconnected:  with code 1006
09:30:51.469 DEBUG Closed WebSocket connection
09:30:51.483 DEBUG The bridge server shut down
09:30:51.490 INFO  ╔═══╤══════╤═══════════╤══════════╗
09:30:51.490 INFO  ║ # │ Rule │ Time (ms) │ Relative ║
09:30:51.492 INFO  ╚═══╧══════╧═══════════╧══════════╝
09:30:51.493 INFO
09:30:53.856 DEBUG WebSocket connection closed:  (code: 1006)
WARNING: step_script could not run to completion because the timeout was exceeded.
1 Like

Same thing is happening to us, we’re using bitbucket pipelines with the bitbucket pipe on a nodejs express project. No matter how long we let it run, it keeps stalling. We can see the file it stops at, we exclude the file, run it again and it stops at another file later in the run. It looks to be having issues with files with a lot of require statements.