Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0-beta.om_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 4.1.0-beta.om/package.mo", uses=false)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0-beta.om/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_4.1.0-beta.om_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_4.1.0-beta.om_Modelica.Electrical.Analog.Examples.NandGate")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001634/0.001634, allocations: 115.3 kB / 19.05 MB, free: 3.656 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001717/0.001717, allocations: 211.7 kB / 20.03 MB, free: 2.68 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0-beta.om/package.mo): time 1.204/1.204, allocations: 230.4 MB / 251.3 MB, free: 8.723 MB / 206.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 9.448e-06/9.448e-06, allocations: 2.281 kB / 368.8 MB, free: 6.559 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Electrical.Analog.Examples.NandGate): time 0.004595/0.004604, allocations: 4.289 MB / 373.1 MB, free: 2.25 MB / 302.1 MB
Notification: Performance of NFInst.instExpressions: time 0.001899/0.006503, allocations: 1.215 MB / 374.3 MB, free: 1.027 MB / 302.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000271/0.006774, allocations: 8 kB / 374.3 MB, free: 1.02 MB / 302.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0002475/0.007022, allocations: 110.8 kB / 374.4 MB, free: 0.9102 MB / 302.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0003722/0.007394, allocations: 186.3 kB / 374.6 MB, free: 0.7266 MB / 302.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0005776/0.007971, allocations: 331.5 kB / 374.9 MB, free: 412 kB / 302.1 MB
Notification: Performance of NFFlatten.flatten: time 0.1159/0.1238, allocations: 1.197 MB / 376.1 MB, free: 10.39 MB / 302.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002809/0.1241, allocations: 174.9 kB / 376.3 MB, free: 10.36 MB / 302.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003417/0.1245, allocations: 413.3 kB / 376.7 MB, free: 10.32 MB / 302.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003494/0.1248, allocations: 457.8 kB / 377.2 MB, free: 10.24 MB / 302.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001204/0.1249, allocations: 119.9 kB / 377.3 MB, free: 10.24 MB / 302.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001287/0.1251, allocations: 118.1 kB / 377.4 MB, free: 10.24 MB / 302.1 MB
Notification: Performance of combineBinaries: time 0.0005758/0.1256, allocations: 1.304 MB / 378.7 MB, free: 9.594 MB / 302.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0002253/0.1259, allocations: 0.7396 MB / 379.4 MB, free: 9.082 MB / 302.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001091/0.126, allocations: 141.8 kB / 379.6 MB, free: 9.055 MB / 302.1 MB
Notification: Performance of FrontEnd: time 9.542e-05/0.1261, allocations: 27.98 kB / 379.6 MB, free: 9.055 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.00172/0.1278, allocations: 2.968 MB / 382.6 MB, free: 7.457 MB / 302.1 MB
Notification: Performance of FunctionAlias: time 0.0002276/0.128, allocations: 387 kB / 383 MB, free: 7.211 MB / 302.1 MB
Notification: Performance of Early Inline: time 0.001159/0.1292, allocations: 1.561 MB / 384.5 MB, free: 6.223 MB / 302.1 MB
Notification: Performance of Simplify 1: time 0.0003322/0.1295, allocations: 343.9 kB / 384.8 MB, free: 6.039 MB / 302.1 MB
Notification: Performance of Alias: time 0.002536/0.1321, allocations: 2.911 MB / 387.8 MB, free: 4.254 MB / 302.1 MB
Notification: Performance of Simplify 2: time 0.0002199/0.1323, allocations: 245 kB / 388 MB, free: 4.133 MB / 302.1 MB
Notification: Performance of Remove Stream: time 0.000168/0.1324, allocations: 234.4 kB / 388.2 MB, free: 3.973 MB / 302.1 MB
Notification: Performance of Detect States: time 0.0003741/0.1328, allocations: 459.5 kB / 388.7 MB, free: 3.656 MB / 302.1 MB
Notification: Performance of Events: time 0.0004968/0.1333, allocations: 0.513 MB / 389.2 MB, free: 3.383 MB / 302.1 MB
Notification: Performance of Partitioning: time 0.0006205/0.1339, allocations: 0.853 MB / 390 MB, free: 2.766 MB / 302.1 MB
Notification: Performance of Causalize: time 0.00254/0.1365, allocations: 2.725 MB / 392.8 MB, free: 1.73 MB / 302.1 MB
Notification: Performance of After Index Reduction Inline: time 0.0008522/0.1373, allocations: 1.244 MB / 394 MB, free: 1.023 MB / 302.1 MB
Notification: Performance of Simplify: time 0.0008955/0.1382, allocations: 0.977 MB / 395 MB, free: 440 kB / 302.1 MB
Notification: Performance of Inline: time 0.001741/0.14, allocations: 1.787 MB / 396.8 MB, free: 15.35 MB / 318.1 MB
Notification: Performance of Partitioning: time 9.754e-05/0.1401, allocations: 61.67 kB / 396.8 MB, free: 15.3 MB / 318.1 MB
Notification: Performance of Cleanup: time 0.0003654/0.1404, allocations: 478 kB / 397.3 MB, free: 14.91 MB / 318.1 MB
Notification: Performance of Causalize: time 0.003975/0.1444, allocations: 3.593 MB / 400.9 MB, free: 13.3 MB / 318.1 MB
Notification: Performance of Tearing: time 1.353e-05/0.1444, allocations: 3.469 kB / 400.9 MB, free: 13.3 MB / 318.1 MB
Notification: Performance of Initialization: time 3.8e-07/0.1444, allocations: 0 / 400.9 MB, free: 13.3 MB / 318.1 MB
Notification: Performance of Tearing: time 8.005e-06/0.1444, allocations: 2.5 kB / 400.9 MB, free: 13.3 MB / 318.1 MB
Notification: Performance of Categorize: time 1.367e-05/0.1444, allocations: 8.875 kB / 400.9 MB, free: 13.3 MB / 318.1 MB
Notification: Performance of Solve: time 0.0005662/0.145, allocations: 406.2 kB / 401.3 MB, free: 13.07 MB / 318.1 MB
Notification: Performance of Jacobian: time 0.0006376/0.1456, allocations: 0.7308 MB / 402 MB, free: 12.53 MB / 318.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.T_start, VIN2.signalSource.count, VIN1.signalSource.T_start, VIN1.signalSource.count}
 * Number of clocked states: ..................... 0 (0) {}
 * 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 clocks: ............................. 0 (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 (resizable: 0generic: 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 (resizable: 0generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 6.529e-05/0.1457, allocations: 69.62 kB / 402.1 MB, free: 12.47 MB / 318.1 MB
Notification: Performance of SimCode: time 0.002285/0.148, allocations: 3.076 MB / 405.2 MB, free: 10.02 MB / 318.1 MB
Notification: Performance of Templates: time 0.01171/0.1597, allocations: 7.878 MB / 413.1 MB, free: 2.504 MB / 318.1 MB
make -j1 -f Modelica_4.1.0-beta.om_Modelica.Electrical.Analog.Examples.NandGate.makefile
(rm -f Modelica_4.1.0-beta.om_Modelica.Electrical.Analog.Examples.NandGate.pipe ; mkfifo Modelica_4.1.0-beta.om_Modelica.Electrical.Analog.Examples.NandGate.pipe ; head -c 1048576 < Modelica_4.1.0-beta.om_Modelica.Electrical.Analog.Examples.NandGate.pipe >> ../files/Modelica_4.1.0-beta.om_Modelica.Electrical.Analog.Examples.NandGate.sim & ./Modelica_4.1.0-beta.om_Modelica.Electrical.Analog.Examples.NandGate  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Modelica_4.1.0-beta.om_Modelica.Electrical.Analog.Examples.NandGate.pipe 2>&1)
diffSimulationResults("Modelica_4.1.0-beta.om_Modelica.Electrical.Analog.Examples.NandGate_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/Modelica/Electrical/Analog/Examples/NandGate/NandGate.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Modelica_4.1.0-beta.om_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