Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.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.001299/0.001299, allocations: 100.4 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.001401/0.001401, allocations: 219.5 kB / 23.07 MB, free: 4.98 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.338/1.338, 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.54/2.54, allocations: 476 MB / 0.7708 GB, free: 4.652 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.BalancedStepUp.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.BalancedStepUp.YY") translateModel(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.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.BalancedStepUp.YY") [Timeout 300] "Notification: Performance of FrontEnd - Absyn->SCode: time 1.95e-05/1.95e-05, allocations: 6.109 kB / 1.118 GB, free: 41.14 MB / 0.9044 GB Notification: Performance of NFInst.instantiate(Buildings.Electrical.AC.ThreePhasesUnbalanced.Validation.IEEETests.Test4NodesFeeder.BalancedStepUp.YY): time 0.01783/0.01785, allocations: 19.26 MB / 1.137 GB, free: 33.18 MB / 0.9044 GB Notification: Performance of NFInst.instExpressions: time 0.01001/0.02785, allocations: 7.15 MB / 1.144 GB, free: 28.61 MB / 0.9044 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001663/0.02951, allocations: 68.44 kB / 1.144 GB, free: 28.59 MB / 0.9044 GB Notification: Performance of NFTyping.typeComponents: time 0.004295/0.03381, allocations: 1.89 MB / 1.146 GB, free: 27.58 MB / 0.9044 GB Notification: Performance of NFTyping.typeBindings: time 0.003423/0.03723, allocations: 1.555 MB / 1.147 GB, free: 26.71 MB / 0.9044 GB Notification: Performance of NFTyping.typeClassSections: time 0.002813/0.04004, allocations: 1.311 MB / 1.149 GB, free: 26.01 MB / 0.9044 GB Notification: Performance of NFFlatten.flatten: time 0.005307/0.04535, allocations: 5.13 MB / 1.154 GB, free: 23.92 MB / 0.9044 GB Notification: Performance of NFFlatten.resolveConnections: time 0.004104/0.04946, allocations: 2.46 MB / 1.156 GB, free: 22.55 MB / 0.9044 GB Notification: Performance of NFEvalConstants.evaluate: time 0.003422/0.05288, allocations: 2.01 MB / 1.158 GB, free: 21.71 MB / 0.9044 GB Notification: Performance of NFSimplifyModel.simplify: time 0.003685/0.05656, allocations: 1.882 MB / 1.16 GB, free: 21 MB / 0.9044 GB Notification: Performance of NFPackage.collectConstants: time 0.001114/0.05768, allocations: 311.9 kB / 1.16 GB, free: 21 MB / 0.9044 GB Notification: Performance of NFFlatten.collectFunctions: time 0.002937/0.06061, allocations: 0.8932 MB / 1.161 GB, free: 20.77 MB / 0.9044 GB Notification: Performance of combineBinaries: time 0.005074/0.06569, allocations: 4.748 MB / 1.166 GB, free: 17.89 MB / 0.9044 GB Notification: Performance of replaceArrayConstructors: time 0.002286/0.06798, allocations: 2.659 MB / 1.168 GB, free: 16.23 MB / 0.9044 GB Notification: Performance of NFVerifyModel.verify: time 0.0006478/0.06862, allocations: 151.3 kB / 1.168 GB, free: 16.22 MB / 0.9044 GB Notification: Performance of FrontEnd: time 0.000328/0.06895, allocations: 35 kB / 1.168 GB, free: 16.22 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: 1083 (512) * Number of variables: 1083 (366) Notification: Performance of [SIM] Bindings: time 0.01294/0.0819, allocations: 12.7 MB / 1.181 GB, free: 8.551 MB / 0.9044 GB Notification: Performance of [SIM] FunctionAlias: time 0.002633/0.08453, allocations: 1.883 MB / 1.183 GB, free: 7.426 MB / 0.9044 GB Notification: Performance of [SIM] Early Inline: time 0.02472/0.1093, allocations: 19.61 MB / 1.202 GB, free: 13.99 MB / 0.92 GB Notification: Performance of [SIM] Simplify 1: time 0.007786/0.117, allocations: 3.795 MB / 1.205 GB, free: 12.33 MB / 0.92 GB Notification: Performance of [SIM] Alias: time 0.02165/0.1387, allocations: 11.68 MB / 1.217 GB, free: 5.895 MB / 0.92 GB Notification: Performance of [SIM] Simplify 2: time 0.006079/0.1448, allocations: 3.581 MB / 1.22 GB, free: 4.379 MB / 0.92 GB Notification: Performance of [SIM] Remove Stream: time 0.002096/0.1469, allocations: 1.058 MB / 1.221 GB, free: 3.609 MB / 0.92 GB Notification: Performance of [SIM] Detect States: time 0.00329/0.1502, allocations: 2.714 MB / 1.224 GB, free: 1.281 MB / 0.92 GB Notification: Performance of [SIM] Events: time 0.002213/0.1524, allocations: 1.413 MB / 1.225 GB, free: 368 kB / 0.92 GB Notification: Performance of [SIM] Partitioning: time 0.00667/0.159, allocations: 5.191 MB / 1.23 GB, free: 13.12 MB / 0.9356 GB Notification: Performance of [SIM] Causalize: time 0.02596/0.185, allocations: 16.36 MB / 1.246 GB, free: 1.559 MB / 0.9356 GB Notification: Performance of [SIM] After Index Reduction Inline: time 0.01572/0.2007, allocations: 13.35 MB / 1.259 GB, free: 4.195 MB / 0.9512 GB Notification: Performance of [INI] Simplify: time 0.01013/0.2108, allocations: 5.782 MB / 1.265 GB, free: 14.36 MB / 0.9669 GB Notification: Performance of [INI] Inline: time 0.02421/0.2351, allocations: 22.33 MB / 1.287 GB, free: 7.969 MB / 0.9825 GB Notification: Performance of [INI] Partitioning: time 0.0006998/0.2358, allocations: 159.1 kB / 1.287 GB, free: 7.777 MB / 0.9825 GB Notification: Performance of [INI] Cleanup: time 0.005927/0.2417, allocations: 3.868 MB / 1.291 GB, free: 3.875 MB / 0.9825 GB Notification: Performance of [INI] Causalize: time 0.05142/0.2931, allocations: 30.65 MB / 1.321 GB, free: 4.812 MB / 1.014 GB Notification: Performance of [INI] Tearing: time 0.00246/0.2956, allocations: 1.921 MB / 1.323 GB, free: 2.938 MB / 1.014 GB Notification: Performance of [SIM] Initialization: time 1.413e-06/0.2956, allocations: 0 / 1.323 GB, free: 2.938 MB / 1.014 GB Notification: Performance of [SIM] DAE-Mode: time 0.007382/0.3029, allocations: 5.087 MB / 1.328 GB, free: 13.84 MB / 1.029 GB Notification: Performance of [SIM] Remove Dummies: time 2.576e-05/0.303, allocations: 3 kB / 1.328 GB, free: 13.83 MB / 1.029 GB Notification: Performance of [SIM] Tearing: time 0.002002/0.305, allocations: 1.705 MB / 1.329 GB, free: 12.16 MB / 1.029 GB Notification: Performance of [SIM] Categorize: time 7.097e-05/0.305, allocations: 15.94 kB / 1.329 GB, free: 12.14 MB / 1.029 GB Notification: Performance of [SIM] Solve: time 0.03839/0.3434, allocations: 25.71 MB / 1.354 GB, free: 2.75 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.098732619953807] Failed to read output from testmodel.py, exit status != 0: 0.8312861259910278 0.37338749 0.30143814900000004 Calling exit ...