Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001578/0.001578, allocations: 121 kB / 18.5 MB, free: 4.562 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001609/0.001609, allocations: 213.5 kB / 21.45 MB, free: 1.617 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.465/1.465, allocations: 230.6 MB / 254.8 MB, free: 15.11 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite master/package.mo): time 0.7933/0.7933, allocations: 120.6 MB / 431.5 MB, free: 188 kB / 350.1 MB " [Timeout remaining time 179] Using package ScalableTestSuite with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestSuite master/package.mo) Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: translateModel(ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5,tolerance=1e-07,outputFormat="mat",numberOfIntervals=21600,variableFilter="Qh.1.|Qh.2.|Qh.3.|Qh.5.|Que.1.|Que.2.|Que.3.|Que.5.|Tu.1.|Tu.2.|Tu.3.|Tu.5.|der.Tu.1..|der.Tu.2..|der.Tu.3..|der.Tu.5..|der.x.1..|der.x.2..|der.x.3..|der.x.5..|time|time|u.1.|u.2.|u.3.|u.5.|x.1.|x.2.|x.3.|x.5.",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5") translateModel(ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5,tolerance=1e-07,outputFormat="mat",numberOfIntervals=21600,variableFilter="Qh.1.|Qh.2.|Qh.3.|Qh.5.|Que.1.|Que.2.|Que.3.|Que.5.|Tu.1.|Tu.2.|Tu.3.|Tu.5.|der.Tu.1..|der.Tu.2..|der.Tu.3..|der.Tu.5..|der.x.1..|der.x.2..|der.x.3..|der.x.5..|time|time|u.1.|u.2.|u.3.|u.5.|x.1.|x.2.|x.3.|x.5.",fileNamePrefix="ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5") [Timeout 300] "Notification: ScalableTestSuite requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed. Notification: Performance of FrontEnd - loaded program: time 0.001955/0.001955, allocations: 67.91 kB / 0.6041 GB, free: 9.57 MB / 0.4982 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.6314/0.6334, allocations: 85.82 MB / 0.6879 GB, free: 11.88 MB / 0.5139 GB Notification: Performance of NFInst.instantiate(ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5): time 0.002185/0.6356, allocations: 1.393 MB / 0.6893 GB, free: 10.77 MB / 0.5139 GB Notification: Performance of NFInst.instExpressions: time 0.0008593/0.6364, allocations: 0.578 MB / 0.6899 GB, free: 10.32 MB / 0.5139 GB Notification: Performance of NFInst.updateImplicitVariability: time 4.65e-05/0.6365, allocations: 1.438 kB / 0.6899 GB, free: 10.32 MB / 0.5139 GB Notification: Performance of NFTyping.typeComponents: time 9.424e-05/0.6366, allocations: 7.922 kB / 0.6899 GB, free: 10.31 MB / 0.5139 GB Notification: Performance of NFTyping.typeBindings: time 0.0002997/0.6369, allocations: 51.38 kB / 0.6899 GB, free: 10.28 MB / 0.5139 GB Notification: Performance of NFTyping.typeClassSections: time 9.994e-05/0.637, allocations: 42.69 kB / 0.69 GB, free: 10.25 MB / 0.5139 GB Notification: Performance of NFFlatten.flatten: time 0.0002222/0.6372, allocations: 195.6 kB / 0.6902 GB, free: 10.14 MB / 0.5139 GB Notification: Performance of NFFlatten.resolveConnections: time 4.596e-05/0.6372, allocations: 11.05 kB / 0.6902 GB, free: 10.14 MB / 0.5139 GB Notification: Performance of NFEvalConstants.evaluate: time 0.0001598/0.6374, allocations: 84.47 kB / 0.6902 GB, free: 10.1 MB / 0.5139 GB Notification: Performance of NFSimplifyModel.simplify: time 0.0001803/0.6376, allocations: 103.9 kB / 0.6903 GB, free: 10.04 MB / 0.5139 GB Notification: Performance of NFPackage.collectConstants: time 3.087e-05/0.6376, allocations: 8.625 kB / 0.6904 GB, free: 10.04 MB / 0.5139 GB Notification: Performance of NFFlatten.collectFunctions: time 9.636e-05/0.6377, allocations: 28.73 kB / 0.6904 GB, free: 10.03 MB / 0.5139 GB Notification: Performance of NFScalarize.scalarize: time 9.444e-05/0.6378, allocations: 66.05 kB / 0.6904 GB, free: 9.988 MB / 0.5139 GB Notification: Performance of NFVerifyModel.verify: time 7.854e-05/0.6379, allocations: 78.91 kB / 0.6905 GB, free: 9.938 MB / 0.5139 GB Notification: Performance of NFConvertDAE.convert: time 0.0001861/0.638, allocations: 145.3 kB / 0.6907 GB, free: 9.859 MB / 0.5139 GB Notification: Performance of FrontEnd - DAE generated: time 3.707e-06/0.638, allocations: 0 / 0.6907 GB, free: 9.859 MB / 0.5139 GB Notification: Performance of FrontEnd: time 1.572e-06/0.6381, allocations: 0 / 0.6907 GB, free: 9.859 MB / 0.5139 GB Notification: Performance of Transformations before backend: time 6.522e-06/0.6381, allocations: 1.25 kB / 0.6907 GB, free: 9.859 MB / 0.5139 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 28 * Number of variables: 28 Notification: Performance of Generate backend data structure: time 0.0007271/0.6388, allocations: 478.7 kB / 0.6911 GB, free: 9.414 MB / 0.5139 GB Notification: Performance of prepare preOptimizeDAE: time 3.498e-05/0.6388, allocations: 8.844 kB / 0.6911 GB, free: 9.414 MB / 0.5139 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 5.75e-05/0.6389, allocations: 16.41 kB / 0.6911 GB, free: 9.406 MB / 0.5139 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.0001791/0.6391, allocations: 216.1 kB / 0.6913 GB, free: 9.176 MB / 0.5139 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 1.488e-05/0.6391, allocations: 9.297 kB / 0.6914 GB, free: 9.172 MB / 0.5139 GB Notification: Performance of preOpt expandDerOperator (simulation): time 4.341e-05/0.6391, allocations: 16.8 kB / 0.6914 GB, free: 9.164 MB / 0.5139 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0002853/0.6394, allocations: 176.8 kB / 0.6915 GB, free: 9.055 MB / 0.5139 GB Notification: Performance of preOpt findStateOrder (simulation): time 9.668e-06/0.6394, allocations: 0 / 0.6915 GB, free: 9.055 MB / 0.5139 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 1.856e-05/0.6394, allocations: 5.281 kB / 0.6915 GB, free: 9.051 MB / 0.5139 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.072e-06/0.6394, allocations: 6.531 kB / 0.6916 GB, free: 9.047 MB / 0.5139 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0002415/0.6397, allocations: 149.1 kB / 0.6917 GB, free: 8.984 MB / 0.5139 GB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.0002855/0.64, allocations: 284.4 kB / 0.692 GB, free: 8.715 MB / 0.5139 GB Notification: Performance of preOpt comSubExp (simulation): time 0.0009458/0.6409, allocations: 350.6 kB / 0.6923 GB, free: 8.559 MB / 0.5139 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.000168/0.6411, allocations: 113.4 kB / 0.6924 GB, free: 8.504 MB / 0.5139 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0001473/0.6412, allocations: 91.39 kB / 0.6925 GB, free: 8.402 MB / 0.5139 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 1.559e-05/0.6412, allocations: 37.09 kB / 0.6925 GB, free: 8.359 MB / 0.5139 GB Notification: Performance of pre-optimization done (n=28): time 1.252e-06/0.6412, allocations: 0 / 0.6925 GB, free: 8.359 MB / 0.5139 GB Notification: Performance of matching and sorting (n=28): time 0.0006427/0.6419, allocations: 377.5 kB / 0.6929 GB, free: 8.184 MB / 0.5139 GB Notification: Performance of inlineWhenForInitialization (initialization): time 3.326e-05/0.6419, allocations: 53.94 kB / 0.6929 GB, free: 8.121 MB / 0.5139 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 8.054e-05/0.642, allocations: 130.5 kB / 0.6931 GB, free: 8.008 MB / 0.5139 GB Notification: Performance of collectPreVariables (initialization): time 1.935e-05/0.642, allocations: 34.95 kB / 0.6931 GB, free: 7.969 MB / 0.5139 GB Notification: Performance of collectInitialEqns (initialization): time 2.996e-05/0.642, allocations: 91.2 kB / 0.6932 GB, free: 7.875 MB / 0.5139 GB Notification: Performance of collectInitialBindings (initialization): time 7.417e-05/0.6421, allocations: 118 kB / 0.6933 GB, free: 7.773 MB / 0.5139 GB Notification: Performance of simplifyInitialFunctions (initialization): time 8.739e-05/0.6422, allocations: 59.28 kB / 0.6934 GB, free: 7.73 MB / 0.5139 GB Notification: Performance of setup shared object (initialization): time 5.586e-05/0.6423, allocations: 335.8 kB / 0.6937 GB, free: 7.398 MB / 0.5139 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0001829/0.6424, allocations: 120.6 kB / 0.6938 GB, free: 7.348 MB / 0.5139 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0001827/0.6426, allocations: 123.8 kB / 0.6939 GB, free: 7.297 MB / 0.5139 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.0003915/0.643, allocations: 283.7 kB / 0.6942 GB, free: 7.164 MB / 0.5139 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.094e-06/0.643, allocations: 5.25 kB / 0.6942 GB, free: 7.16 MB / 0.5139 GB Notification: Performance of matching and sorting (n=39) (initialization): time 0.0005012/0.6435, allocations: 347.4 kB / 0.6945 GB, free: 6.996 MB / 0.5139 GB Notification: Performance of prepare postOptimizeDAE: time 1.499e-05/0.6435, allocations: 8.531 kB / 0.6945 GB, free: 6.992 MB / 0.5139 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.859e-06/0.6435, allocations: 0.9062 kB / 0.6945 GB, free: 6.992 MB / 0.5139 GB Notification: Performance of postOpt tearingSystem (initialization): time 1.721e-05/0.6436, allocations: 5.188 kB / 0.6945 GB, free: 6.988 MB / 0.5139 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003026/0.6439, allocations: 79.58 kB / 0.6946 GB, free: 6.969 MB / 0.5139 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 7.814e-06/0.6439, allocations: 1.156 kB / 0.6946 GB, free: 6.969 MB / 0.5139 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0001057/0.644, allocations: 23.72 kB / 0.6946 GB, free: 6.949 MB / 0.5139 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 2.45e-05/0.644, allocations: 11.5 kB / 0.6946 GB, free: 6.945 MB / 0.5139 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 1 * Number of states: 0 () * Number of discrete variables: 0 () * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (39): * Single equations (assignments): 39 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of prepare postOptimizeDAE: time 9.232e-05/0.6441, allocations: 143.2 kB / 0.6948 GB, free: 6.809 MB / 0.5139 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 3.369e-05/0.6441, allocations: 15.94 kB / 0.6948 GB, free: 6.801 MB / 0.5139 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0006544/0.6448, allocations: 401.6 kB / 0.6952 GB, free: 6.574 MB / 0.5139 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.217e-06/0.6448, allocations: 3.688 kB / 0.6952 GB, free: 6.574 MB / 0.5139 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 4.719e-06/0.6448, allocations: 1.281 kB / 0.6952 GB, free: 6.574 MB / 0.5139 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.012e-06/0.6448, allocations: 7.984 kB / 0.6952 GB, free: 6.566 MB / 0.5139 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0002699/0.6451, allocations: 318.5 kB / 0.6955 GB, free: 6.277 MB / 0.5139 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.403e-06/0.6451, allocations: 0 / 0.6955 GB, free: 6.277 MB / 0.5139 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004068/0.6455, allocations: 87.59 kB / 0.6956 GB, free: 6.258 MB / 0.5139 GB Notification: Performance of postOpt tearingSystem (simulation): time 3.256e-06/0.6455, allocations: 1.094 kB / 0.6956 GB, free: 6.258 MB / 0.5139 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 2.915e-05/0.6455, allocations: 13.23 kB / 0.6956 GB, free: 6.25 MB / 0.5139 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.785e-06/0.6455, allocations: 2.375 kB / 0.6956 GB, free: 6.25 MB / 0.5139 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.893e-06/0.6455, allocations: 3.984 kB / 0.6956 GB, free: 6.246 MB / 0.5139 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0007504/0.6463, allocations: 0.5258 MB / 0.6961 GB, free: 5.969 MB / 0.5139 GB Notification: Performance of postOpt removeConstants (simulation): time 9.715e-05/0.6464, allocations: 132.7 kB / 0.6962 GB, free: 5.84 MB / 0.5139 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 3.519e-05/0.6464, allocations: 8.344 kB / 0.6962 GB, free: 5.836 MB / 0.5139 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0001058/0.6465, allocations: 5.656 kB / 0.6962 GB, free: 5.832 MB / 0.5139 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 4.898e-05/0.6465, allocations: 28.2 kB / 0.6963 GB, free: 5.816 MB / 0.5139 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 1.929e-05/0.6466, allocations: 7.562 kB / 0.6963 GB, free: 5.816 MB / 0.5139 GB Notification: Performance of sorting global known variables: time 4.789e-05/0.6466, allocations: 107.8 kB / 0.6964 GB, free: 5.727 MB / 0.5139 GB Notification: Performance of sort global known variables: time 6e-08/0.6466, allocations: 0 / 0.6964 GB, free: 5.727 MB / 0.5139 GB Notification: Performance of remove unused functions: time 0.0002865/0.6469, allocations: 66.06 kB / 0.6964 GB, free: 5.719 MB / 0.5139 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 1 * Number of states: 11 (Td,Tu[1],Tu[2],Tu[3],Tu[4],Tu[5],x[1],x[2],x[3],x[4],x[5]) * Number of discrete variables: 0 () * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (39): * Single equations (assignments): 39 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of Backend phase and start with SimCode phase: time 0.0001514/0.6471, allocations: 124.9 kB / 0.6966 GB, free: 5.609 MB / 0.5139 GB Notification: Performance of simCode: created initialization part: time 0.0004759/0.6475, allocations: 296.1 kB / 0.6968 GB, free: 5.492 MB / 0.5139 GB Notification: Performance of simCode: created event and clocks part: time 2.164e-06/0.6475, allocations: 0 / 0.6968 GB, free: 5.492 MB / 0.5139 GB Notification: Performance of simCode: created simulation system equations: time 0.000217/0.6477, allocations: 156.5 kB / 0.697 GB, free: 5.434 MB / 0.5139 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0002553/0.648, allocations: 39.84 kB / 0.697 GB, free: 5.406 MB / 0.5139 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.001185/0.6492, allocations: 0.8623 MB / 0.6979 GB, free: 4.789 MB / 0.5139 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0001611/0.6494, allocations: 0.7438 MB / 0.6986 GB, free: 4.066 MB / 0.5139 GB Notification: Performance of simCode: alias equations: time 0.0001729/0.6495, allocations: 87.61 kB / 0.6987 GB, free: 4.031 MB / 0.5139 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 9.524e-05/0.6496, allocations: 37.86 kB / 0.6987 GB, free: 4.012 MB / 0.5139 GB Notification: Performance of SimCode: time 3e-07/0.6496, allocations: 1.125 kB / 0.6987 GB, free: 4.012 MB / 0.5139 GB Notification: Performance of Templates: time 0.006298/0.6559, allocations: 3.114 MB / 0.7018 GB, free: 2.5 MB / 0.5139 GB " [Timeout remaining time 299] make -j1 -f ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5.makefile [Timeout 300] (rm -f ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5.pipe ; mkfifo ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5.pipe ; head -c 1048576 < ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5.pipe >> ../files/ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5.sim & ./ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5 -s=ida -abortSlowSimulation -alarm=300 -emit_protected -lv LOG_STATS > ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5.pipe 2>&1) [Timeout 300] diffSimulationResults("ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/ScalableTestSuite/ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ScalableTestSuite_noopt_ScalableTestSuite.Thermal.DistrictHeating.ScaledExperiments.HeatingSystem_N_5.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300] "" [Timeout remaining time 300] Reference file matches [Calling sys.exit(0), Time elapsed: 6.538108922017273]