Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.0.0_Modelica.ComplexBlocks.Examples.ShowTransferFunction.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001384/0.001384, allocations: 104 kB / 21.25 MB, free: 0.5664 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001447/0.001447, allocations: 192.2 kB / 24.53 MB, free: 3.852 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.585/1.585, allocations: 225.7 MB / 253.4 MB, free: 12.8 MB / 206.1 MB " [Timeout remaining time 178] Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo) Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo) Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo) Running command: translateModel(Modelica.ComplexBlocks.Examples.ShowTransferFunction,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="time|logFrequencySweep.y|const.y.re|const.y.im|transferFunction.y.re|transferFunction.y.im",fileNamePrefix="Modelica_4.0.0_Modelica.ComplexBlocks.Examples.ShowTransferFunction") translateModel(Modelica.ComplexBlocks.Examples.ShowTransferFunction,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="time|logFrequencySweep.y|const.y.re|const.y.im|transferFunction.y.re|transferFunction.y.im",fileNamePrefix="Modelica_4.0.0_Modelica.ComplexBlocks.Examples.ShowTransferFunction") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.204e-05/2.204e-05, allocations: 2.281 kB / 371.7 MB, free: 9.273 MB / 302.1 MB Notification: Performance of NFInst.instantiate(Modelica.ComplexBlocks.Examples.ShowTransferFunction): time 0.002995/0.003017, allocations: 1.606 MB / 373.3 MB, free: 7.652 MB / 302.1 MB Notification: Performance of NFInst.instExpressions: time 0.001302/0.004319, allocations: 0.6037 MB / 373.9 MB, free: 7.043 MB / 302.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 6.35e-05/0.004383, allocations: 4 kB / 373.9 MB, free: 7.039 MB / 302.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0002731/0.004656, allocations: 47.73 kB / 373.9 MB, free: 6.992 MB / 302.1 MB Notification: Performance of NFTyping.typeBindings: time 0.0002098/0.004866, allocations: 43.7 kB / 374 MB, free: 6.949 MB / 302.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.001282/0.006148, allocations: 0.5523 MB / 374.5 MB, free: 6.398 MB / 302.1 MB Notification: Performance of NFFlatten.flatten: time 0.0002563/0.006404, allocations: 143.6 kB / 374.7 MB, free: 6.258 MB / 302.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0001268/0.006531, allocations: 12 kB / 374.7 MB, free: 6.246 MB / 302.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0001589/0.00669, allocations: 67.75 kB / 374.8 MB, free: 6.18 MB / 302.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0001526/0.006843, allocations: 71.61 kB / 374.8 MB, free: 6.109 MB / 302.1 MB Notification: Performance of NFPackage.collectConstants: time 3.066e-05/0.006873, allocations: 8 kB / 374.8 MB, free: 6.102 MB / 302.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0001992/0.007073, allocations: 91.94 kB / 374.9 MB, free: 6.012 MB / 302.1 MB Notification: Performance of combineBinaries: time 0.0002344/0.007307, allocations: 257.1 kB / 375.2 MB, free: 5.758 MB / 302.1 MB Notification: Performance of replaceArrayConstructors: time 0.0001241/0.007431, allocations: 177.5 kB / 375.4 MB, free: 5.582 MB / 302.1 MB Notification: Performance of NFVerifyModel.verify: time 2.806e-05/0.007459, allocations: 12 kB / 375.4 MB, free: 5.57 MB / 302.1 MB Notification: Performance of FrontEnd: time 2.448e-05/0.007484, allocations: 0 / 375.4 MB, free: 5.57 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: 29 (18) * Number of variables: 29 (25) Notification: Performance of [SIM] Bindings: time 0.001126/0.008609, allocations: 0.8818 MB / 376.2 MB, free: 4.562 MB / 302.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.0003646/0.008974, allocations: 226.1 kB / 376.5 MB, free: 4.324 MB / 302.1 MB Notification: Performance of [SIM] Early Inline: time 0.001178/0.01015, allocations: 0.9519 MB / 377.4 MB, free: 3.352 MB / 302.1 MB Notification: Performance of [SIM] Simplify 1: time 0.0002657/0.01042, allocations: 173.7 kB / 377.6 MB, free: 3.145 MB / 302.1 MB Notification: Performance of [SIM] Alias: time 0.0009502/0.01137, allocations: 0.5061 MB / 378.1 MB, free: 2.555 MB / 302.1 MB Notification: Performance of [SIM] Simplify 2: time 0.0002241/0.01159, allocations: 165.2 kB / 378.3 MB, free: 2.355 MB / 302.1 MB Notification: Performance of [SIM] Remove Stream: time 0.0001155/0.01171, allocations: 80.38 kB / 378.3 MB, free: 2.25 MB / 302.1 MB Notification: Performance of [SIM] Detect States: time 0.0002268/0.01193, allocations: 192.6 kB / 378.5 MB, free: 2.008 MB / 302.1 MB Notification: Performance of [SIM] Events: time 0.0001162/0.01205, allocations: 53.16 kB / 378.6 MB, free: 1.957 MB / 302.1 MB Notification: Performance of [SIM] Partitioning: time 0.0003397/0.01239, allocations: 265.7 kB / 378.8 MB, free: 1.691 MB / 302.1 MB Error: Internal error NBSorting.tarjan failed to sort system: System Variables (33/37) ************************** (1|1) [ALGB] (1) Real $FUN_4 (2|2) [ALGB] (1) Real $FUN_3 (3|3) [ALGB] (1) Real $FUN_2 (4|4) [ALGB] (1) Real $FUN_1 (5|5) [ALGB] (1) protected Real transferFunction.uInternal.im = transferFunction.u.im (6|6) [ALGB] (1) protected Real transferFunction.bSum.im (7|7) [ALGB] (3) protected Real[3] transferFunction.aw.re (8|10) [ALGB] (1) input Real transferFunction.u.im (9|11) [ALGB] (1) output Real transferFunction.y.im (10|12) [ALGB] (1) Real complexToPolar.len (11|13) [ALGB] (1) protected Real[1] transferFunction.bw.im (12|14) [ALGB] (1) protected Real[1] transferFunction.bw.re (13|15) [ALGB] (1) Real lg_w = log10(logFrequencySweep.y) (14|16) [ALGB] (1) input Real transferFunction.u.re (15|17) [ALGB] (1) protected Real transferFunction.bSum.re (16|18) [ALGB] (1) protected Real transferFunction.aSum.im (17|19) [ALGB] (1) input Real complexToPolar.u.re (18|20) [ALGB] (3) protected Real[3] transferFunction.aw.im (19|23) [ALGB] (1) output Real const.y.re (20|24) [ALGB] (1) input Real complexToPolar.u.im (21|25) [ALGB] (1) Real logFrequencySweep.y (22|26) [ALGB] (1) Real dB = 20.0 * log10(complexToPolar.len) (23|27) [DISC] (1) Boolean $TEV_1 (24|28) [DISC] (1) Boolean $TEV_0 (25|29) [ALGB] (1) Real phi = phi (26|30) [ALGB] (1) output Real const.y.im (27|31) [ALGB] (1) protected Real transferFunction.uInternal.re = transferFunction.u.re (28|32) [ALGB] (1) Real $FUN_8 (29|33) [ALGB] (1) protected Real transferFunction.aSum.re (30|34) [ALGB] (1) Real $FUN_7 (31|35) [ALGB] (1) output Real transferFunction.y.re (32|36) [ALGB] (1) Real $FUN_6 (33|37) [ALGB] (1) Real $FUN_5 System Equations (30/34) ************************** (1|1) [SCAL] (1) transferFunction.y.re = ((transferFunction.bSum.re * transferFunction.u.re - transferFunction.bSum.im * transferFunction.u.im) * transferFunction.aSum.re + (transferFunction.bSum.re * transferFunction.u.im + transferFunction.bSum.im * transferFunction.u.re) * transferFunction.aSum.im) / (transferFunction.aSum.re * transferFunction.aSum.re + transferFunction.aSum.im * transferFunction.aSum.im) ($RES_SIM_42) (2|2) [SCAL] (1) $TEV_1 = time < (logFrequencySweep.startTime + max(logFrequencySweep.duration, 1e-15)) ($RES_EVT_46) (3|3) [SCAL] (1) transferFunction.bw[1].im = 0.0 ($RES_SIM_37) (4|4) [SCAL] (1) transferFunction.y.im = ((transferFunction.bSum.re * transferFunction.u.im + transferFunction.bSum.im * transferFunction.u.re) * transferFunction.aSum.re - (transferFunction.bSum.re * transferFunction.u.re - transferFunction.bSum.im * transferFunction.u.im) * transferFunction.aSum.im) / (transferFunction.aSum.re * transferFunction.aSum.re + transferFunction.aSum.im * transferFunction.aSum.im) ($RES_SIM_43) (5|5) [SCAL] (1) transferFunction.bSum.re = $FUN_3 ($RES_SIM_38) (6|6) [SCAL] (1) transferFunction.bSum.im = $FUN_4 ($RES_SIM_39) (7|7) [SCAL] (1) transferFunction.y.im = complexToPolar.u.im ($RES_SIM_9) (8|8) [SCAL] (1) logFrequencySweep.y = if $TEV_0 then logFrequencySweep.wMin else if $TEV_1 then 10.0 ^ ($FUN_1 + ($FUN_2 - $FUN_1) * min(1.0, (time - logFrequencySweep.startTime) / max(logFrequencySweep.duration, 1e-15))) else logFrequencySweep.wMax ($RES_SIM_8) (9|9) [SCAL] (1) $FUN_4 = sum(transferFunction.bw.im) ($RES_AUX_30) (10|10) [SCAL] (1) lg_w = log10(logFrequencySweep.y) ($RES_AUX_24) (11|11) [RECD] (2) const.y = const.k ($RES_SIM_7) (12|13) [SCAL] (1) $FUN_3 = sum(transferFunction.bw.re) ($RES_AUX_31) (13|14) [SCAL] (1) 0.05 * dB = log10(complexToPolar.len) ($RES_AUX_25) (14|15) [SCAL] (1) $FUN_2 = log10(logFrequencySweep.wMax) ($RES_AUX_32) (15|16) [SCAL] (1) $FUN_8 = atan2(complexToPolar.u.im, complexToPolar.u.re) ($RES_AUX_26) (16|17) [SCAL] (1) transferFunction.y.re = complexToPolar.u.re ($RES_SIM_10) (17|18) [SCAL] (1) $FUN_1 = log10(logFrequencySweep.wMin) ($RES_AUX_33) (18|19) [SCAL] (1) $FUN_7 = atan2(-complexToPolar.u.im, complexToPolar.u.re) ($RES_AUX_27) (19|20) [SCAL] (1) $FUN_6 = sum(transferFunction.aw.im) ($RES_AUX_28) (20|21) [SCAL] (1) const.y.im = transferFunction.u.im ($RES_SIM_12) (21|22) [SCAL] (1) $FUN_5 = sum(transferFunction.aw.re) ($RES_AUX_29) (22|23) [SCAL] (1) const.y.re = transferFunction.u.re ($RES_SIM_13) (23|24) [SCAL] (1) complexToPolar.len = (complexToPolar.u.re ^ 2.0 + complexToPolar.u.im ^ 2.0) ^ 0.5 ($RES_SIM_1) (24|25) [SCAL] (1) phi = if complexToPolar.useConjugateInput then $FUN_7 else $FUN_8 ($RES_SIM_0) (25|26) [FOR-] (3) ($RES_SIM_22) (25|26) [----] for i in 1:3 loop (25|26) [----] [SCAL] (1) transferFunction.aw[i].im = (Complex.'constructor'.fromReal(transferFunction.a[i] * cos(((-1) + i) * atan2(logFrequencySweep.y, 0.0)) * exp(0.5 * ((-1) + i) * log(logFrequencySweep.y * logFrequencySweep.y)), transferFunction.a[i] * sin(((-1) + i) * atan2(logFrequencySweep.y, 0.0)) * exp(0.5 * ((-1) + i) * log(logFrequencySweep.y * logFrequencySweep.y)))).im ($RES_SIM_23) (25|26) [----] end for; (26|29) [RECD] (2) transferFunction.uInternal = transferFunction.u ($RES_BND_17) (27|31) [SCAL] (1) transferFunction.aSum.re = $FUN_5 ($RES_SIM_40) (28|32) [SCAL] (1) transferFunction.bw[1].re = transferFunction.b[1] ($RES_SIM_35) (29|33) [SCAL] (1) transferFunction.aSum.im = $FUN_6 ($RES_SIM_41) (30|34) [SCAL] (1) $TEV_0 = time < logFrequencySweep.startTime ($RES_EVT_45) =================== Scalar Matching =================== variable to equation ********************** var 1 --> eqn 9 var 2 --> eqn 13 var 3 --> eqn 15 var 4 --> eqn 18 var 5 --> eqn 30 var 6 --> eqn 6 var 7 --> eqn -1 var 8 --> eqn -1 var 9 --> eqn 22 var 10 --> eqn 21 var 11 --> eqn 4 var 12 --> eqn 14 var 13 --> eqn 3 var 14 --> eqn 32 var 15 --> eqn 10 var 16 --> eqn 23 var 17 --> eqn 5 var 18 --> eqn 33 var 19 --> eqn 24 var 20 --> eqn 26 var 21 --> eqn 27 var 22 --> eqn 28 var 23 --> eqn 11 var 24 --> eqn 7 var 25 --> eqn 8 var 26 --> eqn -1 var 27 --> eqn 2 var 28 --> eqn 34 var 29 --> eqn 25 var 30 --> eqn 12 var 31 --> eqn 29 var 32 --> eqn 16 var 33 --> eqn 1 var 34 --> eqn 19 var 35 --> eqn 17 var 36 --> eqn 20 var 37 --> eqn 31 equation to variable ********************** eqn 1 --> var 33 eqn 2 --> var 27 eqn 3 --> var 13 eqn 4 --> var 11 eqn 5 --> var 17 eqn 6 --> var 6 eqn 7 --> var 24 eqn 8 --> var 25 eqn 9 --> var 1 eqn 10 --> var 15 eqn 11 --> var 23 eqn 12 --> var 30 eqn 13 --> var 2 eqn 14 --> var 12 eqn 15 --> var 3 eqn 16 --> var 32 eqn 17 --> var 35 eqn 18 --> var 4 eqn 19 --> var 34 eqn 20 --> var 36 eqn 21 --> var 10 eqn 22 --> var 9 eqn 23 --> var 16 eqn 24 --> var 19 eqn 25 --> var 29 eqn 26 --> var 20 eqn 27 --> var 21 eqn 28 --> var 22 eqn 29 --> var 31 eqn 30 --> var 5 eqn 31 --> var 37 eqn 32 --> var 14 eqn 33 --> var 18 eqn 34 --> var 28 " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 2.591680279991124] Failed to read output from testmodel.py, exit status != 0: ['time', 'logFrequencySweep.y', 'const.y.re', 'const.y.im', 'transferFunction.y.re', 'transferFunction.y.im'] 0.22625774098560214 0.24004369 0.229521688 Calling exit ...