[asterisk-bugs] [JIRA] (ASTERISK-30425) cel: CEL APP_START and APP_END are incorrectly aggregated when same apps runs in sequence

[Joshua C. Colp (JIRA)]

     [ https://issues.asterisk.org/jira/browse/ASTERISK-30425?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]

Joshua C. Colp updated ASTERISK-30425:
--------------------------------------

    Status: Open  (was: Triage)

> cel: CEL APP_START and APP_END are incorrectly aggregated when same apps runs in sequence
> -----------------------------------------------------------------------------------------
>
>                 Key: ASTERISK-30425
>                 URL: https://issues.asterisk.org/jira/browse/ASTERISK-30425
>             Project: Asterisk
>          Issue Type: Bug
>      Security Level: None
>          Components: CEL/General
>    Affects Versions: 18.16.0
>         Environment: CentOS 7, Fedora 37
>            Reporter: Pavel Šidlo
>            Severity: Major
>         Attachments: cel_bug.tar.gz
>
>
> We've spotted incorrect behavior of CEL APP_START and APP_END when the same app is called more times in sequence. Only first APP_START and last APP_END is logged correctly.
> This behavior is reproducible without relation to specific CEL backend. I've tested CSV and PostgreSQL backends.
> Test env stripped down to bare minimum for calling of NoOp and Wait app and logging using cel_custom backend attached:
> {quote}
> pbxtest3*CLI> dialplan show 
> [ Context 'locals' created by 'pbx_config' ]
>   '123' =>          1. NoOp(test1)                                [extensions.conf:2]
>                     2. NoOp(test2)                                [extensions.conf:3]
>                     3. NoOp(test3)                                [extensions.conf:4]
>                     4. Hangup()                                   [extensions.conf:5]
>   '124' =>          1. NoOp(test1)                                [extensions.conf:6]
>                     2. Wait(0)                                    [extensions.conf:7]
>                     3. NoOp(test2)                                [extensions.conf:8]
>                     4. Wait(0)                                    [extensions.conf:9]
>                     5. NoOp(test3)                                [extensions.conf:10]
>                     6. Hangup()                                   [extensions.conf:11]
> -= 2 extensions (10 priorities) in 1 context. =-
> {quote}
> Dialing to 123 at locals produce only two APP events:
> {quote}
> "1676300067.034582","APP_START","","","","","","","123","locals","Local/123 at locals-00000003;2","NoOp","test1","","","1676300067.42","1676300067.41","3","","",""
> "1676300067.034604","APP_END","","","","","","","123","locals","Local/123 at locals-00000003;2","NoOp","test3","","","1676300067.42","1676300067.41","3","","",""
> {quote}
> If I put some other app between NoOps then events are complete. It can be used as a workaround:
> {quote}
> "1676300069.113237","APP_START","","","","","","","124","locals","Local/124 at locals-00000004;2","NoOp","test1","","","1676300069.53","1676300069.52","3","","",""
> "1676300069.113246","APP_END","","","","","","","124","locals","Local/124 at locals-00000004;2","NoOp","test1","","","1676300069.53","1676300069.52","3","","",""
> "1676300069.113246","APP_START","","","","","","","124","locals","Local/124 at locals-00000004;2","Wait","0","","","1676300069.53","1676300069.52","3","","",""
> "1676300069.113284","APP_END","","","","","","","124","locals","Local/124 at locals-00000004;2","Wait","0","","","1676300069.53","1676300069.52","3","","",""
> "1676300069.113284","APP_START","","","","","","","124","locals","Local/124 at locals-00000004;2","NoOp","test2","","","1676300069.53","1676300069.52","3","","",""
> "1676300069.113292","APP_END","","","","","","","124","locals","Local/124 at locals-00000004;2","NoOp","test2","","","1676300069.53","1676300069.52","3","","",""
> "1676300069.113292","APP_START","","","","","","","124","locals","Local/124 at locals-00000004;2","Wait","0","","","1676300069.53","1676300069.52","3","","",""
> "1676300069.113299","APP_END","","","","","","","124","locals","Local/124 at locals-00000004;2","Wait","0","","","1676300069.53","1676300069.52","3","","",""
> "1676300069.113299","APP_START","","","","","","","124","locals","Local/124 at locals-00000004;2","NoOp","test3","","","1676300069.53","1676300069.52","3","","",""
> {quote}
> I've checked Asterisk 12 CEL Specification on Asterisk wiki and there are no signs about APP_START/END events aggregation.



--
This message was sent by Atlassian JIRA
(v6.2#6252)