Description: upgrade/nautilus-x/stress-split/{0-cluster/{openstack.yaml start.yaml} 1-ceph-install/nautilus.yaml 1.1-pg-log-overrides/normal_pg_log.yaml 2-partial-upgrade/firsthalf.yaml 3-thrash/default.yaml 4-workload/{radosbench.yaml rbd-cls.yaml rbd-import-export.yaml rbd_api.yaml readwrite.yaml rgw_ragweed_prepare.yaml snaps-few-objects.yaml} 5-finish-upgrade.yaml 6-octopus.yaml 7-msgr2.yaml 8-final-workload/{rbd-python.yaml snaps-many-objects.yaml} objectstore/bluestore-bitmap.yaml thrashosds-health.yaml ubuntu_latest.yaml}

Log: http://qa-proxy.ceph.com/teuthology/sage-2020-02-12_23:14:48-upgrade-wip-sage3-testing-2020-02-11-1819-distro-basic-smithi/4758889/teuthology.log

Failure Reason:

failed to become clean before timeout expired

  • log_href: http://qa-proxy.ceph.com/teuthology/sage-2020-02-12_23:14:48-upgrade-wip-sage3-testing-2020-02-11-1819-distro-basic-smithi/4758889/teuthology.log
  • archive_path: /home/teuthworker/archive/sage-2020-02-12_23:14:48-upgrade-wip-sage3-testing-2020-02-11-1819-distro-basic-smithi/4758889
  • description: upgrade/nautilus-x/stress-split/{0-cluster/{openstack.yaml start.yaml} 1-ceph-install/nautilus.yaml 1.1-pg-log-overrides/normal_pg_log.yaml 2-partial-upgrade/firsthalf.yaml 3-thrash/default.yaml 4-workload/{radosbench.yaml rbd-cls.yaml rbd-import-export.yaml rbd_api.yaml readwrite.yaml rgw_ragweed_prepare.yaml snaps-few-objects.yaml} 5-finish-upgrade.yaml 6-octopus.yaml 7-msgr2.yaml 8-final-workload/{rbd-python.yaml snaps-many-objects.yaml} objectstore/bluestore-bitmap.yaml thrashosds-health.yaml ubuntu_latest.yaml}
  • duration: 1:07:25
  • email:
  • failure_reason: failed to become clean before timeout expired
  • flavor: basic
  • job_id: 4758889
  • kernel:
    • sha1: distro
    • kdb: True
  • last_in_suite: False
  • machine_type: smithi
  • name: sage-2020-02-12_23:14:48-upgrade-wip-sage3-testing-2020-02-11-1819-distro-basic-smithi
  • nuke_on_error: True
  • os_type: ubuntu
  • os_version: 18.04
  • 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
          • bdev enable discard: True
          • osd failsafe full ratio: 0.95
          • bdev async discard: True
      • bluestore: True
    • workunit:
      • sha1: 798dec8430828b7b88c3784be1c1cb438b8576dd
      • branch: wip-sage3-testing-2020-02-11-1819
    • ceph:
      • mon_bind_addrvec: False
      • log-whitelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • overall HEALTH_
        • \(MON_DOWN\)
        • \(MGR_DOWN\)
        • slow request
        • \(MON_MSGR2_NOT_ENABLED\)
        • but it is still running
        • wrongly marked me down
        • objects unfound and apparently lost
        • log bound mismatch
        • overall HEALTH_
        • \(OSDMAP_FLAGS\)
        • \(OSD_
        • \(PG_
        • \(POOL_
        • \(CACHE_POOL_
        • \(SMALLER_PGP_NUM\)
        • \(OBJECT_
        • \(SLOW_OPS\)
        • \(REQUEST_SLOW\)
        • \(TOO_FEW_PGS\)
        • slow requests
      • sha1: 798dec8430828b7b88c3784be1c1cb438b8576dd
      • fs: xfs
      • mon_bind_msgr2: False
      • conf:
        • client:
          • rbd default clone format: 1
        • global:
          • enable experimental unrecoverable data corrupting features: *
          • mon warn on msgr2 not enabled: False
        • osd:
          • mon osd full ratio: 0.9
          • debug ms: 1
          • debug filestore: 20
          • bluestore fsck on mount: True
          • bdev enable discard: True
          • debug osd: 25
          • bluestore block size: 96636764160
          • debug bluestore: 20
          • debug bluefs: 20
          • osd objectstore: bluestore
          • mon osd backfillfull_ratio: 0.85
          • bluestore allocator: bitmap
          • bdev async discard: True
          • debug rocksdb: 10
          • mon osd nearfull ratio: 0.8
          • osd failsafe full ratio: 0.95
          • debug journal: 20
        • mon:
          • debug mon: 20
          • debug paxos: 20
          • mon warn on osd down out interval zero: False
          • debug ms: 1
    • install:
      • ceph:
        • sha1: 798dec8430828b7b88c3784be1c1cb438b8576dd
    • admin_socket:
      • branch: wip-sage3-testing-2020-02-11-1819
    • thrashosds:
      • bdev_inject_crash_probability: 0.5
      • bdev_inject_crash: 2
  • owner: scheduled_sage@teuthology
  • pid:
  • roles:
    • ['mon.a', 'mgr.x', 'osd.0', 'osd.1', 'osd.2', 'osd.3']
    • ['mon.b', 'osd.4', 'osd.5', 'osd.6', 'osd.7']
    • ['mon.c']
    • ['osd.8', 'osd.9', 'osd.10', 'osd.11']
    • ['client.0']
  • sentry_event:
  • status: fail
  • success: False
  • branch: wip-sage3-testing-2020-02-11-1819
  • seed:
  • sha1: 798dec8430828b7b88c3784be1c1cb438b8576dd
  • subset:
  • suite:
  • suite_branch: wip-sage3-testing-2020-02-11-1819
  • suite_path:
  • suite_relpath:
  • suite_repo:
  • suite_sha1: 798dec8430828b7b88c3784be1c1cb438b8576dd
  • targets:
    • smithi167.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDQjUNByn1KmsPOiIMO92n7dyE8ERY00SyjQzk3LWI3+KSkygISOShGiDDnHuNrN6j7qr0L7bPF0i+bjA9t4RiOE8B18sV7Z/+vZg2ew10Ynh+MUdbQusqB5rCIHyAWrthOmSmauX6zoHQWAkiRM4Ny5lUX6UujGFA7q/1yDgPRRiLlPyXbSrNGlBze9oGxQmaLZDEHZq7zLStmH1JYuU8+sXO8BqbkgW4hqm1hlV4x988iGj2NzvHHm6UA6EeqcI2oj0sbKJtp2e0lAYt077OytyjzJ/U8y8U4MR6hDeQO7Vj+Y/Cmb5I6aMViGQB3mJmHGvUlnUESgrdQwaLTkiOv
    • smithi094.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQCuVAflVp7Y9liVRRHFugyHjE3wM8MFT5Z+95STI9jP2pNyjq2F7mlxxslAZ9C5As8R2EVNEcPSGksaNMWZzQTkgZaZsAa8B11UuqmysxRCkCNt0nIGgLQH3WOA1KMDHpoYV9qwDZ2hxyDA134PyAmhAlbuD9cgv2b84eQrvSwLvuLSD9Ro8qEaeumkaKaOsacQATUDMSOQp03s3xLQSjEk25yTmImmfQSTpDibWpsXGQOyCW+jMEgsVvzG4+xPj15ZLkQt4G0r6mJRPbmhWqZ6E+iXre4zoS6orP9gcQyRL7qUtMkp6KaffMbk062Q4K29mbndHfftjSR4xIONMkOn
    • smithi031.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDtVW6WHV1uk1Tc6F4KKNlNZ6GnzQ2p0HNz5RBmURo6OxZPpyVR1tHSB+Zu47g8zIHgeqjPrJITZgTxGUSpjg3GesfJAx9Dez4fO6OsS9pZHyFIyQDcg/bJARom5X35v9DWuZ9igJ92y8Xp2paGh5Uw2TKb4OzN4DjzZsgCp+55QXXs0TpTQswkUvrOUZgPMDFVT7tiuh/p8A93N5pYMsmwZvKMSs2o7PHjL3PtgGhsRQQ+7QgqFWyexNdksaCFMJtd2+aCBoz8DXPuciPEqBiyERnCNyf/QahJpbjBx72reqNNm3gl/gZWkdXhnX6stGxTyScv1iIq/9wyfaGBI5cX
    • smithi130.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDmDfGg1YUIrA1a2mn8s4sOyjG+SGKbrwfVIvwmmSuQFv27kfkP6WqQ7nqkpTsN1B/kuQ9MOyZTce9QFpdI4Nuxsm9QuPss/ONetR3XrqcfqryyP4tGU0ChZKLZhOnrTlz2KfQZ3idAhuXJQz2Mr3NVtEwLNP2eeNah4SXDfQI51RTjMFIhgosw3kEykrxsCZiXTRf2GOODI3DG8wLmyu6Vu+gLU57BWAe4V851mERrAkneW9M8BKasCl6ifs+djTtTuJXEBXGphHLudARd/ndqWm0iU9tG4CG9UpQtcvyX6gcIX/i/P5e+4Iq54f2WF40aSc5hZL36gaRByZQG6mZr
    • smithi075.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC60ln37qdSimtmUPT4FYId4gyaeZfjGU2Mmugirav1syq7FsSb9Amwcp+VxSVmA/HctjT6f0snAv0fmP7znEm3vhFoV8JBz0hhoQgHC80nKCADkekCJl8La+b7OtvgXSNmL2qG5DOvtEA1vhUYQ4vzQ/ZNpGjUJeoHv5G/8NaUy4/bicgGz/VTgL+TWUc9COaoasnGtYVyIN6jWtc6yW2y9coaal46IMmKNYOp4296Md+SpttEvCgsbk5c+VM+tm4Fy40xnyCYg6nwsIwvso1YrIjsFYvL/12sG/f65XrfsSnmSTDfILQtFrq4Kg8HM7Dm5vvQLMce+rb2A/9SOMyb
  • tasks:
    • internal.check_packages:
    • internal.buildpackages_prep:
    • internal.lock_machines:
      • 5
      • 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: 798dec8430828b7b88c3784be1c1cb438b8576dd
      • exclude_packages:
        • ceph-mgr-cephadm
        • cephadm
        • libcephfs-dev
      • branch: nautilus
    • print: **** done install nautilus
    • ceph:
      • mon_bind_addrvec: False
      • log-whitelist:
        • \(MDS_ALL_DOWN\)
        • \(MDS_UP_LESS_THAN_MAX\)
        • overall HEALTH_
        • \(MON_DOWN\)
        • \(MGR_DOWN\)
        • slow request
        • \(MON_MSGR2_NOT_ENABLED\)
        • but it is still running
        • wrongly marked me down
        • objects unfound and apparently lost
        • log bound mismatch
        • overall HEALTH_
        • \(OSDMAP_FLAGS\)
        • \(OSD_
        • \(PG_
        • \(POOL_
        • \(CACHE_POOL_
        • \(SMALLER_PGP_NUM\)
        • \(OBJECT_
        • \(SLOW_OPS\)
        • \(REQUEST_SLOW\)
        • \(TOO_FEW_PGS\)
        • slow requests
      • sha1: 798dec8430828b7b88c3784be1c1cb438b8576dd
      • cluster: ceph
      • fs: xfs
      • mon_bind_msgr2: False
      • conf:
        • global:
          • enable experimental unrecoverable data corrupting features: *
          • mon warn on msgr2 not enabled: False
          • bluestore_warn_on_legacy_statfs: False
          • bluestore warn on no per pool omap: False
          • mon pg warn min per osd: 0
        • client:
          • rbd default clone format: 1
        • osd:
          • mon osd full ratio: 0.9
          • debug ms: 1
          • debug filestore: 20
          • bluestore fsck on mount: True
          • bdev enable discard: True
          • debug osd: 25
          • bluestore block size: 96636764160
          • debug bluestore: 20
          • debug bluefs: 20
          • osd objectstore: bluestore
          • mon osd backfillfull_ratio: 0.85
          • bluestore allocator: bitmap
          • bdev async discard: True
          • debug rocksdb: 10
          • mon osd nearfull ratio: 0.8
          • osd failsafe full ratio: 0.95
          • debug journal: 20
        • mon:
          • debug mon: 20
          • debug paxos: 20
          • mon warn on osd down out interval zero: False
          • debug ms: 1
    • exec:
      • osd.0:
        • ceph osd require-osd-release nautilus
        • ceph osd set-require-min-compat-client nautilus
    • print: **** done ceph
    • rgw:
      • client.0
    • print: **** done => started rgw client.0
    • install.upgrade:
      • mon.a:
      • mon.c:
      • mon.b:
    • print: **** done install.upgrade of first 3 nodes
    • ceph.restart:
      • daemons:
        • mon.a
        • mon.b
        • mgr.x
        • osd.0
        • osd.1
        • osd.2
        • osd.3
        • osd.4
        • osd.5
        • osd.6
        • osd.7
      • mon-health-to-clog: False
    • print: **** done ceph.restart of all mons and 2/3 of osds
    • parallel:
      • stress-tasks
    • install.upgrade:
      • osd.8:
      • client.0:
      • extra_packages:
        • python3-rados
        • python3-rgw
        • python3-rbd
        • python3-cephfs
    • ceph.restart:
      • daemons:
        • mon.c
        • osd.8
        • osd.9
        • osd.10
        • osd.11
        • rgw.*
      • wait-for-healthy: False
      • wait-for-osds-up: True
    • print: **** restarted/upgrated => mon.c, osd.8, osd.9, osd.10, osd.11, rgw.*
    • exec:
      • osd.0:
        • ceph osd set pglog_hardlimit
        • ceph osd dump --format=json-pretty | grep "flags"
        • ceph config set global mon_warn_on_msgr2_not_enabled false
    • print: **** try to set pglog_hardlimit again, should succeed
    • exec:
      • osd.0:
        • ceph osd require-osd-release octopus
        • ceph osd set-require-min-compat-client octopus
        • for f in `ceph osd pool ls` ; do ceph osd pool set $f pg_autoscale_mode off ; done
    • ceph.healthy:
    • exec:
      • mon.a:
        • ceph mon enable-msgr2
        • ceph config rm global mon_warn_on_msgr2_not_enabled
    • ceph.healthy:
    • workunit:
      • clients:
        • client.0:
          • rbd/test_librbd_python.sh
    • print: **** done rbd/test_librbd_python.sh 9-workload
    • rados:
      • op_weights:
        • snap_remove: 50
        • snap_create: 50
        • rollback: 50
        • read: 100
        • write: 100
        • delete: 50
      • clients:
        • client.0
      • write_append_excl: False
      • objects: 500
      • ops: 4000
  • teuthology_branch: master
  • verbose: False
  • pcp_grafana_url:
  • priority:
  • user:
  • queue:
  • posted: 2020-02-12 23:15:01
  • started: 2020-02-12 23:18:40
  • updated: 2020-02-13 01:40:42
  • status_class: danger
  • runtime: 2:22:02
  • wait_time: 1:14:37