Agent tries to log out of queue but keeps saying "agent logged in"

FreePBX Applications / Modules
1

Hello,

I have an issue where an agent tries to log out at the end of the day and cannot. They all have BLF buttons programmed as * 45Ext*Queue. The BLF light is red, fop2 shows them as logged in. They press the button, system says “Agent logged in…” Press the button again… “Agent logged in…”

It seems to happen randomly throughout the day for about 10-20 minutes. After 10-20 minutes, if they press the button, it works as it should. and they don’t see it happen again for a few days.

The agents are dynamic members.

For what its worth, they had an old server that was replaced (for a different reason) where the problem happened as well. I didn’t do any backup or restores. Only used bulk handler for extensions and DIDs. Everything else was reprogrammed.

FreePBX 15.0.17.55
Asterisk 16.20.0
Linux freepbx.sangoma.local 3.10.0-1127.19.1.el7.x86_64

Here are what the logs and AGI debug are showing.

This one was ext 283 logging out of 369.

1087722[2021-10-19 17:02:53] VERBOSE[13556][C-00001cb0] pbx.c: Executing [*45283*369@from-internal:1] Set("SIP/283-00002d4a", "QUEUENO=369") in new stack

1087723[2021-10-19 17:02:53] VERBOSE[13556][C-00001cb0] pbx.c: Executing [*45283*369@from-internal:2] Set("SIP/283-00002d4a", "QUEUEUSER=283") in new stack

1087724[2021-10-19 17:02:53] VERBOSE[13556][C-00001cb0] pbx.c: Executing [*45283*369@from-internal:3] Goto("SIP/283-00002d4a", "app-queue-toggle,s,start") in new stack

1087725[2021-10-19 17:02:54] VERBOSE[13556][C-00001cb0] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Getting Queue Status for user 283 in queue 369

1087726[2021-10-19 17:02:54] VERBOSE[13556][C-00001cb0] pbx.c: Executing [s@macro-toggle-add-agent:5] ExecIf("SIP/283-00002d4a", "1?AddQueueMember(369,Local/283@from-queue/n,0,,"Stacey ",hint:283@ext-local)") in new stack

1087727[2021-10-19 17:02:54] WARNING[13556][C-00001cb0] app_queue.c: Unable to add interface 'Local/283@from-queue/n' to queue '369': Already there

1087728[2021-10-19 17:02:54] VERBOSE[13556][C-00001cb0] pbx.c: Executing [s@macro-toggle-add-agent:6] ExecIf("SIP/283-00002d4a", "0?AddQueueMember(369,Local/283@from-queue/n,0,,"Stacey ")") in new stack

1087729[2021-10-19 17:02:54] VERBOSE[13556][C-00001cb0] pbx.c: Executing [sstate@app-queue-toggle:5] Set("SIP/283-00002d4a", "DEVICE_STATE(Custom:QUEUE283*369)=INUSE") in new stack

1087730[2021-10-19 17:03:01] VERBOSE[13583][C-00001cb1] pbx.c: Executing [*45283*369@from-internal:1] Set("SIP/283-00002d4b", "QUEUENO=369") in new stack

1087731[2021-10-19 17:03:01] VERBOSE[13583][C-00001cb1] pbx.c: Executing [*45283*369@from-internal:2] Set("SIP/283-00002d4b", "QUEUEUSER=283") in new stack

1087732[2021-10-19 17:03:01] VERBOSE[13583][C-00001cb1] pbx.c: Executing [*45283*369@from-internal:3] Goto("SIP/283-00002d4b", "app-queue-toggle,s,start") in new stack

1087733[2021-10-19 17:03:03] VERBOSE[13583][C-00001cb1] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Getting Queue Status for user 283 in queue 369

1087734[2021-10-19 17:03:03] VERBOSE[13583][C-00001cb1] pbx.c: Executing [s@macro-toggle-add-agent:5] ExecIf("SIP/283-00002d4b", "1?AddQueueMember(369,Local/283@from-queue/n,0,,"Stacey ",hint:283@ext-local)") in new stack

1087735[2021-10-19 17:03:03] WARNING[13583][C-00001cb1] app_queue.c: Unable to add interface 'Local/283@from-queue/n' to queue '369': Already there

1087736[2021-10-19 17:03:03] VERBOSE[13583][C-00001cb1] pbx.c: Executing [s@macro-toggle-add-agent:6] ExecIf("SIP/283-00002d4b", "0?AddQueueMember(369,Local/283@from-queue/n,0,,"Stacey ")") in new stack

1087737[2021-10-19 17:03:03] VERBOSE[13583][C-00001cb1] pbx.c: Executing [sstate@app-queue-toggle:5] Set("SIP/283-00002d4b", "DEVICE_STATE(Custom:QUEUE283*369)=INUSE") in new stack

1087738[2021-10-19 17:03:19] VERBOSE[13690][C-00001cb2] pbx.c: Executing [*45283*369@from-internal:1] Set("SIP/283-00002d4c", "QUEUENO=369") in new stack

1087739[2021-10-19 17:03:19] VERBOSE[13690][C-00001cb2] pbx.c: Executing [*45283*369@from-internal:2] Set("SIP/283-00002d4c", "QUEUEUSER=283") in new stack

1087740[2021-10-19 17:03:19] VERBOSE[13690][C-00001cb2] pbx.c: Executing [*45283*369@from-internal:3] Goto("SIP/283-00002d4c", "app-queue-toggle,s,start") in new stack

1087741[2021-10-19 17:03:19] VERBOSE[13690][C-00001cb2] pbx_builtins.c: Goto (app-queue-toggle,s,1)

1087742[2021-10-19 17:03:19] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@app-queue-toggle:1] Answer("SIP/283-00002d4c", "") in new stack

1087743[2021-10-19 17:03:20] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@app-queue-toggle:2] Wait("SIP/283-00002d4c", "1") in new stack

1087744[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@app-queue-toggle:3] Macro("SIP/283-00002d4c", "user-callerid,") in new stack

1087745[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/283-00002d4c", "TOUCH_MONITOR=1634677399.32603") in new stack

1087746[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/283-00002d4c", "CHANCONTEXT=") in new stack

1087747[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:3] Set("SIP/283-00002d4c", "CHANCONTEXT=") in new stack

1087748[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:4] Set("SIP/283-00002d4c", "CHANEXTENCONTEXT=283-00002d4c") in new stack

1087749[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/283-00002d4c", "CHANEXTEN=283-00002d4c") in new stack

1087750[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:6] Set("SIP/283-00002d4c", "CALLERID(number)=283") in new stack

1087751[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:7] Set("SIP/283-00002d4c", "AMPUSER=283") in new stack

1087752[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:8] Set("SIP/283-00002d4c", "HOTDESCKCHAN=283-00002d4c") in new stack

1087753[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:9] Set("SIP/283-00002d4c", "HOTDESKEXTEN=283") in new stack

1087754[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/283-00002d4c", "HOTDESKCALL=0") in new stack

1087755[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:11] ExecIf("SIP/283-00002d4c", "0?Set(HOTDESKCALL=1)") in new stack

1087756[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:12] ExecIf("SIP/283-00002d4c", "0?Set(CALLERID(name)=)") in new stack

1087757[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("SIP/283-00002d4c", "0?report") in new stack

1087758[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("SIP/283-00002d4c", "1?Set(REALCALLERIDNUM=283)") in new stack

1087759[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:15] Set("SIP/283-00002d4c", "AMPUSER=283") in new stack

1087760[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("SIP/283-00002d4c", "0?limit") in new stack

1087761[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:17] Set("SIP/283-00002d4c", "AMPUSERCIDNAME=Stacey ") in new stack

1087762[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("SIP/283-00002d4c", "0?Set(__CIDMASQUERADING=TRUE)") in new stack

1087763[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:19] GotoIf("SIP/283-00002d4c", "0?report") in new stack

1087764[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:20] Set("SIP/283-00002d4c", "AMPUSERCID=283") in new stack

1087765[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:21] Set("SIP/283-00002d4c", "__DIAL_OPTIONS=HhTtr") in new stack

1087766[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:22] Set("SIP/283-00002d4c", "CALLERID(all)="Stacey " <283>") in new stack

1087767[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:23] ExecIf("SIP/283-00002d4c", "0?Set(CUSDIAL=)") in new stack

1087768[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:24] ExecIf("SIP/283-00002d4c", "0?Set(CALLERID(all)="Stacey " <283>)") in new stack

1087769[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:25] GotoIf("SIP/283-00002d4c", "0?limit") in new stack

1087770[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:26] ExecIf("SIP/283-00002d4c", "0?Set(GROUP(concurrency_limit)=283)") in new stack

1087771[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:27] ExecIf("SIP/283-00002d4c", "0?Set(CHANNEL(language)=)") in new stack

1087772[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:28] NoOp("SIP/283-00002d4c", "Macro Depth is 1") in new stack

1087773[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:29] GotoIf("SIP/283-00002d4c", "1?report2:macroerror") in new stack

1087774[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx_builtins.c: Goto (macro-user-callerid,s,30)

1087775[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("SIP/283-00002d4c", "0?continue") in new stack

1087776[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:31] ExecIf("SIP/283-00002d4c", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack

1087777[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:32] Set("SIP/283-00002d4c", "__TTL=64") in new stack

1087778[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:33] GotoIf("SIP/283-00002d4c", "1?continue") in new stack

1087779[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx_builtins.c: Goto (macro-user-callerid,s,49)

1087780[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:49] Set("SIP/283-00002d4c", "CALLERID(number)=283") in new stack

1087781[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:50] Set("SIP/283-00002d4c", "CALLERID(name)=Stacey ") in new stack

1087782[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:51] GotoIf("SIP/283-00002d4c", "0?cnum") in new stack

1087783[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:52] Set("SIP/283-00002d4c", "CDR(cnam)=Stacey ") in new stack

1087784[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:53] Set("SIP/283-00002d4c", "CDR(cnum)=283") in new stack

1087785[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:54] Set("SIP/283-00002d4c", "CHANNEL(language)=en") in new stack

1087786[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@app-queue-toggle:4] Set("SIP/283-00002d4c", "QUEUEUSER=283") in new stack

1087787[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@app-queue-toggle:5] Set("SIP/283-00002d4c", "QUEUESTAT=LOGGEDOUT") in new stack

1087788[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@app-queue-toggle:6] AGI("SIP/283-00002d4c", "agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283)") in new stack

1087789[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Initiating queue: 2001

1087790[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://queue_devstate.agi%2Cgetqueues%2C283/): Queue 2001 has no one logged in

1087791[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Initiating queue: 2002

1087792[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Agent 200 is static

1087793[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate..agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Agent 200 is assigned to queue 2002

1087794[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://queue_devstate.agi%2Cgetqueues%2C283/): Finished processing members for 2002

1087795[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Initiating queue: 360

1087796[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Queue 360 has no one logged in

1087797[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0..0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Initiating queue: 1

1087798[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Agent 354 is dynamic

1087799[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Agent 354 is assigned to queue 1

1087800[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Agent 283 is dynamic

1087801[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Agent 283 is assigned to queue 1

1087802[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Agent 239 is dynamic

1087803[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Agent 239 is assigned to queue 1

1087804[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Finished processing members for 1

1087805[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Finished parsing queues

1087806[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Getting Queue Status for user 283 in queue 369

1087807[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: agi://[127.0.0.1/queue_devstate.agi,getqueues,283](http://127.0.0.1/queue_devstate.agi,getqueues,283): Agent 283 is LOGGEDOUT

1087808[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] res_agi.c: <SIP/283-00002d4c>AGI Script agi://[127.0.0.1/queue_devstate.agi](http://127.0.0.1/queue_devstate.agi) completed, returning 0

1087809[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@app-queue-toggle:7] GotoIf("SIP/283-00002d4c", "1?activate") in new stack

1087810[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx_builtins.c: Goto (app-queue-toggle,s,16)

1087811[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@app-queue-toggle:16] NoOp("SIP/283-00002d4c", "Agent Logged In") in new stack

1087812[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@app-queue-toggle:17] Macro("SIP/283-00002d4c", "toggle-add-agent,") in new stack

1087813[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-toggle-add-agent:1] Macro("SIP/283-00002d4c", "user-callerid,SKIPTTL,") in new stack

1087814[2021-10-19 17:03:21] VERBOSE[13690][C-00001cb2] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/283-00002d4c", "TOUCH_MONITOR=1634677399.32603") in new stack

1087815[2021-10-19 17:03:21] VERBOSE[13690

I attempted to log ext 354 out of queue 369 twice here.

> freepbx*CLI> agi set debug on
> AGI Debugging Enabled
> [2021-11-03 17:01:08] WARNING[22667][C-00004fbe]: chan_sip.c:7619 sip_write: Can't send 10 type frames with SIP write
> AGI Tx >> agi_network: yes
> AGI Tx >> agi_network_script: queue_devstate.agi
> <SIP/205-000092ce>AGI Tx >> agi_request: agi://[127.0.0.1/queue_devstate.agi](http://127.0.0.1/queue_devstate.agi)
> <SIP/205-000092ce>AGI Tx >> agi_channel: SIP/205-000092ce
> <SIP/205-000092ce>AGI Tx >> agi_language: en
> <SIP/205-000092ce>AGI Tx >> agi_type: SIP
> <SIP/205-000092ce>AGI Tx >> agi_uniqueid: 1635973270.125835
> <SIP/205-000092ce>AGI Tx >> agi_version: 16.20.0
> <SIP/205-000092ce>AGI Tx >> agi_callerid: 205
> <SIP/205-000092ce>AGI Tx >> agi_calleridname: Greg Test
> <SIP/205-000092ce>AGI Tx >> agi_callingpres: 0
> <SIP/205-000092ce>AGI Tx >> agi_callingani2: 0
> <SIP/205-000092ce>AGI Tx >> agi_callington: 0
> <SIP/205-000092ce>AGI Tx >> agi_callingtns: 0
> <SIP/205-000092ce>AGI Tx >> agi_dnid: *45354*369
> <SIP/205-000092ce>AGI Tx >> agi_rdnis: unknown
> <SIP/205-000092ce>AGI Tx >> agi_context: app-queue-toggle
> <SIP/205-000092ce>AGI Tx >> agi_extension: s
> <SIP/205-000092ce>AGI Tx >> agi_priority: 6
> <SIP/205-000092ce>AGI Tx >> agi_enhanced: 0.0
> <SIP/205-000092ce>AGI Tx >> agi_accountcode:
> <SIP/205-000092ce>AGI Tx >> agi_threadid: 140349828605696
> <SIP/205-000092ce>AGI Tx >> agi_arg_1: getqueues
> <SIP/205-000092ce>AGI Tx >> agi_arg_2: 354
> <SIP/205-000092ce>AGI Tx >>
> <SIP/205-000092ce>AGI Rx << VERBOSE "Initiating queue: 2001" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Queue 2001 has no one logged in" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Initiating queue: 2002" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Agent 200 is static" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Agent 200 is assigned to queue 2002" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Finished processing members for 2002" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Initiating queue: 360" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Queue 360 has no one logged in" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Initiating queue: 1" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Agent 354 is dynamic" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Agent 354 is assigned to queue 1" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Agent 444 is dynamic" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Agent 444 is assigned to queue 1" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Agent 283 is dynamic" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Agent 283 is assigned to queue 1" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Agent 367 is dynamic" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Agent 367 is assigned to queue 1" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Finished processing members for 1" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Finished parsing queues" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << GET VARIABLE QUEUENO
> <SIP/205-000092ce>AGI Tx >> 200 result=1 (369)
> <SIP/205-000092ce>AGI Rx << VERBOSE "Getting Queue Status for user 354 in queue 369" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << VERBOSE "Agent 354 is LOGGEDOUT" 3
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Rx << SET VARIABLE QUEUESTAT "LOGGEDOUT"
> <SIP/205-000092ce>AGI Tx >> 200 result=1
> <SIP/205-000092ce>AGI Tx >> HANGUP
> [2021-11-03 17:01:11] WARNING[22951][C-00004fc0]: app_queue.c:8208 aqm_exec: Unable to add interface 'Local/354@from-queue/n' to queue '369': Already there
> [2021-11-03 17:01:11] WARNING[22667][C-00004fbe]: chan_sip.c:7619 sip_write: Can't send 10 type frames with SIP write
> [2021-11-03 17:01:14] WARNING[22667][C-00004fbe]: chan_sip.c:7619 sip_write: Can't send 10 type frames with SIP write
> [2021-11-03 17:01:18] WARNING[22667][C-00004fbe]: chan_sip.c:7619 sip_write: Can't send 10 type frames with SIP write
> [2021-11-03 17:01:19] WARNING[22667][C-00004fbe]: chan_sip.c:7619 sip_write: Can't send 10 type frames with SIP write
> AGI Tx >> agi_network: yes
> AGI Tx >> agi_network_script: queue_devstate.agi
> <SIP/205-000092cf>AGI Tx >> agi_request: agi://[127.0.0.1/queue_devstate.agi](http://127.0.0.1/queue_devstate.agi)
> <SIP/205-000092cf>AGI Tx >> agi_channel: SIP/205-000092cf
> <SIP/205-000092cf>AGI Tx >> agi_language: en
> <SIP/205-000092cf>AGI Tx >> agi_type: SIP
> <SIP/205-000092cf>AGI Tx >> agi_uniqueid: 1635973278.125836
> <SIP/205-000092cf>AGI Tx >> agi_version: 16.20.0
> <SIP/205-000092cf>AGI Tx >> agi_callerid: 205
> <SIP/205-000092cf>AGI Tx >> agi_calleridname: Greg Test
> <SIP/205-000092cf>AGI Tx >> agi_callingpres: 0
> <SIP/205-000092cf>AGI Tx >> agi_callingani2: 0
> <SIP/205-000092cf>AGI Tx >> agi_callington: 0
> <SIP/205-000092cf>AGI Tx >> agi_callingtns: 0
> <SIP/205-000092cf>AGI Tx >> agi_dnid: *45354*369
> <SIP/205-000092cf>AGI Tx >> agi_rdnis: unknown
> <SIP/205-000092cf>AGI Tx >> agi_context: app-queue-toggle
> <SIP/205-000092cf>AGI Tx >> agi_extension: s
> <SIP/205-000092cf>AGI Tx >> agi_priority: 6
> <SIP/205-000092cf>AGI Tx >> agi_enhanced: 0.0
> <SIP/205-000092cf>AGI Tx >> agi_accountcode:
> <SIP/205-000092cf>AGI Tx >> agi_threadid: 140349838333696
> <SIP/205-000092cf>AGI Tx >> agi_arg_1: getqueues
> <SIP/205-000092cf>AGI Tx >> agi_arg_2: 354
> <SIP/205-000092cf>AGI Tx >>
> [2021-11-03 17:01:19] WARNING[22667][C-00004fbe]: chan_sip.c:7619 sip_write: Can't send 10 type frames with SIP write
> <SIP/205-000092cf>AGI Rx << VERBOSE "Initiating queue: 2001" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Queue 2001 has no one logged in" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Initiating queue: 2002" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Agent 200 is static" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Agent 200 is assigned to queue 2002" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Finished processing members for 2002" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Initiating queue: 360" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Queue 360 has no one logged in" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Initiating queue: 1" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Agent 354 is dynamic" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Agent 354 is assigned to queue 1" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Agent 444 is dynamic" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Agent 444 is assigned to queue 1" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Agent 283 is dynamic" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Agent 283 is assigned to queue 1" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Agent 367 is dynamic" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Agent 367 is assigned to queue 1" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Finished processing members for 1" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Finished parsing queues" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << GET VARIABLE QUEUENO
> <SIP/205-000092cf>AGI Tx >> 200 result=1 (369)
> <SIP/205-000092cf>AGI Rx << VERBOSE "Getting Queue Status for user 354 in queue 369" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << VERBOSE "Agent 354 is LOGGEDOUT" 3
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Rx << SET VARIABLE QUEUESTAT "LOGGEDOUT"
> <SIP/205-000092cf>AGI Tx >> 200 result=1
> <SIP/205-000092cf>AGI Tx >> HANGUP

Any help would be much appreciated!
Thanks

2

Has anyone seen this before?

3

This topic was automatically closed 31 days after the last reply. New replies are no longer allowed.