Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false)
Using package ModelicaTest with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Running command: translateModel(ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|junction1.mC_scaled.1.|junction1.medium.T|junction1.medium.Xi.1.|junction1.medium.p",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances")
translateModel(ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|junction1.mC_scaled.1.|junction1.medium.T|junction1.medium.Xi.1.|junction1.medium.p",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001734/0.001734, allocations: 207.3 kB / 17.99 MB, free: 3.777 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.503/1.503, allocations: 226.7 MB / 245.5 MB, free: 6.988 MB / 202.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001047/0.001047, allocations: 108.9 kB / 296.7 MB, free: 6.477 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.5206/0.5206, allocations: 44.83 MB / 392.7 MB, free: 34.73 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.001127/0.001127, allocations: 60.09 kB / 465.5 MB, free: 12.11 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4241/0.4253, allocations: 62.01 MB / 0.5152 GB, free: 37.86 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances): time 0.797/1.222, allocations: 317 MB / 0.8247 GB, free: 9.711 MB / 0.5261 GB
Notification: Performance of NFInst.instExpressions: time 0.03644/1.259, allocations: 24.21 MB / 0.8483 GB, free: 1.688 MB / 0.5417 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004369/1.263, allocations: 79.38 kB / 0.8484 GB, free: 1.609 MB / 0.5417 GB
Notification: Performance of NFTyping.typeComponents: time 0.004233/1.268, allocations: 0.9639 MB / 0.8493 GB, free: 0.6406 MB / 0.5417 GB
Notification: Performance of NFTyping.typeBindings: time 0.02312/1.291, allocations: 6.312 MB / 0.8555 GB, free: 10.3 MB / 0.5573 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02214/1.313, allocations: 7.197 MB / 0.8625 GB, free: 3.113 MB / 0.5573 GB
Notification: Performance of NFFlatten.flatten: time 0.01113/1.324, allocations: 9.125 MB / 0.8714 GB, free: 9.969 MB / 0.573 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003643/1.328, allocations: 1.72 MB / 0.8731 GB, free: 8.219 MB / 0.573 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00978/1.338, allocations: 3.601 MB / 0.8766 GB, free: 4.605 MB / 0.573 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.006445/1.344, allocations: 2.87 MB / 0.8794 GB, free: 1.727 MB / 0.573 GB
Notification: Performance of NFPackage.collectConstants: time 0.0008734/1.345, allocations: 155.9 kB / 0.8796 GB, free: 1.574 MB / 0.573 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.03439/1.379, allocations: 17.2 MB / 0.8964 GB, free: 356 kB / 0.5886 GB
Notification: Performance of NFScalarize.scalarize: time 0.002774/1.382, allocations: 1.087 MB / 0.8974 GB, free: 15.26 MB / 0.6042 GB
Notification: Performance of NFVerifyModel.verify: time 0.004412/1.387, allocations: 1.365 MB / 0.8988 GB, free: 13.89 MB / 0.6042 GB
Notification: Performance of NFConvertDAE.convert: time 0.04199/1.429, allocations: 12.08 MB / 0.9106 GB, free: 1.777 MB / 0.6042 GB
Notification: Performance of FrontEnd - DAE generated: time 7.825e-06/1.429, allocations: 0 / 0.9106 GB, free: 1.777 MB / 0.6042 GB
Notification: Performance of FrontEnd: time 5.4e-06/1.429, allocations: 0 / 0.9106 GB, free: 1.777 MB / 0.6042 GB
Notification: Performance of Transformations before backend: time 0.0001732/1.429, allocations: 3.938 kB / 0.9106 GB, free: 1.773 MB / 0.6042 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 498
 * Number of variables: 498
Notification: Performance of Generate backend data structure: time 0.3571/1.786, allocations: 4.697 MB / 0.9152 GB, free: 257.3 MB / 0.6042 GB
Notification: Performance of prepare preOptimizeDAE: time 5.158e-05/1.786, allocations: 9.656 kB / 0.9152 GB, free: 257.3 MB / 0.6042 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001448/1.787, allocations: 288.7 kB / 0.9155 GB, free: 257.2 MB / 0.6042 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002888/1.79, allocations: 1.44 MB / 0.9169 GB, free: 256.4 MB / 0.6042 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001256/1.79, allocations: 151.5 kB / 0.917 GB, free: 256.3 MB / 0.6042 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000318/1.791, allocations: 190 kB / 0.9172 GB, free: 256.3 MB / 0.6042 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005341/1.796, allocations: 3.136 MB / 0.9202 GB, free: 255.1 MB / 0.6042 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.892e-05/1.796, allocations: 2.438 kB / 0.9202 GB, free: 255.1 MB / 0.6042 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002399/1.796, allocations: 89.69 kB / 0.9203 GB, free: 255.1 MB / 0.6042 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003264/1.797, allocations: 189.7 kB / 0.9205 GB, free: 255.1 MB / 0.6042 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006282/1.803, allocations: 3.514 MB / 0.9239 GB, free: 253.9 MB / 0.6042 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.02397/1.827, allocations: 12.83 MB / 0.9365 GB, free: 245.7 MB / 0.6042 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003838/1.831, allocations: 1.709 MB / 0.9381 GB, free: 245.1 MB / 0.6042 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002107/1.833, allocations: 1.13 MB / 0.9392 GB, free: 244.7 MB / 0.6042 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001393/1.835, allocations: 1.671 MB / 0.9409 GB, free: 242.8 MB / 0.6042 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.406e-05/1.835, allocations: 58 kB / 0.9409 GB, free: 242.8 MB / 0.6042 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002521/1.837, allocations: 351.2 kB / 0.9413 GB, free: 242.6 MB / 0.6042 GB
Notification: Performance of pre-optimization done (n=153): time 1.561e-05/1.837, allocations: 0 / 0.9413 GB, free: 242.6 MB / 0.6042 GB
Notification: Performance of matching and sorting (n=165): time 0.03194/1.869, allocations: 8.867 MB / 0.9499 GB, free: 239.5 MB / 0.6042 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001237/1.869, allocations: 202.1 kB / 0.9501 GB, free: 239.3 MB / 0.6042 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004417/1.874, allocations: 2.064 MB / 0.9521 GB, free: 238.4 MB / 0.6042 GB
Notification: Performance of collectPreVariables (initialization): time 0.0005264/1.874, allocations: 61.11 kB / 0.9522 GB, free: 238.3 MB / 0.6042 GB
Notification: Performance of collectInitialEqns (initialization): time 0.000789/1.875, allocations: 0.9879 MB / 0.9532 GB, free: 237.4 MB / 0.6042 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0008236/1.876, allocations: 0.5781 MB / 0.9537 GB, free: 236.9 MB / 0.6042 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001608/1.878, allocations: 0.4891 MB / 0.9542 GB, free: 236.7 MB / 0.6042 GB
Notification: Performance of setup shared object (initialization): time 5.486e-05/1.878, allocations: 305.1 kB / 0.9545 GB, free: 236.4 MB / 0.6042 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003004/1.881, allocations: 1.355 MB / 0.9558 GB, free: 235.6 MB / 0.6042 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003136/1.884, allocations: 1.728 MB / 0.9575 GB, free: 234.5 MB / 0.6042 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005514/1.889, allocations: 3.007 MB / 0.9604 GB, free: 232.7 MB / 0.6042 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.838e-05/1.889, allocations: 0 / 0.9604 GB, free: 232.7 MB / 0.6042 GB
Notification: Performance of matching and sorting (n=280) (initialization): time 0.008988/1.898, allocations: 3.969 MB / 0.9643 GB, free: 230.7 MB / 0.6042 GB
Notification: Performance of prepare postOptimizeDAE: time 6.896e-05/1.898, allocations: 67.3 kB / 0.9644 GB, free: 230.6 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.376e-05/1.899, allocations: 7.938 kB / 0.9644 GB, free: 230.6 MB / 0.6042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.006993/1.906, allocations: 1.29 MB / 0.9656 GB, free: 230.1 MB / 0.6042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00276/1.908, allocations: 0.4898 MB / 0.9661 GB, free: 230 MB / 0.6042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003128/1.911, allocations: 2.114 MB / 0.9682 GB, free: 228.4 MB / 0.6042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004092/1.916, allocations: 174.5 kB / 0.9684 GB, free: 228.3 MB / 0.6042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008738/1.916, allocations: 133.6 kB / 0.9685 GB, free: 228.2 MB / 0.6042 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.004035/1.921, allocations: 1.737 MB / 0.9702 GB, free: 227.3 MB / 0.6042 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003149/1.924, allocations: 1.692 MB / 0.9718 GB, free: 226.1 MB / 0.6042 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.004952/1.929, allocations: 2.916 MB / 0.9747 GB, free: 223.2 MB / 0.6042 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.999e-05/1.929, allocations: 4 kB / 0.9747 GB, free: 223.2 MB / 0.6042 GB
Notification: Performance of matching and sorting (n=280) (initialization_lambda0): time 0.009864/1.939, allocations: 4.064 MB / 0.9787 GB, free: 219.1 MB / 0.6042 GB
Notification: Performance of prepare postOptimizeDAE: time 8.161e-05/1.939, allocations: 71.39 kB / 0.9787 GB, free: 219 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.034e-05/1.939, allocations: 11.94 kB / 0.9787 GB, free: 219 MB / 0.6042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004688/1.943, allocations: 0.9309 MB / 0.9796 GB, free: 218.1 MB / 0.6042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00292/1.946, allocations: 0.4954 MB / 0.9801 GB, free: 217.6 MB / 0.6042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002538/1.949, allocations: 1.889 MB / 0.982 GB, free: 215.7 MB / 0.6042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003745/1.953, allocations: 179.8 kB / 0.9821 GB, free: 215.5 MB / 0.6042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000655/1.953, allocations: 135.9 kB / 0.9823 GB, free: 215.4 MB / 0.6042 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 38
 * Number of states: 0 ()
 * Number of discrete variables: 2 (traceSubstance2.ind,traceSubstance.ind)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (255):
 * Single equations (assignments): 251
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(2,6), (4,15)}
Notification: Performance of prepare postOptimizeDAE: time 0.001126/1.955, allocations: 308.3 kB / 0.9826 GB, free: 215.1 MB / 0.6042 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001098/1.956, allocations: 225.3 kB / 0.9828 GB, free: 214.8 MB / 0.6042 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007526/1.963, allocations: 4.169 MB / 0.9869 GB, free: 210.7 MB / 0.6042 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.185e-05/1.963, allocations: 16 kB / 0.9869 GB, free: 210.6 MB / 0.6042 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 9.738e-06/1.963, allocations: 0 / 0.9869 GB, free: 210.6 MB / 0.6042 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.732e-05/1.963, allocations: 7.969 kB / 0.9869 GB, free: 210.6 MB / 0.6042 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.009486/1.973, allocations: 5.588 MB / 0.9923 GB, free: 205 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.608e-06/1.973, allocations: 4 kB / 0.9923 GB, free: 205 MB / 0.6042 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001283/1.974, allocations: 295.6 kB / 0.9926 GB, free: 204.7 MB / 0.6042 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.005204/1.979, allocations: 1.14 MB / 0.9937 GB, free: 203.6 MB / 0.6042 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.000366/1.98, allocations: 63.95 kB / 0.9938 GB, free: 203.5 MB / 0.6042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002528/1.982, allocations: 2.03 MB / 0.9958 GB, free: 201.4 MB / 0.6042 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.42e-06/1.982, allocations: 7.938 kB / 0.9958 GB, free: 201.4 MB / 0.6042 GB
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork@2/OpenModelica/OMCompiler/Compiler/BackEnd/Differentiate.mo:267:5-267:157:writable] Error: Derivative of expression "pipe1.flowModel.states[2].T = Modelica.Math.Nonlinear.solveOneNonlinearEquation(function ModelicaTest.Fluid.TestComponents.Fittings.TestJunctionTraceSubstances.pipe1.Medium.T_phX.f_nonlinear(#(junction1.medium.p), #(junction.port_1.h_outflow), #({multiPort.ports_b_Xi_inStream[2,1]})), 190.0, 647.0, 1e-13)" w.r.t. "dummyVarA" is non-existent.
Error: Internal error SymbolicJacobian.deriveAll failed
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork@2/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2440:7-2440:87:writable] Error: Internal error function generateSymbolicJacobian failed
[/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork@2/OpenModelica/OMCompiler/Compiler/BackEnd/SymbolicJacobian.mo:2231:9-2231:79:writable] Error: Internal error function createJacobian failed
Notification: Performance of <failed> postOpt symbolicJacobian (simulation): time 0.02912/2.011, allocations: 10.06 MB / 1.006 GB, free: 191.1 MB / 0.6042 GB
Error: post-optimization module symbolicJacobian (simulation) failed.