Description: upgrade:luminous-x/parallel/{0-cluster/{openstack.yaml start.yaml} 1-ceph-install/luminous.yaml 2-workload/{blogbench.yaml ec-rados-default.yaml rados_api.yaml rados_loadgenbig.yaml test_rbd_api.yaml test_rbd_python.yaml} 3-upgrade-sequence/upgrade-all.yaml 5-final-workload/{blogbench.yaml rados-snaps-few-objects.yaml rados_loadgenmix.yaml rados_mon_thrash.yaml rbd_cls.yaml rbd_import_export_no_upgrated.yaml rbd_import_export_upgrated.yaml rgw_swift.yaml} distros/centos_latest.yaml objectstore/bluestore.yaml}

Log: http://qa-proxy.ceph.com/teuthology/teuthology-2018-07-30_02:25:01-upgrade:luminous-x-master-distro-basic-smithi/2835539/teuthology.log

Failure Reason:

"2018-07-30 12:16:06.316551 mon.a (mon.0) 503 : cluster [WRN] Health check failed: 3 slow requests are blocked > 32 sec (REQUEST_SLOW)" in cluster log

  • log_href: http://qa-proxy.ceph.com/teuthology/teuthology-2018-07-30_02:25:01-upgrade:luminous-x-master-distro-basic-smithi/2835539/teuthology.log
  • archive_path: /home/teuthworker/archive/teuthology-2018-07-30_02:25:01-upgrade:luminous-x-master-distro-basic-smithi/2835539
  • description: upgrade:luminous-x/parallel/{0-cluster/{openstack.yaml start.yaml} 1-ceph-install/luminous.yaml 2-workload/{blogbench.yaml ec-rados-default.yaml rados_api.yaml rados_loadgenbig.yaml test_rbd_api.yaml test_rbd_python.yaml} 3-upgrade-sequence/upgrade-all.yaml 5-final-workload/{blogbench.yaml rados-snaps-few-objects.yaml rados_loadgenmix.yaml rados_mon_thrash.yaml rbd_cls.yaml rbd_import_export_no_upgrated.yaml rbd_import_export_upgrated.yaml rgw_swift.yaml} distros/centos_latest.yaml objectstore/bluestore.yaml}
  • duration: 1:49:10
  • email: ceph-qa@ceph.com
  • failure_reason: "2018-07-30 12:16:06.316551 mon.a (mon.0) 503 : cluster [WRN] Health check failed: 3 slow requests are blocked > 32 sec (REQUEST_SLOW)" in cluster log
  • flavor: basic
  • job_id: 2835539
  • kernel:
    • sha1: distro
    • kdb: True
  • last_in_suite: False
  • machine_type: smithi
  • name: teuthology-2018-07-30_02:25:01-upgrade:luminous-x-master-distro-basic-smithi
  • nuke_on_error: True
  • os_type: centos
  • os_version: 7.4
  • 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
    • rgw:
      • frontend: civetweb
    • workunit:
      • sha1: d8d85deedb0f112e68dd03bf6a0633efcf85412b
      • branch: luminous
    • ceph:
      • log-whitelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • scrub mismatch
        • ScrubResult
        • wrongly marked
        • \(POOL_APP_NOT_ENABLED\)
        • overall HEALTH_
        • reached quota
      • fs: xfs
      • conf:
        • global:
          • enable experimental unrecoverable data corrupting features: *
        • mon:
          • debug mon: 20
          • debug paxos: 20
          • mon warn on osd down out interval zero: False
          • debug ms: 1
        • osd:
          • mon osd full ratio: 0.9
          • debug ms: 1
          • debug journal: 20
          • osd_class_load_list: cephfs hello journal lock log numops rbd refcount replica_log rgw sdk statelog timeindex user version
          • debug osd: 25
          • debug bluestore: 20
          • debug bluefs: 20
          • osd objectstore: bluestore
          • mon osd backfillfull_ratio: 0.85
          • osd_class_default_list: cephfs hello journal lock log numops rbd refcount replica_log rgw sdk statelog timeindex user version
          • 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
      • sha1: cecbf3e5dda2dc132367d6d5d74b1b384846c31a
    • install:
      • ceph:
        • sha1: cecbf3e5dda2dc132367d6d5d74b1b384846c31a
    • admin_socket:
      • branch: master
    • thrashosds:
      • bdev_inject_crash_probability: 0.5
      • bdev_inject_crash: 2
  • owner: scheduled_teuthology@teuthology
  • pid:
  • roles:
    • ['mon.a', 'mgr.x', 'mds.a', 'osd.0', 'osd.1']
    • ['mon.b', 'mon.c', 'osd.2', 'osd.3']
    • ['client.0', 'client.1', 'client.2', 'client.3']
    • ['client.4']
  • sentry_event:
  • status: fail
  • success: False
  • branch: master
  • seed:
  • sha1: cecbf3e5dda2dc132367d6d5d74b1b384846c31a
  • subset:
  • suite:
  • suite_branch: luminous
  • suite_path:
  • suite_relpath:
  • suite_repo:
  • suite_sha1: d8d85deedb0f112e68dd03bf6a0633efcf85412b
  • targets:
    • smithi070.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDhwd+9uT/rNmNfi2uOYKqKoSvgepgzDPALwhbbYbaif7D3e2dNsCuSDud3FwOI4v79cvSujft0jo4i98iaic7z0xCRh8L3fFSXh/M5I6STW1vPgNXEHo5AntIygb7JrUiTYnn/xXM/XBFUblcKOz0inksv3FBtD9ABPFj0whjyDnwE8nMiGLEDMoyo90FI/sYFTfAJJkcMUPVyqWNRPhQzQpLQBFkXvShupGFu1FSCbRYyBLBfbtL4u/biK5UJNYA3kjI+Mzu9calJCeMu5FVo/jgFDUdjZbDNRrJWZ33p+5fjO/72hLpqpL/cR87PtpxdhyaYtYyr9CBgGibyMVDH
    • smithi047.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDs+CE0e4mQzHfmgbsc4arm6farwpBq+dG9f8FQUwJIXySwsQC8Yy4ynrySYtFuG5pCELsFopOQqhuJQsEDiXGku/AImwUhmOh9nzSaAMvUpann/2vDaeovqJ+f8Fjju3aUHXnmCEYbQj2M3sreVWJ8SXbiOKpZwRPTiBYFe3bxpbNDVlVwe3mlygLnmpo1Ty0ulRJY8IWA8EalvzFVu0LG9Z6WQWwAm4d6UcAT/CfaFjeNQsOyS8IB1mVgw+HM8MQeVEvn/8sDPlQjmsZE6Lv49Z62pN0ZCxgSA90ohEcbzzzSU5Oazo5zFKLLzvuBA66a3inJdUJSFC9B/wuamo0J
    • smithi135.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDegf95hYab05NQ3maNhxUmRPF+Hi/oYJIXOpJ15TKMwzBaGmZgwJQFf7QuviyiPDk25itS0XKz27aAn0c1FrWbzBvzccgOrS/6kqWWVqQObXasAiThx1LtIoUU38wzKnFQcmF0LZ9n58jnhZ8Wra6aDZq1sfsPkyhJ896Jrxh9WwePvnwW/IWyeq2MuqVF1JpktS46ayuJlCOL7ki18SiqjLbuT7yoXcIJ16htAiikf/FbPirZcOZQ+Ggr9qT5N4oREgeYbC50uiVZIiYrh03aTbuWk8vAW5Z+DfXoza9rphs6H8mJq3rJc7o7sjtIcf/CNjHGRJinaB4/+fYvMVC7
    • smithi007.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDTViU6izWbt5Ykbwo/wUKh8bl9cmshU47yCMSVBmJc+7D6aC+rHkp40NQuAEHKOs5RMiJdC2MlCZauHGzlartXmmcQtOEmArHf7OM+nfSAIkpj/c1Aqxtzmld8jx3cfLP7vN2+UfAr1zw14NRJqZLNQvC5N5LxbCRHql/hD0CJxTRWYWRsIUE1eny0N/AQQXkrlQHgo3jkNt09ucSFEIj7CDXq1Eb/3PywiygFo7fCNjPlKkfA5Idi5PhwwDUdRV5Z3ZzyVFNTqHLJ2HAWU2zCk4HXx5yQ/+BYJAmr7WTkd4Cyxa0djiItNpG+cnuHJXeoQkT8yEFFO2476U2HER5x
  • tasks:
    • internal.check_packages:
    • internal.buildpackages_prep:
    • internal.lock_machines:
      • 4
      • smithi
    • 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:
      • sha1: cecbf3e5dda2dc132367d6d5d74b1b384846c31a
      • branch: luminous
    • print: **** done installing luminous
    • ceph:
      • cluster: ceph
      • log-whitelist:
        • overall HEALTH_
        • \(FS_
        • \(MDS_
        • \(OSD_
        • \(MON_DOWN\)
        • \(CACHE_POOL_
        • \(POOL_
        • \(MGR_DOWN\)
        • \(PG_
        • \(SMALLER_PGP_NUM\)
        • Monitor daemon marked osd
        • Behind on trimming
        • Manager daemon
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • scrub mismatch
        • ScrubResult
        • wrongly marked
        • \(POOL_APP_NOT_ENABLED\)
        • overall HEALTH_
        • reached quota
      • conf:
        • global:
          • mon warn on pool no app: False
          • enable experimental unrecoverable data corrupting features: *
        • mon:
          • debug mon: 20
          • debug paxos: 20
          • mon warn on osd down out interval zero: False
          • debug ms: 1
        • osd:
          • mon osd full ratio: 0.9
          • debug ms: 1
          • debug journal: 20
          • osd_class_load_list: cephfs hello journal lock log numops rbd refcount replica_log rgw sdk statelog timeindex user version
          • debug osd: 25
          • debug bluestore: 20
          • debug bluefs: 20
          • osd objectstore: bluestore
          • mon osd backfillfull_ratio: 0.85
          • osd_class_default_list: cephfs hello journal lock log numops rbd refcount replica_log rgw sdk statelog timeindex user version
          • 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
      • fs: xfs
      • sha1: cecbf3e5dda2dc132367d6d5d74b1b384846c31a
    • exec:
      • osd.0:
        • ceph osd require-osd-release luminous
        • ceph osd set-require-min-compat-client luminous
    • print: **** done ceph
    • install.upgrade:
      • mon.a:
      • mon.b:
    • print: **** done install.upgrade both hosts
    • parallel:
      • workload
      • upgrade-sequence
    • print: **** done parallel
    • install.upgrade:
      • client.0:
    • print: **** done install.upgrade on client.0
    • sequential:
      • ceph-fuse:
      • print: **** done ceph-fuse 5-final-workload
      • workunit:
        • clients:
          • client.3:
            • suites/blogbench.sh
        • branch: luminous
        • sha1: d8d85deedb0f112e68dd03bf6a0633efcf85412b
      • print: **** done suites/blogbench.sh 5-final-workload
    • rados:
      • op_weights:
        • snap_remove: 50
        • snap_create: 50
        • rollback: 50
        • read: 100
        • write: 100
        • delete: 50
      • clients:
        • client.1
      • write_append_excl: False
      • objects: 50
      • ops: 4000
    • print: **** done rados 4-final-workload
    • workunit:
      • clients:
        • client.1:
          • rados/load-gen-mix.sh
      • branch: luminous
      • sha1: d8d85deedb0f112e68dd03bf6a0633efcf85412b
    • print: **** done rados/load-gen-mix.sh 4-final-workload
    • mon_thrash:
      • revive_delay: 20
      • thrash_delay: 1
    • print: **** done mon_thrash 4-final-workload
    • workunit:
      • clients:
        • client.1:
          • rados/test.sh
      • branch: luminous
    • print: **** done rados/test.sh 4-final-workload
    • workunit:
      • clients:
        • client.1:
          • cls/test_cls_rbd.sh
      • branch: luminous
      • sha1: d8d85deedb0f112e68dd03bf6a0633efcf85412b
    • print: **** done cls/test_cls_rbd.sh 4-final-workload
    • workunit:
      • clients:
        • client.4:
          • rbd/import_export.sh
      • env:
        • RBD_CREATE_ARGS: --new-format
      • branch: luminous
    • print: **** done rbd/import_export.sh 4-final-workload on NO upgrated client
    • workunit:
      • clients:
        • client.1:
          • rbd/import_export.sh
      • env:
        • RBD_CREATE_ARGS: --new-format
      • branch: luminous
      • sha1: d8d85deedb0f112e68dd03bf6a0633efcf85412b
    • print: **** done rbd/import_export.sh 4-final-workload on upgrated client
    • rgw:
      • client.1
    • print: **** done rgw 4-final-workload
    • swift:
      • client.1:
        • rgw_server: client.1
    • print: **** done swift 4-final-workload
  • teuthology_branch: master
  • verbose: True
  • pcp_grafana_url:
  • priority:
  • user:
  • queue:
  • posted: 2018-07-30 02:25:13
  • started: 2018-07-30 04:27:54
  • updated: 2018-07-30 12:32:02
  • status_class: danger
  • runtime: 8:04:08
  • wait_time: 6:14:58