Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite 2.2.0-master/package.mo", uses=false)
Using package ScalableTestSuite with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite 2.2.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="der.x.10..|der.x.1..|der.x.2..|der.x.3..|der.x.4..|der.x.5..|der.x.6..|der.x.7..|der.x.8..|der.x.9..|time|time|x.10.|x.1.|x.2.|x.3.|x.4.|x.5.|x.6.|x.7.|x.8.|x.9.",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder")
translateModel(ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="der.x.10..|der.x.1..|der.x.2..|der.x.3..|der.x.4..|der.x.5..|der.x.6..|der.x.7..|der.x.8..|der.x.9..|time|time|x.10.|x.1.|x.2.|x.3.|x.4.|x.5.|x.6.|x.7.|x.8.|x.9.",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001199/0.001199, allocations: 112.6 kB / 17.75 MB, free: 5.348 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001043/0.001043, allocations: 190.5 kB / 18.68 MB, free: 4.422 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.455/1.455, allocations: 222.9 MB / 242.4 MB, free: 15.15 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite 2.2.0-master/package.mo): time 1.362/1.362, allocations: 119.3 MB / 411.8 MB, free: 9.492 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 3.659e-05/3.688e-05, allocations: 2.281 kB / 0.5715 GB, free: 39.77 MB / 462.3 MB
Notification: Performance of NFInst.instantiate(ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder): time 0.002734/0.002793, allocations: 1.173 MB / 0.5726 GB, free: 38.91 MB / 462.3 MB
Notification: Performance of NFInst.instExpressions: time 0.0002174/0.003028, allocations: 30.02 kB / 0.5727 GB, free: 38.88 MB / 462.3 MB
Notification: Performance of NFInst.updateImplicitVariability: time 4.759e-05/0.003084, allocations: 0 / 0.5727 GB, free: 38.88 MB / 462.3 MB
Notification: Performance of NFTyping.typeComponents: time 0.0001112/0.003204, allocations: 0 / 0.5727 GB, free: 38.88 MB / 462.3 MB
Notification: Performance of NFTyping.typeBindings: time 4.667e-05/0.00326, allocations: 9.312 kB / 0.5727 GB, free: 38.88 MB / 462.3 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0001808/0.003459, allocations: 13.45 kB / 0.5727 GB, free: 38.86 MB / 462.3 MB
Notification: Performance of NFFlatten.flatten: time 0.0001145/0.00358, allocations: 16.02 kB / 0.5727 GB, free: 38.86 MB / 462.3 MB
Notification: Performance of NFFlatten.resolveConnections: time 7.234e-05/0.003658, allocations: 1.469 kB / 0.5727 GB, free: 38.86 MB / 462.3 MB
Notification: Performance of NFEvalConstants.evaluate: time 4.311e-05/0.003706, allocations: 13.61 kB / 0.5727 GB, free: 38.85 MB / 462.3 MB
Notification: Performance of NFSimplifyModel.simplify: time 6.622e-05/0.003777, allocations: 6.266 kB / 0.5727 GB, free: 38.84 MB / 462.3 MB
Notification: Performance of NFPackage.collectConstants: time 2.409e-05/0.003807, allocations: 4.875 kB / 0.5727 GB, free: 38.84 MB / 462.3 MB
Notification: Performance of NFFlatten.collectFunctions: time 1.281e-05/0.003824, allocations: 1.625 kB / 0.5727 GB, free: 38.84 MB / 462.3 MB
Notification: Performance of combineBinaries: time 7.595e-05/0.003904, allocations: 28.17 kB / 0.5727 GB, free: 38.82 MB / 462.3 MB
Notification: Performance of replaceArrayConstructors: time 1.823e-05/0.003928, allocations: 16.94 kB / 0.5728 GB, free: 38.81 MB / 462.3 MB
Notification: Performance of NFVerifyModel.verify: time 2.755e-05/0.003959, allocations: 5.5 kB / 0.5728 GB, free: 38.8 MB / 462.3 MB
Notification: Performance of FrontEnd: time 1.445e-05/0.003978, allocations: 0 / 0.5728 GB, free: 38.8 MB / 462.3 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 11 (3)
 * Number of variables: 11 (2)
Notification: Performance of Bindings: time 0.0004639/0.004447, allocations: 218.2 kB / 0.573 GB, free: 38.53 MB / 462.3 MB
Notification: Performance of FunctionAlias: time 2.43e-05/0.004478, allocations: 5.219 kB / 0.573 GB, free: 38.52 MB / 462.3 MB
Notification: Performance of Early Inline: time 8.809e-05/0.004572, allocations: 73.28 kB / 0.5731 GB, free: 38.44 MB / 462.3 MB
Notification: Performance of simplify1: time 1.672e-05/0.004594, allocations: 5.172 kB / 0.5731 GB, free: 38.44 MB / 462.3 MB
Notification: Performance of Alias: time 0.0002816/0.004881, allocations: 97.31 kB / 0.5731 GB, free: 38.32 MB / 462.3 MB
Notification: Performance of simplify2: time 7.394e-06/0.004896, allocations: 1.188 kB / 0.5732 GB, free: 38.32 MB / 462.3 MB
Notification: Performance of Events: time 1.652e-05/0.004917, allocations: 5.328 kB / 0.5732 GB, free: 38.31 MB / 462.3 MB
Notification: Performance of Detect States: time 0.0004617/0.005384, allocations: 46.77 kB / 0.5732 GB, free: 38.26 MB / 462.3 MB
Notification: Performance of Partitioning: time 5.299e-05/0.005445, allocations: 17.5 kB / 0.5732 GB, free: 38.24 MB / 462.3 MB
Notification: Performance of Causalize: time 0.0001955/0.005647, allocations: 96.39 kB / 0.5733 GB, free: 38.18 MB / 462.3 MB
Notification: Performance of After Index Reduction Inline: time 7.463e-05/0.00573, allocations: 69.66 kB / 0.5734 GB, free: 38.1 MB / 462.3 MB
Notification: Performance of Inline: time 0.000192/0.00593, allocations: 121.9 kB / 0.5735 GB, free: 37.98 MB / 462.3 MB
Notification: Performance of Partitioning: time 1.534e-05/0.005954, allocations: 10.72 kB / 0.5735 GB, free: 37.96 MB / 462.3 MB
Notification: Performance of Cleanup: time 1.919e-05/0.005978, allocations: 13.14 kB / 0.5735 GB, free: 37.95 MB / 462.3 MB
Notification: Performance of Causalize: time 0.0004064/0.006389, allocations: 235.8 kB / 0.5737 GB, free: 37.85 MB / 462.3 MB
Notification: Performance of Tearing: time 1.06e-05/0.006411, allocations: 4 kB / 0.5737 GB, free: 37.85 MB / 462.3 MB
Notification: Performance of Initialization: time 3.4e-07/0.006416, allocations: 3.938 kB / 0.5737 GB, free: 37.84 MB / 462.3 MB
Notification: Performance of Tearing: time 2.715e-06/0.006423, allocations: 1.406 kB / 0.5737 GB, free: 37.84 MB / 462.3 MB
Notification: Performance of Categorize: time 7.834e-06/0.006436, allocations: 0 / 0.5737 GB, free: 37.84 MB / 462.3 MB
Notification: Performance of Solve: time 0.0001113/0.006552, allocations: 31.59 kB / 0.5738 GB, free: 37.83 MB / 462.3 MB
Notification: Performance of Jacobian: time 0.000446/0.007004, allocations: 385.8 kB / 0.5741 GB, free: 37.54 MB / 462.3 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 0
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 10 (1) {x}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {NOT YET AVAILABLE}
 * Number of discrete variables: ................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 1 (scalar:1, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 1 (generic: 1, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 3 (scalar:2, array:1, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 1 (generic: 1, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 5.261e-05/0.007068, allocations: 25.67 kB / 0.5742 GB, free: 37.52 MB / 462.3 MB
Notification: Performance of SimCode: time 0.0008251/0.007899, allocations: 1.031 MB / 0.5752 GB, free: 36.61 MB / 462.3 MB
Notification: Performance of Templates: time 0.003025/0.01093, allocations: 461.4 kB / 0.5756 GB, free: 36.38 MB / 462.3 MB
make -j1 -f ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder.makefile
(rm -f ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder.pipe ; mkfifo ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder.pipe ; head -c 1048576 < ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder.pipe >> ../files/ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder.sim & ./ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder  -abortSlowSimulation -alarm=300  -emit_protected -lv LOG_STATS > ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder.pipe 2>&1)
diffSimulationResults("ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/ScalableTestSuite/ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ScalableTestSuite_noopt_ScalableTestSuite.Elementary.SimpleODE.Models.CascadedFirstOrder.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches