Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerGrids_PowerGrids.Electrical.Test.TestTransformerWithTapChangerInterval.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.00122/0.00122, allocations: 97.92 kB / 19.73 MB, free: 2.133 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.001491/0.001491, allocations: 214.6 kB / 23.03 MB, free: 4.949 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.375/1.375, allocations: 207.7 MB / 233.9 MB, free: 9.785 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo): time 0.06753/0.06753, allocations: 14.39 MB / 300.5 MB, free: 7.254 MB / 238.1 MB
"
[Timeout remaining time 180]
Using package PowerGrids with version 1.0.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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)
Ignoring simflag  -noemit -emit_protected=() since it seems broken on HelloWorld
Running command: "" <> buildModelFMU(PowerGrids.Electrical.Test.TestTransformerWithTapChangerInterval,fileNamePrefix="PowerGrids_PowerGrids_Electrical_Test_TestTransformerWithTapChangerInterval",fmuType="cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(PowerGrids.Electrical.Test.TestTransformerWithTapChangerInterval,fileNamePrefix="PowerGrids_PowerGrids_Electrical_Test_TestTransformerWithTapChangerInterval",fmuType="cs",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Modelica requested package Complex of version 3.2.3. Complex 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 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.002188/0.002188, allocations: 71.89 kB / 424.5 MB, free: 35.95 MB / 318.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08043/0.08262, allocations: 52.9 MB / 477.4 MB, free: 14.96 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Electrical.Test.TestTransformerWithTapChangerInterval): time 0.008337/0.09096, allocations: 6.821 MB / 484.3 MB, free: 8.109 MB / 350.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/Electrical/BaseClasses/TwoPortAC.mo:4:3-4:107:writable] Warning: Parameter PowerGrids.Electrical.Branches.TransformerWithTapChangerInterval.UNomA has no value, and is fixed during initialization (fixed=true), using available start value (start=400e3) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/Electrical/BaseClasses/TwoPortAC.mo:6:3-6:94:writable] Warning: Parameter PowerGrids.Electrical.Branches.TransformerWithTapChangerInterval.SNom has no value, and is fixed during initialization (fixed=true), using available start value (start=100e6) as default value.
Notification: Performance of NFInst.instExpressions: time 0.01123/0.1022, allocations: 7.686 MB / 491.9 MB, free: 412 kB / 350.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0009968/0.1032, allocations: 19.88 kB / 492 MB, free: 392 kB / 350.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001409/0.1046, allocations: 409.7 kB / 492.4 MB, free: 15.98 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.004531/0.1091, allocations: 1.581 MB / 493.9 MB, free: 14.4 MB / 366.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001513/0.1106, allocations: 0.7036 MB / 494.6 MB, free: 13.7 MB / 366.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002969/0.1136, allocations: 2.216 MB / 496.9 MB, free: 11.48 MB / 366.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002449/0.1139, allocations: 86.67 kB / 496.9 MB, free: 11.38 MB / 366.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001139/0.115, allocations: 0.802 MB / 497.7 MB, free: 10.57 MB / 366.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001058/0.116, allocations: 0.7706 MB / 498.5 MB, free: 9.801 MB / 366.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001945/0.1162, allocations: 96 kB / 498.6 MB, free: 9.707 MB / 366.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00103/0.1173, allocations: 463.7 kB / 499.1 MB, free: 9.254 MB / 366.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0002747/0.1175, allocations: 263 kB / 499.3 MB, free: 8.996 MB / 366.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0007045/0.1183, allocations: 0.5717 MB / 499.9 MB, free: 8.422 MB / 366.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.00276/0.121, allocations: 1.822 MB / 0.49 GB, free: 6.594 MB / 366.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.62e-06/0.121, allocations: 0 / 0.49 GB, free: 6.594 MB / 366.1 MB
Notification: Performance of FrontEnd: time 1.713e-06/0.121, allocations: 3.938 kB / 0.49 GB, free: 6.59 MB / 366.1 MB
Notification: Performance of Transformations before backend: time 3.11e-05/0.1211, allocations: 0 / 0.49 GB, free: 6.59 MB / 366.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 205
 * Number of variables: 205
Notification: Performance of Generate backend data structure: time 0.006662/0.1277, allocations: 2.089 MB / 0.492 GB, free: 4.461 MB / 366.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.165e-05/0.1278, allocations: 12.02 kB / 0.492 GB, free: 4.449 MB / 366.1 MB
Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 3.319e-05/0.1278, allocations: 22.19 kB / 0.492 GB, free: 4.43 MB / 366.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0002147/0.128, allocations: 139.2 kB / 0.4922 GB, free: 4.285 MB / 366.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0008218/0.1288, allocations: 188.2 kB / 0.4923 GB, free: 4.102 MB / 366.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001595/0.1304, allocations: 0.7413 MB / 0.4931 GB, free: 3.332 MB / 366.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.162e-05/0.1305, allocations: 78.34 kB / 0.4931 GB, free: 3.258 MB / 366.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002091/0.1307, allocations: 115.9 kB / 0.4933 GB, free: 3.145 MB / 366.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002454/0.1332, allocations: 1.449 MB / 0.4947 GB, free: 1.625 MB / 366.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.16e-05/0.1332, allocations: 4 kB / 0.4947 GB, free: 1.621 MB / 366.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001373/0.1333, allocations: 47.97 kB / 0.4947 GB, free: 1.574 MB / 366.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.01e-05/0.1333, allocations: 20 kB / 0.4947 GB, free: 1.555 MB / 366.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001648/0.135, allocations: 0.8548 MB / 0.4956 GB, free: 0.6992 MB / 366.1 MB
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.006958/0.1419, allocations: 3.593 MB / 0.4991 GB, free: 13.01 MB / 382.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001706/0.1436, allocations: 0.8091 MB / 0.4999 GB, free: 12.19 MB / 382.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.000846/0.1445, allocations: 415.7 kB / 0.5003 GB, free: 11.78 MB / 382.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 5.042e-05/0.1445, allocations: 9 kB / 0.5003 GB, free: 11.77 MB / 382.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001934/0.1465, allocations: 1.173 MB / 0.5014 GB, free: 10.57 MB / 382.1 MB
Notification: Performance of pre-optimization done (n=118): time 4.348e-06/0.1465, allocations: 0 / 0.5014 GB, free: 10.57 MB / 382.1 MB
Notification: Performance of matching and sorting (n=118): time 0.004773/0.1513, allocations: 2.097 MB / 0.5035 GB, free: 8.461 MB / 382.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.855e-05/0.1513, allocations: 72.39 kB / 0.5035 GB, free: 8.375 MB / 382.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001161/0.1525, allocations: 0.6369 MB / 0.5042 GB, free: 7.734 MB / 382.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001767/0.1527, allocations: 69.69 kB / 0.5042 GB, free: 7.66 MB / 382.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0004079/0.1531, allocations: 397.4 kB / 0.5046 GB, free: 7.266 MB / 382.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004356/0.1535, allocations: 388.9 kB / 0.505 GB, free: 6.883 MB / 382.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003406/0.1539, allocations: 194.9 kB / 0.5052 GB, free: 6.688 MB / 382.1 MB
Notification: Performance of setup shared object (initialization): time 0.000231/0.1541, allocations: 394.7 kB / 0.5055 GB, free: 6.293 MB / 382.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006441/0.1547, allocations: 358.5 kB / 0.5059 GB, free: 5.941 MB / 382.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0009058/0.1556, allocations: 0.6951 MB / 0.5066 GB, free: 5.141 MB / 382.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004226/0.1599, allocations: 1.575 MB / 0.5081 GB, free: 3.504 MB / 382.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.516e-06/0.1599, allocations: 4 kB / 0.5081 GB, free: 3.5 MB / 382.1 MB
Notification: Performance of matching and sorting (n=151) (initialization): time 0.002209/0.1621, allocations: 1.161 MB / 0.5092 GB, free: 2.328 MB / 382.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.241e-05/0.1621, allocations: 8 kB / 0.5092 GB, free: 2.32 MB / 382.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.345e-05/0.1621, allocations: 4 kB / 0.5092 GB, free: 2.316 MB / 382.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005363/0.1627, allocations: 165.3 kB / 0.5094 GB, free: 2.152 MB / 382.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000858/0.1635, allocations: 203.6 kB / 0.5096 GB, free: 1.953 MB / 382.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003226/0.1667, allocations: 2.33 MB / 0.5119 GB, free: 15.52 MB / 398.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00115/0.1679, allocations: 111.5 kB / 0.512 GB, free: 15.41 MB / 398.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.705e-05/0.168, allocations: 47.98 kB / 0.512 GB, free: 15.36 MB / 398.1 MB
Warning: Assuming fixed start value for the following 7 variables:
         trafo.valueUnderMin:DISCRETE(start = false fixed = true protected = true )  \"true if the monitored signal is under the minimum limit\" type: Boolean
         trafo.valueAboveMax:DISCRETE(start = false fixed = true protected = true )  \"true if the monitored signal is above the maximum limit\" type: Boolean
         trafo.tValueUnderMinWhileRunning:DISCRETE(start = 1e60 unit = \"s\" fixed = true protected = true )  \"time when the monitored signal went under the minimum limit and the tap-changer/phase-shifter is running\" type: Real
         trafo.tValueAboveMaxWhileRunning:DISCRETE(start = 1e60 unit = \"s\" fixed = true protected = true )  \"time when the monitored signal went above the maximum limit and the tap-changer/phase-shifter is running\" type: Real
         trafo.tValueInRangeWhileRunning:DISCRETE(start = 1e60 unit = \"s\" fixed = true protected = true )  \"time when the monitored signal comes back into the [valueMin ; valueMax] range and the tap-changer/phase-shifter is running\" type: Real
         trafo.locked:DISCRETE(start = trafo.lockedStart fixed = true )  \"whether the tap-changer/phase-shifter is locked\" type: Boolean
         trafo.running:DISCRETE(start = trafo.runningStart fixed = true )  \"whether the tap-changer/phase-shifter is running\" type: Boolean
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 20
 * Number of states: 0 ()
 * Number of discrete variables: 52 ($PRE.trafo.valueUnderMin,$PRE.trafo.valueAboveMax,$PRE.trafo.tValueUnderMinWhileRunning,$PRE.trafo.tValueAboveMaxWhileRunning,$PRE.trafo.tValueInRangeWhileRunning,$PRE.trafo.locked,$PRE.trafo.running,trafo.tValueInRangeWhileRunning,trafo.tValueAboveMaxWhileRunning,trafo.tValueUnderMinWhileRunning,trafo.valueInRange,trafo.valueAboveMax,trafo.valueUnderMin,trafo.tTapMoved,$PRE.trafo.tTapMoved,trafo.lookingToDecreaseTap,trafo.lookingToIncreaseTap,trafo.tap,$PRE.trafo.tap,trafo.state,$PRE.trafo.state,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,$whenCondition29,$whenCondition28,$whenCondition27,$whenCondition26,$whenCondition25,trafo.running,trafo.locked)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (136):
 * Single equations (assignments): 135
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(4,12,93.8%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0006493/0.1686, allocations: 306.1 kB / 0.5123 GB, free: 15.05 MB / 398.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002495/0.1689, allocations: 119.4 kB / 0.5124 GB, free: 14.94 MB / 398.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002742/0.1716, allocations: 1.585 MB / 0.514 GB, free: 13.33 MB / 398.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.218e-05/0.1716, allocations: 12 kB / 0.514 GB, free: 13.32 MB / 398.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.693e-06/0.1716, allocations: 4 kB / 0.514 GB, free: 13.32 MB / 398.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.37e-05/0.1717, allocations: 7.969 kB / 0.514 GB, free: 13.31 MB / 398.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004046/0.1757, allocations: 2.516 MB / 0.5165 GB, free: 10.74 MB / 398.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.409e-06/0.1757, allocations: 0 / 0.5165 GB, free: 10.74 MB / 398.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006953/0.1764, allocations: 151.8 kB / 0.5166 GB, free: 10.59 MB / 398.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0004797/0.1769, allocations: 156.1 kB / 0.5168 GB, free: 10.44 MB / 398.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001033/0.177, allocations: 51.92 kB / 0.5168 GB, free: 10.39 MB / 398.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002977/0.18, allocations: 2.311 MB / 0.5191 GB, free: 7.969 MB / 398.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.343e-06/0.18, allocations: 4 kB / 0.5191 GB, free: 7.965 MB / 398.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002738/0.1827, allocations: 1.643 MB / 0.5207 GB, free: 6.301 MB / 398.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.000592/0.1833, allocations: 219.1 kB / 0.5209 GB, free: 6.086 MB / 398.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002598/0.1835, allocations: 71.88 kB / 0.5209 GB, free: 6.016 MB / 398.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008415/0.1844, allocations: 87.8 kB / 0.521 GB, free: 5.93 MB / 398.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004199/0.1848, allocations: 192.6 kB / 0.5212 GB, free: 5.742 MB / 398.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001441/0.185, allocations: 83.92 kB / 0.5213 GB, free: 5.66 MB / 398.1 MB
Notification: Performance of sorting global known variables: time 0.0006419/0.1856, allocations: 446.9 kB / 0.5217 GB, free: 5.227 MB / 398.1 MB
Notification: Performance of sort global known variables: time 8e-08/0.1856, allocations: 0 / 0.5217 GB, free: 5.227 MB / 398.1 MB
Notification: Performance of remove unused functions: time 0.00114/0.1867, allocations: 415.8 kB / 0.5221 GB, free: 4.82 MB / 398.1 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 0 ()
 * Number of discrete variables: 40 ($whenCondition25,$whenCondition26,$whenCondition27,$whenCondition28,$whenCondition29,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,$whenCondition24,trafo.state,trafo.tap,trafo.lookingToIncreaseTap,trafo.lookingToDecreaseTap,trafo.tTapMoved,trafo.valueUnderMin,trafo.valueAboveMax,trafo.valueInRange,trafo.tValueUnderMinWhileRunning,trafo.tValueAboveMaxWhileRunning,trafo.tValueInRangeWhileRunning)
 * Number of discrete states: 8 (trafo.valueAboveMax,trafo.valueUnderMin,trafo.state,trafo.tTapMoved,trafo.tap,trafo.tValueInRangeWhileRunning,trafo.tValueAboveMaxWhileRunning,trafo.tValueUnderMinWhileRunning)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (104):
 * Single equations (assignments): 97
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 6
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(3,13,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.003251/0.19, allocations: 2.33 MB / 0.5244 GB, free: 2.461 MB / 398.1 MB
Notification: Performance of simCode: created initialization part: time 0.002295/0.1923, allocations: 1.205 MB / 0.5256 GB, free: 1.246 MB / 398.1 MB
Notification: Performance of simCode: created event and clocks part: time 3.025e-06/0.1923, allocations: 7.938 kB / 0.5256 GB, free: 1.238 MB / 398.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.001254/0.1935, allocations: 0.758 MB / 0.5263 GB, free: 480 kB / 398.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0009558/0.1945, allocations: 172.9 kB / 0.5265 GB, free: 304 kB / 398.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1792/0.3737, allocations: 7.712 MB / 0.534 GB, free: 58.89 MB / 398.1 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004582/0.3742, allocations: 425.2 kB / 0.5344 GB, free: 58.77 MB / 398.1 MB
Notification: Performance of simCode: alias equations: time 0.0005725/0.3748, allocations: 132.4 kB / 0.5345 GB, free: 58.76 MB / 398.1 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006053/0.3754, allocations: 374.8 kB / 0.5349 GB, free: 58.5 MB / 398.1 MB
Notification: Performance of SimCode: time 1.122e-06/0.3754, allocations: 4.312 kB / 0.5349 GB, free: 58.5 MB / 398.1 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.06036/0.4357, allocations: 25.76 MB / 0.5601 GB, free: 40.34 MB / 398.1 MB
Notification: Performance of buildModelFMU: Generate platform static: time 13.75/14.19, allocations: 7.062 kB / 0.5601 GB, free: 40.34 MB / 398.1 MB
"
[Timeout remaining time 646]
(rm -f PowerGrids_PowerGrids.Electrical.Test.TestTransformerWithTapChangerInterval.pipe ; mkfifo PowerGrids_PowerGrids.Electrical.Test.TestTransformerWithTapChangerInterval.pipe ; head -c 1048576 < PowerGrids_PowerGrids.Electrical.Test.TestTransformerWithTapChangerInterval.pipe >> ../files/PowerGrids_PowerGrids.Electrical.Test.TestTransformerWithTapChangerInterval.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=PowerGrids_PowerGrids.Electrical.Test.TestTransformerWithTapChangerInterval_res.mat --tempDir=temp_PowerGrids_PowerGrids_Electrical_Test_TestTransformerWithTapChangerInterval_fmu --startTime=0 --stopTime=80 --stepSize=0.16 --timeout=50 --tolerance=1e-06 PowerGrids_PowerGrids_Electrical_Test_TestTransformerWithTapChangerInterval.fmu > PowerGrids_PowerGrids.Electrical.Test.TestTransformerWithTapChangerInterval.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 16.82186681497842]
Failed to read output from testmodel.py, exit status != 0:
14.369559832965024 14.385632777 14.262046628
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fc768f3b3a0>