Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AixLib_AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState.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/Modelica_DeviceDrivers 2.1.1-master/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/package.mo", uses=false) Using package AixLib with version 1.3.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/package.mo) Using package SDF with version 0.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo) Using package Modelica_DeviceDrivers with version 2.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-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(AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="AixLib_AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState") translateModel(AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="AixLib_AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001576/0.001576, allocations: 116.2 kB / 16.42 MB, free: 6.492 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.001873/0.001873, allocations: 183.9 kB / 17.35 MB, free: 5.762 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.273/1.273, allocations: 222.9 MB / 241.1 MB, free: 15.16 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/package.mo): time 0.05544/0.05544, allocations: 12.04 MB / 303.3 MB, free: 3.121 MB / 238.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo): time 0.00052/0.00052, allocations: 23.97 kB / 356.3 MB, free: 14 MB / 302.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:6228:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:6853:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:8435:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:9369:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:11505:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/Obsolete/YearIndependent/FastHVAC/Components/HeatExchangers/RadiatorMultiLayer.mo:265:34-265:12875:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/ThermalZones/HighOrder/Components/Examples/DryAir/DryAir_test.mo:71:18-71:405:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/ThermalZones/HighOrder/Components/DryAir/InfiltrationRate_DIN12831.mo:20:192-20:2066:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/ThermalZones/HighOrder/Components/DryAir/InfiltrationRate_DIN12831.mo:20:192-20:4252:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/DataBase/Weather/SurfaceOrientation/SurfaceOrientationData_N_E_S_W_RoofN_Roof_S.mo:5:35-5:362:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/DataBase/Weather/SurfaceOrientation/SurfaceOrientationData_N_E_S_W_Hor.mo:5:35-5:320:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/DataBase/Weather/SurfaceOrientation/SurfaceOrientationData_NE_SE_SW_NW_Hor.mo:5:35-5:324:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/DataBase/CHP/CHPDataSimple/CHP_XRGI_9kWel.mo:25:34-25:588:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/DataBase/CHP/CHPDataSimple/CHP_XRGI_9kWel.mo:25:34-25:3852:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/DataBase/CHP/CHPDataSimple/CHP_Cleanergy_C9G.mo:36:34-36:594:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/BoundaryConditions/InternalGains/Examples/InternalGains/Machines.mo:31:20-31:400:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/BoundaryConditions/InternalGains/Examples/InternalGains/Lights.mo:27:20-27:398:writable] Warning: Lexer treating \ as \\, since \ is not a valid Modelica escape sequence. Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.3.2/package.mo): time 1.461/1.461, allocations: 268.2 MB / 0.6617 GB, free: 2.617 MB / 478.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001959/0.00196, allocations: 115.8 kB / 0.888 GB, free: 2.797 MB / 0.6075 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.4456/0.4476, allocations: 108.4 MB / 0.9939 GB, free: 1.152 MB / 0.67 GB Notification: Performance of NFInst.instantiate(AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState): time 0.1812/0.6288, allocations: 187.1 MB / 1.177 GB, free: 5.352 MB / 0.8575 GB Notification: Performance of NFInst.instExpressions: time 0.01434/0.6432, allocations: 13.03 MB / 1.189 GB, free: 8.281 MB / 0.8732 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.0008626/0.6441, allocations: 35.75 kB / 1.189 GB, free: 8.246 MB / 0.8732 GB Notification: Performance of NFTyping.typeComponents: time 0.001097/0.6452, allocations: 425.2 kB / 1.19 GB, free: 7.828 MB / 0.8732 GB Notification: Performance of NFTyping.typeBindings: time 0.001911/0.6471, allocations: 0.9527 MB / 1.191 GB, free: 6.871 MB / 0.8732 GB Notification: Performance of NFTyping.typeClassSections: time 0.00164/0.6488, allocations: 0.7064 MB / 1.191 GB, free: 6.172 MB / 0.8732 GB Notification: Performance of NFFlatten.flatten: time 0.001695/0.6505, allocations: 1.508 MB / 1.193 GB, free: 4.66 MB / 0.8732 GB Notification: Performance of NFFlatten.resolveConnections: time 0.0008755/0.6514, allocations: 0.6391 MB / 1.193 GB, free: 4.008 MB / 0.8732 GB Notification: Performance of NFEvalConstants.evaluate: time 0.00326/0.6546, allocations: 1.782 MB / 1.195 GB, free: 2.219 MB / 0.8732 GB Notification: Performance of NFSimplifyModel.simplify: time 0.001111/0.6558, allocations: 0.5119 MB / 1.196 GB, free: 1.715 MB / 0.8732 GB Notification: Performance of NFPackage.collectConstants: time 0.0001113/0.6559, allocations: 52 kB / 1.196 GB, free: 1.664 MB / 0.8732 GB Notification: Performance of NFFlatten.collectFunctions: time 0.001389/0.6573, allocations: 0.8809 MB / 1.197 GB, free: 0.7812 MB / 0.8732 GB Notification: Performance of NFScalarize.scalarize: time 0.0002653/0.6575, allocations: 275.2 kB / 1.197 GB, free: 0.5117 MB / 0.8732 GB Notification: Performance of NFVerifyModel.verify: time 0.0004112/0.658, allocations: 382 kB / 1.197 GB, free: 140 kB / 0.8732 GB Notification: Performance of NFConvertDAE.convert: time 0.001438/0.6594, allocations: 1.184 MB / 1.198 GB, free: 14.95 MB / 0.8888 GB Notification: Performance of FrontEnd - DAE generated: time 3.977e-06/0.6594, allocations: 0 / 1.198 GB, free: 14.95 MB / 0.8888 GB Notification: Performance of FrontEnd: time 1.783e-06/0.6594, allocations: 4 kB / 1.198 GB, free: 14.95 MB / 0.8888 GB Notification: Performance of Transformations before backend: time 3.289e-05/0.6595, allocations: 0 / 1.198 GB, free: 14.95 MB / 0.8888 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 144 * Number of variables: 144 Notification: Performance of Generate backend data structure: time 0.001712/0.6612, allocations: 1.051 MB / 1.199 GB, free: 13.84 MB / 0.8888 GB Notification: Performance of prepare preOptimizeDAE: time 4.069e-05/0.6612, allocations: 8.031 kB / 1.199 GB, free: 13.83 MB / 0.8888 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0009896/0.6622, allocations: 186.9 kB / 1.2 GB, free: 13.65 MB / 0.8888 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.0009193/0.6632, allocations: 0.548 MB / 1.2 GB, free: 13.07 MB / 0.8888 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.636e-05/0.6632, allocations: 49.31 kB / 1.2 GB, free: 13.02 MB / 0.8888 GB Notification: Performance of preOpt expandDerOperator (simulation): time 8.846e-05/0.6633, allocations: 59.94 kB / 1.2 GB, free: 12.96 MB / 0.8888 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.00113/0.6644, allocations: 0.775 MB / 1.201 GB, free: 12.07 MB / 0.8888 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.31e-05/0.6645, allocations: 7.938 kB / 1.201 GB, free: 12.07 MB / 0.8888 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.209e-05/0.6645, allocations: 28 kB / 1.201 GB, free: 12.04 MB / 0.8888 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.036e-05/0.6646, allocations: 25 kB / 1.201 GB, free: 12.02 MB / 0.8888 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0009033/0.6655, allocations: 455.3 kB / 1.201 GB, free: 11.57 MB / 0.8888 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.003749/0.6692, allocations: 4.382 MB / 1.206 GB, free: 6.957 MB / 0.8888 GB Notification: Performance of preOpt comSubExp (simulation): time 0.0001779/0.6694, allocations: 106.4 kB / 1.206 GB, free: 6.816 MB / 0.8888 GB Notification: Performance of preOpt resolveLoops (simulation): time 9.01e-05/0.6695, allocations: 71.5 kB / 1.206 GB, free: 6.734 MB / 0.8888 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0001511/0.6697, allocations: 93.09 kB / 1.206 GB, free: 6.625 MB / 0.8888 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.567e-05/0.6697, allocations: 46.5 kB / 1.206 GB, free: 6.57 MB / 0.8888 GB Notification: Performance of pre-optimization done (n=10): time 1.603e-06/0.6697, allocations: 0 / 1.206 GB, free: 6.57 MB / 0.8888 GB Notification: Performance of matching and sorting (n=10): time 0.0006227/0.6704, allocations: 240.6 kB / 1.206 GB, free: 6.328 MB / 0.8888 GB Notification: Performance of inlineWhenForInitialization (initialization): time 6.264e-05/0.6704, allocations: 140.7 kB / 1.206 GB, free: 6.16 MB / 0.8888 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001068/0.6715, allocations: 0.8369 MB / 1.207 GB, free: 5.309 MB / 0.8888 GB Notification: Performance of collectPreVariables (initialization): time 3.359e-05/0.6716, allocations: 33.7 kB / 1.207 GB, free: 5.27 MB / 0.8888 GB Notification: Performance of collectInitialEqns (initialization): time 0.0002784/0.6718, allocations: 406.8 kB / 1.208 GB, free: 4.867 MB / 0.8888 GB Notification: Performance of collectInitialBindings (initialization): time 3.299e-05/0.6719, allocations: 39.45 kB / 1.208 GB, free: 4.828 MB / 0.8888 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001246/0.672, allocations: 89.97 kB / 1.208 GB, free: 4.734 MB / 0.8888 GB Notification: Performance of setup shared object (initialization): time 9.927e-05/0.6721, allocations: 322 kB / 1.208 GB, free: 4.414 MB / 0.8888 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002752/0.6724, allocations: 112.7 kB / 1.208 GB, free: 4.305 MB / 0.8888 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004238/0.6728, allocations: 361.7 kB / 1.209 GB, free: 3.836 MB / 0.8888 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.0005342/0.6734, allocations: 437.5 kB / 1.209 GB, free: 3.301 MB / 0.8888 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.261e-06/0.6734, allocations: 4 kB / 1.209 GB, free: 3.297 MB / 0.8888 GB Notification: Performance of matching and sorting (n=46) (initialization): time 0.0008994/0.6743, allocations: 0.4999 MB / 1.209 GB, free: 2.789 MB / 0.8888 GB Notification: Performance of prepare postOptimizeDAE: time 1.74e-05/0.6743, allocations: 8 kB / 1.209 GB, free: 2.781 MB / 0.8888 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.177e-05/0.6743, allocations: 8.844 kB / 1.209 GB, free: 2.773 MB / 0.8888 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.151e-05/0.6744, allocations: 12 kB / 1.209 GB, free: 2.762 MB / 0.8888 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003203/0.6747, allocations: 99.89 kB / 1.21 GB, free: 2.664 MB / 0.8888 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.714e-05/0.6747, allocations: 15.92 kB / 1.21 GB, free: 2.648 MB / 0.8888 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006303/0.6753, allocations: 127 kB / 1.21 GB, free: 2.523 MB / 0.8888 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.498e-05/0.6754, allocations: 24 kB / 1.21 GB, free: 2.5 MB / 0.8888 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 35 * 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 (46): * Single equations (assignments): 46 * 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.0002326/0.6756, allocations: 229.6 kB / 1.21 GB, free: 2.266 MB / 0.8888 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001415/0.6758, allocations: 71.16 kB / 1.21 GB, free: 2.195 MB / 0.8888 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0001028/0.6759, allocations: 70.17 kB / 1.21 GB, free: 2.121 MB / 0.8888 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.438e-06/0.6759, allocations: 4 kB / 1.21 GB, free: 2.117 MB / 0.8888 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.313e-06/0.6759, allocations: 0 / 1.21 GB, free: 2.117 MB / 0.8888 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0002102/0.6761, allocations: 172.1 kB / 1.21 GB, free: 1.93 MB / 0.8888 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 9.24e-05/0.6762, allocations: 4 kB / 1.21 GB, free: 1.926 MB / 0.8888 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004323/0.6767, allocations: 15.98 kB / 1.21 GB, free: 1.91 MB / 0.8888 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 1.983e-05/0.6767, allocations: 7.984 kB / 1.21 GB, free: 1.902 MB / 0.8888 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0002798/0.677, allocations: 423.1 kB / 1.211 GB, free: 1.48 MB / 0.8888 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.000334/0.6773, allocations: 0.57 MB / 1.211 GB, free: 0.8906 MB / 0.8888 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 6.681e-05/0.6774, allocations: 43.95 kB / 1.211 GB, free: 0.8477 MB / 0.8888 GB Notification: Performance of sorting global known variables: time 0.0007518/0.6782, allocations: 0.5888 MB / 1.212 GB, free: 272 kB / 0.8888 GB Notification: Performance of Backend: time 3.21e-07/0.6782, allocations: 0 / 1.212 GB, free: 272 kB / 0.8888 GB Notification: Performance of simCode: created initialization part: time 0.001562/0.6797, allocations: 483.8 kB / 1.212 GB, free: 15.8 MB / 0.9044 GB Notification: Performance of SimCode: time 0.002734/0.6825, allocations: 1.812 MB / 1.214 GB, free: 13.96 MB / 0.9044 GB Notification: Performance of Templates: time 0.02051/0.703, allocations: 13.95 MB / 1.228 GB, free: 244 kB / 0.9044 GB make -j1 -f AixLib_AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState.makefile (rm -f AixLib_AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState.pipe ; mkfifo AixLib_AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState.pipe ; head -c 1048576 < AixLib_AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState.pipe >> ../files/AixLib_AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState.sim & ./AixLib_AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState -abortSlowSimulation -alarm=480 -lv LOG_STATS > AixLib_AixLib.Fluid.MixingVolumes.Validation.TraceSubstanceConservationSteadyState.pipe 2>&1)