Project

General

Profile

Actions

Bug #47269

closed

nautilus make check failure: run-tox-mgr-dashboard test fails in IscsiTestController.test_remove_client_logged_in

Added by Vikhyat Umrao over 3 years ago. Updated about 3 years ago.

Status:
Resolved
Priority:
Urgent
Assignee:
Category:
Component - iSCSI
Target version:
-
% Done:

0%

Source:
Tags:
Backport:
Regression:
No
Severity:
3 - minor
Reviewed:
Affected Versions:
ceph-qa-suite:
Pull request ID:
Crash signature (v1):
Crash signature (v2):

Description

- From any number of nautilus backport prs - e.g. https://github.com/ceph/ceph/pull/36944, https://github.com/ceph/ceph/pull/37033, etc. (presumably also reproducible on tip of nautilus branch)
- Jenkins log file - https://jenkins.ceph.com/job/ceph-pull-requests/58924/consoleText

=================================== FAILURES ===================================
_______________ IscsiTestController.test_remove_client_logged_in _______________

self = <dashboard.tests.test_iscsi.IscsiTestController testMethod=test_remove_client_logged_in>
_validate_image_mock = <MagicMock name='_validate_image' id='140569011517264'>

    @mock.patch('dashboard.controllers.iscsi.IscsiTarget._validate_image')
    def test_remove_client_logged_in(self, _validate_image_mock):
        client_info = {
            'alias': '',
            'ip_address': [],
            'state': {'LOGGED_IN': ['node1']}
        }
        # pylint: disable=protected-access
        IscsiClientMock._instance.clientinfo = client_info
        target_iqn = "iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19" 
        create_request = copy.deepcopy(iscsi_target_request)
        create_request['target_iqn'] = target_iqn
        update_request = copy.deepcopy(create_request)
        update_request['new_target_iqn'] = target_iqn
        update_request['clients'].pop(0)
        response = copy.deepcopy(iscsi_target_response)
        response['target_iqn'] = target_iqn
        for client in response['clients']:
            client['info'] = client_info
        update_response = {
            'detail': "Client 'iqn.1994-05.com.redhat:rh7-client' cannot be deleted until it's " 
                      "logged out",
            'code': 'client_logged_in',
            'component': 'iscsi'
        }
>       self._update_iscsi_target(create_request, update_request, 400, update_response, response)

tests/test_iscsi.py:505: 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
tests/test_iscsi.py:526: in _update_iscsi_target
    self.assertJsonBody(update_response)
tests/__init__.py:255: in assertJsonBody
    self._handlewebError(msg)
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 

self = <dashboard.tests.test_iscsi.IscsiTestController testMethod=test_remove_client_logged_in>
msg = 'expected body:\n{\'detail\': "Client \'iqn.1994-05.com.redhat:rh7-client\' cannot be deleted until it\'s logged out",...rh7-client2\' cannot be deleted until it\'s logged out", u\'code\': u\'client_logged_in\', u\'component\': u\'iscsi\'}'

    def _handlewebError(self, msg):
        print('')
        print('    ERROR: %s' % msg)

        if not self.interactive:
>           raise self.failureException(msg)
E           AssertionError: expected body:
E           {'detail': "Client 'iqn.1994-05.com.redhat:rh7-client' cannot be deleted until it's logged out", 'code': 'client_logged_in', 'component': 'iscsi'}
E           
E           actual body:
E           {u'detail': u"Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out", u'code': u'client_logged_in', u'component': u'iscsi'}

../../../../build/dashboard/py27-cov/local/lib/python2.7/site-packages/cheroot/test/webtest.py:325: AssertionError
----------------------------- Captured stdout call -----------------------------

    ERROR: expected body:
{'detail': "Client 'iqn.1994-05.com.redhat:rh7-client' cannot be deleted until it's logged out", 'code': 'client_logged_in', 'component': 'iscsi'}

actual body:
{u'detail': u"Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out", u'code': u'client_logged_in', u'component': u'iscsi'}

Related issues 1 (0 open1 closed)

Related to Dashboard - Backport #47558: nautilus: mgr/dashboard: Its currently not possible to edit some parts of iSCSI target when a user is connectedResolvedTiago MeloActions
Actions #1

Updated by Vikhyat Umrao over 3 years ago

Another PR - https://github.com/ceph/ceph/pull/36930 which has similar report.

Actions #2

Updated by Vikhyat Umrao over 3 years ago

- More backtraces:

----------------------------- Captured stderr call -----------------------------
DEBUG:dashboard:TM: created Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
INFO:dashboard:TM: running Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was registered for events of type cd_task_finished
DEBUG:dashboard:TEX: executing task Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:EX: successfully finished task: Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:TK: execution of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'}) finished in: 0.0216221809387 s
DEBUG:dashboard:NQ: processing queue: 1
INFO:dashboard:TM: finished Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was deregistered for events of type cd_task_finished
INFO:cherrypy.access.140569013684176:127.0.0.1 - - [01/Sep/2020:16:03:41] "POST /api/iscsi/target HTTP/1.1" 201 4 "" "" 
INFO:dashboard:task finished immediately
DEBUG:dashboard:TM: created Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
INFO:dashboard:TM: running Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was registered for events of type cd_task_finished
DEBUG:dashboard:TEX: executing task Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
ERROR:dashboard:Error while calling Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/tools.py", line 555, in _run
    val = self.task.fn(*self.task.fn_args, **self.task.fn_kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 328, in set
    disks, clients, groups)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 666, in _validate_delete
    component='iscsi')
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out
tools.py                   557 ERROR    Error while calling Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/tools.py", line 555, in _run
    val = self.task.fn(*self.task.fn_args, **self.task.fn_kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 328, in set
    disks, clients, groups)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 666, in _validate_delete
    component='iscsi')
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out 
DEBUG:dashboard:EX: task finished with exception: Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:TK: execution of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'}) finished in: 0.0267839431763 s
DEBUG:dashboard:NQ: processing queue: 1
INFO:dashboard:TM: finished Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was deregistered for events of type cd_task_finished
ERROR:dashboard:dashboard_exception_handler
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/services/exception.py", line 88, in dashboard_exception_handler
    return handler(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/build/dashboard/py27-cov/local/lib/python2.7/site-packages/cherrypy/_cpdispatch.py", line 60, in __call__
    return self.callable(*self.args, **self.kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 662, in inner
    ret = func(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 855, in wrapper
    return func(*vpath, **params)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 463, in wrapper
    raise ex
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out
exception.py                91 ERROR    dashboard_exception_handler
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/services/exception.py", line 88, in dashboard_exception_handler
    return handler(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/build/dashboard/py27-cov/local/lib/python2.7/site-packages/cherrypy/_cpdispatch.py", line 60, in __call__
    return self.callable(*self.args, **self.kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 662, in inner
    ret = func(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 855, in wrapper
    return func(*vpath, **params)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 463, in wrapper
    raise ex
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out
INFO:cherrypy.access.140569013684176:127.0.0.1 - - [01/Sep/2020:16:03:41] "PUT /api/iscsi/target/iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19 HTTP/1.1" 400 147 "" "" 
INFO:dashboard:task finished immediately
------------------------------ Captured log call -------------------------------
tools.py                   449 DEBUG    TM: created Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   451 INFO     TM: running Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   336 DEBUG    NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was registered for events of type cd_task_finished
tools.py                   554 DEBUG    TEX: executing task Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   535 DEBUG    EX: successfully finished task: Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   624 DEBUG    TK: execution of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'}) finished in: 0.0216221809387 s
tools.py                   390 DEBUG    NQ: processing queue: 1
tools.py                   427 INFO     TM: finished Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   367 DEBUG    NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was deregistered for events of type cd_task_finished
_cplogging.py              310 INFO     127.0.0.1 - - [01/Sep/2020:16:03:41] "POST /api/iscsi/target HTTP/1.1" 201 4 "" "" 
__init__.py                171 INFO     task finished immediately
tools.py                   449 DEBUG    TM: created Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   451 INFO     TM: running Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   336 DEBUG    NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was registered for events of type cd_task_finished
tools.py                   554 DEBUG    TEX: executing task Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   557 ERROR    Error while calling Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/tools.py", line 555, in _run
    val = self.task.fn(*self.task.fn_args, **self.task.fn_kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 328, in set
    disks, clients, groups)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 666, in _validate_delete
    component='iscsi')
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out
tools.py                   537 DEBUG    EX: task finished with exception: Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   624 DEBUG    TK: execution of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'}) finished in: 0.0267839431763 s
tools.py                   390 DEBUG    NQ: processing queue: 1
tools.py                   427 INFO     TM: finished Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   367 DEBUG    NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was deregistered for events of type cd_task_finished
exception.py                91 ERROR    dashboard_exception_handler
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/services/exception.py", line 88, in dashboard_exception_handler
    return handler(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/build/dashboard/py27-cov/local/lib/python2.7/site-packages/cherrypy/_cpdispatch.py", line 60, in __call__
    return self.callable(*self.args, **self.kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 662, in inner
    ret = func(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 855, in wrapper
    return func(*vpath, **params)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 463, in wrapper
    raise ex
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out
_cplogging.py              310 INFO     127.0.0.1 - - [01/Sep/2020:16:03:41] "PUT /api/iscsi/target/iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19 HTTP/1.1" 400 147 "" "" 
__init__.py                171 INFO     task finished immediately
==================== 1 failed, 314 passed in 107.54 seconds ====================
ERROR: InvocationError: '/home/jenkins-build/build/workspace/ceph-pull-requests/build/dashboard/py27-cov/bin/py.test --cov=. --cov-report= --junitxml=junit.py27-cov.xml --doctest-modules controllers services/ tests/ tools.py'
Actions #3

Updated by Jason Dillaman over 3 years ago

  • Project changed from rbd to mgr
  • Category set to 141
Actions #4

Updated by Josh Durgin over 3 years ago

Another instance: https://github.com/ceph/ceph/pull/37033

=================================== FAILURES ===================================
_______________ IscsiTestController.test_remove_client_logged_in _______________

self = <dashboard.tests.test_iscsi.IscsiTestController testMethod=test_remove_client_logged_in>
_validate_image_mock = <MagicMock name='_validate_image' id='140605790728080'>

    @mock.patch('dashboard.controllers.iscsi.IscsiTarget._validate_image')
    def test_remove_client_logged_in(self, _validate_image_mock):
        client_info = {
            'alias': '',
            'ip_address': [],
            'state': {'LOGGED_IN': ['node1']}
        }
        # pylint: disable=protected-access
        IscsiClientMock._instance.clientinfo = client_info
        target_iqn = "iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19" 
        create_request = copy.deepcopy(iscsi_target_request)
        create_request['target_iqn'] = target_iqn
        update_request = copy.deepcopy(create_request)
        update_request['new_target_iqn'] = target_iqn
        update_request['clients'].pop(0)
        response = copy.deepcopy(iscsi_target_response)
        response['target_iqn'] = target_iqn
        for client in response['clients']:
            client['info'] = client_info
        update_response = {
            'detail': "Client 'iqn.1994-05.com.redhat:rh7-client' cannot be deleted until it's " 
                      "logged out",
            'code': 'client_logged_in',
            'component': 'iscsi'
        }
>       self._update_iscsi_target(create_request, update_request, 400, update_response, response)

tests/test_iscsi.py:505: 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
tests/test_iscsi.py:526: in _update_iscsi_target
    self.assertJsonBody(update_response)
tests/__init__.py:255: in assertJsonBody
    self._handlewebError(msg)
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 

self = <dashboard.tests.test_iscsi.IscsiTestController testMethod=test_remove_client_logged_in>
msg = 'expected body:\n{\'detail\': "Client \'iqn.1994-05.com.redhat:rh7-client\' cannot be deleted until it\'s logged out",...rh7-client2\' cannot be deleted until it\'s logged out", u\'component\': u\'iscsi\', u\'code\': u\'client_logged_in\'}'

    def _handlewebError(self, msg):
        print('')
        print('    ERROR: %s' % msg)

        if not self.interactive:
>           raise self.failureException(msg)
E           AssertionError: expected body:
E           {'detail': "Client 'iqn.1994-05.com.redhat:rh7-client' cannot be deleted until it's logged out", 'component': 'iscsi', 'code': 'client_logged_in'}
E           
E           actual body:
E           {u'detail': u"Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out", u'component': u'iscsi', u'code': u'client_logged_in'}

../../../../build/dashboard/py27-cov/local/lib/python2.7/site-packages/cheroot/test/webtest.py:325: AssertionError
----------------------------- Captured stdout call -----------------------------

    ERROR: expected body:
{'detail': "Client 'iqn.1994-05.com.redhat:rh7-client' cannot be deleted until it's logged out", 'component': 'iscsi', 'code': 'client_logged_in'}

actual body:
{u'detail': u"Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out", u'component': u'iscsi', u'code': u'client_logged_in'}
----------------------------- Captured stderr call -----------------------------
DEBUG:dashboard:TM: created Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
INFO:dashboard:TM: running Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was registered for events of type cd_task_finished
DEBUG:dashboard:TEX: executing task Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:EX: successfully finished task: Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:TK: execution of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'}) finished in: 0.0154240131378 s
DEBUG:dashboard:NQ: processing queue: 1
INFO:dashboard:TM: finished Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was deregistered for events of type cd_task_finished
INFO:cherrypy.access.140605793442000:127.0.0.1 - - [14/Sep/2020:17:41:58] "POST /api/iscsi/target HTTP/1.1" 201 4 "" "" 
INFO:dashboard:task finished immediately
DEBUG:dashboard:TM: created Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
INFO:dashboard:TM: running Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was registered for events of type cd_task_finished
DEBUG:dashboard:TEX: executing task Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
ERROR:dashboard:Error while calling Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/tools.py", line 555, in _run
    val = self.task.fn(*self.task.fn_args, **self.task.fn_kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 328, in set
    disks, clients, groups)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 666, in _validate_delete
    component='iscsi')
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out
tools.py                   557 ERROR    Error while calling Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/tools.py", line 555, in _run
    val = self.task.fn(*self.task.fn_args, **self.task.fn_kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 328, in set
    disks, clients, groups)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 666, in _validate_delete
    component='iscsi')
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out
DEBUG:dashboard:EX: task finished with exception: Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:TK: execution of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'}) finished in: 0.0243968963623 s
DEBUG:dashboard:NQ: processing queue: 1
INFO:dashboard:TM: finished Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
DEBUG:dashboard:NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was deregistered for events of type cd_task_finished
ERROR:dashboard:dashboard_exception_handler
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/services/exception.py", line 88, in dashboard_exception_handler
    return handler(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/build/dashboard/py27-cov/local/lib/python2.7/site-packages/cherrypy/_cpdispatch.py", line 60, in __call__
    return self.callable(*self.args, **self.kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 662, in inner
    ret = func(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 855, in wrapper
    return func(*vpath, **params)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 463, in wrapper
    raise ex
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out
exception.py                91 ERROR    dashboard_exception_handler
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/services/exception.py", line 88, in dashboard_exception_handler
    return handler(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/build/dashboard/py27-cov/local/lib/python2.7/site-packages/cherrypy/_cpdispatch.py", line 60, in __call__
    return self.callable(*self.args, **self.kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 662, in inner
    ret = func(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 855, in wrapper
    return func(*vpath, **params)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 463, in wrapper
    raise ex
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out
INFO:cherrypy.access.140605793442000:127.0.0.1 - - [14/Sep/2020:17:41:58] "PUT /api/iscsi/target/iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19 HTTP/1.1" 400 147 "" "" 
INFO:dashboard:task finished immediately
------------------------------ Captured log call -------------------------------
tools.py                   449 DEBUG    TM: created Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   451 INFO     TM: running Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   336 DEBUG    NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was registered for events of type cd_task_finished
tools.py                   554 DEBUG    TEX: executing task Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   535 DEBUG    EX: successfully finished task: Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   624 DEBUG    TK: execution of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'}) finished in: 0.0154240131378 s
tools.py                   390 DEBUG    NQ: processing queue: 1
tools.py                   427 INFO     TM: finished Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   367 DEBUG    NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/create, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was deregistered for events of type cd_task_finished
_cplogging.py              310 INFO     127.0.0.1 - - [14/Sep/2020:17:41:58] "POST /api/iscsi/target HTTP/1.1" 201 4 "" "" 
__init__.py                171 INFO     task finished immediately
tools.py                   449 DEBUG    TM: created Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   451 INFO     TM: running Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   336 DEBUG    NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was registered for events of type cd_task_finished
tools.py                   554 DEBUG    TEX: executing task Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   557 ERROR    Error while calling Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/tools.py", line 555, in _run
    val = self.task.fn(*self.task.fn_args, **self.task.fn_kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 328, in set
    disks, clients, groups)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/iscsi.py", line 666, in _validate_delete
    component='iscsi')
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out
tools.py                   537 DEBUG    EX: task finished with exception: Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   624 DEBUG    TK: execution of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'}) finished in: 0.0243968963623 s
tools.py                   390 DEBUG    NQ: processing queue: 1
tools.py                   427 INFO     TM: finished Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})
tools.py                   367 DEBUG    NQ: function <bound method Task._handle_task_finished of Task(ns=iscsi/target/edit, md={'target_iqn': u'iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19'})> was deregistered for events of type cd_task_finished
exception.py                91 ERROR    dashboard_exception_handler
Traceback (most recent call last):
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/services/exception.py", line 88, in dashboard_exception_handler
    return handler(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/build/dashboard/py27-cov/local/lib/python2.7/site-packages/cherrypy/_cpdispatch.py", line 60, in __call__
    return self.callable(*self.args, **self.kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 662, in inner
    ret = func(*args, **kwargs)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 855, in wrapper
    return func(*vpath, **params)
  File "/home/jenkins-build/build/workspace/ceph-pull-requests/src/pybind/mgr/dashboard/controllers/__init__.py", line 463, in wrapper
    raise ex
DashboardException: Client 'iqn.1994-05.com.redhat:rh7-client2' cannot be deleted until it's logged out
_cplogging.py              310 INFO     127.0.0.1 - - [14/Sep/2020:17:41:58] "PUT /api/iscsi/target/iqn.2003-01.com.redhat.iscsi-gw:iscsi-igw19 HTTP/1.1" 400 147 "" "" 
__init__.py                171 INFO     task finished immediately
==================== 1 failed, 314 passed in 104.69 seconds ====================

Actions #5

Updated by Nathan Cutler over 3 years ago

  • Description updated (diff)

Happening in multiple nautilus PRs. Presumably also on tip of nautilus branch?

Actions #6

Updated by Lenz Grimmer over 3 years ago

Looks like this backport PR is the culprit?

https://github.com/ceph/ceph/pull/36613

Actions #7

Updated by Lenz Grimmer over 3 years ago

  • Assignee set to Tiago Melo
Actions #8

Updated by Tiago Melo over 3 years ago

I was finally able to reproduce the problem and I'm testing if a backport of https://tracker.ceph.com/issues/47393 will fix the issue.
So far it hasn't failed: https://github.com/ceph/ceph/pull/37155 (3 successes)

Actions #9

Updated by Yuri Weinstein over 3 years ago

  • Priority changed from High to Urgent

This is slowing down PRs merging process, pls take a look !

Actions #10

Updated by Laura Paduano over 3 years ago

  • Related to Backport #47558: nautilus: mgr/dashboard: Its currently not possible to edit some parts of iSCSI target when a user is connected added
Actions #11

Updated by Laura Paduano over 3 years ago

I just merged the backport PR (https://github.com/ceph/ceph/pull/37278) and hope the issue will be fixed.

Actions #12

Updated by Nathan Cutler over 3 years ago

  • Status changed from New to Resolved
  • Pull request ID set to 37278
Actions #13

Updated by Ernesto Puerta about 3 years ago

  • Project changed from mgr to Dashboard
  • Category changed from 141 to Component - iSCSI
Actions

Also available in: Atom PDF