Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4.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.0008879/0.0008879, allocations: 96.36 kB / 19.72 MB, free: 428 kB / 13.93 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.00121/0.00121, allocations: 219.6 kB / 23.02 MB, free: 2.949 MB / 13.93 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.025/1.025, allocations: 207.7 MB / 233.9 MB, free: 11.44 MB / 186.7 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.8.0/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.8.0/package.mo): time 0.459/0.459, allocations: 122.7 MB / 408.8 MB, free: 15.38 MB / 346.7 MB " [Timeout remaining time 179] Using package Dynawo with version 1.8.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.8.0/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 -noHomotopyOnFirstTry=() since the simulation runtime does not accept it Ignoring simflag -noemit -noRestart=() since the simulation runtime does not accept it Ignoring simflag -noemit -noRootFinding=() since the simulation runtime does not accept it Running command: "" <> buildModelFMU(Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4,fileNamePrefix="Dynawo_Dynawo_Examples_Photovoltaics_WECC_PVVoltageSource4",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4,fileNamePrefix="Dynawo_Dynawo_Examples_Photovoltaics_WECC_PVVoltageSource4",fmuType="me",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.001122/0.001122, allocations: 71.91 kB / 0.5804 GB, free: 7.695 MB / 490.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.3585/0.3596, allocations: 80.89 MB / 0.6594 GB, free: 20.41 MB / 0.4948 GB Notification: Performance of NFInst.instantiate(Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4): time 0.01201/0.3716, allocations: 14.56 MB / 0.6736 GB, free: 9.41 MB / 0.4948 GB Notification: Performance of NFInst.instExpressions: time 0.01161/0.3832, allocations: 6.818 MB / 0.6803 GB, free: 3.852 MB / 0.4948 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.002418/0.3856, allocations: 108.6 kB / 0.6804 GB, free: 3.805 MB / 0.4948 GB Notification: Performance of NFTyping.typeComponents: time 0.001464/0.3871, allocations: 0.7787 MB / 0.6812 GB, free: 3.125 MB / 0.4948 GB Notification: Performance of NFTyping.typeBindings: time 0.002421/0.3895, allocations: 1.546 MB / 0.6827 GB, free: 1.84 MB / 0.4948 GB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Dynawo 1.8.0/Electrical/Photovoltaics/WECC/PVVoltageSource_INIT.mo:106:3-106:91:writable] Warning: In relation Modelica.ComplexMath.'abs'(pvVoltageSource_INIT.s0Pu) == 0.0, == on Real numbers is only allowed inside functions. Notification: Performance of NFTyping.typeClassSections: time 0.003782/0.3933, allocations: 3.041 MB / 0.6856 GB, free: 15.35 MB / 0.5105 GB Notification: Performance of NFFlatten.flatten: time 0.005063/0.3984, allocations: 5.802 MB / 0.6913 GB, free: 11.58 MB / 0.5105 GB Notification: Performance of NFFlatten.resolveConnections: time 0.002016/0.4004, allocations: 1.386 MB / 0.6927 GB, free: 10.54 MB / 0.5105 GB Notification: Performance of NFEvalConstants.evaluate: time 0.002552/0.4029, allocations: 2.137 MB / 0.6948 GB, free: 9.047 MB / 0.5105 GB Notification: Performance of NFSimplifyModel.simplify: time 0.001798/0.4047, allocations: 2.047 MB / 0.6968 GB, free: 7.387 MB / 0.5105 GB Notification: Performance of NFPackage.collectConstants: time 0.0005448/0.4053, allocations: 0.6367 MB / 0.6974 GB, free: 6.75 MB / 0.5105 GB Notification: Performance of NFFlatten.collectFunctions: time 0.001187/0.4065, allocations: 0.9333 MB / 0.6983 GB, free: 5.816 MB / 0.5105 GB Notification: Performance of NFScalarize.scalarize: time 0.0006776/0.4071, allocations: 1.242 MB / 0.6995 GB, free: 4.57 MB / 0.5105 GB Notification: Performance of NFVerifyModel.verify: time 0.001233/0.4084, allocations: 1.912 MB / 0.7014 GB, free: 2.648 MB / 0.5105 GB Notification: Performance of NFConvertDAE.convert: time 0.005623/0.414, allocations: 7.639 MB / 0.7088 GB, free: 10.98 MB / 0.5261 GB Notification: Performance of FrontEnd - DAE generated: time 6.632e-06/0.414, allocations: 0 / 0.7088 GB, free: 10.98 MB / 0.5261 GB Notification: Performance of FrontEnd: time 2.214e-06/0.414, allocations: 0 / 0.7088 GB, free: 10.98 MB / 0.5261 GB Notification: Performance of Transformations before backend: time 7.265e-05/0.4141, allocations: 3.938 kB / 0.7088 GB, free: 10.98 MB / 0.5261 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 827 * Number of variables: 827 Notification: Performance of Generate backend data structure: time 0.01013/0.4242, allocations: 6.307 MB / 0.715 GB, free: 4.586 MB / 0.5261 GB Notification: Performance of prepare preOptimizeDAE: time 4.616e-05/0.4243, allocations: 8.031 kB / 0.715 GB, free: 4.578 MB / 0.5261 GB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0003962/0.4247, allocations: 459.3 kB / 0.7154 GB, free: 4.117 MB / 0.5261 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003844/0.4285, allocations: 1.317 MB / 0.7167 GB, free: 2.797 MB / 0.5261 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.003061/0.4316, allocations: 2.84 MB / 0.7195 GB, free: 15.9 MB / 0.5417 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004163/0.432, allocations: 0.9017 MB / 0.7204 GB, free: 14.85 MB / 0.5417 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003243/0.4323, allocations: 339.9 kB / 0.7207 GB, free: 14.52 MB / 0.5417 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.00477/0.4371, allocations: 4.482 MB / 0.7251 GB, free: 9.758 MB / 0.5417 GB Notification: Performance of preOpt findStateOrder (simulation): time 3.958e-05/0.4371, allocations: 11.94 kB / 0.7251 GB, free: 9.746 MB / 0.5417 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002189/0.4373, allocations: 140 kB / 0.7252 GB, free: 9.609 MB / 0.5417 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.821e-05/0.4374, allocations: 80 kB / 0.7253 GB, free: 9.531 MB / 0.5417 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004506/0.4419, allocations: 3.47 MB / 0.7287 GB, free: 6.051 MB / 0.5417 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.01218/0.4541, allocations: 12.29 MB / 0.7407 GB, free: 9.547 MB / 0.5573 GB Notification: Performance of preOpt comSubExp (simulation): time 0.004478/0.4585, allocations: 3.381 MB / 0.744 GB, free: 6.168 MB / 0.5573 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.001972/0.4605, allocations: 1.397 MB / 0.7454 GB, free: 4.77 MB / 0.5573 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0001676/0.4607, allocations: 45.97 kB / 0.7454 GB, free: 4.727 MB / 0.5573 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002285/0.463, allocations: 2.002 MB / 0.7474 GB, free: 2.652 MB / 0.5573 GB Notification: Performance of pre-optimization done (n=274): time 3.647e-06/0.463, allocations: 0 / 0.7474 GB, free: 2.652 MB / 0.5573 GB Notification: Performance of matching and sorting (n=274): time 0.008538/0.4715, allocations: 5.485 MB / 0.7527 GB, free: 13.16 MB / 0.573 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001779/0.4717, allocations: 0.5469 MB / 0.7532 GB, free: 12.49 MB / 0.573 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003365/0.475, allocations: 3.43 MB / 0.7566 GB, free: 9.074 MB / 0.573 GB Notification: Performance of collectPreVariables (initialization): time 0.0001564/0.4752, allocations: 89.7 kB / 0.7567 GB, free: 8.98 MB / 0.573 GB Notification: Performance of collectInitialEqns (initialization): time 0.0009598/0.4762, allocations: 1.66 MB / 0.7583 GB, free: 7.305 MB / 0.573 GB Notification: Performance of collectInitialBindings (initialization): time 0.0006598/0.4768, allocations: 0.9919 MB / 0.7593 GB, free: 6.305 MB / 0.573 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0009294/0.4777, allocations: 0.8432 MB / 0.7601 GB, free: 5.449 MB / 0.573 GB Notification: Performance of setup shared object (initialization): time 6.848e-05/0.4778, allocations: 305.1 kB / 0.7604 GB, free: 5.148 MB / 0.573 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.002299/0.4801, allocations: 1.923 MB / 0.7623 GB, free: 3.199 MB / 0.573 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.003035/0.4831, allocations: 3.012 MB / 0.7652 GB, free: 15.86 MB / 0.5886 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.0162/0.4993, allocations: 9.892 MB / 0.7749 GB, free: 5.699 MB / 0.5886 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.466e-05/0.4994, allocations: 4 kB / 0.7749 GB, free: 5.695 MB / 0.5886 GB Notification: Performance of matching and sorting (n=593) (initialization): time 0.007809/0.5072, allocations: 5.765 MB / 0.7805 GB, free: 15.84 MB / 0.6042 GB Notification: Performance of prepare postOptimizeDAE: time 8.672e-05/0.5073, allocations: 69.66 kB / 0.7806 GB, free: 15.77 MB / 0.6042 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.03e-05/0.5073, allocations: 12 kB / 0.7806 GB, free: 15.75 MB / 0.6042 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0007594/0.508, allocations: 0.5404 MB / 0.7811 GB, free: 15.21 MB / 0.6042 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002297/0.5103, allocations: 0.9205 MB / 0.782 GB, free: 14.29 MB / 0.6042 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004542/0.5149, allocations: 3.936 MB / 0.7858 GB, free: 10.24 MB / 0.6042 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002493/0.5174, allocations: 0.5049 MB / 0.7863 GB, free: 9.734 MB / 0.6042 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002415/0.5176, allocations: 152 kB / 0.7865 GB, free: 9.586 MB / 0.6042 GB Warning: Assuming fixed start value for the following 36 variables: PV.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = PV.injector.State0 fixed = true ) \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) PV.injector.running:DISCRETE(flow=false start = PV.injector.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean PV.HvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = PV.HvTfo.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) PV.LvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = PV.LvTfo.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) PV.source.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = PV.source.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) PV.s0Pu.im:VARIABLE(unit = \"1\" fixed = true ) \"Imaginary part of complex number\" type: Real PV.s0Pu.re:VARIABLE(unit = \"1\" fixed = true ) \"Real part of complex number\" type: Real line.running:DISCRETE(flow=false start = line.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean PV.wecc_regc.rateLimFirstOrderFreeze2.y:VARIABLE(flow=false start = PV.wecc_regc.rateLimFirstOrderFreeze2.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_regc.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = PV.wecc_regc.rateLimFirstOrderFreeze1.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_regc.firstOrder.y:VARIABLE(flow=false start = PV.wecc_regc.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_regc.offDelay.delaySignal:DISCRETE(start = false fixed = true protected = true ) type: Boolean PV.wecc_regc.offDelay.tNext:DISCRETE(start = -1.0 unit = \"s\" fixed = true protected = true ) type: Real PV.wecc_regc.vSourceRef.firstOrder.y:VARIABLE(flow=false start = PV.wecc_regc.vSourceRef.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_regc.vSourceRef.firstOrder1.y:VARIABLE(flow=false start = PV.wecc_regc.vSourceRef.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.source.running:DISCRETE(flow=false start = PV.source.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean PV.LvTfo.running:DISCRETE(flow=false start = PV.LvTfo.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean PV.HvTfo.running:DISCRETE(flow=false start = PV.HvTfo.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean PV.wecc_repc.firstOrder.y:VARIABLE(flow=false start = PV.wecc_repc.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_repc.firstOrder1.y:VARIABLE(flow=false start = PV.wecc_repc.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_repc.firstOrder2.y:VARIABLE(flow=false start = PV.wecc_repc.firstOrder2.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_repc.firstOrder3.y:VARIABLE(flow=false start = PV.wecc_repc.firstOrder3.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_repc.limPIDFreeze.I.y:VARIABLE(flow=false start = PV.wecc_repc.limPIDFreeze.I.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_repc.leadLag.x_scaled[1]:VARIABLE(start = PV.wecc_repc.leadLag.X0[1] * PV.wecc_repc.leadLag.a_end fixed = true protected = true ) \"Scaled vector x\" type: Real [1] PV.wecc_reec.firstOrder.y:VARIABLE(flow=false start = PV.wecc_reec.UConv0Pu fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.firstOrder1.y:VARIABLE(flow=false start = PV.wecc_reec.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.limPIDFreeze.I.y:VARIABLE(flow=false start = PV.wecc_reec.limPIDFreeze.I.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = PV.wecc_reec.rateLimFirstOrderFreeze1.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = PV.wecc_reec.rateLimFirstOrderFreeze.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.varLimPIDFreeze.I.y:VARIABLE(flow=false start = PV.wecc_reec.varLimPIDFreeze.I.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.firstOrder2.y:VARIABLE(flow=false start = PV.wecc_reec.firstOrder2.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.firstOrder3.y:VARIABLE(flow=false start = PV.wecc_reec.firstOrder3.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.iSource0Pu.im:VARIABLE(unit = \"1\" fixed = true ) \"Imaginary part of complex number\" type: Real PV.iSource0Pu.re:VARIABLE(unit = \"1\" fixed = true ) \"Real part of complex number\" type: Real PV.wecc_regc.offDelay.u:DISCRETE(flow=false fixed = true ) \"Boolean input signal\" type: Boolean Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003975/0.5216, allocations: 2.65 MB / 0.7891 GB, free: 6.934 MB / 0.6042 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002815/0.5244, allocations: 2.942 MB / 0.7919 GB, free: 3.664 MB / 0.6042 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01582/0.5402, allocations: 9.751 MB / 0.8015 GB, free: 9.648 MB / 0.6198 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.356e-05/0.5402, allocations: 4 kB / 0.8015 GB, free: 9.645 MB / 0.6198 GB Notification: Performance of matching and sorting (n=593) (initialization_lambda0): time 0.007664/0.5479, allocations: 5.66 MB / 0.807 GB, free: 3.895 MB / 0.6198 GB Notification: Performance of prepare postOptimizeDAE: time 6.2e-05/0.548, allocations: 73.66 kB / 0.8071 GB, free: 3.816 MB / 0.6198 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.374e-05/0.548, allocations: 12 kB / 0.8071 GB, free: 3.805 MB / 0.6198 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0006438/0.5486, allocations: 0.5475 MB / 0.8076 GB, free: 3.254 MB / 0.6198 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002124/0.5507, allocations: 0.8933 MB / 0.8085 GB, free: 2.359 MB / 0.6198 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004385/0.5551, allocations: 3.94 MB / 0.8123 GB, free: 14.3 MB / 0.6355 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002243/0.5574, allocations: 433.9 kB / 0.8127 GB, free: 13.88 MB / 0.6355 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002116/0.5576, allocations: 156 kB / 0.8129 GB, free: 13.72 MB / 0.6355 GB Warning: Assuming fixed start value for the following 36 variables: PV.injector.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = PV.injector.State0 fixed = true ) \"Injector connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) PV.injector.running:DISCRETE(flow=false start = PV.injector.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean PV.HvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = PV.HvTfo.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) PV.LvTfo.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = PV.LvTfo.State0 fixed = true ) \"Transformer connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) PV.source.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = PV.source.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) line.state:DISCRETE(min = Dynawo.Electrical.Constants.state.Open max = Dynawo.Electrical.Constants.state.Undefined start = line.State0 fixed = true ) \"Line connection state\" type: enumeration(Open, Closed, Closed1, Closed2, Closed3, Undefined) PV.s0Pu.im:VARIABLE(unit = \"1\" fixed = true ) \"Imaginary part of complex number\" type: Real PV.s0Pu.re:VARIABLE(unit = \"1\" fixed = true ) \"Real part of complex number\" type: Real line.running:DISCRETE(flow=false start = line.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean PV.wecc_regc.rateLimFirstOrderFreeze2.y:VARIABLE(flow=false start = PV.wecc_regc.rateLimFirstOrderFreeze2.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_regc.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = PV.wecc_regc.rateLimFirstOrderFreeze1.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_regc.firstOrder.y:VARIABLE(flow=false start = PV.wecc_regc.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_regc.offDelay.delaySignal:DISCRETE(start = false fixed = true protected = true ) type: Boolean PV.wecc_regc.offDelay.tNext:DISCRETE(start = -1.0 unit = \"s\" fixed = true protected = true ) type: Real PV.wecc_regc.vSourceRef.firstOrder.y:VARIABLE(flow=false start = PV.wecc_regc.vSourceRef.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_regc.vSourceRef.firstOrder1.y:VARIABLE(flow=false start = PV.wecc_regc.vSourceRef.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.source.running:DISCRETE(flow=false start = PV.source.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean PV.LvTfo.running:DISCRETE(flow=false start = PV.LvTfo.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean PV.HvTfo.running:DISCRETE(flow=false start = PV.HvTfo.Running0 fixed = true ) \"Indicates if the component is running or not\" type: Boolean PV.wecc_repc.firstOrder.y:VARIABLE(flow=false start = PV.wecc_repc.firstOrder.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_repc.firstOrder1.y:VARIABLE(flow=false start = PV.wecc_repc.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_repc.firstOrder2.y:VARIABLE(flow=false start = PV.wecc_repc.firstOrder2.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_repc.firstOrder3.y:VARIABLE(flow=false start = PV.wecc_repc.firstOrder3.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_repc.limPIDFreeze.I.y:VARIABLE(flow=false start = PV.wecc_repc.limPIDFreeze.I.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_repc.leadLag.x_scaled[1]:VARIABLE(start = PV.wecc_repc.leadLag.X0[1] * PV.wecc_repc.leadLag.a_end fixed = true protected = true ) \"Scaled vector x\" type: Real [1] PV.wecc_reec.firstOrder.y:VARIABLE(flow=false start = PV.wecc_reec.UConv0Pu fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.firstOrder1.y:VARIABLE(flow=false start = PV.wecc_reec.firstOrder1.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.limPIDFreeze.I.y:VARIABLE(flow=false start = PV.wecc_reec.limPIDFreeze.I.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.rateLimFirstOrderFreeze1.y:VARIABLE(flow=false start = PV.wecc_reec.rateLimFirstOrderFreeze1.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.rateLimFirstOrderFreeze.y:VARIABLE(flow=false start = PV.wecc_reec.rateLimFirstOrderFreeze.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.varLimPIDFreeze.I.y:VARIABLE(flow=false start = PV.wecc_reec.varLimPIDFreeze.I.Y0 fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.firstOrder2.y:VARIABLE(flow=false start = PV.wecc_reec.firstOrder2.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.wecc_reec.firstOrder3.y:VARIABLE(flow=false start = PV.wecc_reec.firstOrder3.y_start fixed = true ) \"Connector of Real output signal\" type: Real PV.iSource0Pu.im:VARIABLE(unit = \"1\" fixed = true ) \"Imaginary part of complex number\" type: Real PV.iSource0Pu.re:VARIABLE(unit = \"1\" fixed = true ) \"Real part of complex number\" type: Real PV.wecc_regc.offDelay.u:DISCRETE(flow=false fixed = true ) \"Boolean input signal\" type: Boolean Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 50 * Number of states: 0 () * Number of discrete variables: 68 ($PRE.PV.injector.state,PV.injector.state,$PRE.PV.injector.running,PV.injector.running,$whenCondition7,$whenCondition6,$whenCondition8,$PRE.PV.HvTfo.state,PV.HvTfo.state,$PRE.PV.LvTfo.state,PV.LvTfo.state,$PRE.PV.source.state,PV.source.state,$PRE.line.state,line.state,PV.injector.switchOffSignal3,PV.injector.switchOffSignal2,PV.injector.switchOffSignal1,line.switchOffSignal2,line.switchOffSignal1,PV.wecc_regc.rateLimFirstOrderFreeze1.local_freeze,PV.wecc_regc.rateLimFirstOrderFreeze2.local_freeze,$PRE.line.running,$PRE.PV.wecc_regc.offDelay.delaySignal,$PRE.PV.wecc_regc.offDelay.tNext,$PRE.PV.source.running,$PRE.PV.LvTfo.running,$PRE.PV.HvTfo.running,PV.wecc_regc.QConv0PuPos.k,PV.wecc_regc.and1.u[1],PV.wecc_regc.QConv0PuPos.y,PV.wecc_regc.QConv0PuNeg.k,PV.wecc_regc.and2.u[2],PV.wecc_regc.QConv0PuNeg.y,$PRE.PV.wecc_regc.offDelay.u,PV.wecc_repc.freeze,PV.HvTfo.running,PV.LvTfo.running,PV.source.running,PV.wecc_regc.and2.y,PV.wecc_regc.and1.y,PV.wecc_regc.and1.u[2],PV.wecc_regc.offDelay.tNext,PV.wecc_regc.offDelay.delaySignal,PV.wecc_regc.offDelay.u,line.running,$whenCondition2,$whenCondition1,$whenCondition3,$whenCondition5,$whenCondition4,$whenCondition10,$whenCondition9,$whenCondition11,$whenCondition13,$whenCondition12,$whenCondition14,$whenCondition16,$whenCondition15,$whenCondition17,PV.wecc_reec.varLimPIDFreeze.I.resetLocal,PV.wecc_reec.limPIDFreeze.I.resetLocal,PV.wecc_repc.limPIDFreeze.I.resetLocal,PV.wecc_repc.limPID.I.local_reset,PV.pll.limIntegrator.local_reset,PV.pll.integrator.local_reset,PV.wecc_regc.pIAntiWindupVariableLimits1.integrator.local_reset,PV.wecc_regc.pIAntiWindupVariableLimits.integrator.local_reset) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (546): * Single equations (assignments): 544 * Array equations: 0 * Algorithm blocks: 1 * 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 {(12,8,44.4%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.000945/0.5585, allocations: 0.5896 MB / 0.8135 GB, free: 13.14 MB / 0.6355 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005039/0.559, allocations: 401.4 kB / 0.8139 GB, free: 12.75 MB / 0.6355 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00586/0.5649, allocations: 3.985 MB / 0.8177 GB, free: 8.742 MB / 0.6355 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.628e-05/0.5649, allocations: 28 kB / 0.8178 GB, free: 8.715 MB / 0.6355 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 9.458e-06/0.5649, allocations: 4 kB / 0.8178 GB, free: 8.711 MB / 0.6355 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.68e-05/0.5649, allocations: 11.95 kB / 0.8178 GB, free: 8.699 MB / 0.6355 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01194/0.5769, allocations: 8.268 MB / 0.8259 GB, free: 308 kB / 0.6355 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.867e-06/0.5769, allocations: 8.156 kB / 0.8259 GB, free: 300 kB / 0.6355 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001652/0.5785, allocations: 0.5306 MB / 0.8264 GB, free: 15.76 MB / 0.6511 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0006686/0.5792, allocations: 0.5352 MB / 0.8269 GB, free: 15.23 MB / 0.6511 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001626/0.5794, allocations: 67.98 kB / 0.827 GB, free: 15.16 MB / 0.6511 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00421/0.5836, allocations: 3.94 MB / 0.8308 GB, free: 11.11 MB / 0.6511 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.39e-06/0.5836, allocations: 11.94 kB / 0.8308 GB, free: 11.1 MB / 0.6511 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.008255/0.5918, allocations: 6.37 MB / 0.8371 GB, free: 4.535 MB / 0.6511 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001555/0.5934, allocations: 0.848 MB / 0.8379 GB, free: 3.684 MB / 0.6511 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003079/0.5937, allocations: 75.98 kB / 0.838 GB, free: 3.609 MB / 0.6511 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00122/0.5949, allocations: 207.8 kB / 0.8382 GB, free: 3.406 MB / 0.6511 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004828/0.5954, allocations: 225.4 kB / 0.8384 GB, free: 3.184 MB / 0.6511 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001417/0.5955, allocations: 95.97 kB / 0.8385 GB, free: 3.09 MB / 0.6511 GB Notification: Performance of sorting global known variables: time 0.002449/0.598, allocations: 2.213 MB / 0.8406 GB, free: 0.8945 MB / 0.6511 GB Notification: Performance of sort global known variables: time 1.71e-07/0.598, allocations: 0 / 0.8406 GB, free: 0.8945 MB / 0.6511 GB Notification: Performance of remove unused functions: time 0.003125/0.6011, allocations: 1.821 MB / 0.8424 GB, free: 15.07 MB / 0.6667 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 28 * Number of states: 25 (PV.wecc_regc.rateLimFirstOrderFreeze2.y,PV.wecc_regc.rateLimFirstOrderFreeze1.y,PV.wecc_regc.firstOrder.y,PV.wecc_regc.vSourceRef.firstOrder.y,PV.wecc_regc.vSourceRef.firstOrder1.y,PV.wecc_regc.pIAntiWindupVariableLimits.integrator.y,PV.wecc_regc.pIAntiWindupVariableLimits1.integrator.y,PV.pll.integrator.y,PV.pll.limIntegrator.y,PV.wecc_repc.firstOrder.y,PV.wecc_repc.limPID.I.y,PV.wecc_repc.firstOrder1.y,PV.wecc_repc.firstOrder2.y,PV.wecc_repc.firstOrder3.y,PV.wecc_repc.limPIDFreeze.I.y,PV.wecc_repc.leadLag.x_scaled[1],PV.wecc_reec.firstOrder.y,PV.wecc_reec.firstOrder1.y,PV.wecc_reec.limPIDFreeze.I.y,PV.wecc_reec.rateLimFirstOrderFreeze1.y,PV.wecc_reec.slewRateLimiter.y,PV.wecc_reec.rateLimFirstOrderFreeze.y,PV.wecc_reec.varLimPIDFreeze.I.y,PV.wecc_reec.firstOrder2.y,PV.wecc_reec.firstOrder3.y) * Number of discrete variables: 34 ($whenCondition17,$whenCondition15,$whenCondition16,$whenCondition14,$whenCondition12,$whenCondition13,$whenCondition11,$whenCondition9,$whenCondition10,$whenCondition4,$whenCondition5,$whenCondition3,$whenCondition1,$whenCondition2,line.running,line.state,PV.wecc_regc.offDelay.u,PV.wecc_regc.offDelay.delaySignal,PV.wecc_regc.offDelay.tNext,PV.wecc_regc.and1.u[2],PV.wecc_regc.and1.y,PV.wecc_regc.and2.y,PV.source.running,PV.source.state,PV.LvTfo.running,PV.LvTfo.state,PV.HvTfo.running,PV.HvTfo.state,PV.wecc_repc.freeze,$whenCondition8,$whenCondition6,$whenCondition7,PV.injector.running,PV.injector.state) * Number of discrete states: 6 (PV.injector.running,PV.HvTfo.running,PV.LvTfo.running,PV.source.running,line.running,PV.wecc_regc.offDelay.u) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (267): * Single equations (assignments): 254 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 12 * 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 {(12,8,44.4%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of Backend phase and start with SimCode phase: time 0.008037/0.6092, allocations: 7.095 MB / 0.8493 GB, free: 7.758 MB / 0.6667 GB Notification: Performance of simCode: created initialization part: time 0.01015/0.6193, allocations: 7.338 MB / 0.8565 GB, free: 364 kB / 0.6667 GB Notification: Performance of simCode: created event and clocks part: time 7.424e-06/0.6193, allocations: 0 / 0.8565 GB, free: 364 kB / 0.6667 GB Notification: Performance of simCode: created simulation system equations: time 0.2591/0.8784, allocations: 2.108 MB / 0.8586 GB, free: 176.9 MB / 0.6667 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002845/0.8813, allocations: 0.5808 MB / 0.8591 GB, free: 176.9 MB / 0.6667 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.05134/0.9326, allocations: 35.07 MB / 0.8934 GB, free: 161.9 MB / 0.6667 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001519/0.9341, allocations: 1.566 MB / 0.8949 GB, free: 161.2 MB / 0.6667 GB Notification: Performance of simCode: alias equations: time 0.002288/0.9364, allocations: 0.5651 MB / 0.8955 GB, free: 160.6 MB / 0.6667 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001534/0.9379, allocations: 1.678 MB / 0.8971 GB, free: 158.9 MB / 0.6667 GB Notification: Performance of SimCode: time 1.683e-06/0.9379, allocations: 3.938 kB / 0.8971 GB, free: 158.9 MB / 0.6667 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1543/1.092, allocations: 91.42 MB / 0.9864 GB, free: 67.88 MB / 0.6667 GB Notification: Performance of buildModelFMU: Generate platform static: time 10.19/11.28, allocations: 7.922 kB / 0.9864 GB, free: 67.88 MB / 0.6667 GB " [Timeout remaining time 649] (rm -f Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4.pipe ; mkfifo Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4.pipe ; head -c 1048576 < Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4.pipe >> ../files/Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4.sim & (cd run_OMSimulator && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --stripRoot --tempDir=temp_Dynawo_Dynawo_Examples_Photovoltaics_WECC_PVVoltageSource4_fmu --startTime=0 --stopTime=20 --stepSize=0.001 --timeout=50 --tolerance=1e-05 ../Dynawo_Dynawo_Examples_Photovoltaics_WECC_PVVoltageSource4.fmu) > Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4.pipe 2>&1) [Timeout 52.5] (rm -f Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4_fmpy.pipe ; mkfifo Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4_fmpy.pipe ; head -c 1048576 < Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4_fmpy.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4_fmpy.sim & (cd run_fmpy && python3 -m fmpy simulate --output-file ../Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4_fmpy_res.csv --start-time 0 --stop-time 20 --timeout 50 --relative-tolerance 1e-05 --interface-type ModelExchange --solver CVode --output-interval 0.001 ../Dynawo_Dynawo_Examples_Photovoltaics_WECC_PVVoltageSource4.fmu) > Dynawo_Dynawo.Examples.Photovoltaics.WECC.PVVoltageSource4_fmpy.pipe 2>&1) [Timeout 52.5] [Calling sys.exit(0), Time elapsed: 15.516222451813519]