Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.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.0009599/0.0009599, allocations: 76.5 kB / 19.93 MB, free: 4.633 MB / 18.57 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.000874/0.000874, allocations: 174.3 kB / 23.21 MB, free: 1.352 MB / 18.57 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 0.8625/0.8625, allocations: 177.1 MB / 203.5 MB, free: 5.77 MB / 186.7 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo): time 1.65/1.65, allocations: 359 MB / 0.6044 GB, free: 11.1 MB / 0.573 GB " [Timeout remaining time 178] Using package Buildings with version 11.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/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(Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|buiTesOutETS.PHea|buiTesOutETS.PCoo|buiTesOutETS.PFan|buiTesOutETS.PPum|buiTesOutETSBui.QHea_flow|buiTesOutETSBui.QCoo_flow|buiTesOutETSBui.PHea|buiTesOutETSBui.PCoo|buiTesOutETSBui.PFan|buiTesOutETSBui.PPum|buiTesFacMul.PHea|buiTesFacMul.PCoo|buiTesFacMul.PFan|buiTesFacMul.PPum|buiTesFacMul.QHea_flow|buiTesFacMul.QCoo_flow",fileNamePrefix="Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS") translateModel(Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|buiTesOutETS.PHea|buiTesOutETS.PCoo|buiTesOutETS.PFan|buiTesOutETS.PPum|buiTesOutETSBui.QHea_flow|buiTesOutETSBui.QCoo_flow|buiTesOutETSBui.PHea|buiTesOutETSBui.PCoo|buiTesOutETSBui.PFan|buiTesOutETSBui.PPum|buiTesFacMul.PHea|buiTesFacMul.PCoo|buiTesFacMul.PFan|buiTesFacMul.PPum|buiTesFacMul.QHea_flow|buiTesFacMul.QCoo_flow",fileNamePrefix="Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS") [Timeout 300] "Notification: Performance of FrontEnd - loaded program: time 1.743e-06/1.743e-06, allocations: 0 / 0.9518 GB, free: 2.965 MB / 0.9011 GB Notification: Performance of FrontEnd - Absyn->SCode: time 2.675e-05/2.849e-05, allocations: 2.281 kB / 0.9518 GB, free: 2.961 MB / 0.9011 GB Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS): time 2.787/2.787, allocations: 1.247 GB / 2.199 GB, free: 105.1 MB / 1.589 GB Notification: Performance of NFInst.instExpressions: time 0.2992/3.086, allocations: 311.1 MB / 2.503 GB, free: 63.36 MB / 1.589 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.04575/3.132, allocations: 1.698 MB / 2.505 GB, free: 63.36 MB / 1.589 GB Notification: Performance of NFTyping.typeComponents: time 0.03059/3.162, allocations: 13.6 MB / 2.518 GB, free: 54.88 MB / 1.589 GB Notification: Performance of NFTyping.typeBindings: time 0.071/3.233, allocations: 34.9 MB / 2.552 GB, free: 29.35 MB / 1.589 GB Notification: Performance of NFTyping.typeClassSections: time 0.03501/3.268, allocations: 21.11 MB / 2.572 GB, free: 10.5 MB / 1.589 GB Notification: Performance of NFFlatten.flatten: time 0.0603/3.329, allocations: 58.82 MB / 2.63 GB, free: 1.438 MB / 1.635 GB Notification: Performance of NFFlatten.resolveConnections: time 0.02845/3.357, allocations: 16.76 MB / 2.646 GB, free: 1.137 MB / 1.651 GB Notification: Performance of NFEvalConstants.evaluate: time 0.07456/3.432, allocations: 34.06 MB / 2.68 GB, free: 15.02 MB / 1.698 GB Notification: Performance of NFSimplifyModel.simplify: time 0.02989/3.462, allocations: 16.3 MB / 2.695 GB, free: 14.68 MB / 1.714 GB Notification: Performance of NFPackage.collectConstants: time 0.006928/3.469, allocations: 2.133 MB / 2.698 GB, free: 12.55 MB / 1.714 GB Notification: Performance of NFFlatten.collectFunctions: time 0.03916/3.508, allocations: 15.82 MB / 2.713 GB, free: 12.7 MB / 1.729 GB Notification: Performance of NFScalarize.scalarize: time 0.01033/3.518, allocations: 5.23 MB / 2.718 GB, free: 7.449 MB / 1.729 GB Notification: Performance of NFVerifyModel.verify: time 0.01998/3.538, allocations: 7.319 MB / 2.725 GB, free: 116 kB / 1.729 GB Notification: Performance of NFConvertDAE.convert: time 0.07154/3.61, allocations: 42.39 MB / 2.767 GB, free: 5.605 MB / 1.776 GB Notification: Performance of FrontEnd - DAE generated: time 8.676e-06/3.61, allocations: 3.938 kB / 2.767 GB, free: 5.602 MB / 1.776 GB Notification: Performance of FrontEnd: time 1.783e-06/3.61, allocations: 0 / 2.767 GB, free: 5.602 MB / 1.776 GB Notification: Performance of Transformations before backend: time 0.001139/3.611, allocations: 0 / 2.767 GB, free: 5.602 MB / 1.776 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 3233 * Number of variables: 3233 Notification: Performance of Generate backend data structure: time 0.04193/3.653, allocations: 21.33 MB / 2.787 GB, free: 28 kB / 1.792 GB Notification: Performance of prepare preOptimizeDAE: time 4.894e-05/3.653, allocations: 8.031 kB / 2.787 GB, free: 20 kB / 1.792 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005925/3.659, allocations: 2.369 MB / 2.79 GB, free: 13.64 MB / 1.807 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.02984/3.688, allocations: 18.94 MB / 2.808 GB, free: 10.54 MB / 1.823 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006258/3.689, allocations: 0.9661 MB / 2.809 GB, free: 9.574 MB / 1.823 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.002449/3.692, allocations: 1.297 MB / 2.811 GB, free: 8.277 MB / 1.823 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.02264/3.714, allocations: 17.06 MB / 2.827 GB, free: 5.867 MB / 1.839 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0002513/3.714, allocations: 43.58 kB / 2.827 GB, free: 5.824 MB / 1.839 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001064/3.715, allocations: 0.5352 MB / 2.828 GB, free: 5.289 MB / 1.839 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002333/3.716, allocations: 351.9 kB / 2.828 GB, free: 4.945 MB / 1.839 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01429/3.73, allocations: 10.08 MB / 2.838 GB, free: 10.9 MB / 1.854 GB Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts. Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.6097/4.34, allocations: 56.84 MB / 2.893 GB, free: 0.9112 GB / 1.87 GB Notification: Performance of preOpt comSubExp (simulation): time 0.004665/4.344, allocations: 4.342 MB / 2.898 GB, free: 0.9098 GB / 1.87 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.002152/4.346, allocations: 2.283 MB / 2.9 GB, free: 0.9088 GB / 1.87 GB Notification: Performance of preOpt evalFunc (simulation): time 0.04046/4.387, allocations: 22.88 MB / 2.922 GB, free: 0.9077 GB / 1.87 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001319/4.387, allocations: 121.7 kB / 2.922 GB, free: 0.9077 GB / 1.87 GB Notification: Performance of pre-optimization done (n=412): time 8.145e-06/4.387, allocations: 3.141 kB / 2.922 GB, free: 0.9077 GB / 1.87 GB Notification: Performance of matching and sorting (n=412): time 0.01168/4.399, allocations: 6.688 MB / 2.929 GB, free: 0.9057 GB / 1.87 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001425/4.399, allocations: 0.7891 MB / 2.93 GB, free: 0.9049 GB / 1.87 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01598/4.415, allocations: 12 MB / 2.941 GB, free: 0.9008 GB / 1.87 GB Notification: Performance of collectPreVariables (initialization): time 0.001048/4.416, allocations: 143.4 kB / 2.942 GB, free: 0.9007 GB / 1.87 GB Notification: Performance of collectInitialEqns (initialization): time 0.00471/4.421, allocations: 8.745 MB / 2.95 GB, free: 0.8951 GB / 1.87 GB Notification: Performance of collectInitialBindings (initialization): time 0.001467/4.422, allocations: 1.516 MB / 2.952 GB, free: 0.894 GB / 1.87 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.001627/4.424, allocations: 1.48 MB / 2.953 GB, free: 0.8933 GB / 1.87 GB Notification: Performance of setup shared object (initialization): time 3.12e-05/4.424, allocations: 301.1 kB / 2.953 GB, free: 0.893 GB / 1.87 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.002415/4.426, allocations: 2.087 MB / 2.955 GB, free: 0.8922 GB / 1.87 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.004562/4.431, allocations: 9.611 MB / 2.965 GB, free: 0.8825 GB / 1.87 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.00537/4.436, allocations: 7.14 MB / 2.972 GB, free: 0.8773 GB / 1.87 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.422e-05/4.436, allocations: 23.66 kB / 2.972 GB, free: 0.8773 GB / 1.87 GB Notification: Performance of matching and sorting (n=847) (initialization): time 0.01041/4.447, allocations: 8.06 MB / 2.98 GB, free: 0.874 GB / 1.87 GB Notification: Performance of prepare postOptimizeDAE: time 4.29e-05/4.447, allocations: 42.41 kB / 2.98 GB, free: 0.874 GB / 1.87 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.995e-05/4.447, allocations: 83.06 kB / 2.98 GB, free: 0.874 GB / 1.87 GB Notification: Performance of postOpt tearingSystem (initialization): time 7.443e-05/4.447, allocations: 118.2 kB / 2.98 GB, free: 0.874 GB / 1.87 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002342/4.449, allocations: 1.456 MB / 2.981 GB, free: 0.8738 GB / 1.87 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 9.382e-05/4.449, allocations: 175 kB / 2.981 GB, free: 0.8738 GB / 1.87 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005598/4.455, allocations: 0.8016 MB / 2.982 GB, free: 0.8733 GB / 1.87 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005482/4.455, allocations: 392 kB / 2.983 GB, free: 0.8733 GB / 1.87 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 367 * Number of states: 0 () * Number of discrete variables: 4 (senDifEntFlo1.state_b1_inflow.phase,senDifEntFlo1.state_a1_inflow.phase,senDifEntFlo.state_b1_inflow.phase,senDifEntFlo.state_a1_inflow.phase) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (847): * Single equations (assignments): 847 * 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 0.006378/4.462, allocations: 3.581 MB / 2.986 GB, free: 0.8713 GB / 1.87 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002944/4.465, allocations: 1.352 MB / 2.987 GB, free: 0.8705 GB / 1.87 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007497/4.472, allocations: 7.438 MB / 2.995 GB, free: 0.8677 GB / 1.87 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.538e-05/4.472, allocations: 82.84 kB / 2.995 GB, free: 0.8676 GB / 1.87 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.949e-05/4.472, allocations: 7.125 kB / 2.995 GB, free: 0.8676 GB / 1.87 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002261/4.475, allocations: 3.889 MB / 2.999 GB, free: 0.865 GB / 1.87 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02634/4.501, allocations: 25.4 MB / 3.023 GB, free: 0.8505 GB / 1.87 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.923e-05/4.501, allocations: 32 kB / 3.023 GB, free: 0.8505 GB / 1.87 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00138/4.502, allocations: 0.7722 MB / 3.024 GB, free: 0.8497 GB / 1.87 GB Notification: Performance of postOpt tearingSystem (simulation): time 3.801e-05/4.502, allocations: 62.64 kB / 3.024 GB, free: 0.8497 GB / 1.87 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002078/4.503, allocations: 152 kB / 3.024 GB, free: 0.8495 GB / 1.87 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.609e-05/4.503, allocations: 67.78 kB / 3.024 GB, free: 0.8495 GB / 1.87 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.307e-05/4.503, allocations: 47.81 kB / 3.024 GB, free: 0.8494 GB / 1.87 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.009995/4.513, allocations: 11.7 MB / 3.036 GB, free: 0.8374 GB / 1.87 GB Notification: Performance of postOpt removeConstants (simulation): time 0.004368/4.517, allocations: 2.235 MB / 3.038 GB, free: 0.8352 GB / 1.87 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001362/4.518, allocations: 155.7 kB / 3.038 GB, free: 0.8351 GB / 1.87 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002819/4.521, allocations: 169.2 kB / 3.038 GB, free: 0.8349 GB / 1.87 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002895/4.521, allocations: 418.4 kB / 3.039 GB, free: 0.8345 GB / 1.87 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003098/4.522, allocations: 259.9 kB / 3.039 GB, free: 0.8343 GB / 1.87 GB Notification: Performance of sorting global known variables: time 0.009048/4.531, allocations: 8.138 MB / 3.047 GB, free: 0.8264 GB / 1.87 GB Notification: Performance of sort global known variables: time 1.9e-07/4.531, allocations: 5.844 kB / 3.047 GB, free: 0.8264 GB / 1.87 GB Notification: Performance of remove unused functions: time 0.01445/4.545, allocations: 5.886 MB / 3.053 GB, free: 0.8207 GB / 1.87 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 141 * Number of states: 15 (buiTesFacMul.bui.loaHea.vol.dynBal.U,buiTesFacMul.bui.loaCoo.vol.dynBal.U,buiTesOutETSBui.bui.loaHea.vol.dynBal.U,buiTesOutETSBui.bui.loaCoo.vol.dynBal.U,buiTesOutETS.bui.loaHea.vol.dynBal.U,buiTesOutETS.bui.loaCoo.vol.dynBal.U,buiComGen5.bui.loaHea.vol.dynBal.U,buiComGen5.bui.loaCoo.vol.dynBal.U,buiHeaGen2to4.bui.loaHea.vol.dynBal.U,buiComGen2to4.bui.loaHea.vol.dynBal.U,buiComGen2to4.bui.loaCoo.vol.dynBal.U,buiCoo.bui.loaCoo.vol.dynBal.U,buiComGen1.bui.loaHea.vol.dynBal.U,buiComGen1.bui.loaCoo.vol.dynBal.U,buiHeaGen1.bui.loaHea.vol.dynBal.U) * Number of discrete variables: 4 ($cse12.phase,$cse12.region,$cse3.phase,$cse3.region) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (478): * Single equations (assignments): 412 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 66 * 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.007303/4.552, allocations: 4.649 MB / 3.057 GB, free: 0.8168 GB / 1.87 GB Notification: Performance of simCode: created initialization part: time 0.006433/4.559, allocations: 5.517 MB / 3.063 GB, free: 0.8114 GB / 1.87 GB Notification: Performance of simCode: created event and clocks part: time 3.559e-05/4.559, allocations: 8 kB / 3.063 GB, free: 0.8114 GB / 1.87 GB Notification: Performance of simCode: created simulation system equations: time 0.002221/4.561, allocations: 2.468 MB / 3.065 GB, free: 0.809 GB / 1.87 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01786/4.579, allocations: 5.898 MB / 3.071 GB, free: 0.8037 GB / 1.87 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03002/4.609, allocations: 27.5 MB / 3.098 GB, free: 0.7764 GB / 1.87 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004684/4.614, allocations: 7.263 MB / 3.105 GB, free: 0.7693 GB / 1.87 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002334/4.616, allocations: 0.8948 MB / 3.106 GB, free: 0.7684 GB / 1.87 GB Notification: Performance of SimCode: time 2.485e-06/4.616, allocations: 0 / 3.106 GB, free: 0.7684 GB / 1.87 GB Notification: Performance of Templates: time 0.2621/4.878, allocations: 276.6 MB / 3.376 GB, free: 0.4991 GB / 1.87 GB " [Timeout remaining time 295] make -j1 -f Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.makefile [Timeout 300] (rm -f Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; mkfifo Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; head -c 1048576 < Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe >> ../files/Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.sim & ./Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS -abortSlowSimulation -alarm=400 -emit_protected -lv LOG_STATS > Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe 2>&1) [Timeout 400] diffSimulationResults("Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_DHC_Loads_BaseClasses_Validation_BuildingWithETS.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.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: 39.29295377526432]