Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.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.001428/0.001428, allocations: 104.3 kB / 19.76 MB, free: 1.906 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.001541/0.001541, allocations: 214.7 kB / 23.06 MB, free: 4.984 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.295/1.295, allocations: 230.6 MB / 256.9 MB, free: 7.77 MB / 206.1 MB " [Timeout remaining time 179] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.787/2.787, allocations: 0.4893 GB / 0.7952 GB, free: 35.56 MB / 0.6231 GB " [Timeout remaining time 177] Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.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.BalancedStepDown.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_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YY") translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.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_12_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YY") [Timeout 300] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.135e-05/1.135e-05, allocations: 6.438 kB / 1.155 GB, free: 25.5 MB / 0.9044 GB Notification: Performance of NFInst.instantiate(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepDown.YY): time 0.01818/0.01819, allocations: 19.25 MB / 1.173 GB, free: 13.68 MB / 0.9044 GB Notification: Performance of NFInst.instExpressions: time 0.009733/0.02792, allocations: 7.15 MB / 1.18 GB, free: 9.09 MB / 0.9044 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001125/0.02905, allocations: 67.25 kB / 1.18 GB, free: 9.074 MB / 0.9044 GB Notification: Performance of NFTyping.typeComponents: time 0.003866/0.03291, allocations: 1.909 MB / 1.182 GB, free: 8.027 MB / 0.9044 GB Notification: Performance of NFTyping.typeBindings: time 0.003659/0.03657, allocations: 1.542 MB / 1.184 GB, free: 7.164 MB / 0.9044 GB Notification: Performance of NFTyping.typeClassSections: time 0.002867/0.03944, allocations: 1.311 MB / 1.185 GB, free: 6.457 MB / 0.9044 GB Notification: Performance of NFFlatten.flatten: time 0.005514/0.04495, allocations: 5.131 MB / 1.19 GB, free: 4.293 MB / 0.9044 GB Notification: Performance of NFFlatten.resolveConnections: time 0.00327/0.04822, allocations: 2.452 MB / 1.192 GB, free: 2.922 MB / 0.9044 GB Notification: Performance of NFEvalConstants.evaluate: time 0.003017/0.05124, allocations: 2.003 MB / 1.194 GB, free: 2.09 MB / 0.9044 GB Notification: Performance of NFSimplifyModel.simplify: time 0.002426/0.05366, allocations: 1.889 MB / 1.196 GB, free: 1.367 MB / 0.9044 GB Notification: Performance of NFPackage.collectConstants: time 0.0004148/0.05408, allocations: 311.7 kB / 1.197 GB, free: 1.367 MB / 0.9044 GB Notification: Performance of NFFlatten.collectFunctions: time 0.001734/0.05581, allocations: 0.8887 MB / 1.197 GB, free: 1.145 MB / 0.9044 GB Notification: Performance of combineBinaries: time 0.004194/0.06001, allocations: 4.753 MB / 1.202 GB, free: 14.26 MB / 0.92 GB Notification: Performance of replaceArrayConstructors: time 0.002545/0.06255, allocations: 2.66 MB / 1.205 GB, free: 12.59 MB / 0.92 GB Notification: Performance of NFVerifyModel.verify: time 0.0004695/0.06302, allocations: 145.8 kB / 1.205 GB, free: 12.59 MB / 0.92 GB Notification: Performance of FrontEnd: time 0.000265/0.06329, allocations: 35.72 kB / 1.205 GB, free: 12.59 MB / 0.92 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1083 (512) * Number of variables: 1083 (366) Notification: Performance of [SIM] Bindings: time 0.01324/0.07653, allocations: 12.7 MB / 1.217 GB, free: 4.906 MB / 0.92 GB Notification: Performance of [SIM] FunctionAlias: time 0.002147/0.07867, allocations: 1.878 MB / 1.219 GB, free: 3.777 MB / 0.92 GB Notification: Performance of [SIM] Early Inline: time 0.0222/0.1009, allocations: 19.62 MB / 1.238 GB, free: 8.441 MB / 0.9356 GB Notification: Performance of [SIM] Simplify 1: time 0.005334/0.1062, allocations: 3.782 MB / 1.242 GB, free: 6.316 MB / 0.9356 GB Notification: Performance of [SIM] Alias: time 0.01473/0.1209, allocations: 11.67 MB / 1.253 GB, free: 12.29 MB / 0.9512 GB Notification: Performance of [SIM] Simplify 2: time 0.00494/0.1259, allocations: 3.597 MB / 1.257 GB, free: 8.926 MB / 0.9512 GB Notification: Performance of [SIM] Remove Stream: time 0.00135/0.1272, allocations: 1.055 MB / 1.258 GB, free: 7.816 MB / 0.9512 GB Notification: Performance of [SIM] Detect States: time 0.002682/0.1299, allocations: 2.703 MB / 1.26 GB, free: 5.02 MB / 0.9512 GB Notification: Performance of [SIM] Events: time 0.001696/0.1316, allocations: 1.402 MB / 1.262 GB, free: 3.699 MB / 0.9512 GB Notification: Performance of [SIM] Partitioning: time 0.005405/0.137, allocations: 5.198 MB / 1.267 GB, free: 14.41 MB / 0.9669 GB Notification: Performance of [SIM] Causalize: time 0.02293/0.1599, allocations: 16.36 MB / 1.283 GB, free: 13.78 MB / 0.9825 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.01316/0.1731, allocations: 13.35 MB / 1.296 GB, free: 428 kB / 0.9825 GB Notification: Performance of [INI] Simplify: time 0.00931/0.1824, allocations: 5.79 MB / 1.302 GB, free: 10.6 MB / 0.9981 GB Notification: Performance of [INI] Inline: time 0.02361/0.206, allocations: 22.34 MB / 1.323 GB, free: 4.215 MB / 1.014 GB Notification: Performance of [INI] Partitioning: time 0.0005413/0.2066, allocations: 159.1 kB / 1.324 GB, free: 4.016 MB / 1.014 GB Notification: Performance of [INI] Cleanup: time 0.004545/0.2111, allocations: 3.868 MB / 1.327 GB, free: 124 kB / 1.014 GB Notification: Performance of [INI] Causalize: time 0.04337/0.2545, allocations: 30.66 MB / 1.357 GB, free: 1.047 MB / 1.045 GB Notification: Performance of [INI] Tearing: time 0.00228/0.2568, allocations: 1.906 MB / 1.359 GB, free: 15.18 MB / 1.061 GB Notification: Performance of [SIM] Initialization: time 1.302e-06/0.2568, allocations: 0 / 1.359 GB, free: 15.18 MB / 1.061 GB Notification: Performance of [SIM] DAE-Mode: time 0.007163/0.2639, allocations: 5.086 MB / 1.364 GB, free: 10.09 MB / 1.061 GB Notification: Performance of [SIM] Remove Dummies: time 1.692e-05/0.2639, allocations: 7 kB / 1.364 GB, free: 10.08 MB / 1.061 GB Notification: Performance of [SIM] Tearing: time 0.00179/0.2657, allocations: 1.702 MB / 1.366 GB, free: 8.406 MB / 1.061 GB Notification: Performance of [SIM] Categorize: time 4.168e-05/0.2658, allocations: 15.98 kB / 1.366 GB, free: 8.391 MB / 1.061 GB Notification: Performance of [SIM] Solve: time 0.03218/0.298, allocations: 25.71 MB / 1.391 GB, free: 14.99 MB / 1.092 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 300] [Calling sys.exit(0), Time elapsed: 5.85810524597764] Failed to read output from testmodel.py, exit status != 0: 0.31160271901171654 0.32525314800000005 0.25907878500000003 Calling exit ...