Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AixLib_latest_AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001293/0.001293, allocations: 111.3 kB / 17.96 MB, free: 3.859 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001318/0.001318, allocations: 193.5 kB / 21.21 MB, free: 0.6172 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.384/1.384, allocations: 225.6 MB / 249.9 MB, free: 13.36 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1/package.mo): time 0.06287/0.06287, allocations: 12.18 MB / 317.3 MB, free: 13.07 MB / 254.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo): time 0.0007584/0.0007584, allocations: 31.92 kB / 375.5 MB, free: 2.727 MB / 302.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/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.4.0-development/package.mo): time 1.913/1.913, allocations: 275.6 MB / 0.6927 GB, free: 9.094 MB / 462.1 MB
"
[Timeout remaining time 178]
Using package AixLib with version 1.4.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 1.4.0-development/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/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.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650,tolerance=1e-06,outputFormat="empty",numberOfIntervals=8760,variableFilter="",fileNamePrefix="AixLib_latest_AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650")
translateModel(AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650,tolerance=1e-06,outputFormat="empty",numberOfIntervals=8760,variableFilter="",fileNamePrefix="AixLib_latest_AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.003302/0.003302, allocations: 122.1 kB / 0.9362 GB, free: 27.93 MB / 0.6388 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2667/0.27, allocations: 115.4 MB / 1.049 GB, free: 0.9727 MB / 0.7013 GB
Notification: Performance of NFInst.instantiate(AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650): time 0.69/0.96, allocations: 207.5 MB / 1.252 GB, free: 4.211 MB / 0.8732 GB
Notification: Performance of NFInst.instExpressions: time 0.02205/0.982, allocations: 14.11 MB / 1.265 GB, free: 3.969 MB / 0.8732 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004384/0.9864, allocations: 104.8 kB / 1.265 GB, free: 3.969 MB / 0.8732 GB
Notification: Performance of NFTyping.typeComponents: time 0.002456/0.9889, allocations: 0.9514 MB / 1.266 GB, free: 3.957 MB / 0.8732 GB
Notification: Performance of NFTyping.typeBindings: time 0.007936/0.9968, allocations: 2.484 MB / 1.269 GB, free: 3.871 MB / 0.8732 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005923/1.003, allocations: 2.295 MB / 1.271 GB, free: 3.766 MB / 0.8732 GB
Notification: Performance of NFFlatten.flatten: time 0.01043/1.013, allocations: 8.307 MB / 1.279 GB, free: 3.742 MB / 0.8732 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.009163/1.022, allocations: 6.269 MB / 1.285 GB, free: 18.95 MB / 0.8888 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007257/1.03, allocations: 3.717 MB / 1.289 GB, free: 17.43 MB / 0.8888 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.006121/1.036, allocations: 4.254 MB / 1.293 GB, free: 15.59 MB / 0.8888 GB
Notification: Performance of NFPackage.collectConstants: time 0.002215/1.038, allocations: 0.8462 MB / 1.294 GB, free: 15.59 MB / 0.8888 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005387/1.043, allocations: 2.126 MB / 1.296 GB, free: 15.22 MB / 0.8888 GB
Notification: Performance of NFScalarize.scalarize: time 0.002437/1.046, allocations: 2.141 MB / 1.298 GB, free: 13.98 MB / 0.8888 GB
Notification: Performance of NFVerifyModel.verify: time 0.005761/1.051, allocations: 3.692 MB / 1.302 GB, free: 11.57 MB / 0.8888 GB
Notification: Performance of NFConvertDAE.convert: time 0.01372/1.065, allocations: 10.92 MB / 1.312 GB, free: 6.336 MB / 0.8888 GB
Notification: Performance of FrontEnd - DAE generated: time 4.889e-06/1.065, allocations: 0 / 1.312 GB, free: 6.336 MB / 0.8888 GB
Notification: Performance of FrontEnd: time 1.733e-06/1.065, allocations: 0.8438 kB / 1.312 GB, free: 6.336 MB / 0.8888 GB
Notification: Performance of Transformations before backend: time 0.0002726/1.065, allocations: 0 / 1.312 GB, free: 6.336 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: 1627
 * Number of variables: 1627
Notification: Performance of Generate backend data structure: time 0.01935/1.085, allocations: 8.133 MB / 1.32 GB, free: 1.109 MB / 0.8888 GB
Notification: Performance of prepare preOptimizeDAE: time 3.709e-05/1.085, allocations: 11.19 kB / 1.32 GB, free: 1.109 MB / 0.8888 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.03331/1.118, allocations: 6.695 MB / 1.327 GB, free: 13.94 MB / 0.9044 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.008859/1.127, allocations: 3.856 MB / 1.331 GB, free: 11.61 MB / 0.9044 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003473/1.127, allocations: 482.4 kB / 1.331 GB, free: 11.38 MB / 0.9044 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001772/1.129, allocations: 0.6001 MB / 1.332 GB, free: 11.18 MB / 0.9044 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02773/1.157, allocations: 11.08 MB / 1.342 GB, free: 1.391 MB / 0.9044 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001104/1.157, allocations: 7.938 kB / 1.342 GB, free: 1.383 MB / 0.9044 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0008353/1.158, allocations: 260 kB / 1.343 GB, free: 1.129 MB / 0.9044 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001297/1.158, allocations: 155.9 kB / 1.343 GB, free: 0.9766 MB / 0.9044 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03813/1.196, allocations: 13.7 MB / 1.356 GB, free: 3.258 MB / 0.92 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.06278/1.259, allocations: 27.76 MB / 1.383 GB, free: 7.426 MB / 0.9513 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02096/1.28, allocations: 7.554 MB / 1.391 GB, free: 15.83 MB / 0.9669 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01357/1.293, allocations: 4.904 MB / 1.395 GB, free: 10.91 MB / 0.9669 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001612/1.295, allocations: 0.9133 MB / 1.396 GB, free: 9.859 MB / 0.9669 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01559/1.311, allocations: 5.564 MB / 1.402 GB, free: 4.199 MB / 0.9669 GB
Notification: Performance of pre-optimization done (n=520): time 9.878e-06/1.311, allocations: 0 / 1.402 GB, free: 4.199 MB / 0.9669 GB
Notification: Performance of matching and sorting (n=520): time 0.04542/1.356, allocations: 15.04 MB / 1.417 GB, free: 5.004 MB / 0.9825 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002432/1.356, allocations: 338.8 kB / 1.417 GB, free: 4.602 MB / 0.9825 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005444/1.362, allocations: 3.257 MB / 1.42 GB, free: 1.352 MB / 0.9825 GB
Notification: Performance of collectPreVariables (initialization): time 0.001463/1.363, allocations: 113.7 kB / 1.42 GB, free: 1.234 MB / 0.9825 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002646/1.366, allocations: 2.369 MB / 1.422 GB, free: 14.85 MB / 0.9982 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003256/1.369, allocations: 1.819 MB / 1.424 GB, free: 13.06 MB / 0.9982 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002464/1.372, allocations: 0.957 MB / 1.425 GB, free: 12.09 MB / 0.9982 GB
Notification: Performance of setup shared object (initialization): time 0.0001273/1.372, allocations: 305.1 kB / 1.425 GB, free: 11.79 MB / 0.9982 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0122/1.384, allocations: 4.34 MB / 1.43 GB, free: 7.441 MB / 0.9982 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01331/1.397, allocations: 4.964 MB / 1.435 GB, free: 2.309 MB / 0.9982 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02496/1.422, allocations: 9.229 MB / 1.444 GB, free: 8.902 MB / 1.014 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.714e-05/1.422, allocations: 0 / 1.444 GB, free: 8.902 MB / 1.014 GB
Notification: Performance of matching and sorting (n=600) (initialization): time 0.02919/1.451, allocations: 10.33 MB / 1.454 GB, free: 14.54 MB / 1.029 GB
Notification: Performance of prepare postOptimizeDAE: time 3.189e-05/1.451, allocations: 8 kB / 1.454 GB, free: 14.53 MB / 1.029 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.647e-05/1.451, allocations: 8 kB / 1.454 GB, free: 14.52 MB / 1.029 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000933/1.452, allocations: 359.6 kB / 1.454 GB, free: 14.17 MB / 1.029 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009427/1.462, allocations: 1.744 MB / 1.456 GB, free: 12.48 MB / 1.029 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006164/1.468, allocations: 4.252 MB / 1.46 GB, free: 8.109 MB / 1.029 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00807/1.476, allocations: 1.179 MB / 1.461 GB, free: 6.926 MB / 1.029 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001118/1.477, allocations: 239.8 kB / 1.461 GB, free: 6.691 MB / 1.029 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 42
 * Number of states: 0 ()
 * Number of discrete variables: 30 ($PRE.souWea.nextTimeEvent,$whenCondition4,$PRE.souRad.nextTimeEvent,$whenCondition3,$PRE.SouTSetC.nextTimeEvent,$whenCondition2,$PRE.InfVen.nextTimeEvent,$whenCondition1,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,InfVen.nextTimeEventScaled,$PRE.InfVen.nextTimeEventScaled,InfVen.nextTimeEvent,SouTSetC.nextTimeEventScaled,$PRE.SouTSetC.nextTimeEventScaled,SouTSetC.nextTimeEvent,souRad.nextTimeEventScaled,$PRE.souRad.nextTimeEventScaled,souRad.nextTimeEvent,souWea.nextTimeEventScaled,$PRE.souWea.nextTimeEventScaled,souWea.nextTimeEvent,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,$whenCondition5,$whenCondition6,integrator.local_reset,conCoo.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (570):
 * Single equations (assignments): 569
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(3,28,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.00399/1.481, allocations: 1.649 MB / 1.463 GB, free: 5.094 MB / 1.029 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001324/1.482, allocations: 469 kB / 1.463 GB, free: 4.633 MB / 1.029 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03273/1.515, allocations: 11.57 MB / 1.475 GB, free: 8.957 MB / 1.045 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.36e-05/1.515, allocations: 58.53 kB / 1.475 GB, free: 8.902 MB / 1.045 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.588e-05/1.515, allocations: 4 kB / 1.475 GB, free: 8.898 MB / 1.045 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02695/1.542, allocations: 9.498 MB / 1.484 GB, free: 15.25 MB / 1.061 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.04391/1.586, allocations: 18.6 MB / 1.502 GB, free: 12.62 MB / 1.076 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.74e-05/1.586, allocations: 4 kB / 1.502 GB, free: 12.61 MB / 1.076 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.009318/1.595, allocations: 1.586 MB / 1.504 GB, free: 11.07 MB / 1.076 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001144/1.597, allocations: 377.1 kB / 1.504 GB, free: 10.7 MB / 1.076 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001403/1.598, allocations: 143.9 kB / 1.504 GB, free: 10.55 MB / 1.076 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007814/1.606, allocations: 6.293 MB / 1.51 GB, free: 3.988 MB / 1.076 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.264e-06/1.606, allocations: 0 / 1.51 GB, free: 3.988 MB / 1.076 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04347/1.649, allocations: 16.4 MB / 1.526 GB, free: 3.434 MB / 1.092 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.004114/1.653, allocations: 1.453 MB / 1.528 GB, free: 1.957 MB / 1.092 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001288/1.655, allocations: 115.8 kB / 1.528 GB, free: 1.844 MB / 1.092 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006841/1.662, allocations: 0.8666 MB / 1.529 GB, free: 0.9766 MB / 1.092 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001008/1.663, allocations: 322.2 kB / 1.529 GB, free: 0.6602 MB / 1.092 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0006221/1.663, allocations: 187.9 kB / 1.529 GB, free: 488 kB / 1.092 GB
Notification: Performance of sorting global known variables: time 0.00505/1.668, allocations: 2.39 MB / 1.531 GB, free: 14.11 MB / 1.108 GB
Notification: Performance of sort global known variables: time 1.1e-07/1.668, allocations: 0 / 1.531 GB, free: 14.11 MB / 1.108 GB
Notification: Performance of remove unused functions: time 0.008237/1.676, allocations: 1.874 MB / 1.533 GB, free: 12.23 MB / 1.108 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 6 (thermalZoneThreeElements.volAir.dynBal.U,thermalZoneThreeElements.volAir.dynBal.m,thermalZoneThreeElements.extWallRC.thermCapExt[1].T,thermalZoneThreeElements.intWallRC.thermCapInt[1].T,conCoo.I.y,integrator.y)
 * Number of discrete variables: 16 ($whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,weaDat.conTimMin.tNext,weaDat.conTim.tNext,souWea.nextTimeEvent,souWea.nextTimeEventScaled,souRad.nextTimeEvent,souRad.nextTimeEventScaled,SouTSetC.nextTimeEvent,SouTSetC.nextTimeEventScaled,InfVen.nextTimeEvent,InfVen.nextTimeEventScaled)
 * Number of discrete states: 10 (souWea.nextTimeEvent,souRad.nextTimeEvent,SouTSetC.nextTimeEvent,InfVen.nextTimeEvent,InfVen.nextTimeEventScaled,SouTSetC.nextTimeEventScaled,souRad.nextTimeEventScaled,souWea.nextTimeEventScaled,weaDat.conTimMin.tNext,weaDat.conTim.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (511):
 * Single equations (assignments): 498
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 10
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,3,100.0%), (3,25,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,1)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.005303/1.682, allocations: 1.299 MB / 1.535 GB, free: 11.38 MB / 1.108 GB
Notification: Performance of simCode: created initialization part: time 0.02814/1.71, allocations: 9.756 MB / 1.544 GB, free: 1.617 MB / 1.108 GB
Notification: Performance of simCode: created event and clocks part: time 6.292e-06/1.71, allocations: 0 / 1.544 GB, free: 1.617 MB / 1.108 GB
Notification: Performance of simCode: created simulation system equations: time 0.01393/1.724, allocations: 5.133 MB / 1.549 GB, free: 12.54 MB / 1.123 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005406/1.729, allocations: 1.024 MB / 1.55 GB, free: 11.56 MB / 1.123 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03311/1.762, allocations: 14.71 MB / 1.564 GB, free: 12.79 MB / 1.139 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004344/1.767, allocations: 3.987 MB / 1.568 GB, free: 8.773 MB / 1.139 GB
Notification: Performance of simCode: alias equations: time 0.00994/1.777, allocations: 2.302 MB / 1.571 GB, free: 6.465 MB / 1.139 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002825/1.779, allocations: 495.1 kB / 1.571 GB, free: 5.98 MB / 1.139 GB
Notification: Performance of SimCode: time 9.72e-07/1.779, allocations: 0 / 1.571 GB, free: 5.98 MB / 1.139 GB
Notification: Performance of Templates: time 0.1472/1.927, allocations: 82.09 MB / 1.651 GB, free: 4.594 MB / 1.217 GB
"
[Timeout remaining time 658]
make -j1 -f AixLib_latest_AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650.makefile [Timeout 660]
(rm -f AixLib_latest_AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650.pipe ; mkfifo AixLib_latest_AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650.pipe ; head -c 1048576 < AixLib_latest_AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650.pipe >> ../files/AixLib_latest_AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650.sim & ./AixLib_latest_AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650  -abortSlowSimulation -alarm=480 -lv LOG_STATS > AixLib_latest_AixLib.ThermalZones.ReducedOrder.Validation.ASHRAE140.ThreeElements.TestCase650.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 11.38782318495214]
Failed to read output from testmodel.py, exit status != 0:
1.9358810298144817 1.950683566 0.88216181
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f834173e020>