Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerSystems_latest_PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat.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.001514/0.001514, allocations: 113 kB / 18.49 MB, free: 4.539 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.001682/0.001682, allocations: 217.4 kB / 21.46 MB, free: 1.586 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.544/1.544, allocations: 230.6 MB / 254.8 MB, free: 15.07 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems master/package.mo): time 0.2051/0.2051, allocations: 38.51 MB / 349.4 MB, free: 2.578 MB / 270.1 MB
"
[Timeout remaining time 180]
Using package PowerSystems with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems master/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(PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat,fileNamePrefix="PowerSystems_latest_PowerSystems_Examples_AC3ph_Precalculation_EqCircFromTransDat",fmuType="cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat,fileNamePrefix="PowerSystems_latest_PowerSystems_Examples_AC3ph_Precalculation_EqCircFromTransDat",fmuType="cs",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: PowerSystems 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.002031/0.002031, allocations: 63.91 kB / 487.9 MB, free: 22.16 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1296/0.1316, allocations: 62.42 MB / 0.5374 GB, free: 7.625 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat): time 0.003542/0.1352, allocations: 2.169 MB / 0.5395 GB, free: 5.438 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.003361/0.1385, allocations: 2.101 MB / 0.5415 GB, free: 3.324 MB / 398.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 6.431e-05/0.1386, allocations: 3.938 kB / 0.5416 GB, free: 3.32 MB / 398.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.000135/0.1387, allocations: 11.91 kB / 0.5416 GB, free: 3.309 MB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0001123/0.1388, allocations: 39.81 kB / 0.5416 GB, free: 3.27 MB / 398.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002291/0.1411, allocations: 0.8227 MB / 0.5424 GB, free: 2.445 MB / 398.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0001776/0.1413, allocations: 95.61 kB / 0.5425 GB, free: 2.352 MB / 398.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 5.028e-05/0.1414, allocations: 7.984 kB / 0.5425 GB, free: 2.344 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0001683/0.1415, allocations: 47.83 kB / 0.5425 GB, free: 2.297 MB / 398.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.000102/0.1416, allocations: 63.69 kB / 0.5426 GB, free: 2.234 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 1.502e-05/0.1416, allocations: 4 kB / 0.5426 GB, free: 2.23 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002414/0.1441, allocations: 1.587 MB / 0.5442 GB, free: 0.6406 MB / 398.1 MB
Notification: Performance of NFScalarize.scalarize: time 7.041e-05/0.1441, allocations: 31.89 kB / 0.5442 GB, free: 0.6094 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 7.167e-05/0.1442, allocations: 35.75 kB / 0.5442 GB, free: 0.5742 MB / 398.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.00184/0.146, allocations: 1.34 MB / 0.5455 GB, free: 15.23 MB / 414.1 MB
Notification: Performance of FrontEnd - DAE generated: time 3.897e-06/0.146, allocations: 0 / 0.5455 GB, free: 15.23 MB / 414.1 MB
Notification: Performance of FrontEnd: time 1.162e-06/0.146, allocations: 4 kB / 0.5455 GB, free: 15.23 MB / 414.1 MB
Notification: Performance of Transformations before backend: time 5.34e-06/0.1461, allocations: 0 / 0.5455 GB, free: 15.23 MB / 414.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 14
 * Number of variables: 14
Notification: Performance of Generate backend data structure: time 0.0008008/0.1469, allocations: 0.55 MB / 0.5461 GB, free: 14.62 MB / 414.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.528e-05/0.1469, allocations: 12.03 kB / 0.5461 GB, free: 14.61 MB / 414.1 MB
Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 5.434e-05/0.147, allocations: 16.17 kB / 0.5461 GB, free: 14.59 MB / 414.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 8.461e-05/0.147, allocations: 74.56 kB / 0.5462 GB, free: 14.51 MB / 414.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 5.55e-05/0.1471, allocations: 20.8 kB / 0.5462 GB, free: 14.49 MB / 414.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0002581/0.1474, allocations: 219.8 kB / 0.5464 GB, free: 14.24 MB / 414.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 1.031e-05/0.1474, allocations: 8 kB / 0.5464 GB, free: 14.23 MB / 414.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 4.715e-05/0.1474, allocations: 19.95 kB / 0.5464 GB, free: 14.21 MB / 414.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0003371/0.1477, allocations: 181.3 kB / 0.5466 GB, free: 14.03 MB / 414.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.622e-05/0.1478, allocations: 15.92 kB / 0.5466 GB, free: 14.01 MB / 414.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 1.932e-05/0.1478, allocations: 4 kB / 0.5466 GB, free: 14.01 MB / 414.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.344e-06/0.1478, allocations: 4 kB / 0.5466 GB, free: 14 MB / 414.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.000196/0.148, allocations: 108.4 kB / 0.5467 GB, free: 13.9 MB / 414.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.0004706/0.1485, allocations: 368.5 kB / 0.5471 GB, free: 13.49 MB / 414.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0003771/0.1488, allocations: 227.1 kB / 0.5473 GB, free: 13.26 MB / 414.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0002173/0.1491, allocations: 159.3 kB / 0.5475 GB, free: 13.1 MB / 414.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 1.271e-05/0.1491, allocations: 4 kB / 0.5475 GB, free: 13.1 MB / 414.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.131e-05/0.1491, allocations: 38.55 kB / 0.5475 GB, free: 13.05 MB / 414.1 MB
Notification: Performance of pre-optimization done (n=42): time 1.272e-06/0.1491, allocations: 0 / 0.5475 GB, free: 13.05 MB / 414.1 MB
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/Differentiate.mo:268:5-268:157:writable] Error: Derivative of expression \"algorithm
  (r_rd, xsig_rd, xm_d) := PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat.equiCircuit(2, {omega_nom * tc_d[1], omega_nom * tc_d[2]}, PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat.T_open(x_d, xtr_d, {omega_nom * tc_d[1], omega_nom * tc_d[2]}), x_d, xsig_s, r_s, if0, alpha_if0 + 3.141592653589793, tol, true);
  (r_rq, xsig_rq, xm_q) := PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat.equiCircuit(2, {omega_nom * tc_q[1], omega_nom * tc_q[2]}, PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat.T_open(x_q, xtr_q, {omega_nom * tc_q[1], omega_nom * tc_q[2]}), x_q, xsig_s, r_s, 0.0, 0.0, 0.0, false);
\" w.r.t. \"time\" is non-existent.
Error: Internal error 
Differentiate.differentiateEquationTime failed for algorithm
  (r_rd, xsig_rd, xm_d) := PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat.equiCircuit(2, {omega_nom * tc_d[1], omega_nom * tc_d[2]}, PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat.T_open(x_d, xtr_d, {omega_nom * tc_d[1], omega_nom * tc_d[2]}), x_d, xsig_s, r_s, if0, alpha_if0 + 3.141592653589793, tol, true);
  (r_rq, xsig_rq, xm_q) := PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat.equiCircuit(2, {omega_nom * tc_q[1], omega_nom * tc_q[2]}, PowerSystems.Examples.AC3ph.Precalculation.EqCircFromTransDat.T_open(x_q, xtr_q, {omega_nom * tc_q[1], omega_nom * tc_q[2]}), x_q, xsig_s, r_s, 0.0, 0.0, 0.0, false);
Error: Internal error - IndexReduction.pantelidesIndexReduction failed!
Error: Internal error Transformation Module PFPlusExt index Reduction Method Pantelides failed!
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 3.0083052120171487]
Failed to read output from testmodel.py, exit status != 0:
0.15643717400962487 0.17081173900000002 0.021846764
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f0c0c13f3a0>