Bug #39061: Test failure: test_drop_cache_command_timeout_asok (tasks.cephfs.test_misc.TestMisc) - CephFS - Ceph

Actions

Copy link

Bug #39061

closed

Test failure: test_drop_cache_command_timeout_asok (tasks.cephfs.test_misc.TestMisc)

Added by Venky Shankar about 5 years ago. Updated about 5 years ago.

Status:

Duplicate

Priority:

Normal

Assignee:

Category:

Target version:

% Done:

Source:

Tags:

Backport:

Regression:

Severity:

3 - minor

Reviewed:

Affected Versions:

ceph-qa-suite:

Component(FS):

MDS

Labels (FS):

Pull request ID:

Crash signature (v1):

Crash signature (v2):

Description

Seen in luminous run: http://qa-proxy.ceph.com/teuthology/yuriw-2019-03-28_20:44:19-fs-wip-yuri4-testing-2019-03-28-1550-luminous-distro-basic-smithi/3781474/teuthology.log

Dropping client cache should return -ETIMEDOUT if it takes longer then <timeout> seconds for the client to respond. But in the above case:

2019-03-29T00:11:02.052 INFO:teuthology.orchestra.run.smithi087:> rm -rf /home/ubuntu/cephtest/mnt.2
2019-03-29T00:11:02.123 INFO:tasks.cephfs_test_runner:
2019-03-29T00:11:02.123 INFO:tasks.cephfs_test_runner:======================================================================
2019-03-29T00:11:02.124 INFO:tasks.cephfs_test_runner:FAIL: test_drop_cache_command_timeout_asok (tasks.cephfs.test_misc.TestMisc)
2019-03-29T00:11:02.124 INFO:tasks.cephfs_test_runner:----------------------------------------------------------------------
2019-03-29T00:11:02.124 INFO:tasks.cephfs_test_runner:Traceback (most recent call last):
2019-03-29T00:11:02.124 INFO:tasks.cephfs_test_runner:  File "/home/teuthworker/src/github.com_ceph_ceph-c_wip-yuri4-testing-2019-03-28-1550-luminous/qa/tasks/cephfs/test_misc.py", line 281, in test_drop_cache_command_timeout_asok
2019-03-29T00:11:02.124 INFO:tasks.cephfs_test_runner:    self._drop_cache_command_timeout(5, use_tell=False)
2019-03-29T00:11:02.124 INFO:tasks.cephfs_test_runner:  File "/home/teuthworker/src/github.com_ceph_ceph-c_wip-yuri4-testing-2019-03-28-1550-luminous/qa/tasks/cephfs/test_misc.py", line 255, in _drop_cache_command_timeout
2019-03-29T00:11:02.124 INFO:tasks.cephfs_test_runner:    self.assertTrue(drop_res['client_recall']['return_code'] == -errno.ETIMEDOUT)
2019-03-29T00:11:02.125 INFO:tasks.cephfs_test_runner:AssertionError: False is not true
2019-03-29T00:11:02.125 INFO:tasks.cephfs_test_runner:
2019-03-29T00:11:02.125 INFO:tasks.cephfs_test_runner:----------------------------------------------------------------------
2019-03-29T00:11:02.125 INFO:tasks.cephfs_test_runner:Ran 4 tests in 195.060s
2019-03-29T00:11:02.125 INFO:tasks.cephfs_test_runner:
2019-03-29T00:11:02.125 INFO:tasks.cephfs_test_runner:FAILED (failures=1)
2019-03-29T00:11:02.125 INFO:tasks.cephfs_test_runner:

as `cache drop` returned:

2019-03-29T00:11:00.296 INFO:tasks.cephfs.filesystem:_json_asok output: {
    "client_recall": {
        "return_code": 0,
        "message": "(0) Success",
        "recalled": 2706
    },
    "flush_journal": {
        "return_code": 0,
        "message": "" 
    },
    "trim_cache": {
        "trimmed": 0
    },
    "cache": {
        "pool": {
            "items": 16397,
            "bytes": 3252152
        }
    },
    "duration": 3.357389
}