Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Fluid.Sources.Examples.Outside_CpData_Angles.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.001916/0.001916, allocations: 117.4 kB / 17.17 MB, free: 5.977 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.002617/0.002617, allocations: 214.3 kB / 20.13 MB, free: 3.035 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.563/1.563, allocations: 230.6 MB / 253.5 MB, free: 15.07 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo): time 2.859/2.859, allocations: 476.7 MB / 0.7678 GB, free: 9.508 MB / 0.6075 GB
"
[Timeout remaining time 176]
Using package Buildings with version 11.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(Buildings.Fluid.Sources.Examples.Outside_CpData_Angles,fileNamePrefix="Buildings_11_Buildings_Fluid_Sources_Examples_Outside_CpData_Angles",fmuType="cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Fluid.Sources.Examples.Outside_CpData_Angles,fileNamePrefix="Buildings_11_Buildings_Fluid_Sources_Examples_Outside_CpData_Angles",fmuType="cs",version="2.0",platforms={"static"}) [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.002066/0.002066, allocations: 63.89 kB / 1.113 GB, free: 15.9 MB / 0.8575 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.98/0.9821, allocations: 169.9 MB / 1.279 GB, free: 11.76 MB / 0.9981 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Sources.Examples.Outside_CpData_Angles): time 0.2471/1.229, allocations: 171.9 MB / 1.447 GB, free: 15.98 MB / 1.139 GB
Notification: Performance of NFInst.instExpressions: time 0.02689/1.256, allocations: 17.53 MB / 1.464 GB, free: 14.39 MB / 1.154 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002525/1.259, allocations: 43.62 kB / 1.464 GB, free: 14.35 MB / 1.154 GB
Notification: Performance of NFTyping.typeComponents: time 0.002159/1.261, allocations: 0.6089 MB / 1.465 GB, free: 13.73 MB / 1.154 GB
Notification: Performance of NFTyping.typeBindings: time 0.006839/1.268, allocations: 1.828 MB / 1.466 GB, free: 11.9 MB / 1.154 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004679/1.272, allocations: 1.467 MB / 1.468 GB, free: 10.45 MB / 1.154 GB
Notification: Performance of NFFlatten.flatten: time 0.004854/1.277, allocations: 2.906 MB / 1.471 GB, free: 7.535 MB / 1.154 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002758/1.28, allocations: 1.617 MB / 1.472 GB, free: 5.859 MB / 1.154 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004977/1.285, allocations: 1.526 MB / 1.474 GB, free: 4.379 MB / 1.154 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002189/1.287, allocations: 1.163 MB / 1.475 GB, free: 3.211 MB / 1.154 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005194/1.288, allocations: 224 kB / 1.475 GB, free: 2.992 MB / 1.154 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003797/1.291, allocations: 1.634 MB / 1.477 GB, free: 1.355 MB / 1.154 GB
Notification: Performance of NFScalarize.scalarize: time 0.0009255/1.292, allocations: 0.8216 MB / 1.477 GB, free: 0.5312 MB / 1.154 GB
Notification: Performance of NFVerifyModel.verify: time 0.001867/1.294, allocations: 1.294 MB / 1.479 GB, free: 15.23 MB / 1.17 GB
Notification: Performance of NFConvertDAE.convert: time 0.006379/1.301, allocations: 3.802 MB / 1.482 GB, free: 11.41 MB / 1.17 GB
Notification: Performance of FrontEnd - DAE generated: time 6.863e-06/1.301, allocations: 0 / 1.482 GB, free: 11.41 MB / 1.17 GB
Notification: Performance of FrontEnd: time 1.934e-06/1.301, allocations: 0 / 1.482 GB, free: 11.41 MB / 1.17 GB
Notification: Performance of Transformations before backend: time 7.039e-05/1.301, allocations: 3.984 kB / 1.482 GB, free: 11.41 MB / 1.17 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 431
 * Number of variables: 431
Notification: Performance of Generate backend data structure: time 0.006305/1.307, allocations: 3.059 MB / 1.485 GB, free: 8.285 MB / 1.17 GB
Notification: Performance of prepare preOptimizeDAE: time 5.252e-05/1.307, allocations: 12.03 kB / 1.485 GB, free: 8.273 MB / 1.17 GB
Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 5.534e-05/1.307, allocations: 43.39 kB / 1.485 GB, free: 8.23 MB / 1.17 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0003159/1.307, allocations: 248.9 kB / 1.486 GB, free: 7.977 MB / 1.17 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004634/1.312, allocations: 0.6345 MB / 1.486 GB, free: 7.34 MB / 1.17 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005144/1.317, allocations: 3.466 MB / 1.49 GB, free: 3.824 MB / 1.17 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001337/1.317, allocations: 127.4 kB / 1.49 GB, free: 3.699 MB / 1.17 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002937/1.318, allocations: 175.9 kB / 1.49 GB, free: 3.527 MB / 1.17 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003934/1.321, allocations: 1.953 MB / 1.492 GB, free: 1.523 MB / 1.17 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.072e-05/1.321, allocations: 0 / 1.492 GB, free: 1.523 MB / 1.17 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001838/1.322, allocations: 75.98 kB / 1.492 GB, free: 1.449 MB / 1.17 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.26e-05/1.322, allocations: 44 kB / 1.492 GB, free: 1.406 MB / 1.17 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003956/1.326, allocations: 2.113 MB / 1.494 GB, free: 15.29 MB / 1.186 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.01119/1.337, allocations: 6.741 MB / 1.501 GB, free: 8.207 MB / 1.186 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003813/1.341, allocations: 2.045 MB / 1.503 GB, free: 6.09 MB / 1.186 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001421/1.342, allocations: 0.7101 MB / 1.503 GB, free: 5.379 MB / 1.186 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0006634/1.343, allocations: 433.6 kB / 1.504 GB, free: 4.879 MB / 1.186 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001966/1.345, allocations: 1.013 MB / 1.505 GB, free: 3.848 MB / 1.186 GB
Notification: Performance of pre-optimization done (n=146): time 3.046e-06/1.345, allocations: 4 kB / 1.505 GB, free: 3.844 MB / 1.186 GB
Notification: Performance of matching and sorting (n=146): time 0.007872/1.353, allocations: 3.005 MB / 1.508 GB, free: 0.7266 MB / 1.186 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001627/1.353, allocations: 201.2 kB / 1.508 GB, free: 496 kB / 1.186 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005705/1.358, allocations: 4.13 MB / 1.512 GB, free: 12.35 MB / 1.201 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004187/1.359, allocations: 53.7 kB / 1.512 GB, free: 12.29 MB / 1.201 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0009932/1.36, allocations: 0.9196 MB / 1.513 GB, free: 11.36 MB / 1.201 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0006485/1.361, allocations: 0.4957 MB / 1.513 GB, free: 10.86 MB / 1.201 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005028/1.361, allocations: 238.8 kB / 1.514 GB, free: 10.62 MB / 1.201 GB
Notification: Performance of setup shared object (initialization): time 0.0001953/1.361, allocations: 353.9 kB / 1.514 GB, free: 10.27 MB / 1.201 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001363/1.363, allocations: 0.5804 MB / 1.514 GB, free: 9.691 MB / 1.201 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001584/1.364, allocations: 0.8124 MB / 1.515 GB, free: 8.816 MB / 1.201 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002911/1.367, allocations: 1.333 MB / 1.517 GB, free: 7.469 MB / 1.201 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.406e-06/1.367, allocations: 8 kB / 1.517 GB, free: 7.461 MB / 1.201 GB
Notification: Performance of matching and sorting (n=155) (initialization): time 0.004696/1.372, allocations: 1.808 MB / 1.518 GB, free: 5.629 MB / 1.201 GB
Notification: Performance of prepare postOptimizeDAE: time 2.825e-05/1.372, allocations: 4 kB / 1.518 GB, free: 5.625 MB / 1.201 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.064e-05/1.372, allocations: 0 / 1.518 GB, free: 5.625 MB / 1.201 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001196/1.373, allocations: 216.2 kB / 1.519 GB, free: 5.398 MB / 1.201 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001711/1.375, allocations: 327.5 kB / 1.519 GB, free: 5.078 MB / 1.201 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007522/1.382, allocations: 7.335 MB / 1.526 GB, free: 13.04 MB / 1.217 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001945/1.384, allocations: 179.1 kB / 1.526 GB, free: 12.87 MB / 1.217 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001648/1.384, allocations: 47.97 kB / 1.526 GB, free: 12.82 MB / 1.217 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 4
 * Number of states: 0 ()
 * Number of discrete variables: 15 (weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (145):
 * Single equations (assignments): 140
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.001065/1.385, allocations: 490.7 kB / 1.527 GB, free: 12.33 MB / 1.217 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005958/1.386, allocations: 206.7 kB / 1.527 GB, free: 12.13 MB / 1.217 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005048/1.391, allocations: 2.154 MB / 1.529 GB, free: 9.949 MB / 1.217 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.731e-05/1.391, allocations: 16 kB / 1.529 GB, free: 9.934 MB / 1.217 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.953e-06/1.391, allocations: 0 / 1.529 GB, free: 9.934 MB / 1.217 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.333e-05/1.391, allocations: 15.89 kB / 1.529 GB, free: 9.918 MB / 1.217 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.008075/1.399, allocations: 4.153 MB / 1.533 GB, free: 5.688 MB / 1.217 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.214e-06/1.399, allocations: 4 kB / 1.533 GB, free: 5.684 MB / 1.217 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001582/1.401, allocations: 315.6 kB / 1.533 GB, free: 5.375 MB / 1.217 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.000969/1.402, allocations: 204.1 kB / 1.534 GB, free: 5.16 MB / 1.217 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001388/1.402, allocations: 43.95 kB / 1.534 GB, free: 5.117 MB / 1.217 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007188/1.409, allocations: 7.364 MB / 1.541 GB, free: 13.05 MB / 1.232 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.824e-06/1.409, allocations: 0 / 1.541 GB, free: 13.05 MB / 1.232 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0049/1.414, allocations: 2.041 MB / 1.543 GB, free: 10.97 MB / 1.232 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001292/1.415, allocations: 0.5226 MB / 1.543 GB, free: 10.43 MB / 1.232 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004538/1.416, allocations: 28 kB / 1.543 GB, free: 10.4 MB / 1.232 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001584/1.417, allocations: 115.2 kB / 1.543 GB, free: 10.29 MB / 1.232 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002985/1.418, allocations: 113.1 kB / 1.544 GB, free: 10.18 MB / 1.232 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001654/1.418, allocations: 67.95 kB / 1.544 GB, free: 10.11 MB / 1.232 GB
Notification: Performance of sorting global known variables: time 0.003818/1.422, allocations: 3.169 MB / 1.547 GB, free: 6.953 MB / 1.232 GB
Notification: Performance of sort global known variables: time 1.3e-07/1.422, allocations: 0 / 1.547 GB, free: 6.953 MB / 1.232 GB
Notification: Performance of remove unused functions: time 0.002508/1.424, allocations: 0.7014 MB / 1.547 GB, free: 6.25 MB / 1.232 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 0 ()
 * Number of discrete variables: 10 ($whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext)
 * Number of discrete states: 5 (weaDat.locTim.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,weaDat.conTimMin.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (149):
 * Single equations (assignments): 139
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 5
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(1,2,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.007478/1.432, allocations: 3.23 MB / 1.551 GB, free: 3.16 MB / 1.232 GB
Notification: Performance of simCode: created initialization part: time 0.004045/1.436, allocations: 2.02 MB / 1.553 GB, free: 1.078 MB / 1.232 GB
Notification: Performance of simCode: created event and clocks part: time 9.288e-06/1.436, allocations: 4.562 kB / 1.553 GB, free: 1.074 MB / 1.232 GB
Notification: Performance of simCode: created simulation system equations: time 0.002415/1.438, allocations: 1.375 MB / 1.554 GB, free: 15.63 MB / 1.248 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002939/1.441, allocations: 0.5584 MB / 1.554 GB, free: 15.09 MB / 1.248 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03596/1.477, allocations: 21.26 MB / 1.575 GB, free: 9.59 MB / 1.264 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001472/1.478, allocations: 1.541 MB / 1.577 GB, free: 8.02 MB / 1.264 GB
Notification: Performance of simCode: alias equations: time 0.001982/1.48, allocations: 0.529 MB / 1.577 GB, free: 7.484 MB / 1.264 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001405/1.482, allocations: 0.9132 MB / 1.578 GB, free: 6.57 MB / 1.264 GB
Notification: Performance of SimCode: time 8.22e-07/1.482, allocations: 3.938 kB / 1.578 GB, free: 6.566 MB / 1.264 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1448/1.627, allocations: 50.24 MB / 1.627 GB, free: 4.82 MB / 1.311 GB
Notification: Performance of buildModelFMU: Generate platform static: time 17.63/19.25, allocations: 13.88 kB / 1.627 GB, free: 4.809 MB / 1.311 GB
"
[Timeout remaining time 280]
(rm -f Buildings_11_Buildings.Fluid.Sources.Examples.Outside_CpData_Angles.pipe ; mkfifo Buildings_11_Buildings.Fluid.Sources.Examples.Outside_CpData_Angles.pipe ; head -c 1048576 < Buildings_11_Buildings.Fluid.Sources.Examples.Outside_CpData_Angles.pipe >> ../files/Buildings_11_Buildings.Fluid.Sources.Examples.Outside_CpData_Angles.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Buildings_11_Buildings.Fluid.Sources.Examples.Outside_CpData_Angles_res.mat --tempDir=temp_Buildings_11_Buildings_Fluid_Sources_Examples_Outside_CpData_Angles_fmu --startTime=0 --stopTime=20 --stepSize=0.008 --timeout=400 --tolerance=1e-06 Buildings_11_Buildings_Fluid_Sources_Examples_Outside_CpData_Angles.fmu > Buildings_11_Buildings.Fluid.Sources.Examples.Outside_CpData_Angles.pipe 2>&1) [Timeout 420.0]
[Calling os._exit(0), Time elapsed: 26.03545166202821]
Failed to read output from testmodel.py, exit status != 0:
19.543869910005014 19.568273191 18.262893034
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff693d6f3a0>