Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AixLib_AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270.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.0009634/0.0009634, allocations: 92.2 kB / 20.19 MB, free: 4.355 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.0009269/0.0009269, allocations: 173 kB / 23.49 MB, free: 1.051 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.9277/0.9277, allocations: 177.1 MB / 203.8 MB, free: 5.629 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo): time 0.03641/0.03641, allocations: 9.129 MB / 269.4 MB, free: 4.336 MB / 250.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[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.0005519/0.0005519, allocations: 35.72 kB / 328.9 MB, free: 20.46 MB / 266.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.1/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.1/package.mo): time 1.685/1.685, allocations: 274.9 MB / 0.6478 GB, free: 2.457 MB / 0.4949 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 178]
Using package AixLib with version 3.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.1/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.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/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(AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="AixLib_AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270")
translateModel(AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="AixLib_AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.763e-06/1.763e-06, allocations: 3.938 kB / 0.7983 GB, free: 7.914 MB / 0.6512 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.286e-05/2.463e-05, allocations: 2.312 kB / 0.7983 GB, free: 7.91 MB / 0.6512 GB
Notification: Performance of NFInst.instantiate(AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270): time 0.5586/0.5586, allocations: 276 MB / 1.068 GB, free: 10.89 MB / 0.823 GB
Notification: Performance of NFInst.instExpressions: time 0.07392/0.6326, allocations: 49.47 MB / 1.116 GB, free: 9.379 MB / 0.8699 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02716/0.6597, allocations: 0.6982 MB / 1.117 GB, free: 8.676 MB / 0.8699 GB
Notification: Performance of NFTyping.typeComponents: time 0.01467/0.6744, allocations: 7.485 MB / 1.124 GB, free: 1.152 MB / 0.8699 GB
Notification: Performance of NFTyping.typeBindings: time 0.01912/0.6935, allocations: 7.979 MB / 1.132 GB, free: 9.129 MB / 0.8855 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01319/0.7067, allocations: 6.988 MB / 1.139 GB, free: 2.172 MB / 0.8855 GB
Notification: Performance of NFFlatten.flatten: time 0.8297/1.536, allocations: 27.82 MB / 1.166 GB, free: 19.26 MB / 0.9013 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01663/1.553, allocations: 12.32 MB / 1.178 GB, free: 18.47 MB / 0.9013 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02974/1.583, allocations: 14.53 MB / 1.192 GB, free: 18.47 MB / 0.9013 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02246/1.605, allocations: 10.28 MB / 1.202 GB, free: 18.14 MB / 0.9013 GB
Notification: Performance of NFPackage.collectConstants: time 0.008848/1.614, allocations: 2.356 MB / 1.205 GB, free: 18.14 MB / 0.9013 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01406/1.628, allocations: 3.916 MB / 1.208 GB, free: 18.03 MB / 0.9013 GB
Notification: Performance of NFScalarize.scalarize: time 0.01136/1.64, allocations: 6.782 MB / 1.215 GB, free: 17.14 MB / 0.9013 GB
Notification: Performance of NFVerifyModel.verify: time 0.01782/1.657, allocations: 6.898 MB / 1.222 GB, free: 16.32 MB / 0.9013 GB
Notification: Performance of NFConvertDAE.convert: time 0.0278/1.685, allocations: 17.33 MB / 1.239 GB, free: 14.05 MB / 0.9013 GB
Notification: Performance of FrontEnd - DAE generated: time 1.04e-05/1.685, allocations: 0 / 1.239 GB, free: 14.05 MB / 0.9013 GB
Notification: Performance of FrontEnd: time 2.845e-06/1.685, allocations: 0.6875 kB / 1.239 GB, free: 14.05 MB / 0.9013 GB
Notification: Performance of Transformations before backend: time 0.001432/1.687, allocations: 0 / 1.239 GB, free: 14.05 MB / 0.9013 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2803
 * Number of variables: 2803
Notification: Performance of Generate backend data structure: time 0.04332/1.73, allocations: 21.63 MB / 1.26 GB, free: 5.289 MB / 0.9013 GB
Notification: Performance of prepare preOptimizeDAE: time 4.754e-05/1.73, allocations: 11.83 kB / 1.26 GB, free: 5.285 MB / 0.9013 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01539/1.745, allocations: 4.377 MB / 1.264 GB, free: 3.938 MB / 0.9013 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01969/1.765, allocations: 10.93 MB / 1.275 GB, free: 15.96 MB / 0.9169 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006817/1.766, allocations: 0.8842 MB / 1.276 GB, free: 15.51 MB / 0.9169 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002794/1.768, allocations: 1.083 MB / 1.277 GB, free: 15.14 MB / 0.9169 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01985/1.788, allocations: 9.281 MB / 1.286 GB, free: 11.25 MB / 0.9169 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002373/1.789, allocations: 22.52 kB / 1.286 GB, free: 11.24 MB / 0.9169 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007973/1.789, allocations: 446.1 kB / 1.286 GB, free: 10.91 MB / 0.9169 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003357/1.79, allocations: 457.6 kB / 1.287 GB, free: 10.87 MB / 0.9169 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01063/1.8, allocations: 4.957 MB / 1.291 GB, free: 10.14 MB / 0.9169 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.06253/1.863, allocations: 42.7 MB / 1.333 GB, free: 11.37 MB / 0.9482 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01147/1.874, allocations: 7.16 MB / 1.34 GB, free: 4.27 MB / 0.9482 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004557/1.879, allocations: 2.973 MB / 1.343 GB, free: 1.289 MB / 0.9482 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007112/1.88, allocations: 223.3 kB / 1.343 GB, free: 1.07 MB / 0.9482 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004957/1.885, allocations: 3.481 MB / 1.347 GB, free: 13.46 MB / 0.9638 GB
Notification: Performance of pre-optimization done (n=872): time 1.474e-05/1.885, allocations: 0 / 1.347 GB, free: 13.46 MB / 0.9638 GB
Notification: Performance of matching and sorting (n=872): time 0.03724/1.922, allocations: 16.33 MB / 1.363 GB, free: 13.12 MB / 0.9794 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002202/1.922, allocations: 0.5801 MB / 1.363 GB, free: 12.43 MB / 0.9794 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02224/1.944, allocations: 12.66 MB / 1.376 GB, free: 15.86 MB / 0.995 GB
Notification: Performance of collectPreVariables (initialization): time 0.002274/1.947, allocations: 185.7 kB / 1.376 GB, free: 15.67 MB / 0.995 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006069/1.953, allocations: 7.97 MB / 1.383 GB, free: 7.684 MB / 0.995 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00435/1.957, allocations: 3.128 MB / 1.387 GB, free: 4.598 MB / 0.995 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002199/1.959, allocations: 1.516 MB / 1.388 GB, free: 3.074 MB / 0.995 GB
Notification: Performance of setup shared object (initialization): time 0.0001094/1.959, allocations: 484.5 kB / 1.388 GB, free: 2.602 MB / 0.995 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003264/1.963, allocations: 1.396 MB / 1.39 GB, free: 1.203 MB / 0.995 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004185/1.967, allocations: 3.918 MB / 1.394 GB, free: 12.6 MB / 1.011 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007512/1.974, allocations: 4.622 MB / 1.398 GB, free: 7.664 MB / 1.011 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.387e-05/1.974, allocations: 8 kB / 1.398 GB, free: 7.656 MB / 1.011 GB
Notification: Performance of matching and sorting (n=1021) (initialization): time 0.01932/1.994, allocations: 8.444 MB / 1.406 GB, free: 15.25 MB / 1.026 GB
Notification: Performance of prepare postOptimizeDAE: time 4.302e-05/1.994, allocations: 14.66 kB / 1.406 GB, free: 15.24 MB / 1.026 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.844e-05/1.994, allocations: 20 kB / 1.406 GB, free: 15.22 MB / 1.026 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01059/2.004, allocations: 3.64 MB / 1.41 GB, free: 11.45 MB / 1.026 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004166/2.008, allocations: 1.45 MB / 1.411 GB, free: 10.07 MB / 1.026 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03604/2.044, allocations: 74.14 MB / 1.484 GB, free: 12.11 MB / 1.104 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008305/2.053, allocations: 0.8042 MB / 1.485 GB, free: 11.3 MB / 1.104 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001357/2.054, allocations: 303.9 kB / 1.485 GB, free: 11 MB / 1.104 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.007662/2.062, allocations: 1.631 MB / 1.486 GB, free: 9.363 MB / 1.104 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.004435/2.066, allocations: 3.917 MB / 1.49 GB, free: 4.762 MB / 1.104 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.007895/2.074, allocations: 4.616 MB / 1.495 GB, free: 15.83 MB / 1.12 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.675e-05/2.074, allocations: 8 kB / 1.495 GB, free: 15.82 MB / 1.12 GB
Notification: Performance of matching and sorting (n=1021) (initialization_lambda0): time 0.02064/2.095, allocations: 8.443 MB / 1.503 GB, free: 7.426 MB / 1.12 GB
Notification: Performance of prepare postOptimizeDAE: time 3.061e-05/2.095, allocations: 12 kB / 1.503 GB, free: 7.414 MB / 1.12 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.046e-05/2.095, allocations: 20 kB / 1.503 GB, free: 7.395 MB / 1.12 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01016/2.105, allocations: 3.641 MB / 1.507 GB, free: 3.617 MB / 1.12 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004216/2.109, allocations: 1.443 MB / 1.508 GB, free: 2.25 MB / 1.12 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.4058/2.515, allocations: 74.12 MB / 1.58 GB, free: 487.3 MB / 1.183 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007795/2.523, allocations: 0.7844 MB / 1.581 GB, free: 487.3 MB / 1.183 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0009114/2.524, allocations: 303.6 kB / 1.582 GB, free: 487.3 MB / 1.183 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 86
 * Number of states: 0 ()
 * Number of discrete variables: 59 (checkResultsAccordingToASHRAEHeatingOrTempMax.satisfied,$PRE.checkResultsAccordingToASHRAEHeatingOrTempMax.satisfied,checkResultsAccordingToASHRAECoolingOrTempMin.satisfied,$PRE.checkResultsAccordingToASHRAECoolingOrTempMin.satisfied,$PRE.Solar_Radiation.nextTimeEvent,$whenCondition8,$PRE.Source_Weather.nextTimeEvent,$whenCondition7,$whenCondition6,$PRE.ReferenceHeatingLoadOrTempMax.nextTimeEvent,$whenCondition5,$whenCondition4,$PRE.ReferenceCoolingLoadOrTempMin.nextTimeEvent,$whenCondition3,$PRE.Source_Weather_dyn.nextTimeEvent,$whenCondition2,ReferenceCoolingLoadOrTempMin.nextTimeEventScaled,$PRE.ReferenceCoolingLoadOrTempMin.nextTimeEventScaled,ReferenceCoolingLoadOrTempMin.nextTimeEvent,ReferenceHeatingLoadOrTempMax.nextTimeEventScaled,$PRE.ReferenceHeatingLoadOrTempMax.nextTimeEventScaled,ReferenceHeatingLoadOrTempMax.nextTimeEvent,$PRE.Solar_Radiation_dyn.nextTimeEvent,$whenCondition1,Solar_Radiation_dyn.nextTimeEventScaled,$PRE.Solar_Radiation_dyn.nextTimeEventScaled,Solar_Radiation_dyn.nextTimeEvent,idealHeaterCooler_dyn.booleanExpressionCooler.y,idealHeaterCooler_dyn.booleanExpressionHeater.y,idealHeaterCooler.booleanExpressionCooler.y,idealHeaterCooler.booleanExpressionHeater.y,idealHeaterCooler_dyn.pITempHeat.triggeredTrapezoid.T,idealHeaterCooler_dyn.pITempHeat.triggeredTrapezoid.rate,idealHeaterCooler_dyn.pITempHeat.triggeredTrapezoid.endValue,idealHeaterCooler_dyn.pITempCool.triggeredTrapezoid.T,idealHeaterCooler_dyn.pITempCool.triggeredTrapezoid.rate,idealHeaterCooler_dyn.pITempCool.triggeredTrapezoid.endValue,Source_Weather_dyn.nextTimeEventScaled,$PRE.Source_Weather_dyn.nextTimeEventScaled,Source_Weather_dyn.nextTimeEvent,idealHeaterCooler.pITempHeat.triggeredTrapezoid.T,idealHeaterCooler.pITempHeat.triggeredTrapezoid.rate,idealHeaterCooler.pITempHeat.triggeredTrapezoid.endValue,idealHeaterCooler.pITempCool.triggeredTrapezoid.T,idealHeaterCooler.pITempCool.triggeredTrapezoid.rate,idealHeaterCooler.pITempCool.triggeredTrapezoid.endValue,Source_Weather.nextTimeEventScaled,$PRE.Source_Weather.nextTimeEventScaled,Source_Weather.nextTimeEvent,Solar_Radiation.nextTimeEventScaled,$PRE.Solar_Radiation.nextTimeEventScaled,Solar_Radiation.nextTimeEvent,idealHeaterCooler_dyn.pITempHeat.PI.I.local_reset,idealHeaterCooler_dyn.pITempCool.PI.I.local_reset,idealHeaterCooler.pITempHeat.PI.I.local_reset,idealHeaterCooler.pITempCool.PI.I.local_reset,integrator2.local_reset,integratorCool.local_reset,integratorHeat.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (787):
 * Single equations (assignments): 751
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 36
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 34 systems
   {(1,3,100.0%), (1,2,100.0%), (1,3,100.0%), (1,3,100.0%), (1,4,100.0%), (1,3,100.0%), (1,3,100.0%), (1,4,100.0%), (1,3,100.0%), (1,3,100.0%), (1,4,100.0%), (1,3,100.0%), (1,3,100.0%), (1,4,100.0%), (1,3,100.0%), (1,3,100.0%), (1,4,100.0%), (1,3,100.0%), (1,2,100.0%), (1,3,100.0%), (1,3,100.0%), (1,4,100.0%), (1,3,100.0%), (1,3,100.0%), (1,4,100.0%), (1,3,100.0%), (1,3,100.0%), (1,4,100.0%), (1,3,100.0%), (1,3,100.0%), (1,4,100.0%), (1,3,100.0%), (1,3,100.0%), (1,4,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(8,55), (8,55)}
Notification: Performance of prepare postOptimizeDAE: time 0.001701/2.525, allocations: 0.7381 MB / 1.582 GB, free: 487.1 MB / 1.183 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002879/2.528, allocations: 1.764 MB / 1.584 GB, free: 487.1 MB / 1.183 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01489/2.543, allocations: 8.955 MB / 1.593 GB, free: 486.2 MB / 1.183 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.297e-05/2.543, allocations: 90.72 kB / 1.593 GB, free: 486.2 MB / 1.183 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.754e-05/2.543, allocations: 20.47 kB / 1.593 GB, free: 486.2 MB / 1.183 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.933e-05/2.543, allocations: 43.41 kB / 1.593 GB, free: 486.2 MB / 1.183 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.03713/2.581, allocations: 22.54 MB / 1.615 GB, free: 483.7 MB / 1.183 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.569e-05/2.581, allocations: 23.75 kB / 1.615 GB, free: 483.7 MB / 1.183 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003733/2.584, allocations: 1.273 MB / 1.616 GB, free: 483.6 MB / 1.183 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.01022/2.595, allocations: 3.195 MB / 1.619 GB, free: 483.1 MB / 1.183 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001434/2.596, allocations: 250.4 kB / 1.619 GB, free: 483.1 MB / 1.183 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02576/2.622, allocations: 74.45 MB / 1.692 GB, free: 415.3 MB / 1.183 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.876e-05/2.622, allocations: 30.69 kB / 1.692 GB, free: 415.3 MB / 1.183 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02382/2.646, allocations: 11.8 MB / 1.704 GB, free: 410.2 MB / 1.183 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006581/2.652, allocations: 3.121 MB / 1.707 GB, free: 408.4 MB / 1.183 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002026/2.654, allocations: 245.7 kB / 1.707 GB, free: 408.2 MB / 1.183 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003181/2.657, allocations: 345.3 kB / 1.707 GB, free: 408.1 MB / 1.183 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001325/2.659, allocations: 0.6733 MB / 1.708 GB, free: 408 MB / 1.183 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004353/2.659, allocations: 279.3 kB / 1.708 GB, free: 407.9 MB / 1.183 GB
Notification: Performance of sorting global known variables: time 0.0108/2.67, allocations: 7.219 MB / 1.715 GB, free: 406 MB / 1.183 GB
Notification: Performance of sort global known variables: time 4.1e-07/2.67, allocations: 0 / 1.715 GB, free: 406 MB / 1.183 GB
Notification: Performance of remove unused functions: time 0.01528/2.685, allocations: 6.645 MB / 1.722 GB, free: 404.6 MB / 1.183 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 87
 * Number of states: 47 (Room.airload.dynBal.medium.Xi[1],Room.airload.dynBal.U,Room.airload.dynBal.m,Room.wallSouth.Wall.simpleNLayer.cap[1].T,Room.wallSouth.Wall.simpleNLayer.cap[2].T,Room.wallSouth.Wall.simpleNLayer.cap[3].T,Room.wallWest.Wall.simpleNLayer.cap[1].T,Room.wallWest.Wall.simpleNLayer.cap[2].T,Room.wallWest.Wall.simpleNLayer.cap[3].T,Room.wallEast.Wall.simpleNLayer.cap[1].T,Room.wallEast.Wall.simpleNLayer.cap[2].T,Room.wallEast.Wall.simpleNLayer.cap[3].T,Room.wallNorth.Wall.simpleNLayer.cap[1].T,Room.wallNorth.Wall.simpleNLayer.cap[2].T,Room.wallNorth.Wall.simpleNLayer.cap[3].T,Room.ceiling.Wall.simpleNLayer.cap[1].T,Room.ceiling.Wall.simpleNLayer.cap[2].T,Room.ceiling.Wall.simpleNLayer.cap[3].T,Room.floor.Wall.simpleNLayer.cap[1].T,Room.floor.Wall.simpleNLayer.cap[2].T,integratorHeat.y,integratorCool.y,integrator2.y,idealHeaterCooler.pITempCool.PI.I.y,idealHeaterCooler.pITempHeat.PI.I.y,Room_dyn.airload.dynBal.medium.Xi[1],Room_dyn.airload.dynBal.U,Room_dyn.airload.dynBal.m,Room_dyn.wallSouth.Wall.simpleNLayer.cap[1].T,Room_dyn.wallSouth.Wall.simpleNLayer.cap[2].T,Room_dyn.wallSouth.Wall.simpleNLayer.cap[3].T,Room_dyn.wallWest.Wall.simpleNLayer.cap[1].T,Room_dyn.wallWest.Wall.simpleNLayer.cap[2].T,Room_dyn.wallWest.Wall.simpleNLayer.cap[3].T,Room_dyn.wallEast.Wall.simpleNLayer.cap[1].T,Room_dyn.wallEast.Wall.simpleNLayer.cap[2].T,Room_dyn.wallEast.Wall.simpleNLayer.cap[3].T,Room_dyn.wallNorth.Wall.simpleNLayer.cap[1].T,Room_dyn.wallNorth.Wall.simpleNLayer.cap[2].T,Room_dyn.wallNorth.Wall.simpleNLayer.cap[3].T,Room_dyn.ceiling.Wall.simpleNLayer.cap[1].T,Room_dyn.ceiling.Wall.simpleNLayer.cap[2].T,Room_dyn.ceiling.Wall.simpleNLayer.cap[3].T,Room_dyn.floor.Wall.simpleNLayer.cap[1].T,Room_dyn.floor.Wall.simpleNLayer.cap[2].T,idealHeaterCooler_dyn.pITempCool.PI.I.y,idealHeaterCooler_dyn.pITempHeat.PI.I.y)
 * Number of discrete variables: 34 ($whenCondition1,Solar_Radiation_dyn.nextTimeEvent,Solar_Radiation_dyn.nextTimeEventScaled,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,Solar_Radiation.nextTimeEvent,Solar_Radiation.nextTimeEventScaled,Source_Weather.nextTimeEvent,Source_Weather.nextTimeEventScaled,checkResultsAccordingToASHRAEHeatingOrTempMax.satisfied,ReferenceHeatingLoadOrTempMax.nextTimeEvent,ReferenceHeatingLoadOrTempMax.nextTimeEventScaled,checkResultsAccordingToASHRAECoolingOrTempMin.satisfied,ReferenceCoolingLoadOrTempMin.nextTimeEvent,ReferenceCoolingLoadOrTempMin.nextTimeEventScaled,idealHeaterCooler.pITempCool.triggeredTrapezoid.endValue,idealHeaterCooler.pITempCool.triggeredTrapezoid.rate,idealHeaterCooler.pITempCool.triggeredTrapezoid.T,idealHeaterCooler.pITempHeat.triggeredTrapezoid.endValue,idealHeaterCooler.pITempHeat.triggeredTrapezoid.rate,idealHeaterCooler.pITempHeat.triggeredTrapezoid.T,Source_Weather_dyn.nextTimeEvent,Source_Weather_dyn.nextTimeEventScaled,idealHeaterCooler_dyn.pITempCool.triggeredTrapezoid.endValue,idealHeaterCooler_dyn.pITempCool.triggeredTrapezoid.rate,idealHeaterCooler_dyn.pITempCool.triggeredTrapezoid.T,idealHeaterCooler_dyn.pITempHeat.triggeredTrapezoid.endValue,idealHeaterCooler_dyn.pITempHeat.triggeredTrapezoid.rate,idealHeaterCooler_dyn.pITempHeat.triggeredTrapezoid.T)
 * Number of discrete states: 16 (Solar_Radiation.nextTimeEvent,Source_Weather.nextTimeEvent,ReferenceHeatingLoadOrTempMax.nextTimeEvent,ReferenceCoolingLoadOrTempMin.nextTimeEvent,Source_Weather_dyn.nextTimeEvent,idealHeaterCooler.pITempCool.triggeredTrapezoid.y,idealHeaterCooler.pITempHeat.triggeredTrapezoid.y,idealHeaterCooler_dyn.pITempCool.triggeredTrapezoid.y,idealHeaterCooler_dyn.pITempHeat.triggeredTrapezoid.y,Source_Weather_dyn.nextTimeEventScaled,ReferenceCoolingLoadOrTempMin.nextTimeEventScaled,ReferenceHeatingLoadOrTempMax.nextTimeEventScaled,Source_Weather.nextTimeEventScaled,Solar_Radiation.nextTimeEventScaled,Solar_Radiation_dyn.nextTimeEvent,Solar_Radiation_dyn.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (680):
 * Single equations (assignments): 618
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 26
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 36
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 34 systems
   {(1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,3,100.0%), (1,2,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,2,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(9,63), (9,63)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.002694/2.688, allocations: 1.19 MB / 1.723 GB, free: 404.2 MB / 1.183 GB
Notification: Performance of simCode: created initialization part: time 0.02081/2.709, allocations: 21.08 MB / 1.744 GB, free: 390 MB / 1.183 GB
Notification: Performance of simCode: created event and clocks part: time 1.968e-05/2.709, allocations: 7.625 kB / 1.744 GB, free: 390 MB / 1.183 GB
Notification: Performance of simCode: created simulation system equations: time 0.007866/2.717, allocations: 9.562 MB / 1.753 GB, free: 383 MB / 1.183 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01488/2.731, allocations: 4.804 MB / 1.758 GB, free: 381.3 MB / 1.183 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03849/2.77, allocations: 30.01 MB / 1.787 GB, free: 353.7 MB / 1.183 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004007/2.774, allocations: 3.879 MB / 1.791 GB, free: 351 MB / 1.183 GB
Notification: Performance of simCode: alias equations: time 0.008986/2.783, allocations: 2.897 MB / 1.794 GB, free: 349.1 MB / 1.183 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002077/2.785, allocations: 0.7208 MB / 1.794 GB, free: 348.4 MB / 1.183 GB
Notification: Performance of SimCode: time 2.765e-06/2.785, allocations: 4 kB / 1.794 GB, free: 348.4 MB / 1.183 GB
Notification: Performance of Templates: time 0.23/3.015, allocations: 231.9 MB / 2.021 GB, free: 121.3 MB / 1.183 GB
"
[Timeout remaining time 657]
make -j1 -f AixLib_AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270.makefile [Timeout 660]
(rm -f AixLib_AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270.pipe ; mkfifo AixLib_AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270.pipe ; head -c 1048576 < AixLib_AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270.pipe >> ../files/AixLib_AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270.sim & ./AixLib_AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270 -abortSlowSimulation -alarm=240  -lv LOG_STATS > AixLib_AixLib.ThermalZones.HighOrder.Examples.ASHREA140.CompareDynamicAndStaticSolarFrac_Case270.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 12.985485553042963]