Pulpito :: Results Dashboard

Posted	Started	Updated	Runtime	Duration	In Waiting	Machine	Teuthology Branch	OS Type	OS Version	Nodes	Status
2019-01-10 20:25:53	2019-01-10 20:52:02	2019-01-10 21:32:02	0:40:00	0:21:01	0:18:59	smithi	master			3	fail

Nodes: smithi136 smithi166 smithi013

Description: kcephfs/thrash/{clusters/1-mds-1-client.yaml conf/{client.yaml mds.yaml mon.yaml osd.yaml} objectstore-ec/bluestore-comp.yaml overrides/{frag_enable.yaml log-config.yaml ms-die-on-skipped.yaml osd-asserts.yaml whitelist_health.yaml whitelist_wrongly_marked_down.yaml} thrashers/default.yaml thrashosds-health.yaml whitelist_health.yaml workloads/kclient_workunit_suites_ffsb.yaml}

Log: http://qa-proxy.ceph.com/teuthology/yuriw-2019-01-10_20:25:47-kcephfs-wip-yuri4-testing-2019-01-10-1638-luminous-testing-basic-smithi/3443479/teuthology.log

Failure Reason:

"2019-01-10 21:19:38.854913 osd.3 osd.3 172.21.15.136:6804/13234 108 : cluster [WRN] slow request 180.808266 seconds old, received at 2019-01-10 21:16:38.046526: osd_op(client.4258.0:14357 3.7 3:f750f038:::10000000173.00000000:head [write 2228224~8192,write 2260992~4096,write 2285568~12288,write 2318336~4096,write 2338816~4096,write 2367488~4096,write 2379776~12288,write 2396160~4096,write 2404352~4096,write 2412544~4096,write 2428928~4096,write 2437120~8192,write 2469888~4096,write 2486272~8192,write 2519040~16384,write 2555904~4096] snapc 1=[] ondisk+write+known_if_redirected e62) currently sub_op_commit_rec from 7" in cluster log

All Details...

log_href: http://qa-proxy.ceph.com/teuthology/yuriw-2019-01-10_20:25:47-kcephfs-wip-yuri4-testing-2019-01-10-1638-luminous-testing-basic-smithi/3443479/teuthology.log
archive_path: /home/teuthworker/archive/yuriw-2019-01-10_20:25:47-kcephfs-wip-yuri4-testing-2019-01-10-1638-luminous-testing-basic-smithi/3443479
description: kcephfs/thrash/{clusters/1-mds-1-client.yaml conf/{client.yaml mds.yaml mon.yaml osd.yaml} objectstore-ec/bluestore-comp.yaml overrides/{frag_enable.yaml log-config.yaml ms-die-on-skipped.yaml osd-asserts.yaml whitelist_health.yaml whitelist_wrongly_marked_down.yaml} thrashers/default.yaml thrashosds-health.yaml whitelist_health.yaml workloads/kclient_workunit_suites_ffsb.yaml}
duration: 0:21:01
email: ceph-qa@lists.ceph.com
failure_reason: "2019-01-10 21:19:38.854913 osd.3 osd.3 172.21.15.136:6804/13234 108 : cluster [WRN] slow request 180.808266 seconds old, received at 2019-01-10 21:16:38.046526: osd_op(client.4258.0:14357 3.7 3:f750f038:::10000000173.00000000:head [write 2228224~8192,write 2260992~4096,write 2285568~12288,write 2318336~4096,write 2338816~4096,write 2367488~4096,write 2379776~12288,write 2396160~4096,write 2404352~4096,write 2412544~4096,write 2428928~4096,write 2437120~8192,write 2469888~4096,write 2486272~8192,write 2519040~16384,write 2555904~4096] snapc 1=[] ondisk+write+known_if_redirected e62) currently sub_op_commit_rec from 7" in cluster log
flavor: basic
job_id: 3443479
kernel:
- flavor: basic
- sha1: 9e78dcdd94782ed234d6c3e148674b799a2c4a8b
- kdb: True
last_in_suite: False
machine_type: smithi
name: yuriw-2019-01-10_20:25:47-kcephfs-wip-yuri4-testing-2019-01-10-1638-luminous-testing-basic-smithi
nuke_on_error: True
os_type:
os_version:
overrides:
- ceph-deploy:
  - conf:
    - client:
      - log file: /var/log/ceph/ceph-$name.$pid.log
    - mon:
      - osd default pool size: 2
- workunit:
  - sha1: 22899e551b699eb624418e679c3da589b8a8fb5b
  - branch: wip-yuri4-testing-2019-01-10-1638-luminous
- ceph:
  - log-whitelist:
    - $MDS_ALL_DOWN$
    - $MDS_UP_LESS_THAN_MAX$
    - overall HEALTH_
    - $FS_DEGRADED$
    - $MDS_FAILED$
    - $MDS_DEGRADED$
    - $FS_WITH_FAILED_MDS$
    - $MDS_DAMAGE$
    - overall HEALTH_
    - $OSD_DOWN$
    - $OSD_
    - but it is still running
    - is not responding
    - overall HEALTH_
    - \(OSDMAP_FLAGS$
    - $OSD_
    - \(PG_
    - \(POOL_
    - \(CACHE_POOL_
    - \(SMALLER_PGP_NUM$
    - $OBJECT_
    - \(REQUEST_SLOW$
    - $TOO_FEW_PGS$
    - $MON_DOWN$
    - slow requests
    - overall HEALTH_
    - $FS_DEGRADED$
    - $MDS_FAILED$
    - $MDS_DEGRADED$
    - $FS_WITH_FAILED_MDS$
    - $MDS_DAMAGE$
  - 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
      - debug client: 20
      - client mount timeout: 600
    - global:
      - ms die on skipped message: False
    - osd:
      - mon osd full ratio: 0.9
      - debug ms: 1
      - bluestore fsck on mount: True
      - filestore flush min: 0
      - debug osd: 25
      - bluestore compression mode: aggressive
      - debug bluestore: 20
      - debug bluefs: 20
      - osd objectstore: bluestore
      - mon osd backfillfull_ratio: 0.85
      - mon osd nearfull ratio: 0.8
      - osd op complaint time: 180
      - bluestore block size: 96636764160
      - debug filestore: 20
      - debug rocksdb: 10
      - osd shutdown pgref assert: True
      - osd failsafe full ratio: 0.95
      - debug journal: 20
    - mon:
      - debug ms: 1
      - debug mon: 20
      - debug paxos: 20
      - mon op complaint time: 120
  - sha1: 22899e551b699eb624418e679c3da589b8a8fb5b
- install:
  - ceph:
    - sha1: 22899e551b699eb624418e679c3da589b8a8fb5b
- admin_socket:
  - branch: wip-yuri4-testing-2019-01-10-1638-luminous
- thrashosds:
  - bdev_inject_crash_probability: 0.5
  - bdev_inject_crash: 2
owner: scheduled_yuriw@teuthology
pid:
roles:
- ['mon.a', 'mgr.y', 'mds.a', 'osd.0', 'osd.1', 'osd.2', 'osd.3']
- ['mon.b', 'mon.c', 'mgr.x', 'mds.a-s', 'osd.4', 'osd.5', 'osd.6', 'osd.7']
- ['client.0']
sentry_event:
status: fail
success: False
branch: wip-yuri4-testing-2019-01-10-1638-luminous
seed:
sha1: 22899e551b699eb624418e679c3da589b8a8fb5b
subset:
suite:
suite_branch: wip-yuri4-testing-2019-01-10-1638-luminous
suite_path:
suite_relpath:
suite_repo:
suite_sha1: 22899e551b699eb624418e679c3da589b8a8fb5b
targets:
- smithi136.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDqrma/gldprlz5wksYQgOg8VwORhr7kCETxAWh30fQLya70tWlxogEjNfaKd+NnwydmAGQ+hzVFEHZgZf8dkuDIj9SyiVhYpbvgIUmxjjrC0hrM7RHphRNlv3bErlrgZCdOytHHdp52+Mlb1/Z8K7E/vK30MUZLwo4ycavyPlC0JY7chAv24hY9cresMnGc3UuIejSy1XKiGjhLBBKGulwxIzb2gUk7Nl0Uw8bFVj/jDsZt5Qz1V9ZZmhcCxZGYiLzuk0KJcy+SKf3u5PV0uYZz7guajRJjU1z6hQKKwwxwDm1BoAZplROB33n3Mce1sUm/aBtJnZgW78mL0mHxmnT
- smithi166.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDm47Of1Mx0tFHIMBV+0h0h15iO87iNS6Aa87MoMs0UAeIWYd32R6GSar2vPa6YCNsxeBZhTZTc329+Iw6VPON5MCOtB0PS/+732RMFPPWEb91YpDJC32NZBkm8DcadvQ2VIAjVz+Mote7wcQcpbXoHEGFDAxm1YAyK9Lx5W+mC6OQEODNvSoY7zctd+/5HklaqbZbMNiTgomVoiRht20qKnULysTWMjCFheQqd6hY47g5DU4gO0qVZvIpzhJNhIjCReX1MS2SdAOsnemhtMU2OpPZtG4dkzIE65c5qTb+anvRH5m569tLj7qJMKp73t6Je93gQBiRgY1y8rrn+c2HZ
- smithi013.front.sepia.ceph.com: ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDHQNNND6Pahd01/KsdkLX30mQLZ9XSEdhFlvMfbqseF+zfbCCSG9sLYcqJSj/bUG+Hzl/HY9GS8E7g/b+M3c4FFY/D+JLeVPdphLssmlCigtblm2JPI0PzK6pPDmEqFtvsuTSTnPVw5qhtFfwvGMe0PM2uOcURfH8hxcs1PiIY95xNdfHG5RKtOsJ2OCpAXZghH1Kd5srrnYQ9dZpDYhbqmoloTS73r0VAajXelIZOCcX9PL6OKl6qXLE4hSALCru3nm/Ig2KuxTQdcS2vdYfVSXllTQ2Groxu/5vrWLHj2cHZXBI5VFw7eQ/puZl8OkTe+vKWgFbYdDDSETzzHww7
tasks:
- internal.check_packages:
- internal.buildpackages_prep:
- internal.lock_machines:
  - 3
  - 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:
  - flavor: basic
  - sha1: 9e78dcdd94782ed234d6c3e148674b799a2c4a8b
  - kdb: True
- internal.base:
- internal.archive_upload:
- internal.archive:
- internal.coredump:
- internal.sudo:
- internal.syslog:
- internal.timer:
- pcp:
- selinux:
- ansible.cephlab:
- clock:
- install:
- ceph:
  - cluster: ceph
  - log-whitelist:
    - but it is still running
    - objects unfound and apparently lost
    - $MDS_ALL_DOWN$
    - $MDS_UP_LESS_THAN_MAX$
    - overall HEALTH_
    - $FS_DEGRADED$
    - $MDS_FAILED$
    - $MDS_DEGRADED$
    - $FS_WITH_FAILED_MDS$
    - $MDS_DAMAGE$
    - overall HEALTH_
    - $OSD_DOWN$
    - $OSD_
    - but it is still running
    - is not responding
    - overall HEALTH_
    - \(OSDMAP_FLAGS$
    - $OSD_
    - \(PG_
    - \(POOL_
    - \(CACHE_POOL_
    - \(SMALLER_PGP_NUM$
    - $OBJECT_
    - \(REQUEST_SLOW$
    - $TOO_FEW_PGS$
    - $MON_DOWN$
    - slow requests
    - overall HEALTH_
    - $FS_DEGRADED$
    - $MDS_FAILED$
    - $MDS_DEGRADED$
    - $FS_WITH_FAILED_MDS$
    - $MDS_DAMAGE$
  - 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
      - debug client: 20
      - client mount timeout: 600
    - global:
      - ms die on skipped message: False
    - osd:
      - mon osd full ratio: 0.9
      - debug ms: 1
      - bluestore fsck on mount: True
      - filestore flush min: 0
      - debug osd: 25
      - bluestore compression mode: aggressive
      - debug bluestore: 20
      - debug bluefs: 20
      - osd objectstore: bluestore
      - mon osd backfillfull_ratio: 0.85
      - mon osd nearfull ratio: 0.8
      - osd op complaint time: 180
      - bluestore block size: 96636764160
      - debug filestore: 20
      - debug rocksdb: 10
      - osd shutdown pgref assert: True
      - osd failsafe full ratio: 0.95
      - debug journal: 20
    - mon:
      - debug ms: 1
      - debug mon: 20
      - debug paxos: 20
      - mon op complaint time: 120
  - fs: xfs
  - sha1: 22899e551b699eb624418e679c3da589b8a8fb5b
- thrashosds:
- kclient:
- workunit:
  - clients:
    - all:
      - suites/ffsb.sh
  - branch: wip-yuri4-testing-2019-01-10-1638-luminous
  - sha1: 22899e551b699eb624418e679c3da589b8a8fb5b
teuthology_branch: master
verbose: True
pcp_grafana_url:
priority:
user:
queue:
posted: 2019-01-10 20:25:53
started: 2019-01-10 20:52:02
updated: 2019-01-10 21:32:02
status_class: danger
runtime: 0:40:00
wait_time: 0:18:59