Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo): time 0.01065/0.01065, allocations: 1.754 MB / 20.61 MB, free: 1.004 MB / 14.72 MB
"
[Timeout remaining time 180]
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.001332/0.001332, allocations: 102 kB / 24.18 MB, free: 2.438 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.001835/0.001835, allocations: 212.9 kB / 27.9 MB, free: 3.742 MB / 19.63 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.544/1.544, allocations: 230.6 MB / 262.1 MB, free: 5.824 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/package.mo): time 1.175/1.175, allocations: 130.7 MB / 449.6 MB, free: 6.406 MB / 350.1 MB
"
[Timeout remaining time 179]
Using package ClaRa with version 1.9.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.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)
Using package SMArtInt with version 0.3.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo)
Running command: "" <> buildModelFMU(ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP,fileNamePrefix="ClaRa_ClaRa_Basics_ControlVolumes_SolidVolumes_Fundamentals_Blocks_Check_Check_TinyPIP",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP,fileNamePrefix="ClaRa_ClaRa_Basics_ControlVolumes_SolidVolumes_Fundamentals_Blocks_Check_Check_TinyPIP",fmuType="me",version="2.0",platforms={"static"}) [Timeout 800]
"Notification: SMArtInt 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: ClaRa 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: Skipped loading package TILMedia (1.9.0 ClaRa) using MODELICAPATH /home/hudson/saved_omc/libraries/.openmodelica/libraries (uses-annotation may be wrong).
Warning: Requested package SMArtInt of version 0.5.1, but this package was already loaded with version 0.3.1. There are no conversion annotations for this version but 0.5.1 is newer than 0.3.1. There is a possibility that 0.3.1 remains backwards compatible, but it is not loaded so OpenModelica cannot verify this.
Notification: Performance of FrontEnd - loaded program: time 0.06895/0.06895, allocations: 20.99 MB / 0.6359 GB, free: 4.863 MB / 462.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1974/0.2664, allocations: 81.91 MB / 0.7158 GB, free: 2.848 MB / 0.5294 GB
Notification: Performance of NFInst.instantiate(ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP): time 0.008236/0.2746, allocations: 3.309 MB / 0.7191 GB, free: 15.52 MB / 0.545 GB
Notification: Performance of NFInst.instExpressions: time 0.003716/0.2783, allocations: 1.076 MB / 0.7201 GB, free: 14.43 MB / 0.545 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0006954/0.279, allocations: 11.94 kB / 0.7201 GB, free: 14.42 MB / 0.545 GB
Notification: Performance of NFTyping.typeComponents: time 0.0006621/0.2797, allocations: 147.1 kB / 0.7203 GB, free: 14.28 MB / 0.545 GB
Notification: Performance of NFTyping.typeBindings: time 0.000811/0.2805, allocations: 187.1 kB / 0.7205 GB, free: 14.09 MB / 0.545 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001756/0.2822, allocations: 362.7 kB / 0.7208 GB, free: 13.74 MB / 0.545 GB
Notification: Performance of NFFlatten.flatten: time 0.001457/0.2837, allocations: 0.5974 MB / 0.7214 GB, free: 13.14 MB / 0.545 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0004332/0.2841, allocations: 125.8 kB / 0.7215 GB, free: 13.02 MB / 0.545 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00056/0.2847, allocations: 231.1 kB / 0.7217 GB, free: 12.79 MB / 0.545 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0007697/0.2855, allocations: 270.8 kB / 0.722 GB, free: 12.52 MB / 0.545 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001837/0.2856, allocations: 44 kB / 0.722 GB, free: 12.48 MB / 0.545 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0003031/0.286, allocations: 111.9 kB / 0.7221 GB, free: 12.37 MB / 0.545 GB
Notification: Performance of NFScalarize.scalarize: time 0.0001956/0.2861, allocations: 115.5 kB / 0.7222 GB, free: 12.26 MB / 0.545 GB
Notification: Performance of NFVerifyModel.verify: time 0.00029/0.2864, allocations: 178.9 kB / 0.7224 GB, free: 12.08 MB / 0.545 GB
Notification: Performance of NFConvertDAE.convert: time 0.001034/0.2875, allocations: 0.595 MB / 0.723 GB, free: 11.48 MB / 0.545 GB
Notification: Performance of FrontEnd - DAE generated: time 6.682e-06/0.2875, allocations: 0 / 0.723 GB, free: 11.48 MB / 0.545 GB
Notification: Performance of FrontEnd: time 3.086e-06/0.2875, allocations: 0 / 0.723 GB, free: 11.48 MB / 0.545 GB
Notification: Performance of Transformations before backend: time 3.145e-05/0.2875, allocations: 4 kB / 0.723 GB, free: 11.48 MB / 0.545 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 86
 * Number of variables: 86
Notification: Performance of Generate backend data structure: time 0.002108/0.2896, allocations: 0.8355 MB / 0.7238 GB, free: 10.6 MB / 0.545 GB
Notification: Performance of prepare preOptimizeDAE: time 5.792e-05/0.2897, allocations: 11.97 kB / 0.7238 GB, free: 10.59 MB / 0.545 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001244/0.2898, allocations: 70.72 kB / 0.7239 GB, free: 10.51 MB / 0.545 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0002092/0.29, allocations: 64.56 kB / 0.724 GB, free: 10.45 MB / 0.545 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0008137/0.2908, allocations: 336.2 kB / 0.7243 GB, free: 10.09 MB / 0.545 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.87e-05/0.2909, allocations: 25.03 kB / 0.7243 GB, free: 10.07 MB / 0.545 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 7.778e-05/0.291, allocations: 40.38 kB / 0.7243 GB, free: 10.03 MB / 0.545 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.000923/0.2919, allocations: 487.2 kB / 0.7248 GB, free: 9.516 MB / 0.545 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.639e-05/0.2919, allocations: 3.938 kB / 0.7248 GB, free: 9.512 MB / 0.545 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.128e-05/0.2919, allocations: 20 kB / 0.7248 GB, free: 9.492 MB / 0.545 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.368e-05/0.2919, allocations: 8 kB / 0.7248 GB, free: 9.484 MB / 0.545 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.000654/0.2926, allocations: 312.1 kB / 0.7251 GB, free: 9.172 MB / 0.545 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.002599/0.2952, allocations: 1.282 MB / 0.7264 GB, free: 7.824 MB / 0.545 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001075/0.2963, allocations: 487.7 kB / 0.7268 GB, free: 7.289 MB / 0.545 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003836/0.2967, allocations: 227 kB / 0.7271 GB, free: 7.043 MB / 0.545 GB
Notification: Performance of preOpt evalFunc (simulation): time 3.621e-05/0.2967, allocations: 4.234 kB / 0.7271 GB, free: 7.039 MB / 0.545 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0007016/0.2974, allocations: 371.1 kB / 0.7274 GB, free: 6.629 MB / 0.545 GB
Notification: Performance of pre-optimization done (n=39): time 3.527e-06/0.2974, allocations: 0 / 0.7274 GB, free: 6.629 MB / 0.545 GB
Notification: Performance of matching and sorting (n=39): time 0.00144/0.2988, allocations: 0.7102 MB / 0.7281 GB, free: 5.898 MB / 0.545 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002191/0.2991, allocations: 251.2 kB / 0.7284 GB, free: 5.598 MB / 0.545 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0006717/0.2997, allocations: 449.9 kB / 0.7288 GB, free: 5.152 MB / 0.545 GB
Notification: Performance of collectPreVariables (initialization): time 5.713e-05/0.2998, allocations: 33.7 kB / 0.7288 GB, free: 5.113 MB / 0.545 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002712/0.3001, allocations: 249.5 kB / 0.7291 GB, free: 4.867 MB / 0.545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001549/0.3002, allocations: 138.8 kB / 0.7292 GB, free: 4.73 MB / 0.545 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001672/0.3004, allocations: 82.12 kB / 0.7293 GB, free: 4.645 MB / 0.545 GB
Notification: Performance of setup shared object (initialization): time 0.0002402/0.3006, allocations: 362.8 kB / 0.7296 GB, free: 4.281 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003959/0.301, allocations: 192.2 kB / 0.7298 GB, free: 4.086 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004917/0.3015, allocations: 317.7 kB / 0.7301 GB, free: 3.727 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003283/0.3048, allocations: 1.087 MB / 0.7312 GB, free: 2.582 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.64e-06/0.3048, allocations: 0 / 0.7312 GB, free: 2.582 MB / 0.545 GB
Notification: Performance of matching and sorting (n=53) (initialization): time 0.001054/0.3059, allocations: 0.6175 MB / 0.7318 GB, free: 1.945 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 5.222e-05/0.3059, allocations: 37.7 kB / 0.7318 GB, free: 1.902 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.079e-05/0.3059, allocations: 4 kB / 0.7318 GB, free: 1.898 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.445e-05/0.3059, allocations: 7.984 kB / 0.7318 GB, free: 1.891 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005638/0.3065, allocations: 124 kB / 0.7319 GB, free: 1.77 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002057/0.3086, allocations: 1.447 MB / 0.7333 GB, free: 212 kB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0002783/0.3088, allocations: 43.8 kB / 0.7334 GB, free: 168 kB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.581e-05/0.3089, allocations: 19.94 kB / 0.7334 GB, free: 148 kB / 0.545 GB
Warning: Assuming fixed start value for the following 1 variables:
         PI_1ph_in.switch_OnOff.u2:DISCRETE(flow=false fixed = true )  \"Connector of Boolean input signal\" type: Boolean
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0006079/0.3095, allocations: 326.7 kB / 0.7337 GB, free: 15.81 MB / 0.5607 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0004602/0.3099, allocations: 302 kB / 0.734 GB, free: 15.47 MB / 0.5607 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002989/0.3129, allocations: 1.067 MB / 0.735 GB, free: 14.35 MB / 0.5607 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.096e-06/0.3129, allocations: 0 / 0.735 GB, free: 14.35 MB / 0.5607 GB
Notification: Performance of matching and sorting (n=53) (initialization_lambda0): time 0.0009551/0.3139, allocations: 0.6098 MB / 0.7356 GB, free: 13.72 MB / 0.5607 GB
Notification: Performance of prepare postOptimizeDAE: time 4.305e-05/0.3139, allocations: 41.69 kB / 0.7357 GB, free: 13.67 MB / 0.5607 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.378e-06/0.3139, allocations: 0 / 0.7357 GB, free: 13.67 MB / 0.5607 GB
Notification: Performance of postOpt tearingSystem (initialization): time 6.723e-06/0.3139, allocations: 8 kB / 0.7357 GB, free: 13.66 MB / 0.5607 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005148/0.3145, allocations: 111.8 kB / 0.7358 GB, free: 13.55 MB / 0.5607 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001758/0.3162, allocations: 1.443 MB / 0.7372 GB, free: 11.99 MB / 0.5607 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0002459/0.3165, allocations: 47.89 kB / 0.7372 GB, free: 11.95 MB / 0.5607 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 2.832e-05/0.3165, allocations: 12 kB / 0.7373 GB, free: 11.93 MB / 0.5607 GB
Warning: Assuming fixed start value for the following 1 variables:
         PI_1ph_in.switch_OnOff.u2:DISCRETE(flow=false fixed = true )  \"Connector of Boolean input signal\" type: Boolean
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 11
 * Number of states: 0 ()
 * Number of discrete variables: 14 ($PRE.PI_1ph_in.time_lag_I_activation.entryTime,$PRE.PI_1ph_in.switch_OnOff.u2,PI_1ph_in.I_activation.y,PI_1ph_in.time_lag_I_activation.entryTime,PI_1ph_in.switch_OnOff.u2,step.nextEventScaled,step.nextEvent,$PRE.step.nextEvent,step.last,step.b,step.a,$whenCondition2,$whenCondition1,$whenCondition3)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (48):
 * Single equations (assignments): 46
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 0
 * 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): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0002911/0.3168, allocations: 261.8 kB / 0.7375 GB, free: 11.67 MB / 0.5607 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 9.907e-05/0.3169, allocations: 55.66 kB / 0.7376 GB, free: 11.61 MB / 0.5607 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0009521/0.3178, allocations: 0.5635 MB / 0.7381 GB, free: 11.03 MB / 0.5607 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.967e-06/0.3178, allocations: 7.938 kB / 0.7381 GB, free: 11.02 MB / 0.5607 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.114e-06/0.3178, allocations: 0 / 0.7381 GB, free: 11.02 MB / 0.5607 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.744e-06/0.3179, allocations: 8 kB / 0.7381 GB, free: 11.01 MB / 0.5607 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001808/0.3197, allocations: 1.121 MB / 0.7392 GB, free: 9.828 MB / 0.5607 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.019e-05/0.3197, allocations: 11.92 kB / 0.7392 GB, free: 9.816 MB / 0.5607 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000293/0.32, allocations: 59.91 kB / 0.7393 GB, free: 9.758 MB / 0.5607 GB
Notification: Performance of postOpt tearingSystem (simulation): time 8.816e-06/0.32, allocations: 4 kB / 0.7393 GB, free: 9.754 MB / 0.5607 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.434e-05/0.32, allocations: 8 kB / 0.7393 GB, free: 9.746 MB / 0.5607 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 7.584e-06/0.32, allocations: 7.938 kB / 0.7393 GB, free: 9.738 MB / 0.5607 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.546e-06/0.32, allocations: 4 kB / 0.7393 GB, free: 9.734 MB / 0.5607 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001351/0.3214, allocations: 0.9507 MB / 0.7402 GB, free: 8.73 MB / 0.5607 GB
Notification: Performance of postOpt removeConstants (simulation): time 9.106e-05/0.3215, allocations: 51.61 kB / 0.7403 GB, free: 8.68 MB / 0.5607 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 6.381e-05/0.3215, allocations: 16 kB / 0.7403 GB, free: 8.664 MB / 0.5607 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002422/0.3218, allocations: 19.97 kB / 0.7403 GB, free: 8.645 MB / 0.5607 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.35e-05/0.3218, allocations: 31.89 kB / 0.7404 GB, free: 8.613 MB / 0.5607 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 3.809e-05/0.3219, allocations: 16 kB / 0.7404 GB, free: 8.598 MB / 0.5607 GB
Notification: Performance of sorting global known variables: time 0.0003786/0.3223, allocations: 315.1 kB / 0.7407 GB, free: 8.289 MB / 0.5607 GB
Notification: Performance of sort global known variables: time 9e-08/0.3223, allocations: 3.938 kB / 0.7407 GB, free: 8.285 MB / 0.5607 GB
Notification: Performance of remove unused functions: time 0.0006458/0.3229, allocations: 183.5 kB / 0.7408 GB, free: 8.105 MB / 0.5607 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 6
 * Number of states: 8 (PI_1ph_in.smoothPIDInput.y_aux,PI_1ph_in.smoothPIDOutput.y_aux,PI_1ph_in.smoothPIDOutput1.y_aux,PI_1ph_in.resetValueI,stopablePI.outputI,PI_1ph_in.resetValueP,PI_1ph_in.resetValueID,PI_1ph_in.I.y)
 * Number of discrete variables: 11 ($whenCondition3,$whenCondition1,$whenCondition2,step.a,step.b,step.last,step.nextEvent,step.nextEventScaled,PI_1ph_in.switch_OnOff.u2,PI_1ph_in.time_lag_I_activation.entryTime,PI_1ph_in.I_activation.y)
 * Number of discrete states: 8 (step.nextEvent,step.last,step.nextEventScaled,step.b,step.a,$whenCondition2,PI_1ph_in.switch_OnOff.u2,PI_1ph_in.toPU.y)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (37):
 * Single equations (assignments): 35
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 1
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.002097/0.325, allocations: 1.539 MB / 0.7424 GB, free: 6.504 MB / 0.5607 GB
Notification: Performance of simCode: created initialization part: time 0.002816/0.3278, allocations: 0.8866 MB / 0.7432 GB, free: 5.574 MB / 0.5607 GB
Notification: Performance of simCode: created event and clocks part: time 5.049e-06/0.3278, allocations: 4.062 kB / 0.7432 GB, free: 5.57 MB / 0.5607 GB
Notification: Performance of simCode: created simulation system equations: time 0.0006212/0.3284, allocations: 292.8 kB / 0.7435 GB, free: 5.266 MB / 0.5607 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0007731/0.3292, allocations: 55.44 kB / 0.7436 GB, free: 5.215 MB / 0.5607 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01123/0.3405, allocations: 4.97 MB / 0.7484 GB, free: 40 kB / 0.5607 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.4424/0.7829, allocations: 246.3 kB / 0.7486 GB, free: 49.69 MB / 0.5607 GB
Notification: Performance of simCode: alias equations: time 0.000321/0.7832, allocations: 47 kB / 0.7487 GB, free: 49.69 MB / 0.5607 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002513/0.7834, allocations: 176.2 kB / 0.7489 GB, free: 49.68 MB / 0.5607 GB
Notification: Performance of SimCode: time 1.934e-06/0.7834, allocations: 1.312 kB / 0.7489 GB, free: 49.68 MB / 0.5607 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.05026/0.8337, allocations: 10.52 MB / 0.7591 GB, free: 48.57 MB / 0.5607 GB
Notification: Performance of buildModelFMU: Generate platform static: time 13.45/14.28, allocations: 4.312 kB / 0.7591 GB, free: 48.57 MB / 0.5607 GB
"
[Timeout remaining time 786]
(rm -f ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP.pipe ; mkfifo ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP.pipe ; head -c 1048576 < ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP.pipe >> ../files/ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP.sim & python3 -m fmpy simulate  --output-file ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP_res.csv --start-time 0 --stop-time 8 --timeout 800 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.000159926 ClaRa_ClaRa_Basics_ControlVolumes_SolidVolumes_Fundamentals_Blocks_Check_Check_TinyPIP.fmu > ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP.pipe 2>&1) [Timeout 840.0]
diffSimulationResults("ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP_res.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/ClaRa/ReferenceResults/ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 800]
"Error: Could not read variable PI_1ph_in.smoothPIDOutput.y_aux in file ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP_res.csv.
Warning: Get data of variable PI_1ph_in.smoothPIDOutput.y_aux from file ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP_res.csv failed!
Error: Could not read variable PI_1ph_in.smoothPIDOutput1.y_aux in file ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP_res.csv.
Warning: Get data of variable PI_1ph_in.smoothPIDOutput1.y_aux from file ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP_res.csv failed!
Error: Could not read variable Time in file ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP_res.csv.
Warning: Get data of variable Time from file ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP_res.csv failed!
Error: Could not read variable stopablePI.outputI in file ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP_res.csv.
Warning: Get data of variable stopablePI.outputI from file ClaRa_ClaRa.Basics.ControlVolumes.SolidVolumes.Fundamentals.Blocks.Check.Check_TinyPIP_res.csv failed!
"
[Timeout remaining time 800]
Reference file matches
[Calling sys.exit(0), Time elapsed: 19.65611408604309]