[2017-01-16 14:55:36] Asterisk 13.13.1 built by root @ asterisk-boot on a x86_64 running Linux on 2016-12-19 21:59:47 UTC [2017-01-16 14:55:36] DEBUG[18318] config.c: Parsing /etc/asterisk/logger.conf [2017-01-16 14:55:36] VERBOSE[18318] config.c: Parsing '/etc/asterisk/logger.conf': Found [2017-01-16 14:55:36] VERBOSE[18318] logger.c: Asterisk Queue Logger restarted [2017-01-16 14:55:40] DEBUG[18374] tcptls.c: TCP timeout reading data [2017-01-16 14:55:40] DEBUG[18374] http.c: HTTP idle timeout or peer closed connection. [2017-01-16 14:55:40] DEBUG[18374] http.c: HTTP closing session. Top level [2017-01-16 14:55:45] DEBUG[18380] threadpool.c: Worker thread idle timeout reached. Dying. [2017-01-16 14:55:45] DEBUG[18285] threadpool.c: Destroying worker thread 15 [2017-01-16 14:55:45] DEBUG[18355] threadpool.c: Worker thread idle timeout reached. Dying. [2017-01-16 14:55:45] DEBUG[18285] threadpool.c: Destroying worker thread 13 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP opening session. Top level [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/resources.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/resources.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/resources.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/resources.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(resources.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2012 - 2013, Digium, Inc.", "_author": "David M. Lee, II ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.1", "basePath": "http://1.1.1.115:8088/ari", "apis": [ { "path": "/api-docs/asterisk.{format}", "description": "Asterisk resources" }, { "path": "/api-docs/endpoints.{format}", "description": "Endpoint resources" }, { "path": "/api-docs/channels.{format}", "description": "Channel resources" }, { "path": "/api-docs/bridges.{format}", "description": "Bridge resources" }, { "path": "/api-docs/recordings.{format}", "description": "Recording resources" }, { "path": "/api-docs/sounds.{format}", "description": "Sound resources" }, { "path": "/api-docs/playbacks.{format}", "description": "Playback control resources" }, { "path": "/api-docs/deviceStates.{format}", "description": "Device state resources" }, { "path": "/api-docs/mailboxes.{format}", "description": "Mailboxes resources" }, { "path": "/api-docs/events.{format}", "description": "WebSocket resource" }, { "path": "/api-docs/applications.{format}", "description": "Stasis application resources" } ] } [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/asterisk.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/asterisk.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/asterisk.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/asterisk.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(asterisk.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2012 - 2013, Digium, Inc.", "_author": "David M. Lee, II ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.1", "basePath": "http://1.1.1.115:8088/ari", "resourcePath": "/api-docs/asterisk.{format}", "apis": [ { "path": "/asterisk/config/dynamic/{configClass}/{objectType}/{id}", "description": "Asterisk dynamic configuration", "operations": [ { "httpMethod": "GET", "summary": "Retrieve a dynamic configuration object.", "nickname": "getObject", "responseClass": "List[ConfigTuple]", "parameters": [ { "name": "configClass", "description": "The configuration class containing dynamic configuration objects.", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "objectType", "description": "The type of configuration object to retrieve.", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "id", "description": "The unique identifier of the object to retrieve.", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "{configClass|objectType|id} not found" } ] }, { "httpMethod": "PUT", "summary": "Create or update a dynamic configuration object.", "nickname": "updateObject", "responseClass": "List[ConfigTuple]", "parameters": [ { "name": "configClass", "description": "The configuration class containing dynamic configuration objects.", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "objectType", "description": "The type of configuration object to create or update.", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "id", "description": "The unique identifier of the object to create or update.", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "fields", "description": "The body object should have a value that is a list of ConfigTuples, which provide the fields to update. Ex. [ { \"attribute\": \"directmedia\", \"value\": \"false\" } ]", "paramType": "body", "required": false, "dataType": "containers", "allowMultiple": false } ], "errorResponses": [ { "code": 400, "reason": "Bad request body" }, { "code": 403, "reason": "Could not create or update object" }, { "code": 404, "reason": "{configClass|objectType} not found" } ] }, { "httpMethod": "DELETE", "summary": "Delete a dynamic configuration object.", "nickname": "deleteObject", "responseClass": "void", "parameters": [ { "name": "configClass", "description": "The configuration class containing dynamic configuration objects.", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "objectType", "description": "The type of configuration object to delete.", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "id", "description": "The unique identifier of the object to delete.", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 403, "reason": "Could not delete object" }, { "code": 404, "reason": "{configClass|objectType|id} not found" } ] } ] }, { "path": "/asterisk/info", "description": "Asterisk system information (similar to core show settings)", "operations": [ { "httpMethod": "GET", "summary": "Gets Asterisk system information.", "nickname": "getInfo", "responseClass": "AsteriskInfo", "parameters": [ { "name": "only", "description": "Filter information returned", "paramType": "query", "required": false, "allowMultiple": true, "dataType": "string", "allowableValues": { "valueType": "LIST", "values": [ "build", "system", "config", "status" ] } } ] } ] }, { "path": "/asterisk/modules", "description": "Asterisk modules", "operations": [ { "httpMethod": "GET", "summary": "List Asterisk modules.", "nickname": "listModules", "responseClass": "List[Module]" } ] }, { "path": "/asterisk/modules/{moduleName}", "description": "Asterisk module", "operations": [ { "httpMethod": "GET", "summary": "Get Asterisk module information.", "nickname": "getModule", "responseClass": "Module", "parameters": [ { "name": "moduleName", "description": "Module's name", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Module could not be found in running modules." }, { "code": 409, "reason": "Module information could not be retrieved." } ] }, { "httpMethod": "POST", "summary": "Load an Asterisk module.", "nickname": "loadModule", "responseClass": "void", "parameters": [ { "name": "moduleName", "description": "Module's name", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 409, "reason": "Module could not be loaded." } ] }, { "httpMethod": "DELETE", "summary": "Unload an Asterisk module.", "nickname": "unloadModule", "responseClass": "void", "parameters": [ { "name": "moduleName", "description": "Module's name", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }[2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/endpoints.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/endpoints.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/endpoints.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/endpoints.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(endpoints.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2012 - 2013, Digium, Inc.", "_author": "David M. Lee, II ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.1", "basePath": "http://1.1.1.115:8088/ari", "resourcePath": "/api-docs/endpoints.{format}", "apis": [ { "path": "/endpoints", "description": "Asterisk endpoints", "operations": [ { "httpMethod": "GET", "summary": "List all endpoints.", "nickname": "list", "responseClass": "List[Endpoint]" } ] }, { "path": "/endpoints/sendMessage", "description": "Send a message to some technology URI or endpoint.", "operations": [ { "httpMethod": "PUT", "summary": "Send a message to some technology URI or endpoint.", "nickname": "sendMessage", "responseClass": "void", "parameters": [ { "name": "to", "description": "The endpoint resource or technology specific URI to send the message to. Valid resources are sip, pjsip, and xmpp.", "paramType": "query", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "from", "description": "The endpoint resource or technology specific identity to send this message from. Valid resources are sip, pjsip, and xmpp.", "paramType": "query", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "body", "description": "The body of the message", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "variables", "descriptioni": "The \"variables\" key in the body object holds technology specific key/value pairs to append to the message. These can be interpreted and used by the various resource types; for example, pjsip and sip resource types will add the key/value pairs as SIP headers,", "paramType": "body", "required": false, "dataType": "containers", "allowMultiple": false } ], "errorResponses": [ { "code": 400, "reason": "Invalid parameters for sending a message." }, { "code": 404, "reason": "Endpoint not found" } ] } ] }, { "path": "/endpoints/{tech}", "description": "Asterisk endpoints", "operations": [ { "httpMethod": "GET", "summary": "List available endoints for a given endpoint technology.", "nickname": "listByTech", "responseClass": "List[Endpoint]", "parameters": [ { "name": "tech", "description": "Technology of the endpoints (sip,iax2,...)", "paramType": "path", "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Endpoints not found" } ] } ] }, { "path": "/endpoints/{tech}/{resource}", "description": "Single endpoint", "operations": [ { "httpMethod": "GET", "summary": "Details for an endpoint.", "nickname": "get", "responseClass": "Endpoint", "parameters": [ { "name": "tech", "description": "Technology of the endpoint", "paramType": "path", "dataType": "string" }, { "name": "resource", "description": "ID of the endpoint", "paramType": "path", "dataType": "string" } ], "errorResponses": [ { "code": 400, "reason": "Invalid parameters for sending a message." }, { "code": 404, "reason": "Endpoints not found" } ] } ] }, { "path": "/endpoints/{tech}/{resource}/sendMessage", "description": "Send a message to some endpoint in a technology.", "operations": [ { "httpMethod": "PUT", "summary": "Send a message to some endpoint in a technology.", "nickname": "sendMessageToEndpoint", "responseClass": "void", "parameters": [ { "name": "tech", "description": "Technology of the endpoint", "paramType": "path", "dataType": "string" }, { "name": "resource", "description": "ID of the endpoint", "paramType": "path", "dataType": "string" }, { "name": "from", "description": "The endpoint resource or technology specific identity to send this message from. Valid resources are sip, pjsip, and xmpp.", "paramType": "query", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "body", "description": "The body of the message", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "variables", "descriptioni": "The \"variables\" key in the body object holds technology specific key/value pairs to append to the message. These can be interpreted and used by the various resource types; for example, pjsip and sip resource types will add the key/value pairs as SIP headers,", "paramType": "body", "required": false, "dataType": "containers", "allowMultiple": false } ], "errorResponses": [ { "code": 400, "reason": "Invalid parameters for sending a message." }, { "code": 404, "reason": "Endpoint not found" } ] } ] } ], "models": { "Endpoint": { "id": "Endpoint", "description": "An external device that may offer/accept calls to/from Asterisk.\n\nUnlike most resources, which have a single unique identifier, an endpoint is uniquely identified by the technology/resource pair.", "properties": { "technology": { "type": "string", "description": "Technology of the endpoint", "required": true }, "resource": { "type": "string", "description": "Identifier of the endpoint, specific to the given technology.", "required": true }, "state": { "type": "string", "description": "Endpoint's state", "required": false, "allowableValues": { "valueType": "LIST", "values": [ "unknown", "offline", "online" ] } }, "channel_ids": { "type": "List[string]", "description": "Id's of channels associated with this endpoint", "required": true } } }, "TextMessageVariable": { "id": "TextMessageVariable", "description": "A key/value pair variable in a text message.", "properties": { "key": { "type": "string", "description": "A unique key identifying the variable.", "required": true }, "value": { "type": "string", "description": "The value of the variable.", "re[2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/channels.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/channels.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/channels.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/channels.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(channels.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2012 - 2013, Digium, Inc.", "_author": "David M. Lee, II ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.1", "basePath": "http://1.1.1.115:8088/ari", "resourcePath": "/api-docs/channels.{format}", "apis": [ { "path": "/channels", "description": "Active channels", "operations": [ { "httpMethod": "GET", "summary": "List all active channels in Asterisk.", "nickname": "list", "responseClass": "List[Channel]" }, { "httpMethod": "POST", "summary": "Create a new channel (originate).", "notes": "The new channel is created immediately and a snapshot of it returned. If a Stasis application is provided it will be automatically subscribed to the originated channel for further events and updates.", "nickname": "originate", "responseClass": "Channel", "parameters": [ { "name": "endpoint", "description": "Endpoint to call.", "paramType": "query", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "extension", "description": "The extension to dial after the endpoint answers. Mutually exclusive with 'app'.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "context", "description": "The context to dial after the endpoint answers. If omitted, uses 'default'. Mutually exclusive with 'app'.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "priority", "description": "The priority to dial after the endpoint answers. If omitted, uses 1. Mutually exclusive with 'app'.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "long" }, { "name": "label", "description": "The label to dial after the endpoint answers. Will supersede 'priority' if provided. Mutually exclusive with 'app'.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "app", "description": "The application that is subscribed to the originated channel. When the channel is answered, it will be passed to this Stasis application. Mutually exclusive with 'context', 'extension', 'priority', and 'label'.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "appArgs", "description": "The application arguments to pass to the Stasis application provided by 'app'. Mutually exclusive with 'context', 'extension', 'priority', and 'label'.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "callerId", "description": "CallerID to use when dialing the endpoint or extension.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "timeout", "description": "Timeout (in seconds) before giving up dialing, or -1 for no timeout.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "int", "defaultValue": 30 }, { "name": "variables", "description": "The \"variables\" key in the body object holds variable key/value pairs to set on the channel on creation. Other keys in the body object are interpreted as query parameters. Ex. { \"endpoint\": \"SIP/Alice\", \"variables\": { \"CALLERID(name)\": \"Alice\" } }", "paramType": "body", "required": false, "dataType": "containers", "allowMultiple": false }, { "name": "channelId", "description": "The unique id to assign the channel on creation.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "otherChannelId", "description": "The unique id to assign the second channel when using local channels.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "originator", "description": "The unique id of the channel which is originating this one.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "formats", "description": "The format name capability list to use if originator is not specified. Ex. \"ulaw,slin16\". Format names can be found with \"core show codecs\".", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 400, "reason": "Invalid parameters for originating a channel." }, { "code": 409, "reason": "Channel with given unique ID already exists." } ] } ] }, { "path": "/channels/{channelId}", "description": "Active channel", "operations": [ { "httpMethod": "GET", "summary": "Channel details.", "nickname": "get", "responseClass": "Channel", "parameters": [ { "name": "channelId", "description": "Channel's id", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Channel not found" } ] }, { "httpMethod": "POST", "summary": "Create a new channel (originate with id).", "notes": "The new channel is created immediately and a snapshot of it returned. If a Stasis application is provided it will be automatically subscribed to the originated channel for further events and updates.", "nickname": "originateWithId", "responseClass": "Channel", "parameters": [ { "name": "channelId", "description": "The unique id to assign the channel on creation.", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "endpoint", "description": "Endpoint to call.", "paramType": "query", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "extension", "description": "The extension to dial after the endpoint answers. Mutually exclusive with 'app'.", "paramType": "query", "required": false, "allowMultiple": false, [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/bridges.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/bridges.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/bridges.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/bridges.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(bridges.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2012 - 2013, Digium, Inc.", "_author": "David M. Lee, II ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.1", "basePath": "http://1.1.1.115:8088/ari", "resourcePath": "/api-docs/bridges.{format}", "apis": [ { "path": "/bridges", "description": "Active bridges", "operations": [ { "httpMethod": "GET", "summary": "List all active bridges in Asterisk.", "nickname": "list", "responseClass": "List[Bridge]" }, { "httpMethod": "POST", "summary": "Create a new bridge.", "notes": "This bridge persists until it has been shut down, or Asterisk has been shut down.", "nickname": "create", "responseClass": "Bridge", "parameters": [ { "name": "type", "description": "Comma separated list of bridge type attributes (mixing, holding, dtmf_events, proxy_media).", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "bridgeId", "description": "Unique ID to give to the bridge being created.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "name", "description": "Name to give to the bridge being created.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" } ] } ] }, { "path": "/bridges/{bridgeId}", "description": "Individual bridge", "operations": [ { "httpMethod": "POST", "summary": "Create a new bridge or updates an existing one.", "notes": "This bridge persists until it has been shut down, or Asterisk has been shut down.", "nickname": "createWithId", "responseClass": "Bridge", "parameters": [ { "name": "type", "description": "Comma separated list of bridge type attributes (mixing, holding, dtmf_events, proxy_media) to set.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" }, { "name": "bridgeId", "description": "Unique ID to give to the bridge being created.", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "name", "description": "Set the name of the bridge.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" } ] }, { "httpMethod": "GET", "summary": "Get bridge details.", "nickname": "get", "responseClass": "Bridge", "parameters": [ { "name": "bridgeId", "description": "Bridge's id", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Bridge not found" } ] }, { "httpMethod": "DELETE", "summary": "Shut down a bridge.", "notes": "If any channels are in this bridge, they will be removed and resume whatever they were doing beforehand.", "nickname": "destroy", "responseClass": "void", "parameters": [ { "name": "bridgeId", "description": "Bridge's id", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Bridge not found" } ] } ] }, { "path": "/bridges/{bridgeId}/addChannel", "description": "Add a channel to a bridge", "operations": [ { "httpMethod": "POST", "summary": "Add a channel to a bridge.", "nickname": "addChannel", "responseClass": "void", "parameters": [ { "name": "bridgeId", "description": "Bridge's id", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "channel", "description": "Ids of channels to add to bridge", "paramType": "query", "required": true, "allowMultiple": true, "dataType": "string" }, { "name": "role", "description": "Channel's role in the bridge", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 400, "reason": "Channel not found" }, { "code": 404, "reason": "Bridge not found" }, { "code": 409, "reason": "Bridge not in Stasis application; Channel currently recording" }, { "code": 422, "reason": "Channel not in Stasis application" } ] } ] }, { "path": "/bridges/{bridgeId}/removeChannel", "description": "Remove a channel from a bridge", "operations": [ { "httpMethod": "POST", "summary": "Remove a channel from a bridge.", "nickname": "removeChannel", "responseClass": "void", "parameters": [ { "name": "bridgeId", "description": "Bridge's id", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "channel", "description": "Ids of channels to remove from bridge", "paramType": "query", "required": true, "allowMultiple": true, "dataType": "string" } ], "errorResponses": [ { "code": 400, "reason": "Channel not found" }, { "code": 404, "reason": "Bridge not found" }, { "code": 409, "reason": "Bridge not in Stasis application" }, { "code": 422, "reason": "Channel not in this bridge" } ] } ] }, { "path": "/bridges/{bridgeId}/videoSource/{channelId}", "description": "Set a channel as the video source in a multi-party bridge", "operations": [ { "httpMethod": "POST", "summary": "Set a channel as the video source in a multi-party mixing bridge. This operation has no effect on bridges with two or fewer participants.", "nickname": "setVideoSource", "responseClass": "void", "parameters": [ { "name": "bridgeId", "description": "Bridge's id", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/recordings.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/recordings.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/recordings.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/recordings.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(recordings.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2012 - 2013, Digium, Inc.", "_author": "David M. Lee, II ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.1", "basePath": "http://1.1.1.115:8088/ari", "resourcePath": "/api-docs/recordings.{format}", "apis": [ { "path": "/recordings/stored", "description": "Recordings", "operations": [ { "httpMethod": "GET", "summary": "List recordings that are complete.", "nickname": "listStored", "responseClass": "List[StoredRecording]" } ] }, { "path": "/recordings/stored/{recordingName}", "description": "Individual recording", "operations": [ { "httpMethod": "GET", "summary": "Get a stored recording's details.", "nickname": "getStored", "responseClass": "StoredRecording", "parameters": [ { "name": "recordingName", "description": "The name of the recording", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Recording not found" } ] }, { "httpMethod": "DELETE", "summary": "Delete a stored recording.", "nickname": "deleteStored", "responseClass": "void", "parameters": [ { "name": "recordingName", "description": "The name of the recording", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Recording not found" } ] } ] }, { "path": "/recordings/stored/{recordingName}/copy", "description": "Copy an individual recording", "operations": [ { "httpMethod": "POST", "summary": "Copy a stored recording.", "nickname": "copyStored", "responseClass": "StoredRecording", "parameters": [ { "name": "recordingName", "description": "The name of the recording to copy", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "destinationRecordingName", "description": "The destination name of the recording", "paramType": "query", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Recording not found" }, { "code": 409, "reason": "A recording with the same name already exists on the system" } ] } ] }, { "path": "/recordings/live/{recordingName}", "description": "A recording that is in progress", "operations": [ { "httpMethod": "GET", "summary": "List live recordings.", "nickname": "getLive", "responseClass": "LiveRecording", "parameters": [ { "name": "recordingName", "description": "The name of the recording", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Recording not found" } ] }, { "httpMethod": "DELETE", "summary": "Stop a live recording and discard it.", "nickname": "cancel", "responseClass": "void", "parameters": [ { "name": "recordingName", "description": "The name of the recording", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Recording not found" } ] } ] }, { "path": "/recordings/live/{recordingName}/stop", "operations": [ { "httpMethod": "POST", "summary": "Stop a live recording and store it.", "nickname": "stop", "responseClass": "void", "parameters": [ { "name": "recordingName", "description": "The name of the recording", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Recording not found" } ] } ] }, { "path": "/recordings/live/{recordingName}/pause", "operations": [ { "httpMethod": "POST", "summary": "Pause a live recording.", "notes": "Pausing a recording suspends silence detection, which will be restarted when the recording is unpaused. Paused time is not included in the accounting for maxDurationSeconds.", "nickname": "pause", "responseClass": "void", "parameters": [ { "name": "recordingName", "description": "The name of the recording", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Recording not found" }, { "code": 409, "reason": "Recording not in session" } ] }, { "httpMethod": "DELETE", "summary": "Unpause a live recording.", "nickname": "unpause", "responseClass": "void", "parameters": [ { "name": "recordingName", "description": "The name of the recording", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Recording not found" }, { "code": 409, "reason": "Recording not in session" } ] } ] }, { "path": "/recordings/live/{recordingName}/mute", "operations": [ { "httpMethod": "POST", "summary": "Mute a live recording.", "notes": "Muting a recording suspends silence detection, which will be restarted when the recording is unmuted.", "nickname": "mute", "responseClass": "void", "parameters": [ { "name": "recordingName", "description": "The name of the recording", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Recording not found" }, { "code": 409, "reason": "Recording not in session" } ] }, { "httpMethod": "DELETE", "summary": "Unmute a live recording.[2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/sounds.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/sounds.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/sounds.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/sounds.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(sounds.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2012 - 2013, Digium, Inc.", "_author": "David M. Lee, II ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.1", "basePath": "http://1.1.1.115:8088/ari", "resourcePath": "/api-docs/sounds.{format}", "apis": [ { "path": "/sounds", "description": "Sounds", "operations": [ { "httpMethod": "GET", "summary": "List all sounds.", "nickname": "list", "responseClass": "List[Sound]", "parameters": [ { "name": "lang", "description": "Lookup sound for a specific language.", "paramType": "query", "dataType": "string", "required": false }, { "name": "format", "description": "Lookup sound in a specific format.", "paramType": "query", "dataType": "string", "required": false, "__note": "core show translation can show translation paths between formats, along with relative costs. so this could be just installed format, or we could follow that for transcoded formats." } ] } ] }, { "path": "/sounds/{soundId}", "description": "Individual sound", "operations": [ { "httpMethod": "GET", "summary": "Get a sound's details.", "nickname": "get", "responseClass": "Sound", "parameters": [ { "name": "soundId", "description": "Sound's id", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ] } ] } ], "models": { "FormatLangPair": { "id": "FormatLangPair", "description": "Identifies the format and language of a sound file", "properties": { "language": { "required": true, "type": "string" }, "format": { "required": true, "type": "string" } } }, "Sound": { "id": "Sound", "description": "A media file that may be played back.", "properties": { "id": { "required": true, "description": "Sound's identifier.", "type": "string" }, "text": { "required": false, "description": "Text description of the sound, usually the words spoken.", "type": "string" }, "formats": { "required": true, "description": "The formats and languages in which this sound is available.", "type": "List[FormatLangPair]" } } } } } [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/playbacks.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/playbacks.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/playbacks.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/playbacks.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(playbacks.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2012 - 2013, Digium, Inc.", "_author": "David M. Lee, II ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.1", "basePath": "http://1.1.1.115:8088/ari", "resourcePath": "/api-docs/playbacks.{format}", "apis": [ { "path": "/playbacks/{playbackId}", "description": "Control object for a playback operation.", "operations": [ { "httpMethod": "GET", "summary": "Get a playback's details.", "nickname": "get", "responseClass": "Playback", "parameters": [ { "name": "playbackId", "description": "Playback's id", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "The playback cannot be found" } ] }, { "httpMethod": "DELETE", "summary": "Stop a playback.", "nickname": "stop", "responseClass": "void", "parameters": [ { "name": "playbackId", "description": "Playback's id", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "The playback cannot be found" } ] } ] }, { "path": "/playbacks/{playbackId}/control", "description": "Control object for a playback operation.", "operations": [ { "httpMethod": "POST", "summary": "Control a playback.", "nickname": "control", "responseClass": "void", "parameters": [ { "name": "playbackId", "description": "Playback's id", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "operation", "description": "Operation to perform on the playback.", "paramType": "query", "required": true, "allowMultiple": false, "dataType": "string", "allowableValues": { "valueType": "LIST", "values": [ "restart", "pause", "unpause", "reverse", "forward" ] } } ], "errorResponses": [ { "code": 400, "reason": "The provided operation parameter was invalid" }, { "code": 404, "reason": "The playback cannot be found" }, { "code": 409, "reason": "The operation cannot be performed in the playback's current state" } ] } ] } ], "models": { "Playback": { "id": "Playback", "description": "Object representing the playback of media to a channel", "properties": { "id": { "type": "string", "description": "ID for this playback operation", "required": true }, "media_uri": { "type": "string", "description": "URI for the media to play back.", "required": true }, "target_uri": { "type": "string", "description": "URI for the channel or bridge to play the media on", "required": true }, "language": { "type": "string", "description": "For media types that support multiple languages, the language requested for playback." }, "state": { "type": "string", "description": "Current state of the playback operation.", "required": true, "allowableValues": { "valueType": "LIST", "values": [ "queued", "playing", "complete" ] } } } } } } [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/deviceStates.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/deviceStates.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/deviceStates.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/deviceStates.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(deviceStates.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2012 - 2013, Digium, Inc.", "_author": "Kevin Harwell ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.1", "basePath": "http://1.1.1.115:8088/ari", "resourcePath": "/api-docs/deviceStates.{format}", "apis": [ { "path": "/deviceStates", "description": "Device states", "operations": [ { "httpMethod": "GET", "summary": "List all ARI controlled device states.", "nickname": "list", "responseClass": "List[DeviceState]" } ] }, { "path": "/deviceStates/{deviceName}", "description": "Device state", "operations": [ { "httpMethod": "GET", "summary": "Retrieve the current state of a device.", "nickname": "get", "responseClass": "DeviceState", "parameters": [ { "name": "deviceName", "description": "Name of the device", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ] }, { "httpMethod": "PUT", "summary": "Change the state of a device controlled by ARI. (Note - implicitly creates the device state).", "nickname": "update", "responseClass": "void", "parameters": [ { "name": "deviceName", "description": "Name of the device", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "deviceState", "description": "Device state value", "paramType": "query", "required": true, "allowMultiple": false, "dataType": "string", "allowableValues": { "valueType": "LIST", "values": [ "NOT_INUSE", "INUSE", "BUSY", "INVALID", "UNAVAILABLE", "RINGING", "RINGINUSE", "ONHOLD" ] } } ], "errorResponses": [ { "code": 404, "reason": "Device name is missing" }, { "code": 409, "reason": "Uncontrolled device specified" } ] }, { "httpMethod": "DELETE", "summary": "Destroy a device-state controlled by ARI.", "nickname": "delete", "responseClass": "void", "parameters": [ { "name": "deviceName", "description": "Name of the device", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Device name is missing" }, { "code": 409, "reason": "Uncontrolled device specified" } ] } ] } ], "models": { "DeviceState": { "id": "DeviceState", "description": "Represents the state of a device.", "properties": { "name": { "type": "string", "description": "Name of the device.", "required": true }, "state": { "type": "string", "description": "Device's state", "required": true, "allowableValues": { "valueType": "LIST", "values": [ "UNKNOWN", "NOT_INUSE", "INUSE", "BUSY", "INVALID", "UNAVAILABLE", "RINGING", "RINGINUSE", "ONHOLD" ] } } } } } } [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/mailboxes.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/mailboxes.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/mailboxes.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/mailboxes.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(mailboxes.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2013, Digium, Inc.", "_author": "Jonathan Rose ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.1", "basePath": "http://1.1.1.115:8088/ari", "resourcePath": "/api-docs/mailboxes.{format}", "apis": [ { "path": "/mailboxes", "description": "Mailboxes", "operations": [ { "httpMethod": "GET", "summary": "List all mailboxes.", "nickname": "list", "responseClass": "List[Mailbox]" } ] }, { "path": "/mailboxes/{mailboxName}", "description": "Mailbox state", "operations": [ { "httpMethod": "GET", "summary": "Retrieve the current state of a mailbox.", "nickname": "get", "responseClass": "Mailbox", "parameters": [ { "name": "mailboxName", "description": "Name of the mailbox", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Mailbox not found" } ] }, { "httpMethod": "PUT", "summary": "Change the state of a mailbox. (Note - implicitly creates the mailbox).", "nickname": "update", "responseClass": "void", "parameters": [ { "name": "mailboxName", "description": "Name of the mailbox", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "oldMessages", "description": "Count of old messages in the mailbox", "paramType": "query", "required": true, "allowMultiple": false, "dataType": "int" }, { "name": "newMessages", "description": "Count of new messages in the mailbox", "paramType": "query", "required": true, "allowMultiple": false, "dataType": "int" } ], "errorResponses": [ { "code": 404, "reason": "Mailbox not found" } ] }, { "httpMethod": "DELETE", "summary": "Destroy a mailbox.", "nickname": "delete", "responseClass": "void", "parameters": [ { "name": "mailboxName", "description": "Name of the mailbox", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Mailbox not found" } ] } ] } ], "models": { "Mailbox": { "id": "Mailbox", "description": "Represents the state of a mailbox.", "properties": { "name": { "type": "string", "description": "Name of the mailbox.", "required": true }, "old_messages": { "type": "int", "description": "Count of old messages in the mailbox.", "required": true }, "new_messages": { "type": "int", "description": "Count of new messages in the mailbox.", "required": true } } } } } [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/events.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/events.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/events.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/events.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(events.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2012 - 2013, Digium, Inc.", "_author": "David M. Lee, II ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.2", "basePath": "http://1.1.1.115:8088/ari", "resourcePath": "/api-docs/events.{format}", "apis": [ { "path": "/events", "description": "Events from Asterisk to applications", "operations": [ { "httpMethod": "GET", "upgrade": "websocket", "websocketProtocol": "ari", "summary": "WebSocket connection for events.", "nickname": "eventWebsocket", "responseClass": "Message", "parameters": [ { "name": "app", "description": "Applications to subscribe to.", "paramType": "query", "required": true, "allowMultiple": true, "dataType": "string" }, { "name": "subscribeAll", "description": "Subscribe to all Asterisk events. If provided, the applications listed will be subscribed to all events, effectively disabling the application specific subscriptions. Default is 'false'.", "paramType": "query", "required": false, "allowMultiple": false, "dataType": "boolean" } ] } ] }, { "path": "/events/user/{eventName}", "description": "Stasis application user events", "operations": [ { "httpMethod": "POST", "summary": "Generate a user event.", "nickname": "userEvent", "responseClass": "void", "parameters": [ { "name": "eventName", "description": "Event name", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "application", "description": "The name of the application that will receive this event", "paramType": "query", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "source", "description": "URI for event source (channel:{channelId}, bridge:{bridgeId}, endpoint:{tech}/{resource}, deviceState:{deviceName}", "paramType": "query", "required": false, "allowMultiple": true, "dataType": "string" }, { "name": "variables", "description": "The \"variables\" key in the body object holds custom key/value pairs to add to the user event. Ex. { \"variables\": { \"key\": \"value\" } }", "paramType": "body", "required": false, "allowMultiple": false, "dataType": "containers" } ], "errorResponses": [ { "code": 404, "reason": "Application does not exist." }, { "code": 422, "reason": "Event source not found." }, { "code": 400, "reason": "Invalid even tsource URI or userevent data." } ] } ] } ], "models": { "Message": { "id": "Message", "description": "Base type for errors and events", "discriminator": "type", "properties": { "type": { "type": "string", "required": true, "description": "Indicates the type of this message." }, "asterisk_id": { "type": "string", "required": false, "description": "The unique ID for the Asterisk instance that raised this event." } }, "subTypes": [ "MissingParams", "Event" ] }, "MissingParams": { "id": "MissingParams", "description": "Error event sent when required params are missing.", "properties": { "params": { "required": true, "type": "List[string]", "description": "A list of the missing parameters" } } }, "Event": { "id": "Event", "description": "Base type for asynchronous events from Asterisk.", "properties": { "application": { "type": "string", "description": "Name of the application receiving the event.", "required": true }, "timestamp": { "type": "Date", "description": "Time at which this event was created.", "required": false } }, "subTypes": [ "DeviceStateChanged", "PlaybackStarted", "PlaybackFinished", "RecordingStarted", "RecordingFinished", "RecordingFailed", "ApplicationReplaced", "BridgeCreated", "BridgeDestroyed", "BridgeMerged", "BridgeBlindTransfer", "BridgeAttendedTransfer", "BridgeVideoSourceChanged", "ChannelCreated", "ChannelDestroyed", "ChannelEnteredBridge", "ChannelLeftBridge", "ChannelStateChange", "ChannelDtmfReceived", "ChannelDialplan", "ChannelCallerId", "ChannelUserevent", "ChannelHangupRequest", "ChannelVarset", "ChannelTalkingStarted", "ChannelTalkingFinished", "ChannelHold", "ChannelUnhold", "ContactStatusChange", "EndpointStateChange", "Dial", "StasisEnd", "StasisStart", "TextMessageReceived", "ChannelConnectedLine", "PeerStatusChange" ] }, "ContactInfo": { "id": "ContactInfo", "description": "Detailed information about a contact on an endpoint.", "properties": { "uri": { "type": "string", "description": "The location of the contact.", "required": true }, "contact_status": { "type": "string", "description": "The current status of the contact.", "required": true, "allowableValues": { "valueType": "LIST", "values": [ "Unreachable", "Reachable", "Unknown", "Created", "Removed" ] } }, "aor": { "type": "string", "description": "The Address of Record this contact belongs to.", "required": true }, "roundtrip_usec": { "type": "string", "description": "Current round trip time, in microseconds, for the contact.", "required": false } } }, "Peer": { "id": "Peer", "description": "Detailed information about a remote peer that communicates with Asterisk.", "properties": { "peer_status": { "type": "string", "description": "The current state of the peer. Note that the values of the status are dependent on the underlying peer technology.", "required": true }, "cause": { "type": "string", "description": "An optional reason associated with the change in peer_status.", "required": false }, "address": { "type": "string", "description": "The IP address of the peer.", "required": false }, "port": { "type": "string", "description": "The port of the peer.", "required": false }, "time": { "type": "string", "description": "The last known time the peer was contacted.", "required": false } } }, "DeviceStateChanged": { "id": "DeviceStateChanged", "description": "Notification that a device state has changed.", "properties": { "device_state": { "type": "DeviceState", "description":[2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/api-docs/applications.json [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/applications.json] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/applications.json] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/api-docs/applications.json] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: ast_ari_get_docs(applications.json) [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "_copyright": "Copyright (C) 2013, Digium, Inc.", "_author": "David M. Lee, II ", "_svn_revision": "$Revision$", "apiVersion": "1.10.0", "swaggerVersion": "1.1", "basePath": "http://1.1.1.115:8088/ari", "resourcePath": "/api-docs/applications.{format}", "apis": [ { "path": "/applications", "description": "Stasis applications", "operations": [ { "httpMethod": "GET", "summary": "List all applications.", "nickname": "list", "responseClass": "List[Application]" } ] }, { "path": "/applications/{applicationName}", "description": "Stasis application", "operations": [ { "httpMethod": "GET", "summary": "Get details of an application.", "nickname": "get", "responseClass": "Application", "parameters": [ { "name": "applicationName", "description": "Application's name", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" } ], "errorResponses": [ { "code": 404, "reason": "Application does not exist." } ] } ] }, { "path": "/applications/{applicationName}/subscription", "description": "Stasis application", "operations": [ { "httpMethod": "POST", "summary": "Subscribe an application to a event source.", "notes": "Returns the state of the application after the subscriptions have changed", "nickname": "subscribe", "responseClass": "Application", "parameters": [ { "name": "applicationName", "description": "Application's name", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "eventSource", "description": "URI for event source (channel:{channelId}, bridge:{bridgeId}, endpoint:{tech}[/{resource}], deviceState:{deviceName}", "paramType": "query", "required": true, "allowMultiple": true, "dataType": "string" } ], "errorResponses": [ { "code": 400, "reason": "Missing parameter." }, { "code": 404, "reason": "Application does not exist." }, { "code": 422, "reason": "Event source does not exist." } ] }, { "httpMethod": "DELETE", "summary": "Unsubscribe an application from an event source.", "notes": "Returns the state of the application after the subscriptions have changed", "nickname": "unsubscribe", "responseClass": "Application", "parameters": [ { "name": "applicationName", "description": "Application's name", "paramType": "path", "required": true, "allowMultiple": false, "dataType": "string" }, { "name": "eventSource", "description": "URI for event source (channel:{channelId}, bridge:{bridgeId}, endpoint:{tech}[/{resource}], deviceState:{deviceName}", "paramType": "query", "required": true, "allowMultiple": true, "dataType": "string" } ], "errorResponses": [ { "code": 400, "reason": "Missing parameter; event source scheme not recognized." }, { "code": 404, "reason": "Application does not exist." }, { "code": 409, "reason": "Application not subscribed to event source." }, { "code": 422, "reason": "Event source does not exist." } ] } ] } ], "models": { "Application": { "id": "Application", "description": "Details of a Stasis application", "properties": { "name": { "type": "string", "description": "Name of this application", "required": true }, "channel_ids": { "type": "List[string]", "description": "Id's for channels subscribed to.", "required": true }, "bridge_ids": { "type": "List[string]", "description": "Id's for bridges subscribed to.", "required": true }, "endpoint_ids": { "type": "List[string]", "description": "{tech}/{resource} for endpoints subscribed to.", "required": true }, "device_names": { "type": "List[string]", "description": "Names of the devices subscribed to.", "required": true } } } } } [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/channels?app=mg-bridges&endpoint=PJSIP%2F2&appArgs=819901%2C2%2Cagent%2C13236941&callerId=CID819901+%3CCID819901%3E [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/channels] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/channels] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/channels] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Finding handler for channels [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_endpoints WHERE id = '2' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd2f403e7f0 Query: SELECT * FROM ps_endpoints WHERE id = '2' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Found 1 rows. [2017-01-16 14:55:49] DEBUG[18312] res_sorcery_realtime.c: Filtering out realtime field 'disallow' from retrieval [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [1800] in [0, 4294967295] gives [1800](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [90] in [0, 4294967295] gives [90](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_aors WHERE id = '2' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd2f400e6b0 Query: SELECT * FROM ps_aors WHERE id = '2' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Found 1 rows. [2017-01-16 14:55:49] DEBUG[18312] config.c: extract double from [3.0] in [-inf, inf] gives [3.000000](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [60] in [0, 4294967295] gives [60](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [3600] in [0, 4294967295] gives [3600](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [7200] in [0, 4294967295] gives [7200](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [1] in [0, 4294967295] gives [1](0) [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_contacts WHERE id LIKE '2^3B@%' ORDER BY id [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd2f4008ea0 Query: SELECT * FROM ps_contacts WHERE id LIKE '2^3B@%' ORDER BY id [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Found 1 rows. [2017-01-16 14:55:49] DEBUG[18312] config.c: extract double from [3.0] in [-inf, inf] gives [3.000000](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 86400] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract double from [3] in [-inf, inf] gives [3.000000](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18285] threadpool.c: Increasing threadpool stasis-core's size by 1 [2017-01-16 14:55:49] DEBUG[18390] res_stasis.c: mg-bridges: Subscribing to 1484596549.18 [2017-01-16 14:55:49] DEBUG[18390] stasis/app.c: Channel '1484596549.18' is 1 interested in mg-bridges [2017-01-16 14:55:49] VERBOSE[18392] dial.c: Called 2 [2017-01-16 14:55:49] DEBUG[18312] rtp_engine.c: Using engine 'asterisk' for RTP instance '0x7fd2f4042500' [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "id": "1484596549.18", "name": "PJSIP/2-00000002", "state": "Down", "caller": { "name": "CID819901", "number": "CID819901" }, "connected": { "name": "CID819901", "number": "CID819901" }, "accountcode": "", "dialplan": { "context": "ctx_lan", "exten": "s", "priority": 1 }, "creationtime": "2017-01-16T14:55:49.373-0500", "language": "en" } [2017-01-16 14:55:49] DEBUG[18312] res_rtp_asterisk.c: Allocated port 13566 for RTP instance '0x7fd2f4042500' [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18312] res_rtp_asterisk.c: Creating ICE session [::]:13566 (13566) for RTP instance '0x7fd2f4042500' [2017-01-16 14:55:49] DEBUG[18312] rtp_engine.c: RTP instance '0x7fd2f4042500' is setup and ready to go [2017-01-16 14:55:49] DEBUG[18312] acl.c: Not an IPv4 nor IPv6 address, cannot get port. [2017-01-16 14:55:49] DEBUG[18312] res_rtp_asterisk.c: Setup RTCP on RTP instance '0x7fd2f4042500' [2017-01-16 14:55:49] VERBOSE[18312] res_rtp_asterisk.c: DTLS ECDH initialized (secp256r1), faster PFS enabled [2017-01-16 14:55:49] DEBUG[18312] sdp_srtp.c: local_key64 ThGhFb9ncX64YMyRzVU+6pw6B4F0ukRK36WKBidv len 40 [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_t38.c: Not creating outgoing SDP stream: T.38 not enabled [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Method is INVITE [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_aors WHERE id = '2' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd2f4044ce0 Query: SELECT * FROM ps_aors WHERE id = '2' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Found 1 rows. [2017-01-16 14:55:49] DEBUG[18312] config.c: extract double from [3.0] in [-inf, inf] gives [3.000000](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [60] in [0, 4294967295] gives [60](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [3600] in [0, 4294967295] gives [3600](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [7200] in [0, 4294967295] gives [7200](0) [2017-01-16 14:55:49] DEBUG[18312] config.c: extract uint from [1] in [0, 4294967295] gives [1](0) [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_sips_contact.c: Upgrading contact URI on outgoing SIP request to SIPS due to SIPS Request URI [2017-01-16 14:55:49] DEBUG[18312] res_http_websocket.c: Writing websocket text frame, length 1672 [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Source of transaction state change is TX_MSG [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP Request URI is /ari/channels?originator=1484596549.18&app=mg-bridges&endpoint=Local%2F13051002000-18001002000%40cont-fas%2Fn&appArgs=819901%2C3056002778%2Cpstn%2C13236941&callerId=%2B18001002000+%3C%2B18001002000%3E [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/channels] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/channels] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18390] http.c: match request [ari/channels] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18390] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Finding handler for channels [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18390] res_stasis.c: mg-bridges: Subscribing to 1484596549.19 [2017-01-16 14:55:49] DEBUG[18390] stasis/app.c: Channel '1484596549.19' is 1 interested in mg-bridges [2017-01-16 14:55:49] DEBUG[18390] res_stasis.c: mg-bridges: Subscribing to 1484596549.20 [2017-01-16 14:55:49] DEBUG[18390] stasis/app.c: Channel '1484596549.20' is 1 interested in mg-bridges [2017-01-16 14:55:49] DEBUG[18390] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "id": "1484596549.19", "name": "Local/13051002000-18001002000@cont-fas-00000003;1", "state": "Down", "caller": { "name": "+18001002000", "number": "+18001002000" }, "connected": { "name": "+18001002000", "number": "+18001002000" }, "accountcode": "", "dialplan": { "context": "cont-fas", "exten": "13051002000-18001002000", "priority": 1 }, "creationtime": "2017-01-16T14:55:49.378-0500", "language": "en" } [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 758 [2017-01-16 14:55:49] VERBOSE[18393] dial.c: Called 13051002000-18001002000@cont-fas/n [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 758 [2017-01-16 14:55:49] DEBUG[18394][C-00000003] pbx.c: Launching 'Answer' [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] pbx.c: Executing [13051002000-18001002000@cont-fas:1] Answer("Local/13051002000-18001002000@cont-fas-00000003;2", "") in new stack [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 668 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 668 [2017-01-16 14:55:49] VERBOSE[18393] dial.c: Local/13051002000-18001002000@cont-fas-00000003;1 answered [2017-01-16 14:55:49] DEBUG[18296] devicestate.c: Changing state for Local/13051002000-18001002000@cont-fas - state 2 (In use) [2017-01-16 14:55:49] DEBUG[18296] devicestate.c: Changing state for Local/13051002000-18001002000@cont-fas - state 2 (In use) [2017-01-16 14:55:49] VERBOSE[18393] ari/resource_channels.c: Launching Stasis(mg-bridges,819901,3056002778,pstn,13236941) on Local/13051002000-18001002000@cont-fas-00000003;1 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 718 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 718 [2017-01-16 14:55:49] DEBUG[18393] stasis/app.c: Channel '1484596549.19' is 2 interested in mg-bridges [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 664 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 664 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 664 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 664 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 704 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 704 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 733 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 733 [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP idle timeout or peer closed connection. [2017-01-16 14:55:49] DEBUG[18390] http.c: HTTP closing session. Top level [2017-01-16 14:55:49] DEBUG[18312] res_pjsip/pjsip_distributor.c: Searching for serializer on dialog dlg0x7fd2f4041308 for Response msg 100/INVITE/cseq=1139 (rdata0x7fd2f4004de8) [2017-01-16 14:55:49] DEBUG[18312] res_pjsip/pjsip_distributor.c: Found serializer pjsip/outsess/2-000001dd on dialog dlg0x7fd2f4041308 [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Received response [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Response is 100 Trying (sent from the Transaction Layer) [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP opening session. Top level [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP Request URI is /ari/bridges/cid-819901 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for bridges [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking bridges [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for cid-819901 [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking bridgeId [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Examining ARI response: 404 Not Found Content-type: application/json { "message": "Bridge not found" } [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP keeping session open. status_code:404 [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP Request URI is /ari/bridges/cid-819901?type=mixing [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for bridges [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking bridges [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for cid-819901 [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking bridgeId [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] bridge_native_rtp.c: Bridge 'cid-819901' can not use native RTP bridge as two channels are required [2017-01-16 14:55:49] DEBUG[18395] bridge.c: Bridge technology native_rtp is not compatible with properties of existing bridge. [2017-01-16 14:55:49] DEBUG[18395] bridge.c: Bridge technology holding_bridge does not have any capabilities we want. [2017-01-16 14:55:49] DEBUG[18395] bridge.c: Chose bridge technology simple_bridge [2017-01-16 14:55:49] DEBUG[18395] bridge.c: Bridge cid-819901: calling simple_bridge technology constructor [2017-01-16 14:55:49] DEBUG[18395] bridge.c: Bridge cid-819901: calling simple_bridge technology start [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "id": "cid-819901", "technology": "simple_bridge", "bridge_type": "mixing", "bridge_class": "stasis", "creator": "Stasis", "name": "", "channels": [], "video_mode": "talker" } [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP Request URI is /ari/channels/1484596549.19/answer [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.19/answer] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.19/answer] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.19/answer] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for 1484596549.19 [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channelId [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for answer [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking continue [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking redirect [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking answer [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_stasis_answer.c: 1484596549.19: Sending answer command [2017-01-16 14:55:49] DEBUG[18312] res_pjsip/pjsip_distributor.c: Searching for serializer on dialog dlg0x7fd2f4041308 for Response msg 180/INVITE/cseq=1139 (rdata0x7fd2f4004de8) [2017-01-16 14:55:49] DEBUG[18312] res_pjsip/pjsip_distributor.c: Found serializer pjsip/outsess/2-000001dd on dialog dlg0x7fd2f4041308 [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Source of transaction state change is RX_MSG [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Received response [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Response is 180 Ringing [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Received response [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Response is 180 Ringing [2017-01-16 14:55:49] DEBUG[18296] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:49] VERBOSE[18392] dial.c: PJSIP/2-00000002 is ringing [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 601 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 601 [2017-01-16 14:55:49] DEBUG[18296] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_endpoints WHERE id = '2' [2017-01-16 14:55:49] DEBUG[18296] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd330005be0 Query: SELECT * FROM ps_endpoints WHERE id = '2' [2017-01-16 14:55:49] DEBUG[18296] res_config_pgsql.c: PostgreSQL RealTime: Found 1 rows. [2017-01-16 14:55:49] DEBUG[18296] res_sorcery_realtime.c: Filtering out realtime field 'disallow' from retrieval [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [1800] in [0, 4294967295] gives [1800](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [90] in [0, 4294967295] gives [90](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] devicestate.c: Changing state for PJSIP/2 - state 6 (Ringing) [2017-01-16 14:55:49] DEBUG[18312] res_pjsip/pjsip_distributor.c: Searching for serializer on dialog dlg0x7fd2f4041308 for Response msg 200/INVITE/cseq=1139 (rdata0x7fd2f4004de8) [2017-01-16 14:55:49] DEBUG[18312] res_pjsip/pjsip_distributor.c: Found serializer pjsip/outsess/2-000001dd on dialog dlg0x7fd2f4041308 [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Source of transaction state change is RX_MSG [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Received response [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Response is 200 OK [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Applying negotiated SDP media stream 'audio' using audio SDP handler [2017-01-16 14:55:49] DEBUG[18312] acl.c: Not an IPv4 nor IPv6 address, cannot get port. [2017-01-16 14:55:49] DEBUG[18312] acl.c: For destination '10.57.12.18', our source address is '1.1.1.115'. [2017-01-16 14:55:49] DEBUG[18312] res_rtp_asterisk.c: Setting RTCP address on RTP instance '0x7fd2f4042500' [2017-01-16 14:55:49] DEBUG[18312] rtp_engine.c: Setting tx payload type 8 based on m type on 0x7fd3580fabe0 [2017-01-16 14:55:49] DEBUG[18312] rtp_engine.c: Copying payload 8 (0x7fd2f4040f78) from 0x7fd3580fabe0 to 0x7fd2f40426c8 [2017-01-16 14:55:49] DEBUG[18312] res_rtp_asterisk.c: Set role to CONTROLLING (0x7fd2f4042500) [2017-01-16 14:55:49] DEBUG[18312] res_rtp_asterisk.c: Resetting ICE for RTP instance '0x7fd2f4042500' [2017-01-16 14:55:49] DEBUG[18312] res_rtp_asterisk.c: Nevermind. ICE isn't ready for a reset [2017-01-16 14:55:49] DEBUG[18312] res_rtp_asterisk.c: Successfully created ICE checklist (0x7fd2f4042500) [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Applied negotiated SDP media stream 'audio' using audio SDP handler [2017-01-16 14:55:49] DEBUG[18312] res_http_websocket.c: Writing websocket text frame, length 440 [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Received response [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Response is 200 OK [2017-01-16 14:55:49] VERBOSE[18392] dial.c: PJSIP/2-00000002 answered [2017-01-16 14:55:49] DEBUG[18296] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:49] VERBOSE[18392] ari/resource_channels.c: Launching Stasis(mg-bridges,819901,2,agent,13236941) on PJSIP/2-00000002 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 596 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 596 [2017-01-16 14:55:49] DEBUG[18392] stasis/app.c: Channel '1484596549.18' is 2 interested in mg-bridges [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 636 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 636 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 657 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 657 [2017-01-16 14:55:49] DEBUG[18296] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_endpoints WHERE id = '2' [2017-01-16 14:55:49] DEBUG[18296] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd330079b80 Query: SELECT * FROM ps_endpoints WHERE id = '2' [2017-01-16 14:55:49] DEBUG[18296] res_config_pgsql.c: PostgreSQL RealTime: Found 1 rows. [2017-01-16 14:55:49] DEBUG[18296] res_sorcery_realtime.c: Filtering out realtime field 'disallow' from retrieval [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [1800] in [0, 4294967295] gives [1800](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [90] in [0, 4294967295] gives [90](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:49] DEBUG[18296] devicestate.c: Changing state for PJSIP/2 - state 2 (In use) [2017-01-16 14:55:49] DEBUG[18328] acl.c: Not an IPv4 nor IPv6 address, cannot get port. [2017-01-16 14:55:49] DEBUG[18328] acl.c: For destination '10.57.12.18', our source address is '1.1.1.115'. [2017-01-16 14:55:49] DEBUG[18328] res_rtp_asterisk.c: Setting RTCP address on RTP instance '0x7fd2f4042500' [2017-01-16 14:55:49] DEBUG[18392] res_srtp.c: Adding new policy for SSRC 740394102 [2017-01-16 14:55:49] DEBUG[18392] res_srtp.c: Adding new policy for SSRC 740394102 [2017-01-16 14:55:49] DEBUG[18392] res_rtp_asterisk.c: 0x7fd2f4051b70 -- Probation learning mode pass with source address 10.57.12.18:50453 [2017-01-16 14:55:49] VERBOSE[18392] res_rtp_asterisk.c: 0x7fd2f4051b70 -- Probation passed - setting RTP source address to 10.57.12.18:50453 [2017-01-16 14:55:49] DEBUG[18393] res_stasis_answer.c: 1484596549.19: Answering [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Examining ARI response: 204 No Content [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP keeping session open. status_code:204 [2017-01-16 14:55:49] DEBUG[18392] res_rtp_asterisk.c: Got RTCP report of 80 bytes [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP Request URI is /ari/bridges/cid-819901/addChannel?channel=1484596549.19 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901/addChannel] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901/addChannel] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901/addChannel] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for bridges [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking bridges [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for cid-819901 [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking bridgeId [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for addChannel [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking addChannel [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] stasis/control.c: 1484596549.19: Sending channel add_to_bridge command [2017-01-16 14:55:49] DEBUG[18393] bridge_roles.c: Roles did not exist on channel Local/13051002000-18001002000@cont-fas-00000003;1 [2017-01-16 14:55:49] DEBUG[18393] stasis/control.c: 1484596549.19: Adding to bridge cid-819901 [2017-01-16 14:55:49] DEBUG[18393] stasis/app.c: Bridge 'cid-819901' is 1 interested in mg-bridges [2017-01-16 14:55:49] DEBUG[18396] bridge_channel.c: Bridge cid-819901: 0x7fd2e00065d0(Local/13051002000-18001002000@cont-fas-00000003;1) is joining [2017-01-16 14:55:49] DEBUG[18396] bridge_channel.c: Bridge cid-819901: pushing 0x7fd2e00065d0(Local/13051002000-18001002000@cont-fas-00000003;1) [2017-01-16 14:55:49] VERBOSE[18396] bridge_channel.c: Channel Local/13051002000-18001002000@cont-fas-00000003;1 joined 'simple_bridge' stasis-bridge [2017-01-16 14:55:49] DEBUG[18396] bridge_native_rtp.c: Bridge 'cid-819901' can not use native RTP bridge as two channels are required [2017-01-16 14:55:49] DEBUG[18396] bridge.c: Bridge technology native_rtp is not compatible with properties of existing bridge. [2017-01-16 14:55:49] DEBUG[18396] bridge.c: Bridge technology holding_bridge does not have any capabilities we want. [2017-01-16 14:55:49] DEBUG[18396] bridge.c: Bridge technology softmix does not have any capabilities we want. [2017-01-16 14:55:49] DEBUG[18396] bridge.c: Chose bridge technology simple_bridge [2017-01-16 14:55:49] DEBUG[18396] bridge.c: Bridge cid-819901 is already using the new technology. [2017-01-16 14:55:49] DEBUG[18396] bridge.c: Bridge cid-819901: 0x7fd2e00065d0(Local/13051002000-18001002000@cont-fas-00000003;1) is joining simple_bridge technology [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 918 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 918 [2017-01-16 14:55:49] DEBUG[18393] stasis/app.c: Bridge 'cid-819901' is 2 interested in mg-bridges [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Examining ARI response: 204 No Content [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP keeping session open. status_code:204 [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP Request URI is /ari/bridges/cid-819901 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for bridges [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking bridges [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for cid-819901 [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking bridgeId [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "id": "cid-819901", "technology": "simple_bridge", "bridge_type": "mixing", "bridge_class": "stasis", "creator": "Stasis", "name": "", "channels": [ "1484596549.19" ], "video_mode": "talker" } [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP Request URI is /ari/channels/1484596549.18/answer [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.18/answer] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.18/answer] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.18/answer] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for 1484596549.18 [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channelId [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for answer [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking continue [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking redirect [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking answer [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_stasis_answer.c: 1484596549.18: Sending answer command [2017-01-16 14:55:49] DEBUG[18392] res_stasis_answer.c: 1484596549.18: Answering [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Examining ARI response: 204 No Content [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP keeping session open. status_code:204 [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP Request URI is /ari/channels/1484596549.18/snoop?spy=both&app=mg-bridges&appArgs=819901%2C2%2Csnoop%2C13236941&whisper=none [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.18/snoop] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.18/snoop] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.18/snoop] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for 1484596549.18 [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channelId [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for snoop [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking continue [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking redirect [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking answer [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking ring [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking dtmf [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking mute [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking hold [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking moh [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking silence [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking play [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking record [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking variable [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking snoop [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "id": "1484596549.21", "name": "Snoop/1484596549.18-00000001", "state": "Up", "caller": { "name": "", "number": "" }, "connected": { "name": "", "number": "" }, "accountcode": "", "dialplan": { "context": "default", "exten": "s", "priority": 1 }, "creationtime": "2017-01-16T14:55:49.810-0500", "language": "en" } [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:49] DEBUG[18397] stasis/app.c: Channel '1484596549.21' is 1 interested in mg-bridges [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 633 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 633 [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP Request URI is /ari/bridges/cid-819901/addChannel?channel=1484596549.18 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901/addChannel] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901/addChannel] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/bridges/cid-819901/addChannel] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for bridges [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking bridges [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for cid-819901 [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking bridgeId [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for addChannel [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking addChannel [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] stasis/control.c: 1484596549.18: Sending channel add_to_bridge command [2017-01-16 14:55:49] DEBUG[18392] bridge_roles.c: Roles did not exist on channel PJSIP/2-00000002 [2017-01-16 14:55:49] DEBUG[18392] stasis/control.c: 1484596549.18: Adding to bridge cid-819901 [2017-01-16 14:55:49] DEBUG[18392] stasis/app.c: Bridge 'cid-819901' is 3 interested in mg-bridges [2017-01-16 14:55:49] DEBUG[18398] bridge_channel.c: Bridge cid-819901: 0x7fd35000a710(PJSIP/2-00000002) is joining [2017-01-16 14:55:49] DEBUG[18398] bridge_channel.c: Bridge cid-819901: pushing 0x7fd35000a710(PJSIP/2-00000002) [2017-01-16 14:55:49] VERBOSE[18398] bridge_channel.c: Channel PJSIP/2-00000002 joined 'simple_bridge' stasis-bridge [2017-01-16 14:55:49] DEBUG[18299] cdr.c: Finalized CDR for PJSIP/2-00000002 - start 1484596549.373668 answer 1484596549.508545 end 1484596549.827457 dispo ANSWERED [2017-01-16 14:55:49] DEBUG[18398] bridge_native_rtp.c: Bridge 'cid-819901' can not use native RTP bridge as channel 'PJSIP/2-00000002' has features which prevent it [2017-01-16 14:55:49] DEBUG[18398] bridge.c: Bridge technology native_rtp is not compatible with properties of existing bridge. [2017-01-16 14:55:49] DEBUG[18398] bridge.c: Bridge technology holding_bridge does not have any capabilities we want. [2017-01-16 14:55:49] DEBUG[18398] bridge.c: Bridge technology softmix does not have any capabilities we want. [2017-01-16 14:55:49] DEBUG[18398] bridge.c: Chose bridge technology simple_bridge [2017-01-16 14:55:49] DEBUG[18398] bridge.c: Bridge cid-819901 is already using the new technology. [2017-01-16 14:55:49] DEBUG[18398] bridge.c: Bridge cid-819901: 0x7fd35000a710(PJSIP/2-00000002) is joining simple_bridge technology [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 873 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 873 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 718 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 718 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 743 [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Examining ARI response: 204 No Content [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 743 [2017-01-16 14:55:49] DEBUG[18392] stasis/app.c: Bridge 'cid-819901' is 4 interested in mg-bridges [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP keeping session open. status_code:204 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 683 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 683 [2017-01-16 14:55:49] DEBUG[18394][C-00000003] pbx_variables.c: Function CUT(EXTEN,-,1) result is '13051002000' [2017-01-16 14:55:49] DEBUG[18394][C-00000003] pbx.c: Launching 'Set' [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 604 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 604 [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] pbx.c: Executing [13051002000-18001002000@cont-fas:2] Set("Local/13051002000-18001002000@cont-fas-00000003;2", "fasDestination=13051002000") in new stack [2017-01-16 14:55:49] DEBUG[18394][C-00000003] pbx_variables.c: Function CUT(EXTEN,-,2) result is '18001002000' [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 660 [2017-01-16 14:55:49] DEBUG[18394][C-00000003] pbx.c: Launching 'Set' [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 660 [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] pbx.c: Executing [13051002000-18001002000@cont-fas:3] Set("Local/13051002000-18001002000@cont-fas-00000003;2", "fasCallerid=18001002000") in new stack [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 733 [2017-01-16 14:55:49] NOTICE[18394][C-00000003] ast_expr2.y: argbuf allocated 12 bytes; [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 733 [2017-01-16 14:55:49] NOTICE[18394][C-00000003] ast_expr2.y: argbuf uses 11 bytes; [2017-01-16 14:55:49] DEBUG[18394][C-00000003] pbx_variables.c: Expression result is '1' [2017-01-16 14:55:49] DEBUG[18394][C-00000003] pbx_variables.c: Function IF(1?18001002000:0) result is '18001002000' [2017-01-16 14:55:49] DEBUG[18394][C-00000003] pbx.c: Launching 'Set' [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] pbx.c: Executing [13051002000-18001002000@cont-fas:4] Set("Local/13051002000-18001002000@cont-fas-00000003;2", "CALLERID(num)=18001002000") in new stack [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 750 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 750 [2017-01-16 14:55:49] DEBUG[18394][C-00000003] pbx.c: Launching 'Dial' [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] pbx.c: Executing [13051002000-18001002000@cont-fas:5] Dial("Local/13051002000-18001002000@cont-fas-00000003;2", "PJSIP/95060074*13051002000@flowroute,,b(fas-handler^addcli^1(18001002000))") in new stack [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 711 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 711 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 730 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 730 [2017-01-16 14:55:49] CC[18394][C-00000003] ccss.c: Agent policy for Local/13051002000-18001002000@cont-fas-00000003;2 is 'never'. CC not possible [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 708 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 708 [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 732 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 732 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 752 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 752 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 784 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 784 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 698 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 698 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 704 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 704 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 702 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 702 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 700 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 700 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 698 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 698 [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_endpoints WHERE id = 'flowroute' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd2f404b3c0 Query: SELECT * FROM ps_endpoints WHERE id = 'flowroute' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: Postgresql RealTime: Could not find any rows in table ps_endpoints@asterisk. [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_aors WHERE id = 'flowroute' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd2f404b3c0 Query: SELECT * FROM ps_aors WHERE id = 'flowroute' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: Postgresql RealTime: Could not find any rows in table ps_aors@asterisk. [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:49] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_contacts WHERE id LIKE 'flowroute^3B@%' ORDER BY id [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd2f404b3c0 Query: SELECT * FROM ps_contacts WHERE id LIKE 'flowroute^3B@%' ORDER BY id [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Could not find any rows in table ps_contacts. [2017-01-16 14:55:49] DEBUG[18394][C-00000003] rtp_engine.c: Can't find native functions for channel 'Local/13051002000-18001002000@cont-fas-00000003;2' [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] app_stack.c: PJSIP/flowroute-00000003 Internal Gosub(fas-handler,addcli,1(18001002000)) start [2017-01-16 14:55:49] DEBUG[18394][C-00000003] app_stack.c: Channel PJSIP/flowroute-00000003 has no datastore, so we're allocating one. [2017-01-16 14:55:49] DEBUG[18394][C-00000003] app_stack.c: Setting 'ARG1' to '18001002000' [2017-01-16 14:55:49] DEBUG[18394][C-00000003] pbx.c: Launching 'Set' [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] pbx.c: Executing [addcli@fas-handler:1] Set("PJSIP/flowroute-00000003", "CALLERID(num)=18001002000") in new stack [2017-01-16 14:55:49] DEBUG[18394][C-00000003] pbx.c: Launching 'Return' [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] pbx.c: Executing [addcli@fas-handler:2] Return("PJSIP/flowroute-00000003", "") in new stack [2017-01-16 14:55:49] DEBUG[18394][C-00000003] app_stack.c: Spawn extension (ctx_flow_in,13051002000-18001002000,1) exited with -1 on 'PJSIP/flowroute-00000003' [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] app_stack.c: Spawn extension (ctx_flow_in, 13051002000-18001002000, 1) exited non-zero on 'PJSIP/flowroute-00000003' [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] app_stack.c: PJSIP/flowroute-00000003 Internal Gosub(fas-handler,addcli,1(18001002000)) complete GOSUB_RETVAL= [2017-01-16 14:55:49] DEBUG[18312] rtp_engine.c: Using engine 'asterisk' for RTP instance '0x7fd2f402bcc0' [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] app_dial.c: Called PJSIP/95060074*13051002000@flowroute [2017-01-16 14:55:49] DEBUG[18312] res_rtp_asterisk.c: Allocated port 13266 for RTP instance '0x7fd2f402bcc0' [2017-01-16 14:55:49] DEBUG[18394][C-00000003] channel.c: Channel Local/13051002000-18001002000@cont-fas-00000003;2 setting write format path: ulaw -> alaw [2017-01-16 14:55:49] DEBUG[18394][C-00000003] channel.c: Channel PJSIP/flowroute-00000003 setting write format path: alaw -> ulaw [2017-01-16 14:55:49] DEBUG[18312] res_rtp_asterisk.c: Creating ICE session [::]:13266 (13266) for RTP instance '0x7fd2f402bcc0' [2017-01-16 14:55:49] VERBOSE[18394][C-00000003] app_dial.c: Local/13051002000-18001002000@cont-fas-00000003;2 requested media update control 26, passing it to PJSIP/flowroute-00000003 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 1201 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 1201 [2017-01-16 14:55:49] DEBUG[18312] rtp_engine.c: RTP instance '0x7fd2f402bcc0' is setup and ready to go [2017-01-16 14:55:49] DEBUG[18312] acl.c: Not an IPv4 nor IPv6 address, cannot get port. [2017-01-16 14:55:49] DEBUG[18312] res_rtp_asterisk.c: Setup RTCP on RTP instance '0x7fd2f402bcc0' [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_t38.c: Not creating outgoing SDP stream: T.38 not enabled [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Method is INVITE [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 661 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 661 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 603 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 603 [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_domain_aliases WHERE id = 'sip.flowroute.com' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd2f402d950 Query: SELECT * FROM ps_domain_aliases WHERE id = 'sip.flowroute.com' [2017-01-16 14:55:49] DEBUG[18312] res_config_pgsql.c: Postgresql RealTime: Could not find any rows in table ps_domain_aliases@asterisk. [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Source of transaction state change is TX_MSG [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP Request URI is /ari/channels/1484596549.21/record?ifExists=overwrite&maxSilenceSeconds=600&maxDurationSeconds=7200&name=2017-01-16%2Fsnoop-819901-13236941&format=wav [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.21/record] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.21/record] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.21/record] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for 1484596549.21 [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channelId [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for record [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking continue [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking redirect [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking answer [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking ring [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking dtmf [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking mute [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking hold [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking moh [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking silence [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking play [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking record [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_stasis_recording.c: 1484596549.21: Sending record(2017-01-16/snoop-819901-13236941.wav) command [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Examining ARI response: 201 Created Location: /ari/recordings/live/2017-01-16%2Fsnoop-819901-13236941 Content-type: application/json { "name": "2017-01-16/snoop-819901-13236941", "format": "wav", "state": "queued", "target_uri": "channel:1484596549.21" } [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP keeping session open. status_code:201 [2017-01-16 14:55:49] DEBUG[18397] app.c: play_and_record: , /home/asterisk/spool/recording/2017-01-16/snoop-819901-13236941, 'wav' [2017-01-16 14:55:49] DEBUG[18397] app.c: Recording Formats: sfmts=wav [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 260 [2017-01-16 14:55:49] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 260 [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP Request URI is /ari/channels/1484596549.21/continue [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.21/continue] with handler [httpstatus] len 10 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.21/continue] with handler [static] len 6 [2017-01-16 14:55:49] DEBUG[18395] http.c: match request [ari/channels/1484596549.21/continue] with handler [ari] len 3 [2017-01-16 14:55:49] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for 1484596549.21 [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking channelId [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Finding handler for continue [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Checking continue [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:49] DEBUG[18395] res_ari.c: Examining ARI response: 204 No Content [2017-01-16 14:55:49] DEBUG[18395] http.c: HTTP keeping session open. status_code:204 [2017-01-16 14:55:49] VERBOSE[18397] app.c: x=0, open writing: /home/asterisk/spool/recording/2017-01-16/snoop-819901-13236941 format: wav, 0x7fd2e4005920 [2017-01-16 14:55:49] DEBUG[18397] dsp.c: Setup tone 1100 Hz, 500 ms, block_size=160, hits_required=21 [2017-01-16 14:55:49] DEBUG[18397] dsp.c: Setup tone 2100 Hz, 2600 ms, block_size=160, hits_required=116 [2017-01-16 14:55:49] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:49] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:49] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:49] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:49] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:49] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:49] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:49] DEBUG[18311] res_pjsip/pjsip_distributor.c: Searching for serializer on dialog dlg0x7fd2f400f2d8 for Response msg 100/INVITE/cseq=22479 (rdata0x7fd2dc0080b8) [2017-01-16 14:55:49] DEBUG[18311] res_pjsip/pjsip_distributor.c: Found serializer pjsip/outsess/flowroute-000001de on dialog dlg0x7fd2f400f2d8 [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Received response [2017-01-16 14:55:49] DEBUG[18312] res_pjsip_session.c: Response is 100 Trying [2017-01-16 14:55:49] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:49] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:49] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:49] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:49] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:49] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:49] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:49] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:50] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:50] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18397] audiohook.c: Failed to get 160 samples from write factory 0x7fd35400ffe8 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18312] res_pjsip/pjsip_distributor.c: Searching for serializer on dialog dlg0x7fd2f4041308 for Request msg BYE/cseq=6849 (rdata0x7fd2f4004de8) [2017-01-16 14:55:51] DEBUG[18312] res_pjsip/pjsip_distributor.c: Found serializer pjsip/outsess/2-000001dd on dialog dlg0x7fd2f4041308 [2017-01-16 14:55:51] DEBUG[18312] res_http_websocket.c: Writing websocket text frame, length 382 [2017-01-16 14:55:51] DEBUG[18312] res_pjsip_session.c: Source of transaction state change is RX_MSG [2017-01-16 14:55:51] DEBUG[18312] res_pjsip_session.c: Received request [2017-01-16 14:55:51] DEBUG[18312] res_pjsip_session.c: Method is BYE [2017-01-16 14:55:51] DEBUG[18312] channel.c: *TMP* Received ast_queue_hangup_with_cause for PJSIP/2-00000002 [2017-01-16 14:55:51] DEBUG[18312] channel.c: *TMP* ast_queue_hangup_with_cause returning 0 for PJSIP/2-00000002 [2017-01-16 14:55:51] DEBUG[18398] channel.c: *TMP* ast_read_i_am_zombie(PJSIP/2-00000002) [2017-01-16 14:55:51] DEBUG[18398] channel.c: *TMP* ast_read_soft(PJSIP/2-00000002) [2017-01-16 14:55:51] DEBUG[18398] channel.c: *TMP* hangup_not_doing_anything for PJSIP/2-00000002 [2017-01-16 14:55:51] DEBUG[18398] channel.c: *TMP* pending_empty_control_hangup(PJSIP/2-00000002)[2017-01-16 14:55:51] DEBUG[18398] channel.c: *TMP* pending_empty_control_end(PJSIP/2-00000002)[2017-01-16 14:55:51] DEBUG[18398] bridge_channel.c: Setting 0x7fd35000a710(PJSIP/2-00000002) state from:0 to:1 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 618 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 618 [2017-01-16 14:55:51] DEBUG[18398] bridge_channel.c: Bridge cid-819901: pulling 0x7fd35000a710(PJSIP/2-00000002) [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 639 [2017-01-16 14:55:51] VERBOSE[18398] bridge_channel.c: Channel PJSIP/2-00000002 left 'simple_bridge' stasis-bridge [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 639 [2017-01-16 14:55:51] DEBUG[18398] bridge_channel.c: Bridge cid-819901: 0x7fd35000a710(PJSIP/2-00000002) is leaving simple_bridge technology [2017-01-16 14:55:51] DEBUG[18398] bridge_native_rtp.c: Bridge 'cid-819901' can not use native RTP bridge as two channels are required [2017-01-16 14:55:51] DEBUG[18299] cdr.c: Finalized CDR for PJSIP/2-00000002 - start 1484596549.827490 answer 1484596549.827490 end 1484596551.268622 dispo ANSWERED [2017-01-16 14:55:51] DEBUG[18398] bridge.c: Bridge technology native_rtp is not compatible with properties of existing bridge. [2017-01-16 14:55:51] DEBUG[18398] bridge.c: Bridge technology holding_bridge does not have any capabilities we want. [2017-01-16 14:55:51] DEBUG[18398] bridge.c: Bridge technology softmix does not have any capabilities we want. [2017-01-16 14:55:51] DEBUG[18398] bridge.c: Chose bridge technology simple_bridge [2017-01-16 14:55:51] DEBUG[18398] bridge.c: Bridge cid-819901 is already using the new technology. [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 852 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 852 [2017-01-16 14:55:51] DEBUG[18398] stasis/control.c: 1484596549.18, cid-819901: Channel leaving bridge [2017-01-16 14:55:51] DEBUG[18398] stasis/app.c: bridge 'cid-819901': is 3 interested in mg-bridges [2017-01-16 14:55:51] DEBUG[18398] stasis/control.c: reason: Channel was departed from bridge [2017-01-16 14:55:51] DEBUG[18392] stasis/control.c: 1484596549.18: Channel departing bridge [2017-01-16 14:55:51] DEBUG[18392] bridge.c: Waiting for 0x7fd35000a710(PJSIP/2-00000002) bridge thread to die. [2017-01-16 14:55:51] DEBUG[18392] stasis/app.c: channel '1484596549.18': is 1 interested in mg-bridges [2017-01-16 14:55:51] DEBUG[18392] channel.c: Hanging up channel 'PJSIP/2-00000002' [2017-01-16 14:55:51] DEBUG[18392] chan_pjsip.c: AST hangup cause 16 (no match found in PJSIP) [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 592 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 592 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 648 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 648 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 648 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 648 [2017-01-16 14:55:51] DEBUG[18299] cdr_pgsql.c: Inserting a CDR record: [INSERT INTO cdr ("calldate","clid","src","dst","dcontext","channel","dstchannel","lastapp","lastdata","duration","billsec","disposition","amaflags","accountcode","uniqueid","userfield","peeraccount","linkedid","sequence") VALUES ('2017-01-16 19:55:49','"CID819901" ','CID819901','s','ctx_lan','PJSIP/2-00000002','','Stasis','mg-bridges,819901,2,agent,13236941',0,0,'ANSWERED',3,'','1484596549.18','','','1484596549.18',10)] [2017-01-16 14:55:51] DEBUG[18345] stasis/app.c: channel '1484596549.18': is 0 interested in mg-bridges [2017-01-16 14:55:51] DEBUG[18296] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:51] DEBUG[18345] stasis/app.c: channel '1484596549.18' unsubscribed from mg-bridges [2017-01-16 14:55:51] VERBOSE[18397] app.c: User hung up [2017-01-16 14:55:51] DEBUG[18296] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_endpoints WHERE id = '2' [2017-01-16 14:55:51] DEBUG[18296] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd330079f60 Query: SELECT * FROM ps_endpoints WHERE id = '2' [2017-01-16 14:55:51] DEBUG[18296] res_config_pgsql.c: PostgreSQL RealTime: Found 1 rows. [2017-01-16 14:55:51] DEBUG[18296] res_sorcery_realtime.c: Filtering out realtime field 'disallow' from retrieval [2017-01-16 14:55:51] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:51] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:51] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:51] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:51] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:51] DEBUG[18296] config.c: extract uint from [1800] in [0, 4294967295] gives [1800](0) [2017-01-16 14:55:51] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:51] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:51] DEBUG[18296] config.c: extract uint from [90] in [0, 4294967295] gives [90](0) [2017-01-16 14:55:51] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:51] DEBUG[18296] config.c: extract uint from [0] in [0, 4294967295] gives [0](0) [2017-01-16 14:55:51] DEBUG[18296] devicestate.c: Changing state for PJSIP/2 - state 1 (Not in use) [2017-01-16 14:55:51] DEBUG[18312] res_pjsip_session.c: Destroying SIP session with endpoint 2 [2017-01-16 14:55:51] DEBUG[18312] res_rtp_asterisk.c: Setting RTCP address on RTP instance '0x7fd2f4042500' [2017-01-16 14:55:51] DEBUG[18312] rtp_engine.c: Destroyed RTP instance '0x7fd2f4042500' [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP Request URI is /ari/channels/1484596549.18 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.18] with handler [httpstatus] len 10 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.18] with handler [static] len 6 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.18] with handler [ari] len 3 [2017-01-16 14:55:51] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for 1484596549.18 [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channelId [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Examining ARI response: 404 Not Found Content-type: application/json { "message": "Channel not found" } [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP keeping session open. status_code:404 [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP Request URI is /ari/bridges/cid-819901 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [httpstatus] len 10 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [static] len 6 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [ari] len 3 [2017-01-16 14:55:51] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for bridges [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking bridges [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for cid-819901 [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking bridgeId [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "id": "cid-819901", "technology": "simple_bridge", "bridge_type": "mixing", "bridge_class": "stasis", "creator": "Stasis", "name": "", "channels": [ "1484596549.19" ], "video_mode": "talker" } [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP Request URI is /ari/channels/1484596549.19 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.19] with handler [httpstatus] len 10 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.19] with handler [static] len 6 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.19] with handler [ari] len 3 [2017-01-16 14:55:51] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for 1484596549.19 [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channelId [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Examining ARI response: 200 OK Content-type: application/json { "id": "1484596549.19", "name": "Local/13051002000-18001002000@cont-fas-00000003;1", "state": "Up", "caller": { "name": "+18001002000", "number": "+18001002000" }, "connected": { "name": "CID819901", "number": "CID819901" }, "accountcode": "", "dialplan": { "context": "cont-fas", "exten": "13051002000-18001002000", "priority": 1 }, "creationtime": "2017-01-16T14:55:49.378-0500", "language": "en" } [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP keeping session open. status_code:200 [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP Request URI is /ari/channels/1484596549.19 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.19] with handler [httpstatus] len 10 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.19] with handler [static] len 6 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.19] with handler [ari] len 3 [2017-01-16 14:55:51] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for 1484596549.19 [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channelId [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] channel.c: Soft-Hanging (0x20) up channel 'Local/13051002000-18001002000@cont-fas-00000003;1' [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Examining ARI response: 204 No Content [2017-01-16 14:55:51] DEBUG[18396] channel.c: *TMP* ast_read_i_am_zombie(Local/13051002000-18001002000@cont-fas-00000003;1) [2017-01-16 14:55:51] DEBUG[18396] channel.c: *TMP* ast_read_soft(Local/13051002000-18001002000@cont-fas-00000003;1) [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP keeping session open. status_code:204 [2017-01-16 14:55:51] DEBUG[18396] channel.c: *TMP* ast_read_i_am_zombie(Local/13051002000-18001002000@cont-fas-00000003;1) [2017-01-16 14:55:51] DEBUG[18396] channel.c: *TMP* ast_read_soft(Local/13051002000-18001002000@cont-fas-00000003;1) [2017-01-16 14:55:51] DEBUG[18396] channel.c: *TMP* hangup_not_doing_anything for Local/13051002000-18001002000@cont-fas-00000003;1 [2017-01-16 14:55:51] DEBUG[18396] channel.c: *TMP* pending_empty_control_end(Local/13051002000-18001002000@cont-fas-00000003;1)[2017-01-16 14:55:51] DEBUG[18396] bridge_channel.c: Setting 0x7fd2e00065d0(Local/13051002000-18001002000@cont-fas-00000003;1) state from:0 to:1 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 690 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 690 [2017-01-16 14:55:51] DEBUG[18396] bridge_channel.c: Bridge cid-819901: pulling 0x7fd2e00065d0(Local/13051002000-18001002000@cont-fas-00000003;1) [2017-01-16 14:55:51] VERBOSE[18396] bridge_channel.c: Channel Local/13051002000-18001002000@cont-fas-00000003;1 left 'simple_bridge' stasis-bridge [2017-01-16 14:55:51] DEBUG[18396] bridge_channel.c: Bridge cid-819901: 0x7fd2e00065d0(Local/13051002000-18001002000@cont-fas-00000003;1) is leaving simple_bridge technology [2017-01-16 14:55:51] DEBUG[18396] bridge_native_rtp.c: Bridge 'cid-819901' can not use native RTP bridge as two channels are required [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 696 [2017-01-16 14:55:51] DEBUG[18396] bridge.c: Bridge technology native_rtp is not compatible with properties of existing bridge. [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 696 [2017-01-16 14:55:51] DEBUG[18396] bridge.c: Bridge technology holding_bridge does not have any capabilities we want. [2017-01-16 14:55:51] DEBUG[18396] bridge.c: Bridge technology softmix does not have any capabilities we want. [2017-01-16 14:55:51] DEBUG[18396] bridge.c: Chose bridge technology simple_bridge [2017-01-16 14:55:51] DEBUG[18396] bridge.c: Bridge cid-819901 is already using the new technology. [2017-01-16 14:55:51] DEBUG[18396] stasis/control.c: 1484596549.19, cid-819901: Channel leaving bridge [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 701 [2017-01-16 14:55:51] DEBUG[18396] stasis/app.c: bridge 'cid-819901': is 2 interested in mg-bridges [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 701 [2017-01-16 14:55:51] DEBUG[18396] stasis/control.c: reason: Channel was departed from bridge [2017-01-16 14:55:51] DEBUG[18393] stasis/control.c: 1484596549.19: Channel departing bridge [2017-01-16 14:55:51] DEBUG[18393] bridge.c: Waiting for 0x7fd2e00065d0(Local/13051002000-18001002000@cont-fas-00000003;1) bridge thread to die. [2017-01-16 14:55:51] DEBUG[18393] stasis/app.c: channel '1484596549.19': is 1 interested in mg-bridges [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 749 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 749 [2017-01-16 14:55:51] DEBUG[18393] channel.c: Hanging up channel 'Local/13051002000-18001002000@cont-fas-00000003;1' [2017-01-16 14:55:51] DEBUG[18393] core_local.c: *TMP* Entering local_hangup [2017-01-16 14:55:51] DEBUG[18393] core_unreal.c: *TMP* ast_unreal_lock_all(Local/13051002000-18001002000@cont-fas-00000003;1) -> owner: Local/13051002000-18001002000@cont-fas-00000003;1, chan: Local/13051002000-18001002000@cont-fas-00000003;2 [2017-01-16 14:55:51] DEBUG[18393] core_unreal.c: *TMP* Inside unreal_hangup(Local/13051002000-18001002000@cont-fas-00000003;1) P_CHAN_IF_2 [2017-01-16 14:55:51] DEBUG[18393] channel.c: *TMP* Received ast_queue_hangup_with_cause for Local/13051002000-18001002000@cont-fas-00000003;2 [2017-01-16 14:55:51] DEBUG[18393] channel.c: *TMP* ast_queue_hangup_with_cause returning 0 for Local/13051002000-18001002000@cont-fas-00000003;2 [2017-01-16 14:55:51] DEBUG[18393] core_local.c: *TMP* No_res [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 881 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 881 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] channel.c: *TMP* ast_read_i_am_zombie(Local/13051002000-18001002000@cont-fas-00000003;2) [2017-01-16 14:55:51] DEBUG[18394][C-00000003] channel.c: *TMP* ast_read_soft(Local/13051002000-18001002000@cont-fas-00000003;2) [2017-01-16 14:55:51] DEBUG[18394][C-00000003] channel.c: *TMP* hangup_not_doing_anything for Local/13051002000-18001002000@cont-fas-00000003;2 [2017-01-16 14:55:51] DEBUG[18394][C-00000003] res_rtp_asterisk.c: No remote address on RTP instance '0x7fd2f402bcc0' so dropping frame [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 648 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 648 [2017-01-16 14:55:51] DEBUG[18296] devicestate.c: Changing state for Local/13051002000-18001002000@cont-fas - state 1 (Not in use) [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 704 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 704 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 676 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 676 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 704 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 704 [2017-01-16 14:55:51] DEBUG[18345] stasis/app.c: channel '1484596549.19': is 0 interested in mg-bridges [2017-01-16 14:55:51] DEBUG[18345] stasis/app.c: channel '1484596549.19' unsubscribed from mg-bridges [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP Request URI is /ari/bridges/cid-819901 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [httpstatus] len 10 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [static] len 6 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [ari] len 3 [2017-01-16 14:55:51] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for bridges [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking bridges [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for cid-819901 [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking bridgeId [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] bridge.c: Bridge cid-819901: telling all channels to leave the party [2017-01-16 14:55:51] DEBUG[18395] bridge.c: Bridge cid-819901: dissolving bridge with cause 16(Normal Clearing) [2017-01-16 14:55:51] DEBUG[18395] bridge.c: Bridge cid-819901: queueing action type:13 sub:1001 [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Examining ARI response: 204 No Content [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP keeping session open. status_code:204 [2017-01-16 14:55:51] DEBUG[18295][C-00000002] bridge.c: Bridge cid-819901: actually destroying stasis bridge, nobody wants it anymore [2017-01-16 14:55:51] DEBUG[18295][C-00000002] bridge.c: Bridge cid-819901: calling stasis bridge destructor [2017-01-16 14:55:51] DEBUG[18295][C-00000002] bridge.c: Bridge cid-819901: calling simple_bridge technology stop [2017-01-16 14:55:51] DEBUG[18295][C-00000002] bridge.c: Bridge cid-819901: calling simple_bridge technology destructor [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 372 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 372 [2017-01-16 14:55:51] DEBUG[18345] stasis/app.c: bridge 'cid-819901': is 1 interested in mg-bridges [2017-01-16 14:55:51] DEBUG[18345] stasis/app.c: bridge 'cid-819901' unsubscribed from mg-bridges [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP Request URI is /ari/bridges/hld-819901 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/hld-819901] with handler [httpstatus] len 10 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/hld-819901] with handler [static] len 6 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/hld-819901] with handler [ari] len 3 [2017-01-16 14:55:51] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for bridges [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking bridges [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for hld-819901 [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking bridgeId [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Examining ARI response: 404 Not Found Content-type: application/json { "message": "Bridge not found" } [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP keeping session open. status_code:404 [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP Request URI is /ari/channels/1484596549.19 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.19] with handler [httpstatus] len 10 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.19] with handler [static] len 6 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/channels/1484596549.19] with handler [ari] len 3 [2017-01-16 14:55:51] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for 1484596549.19 [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channelId [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Examining ARI response: 404 Not Found Content-type: application/json { "message": "Channel not found" } [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP keeping session open. status_code:404 [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP Request URI is /ari/bridges/cid-819901 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [httpstatus] len 10 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [static] len 6 [2017-01-16 14:55:51] DEBUG[18395] http.c: match request [ari/bridges/cid-819901] with handler [ari] len 3 [2017-01-16 14:55:51] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for bridges [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking bridges [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Finding handler for cid-819901 [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Checking bridgeId [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:55:51] DEBUG[18395] res_ari.c: Examining ARI response: 404 Not Found Content-type: application/json { "message": "Bridge not found" } [2017-01-16 14:55:51] DEBUG[18395] http.c: HTTP keeping session open. status_code:404 [2017-01-16 14:55:51] DEBUG[18397] res_stasis_recording.c: 1484596549.21: Recording complete [2017-01-16 14:55:51] DEBUG[18397] stasis/app.c: channel '1484596549.21': is 0 interested in mg-bridges [2017-01-16 14:55:51] DEBUG[18397] stasis/app.c: channel '1484596549.21' unsubscribed from mg-bridges [2017-01-16 14:55:51] DEBUG[18397] channel.c: Hanging up channel 'Snoop/1484596549.18-00000001' [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 329 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 329 [2017-01-16 14:55:51] DEBUG[18296] devicestate.c: Changing state for Snoop/1484596549.18 - state 4 (Invalid) [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 563 [2017-01-16 14:55:51] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 563 [2017-01-16 14:55:51] DEBUG[18299] cdr_pgsql.c: Inserting a CDR record: [INSERT INTO cdr ("calldate","clid","src","dst","dcontext","channel","dstchannel","lastapp","lastdata","duration","billsec","disposition","amaflags","accountcode","uniqueid","userfield","peeraccount","linkedid","sequence") VALUES ('2017-01-16 19:55:49','"CID819901" ','CID819901','s','ctx_lan','PJSIP/2-00000002','Local/13051002000-18001002000@cont-fas-00000003;1','Stasis','mg-bridges,819901,2,agent,13236941',1,1,'ANSWERED',3,'','1484596549.18','','','1484596549.18',14)] [2017-01-16 14:55:51] DEBUG[18299] cdr.c: Finalized CDR for Local/13051002000-18001002000@cont-fas-00000003;1 - start 1484596549.378495 answer 1484596549.379085 end 1484596551.492916 dispo ANSWERED [2017-01-16 14:55:51] DEBUG[18299] cdr_pgsql.c: Inserting a CDR record: [INSERT INTO cdr ("calldate","clid","src","dst","dcontext","channel","dstchannel","lastapp","lastdata","duration","billsec","disposition","amaflags","accountcode","uniqueid","userfield","peeraccount","linkedid","sequence") VALUES ('2017-01-16 19:55:49','"+18001002000" <18001002000>','18001002000','13051002000-18001002000','cont-fas','Local/13051002000-18001002000@cont-fas-00000003;1','','Stasis','mg-bridges,819901,3056002778,pstn,13236941',2,2,'ANSWERED',3,'','1484596549.19','','','1484596549.18',11)] [2017-01-16 14:55:51] DEBUG[18299] cdr.c: Finalized CDR for Snoop/1484596549.18-00000001 - start 1484596549.810308 answer 1484596549.810308 end 1484596551.542994 dispo ANSWERED [2017-01-16 14:55:51] DEBUG[18299] cdr_pgsql.c: Inserting a CDR record: [INSERT INTO cdr ("calldate","clid","src","dst","dcontext","channel","dstchannel","lastapp","lastdata","duration","billsec","disposition","amaflags","accountcode","uniqueid","userfield","peeraccount","linkedid","sequence") VALUES ('2017-01-16 19:55:49','"" <>','','s','default','Snoop/1484596549.18-00000001','','Stasis','mg-bridges,819901,2,snoop,13236941',1,1,'ANSWERED',3,'','1484596549.21','','','1484596549.21',13)] [2017-01-16 14:55:52] DEBUG[18311] res_pjsip/pjsip_distributor.c: Searching for serializer on dialog dlg0x7fd2f400f2d8 for Response msg 183/INVITE/cseq=22479 (rdata0x7fd2dc0080b8) [2017-01-16 14:55:52] DEBUG[18311] res_pjsip/pjsip_distributor.c: Found serializer pjsip/outsess/flowroute-000001de on dialog dlg0x7fd2f400f2d8 [2017-01-16 14:55:52] DEBUG[18312] res_pjsip_session.c: Source of transaction state change is RX_MSG [2017-01-16 14:55:52] DEBUG[18312] res_pjsip_session.c: Received response [2017-01-16 14:55:52] DEBUG[18312] res_pjsip_session.c: Response is 183 Session Progress [2017-01-16 14:55:52] DEBUG[18312] res_pjsip_session.c: Applying negotiated SDP media stream 'audio' using audio SDP handler [2017-01-16 14:55:52] DEBUG[18312] acl.c: Not an IPv4 nor IPv6 address, cannot get port. [2017-01-16 14:55:52] DEBUG[18312] acl.c: For destination '65.98.237.158', our source address is '1.1.1.115'. [2017-01-16 14:55:52] DEBUG[18312] res_rtp_asterisk.c: Setting RTCP address on RTP instance '0x7fd2f402bcc0' [2017-01-16 14:55:52] DEBUG[18312] rtp_engine.c: Setting tx payload type 0 based on m type on 0x7fd3580fac00 [2017-01-16 14:55:52] DEBUG[18312] rtp_engine.c: Setting tx payload type 101 based on m type on 0x7fd3580fac00 [2017-01-16 14:55:52] DEBUG[18312] rtp_engine.c: Copying payload 0 (0x31c5928) from 0x7fd3580fac00 to 0x7fd2f402be88 [2017-01-16 14:55:52] DEBUG[18312] rtp_engine.c: Copying payload 101 (0x7fd2f404b4e8) from 0x7fd3580fac00 to 0x7fd2f402be88 [2017-01-16 14:55:52] DEBUG[18312] res_pjsip_session.c: Applied negotiated SDP media stream 'audio' using audio SDP handler [2017-01-16 14:55:52] DEBUG[18312] res_pjsip_session.c: Received response [2017-01-16 14:55:52] DEBUG[18312] res_pjsip_session.c: Response is 183 Session Progress [2017-01-16 14:55:52] VERBOSE[18394][C-00000003] app_dial.c: PJSIP/flowroute-00000003 is making progress passing it to Local/13051002000-18001002000@cont-fas-00000003;2 [2017-01-16 14:55:52] DEBUG[18394][C-00000003] res_rtp_asterisk.c: 0x7fd2f4031d90 -- Probation learning mode pass with source address 65.98.237.158:13804 [2017-01-16 14:55:52] VERBOSE[18394][C-00000003] res_rtp_asterisk.c: 0x7fd2f4031d90 -- Probation passed - setting RTP source address to 65.98.237.158:13804 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:52] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:53] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:54] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:54] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:54] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:54] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:54] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:54] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] WARNING[18394][C-00000003] app_dial.c: Unable to write frametype: 2 [2017-01-16 14:55:56] DEBUG[18311] res_pjsip/pjsip_distributor.c: Searching for serializer on dialog dlg0x7fd2f400f2d8 for Response msg 200/INVITE/cseq=22479 (rdata0x7fd2dc0080b8) [2017-01-16 14:55:56] DEBUG[18311] res_pjsip/pjsip_distributor.c: Found serializer pjsip/outsess/flowroute-000001de on dialog dlg0x7fd2f400f2d8 [2017-01-16 14:55:56] DEBUG[18312] res_pjsip_session.c: Source of transaction state change is RX_MSG [2017-01-16 14:55:56] DEBUG[18312] res_pjsip_session.c: Received response [2017-01-16 14:55:56] DEBUG[18312] res_pjsip_session.c: Response is 200 OK [2017-01-16 14:55:56] DEBUG[18312] res_pjsip_session.c: Received response [2017-01-16 14:55:56] DEBUG[18312] res_pjsip_session.c: Response is 200 OK [2017-01-16 14:55:56] VERBOSE[18394][C-00000003] app_dial.c: PJSIP/flowroute-00000003 answered Local/13051002000-18001002000@cont-fas-00000003;2 [2017-01-16 14:55:56] DEBUG[18296] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:55:56] VERBOSE[18394][C-00000003] app_dial.c: Nobody picked up in -1 ms [2017-01-16 14:55:56] DEBUG[18299] cdr.c: Finalized CDR for Local/13051002000-18001002000@cont-fas-00000003;2 - start 1484596549.378522 answer 1484596549.379064 end 1484596556.695119 dispo NO ANSWER [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 1168 [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 1168 [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge_native_rtp.c: Bridge '719a406d-e1b6-4c11-8f50-3537836b6149' can not use native RTP bridge as two channels are required [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge.c: Bridge technology native_rtp is not compatible with properties of existing bridge. [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge.c: Bridge technology holding_bridge does not have any capabilities we want. [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge.c: Chose bridge technology simple_bridge [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: calling simple_bridge technology constructor [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: calling simple_bridge technology start [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 703 [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 703 [2017-01-16 14:55:56] DEBUG[18399][C-00000003] bridge_channel.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: 0x7fd2e8014870(PJSIP/flowroute-00000003) is joining [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 725 [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 725 [2017-01-16 14:55:56] DEBUG[18399][C-00000003] bridge_channel.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: pushing 0x7fd2e8014870(PJSIP/flowroute-00000003) [2017-01-16 14:55:56] VERBOSE[18399][C-00000003] bridge_channel.c: Channel PJSIP/flowroute-00000003 joined 'simple_bridge' basic-bridge <719a406d-e1b6-4c11-8f50-3537836b6149> [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 733 [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 733 [2017-01-16 14:55:56] DEBUG[18399][C-00000003] bridge_native_rtp.c: Bridge '719a406d-e1b6-4c11-8f50-3537836b6149' can not use native RTP bridge as two channels are required [2017-01-16 14:55:56] DEBUG[18399][C-00000003] bridge.c: Bridge technology native_rtp is not compatible with properties of existing bridge. [2017-01-16 14:55:56] DEBUG[18399][C-00000003] bridge.c: Bridge technology holding_bridge does not have any capabilities we want. [2017-01-16 14:55:56] DEBUG[18399][C-00000003] bridge.c: Bridge technology softmix does not have any capabilities we want. [2017-01-16 14:55:56] DEBUG[18399][C-00000003] bridge.c: Chose bridge technology simple_bridge [2017-01-16 14:55:56] DEBUG[18399][C-00000003] bridge.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149 is already using the new technology. [2017-01-16 14:55:56] DEBUG[18399][C-00000003] bridge.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: 0x7fd2e8014870(PJSIP/flowroute-00000003) is joining simple_bridge technology [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 1166 [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge_channel.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: 0x7fd2e8001c50(Local/13051002000-18001002000@cont-fas-00000003;2) is joining [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 1166 [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge_channel.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: pushing 0x7fd2e8001c50(Local/13051002000-18001002000@cont-fas-00000003;2) [2017-01-16 14:55:56] VERBOSE[18394][C-00000003] bridge_channel.c: Channel Local/13051002000-18001002000@cont-fas-00000003;2 joined 'simple_bridge' basic-bridge <719a406d-e1b6-4c11-8f50-3537836b6149> [2017-01-16 14:55:56] DEBUG[18296] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_endpoints WHERE id = 'flowroute' [2017-01-16 14:55:56] DEBUG[18296] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd330079890 Query: SELECT * FROM ps_endpoints WHERE id = 'flowroute' [2017-01-16 14:55:56] DEBUG[18296] res_config_pgsql.c: Postgresql RealTime: Could not find any rows in table ps_endpoints@asterisk. [2017-01-16 14:55:56] DEBUG[18299] cdr.c: Finalized CDR for PJSIP/flowroute-00000003 - start 1484596549.831190 answer 1484596556.695031 end 1484596556.695787 dispo ANSWERED [2017-01-16 14:55:56] DEBUG[18296] devicestate.c: Changing state for PJSIP/flowroute - state 2 (In use) [2017-01-16 14:55:56] DEBUG[18394][C-00000003] channel.c: *TMP* hangup_not_doing_anything for Local/13051002000-18001002000@cont-fas-00000003;2 [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge_native_rtp.c: Bridge '719a406d-e1b6-4c11-8f50-3537836b6149' can not use native RTP bridge as it was forbidden while getting details [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge.c: Bridge technology native_rtp is not compatible with properties of existing bridge. [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge.c: Bridge technology holding_bridge does not have any capabilities we want. [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge.c: Bridge technology softmix does not have any capabilities we want. [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge.c: Chose bridge technology simple_bridge [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149 is already using the new technology. [2017-01-16 14:55:56] DEBUG[18394][C-00000003] bridge.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: 0x7fd2e8001c50(Local/13051002000-18001002000@cont-fas-00000003;2) is joining simple_bridge technology [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 721 [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 721 [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 738 [2017-01-16 14:55:56] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 738 [2017-01-16 14:55:57] DEBUG[18320] threadpool.c: Worker thread idle timeout reached. Dying. [2017-01-16 14:55:57] DEBUG[18284] threadpool.c: Destroying worker thread 10 [2017-01-16 14:55:57] DEBUG[18321] threadpool.c: Worker thread idle timeout reached. Dying. [2017-01-16 14:55:57] DEBUG[18284] threadpool.c: Destroying worker thread 11 [2017-01-16 14:56:01] VERBOSE[18287] asterisk.c: Remote UNIX connection [2017-01-16 14:56:01] VERBOSE[18404] asterisk.c: Remote UNIX connection disconnected [2017-01-16 14:56:01] DEBUG[18406][C-00000004] pbx.c: Launching 'Stasis' [2017-01-16 14:56:01] VERBOSE[18405] dial.c: Called 1@cont-ping [2017-01-16 14:56:01] VERBOSE[18406][C-00000004] pbx.c: Executing [1@cont-ping:1] Stasis("Local/1@cont-ping-00000004;2", "mg-bridges,0,0,ping,0,0") in new stack [2017-01-16 14:56:01] DEBUG[18406][C-00000004] stasis/app.c: Channel '1484596561.28' is 1 interested in mg-bridges [2017-01-16 14:56:01] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 633 [2017-01-16 14:56:01] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 633 [2017-01-16 14:56:01] DEBUG[18395] http.c: HTTP Request URI is /ari/channels/1484596561.28/continue [2017-01-16 14:56:01] DEBUG[18395] http.c: match request [ari/channels/1484596561.28/continue] with handler [httpstatus] len 10 [2017-01-16 14:56:01] DEBUG[18395] http.c: match request [ari/channels/1484596561.28/continue] with handler [static] len 6 [2017-01-16 14:56:01] DEBUG[18395] http.c: match request [ari/channels/1484596561.28/continue] with handler [ari] len 3 [2017-01-16 14:56:01] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Finding handler for channels [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Finding handler for 1484596561.28 [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking channelId [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Finding handler for continue [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking continue [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Examining ARI response: 204 No Content [2017-01-16 14:56:01] DEBUG[18395] http.c: HTTP keeping session open. status_code:204 [2017-01-16 14:56:01] DEBUG[18395] http.c: HTTP Request URI is /ari/channels/1484596561.28/continue [2017-01-16 14:56:01] DEBUG[18395] http.c: match request [ari/channels/1484596561.28/continue] with handler [httpstatus] len 10 [2017-01-16 14:56:01] DEBUG[18395] http.c: match request [ari/channels/1484596561.28/continue] with handler [static] len 6 [2017-01-16 14:56:01] DEBUG[18395] http.c: match request [ari/channels/1484596561.28/continue] with handler [ari] len 3 [2017-01-16 14:56:01] DEBUG[18395] http.c: Match made with [ari] [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Finding handler for channels [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking events [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking sounds [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking applications [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking channels [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Finding handler for 1484596561.28 [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking channelId [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Finding handler for continue [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Checking continue [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Got it! [2017-01-16 14:56:01] DEBUG[18395] res_ari.c: Examining ARI response: 204 No Content [2017-01-16 14:56:01] DEBUG[18395] http.c: HTTP keeping session open. status_code:204 [2017-01-16 14:56:01] DEBUG[18406][C-00000004] stasis/app.c: channel '1484596561.28': is 0 interested in mg-bridges [2017-01-16 14:56:01] DEBUG[18406][C-00000004] stasis/app.c: channel '1484596561.28' unsubscribed from mg-bridges [2017-01-16 14:56:01] DEBUG[18406][C-00000004] pbx.c: Launching 'Hangup' [2017-01-16 14:56:01] VERBOSE[18406][C-00000004] pbx.c: Executing [1@cont-ping:2] Hangup("Local/1@cont-ping-00000004;2", "") in new stack [2017-01-16 14:56:01] DEBUG[18406][C-00000004] channel.c: Soft-Hanging (0x20) up channel 'Local/1@cont-ping-00000004;2' [2017-01-16 14:56:01] DEBUG[18406][C-00000004] pbx.c: Spawn extension (cont-ping,1,2) exited non-zero on 'Local/1@cont-ping-00000004;2' [2017-01-16 14:56:01] VERBOSE[18406][C-00000004] pbx.c: Spawn extension (cont-ping, 1, 2) exited non-zero on 'Local/1@cont-ping-00000004;2' [2017-01-16 14:56:01] DEBUG[18406][C-00000004] channel.c: Soft-Hanging (0x10) up channel 'Local/1@cont-ping-00000004;2' [2017-01-16 14:56:01] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 567 [2017-01-16 14:56:01] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 567 [2017-01-16 14:56:01] DEBUG[18406][C-00000004] channel.c: Hanging up channel 'Local/1@cont-ping-00000004;2' [2017-01-16 14:56:01] DEBUG[18406][C-00000004] core_local.c: *TMP* Entering local_hangup [2017-01-16 14:56:01] DEBUG[18406][C-00000004] core_unreal.c: *TMP* ast_unreal_lock_all(Local/1@cont-ping-00000004;2) -> owner: Local/1@cont-ping-00000004;1, chan: Local/1@cont-ping-00000004;2 [2017-01-16 14:56:01] DEBUG[18406][C-00000004] channel.c: *TMP* Received ast_queue_hangup_with_cause for Local/1@cont-ping-00000004;1 [2017-01-16 14:56:01] DEBUG[18406][C-00000004] channel.c: *TMP* ast_queue_hangup_with_cause returning 0 for Local/1@cont-ping-00000004;1 [2017-01-16 14:56:01] DEBUG[18406][C-00000004] core_local.c: *TMP* No_res [2017-01-16 14:56:01] DEBUG[18405] channel.c: *TMP* ast_read_i_am_zombie(Local/1@cont-ping-00000004;1) [2017-01-16 14:56:01] DEBUG[18405] channel.c: *TMP* ast_read_soft(Local/1@cont-ping-00000004;1) [2017-01-16 14:56:01] DEBUG[18405] channel.c: *TMP* hangup_not_doing_anything for Local/1@cont-ping-00000004;1 [2017-01-16 14:56:01] DEBUG[18405] channel.c: *TMP* pending_empty_control_hangup(Local/1@cont-ping-00000004;1)[2017-01-16 14:56:01] DEBUG[18405] channel.c: *TMP* pending_empty_control_end(Local/1@cont-ping-00000004;1)[2017-01-16 14:56:01] DEBUG[18299] cdr.c: Finalized CDR for Local/1@cont-ping-00000004;2 - start 1484596561.361945 answer 0.000000 end 1484596561.562911 dispo NO ANSWER [2017-01-16 14:56:01] DEBUG[18299] cdr.c: Skipping CDR for Local/1@cont-ping-00000004;2 since we weren't answered [2017-01-16 14:56:01] DEBUG[18405] channel.c: Hanging up channel 'Local/1@cont-ping-00000004;1' [2017-01-16 14:56:01] DEBUG[18299] cdr.c: Finalized CDR for Local/1@cont-ping-00000004;1 - start 1484596561.361916 answer 0.000000 end 1484596561.562974 dispo NO ANSWER [2017-01-16 14:56:01] DEBUG[18405] core_local.c: *TMP* Entering local_hangup [2017-01-16 14:56:01] DEBUG[18405] core_unreal.c: *TMP* ast_unreal_lock_all(Local/1@cont-ping-00000004;1) -> owner: Local/1@cont-ping-00000004;1, chan: NULL [2017-01-16 14:56:01] DEBUG[18405] core_local.c: *TMP* No_res [2017-01-16 14:56:01] DEBUG[18405] core_local.c: *TMP* Unlink_locals [2017-01-16 14:56:01] DEBUG[18296] devicestate.c: Changing state for Local/1@cont-ping - state 1 (Not in use) [2017-01-16 14:56:01] DEBUG[18299] cdr.c: Skipping CDR for Local/1@cont-ping-00000004;1 since we weren't answered [2017-01-16 14:56:01] DEBUG[18296] core_local.c: Checking if extension 1@cont-ping exists (devicestate) [2017-01-16 14:56:01] DEBUG[18296] devicestate.c: Changing state for Local/1@cont-ping - state 1 (Not in use) [2017-01-16 14:56:05] DEBUG[18311] res_pjsip/pjsip_distributor.c: Searching for serializer on dialog dlg0x7fd2f400f2d8 for Request msg BYE/cseq=2716201 (rdata0x7fd2dc0080b8) [2017-01-16 14:56:05] DEBUG[18311] res_pjsip/pjsip_distributor.c: Found serializer pjsip/outsess/flowroute-000001de on dialog dlg0x7fd2f400f2d8 [2017-01-16 14:56:05] DEBUG[18312] res_pjsip_session.c: Source of transaction state change is RX_MSG [2017-01-16 14:56:05] DEBUG[18312] res_pjsip_session.c: Received request [2017-01-16 14:56:05] DEBUG[18312] res_pjsip_session.c: Method is BYE [2017-01-16 14:56:05] DEBUG[18399][C-00000003] channel.c: *TMP* ast_read_i_am_zombie(PJSIP/flowroute-00000003) [2017-01-16 14:56:05] DEBUG[18399][C-00000003] channel.c: *TMP* ast_read_soft(PJSIP/flowroute-00000003) [2017-01-16 14:56:05] DEBUG[18399][C-00000003] channel.c: *TMP* hangup_not_doing_anything for PJSIP/flowroute-00000003 [2017-01-16 14:56:05] DEBUG[18399][C-00000003] channel.c: *TMP* pending_empty_control_hangup(PJSIP/flowroute-00000003)[2017-01-16 14:56:05] DEBUG[18399][C-00000003] channel.c: *TMP* pending_empty_control_end(PJSIP/flowroute-00000003)[2017-01-16 14:56:05] DEBUG[18399][C-00000003] bridge_channel.c: Setting 0x7fd2e8014870(PJSIP/flowroute-00000003) state from:0 to:1 [2017-01-16 14:56:05] DEBUG[18399][C-00000003] bridge_channel.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: pulling 0x7fd2e8014870(PJSIP/flowroute-00000003) [2017-01-16 14:56:05] VERBOSE[18399][C-00000003] bridge_channel.c: Channel PJSIP/flowroute-00000003 left 'simple_bridge' basic-bridge <719a406d-e1b6-4c11-8f50-3537836b6149> [2017-01-16 14:56:05] DEBUG[18399][C-00000003] bridge_channel.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: 0x7fd2e8014870(PJSIP/flowroute-00000003) is leaving simple_bridge technology [2017-01-16 14:56:05] DEBUG[18399][C-00000003] bridge.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: dissolving bridge with cause 16(Normal Clearing) [2017-01-16 14:56:05] DEBUG[18399][C-00000003] bridge_channel.c: Setting 0x7fd2e8001c50(Local/13051002000-18001002000@cont-fas-00000003;2) state from:0 to:2 [2017-01-16 14:56:05] DEBUG[18399][C-00000003] channel.c: *TMP* hangup_not_doing_anything for Local/13051002000-18001002000@cont-fas-00000003;2 [2017-01-16 14:56:05] DEBUG[18399][C-00000003] bridge.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149: queueing action type:13 sub:1001 [2017-01-16 14:56:05] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 697 [2017-01-16 14:56:05] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 697 [2017-01-16 14:56:05] DEBUG[18399][C-00000003] bridge.c: Bridge 719a406d-e1b6-4c11-8f50-3537836b6149 is dissolved, not performing smart bridge operation. [2017-01-16 14:56:05] DEBUG[18345] res_http_websocket.c: Writing websocket string of length 702 [2017-01-16 14:56:05] DEBUG[18345] res_http_websocket.c: Writing websocket text frame, length 702 [2017-01-16 14:56:05] DEBUG[18399][C-00000003] channel.c: Hanging up channel 'PJSIP/flowroute-00000003' [2017-01-16 14:56:05] DEBUG[18399][C-00000003] chan_pjsip.c: AST hangup cause 16 (no match found in PJSIP) [2017-01-16 14:56:05] DEBUG[18299] cdr.c: Finalized CDR for Local/13051002000-18001002000@cont-fas-00000003;2 - start 1484596556.695779 answer 1484596556.695779 end 1484596565.287036 dispo ANSWERED [2017-01-16 14:56:05] DEBUG[18299] cdr.c: CDR for PJSIP/flowroute-00000003 is dialed and has no Party B; discarding [2017-01-16 14:56:05] DEBUG[18296] res_config_pgsql.c: PostgreSQL query attempt 1 [2017-01-16 14:56:05] DEBUG[18296] res_config_pgsql.c: PostgreSQL query successful: SELECT * FROM ps_endpoints WHERE id = 'flowroute' [2017-01-16 14:56:05] DEBUG[18296] res_config_pgsql.c: PostgreSQL RealTime: Result=0x7fd330079890 Query: SELECT * FROM ps_endpoints WHERE id = 'flowroute' [2017-01-16 14:56:05] DEBUG[18296] res_config_pgsql.c: Postgresql RealTime: Could not find any rows in table ps_endpoints@asterisk. [2017-01-16 14:56:05] DEBUG[18296] devicestate.c: Changing state for PJSIP/flowroute - state 1 (Not in use)