Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
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)
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)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: translateModel(Modelica.Electrical.Analog.Examples.NandGate,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|Nand.C4.v|Nand.C7.v",fileNamePrefix="Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate")
translateModel(Modelica.Electrical.Analog.Examples.NandGate,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|Nand.C4.v|Nand.C7.v",fileNamePrefix="Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001178/0.001179, allocations: 111.8 kB / 18.47 MB, free: 4.586 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001245/0.001245, allocations: 206.8 kB / 19.42 MB, free: 3.645 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.223/1.223, allocations: 227.4 MB / 247.6 MB, free: 10.5 MB / 206.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.749e-05/1.75e-05, allocations: 2.281 kB / 359.3 MB, free: 13 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Electrical.Analog.Examples.NandGate): time 0.004388/0.004414, allocations: 4.272 MB / 363.6 MB, free: 8.703 MB / 302.1 MB
Notification: Performance of NFInst.instExpressions: time 0.001698/0.006124, allocations: 1.207 MB / 364.8 MB, free: 7.488 MB / 302.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0001901/0.006325, allocations: 15.94 kB / 364.8 MB, free: 7.473 MB / 302.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0002174/0.006549, allocations: 102.9 kB / 364.9 MB, free: 7.371 MB / 302.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0002817/0.006847, allocations: 182.3 kB / 365.1 MB, free: 7.191 MB / 302.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0005193/0.007372, allocations: 327.5 kB / 365.4 MB, free: 6.871 MB / 302.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0009368/0.008318, allocations: 1.206 MB / 366.6 MB, free: 5.66 MB / 302.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003552/0.008682, allocations: 287 kB / 366.9 MB, free: 5.371 MB / 302.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003314/0.009022, allocations: 410.8 kB / 367.3 MB, free: 4.969 MB / 302.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003684/0.009399, allocations: 462.3 kB / 367.8 MB, free: 4.516 MB / 302.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001344/0.009539, allocations: 120 kB / 367.9 MB, free: 4.398 MB / 302.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001345/0.00968, allocations: 116 kB / 368 MB, free: 4.285 MB / 302.1 MB
Notification: Performance of combineBinaries: time 0.0008429/0.01053, allocations: 1.299 MB / 369.3 MB, free: 2.973 MB / 302.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0003669/0.0109, allocations: 0.7389 MB / 370 MB, free: 2.223 MB / 302.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.000127/0.01103, allocations: 143.6 kB / 370.2 MB, free: 2.082 MB / 302.1 MB
Notification: Performance of FrontEnd: time 7.485e-05/0.01111, allocations: 20 kB / 370.2 MB, free: 2.062 MB / 302.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 147 (147)
 * Number of variables: 147 (147)
Notification: Performance of Bindings: time 0.1432/0.1543, allocations: 3.91 MB / 374.1 MB, free: 14.35 MB / 302.1 MB
Notification: Performance of FunctionAlias: time 0.0001769/0.1545, allocations: 194.2 kB / 374.3 MB, free: 14.35 MB / 302.1 MB
Notification: Performance of Early Inline: time 0.00216/0.1567, allocations: 2.326 MB / 376.6 MB, free: 13.5 MB / 302.1 MB
Notification: Performance of simplify1: time 0.0003681/0.1571, allocations: 199.5 kB / 376.8 MB, free: 13.42 MB / 302.1 MB
Notification: Performance of Alias: time 0.003875/0.161, allocations: 3.791 MB / 380.6 MB, free: 11.21 MB / 302.1 MB
Notification: Performance of simplify2: time 0.0001414/0.1611, allocations: 146.1 kB / 380.7 MB, free: 11.16 MB / 302.1 MB
Notification: Performance of Events: time 0.0005779/0.1617, allocations: 0.5308 MB / 381.3 MB, free: 10.91 MB / 302.1 MB
Notification: Performance of Detect States: time 0.0005976/0.1623, allocations: 0.6467 MB / 381.9 MB, free: 10.5 MB / 302.1 MB
Notification: Performance of Partitioning: time 0.0006417/0.163, allocations: 0.7837 MB / 382.7 MB, free: 9.957 MB / 302.1 MB
Notification: Performance of Causalize: time 0.002951/0.1659, allocations: 3.051 MB / 385.8 MB, free: 8.785 MB / 302.1 MB
Notification: Performance of After Index Reduction Inline: time 0.001529/0.1674, allocations: 1.915 MB / 387.7 MB, free: 7.617 MB / 302.1 MB
Notification: Performance of Inline: time 0.002603/0.1701, allocations: 3.146 MB / 390.8 MB, free: 5.715 MB / 302.1 MB
Notification: Performance of Partitioning: time 0.0001385/0.1702, allocations: 144.9 kB / 391 MB, free: 5.621 MB / 302.1 MB
Notification: Performance of Cleanup: time 0.0001224/0.1703, allocations: 160.2 kB / 391.1 MB, free: 5.52 MB / 302.1 MB
Notification: Performance of Causalize: time 0.004487/0.1748, allocations: 4.395 MB / 395.5 MB, free: 3.934 MB / 302.1 MB
Notification: Performance of Tearing: time 8.877e-06/0.1748, allocations: 0 / 395.5 MB, free: 3.934 MB / 302.1 MB
Notification: Performance of Initialization: time 9.62e-07/0.1749, allocations: 0 / 395.5 MB, free: 3.934 MB / 302.1 MB
Notification: Performance of Tearing: time 1.188e-05/0.1749, allocations: 7.188 kB / 395.5 MB, free: 3.93 MB / 302.1 MB
Notification: Performance of Categorize: time 2.067e-05/0.1749, allocations: 3.438 kB / 395.5 MB, free: 3.93 MB / 302.1 MB
Notification: Performance of Solve: time 0.0006517/0.1756, allocations: 489.1 kB / 396 MB, free: 3.781 MB / 302.1 MB
Notification: Performance of Jacobian: time 0.0006711/0.1762, allocations: 0.9311 MB / 396.9 MB, free: 3.27 MB / 302.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 2
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 12
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 2 (2) {Nand.C4.v, Nand.C7.v}
 * Number of discrete states: .................... 4 (4) {VIN2.signalSource.count, VIN2.signalSource.T_start, VIN1.signalSource.count, VIN1.signalSource.T_start}
 * Number of clocked states: ..................... 0 (0) {NOT YET AVAILABLE}
 * Number of discrete variables: ................. 43 (43) {$SEV_40, $SEV_39, $SEV_38, $SEV_37, $SEV_36, $SEV_35, $SEV_34, $SEV_33, $SEV_32, $SEV_31, $SEV_30, $SEV_29, $SEV_28, $SEV_27, $SEV_26, $SEV_25, $SEV_24, $SEV_23, $SEV_22, $SEV_21, $SEV_20, $SEV_19, $SEV_18, $SEV_17, $SEV_16, $SEV_15, $SEV_14, $SEV_13, $SEV_12, $SEV_11, $SEV_10, $SEV_9, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_1, $TEV_0}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 103 (scalar:103, array:0, record:0)
 * Number of multi strong components: ............ 4 (algorithm:0, when:4, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 151 (scalar:151, array:0, record:0)
 * Number of multi strong components: ............ 2 (algorithm:2, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 5.54e-05/0.1763, allocations: 61.33 kB / 397 MB, free: 3.223 MB / 302.1 MB
Notification: Performance of SimCode: time 0.001704/0.178, allocations: 3.267 MB / 400.3 MB, free: 0.6953 MB / 302.1 MB
Notification: Performance of Templates: time 0.0118/0.1898, allocations: 8.013 MB / 408.3 MB, free: 8.711 MB / 318.1 MB
make -j1 -f Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate.makefile
(rm -f Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate.pipe ; mkfifo Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate.pipe ; head -c 1048576 < Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate.pipe >> ../files/Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate.sim & ./Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate.pipe 2>&1)
diffSimulationResults("Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/Modelica/Electrical/Analog/Examples/NandGate/NandGate.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Modelica_trunk_Modelica.Electrical.Analog.Examples.NandGate.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
""

Variables in the reference:time,Nand.C4.v,Nand.C7.v

Variables in the result:Gnd1.p.v,Gnd4.p.v,Gnd5.p.v,Nand.C4.C,Nand.C4.n.v,Nand.C4.v,Nand.C7.C,Nand.C7.n.v,Nand.C7.v,Nand.Gnd.p.v,Nand.Gnd2.p.v,Nand.Gnd3.p.v,Nand.Gnd6.p.i,Nand.Gnd6.p.v,Nand.Gnd7.p.i,Nand.Gnd7.p.v,Nand.Gnd8.p.i,Nand.Gnd8.p.v,Nand.TN1.B.i,Nand.TN1.B.v,Nand.TN1.Beta,Nand.TN1.G.i,Nand.TN1.K2,Nand.TN1.K5,Nand.TN1.L,Nand.TN1.RDS,Nand.TN1.T,Nand.TN1.T_heatPort,Nand.TN1.Tnom,Nand.TN1.Vt,Nand.TN1.W,Nand.TN1.beta_t,Nand.TN1.dL,Nand.TN1.dW,Nand.TN1.k2_t,Nand.TN1.kk2,Nand.TN1.kvt,Nand.TN1.vt_t,Nand.TN2.B.i,Nand.TN2.B.v,Nand.TN2.Beta,Nand.TN2.G.i,Nand.TN2.K2,Nand.TN2.K5,Nand.TN2.L,Nand.TN2.RDS,Nand.TN2.S.v,Nand.TN2.T,Nand.TN2.T_heatPort,Nand.TN2.Tnom,Nand.TN2.Vt,Nand.TN2.W,Nand.TN2.beta_t,Nand.TN2.dL,Nand.TN2.dW,Nand.TN2.k2_t,Nand.TN2.kk2,Nand.TN2.kvt,Nand.TN2.vt_t,Nand.TP1.B.i,Nand.TP1.B.v,Nand.TP1.Beta,Nand.TP1.G.i,Nand.TP1.K2,Nand.TP1.K5,Nand.TP1.L,Nand.TP1.RDS,Nand.TP1.T,Nand.TP1.T_heatPort,Nand.TP1.Tnom,Nand.TP1.Vt,Nand.TP1.W,Nand.TP1.beta_t,Nand.TP1.dL,Nand.TP1.dW,Nand.TP1.k2_t,Nand.TP1.kk2,Nand.TP1.kvt,Nand.TP1.vt_t,Nand.TP2.B.i,Nand.TP2.B.v,Nand.TP2.Beta,Nand.TP2.G.i,Nand.TP2.K2,Nand.TP2.K5,Nand.TP2.L,Nand.TP2.RDS,Nand.TP2.T,Nand.TP2.T_heatPort,Nand.TP2.Tnom,Nand.TP2.Vt,Nand.TP2.W,Nand.TP2.beta_t,Nand.TP2.dL,Nand.TP2.dW,Nand.TP2.k2_t,Nand.TP2.kk2,Nand.TP2.kvt,Nand.TP2.vt_t,Nand.y.i,VDD.V,VDD.duration,VDD.n.v,VDD.offset,VDD.signalSource.duration,VDD.signalSource.height,VDD.signalSource.offset,VDD.signalSource.startTime,VDD.startTime,VIN1.V,VIN1.falling,VIN1.n.v,VIN1.nperiod,VIN1.offset,VIN1.period,VIN1.rising,VIN1.signalSource.T_falling,VIN1.signalSource.T_rising,VIN1.signalSource.T_width,VIN1.signalSource.amplitude,VIN1.signalSource.falling,VIN1.signalSource.nperiod,VIN1.signalSource.offset,VIN1.signalSource.period,VIN1.signalSource.rising,VIN1.signalSource.startTime,VIN1.signalSource.width,VIN1.startTime,VIN1.width,VIN2.V,VIN2.falling,VIN2.n.v,VIN2.nperiod,VIN2.offset,VIN2.period,VIN2.rising,VIN2.signalSource.T_falling,VIN2.signalSource.T_rising,VIN2.signalSource.T_width,VIN2.signalSource.amplitude,VIN2.signalSource.falling,VIN2.signalSource.nperiod,VIN2.signalSource.offset,VIN2.signalSource.period,VIN2.signalSource.rising,VIN2.signalSource.startTime,VIN2.signalSource.width,VIN2.startTime,VIN2.width,time