Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.NonIntegrated.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.00174/0.00174, allocations: 104.2 kB / 19.71 MB, free: 2.141 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.002019/0.002019, allocations: 210.9 kB / 23 MB, free: 4.969 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.478/1.478, allocations: 230.6 MB / 256.8 MB, free: 7.828 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 3.255/3.255, allocations: 0.49 GB / 0.7959 GB, free: 35.6 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.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.Applications.DataCenters.ChillerCooled.Equipment.Validation.NonIntegrated,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|onChi.y|onWSE.y|tri.y|sou1.T_in|sou2.T_in|nonIntWSE1.wse.heaExc.con.addPID.y|nonIntWSE2.wse.heaExc.con.addPID.y|TSup1.T|TSup2.T|nonIntWSE1.TCHWSupWSE|nonIntWSE2.TCHWSupWSE|nonIntWSE1.chiPar.port_a1.m_flow|nonIntWSE1.chiPar.port_a2.m_flow|nonIntWSE2.chiPar.port_a1.m_flow|nonIntWSE2.chiPar.port_a2.m_flow|nonIntWSE1.chiPar.P.1.|nonIntWSE2.chiPar.P.1.",fileNamePrefix="Buildings_12_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.NonIntegrated")
translateModel(Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.NonIntegrated,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|onChi.y|onWSE.y|tri.y|sou1.T_in|sou2.T_in|nonIntWSE1.wse.heaExc.con.addPID.y|nonIntWSE2.wse.heaExc.con.addPID.y|TSup1.T|TSup2.T|nonIntWSE1.TCHWSupWSE|nonIntWSE2.TCHWSupWSE|nonIntWSE1.chiPar.port_a1.m_flow|nonIntWSE1.chiPar.port_a2.m_flow|nonIntWSE2.chiPar.port_a1.m_flow|nonIntWSE2.chiPar.port_a2.m_flow|nonIntWSE1.chiPar.P.1.|nonIntWSE2.chiPar.P.1.",fileNamePrefix="Buildings_12_Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.NonIntegrated") [Timeout 300]
"Notification: Buildings requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002097/0.002097, allocations: 70.86 kB / 1.155 GB, free: 25.29 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3437/0.3458, allocations: 176.1 MB / 1.327 GB, free: 1.023 MB / 1.014 GB
Notification: Performance of NFInst.instantiate(Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.NonIntegrated): time 1.337/1.683, allocations: 0.6031 GB / 1.93 GB, free: 13.16 MB / 1.404 GB
Notification: Performance of NFInst.instExpressions: time 0.1551/1.838, allocations: 94.55 MB / 2.023 GB, free: 14.42 MB / 1.498 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02046/1.858, allocations: 0.8635 MB / 2.023 GB, free: 13.55 MB / 1.498 GB
Notification: Performance of NFTyping.typeComponents: time 0.02111/1.879, allocations: 6.889 MB / 2.03 GB, free: 6.621 MB / 1.498 GB
Notification: Performance of NFTyping.typeBindings: time 0.0521/1.932, allocations: 18.2 MB / 2.048 GB, free: 4.367 MB / 1.514 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02816/1.96, allocations: 11.79 MB / 2.059 GB, free: 8.668 MB / 1.529 GB
Notification: Performance of NFFlatten.flatten: time 0.05001/2.01, allocations: 34.01 MB / 2.093 GB, free: 6.562 MB / 1.561 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02174/2.031, allocations: 10.28 MB / 2.103 GB, free: 12.15 MB / 1.576 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04124/2.073, allocations: 15.71 MB / 2.118 GB, free: 12.41 MB / 1.592 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02222/2.095, allocations: 9.998 MB / 2.128 GB, free: 2.375 MB / 1.592 GB
Notification: Performance of NFPackage.collectConstants: time 0.00638/2.101, allocations: 1.555 MB / 2.129 GB, free: 0.8203 MB / 1.592 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02023/2.122, allocations: 5.64 MB / 2.135 GB, free: 11.17 MB / 1.607 GB
Notification: Performance of NFScalarize.scalarize: time 0.008479/2.13, allocations: 3.694 MB / 2.138 GB, free: 7.465 MB / 1.607 GB
Notification: Performance of NFVerifyModel.verify: time 0.01827/2.148, allocations: 6.067 MB / 2.144 GB, free: 1.371 MB / 1.607 GB
Notification: Performance of NFConvertDAE.convert: time 0.05118/2.199, allocations: 26.19 MB / 2.17 GB, free: 7.102 MB / 1.639 GB
Notification: Performance of FrontEnd - DAE generated: time 5.2e-06/2.199, allocations: 0 / 2.17 GB, free: 7.102 MB / 1.639 GB
Notification: Performance of FrontEnd: time 1.764e-06/2.199, allocations: 4 kB / 2.17 GB, free: 7.098 MB / 1.639 GB
Notification: Performance of Transformations before backend: time 0.0006934/2.2, allocations: 4 kB / 2.17 GB, free: 7.094 MB / 1.639 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1584
 * Number of variables: 1584
Notification: Performance of Generate backend data structure: time 0.045/2.245, allocations: 15.46 MB / 2.185 GB, free: 7.492 MB / 1.654 GB
Notification: Performance of prepare preOptimizeDAE: time 4.333e-05/2.245, allocations: 8.031 kB / 2.185 GB, free: 7.484 MB / 1.654 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01856/2.264, allocations: 3.332 MB / 2.188 GB, free: 4.141 MB / 1.654 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03469/2.298, allocations: 14.4 MB / 2.202 GB, free: 5.629 MB / 1.67 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00112/2.3, allocations: 0.7616 MB / 2.203 GB, free: 4.812 MB / 1.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002721/2.302, allocations: 0.664 MB / 2.204 GB, free: 4.148 MB / 1.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03065/2.333, allocations: 10.54 MB / 2.214 GB, free: 9.262 MB / 1.686 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001839/2.333, allocations: 4 kB / 2.214 GB, free: 9.258 MB / 1.686 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001519/2.335, allocations: 256 kB / 2.214 GB, free: 9.008 MB / 1.686 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001713/2.335, allocations: 167.9 kB / 2.214 GB, free: 8.844 MB / 1.686 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02785/2.363, allocations: 10.41 MB / 2.225 GB, free: 14.4 MB / 1.701 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.08295/2.446, allocations: 34.96 MB / 2.259 GB, free: 10.96 MB / 1.732 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01767/2.463, allocations: 6.012 MB / 2.265 GB, free: 4.945 MB / 1.732 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00905/2.472, allocations: 3.606 MB / 2.268 GB, free: 1.32 MB / 1.732 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001687/2.474, allocations: 386.3 kB / 2.269 GB, free: 0.9414 MB / 1.732 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 1.246/3.72, allocations: 4.577 MB / 2.273 GB, free: 0.6723 GB / 1.733 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.007865/3.728, allocations: 0.9185 MB / 2.274 GB, free: 0.6723 GB / 1.733 GB
Notification: Performance of pre-optimization done (n=344): time 3.95e-05/3.728, allocations: 1.781 kB / 2.274 GB, free: 0.6723 GB / 1.733 GB
Notification: Performance of matching and sorting (n=344): time 0.06337/3.791, allocations: 15.25 MB / 2.289 GB, free: 0.6692 GB / 1.733 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.841e-05/3.791, allocations: 115 kB / 2.289 GB, free: 0.6691 GB / 1.733 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02588/3.817, allocations: 11.29 MB / 2.3 GB, free: 0.6653 GB / 1.733 GB
Notification: Performance of collectPreVariables (initialization): time 0.001472/3.818, allocations: 114.8 kB / 2.3 GB, free: 0.6652 GB / 1.733 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006609/3.825, allocations: 5.528 MB / 2.305 GB, free: 0.662 GB / 1.733 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001945/3.827, allocations: 1.234 MB / 2.307 GB, free: 0.6612 GB / 1.733 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.004076/3.831, allocations: 1.171 MB / 2.308 GB, free: 0.6607 GB / 1.733 GB
Notification: Performance of setup shared object (initialization): time 4.303e-05/3.831, allocations: 307.9 kB / 2.308 GB, free: 0.6604 GB / 1.733 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007709/3.839, allocations: 3.936 MB / 2.312 GB, free: 0.6591 GB / 1.733 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01/3.849, allocations: 7.112 MB / 2.319 GB, free: 0.6541 GB / 1.733 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01579/3.865, allocations: 8.446 MB / 2.327 GB, free: 0.6496 GB / 1.733 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.214e-05/3.865, allocations: 7.5 kB / 2.327 GB, free: 0.6496 GB / 1.733 GB
Notification: Performance of matching and sorting (n=626) (initialization): time 0.02726/3.892, allocations: 11.11 MB / 2.338 GB, free: 0.6411 GB / 1.733 GB
Notification: Performance of prepare postOptimizeDAE: time 7.602e-05/3.892, allocations: 49.7 kB / 2.338 GB, free: 0.641 GB / 1.733 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.696e-05/3.892, allocations: 32 kB / 2.338 GB, free: 0.641 GB / 1.733 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01003/3.902, allocations: 2.065 MB / 2.34 GB, free: 0.639 GB / 1.733 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007811/3.91, allocations: 1.548 MB / 2.342 GB, free: 0.6376 GB / 1.733 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006764/3.917, allocations: 8.182 MB / 2.35 GB, free: 0.6293 GB / 1.733 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01012/3.927, allocations: 0.668 MB / 2.35 GB, free: 0.6287 GB / 1.733 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001437/3.928, allocations: 271.3 kB / 2.35 GB, free: 0.6285 GB / 1.733 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01307/3.941, allocations: 6.742 MB / 2.357 GB, free: 0.6219 GB / 1.733 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.008767/3.95, allocations: 7.06 MB / 2.364 GB, free: 0.614 GB / 1.733 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01488/3.965, allocations: 8.33 MB / 2.372 GB, free: 0.6055 GB / 1.733 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.882e-05/3.965, allocations: 12 kB / 2.372 GB, free: 0.6055 GB / 1.733 GB
Notification: Performance of matching and sorting (n=626) (initialization_lambda0): time 0.02424/3.989, allocations: 10.56 MB / 2.382 GB, free: 0.5952 GB / 1.733 GB
Notification: Performance of prepare postOptimizeDAE: time 6.478e-05/3.989, allocations: 53.69 kB / 2.382 GB, free: 0.5952 GB / 1.733 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.326e-05/3.989, allocations: 35.94 kB / 2.383 GB, free: 0.5951 GB / 1.733 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004542/3.994, allocations: 1.168 MB / 2.384 GB, free: 0.594 GB / 1.733 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006655/4.001, allocations: 1.377 MB / 2.385 GB, free: 0.5927 GB / 1.733 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006063/4.007, allocations: 6.408 MB / 2.391 GB, free: 0.5862 GB / 1.733 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009955/4.017, allocations: 0.7034 MB / 2.392 GB, free: 0.5855 GB / 1.733 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001318/4.018, allocations: 263.7 kB / 2.392 GB, free: 0.5853 GB / 1.733 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 145
 * Number of states: 0 ()
 * Number of discrete variables: 17 ($whenCondition2,tri.y,tri.pulseStart,$PRE.tri.pulseStart,$whenCondition3,nonIntWSE2.chiPar.chi[1].tru.y,nonIntWSE1.chiPar.chi[1].tru.y,TCon_in.a,TCon_in.b,TCon_in.last,TCon_in.nextEvent,$PRE.TCon_in.nextEvent,TCon_in.nextEventScaled,nonIntWSE2.on[1],nonIntWSE2.on[2],$whenCondition1,nonIntWSE1.wse.heaExc.con.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (521):
 * Single equations (assignments): 498
 * Array equations: 12
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 6 systems
   {1, 1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 4 systems
   {(3,18), (2,19), (3,18), (2,19)}
Notification: Performance of prepare postOptimizeDAE: time 0.002331/4.02, allocations: 0.5024 MB / 2.393 GB, free: 0.5848 GB / 1.733 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003618/4.024, allocations: 1.071 MB / 2.394 GB, free: 0.5837 GB / 1.733 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02272/4.047, allocations: 9.466 MB / 2.403 GB, free: 0.5745 GB / 1.733 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01555/4.062, allocations: 7.58 MB / 2.41 GB, free: 0.5671 GB / 1.733 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.588e-05/4.062, allocations: 8.609 kB / 2.41 GB, free: 0.5671 GB / 1.733 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006211/4.068, allocations: 2.163 MB / 2.412 GB, free: 0.5649 GB / 1.733 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0028/4.071, allocations: 75.98 kB / 2.413 GB, free: 0.5649 GB / 1.733 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.007634/4.079, allocations: 0.5522 MB / 2.413 GB, free: 0.5643 GB / 1.733 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006573/4.079, allocations: 246.7 kB / 2.413 GB, free: 0.5641 GB / 1.733 GB
Error: Internal error IndexReduction.pantelidesIndexReduction failed! System is structurally singular and cannot be handled because the number of unassigned equations is larger than the number of states. Use -d=bltdump to get more information.
Error: Internal error Transformation Module PFPlusExt index Reduction Method Pantelides failed!
Notification: Performance of <failed> postOpt createDAEmodeBDAE (simulation): time 0.01547/4.095, allocations: 5.521 MB / 2.419 GB, free: 0.5587 GB / 1.733 GB
Error: post-optimization module createDAEmodeBDAE (simulation) failed.
Error: Internal error SimCode DAEmode: The model Buildings.Applications.DataCenters.ChillerCooled.Equipment.Validation.NonIntegrated could not be translated
"
[Timeout remaining time 296]
[Calling sys.exit(0), Time elapsed: 10.644944236999436]
Failed to read output from testmodel.py, exit status != 0:
4.104237355000805 4.1129628480000004 1.910902729
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fee7dfcef80>