Started by upstream project "<a href='/jenkins/job/autoplot-run-tests/' class='model-link'>autoplot-run-tests</a>" build number <a href='/jenkins/job/autoplot-run-tests/9725' class='model-link'>9725</a>
originally caused by:
 Started by upstream project "<a href='/jenkins/job/autoplot-all/' class='model-link'>autoplot-all</a>" build number <a href='/jenkins/job/autoplot-all/9682' class='model-link'>9682</a>
 originally caused by:
  Started by timer
 Started by upstream project "<a href='/jenkins/job/autoplot-all/' class='model-link'>autoplot-all</a>" build number <a href='/jenkins/job/autoplot-all/9682' class='model-link'>9682</a>
Running as SYSTEM
Building in workspace /var/local/jenkins/workspace/autoplot-test148
[autoplot-test148] $ /bin/sh -xe /usr/local/apache-tomcat-8.0.27/temp/jenkins1194055732635798588.sh
+ pwd
/var/local/jenkins/workspace/autoplot-test148
+ rm -rf Test140.java test148.txt test148_000.dep0.qds test148_000.qds test148_001.dep0.qds test148_001.qds test148_002.dep0.qds test148_002.qds test148_003.dep0.qds test148_003.qds test148_004.qds test148_005.qds test148_006.qds test148_007.dep0.qds test148_007.qds test148_008.dep0.qds test148_008.qds test148_009.qds test148_010.qds test148_011.dep0.qds test148_011.qds test148_012.dep0.qds test148_012.qds test148_013.dep0.qds test148_013.qds test148_014.dep0.qds test148_014.qds test148_015.dep0.qds test148_015.qds test148_016.dep0.qds test148_016.qds test148_017.dep0.qds test148_017.qds test148_018.dep0.qds test148_018.qds test148_019.dep0.qds test148_019.qds test148__home_jbf_ct_hudson_vap_darren_gse_extract.vap.png test148__home_jbf_ct_hudson_vap_demoUserProperties.vap.png test148__home_jbf_ct_hudson_vap_flippedAxis.vap.png test148__home_jbf_public_html_autoplot_vap_demos_americanRedstart.vap.png test148_file__home_jbf_ct_autoplot_data_cdf_bugs_20190104_psp_isois-epihi_l1-442_20181004_v1.0.0.cdf_PRIMARY_CUR.png test148_file__home_jbf_ct_hudson_data.backup_cdf_rbsp-a_HFR-spectra-burst_emfisis-Quick-Look_20170901_v1.6.3.cdf_HFR_Spectra_10_.png test148_file__home_jbf_ct_hudson_data_dat_rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt_X_Rgeo_x_Y_Rgeo_y_Z_Rgeo_z_depend0_IsoDateTime.png test148_file__home_jbf_ct_hudson_data_dat_rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt_column_Rgeo.png test148_file__home_jbf_ct_hudson_data_dat_rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt_depend0_IsoDateTime_rank2_Rgeo_x-Rgeo_z.png test148_file__home_jbf_ct_hudson_data_dat_richAscii_Tracing_20100101_4.733333.mod.txt_column_pVel.png test148_file__home_jbf_ct_hudson_data_dat_xyzScatter.dat_X_field0_Y_field1_Z_field2.png test148_file__home_jbf_ct_hudson_data_dat_xyzScatter.dat_bundle_.png test148_file__home_jbf_ct_hudson_vap_u_joe_20180905_demoMeta.vap.png test148_file_home_jbf_ct_autoplot_userlog_20170104_timeSeriesSpec.jyds_timerange_2017_Jan.png test148_file_home_jbf_ct_hudson_data.backup_cdf_rbspa__x_ect-mageis-L3__Y_m_d_v__v_sep_.cdf_FEDU_Energy_timerange_2012-12-09_2012-12-11.png test148_file_home_jbf_public_html_autoplot_data_cdf_LANL_1991_080_H0_SOPA_ESP_19920308_V01.cdf_doDep_no_Position__0__Position__2_.png test148_https_cdaweb.gsfc.nasa.gov_istp_public_data_ace_mag_level_2_cdaweb_mfi_h3__Y_ac_h3_mfi__Y_m_d_v_v.cdf_where_BGSEc__2_.gt_0__Magnitude_timerange_2018-0...0000000568220595.png test148_https_jfaden.net__jbf_autoplot_rfe_misc_20210115_fs_hidden_afile.dat.png test148_https_rbsp-ect.newmexicoconsortium.org_data_pub_rbspa_hope_level3_pitchangle__Y_rbspa__x_ect-hope-PA-L3__Y_m_d_v__v_sep_.cdf_FEDU_timerange_2012-11-01...-000001994875541.png test148_vap_datfile__home_jbf_ct_hudson_data_dat_me140101.dwn_bundle_field3-field5_time_field0_timeFormat___H_Y_2013_m_12_d_31___M__S_label_h_d_z.png
+ JAR=../autoplot-jar-all/autoplot/Autoplot/dist/AutoplotAll.jar
+ cp ../autoplot-jar-all/autoplot/Autoplot/src/test/endtoend/Test140.java .
+ cp /home/jbf/ct/hudson/test148.txt .
+ /usr/local/jdk1.8//bin/java -Xmx2G -Djava.awt.headless=true -cp ../autoplot-jar-all/autoplot/Autoplot/dist/AutoplotAll.jar test.endtoend.Test140 148 /home/jbf/ct/hudson/test148.txt
disable certificate checking
Jul 19, 2025 5:51:23 PM org.autoplot.AutoplotUtil disableCertificates
INFO: disabling HTTP certificate checks.
home (prefs): /home/tomcat
autoplot_data: /home/tomcat/autoplot_data
fscache: /home/tomcat/autoplot_data/fscache
reading logger configuration from System.getProperty("java.util.logging.config.file"): null
no config file, set java property java.util.logging.config.file like so:
-Djava.util.logging.config.file=/tmp/logging.properties

=======================
== from /home/jbf/ct/hudson/test148.txt
=======================

&gt;&gt; doHistory # this is a test of edge cases and regressions.
== 148 000  ==
uri: file:/home/jbf/ct/hudson/data.backup/cdf/rbspa_$x_ect-mageis-L3_$Y$m$d_v$(v,sep).cdf?FEDU_Energy&amp;timerange=2012-12-09/2012-12-11
Jul 19, 2025 5:51:25 PM org.das2.graph.SeriesRenderer updateFirstLast
INFO: all data removed in firstIndex/lastIndex
Jul 19, 2025 5:51:25 PM org.das2.graph.SeriesRenderer updateFirstLast
INFO: all data removed in firstIndex/lastIndex
Jul 19, 2025 5:51:25 PM org.das2.graph.SeriesRenderer updateFirstLast
INFO: all data removed in firstIndex/lastIndex
dataset: FEDU_Energy[2,25] (keV)
Jul 19, 2025 5:51:26 PM org.das2.graph.SeriesRenderer updateFirstLast
INFO: all data removed in firstIndex/lastIndex
Jul 19, 2025 5:51:26 PM org.das2.graph.SeriesRenderer updateFirstLast
INFO: all data removed in firstIndex/lastIndex
wrote to file: test148_file_home_jbf_ct_hudson_data.backup_cdf_rbspa__x_ect-mageis-L3__Y_m_d_v__v_sep_.cdf_FEDU_Energy_timerange_2012-12-09_2012-12-11.png
Read in     0.160 seconds (test148_000): file:/home/jbf/ct/hudson/data.backup/cdf/rbspa_$x_ect-mageis-L3_$Y$m$d_v$(v,sep).cdf?FEDU_Energy&amp;timerange=2012-12-09/2012-12-11
Plot in     1.064 seconds (test148_000): file:/home/jbf/ct/hudson/data.backup/cdf/rbspa_$x_ect-mageis-L3_$Y$m$d_v$(v,sep).cdf?FEDU_Energy&amp;timerange=2012-12-09/2012-12-11
== 148 001  ==
uri: <a href='file:///home/jbf/ct/hudson/data.backup/cdf/rbsp-a_HFR-spectra-burst_emfisis-Quick-Look_20170901_v1.6.3.cdf?HFR_Spectra[::10'>file:///home/jbf/ct/hudson/data.backup/cdf/rbsp-a_HFR-spectra-burst_emfisis-Quick-Look_20170901_v1.6.3.cdf?HFR_Spectra[::10</a>]
Jul 19, 2025 5:51:27 PM org.das2.graph.DasCanvas waitUntilIdle
INFO: strange bug where update event didn't clear dirty flags, reposting.
dataset: HFR_Spectra[15398,BUNDLE_1=82]
wrote to file: test148_file__home_jbf_ct_hudson_data.backup_cdf_rbsp-a_HFR-spectra-burst_emfisis-Quick-Look_20170901_v1.6.3.cdf_HFR_Spectra_10_.png
Read in     0.634 seconds (test148_001): <a href='file:///home/jbf/ct/hudson/data.backup/cdf/rbsp-a_HFR-spectra-burst_emfisis-Quick-Look_20170901_v1.6.3.cdf?HFR_Spectra[::10'>file:///home/jbf/ct/hudson/data.backup/cdf/rbsp-a_HFR-spectra-burst_emfisis-Quick-Look_20170901_v1.6.3.cdf?HFR_Spectra[::10</a>]
Plot in     1.704 seconds (test148_001): <a href='file:///home/jbf/ct/hudson/data.backup/cdf/rbsp-a_HFR-spectra-burst_emfisis-Quick-Look_20170901_v1.6.3.cdf?HFR_Spectra[::10'>file:///home/jbf/ct/hudson/data.backup/cdf/rbsp-a_HFR-spectra-burst_emfisis-Quick-Look_20170901_v1.6.3.cdf?HFR_Spectra[::10</a>]
== 148 002  ==
uri: <a href='https://rbsp-ect.newmexicoconsortium.org/data_pub/rbspa/hope/level3/pitchangle/$Y/rbspa_$x_ect-hope-PA-L3_$Y$m$d_v$(v,sep).cdf?FEDU&timerange=2012-11-01+04:55+to+2012-11-02+06:10'>https://rbsp-ect.newmexicoconsortium.org/data_pub/rbspa/hope/level3/pitchangle/$Y/rbspa_$x_ect-hope-PA-L3_$Y$m$d_v$(v,sep).cdf?FEDU&amp;timerange=2012-11-01+04:55+to+2012-11-02+06:10</a>
dataset: dataset[DEPEND_0=2,3548*,11*,72*] (s!E-1!Ncm!E-2!Nster!E-1!NkeV!E-1!N)
wrote to file: test148_https_rbsp-ect.newmexicoconsortium.org_data_pub_rbspa_hope_level3_pitchangle__Y_rbspa__x_ect-hope-PA-L3__Y_m_d_v__v_sep_.cdf_FEDU_timerange_2012-11-01...-000001994875541.png
Read in     1.235 seconds (test148_002): <a href='https://rbsp-ect.newmexicoconsortium.org/data_pub/rbspa/hope/level3/pitchangle/$Y/rbspa_$x_ect-hope-PA-L3_$Y$m$d_v$(v,sep).cdf?FEDU&timerange=2012-11-01+04:55+to+2012-11-02+06:10'>https://rbsp-ect.newmexicoconsortium.org/data_pub/rbspa/hope/level3/pitchangle/$Y/rbspa_$x_ect-hope-PA-L3_$Y$m$d_v$(v,sep).cdf?FEDU&amp;timerange=2012-11-01+04:55+to+2012-11-02+06:10</a>
Plot in     3.846 seconds (test148_002): <a href='https://rbsp-ect.newmexicoconsortium.org/data_pub/rbspa/hope/level3/pitchangle/$Y/rbspa_$x_ect-hope-PA-L3_$Y$m$d_v$(v,sep).cdf?FEDU&timerange=2012-11-01+04:55+to+2012-11-02+06:10'>https://rbsp-ect.newmexicoconsortium.org/data_pub/rbspa/hope/level3/pitchangle/$Y/rbspa_$x_ect-hope-PA-L3_$Y$m$d_v$(v,sep).cdf?FEDU&amp;timerange=2012-11-01+04:55+to+2012-11-02+06:10</a>
== 148 003  ==
uri: file:/home/jbf/ct/autoplot/userlog/20170104/timeSeriesSpec.jyds?timerange=2017+Jan
2017-01-01
2017-01-02
2017-01-03
2017-01-04
2017-01-05
2017-01-06
2017-01-07
2017-01-08
before uniq:  field4[field5=17] (dimensionless) field2[DEPEND_0=17] (events(ordinal))
after uniq:  field4[field5=11] (dimensionless) field2[DEPEND_0=11] (events(ordinal))
2017-01-08 11.0
2017-01-09
before uniq:  field4[field5=52] (dimensionless) field2[DEPEND_0=52] (events(ordinal))
after uniq:  field4[field5=39] (dimensionless) field2[DEPEND_0=39] (events(ordinal))
2017-01-09 39.0
2017-01-10
before uniq:  field4[field5=53] (dimensionless) field2[DEPEND_0=53] (events(ordinal))
after uniq:  field4[field5=40] (dimensionless) field2[DEPEND_0=40] (events(ordinal))
2017-01-10 40.0
2017-01-11
Jul 19, 2025 5:51:34 PM org.das2.qds.DataSetUtil validate
INFO: validate finds BINS_1 is min,max and min is greater than max, but not marking this as invalid.
before uniq:  field4[field5=54] (dimensionless) field2[DEPEND_0=54] (events(ordinal))
after uniq:  field4[field5=39] (dimensionless) field2[DEPEND_0=39] (events(ordinal))
2017-01-11 39.0
2017-01-12
before uniq:  field4[field5=46] (dimensionless) field2[DEPEND_0=46] (events(ordinal))
after uniq:  field4[field5=38] (dimensionless) field2[DEPEND_0=38] (events(ordinal))
2017-01-12 38.0
2017-01-13
before uniq:  field4[field5=65] (dimensionless) field2[DEPEND_0=65] (events(ordinal))
after uniq:  field4[field5=47] (dimensionless) field2[DEPEND_0=47] (events(ordinal))
2017-01-13 47.0
2017-01-14
before uniq:  field4[field5=33] (dimensionless) field2[DEPEND_0=33] (events(ordinal))
after uniq:  field4[field5=21] (dimensionless) field2[DEPEND_0=21] (events(ordinal))
2017-01-14 21.0
2017-01-15
before uniq:  field4[field5=23] (dimensionless) field2[DEPEND_0=23] (events(ordinal))
after uniq:  field4[field5=16] (dimensionless) field2[DEPEND_0=16] (events(ordinal))
2017-01-15 16.0
2017-01-16
before uniq:  field4[field5=43] (dimensionless) field2[DEPEND_0=43] (events(ordinal))
after uniq:  field4[field5=34] (dimensionless) field2[DEPEND_0=34] (events(ordinal))
2017-01-16 34.0
2017-01-17
Jul 19, 2025 5:51:34 PM org.das2.qds.DataSetUtil validate
INFO: validate finds BINS_1 is min,max and min is greater than max, but not marking this as invalid.
before uniq:  field4[field5=56] (dimensionless) field2[DEPEND_0=56] (events(ordinal))
after uniq:  field4[field5=41] (dimensionless) field2[DEPEND_0=41] (events(ordinal))
2017-01-17 41.0
2017-01-18
before uniq:  field4[field5=39] (dimensionless) field2[DEPEND_0=39] (events(ordinal))
after uniq:  field4[field5=30] (dimensionless) field2[DEPEND_0=30] (events(ordinal))
2017-01-18 30.0
2017-01-19
Jul 19, 2025 5:51:35 PM org.das2.qds.DataSetUtil validate
INFO: validate finds BINS_1 is min,max and min is greater than max, but not marking this as invalid.
before uniq:  field4[field5=59] (dimensionless) field2[DEPEND_0=59] (events(ordinal))
after uniq:  field4[field5=41] (dimensionless) field2[DEPEND_0=41] (events(ordinal))
2017-01-19 41.0
2017-01-20
before uniq:  field4[field5=44] (dimensionless) field2[DEPEND_0=44] (events(ordinal))
after uniq:  field4[field5=35] (dimensionless) field2[DEPEND_0=35] (events(ordinal))
2017-01-20 35.0
2017-01-21
Jul 19, 2025 5:51:35 PM org.autoplot.datasource.jython.JythonDataSource getDataSet
WARNING: Traceback (innermost last):
  File "uniqUsers.jyds", line 5, in ?
java.lang.IllegalArgumentException: File is empty: /home/jbf/ct/autoplot/userlog/20170104/logs/20170121.log.txt
	at org.das2.qds.util.AsciiParser.guessSkipAndDelimParser(AsciiParser.java:367)
	at org.autoplot.ascii.AsciiTableDataSource.doReadFile(AsciiTableDataSource.java:740)
	at org.autoplot.ascii.AsciiTableDataSource.getDataSet(AsciiTableDataSource.java:225)
	at org.autoplot.aggregator.AggregatingDataSource.getDataSet(AggregatingDataSource.java:542)
	at org.autoplot.aggregator.AggregatingDataSource.getDataSet(AggregatingDataSource.java:372)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:215)
	at org.autoplot.jythonsupport.GetDataSetCommand.__call__(GetDataSetCommand.java:205)
	at org.python.core.PyObject.__call__(PyObject.java:495)
	at org.python.pycode._pyx135.f$0(uniqUsers.jyds:5)
	at org.python.pycode._pyx135.call_function(uniqUsers.jyds)
	at org.python.core.PyTableCode.call(PyTableCode.java:217)
	at org.python.core.PyCode.call(PyCode.java:14)
	at org.python.core.Py.runCode(Py.java:1224)
	at org.python.util.PythonInterpreter.execfile(PythonInterpreter.java:165)
	at org.autoplot.datasource.jython.JythonDataSource.getDataSet(JythonDataSource.java:316)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:215)
	at org.autoplot.jythonsupport.GetDataSetCommand.__call__(GetDataSetCommand.java:205)
	at org.python.core.PyObject.__call__(PyObject.java:495)
	at org.python.pycode._pyx4.f$0(timeSeriesSpec.jyds:10)
	at org.python.pycode._pyx4.call_function(timeSeriesSpec.jyds)
	at org.python.core.PyTableCode.call(PyTableCode.java:217)
	at org.python.core.PyCode.call(PyCode.java:14)
	at org.python.core.Py.runCode(Py.java:1224)
	at org.python.util.PythonInterpreter.execfile(PythonInterpreter.java:165)
	at org.autoplot.datasource.jython.JythonDataSource.getDataSet(JythonDataSource.java:316)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:278)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:557)
	at test.endtoend.Test140.do1(Test140.java:177)
	at test.endtoend.Test140.doHistory(Test140.java:456)
	at test.endtoend.Test140.main(Test140.java:530)

java.lang.IllegalArgumentException: java.lang.IllegalArgumentException: File is empty: /home/jbf/ct/autoplot/userlog/20170104/logs/20170121.log.txt

2017-01-22
before uniq:  field4[field5=14] (dimensionless) field2[DEPEND_0=14] (events(ordinal))
after uniq:  field4[field5=10] (dimensionless) field2[DEPEND_0=10] (events(ordinal))
2017-01-22 10.0
2017-01-23
before uniq:  field4[field5=53] (dimensionless) field2[DEPEND_0=53] (events(ordinal))
after uniq:  field4[field5=37] (dimensionless) field2[DEPEND_0=37] (events(ordinal))
2017-01-23 37.0
2017-01-24
before uniq:  field4[field5=54] (dimensionless) field2[DEPEND_0=54] (events(ordinal))
after uniq:  field4[field5=42] (dimensionless) field2[DEPEND_0=42] (events(ordinal))
2017-01-24 42.0
2017-01-25
Jul 19, 2025 5:51:36 PM org.das2.qds.DataSetUtil validate
INFO: validate finds BINS_1 is min,max and min is greater than max, but not marking this as invalid.
before uniq:  field4[field5=12] (dimensionless) field2[DEPEND_0=12] (events(ordinal))
after uniq:  field4[field5=8] (dimensionless) field2[DEPEND_0=8] (events(ordinal))
2017-01-25 8.0
2017-01-26
Jul 19, 2025 5:51:36 PM org.autoplot.datasource.jython.JythonDataSource getDataSet
WARNING: Traceback (innermost last):
  File "uniqUsers.jyds", line 5, in ?
java.lang.IllegalArgumentException: File is empty: /home/jbf/ct/autoplot/userlog/20170104/logs/20170126.log.txt
	at org.das2.qds.util.AsciiParser.guessSkipAndDelimParser(AsciiParser.java:367)
	at org.autoplot.ascii.AsciiTableDataSource.doReadFile(AsciiTableDataSource.java:740)
	at org.autoplot.ascii.AsciiTableDataSource.getDataSet(AsciiTableDataSource.java:225)
	at org.autoplot.aggregator.AggregatingDataSource.getDataSet(AggregatingDataSource.java:542)
	at org.autoplot.aggregator.AggregatingDataSource.getDataSet(AggregatingDataSource.java:372)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:215)
	at org.autoplot.jythonsupport.GetDataSetCommand.__call__(GetDataSetCommand.java:205)
	at org.python.core.PyObject.__call__(PyObject.java:495)
	at org.python.pycode._pyx170.f$0(uniqUsers.jyds:5)
	at org.python.pycode._pyx170.call_function(uniqUsers.jyds)
	at org.python.core.PyTableCode.call(PyTableCode.java:217)
	at org.python.core.PyCode.call(PyCode.java:14)
	at org.python.core.Py.runCode(Py.java:1224)
	at org.python.util.PythonInterpreter.execfile(PythonInterpreter.java:165)
	at org.autoplot.datasource.jython.JythonDataSource.getDataSet(JythonDataSource.java:316)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:215)
	at org.autoplot.jythonsupport.GetDataSetCommand.__call__(GetDataSetCommand.java:205)
	at org.python.core.PyObject.__call__(PyObject.java:495)
	at org.python.pycode._pyx4.f$0(timeSeriesSpec.jyds:10)
	at org.python.pycode._pyx4.call_function(timeSeriesSpec.jyds)
	at org.python.core.PyTableCode.call(PyTableCode.java:217)
	at org.python.core.PyCode.call(PyCode.java:14)
	at org.python.core.Py.runCode(Py.java:1224)
	at org.python.util.PythonInterpreter.execfile(PythonInterpreter.java:165)
	at org.autoplot.datasource.jython.JythonDataSource.getDataSet(JythonDataSource.java:316)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:278)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:557)
	at test.endtoend.Test140.do1(Test140.java:177)
	at test.endtoend.Test140.doHistory(Test140.java:456)
	at test.endtoend.Test140.main(Test140.java:530)

java.lang.IllegalArgumentException: java.lang.IllegalArgumentException: File is empty: /home/jbf/ct/autoplot/userlog/20170104/logs/20170126.log.txt

2017-01-27
Jul 19, 2025 5:51:36 PM org.autoplot.datasource.jython.JythonDataSource getDataSet
WARNING: Traceback (innermost last):
  File "uniqUsers.jyds", line 5, in ?
java.lang.IllegalArgumentException: File is empty: /home/jbf/ct/autoplot/userlog/20170104/logs/20170127.log.txt
	at org.das2.qds.util.AsciiParser.guessSkipAndDelimParser(AsciiParser.java:367)
	at org.autoplot.ascii.AsciiTableDataSource.doReadFile(AsciiTableDataSource.java:740)
	at org.autoplot.ascii.AsciiTableDataSource.getDataSet(AsciiTableDataSource.java:225)
	at org.autoplot.aggregator.AggregatingDataSource.getDataSet(AggregatingDataSource.java:542)
	at org.autoplot.aggregator.AggregatingDataSource.getDataSet(AggregatingDataSource.java:372)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:215)
	at org.autoplot.jythonsupport.GetDataSetCommand.__call__(GetDataSetCommand.java:205)
	at org.python.core.PyObject.__call__(PyObject.java:495)
	at org.python.pycode._pyx177.f$0(uniqUsers.jyds:5)
	at org.python.pycode._pyx177.call_function(uniqUsers.jyds)
	at org.python.core.PyTableCode.call(PyTableCode.java:217)
	at org.python.core.PyCode.call(PyCode.java:14)
	at org.python.core.Py.runCode(Py.java:1224)
	at org.python.util.PythonInterpreter.execfile(PythonInterpreter.java:165)
	at org.autoplot.datasource.jython.JythonDataSource.getDataSet(JythonDataSource.java:316)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:215)
	at org.autoplot.jythonsupport.GetDataSetCommand.__call__(GetDataSetCommand.java:205)
	at org.python.core.PyObject.__call__(PyObject.java:495)
	at org.python.pycode._pyx4.f$0(timeSeriesSpec.jyds:10)
	at org.python.pycode._pyx4.call_function(timeSeriesSpec.jyds)
	at org.python.core.PyTableCode.call(PyTableCode.java:217)
	at org.python.core.PyCode.call(PyCode.java:14)
	at org.python.core.Py.runCode(Py.java:1224)
	at org.python.util.PythonInterpreter.execfile(PythonInterpreter.java:165)
	at org.autoplot.datasource.jython.JythonDataSource.getDataSet(JythonDataSource.java:316)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:278)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:557)
	at test.endtoend.Test140.do1(Test140.java:177)
	at test.endtoend.Test140.doHistory(Test140.java:456)
	at test.endtoend.Test140.main(Test140.java:530)

java.lang.IllegalArgumentException: java.lang.IllegalArgumentException: File is empty: /home/jbf/ct/autoplot/userlog/20170104/logs/20170127.log.txt

2017-01-28
Jul 19, 2025 5:51:36 PM org.autoplot.datasource.jython.JythonDataSource getDataSet
WARNING: Traceback (innermost last):
  File "uniqUsers.jyds", line 5, in ?
java.lang.IllegalArgumentException: File is empty: /home/jbf/ct/autoplot/userlog/20170104/logs/20170128.log.txt
	at org.das2.qds.util.AsciiParser.guessSkipAndDelimParser(AsciiParser.java:367)
	at org.autoplot.ascii.AsciiTableDataSource.doReadFile(AsciiTableDataSource.java:740)
	at org.autoplot.ascii.AsciiTableDataSource.getDataSet(AsciiTableDataSource.java:225)
	at org.autoplot.aggregator.AggregatingDataSource.getDataSet(AggregatingDataSource.java:542)
	at org.autoplot.aggregator.AggregatingDataSource.getDataSet(AggregatingDataSource.java:372)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:215)
	at org.autoplot.jythonsupport.GetDataSetCommand.__call__(GetDataSetCommand.java:205)
	at org.python.core.PyObject.__call__(PyObject.java:495)
	at org.python.pycode._pyx184.f$0(uniqUsers.jyds:5)
	at org.python.pycode._pyx184.call_function(uniqUsers.jyds)
	at org.python.core.PyTableCode.call(PyTableCode.java:217)
	at org.python.core.PyCode.call(PyCode.java:14)
	at org.python.core.Py.runCode(Py.java:1224)
	at org.python.util.PythonInterpreter.execfile(PythonInterpreter.java:165)
	at org.autoplot.datasource.jython.JythonDataSource.getDataSet(JythonDataSource.java:316)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:215)
	at org.autoplot.jythonsupport.GetDataSetCommand.__call__(GetDataSetCommand.java:205)
	at org.python.core.PyObject.__call__(PyObject.java:495)
	at org.python.pycode._pyx4.f$0(timeSeriesSpec.jyds:10)
	at org.python.pycode._pyx4.call_function(timeSeriesSpec.jyds)
	at org.python.core.PyTableCode.call(PyTableCode.java:217)
	at org.python.core.PyCode.call(PyCode.java:14)
	at org.python.core.Py.runCode(Py.java:1224)
	at org.python.util.PythonInterpreter.execfile(PythonInterpreter.java:165)
	at org.autoplot.datasource.jython.JythonDataSource.getDataSet(JythonDataSource.java:316)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:278)
	at org.autoplot.jythonsupport.Util.getDataSet(Util.java:557)
	at test.endtoend.Test140.do1(Test140.java:177)
	at test.endtoend.Test140.doHistory(Test140.java:456)
	at test.endtoend.Test140.main(Test140.java:530)

java.lang.IllegalArgumentException: java.lang.IllegalArgumentException: File is empty: /home/jbf/ct/autoplot/userlog/20170104/logs/20170128.log.txt

2017-01-29
before uniq:  field4[field5=18] (dimensionless) field2[DEPEND_0=18] (events(ordinal))
after uniq:  field4[field5=14] (dimensionless) field2[DEPEND_0=14] (events(ordinal))
2017-01-29 14.0
2017-01-30
before uniq:  field4[field5=45] (dimensionless) field2[DEPEND_0=45] (events(ordinal))
after uniq:  field4[field5=34] (dimensionless) field2[DEPEND_0=34] (events(ordinal))
2017-01-30 34.0
2017-01-31
before uniq:  field4[field5=38] (dimensionless) field2[DEPEND_0=38] (events(ordinal))
after uniq:  field4[field5=27] (dimensionless) field2[DEPEND_0=27] (events(ordinal))
2017-01-31 27.0
dataset[20,BUNDLE_1=2]
Jul 19, 2025 5:51:37 PM org.das2.graph.DasCanvas waitUntilIdle
INFO: strange bug where update event didn't clear dirty flags, reposting.
dataset: dataset[UTC=20] (dimensionless)
wrote to file: test148_file_home_jbf_ct_autoplot_userlog_20170104_timeSeriesSpec.jyds_timerange_2017_Jan.png
Read in     4.815 seconds (test148_003): file:/home/jbf/ct/autoplot/userlog/20170104/timeSeriesSpec.jyds?timerange=2017+Jan
Plot in     5.540 seconds (test148_003): file:/home/jbf/ct/autoplot/userlog/20170104/timeSeriesSpec.jyds?timerange=2017+Jan
== 148 004  ==
uri: /home/jbf/ct/hudson/vap/demoUserProperties.vap
  data_0: vap+jyds:file:/home/jbf/ct/hudson/jyds/demoRfe426.jyds
  data_1: vap+jyds:file:/home/jbf/ct/hudson/jyds/demoRfe426.jyds
  timerange: 2014-12-31 22:00 to 2015-01-02 18:00
Jul 19, 2025 5:51:38 PM org.das2.graph.DasCanvas waitUntilIdle
INFO: strange bug where update event didn't clear dirty flags, reposting.
Jul 19, 2025 5:51:38 PM org.das2.graph.DasCanvas waitUntilIdle
INFO: strange bug where update event didn't clear dirty flags, reposting.
dataset: dataset[DEPEND_0=2514,DEPEND_1=20] (dimensionless)
wrote to file: test148__home_jbf_ct_hudson_vap_demoUserProperties.vap.png
Read in     1.172 seconds (test148_004): /home/jbf/ct/hudson/vap/demoUserProperties.vap
Plot in     1.183 seconds (test148_004): /home/jbf/ct/hudson/vap/demoUserProperties.vap
== 148 005  ==
uri: <a href='file:///home/jbf/ct/hudson/vap/u/joe/20180905/demoMeta.vap'>file:///home/jbf/ct/hudson/vap/u/joe/20180905/demoMeta.vap</a>
  data_0: vap+nc:file:/home/jbf/ct/autoplot/u/2018/joef/20180905/oe_m1m_dscovr_s20180212000000_e20180212235959_p20180213023914_pub.nc?bt
  timerange: 2018-02-11 23:00 to 2018-02-13 01:00
SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
SLF4J: Defaulting to no-operation (NOP) logger implementation
SLF4J: See <a href='http://www.slf4j.org/codes.html#StaticLoggerBinder'>http://www.slf4j.org/codes.html#StaticLoggerBinder</a> for further details.
Jul 19, 2025 5:51:39 PM org.das2.graph.DasCanvas waitUntilIdle
INFO: strange bug where update event didn't clear dirty flags, reposting.
dataset: bt[time=1440] (nT)
wrote to file: test148_file__home_jbf_ct_hudson_vap_u_joe_20180905_demoMeta.vap.png
Read in     0.922 seconds (test148_005): <a href='file:///home/jbf/ct/hudson/vap/u/joe/20180905/demoMeta.vap'>file:///home/jbf/ct/hudson/vap/u/joe/20180905/demoMeta.vap</a>
Plot in     0.933 seconds (test148_005): <a href='file:///home/jbf/ct/hudson/vap/u/joe/20180905/demoMeta.vap'>file:///home/jbf/ct/hudson/vap/u/joe/20180905/demoMeta.vap</a>
== 148 006  ==
uri: /home/jbf/public_html/autoplot/vap/demos/americanRedstart.vap
  data_0: vap+wav:<a href='file:///home/jbf/fun/2018/birds/americanRedstart.wav'>file:///home/jbf/fun/2018/birds/americanRedstart.wav</a>
  data_1: vap+wav:<a href='file:///home/jbf/fun/2018/birds/americanRedstart.wav'>file:///home/jbf/fun/2018/birds/americanRedstart.wav</a>
  timerange: 2010-01-01
dataset: dataset[DEPEND_0=1122839] (dimensionless)
wrote to file: test148__home_jbf_public_html_autoplot_vap_demos_americanRedstart.vap.png
Read in     3.846 seconds (test148_006): /home/jbf/public_html/autoplot/vap/demos/americanRedstart.vap
Plot in     3.955 seconds (test148_006): /home/jbf/public_html/autoplot/vap/demos/americanRedstart.vap
== 148 007  ==
uri: <a href='file:///home/jbf/ct/autoplot/data/cdf/bugs/20190104/psp_isois-epihi_l1-442_20181004_v1.0.0.cdf?PRIMARY_CUR'>file:///home/jbf/ct/autoplot/data/cdf/bugs/20190104/psp_isois-epihi_l1-442_20181004_v1.0.0.cdf?PRIMARY_CUR</a>
dataset: PRIMARY_CUR[1] (A)
wrote to file: test148_file__home_jbf_ct_autoplot_data_cdf_bugs_20190104_psp_isois-epihi_l1-442_20181004_v1.0.0.cdf_PRIMARY_CUR.png
Read in     0.013 seconds (test148_007): <a href='file:///home/jbf/ct/autoplot/data/cdf/bugs/20190104/psp_isois-epihi_l1-442_20181004_v1.0.0.cdf?PRIMARY_CUR'>file:///home/jbf/ct/autoplot/data/cdf/bugs/20190104/psp_isois-epihi_l1-442_20181004_v1.0.0.cdf?PRIMARY_CUR</a>
Plot in     0.343 seconds (test148_007): <a href='file:///home/jbf/ct/autoplot/data/cdf/bugs/20190104/psp_isois-epihi_l1-442_20181004_v1.0.0.cdf?PRIMARY_CUR'>file:///home/jbf/ct/autoplot/data/cdf/bugs/20190104/psp_isois-epihi_l1-442_20181004_v1.0.0.cdf?PRIMARY_CUR</a>
== 148 008  ==
uri: <a href='https://cdaweb.gsfc.nasa.gov/istp_public/data/ace/mag/level_2_cdaweb/mfi_h3/$Y/ac_h3_mfi_$Y$m$d_v$v.cdf?where=BGSEc[:,2].gt(0)&Magnitude&timerange=2018-01-01'>https://cdaweb.gsfc.nasa.gov/istp_public/data/ace/mag/level_2_cdaweb/mfi_h3/$Y/ac_h3_mfi_$Y$m$d_v$v.cdf?where=BGSEc[:,2].gt(0)&amp;Magnitude&amp;timerange=2018-01-01</a>
Jul 19, 2025 5:51:45 PM org.das2.graph.DasCanvas waitUntilIdle
INFO: strange bug where update event didn't clear dirty flags, reposting.
dataset: Magnitude[33066] (nT)
wrote to file: test148_https_cdaweb.gsfc.nasa.gov_istp_public_data_ace_mag_level_2_cdaweb_mfi_h3__Y_ac_h3_mfi__Y_m_d_v_v.cdf_where_BGSEc__2_.gt_0__Magnitude_timerange_2018-0...0000000568220595.png
Read in     0.738 seconds (test148_008): <a href='https://cdaweb.gsfc.nasa.gov/istp_public/data/ace/mag/level_2_cdaweb/mfi_h3/$Y/ac_h3_mfi_$Y$m$d_v$v.cdf?where=BGSEc[:,2].gt(0)&Magnitude&timerange=2018-01-01'>https://cdaweb.gsfc.nasa.gov/istp_public/data/ace/mag/level_2_cdaweb/mfi_h3/$Y/ac_h3_mfi_$Y$m$d_v$v.cdf?where=BGSEc[:,2].gt(0)&amp;Magnitude&amp;timerange=2018-01-01</a>
Plot in     1.300 seconds (test148_008): <a href='https://cdaweb.gsfc.nasa.gov/istp_public/data/ace/mag/level_2_cdaweb/mfi_h3/$Y/ac_h3_mfi_$Y$m$d_v$v.cdf?where=BGSEc[:,2].gt(0)&Magnitude&timerange=2018-01-01'>https://cdaweb.gsfc.nasa.gov/istp_public/data/ace/mag/level_2_cdaweb/mfi_h3/$Y/ac_h3_mfi_$Y$m$d_v$v.cdf?where=BGSEc[:,2].gt(0)&amp;Magnitude&amp;timerange=2018-01-01</a>
== 148 009  ==
uri: /home/jbf/ct/hudson/vap/flippedAxis.vap
  data_0: vap+cdf:<a href='http://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/$Y/po_h0_hyd_$Y$m$d_v$v.cdf?ELECTRON_DIFFERENTIAL_ENERGY_FLUX&timerange=2000-02-06'>http://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/$Y/po_h0_hyd_$Y$m$d_v$v.cdf?ELECTRON_DIFFERENTIAL_ENERGY_FLUX&amp;timerange=2000-02-06</a>
  data_1: vap+cdf:<a href='http://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/$Y/po_h0_hyd_$Y$m$d_v$v.cdf?ION_DIFFERENTIAL_ENERGY_FLUX&timerange=2000-02-06'>http://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/$Y/po_h0_hyd_$Y$m$d_v$v.cdf?ION_DIFFERENTIAL_ENERGY_FLUX&amp;timerange=2000-02-06</a>
  timerange: 2000-02-07 12:00 to 24:00
Jul 19, 2025 5:51:46 PM org.das2.util.filesystem.HttpUtil checkRedirect
INFO: URL <a href='http://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/'>http://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/</a> permanently moved to <a href='https://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/'>https://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/</a>
Jul 19, 2025 5:51:46 PM org.das2.util.filesystem.HttpUtil checkRedirect
INFO: URL <a href='http://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/2000/'>http://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/2000/</a> permanently moved to <a href='https://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/2000/'>https://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/2000/</a>
Jul 19, 2025 5:51:46 PM org.das2.util.filesystem.HttpUtil checkRedirect
INFO: URL <a href='http://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/2000/po_h0_hyd_20000207_v01.cdf'>http://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/2000/po_h0_hyd_20000207_v01.cdf</a> permanently moved to <a href='https://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/2000/po_h0_hyd_20000207_v01.cdf'>https://cdaweb.gsfc.nasa.gov/istp_public/data/polar/hydra/hyd_h0/2000/po_h0_hyd_20000207_v01.cdf</a>
Jul 19, 2025 5:51:47 PM org.autoplot.dom.DataSourceController loadDataSet
INFO: resetting autorange=T because dataset is not time series: ELECTRON_DIFFERENTIAL_ENERGY_FLUX[6260,29] (1/(cm^2-s-sr))
Jul 19, 2025 5:51:47 PM org.autoplot.dom.DataSourceController loadDataSet
INFO: resetting autorange=T because dataset is not time series: ION_DIFFERENTIAL_ENERGY_FLUX[6260,29] (1/(cm^2-s-sr))
dataset: ELECTRON_DIFFERENTIAL_ENERGY_FLUX[6260,29] (1/(cm^2-s-sr))
wrote to file: test148__home_jbf_ct_hudson_vap_flippedAxis.vap.png
Read in     1.000 seconds (test148_009): /home/jbf/ct/hudson/vap/flippedAxis.vap
Plot in     1.021 seconds (test148_009): /home/jbf/ct/hudson/vap/flippedAxis.vap
== 148 010  ==
uri: /home/jbf/ct/hudson/vap/darren/gse_extract.vap
  data_0: vap+txt:<a href='file:///home/jbf/ct/hudson/data.backup/dat/GSE_extract.txt?bundle=X-Z&time=year&timeFormat=$Y+$m+$d+$H+$M+$S+$(milli'>file:///home/jbf/ct/hudson/data.backup/dat/GSE_extract.txt?bundle=X-Z&amp;time=year&amp;timeFormat=$Y+$m+$d+$H+$M+$S+$(milli</a>)
  data_1: vap+txt:<a href='file:///home/jbf/ct/hudson/data.backup/dat/GSE_extract.txt?bundle=Bx-Bz&time=year&timeFormat=$Y+$m+$d+$H+$M+$S+$(milli'>file:///home/jbf/ct/hudson/data.backup/dat/GSE_extract.txt?bundle=Bx-Bz&amp;time=year&amp;timeFormat=$Y+$m+$d+$H+$M+$S+$(milli</a>)
  timerange: 2012-03-08 08:00 to 2012-03-09 10:00
dataset: dataset[msc=17281,BUNDLE_1=3] ()
wrote to file: test148__home_jbf_ct_hudson_vap_darren_gse_extract.vap.png
Read in     1.345 seconds (test148_010): /home/jbf/ct/hudson/vap/darren/gse_extract.vap
Plot in     1.362 seconds (test148_010): /home/jbf/ct/hudson/vap/darren/gse_extract.vap
== 148 011  ==
uri: vap+dat:<a href='file:///home/jbf/ct/hudson/data/dat/me140101.dwn?bundle=field3-field5&time=field0&timeFormat=$(H,Y=2013,m=12,d=31)+$M+$S&label=h,d,z'>file:///home/jbf/ct/hudson/data/dat/me140101.dwn?bundle=field3-field5&amp;time=field0&amp;timeFormat=$(H,Y=2013,m=12,d=31)+$M+$S&amp;label=h,d,z</a>
dataset: dataset[field2=82029,BUNDLE_1=3] ()
wrote to file: test148_vap_datfile__home_jbf_ct_hudson_data_dat_me140101.dwn_bundle_field3-field5_time_field0_timeFormat___H_Y_2013_m_12_d_31___M__S_label_h_d_z.png
Read in     0.531 seconds (test148_011): vap+dat:<a href='file:///home/jbf/ct/hudson/data/dat/me140101.dwn?bundle=field3-field5&time=field0&timeFormat=$(H,Y=2013,m=12,d=31)+$M+$S&label=h,d,z'>file:///home/jbf/ct/hudson/data/dat/me140101.dwn?bundle=field3-field5&amp;time=field0&amp;timeFormat=$(H,Y=2013,m=12,d=31)+$M+$S&amp;label=h,d,z</a>
Plot in     1.028 seconds (test148_011): vap+dat:<a href='file:///home/jbf/ct/hudson/data/dat/me140101.dwn?bundle=field3-field5&time=field0&timeFormat=$(H,Y=2013,m=12,d=31)+$M+$S&label=h,d,z'>file:///home/jbf/ct/hudson/data/dat/me140101.dwn?bundle=field3-field5&amp;time=field0&amp;timeFormat=$(H,Y=2013,m=12,d=31)+$M+$S&amp;label=h,d,z</a>
== 148 012  ==
uri: <a href='file:///home/jbf/ct/hudson/data/dat/richAscii/Tracing_20100101_4.733333.mod.txt?column=pVel'>file:///home/jbf/ct/hudson/data/dat/richAscii/Tracing_20100101_4.733333.mod.txt?column=pVel</a>
dataset: pVel[424,BUNDLE_1=3]
wrote to file: test148_file__home_jbf_ct_hudson_data_dat_richAscii_Tracing_20100101_4.733333.mod.txt_column_pVel.png
Read in     0.018 seconds (test148_012): <a href='file:///home/jbf/ct/hudson/data/dat/richAscii/Tracing_20100101_4.733333.mod.txt?column=pVel'>file:///home/jbf/ct/hudson/data/dat/richAscii/Tracing_20100101_4.733333.mod.txt?column=pVel</a>
Plot in     0.255 seconds (test148_012): <a href='file:///home/jbf/ct/hudson/data/dat/richAscii/Tracing_20100101_4.733333.mod.txt?column=pVel'>file:///home/jbf/ct/hudson/data/dat/richAscii/Tracing_20100101_4.733333.mod.txt?column=pVel</a>
== 148 013  ==
uri: <a href='file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?X=field0&Y=field1&Z=field2'>file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?X=field0&amp;Y=field1&amp;Z=field2</a>
dataset: dataset[2000,BUNDLE_1=3] ()
wrote to file: test148_file__home_jbf_ct_hudson_data_dat_xyzScatter.dat_X_field0_Y_field1_Z_field2.png
Read in     0.023 seconds (test148_013): <a href='file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?X=field0&Y=field1&Z=field2'>file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?X=field0&amp;Y=field1&amp;Z=field2</a>
Plot in     0.281 seconds (test148_013): <a href='file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?X=field0&Y=field1&Z=field2'>file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?X=field0&amp;Y=field1&amp;Z=field2</a>
== 148 014  ==
uri: <a href='file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?bundle'>file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?bundle</a>=:
dataset: dataset[2000,BUNDLE_1=3] ()
wrote to file: test148_file__home_jbf_ct_hudson_data_dat_xyzScatter.dat_bundle_.png
Read in     0.014 seconds (test148_014): <a href='file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?bundle'>file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?bundle</a>=:
Plot in     0.264 seconds (test148_014): <a href='file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?bundle'>file:///home/jbf/ct/hudson/data/dat/xyzScatter.dat?bundle</a>=:
== 148 015  ==
uri: <a href='file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?column=Rgeo'>file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?column=Rgeo</a>
Jul 19, 2025 5:51:52 PM org.das2.graph.DasCanvas waitUntilIdle
INFO: strange bug where update event didn't clear dirty flags, reposting.
Jul 19, 2025 5:51:53 PM org.das2.graph.DasCanvas waitUntilIdle
INFO: strange bug where update event didn't clear dirty flags, reposting.
dataset: Rgeo[IsoDat...=1441,BUNDLE_1=3] (R!BE!N)
wrote to file: test148_file__home_jbf_ct_hudson_data_dat_rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt_column_Rgeo.png
Read in     0.812 seconds (test148_015): <a href='file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?column=Rgeo'>file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?column=Rgeo</a>
Plot in     1.919 seconds (test148_015): <a href='file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?column=Rgeo'>file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?column=Rgeo</a>
== 148 016  ==
uri: <a href='file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?depend0=IsoDateTime&rank2=Rgeo_x-Rgeo_z'>file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?depend0=IsoDateTime&amp;rank2=Rgeo_x-Rgeo_z</a>
Jul 19, 2025 5:51:54 PM org.das2.graph.DasCanvas waitUntilIdle
INFO: strange bug where update event didn't clear dirty flags, reposting.
dataset: dataset[IsoDat...=1441,BUNDLE_1=3] (R!BE!N)
wrote to file: test148_file__home_jbf_ct_hudson_data_dat_rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt_depend0_IsoDateTime_rank2_Rgeo_x-Rgeo_z.png
Read in     0.764 seconds (test148_016): <a href='file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?depend0=IsoDateTime&rank2=Rgeo_x-Rgeo_z'>file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?depend0=IsoDateTime&amp;rank2=Rgeo_x-Rgeo_z</a>
Plot in     1.472 seconds (test148_016): <a href='file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?depend0=IsoDateTime&rank2=Rgeo_x-Rgeo_z'>file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?depend0=IsoDateTime&amp;rank2=Rgeo_x-Rgeo_z</a>
== 148 017  ==
uri: <a href='file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?X=Rgeo_x&Y=Rgeo_y&Z=Rgeo_z&depend0=IsoDateTime'>file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?X=Rgeo_x&amp;Y=Rgeo_y&amp;Z=Rgeo_z&amp;depend0=IsoDateTime</a>
dataset: dataset[1441,BUNDLE_1=3] (R!BE!N)
wrote to file: test148_file__home_jbf_ct_hudson_data_dat_rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt_X_Rgeo_x_Y_Rgeo_y_Z_Rgeo_z_depend0_IsoDateTime.png
Read in     0.752 seconds (test148_017): <a href='file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?X=Rgeo_x&Y=Rgeo_y&Z=Rgeo_z&depend0=IsoDateTime'>file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?X=Rgeo_x&amp;Y=Rgeo_y&amp;Z=Rgeo_z&amp;depend0=IsoDateTime</a>
Plot in     1.002 seconds (test148_017): <a href='file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?X=Rgeo_x&Y=Rgeo_y&Z=Rgeo_z&depend0=IsoDateTime'>file:///home/jbf/ct/hudson/data/dat/rbspa_def_MagEphem_OP77Q_20121101_v2.3.0.txt?X=Rgeo_x&amp;Y=Rgeo_y&amp;Z=Rgeo_z&amp;depend0=IsoDateTime</a>
== 148 018  ==
uri: file:/home/jbf/public_html/autoplot/data/cdf/LANL_1991_080_H0_SOPA_ESP_19920308_V01.cdf?doDep=no&amp;Position[:,0];Position[:,2]
Jul 19, 2025 5:51:56 PM org.das2.graph.DasCanvas waitUntilIdle
INFO: strange bug where update event didn't clear dirty flags, reposting.
dataset: dataset[7175,BUNDLE_1=2] (km)
wrote to file: test148_file_home_jbf_public_html_autoplot_data_cdf_LANL_1991_080_H0_SOPA_ESP_19920308_V01.cdf_doDep_no_Position__0__Position__2_.png
Read in     0.008 seconds (test148_018): file:/home/jbf/public_html/autoplot/data/cdf/LANL_1991_080_H0_SOPA_ESP_19920308_V01.cdf?doDep=no&amp;Position[:,0];Position[:,2]
Plot in     0.552 seconds (test148_018): file:/home/jbf/public_html/autoplot/data/cdf/LANL_1991_080_H0_SOPA_ESP_19920308_V01.cdf?doDep=no&amp;Position[:,0];Position[:,2]
== 148 019  ==
uri: <a href='https://jfaden.net/~jbf/autoplot/rfe_misc/20210115_fs/hidden/afile.dat'>https://jfaden.net/~jbf/autoplot/rfe_misc/20210115_fs/hidden/afile.dat</a>
dataset: field0[15] (dimensionless)
wrote to file: test148_https_jfaden.net__jbf_autoplot_rfe_misc_20210115_fs_hidden_afile.dat.png
Read in     0.035 seconds (test148_019): <a href='https://jfaden.net/~jbf/autoplot/rfe_misc/20210115_fs/hidden/afile.dat'>https://jfaden.net/~jbf/autoplot/rfe_misc/20210115_fs/hidden/afile.dat</a>
Plot in     0.270 seconds (test148_019): <a href='https://jfaden.net/~jbf/autoplot/rfe_misc/20210115_fs/hidden/afile.dat'>https://jfaden.net/~jbf/autoplot/rfe_misc/20210115_fs/hidden/afile.dat</a>
== 148 020  ==
uri: /home/jbf/project/cluster/u/2023/keith/20230216/testCadence.vap
  data_0: vap+jyds:file:/home/jbf/project/cluster/u/2023/keith/20230216/testCadence3.jyds
  timerange: 2022-04-24 13:50 to 14:21
Jul 19, 2025 5:52:07 PM org.autoplot.datasource.jython.JythonDataSource getDataSet
WARNING: Traceback (innermost last):
  File "testCadence3.jyds", line 22, in ?
	at org.das2.qds.ops.Ops.addGen(Ops.java:468)
	at org.das2.qds.ops.Ops.add(Ops.java:585)
	at org.das2.qds.ops.Ops.fftPower(Ops.java:9080)
	at org.das2.qds.ops.Ops.fftPower(Ops.java:8649)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)

java.lang.IllegalArgumentException: java.lang.IllegalArgumentException: units cannot be added: , kHz

Jul 19, 2025 5:52:07 PM org.autoplot.dom.DataSourceController loadDataSet
WARNING: null
Traceback (innermost last):
  File "testCadence3.jyds", line 22, in ?
	at org.das2.qds.ops.Ops.addGen(Ops.java:468)
	at org.das2.qds.ops.Ops.add(Ops.java:585)
	at org.das2.qds.ops.Ops.fftPower(Ops.java:9080)
	at org.das2.qds.ops.Ops.fftPower(Ops.java:8649)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)

java.lang.IllegalArgumentException: java.lang.IllegalArgumentException: units cannot be added: , kHz

	at org.python.core.Py.JavaError(Py.java:368)
	at org.python.core.Py.JavaError(Py.java:363)
	at org.python.core.PyReflectedFunction.__call__(PyReflectedFunction.java:176)
	at org.python.core.PyReflectedFunction.__call__(PyReflectedFunction.java:181)
	at org.python.core.PyObject.__call__(PyObject.java:460)
	at org.python.pycode._pyx227.f$0(testCadence3.jyds:22)
	at org.python.pycode._pyx227.call_function(testCadence3.jyds)
	at org.python.core.PyTableCode.call(PyTableCode.java:217)
	at org.python.core.PyCode.call(PyCode.java:14)
	at org.python.core.Py.runCode(Py.java:1224)
	at org.python.util.PythonInterpreter.execfile(PythonInterpreter.java:165)
	at org.autoplot.datasource.jython.JythonDataSource.getDataSet(JythonDataSource.java:316)
	at org.autoplot.dom.DataSourceController.loadDataSet(DataSourceController.java:1855)
	at org.autoplot.dom.DataSourceController.updateImmediately(DataSourceController.java:1450)
	at org.autoplot.dom.DataSourceController.access$1300(DataSourceController.java:65)
	at org.autoplot.dom.DataSourceController$11.run(DataSourceController.java:1549)
	at org.autoplot.dom.DataSourceController.update(DataSourceController.java:1581)
	at org.autoplot.dom.DataSourceController.resetDataSource(DataSourceController.java:510)
	at org.autoplot.dom.DataSourceController.resolveDataSource(DataSourceController.java:2149)
	at org.autoplot.dom.DataSourceController$3$1.run(DataSourceController.java:155)
	at org.autoplot.util.RunLaterListener.propertyChange(RunLaterListener.java:70)
	at java.beans.PropertyChangeSupport.fire(PropertyChangeSupport.java:335)
	at java.beans.PropertyChangeSupport.firePropertyChange(PropertyChangeSupport.java:328)
	at org.autoplot.dom.DebugPropertyChangeSupport.firePropertyChange(DebugPropertyChangeSupport.java:175)
	at java.beans.PropertyChangeSupport.firePropertyChange(PropertyChangeSupport.java:263)
	at org.autoplot.dom.ChangesSupport$DomLock.unlock(ChangesSupport.java:255)
	at org.autoplot.dom.ApplicationController.syncTo(ApplicationController.java:3551)
	at org.autoplot.dom.Application.syncTo(Application.java:340)
	at org.autoplot.dom.Application.syncTo(Application.java:332)
	at org.autoplot.ApplicationModel.restoreState(ApplicationModel.java:1128)
	at org.autoplot.ApplicationModel.doOpenVap(ApplicationModel.java:1307)
	at org.autoplot.ApplicationModel.doOpenVap(ApplicationModel.java:1193)
	at org.autoplot.ApplicationModel.resetDataSetSourceURL(ApplicationModel.java:505)
	at org.autoplot.ScriptContext.plot(ScriptContext.java:524)
	at org.autoplot.ScriptContext.load(ScriptContext.java:2058)
	at test.endtoend.Test140.do1(Test140.java:158)
	at test.endtoend.Test140.doHistory(Test140.java:456)
	at test.endtoend.Test140.main(Test140.java:530)

Jul 19, 2025 5:52:07 PM org.autoplot.dom.DataSourceController handleException
WARNING: model.getExceptionHandler: org.autoplot.scriptconsole.ExitExceptionHandler@7dbe9654
Jul 19, 2025 5:52:07 PM org.autoplot.scriptconsole.ExitExceptionHandler handle
WARNING: exception occurred: null
Traceback (innermost last):
  File "testCadence3.jyds", line 22, in ?
	at org.das2.qds.ops.Ops.addGen(Ops.java:468)
	at org.das2.qds.ops.Ops.add(Ops.java:585)
	at org.das2.qds.ops.Ops.fftPower(Ops.java:9080)
	at org.das2.qds.ops.Ops.fftPower(Ops.java:8649)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)

java.lang.IllegalArgumentException: java.lang.IllegalArgumentException: units cannot be added: , kHz

	at org.python.core.Py.JavaError(Py.java:368)
	at org.python.core.Py.JavaError(Py.java:363)
	at org.python.core.PyReflectedFunction.__call__(PyReflectedFunction.java:176)
	at org.python.core.PyReflectedFunction.__call__(PyReflectedFunction.java:181)
	at org.python.core.PyObject.__call__(PyObject.java:460)
	at org.python.pycode._pyx227.f$0(testCadence3.jyds:22)
	at org.python.pycode._pyx227.call_function(testCadence3.jyds)
	at org.python.core.PyTableCode.call(PyTableCode.java:217)
	at org.python.core.PyCode.call(PyCode.java:14)
	at org.python.core.Py.runCode(Py.java:1224)
	at org.python.util.PythonInterpreter.execfile(PythonInterpreter.java:165)
	at org.autoplot.datasource.jython.JythonDataSource.getDataSet(JythonDataSource.java:316)
	at org.autoplot.dom.DataSourceController.loadDataSet(DataSourceController.java:1855)
	at org.autoplot.dom.DataSourceController.updateImmediately(DataSourceController.java:1450)
	at org.autoplot.dom.DataSourceController.access$1300(DataSourceController.java:65)
	at org.autoplot.dom.DataSourceController$11.run(DataSourceController.java:1549)
	at org.autoplot.dom.DataSourceController.update(DataSourceController.java:1581)
	at org.autoplot.dom.DataSourceController.resetDataSource(DataSourceController.java:510)
	at org.autoplot.dom.DataSourceController.resolveDataSource(DataSourceController.java:2149)
	at org.autoplot.dom.DataSourceController$3$1.run(DataSourceController.java:155)
	at org.autoplot.util.RunLaterListener.propertyChange(RunLaterListener.java:70)
	at java.beans.PropertyChangeSupport.fire(PropertyChangeSupport.java:335)
	at java.beans.PropertyChangeSupport.firePropertyChange(PropertyChangeSupport.java:328)
	at org.autoplot.dom.DebugPropertyChangeSupport.firePropertyChange(DebugPropertyChangeSupport.java:175)
	at java.beans.PropertyChangeSupport.firePropertyChange(PropertyChangeSupport.java:263)
	at org.autoplot.dom.ChangesSupport$DomLock.unlock(ChangesSupport.java:255)
	at org.autoplot.dom.ApplicationController.syncTo(ApplicationController.java:3551)
	at org.autoplot.dom.Application.syncTo(Application.java:340)
	at org.autoplot.dom.Application.syncTo(Application.java:332)
	at org.autoplot.ApplicationModel.restoreState(ApplicationModel.java:1128)
	at org.autoplot.ApplicationModel.doOpenVap(ApplicationModel.java:1307)
	at org.autoplot.ApplicationModel.doOpenVap(ApplicationModel.java:1193)
	at org.autoplot.ApplicationModel.resetDataSetSourceURL(ApplicationModel.java:505)
	at org.autoplot.ScriptContext.plot(ScriptContext.java:524)
	at org.autoplot.ScriptContext.load(ScriptContext.java:2058)
	at test.endtoend.Test140.do1(Test140.java:158)
	at test.endtoend.Test140.doHistory(Test140.java:456)
	at test.endtoend.Test140.main(Test140.java:530)
Caused by: java.lang.RuntimeException: attempt to load vap+jyds:file:/home/jbf/project/cluster/u/2023/keith/20230216/testCadence3.jyds
	at org.autoplot.dom.DataSourceController.update(DataSourceController.java:1542)
	... 21 more

Traceback (innermost last):
  File "testCadence3.jyds", line 22, in ?
	at org.das2.qds.ops.Ops.addGen(Ops.java:468)
	at org.das2.qds.ops.Ops.add(Ops.java:585)
	at org.das2.qds.ops.Ops.fftPower(Ops.java:9080)
	at org.das2.qds.ops.Ops.fftPower(Ops.java:8649)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)

java.lang.IllegalArgumentException: java.lang.IllegalArgumentException: units cannot be added: , kHz
Build step 'Execute shell' marked build as failure
Archiving artifacts
Finished: FAILURE