4 Replies Latest reply on Dec 12, 2017 2:38 PM by Eric Liong

    Tabjolt custom workload mix "Failed to set up load test session" error

    jiao li

      Hi,

       

      I configured files in C:\Tabjolt\config and executed default workload mix without any problem.

      My problem is when I created a customized workload mix following Tabjolt Installation Guide(Page 16--Customizing workload mix),

      I got errors when executing it.

      Here is what I got when I executed my customized load test:

       

      C:\Tabjolt>go --t=testplans\InteractVizLoadTest_revised3.jmx --d=60 --c=1

      [2017-11-20 16:45:19,611] Perf harness is started with parameters: --rootPath=C:\Tabjolt --t=testplans\InteractVizLoadTest_revised3.jmx --d=60 --c=1

      [2017-11-20 16:45:19,895] Loading PerfTestConfig yaml file C:\Tabjolt\config\PerfTestConfig.yaml

      [2017-11-20 16:45:20,110] Loading ServerTestConfig yaml file C:\Tabjolt\config\ServerTestConfig.yaml

      DEBUG [2017-11-20 16:45:20,126][main] (AbstractConfig.java:279)   - Looking for config file: log4j.properties

      DEBUG [2017-11-20 16:45:20,126][main] (AbstractConfig.java:296)   - Looking for specific folder named [config] in tree of [C:\Tabjolt\lib\ext]

      DEBUG [2017-11-20 16:45:20,159][main] (AbstractConfig.java:329)   - Found config file 'log4j.properties' for class class com.tableausoftware.test.server.configuration.ServerTestConfig at '/C:/Tabjolt/config/log4j.properties'

      DEBUG [2017-11-20 16:45:20,159][main] (ServerTestConfig.java:97)   - Loading ServerTestConfig from: ServerTestConfig.yaml

      DEBUG [2017-11-20 16:45:20,159][main] (AbstractConfig.java:108)   - Read system property java.test.config.override=null

      DEBUG [2017-11-20 16:45:20,159][main] (AbstractConfig.java:112)   - Using test config Override 'null'

      DEBUG [2017-11-20 16:45:20,159][main] (AbstractConfig.java:95)   - No override is set, using default

      DEBUG [2017-11-20 16:45:20,159][main] (AbstractConfig.java:279)   - Looking for config file: ServerTestConfig.yaml

      DEBUG [2017-11-20 16:45:20,159][main] (AbstractConfig.java:296)   - Looking for specific folder named [config] in tree of [C:\Tabjolt\lib\ext]

      DEBUG [2017-11-20 16:45:20,173][main] (AbstractConfig.java:329)   - Found config file 'ServerTestConfig.yaml' for class class com.tableausoftware.test.server.configuration.ServerTestConfig at '/C:/Tabjolt/config/ServerTestConfig.yaml'

      DEBUG [2017-11-20 16:45:20,173][main] (AbstractConfig.java:144)   - Loading config [class com.tableausoftware.test.server.configuration.ServerTestConfig] from [ServerTestConfig.yaml]

      DEBUG [2017-11-20 16:45:20,173][main] (AbstractConfig.java:148)   - Found config [default]

      DEBUG [2017-11-20 16:45:20,220][main] (AbstractConfig.java:158)   - Completed reading the [default] config

      INFO  [2017-11-20 16:45:20,564][main] (PerfRunHelper.java:247)   - C:\Tabjolt\bin\dataretriever.exe -configpath=C:\Tabjolt\config\dataretriever.config -duration=60 -outputpath=C:\Tabjolt\results\2017-11-20_16-45-19\wincounter.tsv

      -------------start collecting JMX counters--------------

      Output File:C:\Tabjolt/results/2017-11-20_16-45-19/jmxcounter.tsv

      -------------start collecting Zabbix counters--------------

      Output File:C:\Tabjolt/results/2017-11-20_16-45-19/zabbixcounter.tsv

      -------------start windows performance counters collection-------------

      Output File:c:\tabjolt\results\2017-11-20_16-45-19\wincounter.tsv

      INFO  [2017-11-20 16:45:25,439][main] (PerfRunHelper.java:351)   - -------------start Jmeter load test run-------------

      INFO  [2017-11-20 16:45:25,439][main] (PerfRunHelper.java:352)   - Output file: C:\Tabjolt/results/2017-11-20_16-45-19/result-nssm-sv1-0.jtl

      INFO  [2017-11-20 16:45:25,439][main] (PerfRunHelper.java:353)   - Command: [C:\Tabjolt/bin/jmeter.bat, , , , , , -n, -t=C:\Tabjolt\testplans\InteractVizLoadTest_revised3.jmx, -j=C:\Tabjolt/logs/jmeter_2017-11-20_16-45-19.log, -JthreadCount=1, -Jduration=60, -JloginWeight=1.0, -JconfigFolderPath=C:\Tabjolt/config/, -Jlogpath=C:\Tabjolt/results/2017-11-20_16-45-19/result-nssm-sv1-0.jtl, , ]

      INFO  [2017-11-20 16:45:25,767][main] (ResultProcessor.java:129)   - -------------start processing perf counters and run result-------------

      INFO  [2017-11-20 16:45:25,785][main] (ResultProcessor.java:130)   - Perf run result is saving to result repository. Please use this RUN ID 17 to view your result in Tableau

      INFO  [2017-11-20 16:45:25,924][Thread-7] (PerfRunMonitor.java:37)   - Starting Perfrun monitor thread

      Created the tree successfully using C:\Tabjolt\testplans\InteractVizLoadTest_revised3.jmx

      Starting the test @ Mon Nov 20 16:45:27 JST 2017 (1511163927423)

      Waiting for possible shutdown message on port 4446

      DEBUG [2017-11-20 16:45:28,298][setUp Thread Group 1-1] (AbstractConfig.java:279)   - Looking for config file: log4j.properties

      DEBUG [2017-11-20 16:45:28,314][setUp Thread Group 1-1] (AbstractConfig.java:296)   - Looking for specific folder named [config] in tree of [C:\Tabjolt\lib\ext]

      DEBUG [2017-11-20 16:45:28,330][setUp Thread Group 1-1] (AbstractConfig.java:329)   - Found config file 'log4j.properties' for class class com.tableausoftware.test.server.configuration.ServerTestConfig at '/C:/Tabjolt/config/log4j.properties'

      DEBUG [2017-11-20 16:45:28,345][setUp Thread Group 1-1] (ServerTestConfig.java:97)   - Loading ServerTestConfig from: ServerTestConfig.yaml

      DEBUG [2017-11-20 16:45:28,345][setUp Thread Group 1-1] (AbstractConfig.java:108)   - Read system property java.test.config.override=null

      DEBUG [2017-11-20 16:45:28,345][setUp Thread Group 1-1] (AbstractConfig.java:112)   - Using test config Override 'null'

      DEBUG [2017-11-20 16:45:28,345][setUp Thread Group 1-1] (AbstractConfig.java:95)   - No override is set, using default

      DEBUG [2017-11-20 16:45:28,345][setUp Thread Group 1-1] (AbstractConfig.java:279)   - Looking for config file: ServerTestConfig.yaml

      DEBUG [2017-11-20 16:45:28,345][setUp Thread Group 1-1] (AbstractConfig.java:296)   - Looking for specific folder named [config] in tree of [C:\Tabjolt\lib\ext]

      DEBUG [2017-11-20 16:45:28,345][setUp Thread Group 1-1] (AbstractConfig.java:329)   - Found config file 'ServerTestConfig.yaml' for class class com.tableausoftware.test.server.configuration.ServerTestConfig at '/C:/Tabjolt/config/ServerTestConfig.yaml'

      DEBUG [2017-11-20 16:45:28,345][setUp Thread Group 1-1] (AbstractConfig.java:144)   - Loading config [class com.tableausoftware.test.server.configuration.ServerTestConfig] from [ServerTestConfig.yaml]

      DEBUG [2017-11-20 16:45:28,361][setUp Thread Group 1-1] (AbstractConfig.java:148)   - Found config [default]

      DEBUG [2017-11-20 16:45:28,564][setUp Thread Group 1-1] (AbstractConfig.java:158)   - Completed reading the [default] config

      DEBUG [2017-11-20 16:45:28,564][setUp Thread Group 1-1] (AbstractConfig.java:279)   - Looking for config file: log4j.properties

      DEBUG [2017-11-20 16:45:28,564][setUp Thread Group 1-1] (AbstractConfig.java:296)   - Looking for specific folder named [config] in tree of [C:\Tabjolt\lib\ext]

      DEBUG [2017-11-20 16:45:28,590][setUp Thread Group 1-1] (AbstractConfig.java:329)   - Found config file 'log4j.properties' for class class com.tableausoftware.test.server.configuration.ServerTestConfig at '/C:/Tabjolt/config/log4j.properties'

      DEBUG [2017-11-20 16:45:28,596][setUp Thread Group 1-1] (ServerTestConfig.java:97)   - Loading ServerTestConfig from: C:\Tabjolt\config\ServerTestConfig.yaml

      DEBUG [2017-11-20 16:45:28,596][setUp Thread Group 1-1] (AbstractConfig.java:108)   - Read system property java.test.config.override=null

      DEBUG [2017-11-20 16:45:28,596][setUp Thread Group 1-1] (AbstractConfig.java:112)   - Using test config Override 'null'

      DEBUG [2017-11-20 16:45:28,596][setUp Thread Group 1-1] (AbstractConfig.java:95)   - No override is set, using default

      DEBUG [2017-11-20 16:45:28,596][setUp Thread Group 1-1] (AbstractConfig.java:144)   - Loading config [class com.tableausoftware.test.server.configuration.ServerTestConfig] from [C:\Tabjolt\config\ServerTestConfig.yaml]

      DEBUG [2017-11-20 16:45:28,596][setUp Thread Group 1-1] (AbstractConfig.java:148)   - Found config [default]

      DEBUG [2017-11-20 16:45:28,596][setUp Thread Group 1-1] (AbstractConfig.java:158)   - Completed reading the [default] config

      DEBUG [2017-11-20 16:45:28,596][setUp Thread Group 1-1] (AbstractConfig.java:108)   - Read system property java.test.config.override=null

      DEBUG [2017-11-20 16:45:28,596][setUp Thread Group 1-1] (AbstractConfig.java:112)   - Using test config Override 'null'

      DEBUG [2017-11-20 16:45:28,596][setUp Thread Group 1-1] (AbstractConfig.java:95)   - No override is set, using default

      DEBUG [2017-11-20 16:45:28,611][setUp Thread Group 1-1] (AbstractConfig.java:144)   - Loading config [class com.tableausoftware.test.server.perfLib.PerfTestConfig] from [C:\Tabjolt\config\PerfTestConfig.yaml]

      DEBUG [2017-11-20 16:45:28,611][setUp Thread Group 1-1] (AbstractConfig.java:148)   - Found config [default]

      DEBUG [2017-11-20 16:45:28,657][setUp Thread Group 1-1] (AbstractConfig.java:158)   - Completed reading the [default] config

      DEBUG [2017-11-20 16:45:28,657][setUp Thread Group 1-1] (LoadSessionSetup.java:50)   - Custom params string: ${CustomParams}

      FATAL [2017-11-20 16:45:28,657][setUp Thread Group 1-1] (LoadSessionSetup.java:78)   - Failed to set up load test session. Stopping the test run.

      java.lang.NullPointerException

              at com.tableausoftware.test.server.perfTestSuite.LoadSessionSetup.runTest(LoadSessionSetup.java:52)

              at org.apache.jmeter.protocol.java.sampler.JavaSampler.sample(JavaSampler.java:191)

              at org.apache.jmeter.threads.JMeterThread.process_sampler(JMeterThread.java:429)

              at org.apache.jmeter.threads.JMeterThread.run(JMeterThread.java:257)

              at java.lang.Thread.run(Thread.java:745)

      Tidying up ...    @ Mon Nov 20 16:45:28 JST 2017 (1511163928845)

      ... end of run

      INFO  [2017-11-20 16:45:45,830][main] (PerfRunHelper.java:193)   - Jmeter process has exited. Waiting for the other processes to exit.

      INFO  [2017-11-20 16:46:16,316][main] (PerfRunHelper.java:223)   - Waiting for processes "Windows Perf Counter Data Retriever;JMX/Zabbix Counter Data Retriever" to complete. 30 seconds have elapsed.

      INFO  [2017-11-20 16:47:16,824][main] (PerfRunHelper.java:212)   - All processes have exited.

      INFO  [2017-11-20 16:47:16,824][main] (PerfRunMonitor.java:57)   - Perfrun is completed - ending monitor thread

      INFO  [2017-11-20 16:47:17,543][Thread-3] (PerfCounterDBSender.java:72)   - Finished processing all perf counter records

      INFO  [2017-11-20 16:47:17,559][Thread-1] (JmeterResultDBSender.java:81)   - Finish processeing all Jmeter perf result samples.

      Exception in thread "main" org.postgresql.util.PSQLException: ERROR: 0 による除算が行われました

        場所: SQL文 "UPDATE test_runs

                      SET TPS_average=(

                                   totalSamples/totalseconds

                               )

                      WHERE id=runId"

      PL/pgSQL関数sp_update_test_run_stats(integer)の116行目の型SQL ステートメント

              at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2157)

              at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1886)

              at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:255)

              at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:555)

              at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:417)

              at org.postgresql.jdbc2.AbstractJdbc2Statement.executeUpdate(AbstractJdbc2Statement.java:359)

              at com.tableausoftware.test.tools.ResultProcessor.PostgresDBHelper.updateTestRunStats(PostgresDBHelper.java:240)

              at com.tableausoftware.test.tools.ResultProcessor.ResultProcessor.signalRunCompleted(ResultProcessor.java:184)

              at com.tableausoftware.test.tools.perfRunHarness.Main.runOneTest(Main.java:254)

              at com.tableausoftware.test.tools.perfRunHarness.Main.main(Main.java:140)

       

      Does anyone know what wrong is with my customized load mix?