Nodes: mira012 mira053

Description: fs/basic_functional/{begin.yaml clusters/1-mds-4-client-coloc.yaml conf/{client.yaml mds.yaml mon.yaml osd.yaml} mount/fuse.yaml objectstore/bluestore-ec-root.yaml overrides/{frag_enable.yaml no_client_pidfile.yaml whitelist_health.yaml whitelist_wrongly_marked_down.yaml} supported-random-distros$/{rhel_latest.yaml} tasks/libcephfs_python.yaml}

Log: http://qa-proxy.ceph.com/teuthology/vshankar-2018-09-19_15:06:02-fs-wip-cephfs-tools-rank-ops-distro-basic-mira/3043394/teuthology.log

Sentry event: http://sentry.ceph.com/sepia/teuthology/?q=31ec2e40644c4506b5dbd883525ed1c9

Failure Reason:

{'mira012.front.sepia.ceph.com': {'_ansible_parsed': True, 'stderr_lines': ["Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out"], 'cmd': ['timedatectl', 'set-timezone', 'Etc/UTC'], 'end': '2018-09-20 09:17:36.046564', '_ansible_no_log': False, 'stdout': '', 'changed': True, 'invocation': {'module_args': {'creates': None, 'executable': None, 'chdir': None, '_raw_params': 'timedatectl set-timezone Etc/UTC', 'removes': None, 'warn': True, '_uses_shell': False, 'stdin': None}}, 'start': '2018-09-20 09:17:11.028014', 'delta': '0:00:25.018550', 'stderr': "Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out", 'rc': 1, 'msg': 'non-zero return code', 'stdout_lines': []}, 'mira053.front.sepia.ceph.com': {'_ansible_parsed': True, 'stderr_lines': ["Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out"], 'cmd': ['timedatectl', 'set-timezone', 'Etc/UTC'], 'end': '2018-09-20 09:17:35.675221', '_ansible_no_log': False, 'stdout': '', 'changed': True, 'invocation': {'module_args': {'creates': None, 'executable': None, 'chdir': None, '_raw_params': 'timedatectl set-timezone Etc/UTC', 'removes': None, 'warn': True, '_uses_shell': False, 'stdin': None}}, 'start': '2018-09-20 09:17:10.663489', 'delta': '0:00:25.011732', 'stderr': "Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out", 'rc': 1, 'msg': 'non-zero return code', 'stdout_lines': []}}

  • log_href: http://qa-proxy.ceph.com/teuthology/vshankar-2018-09-19_15:06:02-fs-wip-cephfs-tools-rank-ops-distro-basic-mira/3043394/teuthology.log
  • archive_path: /home/teuthworker/archive/vshankar-2018-09-19_15:06:02-fs-wip-cephfs-tools-rank-ops-distro-basic-mira/3043394
  • description: fs/basic_functional/{begin.yaml clusters/1-mds-4-client-coloc.yaml conf/{client.yaml mds.yaml mon.yaml osd.yaml} mount/fuse.yaml objectstore/bluestore-ec-root.yaml overrides/{frag_enable.yaml no_client_pidfile.yaml whitelist_health.yaml whitelist_wrongly_marked_down.yaml} supported-random-distros$/{rhel_latest.yaml} tasks/libcephfs_python.yaml}
  • duration: 0:02:52
  • email: vshankar@redhat.com
  • failure_reason: {'mira012.front.sepia.ceph.com': {'_ansible_parsed': True, 'stderr_lines': ["Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out"], 'cmd': ['timedatectl', 'set-timezone', 'Etc/UTC'], 'end': '2018-09-20 09:17:36.046564', '_ansible_no_log': False, 'stdout': '', 'changed': True, 'invocation': {'module_args': {'creates': None, 'executable': None, 'chdir': None, '_raw_params': 'timedatectl set-timezone Etc/UTC', 'removes': None, 'warn': True, '_uses_shell': False, 'stdin': None}}, 'start': '2018-09-20 09:17:11.028014', 'delta': '0:00:25.018550', 'stderr': "Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out", 'rc': 1, 'msg': 'non-zero return code', 'stdout_lines': []}, 'mira053.front.sepia.ceph.com': {'_ansible_parsed': True, 'stderr_lines': ["Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out"], 'cmd': ['timedatectl', 'set-timezone', 'Etc/UTC'], 'end': '2018-09-20 09:17:35.675221', '_ansible_no_log': False, 'stdout': '', 'changed': True, 'invocation': {'module_args': {'creates': None, 'executable': None, 'chdir': None, '_raw_params': 'timedatectl set-timezone Etc/UTC', 'removes': None, 'warn': True, '_uses_shell': False, 'stdin': None}}, 'start': '2018-09-20 09:17:10.663489', 'delta': '0:00:25.011732', 'stderr': "Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out", 'rc': 1, 'msg': 'non-zero return code', 'stdout_lines': []}}
  • flavor:
  • job_id: 3043394
  • kernel:
    • sha1: distro
    • kdb: True
  • last_in_suite: False
  • machine_type: mira
  • name: vshankar-2018-09-19_15:06:02-fs-wip-cephfs-tools-rank-ops-distro-basic-mira
  • nuke_on_error: True
  • os_type: rhel
  • os_version: 7.5
  • overrides:
    • ceph-deploy:
      • fs: xfs
      • conf:
        • client:
          • log file: /var/log/ceph/ceph-$name.$pid.log
        • mon:
          • osd default pool size: 2
        • osd:
          • mon osd full ratio: 0.9
          • mon osd backfillfull_ratio: 0.85
          • bluestore fsck on mount: True
          • mon osd nearfull ratio: 0.8
          • debug bluestore: 20
          • debug bluefs: 20
          • osd objectstore: bluestore
          • bluestore block size: 96636764160
          • debug rocksdb: 10
          • osd failsafe full ratio: 0.95
      • bluestore: True
    • thrashosds:
      • bdev_inject_crash_probability: 0.5
      • bdev_inject_crash: 2
    • ceph-fuse:
      • disabled: True
    • workunit:
      • sha1: ab60dcf2e503deb2846c9a5855d42c8d4d834272
      • branch: wip-cephfs-tools-rank-ops
    • ceph:
      • sha1: ab60dcf2e503deb2846c9a5855d42c8d4d834272
      • log-whitelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • overall HEALTH_
        • \(FS_DEGRADED\)
        • \(MDS_FAILED\)
        • \(MDS_DEGRADED\)
        • \(FS_WITH_FAILED_MDS\)
        • \(MDS_DAMAGE\)
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • overall HEALTH_
        • \(OSD_DOWN\)
        • \(OSD_
        • but it is still running
        • is not responding
      • fs: xfs
      • conf:
        • mds:
          • mds bal split bits: 3
          • mds bal split size: 100
          • osd op complaint time: 180
          • debug mds: 20
          • mds bal merge size: 5
          • debug ms: 1
          • mds bal frag: True
          • mds verify scatter: True
          • mds bal fragment size max: 10000
          • mds op complaint time: 180
          • mds debug scatterstat: True
          • mds debug frag: True
        • client:
          • debug ms: 1
          • pid file:
          • debug client: 20
          • client mount timeout: 600
        • mon:
          • debug ms: 1
          • debug mon: 20
          • debug paxos: 20
          • mon op complaint time: 120
        • osd:
          • mon osd full ratio: 0.9
          • debug ms: 1
          • debug journal: 20
          • debug osd: 25
          • debug bluestore: 20
          • debug bluefs: 20
          • osd objectstore: bluestore
          • mon osd backfillfull_ratio: 0.85
          • osd op complaint time: 180
          • bluestore block size: 96636764160
          • debug filestore: 20
          • debug rocksdb: 10
          • mon osd nearfull ratio: 0.8
          • osd failsafe full ratio: 0.95
          • bluestore fsck on mount: True
      • cephfs_ec_profile:
        • m=2
        • k=2
        • crush-failure-domain=osd
    • install:
      • ceph:
        • sha1: ab60dcf2e503deb2846c9a5855d42c8d4d834272
    • admin_socket:
      • branch: wip-cephfs-tools-rank-ops
    • kclient:
      • disabled: True
  • owner: vshankar
  • pid:
  • roles:
    • ['mon.a', 'mgr.y', 'mds.a', 'osd.0', 'osd.1', 'osd.2', 'osd.3', 'client.0', 'client.1']
    • ['mon.b', 'mon.c', 'mgr.x', 'mds.a-s', 'osd.4', 'osd.5', 'osd.6', 'osd.7', 'client.2', 'client.3']
  • sentry_event: http://sentry.ceph.com/sepia/teuthology/?q=31ec2e40644c4506b5dbd883525ed1c9
  • status: fail
  • success: False
  • branch: wip-cephfs-tools-rank-ops
  • seed:
  • sha1: ab60dcf2e503deb2846c9a5855d42c8d4d834272
  • subset:
  • suite:
  • suite_branch: wip-cephfs-tools-rank-ops
  • suite_path:
  • suite_relpath:
  • suite_repo:
  • suite_sha1: ab60dcf2e503deb2846c9a5855d42c8d4d834272
  • targets:
    • mira012.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQCd3JdN6DEzQ90hgMZjKpMUtRHOd0dYuYec0vG4PbyEmhgBD9irRC6XsWMJ/tBKAoCQ6jdcUR/+LvlI4NxAJgPkWTE2eDIkkm19EBv5kjJiMkJnCh6ggxS8t2hR6/RxyV9ZsIsviG6/gfLERYhM597svAUwcXz2irucGVPXzbEexbzSdu/uYU0itRsa8N/fPZNW0yNJVmzBxIrHsFzOTRB6nMzrJfuIgU1QCv8uHc/DRLTQuh8uJjl80U8gDSsvOwDbFBFAcGeLiR9gH4U6gbUK/xDvBN+cj1Rx1/XDBIS+OVazpGl5eJBigCQ0jsPCrSrTP1Vn1a+KK0Kqwo5IwgoB
    • mira053.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDu9PODCA1CXfpqtbQBk+F1xOtGmXt5eiOqsUxAhKfNjvvkZUGT/l7WJEvYelA/jyUL6gagfn1W3NKYR5ro+WRMQCzYGlG39gTh9RFF5bFyDKnonTOu9YrVpk4yF5LM3P6LJitE59gcCS/+jvCxZpkMTkLQcbiECCgPMBMfbOdPcmMUuiROMF802Tydi6wR2wFpC3Y1HLV1XOhNIjNFAMdtuxFVWd4aLSS60Yp7w69RXeJU8inehS43EtlpgKDZEfkaQRi26zdH3/1EFCsH3NF38vcvlScRHwOmTxMzZH43kqlJQueHpbDrxidsUAAAcKUxc2JDdAeWOFl63gwbk3qR
  • tasks:
    • internal.check_packages:
    • internal.buildpackages_prep:
    • internal.lock_machines:
      • 2
      • mira
    • internal.save_config:
    • internal.check_lock:
    • internal.add_remotes:
    • console_log:
    • internal.connect:
    • internal.push_inventory:
    • internal.serialize_remote_roles:
    • internal.check_conflict:
    • internal.check_ceph_data:
    • internal.vm_setup:
    • kernel:
      • sha1: distro
      • kdb: True
    • internal.base:
    • internal.archive_upload:
    • internal.archive:
    • internal.coredump:
    • internal.sudo:
    • internal.syslog:
    • internal.timer:
    • pcp:
    • selinux:
    • ansible.cephlab:
    • clock:
    • install:
      • extra_system_packages:
        • deb:
          • bison
          • flex
          • libelf-dev
          • libssl-dev
        • rpm:
          • bison
          • flex
          • elfutils-libelf-devel
          • openssl-devel
      • extra_packages:
        • deb:
          • python3-cephfs
          • cephfs-shell
        • rpm:
          • python3-cephfs
    • ceph:
    • ceph-fuse:
    • workunit:
      • clients:
        • client.0:
          • fs/test_python.sh
  • teuthology_branch: master
  • verbose: False
  • pcp_grafana_url:
  • priority:
  • user:
  • queue:
  • posted: 2018-09-19 15:06:46
  • started: 2018-09-20 09:03:28
  • updated: 2018-09-20 09:19:28
  • status_class: danger
  • runtime: 0:16:00
  • wait_time: 0:13:08