Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY.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.001528/0.001528, allocations: 104.3 kB / 19.77 MB, free: 2.051 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.001688/0.001688, allocations: 216.2 kB / 23.07 MB, free: 4.844 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.357/1.357, allocations: 230.7 MB / 256.9 MB, free: 7.773 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo): time 2.575/2.575, allocations: 476 MB / 0.7708 GB, free: 4.664 MB / 0.6231 GB " [Timeout remaining time 177] Using package Buildings with version 11.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo) Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|err_V2.1.|err_V2.2.|err_V2.3.|err_V3.1.|err_V3.2.|err_V3.3.|err_V4.1.|err_V4.2.|err_V4.3.|err_Theta2.1.|err_Theta2.2.|err_Theta2.3.|err_Theta3.1.|err_Theta3.2.|err_Theta3.3.|err_Theta4.1.|err_Theta4.2.|err_Theta4.3.",fileNamePrefix="Buildings_11_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY") translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|err_V2.1.|err_V2.2.|err_V2.3.|err_V3.1.|err_V3.2.|err_V3.3.|err_V4.1.|err_V4.2.|err_V4.3.|err_Theta2.1.|err_Theta2.2.|err_Theta2.3.|err_Theta3.1.|err_Theta3.2.|err_Theta3.3.|err_Theta4.1.|err_Theta4.2.|err_Theta4.3.",fileNamePrefix="Buildings_11_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY") [Timeout 300] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.789e-05/1.789e-05, allocations: 4.656 kB / 1.118 GB, free: 41.07 MB / 0.9044 GB Notification: Performance of NFInst.instantiate(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.UnbalancedStepUp.YY): time 0.01926/0.01928, allocations: 19.33 MB / 1.137 GB, free: 33.22 MB / 0.9044 GB Notification: Performance of NFInst.instExpressions: time 0.0103/0.02958, allocations: 7.086 MB / 1.144 GB, free: 28.68 MB / 0.9044 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001719/0.0313, allocations: 66.88 kB / 1.144 GB, free: 28.67 MB / 0.9044 GB Notification: Performance of NFTyping.typeComponents: time 0.004369/0.03567, allocations: 1.905 MB / 1.146 GB, free: 27.64 MB / 0.9044 GB Notification: Performance of NFTyping.typeBindings: time 0.003809/0.03948, allocations: 1.54 MB / 1.147 GB, free: 26.78 MB / 0.9044 GB Notification: Performance of NFTyping.typeClassSections: time 0.003083/0.04256, allocations: 1.313 MB / 1.149 GB, free: 26.08 MB / 0.9044 GB Notification: Performance of NFFlatten.flatten: time 0.006179/0.04874, allocations: 5.165 MB / 1.154 GB, free: 23.97 MB / 0.9044 GB Notification: Performance of NFFlatten.resolveConnections: time 0.004968/0.05371, allocations: 2.511 MB / 1.156 GB, free: 22.56 MB / 0.9044 GB Notification: Performance of NFEvalConstants.evaluate: time 0.003842/0.05755, allocations: 2.02 MB / 1.158 GB, free: 21.71 MB / 0.9044 GB Notification: Performance of NFSimplifyModel.simplify: time 0.004087/0.06164, allocations: 1.892 MB / 1.16 GB, free: 21 MB / 0.9044 GB Notification: Performance of NFPackage.collectConstants: time 0.001235/0.06287, allocations: 314.2 kB / 1.16 GB, free: 21 MB / 0.9044 GB Notification: Performance of NFFlatten.collectFunctions: time 0.003056/0.06593, allocations: 0.8698 MB / 1.161 GB, free: 20.79 MB / 0.9044 GB Notification: Performance of combineBinaries: time 0.006666/0.07259, allocations: 4.824 MB / 1.166 GB, free: 17.85 MB / 0.9044 GB Notification: Performance of replaceArrayConstructors: time 0.002982/0.07558, allocations: 2.709 MB / 1.168 GB, free: 16.15 MB / 0.9044 GB Notification: Performance of NFVerifyModel.verify: time 0.001455/0.07703, allocations: 149.5 kB / 1.168 GB, free: 16.15 MB / 0.9044 GB Notification: Performance of FrontEnd: time 0.0004467/0.07748, allocations: 41.59 kB / 1.169 GB, free: 16.14 MB / 0.9044 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1094 (523) * Number of variables: 1094 (377) Notification: Performance of [SIM] Bindings: time 0.01633/0.09381, allocations: 12.9 MB / 1.181 GB, free: 8.293 MB / 0.9044 GB Notification: Performance of [SIM] FunctionAlias: time 0.002471/0.09628, allocations: 1.862 MB / 1.183 GB, free: 7.211 MB / 0.9044 GB Notification: Performance of [SIM] Early Inline: time 0.02626/0.1225, allocations: 19.71 MB / 1.202 GB, free: 13.72 MB / 0.92 GB Notification: Performance of [SIM] Simplify 1: time 0.008234/0.1308, allocations: 3.796 MB / 1.206 GB, free: 12.06 MB / 0.92 GB Notification: Performance of [SIM] Alias: time 0.02114/0.1519, allocations: 11.87 MB / 1.217 GB, free: 5.551 MB / 0.92 GB Notification: Performance of [SIM] Simplify 2: time 0.0061/0.158, allocations: 3.593 MB / 1.221 GB, free: 4.027 MB / 0.92 GB Notification: Performance of [SIM] Remove Stream: time 0.002175/0.1602, allocations: 1.052 MB / 1.222 GB, free: 3.188 MB / 0.92 GB Notification: Performance of [SIM] Detect States: time 0.003662/0.1639, allocations: 2.744 MB / 1.225 GB, free: 0.8359 MB / 0.92 GB Notification: Performance of [SIM] Events: time 0.002204/0.1661, allocations: 1.37 MB / 1.226 GB, free: 15.94 MB / 0.9356 GB Notification: Performance of [SIM] Partitioning: time 0.00842/0.1745, allocations: 5.19 MB / 1.231 GB, free: 12.7 MB / 0.9356 GB Notification: Performance of [SIM] Causalize: time 0.02888/0.2034, allocations: 16.36 MB / 1.247 GB, free: 0.8945 MB / 0.9356 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.01924/0.2226, allocations: 13.34 MB / 1.26 GB, free: 3.539 MB / 0.9512 GB Notification: Performance of [INI] Simplify: time 0.01277/0.2354, allocations: 5.871 MB / 1.266 GB, free: 13.6 MB / 0.9669 GB Notification: Performance of [INI] Inline: time 0.03264/0.268, allocations: 22.36 MB / 1.288 GB, free: 7.18 MB / 0.9825 GB Notification: Performance of [INI] Partitioning: time 0.0008206/0.2688, allocations: 155.5 kB / 1.288 GB, free: 6.992 MB / 0.9825 GB Notification: Performance of [INI] Cleanup: time 0.008274/0.2771, allocations: 3.88 MB / 1.292 GB, free: 3.078 MB / 0.9825 GB Notification: Performance of [INI] Causalize: time 0.05401/0.3311, allocations: 30.72 MB / 1.322 GB, free: 3.949 MB / 1.014 GB Notification: Performance of [INI] Tearing: time 0.00245/0.3336, allocations: 1.928 MB / 1.324 GB, free: 2.066 MB / 1.014 GB Notification: Performance of [SIM] Initialization: time 1.533e-06/0.3336, allocations: 3.938 kB / 1.324 GB, free: 2.062 MB / 1.014 GB Notification: Performance of [SIM] DAE-Mode: time 0.007479/0.341, allocations: 5.078 MB / 1.328 GB, free: 12.98 MB / 1.029 GB Notification: Performance of [SIM] Remove Dummies: time 2.467e-05/0.3411, allocations: 11 kB / 1.328 GB, free: 12.97 MB / 1.029 GB Notification: Performance of [SIM] Tearing: time 0.001986/0.3431, allocations: 1.704 MB / 1.33 GB, free: 11.29 MB / 1.029 GB Notification: Performance of [SIM] Categorize: time 6.632e-05/0.3431, allocations: 19.94 kB / 1.33 GB, free: 11.27 MB / 1.029 GB Notification: Performance of [SIM] Solve: time 0.03794/0.3811, allocations: 25.84 MB / 1.355 GB, free: 1.738 MB / 1.045 GB Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref node4.term.phase[1].i[1] is neither a seed nor a partial candidate! " [Timeout remaining time 299] [Calling sys.exit(0), Time elapsed: 6.187527510977816] Failed to read output from testmodel.py, exit status != 0: 0.8528302399790846 0.41018044600000003 0.329558381 Calling exit ...