[Feb 13 08:34:38] INFO[16585]: test_runner:307 main: Starting test run for tests/rest_api/bridges/move [Feb 13 08:34:38] DEBUG[16585]: test_runner:165 load_and_parse_module: Importing ari.AriTestObject [Feb 13 08:34:38] DEBUG[16585]: test_runner:41 __init__: TestModuleFinder supports path tests/rest_api/bridges/move [Feb 13 08:34:38] DEBUG[16585]: test_runner:57 find_module: Unable to find module 'queue' [Feb 13 08:34:38] DEBUG[16585]: test_runner:57 find_module: Unable to find module 'http' [Feb 13 08:34:38] DEBUG[16585]: test_runner:57 find_module: Unable to find module 'http' [Feb 13 08:34:38] DEBUG[16585]: test_runner:57 find_module: Unable to find module 'ndg' [Feb 13 08:34:38] DEBUG[16585]: test_runner:57 find_module: Unable to find module 'simplejson' [Feb 13 08:34:39] DEBUG[16585]: test_runner:57 find_module: Unable to find module 'win32api' [Feb 13 08:34:39] DEBUG[16585]: test_runner:57 find_module: Unable to find module 'win32api' [Feb 13 08:34:39] DEBUG[16585]: test_runner:57 find_module: Unable to find module 'wsaccel' [Feb 13 08:34:39] DEBUG[16585]: test_runner:57 find_module: Unable to find module 'wsaccel' [Feb 13 08:34:39] DEBUG[16585]: test_runner:57 find_module: Unable to find module 'snappy' [Feb 13 08:34:39] DEBUG[16585]: test_runner:57 find_module: Unable to find module 'ujson' [Feb 13 08:34:39] DEBUG[16585]: test_conditions:138 register_observer: Registering: [Feb 13 08:34:39] DEBUG[16585]: test_conditions:138 register_observer: Registering: [Feb 13 08:34:39] INFO[16585]: test_case:141 __init__: Executing tests/rest_api/bridges/move [Feb 13 08:34:39] INFO[16585]: ari:242 __init__: WebSocketClientFactory(url=ws://127.0.0.1:8088/ari/events?app=testsuite&api_key=testsuite%3Atestsuite) [Feb 13 08:34:39] INFO[16585]: test_case:213 create_asterisk: Creating Asterisk instance 1 [Feb 13 08:34:39] DEBUG[16585]: test_runner:165 load_and_parse_module: Importing ari.WebSocketEventModule [Feb 13 08:34:39] INFO[16585]: test_case:342 _start_asterisk: Starting Asterisk instance 1 [Feb 13 08:34:39] DEBUG[16585]: asterisk:122 connectionMade: Asterisk 127.0.0.1 - connection made [Feb 13 08:34:40] DEBUG[16585]: asterisk:645 cli_exec: Executing ['/usr/sbin/asterisk', '-C', '/tmp/asterisk-testsuite/e1213247703edfd89239cb97f7b8f0c1/ast1/etc/asterisk/asterisk.conf', '-rx', 'core waitfullybooted'] ... [Feb 13 08:34:43] DEBUG[16585]: asterisk:63 __cli_output_callback: Asterisk CLI 127.0.0.1 exited 0 [Feb 13 08:34:43] DEBUG[16585]: ari:269 reconnect: WebSocket attempt #1 [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: Starting factory [Feb 13 08:34:43] DEBUG[16585]: ari:289 __init__: Made me a client protocol! [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: [('debug', True, 'AriClientFactory'), ('debugCodePaths', False, 'AriClientFactory'), ('logOctets', True, 'AriClientFactory'), ('logFrames', True, 'AriClientFactory'), ('trackTimings', False, 'AriClientFactory'), ('allowHixie76', False, 'AriClientFactory'), ('utf8validateIncoming', True, 'AriClientFactory'), ('applyMask', True, 'AriClientFactory'), ('maxFramePayloadSize', 0, 'AriClientFactory'), ('maxMessagePayloadSize', 0, 'AriClientFactory'), ('autoFragmentSize', 0, 'AriClientFactory'), ('failByDrop', True, 'AriClientFactory'), ('echoCloseCodeReason', False, 'AriClientFactory'), ('openHandshakeTimeout', 5, 'AriClientFactory'), ('closeHandshakeTimeout', 1, 'AriClientFactory'), ('tcpNoDelay', True, 'AriClientFactory'), ('version', 18, 'AriClientFactory'), ('acceptMaskedServerFrames', False, 'AriClientFactory'), ('maskClientFrames', True, 'AriClientFactory'), ('serverConnectionDropTimeout', 1, 'AriClientFactory'), ('perMessageCompressionOffers', [], 'AriClientFactory'), ('perMessageCompressionAccept', at 0x2808398>, 'AriClientFactory')] [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: connection to 127.0.0.1:8088 established [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: GET /ari/events?app=testsuite&api_key=testsuite%3Atestsuite HTTP/1.1 User-Agent: AutobahnPython/0.6.4 Host: 127.0.0.1:8088 Upgrade: WebSocket Connection: Upgrade Pragma: no-cache Cache-Control: no-cache Sec-WebSocket-Key: zr45T0RsB0rvNw9m78Bhug== Sec-WebSocket-Protocol: ari Sec-WebSocket-Version: 13 [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: TX Octets to 127.0.0.1:8088 : sync = False, octets = 474554202f6172692f6576656e74733f6170703d746573747375697465266170695f6b65793d74657374737569746525334174657374737569746520485454502f312e310d0a557365722d4167656e743a204175746f6261686e507974686f6e2f302e362e340d0a486f73743a203132372e302e302e313a383038380d0a557067726164653a20576562536f636b65740d0a436f6e6e656374696f6e3a20557067726164650d0a507261676d613a206e6f2d63616368650d0a43616368652d436f6e74726f6c3a206e6f2d63616368650d0a5365632d576562536f636b65742d4b65793a207a72343554305273423072764e77396d3738426875673d3d0d0a5365632d576562536f636b65742d50726f746f636f6c3a206172690d0a5365632d576562536f636b65742d56657273696f6e3a2031330d0a0d0a [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: RX Octets from 127.0.0.1:8088 : octets = 485454502f312e312031303120537769746368696e672050726f746f636f6c730d0a557067726164653a20576562536f636b65740d0a436f6e6e656374696f6e3a20557067726164650d0a5365632d576562536f636b65742d4163636570743a20426766626635584b4744703455517053486b34564a7677304477773d0d0a5365632d576562536f636b65742d50726f746f636f6c3a206172690d0a0d0a [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: received HTTP response: HTTP/1.1 101 Switching Protocols Upgrade: WebSocket Connection: Upgrade Sec-WebSocket-Accept: Bgfbf5XKGDp4UQpSHk4VJvw0Dww= Sec-WebSocket-Protocol: ari [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: received HTTP status line in opening handshake : HTTP/1.1 101 Switching Protocols [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: received HTTP headers in opening handshake : {'connection': u'Upgrade', 'upgrade': u'WebSocket', 'sec-websocket-protocol': u'ari', 'sec-websocket-accept': u'Bgfbf5XKGDp4UQpSHk4VJvw0Dww='} [Feb 13 08:34:43] DEBUG[16585]: ari:295 onOpen: WebSocket Open [Feb 13 08:34:43] INFO[16585]: test_case:244 create_ami_factory: Creating AMIFactory 1 [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: Starting factory [Feb 13 08:34:43] INFO[16585]: AMI:163 connectionMade: Connection Made [Feb 13 08:34:43] INFO[16585]: AMI:178 onComplete: Login Complete: {'message': 'Authentication accepted', 'response': 'Success', 'actionid': 'asterisk-testsuite-64-centos-49616368-1'} [Feb 13 08:34:43] INFO[16585]: test_case:476 _ami_connect: AMI Connect instance 1 [Feb 13 08:34:43] INFO[16585]: ari:190 _spawn_channel: Creating channel Local/s@default [Feb 13 08:34:43] DEBUG[16585]: ari:154 _new_channel_handler: Tracking channel Local/s@default-00000000;1 [Feb 13 08:34:43] DEBUG[16585]: ari:154 _new_channel_handler: Tracking channel Local/s@default-00000000;2 [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: RX Octets from 127.0.0.1:8088 : octets = 817e01747b226170706c69636174696f6e223a22746573747375697465222c2274797065223a225374617369735374617274222c2274696d657374616d70223a22323031342d30322d31335430383a33343a34332e3635332d30363030222c2261726773223a5b5d2c226368616e6e656c223a7b226964223a22313339323330323038332e32222c227374617465223a225570222c226e616d65223a224c6f63616c2f734064656661756c742d30303030303030303b32222c2263616c6c6572223a7b226e616d65223a22222c226e756d626572223a22227d2c22636f6e6e6563746564223a7b226e616d65223a22222c226e756d626572223a22227d2c226163636f756e74636f6465223a22222c226469616c706c616e223a7b22636f6e74657874223a2264656661756c74222c22657874656e223a2273222c227072696f72697479223a337d2c226372656174696f6e74696d65223a22323031342d30322d31335430383a33343a34332e3134382d30363030227d7d [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: RX Frame from 127.0.0.1:8088 : fin = True, rsv = 0, opcode = 1, mask = -, length = 372, payload = {"application":"testsuite","type":"StasisStart","timestamp":"2014-02-13T08:34:43.653-0600","args":[],"channel":{"id":"1392302083.2","state":"Up","name":"Local/s@default-00000000;2","caller":{"name":"","number":""},"connected":{"name":"","number":""},"accountcode":"","dialplan":{"context":"default","exten":"s","priority":3},"creationtime":"2014-02-13T08:34:43.148-0600"}} [Feb 13 08:34:43] INFO[16585]: twisted:443 emit: Traffic statistics: {"incomingWebSocketFrames": 1, "outgoingWebSocketFrames": 0, "outgoingOctetsWireLevel": 0, "incomingOctetsAppLevel": 372, "incomingWebSocketMessages": 0, "outgoingWebSocketOverhead": null, "incomingOctetsWebSocketLevel": 372, "outgoingCompressionRatio": null, "outgoingWebSocketMessages": 0, "incomingOctetsWireLevel": 376, "incomingWebSocketOverhead": 0.010752688172043012, "outgoingOctetsWebSocketLevel": 0, "outgoingOctetsAppLevel": 0, "incomingCompressionRatio": 1.0} [Feb 13 08:34:43] DEBUG[16585]: ari:308 onMessage: rxed: {"application":"testsuite","type":"StasisStart","timestamp":"2014-02-13T08:34:43.653-0600","args":[],"channel":{"id":"1392302083.2","state":"Up","name":"Local/s@default-00000000;2","caller":{"name":"","number":""},"connected":{"name":"","number":""},"accountcode":"","dialplan":{"context":"default","exten":"s","priority":3},"creationtime":"2014-02-13T08:34:43.148-0600"}} [Feb 13 08:34:43] DEBUG[16585]: ari:217 on_event: Received event: u'StasisStart' [Feb 13 08:34:43] DEBUG[16585]: bridge_move:25 on_start: on_start({u'application': u'testsuite', u'args': [], u'type': u'StasisStart', u'channel': {u'accountcode': u'', u'name': u'Local/s@default-00000000;2', u'caller': {u'name': u'', u'number': u''}, u'creationtime': u'2014-02-13T08:34:43.148-0600', u'state': u'Up', u'connected': {u'name': u'', u'number': u''}, u'dialplan': {u'priority': 3, u'exten': u's', u'context': u'default'}, u'id': u'1392302083.2'}, u'timestamp': u'2014-02-13T08:34:43.653-0600'}) [Feb 13 08:34:43] INFO[16585]: ari:373 post: POST http://127.0.0.1:8088/ari/bridges {} [Feb 13 08:34:43] INFO[16585]: requests.packages.urllib3.connectionpool:176 _new_conn: Starting new HTTP connection (1): 127.0.0.1 [Feb 13 08:34:43] DEBUG[16585]: requests.packages.urllib3.connectionpool:344 _make_request: "POST /ari/bridges HTTP/1.1" 200 162 [Feb 13 08:34:43] INFO[16585]: ari:373 post: POST http://127.0.0.1:8088/ari/bridges {} [Feb 13 08:34:43] INFO[16585]: requests.packages.urllib3.connectionpool:176 _new_conn: Starting new HTTP connection (1): 127.0.0.1 [Feb 13 08:34:43] DEBUG[16585]: requests.packages.urllib3.connectionpool:344 _make_request: "POST /ari/bridges HTTP/1.1" 200 162 [Feb 13 08:34:43] INFO[16585]: ari:373 post: POST http://127.0.0.1:8088/ari/channels/1392302083.2/answer {} [Feb 13 08:34:43] INFO[16585]: requests.packages.urllib3.connectionpool:176 _new_conn: Starting new HTTP connection (1): 127.0.0.1 [Feb 13 08:34:43] DEBUG[16585]: requests.packages.urllib3.connectionpool:344 _make_request: "POST /ari/channels/1392302083.2/answer HTTP/1.1" 204 0 [Feb 13 08:34:43] INFO[16585]: ari:373 post: POST http://127.0.0.1:8088/ari/bridges/c5b0d91f-0e5a-43c4-a1f0-f79969092862/addChannel {'channel': u'1392302083.2'} [Feb 13 08:34:43] INFO[16585]: requests.packages.urllib3.connectionpool:176 _new_conn: Starting new HTTP connection (1): 127.0.0.1 [Feb 13 08:34:44] DEBUG[16585]: requests.packages.urllib3.connectionpool:344 _make_request: "POST /ari/bridges/c5b0d91f-0e5a-43c4-a1f0-f79969092862/addChannel?channel=1392302083.2 HTTP/1.1" 204 0 [Feb 13 08:34:44] INFO[16585]: twisted:443 emit: RX Octets from 127.0.0.1:8088 : octets = 817e022d7b226170706c69636174696f6e223a22746573747375697465222c2274797065223a224368616e6e656c456e7465726564427269646765222c22627269646765223a7b226964223a2263356230643931662d306535612d343363342d613166302d663739393639303932383632222c226368616e6e656c73223a5b22313339323330323038332e32225d2c226e616d65223a22222c22746563686e6f6c6f6779223a2273696d706c655f627269646765222c226272696467655f636c617373223a2262617365222c2263726561746f72223a22537461736973222c226272696467655f74797065223a226d6978696e67227d2c2274696d657374616d70223a22323031342d30322d31335430383a33343a34342e3035362d30363030222c226368616e6e656c223a7b226964223a22313339323330323038332e32222c227374617465223a225570222c226e616d65223a224c6f63616c2f734064656661756c742d30303030303030303b32222c2263616c6c6572223a7b226e616d65223a22222c226e756d626572223a22227d2c22636f6e6e6563746564223a7b226e616d65223a22222c226e756d626572223a22227d2c226163636f756e74636f6465223a22222c226469616c706c616e223a7b22636f6e74657874223a2264656661756c74222c22657874656e223a2273222c227072696f72697479223a337d2c226372656174696f6e74696d65223a22323031342d30322d31335430383a33343a34332e3134382d30363030227d7d [Feb 13 08:34:44] INFO[16585]: twisted:443 emit: RX Frame from 127.0.0.1:8088 : fin = True, rsv = 0, opcode = 1, mask = -, length = 557, payload = {"application":"testsuite","type":"ChannelEnteredBridge","bridge":{"id":"c5b0d91f-0e5a-43c4-a1f0-f79969092862","channels":["1392302083.2"],"name":"","technology":"simple_bridge","bridge_class":"base","creator":"Stasis","bridge_type":"mixing"},"timestamp":"2014-02-13T08:34:44.056-0600","channel":{"id":"1392302083.2","state":"Up","name":"Local/s@default-00000000;2","caller":{"name":"","number":""},"connected":{"name":"","number":""},"accountcode":"","dialplan":{"context":"default","exten":"s","priority":3},"creationtime":"2014-02-13T08:34:43.148-0600"}} [Feb 13 08:34:44] INFO[16585]: twisted:443 emit: Traffic statistics: {"incomingWebSocketFrames": 2, "outgoingWebSocketFrames": 0, "outgoingOctetsWireLevel": 0, "incomingOctetsAppLevel": 929, "incomingWebSocketMessages": 1, "outgoingWebSocketOverhead": null, "incomingOctetsWebSocketLevel": 929, "outgoingCompressionRatio": null, "outgoingWebSocketMessages": 0, "incomingOctetsWireLevel": 937, "incomingWebSocketOverhead": 0.0086114101184068884, "outgoingOctetsWebSocketLevel": 0, "outgoingOctetsAppLevel": 0, "incomingCompressionRatio": 1.0} [Feb 13 08:34:44] DEBUG[16585]: ari:308 onMessage: rxed: {"application":"testsuite","type":"ChannelEnteredBridge","bridge":{"id":"c5b0d91f-0e5a-43c4-a1f0-f79969092862","channels":["1392302083.2"],"name":"","technology":"simple_bridge","bridge_class":"base","creator":"Stasis","bridge_type":"mixing"},"timestamp":"2014-02-13T08:34:44.056-0600","channel":{"id":"1392302083.2","state":"Up","name":"Local/s@default-00000000;2","caller":{"name":"","number":""},"connected":{"name":"","number":""},"accountcode":"","dialplan":{"context":"default","exten":"s","priority":3},"creationtime":"2014-02-13T08:34:43.148-0600"}} [Feb 13 08:34:44] DEBUG[16585]: ari:217 on_event: Received event: u'ChannelEnteredBridge' [Feb 13 08:34:44] INFO[16585]: ari:373 post: POST http://127.0.0.1:8088/ari/bridges/d120f66d-7b18-4b92-aec0-c20fd5fc13eb/addChannel {'channel': u'1392302083.2'} [Feb 13 08:34:44] INFO[16585]: requests.packages.urllib3.connectionpool:176 _new_conn: Starting new HTTP connection (1): 127.0.0.1 [Feb 13 08:34:44] DEBUG[16585]: requests.packages.urllib3.connectionpool:344 _make_request: "POST /ari/bridges/d120f66d-7b18-4b92-aec0-c20fd5fc13eb/addChannel?channel=1392302083.2 HTTP/1.1" 204 0 [Feb 13 08:34:44] INFO[16585]: twisted:443 emit: RX Octets from 127.0.0.1:8088 : octets = 817e021c7b226170706c69636174696f6e223a22746573747375697465222c2274797065223a224368616e6e656c4c656674427269646765222c22627269646765223a7b226964223a2263356230643931662d306535612d343363342d613166302d663739393639303932383632222c226368616e6e656c73223a5b5d2c226e616d65223a22222c22746563686e6f6c6f6779223a2273696d706c655f627269646765222c226272696467655f636c617373223a2262617365222c2263726561746f72223a22537461736973222c226272696467655f74797065223a226d6978696e67227d2c2274696d657374616d70223a22323031342d30322d31335430383a33343a34342e3036352d30363030222c226368616e6e656c223a7b226964223a22313339323330323038332e32222c227374617465223a225570222c226e616d65223a224c6f63616c2f734064656661756c742d30303030303030303b32222c2263616c6c6572223a7b226e616d65223a22222c226e756d626572223a22227d2c22636f6e6e6563746564223a7b226e616d65223a22222c226e756d626572223a22227d2c226163636f756e74636f6465223a22222c226469616c706c616e223a7b22636f6e74657874223a2264656661756c74222c22657874656e223a2273222c227072696f72697479223a337d2c226372656174696f6e74696d65223a22323031342d30322d31335430383a33343a34332e3134382d30363030227d7d [Feb 13 08:34:44] INFO[16585]: twisted:443 emit: RX Frame from 127.0.0.1:8088 : fin = True, rsv = 0, opcode = 1, mask = -, length = 540, payload = {"application":"testsuite","type":"ChannelLeftBridge","bridge":{"id":"c5b0d91f-0e5a-43c4-a1f0-f79969092862","channels":[],"name":"","technology":"simple_bridge","bridge_class":"base","creator":"Stasis","bridge_type":"mixing"},"timestamp":"2014-02-13T08:34:44.065-0600","channel":{"id":"1392302083.2","state":"Up","name":"Local/s@default-00000000;2","caller":{"name":"","number":""},"connected":{"name":"","number":""},"accountcode":"","dialplan":{"context":"default","exten":"s","priority":3},"creationtime":"2014-02-13T08:34:43.148-0600"}} [Feb 13 08:34:44] INFO[16585]: twisted:443 emit: Traffic statistics: {"incomingWebSocketFrames": 3, "outgoingWebSocketFrames": 0, "outgoingOctetsWireLevel": 0, "incomingOctetsAppLevel": 1469, "incomingWebSocketMessages": 2, "outgoingWebSocketOverhead": null, "incomingOctetsWebSocketLevel": 1469, "outgoingCompressionRatio": null, "outgoingWebSocketMessages": 0, "incomingOctetsWireLevel": 1481, "incomingWebSocketOverhead": 0.008168822328114363, "outgoingOctetsWebSocketLevel": 0, "outgoingOctetsAppLevel": 0, "incomingCompressionRatio": 1.0} [Feb 13 08:34:44] DEBUG[16585]: ari:308 onMessage: rxed: {"application":"testsuite","type":"ChannelLeftBridge","bridge":{"id":"c5b0d91f-0e5a-43c4-a1f0-f79969092862","channels":[],"name":"","technology":"simple_bridge","bridge_class":"base","creator":"Stasis","bridge_type":"mixing"},"timestamp":"2014-02-13T08:34:44.065-0600","channel":{"id":"1392302083.2","state":"Up","name":"Local/s@default-00000000;2","caller":{"name":"","number":""},"connected":{"name":"","number":""},"accountcode":"","dialplan":{"context":"default","exten":"s","priority":3},"creationtime":"2014-02-13T08:34:43.148-0600"}} [Feb 13 08:34:44] DEBUG[16585]: ari:217 on_event: Received event: u'ChannelLeftBridge' [Feb 13 08:35:13] WARNING[16585]: test_case:426 _reactor_timeout: Reactor timeout: '30' seconds [Feb 13 08:35:13] INFO[16585]: test_case:385 __stop_instances: Stopping Asterisk instance 1 [Feb 13 08:35:13] DEBUG[16585]: asterisk:381 __send_stop_gracefully: sending stop gracefully [Feb 13 08:35:13] DEBUG[16585]: asterisk:645 cli_exec: Executing ['/usr/sbin/asterisk', '-C', '/tmp/asterisk-testsuite/e1213247703edfd89239cb97f7b8f0c1/ast1/etc/asterisk/asterisk.conf', '-rx', 'core stop gracefully'] ... [Feb 13 08:35:23] WARNING[16585]: asterisk:404 __send_kill: Sending KILL to Asterisk 127.0.0.1 [Feb 13 08:35:23] ERROR[16585]: ari:467 on_stop: Expected 2 <= count <= 2; was 1 ({'match': {'application': 'testsuite', 'type': 'ChannelEnteredBridge'}}) [Feb 13 08:35:23] ERROR[16585]: ari:467 on_stop: Expected 2 <= count <= 2; was 1 ({'match': {'application': 'testsuite', 'type': 'ChannelLeftBridge'}}) [Feb 13 08:35:23] ERROR[16585]: ari:467 on_stop: Expected 1 <= count <= 1; was 0 ({'match': {'application': 'testsuite', 'type': 'StasisEnd'}}) [Feb 13 08:35:23] INFO[16585]: test_case:406 __stop_reactor: Stopping Reactor [Feb 13 08:35:23] INFO[16585]: twisted:443 emit: Stopping factory [Feb 13 08:35:23] DEBUG[16585]: ari:300 onClose: WebSocket closed(False, 1006, connection was closed uncleanly (peer dropped the TCP connection without previous WebSocket closing handshake)) [Feb 13 08:35:23] DEBUG[16585]: ari:131 on_ws_closed: WebSocket connection closed... [Feb 13 08:35:23] INFO[16585]: twisted:443 emit: connection to 127.0.0.1:8088 lost [Feb 13 08:35:23] INFO[16585]: twisted:443 emit: Stopping factory [Feb 13 08:35:23] INFO[16585]: twisted:443 emit: Main loop terminated. [Feb 13 08:35:23] INFO[16585]: test_runner:325 main: Test run for tests/rest_api/bridges/move completed with result False [Feb 13 08:35:23] INFO[16697]: test_runner:307 main: Starting test run for tests/rest_api/bridges/delete